[49.171060] Initializing watchdogs [49.171114] /dev/watchdog0 [49.177023] [001/130] (960s left) kms_flip (dpms-vs-vblank-race-interruptible) [49.366160] Starting subtest: dpms-vs-vblank-race-interruptible [49.367542] Starting dynamic subtest: A-HDMI-A1 [54.878434] Dynamic subtest A-HDMI-A1: SUCCESS (5.509s) [54.882164] Starting dynamic subtest: B-HDMI-A1 [60.323847] Dynamic subtest B-HDMI-A1: SUCCESS (5.382s) [60.324702] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (10.893s) [60.503519] [002/130] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [60.629451] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [60.630778] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [60.752564] [003/130] (949s left) prime_vgem (fence-read-hang) [60.894598] Subtest fence-read-hang: SKIP (0.000s) [61.039363] [004/130] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [61.162713] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [61.196400] [005/130] (948s left) gem_exec_alignment (pi) [61.245717] Starting subtest: pi [118.703435] Subtest pi: SUCCESS (57.366s) [119.614733] [006/130] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [119.788365] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [119.789683] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [119.914662] [007/130] (890s left) sysfs_timeslice_duration (timeout) [119.959967] Starting subtest: timeout [119.960655] Starting dynamic subtest: vecs0 [120.944414] Dynamic subtest vecs0: SUCCESS (0.983s) [120.951946] Starting dynamic subtest: vcs0 [121.949655] Dynamic subtest vcs0: SUCCESS (1.004s) [121.956553] Starting dynamic subtest: bcs0 [122.942629] Dynamic subtest bcs0: SUCCESS (0.992s) [122.951087] Starting dynamic subtest: rcs0 [123.881101] Dynamic subtest rcs0: SUCCESS (0.936s) [123.882254] Subtest timeout: SUCCESS (3.919s) [123.944382] [008/130] (886s left) gem_exec_fence (submit) [124.127873] Starting subtest: submit [124.128669] Starting dynamic subtest: rcs0 [124.134987] Dynamic subtest rcs0: SUCCESS (0.008s) [124.140442] Starting dynamic subtest: bcs0 [124.141106] Dynamic subtest bcs0: SUCCESS (0.006s) [124.145549] Starting dynamic subtest: vcs0 [124.146217] Dynamic subtest vcs0: SUCCESS (0.005s) [124.150574] Starting dynamic subtest: vecs0 [124.152105] Dynamic subtest vecs0: SUCCESS (0.005s) [124.152781] Subtest submit: SUCCESS (0.025s) [124.617555] [009/130] (885s left) kms_getfb (getfb-handle-valid) [124.661048] Starting subtest: getfb-handle-valid [124.661767] Subtest getfb-handle-valid: SUCCESS (0.000s) [124.794144] [010/130] (885s left) kms_plane_scaling (planes-upscale-20x20) [124.909892] Starting subtest: planes-upscale-20x20 [124.910570] Starting dynamic subtest: pipe-A [125.027686] Dynamic subtest pipe-A: SUCCESS (0.117s) [125.040372] Starting dynamic subtest: pipe-B [125.174765] Dynamic subtest pipe-B: SUCCESS (0.146s) [125.176027] Subtest planes-upscale-20x20: SUCCESS (0.265s) [125.351111] [011/130] (884s left) api_intel_allocator (open-vm) [125.388523] Starting subtest: open-vm [125.390068] Subtest open-vm: SUCCESS (0.002s) [125.516812] [012/130] (884s left) gem_render_tiled_blits (basic) [125.560033] Starting subtest: basic [125.583587] Subtest basic: SUCCESS (0.023s) [125.641292] [013/130] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [125.753378] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [125.754677] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [125.884164] [014/130] (884s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [125.932464] Starting subtest: yf-tiled-to-vebox-x-tiled [125.933201] Starting dynamic subtest: smem [126.038511] Dynamic subtest smem: SUCCESS (0.106s) [126.039198] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.107s) [126.220016] [015/130] (883s left) kms_psr (psr2-primary-render) [126.332491] Subtest psr2-primary-render: SKIP (0.000s) [126.354122] [016/130] (883s left) gem_exec_await (wide-contexts) [126.420965] Starting subtest: wide-contexts [148.144601] Subtest wide-contexts: SUCCESS (21.722s) [148.352721] [017/130] (861s left) kms_flip (plain-flip-ts-check) [148.516399] Starting subtest: plain-flip-ts-check [148.517934] Starting dynamic subtest: A-HDMI-A1 [164.065388] Dynamic subtest A-HDMI-A1: SUCCESS (15.547s) [164.074979] Starting dynamic subtest: B-HDMI-A1 [179.538753] Dynamic subtest B-HDMI-A1: SUCCESS (15.471s) [179.540884] Subtest plain-flip-ts-check: SUCCESS (31.023s) [179.734765] [018/130] (830s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [179.848896] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [179.850277] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [180.023200] [019/130] (830s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [180.147117] Starting subtest: yf-tiled-64bpp-rotate-180 [180.148416] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [180.271698] [020/130] (830s left) gem_exec_params (no-blt) [180.314942] Starting subtest: no-blt [180.315662] Subtest no-blt: SUCCESS (0.000s) [180.459031] [021/130] (829s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [180.574743] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [180.940083] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.365s) [181.154350] [022/130] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [181.263744] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [181.265077] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [181.382971] [023/130] (828s left) gem_exec_reloc (basic-wc-cpu-active) [181.425036] Subtest basic-wc-cpu-active: SKIP (0.000s) [181.510316] [024/130] (828s left) gem_exec_params (rel-constants-invalid-ring) [181.547346] Starting subtest: rel-constants-invalid-ring [181.548044] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [181.674123] [025/130] (828s left) syncobj_eventfd (timeline-wait-signaled) [181.720430] Starting subtest: timeline-wait-signaled [181.721116] Subtest timeline-wait-signaled: SUCCESS (0.000s) [181.807592] [026/130] (828s left) kms_flip (flip-vs-expired-vblank-interruptible) [181.932049] Starting subtest: flip-vs-expired-vblank-interruptible [181.933526] Starting dynamic subtest: A-HDMI-A1 [197.101450] Dynamic subtest A-HDMI-A1: SUCCESS (15.167s) [197.109664] Starting dynamic subtest: B-HDMI-A1 [212.253421] Dynamic subtest B-HDMI-A1: SUCCESS (15.132s) [212.254545] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.305s) [212.423362] [027/130] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [212.533496] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [212.534805] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [212.641628] [028/130] (797s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [212.814386] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [212.869948] [029/130] (797s left) drm_fdinfo (busy-check-all) [212.904800] Starting subtest: busy-check-all [212.905470] Starting dynamic subtest: rcs0 [213.423253] Dynamic subtest rcs0: SUCCESS (0.518s) [213.431820] Starting dynamic subtest: bcs0 [213.943465] Dynamic subtest bcs0: SUCCESS (0.519s) [213.952086] Starting dynamic subtest: vcs0 [214.465229] Dynamic subtest vcs0: SUCCESS (0.520s) [214.473393] Starting dynamic subtest: vecs0 [214.992219] Dynamic subtest vecs0: SUCCESS (0.526s) [214.993542] Subtest busy-check-all: SUCCESS (2.088s) [215.073859] [030/130] (795s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [215.189892] Starting subtest: fbc-rgb565-draw-mmap-cpu [217.568363] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.380s) [217.730872] [031/130] (792s left) prime_self_import (reimport-vs-gem_close-race) [217.764455] Starting subtest: reimport-vs-gem_close-race [222.807745] Subtest reimport-vs-gem_close-race: SUCCESS (5.036s) [222.882531] [032/130] (787s left) kms_selftest (drm_dp_mst_helper) [222.986377] Starting subtest: drm_dp_mst_helper [222.991802] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [223.071618] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.079s) [223.085302] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [223.206913] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.135s) [223.212970] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [223.338366] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.129s) [223.339302] Subtest drm_dp_mst_helper: SUCCESS (0.351s) [223.519915] [033/130] (787s left) kms_atomic (plane-invalid-params) [223.630965] Starting subtest: plane-invalid-params [223.632831] Starting dynamic subtest: pipe-A-HDMI-A-1 [223.825281] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.193s) [223.826200] Subtest plane-invalid-params: SUCCESS (0.195s) [223.968292] [034/130] (786s left) gem_exec_schedule (preemptive-hang) [224.120540] Starting subtest: preemptive-hang [224.121233] Starting dynamic subtest: rcs0 [229.999762] Dynamic subtest rcs0: SUCCESS (5.870s) [230.004713] Starting dynamic subtest: bcs0 [236.014027] Dynamic subtest bcs0: SUCCESS (6.014s) [236.019189] Starting dynamic subtest: vcs0 [241.958006] Dynamic subtest vcs0: SUCCESS (5.942s) [241.963980] Starting dynamic subtest: vecs0 [247.974638] Dynamic subtest vecs0: SUCCESS (6.015s) [247.975632] Subtest preemptive-hang: SUCCESS (23.846s) [248.172938] [035/130] (762s left) syncobj_timeline (multi-wait-available-signaled) [248.216332] Starting subtest: multi-wait-available-signaled [248.217061] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [248.299251] [036/130] (762s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [248.412016] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [248.412694] Starting dynamic subtest: pipe-A-valid-mode [248.474713] Dynamic subtest pipe-A-valid-mode: SKIP (0.061s) [248.476011] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.062s) [248.587037] [037/130] (762s left) gem_exec_schedule (u-submit-early-slice) [248.634230] Starting subtest: u-submit-early-slice [248.634917] Starting dynamic subtest: rcs0 [248.656491] Dynamic subtest rcs0: SUCCESS (0.022s) [248.661402] Starting dynamic subtest: bcs0 [248.678492] Dynamic subtest bcs0: SUCCESS (0.022s) [248.683377] Starting dynamic subtest: vcs0 [248.700406] Dynamic subtest vcs0: SUCCESS (0.021s) [248.705274] Starting dynamic subtest: vecs0 [248.724824] Dynamic subtest vecs0: SUCCESS (0.024s) [248.725479] Subtest u-submit-early-slice: SUCCESS (0.091s) [249.037499] [038/130] (761s left) kms_plane (plane-position-covered) [249.151964] Starting subtest: plane-position-covered [249.480803] Starting dynamic subtest: pipe-A-plane-1 [249.846999] Dynamic subtest pipe-A-plane-1: SUCCESS (0.366s) [249.856081] Starting dynamic subtest: pipe-A-plane-2 [250.209075] Dynamic subtest pipe-A-plane-2: SUCCESS (0.361s) [250.215711] Starting dynamic subtest: pipe-A-plane-3 [250.565873] Dynamic subtest pipe-A-plane-3: SUCCESS (0.357s) [250.571662] Starting dynamic subtest: pipe-A-plane-4 [250.921882] Dynamic subtest pipe-A-plane-4: SUCCESS (0.355s) [250.927688] Starting dynamic subtest: pipe-A-plane-5 [250.928393] Dynamic subtest pipe-A-plane-5: SUCCESS (0.003s) [251.177287] Starting dynamic subtest: pipe-B-plane-1 [251.512538] Dynamic subtest pipe-B-plane-1: SUCCESS (0.340s) [251.517797] Starting dynamic subtest: pipe-B-plane-2 [251.853526] Dynamic subtest pipe-B-plane-2: SUCCESS (0.341s) [251.858486] Starting dynamic subtest: pipe-B-plane-3 [252.195523] Dynamic subtest pipe-B-plane-3: SUCCESS (0.342s) [252.200559] Starting dynamic subtest: pipe-B-plane-4 [252.537693] Dynamic subtest pipe-B-plane-4: SUCCESS (0.341s) [252.542598] Starting dynamic subtest: pipe-B-plane-5 [252.543265] Dynamic subtest pipe-B-plane-5: SUCCESS (0.003s) [252.543924] Subtest plane-position-covered: SUCCESS (3.388s) [252.689536] [039/130] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [252.806571] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [252.807897] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [252.917799] [040/130] (757s left) i915_power (sanity) [252.959286] Starting subtest: sanity [252.960671] Subtest sanity: SKIP (0.000s) [253.024088] [041/130] (757s left) kms_frontbuffer_tracking (fbc-tiling-y) [253.141659] Starting subtest: fbc-tiling-y [255.598776] Subtest fbc-tiling-y: SUCCESS (2.458s) [255.753826] [042/130] (755s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [255.868326] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [255.870202] Starting dynamic subtest: pipe-A-HDMI-A-1 [255.876279] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [255.881268] Starting dynamic subtest: pipe-B-HDMI-A-1 [255.887113] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [255.887779] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SUCCESS (0.005s) [256.118456] [043/130] (754s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [256.234046] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [256.234740] Starting dynamic subtest: pipe-A-valid-mode [257.062797] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.827s) [257.063589] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.828s) [257.222690] [044/130] (753s left) gem_userptr_blits (readonly-unsync) [257.261671] Subtest readonly-unsync: SKIP (0.000s) [257.402609] [045/130] (753s left) kms_chamelium_color (gamma) [257.514570] Subtest gamma: SKIP (0.000s) [257.556080] [046/130] (753s left) gem_mmap_offset (oob-read) [257.596138] Starting subtest: oob-read [257.596820] Subtest oob-read: SUCCESS (0.000s) [257.705815] [047/130] (753s left) kms_content_protection (dp-mst-type-0) [257.825420] Starting subtest: dp-mst-type-0 [257.826729] Subtest dp-mst-type-0: SKIP (0.000s) [257.952720] [048/130] (752s left) kms_plane_alpha_blend (constant-alpha-max) [258.068028] Starting subtest: constant-alpha-max [258.134331] Starting dynamic subtest: pipe-A-HDMI-A-1 [259.108226] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.974s) [259.114049] Starting dynamic subtest: pipe-B-HDMI-A-1 [260.071643] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.962s) [260.072299] Subtest constant-alpha-max: SUCCESS (2.003s) [260.246884] [049/130] (750s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [260.674824] Starting subtest: dpms-mode-unset-non-lpsp [260.883495] Subtest dpms-mode-unset-non-lpsp: SKIP (0.208s) [261.100961] [050/130] (749s left) core_auth (many-magics) [261.148795] Starting subtest: many-magics [261.464232] Subtest many-magics: SUCCESS (0.316s) [261.521138] [051/130] (749s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [261.569796] Starting subtest: single-wait-all-for-submit-available-submitted [261.570479] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [261.652683] [052/130] (749s left) gem_ctx_persistence (heartbeat-many) [261.693800] Starting subtest: heartbeat-many [262.069777] Subtest heartbeat-many: SUCCESS (0.375s) [262.166991] [053/130] (748s left) gem_exec_reloc (basic-write-read) [262.209564] Subtest basic-write-read: SKIP (0.000s) [262.306380] [054/130] (748s left) kms_joiner (basic-force-big-joiner) [262.416702] Starting subtest: basic-force-big-joiner [262.418304] Subtest basic-force-big-joiner: SKIP (0.000s) [262.507712] [055/130] (748s left) gem_mmap_gtt (close-race) [262.549085] Starting subtest: close-race [282.695817] Subtest close-race: SUCCESS (20.113s) [282.794372] [056/130] (728s left) drm_fdinfo (virtual-busy-hang-all) [282.874234] Starting subtest: virtual-busy-hang-all [282.874928] Subtest virtual-busy-hang-all: SUCCESS (0.000s) [282.959085] [057/130] (728s left) kms_universal_plane (cursor-fb-leak) [283.078102] Starting subtest: cursor-fb-leak [283.079735] Starting dynamic subtest: pipe-A-HDMI-A-1 [283.422965] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.344s) [283.435116] Starting dynamic subtest: pipe-B-HDMI-A-1 [283.801533] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.375s) [283.802713] Subtest cursor-fb-leak: SUCCESS (0.724s) [283.996852] [058/130] (727s left) debugfs_test (basic-hwmon) [284.039440] Starting subtest: basic-hwmon [284.040747] Subtest basic-hwmon: SKIP (0.000s) [284.185507] [059/130] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [284.304590] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [284.305924] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [284.416602] [060/130] (726s left) kms_big_fb (4-tiled-32bpp-rotate-0) [284.535868] Starting subtest: 4-tiled-32bpp-rotate-0 [284.537174] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s) [284.654847] [061/130] (726s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [284.772756] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [285.122346] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.349s) [285.309162] [062/130] (726s left) prime_vgem (basic-gtt) [285.353080] Starting subtest: basic-gtt [285.361810] Subtest basic-gtt: SUCCESS (0.009s) [285.497930] [063/130] (725s left) gem_eio (throttle) [285.544881] Starting subtest: throttle [285.569818] Subtest throttle: SUCCESS (0.024s) [285.725249] [064/130] (725s left) gem_exec_reloc (basic-cpu-read-noreloc) [285.763887] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [285.821534] [065/130] (725s left) kms_psr (psr2-cursor-render) [285.934445] Subtest psr2-cursor-render: SKIP (0.000s) [285.976958] [066/130] (725s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [286.014964] Starting subtest: invalid-multi-wait-all-unsubmitted [286.015682] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [286.104288] [067/130] (725s left) gem_ctx_persistence (legacy-engines-cleanup) [286.147501] Starting subtest: legacy-engines-cleanup [286.148200] Starting dynamic subtest: render [286.221369] Dynamic subtest render: SUCCESS (0.073s) [286.241421] Starting dynamic subtest: bsd [286.293235] Dynamic subtest bsd: SUCCESS (0.069s) [286.312598] Starting dynamic subtest: blt [286.368215] Dynamic subtest blt: SUCCESS (0.072s) [286.387485] Starting dynamic subtest: vebox [286.440257] Dynamic subtest vebox: SUCCESS (0.070s) [286.441401] Subtest legacy-engines-cleanup: SUCCESS (0.293s) [286.541809] [068/130] (724s left) kms_cursor_crc (cursor-onscreen-max-size) [286.658439] Starting subtest: cursor-onscreen-max-size [286.660409] Subtest cursor-onscreen-max-size: SKIP (0.000s) [286.768517] [069/130] (724s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [286.880071] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [286.881700] Starting dynamic subtest: pipe-A-HDMI-A-1 [286.888058] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [286.893260] Starting dynamic subtest: pipe-B-HDMI-A-1 [286.899634] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [286.900930] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.002s) [287.098398] [070/130] (724s left) kms_psr (fbc-psr-sprite-mmap-gtt) [287.207504] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [287.225830] [071/130] (724s left) perf (mi-rpc) [287.392843] Starting subtest: mi-rpc [287.394202] Subtest mi-rpc: SKIP (0.000s) [287.418394] [072/130] (724s left) kms_big_fb (y-tiled-32bpp-rotate-270) [287.530700] Starting subtest: y-tiled-32bpp-rotate-270 [289.266196] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.735s) [289.452424] [073/130] (722s left) gem_exec_params (invalid-fence-in-submit) [289.490990] Starting subtest: invalid-fence-in-submit [289.492800] Subtest invalid-fence-in-submit: SUCCESS (0.002s) [289.642834] [074/130] (722s left) prime_busy (before-wait) [289.682951] Starting subtest: before-wait [289.688229] Starting dynamic subtest: rcs0 [289.738483] Dynamic subtest rcs0: SUCCESS (0.050s) [289.754832] Starting dynamic subtest: bcs0 [289.816972] Dynamic subtest bcs0: SUCCESS (0.077s) [289.837259] Starting dynamic subtest: vcs0 [289.839858] Dynamic subtest vcs0: SUCCESS (0.019s) [289.847995] Starting dynamic subtest: vecs0 [289.858224] Dynamic subtest vecs0: SUCCESS (0.019s) [289.970611] Subtest before-wait: SUCCESS (0.287s) [290.060985] [075/130] (721s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [290.172189] Starting subtest: plane-scaler-unity-scaling-with-rotation [290.172905] Starting dynamic subtest: pipe-A [290.579832] Dynamic subtest pipe-A: SKIP (0.406s) [290.585375] Starting dynamic subtest: pipe-B [291.002806] Dynamic subtest pipe-B: SKIP (0.422s) [291.004153] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.829s) [291.164145] [076/130] (720s left) i915_query (hwconfig_table) [291.198484] Starting subtest: hwconfig_table [291.199874] Subtest hwconfig_table: SKIP (0.000s) [291.258489] [077/130] (720s left) kms_psr2_sf (pr-cursor-plane-update-sf) [291.365741] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [291.387401] [078/130] (720s left) kms_cursor_legacy (forked-move) [291.494262] Starting subtest: forked-move [291.495253] Starting dynamic subtest: pipe-A [296.981571] Dynamic subtest pipe-A: SUCCESS (5.451s) [296.987651] Starting dynamic subtest: pipe-B [302.418868] Dynamic subtest pipe-B: SUCCESS (5.462s) [302.425765] Starting dynamic subtest: all-pipes [307.893513] Dynamic subtest all-pipes: SUCCESS (5.482s) [307.894672] Subtest forked-move: SUCCESS (16.398s) [307.977952] [079/130] (703s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [308.094403] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [308.096808] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.001s) [308.224256] [080/130] (703s left) kms_flip (2x-dpms-vs-vblank-race) [308.332609] Starting subtest: 2x-dpms-vs-vblank-race [308.334170] Subtest 2x-dpms-vs-vblank-race: SKIP (0.001s) [308.452684] [081/130] (703s left) kms_pm_rpm (modeset-non-lpsp-stress) [309.885888] Starting subtest: modeset-non-lpsp-stress [310.093226] Subtest modeset-non-lpsp-stress: SKIP (0.206s) [310.279964] [082/130] (701s left) gem_exec_fence (basic-wait) [310.443539] Starting subtest: basic-wait [310.444549] Starting dynamic subtest: rcs0 [310.521264] Dynamic subtest rcs0: SUCCESS (0.077s) [310.541770] Starting dynamic subtest: bcs0 [310.554319] Dynamic subtest bcs0: SUCCESS (0.030s) [310.570448] Starting dynamic subtest: vcs0 [310.594479] Dynamic subtest vcs0: SUCCESS (0.037s) [310.612196] Starting dynamic subtest: vecs0 [310.628653] Dynamic subtest vecs0: SUCCESS (0.031s) [310.632717] Subtest basic-wait: SUCCESS (0.186s) [311.090685] [083/130] (700s left) gem_lmem_swapping (random-engines) [311.135997] Subtest random-engines: SKIP (0.000s) [311.171733] [084/130] (700s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [311.291700] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [311.293115] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [311.402712] [085/130] (700s left) gem_exec_whisper (basic-queues-forked) [311.450277] Starting subtest: basic-queues-forked [313.424510] Subtest basic-queues-forked: SUCCESS (1.965s) [313.621339] [086/130] (698s left) gem_exec_balancer (hog) [313.665393] Starting subtest: hog [314.692696] Subtest hog: SUCCESS (1.018s) [315.918215] [087/130] (696s left) gem_userptr_blits (relocations) [315.965048] Starting subtest: relocations [315.966417] Subtest relocations: SKIP (0.000s) [316.107116] [088/130] (695s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [316.223763] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [316.225122] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [316.364449] [089/130] (695s left) i915_pm_rpm (debugfs-read) [317.810808] Starting subtest: debugfs-read [318.017676] Subtest debugfs-read: SUCCESS (0.204s) [318.185509] [090/130] (693s left) kms_invalid_mode (int-max-clock) [318.297520] Starting subtest: int-max-clock [318.298240] Starting dynamic subtest: pipe-A-HDMI-A-1 [318.340252] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.041s) [318.346410] Starting dynamic subtest: pipe-B-HDMI-A-1 [318.347130] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [318.347837] Subtest int-max-clock: SUCCESS (0.044s) [318.489683] [091/130] (693s left) gem_exec_suspend (basic) [318.537818] Starting subtest: basic [318.538605] Starting dynamic subtest: smem [318.975929] Dynamic subtest smem: SUCCESS (0.439s) [318.976635] Subtest basic: SUCCESS (0.440s) [319.166701] [092/130] (692s left) perf_pmu (all-busy-check-all) [319.211953] Starting subtest: all-busy-check-all [319.739347] Subtest all-busy-check-all: SUCCESS (0.527s) [319.830016] [093/130] (692s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [319.868849] Starting subtest: invalid-bsd1-flag-on-vebox [319.869563] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [319.987663] [094/130] (692s left) gem_pxp (create-valid-protected-context) [440.084145] Per-test timeout exceeded. Killing the current test with SIGQUIT. [442.456944] Closing watchdogs [442.459660] Initializing watchdogs [442.459702] /dev/watchdog0 [442.467150] [095/130] (569s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt) [442.577589] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt [442.578911] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [442.706992] [096/130] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [442.818692] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [442.819968] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [442.943939] [097/130] (569s left) gem_exec_params (invalid-bsd2-flag-on-blt) [442.984055] Starting subtest: invalid-bsd2-flag-on-blt [442.984755] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [443.127365] [098/130] (569s left) kms_chamelium_color (ctm-green-to-red) [443.235508] Subtest ctm-green-to-red: SKIP (0.000s) [443.260967] [099/130] (569s left) kms_getfb (getfb-handle-closed) [443.297907] Starting subtest: getfb-handle-closed [443.298588] Subtest getfb-handle-closed: SUCCESS (0.000s) [443.427423] [100/130] (568s left) gem_eio (in-flight-10ms) [443.466489] Starting subtest: in-flight-10ms [445.640067] Subtest in-flight-10ms: SUCCESS (2.172s) [445.803626] [101/130] (566s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [445.915640] Starting subtest: fbc-rgb565-draw-pwrite [448.637412] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.722s) [448.806190] [102/130] (563s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [448.915083] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [448.916838] Starting dynamic subtest: pipe-A-HDMI-A-1 [448.923871] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [448.930201] Starting dynamic subtest: pipe-B-HDMI-A-1 [448.937216] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [448.938636] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.002s) [449.127972] [103/130] (563s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [449.244713] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [450.391350] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.146s) [450.570364] [104/130] (561s left) gem_exec_flush (basic-uc-rw-default) [450.618448] Starting subtest: basic-uc-rw-default [456.072236] Subtest basic-uc-rw-default: SUCCESS (5.454s) [456.278720] [105/130] (556s left) kms_frontbuffer_tracking (basic) [456.422997] Starting subtest: basic [459.632147] Subtest basic: SUCCESS (3.210s) [459.799994] [106/130] (552s left) kms_psr (fbc-pr-sprite-render) [459.910498] Subtest fbc-pr-sprite-render: SKIP (0.000s) [459.957168] [107/130] (552s left) kms_writeback (writeback-fb-id-xrgb2101010) [460.067384] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s) [460.104349] [108/130] (552s left) gem_caching (writes) [460.142712] Starting subtest: writes [467.871409] Subtest writes: SUCCESS (7.729s) [467.999937] [109/130] (544s left) kms_cursor_edge_walk (128x128-left-edge) [468.110010] Starting subtest: 128x128-left-edge [468.111670] Starting dynamic subtest: pipe-A-HDMI-A-1 [471.798571] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.685s) [471.804848] Starting dynamic subtest: pipe-B-HDMI-A-1 [475.405199] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.607s) [475.405894] Subtest 128x128-left-edge: SUCCESS (7.295s) [475.519935] [110/130] (537s left) vgem_basic (mmap) [475.561118] Starting subtest: mmap [475.568778] Subtest mmap: SUCCESS (0.008s) [475.629427] [111/130] (536s left) gem_close_race (multigpu-basic-threads) [475.675448] Starting subtest: multigpu-basic-threads [475.676785] Subtest multigpu-basic-threads: SKIP (0.000s) [475.862688] [112/130] (536s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [475.977303] Starting subtest: basic-flip-after-cursor-legacy [477.038899] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.060s) [477.205086] [113/130] (535s left) gem_ctx_freq (sysfs) [477.242220] Starting subtest: sysfs [477.242939] Starting dynamic subtest: gt0 [482.340347] Dynamic subtest gt0: SUCCESS (5.097s) [482.341517] Subtest sysfs: SUCCESS (5.099s) [482.425176] [114/130] (530s left) kms_vblank (wait-idle-hang) [482.535009] Starting subtest: wait-idle-hang [482.536651] Starting dynamic subtest: pipe-A-HDMI-A-1 [496.752769] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.216s) [496.763114] Starting dynamic subtest: pipe-B-HDMI-A-1 [510.569892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (13.813s) [510.570682] Subtest wait-idle-hang: SUCCESS (28.035s) [510.757404] [115/130] (501s left) gem_exec_flush (basic-batch-kernel-default-uc) [510.799470] Starting subtest: basic-batch-kernel-default-uc [516.420446] Subtest basic-batch-kernel-default-uc: SUCCESS (5.621s) [516.629263] [116/130] (496s left) gem_spin_batch (legacy-resubmit) [516.696744] Starting subtest: legacy-resubmit [516.697631] Starting dynamic subtest: default [516.711238] Dynamic subtest default: SUCCESS (0.003s) [516.719173] Starting dynamic subtest: render [516.719944] Dynamic subtest render: SUCCESS (0.001s) [516.728170] Starting dynamic subtest: bsd [516.728830] Dynamic subtest bsd: SUCCESS (0.001s) [516.734740] Starting dynamic subtest: bsd1 [516.735391] Dynamic subtest bsd1: SUCCESS (0.001s) [516.741353] Starting dynamic subtest: blt [516.742021] Dynamic subtest blt: SUCCESS (0.001s) [516.747963] Starting dynamic subtest: vebox [516.748647] Dynamic subtest vebox: SUCCESS (0.001s) [516.749308] Subtest legacy-resubmit: SUCCESS (0.010s) [516.906199] [117/130] (495s left) gem_ctx_bad_destroy (invalid-pad) [516.944232] Starting subtest: invalid-pad [516.944957] Subtest invalid-pad: SUCCESS (0.000s) [517.037874] [118/130] (495s left) syncobj_timeline (invalid-single-wait-unsubmitted) [517.074535] Starting subtest: invalid-single-wait-unsubmitted [517.075221] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [517.144459] [119/130] (495s left) gen9_exec_parse (bb-start-param) [517.185602] Subtest bb-start-param: SKIP (0.000s) [517.231596] [120/130] (495s left) kms_psr (fbc-pr-no-drrs) [517.340434] Subtest fbc-pr-no-drrs: SKIP (0.000s) [517.388350] [121/130] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [517.508556] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [517.509859] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [517.627053] [122/130] (495s left) perf_pmu (busy-hang) [517.667582] Starting subtest: busy-hang [517.668279] Starting dynamic subtest: rcs0 [518.756505] Dynamic subtest rcs0: SUCCESS (1.086s) [518.765226] Starting dynamic subtest: bcs0 [519.809351] Dynamic subtest bcs0: SUCCESS (1.051s) [519.818262] Starting dynamic subtest: vcs0 [520.845447] Dynamic subtest vcs0: SUCCESS (1.036s) [520.855591] Starting dynamic subtest: vecs0 [521.898379] Dynamic subtest vecs0: SUCCESS (1.049s) [521.899566] Subtest busy-hang: SUCCESS (4.229s) [521.981125] [123/130] (490s left) debugfs_test (read_all_entries) [522.020831] Starting subtest: read_all_entries [522.132764] Subtest read_all_entries: SUCCESS (0.112s) [522.293529] [124/130] (490s left) gem_softpin (allocator-nopin-reserve) [522.335403] Starting subtest: allocator-nopin-reserve [522.396823] Subtest allocator-nopin-reserve: SUCCESS (0.061s) [522.538850] [125/130] (490s left) kms_dsc (dsc-fractional-bpp-with-bpc) [522.653147] Starting subtest: dsc-fractional-bpp-with-bpc [522.654553] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.000s) [522.718878] [126/130] (490s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [522.755412] Starting subtest: no-spare-fences-interruptible [524.908691] Subtest no-spare-fences-interruptible: SUCCESS (2.153s) [525.063241] [127/130] (487s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [525.099040] Starting subtest: multi-wait-all-for-submit-unsubmitted [525.203394] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [525.283287] [128/130] (487s left) kms_color (ctm-green-to-red) [525.398099] Starting subtest: ctm-green-to-red [525.398783] Starting dynamic subtest: pipe-A-HDMI-A-1 [525.913931] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.515s) [525.924744] Starting dynamic subtest: pipe-B-HDMI-A-1 [526.354751] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.439s) [526.355414] Subtest ctm-green-to-red: SUCCESS (0.956s) [526.507897] [129/130] (486s left) gem_wait (await) [526.556327] Starting subtest: await [526.557033] Starting dynamic subtest: all-engines [527.583313] Dynamic subtest all-engines: SUCCESS (1.026s) [527.593988] Starting dynamic subtest: rcs0 [528.616350] Dynamic subtest rcs0: SUCCESS (1.030s) [528.626167] Starting dynamic subtest: bcs0 [529.642160] Dynamic subtest bcs0: SUCCESS (1.022s) [529.652194] Starting dynamic subtest: vcs0 [530.668247] Dynamic subtest vcs0: SUCCESS (1.024s) [530.678177] Starting dynamic subtest: vecs0 [531.694439] Dynamic subtest vecs0: SUCCESS (1.021s) [531.695682] Subtest await: SUCCESS (5.137s) [531.910665] [130/130] (481s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite) [532.026692] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite [535.944408] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (3.919s) [536.090228] Closing watchdogs Done.