Balena-Sound; connects but doesn't give out any audio

Project help balenaSound
,
#1

I can connect to the raspberry pie using all the connections types, and it says its playing, yet no audio is given out of both the aux and HDMI.
Error message when rebooting:>

audio E: [pulseaudio] module.c: Failed to load module “module-alsa-card” (argument: "device_id=“0” name=“0” card_name=“alsa_card.0” namereg_fail=false tsched=yes fixed_latency_range=no ignore_dB=no deferred_volume=yes use_ucm=yes avoid_resampling=yes card_properties=“module-udev-detect.discovered=1"”): initialization failed.
05.02.21 11:57:31 (+0000) multiroom-client 2021-02-05 11-57-31.354 [Notice] (Connection) Connected to 192.168.1.76
05.02.21 11:57:31 (+0000) audio W: [pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
05.02.21 11:57:31 (+0000) audio W: [pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11

#2

Hi there,
could you please give more information about the device ? May I also ask which version of BalenaOS it is running ? Are you using a 32bit or 64bit application ?

#4

I actually have this issue too that has started between 2 weeks ago. I noticed a reboot on my two separate installs 4 days ago. Here are my details of one unit.

Online
TYPE
“Raspberry Pi 4 (using 64bit OS)”)Raspberry Pi 4 (using 64bit OS)
LAST SEEN (VPN)
Online (for 11 hours)
HOST OS VERSION
[balenaOS 2.67.3+rev4]
production
SUPERVISOR VERSION
12.3.5
CURRENT
48e1f58

Both units have been working perfectly for 10 months and both have hifi-dacplus cards. I’m streaming from iOS 14.4 to airplay and have multiroom disabled. Have BT and Spotify enabled. The Pi’s no longer appear in the iOS BT. BT interface is also impacted. They show up on the airplay selection, but no audio. Somehow this seems like an iOS change that maybe the cause. ¯_(ツ)_/¯.

Dan

#5

Hi @d.m ,
could you please clarify if any updates have been made on the device? I ask this to understand the reason for the reboot. Also could you please copy/paste device logs to see if there is something wrong?
(e.g. with journalctl -f -n 1000)

#7

Feb 15 09:20:55 24f57f5 balenad[1680]: time=“2021-02-15T09:20:55.932518708Z” level=info msg=“shim reaped” id=a90af1660671392fa64084b64a606d3ab945b3b78f9b9106afd6fe5bfa7d315f
Feb 15 09:20:55 24f57f5 balenad[1656]: time=“2021-02-15T09:20:55.938655165Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:21:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 09:21:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 09:21:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 09:21:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 09:23:56 24f57f5 balenad[1680]: time=“2021-02-15T09:23:56.841614373Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/40981cb3df76b9c48d18ea5c1c77f9a14b379a0b0e79c9eb2adb80a2adf70257.sock debug=false pid=261756
Feb 15 09:23:58 24f57f5 balenad[1680]: time=“2021-02-15T09:23:58.003775734Z” level=info msg=“shim reaped” id=f548e76aa04475a1722f937d63473a89612c4c65f885fcfb0c2599dde658bb03
Feb 15 09:23:58 24f57f5 balenad[1656]: time=“2021-02-15T09:23:58.010286687Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:25:29 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 4.505 ms
Feb 15 09:25:29 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 4.505 ms
Feb 15 09:26:58 24f57f5 balenad[1680]: time=“2021-02-15T09:26:58.898812147Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/a8fc818eb9d0aa07008ad4be19e3678fd17487623dcd7425f7df3947113ed319.sock debug=false pid=262271
Feb 15 09:27:00 24f57f5 balenad[1680]: time=“2021-02-15T09:27:00.076263232Z” level=info msg=“shim reaped” id=d26d1e0c8902151a0a19ed65e25110f40e2e0c88f98557d4445390e7978349b3
Feb 15 09:27:00 24f57f5 balenad[1656]: time=“2021-02-15T09:27:00.082728334Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:30:01 24f57f5 balenad[1680]: time=“2021-02-15T09:30:01.005125941Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/1c52ae980823d5212898ed48370759fe8ca4098446e24250f3b42acfd5b7a18a.sock debug=false pid=262622
Feb 15 09:30:02 24f57f5 balenad[1680]: time=“2021-02-15T09:30:02.176544606Z” level=info msg=“shim reaped” id=d6d33b2bdc203b30837f23cc955a572a20b3fbe249f8e67b6081316144582534
Feb 15 09:30:02 24f57f5 balenad[1656]: time=“2021-02-15T09:30:02.183046319Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] Error from the API: 503
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] Error from the API: 503
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] Non-200 response from the API! Status code: 503 - message: Error
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] at /usr/src/app/dist/app.js:22:554633
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] at runMicrotasks ()
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] Non-200 response from the API! Status code: 503 - message: Error
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] at /usr/src/app/dist/app.js:22:554633
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] at runMicrotasks ()
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] at processTicksAndRejections (internal/process/task_queues.js:97:5)
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] at async /usr/src/app/dist/app.js:22:553941
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] at processTicksAndRejections (internal/process/task_queues.js:97:5)
Feb 15 09:30:02 24f57f5 resin-supervisor[3174]: [error] at async /usr/src/app/dist/app.js:22:555463
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] at async /usr/src/app/dist/app.js:22:553941
Feb 15 09:30:02 24f57f5 e6616a67b862[1656]: [error] at async /usr/src/app/dist/app.js:22:555463
Feb 15 09:30:30 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 3.338 ms
Feb 15 09:30:30 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 3.338 ms
Feb 15 09:31:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 09:31:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 09:31:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 09:31:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 09:33:03 24f57f5 balenad[1680]: time=“2021-02-15T09:33:03.053750499Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/ad5035ff032c78c8a32b1f518133f14c2c35a693610be4cfa851d6573a4fe5d1.sock debug=false pid=263065
Feb 15 09:33:04 24f57f5 balenad[1680]: time=“2021-02-15T09:33:04.226002084Z” level=info msg=“shim reaped” id=625b4c394961bdf063287abe345764afe3947832ebeccea77443d3b905444eac
Feb 15 09:33:04 24f57f5 balenad[1656]: time=“2021-02-15T09:33:04.231890338Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:35:30 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 3.183 ms
Feb 15 09:35:30 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 3.183 ms
Feb 15 09:36:05 24f57f5 balenad[1680]: time=“2021-02-15T09:36:05.111485788Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/3ffa818f3727690315eae1e6755c9aee6f4c236bd3fbba6e56627c5634935929.sock debug=false pid=263585
Feb 15 09:36:06 24f57f5 balenad[1680]: time=“2021-02-15T09:36:06.283619689Z” level=info msg=“shim reaped” id=b4dc558409fc710af985e5c32bada8efc5d8b9c11eb8605bf48fc47086c9be80
Feb 15 09:36:06 24f57f5 balenad[1656]: time=“2021-02-15T09:36:06.289034631Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:39:07 24f57f5 balenad[1680]: time=“2021-02-15T09:39:07.169561315Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/3d36d023c8994406340070e762ba9ad2fad92724ef005884c0b6d58e502e40e6.sock debug=false pid=263867
Feb 15 09:39:08 24f57f5 balenad[1680]: time=“2021-02-15T09:39:08.346866124Z” level=info msg=“shim reaped” id=f38d691a18730989a8c89f990aadb0991e81275e2d53d2d7caf0c90df26d4086
Feb 15 09:39:08 24f57f5 balenad[1656]: time=“2021-02-15T09:39:08.353407521Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:40:31 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 7.369 ms
Feb 15 09:40:31 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 7.369 ms
Feb 15 09:41:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 09:41:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 09:41:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 09:41:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 09:42:09 24f57f5 balenad[1680]: time=“2021-02-15T09:42:09.256431729Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/84f56db039432f519261253edda305729ba24c5398b4ef711efa0c5d17e2d570.sock debug=false pid=264296
Feb 15 09:42:10 24f57f5 balenad[1680]: time=“2021-02-15T09:42:10.438286561Z” level=info msg=“shim reaped” id=07e22931620a5d701c391f455df93b70f84a8f77b49d3b61beb5426b1c54919f
Feb 15 09:42:10 24f57f5 balenad[1656]: time=“2021-02-15T09:42:10.445562324Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:45:11 24f57f5 balenad[1680]: time=“2021-02-15T09:45:11.341391620Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/ce1dadcdbfb29e3c5c6e6eee4314ed556c4c65f7328253180147094c627a1f40.sock debug=false pid=264583
Feb 15 09:45:12 24f57f5 balenad[1680]: time=“2021-02-15T09:45:12.535041053Z” level=info msg=“shim reaped” id=c6191de57335aac64c476ece2b8013d034d9658dc885517414a78ee8c6487b95
Feb 15 09:45:12 24f57f5 balenad[1656]: time=“2021-02-15T09:45:12.541702690Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:45:31 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 5.451 ms
Feb 15 09:45:31 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 5.451 ms
Feb 15 09:48:13 24f57f5 balenad[1680]: time=“2021-02-15T09:48:13.449067471Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/62478822908827fe9eb05150ccd8e23fdd09339fe2e05cb1caf6bbca249bda01.sock debug=false pid=265008
Feb 15 09:48:14 24f57f5 balenad[1680]: time=“2021-02-15T09:48:14.626585446Z” level=info msg=“shim reaped” id=9ed289bddd092ba529c2cca908dce3f975a26d780e6705dc10c891c17f69cc87
Feb 15 09:48:14 24f57f5 balenad[1656]: time=“2021-02-15T09:48:14.632872308Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:50:32 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 4.139 ms
Feb 15 09:50:32 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 4.139 ms
Feb 15 09:51:15 24f57f5 balenad[1680]: time=“2021-02-15T09:51:15.527579866Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/80fb821a83835aac88384a939907aecf839bd4db0587c4d7cc0e04f5366a9f84.sock debug=false pid=265512
Feb 15 09:51:16 24f57f5 balenad[1680]: time=“2021-02-15T09:51:16.695697705Z” level=info msg=“shim reaped” id=cd178efc6e3ec45653cb893074c19101ddc6f4b45043fa621646dd7b432b9d50
Feb 15 09:51:16 24f57f5 balenad[1656]: time=“2021-02-15T09:51:16.702419101Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:51:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 09:51:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 09:51:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 09:51:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 09:54:17 24f57f5 balenad[1680]: time=“2021-02-15T09:54:17.628820616Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/044ccffd6c642c3085f32f0f78dde534c876bb56db3ff3e531accea9cff41637.sock debug=false pid=265816
Feb 15 09:54:18 24f57f5 balenad[1680]: time=“2021-02-15T09:54:18.790811610Z” level=info msg=“shim reaped” id=24ceb96036aafc277d9584c5c6aae9df5f6222b8abbbb59acb846f94cc662465
Feb 15 09:54:18 24f57f5 balenad[1656]: time=“2021-02-15T09:54:18.797240138Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 09:55:32 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 5.017 ms
Feb 15 09:55:32 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 5.017 ms
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] Error from the API: 503
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] Error from the API: 503
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] Non-200 response from the API! Status code: 503 - message: Error
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] at /usr/src/app/dist/app.js:22:554633
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] at runMicrotasks ()
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] at processTicksAndRejections (internal/process/task_queues.js:97:5)
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] at async /usr/src/app/dist/app.js:22:553941
Feb 15 09:56:01 24f57f5 e6616a67b862[1656]: [error] at async /usr/src/app/dist/app.js:22:555463
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] Non-200 response from the API! Status code: 503 - message: Error
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] at /usr/src/app/dist/app.js:22:554633
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] at runMicrotasks ()
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] at processTicksAndRejections (internal/process/task_queues.js:97:5)
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] at async /usr/src/app/dist/app.js:22:553941
Feb 15 09:56:01 24f57f5 resin-supervisor[3174]: [error] at async /usr/src/app/dist/app.js:22:555463
Feb 15 09:57:19 24f57f5 balenad[1680]: time=“2021-02-15T09:57:19.680158651Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/41b4f364b527ef6ff206d04525778ab793381a7ea6567a6225134f7d3922620c.sock debug=false pid=266311
Feb 15 09:57:20 24f57f5 balenad[1680]: time=“2021-02-15T09:57:20.877984592Z” level=info msg=“shim reaped” id=06ff106b7a4b4d52be9a55daea62f6fa3ae30186f297fad1ba74f5f44a298b10
Feb 15 09:57:20 24f57f5 balenad[1656]: time=“2021-02-15T09:57:20.884057030Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:00:02 24f57f5 fake-hwclock[266795]: [fake-hwclock][INFO] Saving system time to /etc/fake-hwclock/fake-hwclock.data.
Feb 15 10:00:21 24f57f5 balenad[1680]: time=“2021-02-15T10:00:21.769406487Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/43aeffa483391730ca1330b731483b2298cd0df80fe33b5fc6d4fc16263ed3ab.sock debug=false pid=266852
Feb 15 10:00:22 24f57f5 balenad[1680]: time=“2021-02-15T10:00:22.938810058Z” level=info msg=“shim reaped” id=92e0f17fa0f28cb3cf44359ae171f9861009d67423e835140a39f89e17d08601
Feb 15 10:00:22 24f57f5 balenad[1656]: time=“2021-02-15T10:00:22.945596658Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:00:33 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 4.658 ms
Feb 15 10:00:33 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 4.658 ms
Feb 15 10:01:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 10:01:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 10:01:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 10:01:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 10:03:23 24f57f5 balenad[1680]: time=“2021-02-15T10:03:23.831014189Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/b4537ca0ea428f5de3abfcd594ea8b9104d650def5c75c9595ce179a1c67e829.sock debug=false pid=267267
Feb 15 10:03:25 24f57f5 balenad[1680]: time=“2021-02-15T10:03:25.017631469Z” level=info msg=“shim reaped” id=04d524079fa71497dfe824743e04f77b3104c148efa136d3241d3cc6e7dac2d9
Feb 15 10:03:25 24f57f5 balenad[1656]: time=“2021-02-15T10:03:25.023788703Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:05:34 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 6.047 ms
Feb 15 10:05:34 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 6.047 ms
Feb 15 10:06:25 24f57f5 balenad[1680]: time=“2021-02-15T10:06:25.922025068Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/56654467a0e26c9e20ae541fc6dc7561a7f11ad23073fe85dcba22a542a6dfb9.sock debug=false pid=267663
Feb 15 10:06:27 24f57f5 balenad[1680]: time=“2021-02-15T10:06:27.115213542Z” level=info msg=“shim reaped” id=7556fdad13b48f2fb6079430a4e7b03aae48ceccf58f843772c53096ea651040
Feb 15 10:06:27 24f57f5 balenad[1656]: time=“2021-02-15T10:06:27.121289980Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:09:28 24f57f5 balenad[1680]: time=“2021-02-15T10:09:28.016489571Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/85d811184eff69de988b9889cc43e2b6b28a3a310f247522da353b534a77c5e6.sock debug=false pid=268005
Feb 15 10:09:29 24f57f5 balenad[1680]: time=“2021-02-15T10:09:29.196451973Z” level=info msg=“shim reaped” id=729e5a0e1ab3b013dca0d983bb7a76e09acc9c6814457f092cbecfa06b9401c1
Feb 15 10:09:29 24f57f5 balenad[1656]: time=“2021-02-15T10:09:29.202828409Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:10:34 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 7.028 ms
Feb 15 10:10:34 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 7.028 ms
Feb 15 10:11:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 10:11:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 10:11:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 10:11:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 10:12:30 24f57f5 balenad[1680]: time=“2021-02-15T10:12:30.100503630Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/081481e0961f64c02440c74dc5bbd8d017115ca992e9f0409abc556bd893aa42.sock debug=false pid=268385
Feb 15 10:12:31 24f57f5 balenad[1680]: time=“2021-02-15T10:12:31.313908719Z” level=info msg=“shim reaped” id=ec338a9224c0a63bf6b2cb94999a026485808388807c1b61efa3631defa08896
Feb 15 10:12:31 24f57f5 balenad[1656]: time=“2021-02-15T10:12:31.320091989Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:15:32 24f57f5 balenad[1680]: time=“2021-02-15T10:15:32.219375124Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/703d233e5654b839e4ff647d21167cb94e3ab62ca56774745fd42ed8b5a187f0.sock debug=false pid=268868
Feb 15 10:15:33 24f57f5 balenad[1680]: time=“2021-02-15T10:15:33.406177700Z” level=info msg=“shim reaped” id=829562aa6bf904e761aeae55086486dff96c24705efdad71014d274ad98c4c3b
Feb 15 10:15:33 24f57f5 balenad[1656]: time=“2021-02-15T10:15:33.412692616Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:15:35 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 10.886 ms
Feb 15 10:15:35 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 10.886 ms
Feb 15 10:18:34 24f57f5 balenad[1680]: time=“2021-02-15T10:18:34.342789456Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/2fed06aa9e2e97f41b68ccaa7c7e06d8b8009578aa304626c9daf078cb2519dd.sock debug=false pid=269327
Feb 15 10:18:35 24f57f5 balenad[1680]: time=“2021-02-15T10:18:35.518157410Z” level=info msg=“shim reaped” id=a21bd1ad6350e2340769835dda4025902be40ceb191f9ddfadf1c042ce14ba38
Feb 15 10:18:35 24f57f5 balenad[1656]: time=“2021-02-15T10:18:35.524189163Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:20:35 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 2.957 ms
Feb 15 10:20:35 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 2.957 ms
Feb 15 10:21:36 24f57f5 balenad[1680]: time=“2021-02-15T10:21:36.419836047Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/b3fa40a23a088d9005112505b2e6dd67a57b11fb50e4287534887bf32f8c419a.sock debug=false pid=269726
Feb 15 10:21:37 24f57f5 balenad[1680]: time=“2021-02-15T10:21:37.619831991Z” level=info msg=“shim reaped” id=a88372b0042900f459fa829db2d6cda57bff69f2709df801bfcbe350210a550b
Feb 15 10:21:37 24f57f5 balenad[1656]: time=“2021-02-15T10:21:37.626577387Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:21:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 10:21:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 10:21:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 10:21:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 10:24:38 24f57f5 balenad[1680]: time=“2021-02-15T10:24:38.522136919Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/4d6bd94947c3a5d60c835d867ef40336989a3d5a1a9df243a539663ae3665c0f.sock debug=false pid=270004
Feb 15 10:24:39 24f57f5 balenad[1680]: time=“2021-02-15T10:24:39.694835411Z” level=info msg=“shim reaped” id=fb5dd84a928cd3c978d78df02557e1ba1d150146fc65788d3b2dd9f08ccb31fb
Feb 15 10:24:39 24f57f5 balenad[1656]: time=“2021-02-15T10:24:39.701426326Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:25:36 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 2.678 ms
Feb 15 10:25:36 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 2.678 ms
Feb 15 10:27:40 24f57f5 balenad[1680]: time=“2021-02-15T10:27:40.614384327Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/34c66a2940c7d9a1dd2aa8fd56e41eb0b4bcc7c05fcc8b1bcbc0b1e68eb4485d.sock debug=false pid=270488
Feb 15 10:27:41 24f57f5 balenad[1680]: time=“2021-02-15T10:27:41.807274414Z” level=info msg=“shim reaped” id=28c8364f92c9e0469304fc1b22f6ea5fbe7f932bb699dc6269db431fc7fa0ade
Feb 15 10:27:41 24f57f5 balenad[1656]: time=“2021-02-15T10:27:41.813386518Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] Error from the API: 503
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] Error from the API: 503
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] Non-200 response from the API! Status code: 503 - message: Error
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] at /usr/src/app/dist/app.js:22:554633
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] at runMicrotasks ()
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] Non-200 response from the API! Status code: 503 - message: Error
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] at /usr/src/app/dist/app.js:22:554633
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] at processTicksAndRejections (internal/process/task_queues.js:97:5)
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] at runMicrotasks ()
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] at processTicksAndRejections (internal/process/task_queues.js:97:5)
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] at async /usr/src/app/dist/app.js:22:553941
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] at async /usr/src/app/dist/app.js:22:553941
Feb 15 10:30:02 24f57f5 e6616a67b862[1656]: [error] at async /usr/src/app/dist/app.js:22:555463
Feb 15 10:30:02 24f57f5 resin-supervisor[3174]: [error] at async /usr/src/app/dist/app.js:22:555463
Feb 15 10:30:36 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 4.238 ms
Feb 15 10:30:36 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 4.238 ms
Feb 15 10:30:42 24f57f5 balenad[1680]: time=“2021-02-15T10:30:42.719345717Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/f7c6a8bb7346d44028634ee2dc3a3e7cbf16489ac5d58adee0bdf5458fa1c3b7.sock debug=false pid=271039
Feb 15 10:30:43 24f57f5 balenad[1680]: time=“2021-02-15T10:30:43.896841730Z” level=info msg=“shim reaped” id=c8e451581dcc35eba4adf8da2cfcc6b77e3890eb5acae4a5334c3f1ea70d570d
Feb 15 10:30:43 24f57f5 balenad[1656]: time=“2021-02-15T10:30:43.903240739Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:31:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 10:31:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 10:31:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 10:31:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 10:33:44 24f57f5 balenad[1680]: time=“2021-02-15T10:33:44.818612833Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/6e42f95da76ee5570364a8812da41491a457d9e5abacf061e792308f3fc569df.sock debug=false pid=271430
Feb 15 10:33:46 24f57f5 balenad[1680]: time=“2021-02-15T10:33:46.048705987Z” level=info msg=“shim reaped” id=11e83358f1f8a3b4ead3f8cd88afa04b25b5f5909bd62c3be101954e70eeb417
Feb 15 10:33:46 24f57f5 balenad[1656]: time=“2021-02-15T10:33:46.054990405Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:35:37 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 5.736 ms
Feb 15 10:35:37 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 5.736 ms
Feb 15 10:36:46 24f57f5 balenad[1680]: time=“2021-02-15T10:36:46.949030745Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/3c82e556772912a9764cfc49c7f457d01a8cd50b2795f5c2bb9fe9fe3d63187d.sock debug=false pid=271969
Feb 15 10:36:48 24f57f5 balenad[1680]: time=“2021-02-15T10:36:48.146407467Z” level=info msg=“shim reaped” id=e4800f4e13314d8bd39fa6593c37a394f2becde9667198488c1dcf0f0bd2a909
Feb 15 10:36:48 24f57f5 balenad[1656]: time=“2021-02-15T10:36:48.153180825Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:39:49 24f57f5 balenad[1680]: time=“2021-02-15T10:39:49.043244231Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/4734008ea6063f8cb861d481b881066a02d688e5385a3a706aa2bea7f629e995.sock debug=false pid=272396
Feb 15 10:39:50 24f57f5 balenad[1680]: time=“2021-02-15T10:39:50.217027270Z” level=info msg=“shim reaped” id=38d41df5a2e04e2fd9faf92a80e3d3afff771915396d7dfb49389d2e7c8e74db
Feb 15 10:39:50 24f57f5 balenad[1656]: time=“2021-02-15T10:39:50.223431002Z” level=info msg=“ignoring event” module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Feb 15 10:40:38 24f57f5 e6616a67b862[1656]: [api] GET /v1/healthy 200 - 11.569 ms
Feb 15 10:40:38 24f57f5 resin-supervisor[3174]: [api] GET /v1/healthy 200 - 11.569 ms
Feb 15 10:41:52 24f57f5 resin-supervisor[3174]: [debug] Attempting container log timestamp flush…
Feb 15 10:41:52 24f57f5 resin-supervisor[3174]: [debug] Container log timestamp flush complete
Feb 15 10:41:52 24f57f5 e6616a67b862[1656]: [debug] Attempting container log timestamp flush…
Feb 15 10:41:52 24f57f5 e6616a67b862[1656]: [debug] Container log timestamp flush complete
Feb 15 10:42:51 24f57f5 balenad[1680]: time=“2021-02-15T10:42:51.137951565Z” level=info msg=“shim balena-engine-containerd-shim started” address=/containerd-shim/78baea5b19483aee65e0bc720f30ddba9184c6eb680477c5c7e364f58ea337bb.sock debug=false pid=272871

#8

I did an OS update on 2/13 when the issue happened so the reboot 3 days prior seems to have been cleared when the OS update happened. How do I just dump the sound system starting up might be better to see?

#9

When was the last time you updated balenaOS and the latest release of balenaSound? There have been a few updates in the last ten months and you might just need a new release of everything. Get the latest info here. Let’s see what a fresh install does.

Also, regarding logs, you can filter logs by specific services to hone in on what’s going on. In the new build of Sound, I’d check out the logs for the audio and bluetooth services.

#11

Hey @d-m !

Was wondering if you tried a fresh install of balenaOS and balenaSound. Also if the logging tip helped. Please let us know how we can help.