Merge branch 't/oggdec_latency_improvements'
[paraslash.git] / web / screenshots / server.log
1 Dec 29 02:12:57 (1) (16077) log_welcome: welcome to para_server git (Sun Dec 29 01:49:51 MET 2013)
2 Dec 29 02:12:57 (0) (16077) populate_user_list: found entry for user maan
3 Dec 29 02:12:57 (0) (16077) populate_user_list: found 4 perm entries
4 Dec 29 02:12:57 (0) (16077) populate_user_list: found entry for user sshmaan
5 Dec 29 02:12:57 (1) (16077) get_asymmetric_key: decoding public rsa-ssh key /home/maan/.ssh/id_rsa.pub
6 Dec 29 02:12:57 (0) (16077) check_ssh_key_header: type: ssh-rsa, rlen: 7
7 Dec 29 02:12:57 (0) (16077) read_bignum: bnsize: 3
8 Dec 29 02:12:57 (0) (16077) read_bignum: bnsize: 257
9 Dec 29 02:12:57 (0) (16077) populate_user_list: found 4 perm entries
10 Dec 29 02:12:57 (0) (16077) populate_user_list: found entry for user install
11 Dec 29 02:12:57 (3) (16077) populate_user_list: public key /home/maan/.paraslash/key.pub.install too short (64)
12 Dec 29 02:12:57 (0) (16077) populate_user_list: found entry for user www
13 Dec 29 02:12:57 (3) (16077) populate_user_list: public key /home/maan/.paraslash/key.pub.www too short (64)
14 Dec 29 02:12:57 (0) (16077) populate_user_list: found entry for user maan@albrecht
15 Dec 29 02:12:57 (0) (16077) populate_user_list: found 2 perm entries
16 Dec 29 02:12:57 (2) (16077) server_init: initializing audio format handlers
17 Dec 29 02:12:57 (1) (16077) afh_init: supported audio formats: mp3 wma ogg spx aac flac
18 Dec 29 02:12:57 (2) (16077) afh_init: initializing mp3 handler
19 Dec 29 02:12:57 (2) (16077) afh_init: initializing ogg handler
20 Dec 29 02:12:57 (2) (16077) afh_init: initializing aac handler
21 Dec 29 02:12:57 (2) (16077) afh_init: initializing wma handler
22 Dec 29 02:12:57 (2) (16077) afh_init: initializing spx handler
23 Dec 29 02:12:57 (2) (16077) afh_init: initializing flac handler
24 Dec 29 02:12:57 (2) (16077) afh_init: initializing opus handler
25 Dec 29 02:12:57 (0) (16077) para_sigaction: catching signal 10
26 Dec 29 02:12:57 (0) (16077) para_block_signal: blocking signal 17
27 Dec 29 02:12:57 (2) (16077) server_init: initializing the audio file selector
28 Dec 29 02:12:57 (1) (16077) init_afs: afs_socket: 4, afs_socket_cookie: 3213854017
29 Dec 29 02:12:57 (2) (16077) init_signal_task: setting up signal handling
30 Dec 29 02:12:57 (0) (16077) para_sigaction: catching signal 2
31 Dec 29 02:12:57 (0) (16077) para_sigaction: catching signal 15
32 Dec 29 02:12:57 (0) (16078) para_sigaction: catching signal 13
33 Dec 29 02:12:57 (0) (16077) para_sigaction: catching signal 1
34 Dec 29 02:12:57 (0) (16077) para_sigaction: catching signal 17
35 Dec 29 02:12:57 (0) (16077) para_sigaction: catching signal 13
36 Dec 29 02:12:57 (1) (16077) register_task: registering signal task (0x807c3e4)
37 Dec 29 02:12:57 (0) (16077) register_task: pre_select: 0x807c3e4
38 Dec 29 02:12:57 (0) (16077) register_task: post_select: 0x807c3e8
39 Dec 29 02:12:57 (0) (16077) para_unblock_signal: unblocking signal 17
40 Dec 29 02:12:57 (2) (16077) server_init: initializing virtual streaming system
41 Dec 29 02:12:57 (1) (16078) register_signal_task: signal pipe: fd 4
42 Dec 29 02:12:57 (0) (16078) para_sigaction: catching signal 2
43 Dec 29 02:12:57 (0) (16078) para_sigaction: catching signal 15
44 Dec 29 02:12:57 (1) (16077) init_vss_task: announce timeval: 300ms
45 Dec 29 02:12:57 (0) (16078) para_sigaction: catching signal 1
46 Dec 29 02:12:57 (2) (16077) init_vss_task: initializing http sender
47 Dec 29 02:12:57 (1) (16078) register_task: registering signal task (0x807cec4)
48 Dec 29 02:12:57 (0) (16078) register_task: pre_select: 0x807cec4
49 Dec 29 02:12:57 (1) (16077) acl_add_entry: adding 192.168.0.0/24 to access list
50 Dec 29 02:12:57 (0) (16078) register_task: post_select: 0x807cec8
51 Dec 29 02:12:57 (1) (16077) acl_add_entry: adding 127.0.0.1/32 to access list
52 Dec 29 02:12:57 (1) (16078) get_database_dir: afs_database dir /home/maan/.paraslash/afs_database-0.4
53 Dec 29 02:12:57 (2) (16078) open_afs_tables: opening 7 osl tables in /home/maan/.paraslash/afs_database-0.4
54 Dec 29 02:12:57 (1) (16077) para_listen: listening on TCP port 8000, fd 7
55 Dec 29 02:12:57 (2) (16077) init_vss_task: initializing dccp sender
56 Dec 29 02:12:57 (1) (16077) para_listen: listening on DCCP port 8000, fd 8
57 Dec 29 02:12:57 (2) (16077) init_vss_task: initializing udp sender
58 Dec 29 02:12:57 (1) (16077) udp_com_add: adding to target list (224.0.1.38:8000)
59 Dec 29 02:12:57 (1) (16077) udp_com_add: adding to target list (192.168.0.2:8000)
60 Dec 29 02:12:57 (0) (16077) udp_send_init: udp sender init complete
61 Dec 29 02:12:57 (1) (16077) register_task: registering vss task (0x807c65c)
62 Dec 29 02:12:57 (0) (16077) register_task: pre_select: 0x807c65c
63 Dec 29 02:12:57 (0) (16077) register_task: post_select: 0x807c660
64 Dec 29 02:12:57 (2) (16077) init_server_command_task: initializing tcp command socket
65 Dec 29 02:12:57 (1) (16077) para_listen: listening on TCP port 2990, fd 11
66 Dec 29 02:12:57 (1) (16077) register_task: registering server command task (0x807c2c0)
67 Dec 29 02:12:57 (0) (16077) register_task: pre_select: 0x807c2c0
68 Dec 29 02:12:57 (0) (16077) register_task: post_select: 0x807c2c4
69 Dec 29 02:12:57 (2) (16077) server_init: server init complete
70 Dec 29 02:12:57 (0) (16077) status_refresh: 0 events, forcing status update
71 Dec 29 02:12:57 (1) (16078) aft_open: audio file table contains 9212 files
72 Dec 29 02:12:57 (1) (16078) afs_init: server_socket: 5, afs_socket_cookie: 3213854017
73 Dec 29 02:12:57 (0) (16078) parse_mood_line: accept entry added, method: 0x806fdac
74 Dec 29 02:12:57 (2) (16078) change_current_mood: computing statistics of admissible files
75 Dec 29 02:12:57 (1) (16078) log_statistics: last_played mean: 1385279255, last_played sigma: 2805987
76 Dec 29 02:12:57 (1) (16078) log_statistics: num_played mean: 48, num_played sigma: 18
77 Dec 29 02:12:57 (1) (16078) change_current_mood: 26 admissible files
78 Dec 29 02:12:57 (2) (16078) change_current_mood: loaded mood gulp
79 Dec 29 02:12:57 (1) (16078) setup_command_socket_or_die: listening on socket /var/paraslash/afs_command_socket-0.4 (fd 7)
80 Dec 29 02:12:57 (1) (16078) register_task: registering afs command task (0x807cfec)
81 Dec 29 02:12:57 (0) (16078) register_task: pre_select: 0x807cfec
82 Dec 29 02:12:57 (0) (16078) register_task: post_select: 0x807cff0
83 Dec 29 02:12:57 (1) (16077) command_post_select: got connection from 192.168.0.4:60731, forking
84 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 11
85 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 10
86 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 9
87 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 8
88 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 7
89 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 5
90 Dec 29 02:12:57 (0) (16079) close_listed_fds: closing fd 4
91 Dec 29 02:12:57 (0) (16079) para_sigaction: catching signal 17
92 Dec 29 02:12:57 (0) (16079) para_sigaction: catching signal 2
93 Dec 29 02:12:57 (0) (16079) para_sigaction: catching signal 15
94 Dec 29 02:12:57 (0) (16079) para_sigaction: catching signal 1
95 Dec 29 02:12:57 (0) (16079) parse_auth_request: received auth request for user maan
96 Dec 29 02:12:57 (0) (16079) handle_connect: received auth request for user maan
97 Dec 29 02:12:57 (0) (16079) handle_connect: sending 64 byte challenge + rc4 keys (256 bytes)
98 Dec 29 02:12:57 (0) (16079) handle_connect: received 20 bytes challenge response
99 Dec 29 02:12:57 (1) (16079) handle_connect: good auth for maan
100 Dec 29 02:12:57 (0) (16079) check_perms: checking permissions
101 Dec 29 02:12:57 (2) (16079) handle_connect: calling com_stat() for maan@192.168.0.4:60731
102 Dec 29 02:12:57 (0) (16079) para_sigaction: catching signal 10
103 Dec 29 02:13:02 (1) (16077) command_post_select: got connection from 192.168.0.1:58527, forking
104 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 11
105 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 10
106 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 9
107 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 8
108 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 7
109 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 5
110 Dec 29 02:13:02 (0) (16080) close_listed_fds: closing fd 4
111 Dec 29 02:13:02 (0) (16080) para_sigaction: catching signal 17
112 Dec 29 02:13:02 (0) (16080) para_sigaction: catching signal 2
113 Dec 29 02:13:02 (0) (16080) para_sigaction: catching signal 15
114 Dec 29 02:13:02 (0) (16080) para_sigaction: catching signal 1
115 Dec 29 02:13:02 (0) (16080) parse_auth_request: received auth request for user maan
116 Dec 29 02:13:02 (0) (16080) handle_connect: received auth request for user maan
117 Dec 29 02:13:02 (0) (16080) handle_connect: sending 64 byte challenge + rc4 keys (256 bytes)
118 Dec 29 02:13:02 (0) (16080) handle_connect: received 20 bytes challenge response
119 Dec 29 02:13:02 (1) (16080) handle_connect: good auth for maan
120 Dec 29 02:13:02 (0) (16080) check_perms: checking permissions
121 Dec 29 02:13:02 (2) (16080) handle_connect: calling com_stat() for maan@192.168.0.1:58527
122 Dec 29 02:13:02 (0) (16080) para_sigaction: catching signal 10
123 Dec 29 02:13:09 (1) (16077) command_post_select: got connection from 192.168.0.1:58528, forking
124 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 11
125 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 10
126 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 9
127 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 8
128 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 7
129 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 5
130 Dec 29 02:13:09 (0) (16089) close_listed_fds: closing fd 4
131 Dec 29 02:13:09 (0) (16089) para_sigaction: catching signal 17
132 Dec 29 02:13:09 (0) (16089) para_sigaction: catching signal 2
133 Dec 29 02:13:09 (0) (16089) para_sigaction: catching signal 15
134 Dec 29 02:13:09 (0) (16089) para_sigaction: catching signal 1
135 Dec 29 02:13:09 (0) (16089) parse_auth_request: received auth request for user maan
136 Dec 29 02:13:09 (0) (16089) handle_connect: received auth request for user maan
137 Dec 29 02:13:09 (0) (16089) handle_connect: sending 64 byte challenge + rc4 keys (256 bytes)
138 Dec 29 02:13:09 (0) (16089) handle_connect: received 20 bytes challenge response
139 Dec 29 02:13:09 (1) (16089) handle_connect: good auth for maan
140 Dec 29 02:13:09 (0) (16089) check_perms: checking permissions
141 Dec 29 02:13:09 (2) (16089) handle_connect: calling com_play() for maan@192.168.0.1:58528
142 Dec 29 02:13:09 (0) (16077) para_next_signal: next signal: 17
143 Dec 29 02:13:09 (0) (16077) para_reap_child: child 16089 exited. Exit status: 0
144 Dec 29 02:13:09 (0) (16077) vss_pre_select: ready and playing, but no audio file
145 Dec 29 02:13:09 (0) (16077) status_refresh: 1 events, forcing status update
146 Dec 29 02:13:09 (2) (16077) vss_post_select: requesting new fd from afs
147 Dec 29 02:13:09 (2) (16078) open_next_audio_file: getting next audio file
148 Dec 29 02:13:09 (2) (16078) open_and_update_audio_file: /home/mp3/checked/dvd_07/cd_45/The_G.U.L.P.__Popstar.ogg
149 Dec 29 02:13:09 (1) (16078) shm_get_shmmax: shmmax: 33554432
150 Dec 29 02:13:09 (0) (16078) mood_update_audio_file: score: -11
151 Dec 29 02:13:09 (0) (16078) mood_update_audio_file: moving from rank 26 to 29%
152 Dec 29 02:13:09 (0) (16078) score_update: new score: -13, rank 8/26
153 Dec 29 02:13:09 (0) (16078) score_update: new score: -67, rank 1/26
154 Dec 29 02:13:09 (0) (16078) pass_afd: passing 8 bytes and fd 8
155 Dec 29 02:13:09 (0) (16077) recv_afs_result: fd: 12, code: 0, shmid: 121700353
156 Dec 29 02:13:09 (0) (16077) vorbis_get_header_callback: processing ogg packet #0
157 Dec 29 02:13:09 (0) (16077) add_ogg_page: header/body/old/new: 28/30/0/58
158 Dec 29 02:13:09 (1) (16077) process_packets_2_and_3: ogg page serial: 867600341
159 Dec 29 02:13:09 (0) (16077) vorbis_get_header_callback: processing ogg packet #1
160 Dec 29 02:13:09 (1) (16077) vorbis_get_header_callback: replacing metadata packet
161 Dec 29 02:13:09 (1) (16077) process_packets_2_and_3: ogg page serial: 867600341
162 Dec 29 02:13:09 (0) (16077) vorbis_get_header_callback: processing ogg packet #2
163 Dec 29 02:13:09 (0) (16077) add_ogg_page: header/body/old/new: 45/4247/58/4350
164 Dec 29 02:13:09 (1) (16077) vorbis_get_header: created 4350 byte ogg vorbis header
165 Dec 29 02:13:09 (0) (16077) chk_barrier: data send barrier: 203ms left
166 Dec 29 02:13:09 (0) (16077) status_refresh: 2 events, forcing status update
167 Dec 29 02:13:09 (0) (16079) connect_local_socket: connecting to /var/paraslash/afs_command_socket-0.4
168 Dec 29 02:13:09 (0) (16080) connect_local_socket: connecting to /var/paraslash/afs_command_socket-0.4
169 Dec 29 02:13:09 (2) (16077) udp_init_session: sending to udp 192.168.0.2:8000
170 Dec 29 02:13:09 (1) (16077) udp_init_fec: current MPS = 548 bytes
171 Dec 29 02:13:09 (1) (16077) initialize_fec_client: mps: 548, k: 26, n: 28, extra slices: 12
172 Dec 29 02:13:09 (0) (16077) set_group_timing: durations (group/chunk/slice): 226/226/8
173 Dec 29 02:13:09 (0) (16077) setup_next_fec_group: FEC group 0: 1 chunks (0 - 0), 4350 bytes
174 Dec 29 02:13:09 (0) (16077) setup_next_fec_group: slice_bytes: 168, 0 header slices, 26 data slices
175 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:0 (168 bytes)
176 Dec 29 02:13:09 (2) (16077) udp_init_session: sending to udp 224.0.1.38:8000
177 Dec 29 02:13:09 (1) (16077) udp_init_fec: current MPS = 548 bytes
178 Dec 29 02:13:09 (1) (16077) initialize_fec_client: mps: 548, k: 26, n: 27, extra slices: 24
179 Dec 29 02:13:09 (0) (16077) set_group_timing: durations (group/chunk/slice): 226/226/8
180 Dec 29 02:13:09 (0) (16077) setup_next_fec_group: FEC group 0: 1 chunks (0 - 0), 4350 bytes
181 Dec 29 02:13:09 (0) (16077) setup_next_fec_group: slice_bytes: 168, 0 header slices, 26 data slices
182 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:0 (168 bytes)
183 Dec 29 02:13:09 (0) (16077) status_refresh: 3 events, forcing status update
184 Dec 29 02:13:09 (0) (16079) connect_local_socket: connecting to /var/paraslash/afs_command_socket-0.4
185 Dec 29 02:13:09 (0) (16080) connect_local_socket: connecting to /var/paraslash/afs_command_socket-0.4
186 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:1 (168 bytes)
187 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:1 (168 bytes)
188 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:2 (168 bytes)
189 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:2 (168 bytes)
190 Dec 29 02:13:09 (0) (16077) vss_send: sending 0:3 (168 bytes)