4681: [dbus/dbus-dataslot.c(146):_dbus_data_slot_allocator_alloc] Allocated slot 0 on allocator 0x80a5c1c total 1 slots allocated 1 used
4681: [dbus/dbus-sysdeps-unix.c(2662):_dbus_generate_random_bytes] /dev/urandom fd 3 opened
4681: [dbus/dbus-sysdeps-unix.c(2672):_dbus_generate_random_bytes] Read 12 bytes from /dev/urandom
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 3 opened
4681: [dbus/dbus-userdb.c(166):_dbus_user_database_lookup] No cache for UID 1010
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 1000000000 for limit max_incoming_bytes
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 1000000000 for limit max_outgoing_bytes
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 1000000000 for limit max_message_size
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 120000 for limit service_start_timeout
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 240000 for limit auth_timeout
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 100000 for limit max_completed_connections
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 10000 for limit max_incomplete_connections
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 100000 for limit max_connections_per_user
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 10000 for limit max_pending_service_starts
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 50000 for limit max_names_per_connection
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 50000 for limit max_match_rules_per_connection
4681: [bus/config-parser.c(2566):bus_config_parser_content] Loaded value 50000 for limit max_replies_per_connection
4681: [dbus/dbus-sysdeps-unix.c(122):_dbus_open_socket] socket fd 3 opened
4681: [dbus/dbus-sysdeps-unix.c(2662):_dbus_generate_random_bytes] /dev/urandom fd 4 opened
4681: [dbus/dbus-sysdeps-unix.c(2672):_dbus_generate_random_bytes] Read 12 bytes from /dev/urandom
4681: [dbus/dbus-server.c(136):_dbus_server_init_base] Initialized server on address tcp:host=192.168.0.10,port=12345,guid=24c4d2c8f0b67785f25e78960000a2b2
4681: [dbus/dbus-watch.c(296):_dbus_watch_list_set_functions] Adding a read watch on fd 3 using newly-set add watch function
4681: [bus/activation.c(612):update_directory] Failed to open directory /usr/local/share/dbus-1/services: Failed to read directory "/usr/local/share/dbus-1/services": No such file or directory
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "vandenoever.strigi" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_DD_Mstk_2.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "net.ekiga.instance" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "org.gnome.GnomeVFS.Daemon" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.basyskom.minigui" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_bl_Mstk_3.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "org.gnome.SettingsDaemon" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.basyskom.simpleclient" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_DD_Mstk_1.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_bl_Mstk_0.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_DD_Mstk_3.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_DD_Mstk_0.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.basyskom.Decibel.Log" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "net.ekiga.helper" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_bl_Mstk_1.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.TCSC.Body" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "org.freedesktop.xesam.searcher" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "org.kde.knotify" to list of services
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 5 opened
4681: [bus/activation.c(412):update_desktop_file_entry] Added "de.dlr.SCOS.IMstk_bl_Mstk_2.Body" to list of services
4681: [bus/activation.c(612):update_directory] Failed to open directory /etc/opt/kde3/share/dbus-1/services: Failed to read directory "/etc/opt/kde3/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/gcc-3.3.6/share/dbus-1/services: Failed to read directory "/opt/gcc-3.3.6/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/kde3/share/dbus-1/services: Failed to read directory "/opt/kde3/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/libsmi-0.4.8/share/dbus-1/services: Failed to read directory "/opt/libsmi-0.4.8/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/omniORB_401.gcc3.2/share/dbus-1/services: Failed to read directory "/opt/omniORB_401.gcc3.2/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/qtsdk-2010.03/share/dbus-1/services: Failed to read directory "/opt/qtsdk-2010.03/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/RealPlayer/share/dbus-1/services: Failed to read directory "/opt/RealPlayer/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /opt/wireshark-1.0.5/share/dbus-1/services: Failed to read directory "/opt/wireshark-1.0.5/share/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /usr/share/gnome/help/dbus-1/services: Failed to read directory "/usr/share/gnome/help/dbus-1/services": No such file or directory
4681: [bus/activation.c(612):update_directory] Failed to open directory /home/sops31/.local/share/dbus-1/services: Failed to read directory "/home/sops31/.local/share/dbus-1/services": No such file or directory
4681: [dbus/dbus-dataslot.c(146):_dbus_data_slot_allocator_alloc] Allocated slot 0 on allocator 0x80a5be0 total 1 slots allocated 1 used
4681: [bus/bus.c(846):bus_context_new] Fork not requested
4681: [dbus/dbus-sysdeps-util-unix.c(246):_dbus_write_pid_to_file_and_pipe] No pid file requested
4681: [dbus/dbus-sysdeps-util-unix.c(288):_dbus_write_pid_to_file_and_pipe] No pid pipe to write to
4681: [dbus/dbus-sysdeps-unix.c(2958):_dbus_full_duplex_pipe] full-duplex pipe 5 <-> 6
4681: [bus/main.c(519):main] We are on D-Bus...
4681: [dbus/dbus-mainloop.c(872):_dbus_loop_run] Running main loop, depth 0 -> 1
4681: [dbus/dbus-server-socket.c(183):socket_handle_watch] Handling client connection, flags 0x1
4681: [dbus/dbus-sysdeps-unix.c(1844):_dbus_accept] client fd 7 accepted
4681: [dbus/dbus-server-socket.c(96):handle_new_client_fd_and_unlock] Creating new client connection with fd 7
4681: [dbus/dbus-connection.c(1338):_dbus_connection_new_for_transport] LOCK
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 1
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-connection.c(1349):_dbus_connection_new_for_transport] UNLOCK
4681: [dbus/dbus-connection.c(5423):dbus_connection_set_route_peer_messages] LOCK
4681: [dbus/dbus-connection.c(5425):dbus_connection_set_route_peer_messages] UNLOCK
4681: [dbus/dbus-connection.c(4877):dbus_connection_set_watch_functions] LOCK
4681: [dbus/dbus-watch.c(296):_dbus_watch_list_set_functions] Adding a write watch on fd 7 using newly-set add watch function
4681: [dbus/dbus-watch.c(296):_dbus_watch_list_set_functions] Adding a read watch on fd 7 using newly-set add watch function
4681: [dbus/dbus-connection.c(4884):dbus_connection_set_watch_functions] UNLOCK
4681: [dbus/dbus-connection.c(4940):dbus_connection_set_timeout_functions] LOCK
4681: [dbus/dbus-connection.c(4947):dbus_connection_set_timeout_functions] UNLOCK
4681: [dbus/dbus-connection.c(5254):dbus_connection_set_unix_user_function] LOCK
4681: [dbus/dbus-connection.c(5258):dbus_connection_set_unix_user_function] UNLOCK
4681: [dbus/dbus-connection.c(5023):dbus_connection_set_dispatch_status_function] LOCK
4681: [dbus/dbus-connection.c(5031):dbus_connection_set_dispatch_status_function] UNLOCK
4681: [dbus/dbus-connection.c(5466):dbus_connection_add_filter] LOCK
4681: [dbus/dbus-connection.c(5485):dbus_connection_add_filter] UNLOCK
4681: [dbus/dbus-connection.c(4351):dbus_connection_get_dispatch_status] start
4681: [dbus/dbus-connection.c(4353):dbus_connection_get_dispatch_status] LOCK
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4357):dbus_connection_get_dispatch_status] UNLOCK
4681: [bus/connection.c(827):bus_connections_expire_incomplete] Connection 0x80aa160 authentication expires in 239999 milliseconds
4681: [bus/expirelist.c(116):bus_expire_timeout_set_interval] Enabled an expire timeout with interval 239999
4681: [dbus/dbus-connection.c(6111):dbus_connection_set_max_received_size] LOCK
4681: [dbus/dbus-connection.c(6114):dbus_connection_set_max_received_size] UNLOCK
4681: [dbus/dbus-connection.c(6016):dbus_connection_set_max_message_size] LOCK
4681: [dbus/dbus-message.c(4263):_dbus_message_loader_set_max_message_size] clamping requested max message size 1000000000 to 134217728
4681: [dbus/dbus-connection.c(6019):dbus_connection_set_max_message_size] UNLOCK
4681: [dbus/dbus-connection.c(6153):dbus_connection_set_max_received_unix_fds] LOCK
4681: [dbus/dbus-connection.c(6156):dbus_connection_set_max_received_unix_fds] UNLOCK
4681: [dbus/dbus-connection.c(6055):dbus_connection_set_max_message_unix_fds] LOCK
4681: [dbus/dbus-connection.c(6058):dbus_connection_set_max_message_unix_fds] UNLOCK
4681: [dbus/dbus-connection.c(5395):dbus_connection_set_allow_anonymous] LOCK
4681: [dbus/dbus-connection.c(5397):dbus_connection_set_allow_anonymous] UNLOCK
4681: [dbus/dbus-connection.c(2129):_dbus_connection_close_if_only_one_ref] LOCK
4681: [dbus/dbus-connection.c(2136):_dbus_connection_close_if_only_one_ref] UNLOCK
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(919):socket_handle_watch] handling read watch 0x80a9908 flags = 1
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-sysdeps-unix.c(1657):_dbus_read_credentials_socket] read credentials byte
4681: [dbus/dbus-sysdeps-unix.c(1752):_dbus_read_credentials_socket] Credentials:  pid 0  uid 4294967295
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(263):read_data_into_auth]  read 24 bytes in auth phase
4681: [dbus/dbus-auth.c(2199):process_command] server: got command "AUTH EXTERNAL 31303130"
4681: [dbus/dbus-auth.c(1716):handle_auth] server: Trying mechanism EXTERNAL
4681: [dbus/dbus-auth.c(1636):process_data] server: data: '1010'
4681: [dbus/dbus-auth.c(1026):handle_server_data_external_mech] server: no credentials, mechanism EXTERNAL can't authenticate
4681: [dbus/dbus-auth.c(430):shutdown_mech] server: Shutting down mechanism EXTERNAL
4681: [dbus/dbus-auth.c(2146):goto_state] server: going from state WaitingForAuth to state WaitingForAuth
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-transport-socket.c(460):do_authentication]  server auth state: bytes to send
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 0
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 1 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-transport-socket.c(703):do_reading] fd = 7
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(948):socket_handle_watch] handling write watch, have_outgoing_messages = 0
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 0, do_writing = 1
4681: [dbus/dbus-transport-socket.c(460):do_authentication]  server auth state: bytes to send
4681: [dbus/dbus-auth.c(2518):_dbus_auth_bytes_sent] server: Sent 46 bytes of: REJECTED EXTERNAL DBUS_COOKIE_SHA1 ANONYMOUS

