Attachment 1476241 Details for Bug 1616338 – journalctl matching up with comment 3

journalctl matching up with comment 3

journal2.txt (text/plain), 30.15 KB, created by Chris Murphy on 2018-08-15 18:07:57 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Chris Murphy

Created: 2018-08-15 18:07:57 UTC

Size: 30.15 KB

patch

obsolete

>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-fwupd.service-bU6rKC: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-fwupd.service-bU6rKC': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-colord.service-Ryrn0A: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-colord.service-Ryrn0A': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bluetooth.service-fc7k6I: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bluetooth.service-fc7k6I': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-chronyd.service-xYqzf8: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-chronyd.service-xYqzf8': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-geoclue.service-pqKsi7: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-geoclue.service-pqKsi7': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-colord.service-wIzzef: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-colord.service-wIzzef': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-rtkit-daemon.service-VoLLCV: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-rtkit-daemon.service-VoLLCV': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-chronyd.service-genMBJ: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-chronyd.service-genMBJ': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-rtkit-daemon.service-eoXmTw: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-rtkit-daemon.service-eoXmTw': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bluetooth.service-qY6amk: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bluetooth.service-qY6amk': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bolt.service-ZtVouj: Error opening directory '/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bolt.service-ZtVouj': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-fwupd.service-cTX7I6: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-fwupd.service-cTX7I6': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-geoclue.service-YNnGUq: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-geoclue.service-YNnGUq': Permission denied
>Aug 15 11:18:09 f28h.local gsd-housekeepin[1847]: Failed to enumerate children of /var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bolt.service-MS5Fm8: Error opening directory '/var/tmp/systemd-private-6fec05ee7d8d45c0a45d314303c3e15f-bolt.service-MS5Fm8': Permission denied
>Aug 15 11:20:36 f28h.local systemd[1]: Starting system activity accounting tool...
>Aug 15 11:20:36 f28h.local systemd[1]: Started system activity accounting tool.
>Aug 15 11:20:36 f28h.local audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:20:36 f28h.local audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:23:05 f28h.local gnome-shell[1594]: The property brightness doesn't seem to be a normal object property of [0x55efcec8ed30 StWidget] or a registered special property
>Aug 15 11:23:05 f28h.local gnome-shell[1594]: The property vignette_sharpness doesn't seem to be a normal object property of [0x55efcec8ed30 StWidget] or a registered special property
>Aug 15 11:23:05 f28h.local gnome-shell[1594]: The property brightness doesn't seem to be a normal object property of [0x55efcfb42840 StWidget] or a registered special property
>Aug 15 11:23:05 f28h.local gnome-shell[1594]: The property vignette_sharpness doesn't seem to be a normal object property of [0x55efcfb42840 StWidget] or a registered special property
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11171880) is greater than comparison timestamp (11171872).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 11171880.  Working around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11171911) is greater than comparison timestamp (11171906).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 11171911.  Working around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11171941) is greater than comparison timestamp (11171937).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 11171941.  Working around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11171971) is greater than comparison timestamp (11171968).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:23:58 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 11171971.  Working around...
>Aug 15 11:25:28 f28h.local org.gnome.Shell.desktop[1594]: libinput error: client bug: timer event18 debounce: offset negative (-4ms)
>Aug 15 11:25:28 f28h.local org.gnome.Shell.desktop[1594]: libinput error: client bug: timer event18 debounce short: offset negative (-17ms)
>Aug 15 11:30:26 f28h.local systemd[1]: Starting dnf makecache...
>Aug 15 11:30:26 f28h.local systemd[1]: Starting system activity accounting tool...
>Aug 15 11:30:26 f28h.local systemd[1]: Started system activity accounting tool.
>Aug 15 11:30:26 f28h.local audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:30:26 f28h.local audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:30:32 f28h.local dnf[7027]: Fedora 28 - x86_64 - Test Updates               2.7 MB/s |  15 MB     00:05
>Aug 15 11:30:45 f28h.local dnf[7027]: Fedora 28 - x86_64 - Updates                    2.7 MB/s |  22 MB     00:08
>Aug 15 11:30:51 f28h.local dnf[7027]: Last metadata expiration check: 0:00:00 ago on Wed 15 Aug 2018 11:30:51 AM MDT.
>Aug 15 11:30:52 f28h.local dnf[7027]: Metadata cache created.
>Aug 15 11:30:53 f28h.local systemd[1]: Started dnf makecache.
>Aug 15 11:30:53 f28h.local audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=dnf-makecache comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:30:53 f28h.local audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=dnf-makecache comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11935488) is greater than comparison timestamp (11935479).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x1a00003 (FARK.com: ) appears to be one of the offending windows with a timestamp of 11935488.  Working around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11935669) is greater than comparison timestamp (11935668).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x1a00003 (FARK.com: ) appears to be one of the offending windows with a timestamp of 11935669.  Working around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11936032) is greater than comparison timestamp (11936027).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x1a00003 (FARK.com: ) appears to be one of the offending windows with a timestamp of 11936032.  Working around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (11936062) is greater than comparison timestamp (11936060).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:36:42 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x1a00003 (FARK.com: ) appears to be one of the offending windows with a timestamp of 11936062.  Working around...
>Aug 15 11:40:36 f28h.local systemd[1]: Starting system activity accounting tool...
>Aug 15 11:40:36 f28h.local systemd[1]: Started system activity accounting tool.
>Aug 15 11:40:36 f28h.local audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:40:36 f28h.local audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:46:44 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (12537830) is greater than comparison timestamp (12537829).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:46:44 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 12537830.  Working around...
>Aug 15 11:46:45 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (12538674) is greater than comparison timestamp (12538660).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:46:45 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 12538674.  Working around...
>Aug 15 11:46:45 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (12538855) is greater than comparison timestamp (12538845).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:46:45 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 12538855.  Working around...
>Aug 15 11:47:15 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (12568484) is greater than comparison timestamp (12568483).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:47:15 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 12568484.  Working around...
>Aug 15 11:47:15 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (12568514) is greater than comparison timestamp (12568513).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:47:15 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 12568514.  Working around...
>Aug 15 11:47:15 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: last_user_time (12568636) is greater than comparison timestamp (12568635).  This most likely represents a buggy client sending inaccurate timestamps in messages such as _NET_ACTIVE_WINDOW.  Trying to work around...
>Aug 15 11:47:15 f28h.local org.gnome.Shell.desktop[1594]: Window manager warning: 0x3000001 (YakYak) appears to be one of the offending windows with a timestamp of 12568636.  Working around...
>Aug 15 11:48:06 f28h.local org.gnome.Shell.desktop[1594]: libinput error: client bug: timer event18 debounce: offset negative (-49ms)
>Aug 15 11:48:06 f28h.local org.gnome.Shell.desktop[1594]: libinput error: client bug: timer event18 debounce short: offset negative (-63ms)
>Aug 15 11:50:36 f28h.local systemd[1]: Starting system activity accounting tool...
>Aug 15 11:50:36 f28h.local systemd[1]: Started system activity accounting tool.
>Aug 15 11:50:36 f28h.local audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:50:36 f28h.local audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=sysstat-collect comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/adapter.c:dev_disconnected() Device 58:1F:AA:EB:B4:6A disconnected, reason 1
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/adapter.c:adapter_remove_connection()
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: plugins/policy.c:disconnect_cb() reason 1
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/adapter.c:bonding_attempt_complete() hci0 bdaddr 58:1F:AA:EB:B4:6A type 0 status 0xe
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/device.c:device_bonding_complete() bonding (nil) status 0x0e
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/device.c:device_bonding_failed() status 14
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/adapter.c:resume_discovery()
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/adapter.c:dev_disconnected() Device 58:1F:AA:EB:B4:6A disconnected, reason 1
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/adapter.c:adapter_remove_connection()
>Aug 15 11:52:31 f28h.local bluetoothd[649]: plugins/policy.c:disconnect_cb() reason 1
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/adapter.c:bonding_attempt_complete() hci0 bdaddr 58:1F:AA:EB:B4:6A type 0 status 0xe
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/device.c:device_bonding_complete() bonding (nil) status 0x0e
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/device.c:device_bonding_failed() status 14
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/adapter.c:resume_discovery()
>Aug 15 11:52:31 f28h.local audit[654]: USER_AVC pid=654 uid=81 auid=4294967295 ses=4294967295 subj=system_u:system_r:system_dbusd_t:s0-s0:c0.c1023 msg='avc:  denied  { send_msg } for msgtype=signal interface=org.freedesktop.PolicyKit1.Authority member=Changed dest=org.freedesktop.DBus spid=718 tpid=1260 scontext=system_u:system_r:policykit_t:s0 tcontext=system_u:system_r:boltd_t:s0 tclass=dbus permissive=0
>                                        exe="/usr/bin/dbus-daemon" sauid=81 hostname=? addr=? terminal=?'
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:ctrl_watch_cb() Device 58:1F:AA:EB:B4:6A disconnected
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:intr_watch_cb() Device 58:1F:AA:EB:B4:6A disconnected
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: src/service.c:change_state() 0x561de814de40: device 58:1F:AA:EB:B4:6A profile input-hid state changed: connected -> disconnected (0)
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:input_device_enter_reconnect_mode() path=/org/bluez/hci0/dev_58_1F_AA_EB_B4_6A reconnect_mode=any
>Aug 15 11:52:31 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:input_device_enter_reconnect_mode() registering auto-reconnect
>Aug 15 11:52:31 f28h.local bluetoothd[649]: profiles/input/device.c:ctrl_watch_cb() Device 58:1F:AA:EB:B4:6A disconnected
>Aug 15 11:52:31 f28h.local bluetoothd[649]: profiles/input/device.c:intr_watch_cb() Device 58:1F:AA:EB:B4:6A disconnected
>Aug 15 11:52:31 f28h.local bluetoothd[649]: src/service.c:change_state() 0x561de814de40: device 58:1F:AA:EB:B4:6A profile input-hid state changed: connected -> disconnected (0)
>Aug 15 11:52:31 f28h.local bluetoothd[649]: profiles/input/device.c:input_device_enter_reconnect_mode() path=/org/bluez/hci0/dev_58_1F_AA_EB_B4_6A reconnect_mode=any
>Aug 15 11:52:31 f28h.local bluetoothd[649]: profiles/input/device.c:input_device_enter_reconnect_mode() registering auto-reconnect
>Aug 15 11:52:31 f28h.local upowerd[1140]: unhandled action 'unbind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/bluetooth/hci0/hci0:256/0005:05AC:030D.0005
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: src/adapter.c:connected_callback() hci0 device 58:1F:AA:EB:B4:6A connected eir_len 13
>Aug 15 11:52:32 f28h.local bluetoothd[649]: src/adapter.c:connected_callback() hci0 device 58:1F:AA:EB:B4:6A connected eir_len 13
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/server.c:connect_event_cb() Incoming connection from 58:1F:AA:EB:B4:6A on PSM 17
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:input_device_set_channel() idev 0x561de814dd80 psm 17
>Aug 15 11:52:32 f28h.local bluetoothd[649]: profiles/input/server.c:connect_event_cb() Incoming connection from 58:1F:AA:EB:B4:6A on PSM 17
>Aug 15 11:52:32 f28h.local bluetoothd[649]: profiles/input/device.c:input_device_set_channel() idev 0x561de814dd80 psm 17
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/server.c:confirm_event_cb()
>Aug 15 11:52:32 f28h.local bluetoothd[649]: profiles/input/server.c:confirm_event_cb()
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/server.c:connect_event_cb() Incoming connection from 58:1F:AA:EB:B4:6A on PSM 19
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:input_device_set_channel() idev 0x561de814dd80 psm 19
>Aug 15 11:52:32 f28h.local bluetoothd[649]: profiles/input/server.c:connect_event_cb() Incoming connection from 58:1F:AA:EB:B4:6A on PSM 19
>Aug 15 11:52:32 f28h.local bluetoothd[649]: profiles/input/device.c:input_device_set_channel() idev 0x561de814dd80 psm 19
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: src/service.c:change_state() 0x561de814de40: device 58:1F:AA:EB:B4:6A profile input-hid state changed: disconnected -> connected (0)
>Aug 15 11:52:32 f28h.local bluetoothd[649]: bluetoothd[649]: plugins/policy.c:service_cb() Added input-hid reconnect 0
>Aug 15 11:52:32 f28h.local bluetoothd[649]: src/service.c:change_state() 0x561de814de40: device 58:1F:AA:EB:B4:6A profile input-hid state changed: disconnected -> connected (0)
>Aug 15 11:52:32 f28h.local bluetoothd[649]: plugins/policy.c:service_cb() Added input-hid reconnect 0
>Aug 15 11:52:32 f28h.local kernel: magicmouse 0005:05AC:030D.0006: unknown main item tag 0x0
>Aug 15 11:52:32 f28h.local kernel: input: mouses as /devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/bluetooth/hci0/hci0:512/0005:05AC:030D.0006/input/input22
>Aug 15 11:52:32 f28h.local kernel: magicmouse 0005:05AC:030D.0006: input,hidraw2: BLUETOOTH HID v3.06 Mouse [mouses] on 00:c2:c6:f0:52:57
>Aug 15 11:52:32 f28h.local audit[654]: USER_AVC pid=654 uid=81 auid=4294967295 ses=4294967295 subj=system_u:system_r:system_dbusd_t:s0-s0:c0.c1023 msg='avc:  denied  { send_msg } for msgtype=signal interface=org.freedesktop.PolicyKit1.Authority member=Changed dest=org.freedesktop.DBus spid=718 tpid=1260 scontext=system_u:system_r:policykit_t:s0 tcontext=system_u:system_r:boltd_t:s0 tclass=dbus permissive=0
>                                        exe="/usr/bin/dbus-daemon" sauid=81 hostname=? addr=? terminal=?'
>Aug 15 11:52:32 f28h.local upowerd[1140]: unhandled action 'bind' on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/bluetooth/hci0/hci0:512/0005:05AC:030D.0006
>Aug 15 11:52:32 f28h.local upowerd[1140]: treating change event as add on /sys/devices/pci0000:00/0000:00:14.0/usb1/1-7/1-7:1.0/bluetooth/hci0/hci0:512/0005:05AC:030D.0006/power_supply/hid-58:1f:aa:eb:b4:6a-battery
>Aug 15 11:52:55 f28h.local sudo[5723]: pam_unix(sudo:session): session closed for user root
>Aug 15 11:52:55 f28h.local audit[5723]: USER_END pid=5723 uid=0 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:session_close grantors=pam_keyinit,pam_limits,pam_keyinit,pam_limits,pam_systemd,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/1 res=success'
>Aug 15 11:52:55 f28h.local audit[5723]: CRED_DISP pid=5723 uid=0 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:setcred grantors=pam_env,pam_fprintd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/1 res=success'
>Aug 15 11:52:57 f28h.local org.gnome.Shell.desktop[1594]: libinput error: client bug: timer event18 debounce short: offset negative (-5ms)
>Aug 15 11:53:01 f28h.local bluetoothd[649]: bluetoothd[649]: profiles/input/device.c:input_device_auto_reconnect() path=/org/bluez/hci0/dev_58_1F_AA_EB_B4_6A, attempt=0
>Aug 15 11:53:01 f28h.local bluetoothd[649]: profiles/input/device.c:input_device_auto_reconnect() path=/org/bluez/hci0/dev_58_1F_AA_EB_B4_6A, attempt=0
>Aug 15 11:53:04 f28h.local dbus-daemon[1529]: [session uid=1000 pid=1529] Activating service name='org.gnome.gedit' requested by ':1.14' (uid=1000 pid=1594 comm="/usr/bin/gnome-shell " label="unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023")
>Aug 15 11:53:04 f28h.local dbus-daemon[1529]: [session uid=1000 pid=1529] Successfully activated service 'org.gnome.gedit'
>Aug 15 11:53:05 f28h.local gnome-shell[1594]: Object Clutter.Clone (0x55efd0145af0), has been already finalized. Impossible to get any property from it.
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: == Stack trace for context 0x55efca131310 ==
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #0 0x7fff45734eb0 I   resource:///org/gnome/shell/ui/tweener.js:73 (0x7f3d2c6c8cd0 @ 9)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #1 0x7fff45734f50 b   resource:///org/gnome/shell/ui/tweener.js:105 (0x7f3d2c6c8f78 @ 36)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #2 0x7fff45734f90 I   resource:///org/gnome/shell/ui/tweener.js:92 (0x7f3d2c6c8de0 @ 52)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #3 0x7fff45735b00 I   resource:///org/gnome/gjs/modules/tweener/tweener.js:208 (0x7f3d2c6d2918 @ 54)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #4 0x7fff45735c50 b   resource:///org/gnome/gjs/modules/tweener/tweener.js:337 (0x7f3d2c6d29a0 @ 1626)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #5 0x7fff45735d00 b   resource:///org/gnome/gjs/modules/tweener/tweener.js:350 (0x7f3d2c6d2a28 @ 100)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #6 0x7fff45735d90 b   resource:///org/gnome/gjs/modules/tweener/tweener.js:365 (0x7f3d2c6d2ab0 @ 10)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #7 0x7fff45735e10 I   resource:///org/gnome/gjs/modules/signals.js:128 (0x7f3d2c6cff78 @ 386)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #8 0x7fff45735e60 I   resource:///org/gnome/shell/ui/tweener.js:207 (0x7f3d2c6cf5e8 @ 159)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #9 0x7fff45735ed0 I   resource:///org/gnome/gjs/modules/_legacy.js:82 (0x7f3d2c6b5de0 @ 71)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #10 0x7fff45735ed0 I   resource:///org/gnome/shell/ui/tweener.js:182 (0x7f3d2c6cf560 @ 15)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: == Stack trace for context 0x55efca131310 ==
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #0 0x7fff45734eb0 I   resource:///org/gnome/shell/ui/tweener.js:80 (0x7f3d2c6c8cd0 @ 82)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #1 0x7fff45734f50 b   resource:///org/gnome/shell/ui/tweener.js:105 (0x7f3d2c6c8f78 @ 36)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #2 0x7fff45734f90 I   resource:///org/gnome/shell/ui/tweener.js:92 (0x7f3d2c6c8de0 @ 52)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #3 0x7fff45735b00 I   resource:///org/gnome/gjs/modules/tweener/tweener.js:208 (0x7f3d2c6d2918 @ 54)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #4 0x7fff45735c50 b   resource:///org/gnome/gjs/modules/tweener/tweener.js:337 (0x7f3d2c6d29a0 @ 1626)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #5 0x7fff45735d00 b   resource:///org/gnome/gjs/modules/tweener/tweener.js:350 (0x7f3d2c6d2a28 @ 100)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #6 0x7fff45735d90 b   resource:///org/gnome/gjs/modules/tweener/tweener.js:365 (0x7f3d2c6d2ab0 @ 10)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #7 0x7fff45735e10 I   resource:///org/gnome/gjs/modules/signals.js:128 (0x7f3d2c6cff78 @ 386)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #8 0x7fff45735e60 I   resource:///org/gnome/shell/ui/tweener.js:207 (0x7f3d2c6cf5e8 @ 159)
>Aug 15 11:53:05 f28h.local gnome-shell[1594]: Object Clutter.Clone (0x55efd0145af0), has been already finalized. Impossible to set any property to it.
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #9 0x7fff45735ed0 I   resource:///org/gnome/gjs/modules/_legacy.js:82 (0x7f3d2c6b5de0 @ 71)
>Aug 15 11:53:05 f28h.local org.gnome.Shell.desktop[1594]: #10 0x7fff45735ed0 I   resource:///org/gnome/shell/ui/tweener.js:182 (0x7f3d2c6cf560 @ 15)
>Aug 15 11:56:35 f28h.local dbus-daemon[654]: [system] Activating via systemd: service name='net.reactivated.Fprint' unit='fprintd.service' requested by ':1.206' (uid=0 pid=7621 comm="sudo journalctl -b --no-pager " label="unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023")
>Aug 15 11:56:35 f28h.local systemd[1]: Starting Fingerprint Authentication Daemon...
>Aug 15 11:56:35 f28h.local dbus-daemon[654]: [system] Successfully activated service 'net.reactivated.Fprint'
>Aug 15 11:56:35 f28h.local systemd[1]: Started Fingerprint Authentication Daemon.
>Aug 15 11:56:35 f28h.local audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:init_t:s0 msg='unit=fprintd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
>Aug 15 11:56:37 f28h.local audit[7621]: USER_AUTH pid=7621 uid=1000 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:authentication grantors=pam_unix acct="chris" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/1 res=success'
>Aug 15 11:56:37 f28h.local audit[7621]: USER_ACCT pid=7621 uid=1000 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:accounting grantors=pam_unix,pam_localuser acct="chris" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/1 res=success'
>Aug 15 11:56:37 f28h.local sudo[7621]:    chris : TTY=pts/1 ; PWD=/home/chris ; USER=root ; COMMAND=/bin/journalctl -b --no-pager
>Aug 15 11:56:37 f28h.local audit[7621]: USER_CMD pid=7621 uid=1000 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='cwd="/home/chris" cmd=6A6F75726E616C63746C202D62202D2D6E6F2D7061676572 terminal=pts/1 res=success'
>Aug 15 11:56:37 f28h.local audit[7621]: CRED_REFR pid=7621 uid=0 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:setcred grantors=pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/1 res=success'
>Aug 15 11:56:37 f28h.local sudo[7621]: pam_systemd(sudo:session): Cannot create session: Already running in a session
>Aug 15 11:56:37 f28h.local sudo[7621]: pam_unix(sudo:session): session opened for user root by (uid=0)
>Aug 15 11:56:37 f28h.local audit[7621]: USER_START pid=7621 uid=0 auid=1000 ses=3 subj=unconfined_u:unconfined_r:unconfined_t:s0-s0:c0.c1023 msg='op=PAM:session_open grantors=pam_keyinit,pam_limits,pam_keyinit,pam_limits,pam_systemd,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=/dev/pts/1 res=success'
>[chris@f28h ~]$ 
>

Actions: View

Attachments on bug 1616338: 1476190 | 1476240 | 1476241