[59.560157] Initializing watchdogs
[59.560201]   /dev/watchdog0
[59.575147] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.580040] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.582506] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.584495] [001/132] (960s left) gem_exec_schedule (u-lateslice)
[59.646471] Starting subtest: u-lateslice
[59.647421] Starting dynamic subtest: rcs0
[59.668236] Dynamic subtest rcs0: SUCCESS (0.022s)
[59.675108] Starting dynamic subtest: bcs0
[59.685340] Dynamic subtest bcs0: SUCCESS (0.017s)
[59.691766] Starting dynamic subtest: vcs0
[59.705087] Dynamic subtest vcs0: SUCCESS (0.020s)
[59.711197] Starting dynamic subtest: vcs1
[59.725847] Dynamic subtest vcs1: SUCCESS (0.020s)
[59.732102] Starting dynamic subtest: vecs0
[59.749361] Dynamic subtest vecs0: SUCCESS (0.023s)
[59.755234] Starting dynamic subtest: ccs0
[59.771722] Dynamic subtest ccs0: SUCCESS (0.022s)
[59.772670] Subtest u-lateslice: SUCCESS (0.125s)
[61.422798] [002/132] (958s left) gem_exec_whisper (basic-forked-all)
[61.485685] Starting subtest: basic-forked-all
[75.652673] Subtest basic-forked-all: SUCCESS (14.154s)
[75.827031] [003/132] (944s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[75.868865] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[75.922864] [004/132] (944s left) kms_pm_dc (dc9-dpms)
[77.026815] Starting subtest: dc9-dpms
[78.455488] Subtest dc9-dpms: SUCCESS (1.429s)
[78.517350] [005/132] (941s left) gem_ctx_persistence (engines-mixed-process)
[78.564067] Starting subtest: engines-mixed-process
[78.565031] Starting dynamic subtest: rcs0
[80.269206] Dynamic subtest rcs0: SUCCESS (1.704s)
[80.277550] Starting dynamic subtest: bcs0
[82.318366] Dynamic subtest bcs0: SUCCESS (2.049s)
[82.326880] Starting dynamic subtest: vcs0
[84.331664] Dynamic subtest vcs0: SUCCESS (2.012s)
[84.341348] Starting dynamic subtest: vcs1
[86.316385] Dynamic subtest vcs1: SUCCESS (1.982s)
[86.325287] Starting dynamic subtest: vecs0
[88.367376] Dynamic subtest vecs0: SUCCESS (2.050s)
[88.377285] Starting dynamic subtest: ccs0
[90.340894] Dynamic subtest ccs0: SUCCESS (1.973s)
[90.342035] Subtest engines-mixed-process: SUCCESS (11.775s)
[90.411433] [006/132] (929s left) kms_chamelium_hpd (vga-hpd-fast)
[90.799949] Subtest vga-hpd-fast: SKIP (0.000s)
[91.598115] [007/132] (928s left) kms_psr (fbc-psr2-cursor-plane-move)
[91.683559] Starting subtest: fbc-psr2-cursor-plane-move
[91.684508] Starting dynamic subtest: eDP-1
[91.686331] Dynamic subtest eDP-1: SKIP (0.000s)
[91.688023] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[91.754179] [008/132] (928s left) kms_properties (colorop-properties-atomic)
[91.834990] Starting subtest: colorop-properties-atomic
[91.835889] Starting dynamic subtest: pipe-A-eDP-1
[92.220104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[92.230253] Starting dynamic subtest: pipe-B-eDP-1
[93.293887] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.073s)
[93.304894] Starting dynamic subtest: pipe-C-eDP-1
[94.333848] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.039s)
[94.342198] Starting dynamic subtest: pipe-D-eDP-1
[96.100916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.757s)
[96.101934] Subtest colorop-properties-atomic: SUCCESS (4.258s)
[96.461442] [009/132] (923s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[96.549981] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[96.550992] Starting dynamic subtest: pipe-A-eDP-1
[96.573160] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[96.580750] Starting dynamic subtest: pipe-B-eDP-1
[96.601896] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[96.608805] Starting dynamic subtest: pipe-C-eDP-1
[96.630565] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[96.638765] Starting dynamic subtest: pipe-D-eDP-1
[96.659893] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[96.661656] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[98.816432] [010/132] (921s left) gem_eio (in-flight-10ms)
[99.047497] Starting subtest: in-flight-10ms
[107.317425] Subtest in-flight-10ms: SUCCESS (8.270s)
[107.445236] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[107.446885] [011/132] (912s left) kms_big_fb (linear-16bpp-rotate-270)
[107.545964] Starting subtest: linear-16bpp-rotate-270
[107.565558] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[107.692698] [012/132] (912s left) gem_flink_basic (basic)
[107.738287] Starting subtest: basic
[107.739333] Subtest basic: SUCCESS (0.000s)
[107.820624] [013/132] (912s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[107.913984] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[107.915895] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[107.995656] [014/132] (912s left) syncobj_timeline (host-signal-ordered)
[108.055541] Starting subtest: host-signal-ordered
[108.056781] Subtest host-signal-ordered: SUCCESS (0.001s)
[108.164146] [015/132] (912s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[108.278859] Starting subtest: cursorB-vs-flipA-toggle
[108.280772] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[108.427198] [016/132] (912s left) kms_vblank (query-forked-busy-hang)
[108.511501] Starting subtest: query-forked-busy-hang
[108.512658] Starting dynamic subtest: pipe-A-eDP-1
[110.395371] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[110.407242] Starting dynamic subtest: pipe-D-eDP-1
[112.973185] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[112.974224] Subtest query-forked-busy-hang: SUCCESS (4.462s)
[113.768060] [017/132] (906s left) kms_cursor_crc (cursor-offscreen-128x128)
[113.975033] Starting subtest: cursor-offscreen-128x128
[113.977417] Starting dynamic subtest: pipe-A-eDP-1
[115.910060] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[115.938173] Starting dynamic subtest: pipe-D-eDP-1
[118.500522] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s)
[118.501459] Subtest cursor-offscreen-128x128: SUCCESS (4.525s)
[119.356674] [018/132] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[119.455478] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[126.219572] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.764s)
[126.314272] [019/132] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[126.413053] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[126.414840] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[126.499662] [020/132] (894s left) syncobj_wait (reset-signaled)
[126.551264] Starting subtest: reset-signaled
[126.552251] Subtest reset-signaled: SUCCESS (0.000s)
[126.636536] [021/132] (894s left) perf (disabled-read-error)
[126.759432] Starting subtest: disabled-read-error
[126.774066] Subtest disabled-read-error: SUCCESS (0.014s)
[126.812835] [022/132] (893s left) kms_pm_rpm (modeset-pc8-residency-stress)
[128.537682] Starting subtest: modeset-pc8-residency-stress
[128.540951] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[129.055217] [023/132] (891s left) kms_atomic (crtc-invalid-params)
[129.150525] Starting subtest: crtc-invalid-params
[129.151469] Starting dynamic subtest: pipe-A-eDP-1
[129.505372] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[129.506325] Subtest crtc-invalid-params: SUCCESS (0.356s)
[130.381027] [024/132] (890s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[130.431217] Starting subtest: invalid-single-wait-unsubmitted
[130.432224] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[130.538341] [025/132] (890s left) kms_psr (fbc-pr-primary-blt)
[130.619894] Starting subtest: fbc-pr-primary-blt
[130.621483] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[130.686610] [026/132] (890s left) gem_ctx_param (invalid-ctx-get)
[130.737672] Starting subtest: invalid-ctx-get
[130.738613] Subtest invalid-ctx-get: SUCCESS (0.000s)
[130.797948] [027/132] (890s left) kms_psr (psr2-cursor-blt)
[130.893889] Starting subtest: psr2-cursor-blt
[130.894701] Starting dynamic subtest: eDP-1
[132.562222] Dynamic subtest eDP-1: SUCCESS (1.668s)
[132.563066] Subtest psr2-cursor-blt: SUCCESS (1.668s)
[133.434978] [028/132] (887s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[133.546812] Starting subtest: flip-vs-cursor-crc-atomic
[134.262343] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.715s)
[135.067975] [029/132] (885s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[135.111615] Starting subtest: etime-multi-wait-all-for-submit-submitted
[135.217098] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[135.291766] [030/132] (885s left) syncobj_timeline (multi-wait-signaled)
[135.351698] Starting subtest: multi-wait-signaled
[135.353044] Subtest multi-wait-signaled: SUCCESS (0.000s)
[135.458168] [031/132] (885s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[135.861836] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[136.693271] [032/132] (884s left) i915_query (query-topology-kernel-writes)
[136.744241] Starting subtest: query-topology-kernel-writes
[136.745148] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[136.845961] [033/132] (884s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[136.937662] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[136.970874] Starting dynamic subtest: pipe-A-plane-0
[137.659276] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[137.668594] Starting dynamic subtest: pipe-A-plane-3
[138.092800] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[139.198141] Starting dynamic subtest: pipe-B-plane-0
[139.856989] Dynamic subtest pipe-B-plane-0: SUCCESS (0.667s)
[139.866222] Starting dynamic subtest: pipe-B-plane-3
[140.290512] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[140.610198] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.672s)
[141.480944] [034/132] (879s left) gem_ccs (ctrl-surf-copy)
[141.554610] Starting subtest: ctrl-surf-copy
[141.556959] Subtest ctrl-surf-copy: SKIP (0.000s)
[141.660381] [035/132] (879s left) gem_exec_fence (long-history)
[142.089839] Starting subtest: long-history
[149.079682] Subtest long-history: SUCCESS (6.981s)
[151.159285] [036/132] (870s left) gem_ctx_persistence (smoketest)
[151.215343] Starting subtest: smoketest
[190.276312] Subtest smoketest: SUCCESS (39.050s)
[190.365358] [037/132] (830s left) kms_cursor_edge_walk (64x64-top-bottom)
[190.471129] Starting subtest: 64x64-top-bottom
[190.472635] Starting dynamic subtest: pipe-A-eDP-1
[193.950815] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[193.959968] Starting dynamic subtest: pipe-D-eDP-1
[197.084520] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[197.085395] Subtest 64x64-top-bottom: SUCCESS (6.614s)
[197.889994] [038/132] (823s left) kms_fbcon_fbt (psr-suspend)
[197.954016] Starting subtest: psr-suspend
[248.985363] Subtest psr-suspend: SUCCESS (20.579s)
[253.105464] [039/132] (772s left) i915_drm_fdinfo (busy-check-all)
[253.159481] Starting subtest: busy-check-all
[253.160371] Starting dynamic subtest: rcs0
[253.165261] Dynamic subtest rcs0: SKIP (0.005s)
[253.181459] Starting dynamic subtest: bcs0
[253.183685] Dynamic subtest bcs0: SKIP (0.001s)
[253.194495] Starting dynamic subtest: vcs0
[253.196337] Dynamic subtest vcs0: SKIP (0.001s)
[253.204747] Starting dynamic subtest: vcs1
[253.207070] Dynamic subtest vcs1: SKIP (0.001s)
[253.217755] Starting dynamic subtest: vecs0
[253.219745] Dynamic subtest vecs0: SKIP (0.001s)
[253.227994] Starting dynamic subtest: ccs0
[253.229868] Dynamic subtest ccs0: SKIP (0.001s)
[253.231505] Subtest busy-check-all: SKIP (0.014s)
[253.263654] [040/132] (772s left) gem_softpin (reverse)
[253.352314] Starting subtest: reverse
[253.358269] Subtest reverse: SUCCESS (0.008s)
[253.491148] [041/132] (772s left) kms_feature_discovery (psr1)
[253.576436] Starting subtest: psr1
[253.577462] Subtest psr1: SUCCESS (0.000s)
[253.668170] [042/132] (771s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[253.715939] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[253.716934] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[253.797658] [043/132] (771s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[253.891558] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[253.892514] Starting dynamic subtest: pipe-A-default-mode
[255.037622] Dynamic subtest pipe-A-default-mode: SKIP (1.142s)
[255.039237] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.143s)
[255.191216] [044/132] (770s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[255.289446] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[255.916943] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[256.061864] [045/132] (769s left) api_intel_bb (offset-control)
[256.104936] Starting subtest: offset-control
[256.111258] Subtest offset-control: SUCCESS (0.007s)
[256.219996] [046/132] (769s left) kms_cursor_crc (cursor-random-128x42)
[256.431469] Starting subtest: cursor-random-128x42
[256.473239] Subtest cursor-random-128x42: SKIP (0.041s)
[256.662462] [047/132] (769s left) gem_ringfill (engines-basic)
[262.769967] Starting subtest: engines-basic
[262.770974] Starting dynamic subtest: rcs0
[262.820078] Dynamic subtest rcs0: SUCCESS (0.057s)
[262.835751] Starting dynamic subtest: bcs0
[262.866200] Dynamic subtest bcs0: SUCCESS (0.045s)
[262.878057] Starting dynamic subtest: vcs0
[262.909313] Dynamic subtest vcs0: SUCCESS (0.041s)
[262.920156] Starting dynamic subtest: vcs1
[262.953108] Dynamic subtest vcs1: SUCCESS (0.042s)
[262.963911] Starting dynamic subtest: vecs0
[262.998004] Dynamic subtest vecs0: SUCCESS (0.043s)
[263.007948] Starting dynamic subtest: ccs0
[263.043635] Dynamic subtest ccs0: SUCCESS (0.044s)
[263.045063] Subtest engines-basic: SUCCESS (0.282s)
[263.117520] [048/132] (762s left) gem_exec_reloc (basic-cpu-wc)
[263.173980] Subtest basic-cpu-wc: SKIP (0.000s)
[263.245655] [049/132] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[263.345594] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[263.347201] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[263.434359] [050/132] (762s left) sw_sync (alloc_merge_fence)
[263.472920] Starting subtest: alloc_merge_fence
[263.473841] Subtest alloc_merge_fence: SUCCESS (0.000s)
[263.520709] [051/132] (762s left) gem_caching (reads)
[263.590158] Subtest reads: SKIP (0.000s)
[263.668960] [052/132] (762s left) kms_hdr (bpc-switch-suspend)
[263.770934] Starting subtest: bpc-switch-suspend
[264.904551] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[285.105426] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.987s)
[286.151137] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[306.110310] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.006s)
[306.111242] Subtest bpc-switch-suspend: SUCCESS (12.161s)
[311.277024] [053/132] (719s left) gem_mmap_gtt (big-bo-tiledy)
[311.333295] Subtest big-bo-tiledY: SKIP (0.000s)
[311.392054] [054/132] (719s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[311.477773] Starting subtest: fbc-psr2-sprite-mmap-cpu
[311.478727] Starting dynamic subtest: eDP-1
[311.480374] Dynamic subtest eDP-1: SKIP (0.000s)
[311.482036] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[311.547148] [055/132] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[311.632255] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[311.633726] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[311.726554] [056/132] (719s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[311.812985] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[315.944564] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.129s)
[317.065064] [057/132] (714s left) gem_userptr_blits (map-fixed-invalidate)
[317.131328] Starting subtest: map-fixed-invalidate
[317.133078] Subtest map-fixed-invalidate: SKIP (0.000s)
[317.238272] [058/132] (713s left) gem_exec_params (cliprects-invalid)
[317.302153] Starting subtest: cliprects-invalid
[317.303093] Subtest cliprects-invalid: SUCCESS (0.000s)
[317.396060] [059/132] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[317.497798] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[317.499610] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[317.602159] [060/132] (713s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[317.699458] Starting subtest: plane-downscale-factor-0-75-with-rotation
[317.700384] Starting dynamic subtest: pipe-A
[317.928953] Dynamic subtest pipe-A: SUCCESS (0.230s)
[317.937960] Starting dynamic subtest: pipe-B
[319.235459] Dynamic subtest pipe-B: SUCCESS (1.305s)
[319.248239] Starting dynamic subtest: pipe-C
[320.571893] Dynamic subtest pipe-C: SUCCESS (1.335s)
[320.581420] Starting dynamic subtest: pipe-D
[321.956908] Dynamic subtest pipe-D: SUCCESS (1.384s)
[321.958828] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.258s)
[323.097515] [061/132] (708s left) kms_plane_scaling (planes-downscale-factor-0-5)
[323.198179] Starting subtest: planes-downscale-factor-0-5
[323.199070] Starting dynamic subtest: pipe-A
[323.218118] Dynamic subtest pipe-A: SKIP (0.018s)
[323.227257] Starting dynamic subtest: pipe-B
[323.252844] Dynamic subtest pipe-B: SKIP (0.031s)
[323.271380] Starting dynamic subtest: pipe-C
[323.284354] Dynamic subtest pipe-C: SKIP (0.031s)
[323.304438] Starting dynamic subtest: pipe-D
[323.317372] Dynamic subtest pipe-D: SKIP (0.032s)
[323.319311] Subtest planes-downscale-factor-0-5: SKIP (0.116s)
[323.435483] [062/132] (707s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[323.526280] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[328.948930] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.404s)
[330.124914] [063/132] (701s left) gem_ctx_shared (q-independent)
[330.179753] Starting subtest: Q-independent
[330.180694] Starting dynamic subtest: rcs0
[330.250478] Dynamic subtest rcs0: SUCCESS (0.070s)
[330.260627] Starting dynamic subtest: vcs0
[330.298863] Dynamic subtest vcs0: SUCCESS (0.047s)
[330.308111] Starting dynamic subtest: vcs1
[330.344400] Dynamic subtest vcs1: SUCCESS (0.045s)
[330.353619] Starting dynamic subtest: vecs0
[330.386650] Dynamic subtest vecs0: SUCCESS (0.042s)
[330.396418] Starting dynamic subtest: ccs0
[330.445791] Dynamic subtest ccs0: SUCCESS (0.056s)
[330.447233] Subtest Q-independent: SUCCESS (0.266s)
[332.000589] [064/132] (699s left) gem_create (create-ext-placement-all)
[332.178136] Starting subtest: create-ext-placement-all
[332.179233] Subtest create-ext-placement-all: SUCCESS (0.000s)
[332.267174] [065/132] (699s left) gen9_exec_parse (bb-chained)
[332.320080] Subtest bb-chained: SKIP (0.000s)
[332.381712] [066/132] (699s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[332.469780] Starting subtest: psr-modesetfrombusy
[338.607747] Subtest psr-modesetfrombusy: SUCCESS (6.131s)
[338.726313] [067/132] (692s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[338.807203] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[338.808095] Starting dynamic subtest: pipe-A-default-mode
[339.969422] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[339.971301] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.160s)
[340.115964] [068/132] (691s left) gem_exec_schedule (preempt)
[340.170316] Starting subtest: preempt
[340.171178] Starting dynamic subtest: rcs0
[340.192199] Dynamic subtest rcs0: SUCCESS (0.021s)
[340.201966] Starting dynamic subtest: bcs0
[340.216658] Dynamic subtest bcs0: SUCCESS (0.024s)
[340.225668] Starting dynamic subtest: vcs0
[340.237619] Dynamic subtest vcs0: SUCCESS (0.020s)
[340.246435] Starting dynamic subtest: vcs1
[340.258305] Dynamic subtest vcs1: SUCCESS (0.020s)
[340.267571] Starting dynamic subtest: vecs0
[340.278964] Dynamic subtest vecs0: SUCCESS (0.020s)
[340.287745] Starting dynamic subtest: ccs0
[340.302627] Dynamic subtest ccs0: SUCCESS (0.023s)
[340.303535] Subtest preempt: SUCCESS (0.133s)
[341.974006] [069/132] (689s left) kms_psr (psr2-sprite-blt)
[342.068636] Starting subtest: psr2-sprite-blt
[342.069564] Starting dynamic subtest: eDP-1
[343.842297] Dynamic subtest eDP-1: SUCCESS (1.769s)
[343.843433] Subtest psr2-sprite-blt: SUCCESS (1.771s)
[344.725763] [070/132] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[344.822980] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[344.824767] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[344.934619] [071/132] (686s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[345.019662] Starting subtest: fbcpsr-stridechange
[351.216388] Subtest fbcpsr-stridechange: SUCCESS (6.193s)
[351.358844] [072/132] (680s left) perf_pmu (idle)
[351.394453] Starting subtest: idle
[351.395467] Starting dynamic subtest: rcs0
[351.942496] Dynamic subtest rcs0: SUCCESS (0.538s)
[351.953645] Starting dynamic subtest: bcs0
[352.456968] Dynamic subtest bcs0: SUCCESS (0.511s)
[352.468074] Starting dynamic subtest: vcs0
[352.976210] Dynamic subtest vcs0: SUCCESS (0.515s)
[352.987368] Starting dynamic subtest: vcs1
[353.496454] Dynamic subtest vcs1: SUCCESS (0.515s)
[353.506828] Starting dynamic subtest: vecs0
[354.012743] Dynamic subtest vecs0: SUCCESS (0.516s)
[354.024286] Starting dynamic subtest: ccs0
[354.530673] Dynamic subtest ccs0: SUCCESS (0.515s)
[354.532128] Subtest idle: SUCCESS (3.127s)
[354.645291] [073/132] (677s left) gem_vm_create (isolation)
[354.713463] Starting subtest: isolation
[354.724366] Subtest isolation: SUCCESS (0.011s)
[354.863009] [074/132] (676s left) gem_exec_balancer (full-late-pulse)
[354.932540] Starting subtest: full-late-pulse
[359.844446] Subtest full-late-pulse: SUCCESS (4.915s)
[360.167048] [075/132] (671s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[360.263050] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[360.263900] Starting dynamic subtest: pipe-A-eDP-1
[360.272646] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.281704] Starting dynamic subtest: pipe-B-eDP-1
[360.290849] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.299659] Starting dynamic subtest: pipe-C-eDP-1
[360.307707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.315949] Starting dynamic subtest: pipe-D-eDP-1
[360.324299] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.326062] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[362.505292] [076/132] (669s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[362.577427] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[362.579241] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[362.788003] [077/132] (669s left) syncobj_basic (bad-flags-fd-to-handle)
[362.840471] Starting subtest: bad-flags-fd-to-handle
[362.841749] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[362.948155] [078/132] (669s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[363.036124] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[363.037003] Starting dynamic subtest: pipe-A-eDP-1
[363.045024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[363.054395] Starting dynamic subtest: pipe-B-eDP-1
[363.062422] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[363.071917] Starting dynamic subtest: pipe-C-eDP-1
[363.079464] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[363.088087] Starting dynamic subtest: pipe-D-eDP-1
[363.095614] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[363.096506] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[365.371382] [079/132] (666s left) kms_vblank (invalid)
[365.461237] Starting subtest: invalid
[365.462241] Starting dynamic subtest: pipe-A-eDP-1
[365.858846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[365.859716] Subtest invalid: SUCCESS (0.398s)
[366.698231] [080/132] (665s left) gem_exec_reloc (basic-active)
[366.753164] Subtest basic-active: SKIP (0.000s)
[366.820578] [081/132] (665s left) perf (rc6-disable)
[366.920319] Starting subtest: rc6-disable
[367.114144] Subtest rc6-disable: SUCCESS (0.193s)
[367.153997] [082/132] (664s left) gem_mmap_gtt (hang-busy)
[367.212611] Subtest hang-busy: SKIP (0.000s)
[367.272751] [083/132] (664s left) gem_exec_suspend (basic-s3)
[367.325338] Starting subtest: basic-S3
[367.326337] Starting dynamic subtest: smem
[387.546713] Dynamic subtest smem: SUCCESS (6.558s)
[387.548318] Subtest basic-S3: SUCCESS (6.560s)
[395.776774] [084/132] (644s left) kms_joiner (basic-force-big-joiner)
[395.872329] Starting subtest: basic-force-big-joiner
[395.874163] Subtest basic-force-big-joiner: SKIP (0.000s)
[395.935035] [085/132] (644s left) api_intel_allocator (reloc-allocator)
[395.992377] Starting subtest: reloc-allocator
[395.993200] Starting dynamic subtest: basic
[395.997053] Dynamic subtest basic: SUCCESS (0.004s)
[396.014539] Starting dynamic subtest: parallel-one
[396.015497] Dynamic subtest parallel-one: SUCCESS (0.006s)
[396.030711] Starting dynamic subtest: print
[396.031637] Dynamic subtest print: SUCCESS (0.000s)
[396.040451] Starting dynamic subtest: reuse
[396.041298] Dynamic subtest reuse: SUCCESS (0.000s)
[396.049978] Starting dynamic subtest: fork-reopen-allocator
[396.051018] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[396.051950] Subtest reloc-allocator: SUCCESS (0.032s)
[396.150699] [086/132] (644s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[396.258930] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[396.270793] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[396.344570] [087/132] (644s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[396.450552] Starting subtest: yf-tiled-8bpp-rotate-270
[396.452368] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[396.553355] [088/132] (643s left) kms_color (invalid-gamma-lut-sizes)
[396.640239] Starting subtest: invalid-gamma-lut-sizes
[396.641139] Starting dynamic subtest: pipe-A
[396.932132] Dynamic subtest pipe-A: SUCCESS (0.291s)
[396.941724] Starting dynamic subtest: pipe-B
[396.942614] Dynamic subtest pipe-B: SUCCESS (0.000s)
[396.951209] Starting dynamic subtest: pipe-C
[396.952130] Dynamic subtest pipe-C: SUCCESS (0.000s)
[396.963012] Starting dynamic subtest: pipe-D
[396.964018] Dynamic subtest pipe-D: SUCCESS (0.000s)
[396.965038] Subtest invalid-gamma-lut-sizes: SUCCESS (0.294s)
[397.765862] [089/132] (642s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[397.826327] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[397.888080] [090/132] (642s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[397.992845] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[398.810853] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[398.996335] [091/132] (641s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[399.091273] Starting subtest: multiplane-rotation-cropping-top
[416.553148] Subtest multiplane-rotation-cropping-top: SUCCESS (17.427s)
[416.652590] [092/132] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[416.753195] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[416.755076] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[416.859730] [093/132] (623s left) syncobj_wait (multi-wait-all-submitted)
[416.919232] Starting subtest: multi-wait-all-submitted
[417.021729] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[417.096104] [094/132] (623s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[417.147452] Starting subtest: invalid-smem-bo-on-discrete
[417.149226] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[417.276577] [095/132] (623s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[417.385696] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[417.387429] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[417.479140] [096/132] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[417.566594] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[424.272463] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.703s)
[424.417452] [097/132] (616s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[424.518933] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[424.530337] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[424.643768] [098/132] (616s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[424.759018] Starting subtest: basic-busy-flip-before-cursor-legacy
[424.760938] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[424.900015] [099/132] (615s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[425.001233] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[425.003477] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[425.102730] [100/132] (615s left) gem_mmap_gtt (medium-copy-xy)
[425.171103] Subtest medium-copy-XY: SKIP (0.000s)
[425.231407] [101/132] (615s left) drm_read (short-buffer-wakeup)
[425.375202] Starting subtest: short-buffer-wakeup
[457.601333] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[457.750792] [102/132] (583s left) sysfs_preempt_timeout (timeout)
[457.805953] Starting subtest: timeout
[457.808801] Starting dynamic subtest: vecs0
[467.537509] Dynamic subtest vecs0: SUCCESS (9.718s)
[467.550463] Starting dynamic subtest: ccs0
[468.820929] Dynamic subtest ccs0: SUCCESS (1.290s)
[468.833426] Starting dynamic subtest: vcs0
[478.547452] Dynamic subtest vcs0: SUCCESS (9.712s)
[478.560965] Starting dynamic subtest: bcs0
[479.818822] Dynamic subtest bcs0: SUCCESS (1.278s)
[479.831313] Starting dynamic subtest: rcs0
[481.085779] Dynamic subtest rcs0: SUCCESS (1.264s)
[481.097750] Starting dynamic subtest: vcs1
[490.578560] Dynamic subtest vcs1: SUCCESS (9.480s)
[490.579562] Subtest timeout: SUCCESS (32.753s)
[490.642325] [103/132] (550s left) kms_plane_multiple (2x-tiling-x)
[490.733585] Starting subtest: 2x-tiling-x
[490.735207] Subtest 2x-tiling-x: SKIP (0.000s)
[490.802903] [104/132] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[490.888605] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[494.726273] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.839s)
[495.878940] [105/132] (545s left) prime_vgem (busy)
[495.949603] Starting subtest: busy
[495.950484] Starting dynamic subtest: rcs0
[496.028670] Dynamic subtest rcs0: SUCCESS (0.079s)
[496.040602] Starting dynamic subtest: bcs0
[496.084940] Dynamic subtest bcs0: SUCCESS (0.053s)
[496.094031] Starting dynamic subtest: vcs0
[496.132530] Dynamic subtest vcs0: SUCCESS (0.045s)
[496.142058] Starting dynamic subtest: vcs1
[496.179031] Dynamic subtest vcs1: SUCCESS (0.046s)
[496.187936] Starting dynamic subtest: vecs0
[496.225146] Dynamic subtest vecs0: SUCCESS (0.045s)
[496.234175] Starting dynamic subtest: ccs0
[496.272781] Dynamic subtest ccs0: SUCCESS (0.047s)
[496.273713] Subtest busy: SUCCESS (0.325s)
[496.386066] [106/132] (544s left) i915_pm_rpm (system-suspend-execbuf)
[497.915812] Starting subtest: system-suspend-execbuf
[557.319724] Subtest system-suspend-execbuf: SUCCESS (43.750s)
[557.692899] [107/132] (483s left) kms_flip (dpms-off-confusion-interruptible)
[557.790536] Starting subtest: dpms-off-confusion-interruptible
[557.794487] Starting dynamic subtest: A-eDP1
[566.534135] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[566.545425] Starting dynamic subtest: B-eDP1
[575.147205] Dynamic subtest B-eDP1: SUCCESS (8.612s)
[575.158731] Starting dynamic subtest: C-eDP1
[583.780512] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[583.791010] Starting dynamic subtest: D-eDP1
[592.386406] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[592.387376] Subtest dpms-off-confusion-interruptible: SUCCESS (34.595s)
[593.552970] [108/132] (447s left) gem_mmap_wc (write-wc-read-gtt)
[593.611805] Subtest write-wc-read-gtt: SKIP (0.000s)
[593.666879] [109/132] (447s left) i915_pm_rps (thresholds-park)
[593.726542] Starting subtest: thresholds-park
[593.728450] Subtest thresholds-park: SKIP (0.001s)
[593.844908] [110/132] (447s left) gem_exec_reloc (basic-write-cpu-noreloc)
[593.905824] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[593.963160] [111/132] (447s left) kms_content_protection (mei-interface)
[594.105270] Starting subtest: mei-interface
[594.107485] Subtest mei-interface: SKIP (0.001s)
[594.231658] [112/132] (447s left) gem_eio (wait-1us)
[594.443878] Starting subtest: wait-1us
[594.775353] Subtest wait-1us: SUCCESS (0.332s)
[594.931712] [113/132] (446s left) kms_hdmi_inject (inject-4k)
[595.270741] Starting subtest: inject-4k
[595.585803] Subtest inject-4k: SUCCESS (0.316s)
[596.113033] [114/132] (445s left) gem_lmem_swapping (heavy-verify-multi)
[596.148234] Subtest heavy-verify-multi: SKIP (0.000s)
[596.184658] [115/132] (445s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[596.275297] Starting subtest: x-tiled-16bpp-rotate-270
[596.295596] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[596.395389] [116/132] (445s left) syncobj_timeline (wait-all-interrupted)
[596.454809] Starting subtest: wait-all-interrupted
[596.556374] Subtest wait-all-interrupted: SUCCESS (0.101s)
[596.629533] [117/132] (444s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[596.718034] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[596.719548] Starting dynamic subtest: pipe-A-eDP-1
[596.729220] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[596.739880] Starting dynamic subtest: pipe-B-eDP-1
[596.748587] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[596.757746] Starting dynamic subtest: pipe-C-eDP-1
[596.765983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[596.774696] Starting dynamic subtest: pipe-D-eDP-1
[596.783160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[596.784843] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[598.978346] [118/132] (442s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[599.066451] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[599.072300] Starting dynamic subtest: pipe-A-eDP-1
[599.082484] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[599.096002] Starting dynamic subtest: pipe-B-eDP-1
[599.105216] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[599.114252] Starting dynamic subtest: pipe-C-eDP-1
[599.123199] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[599.132472] Starting dynamic subtest: pipe-D-eDP-1
[599.141966] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[599.143653] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[601.287714] [119/132] (440s left) syncobj_wait (wait-all-for-submit-complex)
[601.358590] Starting subtest: wait-all-for-submit-complex
[601.581425] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[601.657215] [120/132] (439s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[601.753289] Starting subtest: psr-dirtyfb-ioctl
[601.754284] Starting dynamic subtest: A-eDP-1
[605.627843] Dynamic subtest A-eDP-1: SUCCESS (3.873s)
[605.629214] Subtest psr-dirtyfb-ioctl: SUCCESS (3.874s)
[606.484632] [121/132] (435s left) gem_exec_basic (basic)
[606.548639] Starting subtest: basic
[606.549655] Starting dynamic subtest: rcs0-smem
[606.552799] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[606.563314] Starting dynamic subtest: bcs0-smem
[606.564103] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[606.572822] Starting dynamic subtest: vcs0-smem
[606.573548] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[606.582266] Starting dynamic subtest: vcs1-smem
[606.583115] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[606.591552] Starting dynamic subtest: vecs0-smem
[606.592296] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[606.600721] Starting dynamic subtest: ccs0-smem
[606.601527] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[606.602491] Subtest basic: SUCCESS (0.016s)
[608.156675] [122/132] (433s left) gem_fence_thrash (bo-write-verify-y)
[608.189965] Starting subtest: bo-write-verify-y
[608.217201] Subtest bo-write-verify-y: SKIP (0.026s)
[608.281858] [123/132] (433s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[608.382027] Starting subtest: plane-all-modeset-transition-internal-panels
[608.382927] Starting dynamic subtest: pipe-A-eDP-1
[609.718286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.325s)
[609.989249] Starting dynamic subtest: pipe-B-eDP-1
[611.010914] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.022s)
[611.269907] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.885s)
[612.082204] [124/132] (429s left) kms_plane_scaling (2x-scaler-multi-pipe)
[612.173019] Starting subtest: 2x-scaler-multi-pipe
[612.174626] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[612.264449] [125/132] (429s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[612.359493] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[612.360386] Starting dynamic subtest: pipe-A-eDP-1
[612.460832] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[612.471575] Starting dynamic subtest: pipe-B-eDP-1
[613.628048] Dynamic subtest pipe-B-eDP-1: SKIP (1.165s)
[613.629592] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.269s)
[614.887579] [126/132] (426s left) kms_joiner (invalid-modeset-ultra-joiner)
[614.991158] Starting subtest: invalid-modeset-ultra-joiner
[614.992950] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[615.071004] [127/132] (426s left) perf_pmu (busy)
[615.107896] Starting subtest: busy
[615.108933] Starting dynamic subtest: rcs0
[615.684326] Dynamic subtest rcs0: SUCCESS (0.576s)
[615.697061] Starting dynamic subtest: bcs0
[616.253211] Dynamic subtest bcs0: SUCCESS (0.566s)
[616.265813] Starting dynamic subtest: vcs0
[618.113672] Dynamic subtest vcs0: SUCCESS (1.847s)
[618.125320] Starting dynamic subtest: vcs1
[620.161275] Dynamic subtest vcs1: SUCCESS (2.046s)
[620.173059] Starting dynamic subtest: vecs0
[622.145449] Dynamic subtest vecs0: SUCCESS (1.982s)
[622.156923] Starting dynamic subtest: ccs0
[622.707075] Dynamic subtest ccs0: SUCCESS (0.569s)
[622.708219] Subtest busy: SUCCESS (7.603s)
[622.799139] [128/132] (419s left) kms_plane_alpha_blend (coverage-7efc)
[622.896759] Starting subtest: coverage-7efc
[623.190099] Starting dynamic subtest: pipe-A-eDP-1
[623.776185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[623.804627] Starting dynamic subtest: pipe-D-eDP-1
[625.079114] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[625.079946] Subtest coverage-7efc: SUCCESS (2.182s)
[625.892118] [129/132] (416s left) gem_mmap_wc (write-read)
[625.947146] Subtest write-read: SKIP (0.000s)
[626.003597] [130/132] (415s left) i915_hangman (engine-error-state-capture)
[626.059379] Starting subtest: engine-error-state-capture
[626.060378] Starting dynamic subtest: rcs0
[629.152199] Dynamic subtest rcs0: SUCCESS (3.083s)
[629.163617] Starting dynamic subtest: bcs0
[635.104287] Dynamic subtest bcs0: SUCCESS (5.950s)
[635.116162] Starting dynamic subtest: vcs0
[641.121141] Dynamic subtest vcs0: SUCCESS (6.014s)
[641.133318] Starting dynamic subtest: vcs1
[647.072259] Dynamic subtest vcs1: SUCCESS (5.949s)
[647.087023] Starting dynamic subtest: vecs0
[652.065373] Dynamic subtest vecs0: SUCCESS (4.990s)
[652.076795] Starting dynamic subtest: ccs0
[657.123173] Dynamic subtest ccs0: SUCCESS (5.051s)
[657.124725] Subtest engine-error-state-capture: SUCCESS (31.054s)
[657.189723] [131/132] (384s left) gem_eio (suspend)
[657.371662] Starting subtest: suspend
[669.473894] Subtest suspend: SUCCESS (12.101s)
[675.650484] [132/132] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[675.743576] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[675.745363] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[675.827776] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_pipe_b_c_ivb
results: parsing output: 3/ for test: kms_pm_dc
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_properties
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_flink_basic
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_atomic
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: gem_ccs
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: kms_fbcon_fbt
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_feature_discovery
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_ringfill
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: sw_sync
results: parsing output: 50/ for test: gem_caching
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_vm_create
results: parsing output: 73/ for test: gem_exec_balancer
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_render_copy
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: kms_joiner
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_color
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: drm_read
results: parsing output: 101/ for test: sysfs_preempt_timeout
results: parsing output: 102/ for test: kms_plane_multiple
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: i915_pm_rpm
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_content_protection
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_hdmi_inject
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_dirtyfb
results: parsing output: 120/ for test: gem_exec_basic
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: kms_atomic_transition
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_joiner
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_plane_alpha_blend
results: parsing output: 128/ for test: gem_mmap_wc
results: parsing output: 129/ for test: i915_hangman
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.