[40.561349] Initializing watchdogs
[40.561458]   /dev/watchdog0
[40.573837] [001/140] (960s left) kms_psr (psr_cursor_render)
[40.651646] Starting subtest: psr_cursor_render
[40.654204] Starting dynamic subtest: eDP-1
[42.489612] Dynamic subtest eDP-1: SUCCESS (1.837s)
[42.492210] Subtest psr_cursor_render: SUCCESS (1.838s)
[43.404666] [002/140] (957s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-rc-ccs)
[43.801500] Starting subtest: pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs
[44.586573] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.783s)
[45.773525] [003/140] (955s left) gem_exec_fence (submit)
[45.975781] Starting subtest: submit
[45.980707] Subtest submit: SKIP (0.000s)
[47.517089] [004/140] (953s left) gem_ctx_persistence (userptr)
[47.568143] Starting subtest: userptr
[47.683710] Subtest userptr: SUCCESS (0.117s)
[47.768858] [005/140] (953s left) perf_pmu (rc6-all-gts)
[47.825029] Starting subtest: rc6-all-gts
[54.167550] Subtest rc6-all-gts: SUCCESS (6.343s)
[54.899871] [006/140] (946s left) kms_chamelium_color (ctm-0-50)
[54.970576] Subtest ctm-0-50: SKIP (0.000s)
[54.992115] [007/140] (946s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[55.079077] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[55.084174] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[55.151391] [008/140] (946s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[55.218948] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[55.222919] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[55.293891] [009/140] (945s left) i915_pciid
[55.406838] [010/140] (945s left) gen9_exec_parse (bb-secure)
[55.458478] Subtest bb-secure: SKIP (0.000s)
[55.468549] [011/140] (945s left) i915_pm_rc6_residency (rc6-fence)
[55.511605] Starting subtest: rc6-fence
[55.513763] Starting dynamic subtest: gt0
[67.838887] Dynamic subtest gt0: SUCCESS (12.326s)
[67.851477] Starting dynamic subtest: gt1
[82.457619] Dynamic subtest gt1: SUCCESS (14.618s)
[82.460361] Subtest rc6-fence: SUCCESS (26.947s)
[82.525653] [012/140] (918s left) gem_exec_balancer (hog)
[82.600275] Starting subtest: hog
[82.604936] Subtest hog: SKIP (0.000s)
[82.845650] [013/140] (918s left) drm_fdinfo (virtual-busy)
[82.914672] Starting subtest: virtual-busy
[82.919807] Subtest virtual-busy: SKIP (0.000s)
[82.978885] [014/140] (918s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[83.062273] Starting subtest: plane-all-transition-nonblocking-fencing
[83.064529] Starting dynamic subtest: pipe-A-eDP-1
[85.558566] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[85.879903] Starting dynamic subtest: pipe-B-eDP-1
[89.212763] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.343s)
[89.511478] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.451s)
[90.448386] [015/140] (910s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[90.510113] Starting subtest: etime-multi-wait-all-submitted-signaled
[90.614273] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[90.679761] [016/140] (910s left) gem_mmap (short-mmap)
[90.725489] Subtest short-mmap: SKIP (0.000s)
[90.745958] [017/140] (910s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[90.816945] Starting subtest: psr-modesetfrombusy
[95.127599] Subtest psr-modesetfrombusy: SUCCESS (4.316s)
[95.238106] [018/140] (906s left) api_intel_bb (reset-flags)
[95.283031] Starting subtest: reset-flags
[95.297779] Subtest reset-flags: SUCCESS (0.015s)
[95.387764] [019/140] (906s left) api_intel_bb (blit-noreloc-keep-cache)
[95.422844] Starting subtest: blit-noreloc-keep-cache
[95.434752] Subtest blit-noreloc-keep-cache: SUCCESS (0.016s)
[95.539728] [020/140] (905s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[95.595941] Starting subtest: y-tiled-to-vebox-x-tiled
[95.600056] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[95.773064] [021/140] (905s left) kms_chamelium_frames (dp-frame-dump)
[96.140883] Subtest dp-frame-dump: SKIP (0.000s)
[97.008140] [022/140] (904s left) gem_lmem_swapping (massive)
[97.081235] Subtest massive: SKIP (0.000s)
[97.103869] [023/140] (904s left) perf_pmu (interrupts-sync)
[97.142079] Starting subtest: interrupts-sync
[98.223366] Subtest interrupts-sync: SUCCESS (1.082s)
[98.322882] [024/140] (903s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-ccs)
[98.703751] Starting subtest: pipe-B-bad-pixel-format-y-tiled-ccs
[98.708910] Subtest pipe-B-bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[99.561797] [025/140] (902s left) vc4/vc4_create_bo (create-bo-zeroed)
[99.656847] Subtest create-bo-zeroed: SKIP (0.000s)
[99.698267] [026/140] (901s left) kms_pm_dc (dc5-dpms-negative)
[100.764545] Starting subtest: dc5-dpms-negative
[100.769349] Subtest dc5-dpms-negative: SKIP (0.000s)
[100.830528] [027/140] (900s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[100.981106] Starting subtest: cursor-rapid-movement-64x64
[100.983617] Starting dynamic subtest: pipe-A-eDP-1
[101.572183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[101.606142] Starting dynamic subtest: pipe-D-eDP-1
[102.871927] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[102.874050] Subtest cursor-rapid-movement-64x64: SUCCESS (1.891s)
[103.755970] [028/140] (897s left) syncobj_wait (invalid-wait-illegal-handle)
[103.813015] Starting subtest: invalid-wait-illegal-handle
[103.815437] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[103.878532] [029/140] (897s left) kms_flip_event_leak (basic)
[103.975320] Starting subtest: basic
[103.977291] Starting dynamic subtest: pipe-A-eDP-1
[104.429324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[104.441771] Starting dynamic subtest: pipe-B-eDP-1
[105.682974] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[105.694246] Starting dynamic subtest: pipe-C-eDP-1
[106.889343] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[106.902658] Starting dynamic subtest: pipe-D-eDP-1
[108.094310] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[108.097131] Subtest basic: SUCCESS (4.120s)
[109.009385] [030/140] (892s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[109.066482] Starting subtest: invalid-multi-wait-all-unsubmitted
[109.068806] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[109.125994] [031/140] (892s left) kms_plane_alpha_blend (constant-alpha-mid)
[109.178140] Starting subtest: constant-alpha-mid
[109.425043] Starting dynamic subtest: pipe-A-eDP-1
[110.471408] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.046s)
[110.484878] Starting dynamic subtest: pipe-D-eDP-1
[112.144650] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.670s)
[112.147546] Subtest constant-alpha-mid: SUCCESS (2.967s)
[113.039882] [032/140] (888s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[113.435341] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs-cc
[113.444330] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[114.319469] [033/140] (887s left) kms_psr (psr2_basic)
[114.401237] Starting subtest: psr2_basic
[114.403561] Starting dynamic subtest: eDP-1
[116.079512] Dynamic subtest eDP-1: SUCCESS (1.678s)
[116.082046] Subtest psr2_basic: SUCCESS (1.679s)
[117.007674] [034/140] (884s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[117.387804] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[118.244688] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.853s)
[119.417836] [035/140] (882s left) gem_userptr_blits (create-destroy-sync)
[119.486685] Starting subtest: create-destroy-sync
[124.500453] Subtest create-destroy-sync: SUCCESS (5.015s)
[124.595709] [036/140] (877s left) sw_sync (timeline_closed)
[124.643528] Starting subtest: timeline_closed
[124.646139] Subtest timeline_closed: SUCCESS (0.000s)
[124.682670] [037/140] (877s left) kms_panel_fitting (legacy)
[124.742170] Starting subtest: legacy
[124.744531] Starting dynamic subtest: pipe-A-eDP-1
[125.339071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[125.369272] Starting dynamic subtest: pipe-B-eDP-1
[127.064186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.707s)
[127.097394] Starting dynamic subtest: pipe-C-eDP-1
[128.751234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.664s)
[128.780057] Starting dynamic subtest: pipe-D-eDP-1
[130.379204] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.608s)
[130.381517] Subtest legacy: SUCCESS (5.637s)
[131.667578] [038/140] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[131.738286] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[131.742650] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[131.821624] [039/140] (870s left) gem_mmap_gtt (medium-copy)
[131.871513] Subtest medium-copy: SKIP (0.000s)
[131.906747] [040/140] (870s left) kms_plane_scaling (planes-scaler-unity-scaling)
[131.982640] Starting subtest: planes-scaler-unity-scaling
[131.985070] Starting dynamic subtest: pipe-A-eDP-1
[132.052906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.071s)
[132.070324] Starting dynamic subtest: pipe-B-eDP-1
[133.267034] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[133.283693] Starting dynamic subtest: pipe-C-eDP-1
[134.472842] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[134.489199] Starting dynamic subtest: pipe-D-eDP-1
[135.687439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s)
[135.690316] Subtest planes-scaler-unity-scaling: SUCCESS (3.708s)
[136.910941] [041/140] (865s left) kms_color (ctm-negative)
[136.968198] Starting subtest: ctm-negative
[136.970205] Starting dynamic subtest: pipe-A
[137.722697] Dynamic subtest pipe-A: SUCCESS (0.755s)
[137.736163] Starting dynamic subtest: pipe-B
[139.244028] Dynamic subtest pipe-B: SUCCESS (1.521s)
[139.257921] Starting dynamic subtest: pipe-C
[140.733814] Dynamic subtest pipe-C: SUCCESS (1.488s)
[140.748069] Starting dynamic subtest: pipe-D
[142.193421] Dynamic subtest pipe-D: SUCCESS (1.461s)
[142.195983] Subtest ctm-negative: SUCCESS (5.228s)
[143.119825] [042/140] (858s left) vc4/vc4_tiling (set-bad-modifier)
[143.208216] Subtest set-bad-modifier: SKIP (0.000s)
[143.256595] [043/140] (858s left) i915_query (query-topology-kernel-writes)
[143.303749] Starting subtest: query-topology-kernel-writes
[143.305940] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[143.358232] [044/140] (858s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-mtl-mc-ccs)
[143.747136] Starting subtest: pipe-B-crc-primary-basic-4-tiled-mtl-mc-ccs
[146.201328] Subtest pipe-B-crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (2.455s)
[147.413101] [045/140] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[147.486890] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[147.491149] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[147.578625] [046/140] (854s left) kms_plane_scaling (planes-downscale-factor-0-25)
[147.634771] Starting subtest: planes-downscale-factor-0-25
[147.637109] Starting dynamic subtest: pipe-A-eDP-1
[147.644736] Dynamic subtest pipe-A-eDP-1: SKIP (0.007s)
[147.650429] Starting dynamic subtest: pipe-B-eDP-1
[147.673480] Dynamic subtest pipe-B-eDP-1: SKIP (0.029s)
[147.680292] Starting dynamic subtest: pipe-C-eDP-1
[147.691224] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s)
[147.697824] Starting dynamic subtest: pipe-D-eDP-1
[147.712107] Dynamic subtest pipe-D-eDP-1: SKIP (0.019s)
[147.716126] Subtest planes-downscale-factor-0-25: SKIP (0.075s)
[147.791771] [047/140] (854s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[147.844426] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[147.849058] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[147.922234] [048/140] (854s left) kms_rotation_crc (bad-pixel-format)
[147.989326] Starting subtest: bad-pixel-format
[147.994049] Subtest bad-pixel-format: SKIP (0.002s)
[148.058826] [049/140] (854s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[148.170111] Starting subtest: 4-tiled-64bpp-rotate-90
[148.188062] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.018s)
[148.282697] [050/140] (853s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[148.677871] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[148.683573] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s)
[149.519137] [051/140] (852s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[149.586827] Starting subtest: x-tiled-32bpp-rotate-0
[150.990981] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.404s)
[151.128136] [052/140] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[151.188730] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[151.192496] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[151.274883] [053/140] (851s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[151.333688] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[156.696650] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.364s)
[156.810450] [054/140] (845s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[156.895819] Starting subtest: y-tiled-16bpp-rotate-270
[156.900096] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[156.986252] [055/140] (845s left) v3d/v3d_submit_cl (multisync-out-syncs)
[157.062985] Subtest multisync-out-syncs: SKIP (0.000s)
[157.108896] [056/140] (845s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[157.164282] Starting subtest: mixed-tiled-to-y-tiled-ccs
[157.168379] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[157.339809] [057/140] (845s left) gem_mmap_gtt (basic-write-gtt)
[157.396987] Subtest basic-write-gtt: SKIP (0.000s)
[157.432449] [058/140] (845s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-rc-ccs)
[157.843942] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs
[157.854238] Subtest pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[158.681144] [059/140] (843s left) vgem_basic (create)
[158.745961] Starting subtest: create
[158.748036] Subtest create: SUCCESS (0.000s)
[158.792450] [060/140] (843s left) gem_ctx_exec (basic-close-race)
[158.837065] Starting subtest: basic-close-race
[164.484702] Subtest basic-close-race: SUCCESS (5.648s)
[164.596352] [061/140] (837s left) gem_softpin (overlap)
[164.646176] Starting subtest: overlap
[165.211635] Subtest overlap: SUCCESS (0.564s)
[165.312557] [062/140] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[165.415732] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[170.552840] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.142s)
[170.667329] [063/140] (831s left) gem_ctx_persistence (heartbeat-hang)
[170.719392] Starting subtest: heartbeat-hang
[170.724966] Subtest heartbeat-hang: SKIP (0.000s)
[170.780721] [064/140] (831s left) gem_mmap_offset (isolation)
[170.831483] Starting subtest: isolation
[170.847787] Subtest isolation: SUCCESS (0.002s)
[170.908939] [065/140] (831s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[170.980791] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[170.984768] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[171.054620] [066/140] (831s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[171.601355] Starting subtest: syncobj-timeline-multiple-ext-nodes
[171.607307] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[173.457826] [067/140] (829s left) kms_lease (empty-lease)
[173.536195] Starting subtest: empty-lease
[173.538681] Starting dynamic subtest: pipe-A-eDP-1
[173.541126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[173.553418] Starting dynamic subtest: pipe-B-eDP-1
[173.555426] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[173.564042] Starting dynamic subtest: pipe-C-eDP-1
[173.566255] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[173.571636] Starting dynamic subtest: pipe-D-eDP-1
[173.574069] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[173.576442] Subtest empty-lease: SUCCESS (0.005s)
[173.591166] [068/140] (829s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[173.964328] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[175.847182] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.883s)
[177.040959] [069/140] (825s left) gem_pxp (fail-invalid-protected-context)
[179.640164] Subtest fail-invalid-protected-context: SKIP (0.000s)
[179.704219] [070/140] (823s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs)
[180.143613] Starting subtest: pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs
[180.146701] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[180.946942] [071/140] (821s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[181.012717] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[181.016799] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[181.084436] [072/140] (821s left) kms_rotation_crc (sprite-rotation-180)
[181.144630] Starting subtest: sprite-rotation-180
[187.462307] Subtest sprite-rotation-180: SUCCESS (6.318s)
[188.754467] [073/140] (814s left) kms_cursor_edge_walk (64x64-top-edge)
[188.812987] Starting subtest: 64x64-top-edge
[188.815531] Starting dynamic subtest: pipe-A-eDP-1
[192.363103] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.550s)
[192.371119] Starting dynamic subtest: pipe-D-eDP-1
[195.582721] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.218s)
[195.585427] Subtest 64x64-top-edge: SUCCESS (6.773s)
[196.499158] [074/140] (806s left) prime_vgem (coherency-gtt)
[196.573436] Starting subtest: coherency-gtt
[196.578650] Subtest coherency-gtt: SKIP (0.000s)
[196.667846] [075/140] (806s left) v3d/v3d_create_bo (create-bo-invalid-flags)
[196.745762] Subtest create-bo-invalid-flags: SKIP (0.000s)
[196.791243] [076/140] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[196.863108] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[202.018976] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.158s)
[202.123244] [077/140] (800s left) gem_exec_schedule (preempt-queue-chain)
[202.184146] Subtest preempt-queue-chain: SKIP (0.000s)
[202.462156] [078/140] (800s left) gem_mmap_wc (coherency)
[202.508998] Subtest coherency: SKIP (0.000s)
[202.522786] [079/140] (800s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[202.625989] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[205.201168] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.580s)
[205.330505] [080/140] (797s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[205.398197] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[205.402065] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[205.470428] [081/140] (797s left) syncobj_timeline (wait-any-snapshot)
[205.524770] Starting subtest: wait-any-snapshot
[205.607696] Subtest wait-any-snapshot: SUCCESS (0.083s)
[205.676306] [082/140] (797s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[205.745177] Starting subtest: x-tiled-8bpp-rotate-270
[205.764400] Subtest x-tiled-8bpp-rotate-270: SKIP (0.019s)
[205.859677] [083/140] (797s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[205.932605] Starting subtest: fb-8bpc-vs-panel-6bpc
[205.934744] Starting dynamic subtest: pipe-A-eDP-1
[207.390422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.456s)
[207.392930] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.457s)
[208.273081] [084/140] (794s left) gem_exec_reloc (basic-cpu-wc)
[208.332090] Subtest basic-cpu-wc: SKIP (0.000s)
[208.391432] [085/140] (794s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[208.469066] Starting subtest: yf-tiled-32bpp-rotate-180
[208.474310] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[208.535999] [086/140] (794s left) gem_workarounds (basic-read-fd)
[208.600160] Starting subtest: basic-read-fd
[208.613262] Subtest basic-read-fd: SUCCESS (0.012s)
[208.714714] [087/140] (794s left) gem_exec_whisper (basic-fds-forked)
[208.769858] Starting subtest: basic-fds-forked
[234.496671] Subtest basic-fds-forked: SUCCESS (25.722s)
[234.673578] [088/140] (768s left) gem_exec_reloc (basic-range-active)
[234.737445] Subtest basic-range-active: SKIP (0.000s)
[234.800092] [089/140] (768s left) kms_cursor_crc (cursor-alpha-transparent)
[234.871998] Starting subtest: cursor-alpha-transparent
[234.874233] Starting dynamic subtest: pipe-A-eDP-1
[235.537921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.666s)
[235.554136] Starting dynamic subtest: pipe-D-eDP-1
[236.922815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.382s)
[236.925758] Subtest cursor-alpha-transparent: SUCCESS (2.052s)
[237.805100] [090/140] (765s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[237.867683] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[237.870220] Starting dynamic subtest: pipe-A-default-mode
[239.080976] Dynamic subtest pipe-A-default-mode: SKIP (1.211s)
[239.085967] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.212s)
[239.211433] [091/140] (764s left) gem_mmap_gtt (coherency)
[239.269810] Subtest coherency: SKIP (0.000s)
[239.305648] [092/140] (764s left) gem_partial_pwrite_pread (writes-after-reads)
[239.352751] Subtest writes-after-reads: SKIP (0.000s)
[239.410642] [093/140] (763s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[239.455834] Starting subtest: multi-wait-all-for-submit-signaled
[239.458237] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[239.508969] [094/140] (763s left) gem_eio (kms)
[239.767902] Starting subtest: kms
[261.753077] Subtest kms: SUCCESS (21.985s)
[263.006947] [095/140] (740s left) gem_partial_pwrite_pread (reads-snoop)
[263.051050] Subtest reads-snoop: SKIP (0.000s)
[263.086488] [096/140] (740s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-rc-ccs)
[263.452041] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs
[263.456832] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.000s)
[264.340426] [097/140] (739s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[264.760781] Starting subtest: pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[264.765971] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s)
[265.607502] [098/140] (737s left) drm_fdinfo (busy-check-all)
[265.665365] Starting subtest: busy-check-all
[265.667447] Starting dynamic subtest: rcs0
[265.672455] Dynamic subtest rcs0: SKIP (0.005s)
[265.688511] Starting dynamic subtest: bcs0
[265.693301] Dynamic subtest bcs0: SKIP (0.001s)
[265.707073] Starting dynamic subtest: vcs0
[265.711728] Dynamic subtest vcs0: SKIP (0.001s)
[265.724357] Starting dynamic subtest: vcs1
[265.728741] Dynamic subtest vcs1: SKIP (0.001s)
[265.738322] Starting dynamic subtest: vecs0
[265.742606] Dynamic subtest vecs0: SKIP (0.001s)
[265.750876] Starting dynamic subtest: ccs0
[265.755139] Dynamic subtest ccs0: SKIP (0.000s)
[265.759496] Subtest busy-check-all: SKIP (0.015s)
[265.778188] [099/140] (737s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[265.883594] Starting subtest: cursorA-vs-flipA-atomic-transitions
[277.067503] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.185s)
[277.971703] [100/140] (725s left) gem_softpin (allocator-evict)
[278.022784] Starting subtest: allocator-evict
[278.025934] Starting dynamic subtest: rcs0
[301.264994] Dynamic subtest rcs0: SUCCESS (23.244s)
[301.274540] Starting dynamic subtest: bcs0
[325.006201] Dynamic subtest bcs0: SUCCESS (23.740s)
[325.022036] Starting dynamic subtest: vcs0
[348.258351] Dynamic subtest vcs0: SUCCESS (23.250s)
[348.274567] Starting dynamic subtest: vcs1
[371.536660] Dynamic subtest vcs1: SUCCESS (23.276s)
[371.553611] Starting dynamic subtest: vecs0
[394.744097] Dynamic subtest vecs0: SUCCESS (23.207s)
[394.751913] Starting dynamic subtest: ccs0
[418.377912] Dynamic subtest ccs0: SUCCESS (23.632s)
[418.380832] Subtest allocator-evict: SUCCESS (140.358s)
[418.452630] [101/140] (585s left) gem_ctx_param (basic-default)
[418.547546] Starting subtest: basic-default
[418.549631] Subtest basic-default: SUCCESS (0.000s)
[418.606232] [102/140] (585s left) kms_prop_blob (blob-prop-validate)
[418.671864] Starting subtest: blob-prop-validate
[418.674350] Subtest blob-prop-validate: SUCCESS (0.000s)
[418.737389] [103/140] (584s left) sw_sync (sync_expired_merge)
[418.796761] Starting subtest: sync_expired_merge
[419.871802] Subtest sync_expired_merge: SUCCESS (1.074s)
[419.922189] [104/140] (583s left) gem_wait (write-busy)
[419.985666] Starting subtest: write-busy
[419.988168] Starting dynamic subtest: all-engines
[420.586684] Dynamic subtest all-engines: SUCCESS (0.601s)
[420.610043] Starting dynamic subtest: rcs0
[421.141964] Dynamic subtest rcs0: SUCCESS (0.552s)
[421.165092] Starting dynamic subtest: bcs0
[421.692754] Dynamic subtest bcs0: SUCCESS (0.551s)
[421.716284] Starting dynamic subtest: vcs0
[423.448933] Dynamic subtest vcs0: SUCCESS (1.754s)
[423.472960] Starting dynamic subtest: vcs1
[425.433447] Dynamic subtest vcs1: SUCCESS (1.983s)
[425.459748] Starting dynamic subtest: vecs0
[427.417086] Dynamic subtest vecs0: SUCCESS (1.982s)
[427.441912] Starting dynamic subtest: ccs0
[427.971787] Dynamic subtest ccs0: SUCCESS (0.554s)
[427.974779] Subtest write-busy: SUCCESS (7.986s)
[428.180811] [105/140] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[428.282180] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[428.286862] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[428.364994] [106/140] (575s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[428.443293] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[428.447587] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[428.524769] [107/140] (575s left) syncobj_wait (invalid-signal-zero-handles)
[428.571059] Starting subtest: invalid-signal-zero-handles
[428.573478] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[428.638565] [108/140] (575s left) perf (gen12-oa-tlb-invalidate)
[428.770407] Starting subtest: gen12-oa-tlb-invalidate
[428.772573] Starting dynamic subtest: 0-rcs0
[438.815223] Dynamic subtest 0-rcs0: SUCCESS (10.044s)
[438.828147] Starting dynamic subtest: 1-vcs0
[448.866784] Dynamic subtest 1-vcs0: SUCCESS (10.052s)
[448.869740] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.098s)
[448.894510] [109/140] (554s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-mc-ccs)
[449.294604] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-mc-ccs
[450.514371] Subtest pipe-B-random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (1.220s)
[451.728449] [110/140] (552s left) gem_mmap_wc (write-read)
[451.768098] Subtest write-read: SKIP (0.000s)
[451.797067] [111/140] (552s left) v3d/v3d_wait_bo (used-bo-1ns)
[451.881042] Subtest used-bo-1ns: SKIP (0.000s)
[451.926974] [112/140] (551s left) kms_vblank (wait-busy)
[451.996080] Starting subtest: wait-busy
[451.998501] Starting dynamic subtest: pipe-A-eDP-1
[453.884769] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[453.904553] Starting dynamic subtest: pipe-D-eDP-1
[456.551808] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.656s)
[456.554935] Subtest wait-busy: SUCCESS (4.553s)
[457.422162] [113/140] (546s left) kms_ccs (pipe-a-bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[457.467196] Starting subtest: pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[457.471839] Subtest pipe-A-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[458.644193] [114/140] (545s left) i915_query (test-query-geometry-subslices)
[458.694925] Starting subtest: test-query-geometry-subslices
[458.697200] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[458.762276] [115/140] (545s left) kms_cursor_crc (cursor-offscreen-512x170)
[459.050812] Starting subtest: cursor-offscreen-512x170
[459.055594] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[459.175539] [116/140] (544s left) kms_addfb_basic (basic-x-tiled-legacy)
[459.231462] Starting subtest: basic-x-tiled-legacy
[459.236315] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[459.319562] [117/140] (544s left) kms_sequence (queue-busy)
[459.394817] Starting subtest: queue-busy
[459.397225] Starting dynamic subtest: pipe-A-eDP-1
[461.339746] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[461.355740] Starting dynamic subtest: pipe-B-eDP-1
[464.014261] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.671s)
[464.030559] Starting dynamic subtest: pipe-C-eDP-1
[466.690870] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.673s)
[466.704156] Starting dynamic subtest: pipe-D-eDP-1
[469.339182] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.645s)
[469.341906] Subtest queue-busy: SUCCESS (9.945s)
[470.227449] [118/140] (533s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[470.611334] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[470.617372] Subtest pipe-C-crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[471.501709] [119/140] (532s left) gem_eio (in-flight-internal-10ms)
[471.712038] Starting subtest: in-flight-internal-10ms
[473.521553] Subtest in-flight-internal-10ms: SUCCESS (1.809s)
[473.642908] [120/140] (530s left) sw_sync (timeline_closed_signaled)
[473.696625] Starting subtest: timeline_closed_signaled
[473.699186] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[473.748953] [121/140] (530s left) gem_eio (reset-stress)
[473.970043] Starting subtest: reset-stress
[517.864734] Subtest reset-stress: SUCCESS (43.893s)
[519.421056] [122/140] (484s left) gem_exec_whisper (basic-sync-all)
[519.489065] Starting subtest: basic-sync-all
[530.495656] Subtest basic-sync-all: SUCCESS (11.003s)
[530.677526] [123/140] (473s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[530.750527] Starting subtest: flip-vs-cursor-varying-size
[537.086361] Subtest flip-vs-cursor-varying-size: SUCCESS (6.333s)
[537.999787] [124/140] (466s left) gem_mmap (big-bo)
[538.063661] Subtest big-bo: SKIP (0.000s)
[538.082287] [125/140] (466s left) prime_vgem (basic-gtt)
[538.154938] Starting subtest: basic-gtt
[538.160603] Subtest basic-gtt: SKIP (0.000s)
[538.246889] [126/140] (466s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[538.312153] Starting subtest: primary-4-tiled-reflect-x-180
[546.826384] Subtest primary-4-tiled-reflect-x-180: SUCCESS (8.517s)
[548.117079] [127/140] (456s left) syncobj_eventfd (invalid-illegal-eventfd)
[548.161950] Starting subtest: invalid-illegal-eventfd
[548.164230] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[548.217906] [128/140] (456s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[548.305645] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[549.127682] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.825s)
[549.294583] [129/140] (455s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[549.388152] Starting subtest: basic-busy-flip-before-cursor-legacy
[549.392917] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[549.526236] [130/140] (454s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[549.594906] Starting subtest: y-tiled-8bpp-rotate-270
[549.599113] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[549.682125] [131/140] (454s left) kms_plane (plane-position-hole)
[549.757539] Starting subtest: plane-position-hole
[549.759906] Starting dynamic subtest: pipe-A
[556.168578] Dynamic subtest pipe-A: SUCCESS (6.415s)
[556.187533] Starting dynamic subtest: pipe-B
[563.074510] Dynamic subtest pipe-B: SUCCESS (6.902s)
[563.077177] Subtest plane-position-hole: SUCCESS (13.322s)
[563.925213] [132/140] (440s left) gem_fenced_exec_thrash (no-spare-fences)
[563.984974] Subtest no-spare-fences: SKIP (0.000s)
[564.008849] [133/140] (440s left) kms_getfb (getfb2-accept-ccs)
[564.063581] Starting subtest: getfb2-accept-ccs
[564.066241] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[564.158051] [134/140] (440s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb)
[569.389246] Starting subtest: primary-plane-update-sf-dmg-area-big-fb
[569.392162] Starting dynamic subtest: pipe-A-eDP-1
[577.129886] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.739s)
[577.144564] Starting dynamic subtest: pipe-B-eDP-1
[585.085838] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.951s)
[585.088534] Subtest primary-plane-update-sf-dmg-area-big-fb: SUCCESS (15.697s)
[585.969505] [135/140] (418s left) gem_ccs (block-copy-uncompressed)
[586.031589] Starting subtest: block-copy-uncompressed
[586.033851] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[586.063180] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.030s)
[586.070250] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[586.096501] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.032s)
[586.106435] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[586.119299] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[586.128077] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[586.144919] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.024s)
[586.147883] Subtest block-copy-uncompressed: SUCCESS (0.113s)
[586.242512] [136/140] (418s left) gem_exec_fair (basic-pace-share)
[586.316108] Subtest basic-pace-share: SKIP (0.000s)
[586.365987] [137/140] (418s left) gem_exec_schedule (in-order)
[586.441942] Starting subtest: in-order
[586.444399] Starting dynamic subtest: rcs0
[586.545815] Dynamic subtest rcs0: SUCCESS (0.103s)
[586.562471] Starting dynamic subtest: vcs0
[586.642533] Dynamic subtest vcs0: SUCCESS (0.095s)
[586.658519] Starting dynamic subtest: vcs1
[586.734296] Dynamic subtest vcs1: SUCCESS (0.091s)
[586.746843] Starting dynamic subtest: vecs0
[586.834063] Dynamic subtest vecs0: SUCCESS (0.099s)
[586.849609] Starting dynamic subtest: ccs0
[586.927700] Dynamic subtest ccs0: SUCCESS (0.093s)
[586.929981] Subtest in-order: SUCCESS (0.487s)
[588.519298] [138/140] (416s left) syncobj_timeline (single-wait-available-submitted)
[588.576695] Starting subtest: single-wait-available-submitted
[588.579411] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[588.643044] [139/140] (416s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs)
[589.001594] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs
[589.006776] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[589.907841] [140/140] (414s left) gem_eio (banned)
[590.124974] Starting subtest: banned
[590.759558] Subtest banned: SUCCESS (0.636s)
[590.871426] Closing watchdogs
Done.