[34.718520] Initializing watchdogs
[34.718599]   /dev/watchdog0
[34.724512] [001/141] (960s left) kms_hdr (bpc-switch)
[36.704478] Starting subtest: bpc-switch
[36.706555] Subtest bpc-switch: SKIP (0.000s)
[36.774660] [002/141] (958s left) gem_exec_reloc (basic-write-wc)
[36.863902] Subtest basic-write-wc: SKIP (0.000s)
[36.897588] [003/141] (958s left) i915_pm_rpm (system-suspend-devices)
[41.451758] Starting subtest: system-suspend-devices
[51.008012] Subtest system-suspend-devices: SUCCESS (9.556s)
[57.156901] [004/141] (943s left) gem_exec_schedule (u-submit-early-slice)
[57.245432] Starting subtest: u-submit-early-slice
[57.246306] Starting dynamic subtest: rcs0
[57.296035] Dynamic subtest rcs0: SUCCESS (0.050s)
[57.302128] Starting dynamic subtest: bcs0
[57.337396] Dynamic subtest bcs0: SUCCESS (0.039s)
[57.342970] Starting dynamic subtest: vcs0
[57.381563] Dynamic subtest vcs0: SUCCESS (0.046s)
[57.388342] Starting dynamic subtest: vcs1
[57.419069] Dynamic subtest vcs1: SUCCESS (0.037s)
[57.424828] Starting dynamic subtest: vecs0
[57.453790] Dynamic subtest vecs0: SUCCESS (0.034s)
[57.454675] Subtest u-submit-early-slice: SUCCESS (0.208s)
[57.824558] [005/141] (942s left) kms_chamelium_frames (vga-frame-dump)
[59.836398] Subtest vga-frame-dump: SKIP (0.000s)
[59.894595] [006/141] (940s left) gem_mmap_wc (read-write-distinct)
[59.966939] Subtest read-write-distinct: SKIP (0.000s)
[59.991816] [007/141] (940s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[61.965458] Starting subtest: fbcpsr-shrfb-scaledprimary
[61.967212] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[62.048695] [008/141] (938s left) kms_flip (dpms-vs-vblank-race-interruptible)
[63.104663] Starting subtest: dpms-vs-vblank-race-interruptible
[63.115619] Starting dynamic subtest: A-HDMI-A4
[66.116906] Dynamic subtest A-HDMI-A4: SUCCESS (3.001s)
[66.122868] Starting dynamic subtest: B-HDMI-A4
[69.082292] Dynamic subtest B-HDMI-A4: SUCCESS (2.965s)
[69.088941] Starting dynamic subtest: C-HDMI-A4
[72.045160] Dynamic subtest C-HDMI-A4: SUCCESS (2.963s)
[72.051056] Starting dynamic subtest: D-HDMI-A4
[74.956624] Dynamic subtest D-HDMI-A4: SUCCESS (2.910s)
[74.957642] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.851s)
[75.088712] [009/141] (925s left) i915_suspend (forcewake)
[75.166973] Starting subtest: forcewake
[116.912621] Subtest forcewake: SUCCESS (17.532s)
[123.989095] [010/141] (907s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[125.987615] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[127.085039] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.092s)
[127.198126] [011/141] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[129.189726] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[129.192557] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[129.262778] [012/141] (902s left) api_intel_bb (object-reloc-keep-cache)
[129.343178] Starting subtest: object-reloc-keep-cache
[129.346347] Subtest object-reloc-keep-cache: SKIP (0.002s)
[129.439816] [013/141] (902s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[131.445594] Starting subtest: fbc-farfromfence-mmap-gtt
[131.447570] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[131.529713] [014/141] (900s left) kms_flip (flip-vs-expired-vblank)
[132.579390] Starting subtest: flip-vs-expired-vblank
[132.590227] Starting dynamic subtest: A-HDMI-A4
[140.357323] Dynamic subtest A-HDMI-A4: SUCCESS (7.767s)
[140.364566] Starting dynamic subtest: B-HDMI-A4
[148.052591] Dynamic subtest B-HDMI-A4: SUCCESS (7.695s)
[148.059167] Starting dynamic subtest: C-HDMI-A4
[155.741582] Dynamic subtest C-HDMI-A4: SUCCESS (7.688s)
[155.748432] Starting dynamic subtest: D-HDMI-A4
[163.426323] Dynamic subtest D-HDMI-A4: SUCCESS (7.684s)
[163.427204] Subtest flip-vs-expired-vblank: SUCCESS (30.847s)
[163.583751] [015/141] (868s left) feature_discovery (chamelium)
[165.589297] Starting subtest: chamelium
[165.593152] Subtest chamelium: SKIP (0.001s)
[165.658483] [016/141] (866s left) gem_eio (wait-wedge-immediate)
[165.838287] Starting subtest: wait-wedge-immediate
[167.494294] Subtest wait-wedge-immediate: SUCCESS (1.659s)
[169.523821] [017/141] (862s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[171.513765] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[174.482604] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.971s)
[174.619558] [018/141] (857s left) vgem_slow (nohang)
[174.765642] Starting subtest: nohang
[184.945565] Subtest nohang: SUCCESS (10.177s)
[185.005219] [019/141] (846s left) perf_pmu (invalid-init)
[185.076469] Starting subtest: invalid-init
[185.077319] Subtest invalid-init: SUCCESS (0.000s)
[185.149880] [020/141] (846s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[187.136119] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[190.330773] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.197s)
[190.470222] [021/141] (841s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[192.823097] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs
[192.824993] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[193.003699] [022/141] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[194.984530] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[194.986529] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[195.069797] [023/141] (836s left) gem_unfence_active_buffers
[195.245563] [024/141] (836s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[195.330414] Starting subtest: y-tiled-ccs-to-y-tiled
[195.331326] Starting dynamic subtest: smem
[195.417409] Dynamic subtest smem: SUCCESS (0.086s)
[195.424309] Starting dynamic subtest: lmem0
[196.344108] Dynamic subtest lmem0: SUCCESS (0.923s)
[196.345055] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (1.011s)
[196.569858] [025/141] (835s left) kms_prop_blob (blob-prop-lifetime)
[196.640543] Starting subtest: blob-prop-lifetime
[196.641506] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[196.703718] [026/141] (835s left) gem_mmap_gtt (medium-copy-odd)
[196.776421] Subtest medium-copy-odd: SKIP (0.000s)
[196.811085] [027/141] (835s left) kms_rotation_crc (sprite-rotation-90)
[198.788813] Starting subtest: sprite-rotation-90
[206.381892] Subtest sprite-rotation-90: SUCCESS (7.594s)
[206.581858] [028/141] (825s left) kms_ccs (pipe-b-random-ccs-data-yf_tiled_ccs)
[208.747512] Starting subtest: pipe-B-random-ccs-data-yf_tiled_ccs
[208.750641] Subtest pipe-B-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[209.100661] [029/141] (822s left) gem_mmap_gtt (big-bo-tiledx)
[209.171212] Subtest big-bo-tiledX: SKIP (0.000s)
[209.190412] [030/141] (822s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[211.167884] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[211.170027] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[211.248409] [031/141] (820s left) i915_pm_dc (dc3co-vpb-simulation)
[214.244400] Starting subtest: dc3co-vpb-simulation
[214.246684] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[214.508902] [032/141] (817s left) device_reset (cold-reset-bound)
[214.664261] Subtest cold-reset-bound: SKIP (0.000s)
[214.713724] [033/141] (817s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[214.782318] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[214.887841] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[214.958496] [034/141] (817s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[215.047506] Subtest get-values-invalid-pointer: SKIP (0.000s)
[215.097260] [035/141] (816s left) kms_chamelium_color (degamma)
[217.074308] Subtest degamma: SKIP (0.000s)
[217.106964] [036/141] (814s left) gem_exec_schedule (preempt-hang)
[217.309844] Starting subtest: preempt-hang
[217.312136] Starting dynamic subtest: rcs0
[217.654428] Dynamic subtest rcs0: SUCCESS (0.345s)
[217.661522] Starting dynamic subtest: bcs0
[217.942224] Dynamic subtest bcs0: SUCCESS (0.287s)
[217.949555] Starting dynamic subtest: vcs0
[218.229584] Dynamic subtest vcs0: SUCCESS (0.287s)
[218.236688] Starting dynamic subtest: vcs1
[218.517178] Dynamic subtest vcs1: SUCCESS (0.287s)
[218.524355] Starting dynamic subtest: vecs0
[218.833471] Dynamic subtest vecs0: SUCCESS (0.316s)
[218.834275] Subtest preempt-hang: SUCCESS (1.527s)
[219.128949] [037/141] (812s left) gem_vm_create (invalid-destroy)
[219.209912] Starting subtest: invalid-destroy
[219.212045] Subtest invalid-destroy: SUCCESS (0.002s)
[219.309070] [038/141] (812s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[221.714585] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[221.718674] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.003s)
[221.820095] [039/141] (810s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[223.802710] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[226.919930] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.119s)
[227.053881] [040/141] (805s left) kms_vblank (pipe-a-wait-forked-busy)
[229.030860] Starting subtest: pipe-A-wait-forked-busy
[231.475536] Subtest pipe-A-wait-forked-busy: SUCCESS (2.446s)
[231.579207] [041/141] (800s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[233.567074] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[233.568988] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[233.647157] [042/141] (798s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[235.731404] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[235.733378] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[236.194388] [043/141] (796s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[236.265539] Starting subtest: multi-wait-for-submit-submitted-signaled
[236.266490] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[236.327619] [044/141] (795s left) gem_lmem_swapping (parallel-random-verify)
[240.213460] Starting subtest: parallel-random-verify
[240.214190] Starting dynamic subtest: lmem0
[249.893573] Dynamic subtest lmem0: SUCCESS (9.676s)
[249.894465] Subtest parallel-random-verify: SUCCESS (9.677s)
[251.219717] [045/141] (781s left) gem_busy (parallel)
[253.818416] Starting subtest: parallel
[253.819161] Starting dynamic subtest: rcs0
[253.911108] Dynamic subtest rcs0: SUCCESS (0.092s)
[253.917508] Starting dynamic subtest: bcs0
[253.961963] Dynamic subtest bcs0: SUCCESS (0.050s)
[253.968363] Starting dynamic subtest: vcs0
[254.012944] Dynamic subtest vcs0: SUCCESS (0.050s)
[254.019323] Starting dynamic subtest: vcs1
[254.062243] Dynamic subtest vcs1: SUCCESS (0.049s)
[254.068666] Starting dynamic subtest: vecs0
[254.111939] Dynamic subtest vecs0: SUCCESS (0.049s)
[254.112730] Subtest parallel: SUCCESS (0.294s)
[254.643043] [046/141] (777s left) kms_dp_tiled_display (basic-test-pattern-with-chamelium)
[256.625487] Starting subtest: basic-test-pattern-with-chamelium
[256.627193] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[256.693572] [047/141] (775s left) kms_color (ctm-red-to-blue)
[258.680940] Starting subtest: ctm-red-to-blue
[258.681931] Starting dynamic subtest: pipe-A
[259.284494] Dynamic subtest pipe-A: SUCCESS (0.603s)
[259.293001] Starting dynamic subtest: pipe-B
[260.112416] Dynamic subtest pipe-B: SUCCESS (0.827s)
[260.125879] Starting dynamic subtest: pipe-C
[261.331575] Dynamic subtest pipe-C: SUCCESS (1.219s)
[261.339711] Starting dynamic subtest: pipe-D
[262.925243] Dynamic subtest pipe-D: SUCCESS (1.594s)
[262.926195] Subtest ctm-red-to-blue: SUCCESS (4.245s)
[263.046804] [048/141] (769s left) gem_exec_whisper (basic-fds-priority)
[263.127843] Starting subtest: basic-fds-priority
[285.482425] Subtest basic-fds-priority: SUCCESS (22.350s)
[285.646098] [049/141] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[287.630515] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[287.632571] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[287.710534] [050/141] (744s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[289.709623] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[289.711700] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[289.793717] [051/141] (742s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs)
[291.883357] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs
[291.886317] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[292.315207] [052/141] (740s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[294.529649] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[294.531709] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[294.806362] [053/141] (737s left) kms_atomic_transition (plane-all-transition-nonblocking)
[296.780961] Starting subtest: plane-all-transition-nonblocking
[296.782094] Starting dynamic subtest: pipe-A-HDMI-A-4
[300.603901] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.822s)
[300.655821] Starting dynamic subtest: pipe-B-HDMI-A-4
[304.530363] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.880s)
[304.553196] Subtest plane-all-transition-nonblocking: SUCCESS (7.774s)
[304.656187] [054/141] (727s left) i915_query (query-topology-kernel-writes)
[304.728015] Starting subtest: query-topology-kernel-writes
[304.728854] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[304.788885] [055/141] (727s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[307.086937] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[307.091391] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.003s)
[307.290689] [056/141] (725s left) kms_sequence (get-busy)
[309.265904] Starting subtest: get-busy
[309.266838] Starting dynamic subtest: HDMI-A-4-pipe-A
[311.746651] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (2.479s)
[311.753854] Starting dynamic subtest: HDMI-A-4-pipe-B
[314.546221] Dynamic subtest HDMI-A-4-pipe-B: SUCCESS (2.796s)
[314.555086] Starting dynamic subtest: HDMI-A-4-pipe-C
[317.714660] Dynamic subtest HDMI-A-4-pipe-C: SUCCESS (3.166s)
[317.726416] Starting dynamic subtest: HDMI-A-4-pipe-D
[321.268832] Dynamic subtest HDMI-A-4-pipe-D: SUCCESS (3.549s)
[321.269829] Subtest get-busy: SUCCESS (12.004s)
[321.397557] [057/141] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[323.379834] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[323.381779] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[323.446158] [058/141] (708s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[325.568601] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[325.570616] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[325.949018] [059/141] (706s left) perf (gen12-oa-tlb-invalidate)
[326.095184] Starting subtest: gen12-oa-tlb-invalidate
[326.096097] Starting dynamic subtest: 0-rcs0
[336.159542] Dynamic subtest 0-rcs0: SUCCESS (10.061s)
[336.160509] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.062s)
[336.178809] [060/141] (696s left) perf_pmu (frequency)
[336.250376] Starting subtest: frequency
[336.251311] Starting dynamic subtest: gt0
[338.363575] Dynamic subtest gt0: SUCCESS (2.111s)
[338.372257] Starting dynamic subtest: idle-gt0
[338.896033] Dynamic subtest idle-gt0: SUCCESS (0.528s)
[338.897047] Subtest frequency: SUCCESS (2.641s)
[339.003767] [061/141] (693s left) kms_invalid_mode (clock-too-high)
[340.982601] Starting subtest: clock-too-high
[340.985552] Starting dynamic subtest: HDMI-A-4-pipe-A
[341.039925] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (0.056s)
[341.050782] Starting dynamic subtest: HDMI-A-4-pipe-B
[341.072469] Dynamic subtest HDMI-A-4-pipe-B: SUCCESS (0.028s)
[341.085385] Starting dynamic subtest: HDMI-A-4-pipe-C
[341.105981] Dynamic subtest HDMI-A-4-pipe-C: SUCCESS (0.028s)
[341.115579] Starting dynamic subtest: HDMI-A-4-pipe-D
[341.137347] Dynamic subtest HDMI-A-4-pipe-D: SUCCESS (0.028s)
[341.138283] Subtest clock-too-high: SUCCESS (0.153s)
[341.237161] [062/141] (691s left) vgem_basic (sysfs)
[341.318916] Starting subtest: sysfs
[341.320028] Subtest sysfs: SUCCESS (0.000s)
[341.370118] [063/141] (691s left) i915_pm_dc (dc9-dpms)
[344.356915] Starting subtest: dc9-dpms
[344.804509] Subtest dc9-dpms: SUCCESS (0.449s)
[345.803036] [064/141] (686s left) debugfs_test (read_all_entries)
[345.909154] Starting subtest: read_all_entries
[346.340508] Subtest read_all_entries: SUCCESS (0.430s)
[348.303508] [065/141] (684s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_mc_ccs)
[350.439259] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs
[350.441353] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[350.800727] [066/141] (681s left) gem_exec_gttfill (basic)
[350.879568] Starting subtest: basic
[357.289285] Subtest basic: SUCCESS (6.407s)
[357.599800] [067/141] (675s left) kms_cursor_crc (cursor-offscreen-512x512)
[359.817361] Starting subtest: cursor-offscreen-512x512
[359.821161] Subtest cursor-offscreen-512x512: SKIP (0.002s)
[359.988854] [068/141] (672s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[362.063245] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[363.251808] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.184s)
[363.397131] [069/141] (669s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[363.498522] Starting subtest: multi-wait-for-submit-submitted-signaled
[363.499434] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[363.575924] [070/141] (669s left) i915_query (query-regions-sanity-check)
[363.650067] Starting subtest: query-regions-sanity-check
[363.679162] Subtest query-regions-sanity-check: SUCCESS (0.030s)
[363.787227] [071/141] (668s left) gem_workarounds (suspend-resume)
[363.881014] Starting subtest: suspend-resume
[384.908723] Subtest suspend-resume: SUCCESS (9.078s)
[390.513443] [072/141] (659s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[390.585669] Starting subtest: invalid-single-wait-all-unsubmitted
[390.586648] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[390.642460] [073/141] (659s left) gem_userptr_blits (unsync-unmap-cycles)
[390.717909] Subtest unsync-unmap-cycles: SKIP (0.000s)
[390.869714] [074/141] (659s left) kms_cursor_crc (cursor-offscreen-128x42)
[392.995550] Starting subtest: cursor-offscreen-128x42
[393.002617] Starting dynamic subtest: pipe-A-HDMI-A-4
[395.494817] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.493s)
[395.526099] Starting dynamic subtest: pipe-D-HDMI-A-4
[399.005824] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.492s)
[399.006701] Subtest cursor-offscreen-128x42: SUCCESS (6.010s)
[399.298815] [075/141] (650s left) perf_pmu (event-wait)
[399.375837] Starting subtest: event-wait
[399.376644] Starting dynamic subtest: rcs0
[399.378388] Dynamic subtest rcs0: SKIP (0.000s)
[399.380046] Subtest event-wait: SKIP (0.001s)
[399.473102] [076/141] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[401.464944] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[401.467167] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[401.546541] [077/141] (648s left) gem_eio (create-ext)
[401.785493] Starting subtest: create-ext
[402.062488] Subtest create-ext: SUCCESS (0.278s)
[404.140863] [078/141] (646s left) gem_softpin (allocator-fork)
[404.213439] Starting subtest: allocator-fork
[406.509085] Subtest allocator-fork: SUCCESS (2.292s)
[406.637455] [079/141] (643s left) i915_hangman (engine-engine-hang)
[406.740212] Starting subtest: engine-engine-hang
[406.741105] Starting dynamic subtest: rcs0
[407.431310] Dynamic subtest rcs0: SUCCESS (0.691s)
[407.441238] Starting dynamic subtest: bcs0
[408.091259] Dynamic subtest bcs0: SUCCESS (0.659s)
[408.101293] Starting dynamic subtest: vcs0
[408.753196] Dynamic subtest vcs0: SUCCESS (0.661s)
[408.763167] Starting dynamic subtest: vcs1
[409.405281] Dynamic subtest vcs1: SUCCESS (0.651s)
[409.414515] Starting dynamic subtest: vecs0
[410.058173] Dynamic subtest vecs0: SUCCESS (0.652s)
[410.059115] Subtest engine-engine-hang: SUCCESS (3.318s)
[410.168235] [080/141] (640s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[412.140960] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[412.144128] Starting dynamic subtest: pipe-A-HDMI-A-4
[413.275624] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.133s)
[413.285709] Starting dynamic subtest: pipe-B-HDMI-A-4
[414.381268] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.103s)
[414.391583] Starting dynamic subtest: pipe-C-HDMI-A-4
[415.486277] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.103s)
[415.496400] Starting dynamic subtest: pipe-D-HDMI-A-4
[416.578127] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.087s)
[416.578937] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.435s)
[416.700148] [081/141] (633s left) kms_plane_scaling (2x-scaler-multi-pipe)
[418.691812] Starting subtest: 2x-scaler-multi-pipe
[418.713500] Subtest 2x-scaler-multi-pipe: SKIP (0.020s)
[418.788355] [082/141] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[420.770219] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[420.772118] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[420.849814] [083/141] (629s left) kms_psr (psr2_cursor_mmap_cpu)
[420.936823] Subtest psr2_cursor_mmap_cpu: SKIP (0.000s)
[420.958578] [084/141] (629s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[421.028588] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[421.058300] [085/141] (629s left) gem_reg_read (timestamp-moving)
[421.126883] Starting subtest: timestamp-moving
[422.131138] Subtest timestamp-moving: SUCCESS (1.000s)
[422.218728] [086/141] (628s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[422.287616] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[422.324361] [087/141] (628s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[424.311165] Starting subtest: yf-tiled-16bpp-rotate-270
[424.313173] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[424.401552] [088/141] (626s left) gem_exec_reloc (basic-write-read-noreloc)
[424.510586] Subtest basic-write-read-noreloc: SKIP (0.000s)
[424.558436] [089/141] (626s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[426.549016] Starting subtest: y-tiled-64bpp-rotate-0
[428.699668] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.147s)
[428.834257] [090/141] (621s left) gem_render_linear_blits (basic)
[428.910544] Starting subtest: basic
[428.995550] Subtest basic: SUCCESS (0.085s)
[429.059490] [091/141] (621s left) kms_psr (sprite_mmap_cpu)
[429.135003] Subtest sprite_mmap_cpu: SKIP (0.000s)
[429.156713] [092/141] (621s left) kms_big_fb (linear-8bpp-rotate-270)
[431.143264] Starting subtest: linear-8bpp-rotate-270
[431.224506] Subtest linear-8bpp-rotate-270: SKIP (0.080s)
[431.332791] [093/141] (619s left) kms_pipe_crc_basic (nonblocking-crc)
[433.310029] Starting subtest: nonblocking-crc
[433.311012] Starting dynamic subtest: pipe-A-HDMI-A-4
[433.988793] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.673s)
[434.001770] Starting dynamic subtest: pipe-B-HDMI-A-4
[434.902104] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.911s)
[434.916265] Starting dynamic subtest: pipe-C-HDMI-A-4
[436.186203] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.280s)
[436.202836] Starting dynamic subtest: pipe-D-HDMI-A-4
[437.853503] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.660s)
[437.854418] Subtest nonblocking-crc: SUCCESS (4.541s)
[437.970537] [094/141] (612s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[438.041260] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[438.042137] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[438.103568] [095/141] (612s left) gem_exec_reloc (basic-active)
[438.175701] Subtest basic-active: SKIP (0.000s)
[438.212459] [096/141] (612s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[438.286148] Starting subtest: legacy-engines-hostile-preempt
[438.287132] Starting dynamic subtest: render
[438.340215] Dynamic subtest render: SUCCESS (0.053s)
[438.349527] Starting dynamic subtest: bsd1
[438.383097] Dynamic subtest bsd1: SUCCESS (0.042s)
[438.392264] Starting dynamic subtest: bsd2
[438.403253] Dynamic subtest bsd2: SUCCESS (0.019s)
[438.412523] Starting dynamic subtest: blt
[438.446244] Dynamic subtest blt: SUCCESS (0.042s)
[438.455328] Starting dynamic subtest: vebox
[438.501160] Dynamic subtest vebox: SUCCESS (0.054s)
[438.502194] Subtest legacy-engines-hostile-preempt: SUCCESS (0.215s)
[438.589350] [097/141] (612s left) gem_exec_reloc (basic-write-gtt)
[438.660441] Subtest basic-write-gtt: SKIP (0.000s)
[438.711753] [098/141] (612s left) gem_render_copy (linear-to-vebox-y-tiled)
[438.787087] Starting subtest: linear-to-vebox-y-tiled
[438.788108] Starting dynamic subtest: smem
[438.867026] Dynamic subtest smem: SUCCESS (0.079s)
[438.876431] Starting dynamic subtest: lmem0
[439.638450] Dynamic subtest lmem0: SUCCESS (0.768s)
[439.639316] Subtest linear-to-vebox-y-tiled: SUCCESS (0.848s)
[439.853832] [099/141] (610s left) kms_vblank (pipe-d-query-forked-hang)
[441.831056] Starting subtest: pipe-D-query-forked-hang
[456.988031] Subtest pipe-D-query-forked-hang: SUCCESS (15.156s)
[457.087613] [100/141] (593s left) gem_exec_reloc (basic-gtt-cpu-active)
[457.163200] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[457.196851] [101/141] (593s left) gem_exec_fence (syncobj-invalid-flags)
[457.619599] Starting subtest: syncobj-invalid-flags
[457.620499] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[457.975139] [102/141] (592s left) kms_busy (extended-pageflip-hang-oldfb)
[459.962192] Starting subtest: extended-pageflip-hang-oldfb
[459.964796] Starting dynamic subtest: pipe-A
[460.160152] Dynamic subtest pipe-A: SUCCESS (0.195s)
[460.187902] Starting dynamic subtest: pipe-D
[460.344904] Dynamic subtest pipe-D: SUCCESS (0.173s)
[460.345907] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.383s)
[460.483033] [103/141] (590s left) v3d/v3d_job_submission (threaded-job-submission)
[460.579986] Subtest threaded-job-submission: SKIP (0.000s)
[460.631925] [104/141] (590s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[462.615589] Starting subtest: 4-tiled-16bpp-rotate-180
[462.617637] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[462.699070] [105/141] (588s left) gem_render_copy (y-tiled-ccs-to-linear)
[462.806396] Starting subtest: y-tiled-ccs-to-linear
[462.807501] Starting dynamic subtest: smem
[462.886623] Dynamic subtest smem: SUCCESS (0.079s)
[462.895735] Starting dynamic subtest: lmem0
[463.206649] Dynamic subtest lmem0: SUCCESS (0.320s)
[463.207749] Subtest y-tiled-ccs-to-linear: SUCCESS (0.400s)
[463.435992] [106/141] (587s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[465.806826] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[465.808591] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[465.929980] [107/141] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[467.914128] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[467.916252] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[467.996124] [108/141] (582s left) v3d/v3d_submit_csd (bad-multisync-pad)
[468.111200] Subtest bad-multisync-pad: SKIP (0.000s)
[468.166186] [109/141] (582s left) prime_vgem (busy)
[468.249467] Starting subtest: busy
[468.250578] Starting dynamic subtest: rcs0
[468.290489] Dynamic subtest rcs0: SUCCESS (0.041s)
[468.299794] Starting dynamic subtest: bcs0
[468.333551] Dynamic subtest bcs0: SUCCESS (0.042s)
[468.347325] Starting dynamic subtest: vcs0
[468.373863] Dynamic subtest vcs0: SUCCESS (0.039s)
[468.399959] Starting dynamic subtest: vcs1
[468.418177] Dynamic subtest vcs1: SUCCESS (0.043s)
[468.441600] Starting dynamic subtest: vecs0
[468.457147] Dynamic subtest vecs0: SUCCESS (0.038s)
[468.458422] Subtest busy: SUCCESS (0.208s)
[468.581936] [110/141] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[470.582872] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[470.584558] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[470.661799] [111/141] (580s left) kms_cursor_crc (cursor-sliding-32x10)
[472.728563] Starting subtest: cursor-sliding-32x10
[472.767762] Subtest cursor-sliding-32x10: SKIP (0.037s)
[473.029131] [112/141] (578s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs)
[475.260097] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs
[475.262316] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[475.520440] [113/141] (575s left) kms_plane (pixel-format)
[477.498163] Starting subtest: pixel-format
[477.499196] Starting dynamic subtest: pipe-A-planes
[499.797050] Dynamic subtest pipe-A-planes: FAIL (22.228s)
[499.806457] Starting dynamic subtest: pipe-B-planes
[522.183263] Dynamic subtest pipe-B-planes: FAIL (22.376s)
[522.184209] Subtest pixel-format: FAIL (44.610s)
[522.257704] [114/141] (528s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[524.230783] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[524.233776] Starting dynamic subtest: pipe-A-valid-mode
[525.178741] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.897s)
[525.184802] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.899s)
[525.275925] [115/141] (525s left) kms_flip (2x-wf_vblank-ts-check)
[526.302446] Starting subtest: 2x-wf_vblank-ts-check
[526.327972] Subtest 2x-wf_vblank-ts-check: SKIP (0.025s)
[526.410623] [116/141] (524s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[528.423359] Starting subtest: primary-y-tiled-reflect-x-0
[538.868085] Subtest primary-y-tiled-reflect-x-0: SUCCESS (10.445s)
[539.017600] [117/141] (512s left) gem_mmap_offset (open-flood)
[539.087348] Starting subtest: open-flood
[560.574292] Subtest open-flood: SUCCESS (21.487s)
[560.673552] [118/141] (490s left) gem_exec_fair (basic-throttle)
[560.779828] Subtest basic-throttle: SKIP (0.000s)
[560.830020] [119/141] (490s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[562.853236] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[562.855038] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[563.323537] [120/141] (487s left) gem_ctx_persistence (many-contexts)
[563.396805] Starting subtest: many-contexts
[598.198066] Subtest many-contexts: SUCCESS (34.801s)
[598.290055] [121/141] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[600.275893] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[600.278126] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[600.371071] [122/141] (450s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[602.547701] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[602.549840] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[602.906631] [123/141] (448s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[603.004486] Subtest destroy-valid-perfmon: SKIP (0.000s)
[603.056709] [124/141] (448s left) gem_pxp (display-protected-crc)
[605.649198] Subtest display-protected-crc: SKIP (0.000s)
[605.716677] [125/141] (445s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[607.697533] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[607.699631] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[607.790690] [126/141] (443s left) prime_mmap (test_forked_cpu_write)
[607.886708] Starting subtest: test_forked_cpu_write
[607.887803] Starting dynamic subtest: test_forked_cpu_write-smem
[607.899444] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.012s)
[607.909105] Starting dynamic subtest: test_forked_cpu_write-lmem0
[607.911974] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.012s)
[607.913103] Subtest test_forked_cpu_write: SUCCESS (0.025s)
[608.002859] [127/141] (443s left) gem_userptr_blits (stress-mm-invalidate-close)
[608.106918] Starting subtest: stress-mm-invalidate-close
[610.257776] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[610.392250] [128/141] (440s left) kms_hdmi_inject (inject-audio)
[610.544528] Starting subtest: inject-audio
[610.648065] Subtest inject-audio: SUCCESS (0.103s)
[611.770791] [129/141] (439s left) drm_fdinfo (all-busy-check-all)
[611.844006] Subtest all-busy-check-all: SKIP (0.000s)
[611.879883] [130/141] (439s left) gem_userptr_blits (dmabuf-unsync)
[611.953375] Subtest dmabuf-unsync: SKIP (0.000s)
[612.081442] [131/141] (439s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[614.088670] Starting subtest: fbcpsr-1p-rte
[614.090897] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[614.154390] [132/141] (437s left) kms_plane_scaling (planes-downscale-factor-0-75)
[616.126734] Starting subtest: planes-downscale-factor-0-75
[616.127839] Starting dynamic subtest: pipe-A-HDMI-A-4
[616.234127] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.107s)
[616.244675] Starting dynamic subtest: pipe-B-HDMI-A-4
[616.356844] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.121s)
[616.367681] Starting dynamic subtest: pipe-C-HDMI-A-4
[616.478708] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.120s)
[616.489325] Starting dynamic subtest: pipe-D-HDMI-A-4
[616.601637] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.121s)
[616.602650] Subtest planes-downscale-factor-0-75: SUCCESS (0.477s)
[616.726972] [133/141] (434s left) vc4/vc4_purgeable_bo (free-purged-bo)
[616.823831] Subtest free-purged-bo: SKIP (0.000s)
[616.876854] [134/141] (434s left) gem_exec_capture (userptr)
[616.951417] Starting subtest: userptr
[617.817243] Subtest userptr: SUCCESS (0.867s)
[617.953501] [135/141] (433s left) kms_display_modes (mst-extended-mode-negative)
[619.930354] Starting subtest: mst-extended-mode-negative
[619.933111] Subtest mst-extended-mode-negative: SKIP (0.000s)
[619.969043] [136/141] (431s left) syncobj_timeline (wait-for-submit-complex)
[620.039545] Starting subtest: wait-for-submit-complex
[620.100061] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[620.205898] [137/141] (431s left) gem_exec_balancer (sliced)
[620.291427] Starting subtest: sliced
[620.293992] Subtest sliced: SKIP (0.000s)
[620.611540] [138/141] (431s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[622.592460] Starting subtest: fbc-rgb101010-draw-mmap-wc
[625.440116] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.852s)
[625.561623] [139/141] (426s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[625.635216] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[625.769568] [140/141] (425s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[628.148562] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[628.150364] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[628.286167] [141/141] (423s left) gem_ctx_exec (basic-norecovery)
[628.355867] Starting subtest: basic-norecovery
[628.590741] Subtest basic-norecovery: SUCCESS (0.234s)
[628.692078] Closing watchdogs
Done.