From: Laurent GUILLIER <laurent.guillier@smile.fr>
To: rauc@pengutronix.de
Subject: Re: [RAUC] Rauc and Hawkbit server
Date: Fri, 8 Dec 2017 09:32:15 +0100 [thread overview]
Message-ID: <f77203d7-7c77-dce5-3e0c-5c523b716742@smile.fr> (raw)
Hi Enrico,
thanks for your reply.
Actually the green mark does not appear on the hawkbit web UI update
status, and thus the process is not considered as successful by hawkbit
server and is retried on next boot.
Here are some logs from the rauc-client, after the first boot :
root@imx6dl-riotboard:~# journalctl -f -u rauc*
-- Logs begin at Tue 2017-11-14 11:03:51 UTC. --
Dec 07 15:43:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:43:22
INFO Will sleep for 00:02:00
Dec 07 15:45:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:45:22
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0
Dec 07 15:45:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:45:22
DEBUG {'config': {'polling': {'sleep': '00:02:00'}}}
Dec 07 15:45:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:45:22
INFO Will sleep for 00:02:00
Dec 07 15:47:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:47:22
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0
Dec 07 15:47:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:47:22
DEBUG {'config': {'polling': {'sleep': '00:02:00'}}}
Dec 07 15:47:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:47:22
INFO Will sleep for 00:02:00
Dec 07 15:49:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:49:22
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0
Dec 07 15:49:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:49:22
DEBUG {'config': {'polling': {'sleep': '00:02:00'}}}
Dec 07 15:49:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:49:22
INFO Will sleep for 00:02:00
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
DEBUG {'config': {'polling': {'sleep': '00:02:00'}}, '_links':
{'deploymentBase': {'href':
'http://10.12.90.103:8080/DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/D
EFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1?c=411629670'}}}
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
INFO Deployment found for this target
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
DEBUG {'id': '1', 'deployment': {'download': 'forced', 'chunks':
[{'name': 'Hello', 'part': 'os', 'artifacts': [{'hashes': {'md5':
'd53f3d6b420f142f7746bd48789445e
9', 'sha1': '4282dc91952406e184079567ef8dbe7e36f7c4e3'}, 'filename':
'update-bundle-imx6dl-riotboard-20171207153430.raucb', 'size': 34883096,
'_links': {'md5sum-http': {'href':
'http://10.12.90.103:8080/DEFAULT/controller/v1/riot_0a:14:2e
:95:8e:e0/softwaremodules/1/artifacts/update-bundle-imx6dl-riotboard-20171207153430.raucb.MD5SUM'},
'download-http': {'href':
'http://10.12.90.103:8080/DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/softwaremodules/1/artifacts/update-bundle
-imx6dl-riotboard-20171207153430.raucb'}}}], 'version': '1.1'}],
'update': 'forced'}}
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
INFO Starting bundle download
Dec 07 15:51:22 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:22
DEBUG GET binary
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/softwaremodules/1/artifacts/update-bundle-imx6dl-riotboard-20171207153430.r
aucb
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
INFO Download successful
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
INFO Starting installation
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: input bundle: /tmp/bundle.raucb
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: Active slot bootname: B
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
INFO Will sleep for 00:02:00
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: started
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
INFO Update progress: 0% Installing
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: rauc-Message: Mounting
bundle '/tmp/bundle.raucb' to '/mnt/rauc/bundle'
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: Checking and mounting bundle...
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: rauc-Message: Reading
bundle: /tmp/bundle.raucb
Dec 07 15:51:57 imx6dl-riotboard rauc[282]: rauc-Message: Verifying
bundle...
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
INFO Update progress: 0% Determining slot states
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:57 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
INFO Update progress: 20% Determining slot states done.
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:57
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
INFO Update progress: 20% Checking bundle
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
INFO Update progress: 20% Verifying signature
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
INFO Update progress: 40% Verifying signature done.
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
INFO Update progress: 40% Checking bundle done.
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
INFO Update progress: 50% Verifying manifest checksums
Dec 07 15:51:58 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:51:58
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
[ 2529.707770] EXT4-fs (mmcblk1p2): recovery complete
[ 2529.720763] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data
mode. Opts: (null)
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
INFO Update progress: 60% Verifying manifest checksums done.
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: Adding to target group:
rootfs -> rootfs.0
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: Target Group:
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rootfs -> rootfs.0
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: Using default handler
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rauc-Message: Marking target
slot as non-bootable...
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rauc-Message: Checking image
type for slot type: ext4
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rauc-Message: Image detected
as type: *.ext4
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rauc-Message: mounting slot
/dev/mmcblk1p2
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: Updating slots...
Dec 07 15:52:10 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: Checking slot rootfs.0
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
INFO Update progress: 60% Verifying manifest done.
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
INFO Update progress: 60% Determining target install group
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
INFO Update progress: 80% Determining target install group done.
Dec 07 15:52:10 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:10
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:11 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:11
INFO Update progress: 80% Checking slot rootfs.0
Dec 07 15:52:11 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:11
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:11 imx6dl-riotboard rauc[282]: rauc-Message: Failed to load
slot status file: No such file or directory
Dec 07 15:52:11 imx6dl-riotboard rauc[282]: rauc-Message: Updating
/dev/mmcblk1p2 with
/mnt/rauc/bundle/core-image-minimal-imx6dl-riotboard.ext4
Dec 07 15:52:11 imx6dl-riotboard rauc[282]: rauc-Message: opening slot
device /dev/mmcblk1p2
Dec 07 15:52:11 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: Updating slot rootfs.0
Dec 07 15:52:11 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:11
INFO Update progress: 90% Checking slot rootfs.0 done.
Dec 07 15:52:11 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:11
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:11 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:11
INFO Update progress: 90% Copying image
Dec 07 15:52:11 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:11
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
[ 2567.647271] EXT4-fs (mmcblk1p2): mounted filesystem with ordered data
mode. Opts: (null)
Dec 07 15:52:48 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:48
INFO Update progress: 100% Copying image done.
Dec 07 15:52:48 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:48
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:48 imx6dl-riotboard rauc[282]: rauc-Message: Updating slot
file /mnt/rauc/rootfs.0/slot.raucs
Dec 07 15:52:48 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: Updating slot rootfs.0 status
Dec 07 15:52:49 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: Updating slot rootfs.0 done
Dec 07 15:52:49 imx6dl-riotboard rauc[282]: rauc-Message: Marking slots
as bootable...
Dec 07 15:52:49 imx6dl-riotboard rauc[282]: Starting post install
handler: /usr/lib/rauc/post-install.sh
Dec 07 15:52:49 imx6dl-riotboard rauc[282]: rauc-Message: installing
/tmp/bundle.raucb: All slots updated
Dec 07 15:52:49 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:49
INFO Update progress: 100% Updating slots done.
Dec 07 15:52:49 imx6dl-riotboard rauc-hawkbit[255]: 2017-12-07 15:52:49
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 15:52:49 imx6dl-riotboard rauc[282]: # Reboot scheduled in 60sec
Here we can see the slot is updated and reboot is scheduled by
post-install process.
Messages on hawkbit server are OK, from "Target retrieved update action
and should start now the download." to "Updating slots done."
Now, here is what happens on next reboot :
Dec 07 16:01:36 imx6dl-riotboard systemd[1]: Started RAUC Good-marking
Service.
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: Compatible: RioTHello
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: booted from: A
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: slot states:
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: rootfs.0: class=rootfs,
device=/dev/mmcblk1p2, type=ext4, bootname=A
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: state=booted,
description=, parent=(none), mountpoint=(none)
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: rootfs.1: class=rootfs,
device=/dev/mmcblk1p3, type=ext4, bootname=B
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: state=inactive,
description=, parent=(none), mountpoint=(none)
Dec 07 16:01:37 imx6dl-riotboard rauc[257]: marking slot rootfs.0 as good
Dec 07 16:01:38 imx6dl-riotboard systemd[1]: Starting rauc-hawkbit...
Dec 07 16:01:38 imx6dl-riotboard systemd[1]: Started rauc-hawkbit.
Dec 07 16:01:38 imx6dl-riotboard rauc-hawkbit[273]: Starting
/usr/bin/rauc-hawkbit-client ...
Dec 07 16:01:45 imx6dl-riotboard systemd[1]: Starting Rauc Update Service...
Dec 07 16:01:46 imx6dl-riotboard rauc[303]: (rauc:303):
GLib-GObject-CRITICAL **: g_object_set: assertion 'G_IS_OBJECT (object)'
failed
Dec 07 16:01:46 imx6dl-riotboard systemd[1]: Started Rauc Update Service.
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
DEBUG {'config': {'polling': {'sleep': '00:02:00'}}, '_links':
{'deploymentBase': {'href':
'http://10.12.90.103:8080/DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1?c=411659461'}}}
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
INFO Deployment found for this target
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
DEBUG GET
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
DEBUG {'id': '1', 'deployment': {'download': 'forced', 'update':
'forced', 'chunks': [{'artifacts': [{'size': 34883096, '_links':
{'md5sum-http': {'href':
'http://10.12.90.103:8080/DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/softwaremodules/1/artifacts/update-bundle-imx6dl-riotboard-20171207153430.raucb.MD5SUM'},
'download-http': {'href':
'http://10.12.90.103:8080/DEFAULT/controller/v1/riot_0a:14:
2e:95:8e:e0/softwaremodules/1/artifacts/update-bundle-imx6dl-riotboard-20171207153430.raucb'}},
'hashes': {'sha1': '4282dc91952406e184079567ef8dbe7e36f7c4e3', 'md5':
'd53f3d6b420f142f7746bd48789445e9'}, 'filename':
'update-bundle-imx6dl-riotboard-20171207153430.raucb'}], 'version':
'1.1', 'part': 'os', 'name': 'Hello'}]}}
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
INFO Starting bundle download
Dec 07 16:01:46 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:01:46
DEBUG GET binary
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/softwaremodules/1/artifacts/update-bundle-imx6dl-riotboard-20171207153430.raucb
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Download successful
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Starting installation
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: input bundle: /tmp/bundle.raucb
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: Active slot bootname: A
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: started
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Will sleep for 00:02:00
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: rauc-Message: Mounting
bundle '/tmp/bundle.raucb' to '/mnt/rauc/bundle'
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: Checking and mounting bundle...
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: rauc-Message: Reading
bundle: /tmp/bundle.raucb
Dec 07 16:02:21 imx6dl-riotboard rauc[303]: rauc-Message: Verifying
bundle...
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Update progress: 0% Installing
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Update progress: 0% Determining slot states
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Update progress: 20% Determining slot states done.
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Update progress: 20% Checking bundle
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
INFO Update progress: 20% Verifying signature
Dec 07 16:02:21 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:21
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
INFO Update progress: 40% Verifying signature done.
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
INFO Update progress: 40% Checking bundle done.
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
INFO Update progress: 40% Loading manifest file
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
INFO Update progress: 50% Loading manifest file done.
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
INFO Update progress: 50% Verifying manifest checksums
Dec 07 16:02:22 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:22
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 60% Verifying manifest checksums done.
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: Adding to target group:
rootfs -> rootfs.1
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: Target Group:
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rootfs -> rootfs.1
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: Using default handler
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: Marking target
slot as non-bootable...
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: Checking image
type for slot type: ext4
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: Image detected
as type: *.ext4
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: mounting slot
/dev/mmcblk1p3
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: Updating slots...
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: Checking slot rootfs.1
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 60% Verifying manifest done.
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 60% Determining target install group
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 80% Determining target install group done.
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: Failed to load
slot status file: No such file or directory
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 80% Checking slot rootfs.1
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: Updating
/dev/mmcblk1p3 with
/mnt/rauc/bundle/core-image-minimal-imx6dl-riotboard.ext4
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: opening slot
device /dev/mmcblk1p3
Dec 07 16:02:34 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: Updating slot rootfs.1
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 90% Checking slot rootfs.1 done.
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
INFO Update progress: 90% Copying image
Dec 07 16:02:34 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:02:34
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:03:12 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:03:12
INFO Update progress: 100% Copying image done.
Dec 07 16:03:12 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:03:12
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: rauc-Message: Updating slot
file /mnt/rauc/rootfs.1/slot.raucs
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: Updating slot rootfs.1 status
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: rauc-Message: Marking slots
as bootable...
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: Updating slot rootfs.1 done
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: Starting post install
handler: /usr/lib/rauc/post-install.sh
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: rauc-Message: installing
/tmp/bundle.raucb: All slots updated
Dec 07 16:03:12 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:03:12
INFO Update progress: 100% Updating slots done.
Dec 07 16:03:12 imx6dl-riotboard rauc-hawkbit[273]: 2017-12-07 16:03:12
DEBUG POST
http://10.12.90.103:8080//DEFAULT/controller/v1/riot_0a:14:2e:95:8e:e0/deploymentBase/1/feedback
Dec 07 16:03:12 imx6dl-riotboard rauc[303]: # Reboot scheduled in 60sec
[ OK ] Stopped target Multi-User System.
As we can see, the update is performed again ...
Messages on hawkbit server are exactly the same as for previous update.
It looks like the server miss a message telling it that the update has
been permformed and that everything is OK. Leaving the system alive will
result in a never ending update / reboot process.
Thanks for any though that would help me finish the update.
Regards
Laurent
_______________________________________________
RAUC mailing list
next reply other threads:[~2017-12-08 8:32 UTC|newest]
Thread overview: 3+ messages / expand[flat|nested] mbox.gz Atom feed top
2017-12-08 8:32 Laurent GUILLIER [this message]
-- strict thread matches above, loose matches on Subject: below --
2017-12-05 16:46 Laurent GUILLIER
2017-12-06 15:27 ` Enrico Joerns
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=f77203d7-7c77-dce5-3e0c-5c523b716742@smile.fr \
--to=laurent.guillier@smile.fr \
--cc=rauc@pengutronix.de \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox