[85.595185] Initializing watchdogs
[85.595398]   /dev/watchdog0
[85.637665] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[85.652590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[85.659930] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[85.668388] [001/131] (960s left) perf_pmu (most-busy-check-all)
[85.799106] Starting subtest: most-busy-check-all
[85.802478] Starting dynamic subtest: rcs0
[86.328749] Dynamic subtest rcs0: SUCCESS (0.527s)
[86.347040] Starting dynamic subtest: bcs0
[86.849266] Dynamic subtest bcs0: SUCCESS (0.518s)
[86.867618] Starting dynamic subtest: vcs0
[87.370540] Dynamic subtest vcs0: SUCCESS (0.520s)
[87.391827] Starting dynamic subtest: vecs0
[87.893921] Dynamic subtest vecs0: SUCCESS (0.524s)
[87.897026] Subtest most-busy-check-all: SUCCESS (2.093s)
[88.048208] [002/131] (958s left) i915_hangman (engine-engine-error)
[88.179462] Starting subtest: engine-engine-error
[88.183110] Starting dynamic subtest: rcs0
[88.265232] Dynamic subtest rcs0: SUCCESS (0.084s)
[88.284187] Starting dynamic subtest: bcs0
[88.290861] Dynamic subtest bcs0: SKIP (0.004s)
[88.317124] Starting dynamic subtest: vcs0
[88.357604] Dynamic subtest vcs0: SUCCESS (0.086s)
[88.377141] Starting dynamic subtest: vecs0
[88.430845] Dynamic subtest vecs0: SUCCESS (0.072s)
[88.434573] Subtest engine-engine-error: SUCCESS (0.251s)
[88.599232] [003/131] (957s left) gem_exec_flush (basic-wb-set-default)
[88.729857] Starting subtest: basic-wb-set-default
[94.143735] Subtest basic-wb-set-default: SUCCESS (5.415s)
[94.429131] [004/131] (952s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[94.596047] Starting subtest: flip-vs-cursor-toggle
[116.784413] Subtest flip-vs-cursor-toggle: SUCCESS (22.182s)
[117.031762] [005/131] (929s left) gem_pxp (reject-modify-context-protection-off-1)
[119.691016] Starting subtest: reject-modify-context-protection-off-1
[119.699281] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[119.858110] [006/131] (926s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[120.034076] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[120.040085] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[120.209337] [007/131] (926s left) gem_exec_schedule (independent)
[120.344254] Starting subtest: independent
[120.347427] Starting dynamic subtest: rcs0
[120.496205] Dynamic subtest rcs0: SUCCESS (0.151s)
[120.517150] Starting dynamic subtest: bcs0
[120.647480] Dynamic subtest bcs0: SUCCESS (0.151s)
[120.667883] Starting dynamic subtest: vcs0
[120.780783] Dynamic subtest vcs0: SUCCESS (0.133s)
[120.802098] Starting dynamic subtest: vecs0
[120.915938] Dynamic subtest vecs0: SUCCESS (0.134s)
[120.919998] Subtest independent: SUCCESS (0.573s)
[121.337312] [008/131] (925s left) kms_feature_discovery (display-2x)
[121.509956] Starting subtest: display-2x
[121.518415] Subtest display-2x: SKIP (0.000s)
[121.665274] [009/131] (925s left) kms_psr (psr2-sprite-plane-onoff)
[121.840744] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[121.944783] [010/131] (925s left) syncobj_timeline (etime-multi-wait-submitted)
[122.055790] Starting subtest: etime-multi-wait-submitted
[122.167157] Subtest etime-multi-wait-submitted: SUCCESS (0.109s)
[122.326975] [011/131] (924s left) gem_exec_fence (syncobj-channel)
[122.953817] Starting subtest: syncobj-channel
[124.016623] Subtest syncobj-channel: SUCCESS (1.058s)
[124.403308] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[124.409919] [012/131] (922s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[124.584391] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[124.850400] [013/131] (922s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[125.496122] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[125.639294] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[126.115502] [014/131] (921s left) kms_atomic_transition (plane-all-transition)
[126.348343] Starting subtest: plane-all-transition
[126.353027] Starting dynamic subtest: pipe-A-HDMI-A-2
[130.451986] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.087s)
[130.726751] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.183853] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.512s)
[135.395285] Subtest plane-all-transition: SUCCESS (9.026s)
[135.633119] [015/131] (912s left) sysfs_heartbeat_interval (nopreempt)
[135.770472] Starting subtest: nopreempt
[135.775053] Starting dynamic subtest: vecs0
[139.405197] Dynamic subtest vecs0: SUCCESS (3.633s)
[139.443242] Starting dynamic subtest: vcs0
[143.059523] Dynamic subtest vcs0: SUCCESS (3.654s)
[143.098450] Starting dynamic subtest: bcs0
[146.689834] Dynamic subtest bcs0: SUCCESS (3.627s)
[146.723274] Starting dynamic subtest: rcs0
[150.447761] Dynamic subtest rcs0: SUCCESS (3.760s)
[150.452523] Subtest nopreempt: SUCCESS (14.682s)
[150.633820] [016/131] (897s left) vgem_basic (dmabuf-mmap)
[150.758655] Starting subtest: dmabuf-mmap
[150.784618] Subtest dmabuf-mmap: SUCCESS (0.031s)
[150.932425] [017/131] (897s left) kms_cursor_crc (cursor-random-512x170)
[151.128479] Starting subtest: cursor-random-512x170
[151.135559] Subtest cursor-random-512x170: SKIP (0.003s)
[151.315610] [018/131] (897s left) kms_flip (flip-vs-blocking-wf-vblank)
[151.482429] Starting subtest: flip-vs-blocking-wf-vblank
[151.487740] Starting dynamic subtest: A-HDMI-A2
[162.202408] Dynamic subtest A-HDMI-A2: SUCCESS (10.716s)
[162.222828] Starting dynamic subtest: B-HDMI-A2
[172.857417] Dynamic subtest B-HDMI-A2: SUCCESS (10.651s)
[172.878667] Starting dynamic subtest: C-HDMI-A2
[183.527245] Dynamic subtest C-HDMI-A2: SUCCESS (10.665s)
[183.530273] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.044s)
[183.966409] [019/131] (864s left) syncobj_timeline (wait-delayed-signal)
[184.077806] Starting subtest: wait-delayed-signal
[184.183266] Subtest wait-delayed-signal: SUCCESS (0.105s)
[184.354615] [020/131] (864s left) gem_ctx_param (non-root-set)
[184.456419] Starting subtest: non-root-set
[184.484991] Subtest non-root-set: SUCCESS (0.032s)
[184.656801] [021/131] (863s left) prime_vgem (coherency-blt)
[184.788267] Starting subtest: coherency-blt
[187.709533] Subtest coherency-blt: SUCCESS (2.917s)
[187.883604] [022/131] (860s left) prime_vgem (basic-fence-read)
[188.009102] Starting subtest: basic-fence-read
[188.131182] Subtest basic-fence-read: SUCCESS (0.122s)
[188.318513] [023/131] (860s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[188.693782] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[188.907079] [024/131] (860s left) gem_exec_reloc (basic-wc-read)
[189.029248] Starting subtest: basic-wc-read
[189.048171] Subtest basic-wc-read: SUCCESS (0.017s)
[189.310424] [025/131] (859s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[189.481505] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[189.486316] Starting dynamic subtest: pipe-A
[190.045123] Dynamic subtest pipe-A: SUCCESS (0.569s)
[190.067595] Starting dynamic subtest: pipe-B
[190.874098] Dynamic subtest pipe-B: SUCCESS (0.828s)
[190.895038] Starting dynamic subtest: pipe-C
[191.681195] Dynamic subtest pipe-C: SUCCESS (0.804s)
[191.686807] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.209s)
[192.119125] [026/131] (857s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[192.231563] Starting subtest: etime-multi-wait-all-for-submit-submitted
[192.343784] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[192.519649] [027/131] (856s left) gem_basic (create-fd-close)
[192.625435] Starting subtest: create-fd-close
[192.631654] Subtest create-fd-close: SUCCESS (0.000s)
[192.784571] [028/131] (856s left) gem_exec_fence (syncobj-repeat)
[193.322990] Starting subtest: syncobj-repeat
[194.251259] Subtest syncobj-repeat: SUCCESS (0.919s)
[194.669061] [029/131] (854s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[194.833491] Starting subtest: plane-primary-overlay-mutable-zpos
[195.585856] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.741s)
[196.032565] [030/131] (853s left) kms_flip (2x-dpms-vs-vblank-race)
[196.208279] Starting subtest: 2x-dpms-vs-vblank-race
[196.215090] Subtest 2x-dpms-vs-vblank-race: SKIP (0.002s)
[196.391735] [031/131] (853s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[196.588982] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[196.592474] Starting dynamic subtest: pipe-A-valid-mode
[197.022051] Dynamic subtest pipe-A-valid-mode: SKIP (0.407s)
[197.029232] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.412s)
[197.363973] [032/131] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[197.555161] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[200.066482] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.518s)
[200.295796] [033/131] (849s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[200.505160] Starting subtest: psr-rgb101010-draw-mmap-cpu
[200.512065] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[200.675904] [034/131] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[200.863118] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[203.634617] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.776s)
[203.869679] [035/131] (846s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[203.993979] Starting subtest: y-tiled-to-vebox-yf-tiled
[204.000913] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[204.282259] [036/131] (845s left) perf_pmu (busy-idle-check-all)
[204.393828] Starting subtest: busy-idle-check-all
[204.396802] Starting dynamic subtest: rcs0
[205.026777] Dynamic subtest rcs0: SUCCESS (0.629s)
[205.047777] Starting dynamic subtest: bcs0
[205.658707] Dynamic subtest bcs0: SUCCESS (0.628s)
[205.679193] Starting dynamic subtest: vcs0
[206.286943] Dynamic subtest vcs0: SUCCESS (0.629s)
[206.308363] Starting dynamic subtest: vecs0
[206.920636] Dynamic subtest vecs0: SUCCESS (0.632s)
[206.923837] Subtest busy-idle-check-all: SUCCESS (2.526s)
[207.092415] [037/131] (843s left) gem_exec_whisper (basic-sync)
[207.221069] Starting subtest: basic-sync
[212.164743] Subtest basic-sync: SUCCESS (4.941s)
[212.480216] [038/131] (837s left) gem_userptr_blits (readonly-pwrite-unsync)
[212.606977] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[212.830571] [039/131] (837s left) gem_create (create-ext-placement-all)
[213.057484] Starting subtest: create-ext-placement-all
[213.060646] Subtest create-ext-placement-all: SUCCESS (0.000s)
[213.248486] [040/131] (837s left) kms_content_protection (atomic-dpms)
[213.426689] Starting subtest: atomic-dpms
[214.090095] Subtest atomic-dpms: SKIP (0.650s)
[214.530746] [041/131] (836s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[214.713894] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[214.811745] [042/131] (836s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[214.979326] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[214.983676] Starting dynamic subtest: pipe-A-HDMI-A-2
[215.323615] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.329s)
[215.384045] Starting dynamic subtest: pipe-B-HDMI-A-2
[215.869658] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.479s)
[215.890308] Starting dynamic subtest: pipe-C-HDMI-A-2
[215.922374] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[215.925741] Subtest crc-primary-rotation-180-y-tiled-ccs: SUCCESS (0.822s)
[216.505817] [043/131] (834s left) prime_mmap (test_correct)
[216.615452] Starting subtest: test_correct
[216.620320] Starting dynamic subtest: test_correct-smem
[216.623785] Dynamic subtest test_correct-smem: SUCCESS (0.009s)
[216.626789] Subtest test_correct: SUCCESS (0.011s)
[216.796930] [044/131] (834s left) perf (invalid-oa-metric-set-id)
[217.058532] Starting subtest: invalid-oa-metric-set-id
[217.084441] Subtest invalid-oa-metric-set-id: SUCCESS (0.028s)
[217.188768] [045/131] (833s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[217.296056] Starting subtest: cpuset-basic-small-copy-odd
[222.395518] Subtest cpuset-basic-small-copy-odd: SUCCESS (5.096s)
[222.577729] [046/131] (828s left) kms_atomic (atomic-invalid-params)
[222.884740] Starting subtest: atomic-invalid-params
[222.893997] Starting dynamic subtest: pipe-A-HDMI-A-2
[223.335919] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.441s)
[223.340469] Subtest atomic-invalid-params: SUCCESS (0.449s)
[223.573241] [047/131] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[223.773284] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[223.779635] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[223.953904] [048/131] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[224.135060] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[224.141453] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[224.323580] [049/131] (827s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[224.518385] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[224.524857] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[224.685702] [050/131] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[224.873194] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[224.879437] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[225.022860] [051/131] (826s left) gem_exec_schedule (smoketest)
[225.321694] Starting subtest: smoketest
[225.324831] Starting dynamic subtest: rcs0
[230.744764] Dynamic subtest rcs0: SUCCESS (5.415s)
[230.768293] Starting dynamic subtest: bcs0
[236.178133] Dynamic subtest bcs0: SUCCESS (5.429s)
[236.199909] Starting dynamic subtest: vcs0
[241.608892] Dynamic subtest vcs0: SUCCESS (5.430s)
[241.630852] Starting dynamic subtest: vecs0
[247.042655] Dynamic subtest vecs0: SUCCESS (5.431s)
[247.046609] Subtest smoketest: SUCCESS (21.716s)
[247.324614] [052/131] (804s left) syncobj_basic (bad-pad-fd-to-handle)
[247.468824] Starting subtest: bad-pad-fd-to-handle
[247.473653] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[247.616576] [053/131] (804s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[247.814504] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[247.822046] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[247.988799] [054/131] (804s left) kms_prop_blob (invalid-set-prop)
[248.097858] Starting subtest: invalid-set-prop
[248.102159] Subtest invalid-set-prop: SUCCESS (0.000s)
[248.271587] [055/131] (803s left) kms_hdr (static-swap)
[248.445394] Starting subtest: static-swap
[248.456163] Subtest static-swap: SKIP (0.001s)
[248.605879] [056/131] (803s left) kms_vrr (seamless-rr-switch-vrr)
[248.777189] Starting subtest: seamless-rr-switch-vrr
[248.788140] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[248.958825] [057/131] (803s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[249.122474] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[249.125980] Starting dynamic subtest: pipe-A
[249.239967] Dynamic subtest pipe-A: SUCCESS (0.116s)
[249.271941] Starting dynamic subtest: pipe-B
[249.615144] Dynamic subtest pipe-B: SUCCESS (0.373s)
[249.668213] Starting dynamic subtest: pipe-C
[249.675768] Dynamic subtest pipe-C: SUCCESS (0.036s)
[249.703084] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.534s)
[250.099740] [058/131] (802s left) gem_wait (write-busy)
[250.240637] Starting subtest: write-busy
[250.246516] Starting dynamic subtest: all-engines
[250.776691] Dynamic subtest all-engines: SUCCESS (0.525s)
[250.798113] Starting dynamic subtest: rcs0
[251.288272] Dynamic subtest rcs0: SUCCESS (0.519s)
[251.317393] Starting dynamic subtest: bcs0
[251.808808] Dynamic subtest bcs0: SUCCESS (0.519s)
[251.837712] Starting dynamic subtest: vcs0
[252.328721] Dynamic subtest vcs0: SUCCESS (0.517s)
[252.356875] Starting dynamic subtest: vecs0
[252.847502] Dynamic subtest vecs0: SUCCESS (0.517s)
[252.850797] Subtest write-busy: SUCCESS (2.607s)
[253.177624] [059/131] (799s left) gem_ctx_shared (create-shared-gtt)
[253.305510] Starting subtest: create-shared-gtt
[255.461020] Subtest create-shared-gtt: SUCCESS (2.153s)
[255.750236] [060/131] (796s left) kms_vblank (accuracy-idle)
[255.917589] Starting subtest: accuracy-idle
[255.920904] Starting dynamic subtest: pipe-A-HDMI-A-2
[258.345141] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.422s)
[258.387403] Starting dynamic subtest: pipe-C-HDMI-A-2
[260.750278] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.395s)
[260.753864] Subtest accuracy-idle: SUCCESS (4.832s)
[260.991864] [061/131] (791s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[261.178088] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[261.185205] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[261.366591] [062/131] (791s left) i915_suspend (fence-restore-tiled2untiled)
[261.477679] Starting subtest: fence-restore-tiled2untiled