[45.319620] Initializing watchdogs [45.319864] /dev/watchdog0 [45.336134] [001/142] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [45.680791] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [45.683479] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [45.768477] [002/142] (960s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [45.994313] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [45.996088] Starting dynamic subtest: smem [46.465094] Dynamic subtest smem: SUCCESS (0.469s) [46.466472] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.469s) [46.652576] [003/142] (959s left) gem_exec_schedule (smoketest) [47.041625] Starting subtest: smoketest [47.042962] Starting dynamic subtest: rcs0 [52.516217] Dynamic subtest rcs0: SUCCESS (5.470s) [52.529237] Starting dynamic subtest: bcs0 [57.989629] Dynamic subtest bcs0: SUCCESS (5.472s) [58.004767] Starting dynamic subtest: vcs0 [63.451890] Dynamic subtest vcs0: SUCCESS (5.461s) [63.467445] Starting dynamic subtest: vecs0 [68.916863] Dynamic subtest vecs0: SUCCESS (5.465s) [68.918189] Subtest smoketest: SUCCESS (21.870s) [69.102057] [004/142] (936s left) gem_exec_parallel (engines) [69.325531] Starting subtest: engines [69.326915] Starting dynamic subtest: basic [72.888441] Dynamic subtest basic: SUCCESS (3.563s) [72.904378] Starting dynamic subtest: contexts [76.985504] Dynamic subtest contexts: SUCCESS (4.094s) [77.000413] Starting dynamic subtest: fds [82.214070] Dynamic subtest fds: SUCCESS (5.230s) [82.230497] Starting dynamic subtest: userptr [85.897143] Dynamic subtest userptr: SUCCESS (3.683s) [85.898516] Subtest engines: SUCCESS (16.572s) [86.108360] [005/142] (919s left) gem_readwrite (write-bad-handle) [86.314195] Starting subtest: write-bad-handle [86.316841] Subtest write-bad-handle: SUCCESS (0.000s) [86.400352] [006/142] (919s left) kms_flip (2x-blocking-absolute-wf_vblank) [86.685380] Starting subtest: 2x-blocking-absolute-wf_vblank [86.687867] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.003s) [86.802328] [007/142] (919s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [87.109904] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [87.112434] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s) [87.185098] [008/142] (918s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_ccs) [87.722691] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_ccs [87.724282] Subtest pipe-B-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s) [88.203068] [009/142] (917s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs) [88.839474] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs [88.843596] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s) [89.223451] [010/142] (916s left) gem_userptr_blits (dmabuf-unsync) [89.443177] Subtest dmabuf-unsync: SKIP (0.000s) [89.607532] [011/142] (916s left) kms_chamelium_audio (dp-audio) [90.004596] Subtest dp-audio: SKIP (0.000s) [90.289425] [012/142] (915s left) gem_mmap (bad-offset) [90.486985] Starting subtest: bad-offset [90.488798] Subtest bad-offset: SUCCESS (0.001s) [90.585764] [013/142] (915s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs_cc) [91.157116] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc [91.159768] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [91.568583] [014/142] (914s left) gem_close (basic) [91.781880] Starting subtest: basic [91.783691] Subtest basic: SUCCESS (0.000s) [91.885253] [015/142] (914s left) gem_exec_fence (basic-wait) [92.247893] Starting subtest: basic-wait [92.249415] Starting dynamic subtest: rcs0 [92.276538] Dynamic subtest rcs0: SUCCESS (0.030s) [92.292912] Starting dynamic subtest: bcs0 [92.310647] Dynamic subtest bcs0: SUCCESS (0.034s) [92.325657] Starting dynamic subtest: vcs0 [92.345654] Dynamic subtest vcs0: SUCCESS (0.034s) [92.361761] Starting dynamic subtest: vecs0 [92.384566] Dynamic subtest vecs0: SUCCESS (0.039s) [92.385875] Subtest basic-wait: SUCCESS (0.139s) [93.137213] [016/142] (913s left) kms_setmode (invalid-clone-single-crtc) [93.339092] Starting subtest: invalid-clone-single-crtc [93.342800] Subtest invalid-clone-single-crtc: SKIP (0.000s) [93.419135] [017/142] (912s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [93.625571] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [93.626911] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s) [93.702726] [018/142] (912s left) kms_big_fb (4-tiled-addfb) [94.032727] Starting subtest: 4-tiled-addfb [94.035544] Subtest 4-tiled-addfb: SKIP (0.000s) [94.136544] [019/142] (912s left) gem_ccs (block-multicopy-compressed) [94.347415] Subtest block-multicopy-compressed: SKIP (0.000s) [94.402363] [020/142] (912s left) kms_flip (2x-flip-vs-modeset-vs-hang) [94.687068] Starting subtest: 2x-flip-vs-modeset-vs-hang [94.689635] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.003s) [94.803129] [021/142] (911s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [95.106826] Starting subtest: cursorB-vs-flipA-legacy [95.110803] Subtest cursorB-vs-flipA-legacy: SKIP (0.004s) [95.186114] [022/142] (911s left) kms_plane_scaling (planes-downscale-factor-0-75) [95.487615] Starting subtest: planes-downscale-factor-0-75 [95.488866] Starting dynamic subtest: pipe-A-DP-1 [95.582505] Dynamic subtest pipe-A-DP-1: SUCCESS (0.095s) [95.602609] Starting dynamic subtest: pipe-B-DP-1 [95.997597] Dynamic subtest pipe-B-DP-1: SUCCESS (0.413s) [96.032798] Starting dynamic subtest: pipe-C-DP-1 [96.099227] Dynamic subtest pipe-C-DP-1: SKIP (0.096s) [96.100493] Subtest planes-downscale-factor-0-75: SUCCESS (0.612s) [96.486086] [023/142] (910s left) gem_ctx_persistence (engines-hostile-preempt) [96.699534] Starting subtest: engines-hostile-preempt [96.700912] Starting dynamic subtest: rcs0 [96.794796] Dynamic subtest rcs0: SUCCESS (0.096s) [96.811876] Starting dynamic subtest: bcs0 [96.897644] Dynamic subtest bcs0: SUCCESS (0.103s) [96.915961] Starting dynamic subtest: vcs0 [96.987842] Dynamic subtest vcs0: SUCCESS (0.090s) [97.004410] Starting dynamic subtest: vecs0 [97.076696] Dynamic subtest vecs0: SUCCESS (0.089s) [97.078226] Subtest engines-hostile-preempt: SUCCESS (0.378s) [97.170415] [024/142] (909s left) prime_mmap (test_refcounting) [97.368975] Starting subtest: test_refcounting [97.370321] Starting dynamic subtest: test_refcounting-smem [97.374773] Dynamic subtest test_refcounting-smem: SUCCESS (0.006s) [97.376280] Subtest test_refcounting: SUCCESS (0.007s) [97.469203] [025/142] (909s left) gem_mmap_gtt (coherency) [97.670241] Starting subtest: coherency [97.673139] Subtest coherency: SKIP (0.000s) [97.752717] [026/142] (908s left) syncobj_basic (bad-pad-fd-to-handle) [97.952420] Starting subtest: bad-pad-fd-to-handle [97.954028] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [98.035655] [027/142] (908s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [98.338073] Starting subtest: cursorB-vs-flipB-atomic-transitions [98.340719] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s) [98.419606] [028/142] (908s left) gem_partial_pwrite_pread (reads) [98.632715] Starting subtest: reads [104.859273] Subtest reads: SUCCESS (6.226s) [104.969790] [029/142] (901s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs) [105.681640] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs [105.687377] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.004s) [106.025180] [030/142] (900s left) kms_psr (psr2_primary_mmap_cpu) [106.229891] Subtest psr2_primary_mmap_cpu: SKIP (0.000s) [106.274254] [031/142] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [106.583239] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [106.585994] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [106.675211] [032/142] (900s left) prime_busy (after) [106.881663] Starting subtest: after [106.899040] Starting dynamic subtest: rcs0 [106.916754] Dynamic subtest rcs0: SUCCESS (0.018s) [106.936188] Starting dynamic subtest: bcs0 [106.937590] Dynamic subtest bcs0: SUCCESS (0.015s) [106.954138] Starting dynamic subtest: vcs0 [106.958741] Dynamic subtest vcs0: SUCCESS (0.024s) [106.977878] Starting dynamic subtest: vecs0 [106.979286] Dynamic subtest vecs0: SUCCESS (0.017s) [107.088784] Subtest after: SUCCESS (0.205s) [107.176308] [033/142] (899s left) gem_mmap_wc (write-read) [107.376470] Starting subtest: write-read [107.411600] Subtest write-read: SUCCESS (0.034s) [107.507905] [034/142] (899s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc) [108.187446] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [108.503581] [035/142] (898s left) i915_suspend (fence-restore-untiled) [108.703833] Starting subtest: fence-restore-untiled [128.966208] Subtest fence-restore-untiled: SUCCESS (4.260s) [130.097372] [036/142] (893s left) kms_rotation_crc (sprite-rotation-90) [130.397764] Starting subtest: sprite-rotation-90 [136.513254] Subtest sprite-rotation-90: SUCCESS (6.115s) [136.957930] [037/142] (887s left) gem_ctx_persistence (many-contexts) [137.166408] Starting subtest: many-contexts [170.050621] Subtest many-contexts: SUCCESS (32.883s) [170.137548] [038/142] (854s left) syncobj_wait (wait-all-for-submit-snapshot) [170.342437] Starting subtest: wait-all-for-submit-snapshot [170.428534] Subtest wait-all-for-submit-snapshot: SUCCESS (0.084s) [170.507673] [039/142] (853s left) api_intel_bb (blit-reloc-purge-cache) [170.718509] Starting subtest: blit-reloc-purge-cache [170.739340] Subtest blit-reloc-purge-cache: SUCCESS (0.021s) [170.840681] [040/142] (853s left) kms_cursor_crc (cursor-suspend) [171.140181] Starting subtest: cursor-suspend [171.143498] Starting dynamic subtest: pipe-A-DP-1 [207.546917] Dynamic subtest pipe-A-DP-1: SUCCESS (3.707s) [207.581488] Starting dynamic subtest: pipe-C-DP-1 [243.557278] Dynamic subtest pipe-C-DP-1: SUCCESS (3.817s) [243.560726] Subtest cursor-suspend: SUCCESS (7.531s) [247.940515] [041/142] (845s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs) [248.384360] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs [248.388810] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s) [248.948345] [042/142] (844s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [249.647162] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [249.969006] [043/142] (843s left) gem_ctx_isolation (dirty-create) [250.195593] Starting subtest: dirty-create [250.199551] Starting dynamic subtest: rcs0 [251.877972] Dynamic subtest rcs0: SUCCESS (1.674s) [251.900201] Starting dynamic subtest: bcs0 [254.023151] Dynamic subtest bcs0: SUCCESS (2.148s) [254.046735] Starting dynamic subtest: vcs0 [255.659848] Dynamic subtest vcs0: SUCCESS (1.635s) [255.680920] Starting dynamic subtest: vecs0 [257.259970] Dynamic subtest vecs0: SUCCESS (1.599s) [257.261391] Subtest dirty-create: SUCCESS (7.062s) [257.454176] [044/142] (835s left) template (a) [257.656273] Starting subtest: A [257.658018] Subtest A: SUCCESS (0.000s) [257.752636] [045/142] (835s left) perf_pmu (enable-race) [257.962906] Starting subtest: enable-race [257.964594] Starting dynamic subtest: rcs0 [270.633995] Dynamic subtest rcs0: SUCCESS (12.670s) [270.654805] Starting dynamic subtest: bcs0 [283.348629] Dynamic subtest bcs0: SUCCESS (12.712s) [283.369491] Starting dynamic subtest: vcs0 [296.022103] Dynamic subtest vcs0: SUCCESS (12.672s) [296.042882] Starting dynamic subtest: vecs0 [308.700303] Dynamic subtest vecs0: SUCCESS (12.676s) [308.702532] Subtest enable-race: SUCCESS (50.738s) [308.802369] [046/142] (784s left) gem_exec_flush (basic-wb-prw-default) [309.030794] Starting subtest: basic-wb-prw-default [314.498106] Subtest basic-wb-prw-default: SUCCESS (5.468s) [314.702222] [047/142] (778s left) gem_exec_balancer (bonded-dual) [314.930763] Starting subtest: bonded-dual [318.718588] Subtest bonded-dual: SUCCESS (3.785s) [322.639323] [048/142] (770s left) kms_atomic (crtc-invalid-params) [323.076522] Starting subtest: crtc-invalid-params [323.127440] Subtest crtc-invalid-params: SUCCESS (0.051s) [323.583050] [049/142] (769s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs) [324.134707] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs [324.661104] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.526s) [325.161147] [050/142] (768s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [325.471805] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [325.474470] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [325.577580] [051/142] (768s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [325.969032] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [326.263145] [052/142] (767s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [326.571860] Starting subtest: psr-2p-pri-indfb-multidraw [326.574458] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [326.675341] [053/142] (767s left) kms_frontbuffer_tracking (fbc-tiling-4) [326.979212] Starting subtest: fbc-tiling-4 [326.982008] Subtest fbc-tiling-4: SKIP (0.000s) [327.092071] [054/142] (766s left) kms_chamelium_frames (hdmi-crc-multiple) [327.500551] Subtest hdmi-crc-multiple: SKIP (0.000s) [327.791285] [055/142] (765s left) gem_mmap (pf-nonblock) [327.991610] Starting subtest: pf-nonblock [327.997149] Subtest pf-nonblock: SUCCESS (0.005s) [328.103744] [056/142] (765s left) gem_userptr_blits (mmap-offset-banned) [328.344049] Starting subtest: mmap-offset-banned [328.345582] Starting dynamic subtest: gtt [328.347418] Dynamic subtest gtt: SUCCESS (0.001s) [328.370163] Starting dynamic subtest: wb [328.371423] Dynamic subtest wb: SUCCESS (0.001s) [328.393071] Starting dynamic subtest: wc [328.394386] Dynamic subtest wc: SUCCESS (0.001s) [328.415740] Starting dynamic subtest: uc [328.417051] Dynamic subtest uc: SUCCESS (0.001s) [328.418362] Subtest mmap-offset-banned: SUCCESS (0.008s) [328.488086] [057/142] (765s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [328.816849] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [330.194797] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.377s) [330.339403] [058/142] (763s left) syncobj_wait (wait-delayed-signal) [330.541541] Starting subtest: wait-delayed-signal [330.646801] Subtest wait-delayed-signal: SUCCESS (0.104s) [330.739933] [059/142] (763s left) kms_vblank (pipe-d-query-busy-hang) [331.043708] Subtest pipe-D-query-busy-hang: SKIP (0.000s) [331.120358] [060/142] (762s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [331.438615] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [331.442035] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [331.537368] [061/142] (762s left) gem_exercise_blt (fast-copy-emit) [331.747781] Starting subtest: fast-copy-emit [331.749256] Starting dynamic subtest: linear-smem-smem-emit [331.808345] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.060s) [331.831466] Starting dynamic subtest: ymajor-smem-smem-emit [331.859895] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.050s) [331.883109] Starting dynamic subtest: yfmajor-smem-smem-emit [331.913817] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.052s) [331.937181] Starting dynamic subtest: tile64-smem-smem-emit [331.965450] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.048s) [331.966876] Subtest fast-copy-emit: SUCCESS (0.216s) [332.070740] [062/142] (761s left) perf_pmu (frequency) [332.277295] Starting subtest: frequency [332.278865] Starting dynamic subtest: gt0 [334.397295] Dynamic subtest gt0: SUCCESS (2.116s) [334.419084] Starting dynamic subtest: idle-gt0 [334.904105] Dynamic subtest idle-gt0: SUCCESS (0.505s) [334.905546] Subtest frequency: SUCCESS (2.624s) [335.004025] [063/142] (759s left) kms_cursor_crc (cursor-random-32x32) [335.313775] Starting subtest: cursor-random-32x32 [335.429377] Subtest cursor-random-32x32: SKIP (0.113s) [335.555077] [064/142] (758s left) gem_wait (wait) [335.798407] Starting subtest: wait [335.799983] Starting dynamic subtest: all-engines [336.833340] Dynamic subtest all-engines: SUCCESS (1.034s) [336.859994] Starting dynamic subtest: rcs0 [337.856330] Dynamic subtest rcs0: SUCCESS (1.022s) [337.881034] Starting dynamic subtest: bcs0 [338.890960] Dynamic subtest bcs0: SUCCESS (1.032s) [338.913057] Starting dynamic subtest: vcs0 [339.925130] Dynamic subtest vcs0: SUCCESS (1.032s) [339.947026] Starting dynamic subtest: vecs0 [340.960702] Dynamic subtest vecs0: SUCCESS (1.033s) [340.962142] Subtest wait: SUCCESS (5.163s) [341.205154] [065/142] (752s left) kms_scaling_modes (scaling-mode-none) [341.508109] Starting subtest: scaling-mode-none [341.510665] Subtest scaling-mode-none: SKIP (0.001s) [341.604976] [066/142] (752s left) syncobj_wait (wait-any-complex) [341.807503] Starting subtest: wait-any-complex [341.872375] Subtest wait-any-complex: SUCCESS (0.063s) [341.953867] [067/142] (752s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [342.160706] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [342.162520] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [342.254514] [068/142] (752s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [342.551622] Starting subtest: primary-yf-tiled-reflect-x-270 [342.554120] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.003s) [342.638130] [069/142] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [342.958111] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [342.960833] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [343.072023] [070/142] (751s left) kms_vrr (negative-basic) [343.376143] Starting subtest: negative-basic [343.379747] Subtest negative-basic: SKIP (0.000s) [343.472011] [071/142] (750s left) gem_exec_whisper (basic-forked) [343.699896] Starting subtest: basic-forked [354.464928] Subtest basic-forked: SUCCESS (10.764s) [354.671405] [072/142] (739s left) kms_cursor_crc (cursor-random-64x64) [354.977583] Starting subtest: cursor-random-64x64 [354.989774] Starting dynamic subtest: pipe-A-DP-1 [358.796917] Dynamic subtest pipe-A-DP-1: SUCCESS (3.805s) [358.888042] Starting dynamic subtest: pipe-C-DP-1 [363.039317] Dynamic subtest pipe-C-DP-1: SUCCESS (4.178s) [363.040609] Subtest cursor-random-64x64: SUCCESS (8.063s) [363.409988] [073/142] (731s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [363.718956] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [363.725698] Starting dynamic subtest: pipe-A-valid-mode [363.814248] Dynamic subtest pipe-A-valid-mode: SKIP (0.091s) [363.817522] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.094s) [364.132626] [074/142] (730s left) kms_flip (nonexisting-fb-interruptible) [364.435254] Starting subtest: nonexisting-fb-interruptible [364.438965] Starting dynamic subtest: A-DP1 [364.942668] Dynamic subtest A-DP1: SUCCESS (0.502s) [364.966125] Starting dynamic subtest: B-DP1 [365.395188] Dynamic subtest B-DP1: SUCCESS (0.449s) [365.418741] Starting dynamic subtest: C-DP1 [365.826854] Dynamic subtest C-DP1: SUCCESS (0.430s) [365.830869] Subtest nonexisting-fb-interruptible: SUCCESS (1.394s) [366.236314] [075/142] (728s left) gem_exec_fence (syncobj-timeline-signal) [367.028925] Starting subtest: syncobj-timeline-signal [367.038018] Subtest syncobj-timeline-signal: SUCCESS (0.010s) [367.266111] [076/142] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [367.572282] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [367.575373] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [367.682066] [077/142] (727s left) gem_exec_fence (basic-busy-all) [367.909593] Starting subtest: basic-busy-all [367.941221] Subtest basic-busy-all: SUCCESS (0.031s) [368.733186] [078/142] (726s left) i915_pm_rpm (dpms-lpsp) [370.553857] Starting subtest: dpms-lpsp [370.558667] Subtest dpms-lpsp: SKIP (0.000s) [371.054352] [079/142] (723s left) kms_cursor_crc (cursor-dpms) [371.366537] Starting subtest: cursor-dpms [371.370355] Starting dynamic subtest: pipe-A-DP-1 [372.860890] Dynamic subtest pipe-A-DP-1: SUCCESS (1.486s) [372.885679] Starting dynamic subtest: pipe-C-DP-1 [374.613271] Dynamic subtest pipe-C-DP-1: SUCCESS (1.750s) [374.614943] Subtest cursor-dpms: SUCCESS (3.246s) [374.957483] [080/142] (719s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [375.274065] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [375.276984] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [375.388460] [081/142] (719s left) syncobj_timeline (single-wait-signaled) [375.592289] Starting subtest: single-wait-signaled [375.594094] Subtest single-wait-signaled: SUCCESS (0.001s) [375.687929] [082/142] (719s left) gem_render_copy_redux (flink) [375.921809] Starting subtest: flink [380.575313] Subtest flink: SUCCESS (4.653s) [380.689549] [083/142] (714s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [381.007537] Starting subtest: psr-rgb101010-draw-mmap-gtt [381.010886] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [381.122008] [084/142] (713s left) gem_exec_balancer (parallel-keep-submit-fence) [385.128787] Subtest parallel-keep-submit-fence: SKIP (0.000s) [385.222169] [085/142] (709s left) gem_exec_params (batch-first) [385.432625] Starting subtest: batch-first [385.443352] Subtest batch-first: SUCCESS (0.010s) [385.571444] [086/142] (709s left) gem_exec_reloc (basic-cpu-read-active) [385.787329] Starting subtest: basic-cpu-read-active [385.929914] Subtest basic-cpu-read-active: SUCCESS (0.141s) [386.122842] [087/142] (709s left) dumb_buffer (create-clear) [386.326132] Starting subtest: create-clear [430.773385] Subtest create-clear: SUCCESS (44.444s) [431.170976] [088/142] (664s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [431.481139] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [431.484053] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [431.588602] [089/142] (663s left) core_setmaster (master-drop-set-shared-fd) [433.550705] Starting subtest: master-drop-set-shared-fd [433.592362] Subtest master-drop-set-shared-fd: SUCCESS (0.043s) [433.636840] [090/142] (661s left) kms_invalid_mode (zero-clock) [433.950391] Starting subtest: zero-clock [433.952543] Starting dynamic subtest: DP-1-pipe-A [434.049121] Dynamic subtest DP-1-pipe-A: SUCCESS (0.102s) [434.081483] Starting dynamic subtest: DP-1-pipe-B [434.083167] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s) [434.108774] Starting dynamic subtest: DP-1-pipe-C [434.110536] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s) [434.112236] Subtest zero-clock: SUCCESS (0.141s) [434.425089] [091/142] (660s left) perf_pmu (all-busy-check-all) [434.636083] Starting subtest: all-busy-check-all [435.166043] Subtest all-busy-check-all: SUCCESS (0.529s) [435.257903] [092/142] (660s left) kms_big_fb (linear-16bpp-rotate-180) [435.580248] Starting subtest: linear-16bpp-rotate-180 [440.061824] Subtest linear-16bpp-rotate-180: SUCCESS (4.482s) [440.393006] [093/142] (655s left) kms_plane (plane-position-hole-dpms) [440.700714] Starting subtest: plane-position-hole-dpms [440.702259] Starting dynamic subtest: pipe-A-planes [442.835935] Dynamic subtest pipe-A-planes: SUCCESS (2.135s) [442.867024] Starting dynamic subtest: pipe-B-planes [445.257318] Dynamic subtest pipe-B-planes: SUCCESS (2.417s) [445.259288] Subtest plane-position-hole-dpms: SUCCESS (4.561s) [445.607240] [094/142] (649s left) gem_softpin (full) [445.823393] Starting subtest: full [445.842751] Subtest full: SUCCESS (0.019s) [445.956091] [095/142] (649s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [446.261837] Starting subtest: primary-x-tiled-reflect-x-0 [446.264977] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s) [446.357455] [096/142] (649s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [446.663101] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [446.665783] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [446.773804] [097/142] (648s left) syncobj_timeline (etime-multi-wait-submitted) [446.976816] Starting subtest: etime-multi-wait-submitted [447.082862] Subtest etime-multi-wait-submitted: SUCCESS (0.105s) [447.174183] [098/142] (648s left) vc4/vc4_wait_bo (bad-pad) [447.429309] Subtest bad-pad: SKIP (0.000s) [447.506814] [099/142] (648s left) drm_fdinfo (busy-idle) [447.714585] Starting subtest: busy-idle [447.716172] Starting dynamic subtest: rcs0 [448.345475] Dynamic subtest rcs0: SUCCESS (0.630s) [448.374396] Starting dynamic subtest: bcs0 [448.979493] Dynamic subtest bcs0: SUCCESS (0.632s) [449.007362] Starting dynamic subtest: vcs0 [449.610496] Dynamic subtest vcs0: SUCCESS (0.629s) [449.639680] Starting dynamic subtest: vecs0 [450.242295] Dynamic subtest vecs0: SUCCESS (0.630s) [450.243898] Subtest busy-idle: SUCCESS (2.529s) [450.340406] [100/142] (645s left) gem_exec_schedule (noreorder-corked) [450.711555] Starting subtest: noreorder-corked [450.713037] Starting dynamic subtest: rcs0 [451.839421] Dynamic subtest rcs0: SUCCESS (1.130s) [451.870996] Starting dynamic subtest: bcs0 [452.972404] Dynamic subtest bcs0: SUCCESS (1.130s) [453.002734] Starting dynamic subtest: vcs0 [454.104846] Dynamic subtest vcs0: SUCCESS (1.129s) [454.131375] Starting dynamic subtest: vecs0 [455.232380] Dynamic subtest vecs0: SUCCESS (1.123s) [455.234260] Subtest noreorder-corked: SUCCESS (4.525s) [455.440324] [101/142] (640s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [455.747564] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [455.750330] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [455.856913] [102/142] (639s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [456.162224] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [456.163472] Starting dynamic subtest: pipe-A-valid-mode [456.282795] Dynamic subtest pipe-A-valid-mode: SKIP (0.118s) [456.286181] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.123s) [456.631253] [103/142] (639s left) sysfs_preempt_timeout (idempotent) [456.841428] Starting subtest: idempotent [456.845973] Starting dynamic subtest: vecs0 [456.847349] Dynamic subtest vecs0: SUCCESS (0.002s) [456.875629] Starting dynamic subtest: vcs0 [456.876980] Dynamic subtest vcs0: SUCCESS (0.002s) [456.900112] Starting dynamic subtest: bcs0 [456.901606] Dynamic subtest bcs0: SUCCESS (0.002s) [456.924086] Starting dynamic subtest: rcs0 [456.925540] Dynamic subtest rcs0: SUCCESS (0.002s) [456.926867] Subtest idempotent: SUCCESS (0.020s) [456.964860] [104/142] (638s left) gem_userptr_blits (coherency-sync) [457.206692] Starting subtest: coherency-sync [459.245797] Subtest coherency-sync: SKIP (2.024s) [459.410502] [105/142] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [459.853102] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [459.855922] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [459.966420] [106/142] (636s left) kms_cdclk (mode-transition-all-outputs) [460.170942] Subtest mode-transition-all-outputs: SKIP (0.000s) [460.231252] [107/142] (635s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs) [460.889911] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s) [461.211477] [108/142] (634s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [461.438232] Starting subtest: multi-wait-all-for-submit-submitted-signaled [461.547131] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [461.643627] [109/142] (634s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs_cc) [462.039730] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc [462.042320] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s) [462.629600] [110/142] (633s left) kms_concurrent (pipe-c) [462.938258] Starting subtest: pipe-C [462.942479] Starting dynamic subtest: DP-1 [463.743934] Dynamic subtest DP-1: SUCCESS (0.800s) [463.745330] Subtest pipe-C: SUCCESS (0.805s) [464.058579] [111/142] (632s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [464.359473] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [464.362084] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [465.053745] [112/142] (631s left) gem_render_copy (y-tiled-ccs-to-linear) [465.278424] Starting subtest: y-tiled-ccs-to-linear [465.284092] Starting dynamic subtest: smem [465.546667] Dynamic subtest smem: SUCCESS (0.265s) [465.548876] Subtest y-tiled-ccs-to-linear: SUCCESS (0.268s) [465.754783] [113/142] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [466.062821] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [466.065584] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [466.170277] [114/142] (630s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [468.898196] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [468.987042] [115/142] (627s left) kms_busy (basic-hang) [469.303627] Starting subtest: basic-hang [469.309135] Starting dynamic subtest: flip-pipe-A [470.237541] Dynamic subtest flip-pipe-A: SUCCESS (0.927s) [470.265165] Starting dynamic subtest: modeset-pipe-A [471.830589] Dynamic subtest modeset-pipe-A: SUCCESS (1.591s) [471.862712] Starting dynamic subtest: flip-pipe-C [472.650294] Dynamic subtest flip-pipe-C: SUCCESS (0.811s) [472.680270] Starting dynamic subtest: modeset-pipe-C [474.209761] Dynamic subtest modeset-pipe-C: SUCCESS (1.558s) [474.212058] Subtest basic-hang: SUCCESS (4.906s) [474.589936] [116/142] (621s left) v3d/v3d_submit_csd (bad-bo) [474.858080] Subtest bad-bo: SKIP (0.000s) [474.937200] [117/142] (621s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [475.252872] Starting subtest: fbcpsr-indfb-scaledprimary [475.255567] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s) [475.370597] [118/142] (621s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [475.690732] Starting subtest: fbc-indfb-scaledprimary [478.841592] Subtest fbc-indfb-scaledprimary: SUCCESS (3.153s) [478.988051] [119/142] (617s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs) [479.487361] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs [479.490254] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s) [480.017987] [120/142] (616s left) kms_prop_blob (blob-prop-validate) [480.222285] Starting subtest: blob-prop-validate [480.223952] Subtest blob-prop-validate: SUCCESS (0.000s) [480.317802] [121/142] (616s left) i915_query (query-topology-unsupported) [480.519561] Starting subtest: query-topology-unsupported [480.523062] Subtest query-topology-unsupported: SKIP (0.000s) [480.617892] [122/142] (616s left) kms_big_fb (yf-tiled-addfb) [480.957971] Starting subtest: yf-tiled-addfb [480.959361] Subtest yf-tiled-addfb: SUCCESS (0.000s) [481.068997] [123/142] (615s left) kms_big_fb (x-tiled-64bpp-rotate-90) [481.391376] Starting subtest: x-tiled-64bpp-rotate-90 [481.485604] Subtest x-tiled-64bpp-rotate-90: SKIP (0.091s) [481.601327] [124/142] (615s left) vc4/vc4_label_bo (set-kernel-name) [481.855499] Subtest set-kernel-name: SKIP (0.000s) [481.934028] [125/142] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [482.243119] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [482.246144] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [482.351492] [126/142] (614s left) syncobj_timeline (invalid-single-wait-unsubmitted) [482.556579] Starting subtest: invalid-single-wait-unsubmitted [482.558115] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [482.652055] [127/142] (614s left) vc4/vc4_perfmon (get-values-invalid-perfmon) [482.905726] Subtest get-values-invalid-perfmon: SKIP (0.000s) [482.984429] [128/142] (614s left) kms_plane_cursor (overlay) [483.298251] Starting subtest: overlay [483.301277] Starting dynamic subtest: pipe-A-DP-1-size-64 [485.719578] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.421s) [485.796422] Starting dynamic subtest: pipe-A-DP-1-size-128 [488.202936] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.432s) [488.279023] Starting dynamic subtest: pipe-A-DP-1-size-256 [490.719278] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.465s) [490.898409] Starting dynamic subtest: pipe-B-DP-1-size-64 [493.519891] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.649s) [493.596131] Starting dynamic subtest: pipe-B-DP-1-size-128 [495.986959] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.415s) [496.068446] Starting dynamic subtest: pipe-B-DP-1-size-256 [498.503464] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.464s) [498.681318] Starting dynamic subtest: pipe-C-DP-1-size-64 [501.329317] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.673s) [501.404949] Starting dynamic subtest: pipe-C-DP-1-size-128 [503.796367] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s) [503.873745] Starting dynamic subtest: pipe-C-DP-1-size-256 [506.296313] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.449s) [506.430154] Subtest overlay: SUCCESS (23.133s) [506.759187] [129/142] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [507.082807] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [507.085729] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [507.192936] [130/142] (589s left) i915_pipe_stress (stress-xrgb8888-untiled) [507.501836] Starting subtest: stress-xrgb8888-untiled [510.081563] Subtest stress-xrgb8888-untiled: FAIL (2.248s) [510.586386] [131/142] (586s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs) [511.030406] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs [511.032084] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s) [511.584734] [132/142] (585s left) kms_flip (flip-vs-suspend) [511.875223] Starting subtest: flip-vs-suspend [511.876587] Starting dynamic subtest: A-DP1 [564.354080] Dynamic subtest A-DP1: SUCCESS (4.732s) [564.380732] Starting dynamic subtest: B-DP1 [617.337888] Dynamic subtest B-DP1: SUCCESS (4.631s) [617.381252] Starting dynamic subtest: C-DP1 [670.335795] Dynamic subtest C-DP1: SUCCESS (4.466s) [670.344433] Subtest flip-vs-suspend: SUCCESS (13.846s) [673.779601] [133/142] (571s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [673.988414] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [673.990065] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s) [674.084388] [134/142] (570s left) v3d/v3d_perfmon (get-values-invalid-pointer) [674.355484] Subtest get-values-invalid-pointer: SKIP (0.000s) [674.434140] [135/142] (570s left) kms_pipe_crc_basic (read-crc-frame-sequence) [674.735207] Starting subtest: read-crc-frame-sequence [674.743072] Starting dynamic subtest: pipe-A-DP-1 [675.288249] Dynamic subtest pipe-A-DP-1: SUCCESS (0.545s) [675.320017] Starting dynamic subtest: pipe-B-DP-1 [676.103459] Dynamic subtest pipe-B-DP-1: SUCCESS (0.812s) [676.136650] Starting dynamic subtest: pipe-C-DP-1 [677.125918] Dynamic subtest pipe-C-DP-1: SUCCESS (1.015s) [677.127559] Subtest read-crc-frame-sequence: SUCCESS (2.390s) [677.455630] [136/142] (567s left) syncobj_wait (wait-all-interrupted) [677.660383] Starting subtest: wait-all-interrupted [677.767919] Subtest wait-all-interrupted: SUCCESS (0.106s) [677.856548] [137/142] (567s left) kms_flip (plain-flip-fb-recreate-interruptible) [678.159280] Starting subtest: plain-flip-fb-recreate-interruptible [678.161650] Starting dynamic subtest: A-DP1 [688.981209] Dynamic subtest A-DP1: SUCCESS (10.819s) [689.010255] Starting dynamic subtest: B-DP1 [699.709269] Dynamic subtest B-DP1: SUCCESS (10.724s) [699.738719] Starting dynamic subtest: C-DP1 [710.424148] Dynamic subtest C-DP1: SUCCESS (10.711s) [710.428785] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.271s) [710.868201] [138/142] (534s left) gem_sync (basic-store-all) [711.099434] Starting subtest: basic-store-all [714.820539] Subtest basic-store-all: SUCCESS (3.721s) [715.039321] [139/142] (530s left) i915_pm_rpm (system-suspend-devices) [716.832776] Starting subtest: system-suspend-devices [723.184807] Subtest system-suspend-devices: SUCCESS (6.352s) [727.706399] [140/142] (521s left) kms_cursor_legacy (flip-vs-cursor-legacy) [728.016639] Starting subtest: flip-vs-cursor-legacy [743.513753] Subtest flip-vs-cursor-legacy: SUCCESS (15.501s) [743.863045] [141/142] (505s left) i915_hangman (error-state-basic) [744.094607] Starting subtest: error-state-basic [744.117343] Subtest error-state-basic: SUCCESS (0.023s) [744.228342] [142/142] (505s left) i915_pm_rpm (universal-planes) [746.027155] Starting subtest: universal-planes [746.029748] Starting dynamic subtest: plane-31 [748.306644] Dynamic subtest plane-31: SUCCESS (2.280s) [748.343177] Starting dynamic subtest: plane-39 [750.849563] Dynamic subtest plane-39: SUCCESS (2.540s) [750.879397] Starting dynamic subtest: plane-47 [753.301385] Dynamic subtest plane-47: SUCCESS (2.447s) [753.336112] Starting dynamic subtest: plane-55 [756.070573] Dynamic subtest plane-55: SUCCESS (2.769s) [756.073445] Subtest universal-planes: SUCCESS (10.046s) [756.559205] Closing watchdogs Done.