[68.536646] Initializing watchdogs
[68.536721]   /dev/watchdog0
[68.568090] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.582991] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.588259] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.591679] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[70.104111] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[70.107852] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[70.281927] [002/132] (958s left) kms_content_protection (dp-mst-type-1)
[71.867259] Starting subtest: dp-mst-type-1
[71.870908] Subtest dp-mst-type-1: SKIP (0.000s)
[72.205660] [003/132] (957s left) i915_pm_rpm (gem-evict-pwrite)
[76.077258] Starting subtest: gem-evict-pwrite
[76.082214] Subtest gem-evict-pwrite: SKIP (0.000s)
[77.002956] [004/132] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[78.501456] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[78.504944] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[78.714531] [005/132] (950s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[80.203296] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[80.204798] Starting dynamic subtest: pipe-A-valid-mode
[81.003272] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.797s)
[81.004845] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.799s)
[81.172789] [006/132] (948s left) kms_psr (fbc-psr-no-drrs)
[82.662750] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[82.737895] [007/132] (946s left) gem_render_copy_redux (flink-interruptible)
[82.803133] Starting subtest: flink-interruptible
[84.844603] Subtest flink-interruptible: SUCCESS (2.043s)
[85.065810] [008/132] (944s left) gem_create (create-ext-cpu-access-sanity-check)
[85.233272] Starting subtest: create-ext-cpu-access-sanity-check
[85.237151] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.008s)
[85.383675] [009/132] (944s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[86.898612] Starting subtest: fbc-modesetfrombusy
[88.247943] Subtest fbc-modesetfrombusy: SUCCESS (1.351s)
[88.463111] [010/132] (941s left) tools_test (tools_test)
[88.523049] Starting subtest: tools_test
[88.621241] Subtest tools_test: SUCCESS (0.110s)
[88.716636] [011/132] (941s left) gem_eio (execbuf)
[88.915185] Starting subtest: execbuf
[89.202557] Subtest execbuf: SUCCESS (0.290s)
[90.767613] [012/132] (939s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[95.101494] Starting subtest: dpms-mode-unset-non-lpsp
[96.084316] Subtest dpms-mode-unset-non-lpsp: SKIP (0.979s)
[97.016370] [013/132] (933s left) kms_psr (psr2-basic)
[98.506447] Subtest psr2-basic: SKIP (0.000s)
[98.583000] [014/132] (931s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[100.074033] Starting subtest: plane-lut1d-pre-ctm3x4
[100.278176] Starting dynamic subtest: pipe-A-plane-0
[100.527881] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[100.565063] Starting dynamic subtest: pipe-A-plane-1
[100.727978] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[100.762151] Starting dynamic subtest: pipe-A-plane-2
[100.944862] Dynamic subtest pipe-A-plane-2: SUCCESS (0.215s)
[101.214823] Starting dynamic subtest: pipe-B-plane-0
[101.388566] Dynamic subtest pipe-B-plane-0: SUCCESS (0.184s)
[101.402775] Starting dynamic subtest: pipe-B-plane-1
[101.554838] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[101.584855] Starting dynamic subtest: pipe-B-plane-2
[101.755346] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[102.065391] Starting dynamic subtest: pipe-C-plane-0
[102.223348] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s)
[102.251375] Starting dynamic subtest: pipe-C-plane-1
[102.438125] Dynamic subtest pipe-C-plane-1: SUCCESS (0.215s)
[102.452118] Starting dynamic subtest: pipe-C-plane-2
[102.621756] Dynamic subtest pipe-C-plane-2: SUCCESS (0.182s)
[102.897902] Starting dynamic subtest: pipe-D-plane-0
[103.077215] Dynamic subtest pipe-D-plane-0: SUCCESS (0.200s)
[103.096733] Starting dynamic subtest: pipe-D-plane-1
[103.278250] Dynamic subtest pipe-D-plane-1: SUCCESS (0.199s)
[103.309988] Starting dynamic subtest: pipe-D-plane-2
[103.495175] Dynamic subtest pipe-D-plane-2: SUCCESS (0.215s)
[103.550323] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.473s)
[103.721395] [015/132] (926s left) gem_exec_balancer (parallel)
[104.146156] Starting subtest: parallel
[106.288445] Subtest parallel: SUCCESS (2.143s)
[106.407479] [016/132] (923s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[106.454645] Starting subtest: multi-wait-all-for-submit-signaled
[106.455977] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[106.559712] [017/132] (923s left) perf_pmu (render-node-busy-idle)
[106.611410] Starting subtest: render-node-busy-idle
[106.612853] Starting dynamic subtest: rcs0
[107.312490] Dynamic subtest rcs0: SUCCESS (0.701s)
[107.325457] Starting dynamic subtest: bcs0
[107.974137] Dynamic subtest bcs0: SUCCESS (0.660s)
[107.989451] Starting dynamic subtest: vcs0
[108.631207] Dynamic subtest vcs0: SUCCESS (0.655s)
[108.646501] Starting dynamic subtest: vcs1
[109.289194] Dynamic subtest vcs1: SUCCESS (0.656s)
[109.302467] Starting dynamic subtest: vecs0
[109.950501] Dynamic subtest vecs0: SUCCESS (0.660s)
[109.953254] Subtest render-node-busy-idle: SUCCESS (3.338s)
[110.076998] [018/132] (920s left) gem_mmap_gtt (fault-concurrent-x)
[110.127037] Subtest fault-concurrent-X: SKIP (0.000s)
[110.201767] [019/132] (920s left) kms_pipe_crc_basic (nonblocking-crc)
[111.686954] Starting subtest: nonblocking-crc
[111.688544] Starting dynamic subtest: pipe-A-HDMI-A-1
[112.467862] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.779s)
[112.478750] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.044560] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.574s)
[113.057424] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.603688] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.557s)
[113.616786] Starting dynamic subtest: pipe-D-HDMI-A-1
[114.175589] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.570s)
[114.177052] Subtest nonblocking-crc: SUCCESS (2.488s)
[114.347186] [020/132] (916s left) kms_async_flips (async-flip-dpms)
[115.852114] Starting subtest: async-flip-dpms
[116.125014] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.843542] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.718s)
[119.822606] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.932635] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.120s)
[122.193486] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.305924] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.126s)
[124.580067] Starting dynamic subtest: pipe-D-HDMI-A-1
[126.689642] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.126s)
[126.690945] Subtest async-flip-dpms: SUCCESS (10.836s)
[127.106872] [021/132] (903s left) gem_exec_params (cliprects-invalid)
[127.162223] Starting subtest: cliprects-invalid
[127.163765] Subtest cliprects-invalid: SUCCESS (0.000s)
[127.312739] [022/132] (903s left) kms_draw_crc (draw-method-mmap-cpu)
[128.799278] Starting subtest: draw-method-mmap-cpu
[128.800782] Starting dynamic subtest: xrgb8888-untiled
[129.161807] Dynamic subtest xrgb8888-untiled: SUCCESS (0.362s)
[129.189046] Starting dynamic subtest: rgb565-untiled
[129.495451] Dynamic subtest rgb565-untiled: SUCCESS (0.331s)
[129.528616] Starting dynamic subtest: xrgb2101010-untiled
[129.811788] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s)
[129.853157] Starting dynamic subtest: xbgr16161616f-untiled
[130.178622] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.364s)
[130.218965] Starting dynamic subtest: xrgb8888-xtiled
[130.378062] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s)
[130.405658] Starting dynamic subtest: rgb565-xtiled
[130.561828] Dynamic subtest rgb565-xtiled: SUCCESS (0.182s)
[130.589884] Starting dynamic subtest: xrgb2101010-xtiled
[130.728842] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.165s)
[130.769214] Starting dynamic subtest: xbgr16161616f-xtiled
[130.929282] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.197s)
[130.963233] Starting dynamic subtest: xrgb8888-ytiled
[131.112385] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.180s)
[131.125534] Starting dynamic subtest: rgb565-ytiled
[131.262573] Dynamic subtest rgb565-ytiled: SUCCESS (0.147s)
[131.304061] Starting dynamic subtest: xrgb2101010-ytiled
[131.446038] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.180s)
[131.488555] Starting dynamic subtest: xbgr16161616f-ytiled
[131.646121] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.197s)
[131.649192] Subtest draw-method-mmap-cpu: SUCCESS (2.847s)
[131.816419] [023/132] (898s left) gem_exec_reloc (basic-concurrent16)
[131.870694] Subtest basic-concurrent16: SKIP (0.000s)
[131.971757] [024/132] (898s left) gem_exec_whisper (basic-queues)
[132.031672] Starting subtest: basic-queues
[136.328897] Subtest basic-queues: SUCCESS (4.292s)
[136.553907] [025/132] (894s left) gem_ctx_persistence (processes)
[136.606557] Starting subtest: processes
[137.912027] Subtest processes: SUCCESS (1.305s)
[138.083041] [026/132] (892s left) kms_flip (flip-vs-wf_vblank-interruptible)
[139.575160] Starting subtest: flip-vs-wf_vblank-interruptible
[139.580477] Starting dynamic subtest: A-HDMI-A1
[140.573187] Dynamic subtest A-HDMI-A1: SUCCESS (0.993s)
[140.585938] Starting dynamic subtest: B-HDMI-A1
[141.517146] Dynamic subtest B-HDMI-A1: SUCCESS (0.942s)
[141.529695] Starting dynamic subtest: C-HDMI-A1
[142.462202] Dynamic subtest C-HDMI-A1: SUCCESS (0.944s)
[142.474163] Starting dynamic subtest: D-HDMI-A1
[143.389567] Dynamic subtest D-HDMI-A1: SUCCESS (0.926s)
[143.392461] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (3.817s)
[143.589693] [027/132] (887s left) sriov_basic (bind-unbind-vf)
[143.639815] Subtest bind-unbind-vf: SKIP (0.000s)
[143.719774] [028/132] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[145.214190] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[145.217399] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[145.404506] [029/132] (885s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[146.908405] Starting subtest: cursorB-vs-flipA-toggle
[146.912808] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[147.069974] [030/132] (884s left) gem_eio (throttle)
[147.288346] Starting subtest: throttle
[147.590161] Subtest throttle: SUCCESS (0.302s)
[149.187543] [031/132] (882s left) gen3_render_mixed_blits
[149.305424] [032/132] (882s left) syncobj_timeline (wait-all-interrupted)
[149.355796] Starting subtest: wait-all-interrupted
[149.466667] Subtest wait-all-interrupted: SUCCESS (0.109s)
[149.631322] [033/132] (882s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[149.679747] Starting subtest: invalid-single-wait-unsubmitted
[149.683442] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[149.797820] [034/132] (881s left) gem_eio (in-flight-suspend)
[149.998974] Starting subtest: in-flight-suspend
[192.719378] Subtest in-flight-suspend: SUCCESS (17.785s)
[198.317314] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[198.322938] [035/132] (837s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[199.836272] Starting subtest: x-tiled-addfb-size-offset-overflow
[199.837994] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s)
[200.018355] [036/132] (835s left) sw_sync (sync_busy_fork_unixsocket)
[200.063103] Starting subtest: sync_busy_fork_unixsocket
[200.073697] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s)
[200.167452] [037/132] (835s left) fbdev (nullptr)
[200.248028] Starting subtest: nullptr
[200.249396] Subtest nullptr: SUCCESS (0.000s)
[200.352206] [038/132] (835s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[201.839745] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[201.841511] Starting dynamic subtest: pipe-A-HDMI-A-1
[201.866623] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[201.879934] Starting dynamic subtest: pipe-B-HDMI-A-1
[201.896109] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[201.909174] Starting dynamic subtest: pipe-C-HDMI-A-1
[201.923233] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[201.936315] Starting dynamic subtest: pipe-D-HDMI-A-1
[201.951271] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[201.954248] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.011s)
[202.080953] [039/132] (834s left) kms_frontbuffer_tracking (psr-suspend)
[203.596263] Starting subtest: psr-suspend
[203.599578] Subtest psr-suspend: SKIP (0.000s)
[203.786976] [040/132] (832s left) gem_gtt_cpu_tlb
[203.927352] [041/132] (832s left) gem_exec_schedule (semaphore-codependency)
[204.009289] Starting subtest: semaphore-codependency
[204.037382] Subtest semaphore-codependency: SUCCESS (0.028s)
[204.511958] [042/132] (831s left) kms_addfb_basic (bad-pitch-256)
[204.560894] Starting subtest: bad-pitch-256
[204.562802] Subtest bad-pitch-256: SUCCESS (0.000s)
[206.273865] [043/132] (830s left) kms_psr (psr2-cursor-plane-onoff)
[207.761739] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[207.842833] [044/132] (828s left) gem_eio (kms)
[209.480235] Starting subtest: kms
[227.909438] Subtest kms: SUCCESS (18.427s)
[228.160403] [045/132] (808s left) gem_exec_fence (syncobj-invalid-flags)
[228.610259] Starting subtest: syncobj-invalid-flags
[228.611967] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[229.064677] [046/132] (807s left) kms_cursor_legacy (torture-move)
[230.553490] Starting subtest: torture-move
[230.555392] Starting dynamic subtest: pipe-A
[236.081007] Dynamic subtest pipe-A: SUCCESS (5.524s)
[236.102494] Starting dynamic subtest: pipe-B
[241.538642] Dynamic subtest pipe-B: SUCCESS (5.460s)
[241.553017] Starting dynamic subtest: pipe-C
[247.009400] Dynamic subtest pipe-C: SUCCESS (5.470s)
[247.022767] Starting dynamic subtest: pipe-D
[252.474527] Dynamic subtest pipe-D: SUCCESS (5.464s)
[252.488858] Starting dynamic subtest: all-pipes
[257.941551] Dynamic subtest all-pipes: SUCCESS (5.465s)
[257.943070] Subtest torture-move: SUCCESS (27.388s)
[258.123913] [047/132] (778s left) gem_render_copy (y-tiled-to-vebox-linear)
[258.183852] Starting subtest: y-tiled-to-vebox-linear
[258.185436] Starting dynamic subtest: smem
[258.262429] Dynamic subtest smem: SUCCESS (0.078s)
[258.276150] Starting dynamic subtest: lmem0
[258.389929] Dynamic subtest lmem0: SUCCESS (0.123s)
[258.391637] Subtest y-tiled-to-vebox-linear: SUCCESS (0.203s)
[258.675835] [048/132] (778s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[258.725575] Starting subtest: etime-single-wait-for-submit-unsubmitted
[258.824772] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.100s)
[259.036826] [049/132] (778s left) kms_cursor_crc (cursor-onscreen-128x42)
[260.721905] Starting subtest: cursor-onscreen-128x42
[260.728770] Starting dynamic subtest: pipe-A-HDMI-A-1
[263.520418] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.789s)
[263.553111] Starting dynamic subtest: pipe-D-HDMI-A-1
[266.162181] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.619s)
[266.163894] Subtest cursor-onscreen-128x42: SUCCESS (5.438s)
[266.616281] [050/132] (770s left) gem_pwrite (basic-random)
[266.664954] Subtest basic-random: SKIP (0.000s)
[266.767028] [051/132] (770s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[268.261512] Starting subtest: fbc-rgb101010-draw-blt
[271.218484] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.960s)
[271.490000] [052/132] (766s left) gem_exec_params (sol-reset-invalid)
[271.542014] Starting subtest: sol-reset-invalid
[271.545261] Subtest sol-reset-invalid: SUCCESS (0.002s)
[271.716337] [053/132] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[273.216929] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[273.220081] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[273.362079] [054/132] (764s left) kms_plane_scaling (planes-downscale-factor-0-75)
[274.849905] Starting subtest: planes-downscale-factor-0-75
[274.851219] Starting dynamic subtest: pipe-A
[274.950672] Dynamic subtest pipe-A: SUCCESS (0.100s)
[274.965161] Starting dynamic subtest: pipe-B
[275.091873] Dynamic subtest pipe-B: SUCCESS (0.140s)
[275.105081] Starting dynamic subtest: pipe-C
[275.232878] Dynamic subtest pipe-C: SUCCESS (0.140s)
[275.246403] Starting dynamic subtest: pipe-D
[275.373962] Dynamic subtest pipe-D: SUCCESS (0.140s)
[275.375613] Subtest planes-downscale-factor-0-75: SUCCESS (0.524s)
[275.567995] [055/132] (762s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[277.076675] Starting subtest: 2x-cursor-vs-flip-atomic
[277.079818] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s)
[277.287582] [056/132] (760s left) kms_psr (fbc-pr-basic)
[278.791074] Subtest fbc-pr-basic: SKIP (0.000s)
[278.886709] [057/132] (759s left) syncobj_wait (wait-any-interrupted)
[278.941006] Starting subtest: wait-any-interrupted
[279.051965] Subtest wait-any-interrupted: SUCCESS (0.107s)
[279.271625] [058/132] (758s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[280.777915] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[280.781637] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[280.937103] [059/132] (757s left) core_auth (many-magics)
[280.984840] Starting subtest: many-magics
[281.998855] Subtest many-magics: SUCCESS (1.014s)
[282.271577] [060/132] (756s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[282.319413] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[282.425674] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[282.566410] [061/132] (755s left) kms_plane (plane-position-covered)
[284.057041] Starting subtest: plane-position-covered
[284.488147] Starting dynamic subtest: pipe-A-plane-1
[284.860907] Dynamic subtest pipe-A-plane-1: SUCCESS (0.373s)
[284.874845] Starting dynamic subtest: pipe-A-plane-2
[285.237182] Dynamic subtest pipe-A-plane-2: SUCCESS (0.375s)
[285.251313] Starting dynamic subtest: pipe-A-plane-3
[285.610187] Dynamic subtest pipe-A-plane-3: SUCCESS (0.373s)
[285.623613] Starting dynamic subtest: pipe-A-plane-4
[285.967175] Dynamic subtest pipe-A-plane-4: SUCCESS (0.355s)
[285.980874] Starting dynamic subtest: pipe-A-plane-5
[286.325587] Dynamic subtest pipe-A-plane-5: SUCCESS (0.357s)
[286.339852] Starting dynamic subtest: pipe-A-plane-6
[286.682908] Dynamic subtest pipe-A-plane-6: SUCCESS (0.357s)
[286.696676] Starting dynamic subtest: pipe-A-plane-7
[286.703884] Dynamic subtest pipe-A-plane-7: SUCCESS (0.019s)
[286.994461] Starting dynamic subtest: pipe-B-plane-1
[287.351205] Dynamic subtest pipe-B-plane-1: SUCCESS (0.369s)
[287.365307] Starting dynamic subtest: pipe-B-plane-2
[287.718643] Dynamic subtest pipe-B-plane-2: SUCCESS (0.367s)
[287.732266] Starting dynamic subtest: pipe-B-plane-3
[288.088321] Dynamic subtest pipe-B-plane-3: SUCCESS (0.369s)
[288.102064] Starting dynamic subtest: pipe-B-plane-4
[288.476528] Dynamic subtest pipe-B-plane-4: SUCCESS (0.387s)
[288.490644] Starting dynamic subtest: pipe-B-plane-5
[288.851043] Dynamic subtest pipe-B-plane-5: SUCCESS (0.374s)
[288.864705] Starting dynamic subtest: pipe-B-plane-6
[289.206883] Dynamic subtest pipe-B-plane-6: SUCCESS (0.356s)
[289.224852] Starting dynamic subtest: pipe-B-plane-7
[289.236370] Dynamic subtest pipe-B-plane-7: SUCCESS (0.026s)
[289.238193] Subtest plane-position-covered: SUCCESS (5.182s)
[289.429020] [062/132] (749s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[290.918133] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[290.921217] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[291.121657] [063/132] (747s left) gem_exercise_blt (fast-copy-emit)
[291.176910] Starting subtest: fast-copy-emit
[291.178614] Starting dynamic subtest: linear-smem-smem-emit
[291.213625] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.036s)
[291.227230] Starting dynamic subtest: linear-smem-lmem0-emit
[291.231313] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s)
[291.245018] Starting dynamic subtest: linear-lmem0-smem-emit
[291.291117] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.060s)
[291.304644] Starting dynamic subtest: linear-lmem0-lmem0-emit
[291.350627] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.058s)
[291.364347] Starting dynamic subtest: ymajor-smem-smem-emit
[291.369466] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s)
[291.382954] Starting dynamic subtest: ymajor-smem-lmem0-emit
[291.384689] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s)
[291.398122] Starting dynamic subtest: ymajor-lmem0-smem-emit
[291.442812] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.060s)
[291.456104] Starting dynamic subtest: ymajor-lmem0-lmem0-emit
[291.502239] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.058s)
[291.515833] Starting dynamic subtest: tile4-smem-smem-emit
[291.520219] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[291.533757] Starting dynamic subtest: tile4-smem-lmem0-emit
[291.535557] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s)
[291.549256] Starting dynamic subtest: tile4-lmem0-smem-emit
[291.595298] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.060s)
[291.608551] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[291.655866] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.059s)
[291.669082] Starting dynamic subtest: tile64-smem-smem-emit
[291.673427] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[291.687109] Starting dynamic subtest: tile64-smem-lmem0-emit
[291.688902] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s)
[291.702602] Starting dynamic subtest: tile64-lmem0-smem-emit
[291.749527] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.060s)
[291.765864] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[291.810422] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.060s)
[291.812243] Subtest fast-copy-emit: SUCCESS (0.634s)
[291.987676] [064/132] (746s left) gem_readwrite (new-obj)
[292.035393] Subtest new-obj: SKIP (0.000s)
[292.120774] [065/132] (746s left) gem_exec_balancer (sequential)
[292.178662] Starting subtest: sequential
[296.406538] Subtest sequential: SUCCESS (4.228s)
[296.892151] [066/132] (741s left) kms_big_fb (linear-32bpp-rotate-180)
[298.398870] Starting subtest: linear-32bpp-rotate-180
[300.674096] Subtest linear-32bpp-rotate-180: SUCCESS (2.275s)
[300.930128] [067/132] (737s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[302.435392] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[302.438555] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[302.627863] [068/132] (736s left) kms_addfb_basic (unused-pitches)
[302.675557] Starting subtest: unused-pitches
[302.677168] Subtest unused-pitches: SUCCESS (0.000s)
[304.286841] [069/132] (734s left) gem_exec_schedule (preemptive-hang)
[304.486324] Starting subtest: preemptive-hang
[304.488986] Starting dynamic subtest: rcs0
[314.019926] Dynamic subtest rcs0: SUCCESS (9.540s)
[314.036423] Starting dynamic subtest: bcs0
[322.977507] Dynamic subtest bcs0: SUCCESS (8.956s)
[322.991225] Starting dynamic subtest: vcs0
[332.010052] Dynamic subtest vcs0: SUCCESS (9.030s)
[332.023808] Starting dynamic subtest: vcs1
[341.032098] Dynamic subtest vcs1: SUCCESS (9.022s)
[341.045830] Starting dynamic subtest: vecs0
[349.984351] Dynamic subtest vecs0: SUCCESS (8.950s)
[349.985668] Subtest preemptive-hang: SUCCESS (45.509s)
[350.263320] [070/132] (688s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[351.754985] Starting subtest: short-flip-after-cursor-atomic-transitions
[352.795749] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.040s)
[352.974911] [071/132] (686s left) gem_mmap_gtt (isolation)
[353.024823] Subtest isolation: SKIP (0.000s)
[353.108102] [072/132] (686s left) kms_psr (psr-primary-page-flip)
[354.598861] Subtest psr-primary-page-flip: SKIP (0.000s)
[354.670532] [073/132] (684s left) kms_busy (extended-modeset-hang-oldfb)
[356.166192] Starting subtest: extended-modeset-hang-oldfb
[356.167628] Starting dynamic subtest: pipe-A
[364.121279] Dynamic subtest pipe-A: SUCCESS (7.953s)
[364.137683] Starting dynamic subtest: pipe-D
[372.000240] Dynamic subtest pipe-D: SUCCESS (7.874s)
[372.001785] Subtest extended-modeset-hang-oldfb: SUCCESS (15.835s)
[372.181556] [074/132] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[373.680404] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[373.683861] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[373.878561] [075/132] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[375.373593] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[375.376985] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[375.579851] [076/132] (664s left) kms_vblank (query-forked)
[377.068252] Starting subtest: query-forked
[377.069870] Starting dynamic subtest: pipe-A-HDMI-A-1
[379.469139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.399s)
[379.485827] Starting dynamic subtest: pipe-D-HDMI-A-1
[381.711489] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.237s)
[381.713259] Subtest query-forked: SUCCESS (4.644s)
[381.889286] [077/132] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[383.387699] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[383.391700] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[383.586642] [078/132] (656s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[385.084529] Starting subtest: invalid-modeset-force-ultra-joiner
[385.087841] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[385.216171] [079/132] (654s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[386.707428] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[386.786982] [080/132] (653s left) gem_render_copy (yf-tiled)
[386.842482] Starting subtest: yf-tiled
[386.844023] Starting dynamic subtest: smem
[386.933113] Dynamic subtest smem: SUCCESS (0.090s)
[386.946928] Starting dynamic subtest: lmem0
[387.690938] Dynamic subtest lmem0: SUCCESS (0.753s)
[387.692626] Subtest yf-tiled: SUCCESS (0.846s)
[387.972192] [081/132] (652s left) kms_addfb_basic (invalid-set-prop)
[388.019958] Starting subtest: invalid-set-prop
[388.021551] Subtest invalid-set-prop: SUCCESS (0.000s)
[389.646906] [082/132] (650s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[391.149893] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[391.242517] [083/132] (649s left) i915_pm_freq_api (freq-suspend)
[391.301803] Starting subtest: freq-suspend
[391.303318] Starting dynamic subtest: gt0
[406.964052] Dynamic subtest gt0: SUCCESS (1.714s)
[406.965559] Subtest freq-suspend: SUCCESS (1.715s)
[413.194520] [084/132] (633s left) gem_mmap_gtt (basic-small-bo-tiledy)
[413.245309] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[413.326238] [085/132] (633s left) syncobj_wait (wait-all-for-submit-complex)
[413.375165] Starting subtest: wait-all-for-submit-complex
[413.595064] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[413.720599] [086/132] (632s left) kms_pm_rpm (modeset-non-lpsp-stress)
[417.958110] Starting subtest: modeset-non-lpsp-stress
[418.968517] Subtest modeset-non-lpsp-stress: SKIP (0.965s)
[419.946163] [087/132] (626s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[421.485793] Starting subtest: psr-rgb101010-draw-mmap-cpu
[421.489761] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[421.704434] [088/132] (625s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[423.247133] Starting subtest: x-tiled-8bpp-rotate-0
[424.962021] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.683s)
[425.142318] [089/132] (621s left) kms_prop_blob (invalid-set-prop)
[425.191555] Starting subtest: invalid-set-prop
[425.193127] Subtest invalid-set-prop: SUCCESS (0.000s)
[425.307870] [090/132] (621s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[426.824147] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[426.825604] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.864079] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[426.878282] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.921703] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[426.935657] Starting dynamic subtest: pipe-C-HDMI-A-1
[426.978362] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[426.991958] Starting dynamic subtest: pipe-D-HDMI-A-1
[427.030144] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[427.033186] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.021s)
[427.112620] [091/132] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[428.622766] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[428.636330] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[428.795070] [092/132] (618s left) gem_softpin (noreloc-s3)
[428.885013] Starting subtest: noreloc-S3
[449.517208] Subtest noreloc-S3: SUCCESS (10.643s)
[456.675488] [093/132] (597s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[458.183792] Starting subtest: y-tiled-32bpp-rotate-90
[460.273990] Subtest y-tiled-32bpp-rotate-90: SUCCESS (2.089s)
[460.522203] [094/132] (593s left) dmabuf_sync_file (import-multiple-read-write)
[460.574757] Starting subtest: import-multiple-read-write
[460.580365] Subtest import-multiple-read-write: SUCCESS (0.006s)
[460.677705] [095/132] (593s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[462.164531] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[462.167792] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[462.307945] [096/132] (592s left) kms_lease (lease-again)
[463.799659] Starting subtest: lease-again
[463.801298] Starting dynamic subtest: pipe-A-HDMI-A-1
[463.802944] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.003s)
[463.820912] Starting dynamic subtest: pipe-B-HDMI-A-1
[463.822591] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[463.836928] Starting dynamic subtest: pipe-C-HDMI-A-1
[463.838590] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.003s)
[463.852396] Starting dynamic subtest: pipe-D-HDMI-A-1
[463.856507] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.002s)
[463.858175] Subtest lease-again: SUCCESS (0.021s)
[463.983189] [097/132] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[465.481036] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[465.484742] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[465.654486] [098/132] (589s left) kms_chamelium_hpd (hdmi-hpd)
[467.186301] Subtest hdmi-hpd: SKIP (0.000s)
[467.306512] [099/132] (587s left) kms_flip (2x-plain-flip-ts-check)
[468.794862] Starting subtest: 2x-plain-flip-ts-check
[468.817441] Subtest 2x-plain-flip-ts-check: SKIP (0.021s)
[468.964663] [100/132] (586s left) kms_chamelium_color (ctm-red-to-blue)
[470.452855] Subtest ctm-red-to-blue: SKIP (0.000s)
[470.540825] [101/132] (584s left) gem_userptr_blits (set-cache-level)
[470.600190] Starting subtest: set-cache-level
[470.601668] Subtest set-cache-level: SUCCESS (0.000s)
[470.805225] [102/132] (584s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[472.313226] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[472.317004] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[472.477537] [103/132] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[473.974773] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[473.980383] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[474.185636] [104/132] (581s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[475.677958] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[475.700976] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.021s)
[475.856548] [105/132] (579s left) gem_softpin (full)
[475.910768] Starting subtest: full
[475.932088] Subtest full: SUCCESS (0.021s)
[476.161134] [106/132] (579s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[477.656914] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[477.660741] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.850313] [107/132] (577s left) kms_vrr (seamless-rr-switch-virtual)
[479.354595] Starting subtest: seamless-rr-switch-virtual
[479.359465] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[479.584502] [108/132] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[481.081750] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[481.085377] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[481.266977] [109/132] (574s left) kms_cursor_crc (cursor-sliding-512x512)
[483.021957] Starting subtest: cursor-sliding-512x512
[483.025478] Subtest cursor-sliding-512x512: SKIP (0.001s)
[483.282061] [110/132] (572s left) gen9_exec_parse (batch-invalid-length)
[483.340928] Subtest batch-invalid-length: SKIP (0.000s)
[483.427048] [111/132] (572s left) gem_render_linear_blits (basic)
[483.480123] Starting subtest: basic
[483.549629] Subtest basic: SUCCESS (0.069s)
[483.696838] [112/132] (572s left) kms_universal_plane (disable-primary-vs-flip)
[485.185198] Starting subtest: disable-primary-vs-flip
[485.186579] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.645283] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.458s)
[485.664933] Starting dynamic subtest: pipe-B-HDMI-A-1
[485.963549] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.316s)
[485.980205] Starting dynamic subtest: pipe-C-HDMI-A-1
[486.259496] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.292s)
[486.276128] Starting dynamic subtest: pipe-D-HDMI-A-1
[486.559901] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.298s)
[486.561398] Subtest disable-primary-vs-flip: SUCCESS (1.376s)
[486.739645] [113/132] (569s left) kms_plane_multiple (2x-tiling-none)
[488.229682] Starting subtest: 2x-tiling-none
[488.234144] Subtest 2x-tiling-none: SKIP (0.000s)
[488.425322] [114/132] (568s left) gem_exec_flush (basic-uc-ro-default)
[488.477460] Subtest basic-uc-ro-default: SKIP (0.000s)
[488.585251] [115/132] (568s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[490.073382] Starting subtest: bad-rotation-90-yf-tiled-ccs
[490.074775] Starting dynamic subtest: pipe-A-HDMI-A-1
[490.088904] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[490.103269] Starting dynamic subtest: pipe-B-HDMI-A-1
[490.117688] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[490.131597] Starting dynamic subtest: pipe-C-HDMI-A-1
[490.146448] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[490.160451] Starting dynamic subtest: pipe-D-HDMI-A-1
[490.176013] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[490.179177] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.010s)
[490.316224] [116/132] (566s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[491.823437] Starting subtest: 4-tiled-16bpp-rotate-180
[491.826796] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[492.021388] [117/132] (564s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[493.517602] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[493.521023] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[493.702542] [118/132] (563s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[495.197572] Starting subtest: fbc-shrfb-scaledprimary
[498.829048] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.633s)
[499.067816] [119/132] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[500.567536] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[500.570933] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[500.767437] [120/132] (556s left) gem_exec_params (rel-constants-invalid-ring)
[500.821748] Starting subtest: rel-constants-invalid-ring
[500.823561] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[500.958693] [121/132] (556s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[502.455124] Starting subtest: psr-farfromfence-mmap-gtt
[502.458736] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[502.671846] [122/132] (554s left) sysfs_timeslice_duration (invalid)
[502.743635] Starting subtest: invalid
[502.745368] Starting dynamic subtest: vecs0
[502.747033] Dynamic subtest vecs0: SUCCESS (0.000s)
[502.761478] Starting dynamic subtest: vcs0
[502.763321] Dynamic subtest vcs0: SUCCESS (0.000s)
[502.777444] Starting dynamic subtest: bcs0
[502.779298] Dynamic subtest bcs0: SUCCESS (0.000s)
[502.793092] Starting dynamic subtest: rcs0
[502.794962] Dynamic subtest rcs0: SUCCESS (0.000s)
[502.808962] Starting dynamic subtest: vcs1
[502.811401] Dynamic subtest vcs1: SUCCESS (0.000s)
[502.813099] Subtest invalid: SUCCESS (0.011s)
[502.880385] [123/132] (554s left) i915_drm_fdinfo (busy-idle)
[502.930913] Starting subtest: busy-idle
[502.932270] Starting dynamic subtest: rcs0
[502.934848] Dynamic subtest rcs0: SKIP (0.000s)
[502.948606] Starting dynamic subtest: bcs0
[502.951248] Dynamic subtest bcs0: SKIP (0.000s)
[502.964994] Starting dynamic subtest: vcs0
[502.968005] Dynamic subtest vcs0: SKIP (0.000s)
[502.981925] Starting dynamic subtest: vcs1
[502.985012] Dynamic subtest vcs1: SKIP (0.000s)
[503.000357] Starting dynamic subtest: vecs0
[503.003431] Dynamic subtest vecs0: SKIP (0.010s)
[503.006190] Subtest busy-idle: SKIP (0.019s)
[503.073914] [124/132] (554s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[504.593778] Starting subtest: cursorA-vs-flipB-atomic-transitions
[504.597493] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s)
[504.747762] [125/132] (552s left) gem_ctx_persistence (engines-hang)
[504.801005] Starting subtest: engines-hang
[504.802463] Starting dynamic subtest: rcs0
[504.909846] Dynamic subtest rcs0: SUCCESS (0.107s)
[504.965857] Starting dynamic subtest: bcs0
[504.986531] Dynamic subtest bcs0: SUCCESS (0.070s)
[505.007098] Starting dynamic subtest: vcs0
[505.081730] Dynamic subtest vcs0: SUCCESS (0.092s)
[505.136590] Starting dynamic subtest: vcs1
[505.152571] Dynamic subtest vcs1: SUCCESS (0.064s)
[505.172790] Starting dynamic subtest: vecs0
[505.244219] Dynamic subtest vecs0: SUCCESS (0.089s)
[505.251269] Subtest engines-hang: SUCCESS (0.445s)
[505.499674] [126/132] (552s left) api_intel_allocator (reloc-allocator)
[505.547497] Starting subtest: reloc-allocator
[505.549023] Starting dynamic subtest: basic
[505.564000] Dynamic subtest basic: SUCCESS (0.016s)
[505.579426] Starting dynamic subtest: parallel-one
[505.580961] Dynamic subtest parallel-one: SUCCESS (0.005s)
[505.595662] Starting dynamic subtest: print
[505.597476] Dynamic subtest print: SUCCESS (0.000s)
[505.612006] Starting dynamic subtest: reuse
[505.613749] Dynamic subtest reuse: SUCCESS (0.000s)
[505.627637] Starting dynamic subtest: fork-reopen-allocator
[505.629349] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[505.631050] Subtest reloc-allocator: SUCCESS (0.045s)
[505.765992] [127/132] (552s left) i915_pm_rps (thresholds)
[505.820386] Starting subtest: thresholds
[505.823646] Subtest thresholds: SKIP (0.000s)
[505.943415] [128/132] (552s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[507.671851] Starting subtest: cursor-rapid-movement-256x85
[507.679977] Starting dynamic subtest: pipe-A-HDMI-A-1
[508.116721] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.438s)
[508.153052] Starting dynamic subtest: pipe-D-HDMI-A-1
[508.461771] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.320s)
[508.463380] Subtest cursor-rapid-movement-256x85: SUCCESS (0.789s)
[508.820298] [129/132] (549s left) kms_cdclk (plane-scaling)
[508.874259] Subtest plane-scaling: SKIP (0.000s)
[508.962143] [130/132] (549s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[510.451653] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[510.455840] Starting dynamic subtest: A-HDMI-A1
[511.161474] Dynamic subtest A-HDMI-A1: SUCCESS (0.706s)
[511.175820] Starting dynamic subtest: B-HDMI-A1
[511.843893] Dynamic subtest B-HDMI-A1: SUCCESS (0.681s)
[511.858113] Starting dynamic subtest: C-HDMI-A1
[512.549972] Dynamic subtest C-HDMI-A1: SUCCESS (0.704s)
[512.564183] Starting dynamic subtest: D-HDMI-A1
[513.252637] Dynamic subtest D-HDMI-A1: SUCCESS (0.700s)
[513.256667] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.806s)
[513.449056] [131/132] (544s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[514.977749] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[514.981312] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s)
[515.128923] [132/132] (543s left) api_intel_bb (purge-bb)
[515.187849] Starting subtest: purge-bb
[515.203641] Subtest purge-bb: SUCCESS (0.017s)
[515.372289] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: i915_pm_rpm
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_render_copy_redux
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: tools_test
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_color_pipeline
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: kms_pipe_crc_basic
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: gem_exec_params
results: parsing output: 21/ for test: kms_draw_crc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: sriov_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: gen3_render_mixed_blits
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: fbdev
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_gtt_cpu_tlb
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gem_pwrite
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: core_auth
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_exercise_blt
results: parsing output: 63/ for test: gem_readwrite
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_busy
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: i915_pm_freq_api
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_prop_blob
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: dmabuf_sync_file
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_vrr
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: gem_render_linear_blits
results: parsing output: 111/ for test: kms_universal_plane
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sysfs_timeslice_duration
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: i915_pm_rps
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_cdclk
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: api_intel_bb
Done.