[109.433387] Initializing watchdogs
[109.433616]   /dev/watchdog0
[109.473434] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[109.488565] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[109.494744] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[109.500188] [001/133] (960s left) gen9_exec_parse (unaligned-jump)
[109.649371] Starting subtest: unaligned-jump
[109.964976] Subtest unaligned-jump: SUCCESS (0.317s)
[110.233873] [002/133] (959s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[110.429421] Starting subtest: stress-xrgb8888-yftiled
[120.700380] Subtest stress-xrgb8888-yftiled: SUCCESS (10.270s)
[121.222371] [003/133] (948s left) kms_psr (psr-cursor-plane-move)
[121.418323] Subtest psr-cursor-plane-move: SKIP (0.000s)
[121.512284] [004/133] (948s left) gem_lmem_swapping (heavy-verify-random)
[121.627533] Subtest heavy-verify-random: SKIP (0.000s)
[121.712995] [005/133] (948s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[121.902098] Starting subtest: fbc-rgb565-draw-mmap-wc
[124.709916] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.807s)
[125.001723] [006/133] (945s left) syncobj_wait (wait-for-submit-snapshot)
[125.104133] Starting subtest: wait-for-submit-snapshot
[125.194359] Subtest wait-for-submit-snapshot: SUCCESS (0.088s)
[125.354935] [007/133] (945s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[125.541137] Starting subtest: modeset-transition-nonblocking-fencing
[125.543058] Starting dynamic subtest: 1x-outputs
[129.047607] Dynamic subtest 1x-outputs: SUCCESS (3.510s)
[129.068346] Starting dynamic subtest: 2x-outputs
[136.417690] Dynamic subtest 2x-outputs: SUCCESS (7.367s)
[136.419231] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.880s)
[136.768272] [008/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[136.977147] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[136.980103] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[137.117112] [009/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[137.317092] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[137.319864] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[137.451314] [010/133] (933s left) gem_softpin (noreloc)
[137.571345] Starting subtest: noreloc
[143.051100] Subtest noreloc: SUCCESS (5.472s)
[143.203403] [011/133] (927s left) kms_chamelium_audio (hdmi-audio)
[143.782079] Subtest hdmi-audio: SKIP (0.000s)
[144.048406] [012/133] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[144.239076] Starting subtest: psr-1p-primscrn-spr-indfb-move
[144.242126] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[144.370841] [013/133] (926s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[144.572095] Starting subtest: y-tiled-8bpp-rotate-180
[148.077562] Subtest y-tiled-8bpp-rotate-180: SUCCESS (3.504s)
[148.370825] [014/133] (922s left) kms_pwrite_crc
[149.861185] [015/133] (921s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[149.964201] Starting subtest: invalid-multi-wait-unsubmitted
[149.965284] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[150.095255] [016/133] (921s left) gem_exec_params (cliprects-invalid)
[150.201932] Starting subtest: cliprects-invalid
[150.205128] Subtest cliprects-invalid: SUCCESS (0.001s)
[150.345471] [017/133] (920s left) sw_sync (timeline_closed)
[150.444117] Starting subtest: timeline_closed
[150.445159] Subtest timeline_closed: SUCCESS (0.001s)
[150.586289] [018/133] (920s left) gem_ctx_sseu (engines)
[150.699068] Subtest engines: SKIP (0.000s)
[150.826458] [019/133] (920s left) kms_chamelium_color (gamma)
[151.001092] Subtest gamma: SKIP (0.000s)
[151.116429] [020/133] (920s left) gem_exec_schedule (thriceslice)
[151.251429] Starting subtest: thriceslice
[151.253163] Starting dynamic subtest: rcs0
[151.263065] Dynamic subtest rcs0: SUCCESS (0.012s)
[151.292745] Starting dynamic subtest: bcs0
[151.296882] Dynamic subtest bcs0: SUCCESS (0.013s)
[151.321421] Starting dynamic subtest: vcs0
[151.322445] Dynamic subtest vcs0: SUCCESS (0.014s)
[151.338987] Starting dynamic subtest: vecs0
[151.339901] Dynamic subtest vecs0: SUCCESS (0.013s)
[151.340748] Subtest thriceslice: SUCCESS (0.054s)
[151.681541] [021/133] (919s left) kms_addfb_basic (size-max)
[151.867109] Starting subtest: size-max
[151.868361] Subtest size-max: SUCCESS (0.001s)
[151.995461] [022/133] (919s left) perf (global-sseu-config-invalid)
[152.218391] Starting subtest: global-sseu-config-invalid
[152.221088] Starting dynamic subtest: 0-rcs0
[152.247280] Dynamic subtest 0-rcs0: SUCCESS (0.030s)
[152.249608] Subtest global-sseu-config-invalid: SUCCESS (0.032s)
[152.345547] [023/133] (919s left) gem_exec_create (madvise)
[152.473917] Starting subtest: madvise
[152.475096] Starting dynamic subtest: smem
[172.599804] Dynamic subtest smem: SUCCESS (20.126s)
[172.618729] Subtest madvise: SUCCESS (20.127s)
[173.896299] [024/133] (897s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[174.067931] Starting subtest: cursorB-vs-flipB-atomic
[185.333710] Subtest cursorB-vs-flipB-atomic: SUCCESS (11.269s)
[185.617434] [025/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[185.808442] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[185.812056] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[185.950340] [026/133] (886s left) gem_exec_params (cliprects_ptr-dirt)
[186.058774] Starting subtest: cliprects_ptr-dirt
[186.060822] Subtest cliprects_ptr-dirt: SUCCESS (0.002s)
[186.202692] [027/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[186.407672] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[186.412061] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[186.536318] [028/133] (885s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[186.726251] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[186.824333] [029/133] (885s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[187.007223] Starting subtest: primary-yf-tiled-reflect-x-270
[187.010269] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.003s)
[187.134370] [030/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[187.344278] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[187.348099] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.552960] [031/133] (884s left) gen7_exec_parse (bitmasks)
[187.670315] Subtest bitmasks: SKIP (0.000s)
[187.759092] [032/133] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[187.946358] Starting subtest: addfb25-x-tiled-mismatch-legacy
[187.948463] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[188.083798] [033/133] (884s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[188.193072] Starting subtest: etime-multi-wait-all-submitted-signaled
[188.300063] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[188.435341] [034/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[188.621139] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[188.625058] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[188.752271] [035/133] (884s left) gem_exec_reloc (basic-write-cpu-active)
[188.865057] Starting subtest: basic-write-cpu-active
[189.008460] Subtest basic-write-cpu-active: SUCCESS (0.141s)
[189.216290] [036/133] (883s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[191.857231] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[191.858846] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[191.984454] [037/133] (880s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[192.170835] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[192.173703] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[192.301718] [038/133] (880s left) syncobj_wait (reset-during-wait-for-submit)
[192.407811] Starting subtest: reset-during-wait-for-submit
[192.516651] Subtest reset-during-wait-for-submit: SUCCESS (0.106s)
[192.669550] [039/133] (880s left) kms_plane_scaling (planes-upscale-20x20)
[192.844103] Starting subtest: planes-upscale-20x20
[192.845140] Starting dynamic subtest: pipe-A
[193.173112] Dynamic subtest pipe-A: SUCCESS (0.327s)
[193.209176] Starting dynamic subtest: pipe-B
[193.584382] Dynamic subtest pipe-B: SUCCESS (0.409s)
[193.620344] Starting dynamic subtest: pipe-C
[193.672583] Dynamic subtest pipe-C: SUCCESS (0.086s)
[193.675126] Subtest planes-upscale-20x20: SUCCESS (0.826s)
[194.143371] [040/133] (879s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[194.256187] Starting subtest: no-spare-fences-interruptible
[196.435243] Subtest no-spare-fences-interruptible: SUCCESS (2.168s)
[196.561804] [041/133] (876s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[196.849790] Starting subtest: basic-test-pattern-with-chamelium
[196.853171] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[196.975451] [042/133] (876s left) kms_pm_dc (dc3co-vpb-simulation)
[198.119054] Starting subtest: dc3co-vpb-simulation
[198.121056] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[198.242235] [043/133] (875s left) kms_pipe_crc_basic (bad-source)
[198.384189] Starting subtest: bad-source
[198.386929] Subtest bad-source: SUCCESS (0.001s)
[198.508306] [044/133] (875s left) gem_exec_params (rel-constants-invalid-ring)
[198.620468] Starting subtest: rel-constants-invalid-ring
[198.622486] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[198.788441] [045/133] (874s left) gem_exec_balancer (hang)
[199.031373] Starting subtest: hang
[203.279377] Subtest hang: SUCCESS (4.252s)
[203.428302] [046/133] (870s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[204.176776] Starting subtest: syncobj-timeline-multiple-ext-nodes
[204.177780] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[204.450207] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[204.454352] [047/133] (869s left) kms_plane_multiple (2x-tiling-4)
[204.588358] Starting subtest: 2x-tiling-4
[204.590501] Subtest 2x-tiling-4: SKIP (0.000s)
[204.719388] [048/133] (869s left) gem_gtt_cpu_tlb
[204.971476] [049/133] (869s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[205.109128] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[205.111175] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.181075] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.015s)
[205.219772] Starting dynamic subtest: pipe-A-HDMI-A-2
[205.321921] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.014s)
[205.342260] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.374472] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s)
[205.392725] Starting dynamic subtest: pipe-B-HDMI-A-2
[205.424333] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[205.442226] Starting dynamic subtest: pipe-C-HDMI-A-1
[205.473664] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[205.493580] Starting dynamic subtest: pipe-C-HDMI-A-2
[205.525342] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.010s)
[205.526862] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.098s)
[206.118672] [050/133] (867s left) kms_getfb (getfb2-handle-not-fb)
[206.274081] Starting subtest: getfb2-handle-not-fb
[206.275459] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[206.421650] [051/133] (867s left) kms_feature_discovery (psr1)
[206.560325] Starting subtest: psr1
[206.564382] Subtest psr1: SKIP (0.001s)
[206.702265] [052/133] (867s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[206.848151] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[206.940768] [053/133] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[207.103247] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[210.094104] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (2.994s)
[210.335111] [054/133] (864s left) perf (short-reads)
[210.539386] Starting subtest: short-reads
[210.566858] Subtest short-reads: SUCCESS (0.028s)
[210.669149] [055/133] (863s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[210.796210] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[210.800270] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[210.942856] [056/133] (863s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[211.100255] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[211.212510] [057/133] (863s left) kms_cursor_crc (cursor-onscreen-256x85)
[211.361309] Starting subtest: cursor-onscreen-256x85
[211.406109] Starting dynamic subtest: pipe-A-HDMI-A-1
[214.117981] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.713s)
[214.226390] Starting dynamic subtest: pipe-C-HDMI-A-1
[216.585980] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.395s)
[216.588028] Subtest cursor-onscreen-256x85: SUCCESS (5.226s)
[216.898843] [058/133] (857s left) kms_psr (fbc-psr-cursor-plane-onoff)
[217.038173] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[217.136372] [059/133] (857s left) sysfs_heartbeat_interval (mixed)
[217.250945] Starting subtest: mixed
[217.252231] Starting dynamic subtest: vecs0
[222.523337] Dynamic subtest vecs0: SUCCESS (5.267s)
[222.540661] Starting dynamic subtest: vcs0
[227.790852] Dynamic subtest vcs0: SUCCESS (5.271s)
[227.813312] Starting dynamic subtest: bcs0
[233.051662] Dynamic subtest bcs0: SUCCESS (5.257s)
[233.076106] Starting dynamic subtest: rcs0
[238.313925] Dynamic subtest rcs0: SUCCESS (5.259s)
[238.315728] Subtest mixed: SUCCESS (21.063s)
[238.448488] [060/133] (836s left) kms_color (ctm-0-75)
[238.584664] Starting subtest: ctm-0-75
[238.586063] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.336960] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.754s)
[241.373554] Starting dynamic subtest: pipe-A-HDMI-A-2
[243.813799] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.472s)
[243.845182] Starting dynamic subtest: pipe-B-HDMI-A-1
[246.351340] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.536s)
[246.387313] Starting dynamic subtest: pipe-B-HDMI-A-2
[248.891231] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.533s)
[248.929416] Starting dynamic subtest: pipe-C-HDMI-A-1
[251.358146] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.466s)
[251.399543] Starting dynamic subtest: pipe-C-HDMI-A-2
[253.779845] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.416s)
[253.780973] Subtest ctm-0-75: SUCCESS (15.197s)
[254.085692] [061/133] (820s left) gem_pxp (reject-modify-context-protection-off-3)
[256.740818] Starting subtest: reject-modify-context-protection-off-3
[256.742469] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[256.888145] [062/133] (818s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[257.033132] Starting subtest: psr-rgb101010-draw-blt
[257.036311] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[257.170143] [063/133] (818s left) kms_cursor_legacy (forked-bo)
[257.323084] Starting subtest: forked-bo
[257.326050] Starting dynamic subtest: pipe-A
[262.798028] Dynamic subtest pipe-A: SUCCESS (5.469s)
[262.894742] Starting dynamic subtest: pipe-B
[268.231360] Dynamic subtest pipe-B: SUCCESS (5.435s)
[268.248970] Starting dynamic subtest: pipe-C
[273.651489] Dynamic subtest pipe-C: SUCCESS (5.417s)
[273.669553] Starting dynamic subtest: all-pipes
[279.082804] Dynamic subtest all-pipes: SUCCESS (5.430s)
[279.084221] Subtest forked-bo: SUCCESS (21.766s)
[279.268123] [064/133] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[279.414273] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[279.416305] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[279.553244] [065/133] (795s left) fbdev (unaligned-read)
[279.668912] Starting subtest: unaligned-read
[279.695531] Subtest unaligned-read: SUCCESS (0.027s)
[279.820174] [066/133] (795s left) gem_ctx_isolation (nonpriv-switch)
[279.944237] Starting subtest: nonpriv-switch
[279.953420] Starting dynamic subtest: rcs0
[280.782630] Dynamic subtest rcs0: SUCCESS (0.834s)
[280.801716] Starting dynamic subtest: bcs0
[282.170481] Dynamic subtest bcs0: SUCCESS (1.384s)
[282.198210] Starting dynamic subtest: vcs0
[283.002506] Dynamic subtest vcs0: SUCCESS (0.829s)
[283.029190] Starting dynamic subtest: vecs0
[283.839544] Dynamic subtest vecs0: SUCCESS (0.833s)
[283.841235] Subtest nonpriv-switch: SUCCESS (3.891s)
[284.089296] [067/133] (791s left) kms_psr (psr-sprite-mmap-gtt)
[284.230051] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[284.326428] [068/133] (791s left) gem_render_copy (yf-tiled-to-vebox-linear)
[284.449602] Starting subtest: yf-tiled-to-vebox-linear
[284.451762] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[284.705297] [069/133] (791s left) kms_content_protection (atomic)
[284.860994] Starting subtest: atomic
[284.915773] Subtest atomic: SKIP (0.049s)
[285.053561] [070/133] (790s left) syncobj_eventfd (timeline-wait-before-signal)
[285.157801] Starting subtest: timeline-wait-before-signal
[285.193315] Subtest timeline-wait-before-signal: SUCCESS (0.034s)
[285.339760] [071/133] (790s left) kms_flip (flip-vs-suspend)
[285.488245] Starting subtest: flip-vs-suspend
[285.492053] Starting dynamic subtest: A-HDMI-A1