4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 0, do_writing = 1
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 1
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-transport-socket.c(503):do_writing] Not authenticated, not writing anything
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(919):socket_handle_watch] handling read watch 0x80a9908 flags = 1
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(263):read_data_into_auth]  read 36 bytes in auth phase
4681: [dbus/dbus-auth.c(2199):process_command] server: got command "AUTH DBUS_COOKIE_SHA1 736f70733331"
4681: [dbus/dbus-auth.c(1716):handle_auth] server: Trying mechanism DBUS_COOKIE_SHA1
4681: [dbus/dbus-auth.c(1636):process_data] server: data: 'sops31'
4681: [dbus/dbus-userdb.c(156):_dbus_user_database_lookup] Using cache for UID 1010 information
4681: [dbus/dbus-userdb.c(156):_dbus_user_database_lookup] Using cache for UID 1010 information
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 8 opened
4681: [dbus/dbus-keyring.c(508):_dbus_keyring_reload] dropping/ignoring 6349-seconds old key with timestamp 35310 as current time is 41659
4681: [dbus/dbus-keyring.c(559):_dbus_keyring_reload] Successfully loaded 0 existing keys
4681: [dbus/dbus-file-unix.c(375):_dbus_create_file_exclusively] exclusive file fd 8 opened
4681: [dbus/dbus-file-unix.c(80):_dbus_file_get_contents] file fd 8 opened
4681: [dbus/dbus-keyring.c(508):_dbus_keyring_reload] dropping/ignoring 6349-seconds old key with timestamp 35310 as current time is 41659
4681: [dbus/dbus-keyring.c(559):_dbus_keyring_reload] Successfully loaded 0 existing keys
4681: [dbus/dbus-sysdeps-unix.c(2662):_dbus_generate_random_bytes] /dev/urandom fd 8 opened
4681: [dbus/dbus-sysdeps-unix.c(2672):_dbus_generate_random_bytes] Read 4 bytes from /dev/urandom
4681: [dbus/dbus-keyring.c(328):add_new_key] Creating key with ID 1100968057
4681: [dbus/dbus-sysdeps-unix.c(2662):_dbus_generate_random_bytes] /dev/urandom fd 8 opened
4681: [dbus/dbus-sysdeps-unix.c(2672):_dbus_generate_random_bytes] Read 24 bytes from /dev/urandom
4681: [dbus/dbus-sysdeps-unix.c(2662):_dbus_generate_random_bytes] /dev/urandom fd 8 opened
4681: [dbus/dbus-sysdeps-unix.c(2672):_dbus_generate_random_bytes] Read 8 bytes from /dev/urandom
4681: [dbus/dbus-file-unix.c(239):_dbus_string_save_to_file] tmp file fd 8 opened
4681: [dbus/dbus-keyring.c(919):find_recent_key] Key 0 is 1 seconds old
4681: [dbus/dbus-sysdeps-unix.c(2662):_dbus_generate_random_bytes] /dev/urandom fd 8 opened
4681: [dbus/dbus-sysdeps-unix.c(2672):_dbus_generate_random_bytes] Read 16 bytes from /dev/urandom
4681: [dbus/dbus-auth.c(2146):goto_state] server: going from state WaitingForAuth to state WaitingForData
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-transport-socket.c(460):do_authentication]  server auth state: bytes to send
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 0
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 1 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-transport-socket.c(703):do_reading] fd = 7
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(948):socket_handle_watch] handling write watch, have_outgoing_messages = 0
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 0, do_writing = 1
4681: [dbus/dbus-transport-socket.c(460):do_authentication]  server auth state: bytes to send
4681: [dbus/dbus-auth.c(2518):_dbus_auth_bytes_sent] server: Sent 141 bytes of: DATA 6f72675f667265656465736b746f705f67656e6572616c2031313030393638303537203436353966373563666132313537323534326466363639333863323964653237

