yorokobicom/agent

Yorokobi daemon not starting

pelcasandra opened this issue · 2 comments

The yorokobi daemon is not starting when installing the app via snap.

martin@martin-VirtualBox:~/Documents$ snap install yorokobi --edge
martin@martin-VirtualBox:~/Documents$ sudo snap start yorokobi.daemon
[sudo] password for martin: 
Started.

See the journalctl log below.

ene 12 17:29:19 martin-VirtualBox sudo[5469]:   martin : TTY=pts/4 ; PWD=/home/martin/Documents ; USER=root ; COMMAND=/usr/bin/snap start yorokobi.daemon
ene 12 17:29:19 martin-VirtualBox sudo[5469]: pam_unix(sudo:session): session opened for user root by (uid=0)
ene 12 17:29:19 martin-VirtualBox systemd[1]: Started Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished starting up.
-- 
-- The start-up result is done.
ene 12 17:29:19 martin-VirtualBox sudo[5469]: pam_unix(sudo:session): session closed for user root
ene 12 17:29:20 martin-VirtualBox audit[5712]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5712/mounts" pid=5712 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:20 martin-VirtualBox kernel: kauditd_printk_skb: 2 callbacks suppressed
ene 12 17:29:20 martin-VirtualBox kernel: audit: type=1400 audit(1547324960.520:28499): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5712/mounts" pid=5712 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:20 martin-VirtualBox audit[5712]: AVC apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5712 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:20 martin-VirtualBox kernel: audit: type=1400 audit(1547324960.604:28500): apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5712 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:20 martin-VirtualBox audit[5712]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5712/mounts" pid=5712 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:20 martin-VirtualBox kernel: audit: type=1400 audit(1547324960.836:28501): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5712/mounts" pid=5712 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:20 martin-VirtualBox audit[5712]: SECCOMP auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5712 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7f5574fd65a7 code=0x50000
ene 12 17:29:20 martin-VirtualBox yorokobi.daemon[5712]: Operation not permitted (src/tcp_address.cpp:208)
ene 12 17:29:20 martin-VirtualBox kernel: audit: type=1326 audit(1547324960.940:28502): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5712 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7f5574fd65a7 code=0x50000
ene 12 17:29:21 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Main process exited, code=dumped, status=6/ABRT
ene 12 17:29:21 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Unit entered failed state.
ene 12 17:29:21 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Failed with result 'core-dump'.
ene 12 17:29:21 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Service hold-off time over, scheduling restart.
ene 12 17:29:21 martin-VirtualBox systemd[1]: Stopped Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished shutting down
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished shutting down.
ene 12 17:29:21 martin-VirtualBox systemd[1]: Started Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished starting up.
-- 
-- The start-up result is done.
ene 12 17:29:21 martin-VirtualBox audit[5731]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5731/mounts" pid=5731 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:21 martin-VirtualBox kernel: audit: type=1400 audit(1547324961.888:28503): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5731/mounts" pid=5731 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:21 martin-VirtualBox audit[5731]: AVC apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5731 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:21 martin-VirtualBox kernel: audit: type=1400 audit(1547324961.968:28504): apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5731 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:22 martin-VirtualBox audit[5731]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5731/mounts" pid=5731 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:22 martin-VirtualBox kernel: audit: type=1400 audit(1547324962.256:28505): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5731/mounts" pid=5731 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:22 martin-VirtualBox audit[5731]: SECCOMP auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5731 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7f833692a5a7 code=0x50000
ene 12 17:29:22 martin-VirtualBox yorokobi.daemon[5731]: Operation not permitted (src/tcp_address.cpp:208)
ene 12 17:29:22 martin-VirtualBox kernel: audit: type=1326 audit(1547324962.316:28506): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5731 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7f833692a5a7 code=0x50000
ene 12 17:29:22 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Main process exited, code=dumped, status=6/ABRT
ene 12 17:29:22 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Unit entered failed state.
ene 12 17:29:22 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Failed with result 'core-dump'.
ene 12 17:29:22 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Service hold-off time over, scheduling restart.
ene 12 17:29:22 martin-VirtualBox systemd[1]: Stopped Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished shutting down
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished shutting down.
ene 12 17:29:22 martin-VirtualBox systemd[1]: Started Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished starting up.
-- 
-- The start-up result is done.
ene 12 17:29:23 martin-VirtualBox audit[5749]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5749/mounts" pid=5749 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:23 martin-VirtualBox kernel: audit: type=1400 audit(1547324963.316:28507): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5749/mounts" pid=5749 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:23 martin-VirtualBox audit[5749]: AVC apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5749 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:23 martin-VirtualBox kernel: audit: type=1400 audit(1547324963.404:28508): apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5749 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:23 martin-VirtualBox audit[5749]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5749/mounts" pid=5749 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:23 martin-VirtualBox audit[5749]: SECCOMP auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5749 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7f749106c5a7 code=0x50000
ene 12 17:29:23 martin-VirtualBox yorokobi.daemon[5749]: Operation not permitted (src/tcp_address.cpp:208)
ene 12 17:29:23 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Main process exited, code=dumped, status=6/ABRT
ene 12 17:29:23 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Unit entered failed state.
ene 12 17:29:23 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Failed with result 'core-dump'.
ene 12 17:29:23 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Service hold-off time over, scheduling restart.
ene 12 17:29:23 martin-VirtualBox systemd[1]: Stopped Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished shutting down
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished shutting down.
ene 12 17:29:23 martin-VirtualBox systemd[1]: Started Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished starting up.
-- 
-- The start-up result is done.
ene 12 17:29:24 martin-VirtualBox audit[5768]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5768/mounts" pid=5768 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:24 martin-VirtualBox audit[5768]: AVC apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5768 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:25 martin-VirtualBox audit[5768]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5768/mounts" pid=5768 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:25 martin-VirtualBox audit[5768]: SECCOMP auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5768 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7f3abef875a7 code=0x50000
ene 12 17:29:25 martin-VirtualBox yorokobi.daemon[5768]: Operation not permitted (src/tcp_address.cpp:208)
ene 12 17:29:25 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Main process exited, code=dumped, status=6/ABRT
ene 12 17:29:25 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Unit entered failed state.
ene 12 17:29:25 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Failed with result 'core-dump'.
ene 12 17:29:25 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Service hold-off time over, scheduling restart.
ene 12 17:29:25 martin-VirtualBox systemd[1]: Stopped Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished shutting down
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished shutting down.
ene 12 17:29:25 martin-VirtualBox systemd[1]: Started Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished start-up
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished starting up.
-- 
-- The start-up result is done.
ene 12 17:29:26 martin-VirtualBox audit[5786]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5786/mounts" pid=5786 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:26 martin-VirtualBox kernel: kauditd_printk_skb: 6 callbacks suppressed
ene 12 17:29:26 martin-VirtualBox kernel: audit: type=1400 audit(1547324966.372:28515): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5786/mounts" pid=5786 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:26 martin-VirtualBox audit[5786]: AVC apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5786 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:26 martin-VirtualBox kernel: audit: type=1400 audit(1547324966.484:28516): apparmor="DENIED" operation="create" profile="snap.yorokobi.daemon" pid=5786 comm="python3" family="inet6" sock_type="stream" protocol=0 requested_mask="create" denied_mask="create"
ene 12 17:29:26 martin-VirtualBox audit[5786]: AVC apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5786/mounts" pid=5786 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:26 martin-VirtualBox kernel: audit: type=1400 audit(1547324966.768:28517): apparmor="DENIED" operation="open" profile="snap.yorokobi.daemon" name="/proc/5786/mounts" pid=5786 comm="python3" requested_mask="r" denied_mask="r" fsuid=0 ouid=0
ene 12 17:29:26 martin-VirtualBox audit[5786]: SECCOMP auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5786 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7fe914b0b5a7 code=0x50000
ene 12 17:29:26 martin-VirtualBox yorokobi.daemon[5786]: Operation not permitted (src/tcp_address.cpp:208)
ene 12 17:29:26 martin-VirtualBox kernel: audit: type=1326 audit(1547324966.828:28518): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=5786 comm="python3" exe="/snap/yorokobi/65/usr/bin/python3.5" sig=0 arch=c000003e syscall=41 compat=0 ip=0x7fe914b0b5a7 code=0x50000
ene 12 17:29:26 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Main process exited, code=dumped, status=6/ABRT
ene 12 17:29:26 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Unit entered failed state.
ene 12 17:29:26 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Failed with result 'core-dump'.
ene 12 17:29:27 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Service hold-off time over, scheduling restart.
ene 12 17:29:27 martin-VirtualBox systemd[1]: Stopped Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has finished shutting down
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has finished shutting down.
ene 12 17:29:27 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Start request repeated too quickly.
ene 12 17:29:27 martin-VirtualBox systemd[1]: Failed to start Service for snap application yorokobi.daemon.
-- Subject: Unit snap.yorokobi.daemon.service has failed
-- Defined-By: systemd
-- Support: http://lists.freedesktop.org/mailman/listinfo/systemd-devel
-- 
-- Unit snap.yorokobi.daemon.service has failed.
-- 
-- The result is failed.
ene 12 17:29:27 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Unit entered failed state.
ene 12 17:29:27 martin-VirtualBox systemd[1]: snap.yorokobi.daemon.service: Failed with result 'start-limit-hit'.

Ok, I'll have a look into that shortly.

By the way, I noticed that my recent changes broke the yorokobi command. Until the fix, type yorokobi yorokobi_cli. Also about to send the patch for the backup bug.

Starting now.