[57.552503] Initializing watchdogs [57.552809] /dev/watchdog0 [57.568468] [001/137] (960s left) gem_ctx_shared (q-independent) [58.039526] Starting subtest: Q-independent [58.041149] Starting dynamic subtest: rcs0 [58.145592] Dynamic subtest rcs0: SUCCESS (0.105s) [58.166179] Starting dynamic subtest: bcs0 [58.236727] Dynamic subtest bcs0: SUCCESS (0.090s) [58.253724] Starting dynamic subtest: vcs0 [58.294104] Dynamic subtest vcs0: SUCCESS (0.059s) [58.310819] Starting dynamic subtest: vecs0 [58.350890] Dynamic subtest vecs0: SUCCESS (0.057s) [58.352522] Subtest Q-independent: SUCCESS (0.313s) [58.592419] [002/137] (959s left) gem_exec_params (invalid-bsd2-flag-on-render) [58.803399] Starting subtest: invalid-bsd2-flag-on-render [58.805190] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s) [58.904532] [003/137] (959s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [59.221524] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [59.224212] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [59.321404] [004/137] (958s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [59.624265] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [59.625625] Starting dynamic subtest: pipe-A-valid-mode [60.010611] Dynamic subtest pipe-A-valid-mode: SKIP (0.386s) [60.013308] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.389s) [60.362612] [005/137] (957s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs) [60.666285] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs [60.669312] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s) [61.391811] [006/137] (956s left) perf_pmu (interrupts-sync) [61.602866] Starting subtest: interrupts-sync [62.796728] Subtest interrupts-sync: SUCCESS (1.192s) [62.894407] [007/137] (955s left) kms_psr (psr2_primary_render) [63.096750] Subtest psr2_primary_render: SKIP (0.000s) [63.142663] [008/137] (955s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [63.468570] Starting subtest: yf-tiled-64bpp-rotate-90 [63.471427] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [63.560513] [009/137] (954s left) kms_hdr (bpc-switch-suspend) [63.858604] Starting subtest: bpc-switch-suspend [66.142357] Starting dynamic subtest: pipe-A-DP-1 [84.053974] Dynamic subtest pipe-A-DP-1: SUCCESS (2.913s) [84.055398] Subtest bpc-switch-suspend: SUCCESS (5.198s) [87.455926] [010/137] (948s left) kms_cursor_crc (cursor-rapid-movement-64x21) [87.773617] Starting subtest: cursor-rapid-movement-64x21 [87.787371] Starting dynamic subtest: pipe-A-DP-1 [88.295632] Dynamic subtest pipe-A-DP-1: SUCCESS (0.505s) [88.383414] Starting dynamic subtest: pipe-C-DP-1 [89.230524] Dynamic subtest pipe-C-DP-1: SUCCESS (0.868s) [89.232134] Subtest cursor-rapid-movement-64x21: SUCCESS (1.454s) [89.585279] [011/137] (946s left) kms_plane_alpha_blend (constant-alpha-mid) [89.886867] Starting subtest: constant-alpha-mid [90.190276] Starting dynamic subtest: pipe-A-DP-1 [90.887393] Dynamic subtest pipe-A-DP-1: SUCCESS (0.697s) [90.915945] Starting dynamic subtest: pipe-C-DP-1 [91.814107] Dynamic subtest pipe-C-DP-1: SUCCESS (0.920s) [91.816827] Subtest constant-alpha-mid: SUCCESS (1.929s) [92.169877] [012/137] (944s left) sw_sync (alloc_merge_fence) [92.370377] Starting subtest: alloc_merge_fence [92.371794] Subtest alloc_merge_fence: SUCCESS (0.001s) [92.435546] [013/137] (944s left) kms_atomic_interruptible (legacy-pageflip) [92.732879] Starting subtest: legacy-pageflip [92.735907] Starting dynamic subtest: DP-1-pipe-A [99.259461] Dynamic subtest DP-1-pipe-A: SUCCESS (6.523s) [99.260666] Subtest legacy-pageflip: SUCCESS (6.526s) [99.593357] [014/137] (936s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [99.797027] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [99.841811] [015/137] (936s left) gem_exec_flush (basic-wb-rw-before-default) [100.065100] Starting subtest: basic-wb-rw-before-default [105.547885] Subtest basic-wb-rw-before-default: SUCCESS (5.483s) [105.759873] [016/137] (930s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [106.060210] Starting subtest: flip-vs-cursor-crc-atomic [106.706185] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.646s) [107.045080] [017/137] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [107.350292] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [107.352948] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [107.443379] [018/137] (929s left) vc4/vc4_perfmon (create-perfmon-exceed) [107.705880] Subtest create-perfmon-exceed: SKIP (0.000s) [107.776834] [019/137] (928s left) api_intel_bb (simple-bb-ctx) [107.972191] Starting subtest: simple-bb-ctx [107.985755] Subtest simple-bb-ctx: SUCCESS (0.014s) [108.095280] [020/137] (928s left) dumb_buffer (invalid-bpp) [108.291664] Starting subtest: invalid-bpp [108.293272] Subtest invalid-bpp: SUCCESS (0.000s) [108.377571] [021/137] (928s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync) [108.640624] Subtest multiple-singlesync-to-multisync: SKIP (0.000s) [108.710107] [022/137] (928s left) kms_vblank (pipe-a-query-forked-busy-hang) [109.004397] Starting subtest: pipe-A-query-forked-busy-hang [115.967885] Subtest pipe-A-query-forked-busy-hang: SUCCESS (6.965s) [116.313643] [023/137] (920s left) syncobj_timeline (wait-any-complex) [116.513091] Starting subtest: wait-any-complex [116.578522] Subtest wait-any-complex: SUCCESS (0.064s) [116.662908] [024/137] (920s left) kms_big_fb (y-tiled-16bpp-rotate-90) [116.979888] Starting subtest: y-tiled-16bpp-rotate-90 [117.057778] Subtest y-tiled-16bpp-rotate-90: SKIP (0.076s) [117.163101] [025/137] (919s left) gem_exec_schedule (submit-golden-slice) [117.392892] Starting subtest: submit-golden-slice [117.394431] Starting dynamic subtest: rcs0 [117.448437] Dynamic subtest rcs0: SUCCESS (0.055s) [117.475485] Starting dynamic subtest: bcs0 [117.498882] Dynamic subtest bcs0: SUCCESS (0.050s) [117.523909] Starting dynamic subtest: vcs0 [117.548932] Dynamic subtest vcs0: SUCCESS (0.050s) [117.582499] Starting dynamic subtest: vecs0 [117.596252] Dynamic subtest vecs0: SUCCESS (0.047s) [117.597635] Subtest submit-golden-slice: SUCCESS (0.203s) [117.947672] [026/137] (919s left) gem_lmem_swapping (parallel-multi) [118.153933] Subtest parallel-multi: SKIP (0.000s) [118.213782] [027/137] (918s left) gem_mmap (pf-nonblock) [118.408667] Starting subtest: pf-nonblock [118.413311] Subtest pf-nonblock: SUCCESS (0.006s) [118.513930] [028/137] (918s left) kms_atomic_transition (plane-all-transition-nonblocking) [118.814285] Starting subtest: plane-all-transition-nonblocking [118.815822] Starting dynamic subtest: pipe-A-DP-1 [122.772719] Dynamic subtest pipe-A-DP-1: SUCCESS (3.960s) [122.904171] Starting dynamic subtest: pipe-B-DP-1 [127.198196] Dynamic subtest pipe-B-DP-1: SUCCESS (4.322s) [127.307559] Subtest plane-all-transition-nonblocking: SUCCESS (8.491s) [127.636547] [029/137] (909s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs) [128.139273] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs [128.142315] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s) [128.682797] [030/137] (908s left) gen9_exec_parse (bb-start-cmd) [128.906039] Starting subtest: bb-start-cmd [128.910314] Subtest bb-start-cmd: SUCCESS (0.005s) [129.134348] [031/137] (908s left) vc4/vc4_wait_bo (used-bo) [129.394339] Subtest used-bo: SKIP (0.000s) [129.465315] [032/137] (907s left) gem_media_vme [129.731823] [033/137] (907s left) drm_fdinfo (isolation) [129.934656] Starting subtest: isolation [129.936525] Starting dynamic subtest: rcs0 [130.473661] Dynamic subtest rcs0: SUCCESS (0.538s) [130.493841] Starting dynamic subtest: bcs0 [131.006570] Dynamic subtest bcs0: SUCCESS (0.532s) [131.027172] Starting dynamic subtest: vcs0 [131.538570] Dynamic subtest vcs0: SUCCESS (0.531s) [131.558740] Starting dynamic subtest: vecs0 [132.069533] Dynamic subtest vecs0: SUCCESS (0.530s) [132.070838] Subtest isolation: SUCCESS (2.135s) [132.148621] [034/137] (905s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [132.346559] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [132.456461] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [132.548648] [035/137] (904s left) gem_watchdog (default-virtual) [132.759571] Starting subtest: default-virtual [134.041659] Subtest default-virtual: SUCCESS (1.281s) [134.116305] [036/137] (903s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [134.425503] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [134.428214] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [134.532436] [037/137] (902s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [134.732814] Starting subtest: multi-wait-all-for-submit-available-submitted [134.736927] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.002s) [134.815950] [038/137] (902s left) kms_content_protection (atomic) [135.152331] Starting subtest: atomic [135.194462] Starting dynamic subtest: pipe-A-DP-1 [255.438764] Per-test timeout exceeded. Killing the current test with SIGQUIT. [255.645549] Dynamic subtest pipe-A-DP-1: FAIL (120.140s) [255.646804] Subtest atomic: FAIL (120.276s) [256.313963] Closing watchdogs [256.321409] Initializing watchdogs [256.321598] /dev/watchdog0 [256.345491] [039/137] (781s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [256.647667] Starting subtest: cursor-vs-flip-varying-size [298.507760] Subtest cursor-vs-flip-varying-size: SUCCESS (41.862s) [298.832549] [040/137] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [299.146835] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [299.149487] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [299.246661] [041/137] (738s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [299.540600] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [299.545226] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.003s) [299.647393] [042/137] (737s left) kms_vblank (pipe-c-query-forked-busy) [299.949083] Starting subtest: pipe-C-query-forked-busy [302.888286] Subtest pipe-C-query-forked-busy: SUCCESS (2.942s) [303.219376] [043/137] (734s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [303.527257] Starting subtest: fbc-rgb565-draw-blt [305.744587] Subtest fbc-rgb565-draw-blt: SUCCESS (2.219s) [305.868561] [044/137] (731s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [306.166661] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [306.169952] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.005s) [306.253235] [045/137] (731s left) kms_content_protection (srm) [306.601127] Starting subtest: srm [306.628671] Starting dynamic subtest: pipe-A-DP-1 [427.400589] Per-test timeout exceeded. Killing the current test with SIGQUIT. [428.093075] Closing watchdogs [428.097621] Initializing watchdogs [428.097793] /dev/watchdog0 [428.122060] [046/137] (609s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [428.448421] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [428.500879] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.051s) [428.619155] [047/137] (609s left) gem_pxp (protected-raw-src-copy-not-readible) [431.336208] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [431.419182] [048/137] (606s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs) [432.084501] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs [432.088754] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [432.468725] [049/137] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [432.776955] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [432.779573] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [432.868648] [050/137] (605s left) kms_flip (2x-blocking-wf_vblank) [433.158314] Starting subtest: 2x-blocking-wf_vblank [433.160766] Subtest 2x-blocking-wf_vblank: SKIP (0.003s) [433.268210] [051/137] (604s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs) [433.979574] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s) [434.292383] [052/137] (603s left) gem_fence_thrash (bo-write-verify-none) [434.487128] Starting subtest: bo-write-verify-none [435.646596] Subtest bo-write-verify-none: SUCCESS (1.157s) [435.741838] [053/137] (602s left) gem_mmap_wc (write-read) [435.942038] Starting subtest: write-read [435.971973] Subtest write-read: SUCCESS (0.031s) [436.091842] [054/137] (602s left) gem_userptr_blits (sync-unmap-after-close) [436.331203] Starting subtest: sync-unmap-after-close [436.367431] Subtest sync-unmap-after-close: SUCCESS (0.036s) [436.509764] [055/137] (601s left) prime_vgem (coherency-blt) [436.735202] Starting subtest: coherency-blt [440.390797] Subtest coherency-blt: SUCCESS (3.653s) [440.508832] [056/137] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [440.835794] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [440.838591] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [440.943656] [057/137] (597s left) kms_cursor_crc (cursor-random-max-size) [441.267862] Starting subtest: cursor-random-max-size [441.271879] Subtest cursor-random-max-size: SKIP (0.000s) [441.376832] [058/137] (596s left) perf (disabled-read-error) [441.683921] Starting subtest: disabled-read-error [441.782221] Subtest disabled-read-error: SUCCESS (0.098s) [441.841500] [059/137] (596s left) gem_exec_reloc (basic-wc) [442.055858] Starting subtest: basic-wc [442.072896] Subtest basic-wc: SUCCESS (0.019s) [442.259511] [060/137] (596s left) gem_ctx_persistence (legacy-engines-mixed) [442.466622] Starting subtest: legacy-engines-mixed [442.468301] Starting dynamic subtest: render [442.516784] Dynamic subtest render: SUCCESS (0.048s) [442.539559] Starting dynamic subtest: bsd [442.570805] Dynamic subtest bsd: SUCCESS (0.052s) [442.599555] Starting dynamic subtest: blt [442.618752] Dynamic subtest blt: SUCCESS (0.046s) [442.641462] Starting dynamic subtest: vebox [442.669652] Dynamic subtest vebox: SUCCESS (0.049s) [442.671037] Subtest legacy-engines-mixed: SUCCESS (0.203s) [442.763141] [061/137] (595s left) kms_big_fb (x-tiled-64bpp-rotate-270) [443.088506] Starting subtest: x-tiled-64bpp-rotate-270 [443.173912] Subtest x-tiled-64bpp-rotate-270: SKIP (0.082s) [443.293773] [062/137] (595s left) i915_suspend (basic-s3-without-i915) [443.490184] Starting subtest: basic-s3-without-i915 [463.574808] Subtest basic-s3-without-i915: SUCCESS (3.843s) [466.167610] [063/137] (590s left) sw_sync (sync_multi_timeline_wait) [466.371011] Starting subtest: sync_multi_timeline_wait [466.372801] Subtest sync_multi_timeline_wait: SUCCESS (0.002s) [466.449151] [064/137] (590s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [466.764535] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [466.767196] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [466.865344] [065/137] (590s left) kms_psr2_su (page_flip-nv12) [467.068805] Subtest page_flip-NV12: SKIP (0.000s) [467.113947] [066/137] (590s left) kms_atomic (plane-primary-overlay-mutable-zpos) [467.545250] Starting subtest: plane-primary-overlay-mutable-zpos [467.550003] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.000s) [467.980574] [067/137] (589s left) gen3_mixed_blits [468.227788] [068/137] (589s left) kms_flip (blocking-absolute-wf_vblank) [468.519014] Starting subtest: blocking-absolute-wf_vblank [468.523318] Starting dynamic subtest: A-DP1 [479.073841] Dynamic subtest A-DP1: SUCCESS (10.553s) [479.095318] Starting dynamic subtest: B-DP1 [489.551856] Dynamic subtest B-DP1: SUCCESS (10.476s) [489.572397] Starting dynamic subtest: C-DP1 [500.017715] Dynamic subtest C-DP1: SUCCESS (10.463s) [500.018965] Subtest blocking-absolute-wf_vblank: SUCCESS (31.504s) [500.439642] [069/137] (556s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [500.755949] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [500.758681] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [500.854137] [070/137] (556s left) gem_exec_balancer (bonded-pair) [501.092776] Starting subtest: bonded-pair [504.840255] Subtest bonded-pair: SUCCESS (3.745s) [508.754753] [071/137] (548s left) gem_exec_params (invalid-fence-in-submit) [508.965243] Starting subtest: invalid-fence-in-submit [508.981470] Subtest invalid-fence-in-submit: SUCCESS (0.016s) [509.087424] [072/137] (548s left) gem_readwrite (read-bad-handle) [509.290253] Starting subtest: read-bad-handle [509.293269] Subtest read-bad-handle: SUCCESS (0.000s) [509.404884] [073/137] (548s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [509.626267] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [509.628720] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [509.825279] [074/137] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [510.139589] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [510.142224] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [510.238206] [075/137] (547s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25) [510.536472] Starting subtest: plane-downscale-with-pixel-format-factor-0-25 [510.538161] Starting dynamic subtest: pipe-A-DP-1 [510.573489] Dynamic subtest pipe-A-DP-1: SKIP (0.034s) [510.595279] Starting dynamic subtest: pipe-B-DP-1 [510.655857] Dynamic subtest pipe-B-DP-1: SKIP (0.079s) [510.680206] Starting dynamic subtest: pipe-C-DP-1 [510.740365] Dynamic subtest pipe-C-DP-1: SKIP (0.080s) [510.742901] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.206s) [510.839004] [076/137] (546s left) kms_big_fb (linear-64bpp-rotate-270) [511.156994] Starting subtest: linear-64bpp-rotate-270 [511.243942] Subtest linear-64bpp-rotate-270: SKIP (0.085s) [511.354625] [077/137] (546s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs) [511.988961] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs [511.991419] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s) [512.408169] [078/137] (545s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75) [512.707772] Starting subtest: plane-downscale-with-pixel-format-factor-0-75 [512.711891] Starting dynamic subtest: pipe-A-DP-1 [515.048942] Dynamic subtest pipe-A-DP-1: SUCCESS (2.339s) [515.071405] Starting dynamic subtest: pipe-B-DP-1 [517.612870] Dynamic subtest pipe-B-DP-1: SUCCESS (2.560s) [517.635450] Starting dynamic subtest: pipe-C-DP-1 [517.979018] Dynamic subtest pipe-C-DP-1: SUCCESS (0.361s) [517.980651] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (5.273s) [518.378367] [079/137] (539s left) kms_invalid_mode (zero-hdisplay) [518.679442] Starting subtest: zero-hdisplay [518.680821] Starting dynamic subtest: DP-1-pipe-A [518.774392] Dynamic subtest DP-1-pipe-A: SUCCESS (0.094s) [518.801590] Starting dynamic subtest: DP-1-pipe-B [518.803449] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s) [518.825272] Starting dynamic subtest: DP-1-pipe-C [518.826657] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s) [518.828180] Subtest zero-hdisplay: SUCCESS (0.135s) [519.135141] [080/137] (538s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [519.436357] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [519.437710] Starting dynamic subtest: pipe-A-valid-mode [519.843732] Dynamic subtest pipe-A-valid-mode: SKIP (0.406s) [519.846200] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.410s) [520.219408] [081/137] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [520.526805] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [520.529441] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [520.636537] [082/137] (537s left) gem_ctx_isolation (nonpriv) [520.860175] Starting subtest: nonpriv [520.861876] Starting dynamic subtest: rcs0 [523.139976] Dynamic subtest rcs0: SUCCESS (2.276s) [523.162510] Starting dynamic subtest: bcs0 [526.083877] Dynamic subtest bcs0: SUCCESS (2.941s) [526.104871] Starting dynamic subtest: vcs0 [528.278410] Dynamic subtest vcs0: SUCCESS (2.195s) [528.298204] Starting dynamic subtest: vecs0 [530.520896] Dynamic subtest vecs0: SUCCESS (2.241s) [530.522439] Subtest nonpriv: SUCCESS (9.658s) [530.720624] [083/137] (527s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs) [531.172061] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs [531.174923] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s) [531.745949] [084/137] (526s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs) [532.189345] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs [532.193866] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [532.793481] [085/137] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [533.103208] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [533.106052] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [533.210637] [086/137] (524s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm) [533.507599] Subtest pipe-D-ts-continuation-modeset-rpm: SKIP (0.000s) [533.593681] [087/137] (524s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [533.909844] Starting subtest: psr-rgb101010-draw-mmap-wc [533.912650] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s) [534.010386] [088/137] (524s left) kms_properties (plane-properties-atomic) [534.308205] Starting subtest: plane-properties-atomic [535.355021] Subtest plane-properties-atomic: SUCCESS (1.050s) [535.668949] [089/137] (522s left) kms_flip (basic-flip-vs-dpms) [535.954845] Starting subtest: basic-flip-vs-dpms [535.958946] Starting dynamic subtest: A-DP1 [537.186532] Dynamic subtest A-DP1: SUCCESS (1.224s) [537.207335] Starting dynamic subtest: B-DP1 [538.306866] Dynamic subtest B-DP1: SUCCESS (1.120s) [538.328821] Starting dynamic subtest: C-DP1 [539.429195] Dynamic subtest C-DP1: SUCCESS (1.122s) [539.430440] Subtest basic-flip-vs-dpms: SUCCESS (3.477s) [539.802461] [090/137] (518s left) i915_pm_rc6_residency (rc6-accuracy) [540.173555] Starting subtest: rc6-accuracy [543.176403] Subtest rc6-accuracy: SUCCESS (3.001s) [543.267079] [091/137] (515s left) syncobj_timeline (single-wait-all-for-submit-signaled) [543.466982] Starting subtest: single-wait-all-for-submit-signaled [543.468371] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [543.550425] [092/137] (514s left) v3d/v3d_submit_csd (bad-in-sync) [543.809142] Subtest bad-in-sync: SKIP (0.000s) [543.884587] [093/137] (514s left) i915_pm_backlight (fade-with-dpms) [544.181659] Subtest fade-with-dpms: SKIP (0.000s) [544.232654] [094/137] (514s left) gem_exec_balancer (persistence) [548.240285] Starting subtest: persistence [551.890385] Subtest persistence: SUCCESS (3.648s) [551.985797] [095/137] (506s left) syncobj_wait (invalid-reset-illegal-handle) [552.186659] Starting subtest: invalid-reset-illegal-handle [552.188049] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [552.285189] [096/137] (506s left) gem_partial_pwrite_pread (writes-after-reads) [552.498144] Starting subtest: writes-after-reads [573.620360] Subtest writes-after-reads: SUCCESS (21.122s) [573.734072] [097/137] (484s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [573.939104] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [574.041897] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s) [574.133989] [098/137] (484s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [574.458230] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [574.461412] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [574.551405] [099/137] (484s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [574.853772] Starting subtest: basic-busy-flip-before-cursor-varying-size [574.857308] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [574.934778] [100/137] (483s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [575.325410] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [575.618243] [101/137] (483s left) kms_addfb_basic (too-wide) [575.916312] Starting subtest: too-wide [575.917686] Subtest too-wide: SUCCESS (0.000s) [576.012147] [102/137] (482s left) perf_pmu (init-sema) [576.220402] Starting subtest: init-sema [576.222190] Starting dynamic subtest: rcs0 [576.223779] Dynamic subtest rcs0: SUCCESS (0.003s) [576.248098] Starting dynamic subtest: bcs0 [576.249407] Dynamic subtest bcs0: SUCCESS (0.002s) [576.271169] Starting dynamic subtest: vcs0 [576.272436] Dynamic subtest vcs0: SUCCESS (0.001s) [576.293716] Starting dynamic subtest: vecs0 [576.295148] Dynamic subtest vecs0: SUCCESS (0.001s) [576.296615] Subtest init-sema: SUCCESS (0.012s) [576.329825] [103/137] (482s left) gem_exec_whisper (basic-fds-forked) [576.553566] Starting subtest: basic-fds-forked [595.191988] Subtest basic-fds-forked: SUCCESS (18.637s) [595.396741] [104/137] (463s left) v3d/v3d_wait_bo (map-bo-1ns) [595.654674] Subtest map-bo-1ns: SKIP (0.000s) [595.730817] [105/137] (463s left) gem_exec_reloc (basic-wc-read-active) [595.944075] Starting subtest: basic-wc-read-active [596.085700] Subtest basic-wc-read-active: SUCCESS (0.140s) [596.280750] [106/137] (462s left) gem_exec_reloc (basic-wc-cpu) [596.496667] Starting subtest: basic-wc-cpu [596.515289] Subtest basic-wc-cpu: SUCCESS (0.021s) [596.712954] [107/137] (462s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [597.014952] Starting subtest: primary-yf-tiled-reflect-x-180 [597.017939] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.004s) [597.111712] [108/137] (461s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [597.416934] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [597.418361] Starting dynamic subtest: pipe-A-valid-mode [597.537022] Dynamic subtest pipe-A-valid-mode: SKIP (0.118s) [597.539915] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.122s) [597.882296] [109/137] (461s left) gem_create (create-massive) [598.083930] Starting subtest: create-massive [598.085217] Subtest create-massive: SUCCESS (0.000s) [598.299127] [110/137] (460s left) kms_vblank (pipe-a-accuracy-idle) [598.600661] Starting subtest: pipe-A-accuracy-idle [600.884764] Subtest pipe-A-accuracy-idle: SUCCESS (2.287s) [601.197883] [111/137] (457s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [601.403206] Starting subtest: invalid-single-wait-all-unsubmitted [601.405121] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [601.499420] [112/137] (457s left) gem_spin_batch (user-each) [601.722200] Starting subtest: user-each [605.144751] Subtest user-each: SUCCESS (3.422s) [605.381679] [113/137] (453s left) gem_exec_fence (invalid-timeline-fence-array) [606.181362] Starting subtest: invalid-timeline-fence-array [606.189051] Subtest invalid-timeline-fence-array: SUCCESS (0.009s) [606.414865] [114/137] (452s left) kms_vblank (pipe-d-query-idle) [606.719756] Subtest pipe-D-query-idle: SKIP (0.000s) [606.814317] [115/137] (452s left) syncobj_wait (signal) [607.020050] Starting subtest: signal [607.021575] Subtest signal: SUCCESS (0.001s) [607.114046] [116/137] (452s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs) [607.820884] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [608.139232] [117/137] (451s left) gem_partial_pwrite_pread (reads-snoop) [608.347938] Starting subtest: reads-snoop [614.723797] Subtest reads-snoop: SUCCESS (6.376s) [614.855314] [118/137] (444s left) api_intel_bb (add-remove-objects) [615.058672] Starting subtest: add-remove-objects [615.071365] Subtest add-remove-objects: SUCCESS (0.014s) [615.188812] [119/137] (444s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc) [615.773406] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc [615.779954] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s) [616.219908] [120/137] (443s left) perf_pmu (busy-no-semaphores) [616.426229] Starting subtest: busy-no-semaphores [616.427892] Starting dynamic subtest: rcs0 [616.952288] Dynamic subtest rcs0: SUCCESS (0.523s) [616.977245] Starting dynamic subtest: bcs0 [617.473931] Dynamic subtest bcs0: SUCCESS (0.520s) [617.498349] Starting dynamic subtest: vcs0 [617.995433] Dynamic subtest vcs0: SUCCESS (0.520s) [618.019317] Starting dynamic subtest: vecs0 [618.519099] Dynamic subtest vecs0: SUCCESS (0.520s) [618.520683] Subtest busy-no-semaphores: SUCCESS (2.090s) [618.617604] [121/137] (440s left) drm_read (empty-block) [619.044024] Starting subtest: empty-block [620.043071] Subtest empty-block: SUCCESS (1.001s) [620.168002] [122/137] (439s left) i915_suspend (forcewake) [620.368928] Starting subtest: forcewake [654.721788] Subtest forcewake: SUCCESS (2.945s) [658.865972] [123/137] (436s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc) [659.620448] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [659.937119] [124/137] (435s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [660.253869] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [660.256517] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [660.353446] [125/137] (434s left) kms_properties (plane-properties-legacy) [660.658623] Starting subtest: plane-properties-legacy [662.435962] Subtest plane-properties-legacy: SUCCESS (1.780s) [662.774993] [126/137] (432s left) i915_pm_rpm (gem-idle) [664.666745] Starting subtest: gem-idle [670.230767] Subtest gem-idle: SUCCESS (5.566s) [670.663035] [127/137] (424s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [671.070793] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [671.369804] [128/137] (423s left) kms_addfb_basic (addfb25-bad-modifier) [671.568799] Starting subtest: addfb25-bad-modifier [671.570200] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [671.779143] [129/137] (423s left) kms_plane_scaling (planes-upscale-20x20) [672.078261] Starting subtest: planes-upscale-20x20 [672.079639] Starting dynamic subtest: pipe-A-DP-1 [672.149677] Dynamic subtest pipe-A-DP-1: SUCCESS (0.070s) [672.181060] Starting dynamic subtest: pipe-B-DP-1 [672.504837] Dynamic subtest pipe-B-DP-1: SUCCESS (0.351s) [672.565864] Starting dynamic subtest: pipe-C-DP-1 [672.600154] Dynamic subtest pipe-C-DP-1: SKIP (0.089s) [672.601996] Subtest planes-upscale-20x20: SUCCESS (0.524s) [673.023515] [130/137] (422s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc) [673.734691] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc [673.737730] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [674.091823] [131/137] (421s left) gem_exec_schedule (preempt-queue-contexts-chain) [674.324074] Starting subtest: preempt-queue-contexts-chain [674.328082] Starting dynamic subtest: rcs0 [675.336296] Dynamic subtest rcs0: SUCCESS (1.007s) [675.372238] Starting dynamic subtest: bcs0 [676.436067] Dynamic subtest bcs0: SUCCESS (1.097s) [676.464907] Starting dynamic subtest: vcs0 [677.524045] Dynamic subtest vcs0: SUCCESS (1.087s) [677.553416] Starting dynamic subtest: vecs0 [678.613344] Dynamic subtest vecs0: SUCCESS (1.087s) [678.614796] Subtest preempt-queue-contexts-chain: SUCCESS (4.287s) [678.959693] [132/137] (416s left) gem_pxp (verify-pxp-stale-buf-execution) [681.682178] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [681.774985] [133/137] (413s left) syncobj_basic (bad-flags-handle-to-fd) [681.975270] Starting subtest: bad-flags-handle-to-fd [681.977055] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [682.074252] [134/137] (413s left) gem_exec_fence (syncobj-timeline-export) [682.870666] Starting subtest: syncobj-timeline-export [682.877899] Subtest syncobj-timeline-export: SUCCESS (0.009s) [683.110276] [135/137] (412s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [683.416703] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [683.419314] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [683.525007] [136/137] (412s left) prime_vgem (basic-fence-flip) [683.753235] Starting subtest: basic-fence-flip [684.345596] Subtest basic-fence-flip: SUCCESS (0.592s) [684.477045] [137/137] (411s left) prime_vgem (basic-fence-mmap) [684.694649] Starting subtest: basic-fence-mmap [684.756104] Subtest basic-fence-mmap: SUCCESS (0.061s) [684.855801] Closing watchdogs Done.