[55.474583] Initializing watchdogs [55.474825] /dev/watchdog0 [55.525886] [001/142] (960s left) fbdev (nullptr) [55.834293] Starting subtest: nullptr [55.853525] Subtest nullptr: SUCCESS (0.001s) [55.960519] [002/142] (960s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [56.239831] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [56.277612] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [56.456095] [003/142] (959s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [56.888727] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [56.967137] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.073s) [57.082534] [004/142] (959s left) v3d/v3d_perfmon (create-two-perfmon) [57.442550] Subtest create-two-perfmon: SKIP (0.000s) [57.524440] [005/142] (958s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [57.824728] Starting subtest: multi-wait-all-for-submit-available-signaled [57.843448] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s) [57.920845] [006/142] (958s left) gem_request_retire (retire-vma-not-inactive) [58.216945] Starting subtest: retire-vma-not-inactive [58.258861] Subtest retire-vma-not-inactive: SUCCESS (0.045s) [58.394895] [007/142] (958s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [58.757085] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [58.776560] Starting dynamic subtest: pipe-A-valid-mode [59.504727] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.725s) [59.526826] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.727s) [59.863223] [008/142] (956s left) gem_mmap (bad-offset) [60.161886] Starting subtest: bad-offset [60.180643] Subtest bad-offset: SUCCESS (0.002s) [60.287688] [009/142] (956s left) gem_exec_schedule (wide) [60.741401] Starting subtest: wide [60.762083] Starting dynamic subtest: rcs0 [81.584753] Dynamic subtest rcs0: SUCCESS (20.690s) [81.622472] Starting dynamic subtest: bcs0 [103.272642] Dynamic subtest bcs0: SUCCESS (21.862s) [103.305198] Starting dynamic subtest: vcs0 [124.092549] Dynamic subtest vcs0: SUCCESS (20.819s) [124.133690] Starting dynamic subtest: vecs0 [145.112434] Dynamic subtest vecs0: SUCCESS (21.019s) [145.133136] Subtest wide: SUCCESS (84.397s) [146.097998] [010/142] (870s left) kms_vblank (pipe-d-query-forked-hang) [146.500344] Subtest pipe-D-query-forked-hang: SKIP (0.000s) [146.683929] [011/142] (870s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [147.130113] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [147.171477] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [147.269117] [012/142] (869s left) sysfs_timeslice_duration (timeout) [147.576448] Starting subtest: timeout [147.595190] Starting dynamic subtest: vecs0 [148.479115] Dynamic subtest vecs0: SUCCESS (0.895s) [148.511706] Starting dynamic subtest: vcs0 [149.370408] Dynamic subtest vcs0: SUCCESS (0.890s) [149.405301] Starting dynamic subtest: bcs0 [150.260424] Dynamic subtest bcs0: SUCCESS (0.900s) [150.295448] Starting dynamic subtest: rcs0 [151.160489] Dynamic subtest rcs0: SUCCESS (0.892s) [151.179137] Subtest timeout: SUCCESS (3.581s) [151.264650] [013/142] (865s left) kms_cursor_edge_walk (256x256-right-edge) [151.628831] Starting subtest: 256x256-right-edge [151.649874] Starting dynamic subtest: pipe-A-DP-1 [155.492876] Dynamic subtest pipe-A-DP-1: SUCCESS (3.857s) [155.525282] Starting dynamic subtest: pipe-C-DP-1 [158.989033] Dynamic subtest pipe-C-DP-1: SUCCESS (3.491s) [159.007618] Subtest 256x256-right-edge: SUCCESS (7.354s) [159.347943] [014/142] (857s left) kms_flip (absolute-wf_vblank-interruptible) [159.715243] Starting subtest: absolute-wf_vblank-interruptible [159.733857] Starting dynamic subtest: A-DP1 [170.592315] Dynamic subtest A-DP1: SUCCESS (10.697s) [170.630448] Starting dynamic subtest: B-DP1 [180.860106] Dynamic subtest B-DP1: SUCCESS (10.441s) [180.894729] Starting dynamic subtest: C-DP1 [191.469987] Dynamic subtest C-DP1: SUCCESS (10.421s) [191.493452] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.567s) [191.752140] [015/142] (825s left) kms_vblank (pipe-c-query-idle) [192.133216] Starting subtest: pipe-C-query-idle [194.914842] Subtest pipe-C-query-idle: SUCCESS (2.790s) [195.307929] [016/142] (822s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_ccs) [196.044437] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_ccs [196.082041] Subtest pipe-C-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s) [196.420956] [017/142] (821s left) kms_big_fb (4-tiled-8bpp-rotate-270) [196.843209] Starting subtest: 4-tiled-8bpp-rotate-270 [196.884956] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s) [196.983438] [018/142] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [197.426053] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [197.463222] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [197.569374] [019/142] (820s left) i915_pm_rps (basic-api) [197.871500] Starting subtest: basic-api [197.893284] Subtest basic-api: SUCCESS (0.007s) [198.015338] [020/142] (819s left) kms_fbcon_fbt (fbc-suspend) [198.318917] Starting subtest: fbc-suspend [246.526383] Subtest fbc-suspend: SUCCESS (17.372s) [247.317349] [021/142] (802s left) gem_spin_batch (engines) [247.619845] Starting subtest: engines [247.641483] Starting dynamic subtest: rcs0 [251.129526] Dynamic subtest rcs0: SUCCESS (3.326s) [251.164532] Starting dynamic subtest: bcs0 [254.458673] Dynamic subtest bcs0: SUCCESS (3.325s) [254.494043] Starting dynamic subtest: vcs0 [257.510589] Dynamic subtest vcs0: SUCCESS (3.228s) [257.552080] Starting dynamic subtest: vecs0 [261.018781] Dynamic subtest vecs0: SUCCESS (3.326s) [261.037441] Subtest engines: SUCCESS (13.208s) [261.127133] [022/142] (788s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [261.565052] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [263.344538] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.856s) [263.510452] [023/142] (786s left) perf (gen8-unprivileged-single-ctx-counters) [263.948033] Starting subtest: gen8-unprivileged-single-ctx-counters [264.158438] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.211s) [264.264452] [024/142] (785s left) api_intel_bb (full-batch) [264.570735] Starting subtest: full-batch [264.589981] Subtest full-batch: SUCCESS (0.006s) [264.675753] [025/142] (785s left) gem_tiling_max_stride [265.128315] [026/142] (784s left) gem_exec_balancer (full-late-pulse) [265.425133] Starting subtest: full-late-pulse [269.632347] Subtest full-late-pulse: SUCCESS (4.030s) [273.580551] [027/142] (776s left) gem_ctx_persistence (saturated-hostile-nopreempt) [273.882143] Starting subtest: saturated-hostile-nopreempt [273.901225] Starting dynamic subtest: rcs0 [273.988755] Dynamic subtest rcs0: SUCCESS (0.117s) [274.032532] Starting dynamic subtest: bcs0 [274.117586] Dynamic subtest bcs0: SUCCESS (0.135s) [274.157972] Starting dynamic subtest: vcs0 [274.256080] Dynamic subtest vcs0: SUCCESS (0.130s) [274.297423] Starting dynamic subtest: vecs0 [274.362988] Dynamic subtest vecs0: SUCCESS (0.116s) [274.384256] Subtest saturated-hostile-nopreempt: SUCCESS (0.501s) [274.509497] [028/142] (775s left) gem_lmem_swapping (parallel-multi) [274.828299] Subtest parallel-multi: SKIP (0.000s) [274.913049] [029/142] (775s left) i915_hangman (engine-engine-error) [275.213660] Starting subtest: engine-engine-error [275.232553] Starting dynamic subtest: rcs0 [275.296158] Dynamic subtest rcs0: SUCCESS (0.087s) [275.337410] Starting dynamic subtest: bcs0 [275.376227] Dynamic subtest bcs0: SKIP (0.002s) [275.417129] Starting dynamic subtest: vcs0 [275.435518] Dynamic subtest vcs0: SUCCESS (0.083s) [275.472493] Starting dynamic subtest: vecs0 [275.493913] Dynamic subtest vecs0: SUCCESS (0.095s) [275.515156] Subtest engine-engine-error: SUCCESS (0.271s) [275.606011] [030/142] (774s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted) [275.899834] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted [275.920513] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.001s) [276.005623] [031/142] (774s left) gem_exec_whisper (basic-queues) [276.345578] Starting subtest: basic-queues [283.756364] Subtest basic-queues: SUCCESS (7.339s) [283.885080] [032/142] (766s left) vgem_basic (bad-pad) [284.177340] Starting subtest: bad-pad [284.198740] Subtest bad-pad: SUCCESS (0.000s) [284.291897] [033/142] (766s left) kms_cursor_crc (cursor-onscreen-256x85) [284.675643] Starting subtest: cursor-onscreen-256x85 [284.693944] Starting dynamic subtest: pipe-A-DP-1 [287.026450] Dynamic subtest pipe-A-DP-1: SUCCESS (2.336s) [287.119443] Starting dynamic subtest: pipe-C-DP-1 [289.807962] Dynamic subtest pipe-C-DP-1: SUCCESS (2.694s) [289.830605] Subtest cursor-onscreen-256x85: SUCCESS (5.107s) [290.198560] [034/142] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [290.652957] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [290.698847] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [290.821757] [035/142] (759s left) gem_exec_fence (syncobj-timeline-chain-engines) [291.691632] Starting subtest: syncobj-timeline-chain-engines [291.821321] Subtest syncobj-timeline-chain-engines: SUCCESS (0.131s) [292.076312] [036/142] (758s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs) [292.568100] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs [292.609029] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s) [293.160241] [037/142] (757s left) gem_set_tiling_vs_blt (tiled-to-tiled) [293.466500] Starting subtest: tiled-to-tiled [293.583078] Subtest tiled-to-tiled: SUCCESS (0.119s) [293.712207] [038/142] (757s left) i915_pm_rpm (debugfs-forcewake-user) [295.658785] Starting subtest: debugfs-forcewake-user [306.537950] Subtest debugfs-forcewake-user: SUCCESS (10.750s) [306.936574] [039/142] (744s left) gem_exec_balancer (waits) [307.231427] Starting subtest: waits [311.180425] Subtest waits: SUCCESS (3.783s) [315.168323] [040/142] (736s left) kms_pwrite_crc [316.461981] [041/142] (734s left) kms_plane_multiple (tiling-y) [316.848683] Starting subtest: tiling-y [316.869159] Starting dynamic subtest: pipe-A-DP-1 [318.735274] Dynamic subtest pipe-A-DP-1: SUCCESS (1.888s) [318.775062] Starting dynamic subtest: pipe-B-DP-1 [320.790197] Dynamic subtest pipe-B-DP-1: SUCCESS (2.073s) [320.831484] Starting dynamic subtest: pipe-C-DP-1 [322.814172] Dynamic subtest pipe-C-DP-1: SUCCESS (1.996s) [322.841511] Subtest tiling-y: SUCCESS (5.967s) [323.227481] [042/142] (728s left) kms_vblank (pipe-d-ts-continuation-suspend) [323.638639] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s) [323.886753] [043/142] (727s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [324.273782] Starting subtest: map-fixed-invalidate-overlap-busy [324.293923] Starting dynamic subtest: gtt [328.401989] Dynamic subtest gtt: SUCCESS (4.020s) [328.445461] Starting dynamic subtest: wb [332.327703] Dynamic subtest wb: SUCCESS (3.913s) [332.370653] Starting dynamic subtest: wc [336.332979] Dynamic subtest wc: SUCCESS (4.006s) [336.372174] Starting dynamic subtest: uc [340.375004] Dynamic subtest uc: SUCCESS (4.048s) [340.393705] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (15.994s) [340.483789] [044/142] (711s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [340.923760] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [340.960809] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [341.075840] [045/142] (710s left) kms_chamelium_edid (vga-edid-read) [341.576177] Subtest vga-edid-read: SKIP (0.000s) [341.893682] [046/142] (710s left) i915_module_load (load) [342.177538] Starting subtest: load [342.215073] Subtest load: SKIP (0.003s) [342.326202] [047/142] (709s left) kms_content_protection (lic) [342.736168] Starting subtest: LIC [342.774688] Starting dynamic subtest: pipe-A-DP-1 [463.846624] Per-test timeout exceeded. Killing the current test with SIGQUIT. [470.983284] Closing watchdogs [470.990627] Initializing watchdogs [470.990819] /dev/watchdog0 [471.063103] [048/142] (581s left) gem_exec_flush (basic-batch-kernel-default-uc) [471.412181] Starting subtest: basic-batch-kernel-default-uc [477.298750] Subtest basic-batch-kernel-default-uc: SUCCESS (5.919s) [477.514079] [049/142] (574s left) gem_mmap_gtt (basic-write-gtt) [477.819171] Starting subtest: basic-write-gtt [478.533010] Subtest basic-write-gtt: SUCCESS (0.749s) [478.669455] [050/142] (573s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs) [479.225604] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs [479.262883] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s) [479.769860] [051/142] (572s left) gem_userptr_blits (map-fixed-invalidate-overlap) [480.140484] Starting subtest: map-fixed-invalidate-overlap [480.159143] Starting dynamic subtest: gtt [480.412540] Dynamic subtest gtt: SUCCESS (0.360s) [480.457070] Starting dynamic subtest: wb [480.692931] Dynamic subtest wb: SUCCESS (0.281s) [480.733055] Starting dynamic subtest: wc [480.979717] Dynamic subtest wc: SUCCESS (0.285s) [481.022619] Starting dynamic subtest: uc [481.260896] Dynamic subtest uc: SUCCESS (0.277s) [481.282125] Subtest map-fixed-invalidate-overlap: SUCCESS (1.212s) [481.430856] [052/142] (571s left) gem_exec_gttfill (all-engines) [481.732621] Starting subtest: all-engines [524.750748] Subtest all-engines: SUCCESS (43.022s) [524.985754] [053/142] (527s left) syncobj_basic (bad-handle-to-fd) [525.413177] Starting subtest: bad-handle-to-fd [525.431954] Subtest bad-handle-to-fd: SUCCESS (0.000s) [525.529485] [054/142] (527s left) gem_ctx_param (invalid-param-get) [525.825997] Starting subtest: invalid-param-get [525.847627] Subtest invalid-param-get: SUCCESS (0.000s) [525.943447] [055/142] (526s left) kms_addfb_basic (unused-handle) [526.244053] Starting subtest: unused-handle [526.264528] Subtest unused-handle: SUCCESS (0.000s) [526.553190] [056/142] (526s left) perf (invalid-oa-format-id) [527.015682] Starting subtest: invalid-oa-format-id [527.085646] Subtest invalid-oa-format-id: SUCCESS (0.051s) [527.198220] [057/142] (525s left) kms_force_connector_basic (force-load-detect) [527.518685] Subtest force-load-detect: SKIP (0.000s) [527.610252] [058/142] (525s left) kms_big_fb (4-tiled-16bpp-rotate-90) [528.045482] Starting subtest: 4-tiled-16bpp-rotate-90 [528.082851] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [528.198373] [059/142] (525s left) kms_big_fb (linear-32bpp-rotate-180) [528.577980] Starting subtest: linear-32bpp-rotate-180 [534.562341] Subtest linear-32bpp-rotate-180: SUCCESS (6.006s) [535.135017] [060/142] (518s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [535.618075] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [535.964943] [061/142] (517s left) kms_busy (extended-modeset-hang-oldfb) [536.340478] Starting subtest: extended-modeset-hang-oldfb [536.360994] Starting dynamic subtest: pipe-A [544.279666] Dynamic subtest pipe-A: SUCCESS (7.941s) [544.327613] Starting dynamic subtest: pipe-C [552.263092] Dynamic subtest pipe-C: SUCCESS (7.975s) [552.284424] Subtest extended-modeset-hang-oldfb: SUCCESS (15.928s) [552.662936] [062/142] (500s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [553.109958] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [553.152432] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [553.265009] [063/142] (500s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [553.683831] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [553.725476] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [553.837879] [064/142] (499s left) prime_vgem (basic-read) [554.157014] Starting subtest: basic-read [554.198209] Subtest basic-read: SUCCESS (0.054s) [554.336207] [065/142] (499s left) gem_ctx_param (invalid-size-set) [554.631125] Starting subtest: invalid-size-set [554.650213] Subtest invalid-size-set: SUCCESS (0.000s) [554.762754] [066/142] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [555.205385] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [555.244521] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [555.373128] [067/142] (498s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [555.798682] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [557.184535] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.422s) [557.393113] [068/142] (496s left) dmabuf_sync_file (export-basic) [557.695711] Starting subtest: export-basic [557.716492] Subtest export-basic: SUCCESS (0.003s) [557.809268] [069/142] (496s left) perf (stress-open-close) [558.187358] Starting subtest: stress-open-close [558.205892] Starting dynamic subtest: 0-rcs0 [560.417015] Dynamic subtest 0-rcs0: SUCCESS (2.249s) [560.437446] Subtest stress-open-close: SUCCESS (2.251s) [560.528839] [070/142] (493s left) kms_psr2_su (frontbuffer-xrgb8888) [560.851464] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [560.950989] [071/142] (493s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs) [561.566836] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs [561.585799] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.001s) [562.059196] [072/142] (492s left) kms_flip (basic-flip-vs-wf_vblank) [562.447477] Starting subtest: basic-flip-vs-wf_vblank [562.466015] Starting dynamic subtest: A-DP1 [563.908084] Dynamic subtest A-DP1: SUCCESS (1.487s) [563.953514] Starting dynamic subtest: B-DP1 [565.309748] Dynamic subtest B-DP1: SUCCESS (1.408s) [565.352252] Starting dynamic subtest: C-DP1 [566.733147] Dynamic subtest C-DP1: SUCCESS (1.415s) [566.755143] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.322s) [567.209630] [073/142] (487s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs) [567.722575] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs [567.742994] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s) [568.307790] [074/142] (486s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [568.702561] Starting subtest: yf-tiled-32bpp-rotate-0 [573.612567] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (4.927s) [574.169627] [075/142] (480s left) i915_pm_rpm (pc8-residency) [576.061726] Starting subtest: pc8-residency [576.102933] Subtest pc8-residency: SKIP (0.000s) [576.606046] [076/142] (478s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [576.926594] Starting subtest: invalid-multi-wait-unsubmitted [576.948216] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [577.058583] [077/142] (478s left) gem_mmap_gtt (big-copy-odd) [577.360764] Starting subtest: big-copy-odd [588.951291] Subtest big-copy-odd: SUCCESS (11.644s) [589.134778] [078/142] (466s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [589.684418] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [589.703199] Starting dynamic subtest: pipe-A-DP-1 [592.107630] Dynamic subtest pipe-A-DP-1: SUCCESS (2.425s) [592.174964] Starting dynamic subtest: pipe-B-DP-1 [594.818623] Dynamic subtest pipe-B-DP-1: SUCCESS (2.685s) [594.887379] Starting dynamic subtest: pipe-C-DP-1 [595.226283] Dynamic subtest pipe-C-DP-1: SUCCESS (0.403s) [595.249638] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.528s) [595.677808] [079/142] (459s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs) [596.456936] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s) [596.802832] [080/142] (458s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc) [597.424624] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc [597.462118] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [597.920133] [081/142] (457s left) syncobj_wait (single-wait-for-submit-unsubmitted) [598.250098] Starting subtest: single-wait-for-submit-unsubmitted [598.356758] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s) [598.499296] [082/142] (457s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs) [599.289063] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s) [599.621459] [083/142] (456s left) kms_psr (psr2_sprite_render) [599.939913] Subtest psr2_sprite_render: SKIP (0.000s) [600.059668] [084/142] (455s left) syncobj_timeline (signal-array) [600.358916] Starting subtest: signal-array [600.379655] Subtest signal-array: SUCCESS (0.001s) [600.492311] [085/142] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [600.948190] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [600.985560] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [601.102248] [086/142] (455s left) drm_fdinfo (all-busy-check-all) [601.397246] Starting subtest: all-busy-check-all [601.915536] Subtest all-busy-check-all: SUCCESS (0.527s) [602.034314] [087/142] (454s left) vc4/vc4_label_bo (set-bad-name) [602.405975] Subtest set-bad-name: SKIP (0.000s) [602.525101] [088/142] (453s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged) [602.876081] Subtest mark-unpurgeable-purged: SKIP (0.000s) [602.988897] [089/142] (453s left) kms_cursor_crc (cursor-random-64x21) [603.383559] Starting subtest: cursor-random-64x21 [603.404487] Starting dynamic subtest: pipe-A-DP-1 [607.384269] Dynamic subtest pipe-A-DP-1: SUCCESS (3.983s) [607.477738] Starting dynamic subtest: pipe-C-DP-1 [611.584670] Dynamic subtest pipe-C-DP-1: SUCCESS (4.155s) [611.604224] Subtest cursor-random-64x21: SUCCESS (8.221s) [611.992442] [090/142] (444s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [612.444351] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [612.483599] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s) [612.597847] [091/142] (444s left) kms_psr (sprite_mmap_gtt) [612.910988] Subtest sprite_mmap_gtt: SKIP (0.000s) [613.030929] [092/142] (443s left) core_auth (basic-auth) [613.328703] Starting subtest: basic-auth [613.349469] Subtest basic-auth: SUCCESS (0.002s) [613.443947] [093/142] (443s left) kms_big_fb (x-tiled-8bpp-rotate-180) [613.879286] Starting subtest: x-tiled-8bpp-rotate-180 [616.779503] Subtest x-tiled-8bpp-rotate-180: SUCCESS (2.936s) [617.041662] [094/142] (440s left) gem_ctx_persistence (hang) [617.344542] Starting subtest: hang [617.384350] Subtest hang: SKIP (0.007s) [617.477635] [095/142] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [617.931515] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [617.971768] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [618.099581] [096/142] (439s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [618.385195] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [618.455086] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s) [618.587119] [097/142] (438s left) kms_vblank (pipe-c-ts-continuation-idle-hang) [618.963040] Starting subtest: pipe-C-ts-continuation-idle-hang [619.003862] Subtest pipe-C-ts-continuation-idle-hang: SKIP (0.000s) [619.245878] [098/142] (438s left) perf (create-destroy-userspace-config) [619.667769] Starting subtest: create-destroy-userspace-config [619.734512] Subtest create-destroy-userspace-config: SUCCESS (0.080s) [619.826776] [099/142] (437s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs) [620.503508] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs [620.562585] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s) [620.903822] [100/142] (436s left) kms_prime (basic-crc-hybrid) [623.198917] Subtest basic-crc-hybrid: SKIP (0.000s) [623.316676] [101/142] (434s left) perf_pmu (busy-idle-no-semaphores) [623.620895] Starting subtest: busy-idle-no-semaphores [623.639603] Starting dynamic subtest: rcs0 [624.238893] Dynamic subtest rcs0: SUCCESS (0.637s) [624.283345] Starting dynamic subtest: bcs0 [624.868853] Dynamic subtest bcs0: SUCCESS (0.627s) [624.912231] Starting dynamic subtest: vcs0 [625.502528] Dynamic subtest vcs0: SUCCESS (0.631s) [625.545506] Starting dynamic subtest: vecs0 [626.138449] Dynamic subtest vecs0: SUCCESS (0.629s) [626.158955] Subtest busy-idle-no-semaphores: SUCCESS (2.542s) [626.280826] [102/142] (431s left) gem_ppgtt (blt-vs-render-ctxn) [626.589069] Starting subtest: blt-vs-render-ctxN [659.875112] Subtest blt-vs-render-ctxN: SUCCESS (33.309s) [660.019474] [103/142] (398s left) gem_mmap_gtt (medium-copy-xy) [660.421864] Starting subtest: medium-copy-XY [666.711991] Subtest medium-copy-XY: SUCCESS (6.309s) [666.833048] [104/142] (391s left) kms_invalid_mode (zero-clock) [667.399161] Starting subtest: zero-clock [667.419375] Starting dynamic subtest: DP-1-pipe-A [667.506367] Dynamic subtest DP-1-pipe-A: SUCCESS (0.112s) [667.553429] Starting dynamic subtest: DP-1-pipe-B [667.575917] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s) [667.622288] Starting dynamic subtest: DP-1-pipe-C [667.642163] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s) [667.660930] Subtest zero-clock: SUCCESS (0.154s) [667.913010] [105/142] (390s left) gen9_exec_parse (basic-rejected-ctx-param) [668.215028] Starting subtest: basic-rejected-ctx-param [668.290199] Subtest basic-rejected-ctx-param: SUCCESS (0.080s) [668.564477] [106/142] (389s left) gem_create (create-ext-set-pat) [668.960055] Starting subtest: create-ext-set-pat [668.997872] Subtest create-ext-set-pat: SKIP (0.000s) [669.094699] [107/142] (389s left) gem_exec_reloc (basic-write-cpu-active) [669.394753] Starting subtest: basic-write-cpu-active [669.519370] Subtest basic-write-cpu-active: SUCCESS (0.139s) [669.752121] [108/142] (388s left) gem_mmap_offset (ptrace) [670.049485] Starting subtest: ptrace [670.070733] Starting dynamic subtest: smem0-gtt [670.114685] Dynamic subtest smem0-gtt: SUCCESS (0.088s) [670.157427] Starting dynamic subtest: smem0-wb [670.198108] Dynamic subtest smem0-wb: SUCCESS (0.080s) [670.239423] Starting dynamic subtest: smem0-wc [670.282478] Dynamic subtest smem0-wc: SUCCESS (0.077s) [670.326569] Starting dynamic subtest: smem0-uc [670.368493] Dynamic subtest smem0-uc: SUCCESS (0.080s) [670.387339] Subtest ptrace: SUCCESS (0.341s) [670.513725] [109/142] (388s left) kms_pipe_crc_basic (disable-crc-after-crtc) [670.880795] Starting subtest: disable-crc-after-crtc [670.901926] Starting dynamic subtest: pipe-A-DP-1 [671.657671] Dynamic subtest pipe-A-DP-1: SUCCESS (0.757s) [671.711910] Starting dynamic subtest: pipe-B-DP-1 [672.665100] Dynamic subtest pipe-B-DP-1: SUCCESS (1.009s) [672.729632] Starting dynamic subtest: pipe-C-DP-1 [673.845882] Dynamic subtest pipe-C-DP-1: SUCCESS (1.166s) [673.868499] Subtest disable-crc-after-crtc: SUCCESS (2.947s) [674.207946] [110/142] (384s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [674.662899] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [674.700166] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [674.817319] [111/142] (384s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [675.261676] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [675.301571] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [675.419738] [112/142] (383s left) gem_pread (self) [675.721614] Starting subtest: self [675.762756] Subtest self: SUCCESS (0.064s) [675.908493] [113/142] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [676.351352] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [678.863687] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.592s) [679.088355] [114/142] (380s left) gem_mmap_gtt (basic-wc) [679.401350] Starting subtest: basic-wc [679.998554] Subtest basic-wc: SUCCESS (0.631s) [680.174336] [115/142] (379s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs) [680.648653] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs [681.322453] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.665s) [682.069079] [116/142] (377s left) kms_flip (2x-dpms-vs-vblank-race) [682.435649] Starting subtest: 2x-dpms-vs-vblank-race [682.473297] Subtest 2x-dpms-vs-vblank-race: SKIP (0.003s) [682.597328] [117/142] (376s left) kms_chamelium_hpd (vga-hpd) [683.075714] Subtest vga-hpd: SKIP (0.000s) [683.393564] [118/142] (376s left) gem_ctx_engines (execute-one) [683.700120] Starting subtest: execute-one [686.977259] Subtest execute-one: SUCCESS (3.109s) [687.075963] [119/142] (372s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [687.805135] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc [687.848155] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.004s) [688.168256] [120/142] (371s left) kms_flip_event_leak (basic) [688.541997] Starting subtest: basic [688.562748] Starting dynamic subtest: pipe-A-DP-1 [688.815066] Dynamic subtest pipe-A-DP-1: SUCCESS (0.283s) [688.857565] Starting dynamic subtest: pipe-B-DP-1 [689.373935] Dynamic subtest pipe-B-DP-1: SUCCESS (0.560s) [689.432780] Starting dynamic subtest: pipe-C-DP-1 [690.121637] Dynamic subtest pipe-C-DP-1: SUCCESS (0.736s) [690.143639] Subtest basic: SUCCESS (1.592s) [690.501949] [121/142] (369s left) gem_exec_fence (keep-in-fence) [690.952686] Starting subtest: keep-in-fence [690.974271] Starting dynamic subtest: rcs0 [690.996057] Dynamic subtest rcs0: SUCCESS (0.045s) [691.049815] Starting dynamic subtest: bcs0 [691.140390] Dynamic subtest bcs0: SUCCESS (0.157s) [691.185188] Starting dynamic subtest: vcs0 [691.204054] Dynamic subtest vcs0: SUCCESS (0.046s) [691.251422] Starting dynamic subtest: vecs0 [691.273135] Dynamic subtest vecs0: SUCCESS (0.042s) [691.293697] Subtest keep-in-fence: SUCCESS (0.300s) [691.947591] [122/142] (368s left) gem_exec_params (sol-reset-invalid) [692.247792] Starting subtest: sol-reset-invalid [692.266559] Subtest sol-reset-invalid: SUCCESS (0.003s) [692.405297] [123/142] (367s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [692.775474] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [692.795524] Starting dynamic subtest: pipe-A-valid-mode [693.260252] Dynamic subtest pipe-A-valid-mode: SKIP (0.462s) [693.305237] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.466s) [693.660295] [124/142] (366s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [693.958626] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [693.977572] Starting dynamic subtest: smem [694.398505] Dynamic subtest smem: SUCCESS (0.442s) [694.419507] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.445s) [694.663439] [125/142] (365s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [695.029689] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [695.050616] Starting dynamic subtest: pipe-A-DP-1 [695.125201] Dynamic subtest pipe-A-DP-1: SUCCESS (0.087s) [695.168855] Starting dynamic subtest: pipe-B-DP-1 [695.503758] Dynamic subtest pipe-B-DP-1: SUCCESS (0.375s) [695.547486] Starting dynamic subtest: pipe-C-DP-1 [695.640194] Dynamic subtest pipe-C-DP-1: SKIP (0.093s) [695.662321] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.572s) [696.052785] [126/142] (364s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [696.705467] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [696.745596] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [697.170539] [127/142] (363s left) v3d/v3d_submit_cl (bad-multisync-pad) [697.554287] Subtest bad-multisync-pad: SKIP (0.000s) [697.669348] [128/142] (363s left) perf (i915-ref-count) [698.047561] Starting subtest: i915-ref-count [698.158834] Subtest i915-ref-count: SUCCESS (0.114s) [698.297577] [129/142] (362s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [698.721228] Starting subtest: psr-rgb565-draw-mmap-cpu [698.763452] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s) [698.879872] [130/142] (362s left) gem_exec_schedule (preempt-user) [699.352659] Starting subtest: preempt-user [699.375776] Starting dynamic subtest: rcs0 [699.399480] Dynamic subtest rcs0: SUCCESS (0.070s) [699.450142] Starting dynamic subtest: bcs0 [699.473936] Dynamic subtest bcs0: SUCCESS (0.088s) [699.521447] Starting dynamic subtest: vcs0 [699.544974] Dynamic subtest vcs0: SUCCESS (0.061s) [699.591522] Starting dynamic subtest: vecs0 [699.615432] Dynamic subtest vecs0: SUCCESS (0.064s) [699.639651] Subtest preempt-user: SUCCESS (0.295s) [699.906865] [131/142] (361s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [700.277335] Starting subtest: primary-y-tiled-reflect-x-270 [700.314725] Subtest primary-y-tiled-reflect-x-270: SKIP (0.003s) [700.436992] [132/142] (360s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [700.877941] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [700.920699] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s) [701.035855] [133/142] (360s left) i915_suspend (forcewake) [701.337247] Starting subtest: forcewake [737.188210] Subtest forcewake: SUCCESS (3.144s) [743.330782] [134/142] (356s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs) [743.931141] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs [743.968502] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s) [744.457533] [135/142] (355s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [744.899441] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [744.940723] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [745.065176] [136/142] (355s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [745.414413] Starting subtest: short-flip-before-cursor-atomic-transitions [746.573238] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.134s) [746.930180] [137/142] (353s left) kms_vblank (pipe-a-wait-busy-hang) [747.298453] Starting subtest: pipe-A-wait-busy-hang [754.168753] Subtest pipe-A-wait-busy-hang: SUCCESS (6.745s) [754.442752] [138/142] (346s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_mc_ccs) [755.198940] Subtest pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [755.532864] [139/142] (345s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [755.917695] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [755.955503] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.003s) [756.074476] [140/142] (344s left) kms_flip (plain-flip-fb-recreate) [756.456427] Starting subtest: plain-flip-fb-recreate [756.475410] Starting dynamic subtest: A-DP1 [767.271858] Dynamic subtest A-DP1: SUCCESS (10.834s) [767.317136] Starting dynamic subtest: B-DP1 [778.047718] Dynamic subtest B-DP1: SUCCESS (10.765s) [778.091644] Starting dynamic subtest: C-DP1 [788.772125] Dynamic subtest C-DP1: SUCCESS (10.738s) [788.796713] Subtest plain-flip-fb-recreate: SUCCESS (32.352s) [789.275718] [141/142] (311s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [789.748892] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [789.791234] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [789.909928] [142/142] (311s left) gem_eio (in-flight-internal-10ms) [790.250588] Starting subtest: in-flight-internal-10ms [790.339529] Subtest in-flight-internal-10ms: SUCCESS (0.114s) [790.542053] Closing watchdogs Done.