- {"dt": "2024-11-14T10:37:36.323883", "lvl": "info", "msg": "lava-dispatcher, installed at version: 2024.05.dev0067"}
- {"dt": "2024-11-14T10:37:36.323974", "lvl": "info", "msg": "start: 0 validate"}
- {"dt": "2024-11-14T10:37:36.324050", "lvl": "info", "msg": "Start time: 2024-11-14 10:37:36.324043+00:00 (UTC)"}
- {"dt": "2024-11-14T10:37:36.324634", "lvl": "debug", "msg": "Validating that file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst exists"}
- {"dt": "2024-11-14T10:37:36.324753", "lvl": "debug", "msg": "Validating that file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst exists"}
- {"dt": "2024-11-14T10:37:36.324856", "lvl": "debug", "msg": "Validating that file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst exists"}
- {"dt": "2024-11-14T10:37:36.325139", "lvl": "debug", "msg": "Validating that file:///home/anders/.cache/tuxsuite/plan/144/build_1/vmlinux exists"}
- {"dt": "2024-11-14T10:37:36.325244", "lvl": "debug", "msg": "Validating that file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_buildroot_sparc64_rootfs.ext4.zst exists"}
- {"dt": "2024-11-14T10:37:36.325330", "lvl": "debug", "msg": "Validating that file:///home/anders/.cache/tuxsuite/plan/144/build_1/modules.tar.xz exists"}
- {"dt": "2024-11-14T10:37:36.348071", "lvl": "info", "msg": "qemu, installed at version: 8.2.4, host architecture: x86_64"}
- {"dt": "2024-11-14T10:37:36.348231", "lvl": "warning", "msg": "Missing image arg for url_repo"}
- {"dt": "2024-11-14T10:37:36.348312", "lvl": "warning", "msg": "Missing image arg for rootfs.modules"}
- {"dt": "2024-11-14T10:37:36.348407", "lvl": "info", "msg": "validate duration: 0.02"}
- {"dt": "2024-11-14T10:37:36.348457", "lvl": "results", "msg": {"definition": "lava", "case": "validate", "result": "pass"}}
- {"dt": "2024-11-14T10:37:36.348541", "lvl": "info", "msg": "start: 1 deployimages (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.348600", "lvl": "debug", "msg": "start: 1.1 lava-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.348745", "lvl": "debug", "msg": "[common] Preparing overlay tarball in /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp"}
- {"dt": "2024-11-14T10:37:36.348891", "lvl": "debug", "msg": "makedir: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin"}
- {"dt": "2024-11-14T10:37:36.348998", "lvl": "debug", "msg": "makedir: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/tests"}
- {"dt": "2024-11-14T10:37:36.349099", "lvl": "debug", "msg": "makedir: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/results"}
- {"dt": "2024-11-14T10:37:36.349171", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-add-keys"}
- {"dt": "2024-11-14T10:37:36.349307", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-add-sources"}
- {"dt": "2024-11-14T10:37:36.349441", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-background-process-start"}
- {"dt": "2024-11-14T10:37:36.349565", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-background-process-stop"}
- {"dt": "2024-11-14T10:37:36.349698", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-common-functions"}
- {"dt": "2024-11-14T10:37:36.349822", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-echo-ipv4"}
- {"dt": "2024-11-14T10:37:36.349941", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-install-packages"}
- {"dt": "2024-11-14T10:37:36.350060", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-installed-packages"}
- {"dt": "2024-11-14T10:37:36.350177", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-os-build"}
- {"dt": "2024-11-14T10:37:36.350295", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-probe-channel"}
- {"dt": "2024-11-14T10:37:36.350414", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-probe-ip"}
- {"dt": "2024-11-14T10:37:36.350530", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-target-ip"}
- {"dt": "2024-11-14T10:37:36.350647", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-target-mac"}
- {"dt": "2024-11-14T10:37:36.350769", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-target-storage"}
- {"dt": "2024-11-14T10:37:36.350889", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-case"}
- {"dt": "2024-11-14T10:37:36.351007", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-event"}
- {"dt": "2024-11-14T10:37:36.351124", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-feedback"}
- {"dt": "2024-11-14T10:37:36.351243", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-raise"}
- {"dt": "2024-11-14T10:37:36.351361", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-reference"}
- {"dt": "2024-11-14T10:37:36.351478", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-runner"}
- {"dt": "2024-11-14T10:37:36.351594", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-set"}
- {"dt": "2024-11-14T10:37:36.351713", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-test-shell"}
- {"dt": "2024-11-14T10:37:36.351834", "lvl": "debug", "msg": "Updating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-install-packages (oe)"}
- {"dt": "2024-11-14T10:37:36.351975", "lvl": "debug", "msg": "Updating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/bin/lava-installed-packages (oe)"}
- {"dt": "2024-11-14T10:37:36.352086", "lvl": "debug", "msg": "Creating /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/environment"}
- {"dt": "2024-11-14T10:37:36.352176", "lvl": "debug", "msg": "LAVA metadata"}
- {"dt": "2024-11-14T10:37:36.352225", "lvl": "debug", "msg": "- LAVA_JOB_ID=1"}
- {"dt": "2024-11-14T10:37:36.352268", "lvl": "debug", "msg": "- LAVA_DISPATCHER_IP=192.168.32.138"}
- {"dt": "2024-11-14T10:37:36.352342", "lvl": "debug", "msg": "start: 1.1.1 lava-vland-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352387", "lvl": "debug", "msg": "skipped lava-vland-overlay"}
- {"dt": "2024-11-14T10:37:36.352439", "lvl": "debug", "msg": "end: 1.1.1 lava-vland-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352494", "lvl": "debug", "msg": "start: 1.1.2 lava-multinode-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352542", "lvl": "debug", "msg": "skipped lava-multinode-overlay"}
- {"dt": "2024-11-14T10:37:36.352589", "lvl": "debug", "msg": "end: 1.1.2 lava-multinode-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352640", "lvl": "debug", "msg": "start: 1.1.3 test-definition (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352686", "lvl": "info", "msg": "Loading test definitions"}
- {"dt": "2024-11-14T10:37:36.352742", "lvl": "debug", "msg": "start: 1.1.3.1 url-repo-action (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352795", "lvl": "debug", "msg": "start: 1.1.3.1.1 download-retry (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352849", "lvl": "debug", "msg": "start: 1.1.3.1.1.1 file-download (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.352987", "lvl": "info", "msg": "downloading file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst"}
- {"dt": "2024-11-14T10:37:36.353038", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/url-repo-action-smmaj3vh/url_repo/https___storage.tuxboot.com_test-definitions_2024.07.tar"}
- {"dt": "2024-11-14T10:37:36.353078", "lvl": "debug", "msg": "total size: 13692979 (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.353118", "lvl": "info", "msg": "Using unzstd to decompress zstd"}
- {"dt": "2024-11-14T10:37:36.353472", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.356524", "lvl": "debug", "msg": "progress   5\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.358961", "lvl": "debug", "msg": "progress  10\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.361271", "lvl": "debug", "msg": "progress  15\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.364364", "lvl": "debug", "msg": "progress  20\u202F% (2\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.367068", "lvl": "debug", "msg": "progress  25\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.369465", "lvl": "debug", "msg": "progress  30\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.372009", "lvl": "debug", "msg": "progress  35\u202F% (4\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.374329", "lvl": "debug", "msg": "progress  40\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.376827", "lvl": "debug", "msg": "progress  45\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.379292", "lvl": "debug", "msg": "progress  50\u202F% (6\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.381660", "lvl": "debug", "msg": "progress  55\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.384073", "lvl": "debug", "msg": "progress  60\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.386928", "lvl": "debug", "msg": "progress  65\u202F% (8\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.390047", "lvl": "debug", "msg": "progress  70\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.392517", "lvl": "debug", "msg": "progress  75\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.394890", "lvl": "debug", "msg": "progress  80\u202F% (10\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.397627", "lvl": "debug", "msg": "progress  85\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.400180", "lvl": "debug", "msg": "progress  90\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.404519", "lvl": "debug", "msg": "progress  95\u202F% (12\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.408727", "lvl": "debug", "msg": "progress 100\u202F% (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.416145", "lvl": "info", "msg": "13\u202FMB downloaded in 0.06\u202Fs (207.08\u202FMB/s)"}
- {"dt": "2024-11-14T10:37:36.416316", "lvl": "debug", "msg": "end: 1.1.3.1.1.1 file-download (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.416394", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "file-download", "level": "1.1.3.1.1.1", "duration": "0.06", "result": "pass", "extra": {"label": "url_repo", "size": ! "13692979", "md5sum": "30eb6f40044a706e0edae9b32f16a662", "sha256sum": "c850bed1a93201581f64754245d951f99a4942fe707b841bfe6ea3c9cd7624b0", "sha512sum": "3435daea585c61fec8b4c72eeb412c9d550e229d1220195bd592f268fe6baad5d210433f9802e5f9931fb5b8b17a10a4c5c569f16a3c286247222b96634c6310"}}}
- {"dt": "2024-11-14T10:37:36.416559", "lvl": "debug", "msg": "end: 1.1.3.1.1 download-retry (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.416628", "lvl": "debug", "msg": "Using /lava-1 at stage 0"}
- {"dt": "2024-11-14T10:37:36.416722", "lvl": "debug", "msg": "Runner path : /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/0/tests/0_ltp-fcntl-locktests"}
- {"dt": "2024-11-14T10:37:36.416805", "lvl": "info", "msg": "Untar tests from file /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/url-repo-action-smmaj3vh/url_repo/https___storage.tuxboot.com_test-definitions_2024.07.tar to directory /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/0/tests/0_ltp-fcntl-locktests"}
- {"dt": "2024-11-14T10:37:36.611320", "lvl": "debug", "msg": "Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/0/tests/0_ltp-fcntl-locktests/automated/linux/ltp/ltp.yaml"}
- {"dt": "2024-11-14T10:37:36.611662", "lvl": "debug", "msg": "uuid=1_1.1.3.1 testdef=None"}
- {"dt": "2024-11-14T10:37:36.611751", "lvl": "debug", "msg": "end: 1.1.3.1 url-repo-action (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.611823", "lvl": "debug", "msg": "start: 1.1.3.2 test-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.612391", "lvl": "debug", "msg": "end: 1.1.3.2 test-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.612445", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-overlay", "level": "1.1.3.2", "duration": "0.00", "result": "pass", "extra": {"uuid": "1_1.1.3.1", "name": "ltp-fcntl-locktests", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst"}}}
- {"dt": "2024-11-14T10:37:36.612548", "lvl": "debug", "msg": "start: 1.1.3.3 test-install-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.613434", "lvl": "debug", "msg": "end: 1.1.3.3 test-install-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.613492", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-install-overlay", "level": "1.1.3.3", "duration": "0.00", "result": "pass", "extra": {"uuid": "1_1.1.3.1", "name": "ltp-fcntl-locktests", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst", "skipped test-install-overlay": "1_1.1.3.1"}}}
- {"dt": "2024-11-14T10:37:36.613604", "lvl": "debug", "msg": "start: 1.1.3.4 test-runscript-overlay (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.621723", "lvl": "debug", "msg": "runner path: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/0/tests/0_ltp-fcntl-locktests test_uuid 1_1.1.3.1"}
- {"dt": "2024-11-14T10:37:36.621807", "lvl": "debug", "msg": "SKIP_INSTALL='true'"}
- {"dt": "2024-11-14T10:37:36.621859", "lvl": "debug", "msg": "TST_CMDFILES='fcntl-locktests'"}
- {"dt": "2024-11-14T10:37:36.621899", "lvl": "debug", "msg": "SKIPFILE='/tuxtest/skipfiles/sparc64/ltp-fcntl-locktests'"}
- {"dt": "2024-11-14T10:37:36.621935", "lvl": "debug", "msg": "ENVIRONMENT='production'"}
- {"dt": "2024-11-14T10:37:36.621970", "lvl": "debug", "msg": "LTP_TMPDIR='/scratch'"}
- {"dt": "2024-11-14T10:37:36.622006", "lvl": "debug", "msg": "LTP_INSTALL_PATH='/opt/ltp/'"}
- {"dt": "2024-11-14T10:37:36.622041", "lvl": "debug", "msg": "SHARD_NUMBER='1'"}
- {"dt": "2024-11-14T10:37:36.622075", "lvl": "debug", "msg": "SHARD_INDEX='1'"}
- {"dt": "2024-11-14T10:37:36.622109", "lvl": "debug", "msg": "TIMEOUT_MULTIPLIER='5'"}
- {"dt": "2024-11-14T10:37:36.622233", "lvl": "debug", "msg": "end: 1.1.3.4 test-runscript-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.622288", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-runscript-overlay", "level": "1.1.3.4", "duration": "0.01", "result": "pass", "extra": {"uuid": "1_1.1.3.1", "name": "ltp-fcntl-locktests", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst", "filename": "/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/0/tests/0_ltp-fcntl-locktests/run.sh"}}}
- {"dt": "2024-11-14T10:37:36.622396", "lvl": "debug", "msg": "start: 1.1.3.5 url-repo-action (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.622453", "lvl": "debug", "msg": "start: 1.1.3.5.1 download-retry (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.622506", "lvl": "debug", "msg": "start: 1.1.3.5.1.1 file-download (timeout 00:05:00) [common]"}
- {"dt": "2024-11-14T10:37:36.622631", "lvl": "info", "msg": "downloading file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst"}
- {"dt": "2024-11-14T10:37:36.622683", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/url-repo-action-jlv1e1d7/url_repo/https___storage.tuxboot.com_test-definitions_2024.07.tar"}
- {"dt": "2024-11-14T10:37:36.622725", "lvl": "debug", "msg": "total size: 13692979 (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.622767", "lvl": "info", "msg": "Using unzstd to decompress zstd"}
- {"dt": "2024-11-14T10:37:36.623100", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.626473", "lvl": "debug", "msg": "progress   5\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.629007", "lvl": "debug", "msg": "progress  10\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.631400", "lvl": "debug", "msg": "progress  15\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.633826", "lvl": "debug", "msg": "progress  20\u202F% (2\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.636388", "lvl": "debug", "msg": "progress  25\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.638668", "lvl": "debug", "msg": "progress  30\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.640949", "lvl": "debug", "msg": "progress  35\u202F% (4\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.643313", "lvl": "debug", "msg": "progress  40\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.646040", "lvl": "debug", "msg": "progress  45\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.648255", "lvl": "debug", "msg": "progress  50\u202F% (6\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.650579", "lvl": "debug", "msg": "progress  55\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.652837", "lvl": "debug", "msg": "progress  60\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.655205", "lvl": "debug", "msg": "progress  65\u202F% (8\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.657529", "lvl": "debug", "msg": "progress  70\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.659810", "lvl": "debug", "msg": "progress  75\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.662093", "lvl": "debug", "msg": "progress  80\u202F% (10\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.664798", "lvl": "debug", "msg": "progress  85\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.667300", "lvl": "debug", "msg": "progress  90\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.671511", "lvl": "debug", "msg": "progress  95\u202F% (12\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.675661", "lvl": "debug", "msg": "progress 100\u202F% (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.683042", "lvl": "info", "msg": "13\u202FMB downloaded in 0.06\u202Fs (216.52\u202FMB/s)"}
- {"dt": "2024-11-14T10:37:36.683201", "lvl": "debug", "msg": "end: 1.1.3.5.1.1 file-download (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.683274", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "file-download", "level": "1.1.3.5.1.1", "duration": "0.06", "result": "pass", "extra": {"label": "url_repo", "size": ! "13692979", "md5sum": "30eb6f40044a706e0edae9b32f16a662", "sha256sum": "c850bed1a93201581f64754245d951f99a4942fe707b841bfe6ea3c9cd7624b0", "sha512sum": "3435daea585c61fec8b4c72eeb412c9d550e229d1220195bd592f268fe6baad5d210433f9802e5f9931fb5b8b17a10a4c5c569f16a3c286247222b96634c6310"}}}
- {"dt": "2024-11-14T10:37:36.683436", "lvl": "debug", "msg": "end: 1.1.3.5.1 download-retry (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.683505", "lvl": "debug", "msg": "Using /lava-1 at stage 1"}
- {"dt": "2024-11-14T10:37:36.683601", "lvl": "debug", "msg": "Runner path : /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/1/tests/1_ltp-fs_perms_simple"}
- {"dt": "2024-11-14T10:37:36.683684", "lvl": "info", "msg": "Untar tests from file /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/url-repo-action-jlv1e1d7/url_repo/https___storage.tuxboot.com_test-definitions_2024.07.tar to directory /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/1/tests/1_ltp-fs_perms_simple"}
- {"dt": "2024-11-14T10:37:36.883988", "lvl": "debug", "msg": "Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/1/tests/1_ltp-fs_perms_simple/automated/linux/ltp/ltp.yaml"}
- {"dt": "2024-11-14T10:37:36.884351", "lvl": "debug", "msg": "uuid=1_1.1.3.5 testdef=None"}
- {"dt": "2024-11-14T10:37:36.884447", "lvl": "debug", "msg": "end: 1.1.3.5 url-repo-action (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.884513", "lvl": "debug", "msg": "start: 1.1.3.6 test-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:36.885097", "lvl": "debug", "msg": "end: 1.1.3.6 test-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.885154", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-overlay", "level": "1.1.3.6", "duration": "0.00", "result": "pass", "extra": {"uuid": "1_1.1.3.5", "name": "ltp-fs_perms_simple", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst"}}}
- {"dt": "2024-11-14T10:37:36.885334", "lvl": "debug", "msg": "start: 1.1.3.7 test-install-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:36.886119", "lvl": "debug", "msg": "end: 1.1.3.7 test-install-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.886175", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-install-overlay", "level": "1.1.3.7", "duration": "0.00", "result": "pass", "extra": {"uuid": "1_1.1.3.5", "name": "ltp-fs_perms_simple", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst", "skipped test-install-overlay": "1_1.1.3.5"}}}
- {"dt": "2024-11-14T10:37:36.886285", "lvl": "debug", "msg": "start: 1.1.3.8 test-runscript-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:36.894450", "lvl": "debug", "msg": "runner path: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/1/tests/1_ltp-fs_perms_simple test_uuid 1_1.1.3.5"}
- {"dt": "2024-11-14T10:37:36.894511", "lvl": "debug", "msg": "SKIP_INSTALL='true'"}
- {"dt": "2024-11-14T10:37:36.894553", "lvl": "debug", "msg": "TST_CMDFILES='fs_perms_simple'"}
- {"dt": "2024-11-14T10:37:36.894591", "lvl": "debug", "msg": "SKIPFILE='/tuxtest/skipfiles/sparc64/ltp-fs_perms_simple'"}
- {"dt": "2024-11-14T10:37:36.894626", "lvl": "debug", "msg": "ENVIRONMENT='production'"}
- {"dt": "2024-11-14T10:37:36.894661", "lvl": "debug", "msg": "LTP_TMPDIR='/scratch'"}
- {"dt": "2024-11-14T10:37:36.894697", "lvl": "debug", "msg": "LTP_INSTALL_PATH='/opt/ltp/'"}
- {"dt": "2024-11-14T10:37:36.894732", "lvl": "debug", "msg": "SHARD_NUMBER='1'"}
- {"dt": "2024-11-14T10:37:36.894767", "lvl": "debug", "msg": "SHARD_INDEX='1'"}
- {"dt": "2024-11-14T10:37:36.894801", "lvl": "debug", "msg": "TIMEOUT_MULTIPLIER='5'"}
- {"dt": "2024-11-14T10:37:36.894918", "lvl": "debug", "msg": "end: 1.1.3.8 test-runscript-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.894970", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-runscript-overlay", "level": "1.1.3.8", "duration": "0.01", "result": "pass", "extra": {"uuid": "1_1.1.3.5", "name": "ltp-fs_perms_simple", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst", "filename": "/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/1/tests/1_ltp-fs_perms_simple/run.sh"}}}
- {"dt": "2024-11-14T10:37:36.895075", "lvl": "debug", "msg": "start: 1.1.3.9 url-repo-action (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:36.895132", "lvl": "debug", "msg": "start: 1.1.3.9.1 download-retry (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:36.895187", "lvl": "debug", "msg": "start: 1.1.3.9.1.1 file-download (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:36.895309", "lvl": "info", "msg": "downloading file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst"}
- {"dt": "2024-11-14T10:37:36.895359", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/url-repo-action-mo40wr_v/url_repo/https___storage.tuxboot.com_test-definitions_2024.07.tar"}
- {"dt": "2024-11-14T10:37:36.895399", "lvl": "debug", "msg": "total size: 13692979 (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.895440", "lvl": "info", "msg": "Using unzstd to decompress zstd"}
- {"dt": "2024-11-14T10:37:36.895849", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.899779", "lvl": "debug", "msg": "progress   5\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.902564", "lvl": "debug", "msg": "progress  10\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.905059", "lvl": "debug", "msg": "progress  15\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.907442", "lvl": "debug", "msg": "progress  20\u202F% (2\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.910204", "lvl": "debug", "msg": "progress  25\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.912504", "lvl": "debug", "msg": "progress  30\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.914788", "lvl": "debug", "msg": "progress  35\u202F% (4\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.917162", "lvl": "debug", "msg": "progress  40\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.919596", "lvl": "debug", "msg": "progress  45\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.921938", "lvl": "debug", "msg": "progress  50\u202F% (6\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.924295", "lvl": "debug", "msg": "progress  55\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.926714", "lvl": "debug", "msg": "progress  60\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.929133", "lvl": "debug", "msg": "progress  65\u202F% (8\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.931517", "lvl": "debug", "msg": "progress  70\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.933924", "lvl": "debug", "msg": "progress  75\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.936361", "lvl": "debug", "msg": "progress  80\u202F% (10\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.939583", "lvl": "debug", "msg": "progress  85\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.941919", "lvl": "debug", "msg": "progress  90\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.946146", "lvl": "debug", "msg": "progress  95\u202F% (12\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.950279", "lvl": "debug", "msg": "progress 100\u202F% (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:36.957607", "lvl": "info", "msg": "13\u202FMB downloaded in 0.06\u202Fs (209.94\u202FMB/s)"}
- {"dt": "2024-11-14T10:37:36.957780", "lvl": "debug", "msg": "end: 1.1.3.9.1.1 file-download (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.957858", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "file-download", "level": "1.1.3.9.1.1", "duration": "0.06", "result": "pass", "extra": {"label": "url_repo", "size": ! "13692979", "md5sum": "30eb6f40044a706e0edae9b32f16a662", "sha256sum": "c850bed1a93201581f64754245d951f99a4942fe707b841bfe6ea3c9cd7624b0", "sha512sum": "3435daea585c61fec8b4c72eeb412c9d550e229d1220195bd592f268fe6baad5d210433f9802e5f9931fb5b8b17a10a4c5c569f16a3c286247222b96634c6310"}}}
- {"dt": "2024-11-14T10:37:36.958023", "lvl": "debug", "msg": "end: 1.1.3.9.1 download-retry (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:36.958094", "lvl": "debug", "msg": "Using /lava-1 at stage 2"}
- {"dt": "2024-11-14T10:37:36.958191", "lvl": "debug", "msg": "Runner path : /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/2/tests/2_ltp-smoke"}
- {"dt": "2024-11-14T10:37:36.958290", "lvl": "info", "msg": "Untar tests from file /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/url-repo-action-mo40wr_v/url_repo/https___storage.tuxboot.com_test-definitions_2024.07.tar to directory /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/2/tests/2_ltp-smoke"}
- {"dt": "2024-11-14T10:37:37.155252", "lvl": "debug", "msg": "Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/2/tests/2_ltp-smoke/automated/linux/ltp/ltp.yaml"}
- {"dt": "2024-11-14T10:37:37.155617", "lvl": "debug", "msg": "uuid=1_1.1.3.9 testdef=None"}
- {"dt": "2024-11-14T10:37:37.155713", "lvl": "debug", "msg": "end: 1.1.3.9 url-repo-action (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:37.155782", "lvl": "debug", "msg": "start: 1.1.3.10 test-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:37.156369", "lvl": "debug", "msg": "end: 1.1.3.10 test-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:37.156424", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-overlay", "level": "1.1.3.10", "duration": "0.00", "result": "pass", "extra": {"uuid": "1_1.1.3.9", "name": "ltp-smoke", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst"}}}
- {"dt": "2024-11-14T10:37:37.156530", "lvl": "debug", "msg": "start: 1.1.3.11 test-install-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:37.157353", "lvl": "debug", "msg": "end: 1.1.3.11 test-install-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:37.157410", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-install-overlay", "level": "1.1.3.11", "duration": "0.00", "result": "pass", "extra": {"uuid": "1_1.1.3.9", "name": "ltp-smoke", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst", "skipped test-install-overlay": "1_1.1.3.9"}}}
- {"dt": "2024-11-14T10:37:37.157520", "lvl": "debug", "msg": "start: 1.1.3.12 test-runscript-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:37.165689", "lvl": "debug", "msg": "runner path: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/2/tests/2_ltp-smoke test_uuid 1_1.1.3.9"}
- {"dt": "2024-11-14T10:37:37.165765", "lvl": "debug", "msg": "SKIP_INSTALL='true'"}
- {"dt": "2024-11-14T10:37:37.165821", "lvl": "debug", "msg": "TST_CMDFILES='smoketest'"}
- {"dt": "2024-11-14T10:37:37.165871", "lvl": "debug", "msg": "SKIPFILE='/tuxtest/skipfiles/sparc64/ltp-smoke'"}
- {"dt": "2024-11-14T10:37:37.165919", "lvl": "debug", "msg": "ENVIRONMENT='production'"}
- {"dt": "2024-11-14T10:37:37.165955", "lvl": "debug", "msg": "LTP_TMPDIR='/scratch'"}
- {"dt": "2024-11-14T10:37:37.165990", "lvl": "debug", "msg": "LTP_INSTALL_PATH='/opt/ltp/'"}
- {"dt": "2024-11-14T10:37:37.166025", "lvl": "debug", "msg": "SHARD_NUMBER='1'"}
- {"dt": "2024-11-14T10:37:37.166058", "lvl": "debug", "msg": "SHARD_INDEX='1'"}
- {"dt": "2024-11-14T10:37:37.166091", "lvl": "debug", "msg": "TIMEOUT_MULTIPLIER='5'"}
- {"dt": "2024-11-14T10:37:37.166213", "lvl": "debug", "msg": "end: 1.1.3.12 test-runscript-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:37.166264", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "test-runscript-overlay", "level": "1.1.3.12", "duration": "0.01", "result": "pass", "extra": {"uuid": "1_1.1.3.9", "name": "ltp-smoke", "path": "automated/linux/ltp/ltp.yaml", "from": "url", "repository": "file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_test-definitions_2024.07.tar.zst", "filename": "/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/2/tests/2_ltp-smoke/run.sh"}}}
- {"dt": "2024-11-14T10:37:37.166355", "lvl": "info", "msg": "Creating lava-test-runner.conf files"}
- {"dt": "2024-11-14T10:37:37.166393", "lvl": "debug", "msg": "Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/0 for stage 0"}
- {"dt": "2024-11-14T10:37:37.166468", "lvl": "debug", "msg": "- 0_ltp-fcntl-locktests"}
- {"dt": "2024-11-14T10:37:37.166532", "lvl": "debug", "msg": "Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/1 for stage 1"}
- {"dt": "2024-11-14T10:37:37.166611", "lvl": "debug", "msg": "- 1_ltp-fs_perms_simple"}
- {"dt": "2024-11-14T10:37:37.166668", "lvl": "debug", "msg": "Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/lava-overlay-b6bjq8xp/lava-1/2 for stage 2"}
- {"dt": "2024-11-14T10:37:37.166742", "lvl": "debug", "msg": "- 2_ltp-smoke"}
- {"dt": "2024-11-14T10:37:37.166815", "lvl": "debug", "msg": "end: 1.1.3 test-definition (duration 00:00:01) [common]"}
- {"dt": "2024-11-14T10:37:37.166874", "lvl": "debug", "msg": "start: 1.1.4 compress-overlay (timeout 00:04:59) [common]"}
- {"dt": "2024-11-14T10:37:54.632282", "lvl": "debug", "msg": "end: 1.1.4 compress-overlay (duration 00:00:17) [common]"}
- {"dt": "2024-11-14T10:37:54.632413", "lvl": "debug", "msg": "start: 1.1.5 persistent-nfs-overlay (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.632472", "lvl": "debug", "msg": "end: 1.1.5 persistent-nfs-overlay (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:54.632531", "lvl": "debug", "msg": "end: 1.1 lava-overlay (duration 00:00:18) [common]"}
- {"dt": "2024-11-14T10:37:54.632586", "lvl": "debug", "msg": "start: 1.2 apply-overlay-guest (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.632632", "lvl": "debug", "msg": "Overlay already applied"}
- {"dt": "2024-11-14T10:37:54.632682", "lvl": "debug", "msg": "end: 1.2 apply-overlay-guest (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:54.632733", "lvl": "debug", "msg": "start: 1.3 deploy-device-env (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.632782", "lvl": "debug", "msg": "end: 1.3 deploy-device-env (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:54.632834", "lvl": "debug", "msg": "start: 1.4 download-retry (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.632885", "lvl": "debug", "msg": "start: 1.4.1 file-download (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.633056", "lvl": "info", "msg": "downloading file:///home/anders/.cache/tuxsuite/plan/144/build_1/vmlinux"}
- {"dt": "2024-11-14T10:37:54.633109", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/kernel/vmlinux"}
- {"dt": "2024-11-14T10:37:54.633153", "lvl": "debug", "msg": "total size: 22357496 (21\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.633196", "lvl": "debug", "msg": "No compression specified"}
- {"dt": "2024-11-14T10:37:54.633294", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.636608", "lvl": "debug", "msg": "progress   5\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.640008", "lvl": "debug", "msg": "progress  10\u202F% (2\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.643303", "lvl": "debug", "msg": "progress  15\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.646540", "lvl": "debug", "msg": "progress  20\u202F% (4\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.649776", "lvl": "debug", "msg": "progress  25\u202F% (5\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.653033", "lvl": "debug", "msg": "progress  30\u202F% (6\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.656326", "lvl": "debug", "msg": "progress  35\u202F% (7\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.659598", "lvl": "debug", "msg": "progress  40\u202F% (8\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.663089", "lvl": "debug", "msg": "progress  45\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.666327", "lvl": "debug", "msg": "progress  50\u202F% (10\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.669574", "lvl": "debug", "msg": "progress  55\u202F% (11\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.672817", "lvl": "debug", "msg": "progress  60\u202F% (12\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.676144", "lvl": "debug", "msg": "progress  65\u202F% (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.679437", "lvl": "debug", "msg": "progress  70\u202F% (14\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.682697", "lvl": "debug", "msg": "progress  75\u202F% (16\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.686127", "lvl": "debug", "msg": "progress  80\u202F% (17\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.689399", "lvl": "debug", "msg": "progress  85\u202F% (18\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.692748", "lvl": "debug", "msg": "progress  90\u202F% (19\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.695986", "lvl": "debug", "msg": "progress  95\u202F% (20\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.699256", "lvl": "debug", "msg": "progress 100\u202F% (21\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.699343", "lvl": "info", "msg": "21\u202FMB downloaded in 0.07\u202Fs (322.15\u202FMB/s)"}
- {"dt": "2024-11-14T10:37:54.699445", "lvl": "debug", "msg": "end: 1.4.1 file-download (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:54.699498", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "file-download", "level": "1.4.1", "duration": "0.07", "result": "pass", "extra": {"label": "kernel", "size": ! "22357496", "md5sum": "a24ab13a3a743eb9327b9e70f6495102", "sha256sum": "bd0e97259d7a45b327718035195c5bccce5450afdc9393ec54414fb7d7f9f956", "sha512sum": "826417bf99d5d5d4062c2248a0d99e380d0b993e98704815a404a2d691f4bf67676ce23fe4521dea1aa86f9103a6e48a1ca222b232fd837d1c18f9c6e8b8559d"}}}
- {"dt": "2024-11-14T10:37:54.699607", "lvl": "debug", "msg": "end: 1.4 download-retry (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:54.699664", "lvl": "debug", "msg": "start: 1.5 download-retry (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.699718", "lvl": "debug", "msg": "start: 1.5.1 file-download (timeout 00:04:42) [common]"}
- {"dt": "2024-11-14T10:37:54.699875", "lvl": "info", "msg": "downloading file:///home/anders/.cache/tuxrun/assets/https___storage.tuxboot.com_buildroot_sparc64_rootfs.ext4.zst"}
- {"dt": "2024-11-14T10:37:54.699926", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/rootfs/https___storage.tuxboot.com_buildroot_sparc64_rootfs.ext4"}
- {"dt": "2024-11-14T10:37:54.699967", "lvl": "debug", "msg": "total size: 68595582 (65\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.700007", "lvl": "info", "msg": "Using unzstd to decompress zstd"}
- {"dt": "2024-11-14T10:37:54.700404", "lvl": "debug", "msg": "progress   0\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.719427", "lvl": "debug", "msg": "progress   5\u202F% (3\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.734307", "lvl": "debug", "msg": "progress  10\u202F% (6\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.751574", "lvl": "debug", "msg": "progress  15\u202F% (9\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.774452", "lvl": "debug", "msg": "progress  20\u202F% (13\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.792788", "lvl": "debug", "msg": "progress  25\u202F% (16\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.811032", "lvl": "debug", "msg": "progress  30\u202F% (19\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.828992", "lvl": "debug", "msg": "progress  35\u202F% (22\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.846858", "lvl": "debug", "msg": "progress  40\u202F% (26\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.868613", "lvl": "debug", "msg": "progress  45\u202F% (29\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.887069", "lvl": "debug", "msg": "progress  50\u202F% (32\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.904671", "lvl": "debug", "msg": "progress  55\u202F% (36\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.924474", "lvl": "debug", "msg": "progress  60\u202F% (39\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.949313", "lvl": "debug", "msg": "progress  65\u202F% (42\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.961854", "lvl": "debug", "msg": "progress  70\u202F% (45\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.974101", "lvl": "debug", "msg": "progress  75\u202F% (49\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.986180", "lvl": "debug", "msg": "progress  80\u202F% (52\u202FMB)"}
- {"dt": "2024-11-14T10:37:54.998985", "lvl": "debug", "msg": "progress  85\u202F% (55\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.010929", "lvl": "debug", "msg": "progress  90\u202F% (58\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.037121", "lvl": "debug", "msg": "progress  95\u202F% (62\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.049074", "lvl": "debug", "msg": "progress 100\u202F% (65\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.267663", "lvl": "info", "msg": "65\u202FMB downloaded in 0.57\u202Fs (115.24\u202FMB/s)"}
- {"dt": "2024-11-14T10:37:55.267931", "lvl": "debug", "msg": "end: 1.5.1 file-download (duration 00:00:01) [common]"}
- {"dt": "2024-11-14T10:37:55.268014", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "file-download", "level": "1.5.1", "duration": "0.57", "result": "pass", "extra": {"label": "rootfs", "size": ! "68595582", "md5sum": "cf40811cf0f406a8706ea50a050d2a56", "sha256sum": "afe2b939936418b05f95bea8005c8074ade19fa78bb83e195a1581c4e4beb3c4", "sha512sum": "52e472d03c362becf3e49a004445d2e87c2615978ec78a57659988e2c4a856abb655eb87b759cd473fe59790e35aeb4eefb1e2092e87cf2e24aa4f5fbc3d919b"}}}
- {"dt": "2024-11-14T10:37:55.268184", "lvl": "debug", "msg": "start: 1.5.2 download-retry (timeout 00:04:41) [common]"}
- {"dt": "2024-11-14T10:37:55.268246", "lvl": "debug", "msg": "start: 1.5.2.1 file-download (timeout 00:04:41) [common]"}
- {"dt": "2024-11-14T10:37:55.268434", "lvl": "info", "msg": "downloading file:///home/anders/.cache/tuxsuite/plan/144/build_1/modules.tar.xz"}
- {"dt": "2024-11-14T10:37:55.268486", "lvl": "debug", "msg": "saving as /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/rootfs.modules/modules.tar"}
- {"dt": "2024-11-14T10:37:55.268528", "lvl": "debug", "msg": "total size: 1262700 (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.268569", "lvl": "info", "msg": "Using unxz to decompress xz"}
- {"dt": "2024-11-14T10:37:55.268932", "lvl": "debug", "msg": "progress   2\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.269919", "lvl": "debug", "msg": "progress   7\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.270375", "lvl": "debug", "msg": "progress  12\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.270720", "lvl": "debug", "msg": "progress  18\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.271024", "lvl": "debug", "msg": "progress  23\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.271283", "lvl": "debug", "msg": "progress  28\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.271552", "lvl": "debug", "msg": "progress  33\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.271817", "lvl": "debug", "msg": "progress  38\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.272084", "lvl": "debug", "msg": "progress  44\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.272343", "lvl": "debug", "msg": "progress  49\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.272613", "lvl": "debug", "msg": "progress  54\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.272877", "lvl": "debug", "msg": "progress  59\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.273146", "lvl": "debug", "msg": "progress  64\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.273534", "lvl": "debug", "msg": "progress  70\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.273948", "lvl": "debug", "msg": "progress  75\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.274301", "lvl": "debug", "msg": "progress  80\u202F% (0\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.274600", "lvl": "debug", "msg": "progress  85\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.274884", "lvl": "debug", "msg": "progress  90\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.275178", "lvl": "debug", "msg": "progress  96\u202F% (1\u202FMB)"}
- {"dt": "2024-11-14T10:37:55.305924", "lvl": "info", "msg": "1\u202FMB downloaded in 0.04\u202Fs (32.21\u202FMB/s)"}
- {"dt": "2024-11-14T10:37:55.306143", "lvl": "debug", "msg": "end: 1.5.2.1 file-download (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:55.306224", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "file-download", "level": "1.5.2.1", "duration": "0.04", "result": "pass", "extra": {"label": "rootfs.modules", "size": ! "1262700", "md5sum": "bdd0c012c83aa0631fe5d9b4e52a4c3d", "sha256sum": "c7a04b2f5d5dc2d78b4409fdb8e66b769bea2eb3ee9f514580b635ee6495d2ca", "sha512sum": "544c1a5f540618bfc2de1921b4201f4c9c2f58b9da851b651f0622b1096c5fc7df6a47802d83f9226c380e32b83a23c01c10caee3f07127748b9bda67cb41269"}}}
- {"dt": "2024-11-14T10:37:55.306341", "lvl": "debug", "msg": "end: 1.5.2 download-retry (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:55.306402", "lvl": "debug", "msg": "start: 1.5.3 append-overlays (timeout 00:04:41) [common]"}
- {"dt": "2024-11-14T10:37:55.306451", "lvl": "info", "msg": "Modifying '/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/rootfs/https___storage.tuxboot.com_buildroot_sparc64_rootfs.ext4'"}
- {"dt": "2024-11-14T10:37:56.995283", "lvl": "debug", "msg": "Overlays:"}
- {"dt": "2024-11-14T10:37:56.996149", "lvl": "debug", "msg": "- rootfs.lava: '/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/compress-overlay-1fi31n24/overlay-1.1.4.tar.gz' to '/'"}
- {"dt": "2024-11-14T10:37:58.105118", "lvl": "debug", "msg": "- rootfs.modules: '/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/rootfs.modules/modules.tar' to '/'"}
- {"dt": "2024-11-14T10:37:58.393418", "lvl": "debug", "msg": "end: 1.5.3 append-overlays (duration 00:00:03) [common]"}
- {"dt": "2024-11-14T10:37:58.393868", "lvl": "debug", "msg": "end: 1.5 download-retry (duration 00:00:04) [common]"}
- {"dt": "2024-11-14T10:37:58.394028", "lvl": "info", "msg": "end: 1 deployimages (duration 00:00:22) [common]"}
- {"dt": "2024-11-14T10:37:58.394141", "lvl": "info", "msg": "start: 2 boot-image-retry (timeout 00:15:00) [common]"}
- {"dt": "2024-11-14T10:37:58.394219", "lvl": "debug", "msg": "start: 2.1 boot-qemu-image (timeout 00:15:00) [common]"}
- {"dt": "2024-11-14T10:37:58.394280", "lvl": "debug", "msg": "start: 2.1.1 execute-qemu (timeout 00:15:00) [common]"}
- {"dt": "2024-11-14T10:37:58.394626", "lvl": "info", "msg": "Boot command: /usr/bin/qemu-system-sparc64 -machine sun4u -nographic -nic none -m 4G -monitor none -no-reboot  -kernel /var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/kernel/vmlinux -append \"console=ttyS0,115200 rootwait root=/dev/sda debug verbose console_msg_format=syslog systemd.log_level=warning earlycon\" -drive file=/var/lib/lava/dispatcher/tmp/tuxrun-to28zr5c-1/deployimages-ce_e93b9/rootfs/https___storage.tuxboot.com_buildroot_sparc64_rootfs.ext4,if=ide,format=raw"}
- {"dt": "2024-11-14T10:37:58.398483", "lvl": "debug", "msg": "started a shell command"}
- {"dt": "2024-11-14T10:37:58.398874", "lvl": "debug", "msg": "end: 2.1.1 execute-qemu (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:58.398964", "lvl": "results", "msg": {"definition": "lava", "namespace": "common", "case": "execute-qemu", "level": "2.1.1", "duration": "0.00", "result": "pass", "extra": {"qemu_version": "8.2.4", "host_arch": "x86_64", "job_arch": "sparc64"}}}
- {"dt": "2024-11-14T10:37:58.399126", "lvl": "debug", "msg": "end: 2.1 boot-qemu-image (duration 00:00:00) [common]"}
- {"dt": "2024-11-14T10:37:58.399211", "lvl": "debug", "msg": "start: 2.2 auto-login-action (timeout 00:15:00) [common]"}
- {"dt": "2024-11-14T10:37:58.399280", "lvl": "debug", "msg": "Setting prompt string to ['Linux version [0-9]']"}
- {"dt": "2024-11-14T10:37:58.399333", "lvl": "debug", "msg": "auto-login-action: Wait for prompt ['Linux version [0-9]'] (timeout 00:15:00)"}
- {"dt": "2024-11-14T10:37:58.434708", "lvl": "target", "msg": "OpenBIOS for Sparc64"}
- {"dt": "2024-11-14T10:37:59.402615", "lvl": "target", "msg": "Configuration device id QEMU version 1 machine id 0"}
- {"dt": "2024-11-14T10:37:59.402786", "lvl": "target", "msg": "kernel phys 404000 virt 40004000 size 0x13d3a88"}
- {"dt": "2024-11-14T10:37:59.403139", "lvl": "target", "msg": "kernel cmdline console=ttyS0,115200 rootwait root=/dev/sda debug verbose console_msg_format=syslog systemd.log_level=warning earlycon"}
- {"dt": "2024-11-14T10:37:59.421237", "lvl": "target", "msg": "CPUs: 1 x SUNW,UltraSPARC-IIi"}
- {"dt": "2024-11-14T10:37:59.421364", "lvl": "target", "msg": "UUID: 00000000-0000-0000-0000-000000000000"}
- {"dt": "2024-11-14T10:37:59.540547", "lvl": "target", "msg": "Welcome to OpenBIOS v1.1 built on May 20 2024 13:14"}
- {"dt": "2024-11-14T10:37:59.542684", "lvl": "target", "msg": "  Type 'help' for detailed information"}
- {"dt": "2024-11-14T10:37:59.547762", "lvl": "target", "msg": "[sparc64] Kernel already loaded"}
- {"dt": "2024-11-14T10:37:59.558591", "lvl": "target", "msg": "\r"}
- {"dt": "2024-11-14T10:37:59.607154", "lvl": "target", "msg": "[    0.000523] PROMLIB: Sun IEEE Boot Prom 'OBP 3.10.24 1999/01/01 01:01'\r"}
- {"dt": "2024-11-14T10:37:59.607662", "lvl": "target", "msg": "[    0.001445] PROMLIB: Root node compatible: sun4u\r"}
- {"dt": "2024-11-14T10:37:59.608248", "lvl": "target", "msg": "[    0.002439] Linux version 6.12.0-rc7 (tuxmake@tuxmake) (sparc64-linux-gnu-gcc (Debian 13.3.0-5) 13.3.0, GNU ld (GNU Binutils for Debian) 2.43.1) #1 SMP @1731277175\r"}
- {"dt": "2024-11-14T10:37:59.608590", "lvl": "debug", "msg": "start: 2.2.1 login-action (timeout 00:14:59) [common]"}
- {"dt": "2024-11-14T10:37:59.608690", "lvl": "debug", "msg": "Setting prompt string to []"}
- {"dt": "2024-11-14T10:37:59.608774", "lvl": "debug", "msg": "Setting prompt string to ['-\\\\[ cut here \\\\]', 'Unhandled fault', 'BUG: KCSAN:', 'BUG: KASAN:', 'BUG: KFENCE:', 'Oops(?: -|:)', 'WARNING:', '(kernel BUG at|BUG:)', 'invalid opcode:', 'Kernel panic - not syncing']"}
- {"dt": "2024-11-14T10:37:59.608853", "lvl": "debug", "msg": "Using line separator: #'\\n'#"}
- {"dt": "2024-11-14T10:37:59.608911", "lvl": "info", "msg": "Waiting for the login prompt"}
- {"dt": "2024-11-14T10:37:59.608972", "lvl": "info", "msg": "Parsing kernel messages"}
- {"dt": "2024-11-14T10:37:59.609026", "lvl": "debug", "msg": ["-\\[ cut here \\]", "Unhandled fault", "BUG: KCSAN:", "BUG: KASAN:", "BUG: KFENCE:", "Oops(?: -|:)", "WARNING:", "(kernel BUG at|BUG:)", "invalid opcode:", "Kernel panic - not syncing", "root@(.*):[/~]#", "login:", "Login incorrect"]}
- {"dt": "2024-11-14T10:37:59.609135", "lvl": "debug", "msg": "[login-action] Waiting for messages, (timeout 00:14:59)"}
- {"dt": "2024-11-14T10:37:59.609217", "lvl": "debug", "msg": "Waiting using forced prompt support (timeout 00:07:29)"}
- {"dt": "2024-11-14T10:37:59.609706", "lvl": "target", "msg": "[    0.005437] printk: legacy bootconsole [earlyprom0] enabled\r"}
- {"dt": "2024-11-14T10:37:59.609770", "lvl": "target", "msg": "[    0.008693] ARCH: SUN4U\r"}
- {"dt": "2024-11-14T10:37:59.610899", "lvl": "target", "msg": "[    0.010150] Ethernet address: 52:54:00:12:34:56\r"}
- {"dt": "2024-11-14T10:37:59.613390", "lvl": "target", "msg": "[    0.012636] MM: PAGE_OFFSET is 0xfffff80000000000 (max_phys_bits == 40)\r"}
- {"dt": "2024-11-14T10:37:59.613772", "lvl": "target", "msg": "[    0.013221] MM: VMALLOC [0x0000000100000000 --> 0x0000060000000000]\r"}
- {"dt": "2024-11-14T10:37:59.614227", "lvl": "target", "msg": "[    0.013678] MM: VMEMMAP [0x0000060000000000 --> 0x00000c0000000000]\r"}
- {"dt": "2024-11-14T10:37:59.623421", "lvl": "target", "msg": "[    0.022808] Kernel: Using 5 locked TLB entries for main kernel image.\r"}
- {"dt": "2024-11-14T10:37:59.628183", "lvl": "target", "msg": "[    0.023310] Remapping the kernel... \r"}
- {"dt": "2024-11-14T10:37:59.628466", "lvl": "target", "msg": "[    0.027608] done.\r"}
- {"dt": "2024-11-14T10:38:00.128262", "lvl": "target", "msg": "[    0.527576] OF stdout device is: /pci@1fe,0/pci@1,1/ebus@1/su\r"}
- {"dt": "2024-11-14T10:38:00.128566", "lvl": "target", "msg": "[    0.528044] PROM: Built device tree with 58234 bytes of memory.\r"}
- {"dt": "2024-11-14T10:38:00.129964", "lvl": "target", "msg": "[    0.529393] Top of RAM: 0xffe80000, Total RAM: 0xffe80000\r"}
- {"dt": "2024-11-14T10:38:00.130271", "lvl": "target", "msg": "[    0.529825] Memory hole size: 0MB\r"}
- {"dt": "2024-11-14T10:38:00.131022", "lvl": "target", "msg": "[    0.530411] NODE_DATA(0) allocated [mem 0xffe626c0-0xffe63cbf]\r"}
- {"dt": "2024-11-14T10:38:00.134727", "lvl": "target", "msg": "[    0.534155] Allocated 16384 bytes for kernel page tables.\r"}
- {"dt": "2024-11-14T10:38:00.135668", "lvl": "target", "msg": "[    0.535085] Zone ranges:\r"}
- {"dt": "2024-11-14T10:38:00.136399", "lvl": "target", "msg": "[    0.535451]   Normal   [mem 0x0000000000000000-0x00000000ffe7ffff]\r"}
- {"dt": "2024-11-14T10:38:00.136818", "lvl": "target", "msg": "[    0.536283] Movable zone start for each node\r"}
- {"dt": "2024-11-14T10:38:00.137231", "lvl": "target", "msg": "[    0.536702] Early memory node ranges\r"}
- {"dt": "2024-11-14T10:38:00.137606", "lvl": "target", "msg": "[    0.537077]   node   0: [mem 0x0000000000000000-0x00000000ffe7ffff]\r"}
- {"dt": "2024-11-14T10:38:00.138352", "lvl": "target", "msg": "[    0.537805] Initmem setup node 0 [mem 0x0000000000000000-0x00000000ffe7ffff]\r"}
- {"dt": "2024-11-14T10:38:00.139344", "lvl": "target", "msg": "[    0.538806] Initmem setup node 1 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.139855", "lvl": "target", "msg": "[    0.539303] Initmem setup node 2 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.140323", "lvl": "target", "msg": "[    0.539775] Initmem setup node 3 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.140777", "lvl": "target", "msg": "[    0.540247] Initmem setup node 4 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.141269", "lvl": "target", "msg": "[    0.540715] Initmem setup node 5 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.141663", "lvl": "target", "msg": "[    0.541189] Initmem setup node 6 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.142215", "lvl": "target", "msg": "[    0.541656] Initmem setup node 7 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.142595", "lvl": "target", "msg": "[    0.542127] Initmem setup node 8 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.143132", "lvl": "target", "msg": "[    0.542597] Initmem setup node 9 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.143596", "lvl": "target", "msg": "[    0.543060] Initmem setup node 10 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.144076", "lvl": "target", "msg": "[    0.543537] Initmem setup node 11 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.144543", "lvl": "target", "msg": "[    0.544004] Initmem setup node 12 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.145015", "lvl": "target", "msg": "[    0.544467] Initmem setup node 13 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.145472", "lvl": "target", "msg": "[    0.544925] Initmem setup node 14 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.145932", "lvl": "target", "msg": "[    0.545394] Initmem setup node 15 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.146416", "lvl": "target", "msg": "[    0.545870] Initmem setup node 16 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.146874", "lvl": "target", "msg": "[    0.546336] Initmem setup node 17 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.147354", "lvl": "target", "msg": "[    0.546813] Initmem setup node 18 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.147834", "lvl": "target", "msg": "[    0.547285] Initmem setup node 19 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.148299", "lvl": "target", "msg": "[    0.547760] Initmem setup node 20 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.148776", "lvl": "target", "msg": "[    0.548233] Initmem setup node 21 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.149278", "lvl": "target", "msg": "[    0.548720] Initmem setup node 22 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.149680", "lvl": "target", "msg": "[    0.549212] Initmem setup node 23 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.150219", "lvl": "target", "msg": "[    0.549677] Initmem setup node 24 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.150677", "lvl": "target", "msg": "[    0.550138] Initmem setup node 25 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.151137", "lvl": "target", "msg": "[    0.550596] Initmem setup node 26 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.151604", "lvl": "target", "msg": "[    0.551056] Initmem setup node 27 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.152064", "lvl": "target", "msg": "[    0.551522] Initmem setup node 28 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.152561", "lvl": "target", "msg": "[    0.551993] Initmem setup node 29 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.152935", "lvl": "target", "msg": "[    0.552462] Initmem setup node 30 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.153499", "lvl": "target", "msg": "[    0.552936] Initmem setup node 31 as memoryless\r"}
- {"dt": "2024-11-14T10:38:00.168745", "lvl": "target", "msg": "[    0.568030] On node 0, zone Normal: 192 pages in unavailable ranges\r"}
- {"dt": "2024-11-14T10:38:00.169129", "lvl": "target", "msg": "[    0.568612] Booting Linux...\r"}
- {"dt": "2024-11-14T10:38:00.169801", "lvl": "target", "msg": "[    0.569074] CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]\r"}
- {"dt": "2024-11-14T10:38:00.170139", "lvl": "target", "msg": "[    0.569665] CPU CAPS: [vis]\r"}
- {"dt": "2024-11-14T10:38:00.173397", "lvl": "target", "msg": "[    0.572754] percpu: Embedded 18 pages/cpu s106584 r8192 d32680 u4194304\r"}
- {"dt": "2024-11-14T10:38:00.174613", "lvl": "target", "msg": "[    0.573980] pcpu-alloc: s106584 r8192 d32680 u4194304 alloc=1*4194304\r"}
- {"dt": "2024-11-14T10:38:00.175217", "lvl": "target", "msg": "[    0.574491] pcpu-alloc: [0] 0 \r"}
- {"dt": "2024-11-14T10:38:00.178031", "lvl": "target", "msg": "[    0.577331] Kernel command line: console=ttyS0,115200 rootwait root=/dev/sda debug verbose console_msg_format=syslog systemd.log_level=warning earlycon\r"}
- {"dt": "2024-11-14T10:38:00.179531", "lvl": "target", "msg": "<5>[    0.578920] Unknown kernel command line parameters \"verbose earlycon\", will be passed to user space.\r"}
- {"dt": "2024-11-14T10:38:00.181950", "lvl": "target", "msg": "<6>[    0.581342] Dentry cache hash table entries: 524288 (order: 9, 4194304 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.183060", "lvl": "target", "msg": "<6>[    0.582479] Inode-cache hash table entries: 262144 (order: 8, 2097152 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.183555", "lvl": "target", "msg": "<5>[    0.582995] Sorting __ex_table...\r"}
- {"dt": "2024-11-14T10:38:00.185724", "lvl": "target", "msg": "<6>[    0.584375] Fallback order for Node 0: 0 \r"}
- {"dt": "2024-11-14T10:38:00.186052", "lvl": "target", "msg": "<6>[    0.584634] Fallback order for Node 1: 0 \r"}
- {"dt": "2024-11-14T10:38:00.186372", "lvl": "target", "msg": "<6>[    0.584647] Fallback order for Node 2: 0 \r"}
- {"dt": "2024-11-14T10:38:00.186662", "lvl": "target", "msg": "<6>[    0.584656] Fallback order for Node 3: 0 \r"}
- {"dt": "2024-11-14T10:38:00.186963", "lvl": "target", "msg": "<6>[    0.584665] Fallback order for Node 4: 0 \r"}
- {"dt": "2024-11-14T10:38:00.187306", "lvl": "target", "msg": "<6>[    0.584674] Fallback order for Node 5: 0 \r"}
- {"dt": "2024-11-14T10:38:00.187650", "lvl": "target", "msg": "<6>[    0.584683] Fallback order for Node 6: 0 \r"}
- {"dt": "2024-11-14T10:38:00.187996", "lvl": "target", "msg": "<6>[    0.584691] Fallback order for Node 7: 0 \r"}
- {"dt": "2024-11-14T10:38:00.188341", "lvl": "target", "msg": "<6>[    0.584700] Fallback order for Node 8: 0 \r"}
- {"dt": "2024-11-14T10:38:00.188679", "lvl": "target", "msg": "<6>[    0.584709] Fallback order for Node 9: 0 \r"}
- {"dt": "2024-11-14T10:38:00.189023", "lvl": "target", "msg": "<6>[    0.584718] Fallback order for Node 10: 0 \r"}
- {"dt": "2024-11-14T10:38:00.189379", "lvl": "target", "msg": "<6>[    0.584729] Fallback order for Node 11: 0 \r"}
- {"dt": "2024-11-14T10:38:00.189721", "lvl": "target", "msg": "<6>[    0.584738] Fallback order for Node 12: 0 \r"}
- {"dt": "2024-11-14T10:38:00.190059", "lvl": "target", "msg": "<6>[    0.584748] Fallback order for Node 13: 0 \r"}
- {"dt": "2024-11-14T10:38:00.190403", "lvl": "target", "msg": "<6>[    0.584757] Fallback order for Node 14: 0 \r"}
- {"dt": "2024-11-14T10:38:00.190760", "lvl": "target", "msg": "<6>[    0.584767] Fallback order for Node 15: 0 \r"}
- {"dt": "2024-11-14T10:38:00.191102", "lvl": "target", "msg": "<6>[    0.584776] Fallback order for Node 16: 0 \r"}
- {"dt": "2024-11-14T10:38:00.191443", "lvl": "target", "msg": "<6>[    0.584785] Fallback order for Node 17: 0 \r"}
- {"dt": "2024-11-14T10:38:00.191965", "lvl": "target", "msg": "<6>[    0.584795] Fallback order for Node 18: 0 \r"}
- {"dt": "2024-11-14T10:38:00.192165", "lvl": "target", "msg": "<6>[    0.584805] Fallback order for Node 19: 0 \r"}
- {"dt": "2024-11-14T10:38:00.192521", "lvl": "target", "msg": "<6>[    0.584814] Fallback order for Node 20: 0 \r"}
- {"dt": "2024-11-14T10:38:00.192876", "lvl": "target", "msg": "<6>[    0.584823] Fallback order for Node 21: 0 \r"}
- {"dt": "2024-11-14T10:38:00.193232", "lvl": "target", "msg": "<6>[    0.584833] Fallback order for Node 22: 0 \r"}
- {"dt": "2024-11-14T10:38:00.193573", "lvl": "target", "msg": "<6>[    0.584842] Fallback order for Node 23: 0 \r"}
- {"dt": "2024-11-14T10:38:00.193918", "lvl": "target", "msg": "<6>[    0.584851] Fallback order for Node 24: 0 \r"}
- {"dt": "2024-11-14T10:38:00.194261", "lvl": "target", "msg": "<6>[    0.584861] Fallback order for Node 25: 0 \r"}
- {"dt": "2024-11-14T10:38:00.194601", "lvl": "target", "msg": "<6>[    0.584870] Fallback order for Node 26: 0 \r"}
- {"dt": "2024-11-14T10:38:00.194954", "lvl": "target", "msg": "<6>[    0.584880] Fallback order for Node 27: 0 \r"}
- {"dt": "2024-11-14T10:38:00.195295", "lvl": "target", "msg": "<6>[    0.584890] Fallback order for Node 28: 0 \r"}
- {"dt": "2024-11-14T10:38:00.195636", "lvl": "target", "msg": "<6>[    0.584899] Fallback order for Node 29: 0 \r"}
- {"dt": "2024-11-14T10:38:00.195982", "lvl": "target", "msg": "<6>[    0.584908] Fallback order for Node 30: 0 \r"}
- {"dt": "2024-11-14T10:38:00.196326", "lvl": "target", "msg": "<6>[    0.584918] Fallback order for Node 31: 0 \r"}
- {"dt": "2024-11-14T10:38:00.196740", "lvl": "target", "msg": "<6>[    0.585116] Built 1 zonelists, mobility grouping on.  Total pages: 524096\r"}
- {"dt": "2024-11-14T10:38:00.197234", "lvl": "target", "msg": "<6>[    0.596664] Policy zone: Normal\r"}
- {"dt": "2024-11-14T10:38:00.197794", "lvl": "target", "msg": "<6>[    0.597226] mem auto-init: stack:all(zero), heap alloc:off, heap free:off\r"}
- {"dt": "2024-11-14T10:38:00.209368", "lvl": "target", "msg": "<6>[    0.608756] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=32\r"}
- {"dt": "2024-11-14T10:38:00.213033", "lvl": "target", "msg": "<6>[    0.612404] trace event string verifier disabled\r"}
- {"dt": "2024-11-14T10:38:00.218912", "lvl": "target", "msg": "<6>[    0.618298] rcu: Hierarchical RCU implementation.\r"}
- {"dt": "2024-11-14T10:38:00.219244", "lvl": "target", "msg": "<6>[    0.618715] rcu: \tRCU event tracing is enabled.\r"}
- {"dt": "2024-11-14T10:38:00.219677", "lvl": "target", "msg": "<6>[    0.619139] rcu: \tRCU restricting CPUs from NR_CPUS=4096 to nr_cpu_ids=1.\r"}
- {"dt": "2024-11-14T10:38:00.220407", "lvl": "target", "msg": "<6>[    0.619816] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.\r"}
- {"dt": "2024-11-14T10:38:00.220843", "lvl": "target", "msg": "<6>[    0.620310] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1\r"}
- {"dt": "2024-11-14T10:38:00.226898", "lvl": "target", "msg": "<6>[    0.626288] NR_IRQS: 2048, nr_irqs: 2048, preallocated irqs: 1\r"}
- {"dt": "2024-11-14T10:38:00.228201", "lvl": "target", "msg": "<6>[    0.627620] rcu: srcu_init: Setting srcu_struct sizes based on contention.\r"}
- {"dt": "2024-11-14T10:38:00.229728", "lvl": "target", "msg": "<6>[    0.628945] clocksource: tick: mask: 0xffffffffffffffff max_cycles: 0x171024e7e0, max_idle_ns: 440795205315 ns\r"}
- {"dt": "2024-11-14T10:38:00.230381", "lvl": "target", "msg": "<4>[    0.629727] clocksource: mult[a000000] shift[24]\r"}
- {"dt": "2024-11-14T10:38:00.230703", "lvl": "target", "msg": "<4>[    0.630206] clockevent: mult[1999999a] shift[32]\r"}
- {"dt": "2024-11-14T10:38:00.234354", "lvl": "target", "msg": "<6>[    0.633683] Console: colour dummy device 80x25\r"}
- {"dt": "2024-11-14T10:38:00.384202", "lvl": "target", "msg": "<6>[    0.783452] Calibrating delay using timer specific routine.. 201.38 BogoMIPS (lpj=1006938)\r"}
- {"dt": "2024-11-14T10:38:00.384628", "lvl": "target", "msg": "<6>[    0.784129] pid_max: default: 32768 minimum: 301\r"}
- {"dt": "2024-11-14T10:38:00.387166", "lvl": "target", "msg": "<6>[    0.786537] Mount-cache hash table entries: 8192 (order: 3, 65536 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.387633", "lvl": "target", "msg": "<6>[    0.787049] Mountpoint-cache hash table entries: 8192 (order: 3, 65536 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.431372", "lvl": "target", "msg": "<6>[    0.827962] rcu: Hierarchical SRCU implementation.\r"}
- {"dt": "2024-11-14T10:38:00.432368", "lvl": "target", "msg": "<6>[    0.831730] rcu: \tMax phase no-delay instances is 1000.\r"}
- {"dt": "2024-11-14T10:38:00.436165", "lvl": "target", "msg": "<6>[    0.835552] smp: Bringing up secondary CPUs ...\r"}
- {"dt": "2024-11-14T10:38:00.437141", "lvl": "target", "msg": "<6>[    0.836501] smp: Brought up 1 node, 1 CPU\r"}
- {"dt": "2024-11-14T10:38:00.444934", "lvl": "target", "msg": "<6>[    0.844058] Memory: 4130280K/4192768K available (7752K kernel code, 7964K rwdata, 2064K rodata, 464K init, 2006K bss, 59864K reserved, 0K cma-reserved)\r"}
- {"dt": "2024-11-14T10:38:00.456977", "lvl": "target", "msg": "<6>[    0.856385] devtmpfs: initialized\r"}
- {"dt": "2024-11-14T10:38:00.466127", "lvl": "target", "msg": "<6>[    0.865099] Performance events: No support for PMU type 'ultra12'\r"}
- {"dt": "2024-11-14T10:38:00.468076", "lvl": "target", "msg": "<6>[    0.867298] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns\r"}
- {"dt": "2024-11-14T10:38:00.468859", "lvl": "target", "msg": "<6>[    0.868260] futex hash table entries: 256 (order: 1, 16384 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.476024", "lvl": "target", "msg": "<6>[    0.875405] NET: Registered PF_NETLINK/PF_ROUTE protocol family\r"}
- {"dt": "2024-11-14T10:38:00.493921", "lvl": "target", "msg": "<4>[    0.893047] pci@1f,0: PCI IO [io  0x1fe02000000-0x1fe02ffffff] offset 1fe02000000\r"}
- {"dt": "2024-11-14T10:38:00.494443", "lvl": "target", "msg": "<4>[    0.893795] pci@1f,0: PCI MEM [mem 0x1ff00000000-0x1ffefffffff] offset 1ff00000000\r"}
- {"dt": "2024-11-14T10:38:00.495105", "lvl": "target", "msg": "<6>[    0.894476] pci@1f,0: SABRE PCI Bus Module ver[0:0]\r"}
- {"dt": "2024-11-14T10:38:00.495457", "lvl": "target", "msg": "<4>[    0.894935] PCI: Scanning PBM /pci@1f,0\r"}
- {"dt": "2024-11-14T10:38:00.498986", "lvl": "target", "msg": "<6>[    0.898314] sabre ffe2e480: PCI host bridge to bus 0000:00\r"}
- {"dt": "2024-11-14T10:38:00.499477", "lvl": "target", "msg": "<4>[    0.898904] pci_bus 0000:00: Unknown NUMA node; performance will be reduced\r"}
- {"dt": "2024-11-14T10:38:00.500274", "lvl": "target", "msg": "<6>[    0.899604] pci_bus 0000:00: root bus resource [io  0x1fe02000000-0x1fe02ffffff] (bus address [0x0000-0xffffff])\r"}
- {"dt": "2024-11-14T10:38:00.500883", "lvl": "target", "msg": "<6>[    0.900217] pci_bus 0000:00: root bus resource [mem 0x1ff00000000-0x1ffefffffff] (bus address [0x00000000-0xefffffff])\r"}
- {"dt": "2024-11-14T10:38:00.501544", "lvl": "target", "msg": "<6>[    0.900904] pci_bus 0000:00: root bus resource [bus 00-02]\r"}
- {"dt": "2024-11-14T10:38:00.502749", "lvl": "target", "msg": "<6>[    0.902165] pci 0000:00:01.1: [108e:5000] type 01 class 0x060400\r"}
- {"dt": "2024-11-14T10:38:00.505391", "lvl": "target", "msg": "<6>[    0.904775] pci_bus 0000:01: extended config space not accessible\r"}
- {"dt": "2024-11-14T10:38:00.506540", "lvl": "target", "msg": "<6>[    0.905966] pci 0000:01:01.0: [108e:1000] type 00 class 0x068000\r"}
- {"dt": "2024-11-14T10:38:00.507047", "lvl": "target", "msg": "<6>[    0.906466] pci 0000:01:01.0: reg 0x10: [mem 0x1ff20000000-0x1ff20ffffff]\r"}
- {"dt": "2024-11-14T10:38:00.507540", "lvl": "target", "msg": "<6>[    0.906974] pci 0000:01:01.0: reg 0x14: [io  0x1fe02000000-0x1fe02007fff]\r"}
- {"dt": "2024-11-14T10:38:00.508808", "lvl": "target", "msg": "<6>[    0.908222] pci 0000:01:02.0: [1234:1111] type 00 class 0x030000\r"}
- {"dt": "2024-11-14T10:38:00.509274", "lvl": "target", "msg": "<6>[    0.908658] pci 0000:01:02.0: reg 0x10: [mem 0x1ff21000000-0x1ff21ffffff pref]\r"}
- {"dt": "2024-11-14T10:38:00.509728", "lvl": "target", "msg": "<6>[    0.909164] pci 0000:01:02.0: reg 0x18: [mem 0x1ff22000000-0x1ff22000fff]\r"}
- {"dt": "2024-11-14T10:38:00.510647", "lvl": "target", "msg": "<6>[    0.910060] pci 0000:01:03.0: [1095:0646] type 00 class 0x01018f\r"}
- {"dt": "2024-11-14T10:38:00.511056", "lvl": "target", "msg": "<6>[    0.910494] pci 0000:01:03.0: reg 0x10: [io  0x1fe02008000-0x1fe02008007]\r"}
- {"dt": "2024-11-14T10:38:00.511495", "lvl": "target", "msg": "<6>[    0.910954] pci 0000:01:03.0: reg 0x14: [io  0x1fe02008080-0x1fe02008083]\r"}
- {"dt": "2024-11-14T10:38:00.511920", "lvl": "target", "msg": "<6>[    0.911388] pci 0000:01:03.0: reg 0x18: [io  0x1fe02008100-0x1fe02008107]\r"}
- {"dt": "2024-11-14T10:38:00.512334", "lvl": "target", "msg": "<6>[    0.911808] pci 0000:01:03.0: reg 0x1c: [io  0x1fe02008180-0x1fe02008183]\r"}
- {"dt": "2024-11-14T10:38:00.512783", "lvl": "target", "msg": "<6>[    0.912230] pci 0000:01:03.0: reg 0x20: [io  0x1fe02008200-0x1fe0200820f]\r"}
- {"dt": "2024-11-14T10:38:00.513522", "lvl": "target", "msg": "<6>[    0.912920] pci 0000:00:01.0: [108e:5000] type 01 class 0x060400\r"}
- {"dt": "2024-11-14T10:38:00.514533", "lvl": "target", "msg": "<6>[    0.913949] pci_bus 0000:02: extended config space not accessible\r"}
- {"dt": "2024-11-14T10:38:00.515699", "lvl": "target", "msg": "<6>[    0.915065] pci 0000:01:02.0: can't claim VGA legacy [mem 0x1ff000a0000-0x1ff000bffff]: no compatible bridge window\r"}
- {"dt": "2024-11-14T10:38:00.516402", "lvl": "target", "msg": "<3>[    0.915801] pci 0000:00:01.1: failed to populate child OF nodes (-19)\r"}
- {"dt": "2024-11-14T10:38:00.516808", "lvl": "target", "msg": "<3>[    0.916280] pci 0000:00:01.0: failed to populate child OF nodes (-19)\r"}
- {"dt": "2024-11-14T10:38:00.530397", "lvl": "target", "msg": "<6>[    0.929769] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages\r"}
- {"dt": "2024-11-14T10:38:00.530787", "lvl": "target", "msg": "<6>[    0.930262] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page\r"}
- {"dt": "2024-11-14T10:38:00.531255", "lvl": "target", "msg": "<6>[    0.930707] HugeTLB: registered 8.00 MiB page size, pre-allocated 0 pages\r"}
- {"dt": "2024-11-14T10:38:00.531666", "lvl": "target", "msg": "<6>[    0.931150] HugeTLB: 0 KiB vmemmap can be freed for a 8.00 MiB page\r"}
- {"dt": "2024-11-14T10:38:00.532143", "lvl": "target", "msg": "<6>[    0.931571] HugeTLB: registered 256 MiB page size, pre-allocated 0 pages\r"}
- {"dt": "2024-11-14T10:38:00.532492", "lvl": "target", "msg": "<6>[    0.931985] HugeTLB: 0 KiB vmemmap can be freed for a 256 MiB page\r"}
- {"dt": "2024-11-14T10:38:00.532915", "lvl": "target", "msg": "<6>[    0.932388] HugeTLB: registered 2.00 GiB page size, pre-allocated 0 pages\r"}
- {"dt": "2024-11-14T10:38:00.533323", "lvl": "target", "msg": "<6>[    0.932806] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 GiB page\r"}
- {"dt": "2024-11-14T10:38:00.550511", "lvl": "target", "msg": "<5>[    0.949892] SCSI subsystem initialized\r"}
- {"dt": "2024-11-14T10:38:00.551514", "lvl": "target", "msg": "<7>[    0.950921] libata version 3.00 loaded.\r"}
- {"dt": "2024-11-14T10:38:00.552351", "lvl": "target", "msg": "<6>[    0.951777] usbcore: registered new interface driver usbfs\r"}
- {"dt": "2024-11-14T10:38:00.552939", "lvl": "target", "msg": "<6>[    0.952372] usbcore: registered new interface driver hub\r"}
- {"dt": "2024-11-14T10:38:00.553476", "lvl": "target", "msg": "<6>[    0.952897] usbcore: registered new device driver usb\r"}
- {"dt": "2024-11-14T10:38:00.554171", "lvl": "target", "msg": "<6>[    0.953601] pps_core: LinuxPPS API ver. 1 registered\r"}
- {"dt": "2024-11-14T10:38:00.554628", "lvl": "target", "msg": "<6>[    0.954012] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>\r"}
- {"dt": "2024-11-14T10:38:00.555192", "lvl": "target", "msg": "<6>[    0.954589] PTP clock support registered\r"}
- {"dt": "2024-11-14T10:38:00.576809", "lvl": "target", "msg": "<6>[    0.976169] pci 0000:01:02.0: vgaarb: setting as boot VGA device\r"}
- {"dt": "2024-11-14T10:38:00.577215", "lvl": "target", "msg": "<6>[    0.976689] pci 0000:01:02.0: vgaarb: bridge control possible\r"}
- {"dt": "2024-11-14T10:38:00.577743", "lvl": "target", "msg": "<6>[    0.977157] pci 0000:01:02.0: vgaarb: VGA device added: decodes=io+mem,owns=none,locks=none\r"}
- {"dt": "2024-11-14T10:38:00.578097", "lvl": "target", "msg": "<6>[    0.977667] vgaarb: loaded\r"}
- {"dt": "2024-11-14T10:38:00.578916", "lvl": "target", "msg": "<6>[    0.978275] /pci@1f,0/pci@1,1/ebus@1/eeprom@14,2000: Mostek regs at 0x1fe02002000\r"}
- {"dt": "2024-11-14T10:38:00.591083", "lvl": "target", "msg": "<6>[    0.990451] clocksource: Switched to clocksource tick\r"}
- {"dt": "2024-11-14T10:38:00.613837", "lvl": "target", "msg": "<6>[    1.013201] NET: Registered PF_INET protocol family\r"}
- {"dt": "2024-11-14T10:38:00.615651", "lvl": "target", "msg": "<6>[    1.015053] IP idents hash table entries: 65536 (order: 6, 524288 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.622481", "lvl": "target", "msg": "<6>[    1.021848] tcp_listen_portaddr_hash hash table entries: 2048 (order: 2, 32768 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.623010", "lvl": "target", "msg": "<6>[    1.022422] Table-perturb hash table entries: 65536 (order: 5, 262144 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.623587", "lvl": "target", "msg": "<6>[    1.023021] TCP established hash table entries: 32768 (order: 5, 262144 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.624307", "lvl": "target", "msg": "<6>[    1.023724] TCP bind hash table entries: 32768 (order: 7, 1048576 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.625380", "lvl": "target", "msg": "<6>[    1.024794] TCP: Hash tables configured (established 32768 bind 32768)\r"}
- {"dt": "2024-11-14T10:38:00.626499", "lvl": "target", "msg": "<6>[    1.025899] UDP hash table entries: 2048 (order: 3, 65536 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.627149", "lvl": "target", "msg": "<6>[    1.026574] UDP-Lite hash table entries: 2048 (order: 3, 65536 bytes, linear)\r"}
- {"dt": "2024-11-14T10:38:00.628811", "lvl": "target", "msg": "<6>[    1.028234] NET: Registered PF_UNIX/PF_LOCAL protocol family\r"}
- {"dt": "2024-11-14T10:38:00.629610", "lvl": "target", "msg": "<6>[    1.029019] PCI: CLS 0 bytes, default 64\r"}
- {"dt": "2024-11-14T10:38:00.633396", "lvl": "target", "msg": "<6>[    1.032778] power: Control reg at 1fe02007240\r"}
- {"dt": "2024-11-14T10:38:00.637920", "lvl": "target", "msg": "<6>[    1.037289] workingset: timestamp_bits=57 max_order=19 bucket_order=0\r"}
- {"dt": "2024-11-14T10:38:00.717210", "lvl": "target", "msg": "<6>[    1.116593] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)\r"}
- {"dt": "2024-11-14T10:38:00.717752", "lvl": "target", "msg": "<6>[    1.117151] io scheduler mq-deadline registered\r"}
- {"dt": "2024-11-14T10:38:00.718057", "lvl": "target", "msg": "<6>[    1.117586] io scheduler kyber registered\r"}
- {"dt": "2024-11-14T10:38:00.722509", "lvl": "target", "msg": "<6>[    1.121837] ffe30b48: ttyS0 at MMIO 0x1fe020003f8 (irq = 5, base_baud = 115387) is a 16550A\r"}
- {"dt": "2024-11-14T10:38:00.723921", "lvl": "target", "msg": "<4>[    1.122697] Console: ttyS0 (SU)\r"}
- {"dt": "2024-11-14T10:38:00.724592", "lvl": "target", "msg": "<6>[    1.124046] printk: legacy console [ttyS0] enabled"}
- {"dt": "2024-11-14T10:38:00.725142", "lvl": "target", "msg": "<6>[    1.124046] printk: legacy console [ttyS0] enabled\r"}
- {"dt": "2024-11-14T10:38:00.725376", "lvl": "target", "msg": "<6>[    1.125008] printk: legacy bootconsole [earlyprom0] disabled"}
- {"dt": "2024-11-14T10:38:00.725767", "lvl": "target", "msg": "<6>[    1.125008] printk: legacy bootconsole [earlyprom0] disabled\r"}
- {"dt": "2024-11-14T10:38:00.734944", "lvl": "target", "msg": "<6>[    1.134560] scsi host0: pata_cmd64x"}
- {"dt": "2024-11-14T10:38:00.737225", "lvl": "target", "msg": "<6>[    1.136780] scsi host1: pata_cmd64x"}
- {"dt": "2024-11-14T10:38:00.737813", "lvl": "target", "msg": "<6>[    1.137270] ata1: PATA max UDMA/33 cmd 0x1fe02008000 ctl 0x1fe02008080 bmdma 0x1fe02008200 irq 7 lpm-pol 0"}
- {"dt": "2024-11-14T10:38:00.738391", "lvl": "target", "msg": "<6>[    1.137749] ata2: PATA max UDMA/33 cmd 0x1fe02008100 ctl 0x1fe02008180 bmdma 0x1fe02008208 irq 7 lpm-pol 0"}
- {"dt": "2024-11-14T10:38:00.747287", "lvl": "target", "msg": "<6>[    1.146896] rtc-m48t59 rtc-m48t59.0: registered as rtc0"}
- {"dt": "2024-11-14T10:38:00.748474", "lvl": "target", "msg": "<6>[    1.147721] rtc-m48t59 rtc-m48t59.0: setting system clock to 2024-11-14T10:38:00 UTC (1731580680)"}
- {"dt": "2024-11-14T10:38:00.750273", "lvl": "target", "msg": "<6>[    1.149911] usbcore: registered new interface driver usbhid"}
- {"dt": "2024-11-14T10:38:00.750534", "lvl": "target", "msg": "<6>[    1.150245] usbhid: USB HID core driver"}
- {"dt": "2024-11-14T10:38:00.751882", "lvl": "target", "msg": "<6>[    1.151529] NET: Registered PF_INET6 protocol family"}
- {"dt": "2024-11-14T10:38:00.757313", "lvl": "target", "msg": "<6>[    1.156878] Segment Routing with IPv6"}
- {"dt": "2024-11-14T10:38:00.757512", "lvl": "target", "msg": "<6>[    1.157215] In-situ OAM (IOAM) with IPv6"}
- {"dt": "2024-11-14T10:38:00.758271", "lvl": "target", "msg": "<6>[    1.157888] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver"}
- {"dt": "2024-11-14T10:38:00.760923", "lvl": "target", "msg": "<6>[    1.160542] NET: Registered PF_PACKET protocol family"}
- {"dt": "2024-11-14T10:38:00.776615", "lvl": "target", "msg": "<6>[    1.176255] Demotion targets for Node 0: null"}
- {"dt": "2024-11-14T10:38:00.901532", "lvl": "target", "msg": "<6>[    1.301075] ata1: found unknown device (class 0)"}
- {"dt": "2024-11-14T10:38:00.905785", "lvl": "target", "msg": "<6>[    1.305411] ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100"}
- {"dt": "2024-11-14T10:38:00.906101", "lvl": "target", "msg": "<6>[    1.305760] ata1.00: 2097152 sectors, multi 16: LBA48 "}
- {"dt": "2024-11-14T10:38:00.917080", "lvl": "target", "msg": "<5>[    1.316618] scsi 0:0:0:0: Direct-Access     ATA      QEMU HARDDISK    2.5+ PQ: 0 ANSI: 5"}
- {"dt": "2024-11-14T10:38:00.922326", "lvl": "target", "msg": "<5>[    1.321896] sd 0:0:0:0: [sda] 2097152 512-byte logical blocks: (1.07 GB/1.00 GiB)"}
- {"dt": "2024-11-14T10:38:00.923048", "lvl": "target", "msg": "<5>[    1.322698] sd 0:0:0:0: [sda] Write Protect is off"}
- {"dt": "2024-11-14T10:38:00.923290", "lvl": "target", "msg": "<7>[    1.322960] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00"}
- {"dt": "2024-11-14T10:38:00.923988", "lvl": "target", "msg": "<5>[    1.323512] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA"}
- {"dt": "2024-11-14T10:38:00.925252", "lvl": "target", "msg": "<6>[    1.324850] sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes"}
- {"dt": "2024-11-14T10:38:00.970135", "lvl": "target", "msg": "<5>[    1.369682] sd 0:0:0:0: [sda] Attached SCSI disk"}
- {"dt": "2024-11-14T10:38:01.080614", "lvl": "target", "msg": "<6>[    1.480134] ata2: found unknown device (class 0)"}
- {"dt": "2024-11-14T10:38:01.081462", "lvl": "target", "msg": "<6>[    1.481038] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100"}
- {"dt": "2024-11-14T10:38:01.084771", "lvl": "target", "msg": "<5>[    1.484223] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5"}
- {"dt": "2024-11-14T10:38:01.145195", "lvl": "target", "msg": "<6>[    1.544740] EXT4-fs (sda): orphan cleanup on readonly fs"}
- {"dt": "2024-11-14T10:38:01.146560", "lvl": "target", "msg": "<6>[    1.545776] EXT4-fs (sda): mounted filesystem 7f777666-19a6-42f6-84d8-8187a7b8cca6 ro with ordered data mode. Quota mode: disabled."}
- {"dt": "2024-11-14T10:38:01.147071", "lvl": "target", "msg": "<6>[    1.546531] VFS: Mounted root (ext4 filesystem) readonly on device 8:0."}
- {"dt": "2024-11-14T10:38:01.183285", "lvl": "target", "msg": "<4>[    1.582868] This architecture does not have kernel memory protection."}
- {"dt": "2024-11-14T10:38:01.184917", "lvl": "target", "msg": "<6>[    1.583449] Run /sbin/init as init process"}
- {"dt": "2024-11-14T10:38:01.184987", "lvl": "target", "msg": "<7>[    1.583647]   with arguments:"}
