[37.281894] Initializing watchdogs [37.282063] /dev/watchdog0 [37.296355] [001/144] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [37.387508] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [41.896240] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.513s) [42.026156] [002/144] (955s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [42.114674] Starting subtest: plane-downscale-factor-0-5-with-modifiers [42.117251] Starting dynamic subtest: pipe-A-eDP-1 [42.149944] Dynamic subtest pipe-A-eDP-1: SKIP (0.030s) [42.155589] Starting dynamic subtest: pipe-B-eDP-1 [42.193615] Dynamic subtest pipe-B-eDP-1: SKIP (0.044s) [42.201171] Starting dynamic subtest: pipe-C-eDP-1 [42.236252] Dynamic subtest pipe-C-eDP-1: SKIP (0.043s) [42.244465] Starting dynamic subtest: pipe-D-eDP-1 [42.266392] Dynamic subtest pipe-D-eDP-1: SKIP (0.029s) [42.270762] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.150s) [42.364151] [003/144] (955s left) gem_exec_schedule (pi-common) [42.552312] Starting subtest: pi-common [42.554553] Starting dynamic subtest: rcs0 [42.673294] Dynamic subtest rcs0: SUCCESS (0.123s) [42.699416] Starting dynamic subtest: bcs0 [42.757457] Dynamic subtest bcs0: SUCCESS (0.084s) [42.781707] Starting dynamic subtest: vcs0 [42.838948] Dynamic subtest vcs0: SUCCESS (0.082s) [42.864438] Starting dynamic subtest: vcs1 [42.923400] Dynamic subtest vcs1: SUCCESS (0.084s) [42.946351] Starting dynamic subtest: vecs0 [43.005689] Dynamic subtest vecs0: SUCCESS (0.082s) [43.031697] Starting dynamic subtest: ccs0 [43.087710] Dynamic subtest ccs0: SUCCESS (0.082s) [43.091203] Subtest pi-common: SUCCESS (0.538s) [43.301840] [004/144] (954s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [43.709393] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs-cc [43.714207] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [44.549835] [005/144] (953s left) kms_psr (fbc-pr-primary-mmap-cpu) [44.637407] Starting subtest: fbc-pr-primary-mmap-cpu [44.642299] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [44.740251] [006/144] (953s left) gem_exec_fence (nb-await) [44.940597] Starting subtest: nb-await [44.943797] Starting dynamic subtest: rcs0 [45.019771] Dynamic subtest rcs0: SUCCESS (0.080s) [45.035221] Starting dynamic subtest: bcs0 [45.086671] Dynamic subtest bcs0: SUCCESS (0.067s) [45.101077] Starting dynamic subtest: vcs0 [45.149345] Dynamic subtest vcs0: SUCCESS (0.062s) [45.164214] Starting dynamic subtest: vcs1 [45.215630] Dynamic subtest vcs1: SUCCESS (0.066s) [45.230159] Starting dynamic subtest: vecs0 [45.280465] Dynamic subtest vecs0: SUCCESS (0.065s) [45.294279] Starting dynamic subtest: ccs0 [45.343272] Dynamic subtest ccs0: SUCCESS (0.062s) [45.346305] Subtest nb-await: SUCCESS (0.404s) [47.516106] [007/144] (950s left) prime_vgem (sync) [47.609734] Starting subtest: sync [47.612397] Starting dynamic subtest: rcs0 [47.652170] Dynamic subtest rcs0: SUCCESS (0.042s) [47.665150] Starting dynamic subtest: bcs0 [47.715572] Dynamic subtest bcs0: SUCCESS (0.063s) [47.727595] Starting dynamic subtest: vcs0 [47.773703] Dynamic subtest vcs0: SUCCESS (0.058s) [47.785271] Starting dynamic subtest: vcs1 [47.829316] Dynamic subtest vcs1: SUCCESS (0.055s) [47.837937] Starting dynamic subtest: vecs0 [47.885646] Dynamic subtest vecs0: SUCCESS (0.056s) [47.898259] Starting dynamic subtest: ccs0 [47.944109] Dynamic subtest ccs0: SUCCESS (0.058s) [47.946988] Subtest sync: SUCCESS (0.334s) [48.059666] [008/144] (949s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [48.124786] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [48.143697] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.014s) [48.210284] [009/144] (949s left) drm_fdinfo (busy-check-all) [48.296173] Starting subtest: busy-check-all [48.299213] Starting dynamic subtest: rcs0 [48.307269] Dynamic subtest rcs0: SKIP (0.007s) [48.321530] Starting dynamic subtest: bcs0 [48.326256] Dynamic subtest bcs0: SKIP (0.001s) [48.338600] Starting dynamic subtest: vcs0 [48.343710] Dynamic subtest vcs0: SKIP (0.001s) [48.353758] Starting dynamic subtest: vcs1 [48.359680] Dynamic subtest vcs1: SKIP (0.001s) [48.369413] Starting dynamic subtest: vecs0 [48.374645] Dynamic subtest vecs0: SKIP (0.001s) [48.383612] Starting dynamic subtest: ccs0 [48.388461] Dynamic subtest ccs0: SKIP (0.001s) [48.393541] Subtest busy-check-all: SKIP (0.012s) [48.412922] [010/144] (949s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [48.473730] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [48.476246] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [48.559379] [011/144] (949s left) syncobj_wait (invalid-reset-one-illegal-handle) [48.620444] Starting subtest: invalid-reset-one-illegal-handle [48.622441] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [48.687983] [012/144] (949s left) drm_fdinfo (virtual-busy-hang) [48.742420] Starting subtest: virtual-busy-hang [48.745837] Subtest virtual-busy-hang: SKIP (0.000s) [48.799600] [013/144] (949s left) gen9_exec_parse (bb-oversize) [48.852399] Subtest bb-oversize: SKIP (0.000s) [48.879247] [014/144] (949s left) kms_addfb_basic (invalid-get-prop) [48.934191] Starting subtest: invalid-get-prop [48.936432] Subtest invalid-get-prop: SUCCESS (0.000s) [49.057120] [015/144] (949s left) kms_chamelium_frames (dp-crc-fast) [49.415412] Subtest dp-crc-fast: SKIP (0.000s) [50.311044] [016/144] (947s left) gem_exec_reloc (basic-wc-cpu-active) [50.378570] Subtest basic-wc-cpu-active: SKIP (0.000s) [50.414243] [017/144] (947s left) api_intel_bb (blit-noreloc-purge-cache) [50.475919] Starting subtest: blit-noreloc-purge-cache [50.487532] Subtest blit-noreloc-purge-cache: SUCCESS (0.013s) [50.580339] [018/144] (947s left) kms_panel_fitting (atomic-fastset) [50.646831] Starting subtest: atomic-fastset [50.649380] Starting dynamic subtest: pipe-A-eDP-1 [50.784072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s) [50.797750] Starting dynamic subtest: pipe-B-eDP-1 [52.104458] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.319s) [52.119255] Starting dynamic subtest: pipe-C-eDP-1 [53.393047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.286s) [53.402873] Starting dynamic subtest: pipe-D-eDP-1 [54.609059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [54.611658] Subtest atomic-fastset: SUCCESS (3.963s) [55.846677] [019/144] (942s left) syncobj_wait (wait-for-submit-delayed-submit) [55.910350] Starting subtest: wait-for-submit-delayed-submit [56.012561] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [56.082521] [020/144] (942s left) gem_partial_pwrite_pread (write-display) [56.143333] Subtest write-display: SKIP (0.000s) [56.196191] [021/144] (942s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [56.304618] Starting subtest: flip-vs-cursor-busy-crc-atomic [57.316027] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (1.010s) [58.214199] [022/144] (940s left) i915_suspend (fence-restore-untiled) [58.259449] Starting subtest: fence-restore-untiled [58.263297] Subtest fence-restore-untiled: SKIP (0.000s) [58.322452] [023/144] (940s left) gem_exec_store (dword) [58.380656] Starting subtest: dword [58.382881] Starting dynamic subtest: rcs0 [58.433582] Dynamic subtest rcs0: SUCCESS (0.056s) [58.448639] Starting dynamic subtest: bcs0 [58.478513] Dynamic subtest bcs0: SUCCESS (0.044s) [58.492739] Starting dynamic subtest: vcs0 [58.521257] Dynamic subtest vcs0: SUCCESS (0.042s) [58.535371] Starting dynamic subtest: vcs1 [58.565250] Dynamic subtest vcs1: SUCCESS (0.044s) [58.580928] Starting dynamic subtest: vecs0 [60.460509] Dynamic subtest vecs0: SUCCESS (1.893s) [60.475535] Starting dynamic subtest: ccs0 [60.503895] Dynamic subtest ccs0: SUCCESS (0.044s) [60.506767] Subtest dword: SUCCESS (2.125s) [60.689624] [024/144] (937s left) kms_flip (2x-absolute-wf_vblank) [60.776251] Starting subtest: 2x-absolute-wf_vblank [60.788292] Subtest 2x-absolute-wf_vblank: SKIP (0.014s) [60.862265] [025/144] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [60.920254] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [60.924742] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [61.002653] [026/144] (937s left) kms_cursor_crc (cursor-suspend) [61.109980] Starting subtest: cursor-suspend [61.112469] Starting dynamic subtest: pipe-A-eDP-1 [94.978786] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.107s) [94.992096] Starting dynamic subtest: pipe-D-eDP-1 [128.917503] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.863s) [128.920238] Subtest cursor-suspend: SUCCESS (7.973s) [129.798295] [027/144] (928s left) kms_psr (fbc-psr-cursor-plane-move) [129.850598] Starting subtest: fbc-psr-cursor-plane-move [129.853031] Starting dynamic subtest: eDP-1 [129.857317] Dynamic subtest eDP-1: SKIP (0.000s) [129.861155] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [129.948524] [028/144] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [130.031924] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [130.035593] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [130.106460] [029/144] (928s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [130.174703] Starting subtest: blocking-absolute-wf_vblank-interruptible [130.177121] Starting dynamic subtest: A-eDP1 [138.948474] Dynamic subtest A-eDP1: SUCCESS (8.773s) [138.964248] Starting dynamic subtest: B-eDP1 [147.717856] Dynamic subtest B-eDP1: SUCCESS (8.768s) [147.736770] Starting dynamic subtest: C-eDP1 [156.542394] Dynamic subtest C-eDP1: SUCCESS (8.824s) [156.558619] Starting dynamic subtest: D-eDP1 [165.306433] Dynamic subtest D-eDP1: SUCCESS (8.763s) [165.314583] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (35.141s) [166.555608] [030/144] (891s left) kms_psr (fbc-psr2-primary-render) [166.649865] Starting subtest: fbc-psr2-primary-render [166.652364] Starting dynamic subtest: eDP-1 [166.657246] Dynamic subtest eDP-1: SKIP (0.000s) [166.661923] Subtest fbc-psr2-primary-render: SKIP (0.001s) [166.754853] [031/144] (891s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [166.837304] Starting subtest: psr-1p-pri-indfb-multidraw [187.171485] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (20.339s) [187.291393] [032/144] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [187.380631] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [187.384169] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [187.451479] [033/144] (871s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs) [187.874035] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs [187.876807] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [188.764400] [034/144] (869s left) gem_workarounds (reset-context) [188.849539] Starting subtest: reset-context [189.017452] Subtest reset-context: SUCCESS (0.166s) [189.110122] [035/144] (869s left) kms_properties (connector-properties-legacy) [189.183223] Starting subtest: connector-properties-legacy [197.876531] Subtest connector-properties-legacy: SUCCESS (8.689s) [198.753360] [036/144] (859s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [198.844397] Starting subtest: fbcpsr-rgb565-draw-pwrite [203.733257] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (4.891s) [203.860489] [037/144] (854s left) kms_plane_scaling (invalid-num-scalers) [203.910154] Starting subtest: invalid-num-scalers [203.914687] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [203.925381] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.013s) [203.933249] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [203.944754] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [203.957543] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [203.965338] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [203.982541] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [203.985076] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.020s) [203.987576] Subtest invalid-num-scalers: SUCCESS (0.076s) [204.070334] [038/144] (854s left) syncobj_wait (wait-any-complex) [204.113736] Starting subtest: wait-any-complex [204.171662] Subtest wait-any-complex: SUCCESS (0.062s) [204.244597] [039/144] (854s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-mc-ccs) [204.660011] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs [204.665662] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s) [205.510721] [040/144] (853s left) fbdev (unaligned-write) [205.576224] Starting subtest: unaligned-write [205.755483] Subtest unaligned-write: SUCCESS (0.178s) [205.817186] [041/144] (852s left) kms_prime (basic-crc-vgem) [206.369863] Starting subtest: basic-crc-vgem [206.371966] Starting dynamic subtest: second-to-first [207.377433] Dynamic subtest second-to-first: SUCCESS (1.009s) [207.379571] Subtest basic-crc-vgem: SUCCESS (1.010s) [207.457057] [042/144] (851s left) gem_exec_balancer (parallel-keep-submit-fence) [207.724782] Starting subtest: parallel-keep-submit-fence [208.787190] Subtest parallel-keep-submit-fence: SUCCESS (1.062s) [208.841842] [043/144] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [208.933615] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [208.938126] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [209.028708] [044/144] (849s left) gem_userptr_blits (sd-probe) [209.111967] Starting subtest: sd-probe [209.116073] Subtest sd-probe: SUCCESS (0.000s) [209.217400] [045/144] (849s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-mc-ccs) [209.601095] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs [209.606406] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s) [210.529306] [046/144] (848s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [210.594599] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [210.690696] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s) [210.767344] [047/144] (848s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [210.857679] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [210.878264] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.017s) [210.953331] [048/144] (848s left) kms_psr (psr2-sprite-plane-move) [211.021928] Starting subtest: psr2-sprite-plane-move [211.024398] Starting dynamic subtest: eDP-1 [212.878791] Dynamic subtest eDP-1: SUCCESS (1.857s) [212.882303] Subtest psr2-sprite-plane-move: SUCCESS (1.859s) [213.791079] [049/144] (845s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-mc-ccs) [214.211898] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs [214.218228] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s) [215.069248] [050/144] (843s left) kms_feature_discovery (display-2x) [215.156336] Starting subtest: display-2x [215.160582] Subtest display-2x: SKIP (0.000s) [215.221005] [051/144] (843s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [215.289868] Starting subtest: cursorA-vs-flipA-varying-size [226.482899] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.191s) [227.422464] [052/144] (831s left) perf (blocking-parameterized) [227.586365] Starting subtest: blocking-parameterized [247.613211] Subtest blocking-parameterized: SUCCESS (20.027s) [247.648619] [053/144] (811s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [247.744147] Starting subtest: fbc-2p-primscrn-spr-indfb-move [247.748759] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [247.836933] [054/144] (811s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-gen12-rc-ccs) [248.196097] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs [248.201016] Subtest pipe-A-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s) [249.117649] [055/144] (810s left) gem_exec_reloc (basic-write-gtt-noreloc) [249.180293] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [249.246125] [056/144] (809s left) gem_exec_schedule (submit-golden-slice) [249.315658] Starting subtest: submit-golden-slice [249.318081] Starting dynamic subtest: rcs0 [249.351696] Dynamic subtest rcs0: SUCCESS (0.044s) [249.370712] Starting dynamic subtest: bcs0 [249.452517] Dynamic subtest bcs0: SUCCESS (0.100s) [249.471026] Starting dynamic subtest: vcs0 [249.519719] Dynamic subtest vcs0: SUCCESS (0.066s) [249.538958] Starting dynamic subtest: vcs1 [249.577461] Dynamic subtest vcs1: SUCCESS (0.057s) [249.594989] Starting dynamic subtest: vecs0 [249.630219] Dynamic subtest vecs0: SUCCESS (0.052s) [249.649538] Starting dynamic subtest: ccs0 [249.677857] Dynamic subtest ccs0: SUCCESS (0.047s) [249.680295] Subtest submit-golden-slice: SUCCESS (0.371s) [251.363889] [057/144] (807s left) gem_mmap (bad-offset) [251.422484] Subtest bad-offset: SKIP (0.000s) [251.461501] [058/144] (807s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [251.562578] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [252.420011] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.859s) [252.583899] [059/144] (806s left) gem_pxp (fail-invalid-protected-context) [255.161366] Subtest fail-invalid-protected-context: SKIP (0.000s) [255.233784] [060/144] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [255.333588] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [260.516624] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.186s) [260.648291] [061/144] (798s left) kms_frontbuffer_tracking (fbc-suspend) [260.750156] Starting subtest: fbc-suspend [297.934571] Subtest fbc-suspend: SUCCESS (6.532s) [298.059018] [062/144] (791s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [298.143750] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [298.147798] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [298.230645] [063/144] (791s left) kms_big_fb (x-tiled-32bpp-rotate-90) [298.300338] Starting subtest: x-tiled-32bpp-rotate-90 [298.316937] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s) [298.416506] [064/144] (791s left) i915_pm_rc6_residency (rc6-idle) [298.473350] Starting subtest: rc6-idle [298.475926] Starting dynamic subtest: gt0-rcs0 [310.724675] Dynamic subtest gt0-rcs0: SUCCESS (12.247s) [310.745044] Starting dynamic subtest: gt0-bcs0 [323.002774] Dynamic subtest gt0-bcs0: SUCCESS (12.280s) [323.021646] Starting dynamic subtest: gt0-ccs0 [335.286568] Dynamic subtest gt0-ccs0: SUCCESS (12.279s) [335.306064] Starting dynamic subtest: gt1-vcs0 [347.579230] Dynamic subtest gt1-vcs0: SUCCESS (12.293s) [347.599676] Starting dynamic subtest: gt1-vecs0 [360.108552] Dynamic subtest gt1-vecs0: SUCCESS (12.527s) [360.112143] Subtest rc6-idle: SUCCESS (61.637s) [360.967762] [065/144] (729s left) kms_hdr (invalid-hdr) [361.021085] Starting subtest: invalid-hdr [362.154285] Starting dynamic subtest: pipe-A-eDP-1 [365.578662] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s) [365.581373] Subtest invalid-hdr: SUCCESS (4.561s) [365.679404] [066/144] (724s left) gem_exec_fair (basic-none-rrul) [365.762604] Subtest basic-none-rrul: SKIP (0.000s) [365.797909] [067/144] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [365.890924] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [365.895319] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [365.985025] [068/144] (724s left) kms_plane_alpha_blend (alpha-7efc) [366.065706] Starting subtest: alpha-7efc [366.343632] Starting dynamic subtest: pipe-A-eDP-1 [368.171068] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s) [368.211344] Starting dynamic subtest: pipe-D-eDP-1 [369.563478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.367s) [369.566131] Subtest alpha-7efc: SUCCESS (3.496s) [370.463924] [069/144] (719s left) gem_eio (in-flight-immediate) [370.717244] Starting subtest: in-flight-immediate [378.929580] Subtest in-flight-immediate: SUCCESS (8.210s) [379.063153] [070/144] (711s left) kms_invalid_mode (zero-clock) [379.137400] Starting subtest: zero-clock [379.140559] Starting dynamic subtest: pipe-A-eDP-1 [379.421317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [379.441559] Starting dynamic subtest: pipe-B-eDP-1 [379.444938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [379.459940] Starting dynamic subtest: pipe-C-eDP-1 [379.462513] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [379.472694] Starting dynamic subtest: pipe-D-eDP-1 [379.474964] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [379.477034] Subtest zero-clock: SUCCESS (0.293s) [380.321187] [071/144] (710s left) gem_render_copy (yf-tiled-to-vebox-linear) [380.395342] Starting subtest: yf-tiled-to-vebox-linear [380.400355] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [380.579432] [072/144] (709s left) testdisplay [380.867122] [073/144] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [380.955736] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [380.959987] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [381.036188] [074/144] (709s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [381.141499] Starting subtest: basic-busy-flip-before-cursor-legacy [381.146136] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [381.236031] [075/144] (709s left) gem_exec_reloc (basic-gtt-cpu-active) [381.276310] Subtest basic-gtt-cpu-active: SKIP (0.000s) [381.328021] [076/144] (709s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [383.925050] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s) [383.994955] [077/144] (706s left) gem_ctx_param (invalid-get-engines) [384.054682] Starting subtest: invalid-get-engines [384.057192] Subtest invalid-get-engines: SUCCESS (0.000s) [384.123799] [078/144] (706s left) perf_pmu (rc6-all-gts) [384.180487] Starting subtest: rc6-all-gts [390.525830] Subtest rc6-all-gts: SUCCESS (6.344s) [391.296364] [079/144] (699s left) v3d/v3d_wait_bo (bad-pad) [391.415229] Subtest bad-pad: SKIP (0.000s) [391.473711] [080/144] (699s left) vc4/vc4_purgeable_bo (access-purged-bo-mem) [391.589952] Subtest access-purged-bo-mem: SKIP (0.000s) [391.649411] [081/144] (699s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [392.087276] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc [392.093670] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [392.927994] [082/144] (697s left) gem_mmap_gtt (pf-nonblock) [392.999647] Subtest pf-nonblock: SKIP (0.000s) [393.034625] [083/144] (697s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [393.118761] Starting subtest: cursorB-vs-flipB-atomic [393.126085] Subtest cursorB-vs-flipB-atomic: SKIP (0.003s) [393.275045] [084/144] (697s left) kms_cursor_crc (cursor-random-128x42) [393.510419] Starting subtest: cursor-random-128x42 [393.515872] Starting dynamic subtest: pipe-A-eDP-1 [397.483603] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.967s) [397.524030] Starting dynamic subtest: pipe-D-eDP-1 [402.121958] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.614s) [402.125070] Subtest cursor-random-128x42: SUCCESS (8.610s) [402.997978] [085/144] (687s left) kms_ccs (pipe-d-missing-ccs-buffer-4-tiled-mtl-rc-ccs) [403.396641] Starting subtest: pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs [403.399727] Subtest pipe-D-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [404.233932] [086/144] (686s left) perf (whitelisted-registers-userspace-config) [404.333646] Starting subtest: whitelisted-registers-userspace-config [404.335736] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s) [404.365510] [087/144] (686s left) syncobj_timeline (wait-any-complex) [404.435327] Starting subtest: wait-any-complex [404.497475] Subtest wait-any-complex: SUCCESS (0.063s) [404.575089] [088/144] (686s left) i915_hangman (engine-engine-hang) [404.646499] Starting subtest: engine-engine-hang [404.651952] Starting dynamic subtest: rcs0 [405.884855] Dynamic subtest rcs0: SUCCESS (1.240s) [405.904767] Starting dynamic subtest: bcs0 [407.869433] Dynamic subtest bcs0: SUCCESS (1.983s) [407.889489] Starting dynamic subtest: vcs0 [409.916726] Dynamic subtest vcs0: SUCCESS (2.045s) [409.937147] Starting dynamic subtest: vcs1 [411.901322] Dynamic subtest vcs1: SUCCESS (1.982s) [411.921731] Starting dynamic subtest: vecs0 [413.884943] Dynamic subtest vecs0: SUCCESS (1.982s) [413.906144] Starting dynamic subtest: ccs0 [415.869660] Dynamic subtest ccs0: SUCCESS (1.981s) [415.872419] Subtest engine-engine-hang: SUCCESS (11.224s) [415.956596] [089/144] (674s left) drm_read (fault-buffer) [416.064960] Starting subtest: fault-buffer [416.067509] Subtest fault-buffer: SUCCESS (0.000s) [416.176951] [090/144] (674s left) kms_psr (pr-sprite-plane-onoff) [416.234338] Starting subtest: pr-sprite-plane-onoff [416.239753] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [416.333301] [091/144] (674s left) gem_exec_parallel (userptr) [416.383029] Starting subtest: userptr [416.385706] Starting dynamic subtest: rcs0 [417.848040] Dynamic subtest rcs0: SUCCESS (1.468s) [417.868254] Starting dynamic subtest: bcs0 [419.274597] Dynamic subtest bcs0: SUCCESS (1.425s) [419.298703] Starting dynamic subtest: vcs0 [420.963367] Dynamic subtest vcs0: SUCCESS (1.687s) [420.984188] Starting dynamic subtest: vcs1 [422.929450] Dynamic subtest vcs1: SUCCESS (1.964s) [422.949424] Starting dynamic subtest: vecs0 [424.973140] Dynamic subtest vecs0: SUCCESS (2.042s) [424.986870] Starting dynamic subtest: ccs0 [426.827156] Dynamic subtest ccs0: SUCCESS (1.853s) [426.830341] Subtest userptr: SUCCESS (10.447s) [427.024940] [092/144] (663s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [427.459810] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [427.465279] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s) [428.321992] [093/144] (662s left) gem_caching (reads) [428.386466] Subtest reads: SKIP (0.000s) [428.417124] [094/144] (662s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-dg2-rc-ccs) [428.822645] Starting subtest: pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs [428.827939] Subtest pipe-C-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [429.727808] [095/144] (661s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-dg2-mc-ccs) [430.142812] Starting subtest: pipe-B-random-ccs-data-4-tiled-dg2-mc-ccs [430.150840] Subtest pipe-B-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s) [431.009348] [096/144] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [431.088800] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [431.093183] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [431.178457] [097/144] (660s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-rc-ccs) [431.565696] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs [432.629132] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.063s) [433.796761] [098/144] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [433.887411] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [433.891565] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [433.985099] [099/144] (657s left) vc4/vc4_wait_bo (used-bo) [434.098198] Subtest used-bo: SKIP (0.000s) [434.156487] [100/144] (657s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [434.218778] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [434.224047] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [434.312613] [101/144] (656s left) gem_eio (in-flight-contexts-immediate) [434.549102] Starting subtest: in-flight-contexts-immediate [445.960904] Subtest in-flight-contexts-immediate: SUCCESS (11.411s) [446.076804] [102/144] (645s left) kms_psr (psr-sprite-plane-move) [446.142792] Starting subtest: psr-sprite-plane-move [446.145676] Starting dynamic subtest: eDP-1 [447.984636] Dynamic subtest eDP-1: SUCCESS (1.841s) [447.987728] Subtest psr-sprite-plane-move: SUCCESS (1.842s) [448.926721] [103/144] (642s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-ccs) [449.319510] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-ccs [449.325124] Subtest pipe-B-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s) [450.209186] [104/144] (641s left) kms_psr2_sf (cursor-plane-move-continuous-sf) [455.520103] Starting subtest: cursor-plane-move-continuous-sf [455.522930] Starting dynamic subtest: pipe-A-eDP-1 [466.689628] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.168s) [466.705656] Starting dynamic subtest: pipe-B-eDP-1 [477.844720] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.147s) [477.847540] Subtest cursor-plane-move-continuous-sf: SUCCESS (22.322s) [478.751018] [105/144] (612s left) v3d/v3d_submit_cl (bad-extension) [478.845518] Subtest bad-extension: SKIP (0.000s) [478.899702] [106/144] (612s left) kms_async_flips (test-cursor) [478.989506] Starting subtest: test-cursor [478.994387] Subtest test-cursor: SKIP (0.000s) [480.289348] [107/144] (611s left) gem_exec_params (rel-constants-invalid-rel-gen5) [480.347594] Starting subtest: rel-constants-invalid-rel-gen5 [480.350048] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [480.436309] [108/144] (611s left) kms_big_fb (linear-32bpp-rotate-0) [480.510657] Starting subtest: linear-32bpp-rotate-0 [482.151303] Subtest linear-32bpp-rotate-0: SUCCESS (1.644s) [482.295241] [109/144] (609s left) kms_cursor_crc (cursor-alpha-transparent) [482.343416] Starting subtest: cursor-alpha-transparent [482.345483] Starting dynamic subtest: pipe-A-eDP-1 [482.999000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.655s) [483.022145] Starting dynamic subtest: pipe-D-eDP-1 [484.408048] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s) [484.410779] Subtest cursor-alpha-transparent: SUCCESS (2.064s) [485.295753] [110/144] (606s left) gem_flink_race (flink_close) [485.348970] Starting subtest: flink_close [490.394378] Subtest flink_close: SUCCESS (5.048s) [490.459664] [111/144] (601s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [490.510942] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [490.513562] Starting dynamic subtest: pipe-A-default-mode [493.428045] Dynamic subtest pipe-A-default-mode: SUCCESS (2.918s) [493.430680] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.920s) [494.373753] [112/144] (597s left) kms_atomic_transition (modeset-transition-nonblocking) [494.445310] Starting subtest: modeset-transition-nonblocking [494.447920] Starting dynamic subtest: 1x-outputs [506.547918] Dynamic subtest 1x-outputs: SUCCESS (12.103s) [506.861280] Subtest modeset-transition-nonblocking: SUCCESS (12.414s) [507.745330] [113/144] (583s left) v3d/v3d_submit_cl (simple-flush-cache) [507.847107] Subtest simple-flush-cache: SKIP (0.000s) [507.905192] [114/144] (583s left) gem_create (create-invalid-size) [507.959169] Starting subtest: create-invalid-size [507.961776] Subtest create-invalid-size: SUCCESS (0.000s) [508.144644] [115/144] (583s left) gem_exec_flush (basic-batch-kernel-default-uc) [508.234878] Starting subtest: basic-batch-kernel-default-uc [514.218820] Subtest basic-batch-kernel-default-uc: SUCCESS (5.984s) [514.410833] [116/144] (577s left) kms_cursor_crc (cursor-sliding-64x21) [514.580040] Starting subtest: cursor-sliding-64x21 [514.590213] Starting dynamic subtest: pipe-A-eDP-1 [518.404237] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.814s) [518.447703] Starting dynamic subtest: pipe-D-eDP-1 [522.948394] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.518s) [522.951020] Subtest cursor-sliding-64x21: SUCCESS (8.366s) [523.837750] [117/144] (567s left) gem_exec_flush (basic-uc-rw-default) [523.900682] Starting subtest: basic-uc-rw-default [529.361963] Subtest basic-uc-rw-default: SUCCESS (5.465s) [529.552839] [118/144] (562s left) kms_color (invalid-degamma-lut-sizes) [529.626180] Starting subtest: invalid-degamma-lut-sizes [529.628825] Starting dynamic subtest: pipe-A [529.912254] Dynamic subtest pipe-A: SUCCESS (0.289s) [529.933431] Starting dynamic subtest: pipe-B [529.936091] Dynamic subtest pipe-B: SUCCESS (0.002s) [529.950948] Starting dynamic subtest: pipe-C [529.953770] Dynamic subtest pipe-C: SUCCESS (0.001s) [529.964500] Starting dynamic subtest: pipe-D [529.967080] Dynamic subtest pipe-D: SUCCESS (0.001s) [529.969402] Subtest invalid-degamma-lut-sizes: SUCCESS (0.296s) [530.848517] [119/144] (561s left) gem_exec_reloc (basic-gtt-wc-active) [530.919751] Subtest basic-gtt-wc-active: SKIP (0.000s) [530.990184] [120/144] (560s left) syncobj_timeline (single-wait-all-available-submitted) [531.043993] Starting subtest: single-wait-all-available-submitted [531.046361] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [531.120330] [121/144] (560s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [531.183984] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [531.186555] Starting dynamic subtest: pipe-A-eDP-1 [533.299649] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s) [533.313848] Starting dynamic subtest: pipe-B-eDP-1 [536.486186] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.184s) [536.505967] Starting dynamic subtest: pipe-C-eDP-1 [537.800913] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.312s) [537.824940] Starting dynamic subtest: pipe-D-eDP-1 [539.155942] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s) [539.158467] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (7.974s) [540.449128] [122/144] (551s left) gem_softpin (zero) [540.529319] Starting subtest: zero [540.537520] Subtest zero: SUCCESS (0.008s) [540.645391] [123/144] (551s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [540.728617] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [540.733299] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [540.827044] [124/144] (551s left) kms_writeback (writeback-check-output-xrgb2101010) [540.917969] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [540.936397] [125/144] (551s left) kms_chamelium_color (ctm-0-25) [540.994966] Subtest ctm-0-25: SKIP (0.000s) [541.026205] [126/144] (551s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [543.140541] Starting subtest: dpms-mode-unset-non-lpsp [546.515942] Subtest dpms-mode-unset-non-lpsp: SKIP (3.373s) [547.340081] [127/144] (544s left) kms_vblank (query-idle) [547.440953] Starting subtest: query-idle [547.443349] Starting dynamic subtest: pipe-A-eDP-1 [549.208598] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s) [549.229235] Starting dynamic subtest: pipe-D-eDP-1 [551.717713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s) [551.720389] Subtest query-idle: SUCCESS (4.277s) [552.609649] [128/144] (539s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [552.669773] Starting subtest: invalid-bsd1-flag-on-vebox [552.672758] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [552.761978] [129/144] (539s left) gem_ctx_exec (basic-invalid-context) [552.819219] Starting subtest: basic-invalid-context [552.821667] Subtest basic-invalid-context: SUCCESS (0.006s) [552.932099] [130/144] (539s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [553.018165] Starting subtest: yf-tiled-64bpp-rotate-0 [553.023265] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [553.114229] [131/144] (539s left) api_intel_bb (lot-of-buffers) [553.163957] Starting subtest: lot-of-buffers [559.006473] Subtest lot-of-buffers: SUCCESS (5.844s) [559.758912] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1852 [max: 8192] direct dependencies: 19548 [max: 32768] indirect dependencies: 161640 all direct dependencies: 416243 dependency chains: 29702 [max: 131072] dependency chain hlocks used: 130001 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 305 in-softirq chains: 613 in-process chains: 28784 stack-trace entries: 186764 [max: 1048576] number of stack traces: 9396 number of stack hash chains: 7160 combined max dependencies: 1113273644 hardirq-safe locks: 119 hardirq-unsafe locks: 1105 softirq-safe locks: 214 softirq-unsafe locks: 1015 irq-safe locks: 240 irq-unsafe locks: 1105 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 326 softirq-read-safe locks: 7 softirq-read-unsafe locks: 321 irq-read-safe locks: 7 irq-read-unsafe locks: 326 uncategorized locks: 299 unused locks: 1 max locking depth: 16 max bfs queue depth: 418 max lock class index: 1851 chain lookup misses: 30290 chain lookup hits: 437290231 cyclic checks: 30452 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5219 find-mask backwards checks: 2769 hardirq on events: 227908884 hardirq off events: 227908862 redundant hardirq ons: 82 redundant hardirq offs: 31 softirq on events: 967165 softirq off events: 967165 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 105 large chain blocks: 1 [559.761385] Closing watchdogs Done.