Dec 08 19:28:58 2: (21285) log_welcome: welcome to para_server git (Sat Dec 8 13:42:52 MET 2007) Dec 08 19:28:58 1: (21285) log_welcome: using loglevel 1 Dec 08 19:28:58 1: (21285) populate_user_list: found entry for maan Dec 08 19:28:58 1: (21285) populate_user_list: found 4 perm entries Dec 08 19:28:58 1: (21285) populate_user_list: found entry for install Dec 08 19:28:58 1: (21285) populate_user_list: found 4 perm entries Dec 08 19:28:58 1: (21285) populate_user_list: found entry for www Dec 08 19:28:58 1: (21285) populate_user_list: found 4 perm entries Dec 08 19:28:58 2: (21285) daemon_init: daemonizing Dec 08 19:28:58 3: (21286) server_init: initializing audio format handlers Dec 08 19:28:58 2: (21286) afh_init: supported audio formats: mp3 ogg aac Dec 08 19:28:58 3: (21286) afh_init: initializing mp3 handler Dec 08 19:28:58 3: (21286) afh_init: initializing ogg handler Dec 08 19:28:58 3: (21286) afh_init: initializing aac handler Dec 08 19:28:58 3: (21286) server_init: initializing virtual streaming system Dec 08 19:28:58 2: (21286) vss_init: announce timeval: 300ms Dec 08 19:28:58 3: (21286) vss_init: initializing http sender Dec 08 19:28:58 2: (21286) para_listen: listening on TCP port 8000, fd 4 Dec 08 19:28:58 1: (21286) http_send_init: http sender init complete Dec 08 19:28:58 3: (21286) vss_init: initializing dccp sender Dec 08 19:28:58 2: (21286) para_listen: listening on DCCP port 5001, fd 5 Dec 08 19:28:58 3: (21286) vss_init: initializing ortp sender Dec 08 19:28:58 1: (21286) ortp_send_init: ortp sender init complete Dec 08 19:28:58 3: (21286) setup_signal_handling: setting up signal handlers Dec 08 19:28:58 1: (21286) para_install_sighandler: catching signal 2 Dec 08 19:28:58 1: (21286) para_install_sighandler: catching signal 15 Dec 08 19:28:58 1: (21286) para_install_sighandler: catching signal 1 Dec 08 19:28:58 1: (21286) para_install_sighandler: catching signal 17 Dec 08 19:28:58 1: (21286) para_install_sighandler: catching signal 10 Dec 08 19:28:58 3: (21286) server_init: initializing the audio file selector Dec 08 19:28:58 2: (21287) get_database_dir: afs_database dir /home/maan/.paraslash/afs_database Dec 08 19:28:58 3: (21287) open_afs_tables: opening 7 osl tables in /home/maan/.paraslash/afs_database Dec 08 19:28:58 2: (21287) osl_open_table: opening table audio_files Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'audio_files' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 32 Dec 08 19:28:58 1: (21287) map_table: mapping table 'audio_files' (index: /home/maan/.paraslash/afs_database/audio_files/index) Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/audio_files/index: size 218667 Dec 08 19:28:58 1: (21287) read_table_desc: 5 columns Dec 08 19:28:58 1: (21287) compare_table_descriptions: table description of 'audio_files' matches on-disk data, good Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/audio_files/2346ad27d7568ba9896f1b7da6b5991251debdf2: size 143430 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/audio_files/3150ecd5e0294534a81ae047ddac559de481d774: size 436636 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/audio_files/94ea39e309f3f31357ab60b190b6b8c32f21620b: size 225390 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/audio_files/b063ad096f9d142a388ca2a10d46b56904e26cda: size 1174409 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 6830 Dec 08 19:28:58 2: (21286) init_afs: afs_socket: 8, afs_socket_cookie: 1363241225 Dec 08 19:28:58 3: (21286) server_init: initializing tcp command socket Dec 08 19:28:58 2: (21286) para_listen: listening on TCP port 2990, fd 9 Dec 08 19:28:58 3: (21286) server_init: server init complete Dec 08 19:28:58 1: (21286) chk_barrier: autoplay_delay barrier: 14981ms left Dec 08 19:28:58 1: (21286) status_refresh: 0 events, forcing status update Dec 08 19:28:58 1: (21286) para_next_signal: next signal: 10 Dec 08 19:28:58 1: (21286) chk_barrier: autoplay_delay barrier: 14981ms left Dec 08 19:28:58 1: (21286) para_next_signal: next signal: 10 Dec 08 19:28:58 1: (21286) chk_barrier: autoplay_delay barrier: 14981ms left Dec 08 19:28:58 2: (21287) aft_open: audio file table contains 6830 files Dec 08 19:28:58 2: (21287) osl_open_table: opening table attributes Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'attributes' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 16 Dec 08 19:28:58 1: (21287) map_table: mapping table 'attributes' (index: /home/maan/.paraslash/afs_database/attributes/index) Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/attributes/index: size 396 Dec 08 19:28:58 1: (21287) read_table_desc: 2 columns Dec 08 19:28:58 1: (21287) compare_table_descriptions: table description of 'attributes' matches on-disk data, good Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/attributes/fd1e48caeff7212c45fc08608b7187feb10a7a2d: size 42 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/attributes/6ae999552a0d2dca14d62e2bc8b764d377b1dd6c: size 141 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 21 Dec 08 19:28:58 2: (21287) osl_open_table: opening table score Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'score' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 0 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 0 Dec 08 19:28:58 2: (21287) osl_open_table: opening table moods Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'moods' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 16 Dec 08 19:28:58 1: (21287) map_table: mapping table 'moods' (index: /home/maan/.paraslash/afs_database/moods/index) Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/moods/index: size 235 Dec 08 19:28:58 1: (21287) read_table_desc: 3 columns Dec 08 19:28:58 1: (21287) compare_table_descriptions: table description of 'moods' matches on-disk data, good Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/moods/87ea5dfc8b8e384d848979496e706390b497e547: size 50 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/moods/6ae999552a0d2dca14d62e2bc8b764d377b1dd6c: size 67 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 10 Dec 08 19:28:58 2: (21287) osl_open_table: opening table lyrics Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'lyrics' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 16 Dec 08 19:28:58 1: (21287) map_table: mapping table 'lyrics' (index: /home/maan/.paraslash/afs_database/lyrics/index) Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/lyrics/index: size 347 Dec 08 19:28:58 1: (21287) read_table_desc: 3 columns Dec 08 19:28:58 1: (21287) compare_table_descriptions: table description of 'lyrics' matches on-disk data, good Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/lyrics/87ea5dfc8b8e384d848979496e706390b497e547: size 85 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/lyrics/6ae999552a0d2dca14d62e2bc8b764d377b1dd6c: size 478 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 17 Dec 08 19:28:58 2: (21287) osl_open_table: opening table images Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'images' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 16 Dec 08 19:28:58 1: (21287) map_table: mapping table 'images' (index: /home/maan/.paraslash/afs_database/images/index) Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/images/index: size 7227 Dec 08 19:28:58 1: (21287) read_table_desc: 3 columns Dec 08 19:28:58 1: (21287) compare_table_descriptions: table description of 'images' matches on-disk data, good Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/images/87ea5dfc8b8e384d848979496e706390b497e547: size 2235 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/images/6ae999552a0d2dca14d62e2bc8b764d377b1dd6c: size 12950 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 447 Dec 08 19:28:58 2: (21287) osl_open_table: opening table playlists Dec 08 19:28:58 1: (21287) init_table_structure: creating table structure for 'playlists' from table description Dec 08 19:28:58 1: (21287) init_table_structure: OK. Index entry size: 16 Dec 08 19:28:58 1: (21287) map_table: mapping table 'playlists' (index: /home/maan/.paraslash/afs_database/playlists/index) Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/playlists/index: size 107 Dec 08 19:28:58 1: (21287) read_table_desc: 3 columns Dec 08 19:28:58 1: (21287) compare_table_descriptions: table description of 'playlists' matches on-disk data, good Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/playlists/87ea5dfc8b8e384d848979496e706390b497e547: size 10 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/playlists/6ae999552a0d2dca14d62e2bc8b764d377b1dd6c: size 7 Dec 08 19:28:58 1: (21287) osl_open_table: num rows: 2 Dec 08 19:28:58 2: (21287) afs_init: server_socket: 9, afs_socket_cookie: 1363241225 Dec 08 19:28:58 1: (21287) osl_open_disk_object: filename: /home/maan/.paraslash/afs_database/moods/f3f1dd33eb2a8b380b64a830e5fd90eab77d9ff3/9d/b063f3b5e0adfd0d29a03db0a1c207b3740a94 Dec 08 19:28:58 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/moods/f3f1dd33eb2a8b380b64a830e5fd90eab77d9ff3/9d/b063f3b5e0adfd0d29a03db0a1c207b3740a94: size 31 Dec 08 19:28:58 1: (21287) parse_mood_line: accept entry added, method: 0x806c0f4 Dec 08 19:28:58 3: (21287) change_current_mood: computing statistics of admissible files Dec 08 19:28:58 2: (21287) log_statistics: last_played mean: 1193159581, last_played sigma: 4161524 Dec 08 19:28:58 2: (21287) log_statistics: num_played mean: 32, num_played sigma: 21 Dec 08 19:28:58 2: (21287) change_current_mood: 26 admissible files Dec 08 19:28:58 3: (21287) change_current_mood: loaded mood gulp Dec 08 19:28:58 2: (21287) register_signal_task: signal pipe: fd 8 Dec 08 19:28:58 1: (21287) para_install_sighandler: catching signal 2 Dec 08 19:28:58 1: (21287) para_install_sighandler: catching signal 15 Dec 08 19:28:58 1: (21287) para_install_sighandler: catching signal 13 Dec 08 19:28:58 1: (21287) para_install_sighandler: catching signal 1 Dec 08 19:28:58 2: (21287) init_sched: initializing scheduler Dec 08 19:28:58 2: (21287) register_task: registering signal task (0x806f244) Dec 08 19:28:58 1: (21287) register_task: pre_select: 0x806f248 Dec 08 19:28:58 1: (21287) register_task: post_select: 0x806f248 Dec 08 19:28:58 2: (21287) setup_command_socket_or_die: listening on socket /var/paraslash/afs_command_socket (fd 1) Dec 08 19:28:58 2: (21287) register_task: registering command task (0x806f118) Dec 08 19:28:58 1: (21287) register_task: pre_select: 0x806f11c Dec 08 19:28:58 1: (21287) register_task: post_select: 0x806f11c Dec 08 19:28:59 2: (21286) main: got connection from ::ffff:127.0.0.1#42344, forking Dec 08 19:28:59 1: (21356) close_listed_fds: closing fd 9 Dec 08 19:28:59 1: (21356) close_listed_fds: closing fd 8 Dec 08 19:28:59 1: (21356) close_listed_fds: closing fd 6 Dec 08 19:28:59 1: (21356) close_listed_fds: closing fd 5 Dec 08 19:28:59 1: (21356) close_listed_fds: closing fd 4 Dec 08 19:28:59 1: (21286) chk_barrier: autoplay_delay barrier: 13507ms left Dec 08 19:28:59 1: (21356) handle_connect: received rc4 request for user maan Dec 08 19:28:59 1: (21356) handle_connect: sending 64 byte challenge Dec 08 19:28:59 2: (21356) handle_connect: good auth for maan (1081806111) Dec 08 19:28:59 1: (21356) init_rc4_keys: rc4 keys initialized (84:105) Dec 08 19:28:59 2: (21356) enable_crypt: rc4 encryption activated for fd 10 Dec 08 19:28:59 3: (21356) handle_connect: invalid command Dec 08 19:28:59 1: (21286) para_next_signal: next signal: 17 Dec 08 19:28:59 1: (21286) para_reap_child: child 21356 exited. Exit status: 1 Dec 08 19:28:59 1: (21286) chk_barrier: autoplay_delay barrier: 13498ms left Dec 08 19:29:03 2: (21286) main: got connection from ::ffff:127.0.0.1#42345, forking Dec 08 19:29:03 1: (21362) close_listed_fds: closing fd 9 Dec 08 19:29:03 1: (21362) close_listed_fds: closing fd 8 Dec 08 19:29:03 1: (21362) close_listed_fds: closing fd 6 Dec 08 19:29:03 1: (21362) close_listed_fds: closing fd 5 Dec 08 19:29:03 1: (21362) close_listed_fds: closing fd 4 Dec 08 19:29:03 1: (21286) chk_barrier: autoplay_delay barrier: 9951ms left Dec 08 19:29:03 1: (21362) handle_connect: received rc4 request for user maan Dec 08 19:29:03 1: (21362) handle_connect: sending 64 byte challenge Dec 08 19:29:03 2: (21362) handle_connect: good auth for maan (705434988) Dec 08 19:29:03 1: (21362) init_rc4_keys: rc4 keys initialized (18:65) Dec 08 19:29:03 2: (21362) enable_crypt: rc4 encryption activated for fd 10 Dec 08 19:29:03 1: (21362) check_perms: checking permissions Dec 08 19:29:03 3: (21362) handle_connect: calling com_stat() for maan@::ffff:127.0.0.1#42345 Dec 08 19:29:13 1: (21286) chk_barrier: autoplay_delay barrier: 3ms left Dec 08 19:29:13 1: (21286) vss_preselect: ready and playing, but no audio file Dec 08 19:29:13 3: (21286) vss_post_select: requesting new fd from afs Dec 08 19:29:13 1: (21287) execute_server_command: received: new Dec 08 19:29:13 3: (21287) open_next_audio_file: getting next audio file Dec 08 19:29:13 1: (21287) osl_open_disk_object: filename: /home/maan/.paraslash/afs_database/audio_files/7e078c9876ccabef154017c770e05195c85b5e4d/55/b5e38d467105bd88133cf5ded70e551e582593 Dec 08 19:29:13 1: (21287) mmap_full_file: /home/maan/.paraslash/afs_database/audio_files/7e078c9876ccabef154017c770e05195c85b5e4d/55/b5e38d467105bd88133cf5ded70e551e582593: size 4532 Dec 08 19:29:13 1: (21287) mmap_full_file: /home/mp3/checked/dvd_07/cd_46/The_G.U.L.P.__Scheiss_Krieg.ogg: size 5274482 Dec 08 19:29:13 1: (21287) mood_update_audio_file: score: 6 Dec 08 19:29:13 1: (21287) mood_update_audio_file: moving from rank 26 to 35% Dec 08 19:29:13 1: (21287) score_update: new score: 0, rank 9/26 Dec 08 19:29:13 1: (21287) osl_update_object: updating column 1 of score Dec 08 19:29:13 1: (21287) score_update: new score: -65, rank 1/26 Dec 08 19:29:13 1: (21287) osl_update_object: updating column 1 of score Dec 08 19:29:13 1: (21287) save_afd: size: 8932 Dec 08 19:29:13 1: (21287) pass_afd: passing 8 bytes and fd 12 Dec 08 19:29:13 1: (21286) recv_afs_result: fd: 10, code: 0, shmid: 28442631 Dec 08 19:29:13 1: (21286) chk_barrier: data send barrier: 300ms left Dec 08 19:29:13 1: (21286) status_refresh: 1 events, forcing status update Dec 08 19:29:13 1: (21286) chk_barrier: data send barrier: 300ms left Dec 08 19:29:13 1: (21286) chk_barrier: data send barrier: 300ms left Dec 08 19:29:13 1: (21286) para_next_signal: next signal: 10 Dec 08 19:29:13 1: (21286) chk_barrier: data send barrier: 300ms left Dec 08 19:29:13 3: (21286) dccp_post_select: connection from ::ffff:127.0.0.1#46539 Dec 08 19:29:13 1: (21286) chk_barrier: data send barrier: 287ms left Dec 08 19:29:13 1: (21286) chk_barrier: data send barrier: 287ms left Dec 08 19:29:13 1: (21287) para_next_signal: next signal: 10 Dec 08 19:29:13 1: (21286) status_refresh: 2 events, forcing status update Dec 08 19:29:13 1: (21286) para_next_signal: next signal: 10 Dec 08 19:29:13 1: (21287) para_next_signal: next signal: 10 Dec 08 19:29:14 1: (21286) cq_enqueue: 4446 bytes queued for 0x8072eb0