[57.725974] Initializing watchdogs
[57.726042]   /dev/watchdog0
[57.740401] [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]
[57.744743] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.747523] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.751894] [001/133] (960s left) kms_sequence (queue-idle)
[57.866229] Starting subtest: queue-idle
[57.868636] Starting dynamic subtest: pipe-A-eDP-1
[59.687077] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[59.694835] Starting dynamic subtest: pipe-B-eDP-1
[62.224735] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.532s)
[62.231752] Starting dynamic subtest: pipe-C-eDP-1
[64.725842] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.499s)
[64.737668] Starting dynamic subtest: pipe-D-eDP-1
[67.895608] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.164s)
[67.898590] Subtest queue-idle: SUCCESS (10.014s)
[68.362886] [002/133] (949s left) gem_userptr_blits (userfault)
[68.432997] Starting subtest: userfault
[68.435536] Subtest userfault: SUCCESS (0.006s)
[68.550533] [003/133] (949s left) gem_busy (close-race)
[68.618065] Starting subtest: close-race
[91.936457] Subtest close-race: SUCCESS (23.313s)
[92.302253] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[92.307889] [004/133] (926s left) kms_cursor_crc (cursor-alpha-opaque)
[92.443641] Starting subtest: cursor-alpha-opaque
[92.445864] Starting dynamic subtest: pipe-A-eDP-1
[93.089915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s)
[93.101267] Starting dynamic subtest: pipe-D-eDP-1
[94.319210] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[94.321821] Subtest cursor-alpha-opaque: SUCCESS (1.875s)
[95.130850] [005/133] (923s left) gem_exec_reloc (basic-gtt-wc-active)
[95.209051] Subtest basic-gtt-wc-active: SKIP (0.000s)
[95.287567] [006/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[95.387219] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[95.391188] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[95.487752] [007/133] (922s left) api_intel_allocator (fork-simple-stress-signal)
[95.543707] Starting subtest: fork-simple-stress-signal
[100.944448] Subtest fork-simple-stress-signal: SUCCESS (5.401s)
[101.075701] [008/133] (917s left) gem_exec_params (rel-constants-invalid)
[101.146845] Starting subtest: rel-constants-invalid
[101.149365] Subtest rel-constants-invalid: SUCCESS (0.000s)
[101.300511] [009/133] (917s left) gem_exec_params (dr4-dirt)
[101.375792] Starting subtest: DR4-dirt
[101.378094] Subtest DR4-dirt: SUCCESS (0.000s)
[101.494714] [010/133] (917s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[101.562182] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[101.666283] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[101.746572] [011/133] (916s left) i915_hangman (engine-engine-error)
[101.827759] Starting subtest: engine-engine-error
[101.831079] Starting dynamic subtest: rcs0
[102.902328] Dynamic subtest rcs0: SUCCESS (1.074s)
[102.912853] Starting dynamic subtest: bcs0
[104.885535] Dynamic subtest bcs0: SUCCESS (1.982s)
[104.897590] Starting dynamic subtest: vcs0
[106.869861] Dynamic subtest vcs0: SUCCESS (1.983s)
[106.879954] Starting dynamic subtest: vcs1
[108.852995] Dynamic subtest vcs1: SUCCESS (1.982s)
[108.864768] Starting dynamic subtest: vecs0
[110.900102] Dynamic subtest vecs0: SUCCESS (2.046s)
[110.911606] Starting dynamic subtest: ccs0
[112.883950] Dynamic subtest ccs0: SUCCESS (1.983s)
[112.886579] Subtest engine-engine-error: SUCCESS (11.057s)
[112.965641] [012/133] (905s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[113.037040] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[113.104703] [013/133] (905s left) kms_cursor_crc (cursor-sliding-512x170)
[113.374674] Starting subtest: cursor-sliding-512x170
[113.379116] Subtest cursor-sliding-512x170: SKIP (0.001s)
[113.521857] [014/133] (905s left) kms_atomic_interruptible (legacy-dpms)
[113.609205] Starting subtest: legacy-dpms
[113.611582] Starting dynamic subtest: pipe-A-eDP-1
[121.054796] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.446s)
[121.057293] Subtest legacy-dpms: SUCCESS (7.447s)
[121.888671] [015/133] (896s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[121.997054] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[122.001255] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[122.083508] [016/133] (896s left) gem_exec_reloc (basic-wc-read-active)
[122.157208] Subtest basic-wc-read-active: SKIP (0.000s)
[122.223588] [017/133] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[122.323436] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[128.997150] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.677s)
[129.111630] [018/133] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[129.211650] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[129.216215] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[129.312680] [019/133] (889s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[129.411289] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[129.413672] Starting dynamic subtest: pipe-A-eDP-1
[129.436574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.446112] Starting dynamic subtest: pipe-B-eDP-1
[129.467224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.475471] Starting dynamic subtest: pipe-C-eDP-1
[129.497376] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.507747] Starting dynamic subtest: pipe-D-eDP-1
[129.531113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.535343] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[131.693824] [020/133] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.813123] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.817570] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.957619] [021/133] (887s left) gem_ctx_shared (exec-single-timeline)
[132.013439] Starting subtest: exec-single-timeline
[132.015657] Starting dynamic subtest: rcs0
[133.042309] Dynamic subtest rcs0: SUCCESS (1.026s)
[133.053038] Starting dynamic subtest: bcs0
[134.130361] Dynamic subtest bcs0: SUCCESS (1.086s)
[134.139787] Starting dynamic subtest: vcs0
[135.220693] Dynamic subtest vcs0: SUCCESS (1.089s)
[135.233914] Starting dynamic subtest: vcs1
[136.307532] Dynamic subtest vcs1: SUCCESS (1.084s)
[136.319325] Starting dynamic subtest: vecs0
[137.394355] Dynamic subtest vecs0: SUCCESS (1.083s)
[137.406182] Starting dynamic subtest: ccs0
[138.483413] Dynamic subtest ccs0: SUCCESS (1.088s)
[138.486273] Subtest exec-single-timeline: SUCCESS (6.469s)
[138.685566] [022/133] (880s left) gen7_exec_parse (basic-rejected)
[138.752645] Subtest basic-rejected: SKIP (0.000s)
[138.821986] [023/133] (880s left) gem_pipe_control_store_loop (reused-buffer)
[138.881191] Starting subtest: reused-buffer
[141.036671] Subtest reused-buffer: SUCCESS (2.154s)
[141.144314] [024/133] (878s left) gem_exec_schedule (submit-early-slice)
[141.213385] Starting subtest: submit-early-slice
[141.215685] Starting dynamic subtest: rcs0
[141.265529] Dynamic subtest rcs0: SUCCESS (0.059s)
[141.273805] Starting dynamic subtest: bcs0
[141.312519] Dynamic subtest bcs0: SUCCESS (0.047s)
[141.321523] Starting dynamic subtest: vcs0
[141.370296] Dynamic subtest vcs0: SUCCESS (0.057s)
[141.384385] Starting dynamic subtest: vcs1
[141.425253] Dynamic subtest vcs1: SUCCESS (0.055s)
[141.433182] Starting dynamic subtest: vecs0
[141.464637] Dynamic subtest vecs0: SUCCESS (0.039s)
[141.475671] Starting dynamic subtest: ccs0
[141.516486] Dynamic subtest ccs0: SUCCESS (0.051s)
[141.519019] Subtest submit-early-slice: SUCCESS (0.310s)
[143.012319] [025/133] (876s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[143.111838] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[143.116362] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[144.218050] [026/133] (875s left) gem_spin_batch (resubmit-new)
[144.282257] Starting subtest: resubmit-new
[144.284618] Starting dynamic subtest: rcs0
[144.290883] Dynamic subtest rcs0: SUCCESS (0.008s)
[144.299743] Starting dynamic subtest: bcs0
[144.302123] Dynamic subtest bcs0: SUCCESS (0.010s)
[144.310114] Starting dynamic subtest: vcs0
[144.312532] Dynamic subtest vcs0: SUCCESS (0.008s)
[144.320616] Starting dynamic subtest: vcs1
[144.323026] Dynamic subtest vcs1: SUCCESS (0.008s)
[144.331098] Starting dynamic subtest: vecs0
[144.332999] Dynamic subtest vecs0: SUCCESS (0.008s)
[144.340880] Starting dynamic subtest: ccs0
[144.343102] Dynamic subtest ccs0: SUCCESS (0.006s)
[144.345237] Subtest resubmit-new: SUCCESS (0.053s)
[145.928686] [027/133] (873s left) kms_psr (fbc-psr2-suspend)
[146.031442] Starting subtest: fbc-psr2-suspend
[146.033847] Starting dynamic subtest: eDP-1
[146.038424] Dynamic subtest eDP-1: SKIP (0.000s)
[146.043036] Subtest fbc-psr2-suspend: SKIP (0.000s)
[146.107767] [028/133] (873s left) gem_ctx_exec (basic-close-race)
[146.167070] Starting subtest: basic-close-race
[152.109364] Subtest basic-close-race: SUCCESS (5.941s)
[152.232393] [029/133] (867s left) perf (polling)
[152.386839] Starting subtest: polling
[152.389205] Starting dynamic subtest: 0-rcs0
[162.415962] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[162.424804] Starting dynamic subtest: 1-vecs0
[172.436998] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[172.439572] Subtest polling: SUCCESS (20.049s)
[172.487567] [030/133] (846s left) syncobj_timeline (single-wait-all-available-signaled)
[172.540075] Starting subtest: single-wait-all-available-signaled
[172.542361] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[172.660353] [031/133] (846s left) gem_ctx_persistence (heartbeat-close)
[172.715243] Starting subtest: heartbeat-close
[172.719775] Subtest heartbeat-close: SKIP (0.000s)
[172.809128] [032/133] (846s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[172.914991] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[177.166887] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.254s)
[178.330487] [033/133] (841s left) i915_pm_rpm (debugfs-read)
[180.049167] Starting subtest: debugfs-read
[181.216667] Subtest debugfs-read: SUCCESS (1.168s)
[181.580461] [034/133] (838s left) kms_pm_dc (dc5-retention-flops)
[182.676137] Starting subtest: dc5-retention-flops
[182.680751] Subtest dc5-retention-flops: SKIP (0.000s)
[182.776892] [035/133] (836s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[182.873149] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[182.875480] Starting dynamic subtest: pipe-A-eDP-1
[182.957739] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[182.968241] Starting dynamic subtest: pipe-B-eDP-1
[184.159209] Dynamic subtest pipe-B-eDP-1: SKIP (1.201s)
[184.163932] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.292s)
[185.459813] [036/133] (834s left) gem_reg_read (timestamp-moving)
[185.513234] Starting subtest: timestamp-moving
[186.514863] Subtest timestamp-moving: SUCCESS (1.001s)
[186.639455] [037/133] (833s left) kms_atomic (atomic-plane-damage)
[186.723078] Starting subtest: atomic-plane-damage
[186.772220] Starting dynamic subtest: pipe-A-eDP-1
[187.317844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[187.320206] Subtest atomic-plane-damage: SUCCESS (0.597s)
[188.191704] [038/133] (831s left) kms_psr2_su (page_flip-nv12)
[188.255345] Subtest page_flip-NV12: SKIP (0.000s)
[188.324594] [039/133] (831s left) kms_psr (psr2-no-drrs)
[188.413021] Starting subtest: psr2-no-drrs
[188.415262] Starting dynamic subtest: eDP-1
[190.057086] Dynamic subtest eDP-1: SUCCESS (1.644s)
[190.059261] Subtest psr2-no-drrs: SUCCESS (1.645s)
[190.857262] [040/133] (829s left) gem_lmem_swapping (heavy-verify-random-ccs)
[190.910075] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[190.963575] [041/133] (828s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[191.022767] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[191.107460] [042/133] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[191.201734] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[191.206293] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[191.315838] [043/133] (828s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[191.414280] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[191.418311] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[191.513929] [044/133] (828s left) kms_pm_rpm (modeset-lpsp)
[193.032447] Starting subtest: modeset-lpsp
[194.487601] Subtest modeset-lpsp: SUCCESS (1.454s)
[194.571804] [045/133] (825s left) gem_ctx_param (basic-default)
[194.626784] Starting subtest: basic-default
[194.629275] Subtest basic-default: SUCCESS (0.000s)
[194.713825] [046/133] (825s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[194.809328] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[194.811602] Starting dynamic subtest: pipe-A
[195.990975] Dynamic subtest pipe-A: SUCCESS (1.184s)
[195.999785] Starting dynamic subtest: pipe-B
[198.210037] Dynamic subtest pipe-B: SUCCESS (2.218s)
[198.218934] Starting dynamic subtest: pipe-C
[199.437268] Dynamic subtest pipe-C: SUCCESS (1.226s)
[199.445411] Starting dynamic subtest: pipe-D
[200.581152] Dynamic subtest pipe-D: SUCCESS (1.143s)
[200.583449] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.775s)
[201.771661] [047/133] (818s left) gem_pxp (reject-modify-context-protection-off-2)
[201.913231] Starting subtest: reject-modify-context-protection-off-2
[201.915879] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[202.032269] [048/133] (818s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[202.110858] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[202.240466] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s)
[202.390273] [049/133] (817s left) kms_invalid_mode (uint-max-clock)
[202.493617] Starting subtest: uint-max-clock
[202.495999] Starting dynamic subtest: pipe-A-eDP-1
[202.796229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.304s)
[202.805374] Starting dynamic subtest: pipe-B-eDP-1
[202.807625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[202.815619] Starting dynamic subtest: pipe-C-eDP-1
[202.817872] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[202.826072] Starting dynamic subtest: pipe-D-eDP-1
[202.828319] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[202.830527] Subtest uint-max-clock: SUCCESS (0.310s)
[203.595485] [050/133] (816s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[203.694957] Starting subtest: async-flip-with-page-flip-events-linear
[204.089055] Starting dynamic subtest: pipe-A-eDP-1
[206.873799] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.783s)
[207.235955] Starting dynamic subtest: pipe-B-eDP-1
[210.009669] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.780s)
[210.379301] Starting dynamic subtest: pipe-C-eDP-1
[213.147997] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[213.515941] Starting dynamic subtest: pipe-D-eDP-1
[216.274730] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[216.277495] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.581s)
[217.460339] [051/133] (802s left) gem_exec_reloc (basic-cpu-gtt)
[217.529964] Subtest basic-cpu-gtt: SKIP (0.000s)
[217.596835] [052/133] (802s left) perf (gen12-unprivileged-single-ctx-counters)
[217.700520] Starting subtest: gen12-unprivileged-single-ctx-counters
[217.702554] Starting dynamic subtest: rcs0
[217.732183] Dynamic subtest rcs0: SUCCESS (0.034s)
[217.734539] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.035s)
[217.773820] [053/133] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[217.882634] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[225.189366] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.310s)
[225.324352] [054/133] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[225.420563] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[232.744257] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.326s)
[232.854927] [055/133] (787s left) gem_exec_fence (nb-await)
[233.034079] Starting subtest: nb-await
[233.036176] Starting dynamic subtest: rcs0
[233.096445] Dynamic subtest rcs0: SUCCESS (0.065s)
[233.107938] Starting dynamic subtest: bcs0
[233.155051] Dynamic subtest bcs0: SUCCESS (0.057s)
[233.166237] Starting dynamic subtest: vcs0
[233.214764] Dynamic subtest vcs0: SUCCESS (0.058s)
[233.225542] Starting dynamic subtest: vcs1
[233.274485] Dynamic subtest vcs1: SUCCESS (0.057s)
[233.285631] Starting dynamic subtest: vecs0
[233.334121] Dynamic subtest vecs0: SUCCESS (0.058s)
[233.345404] Starting dynamic subtest: ccs0
[233.390981] Dynamic subtest ccs0: SUCCESS (0.056s)
[233.393922] Subtest nb-await: SUCCESS (0.361s)
[234.998669] [056/133] (785s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[235.122496] Starting subtest: basic-flip-before-cursor-legacy
[236.039973] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.916s)
[236.849461] [057/133] (783s left) kms_pipe_crc_basic (bad-source)
[236.946135] Starting subtest: bad-source
[236.947993] Subtest bad-source: SUCCESS (0.000s)
[237.028383] [058/133] (783s left) syncobj_wait (multi-wait-for-submit-submitted)
[237.074979] Starting subtest: multi-wait-for-submit-submitted
[237.177508] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[237.270111] [059/133] (783s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[237.389659] Starting subtest: cursorB-vs-flipA-atomic-transitions
[237.394350] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[237.546186] [060/133] (783s left) kms_psr (fbc-psr2-primary-blt)
[237.652321] Starting subtest: fbc-psr2-primary-blt
[237.654258] Starting dynamic subtest: eDP-1
[237.658342] Dynamic subtest eDP-1: SKIP (0.000s)
[237.662515] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[237.736075] [061/133] (783s left) gem_render_tiled_blits (basic)
[237.804988] Subtest basic: SKIP (0.000s)
[237.869231] [062/133] (782s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[237.924457] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[237.926686] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[238.025224] [063/133] (782s left) gem_ctx_param (set-priority-not-supported)
[238.078852] Starting subtest: set-priority-not-supported
[238.083140] Subtest set-priority-not-supported: SKIP (0.000s)
[238.151379] [064/133] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[238.251391] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[238.255035] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[238.355378] [065/133] (782s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[238.410215] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[238.414229] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[238.595564] [066/133] (782s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[238.993576] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[239.776160] [067/133] (781s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[239.879244] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[244.779224] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.904s)
[245.925769] [068/133] (775s left) i915_pm_rps (thresholds-park)
[245.996992] Starting subtest: thresholds-park
[246.001435] Subtest thresholds-park: SKIP (0.001s)
[246.094114] [069/133] (775s left) syncobj_eventfd (binary-wait)
[246.152444] Starting subtest: binary-wait
[246.161491] Subtest binary-wait: SUCCESS (0.011s)
[246.240509] [070/133] (774s left) gem_exec_schedule (preempt-hang)
[246.411114] Starting subtest: preempt-hang
[246.413815] Starting dynamic subtest: rcs0
[246.636460] Dynamic subtest rcs0: SUCCESS (0.228s)
[246.650822] Starting dynamic subtest: bcs0
[246.860803] Dynamic subtest bcs0: SUCCESS (0.223s)
[246.869020] Starting dynamic subtest: vcs0
[247.083296] Dynamic subtest vcs0: SUCCESS (0.223s)
[247.093260] Starting dynamic subtest: vcs1
[247.306999] Dynamic subtest vcs1: SUCCESS (0.222s)
[247.316743] Starting dynamic subtest: vecs0
[247.527697] Dynamic subtest vecs0: SUCCESS (0.220s)
[247.537023] Starting dynamic subtest: ccs0
[247.775673] Dynamic subtest ccs0: SUCCESS (0.247s)
[247.777869] Subtest preempt-hang: SUCCESS (1.368s)
[249.013376] [071/133] (772s left) gem_exec_schedule (fifo)
[249.091428] Starting subtest: fifo
[249.093274] Starting dynamic subtest: rcs0
[249.234636] Dynamic subtest rcs0: SUCCESS (0.153s)
[249.245808] Starting dynamic subtest: vcs0
[249.360185] Dynamic subtest vcs0: SUCCESS (0.125s)
[249.371971] Starting dynamic subtest: vcs1
[249.479459] Dynamic subtest vcs1: SUCCESS (0.117s)
[249.492261] Starting dynamic subtest: vecs0
[249.580816] Dynamic subtest vecs0: SUCCESS (0.100s)
[249.592895] Starting dynamic subtest: ccs0
[249.698542] Dynamic subtest ccs0: SUCCESS (0.117s)
[249.701630] Subtest fifo: SUCCESS (0.617s)
[251.006781] [072/133] (770s left) perf_pmu (idle)
[251.048737] Starting subtest: idle
[251.051228] Starting dynamic subtest: rcs0
[251.587631] Dynamic subtest rcs0: SUCCESS (0.537s)
[251.598351] Starting dynamic subtest: bcs0
[252.101403] Dynamic subtest bcs0: SUCCESS (0.512s)
[252.110792] Starting dynamic subtest: vcs0
[252.624044] Dynamic subtest vcs0: SUCCESS (0.520s)
[252.633968] Starting dynamic subtest: vcs1
[253.141227] Dynamic subtest vcs1: SUCCESS (0.514s)
[253.151149] Starting dynamic subtest: vecs0
[253.658896] Dynamic subtest vecs0: SUCCESS (0.516s)
[253.669669] Starting dynamic subtest: ccs0
[254.179934] Dynamic subtest ccs0: SUCCESS (0.514s)
[254.182470] Subtest idle: SUCCESS (3.128s)
[254.289426] [073/133] (766s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[254.390607] Starting subtest: stress-xrgb8888-ytiled
[254.394760] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[254.468471] [074/133] (766s left) kms_psr (psr-sprite-render)
[254.563856] Starting subtest: psr-sprite-render
[254.566078] Starting dynamic subtest: eDP-1
[256.331936] Dynamic subtest eDP-1: SUCCESS (1.766s)
[256.334112] Subtest psr-sprite-render: SUCCESS (1.767s)
[257.165932] [075/133] (764s left) gem_exec_balancer (full)
[257.223207] Starting subtest: full
[261.733079] Subtest full: SUCCESS (4.510s)
[262.053137] [076/133] (759s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[262.154521] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[262.158633] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[262.234904] [077/133] (759s left) syncobj_basic (bad-flags-fd-to-handle)
[262.299380] Starting subtest: bad-flags-fd-to-handle
[262.301633] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[262.402913] [078/133] (759s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[262.498771] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[262.501053] Starting dynamic subtest: A-eDP1
[266.108408] Dynamic subtest A-eDP1: SUCCESS (3.606s)
[266.118392] Starting dynamic subtest: B-eDP1
[269.302621] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[269.312283] Starting dynamic subtest: C-eDP1
[272.422999] Dynamic subtest C-eDP1: SUCCESS (3.120s)
[272.432688] Starting dynamic subtest: D-eDP1
[275.540329] Dynamic subtest D-eDP1: SUCCESS (3.114s)
[275.542306] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.041s)
[276.348758] [079/133] (745s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[276.461829] Starting subtest: 4-tiled-8bpp-rotate-90
[276.482383] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[276.610616] [080/133] (744s left) kms_big_fb (linear-8bpp-rotate-180)
[276.716692] Starting subtest: linear-8bpp-rotate-180
[277.941674] Subtest linear-8bpp-rotate-180: SUCCESS (1.225s)
[278.051714] [081/133] (743s left) gem_softpin (evict-snoop)
[278.114280] Starting subtest: evict-snoop
[278.117736] Subtest evict-snoop: SKIP (0.000s)
[278.214969] [082/133] (743s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[278.303384] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[278.307198] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[279.383842] [083/133] (742s left) gem_ctx_isolation (preservation)
[279.451447] Starting subtest: preservation
[279.453913] Starting dynamic subtest: rcs0
[279.579849] Dynamic subtest rcs0: SUCCESS (0.128s)
[279.591408] Starting dynamic subtest: bcs0
[279.734443] Dynamic subtest bcs0: SUCCESS (0.153s)
[279.746266] Starting dynamic subtest: vcs0
[279.867567] Dynamic subtest vcs0: SUCCESS (0.132s)
[279.880348] Starting dynamic subtest: vcs1
[281.016198] Dynamic subtest vcs1: SUCCESS (1.148s)
[281.027959] Starting dynamic subtest: vecs0
[283.019550] Dynamic subtest vecs0: SUCCESS (2.002s)
[283.030960] Starting dynamic subtest: ccs0
[285.013824] Dynamic subtest ccs0: SUCCESS (1.992s)
[285.016882] Subtest preservation: SUCCESS (5.562s)
[285.244577] [084/133] (736s left) syncobj_wait (invalid-single-wait-unsubmitted)
[285.292312] Starting subtest: invalid-single-wait-unsubmitted
[285.294591] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[285.384864] [085/133] (736s left) gem_exec_reloc (basic-gtt-noreloc)
[285.438285] Subtest basic-gtt-noreloc: SKIP (0.000s)
[285.508651] [086/133] (736s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[285.604626] Starting subtest: fbcpsr-rgb565-draw-render
[292.542431] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.940s)
[292.692663] [087/133] (729s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[292.806088] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[292.810497] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[292.899614] [088/133] (729s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[293.003832] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[293.006081] Starting dynamic subtest: pipe-A
[293.067629] Dynamic subtest pipe-A: SUCCESS (0.065s)
[293.077727] Starting dynamic subtest: pipe-B
[294.253380] Dynamic subtest pipe-B: SUCCESS (1.184s)
[294.264739] Starting dynamic subtest: pipe-C
[295.367620] Dynamic subtest pipe-C: SUCCESS (1.113s)
[295.377660] Starting dynamic subtest: pipe-D
[296.503532] Dynamic subtest pipe-D: SUCCESS (1.135s)
[296.505738] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.502s)
[297.655316] [089/133] (724s left) kms_chamelium_edid (dp-edid-read)
[298.044763] Subtest dp-edid-read: SKIP (0.000s)
[298.863342] [090/133] (723s left) kms_properties (plane-properties-legacy)
[298.964254] Starting subtest: plane-properties-legacy
[298.966590] Starting dynamic subtest: pipe-A-eDP-1
[299.505364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[299.515804] Starting dynamic subtest: pipe-B-eDP-1
[300.748691] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.241s)
[300.758763] Starting dynamic subtest: pipe-C-eDP-1
[301.988669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[301.998321] Starting dynamic subtest: pipe-D-eDP-1
[303.228662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[303.230601] Subtest plane-properties-legacy: SUCCESS (4.265s)
[304.021340] [091/133] (718s left) gem_mmap_offset (open-flood)
[304.091553] Starting subtest: open-flood
[325.580393] Subtest open-flood: SUCCESS (21.490s)
[325.686912] [092/133] (696s left) kms_flip (flip-vs-suspend-interruptible)
[325.795972] Starting subtest: flip-vs-suspend-interruptible
[325.798067] Starting dynamic subtest: A-eDP1
[375.345278] Dynamic subtest A-eDP1: SUCCESS (4.645s)
[375.357855] Starting dynamic subtest: B-eDP1
[424.351093] Dynamic subtest B-eDP1: SUCCESS (4.528s)
[424.367188] Starting dynamic subtest: C-eDP1
[473.347904] Dynamic subtest C-eDP1: SUCCESS (4.530s)
[473.358484] Starting dynamic subtest: D-eDP1
[522.348615] Dynamic subtest D-eDP1: SUCCESS (4.486s)
[522.351014] Subtest flip-vs-suspend-interruptible: SUCCESS (18.200s)
[523.524800] [093/133] (498s left) sysfs_timeslice_duration (timeout)
[523.608078] Starting subtest: timeout
[523.610606] Starting dynamic subtest: vecs0
[533.131106] Dynamic subtest vecs0: SUCCESS (9.498s)
[533.141652] Starting dynamic subtest: ccs0
[534.350186] Dynamic subtest ccs0: SUCCESS (1.217s)
[534.363450] Starting dynamic subtest: vcs0
[544.156985] Dynamic subtest vcs0: SUCCESS (9.794s)
[544.170390] Starting dynamic subtest: bcs0
[544.704727] Dynamic subtest bcs0: SUCCESS (0.547s)
[544.714693] Starting dynamic subtest: rcs0
[545.920075] Dynamic subtest rcs0: SUCCESS (1.211s)
[545.931591] Starting dynamic subtest: vcs1
[555.159379] Dynamic subtest vcs1: SUCCESS (9.224s)
[555.162248] Subtest timeout: SUCCESS (31.502s)
[555.240306] [094/133] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[555.352239] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[559.368977] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.005s)
[560.593307] [095/133] (461s left) vgem_slow (nohang)
[560.638154] Starting subtest: nohang
[571.060096] Subtest nohang: SUCCESS (10.407s)
[571.146650] [096/133] (451s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[571.244910] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[571.247447] Starting dynamic subtest: pipe-A-eDP-1
[571.949874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[571.961208] Starting dynamic subtest: pipe-B-eDP-1
[573.740338] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.787s)
[573.751625] Starting dynamic subtest: pipe-C-eDP-1
[575.586269] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.845s)
[575.596695] Starting dynamic subtest: pipe-D-eDP-1
[577.417554] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.826s)
[577.420109] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.159s)
[578.568163] [097/133] (443s left) syncobj_timeline (reset-during-wait-for-submit)
[578.624675] Starting subtest: reset-during-wait-for-submit
[578.727608] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[578.819429] [098/133] (443s left) dmabuf_sync_file (export-before-signal)
[578.867824] Starting subtest: export-before-signal
[578.870886] Subtest export-before-signal: SUCCESS (0.003s)
[578.926907] [099/133] (443s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[579.020013] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[579.025079] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[579.094260] [100/133] (443s left) gem_mmap_gtt (cpuset-medium-copy)
[579.144893] Subtest cpuset-medium-copy: SKIP (0.000s)
[579.205742] [101/133] (443s left) kms_flip (flip-vs-rmfb)
[579.306189] Starting subtest: flip-vs-rmfb
[579.308966] Starting dynamic subtest: A-eDP1
[588.162639] Dynamic subtest A-eDP1: SUCCESS (8.854s)
[588.173630] Starting dynamic subtest: B-eDP1
[596.894633] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[596.908447] Starting dynamic subtest: C-eDP1
[605.621061] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[605.631097] Starting dynamic subtest: D-eDP1
[614.444913] Dynamic subtest D-eDP1: SUCCESS (8.820s)
[614.449816] Subtest flip-vs-rmfb: SUCCESS (35.138s)
[615.624810] [102/133] (406s left) kms_cursor_crc (cursor-random-512x512)
[615.927987] Starting subtest: cursor-random-512x512
[615.933156] Subtest cursor-random-512x512: SKIP (0.001s)
[616.081243] [103/133] (406s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[616.194673] Starting subtest: cursorB-vs-flipA-atomic
[616.199344] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[616.339390] [104/133] (406s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[616.440349] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[616.444914] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[616.532671] [105/133] (406s left) kms_flip (2x-flip-vs-rmfb)
[616.628523] Starting subtest: 2x-flip-vs-rmfb
[616.636421] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[616.723673] [106/133] (405s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[616.824584] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[616.826580] Starting dynamic subtest: pipe-A-default-mode
[619.568073] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s)
[619.571145] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.743s)
[620.431609] [107/133] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[620.527978] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[620.532843] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[620.625310] [108/133] (402s left) kms_vblank (ts-continuation-dpms-rpm)
[620.716123] Starting subtest: ts-continuation-dpms-rpm
[620.718919] Starting dynamic subtest: pipe-A-eDP-1
[623.209759] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.491s)
[623.225435] Starting dynamic subtest: pipe-D-eDP-1
[625.458691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.245s)
[625.461452] Subtest ts-continuation-dpms-rpm: SUCCESS (4.740s)
[626.336605] [109/133] (396s left) kms_psr (pr-suspend)
[626.427874] Starting subtest: pr-suspend
[626.433010] Subtest pr-suspend: SKIP (0.000s)
[626.499436] [110/133] (396s left) gem_exec_schedule (u-submit-golden-slice)
[626.590991] Starting subtest: u-submit-golden-slice
[626.593523] Starting dynamic subtest: rcs0
[626.625785] Dynamic subtest rcs0: SUCCESS (0.046s)
[626.636314] Starting dynamic subtest: bcs0
[626.652990] Dynamic subtest bcs0: SUCCESS (0.027s)
[626.662990] Starting dynamic subtest: vcs0
[626.687350] Dynamic subtest vcs0: SUCCESS (0.033s)
[626.696898] Starting dynamic subtest: vcs1
[626.724071] Dynamic subtest vcs1: SUCCESS (0.035s)
[626.734074] Starting dynamic subtest: vecs0
[626.757666] Dynamic subtest vecs0: SUCCESS (0.033s)
[626.767839] Starting dynamic subtest: ccs0
[626.787787] Dynamic subtest ccs0: SUCCESS (0.029s)
[626.790152] Subtest u-submit-golden-slice: SUCCESS (0.208s)
[628.204294] [111/133] (394s left) kms_content_protection (lic-type-0-hdcp14)
[628.363914] Starting subtest: lic-type-0-hdcp14
[628.369007] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[628.489849] [112/133] (394s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[628.550488] Starting subtest: invalid-multi-wait-unsubmitted
[628.553669] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[628.659506] [113/133] (394s left) kms_flip (flip-vs-blocking-wf-vblank)
[628.755062] Starting subtest: flip-vs-blocking-wf-vblank
[628.757926] Starting dynamic subtest: A-eDP1
[637.686572] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[637.699912] Starting dynamic subtest: B-eDP1
[646.612021] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[646.622965] Starting dynamic subtest: C-eDP1
[655.525028] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[655.535921] Starting dynamic subtest: D-eDP1
[664.450057] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[664.452797] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.697s)
[665.695588] [114/133] (357s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[665.813573] Starting subtest: psr-rgb101010-draw-mmap-wc
[672.798076] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.990s)
[672.914193] [115/133] (350s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[673.005744] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[673.010882] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[674.114188] [116/133] (349s left) i915_drm_fdinfo (memory-info-resident)
[674.158562] Starting subtest: memory-info-resident
[674.161430] Starting dynamic subtest: smem0
[677.153097] Dynamic subtest smem0: SUCCESS (2.997s)
[677.156070] Subtest memory-info-resident: SUCCESS (2.998s)
[677.228544] [117/133] (345s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[677.334226] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[678.215250] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.881s)
[678.379247] [118/133] (344s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[678.489657] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[685.388236] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.899s)
[685.528425] [119/133] (337s left) kms_plane_cursor (primary)
[685.623530] Starting subtest: primary
[685.628798] Starting dynamic subtest: pipe-A-eDP-1-size-64
[688.169250] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.547s)
[688.193634] Starting dynamic subtest: pipe-A-eDP-1-size-128
[690.738081] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[690.761924] Starting dynamic subtest: pipe-A-eDP-1-size-256
[693.372868] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.616s)
[693.686834] Starting dynamic subtest: pipe-B-eDP-1-size-64
[696.957385] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.279s)
[696.980878] Starting dynamic subtest: pipe-B-eDP-1-size-128
[699.557493] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[699.587890] Starting dynamic subtest: pipe-B-eDP-1-size-256
[702.204529] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.630s)
[702.541731] Starting dynamic subtest: pipe-C-eDP-1-size-64
[705.425863] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.896s)
[705.453095] Starting dynamic subtest: pipe-C-eDP-1-size-128
[707.561710] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.114s)
[707.586911] Starting dynamic subtest: pipe-C-eDP-1-size-256
[709.728212] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[710.049110] Starting dynamic subtest: pipe-D-eDP-1-size-64
[712.905392] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.868s)
[712.933137] Starting dynamic subtest: pipe-D-eDP-1-size-128
[715.106626] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[715.133460] Starting dynamic subtest: pipe-D-eDP-1-size-256
[717.362352] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[717.675906] Subtest primary: SUCCESS (32.047s)
[718.496128] [120/133] (304s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[718.598917] Starting subtest: flip-vs-dpms-off-vs-modeset
[718.601919] Starting dynamic subtest: A-eDP1
[722.226133] Dynamic subtest A-eDP1: SUCCESS (3.629s)
[722.237789] Starting dynamic subtest: B-eDP1
[725.427389] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[725.438606] Starting dynamic subtest: C-eDP1
[728.541119] Dynamic subtest C-eDP1: SUCCESS (3.112s)
[728.553095] Starting dynamic subtest: D-eDP1
[731.666493] Dynamic subtest D-eDP1: SUCCESS (3.125s)
[731.668522] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.071s)
[732.488643] [121/133] (290s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[732.587327] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[732.591972] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[732.679731] [122/133] (290s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[732.781678] Starting subtest: plane-lut1d-ctm3x4
[732.905880] Starting dynamic subtest: pipe-A-plane-0
[733.049779] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[733.063401] Starting dynamic subtest: pipe-A-plane-1
[733.195013] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[733.205599] Starting dynamic subtest: pipe-A-plane-2
[733.338814] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[734.563569] Starting dynamic subtest: pipe-B-plane-0
[734.712491] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[734.723669] Starting dynamic subtest: pipe-B-plane-1
[734.867898] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[734.878117] Starting dynamic subtest: pipe-B-plane-2
[735.001753] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[736.191097] Starting dynamic subtest: pipe-C-plane-0
[736.327506] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[736.338992] Starting dynamic subtest: pipe-C-plane-1
[736.471911] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[736.482327] Starting dynamic subtest: pipe-C-plane-2
[736.639472] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[737.831686] Starting dynamic subtest: pipe-D-plane-0
[737.968916] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[737.979161] Starting dynamic subtest: pipe-D-plane-1
[738.123885] Dynamic subtest pipe-D-plane-1: SUCCESS (0.152s)
[738.134602] Starting dynamic subtest: pipe-D-plane-2
[738.279644] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[738.569896] Subtest plane-lut1d-ctm3x4: SUCCESS (5.789s)
[739.400798] [123/133] (284s left) gem_ctx_param (non-root-set)
[739.450934] Starting subtest: non-root-set
[739.467552] Subtest non-root-set: SUCCESS (0.017s)
[739.551447] [124/133] (283s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[739.641309] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[739.645915] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[739.732495] [125/133] (283s left) kms_lease (lease-uevent)
[739.823092] Starting subtest: lease-uevent
[740.833260] Subtest lease-uevent: SUCCESS (1.011s)
[740.955572] [126/133] (282s left) prime_mmap (test_correct_cpu_write)
[741.027616] Starting subtest: test_correct_cpu_write
[741.030326] Starting dynamic subtest: test_correct_cpu_write-smem
[741.032931] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[741.035697] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[741.120005] [127/133] (282s left) gem_ccs (block-copy-compressed)
[741.172079] Starting subtest: block-copy-compressed
[741.177456] Subtest block-copy-compressed: SKIP (0.000s)
[741.280136] [128/133] (282s left) gem_exec_balancer (parallel-keep-in-fence)
[741.539081] Starting subtest: parallel-keep-in-fence
[742.842768] Subtest parallel-keep-in-fence: SUCCESS (1.305s)
[742.964791] [129/133] (280s left) prime_vgem (basic-fence-blt)
[743.034599] Starting subtest: basic-fence-blt
[743.140978] Subtest basic-fence-blt: SUCCESS (0.106s)
[743.267843] [130/133] (280s left) kms_frontbuffer_tracking (fbc-suspend)
[743.368764] Starting subtest: fbc-suspend
[781.798910] Subtest fbc-suspend: SUCCESS (7.511s)
[782.988621] [131/133] (240s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[783.094777] Starting subtest: psr-dirtyfb-ioctl
[783.097079] Starting dynamic subtest: A-eDP-1
[787.007373] Dynamic subtest A-eDP-1: SUCCESS (3.916s)
[787.010082] Subtest psr-dirtyfb-ioctl: SUCCESS (3.917s)
[787.886549] [132/133] (235s left) api_intel_bb (object-reloc-purge-cache)
[787.941023] Starting subtest: object-reloc-purge-cache
[787.946704] Subtest object-reloc-purge-cache: SKIP (0.004s)
[788.059022] [133/133] (235s left) kms_draw_crc (draw-method-pwrite)
[788.155436] Starting subtest: draw-method-pwrite
[788.157811] Starting dynamic subtest: xrgb8888-untiled
[788.788661] Dynamic subtest xrgb8888-untiled: SUCCESS (0.633s)
[788.799158] Starting dynamic subtest: rgb565-untiled
[789.298306] Dynamic subtest rgb565-untiled: SUCCESS (0.509s)
[789.308489] Starting dynamic subtest: xrgb2101010-untiled
[789.909684] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.610s)
[789.920840] Starting dynamic subtest: xbgr16161616f-untiled
[790.731248] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.820s)
[790.741934] Starting dynamic subtest: xrgb8888-xtiled
[792.819420] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.088s)
[792.830168] Starting dynamic subtest: rgb565-xtiled
[794.163190] Dynamic subtest rgb565-xtiled: SUCCESS (1.343s)
[794.173893] Starting dynamic subtest: xrgb2101010-xtiled
[796.262671] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.098s)
[796.273159] Starting dynamic subtest: xbgr16161616f-xtiled
[799.939996] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.677s)
[799.950571] Starting dynamic subtest: xrgb8888-4tiled
[801.273067] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.332s)
[801.283958] Starting dynamic subtest: rgb565-4tiled
[801.950939] Dynamic subtest rgb565-4tiled: SUCCESS (0.677s)
[801.961203] Starting dynamic subtest: xrgb2101010-4tiled
[803.263071] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.309s)
[803.273872] Starting dynamic subtest: xbgr16161616f-4tiled
[806.627934] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.366s)
[806.630760] Subtest draw-method-pwrite: SUCCESS (18.479s)
[806.721728] Closing watchdogs
results: parsing output: 0/ for test: kms_sequence
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_busy
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_ctx_shared
results: parsing output: 21/ for test: gen7_exec_parse
results: parsing output: 22/ for test: gem_pipe_control_store_loop
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_spin_batch
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_ctx_exec
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: kms_pm_dc
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: gem_reg_read
results: parsing output: 36/ for test: kms_atomic
results: parsing output: 37/ for test: kms_psr2_su
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_lmem_swapping
results: parsing output: 40/ for test: gem_fenced_exec_thrash
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: kms_invalid_mode
results: parsing output: 49/ for test: kms_async_flips
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_pipe_crc_basic
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_render_tiled_blits
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: i915_pm_rps
results: parsing output: 68/ for test: syncobj_eventfd
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_pipe_stress
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: syncobj_basic
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_ctx_isolation
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_chamelium_edid
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: sysfs_timeslice_duration
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: vgem_slow
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_content_protection
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_cursor
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: gem_ccs
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_dirtyfb
results: parsing output: 131/ for test: api_intel_bb
results: parsing output: 132/ for test: kms_draw_crc
Done.