[58.358395] Initializing watchdogs
[58.358445]   /dev/watchdog0
[58.373782] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.378398] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.380976] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.382903] [001/133] (960s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[58.494094] Starting subtest: yf-tiled-8bpp-rotate-180
[58.496104] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[58.583714] [002/133] (960s left) gem_mmap_gtt (pf-nonblock)
[58.646674] Subtest pf-nonblock: SKIP (0.000s)
[58.698836] [003/133] (960s left) gem_tiled_partial_pwrite_pread (reads)
[58.768850] Subtest reads: SKIP (0.000s)
[58.834174] [004/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[58.921652] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[58.923456] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[58.998371] [005/133] (960s left) kms_flip (blocking-absolute-wf_vblank)
[59.077666] Starting subtest: blocking-absolute-wf_vblank
[59.080353] Starting dynamic subtest: A-eDP1
[67.845460] Dynamic subtest A-eDP1: SUCCESS (8.735s)
[67.854373] Starting dynamic subtest: B-eDP1
[76.585556] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[76.592535] Starting dynamic subtest: C-eDP1
[85.288297] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[85.295966] Starting dynamic subtest: D-eDP1
[94.057803] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[94.059084] Subtest blocking-absolute-wf_vblank: SUCCESS (34.936s)
[95.225724] [006/133] (923s left) kms_atomic_transition (plane-toggle-modeset-transition)
[95.322585] Starting subtest: plane-toggle-modeset-transition
[95.323558] Starting dynamic subtest: pipe-A-eDP-1
[108.148467] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.825s)
[108.157590] Starting dynamic subtest: pipe-B-eDP-1
[120.574461] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.422s)
[120.575894] Subtest plane-toggle-modeset-transition: SUCCESS (25.252s)
[121.381179] [007/133] (897s left) gem_busy (semaphore)
[121.559554] Subtest semaphore: SKIP (0.000s)
[121.782280] [008/133] (897s left) kms_vblank (wait-forked-hang)
[121.881534] Starting subtest: wait-forked-hang
[121.882721] Starting dynamic subtest: pipe-A-eDP-1
[149.671375] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.788s)
[149.680879] Starting dynamic subtest: pipe-D-eDP-1
[174.687304] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[174.688264] Subtest wait-forked-hang: SUCCESS (52.804s)
[175.548587] [009/133] (843s left) syncobj_timeline (32bits-limit)
[175.590789] Starting subtest: 32bits-limit
[175.593137] Subtest 32bits-limit: SUCCESS (0.002s)
[175.704416] [010/133] (843s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[175.801983] Starting subtest: fbcpsr-modesetfrombusy
[181.929713] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.129s)
[182.061999] [011/133] (837s left) kms_atomic (plane-primary-legacy)
[182.159981] Starting subtest: plane-primary-legacy
[182.160877] Starting dynamic subtest: pipe-A-eDP-1
[182.615046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[182.616036] Subtest plane-primary-legacy: SUCCESS (0.455s)
[183.427051] [012/133] (835s left) gem_mmap (pf-nonblock)
[183.493121] Subtest pf-nonblock: SKIP (0.000s)
[183.551476] [013/133] (835s left) kms_flip (2x-plain-flip-ts-check)
[183.639470] Starting subtest: 2x-plain-flip-ts-check
[183.650829] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[183.722719] [014/133] (835s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[183.836553] Starting subtest: flip-vs-cursor-busy-crc-atomic
[184.642887] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.805s)
[185.462072] [015/133] (833s left) kms_content_protection (legacy)
[185.597118] Starting subtest: legacy
[185.599171] Subtest legacy: SKIP (0.000s)
[185.724637] [016/133] (833s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[185.781667] Starting subtest: y-tiled-ccs-to-x-tiled
[185.783445] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[185.968386] [017/133] (833s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[186.050705] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[186.051617] Starting dynamic subtest: pipe-A-eDP-1
[186.151483] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[186.158269] Starting dynamic subtest: pipe-B-eDP-1
[187.256491] Dynamic subtest pipe-B-eDP-1: SKIP (1.104s)
[187.258374] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.206s)
[188.461251] [018/133] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[188.554324] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[188.556024] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[188.640226] [019/133] (830s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[189.024498] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[189.840931] [020/133] (829s left) syncobj_wait (invalid-reset-illegal-handle)
[189.882264] Starting subtest: invalid-reset-illegal-handle
[189.883162] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[189.967398] [021/133] (829s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[190.057792] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[196.697951] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.640s)
[196.803415] [022/133] (822s left) vgem_basic (sysfs)
[196.887143] Starting subtest: sysfs
[196.888064] Subtest sysfs: SUCCESS (0.000s)
[196.937242] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[196.938865] [023/133] (822s left) i915_drm_fdinfo (idle)
[196.974510] Starting subtest: idle
[196.975373] Starting dynamic subtest: rcs0
[197.520768] Dynamic subtest rcs0: SUCCESS (0.544s)
[197.529843] Starting dynamic subtest: bcs0
[198.051095] Dynamic subtest bcs0: SUCCESS (0.522s)
[198.060322] Starting dynamic subtest: vcs0
[198.556525] Dynamic subtest vcs0: SUCCESS (0.504s)
[198.565344] Starting dynamic subtest: vcs1
[199.063694] Dynamic subtest vcs1: SUCCESS (0.504s)
[199.071484] Starting dynamic subtest: vecs0
[199.567096] Dynamic subtest vecs0: SUCCESS (0.504s)
[199.576505] Starting dynamic subtest: ccs0
[200.070555] Dynamic subtest ccs0: SUCCESS (0.502s)
[200.071841] Subtest idle: SUCCESS (3.087s)
[200.144500] [024/133] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[200.242524] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[200.244178] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.329606] [025/133] (819s left) gem_exec_schedule (preempt-hang)
[200.520038] Starting subtest: preempt-hang
[200.521058] Starting dynamic subtest: rcs0
[200.742676] Dynamic subtest rcs0: SUCCESS (0.235s)
[200.753096] Starting dynamic subtest: bcs0
[200.971719] Dynamic subtest bcs0: SUCCESS (0.228s)
[200.980839] Starting dynamic subtest: vcs0
[201.184940] Dynamic subtest vcs0: SUCCESS (0.213s)
[201.193964] Starting dynamic subtest: vcs1
[201.408722] Dynamic subtest vcs1: SUCCESS (0.224s)
[201.418834] Starting dynamic subtest: vecs0
[201.636376] Dynamic subtest vecs0: SUCCESS (0.225s)
[201.645847] Starting dynamic subtest: ccs0
[201.864017] Dynamic subtest ccs0: SUCCESS (0.229s)
[201.865036] Subtest preempt-hang: SUCCESS (1.357s)
[203.003235] [026/133] (816s left) gem_ctx_engines (independent)
[203.059572] Starting subtest: independent
[203.060613] Starting dynamic subtest: rcs0
[203.312732] Dynamic subtest rcs0: SUCCESS (0.244s)
[203.321293] Starting dynamic subtest: bcs0
[203.546263] Dynamic subtest bcs0: SUCCESS (0.233s)
[203.557864] Starting dynamic subtest: vcs0
[203.747304] Dynamic subtest vcs0: SUCCESS (0.201s)
[203.759444] Starting dynamic subtest: vcs1
[203.960930] Dynamic subtest vcs1: SUCCESS (0.213s)
[203.969922] Starting dynamic subtest: vecs0
[204.176748] Dynamic subtest vecs0: SUCCESS (0.215s)
[204.184803] Starting dynamic subtest: ccs0
[204.393259] Dynamic subtest ccs0: SUCCESS (0.216s)
[204.402080] Starting dynamic subtest: all-engines
[205.275484] Dynamic subtest all-engines: SUCCESS (0.882s)
[205.276537] Subtest independent: SUCCESS (2.208s)
[206.992137] [027/133] (812s left) kms_addfb_basic (bad-pitch-999)
[207.041285] Starting subtest: bad-pitch-999
[207.042310] Subtest bad-pitch-999: SUCCESS (0.000s)
[207.177852] [028/133] (812s left) gem_exec_params (cliprects_ptr-dirt)
[207.232062] Starting subtest: cliprects_ptr-dirt
[207.233116] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[207.316800] [029/133] (812s left) api_intel_bb (blit-noreloc-keep-cache)
[207.357931] Starting subtest: blit-noreloc-keep-cache
[207.365985] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[207.498743] [030/133] (812s left) kms_invalid_mode (bad-vtotal)
[207.583361] Starting subtest: bad-vtotal
[207.584236] Starting dynamic subtest: pipe-A-eDP-1
[207.866925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[207.874188] Starting dynamic subtest: pipe-B-eDP-1
[207.874967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[207.880858] Starting dynamic subtest: pipe-C-eDP-1
[207.881823] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[207.887710] Starting dynamic subtest: pipe-D-eDP-1
[207.888637] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[207.889480] Subtest bad-vtotal: SUCCESS (0.289s)
[208.735327] [031/133] (811s left) gem_workarounds (basic-read-fd)
[208.789841] Starting subtest: basic-read-fd
[208.800805] Subtest basic-read-fd: SUCCESS (0.011s)
[208.904791] [032/133] (810s left) gem_readwrite (write-bad-handle)
[208.946519] Subtest write-bad-handle: SKIP (0.000s)
[209.004232] [033/133] (810s left) prime_busy (hang-wait)
[209.053451] Starting subtest: hang-wait
[209.054441] Starting dynamic subtest: rcs0
[235.380044] Dynamic subtest rcs0: SUCCESS (26.325s)
[235.388040] Starting dynamic subtest: bcs0
[242.599849] Dynamic subtest bcs0: SUCCESS (7.220s)
[242.607526] Starting dynamic subtest: vcs0
[249.571128] Dynamic subtest vcs0: SUCCESS (6.969s)
[249.579061] Starting dynamic subtest: vcs1
[256.484482] Dynamic subtest vcs1: SUCCESS (6.913s)
[256.492187] Starting dynamic subtest: vecs0
[263.583941] Dynamic subtest vecs0: SUCCESS (7.098s)
[263.591997] Starting dynamic subtest: ccs0
[277.360465] Dynamic subtest ccs0: SUCCESS (13.774s)
[277.362675] Subtest hang-wait: SUCCESS (68.307s)
[277.484187] [034/133] (742s left) gem_ctx_persistence (legacy-engines-persistence)
[277.542455] Starting subtest: legacy-engines-persistence
[277.543405] Starting dynamic subtest: render
[278.354472] Dynamic subtest render: SUCCESS (0.812s)
[278.364895] Starting dynamic subtest: bsd1
[279.103039] Dynamic subtest bsd1: SUCCESS (0.744s)
[279.112054] Starting dynamic subtest: bsd2
[279.892727] Dynamic subtest bsd2: SUCCESS (0.790s)
[279.903894] Starting dynamic subtest: blt
[280.671502] Dynamic subtest blt: SUCCESS (0.777s)
[280.682146] Starting dynamic subtest: vebox
[281.424699] Dynamic subtest vebox: SUCCESS (0.751s)
[281.426020] Subtest legacy-engines-persistence: SUCCESS (3.882s)
[281.495787] [035/133] (738s left) gem_mmap_gtt (coherency)
[281.548408] Subtest coherency: SKIP (0.000s)
[281.622657] [036/133] (738s left) kms_rotation_crc (primary-rotation-90)
[281.718578] Starting subtest: primary-rotation-90
[281.720406] Subtest primary-rotation-90: SKIP (0.001s)
[281.802599] [037/133] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[281.887771] Starting subtest: psr-2p-primscrn-cur-indfb-move
[281.889553] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[281.981463] [038/133] (738s left) gem_exec_suspend (basic-s3-devices)
[282.045078] Starting subtest: basic-S3-devices
[282.046044] Starting dynamic subtest: smem
[293.920794] Dynamic subtest smem: SUCCESS (11.865s)
[293.922222] Subtest basic-S3-devices: SUCCESS (11.866s)
[300.109048] [039/133] (726s left) kms_cursor_crc (cursor-sliding-32x32)
[300.267091] Starting subtest: cursor-sliding-32x32
[300.311665] Subtest cursor-sliding-32x32: SKIP (0.044s)
[300.600571] [040/133] (725s left) perf_pmu (busy-idle-check-all)
[300.637097] Starting subtest: busy-idle-check-all
[300.638040] Starting dynamic subtest: rcs0
[301.290158] Dynamic subtest rcs0: SUCCESS (0.653s)
[301.302478] Starting dynamic subtest: bcs0
[301.941273] Dynamic subtest bcs0: SUCCESS (0.650s)
[301.952059] Starting dynamic subtest: vcs0
[303.902476] Dynamic subtest vcs0: SUCCESS (1.951s)
[303.912082] Starting dynamic subtest: vcs1
[305.950489] Dynamic subtest vcs1: SUCCESS (2.046s)
[305.960328] Starting dynamic subtest: vecs0
[307.870532] Dynamic subtest vecs0: SUCCESS (1.918s)
[307.883525] Starting dynamic subtest: ccs0
[308.520892] Dynamic subtest ccs0: SUCCESS (0.657s)
[308.522064] Subtest busy-idle-check-all: SUCCESS (7.885s)
[308.623705] [041/133] (717s left) gem_exec_flush (basic-uc-rw-default)
[308.684079] Starting subtest: basic-uc-rw-default
[314.157882] Subtest basic-uc-rw-default: SUCCESS (5.474s)
[314.344440] [042/133] (711s left) kms_busy (extended-pageflip-hang-oldfb)
[314.451892] Starting subtest: extended-pageflip-hang-oldfb
[314.452797] Starting dynamic subtest: pipe-A
[314.852407] Dynamic subtest pipe-A: SUCCESS (0.400s)
[314.861329] Starting dynamic subtest: pipe-D
[315.994539] Dynamic subtest pipe-D: SUCCESS (1.139s)
[315.995429] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.543s)
[316.840270] [043/133] (709s left) gem_exec_whisper (basic-fds)
[316.898342] Starting subtest: basic-fds
[323.000268] Subtest basic-fds: SUCCESS (6.101s)
[323.179241] [044/133] (703s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[323.281714] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[323.282620] Starting dynamic subtest: pipe-A-eDP-1
[329.138113] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.857s)
[329.154396] Starting dynamic subtest: pipe-B-eDP-1
[335.776917] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.637s)
[335.777926] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.496s)
[336.640255] [045/133] (689s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[336.738072] Starting subtest: y-tiled-8bpp-rotate-0
[336.739769] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[336.826329] [046/133] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[336.922940] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[344.682959] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.762s)
[344.830496] [047/133] (681s left) kms_flip (2x-flip-vs-dpms)
[344.922984] Starting subtest: 2x-flip-vs-dpms
[344.936076] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[345.011845] [048/133] (681s left) kms_plane_multiple (2x-tiling-none)
[345.094706] Starting subtest: 2x-tiling-none
[345.096428] Subtest 2x-tiling-none: SKIP (0.000s)
[345.163836] [049/133] (681s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[345.218597] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[345.220447] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[345.395602] [050/133] (681s left) kms_prop_blob (blob-prop-core)
[345.439583] Starting subtest: blob-prop-core
[345.440636] Subtest blob-prop-core: SUCCESS (0.000s)
[345.537718] [051/133] (681s left) api_intel_bb (intel-bb-blit-y)
[345.576257] Starting subtest: intel-bb-blit-y
[349.311727] Subtest intel-bb-blit-y: SUCCESS (3.727s)
[349.405899] [052/133] (677s left) gem_exec_fence (syncobj-wait)
[349.895603] Starting subtest: syncobj-wait
[350.968509] Subtest syncobj-wait: SUCCESS (1.065s)
[351.287145] [053/133] (675s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[351.377863] Starting subtest: multiplane-rotation-cropping-bottom
[368.817751] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.439s)
[368.937703] [054/133] (657s left) gem_ctx_param (vm)
[368.995528] Starting subtest: vm
[369.045826] Subtest vm: SUCCESS (0.050s)
[369.182808] [055/133] (657s left) kms_universal_plane (universal-plane-sanity)
[369.277420] Starting subtest: universal-plane-sanity
[369.278353] Starting dynamic subtest: pipe-A-eDP-1
[369.882672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[369.891432] Starting dynamic subtest: pipe-B-eDP-1
[371.125637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s)
[371.134923] Starting dynamic subtest: pipe-C-eDP-1
[372.335817] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s)
[372.343340] Starting dynamic subtest: pipe-D-eDP-1
[373.555728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[373.556931] Subtest universal-plane-sanity: SUCCESS (4.278s)
[374.421277] [056/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[374.508938] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[374.510746] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[374.627291] [057/133] (652s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[374.729077] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[378.827053] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.097s)
[380.025077] [058/133] (646s left) i915_pm_rpm (gem-execbuf)
[382.046360] Starting subtest: gem-execbuf
[382.047577] Starting dynamic subtest: smem0
[383.769196] Dynamic subtest smem0: SUCCESS (1.722s)
[383.770134] Subtest gem-execbuf: SUCCESS (1.724s)
[383.875867] [059/133] (642s left) kms_cursor_legacy (single-move)
[384.004910] Starting subtest: single-move
[384.005795] Starting dynamic subtest: pipe-A
[389.432761] Dynamic subtest pipe-A: SUCCESS (5.379s)
[389.443412] Starting dynamic subtest: pipe-B
[394.815748] Dynamic subtest pipe-B: SUCCESS (5.380s)
[394.825965] Starting dynamic subtest: pipe-C
[400.198336] Dynamic subtest pipe-C: SUCCESS (5.379s)
[400.208534] Starting dynamic subtest: pipe-D
[405.580908] Dynamic subtest pipe-D: SUCCESS (5.379s)
[405.591497] Starting dynamic subtest: all-pipes
[410.970930] Dynamic subtest all-pipes: SUCCESS (5.387s)
[410.972308] Subtest single-move: SUCCESS (26.919s)
[411.064431] [060/133] (615s left) i915_module_load (resize-bar)
[411.103703] Starting subtest: resize-bar
[411.109855] Subtest resize-bar: SKIP (0.006s)
[411.149585] [061/133] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[411.259892] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[417.827821] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.568s)
[417.926243] [062/133] (609s left) gem_sync (basic-store-each)
[417.984827] Starting subtest: basic-store-each
[420.263318] Subtest basic-store-each: SUCCESS (2.279s)
[420.442442] [063/133] (606s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[420.495621] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[420.496867] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[420.588267] [064/133] (606s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[420.701529] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[420.703536] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[420.817014] [065/133] (606s left) gem_ctx_bad_destroy (invalid-default-ctx)
[420.871553] Starting subtest: invalid-default-ctx
[420.872608] Subtest invalid-default-ctx: SUCCESS (0.000s)
[420.941409] [066/133] (606s left) kms_big_fb (linear-8bpp-rotate-90)
[421.041905] Starting subtest: linear-8bpp-rotate-90
[421.063451] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[421.177033] [067/133] (605s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[421.267236] Starting subtest: fbc-rgb565-draw-pwrite
[425.973391] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.705s)
[427.167696] [068/133] (599s left) kms_pipe_crc_basic (suspend-read-crc)
[427.257417] Starting subtest: suspend-read-crc
[427.258377] Starting dynamic subtest: pipe-A-eDP-1
[445.640741] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.018s)
[445.653313] Starting dynamic subtest: pipe-B-eDP-1
[464.591366] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.544s)
[464.601152] Starting dynamic subtest: pipe-C-eDP-1
[483.568671] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.405s)
[483.576891] Starting dynamic subtest: pipe-D-eDP-1
[502.592335] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.491s)
[502.593214] Subtest suspend-read-crc: SUCCESS (13.465s)
[508.464964] [069/133] (523s left) kms_cursor_crc (cursor-offscreen-32x10)
[508.638472] Starting subtest: cursor-offscreen-32x10
[508.682914] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[508.931379] [070/133] (523s left) gem_exec_balancer (smoke)
[508.992250] Starting subtest: smoke
[531.760254] Subtest smoke: SUCCESS (22.673s)
[532.619681] [071/133] (499s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[532.678340] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[532.680430] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[532.781901] [072/133] (499s left) kms_plane (planar-pixel-format-settings)
[532.868635] Starting subtest: planar-pixel-format-settings
[532.941366] Subtest planar-pixel-format-settings: SUCCESS (0.073s)
[533.050684] [073/133] (499s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[533.127903] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[533.129653] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[533.194566] [074/133] (499s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[533.295716] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[533.297624] Starting dynamic subtest: pipe-A-eDP-1
[533.305867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[533.315998] Starting dynamic subtest: pipe-B-eDP-1
[533.323315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[533.331372] Starting dynamic subtest: pipe-C-eDP-1
[533.338804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[533.346418] Starting dynamic subtest: pipe-D-eDP-1
[533.353870] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[533.354697] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.011s)
[535.597902] [075/133] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[535.691034] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[535.692911] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[535.794904] [076/133] (496s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[535.846128] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[535.904179] [077/133] (496s left) kms_psr (pr-sprite-blt)
[535.997101] Starting subtest: pr-sprite-blt
[535.998903] Subtest pr-sprite-blt: SKIP (0.000s)
[536.079615] [078/133] (496s left) kms_chamelium_color (ctm-max)
[536.158070] Subtest ctm-max: SKIP (0.000s)
[536.199096] [079/133] (496s left) syncobj_wait (single-wait-submitted)
[536.252596] Starting subtest: single-wait-submitted
[536.354227] Subtest single-wait-submitted: SUCCESS (0.101s)
[536.424927] [080/133] (496s left) gem_spin_batch (resubmit-new)
[536.480811] Starting subtest: resubmit-new
[536.481740] Starting dynamic subtest: rcs0
[536.489751] Dynamic subtest rcs0: SUCCESS (0.009s)
[536.499622] Starting dynamic subtest: bcs0
[536.500424] Dynamic subtest bcs0: SUCCESS (0.005s)
[536.508415] Starting dynamic subtest: vcs0
[536.509585] Dynamic subtest vcs0: SUCCESS (0.004s)
[536.517780] Starting dynamic subtest: vcs1
[536.518698] Dynamic subtest vcs1: SUCCESS (0.004s)
[536.526628] Starting dynamic subtest: vecs0
[536.527459] Dynamic subtest vecs0: SUCCESS (0.003s)
[536.535206] Starting dynamic subtest: ccs0
[536.536131] Dynamic subtest ccs0: SUCCESS (0.004s)
[536.537005] Subtest resubmit-new: SUCCESS (0.033s)
[537.847851] [081/133] (494s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[537.977916] Starting subtest: 2x-long-flip-vs-cursor-legacy
[537.981386] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[538.116498] [082/133] (494s left) gem_set_tiling_vs_pwrite
[538.223695] [083/133] (494s left) gem_mmap_gtt (cpuset-medium-copy)
[538.270048] Subtest cpuset-medium-copy: SKIP (0.000s)
[538.337917] [084/133] (494s left) gem_softpin (evict-active)
[538.396535] Starting subtest: evict-active
[538.401313] Subtest evict-active: SUCCESS (0.006s)
[538.485498] [085/133] (494s left) kms_feature_discovery (display-3x)
[538.563945] Starting subtest: display-3x
[538.565712] Subtest display-3x: SKIP (0.000s)
[538.633369] [086/133] (494s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[538.718988] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[538.720779] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[538.798516] [087/133] (494s left) kms_color_pipeline (plane-lut1d-lut1d)
[538.885671] Starting subtest: plane-lut1d-lut1d
[539.055381] Starting dynamic subtest: pipe-A-plane-0
[539.232998] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[539.241804] Starting dynamic subtest: pipe-A-plane-1
[539.422102] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[539.430257] Starting dynamic subtest: pipe-A-plane-2
[539.610943] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[540.843676] Starting dynamic subtest: pipe-B-plane-0
[541.013544] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[541.022071] Starting dynamic subtest: pipe-B-plane-1
[541.180240] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[541.188740] Starting dynamic subtest: pipe-B-plane-2
[541.335617] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[542.526923] Starting dynamic subtest: pipe-C-plane-0
[542.652199] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[542.662219] Starting dynamic subtest: pipe-C-plane-1
[542.796662] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[542.807206] Starting dynamic subtest: pipe-C-plane-2
[542.963474] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[544.170703] Starting dynamic subtest: pipe-D-plane-0
[544.329636] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[544.337801] Starting dynamic subtest: pipe-D-plane-1
[544.463167] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[544.471240] Starting dynamic subtest: pipe-D-plane-2
[544.629673] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[544.914512] Subtest plane-lut1d-lut1d: SUCCESS (6.030s)
[545.715529] [088/133] (487s left) gem_mmap_wc (write-gtt-read-wc)
[545.774156] Subtest write-gtt-read-wc: SKIP (0.000s)
[545.824738] [089/133] (487s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[545.921873] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[546.923246] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.002s)
[547.032675] [090/133] (485s left) gem_exec_fence (invalid-timeline-fence-array)
[547.623736] Starting subtest: invalid-timeline-fence-array
[547.624788] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[548.886020] [091/133] (484s left) kms_lease (lease-unleased-crtc)
[548.982843] Starting subtest: lease-unleased-crtc
[548.983624] Starting dynamic subtest: pipe-A-eDP-1
[549.276728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[549.285880] Starting dynamic subtest: pipe-B-eDP-1
[550.073290] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s)
[550.081780] Starting dynamic subtest: pipe-C-eDP-1
[550.082583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[550.090717] Starting dynamic subtest: pipe-D-eDP-1
[550.091450] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[550.092185] Subtest lease-unleased-crtc: SUCCESS (1.105s)
[550.457140] [092/133] (482s left) kms_pm_dc (dc6-dpms)
[551.545042] Starting subtest: dc6-dpms
[556.932341] Subtest dc6-dpms: SUCCESS (5.377s)
[557.047801] [093/133] (476s left) gem_exec_balancer (parallel-bb-first)
[557.320210] Starting subtest: parallel-bb-first
[558.383948] Subtest parallel-bb-first: SUCCESS (1.063s)
[558.830366] [094/133] (474s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[558.924776] Starting subtest: fbc-psr2-sprite-mmap-cpu
[558.925707] Starting dynamic subtest: eDP-1
[558.927427] Dynamic subtest eDP-1: SKIP (0.000s)
[558.929254] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[559.006325] [095/133] (474s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[559.091903] Starting subtest: fbc-psr2-cursor-mmap-cpu
[559.092933] Starting dynamic subtest: eDP-1
[559.094648] Dynamic subtest eDP-1: SKIP (0.000s)
[559.096248] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[559.174363] [096/133] (474s left) kms_fbcon_fbt (fbc)
[559.241901] Starting subtest: fbc
[565.616050] Subtest fbc: SUCCESS (6.360s)
[566.685718] [097/133] (466s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[566.774125] Starting subtest: 4-tiled-64bpp-rotate-90
[566.799788] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.025s)
[566.919918] [098/133] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[567.010794] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[567.012460] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[567.098772] [099/133] (466s left) gen9_exec_parse (allowed-all)
[567.157681] Subtest allowed-all: SKIP (0.000s)
[567.229930] [100/133] (466s left) kms_psr (psr-cursor-plane-onoff)
[567.307798] Starting subtest: psr-cursor-plane-onoff
[567.308794] Starting dynamic subtest: eDP-1
[568.995114] Dynamic subtest eDP-1: SUCCESS (1.685s)
[568.996043] Subtest psr-cursor-plane-onoff: SUCCESS (1.686s)
[569.852956] [101/133] (463s left) core_setmaster (master-drop-set-shared-fd)
[569.943812] Starting subtest: master-drop-set-shared-fd
[569.964153] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[569.995095] [102/133] (463s left) kms_pm_rpm (legacy-planes-dpms)
[571.917105] Starting subtest: legacy-planes-dpms
[571.918364] Starting dynamic subtest: plane-65
[580.232821] Dynamic subtest plane-65: SUCCESS (8.312s)
[580.244988] Starting dynamic subtest: plane-95
[588.640966] Dynamic subtest plane-95: SUCCESS (8.402s)
[588.653938] Starting dynamic subtest: plane-125
[597.163469] Dynamic subtest plane-125: SUCCESS (8.506s)
[597.174369] Starting dynamic subtest: plane-135
[605.450524] Dynamic subtest plane-135: SUCCESS (8.291s)
[605.453440] Subtest legacy-planes-dpms: SUCCESS (33.523s)
[605.841876] [103/133] (427s left) perf_pmu (interrupts)
[605.879603] Starting subtest: interrupts
[606.964825] Subtest interrupts: SUCCESS (1.077s)
[607.066131] [104/133] (426s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[607.122889] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[607.125181] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[607.303168] [105/133] (426s left) gem_userptr_blits (unsync-unmap)
[607.366111] Subtest unsync-unmap: SKIP (0.000s)
[607.475802] [106/133] (426s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[607.565987] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[607.566866] Starting dynamic subtest: pipe-A-eDP-1
[607.575050] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[607.583659] Starting dynamic subtest: pipe-B-eDP-1
[607.591687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[607.600025] Starting dynamic subtest: pipe-C-eDP-1
[607.607820] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[607.615945] Starting dynamic subtest: pipe-D-eDP-1
[607.624306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[607.626001] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[609.906908] [107/133] (423s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[609.996031] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[609.997983] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[610.067565] [108/133] (423s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[610.152790] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[610.153740] Starting dynamic subtest: pipe-A-eDP-1
[610.587908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[610.598392] Starting dynamic subtest: pipe-B-eDP-1
[610.606887] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[610.615203] Starting dynamic subtest: pipe-C-eDP-1
[610.622920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[610.631045] Starting dynamic subtest: pipe-D-eDP-1
[610.638275] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[610.639083] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.450s)
[612.867470] [109/133] (420s left) syncobj_timeline (signal)
[612.921285] Starting subtest: signal
[612.922202] Subtest signal: SUCCESS (0.000s)
[613.018023] [110/133] (420s left) gem_exec_schedule (u-semaphore-resolve)
[613.073652] Starting subtest: u-semaphore-resolve
[613.107382] Subtest u-semaphore-resolve: SUCCESS (0.035s)
[613.435594] [111/133] (420s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[613.519060] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[618.011958] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.494s)
[619.182336] [112/133] (414s left) syncobj_wait (wait-for-submit-snapshot)
[619.232674] Starting subtest: wait-for-submit-snapshot
[619.315058] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[619.387548] [113/133] (414s left) gem_exec_whisper (basic-queues-forked-all)
[619.434708] Starting subtest: basic-queues-forked-all
[638.976237] Subtest basic-queues-forked-all: SUCCESS (19.531s)
[639.150677] [114/133] (394s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[639.254945] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[639.256725] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[639.323491] [115/133] (394s left) gem_render_copy_redux (flink)
[639.379807] Starting subtest: flink
[640.105359] Subtest flink: SUCCESS (0.725s)
[640.225339] [116/133] (393s left) gem_exec_alignment (forked)
[640.290886] Starting subtest: forked
[679.730738] Subtest forked: SUCCESS (39.387s)
[679.767567] [117/133] (354s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[679.907624] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[679.909516] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[680.003697] [118/133] (354s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[680.099598] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[680.101385] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[680.207671] [119/133] (353s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[680.584328] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[681.383238] [120/133] (352s left) gem_linear_blits (normal)
[681.555481] Starting subtest: normal
[684.956713] Subtest normal: SUCCESS (3.392s)
[685.080137] [121/133] (349s left) perf (gen12-group-exclusive-stream-sample-oa)
[685.273987] Starting subtest: gen12-group-exclusive-stream-sample-oa
[685.299420] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.025s)
[685.345249] [122/133] (348s left) sysfs_preempt_timeout (timeout)
[685.412829] Starting subtest: timeout
[685.413726] Starting dynamic subtest: vecs0
[694.790815] Dynamic subtest vecs0: SUCCESS (9.364s)
[694.801915] Starting dynamic subtest: ccs0
[696.086860] Dynamic subtest ccs0: SUCCESS (1.304s)
[696.098748] Starting dynamic subtest: vcs0
[705.797764] Dynamic subtest vcs0: SUCCESS (9.697s)
[705.814920] Starting dynamic subtest: bcs0
[707.016495] Dynamic subtest bcs0: SUCCESS (1.225s)
[707.029422] Starting dynamic subtest: rcs0
[708.256946] Dynamic subtest rcs0: SUCCESS (1.238s)
[708.270002] Starting dynamic subtest: vcs1
[717.770819] Dynamic subtest vcs1: SUCCESS (9.501s)
[717.771978] Subtest timeout: SUCCESS (32.340s)
[717.846232] [123/133] (316s left) syncobj_basic (bad-destroy)
[717.904805] Starting subtest: bad-destroy
[717.905610] Subtest bad-destroy: SUCCESS (0.000s)
[717.996902] [124/133] (316s left) gem_userptr_blits (relocations)
[718.050100] Starting subtest: relocations
[718.051755] Subtest relocations: SKIP (0.000s)
[718.172229] [125/133] (316s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[718.217119] Starting subtest: multi-wait-for-submit-available-submitted
[718.218025] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[718.315048] [126/133] (316s left) kms_3d (basic)
[718.365305] Starting subtest: basic
[720.355707] Subtest basic: SUCCESS (1.991s)
[720.856279] [127/133] (313s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[720.944733] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[720.945514] Starting dynamic subtest: pipe-A-eDP-1
[720.974124] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[720.986294] Starting dynamic subtest: pipe-B-eDP-1
[721.008760] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[721.017496] Starting dynamic subtest: pipe-C-eDP-1
[721.038073] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[721.049119] Starting dynamic subtest: pipe-D-eDP-1
[721.071534] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[721.073213] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[723.137892] [128/133] (311s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[723.233662] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[723.235242] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[723.328241] [129/133] (311s left) gem_wait (write-wait)
[723.387098] Starting subtest: write-wait
[723.388096] Starting dynamic subtest: all-engines
[724.465472] Dynamic subtest all-engines: SUCCESS (1.078s)
[724.482282] Starting dynamic subtest: rcs0
[725.528998] Dynamic subtest rcs0: SUCCESS (1.061s)
[725.550476] Starting dynamic subtest: bcs0
[726.593970] Dynamic subtest bcs0: SUCCESS (1.062s)
[726.614025] Starting dynamic subtest: vcs0
[727.649334] Dynamic subtest vcs0: SUCCESS (1.054s)
[727.667278] Starting dynamic subtest: vcs1
[728.705674] Dynamic subtest vcs1: SUCCESS (1.054s)
[728.724672] Starting dynamic subtest: vecs0
[729.761353] Dynamic subtest vecs0: SUCCESS (1.053s)
[729.780582] Starting dynamic subtest: ccs0
[730.820368] Dynamic subtest ccs0: SUCCESS (1.057s)
[730.823327] Subtest write-wait: SUCCESS (7.432s)
[731.031589] [130/133] (303s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[731.126933] Starting subtest: plane-upscale-20x20-with-rotation
[731.127849] Starting dynamic subtest: pipe-A
[731.354070] Dynamic subtest pipe-A: SUCCESS (0.228s)
[731.364508] Starting dynamic subtest: pipe-B
[732.704423] Dynamic subtest pipe-B: SUCCESS (1.348s)
[732.713431] Starting dynamic subtest: pipe-C
[733.994217] Dynamic subtest pipe-C: SUCCESS (1.289s)
[734.004640] Starting dynamic subtest: pipe-D
[735.286182] Dynamic subtest pipe-D: SUCCESS (1.291s)
[735.287127] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.161s)
[736.439930] [131/133] (298s left) gem_mmap_wc (invalid-flags)
[736.485643] Subtest invalid-flags: SKIP (0.000s)
[736.554814] [132/133] (297s left) kms_cursor_crc (cursor-sliding-128x128)
[736.745861] Starting subtest: cursor-sliding-128x128
[736.749936] Starting dynamic subtest: pipe-A-eDP-1
[740.008393] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.260s)
[740.043568] Starting dynamic subtest: pipe-D-eDP-1
[743.903557] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.868s)
[743.904437] Subtest cursor-sliding-128x128: SUCCESS (7.159s)
[744.744359] [133/133] (289s left) i915_query (hwconfig_table)
[744.804429] Starting subtest: hwconfig_table
[744.911938] Subtest hwconfig_table: SUCCESS (0.001s)
[744.941416] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: gem_busy
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_atomic
results: parsing output: 11/ for test: gem_mmap
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_psr2_sf
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: gem_ctx_engines
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: gem_workarounds
results: parsing output: 31/ for test: gem_readwrite
results: parsing output: 32/ for test: prime_busy
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_rotation_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_suspend
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_flush
results: parsing output: 41/ for test: kms_busy
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_plane_multiple
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_prop_blob
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: kms_universal_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: i915_module_load
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_sync
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_ctx_bad_destroy
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_pipe_crc_basic
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_pipe_b_c_ivb
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_feature_discovery
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_pm_dc
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_fbcon_fbt
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: core_setmaster
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: gem_render_copy_redux
results: parsing output: 115/ for test: gem_exec_alignment
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: gem_linear_blits
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: sysfs_preempt_timeout
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_3d
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: gem_mmap_wc
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: i915_query
Done.