[183.536973] Initializing watchdogs
[183.537315]   /dev/watchdog0
[183.578280] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[183.593189] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[183.600035] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[183.608532] [001/155] (960s left) gem_exec_flush (basic-wb-rw-default)
[183.771197] Starting subtest: basic-wb-rw-default
[189.189330] Subtest basic-wb-rw-default: SUCCESS (5.418s)
[189.490154] [002/155] (954s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[189.702155] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[190.885699] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.185s)
[191.197121] [003/155] (953s left) i915_drm_fdinfo (busy)
[191.310971] Starting subtest: busy
[191.315233] Starting dynamic subtest: rcs0
[191.846931] Dynamic subtest rcs0: SUCCESS (0.536s)
[191.876824] Starting dynamic subtest: bcs0
[192.388365] Dynamic subtest bcs0: SUCCESS (0.539s)
[192.417349] Starting dynamic subtest: vcs0
[192.919685] Dynamic subtest vcs0: SUCCESS (0.532s)
[192.947937] Starting dynamic subtest: vecs0
[193.448544] Dynamic subtest vecs0: SUCCESS (0.528s)
[193.454286] Subtest busy: SUCCESS (2.139s)
[193.592659] [004/155] (950s left) gem_tiled_wb
[239.094384] [005/155] (905s left) gem_workarounds (suspend-resume-context)
[239.237651] Starting subtest: suspend-resume-context
[255.761154] Subtest suspend-resume-context: SUCCESS (1.256s)
[264.947905] [006/155] (888s left) gem_exec_gttfill (all-engines)
[265.112938] Starting subtest: all-engines
[296.050229] Subtest all-engines: SUCCESS (30.688s)
[296.324900] [007/155] (857s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-render)
[296.709242] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-render
[296.715686] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[296.852528] [008/155] (856s left) gem_exec_balancer (smoke)
[297.015569] Starting subtest: smoke
[301.392559] Subtest smoke: SUCCESS (4.385s)
[301.681676] [009/155] (852s left) kms_rotation_crc (sprite-rotation-180)
[301.866795] Starting subtest: sprite-rotation-180
[313.111626] Subtest sprite-rotation-180: SUCCESS (11.242s)
[313.386943] [010/155] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[313.603846] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[316.145272] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SUCCESS (2.555s)
[316.406801] [011/155] (837s left) kms_legacy_colorkey (basic)
[316.596972] Starting subtest: basic
[316.600503] Starting dynamic subtest: pipe-A
[316.642646] Dynamic subtest pipe-A: SUCCESS (0.047s)
[316.668373] Starting dynamic subtest: pipe-B
[316.679978] Dynamic subtest pipe-B: SUCCESS (0.036s)
[316.716632] Starting dynamic subtest: pipe-C
[316.720092] Dynamic subtest pipe-C: SUCCESS (0.001s)
[316.723363] Subtest basic: SUCCESS (0.086s)
[316.821868] [012/155] (837s left) syncobj_timeline (multi-wait-signaled)
[316.938539] Starting subtest: multi-wait-signaled
[316.943211] Subtest multi-wait-signaled: SUCCESS (0.003s)
[317.086871] [013/155] (837s left) kms_addfb_basic (master-rmfb)
[317.200273] Starting subtest: master-rmfb
[317.203562] Subtest master-rmfb: SUCCESS (0.002s)
[317.440249] [014/155] (836s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[317.650200] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[319.695757] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.054s)
[319.920901] [015/155] (834s left) kms_psr (psr2-primary-page-flip)
[320.145613] Subtest psr2-primary-page-flip: SKIP (0.000s)
[320.249846] [016/155] (834s left) i915_query (query-topology-kernel-writes)
[320.363304] Starting subtest: query-topology-kernel-writes
[320.366927] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[320.501690] [017/155] (834s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[321.318876] Starting subtest: syncobj-timeline-invalid-wait
[321.328938] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.009s)
[321.613429] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[321.620042] [018/155] (833s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[321.833831] Starting subtest: cursor-rapid-movement-256x85
[321.904686] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.861747] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.964s)
[322.981025] Starting dynamic subtest: pipe-C-HDMI-A-1
[323.524402] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.596s)
[323.528007] Subtest cursor-rapid-movement-256x85: SUCCESS (1.692s)
[323.890764] [019/155] (831s left) prime_vgem (fence-flip-hang)
[324.039109] Subtest fence-flip-hang: SKIP (0.000s)
[324.199760] [020/155] (830s left) gem_vm_create (invalid-destroy)
[324.321847] Starting subtest: invalid-destroy
[324.325225] Subtest invalid-destroy: SUCCESS (0.001s)
[324.515657] [021/155] (830s left) gem_reg_read (bad-register)
[324.629794] Starting subtest: bad-register
[324.633396] Subtest bad-register: SUCCESS (0.000s)
[324.777599] [022/155] (830s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[324.976199] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[325.098578] [023/155] (830s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[325.305662] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[325.312179] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.467351] [024/155] (829s left) gem_exec_store (cachelines)
[325.595676] Starting subtest: cachelines
[325.600384] Starting dynamic subtest: rcs0
[325.631077] Dynamic subtest rcs0: SUCCESS (0.034s)
[325.663193] Starting dynamic subtest: bcs0
[325.666681] Dynamic subtest bcs0: SUCCESS (0.029s)
[325.695683] Starting dynamic subtest: vcs0
[325.700021] Dynamic subtest vcs0: SUCCESS (0.023s)
[325.726930] Starting dynamic subtest: vecs0
[325.731097] Dynamic subtest vecs0: SUCCESS (0.020s)
[325.735296] Subtest cachelines: SUCCESS (0.111s)
[325.967100] [025/155] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[326.174098] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[326.181097] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[326.331616] [026/155] (829s left) kms_fbcon_fbt (psr-suspend)
[326.447982] Starting subtest: psr-suspend
[326.456575] Subtest psr-suspend: SKIP (0.000s)
[326.660979] [027/155] (829s left) kms_plane_scaling (planes-upscale-factor-0-25)
[326.855099] Starting subtest: planes-upscale-factor-0-25
[326.858874] Starting dynamic subtest: pipe-A
[327.177916] Dynamic subtest pipe-A: SUCCESS (0.332s)
[327.210237] Starting dynamic subtest: pipe-B
[327.586588] Dynamic subtest pipe-B: SUCCESS (0.410s)
[327.644222] Starting dynamic subtest: pipe-C
[327.661556] Dynamic subtest pipe-C: SUCCESS (0.052s)
[327.665677] Subtest planes-upscale-factor-0-25: SUCCESS (0.797s)
[328.162572] [028/155] (827s left) syncobj_wait (wait-all-interrupted)
[328.282327] Starting subtest: wait-all-interrupted
[328.385808] Subtest wait-all-interrupted: SUCCESS (0.104s)
[328.569911] [029/155] (827s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[328.754989] Starting subtest: plane-ctm3x4-lut1d
[330.368472] Subtest plane-ctm3x4-lut1d: SKIP (1.599s)
[330.711613] [030/155] (825s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[330.924597] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[330.931561] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[331.081185] [031/155] (825s left) kms_busy (extended-pageflip-hang-newfb)
[331.279020] Starting subtest: extended-pageflip-hang-newfb
[331.283826] Starting dynamic subtest: pipe-A
[335.159394] Dynamic subtest pipe-A: SUCCESS (3.872s)
[335.197758] Starting dynamic subtest: pipe-C
[339.113305] Dynamic subtest pipe-C: SUCCESS (3.941s)
[339.117270] Subtest extended-pageflip-hang-newfb: SUCCESS (7.831s)
[339.482995] [032/155] (816s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[339.708317] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[339.714925] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[339.864348] [033/155] (816s left) kms_psr (pr-sprite-mmap-cpu)
[340.052216] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[340.174465] [034/155] (816s left) gem_userptr_blits (map-fixed-invalidate)
[340.320801] Starting subtest: map-fixed-invalidate
[340.323935] Starting dynamic subtest: gtt
[340.574898] Dynamic subtest gtt: SUCCESS (0.254s)
[340.603649] Starting dynamic subtest: wb
[340.736788] Dynamic subtest wb: SUCCESS (0.161s)
[340.765982] Starting dynamic subtest: wc
[340.898762] Dynamic subtest wc: SUCCESS (0.161s)
[340.928341] Starting dynamic subtest: uc
[341.064172] Dynamic subtest uc: SUCCESS (0.164s)
[341.067403] Subtest map-fixed-invalidate: SUCCESS (0.745s)
[341.244214] [035/155] (815s left) kms_psr (fbc-pr-suspend)
[341.431766] Subtest fbc-pr-suspend: SKIP (0.000s)
[341.557847] [036/155] (815s left) gem_exec_balancer (bonded-false-hang)
[341.812026] Starting subtest: bonded-false-hang
[346.012625] Subtest bonded-false-hang: SUCCESS (4.199s)
[346.182238] [037/155] (810s left) kms_hdmi_inject (inject-audio)
[346.739554] Starting subtest: inject-audio
[346.958131] Subtest inject-audio: SUCCESS (0.222s)
[347.452552] [038/155] (809s left) core_auth (getclient-simple)
[347.563734] Starting subtest: getclient-simple
[347.572377] Subtest getclient-simple: SUCCESS (0.007s)
[347.733609] [039/155] (809s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[347.939231] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[347.945772] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[348.099493] [040/155] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[348.319102] Starting subtest: fbcpsrhdr-tiling-4
[348.325638] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[348.482064] [041/155] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[348.705358] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[351.021180] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SUCCESS (2.266s)
[351.577168] [042/155] (806s left) kms_psr (fbc-psr-basic)
[352.011467] Subtest fbc-psr-basic: SKIP (0.000s)
[352.117045] [043/155] (805s left) gem_tiled_pread_basic (basic)
[352.227947] Starting subtest: basic
[352.548299] Subtest basic: SUCCESS (0.326s)
[352.715066] [044/155] (805s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[352.922096] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[353.152503] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.227s)
[353.449620] [045/155] (804s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[353.658798] Starting subtest: fbc-rgb101010-draw-blt
[354.561991] Subtest fbc-rgb101010-draw-blt: SUCCESS (0.907s)
[354.849243] [046/155] (803s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt)
[355.058812] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt
[355.065988] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[355.220178] [047/155] (803s left) gem_ctx_sseu (invalid-args)
[355.346777] Subtest invalid-args: SKIP (0.000s)
[355.472255] [048/155] (802s left) gem_lmem_swapping (random)
[355.592540] Subtest random: SKIP (0.000s)
[355.710125] [049/155] (802s left) gem_exec_params (sol-reset-invalid)
[355.833004] Starting subtest: sol-reset-invalid
[355.836890] Subtest sol-reset-invalid: SUCCESS (0.003s)
[356.030374] [050/155] (802s left) kms_psr (psr-sprite-plane-move)
[356.218795] Subtest psr-sprite-plane-move: SKIP (0.000s)
[356.348403] [051/155] (802s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[356.560503] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[356.569222] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[356.721079] [052/155] (802s left) kms_prop_blob (blob-prop-validate)
[356.837845] Starting subtest: blob-prop-validate
[356.841351] Subtest blob-prop-validate: SUCCESS (0.000s)
[356.988341] [053/155] (802s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[357.568766] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[357.938921] [054/155] (801s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[358.081817] Starting subtest: basic-gtt-wc-noreloc
[358.089804] Subtest basic-gtt-wc-noreloc: SUCCESS (0.010s)
[358.319887] [055/155] (800s left) kms_plane (pixel-format-yf-tiled-modifier)
[358.510219] Starting subtest: pixel-format-yf-tiled-modifier
[358.741920] Starting dynamic subtest: pipe-A-plane-0
[359.157052] Dynamic subtest pipe-A-plane-0: SUCCESS (0.416s)
[359.185296] Starting dynamic subtest: pipe-A-plane-1
[359.523120] Dynamic subtest pipe-A-plane-1: SUCCESS (0.365s)
[359.551151] Starting dynamic subtest: pipe-A-plane-2
[359.874659] Dynamic subtest pipe-A-plane-2: SUCCESS (0.348s)
[359.902169] Starting dynamic subtest: pipe-A-plane-3
[360.225330] Dynamic subtest pipe-A-plane-3: SUCCESS (0.348s)
[360.270490] Starting dynamic subtest: pipe-A-plane-4
[360.281951] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[360.646016] Starting dynamic subtest: pipe-B-plane-0
[360.971001] Dynamic subtest pipe-B-plane-0: SUCCESS (0.350s)
[360.998816] Starting dynamic subtest: pipe-B-plane-1
[361.370242] Dynamic subtest pipe-B-plane-1: SUCCESS (0.398s)
[361.398120] Starting dynamic subtest: pipe-B-plane-2
[361.735985] Dynamic subtest pipe-B-plane-2: SUCCESS (0.365s)
[361.763385] Starting dynamic subtest: pipe-B-plane-3
[362.103844] Dynamic subtest pipe-B-plane-3: SUCCESS (0.365s)
[362.132366] Starting dynamic subtest: pipe-B-plane-4
[362.140485] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[362.370824] Subtest pixel-format-yf-tiled-modifier: SUCCESS (3.867s)
[362.728751] [056/155] (796s left) syncobj_basic (illegal-fd-to-handle)
[362.849973] Starting subtest: illegal-fd-to-handle
[362.853952] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[363.006623] [057/155] (796s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[363.223507] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[363.229872] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[363.372363] [058/155] (796s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[363.594786] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[363.604213] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[363.746507] [059/155] (795s left) api_intel_allocator (two-level-inception)
[363.853397] Starting subtest: two-level-inception
[369.391986] Subtest two-level-inception: SUCCESS (5.544s)
[369.554989] [060/155] (790s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[369.772557] Starting subtest: y-tiled-64bpp-rotate-180
[376.496187] Subtest y-tiled-64bpp-rotate-180: SUCCESS (6.728s)
[377.038553] [061/155] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[377.253200] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[377.260071] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[377.401177] [062/155] (782s left) kms_vblank (ts-continuation-dpms-suspend)
[377.594377] Starting subtest: ts-continuation-dpms-suspend
[377.598233] Starting dynamic subtest: pipe-A-HDMI-A-1