4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 0, do_writing = 1
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 1
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-transport-socket.c(503):do_writing] Not authenticated, not writing anything
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(919):socket_handle_watch] handling read watch 0x80a9908 flags = 1
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(263):read_data_into_auth]  read 44 bytes in auth phase
4681: [dbus/dbus-auth.c(2199):process_command] server: got command "ERROR "Don't have the requested cookie ID""
4681: [dbus/dbus-auth.c(430):shutdown_mech] server: Shutting down mechanism DBUS_COOKIE_SHA1
4681: [dbus/dbus-auth.c(2146):goto_state] server: going from state WaitingForData to state WaitingForAuth
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-transport-socket.c(460):do_authentication]  server auth state: bytes to send
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 0
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 1 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-transport-socket.c(703):do_reading] fd = 7
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(948):socket_handle_watch] handling write watch, have_outgoing_messages = 0
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 0, do_writing = 1
4681: [dbus/dbus-transport-socket.c(460):do_authentication]  server auth state: bytes to send
4681: [dbus/dbus-auth.c(2518):_dbus_auth_bytes_sent] server: Sent 46 bytes of: REJECTED EXTERNAL DBUS_COOKIE_SHA1 ANONYMOUS

4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 0, do_writing = 1
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = 7
4681: [dbus/dbus-transport-socket.c(226):check_read_watch]   setting read watch enabled = 1
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-transport-socket.c(503):do_writing] Not authenticated, not writing anything
4681: [dbus/dbus-transport-socket.c(165):check_write_watch] check_write_watch(): needed = 0 on connection 0x80aa160 watch 0x80a9930 fd = 7 outgoing messages exist 0
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 1
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(1485):_dbus_connection_handle_watch] start
4681: [dbus/dbus-connection.c(1487):_dbus_connection_handle_watch] LOCK
4681: [dbus/dbus-connection.c(1051):_dbus_connection_acquire_io_path] UNLOCK
4681: [dbus/dbus-connection.c(1053):_dbus_connection_acquire_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1057):_dbus_connection_acquire_io_path] start connection->io_path_acquired = 0 timeout = 1
4681: [dbus/dbus-connection.c(1100):_dbus_connection_acquire_io_path] end connection->io_path_acquired = 1 we_acquired = 1
4681: [dbus/dbus-connection.c(1102):_dbus_connection_acquire_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1105):_dbus_connection_acquire_io_path] LOCK
4681: [dbus/dbus-transport-socket.c(919):socket_handle_watch] handling read watch 0x80a9908 flags = 1
4681: [dbus/dbus-transport-socket.c(345):exchange_credentials] exchange_credentials: do_reading = 1, do_writing = 0
4681: [dbus/dbus-transport-socket.c(446):do_authentication]  server auth state: waiting for input
4681: [dbus/dbus-transport-socket.c(290):read_data_into_auth] Disconnected from remote app
4681: [dbus/dbus-transport.c(499):_dbus_transport_disconnect] start
4681: [dbus/dbus-transport-socket.c(985):socket_disconnect] 
4681: [dbus/dbus-transport-socket.c(76):free_watches] start
4681: [dbus/dbus-watch.c(400):_dbus_watch_list_remove_watch] Removing watch on fd 7
4681: [dbus/dbus-watch.c(400):_dbus_watch_list_remove_watch] Removing watch on fd 7
4681: [dbus/dbus-watch.c(611):dbus_watch_set_data] Setting watch fd -1 data to data = (nil) function = (nil) from data = (nil) function = (nil)
4681: [dbus/dbus-transport-socket.c(98):free_watches] end
4681: [dbus/dbus-transport.c(510):_dbus_transport_disconnect] end
4681: [dbus/dbus-transport-socket.c(180):check_read_watch] fd = -1
4681: [dbus/dbus-transport-socket.c(703):do_reading] fd = -1
4681: [dbus/dbus-watch.c(611):dbus_watch_set_data] Setting watch fd -1 data to data = (nil) function = (nil) from data = (nil) function = (nil)
4681: [dbus/dbus-connection.c(1126):_dbus_connection_release_io_path] locking io_path_mutex
4681: [dbus/dbus-connection.c(1132):_dbus_connection_release_io_path] start connection->io_path_acquired = 1
4681: [dbus/dbus-connection.c(1137):_dbus_connection_release_io_path] unlocking io_path_mutex
4681: [dbus/dbus-connection.c(1504):_dbus_connection_handle_watch] middle
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 0
4681: [dbus/dbus-connection.c(4197):notify_disconnected_and_dispatch_complete_unlocked] Sending disconnect message
4681: [dbus/dbus-connection.c(537):_dbus_connection_queue_synthesized_message_link] Synthesized message 0x80aa1f8 added to incoming queue 0x80aa160, 1 incoming
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(4312):_dbus_connection_update_dispatch_status_and_unlock] Notifying of change to dispatch status of 0x80aa160 now 0 (data remains)
4681: [dbus/dbus-connection.c(1511):_dbus_connection_handle_watch] end
4681: [dbus/dbus-connection.c(4528):dbus_connection_dispatch] 
4681: [dbus/dbus-connection.c(4530):dbus_connection_dispatch] LOCK
4681: [dbus/dbus-connection.c(4101):_dbus_connection_acquire_dispatch] UNLOCK
4681: [dbus/dbus-connection.c(4103):_dbus_connection_acquire_dispatch] locking dispatch_mutex
4681: [dbus/dbus-connection.c(4117):_dbus_connection_acquire_dispatch] unlocking dispatch_mutex
4681: [dbus/dbus-connection.c(4120):_dbus_connection_acquire_dispatch] LOCK
4681: [dbus/dbus-connection.c(3973):_dbus_connection_pop_message_link_unlocked] Message 0x80aa1f8 (signal /org/freedesktop/DBus/Local org.freedesktop.DBus.Local Disconnected '') removed from incoming queue 0x80aa160, 0 incoming
4681: [dbus/dbus-connection.c(4576):dbus_connection_dispatch]  dispatching message 0x80aa1f8 (signal org.freedesktop.DBus.Local Disconnected '')
4681: [dbus/dbus-connection.c(4631):dbus_connection_dispatch] UNLOCK
4681: [dbus/dbus-connection.c(4646):dbus_connection_dispatch]   running filter on message 0x80aa1f8
4681: [dbus/dbus-connection.c(3159):dbus_connection_preallocate_send] LOCK
4681: [dbus/dbus-connection.c(3164):dbus_connection_preallocate_send] UNLOCK
4681: [bus/dispatch.c(223):bus_dispatch] DISPATCH: org.freedesktop.DBus.Local Disconnected (no error name) to peer
4681: [bus/connection.c(183):bus_connection_disconnected] (inactive) disconnected, dropping all service ownership and releasing
4681: [dbus/dbus-connection.c(5512):dbus_connection_remove_filter] LOCK
4681: [dbus/dbus-connection.c(5534):dbus_connection_remove_filter] UNLOCK
4681: [dbus/dbus-connection.c(4877):dbus_connection_set_watch_functions] LOCK
4681: [dbus/dbus-watch.c(330):_dbus_watch_list_set_functions] Removing all pre-existing watches
4681: [dbus/dbus-connection.c(4884):dbus_connection_set_watch_functions] UNLOCK
4681: [dbus/dbus-connection.c(4940):dbus_connection_set_timeout_functions] LOCK
4681: [dbus/dbus-connection.c(4947):dbus_connection_set_timeout_functions] UNLOCK
4681: [dbus/dbus-connection.c(5254):dbus_connection_set_unix_user_function] LOCK
4681: [dbus/dbus-connection.c(5258):dbus_connection_set_unix_user_function] UNLOCK
4681: [dbus/dbus-connection.c(5353):dbus_connection_set_windows_user_function] LOCK
4681: [dbus/dbus-connection.c(5357):dbus_connection_set_windows_user_function] UNLOCK
4681: [dbus/dbus-connection.c(5023):dbus_connection_set_dispatch_status_function] LOCK
4681: [dbus/dbus-connection.c(5031):dbus_connection_set_dispatch_status_function] UNLOCK
4681: [bus/connection.c(1578):bus_connection_drop_pending_replies] Dropping pending replies that involve connection 0x80aa160
4681: [dbus/dbus-connection.c(4660):dbus_connection_dispatch] LOCK
4681: [dbus/dbus-connection.c(4669):dbus_connection_dispatch] filter handled message in dispatch
4681: [dbus/dbus-connection.c(4782):dbus_connection_dispatch]  ... done dispatching
4681: [dbus/dbus-connection.c(4136):_dbus_connection_release_dispatch] locking dispatch_mutex
4681: [dbus/dbus-connection.c(4144):_dbus_connection_release_dispatch] unlocking dispatch_mutex
4681: [dbus/dbus-connection.c(4793):dbus_connection_dispatch] before final status update
4681: [dbus/dbus-connection.c(4235):_dbus_connection_get_dispatch_status_unlocked] dispatch status = complete is_connected = 0
4681: [dbus/dbus-connection.c(4306):_dbus_connection_update_dispatch_status_and_unlock] UNLOCK
4681: [dbus/dbus-connection.c(2680):_dbus_connection_last_unref] Finalizing connection 0x80aa160
4681: [dbus/dbus-connection.c(5023):dbus_connection_set_dispatch_status_function] LOCK
4681: [dbus/dbus-connection.c(5031):dbus_connection_set_dispatch_status_function] UNLOCK
4681: [dbus/dbus-connection.c(4977):dbus_connection_set_wakeup_main_function] LOCK
4681: [dbus/dbus-connection.c(4985):dbus_connection_set_wakeup_main_function] UNLOCK
4681: [dbus/dbus-connection.c(5254):dbus_connection_set_unix_user_function] LOCK
4681: [dbus/dbus-connection.c(5258):dbus_connection_set_unix_user_function] UNLOCK
4681: [dbus/dbus-transport.c(480):_dbus_transport_unref] finalizing
4681: [dbus/dbus-transport-socket.c(106):socket_finalize] 
4681: [dbus/dbus-transport-socket.c(76):free_watches] start
4681: [dbus/dbus-transport-socket.c(98):free_watches] end