[104.387616] Initializing watchdogs
[104.387803]   /dev/watchdog0
[104.427748] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[104.442554] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.450805] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.456885] [001/133] (960s left) gen9_exec_parse (unaligned-jump)
[104.603285] Starting subtest: unaligned-jump
[104.921817] Subtest unaligned-jump: SUCCESS (0.320s)
[105.189104] [002/133] (959s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[105.377906] Starting subtest: stress-xrgb8888-yftiled
[115.407206] Subtest stress-xrgb8888-yftiled: SUCCESS (10.025s)
[115.951477] [003/133] (949s left) kms_psr (psr-cursor-plane-move)
[116.140332] Subtest psr-cursor-plane-move: SKIP (0.000s)
[116.237789] [004/133] (948s left) gem_lmem_swapping (heavy-verify-random)
[116.356250] Subtest heavy-verify-random: SKIP (0.000s)
[116.456166] [005/133] (948s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[116.656155] Starting subtest: fbc-rgb565-draw-mmap-wc
[119.451129] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.796s)
[119.732176] [006/133] (945s left) syncobj_wait (wait-for-submit-snapshot)
[119.835114] Starting subtest: wait-for-submit-snapshot
[119.927216] Subtest wait-for-submit-snapshot: SUCCESS (0.088s)
[120.052212] [007/133] (945s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[120.233102] Starting subtest: modeset-transition-nonblocking-fencing
[120.235058] Starting dynamic subtest: 1x-outputs
[123.761375] Dynamic subtest 1x-outputs: SUCCESS (3.529s)
[123.781671] Starting dynamic subtest: 2x-outputs
[131.120163] Dynamic subtest 2x-outputs: SUCCESS (7.359s)
[131.121875] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.890s)
[131.418318] [008/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[131.624021] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[131.628114] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[131.768435] [009/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[131.972857] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[131.976881] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[132.117177] [010/133] (933s left) gem_softpin (noreloc)
[132.236282] Starting subtest: noreloc
[137.754050] Subtest noreloc: SUCCESS (5.504s)
[137.891000] [011/133] (927s left) kms_chamelium_audio (hdmi-audio)
[138.476214] Subtest hdmi-audio: SKIP (0.000s)
[138.798897] [012/133] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[139.001442] Starting subtest: psr-1p-primscrn-spr-indfb-move
[139.004416] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[139.137801] [013/133] (926s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[139.346058] Starting subtest: y-tiled-8bpp-rotate-180
[142.772671] Subtest y-tiled-8bpp-rotate-180: SUCCESS (3.421s)
[143.055263] [014/133] (922s left) kms_pwrite_crc
[144.433813] [015/133] (921s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[144.546203] Starting subtest: invalid-multi-wait-unsubmitted
[144.549718] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[144.684971] [016/133] (921s left) gem_exec_params (cliprects-invalid)
[144.793266] Starting subtest: cliprects-invalid
[144.795060] Subtest cliprects-invalid: SUCCESS (0.000s)
[144.935209] [017/133] (921s left) sw_sync (timeline_closed)
[145.033140] Starting subtest: timeline_closed
[145.035893] Subtest timeline_closed: SUCCESS (0.001s)
[145.151424] [018/133] (921s left) gem_ctx_sseu (engines)
[145.258904] Subtest engines: SKIP (0.000s)
[145.360493] [019/133] (921s left) kms_chamelium_color (gamma)
[145.541322] Subtest gamma: SKIP (0.000s)
[145.640877] [020/133] (920s left) gem_exec_schedule (thriceslice)
[145.776210] Starting subtest: thriceslice
[145.777993] Starting dynamic subtest: rcs0
[145.792186] Dynamic subtest rcs0: SUCCESS (0.015s)
[145.814455] Starting dynamic subtest: bcs0
[145.816859] Dynamic subtest bcs0: SUCCESS (0.018s)
[145.846454] Starting dynamic subtest: vcs0
[145.848213] Dynamic subtest vcs0: SUCCESS (0.013s)
[145.866445] Starting dynamic subtest: vecs0
[145.868708] Dynamic subtest vecs0: SUCCESS (0.012s)
[145.871511] Subtest thriceslice: SUCCESS (0.062s)
[146.250965] [021/133] (920s left) kms_addfb_basic (size-max)
[146.436363] Starting subtest: size-max
[146.438194] Subtest size-max: SUCCESS (0.000s)
[146.567351] [022/133] (920s left) perf (global-sseu-config-invalid)
[146.767968] Starting subtest: global-sseu-config-invalid
[146.771086] Starting dynamic subtest: 0-rcs0
[146.801303] Dynamic subtest 0-rcs0: SUCCESS (0.029s)
[146.803219] Subtest global-sseu-config-invalid: SUCCESS (0.031s)
[146.903126] [023/133] (919s left) gem_exec_create (madvise)
[147.026365] Starting subtest: madvise
[147.029159] Starting dynamic subtest: smem
[167.162635] Dynamic subtest smem: SUCCESS (20.136s)
[167.181127] Subtest madvise: SUCCESS (20.137s)
[168.571163] [024/133] (898s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[168.747202] Starting subtest: cursorB-vs-flipB-atomic
[180.007558] Subtest cursorB-vs-flipB-atomic: SUCCESS (11.255s)
[180.328979] [025/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[180.540988] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[180.544650] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.679222] [026/133] (886s left) gem_exec_params (cliprects_ptr-dirt)
[180.788123] Starting subtest: cliprects_ptr-dirt
[180.789821] Subtest cliprects_ptr-dirt: SUCCESS (0.001s)
[180.929363] [027/133] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[181.131377] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[181.135481] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[181.278329] [028/133] (885s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[181.471097] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[181.569179] [029/133] (885s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[181.748712] Starting subtest: primary-yf-tiled-reflect-x-270
[181.759113] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.005s)
[181.891996] [030/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[182.093071] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[182.096458] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.230295] [031/133] (885s left) gen7_exec_parse (bitmasks)
[182.337199] Subtest bitmasks: SKIP (0.000s)
[182.435950] [032/133] (885s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[182.628217] Starting subtest: addfb25-x-tiled-mismatch-legacy
[182.630907] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[182.760681] [033/133] (884s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[182.866071] Starting subtest: etime-multi-wait-all-submitted-signaled
[182.974914] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[183.113020] [034/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[183.312182] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[183.316066] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[183.459856] [035/133] (884s left) gem_exec_reloc (basic-write-cpu-active)
[183.579456] Starting subtest: basic-write-cpu-active
[183.718606] Subtest basic-write-cpu-active: SUCCESS (0.139s)
[183.945057] [036/133] (883s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[186.589611] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[186.594990] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[186.730398] [037/133] (881s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[186.909731] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[186.913526] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[187.045347] [038/133] (881s left) syncobj_wait (reset-during-wait-for-submit)
[187.148363] Starting subtest: reset-during-wait-for-submit
[187.256977] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[187.411172] [039/133] (880s left) kms_plane_scaling (planes-upscale-20x20)
[187.596692] Starting subtest: planes-upscale-20x20
[187.599094] Starting dynamic subtest: pipe-A
[187.926688] Dynamic subtest pipe-A: SUCCESS (0.334s)
[187.962611] Starting dynamic subtest: pipe-B
[188.328160] Dynamic subtest pipe-B: SUCCESS (0.400s)
[188.365419] Starting dynamic subtest: pipe-C
[188.413890] Dynamic subtest pipe-C: SUCCESS (0.086s)
[188.417330] Subtest planes-upscale-20x20: SUCCESS (0.824s)
[188.904201] [040/133] (879s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[189.016485] Starting subtest: no-spare-fences-interruptible
[191.191649] Subtest no-spare-fences-interruptible: SUCCESS (2.165s)
[191.340171] [041/133] (876s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[191.623298] Starting subtest: basic-test-pattern-with-chamelium
[191.626498] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[191.757103] [042/133] (876s left) kms_pm_dc (dc3co-vpb-simulation)
[192.909094] Starting subtest: dc3co-vpb-simulation
[192.913103] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[193.038533] [043/133] (875s left) kms_pipe_crc_basic (bad-source)
[193.179491] Starting subtest: bad-source
[193.181056] Subtest bad-source: SUCCESS (0.001s)
[193.339699] [044/133] (875s left) gem_exec_params (rel-constants-invalid-ring)
[193.463200] Starting subtest: rel-constants-invalid-ring
[193.467347] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[193.608452] [045/133] (875s left) gem_exec_balancer (hang)
[193.851316] Starting subtest: hang
[198.090926] Subtest hang: SUCCESS (4.241s)
[198.272305] [046/133] (870s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[199.020111] Starting subtest: syncobj-timeline-multiple-ext-nodes
[199.022116] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[199.295814] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[199.301406] [047/133] (869s left) kms_plane_multiple (2x-tiling-4)
[199.426336] Starting subtest: 2x-tiling-4
[199.429517] Subtest 2x-tiling-4: SKIP (0.000s)
[199.566500] [048/133] (869s left) gem_gtt_cpu_tlb
[199.851453] [049/133] (869s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[199.987125] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[199.998100] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.086083] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s)
[200.126586] Starting dynamic subtest: pipe-A-HDMI-A-2
[200.246369] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[200.264514] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.330334] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[200.348789] Starting dynamic subtest: pipe-B-HDMI-A-2
[200.413324] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.014s)
[200.432230] Starting dynamic subtest: pipe-C-HDMI-A-1
[200.493368] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.014s)
[200.511859] Starting dynamic subtest: pipe-C-HDMI-A-2
[200.580033] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.016s)
[200.583161] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.106s)
[201.046250] [050/133] (868s left) kms_getfb (getfb2-handle-not-fb)
[201.188569] Starting subtest: getfb2-handle-not-fb
[201.190400] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[201.347178] [051/133] (867s left) kms_feature_discovery (psr1)
[201.492038] Starting subtest: psr1
[201.495101] Subtest psr1: SKIP (0.000s)
[201.630519] [052/133] (867s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[201.774095] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[201.884042] [053/133] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[202.048791] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[205.037040] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (2.987s)
[205.265329] [054/133] (864s left) perf (short-reads)
[205.459418] Starting subtest: short-reads
[205.492533] Subtest short-reads: SUCCESS (0.032s)
[205.598452] [055/133] (864s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[205.728262] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[205.732154] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[205.860982] [056/133] (863s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[206.010074] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[206.115790] [057/133] (863s left) kms_cursor_crc (cursor-onscreen-256x85)
[206.273064] Starting subtest: cursor-onscreen-256x85
[206.339427] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.077467] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.734s)
[209.184540] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.523743] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.382s)
[211.525458] Subtest cursor-onscreen-256x85: SUCCESS (5.249s)
[211.840855] [058/133] (858s left) kms_psr (fbc-psr-cursor-plane-onoff)
[211.994044] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[212.098092] [059/133] (857s left) sysfs_heartbeat_interval (mixed)
[212.213472] Starting subtest: mixed
[212.217618] Starting dynamic subtest: vecs0
[217.476087] Dynamic subtest vecs0: SUCCESS (5.253s)
[217.494765] Starting dynamic subtest: vcs0
[222.732748] Dynamic subtest vcs0: SUCCESS (5.260s)
[222.756046] Starting dynamic subtest: bcs0
[227.983733] Dynamic subtest bcs0: SUCCESS (5.245s)
[228.004890] Starting dynamic subtest: rcs0
[233.234743] Dynamic subtest rcs0: SUCCESS (5.250s)
[233.236409] Subtest mixed: SUCCESS (21.020s)
[233.371525] [060/133] (836s left) kms_color (ctm-0-75)
[233.513162] Starting subtest: ctm-0-75
[233.514852] Starting dynamic subtest: pipe-A-HDMI-A-1
[236.341816] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.829s)
[236.364452] Starting dynamic subtest: pipe-A-HDMI-A-2
[238.853872] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.509s)
[238.893078] Starting dynamic subtest: pipe-B-HDMI-A-1
[241.315251] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.459s)
[241.350295] Starting dynamic subtest: pipe-B-HDMI-A-2
[243.776334] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.458s)
[243.803712] Starting dynamic subtest: pipe-C-HDMI-A-1
[246.236700] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.455s)
[246.273571] Starting dynamic subtest: pipe-C-HDMI-A-2
[248.702413] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.461s)
[248.704428] Subtest ctm-0-75: SUCCESS (15.191s)
[249.077811] [061/133] (821s left) gem_pxp (reject-modify-context-protection-off-3)
[251.730116] Starting subtest: reject-modify-context-protection-off-3
[251.733819] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[251.869249] [062/133] (818s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[252.029183] Starting subtest: psr-rgb101010-draw-blt
[252.032953] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[252.184978] [063/133] (818s left) kms_cursor_legacy (forked-bo)
[252.331053] Starting subtest: forked-bo
[252.333018] Starting dynamic subtest: pipe-A
[257.833058] Dynamic subtest pipe-A: SUCCESS (5.498s)
[258.588968] Starting dynamic subtest: pipe-B
[263.243999] Dynamic subtest pipe-B: SUCCESS (5.412s)
[263.268071] Starting dynamic subtest: pipe-C
[268.666394] Dynamic subtest pipe-C: SUCCESS (5.418s)
[268.685966] Starting dynamic subtest: all-pipes
[274.091958] Dynamic subtest all-pipes: SUCCESS (5.421s)
[274.093747] Subtest forked-bo: SUCCESS (21.760s)
[274.265859] [064/133] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[274.413619] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[274.419590] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[274.552994] [065/133] (796s left) fbdev (unaligned-read)
[274.697459] Starting subtest: unaligned-read
[274.730159] Subtest unaligned-read: SUCCESS (0.034s)
[274.862825] [066/133] (795s left) gem_ctx_isolation (nonpriv-switch)
[274.988223] Starting subtest: nonpriv-switch
[274.989981] Starting dynamic subtest: rcs0
[275.809572] Dynamic subtest rcs0: SUCCESS (0.818s)
[275.832407] Starting dynamic subtest: bcs0
[277.183427] Dynamic subtest bcs0: SUCCESS (1.374s)
[277.206523] Starting dynamic subtest: vcs0
[278.015288] Dynamic subtest vcs0: SUCCESS (0.828s)
[278.035913] Starting dynamic subtest: vecs0
[278.864679] Dynamic subtest vecs0: SUCCESS (0.846s)
[278.866977] Subtest nonpriv-switch: SUCCESS (3.877s)
[279.124219] [067/133] (791s left) kms_psr (psr-sprite-mmap-gtt)
[279.263671] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[279.380496] [068/133] (791s left) gem_render_copy (yf-tiled-to-vebox-linear)
[279.507930] Starting subtest: yf-tiled-to-vebox-linear
[279.511863] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[279.773625] [069/133] (791s left) kms_content_protection (atomic)
[279.933241] Starting subtest: atomic
[279.983056] Subtest atomic: SKIP (0.045s)
[280.121043] [070/133] (790s left) syncobj_eventfd (timeline-wait-before-signal)
[280.229528] Starting subtest: timeline-wait-before-signal
[280.265273] Subtest timeline-wait-before-signal: SUCCESS (0.034s)
[280.407106] [071/133] (790s left) kms_flip (flip-vs-suspend)
[280.549075] Starting subtest: flip-vs-suspend
[280.551171] Starting dynamic subtest: A-HDMI-A1