[47.847393] Initializing watchdogs
[47.847592]   /dev/watchdog0
[47.883197] [001/138] (960s left) syncobj_basic (bad-fd-to-handle)
[48.145526] Starting subtest: bad-fd-to-handle
[48.164992] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[48.255588] [002/138] (960s left) syncobj_timeline (multi-wait-all-available-submitted)
[48.495435] Starting subtest: multi-wait-all-available-submitted
[48.514093] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s)
[48.594337] [003/138] (959s left) gem_exec_reloc (basic-wc-gtt)
[48.827331] Starting subtest: basic-wc-gtt
[48.870749] Subtest basic-wc-gtt: SUCCESS (0.028s)
[49.050066] [004/138] (959s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[49.370533] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[49.391450] Starting dynamic subtest: pipe-A-DP-1
[49.561420] Dynamic subtest pipe-A-DP-1: SKIP (0.177s)
[49.596396] Starting dynamic subtest: pipe-B-DP-1
[49.952312] Dynamic subtest pipe-B-DP-1: SKIP (0.383s)
[49.983685] Starting dynamic subtest: pipe-C-DP-1
[50.333084] Dynamic subtest pipe-C-DP-1: SKIP (0.377s)
[50.372623] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.946s)
[50.715391] [005/138] (957s left) gem_lmem_swapping (parallel-random-verify)
[50.970608] Subtest parallel-random-verify: SKIP (0.000s)
[51.048780] [006/138] (957s left) kms_setmode (basic)
[51.314188] Starting subtest: basic
[51.693584] Starting dynamic subtest: pipe-A-DP-1
[54.023588] Dynamic subtest pipe-A-DP-1: SUCCESS (2.305s)
[54.142866] Starting dynamic subtest: pipe-B-DP-1
[56.466173] Dynamic subtest pipe-B-DP-1: SUCCESS (2.310s)
[56.570387] Subtest basic: SUCCESS (5.256s)
[56.896481] [007/138] (951s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[57.246552] Starting subtest: cursor-rapid-movement-512x170
[57.284776] Subtest cursor-rapid-movement-512x170: SKIP (0.003s)
[57.363620] [008/138] (951s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[57.684574] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[57.704846] Starting dynamic subtest: pipe-A-valid-mode
[57.786301] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[57.829487] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.100s)
[58.112373] [009/138] (950s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[58.463671] Starting subtest: yf-tiled-64bpp-rotate-180
[58.505980] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[58.587371] [010/138] (950s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[58.796415] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[58.817255] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[58.922881] [011/138] (950s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs)
[59.349595] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs
[59.387262] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[59.816420] [012/138] (949s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[60.353890] Subtest pipe-D-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[60.664072] [013/138] (948s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs)
[61.055800] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs
[61.094798] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[61.529815] [014/138] (947s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[61.835306] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[62.945976] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.105s)
[63.290654] [015/138] (946s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[63.713540] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[64.003841] [016/138] (945s left) kms_cursor_crc (cursor-offscreen-32x32)
[64.315794] Starting subtest: cursor-offscreen-32x32
[64.496153] Subtest cursor-offscreen-32x32: SKIP (0.119s)
[64.622165] [017/138] (945s left) kms_atomic_transition (plane-all-transition-fencing)
[64.942212] Starting subtest: plane-all-transition-fencing
[64.964249] Starting dynamic subtest: pipe-A-DP-1
[68.971359] Dynamic subtest pipe-A-DP-1: SUCCESS (4.031s)
[69.089752] Starting dynamic subtest: pipe-B-DP-1
[73.478992] Dynamic subtest pipe-B-DP-1: SUCCESS (4.424s)
[73.584577] Subtest plane-all-transition-fencing: SUCCESS (8.651s)
[73.942770] [018/138] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[74.322490] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[74.363652] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.449680] [019/138] (935s left) gem_exec_balancer (noheartbeat)
[78.703733] Starting subtest: noheartbeat
[82.441272] Subtest noheartbeat: SUCCESS (3.730s)
[82.522918] [020/138] (927s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[82.965462] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs-cc
[83.023042] Subtest pipe-B-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[83.377940] [021/138] (926s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[83.724991] Starting subtest: psr-modesetfrombusy
[83.762156] Subtest psr-modesetfrombusy: SKIP (0.000s)
[83.871571] [022/138] (926s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[84.438433] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[84.758247] [023/138] (925s left) kms_cursor_edge_walk (128x128-top-edge)
[85.087674] Starting subtest: 128x128-top-edge
[85.113453] Starting dynamic subtest: pipe-A-DP-1
[88.728587] Dynamic subtest pipe-A-DP-1: SUCCESS (3.636s)
[88.762888] Starting dynamic subtest: pipe-C-DP-1
[92.188682] Dynamic subtest pipe-C-DP-1: SUCCESS (3.461s)
[92.210887] Subtest 128x128-top-edge: SUCCESS (7.105s)
[92.487200] [024/138] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[92.838078] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[92.879249] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.979690] [025/138] (917s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[93.440211] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[93.477308] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[93.825832] [026/138] (916s left) gem_ctx_shared (exec-single-timeline)
[94.062497] Starting subtest: exec-single-timeline
[94.081126] Starting dynamic subtest: rcs0
[95.140130] Dynamic subtest rcs0: SUCCESS (1.085s)
[95.180515] Starting dynamic subtest: bcs0
[96.229816] Dynamic subtest bcs0: SUCCESS (1.086s)
[96.266821] Starting dynamic subtest: vcs0
[97.314311] Dynamic subtest vcs0: SUCCESS (1.085s)
[97.350702] Starting dynamic subtest: vecs0
[98.406486] Dynamic subtest vecs0: SUCCESS (1.087s)
[98.427683] Subtest exec-single-timeline: SUCCESS (4.350s)
[98.662180] [027/138] (911s left) kms_addfb_basic (unused-pitches)
[98.901607] Starting subtest: unused-pitches
[98.920175] Subtest unused-pitches: SUCCESS (0.000s)
[99.079789] [028/138] (911s left) gem_compute (compute-square)
[99.312364] Starting subtest: compute-square
[99.355808] Subtest compute-square: SKIP (0.000s)
[99.437152] [029/138] (911s left) gem_request_retire (retire-vma-not-inactive)
[99.662266] Starting subtest: retire-vma-not-inactive
[99.681166] Subtest retire-vma-not-inactive: SUCCESS (0.029s)
[99.796469] [030/138] (911s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[100.124801] Starting subtest: 4-tiled-addfb-size-offset-overflow
[100.163735] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[100.252779] [031/138] (910s left) kms_lease (lease-unleased-connector)
[100.556495] Starting subtest: lease-unleased-connector
[100.575077] Starting dynamic subtest: pipe-A-DP-1
[100.731577] Dynamic subtest pipe-A-DP-1: SUCCESS (0.157s)
[100.762568] Starting dynamic subtest: pipe-B-DP-1
[100.875227] Dynamic subtest pipe-B-DP-1: SUCCESS (0.158s)
[100.910301] Starting dynamic subtest: pipe-C-DP-1
[101.039845] Dynamic subtest pipe-C-DP-1: SUCCESS (0.161s)
[101.060421] Subtest lease-unleased-connector: SUCCESS (0.485s)
[101.163772] [032/138] (909s left) gem_pread (uncached)
[101.404566] Starting subtest: uncached
[105.865795] Subtest uncached: SUCCESS (4.299s)
[105.951233] [033/138] (905s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[106.282105] Starting subtest: x-tiled-addfb-size-offset-overflow
[106.324369] Subtest x-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[106.409472] [034/138] (904s left) syncobj_wait (multi-wait-signaled)
[106.646702] Starting subtest: multi-wait-signaled
[106.666286] Subtest multi-wait-signaled: SUCCESS (0.001s)
[106.746401] [035/138] (904s left) api_intel_bb (reset-bb)
[106.985731] Starting subtest: reset-bb
[107.004428] Subtest reset-bb: SUCCESS (0.007s)
[107.096360] [036/138] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[107.464980] Starting subtest: fbcpsr-2p-rte
[107.502827] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[107.590590] [037/138] (903s left) kms_pm_rpm (i2c)
[109.376550] Starting subtest: i2c
[111.392484] Subtest i2c: SUCCESS (2.015s)
[111.596372] [038/138] (899s left) gem_mmap_wc (fault-concurrent)
[111.833714] Starting subtest: fault-concurrent
[113.489392] Subtest fault-concurrent: SUCCESS (1.689s)
[113.595808] [039/138] (897s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[113.827441] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[113.869563] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[114.040550] [040/138] (897s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[114.414335] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[114.451171] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[114.539757] [041/138] (897s left) gem_exec_schedule (semaphore-resolve)
[114.963303] Starting subtest: semaphore-resolve
[114.989515] Subtest semaphore-resolve: SUCCESS (0.053s)
[115.220329] [042/138] (896s left) vc4/vc4_tiling (set-get)
[115.547811] Subtest set-get: SKIP (0.000s)
[115.655999] [043/138] (896s left) gem_exec_whisper (basic-queues)
[115.942812] Starting subtest: basic-queues
[123.187771] Subtest basic-queues: SUCCESS (7.184s)
[123.318187] [044/138] (888s left) kms_psr (psr2_primary_blt)
[123.602062] Subtest psr2_primary_blt: SKIP (0.000s)
[123.696464] [045/138] (888s left) gem_exec_params (rel-constants-invalid-ring)
[123.934375] Starting subtest: rel-constants-invalid-ring
[123.953214] Subtest rel-constants-invalid-ring: SUCCESS (0.001s)
[124.037651] [046/138] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[124.415697] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[126.615584] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.279s)
[126.786713] [047/138] (885s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[127.085749] Starting subtest: primary-x-tiled-reflect-x-0
[127.122555] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[127.213269] [048/138] (885s left) kms_universal_plane (universal-plane-functional)
[127.512118] Starting subtest: universal-plane-functional
[127.532314] Starting dynamic subtest: pipe-A-DP-1
[129.950786] Dynamic subtest pipe-A-DP-1: SUCCESS (2.423s)
[129.985670] Starting dynamic subtest: pipe-B-DP-1
[132.522287] Dynamic subtest pipe-B-DP-1: SUCCESS (2.578s)
[132.557467] Starting dynamic subtest: pipe-C-DP-1
[135.116553] Dynamic subtest pipe-C-DP-1: SUCCESS (2.576s)
[135.138576] Subtest universal-plane-functional: SUCCESS (7.588s)
[135.438963] [049/138] (876s left) gem_mmap_gtt (basic-write-read-distinct)
[135.687233] Starting subtest: basic-write-read-distinct
[135.705821] Subtest basic-write-read-distinct: SUCCESS (0.035s)
[135.824292] [050/138] (876s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[136.124683] Starting subtest: cursor-vs-flip-varying-size
[178.075066] Subtest cursor-vs-flip-varying-size: SUCCESS (41.950s)
[178.441658] [051/138] (834s left) i915_pm_rpm (debugfs-forcewake-user)
[180.225307] Starting subtest: debugfs-forcewake-user
[190.846427] Subtest debugfs-forcewake-user: SUCCESS (10.494s)
[191.229784] [052/138] (821s left) kms_color (legacy-gamma)
[191.578530] Starting subtest: legacy-gamma
[191.603395] Starting dynamic subtest: pipe-A
[192.146612] Dynamic subtest pipe-A: SUCCESS (0.581s)
[192.195064] Starting dynamic subtest: pipe-B
[192.907357] Dynamic subtest pipe-B: SUCCESS (0.757s)
[192.942965] Starting dynamic subtest: pipe-C
[193.669088] Dynamic subtest pipe-C: SUCCESS (0.763s)
[193.690830] Subtest legacy-gamma: SUCCESS (2.106s)
[194.019648] [053/138] (818s left) kms_writeback (writeback-fb-id-xrgb2101010)
[194.453085] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[194.541193] [054/138] (818s left) kms_properties (plane-properties-atomic)
[194.846126] Starting subtest: plane-properties-atomic
[195.851898] Subtest plane-properties-atomic: SUCCESS (0.990s)
[196.194920] [055/138] (816s left) gem_exec_fence (basic-await)
[196.561310] Starting subtest: basic-await
[196.581723] Starting dynamic subtest: rcs0
[196.690238] Dynamic subtest rcs0: SUCCESS (0.130s)
[196.725352] Starting dynamic subtest: bcs0
[196.824030] Dynamic subtest bcs0: SUCCESS (0.130s)
[196.862789] Starting dynamic subtest: vcs0
[196.956541] Dynamic subtest vcs0: SUCCESS (0.129s)
[196.993902] Starting dynamic subtest: vecs0
[197.085284] Dynamic subtest vecs0: SUCCESS (0.128s)
[197.103739] Subtest basic-await: SUCCESS (0.528s)
[197.873204] [056/138] (815s left) prime_busy (after)
[198.108822] Starting subtest: after
[198.128534] Starting dynamic subtest: rcs0
[198.147338] Dynamic subtest rcs0: SUCCESS (0.022s)
[198.182464] Starting dynamic subtest: bcs0
[198.200802] Dynamic subtest bcs0: SUCCESS (0.016s)
[198.235903] Starting dynamic subtest: vcs0
[198.257039] Dynamic subtest vcs0: SUCCESS (0.017s)
[198.294123] Starting dynamic subtest: vecs0
[198.314982] Dynamic subtest vecs0: SUCCESS (0.018s)
[198.334729] Subtest after: SUCCESS (0.213s)
[198.419530] [057/138] (814s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-rc-ccs)
[198.896615] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs
[198.933366] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[199.276200] [058/138] (813s left) syncobj_timeline (wait-all-snapshot)
[199.503300] Starting subtest: wait-all-snapshot
[199.554145] Subtest wait-all-snapshot: SUCCESS (0.084s)
[199.660574] [059/138] (813s left) sw_sync (timeline_closed)
[199.875446] Starting subtest: timeline_closed
[199.894157] Subtest timeline_closed: SUCCESS (0.000s)
[199.982741] [060/138] (813s left) gem_ctx_isolation (preservation-s3)
[200.215412] Starting subtest: preservation-S3
[200.236546] Starting dynamic subtest: rcs0
[218.605907] Dynamic subtest rcs0: SUCCESS (2.851s)
[218.645990] Starting dynamic subtest: bcs0
[237.679414] Dynamic subtest bcs0: SUCCESS (3.019s)
[237.718699] Starting dynamic subtest: vcs0
[256.568756] Dynamic subtest vcs0: SUCCESS (2.674s)
[256.610233] Starting dynamic subtest: vecs0
[275.573283] Dynamic subtest vecs0: SUCCESS (2.684s)
[275.591777] Subtest preservation-S3: SUCCESS (11.238s)
[281.039737] [061/138] (801s left) gem_pwrite (basic-exhaustion)
[281.274059] Starting subtest: basic-exhaustion
[297.595178] Subtest basic-exhaustion: SUCCESS (16.336s)
[297.728178] [062/138] (785s left) gen9_exec_parse (bb-start-far)
[297.960860] Starting subtest: bb-start-far
[297.982196] Subtest bb-start-far: SUCCESS (0.005s)
[298.203090] [063/138] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[298.581071] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[298.617979] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[298.709303] [064/138] (784s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[299.091694] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[299.128361] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[299.243575] [065/138] (783s left) kms_flip (dpms-vs-vblank-race)
[299.538949] Starting subtest: dpms-vs-vblank-race
[299.557152] Starting dynamic subtest: A-DP1
[303.843757] Dynamic subtest A-DP1: SUCCESS (4.287s)
[303.885844] Starting dynamic subtest: B-DP1
[307.994504] Dynamic subtest B-DP1: SUCCESS (4.159s)
[308.035472] Starting dynamic subtest: C-DP1
[312.150631] Dynamic subtest C-DP1: SUCCESS (4.146s)
[312.169353] Subtest dpms-vs-vblank-race: SUCCESS (12.605s)
[312.528320] [066/138] (770s left) gem_ctx_param (invalid-size-get)
[312.778350] Starting subtest: invalid-size-get
[312.796704] Subtest invalid-size-get: SUCCESS (0.000s)
[312.886371] [067/138] (770s left) gem_exec_balancer (bonded-dual)
[313.106009] Starting subtest: bonded-dual
[317.051715] Subtest bonded-dual: SUCCESS (3.772s)
[320.974123] [068/138] (762s left) gem_flink_basic (basic)
[321.201186] Starting subtest: basic
[321.219917] Subtest basic: SUCCESS (0.000s)
[321.313502] [069/138] (762s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[321.627367] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[321.645584] Starting dynamic subtest: A-DP1
[332.574233] Dynamic subtest A-DP1: SUCCESS (10.785s)
[332.624151] Starting dynamic subtest: B-DP1
[343.122926] Dynamic subtest B-DP1: SUCCESS (10.720s)
[343.163244] Starting dynamic subtest: C-DP1
[354.022566] Dynamic subtest C-DP1: SUCCESS (10.721s)
[354.041266] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.240s)
[354.293411] [070/138] (729s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[354.674662] Starting subtest: fbc-rgb565-draw-mmap-wc
[356.759130] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.164s)
[356.938287] [071/138] (726s left) gem_mmap_offset (close-race)
[357.176730] Starting subtest: close-race
[377.263053] Subtest close-race: SUCCESS (20.117s)
[377.409594] [072/138] (706s left) kms_ccs (pipe-c-ccs-on-another-bo-yf-tiled-ccs)
[377.917226] Starting subtest: pipe-C-ccs-on-another-bo-yf-tiled-ccs
[377.955355] Subtest pipe-C-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[378.280846] [073/138] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[378.633903] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[378.675458] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[378.769560] [074/138] (705s left) gem_mmap_wc (read-write-distinct)
[379.006288] Starting subtest: read-write-distinct
[379.026256] Subtest read-write-distinct: SUCCESS (0.033s)
[379.142568] [075/138] (704s left) kms_frontbuffer_tracking (psr-slowdraw)
[379.515831] Starting subtest: psr-slowdraw
[379.552925] Subtest psr-slowdraw: SKIP (0.000s)
[379.650663] [076/138] (704s left) gem_mmap_gtt (fault-concurrent-x)
[379.877354] Starting subtest: fault-concurrent-X
[383.522038] Subtest fault-concurrent-X: SUCCESS (3.503s)
[383.657467] [077/138] (700s left) kms_atomic_transition (modeset-transition)
[383.952099] Starting subtest: modeset-transition
[383.973452] Starting dynamic subtest: 1x-outputs
[388.792746] Dynamic subtest 1x-outputs: SUCCESS (4.838s)
[388.897121] Subtest modeset-transition: SUCCESS (4.936s)
[389.246063] [078/138] (695s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[389.571441] Starting subtest: extended-modeset-hang-oldfb-with-reset
[389.591372] Starting dynamic subtest: pipe-A
[391.478099] Dynamic subtest pipe-A: SUCCESS (1.903s)
[391.517052] Starting dynamic subtest: pipe-C
[393.588502] Dynamic subtest pipe-C: SUCCESS (2.084s)
[393.609985] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.002s)
[393.915612] [079/138] (690s left) gem_exec_schedule (fifo)
[394.304419] Starting subtest: fifo
[394.323117] Starting dynamic subtest: rcs0
[394.343090] Dynamic subtest rcs0: SUCCESS (0.137s)
[394.386962] Starting dynamic subtest: bcs0
[394.432243] Dynamic subtest bcs0: SUCCESS (0.138s)
[394.475275] Starting dynamic subtest: vcs0
[394.550609] Dynamic subtest vcs0: SUCCESS (0.123s)
[394.591422] Starting dynamic subtest: vecs0
[394.679373] Dynamic subtest vecs0: SUCCESS (0.122s)
[394.701206] Subtest fifo: SUCCESS (0.532s)
[395.065324] [080/138] (689s left) perf_pmu (gt-awake)
[395.311399] Starting subtest: gt-awake
[397.854597] Subtest gt-awake: SUCCESS (2.564s)
[397.997135] [081/138] (686s left) kms_pm_rpm (pm-tiling)
[399.773999] Starting subtest: pm-tiling
[401.816909] Subtest pm-tiling: SUCCESS (2.042s)
[402.023496] [082/138] (682s left) gem_ctx_exec (basic)
[402.261234] Starting subtest: basic
[402.282083] Subtest basic: SUCCESS (0.006s)
[402.372783] [083/138] (682s left) drm_fdinfo (basics)
[402.594707] Starting subtest: basics
[402.613527] Subtest basics: SUCCESS (0.000s)
[402.703647] [084/138] (682s left) v3d/v3d_submit_csd (multi-and-single-sync)
[402.991388] Subtest multi-and-single-sync: SKIP (0.000s)
[403.088809] [085/138] (681s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[403.407723] Starting subtest: stress-mm-invalidate-close-overlap
[405.487313] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[405.653468] [086/138] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[406.019401] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[406.060507] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[406.152217] [087/138] (678s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[406.446048] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[406.468409] Starting dynamic subtest: pipe-A-valid-mode
[406.929228] Dynamic subtest pipe-A-valid-mode: SKIP (0.449s)
[406.966584] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.453s)
[407.299046] [088/138] (677s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[407.573456] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[407.666349] [089/138] (677s left) v3d/v3d_job_submission (array-job-submission)
[407.951339] Subtest array-job-submission: SKIP (0.000s)
[408.043959] [090/138] (677s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[408.262638] Starting subtest: y-tiled-ccs-to-y-tiled
[408.281490] Starting dynamic subtest: smem
[408.554766] Dynamic subtest smem: SUCCESS (0.296s)
[408.576138] Subtest y-tiled-ccs-to-y-tiled: SUCCESS (0.298s)
[408.780704] [091/138] (676s left) kms_prop_blob (invalid-get-prop-any)
[409.019676] Starting subtest: invalid-get-prop-any
[409.038554] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[409.131338] [092/138] (676s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[409.505564] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[409.542901] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[409.640389] [093/138] (675s left) kms_flip (nonexisting-fb-interruptible)
[409.924497] Starting subtest: nonexisting-fb-interruptible
[409.945634] Starting dynamic subtest: A-DP1
[410.411565] Dynamic subtest A-DP1: SUCCESS (0.490s)
[410.450652] Starting dynamic subtest: B-DP1
[410.865128] Dynamic subtest B-DP1: SUCCESS (0.433s)
[410.909561] Starting dynamic subtest: C-DP1
[411.306401] Dynamic subtest C-DP1: SUCCESS (0.439s)
[411.330229] Subtest nonexisting-fb-interruptible: SUCCESS (1.376s)
[411.751079] [094/138] (673s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-ccs)
[412.303282] Subtest pipe-D-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[412.623805] [095/138] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[412.961644] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[413.002736] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[413.095219] [096/138] (672s left) kms_lease (page-flip-implicit-plane)
[413.398518] Starting subtest: page-flip-implicit-plane
[413.420341] Starting dynamic subtest: pipe-A-DP-1
[413.685618] Dynamic subtest pipe-A-DP-1: SUCCESS (0.288s)
[413.736543] Starting dynamic subtest: pipe-B-DP-1
[414.152785] Dynamic subtest pipe-B-DP-1: SUCCESS (0.466s)
[414.193095] Starting dynamic subtest: pipe-C-DP-1
[414.627835] Dynamic subtest pipe-C-DP-1: SUCCESS (0.473s)
[414.646460] Subtest page-flip-implicit-plane: SUCCESS (1.240s)
[414.981947] [097/138] (670s left) gem_sync (basic-each)
[415.383927] Starting subtest: basic-each
[417.620694] Subtest basic-each: SUCCESS (2.403s)
[417.843014] [098/138] (668s left) i915_query (query-garbage)
[418.075979] Starting subtest: query-garbage
[418.094797] Subtest query-garbage: SUCCESS (0.000s)
[418.190387] [099/138] (667s left) kms_force_connector_basic (force-edid)
[418.458280] Subtest force-edid: SKIP (0.000s)
[418.556201] [100/138] (667s left) syncobj_timeline (single-wait-all-available-submitted)
[418.785952] Starting subtest: single-wait-all-available-submitted
[418.808793] Subtest single-wait-all-available-submitted: SUCCESS (0.002s)
[418.912964] [101/138] (667s left) kms_dsc (dsc-with-output-formats-with-bpc)
[419.287091] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[419.423166] [102/138] (667s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[419.732698] Starting subtest: basic-busy-flip-before-cursor-varying-size
[419.771942] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[419.868072] [103/138] (666s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[420.236230] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[420.256623] Starting dynamic subtest: pipe-A-DP-1
[420.586794] Dynamic subtest pipe-A-DP-1: SUCCESS (0.343s)
[420.683831] Starting dynamic subtest: pipe-B-DP-1
[420.965056] Dynamic subtest pipe-B-DP-1: SUCCESS (0.392s)
[421.041154] Starting dynamic subtest: pipe-C-DP-1
[421.084616] Dynamic subtest pipe-C-DP-1: SKIP (0.095s)
[421.107026] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.846s)
[421.484554] [104/138] (665s left) kms_flip (basic-flip-vs-modeset)
[421.781942] Starting subtest: basic-flip-vs-modeset
[421.802993] Starting dynamic subtest: A-DP1
[423.028609] Dynamic subtest A-DP1: SUCCESS (1.257s)
[423.068828] Starting dynamic subtest: B-DP1
[424.180392] Dynamic subtest B-DP1: SUCCESS (1.150s)
[424.224723] Starting dynamic subtest: C-DP1
[425.313849] Dynamic subtest C-DP1: SUCCESS (1.118s)
[425.333582] Subtest basic-flip-vs-modeset: SUCCESS (3.538s)
[425.688392] [105/138] (661s left) gem_ctx_param (root-set)
[425.928774] Starting subtest: root-set
[425.949582] Subtest root-set: SUCCESS (0.000s)
[426.041280] [106/138] (660s left) kms_vblank (wait-forked-hang)
[426.352890] Starting subtest: wait-forked-hang
[426.374417] Starting dynamic subtest: pipe-A-DP-1
[433.265052] Dynamic subtest pipe-A-DP-1: SUCCESS (6.807s)
[433.306183] Starting dynamic subtest: pipe-C-DP-1
[440.228288] Dynamic subtest pipe-C-DP-1: SUCCESS (6.952s)
[440.247342] Subtest wait-forked-hang: SUCCESS (13.772s)
[440.496527] [107/138] (646s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[440.725238] Starting subtest: x-tiled-to-vebox-y-tiled
[440.762499] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[440.947483] [108/138] (646s left) gem_mmap_gtt (medium-copy)
[441.176670] Starting subtest: medium-copy
[447.869394] Subtest medium-copy: SUCCESS (6.732s)
[448.007675] [109/138] (639s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[448.557495] Starting subtest: fbc-rgb565-draw-pwrite
[450.863537] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.364s)
[451.033001] [110/138] (636s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[451.406906] Starting subtest: y-tiled-32bpp-rotate-0
[456.696519] Subtest y-tiled-32bpp-rotate-0: SUCCESS (5.328s)
[457.257233] [111/138] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[457.615842] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[457.658668] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[457.756412] [112/138] (629s left) v3d/v3d_submit_cl (bad-pad)
[458.077046] Subtest bad-pad: SKIP (0.000s)
[458.168079] [113/138] (629s left) syncobj_wait (wait-for-submit-delayed-submit)
[458.391003] Starting subtest: wait-for-submit-delayed-submit
[458.464222] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[458.584804] [114/138] (629s left) syncobj_timeline (host-signal-ordered)
[458.818072] Starting subtest: host-signal-ordered
[458.839348] Subtest host-signal-ordered: SUCCESS (0.002s)
[458.939299] [115/138] (628s left) kms_hdr (invalid-metadata-sizes)
[459.244400] Starting subtest: invalid-metadata-sizes
[459.281363] Subtest invalid-metadata-sizes: SKIP (0.000s)
[459.383244] [116/138] (628s left) gem_blits (basic)
[459.617433] Starting subtest: basic
[472.781824] Subtest basic: SUCCESS (12.986s)
[472.890244] [117/138] (615s left) kms_ccs (pipe-b-bad-rotation-90-yf-tiled-ccs)
[473.351669] Starting subtest: pipe-B-bad-rotation-90-yf-tiled-ccs
[473.825161] Subtest pipe-B-bad-rotation-90-yf-tiled-ccs: SUCCESS (0.450s)
[474.343501] [118/138] (613s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[474.684150] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[474.726812] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[474.823958] [119/138] (613s left) gem_wait (write-busy)
[475.085655] Starting subtest: write-busy
[475.104476] Starting dynamic subtest: all-engines
[475.607685] Dynamic subtest all-engines: SUCCESS (0.530s)
[475.653963] Starting dynamic subtest: rcs0
[476.133351] Dynamic subtest rcs0: SUCCESS (0.519s)
[476.173938] Starting dynamic subtest: bcs0
[476.656256] Dynamic subtest bcs0: SUCCESS (0.518s)
[476.699121] Starting dynamic subtest: vcs0
[477.175991] Dynamic subtest vcs0: SUCCESS (0.525s)
[477.216949] Starting dynamic subtest: vecs0
[477.704508] Dynamic subtest vecs0: SUCCESS (0.519s)
[477.725857] Subtest write-busy: SUCCESS (2.626s)
[477.969784] [120/138] (610s left) gem_exec_fence (syncobj-timeline-export)
[478.781968] Starting subtest: syncobj-timeline-export
[478.800839] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[479.039362] [121/138] (609s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-rc-ccs)
[479.531860] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs
[479.602431] Subtest pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[479.896260] [122/138] (608s left) gem_spin_batch (spin-all)
[480.132255] Starting subtest: spin-all
[480.152323] Subtest spin-all: SUCCESS (0.025s)
[480.407284] [123/138] (608s left) api_intel_bb (bb-with-allocator)
[480.665146] Starting subtest: bb-with-allocator
[480.684833] Subtest bb-with-allocator: SUCCESS (0.011s)
[480.776835] [124/138] (607s left) kms_plane (pixel-format)
[481.064946] Starting subtest: pixel-format
[481.085009] Starting dynamic subtest: pipe-A
[487.704150] Dynamic subtest pipe-A: SUCCESS (6.618s)
[487.747653] Starting dynamic subtest: pipe-B
[494.481290] Dynamic subtest pipe-B: SUCCESS (6.774s)
[494.504560] Subtest pixel-format: SUCCESS (13.403s)
[494.829584] [125/138] (593s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[495.254915] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[495.296820] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.001s)
[495.712568] [126/138] (593s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[496.048562] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[496.126749] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.029s)
[496.225758] [127/138] (592s left) kms_chamelium_edid (dp-edid-read)
[496.640027] Subtest dp-edid-read: SKIP (0.000s)
[496.935806] [128/138] (591s left) gem_exec_schedule (noreorder-priority)
[497.337827] Starting subtest: noreorder-priority
[497.357568] Starting dynamic subtest: rcs0
[498.421504] Dynamic subtest rcs0: SUCCESS (1.123s)
[498.469551] Starting dynamic subtest: bcs0
[499.556192] Dynamic subtest bcs0: SUCCESS (1.129s)
[499.606013] Starting dynamic subtest: vcs0
[500.685639] Dynamic subtest vcs0: SUCCESS (1.127s)
[500.734206] Starting dynamic subtest: vecs0
[501.809695] Dynamic subtest vecs0: SUCCESS (1.119s)
[501.829505] Subtest noreorder-priority: SUCCESS (4.512s)
[502.041949] [129/138] (586s left) kms_hdmi_inject (inject-4k)
[502.294921] Subtest inject-4k: SKIP (0.000s)
[502.393099] [130/138] (586s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[502.944800] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[503.269065] [131/138] (585s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[503.718762] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[503.762407] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s)
[504.161843] [132/138] (585s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[504.382789] Starting subtest: addfb25-x-tiled-legacy
[504.404121] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[504.588072] [133/138] (584s left) gem_exec_flush (basic-uc-ro-default)
[504.865972] Starting subtest: basic-uc-ro-default
[510.489205] Subtest basic-uc-ro-default: SUCCESS (5.468s)
[510.623377] [134/138] (578s left) i915_pm_rps (min-max-config-loaded)
[510.894819] Starting subtest: min-max-config-loaded
[511.240438] Subtest min-max-config-loaded: SUCCESS (0.377s)
[511.377689] [135/138] (578s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[511.849284] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[511.886787] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[512.239806] [136/138] (577s left) gem_ctx_persistence (legacy-engines-hang)
[512.459790] Starting subtest: legacy-engines-hang
[512.480746] Starting dynamic subtest: render
[512.500745] Dynamic subtest render: SUCCESS (0.035s)
[512.546046] Starting dynamic subtest: bsd
[512.564700] Dynamic subtest bsd: SUCCESS (0.031s)
[512.605259] Starting dynamic subtest: blt
[512.646453] Dynamic subtest blt: SKIP (0.004s)
[512.689816] Starting dynamic subtest: vebox
[512.710613] Dynamic subtest vebox: SUCCESS (0.047s)
[512.730349] Subtest legacy-engines-hang: SUCCESS (0.130s)
[512.823453] [137/138] (577s left) prime_mmap (test_aperture_limit)
[513.063698] Starting subtest: test_aperture_limit
[513.082584] Starting dynamic subtest: test_aperture_limit-smem
[513.101323] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.025s)
[513.121491] Subtest test_aperture_limit: SUCCESS (0.028s)
[513.221717] [138/138] (576s left) perf (low-oa-exponent-permissions)
[513.604536] Starting subtest: low-oa-exponent-permissions
[513.766191] Subtest low-oa-exponent-permissions: SUCCESS (0.165s)
[513.862562] Closing watchdogs
Done.