[56.558842] Initializing watchdogs
[56.558887]   /dev/watchdog0
[56.574326] [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]
[56.579212] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.581553] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.585114] [001/156] (960s left) gem_mmap_gtt (basic-small-copy)
[56.668649] Subtest basic-small-copy: SKIP (0.000s)
[56.722325] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[56.819797] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[56.824480] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[56.909165] [003/156] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[56.959722] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[56.962254] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[57.051884] [004/156] (960s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[57.106986] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[57.111668] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[57.309275] [005/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[57.409941] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[57.414240] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[57.522977] [006/156] (959s left) gem_lmem_swapping (heavy-verify-random)
[57.570217] Subtest heavy-verify-random: SKIP (0.000s)
[57.605680] [007/156] (959s left) gem_exec_whisper (basic-fds-priority)
[57.663813] Starting subtest: basic-fds-priority
[82.768295] Subtest basic-fds-priority: SUCCESS (25.101s)
[82.948712] [008/156] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[83.049864] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[90.442920] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.402s)
[90.589785] [009/156] (926s left) kms_flip (2x-flip-vs-panning-interruptible)
[90.687246] Starting subtest: 2x-flip-vs-panning-interruptible
[90.699108] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[90.783613] [010/156] (926s left) gem_exec_schedule (out-order)
[90.850544] Starting subtest: out-order
[90.853117] Starting dynamic subtest: rcs0
[90.949187] Dynamic subtest rcs0: SUCCESS (0.106s)
[90.960933] Starting dynamic subtest: vcs0
[91.034071] Dynamic subtest vcs0: SUCCESS (0.085s)
[91.046019] Starting dynamic subtest: vcs1
[91.118868] Dynamic subtest vcs1: SUCCESS (0.085s)
[91.130419] Starting dynamic subtest: vecs0
[91.207602] Dynamic subtest vecs0: SUCCESS (0.087s)
[91.222609] Starting dynamic subtest: ccs0
[91.294667] Dynamic subtest ccs0: SUCCESS (0.088s)
[91.297088] Subtest out-order: SUCCESS (0.452s)
[92.392703] [011/156] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[92.493873] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[92.499097] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.582065] [012/156] (924s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[92.690674] Starting subtest: psr-rgb565-draw-mmap-gtt
[92.695154] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[92.800995] [013/156] (924s left) gem_pxp (verify-pxp-stale-ctx-execution)
[92.931061] Starting subtest: verify-pxp-stale-ctx-execution
[93.991871] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.064s)
[94.111724] [014/156] (923s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[94.497663] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[95.363565] [015/156] (922s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[95.461779] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[96.585330] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.125s)
[96.726749] [016/156] (920s left) kms_lease (master-vs-lease)
[96.824218] Starting subtest: master-vs-lease
[96.826146] Subtest master-vs-lease: SUCCESS (0.001s)
[96.944199] [017/156] (920s left) kms_psr (psr2-sprite-render)
[97.040880] Starting subtest: psr2-sprite-render
[97.042952] Starting dynamic subtest: eDP-1
[98.774763] Dynamic subtest eDP-1: SUCCESS (1.732s)
[98.776648] Subtest psr2-sprite-render: SUCCESS (1.733s)
[99.637067] [018/156] (918s left) gem_exec_fence (syncobj-timeline-chain-engines)
[100.219685] Starting subtest: syncobj-timeline-chain-engines
[100.334812] Subtest syncobj-timeline-chain-engines: SUCCESS (0.115s)
[101.343076] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[101.346361] [019/156] (916s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[101.449869] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[101.454576] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[101.516219] [020/156] (916s left) kms_flip (modeset-vs-vblank-race-interruptible)
[101.623500] Starting subtest: modeset-vs-vblank-race-interruptible
[101.625924] Starting dynamic subtest: A-eDP1
[106.457828] Dynamic subtest A-eDP1: SUCCESS (4.833s)
[106.470869] Starting dynamic subtest: B-eDP1
[111.278794] Dynamic subtest B-eDP1: SUCCESS (4.820s)
[111.290736] Starting dynamic subtest: C-eDP1
[115.977961] Dynamic subtest C-eDP1: SUCCESS (4.697s)
[115.987068] Starting dynamic subtest: D-eDP1
[120.625958] Dynamic subtest D-eDP1: SUCCESS (4.647s)
[120.628355] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.007s)
[121.790899] [021/156] (896s left) syncobj_timeline (multi-wait-all-available-signaled)
[121.855595] Starting subtest: multi-wait-all-available-signaled
[121.858019] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[121.953373] [022/156] (895s left) gem_ctx_isolation (preservation-reset)
[122.118235] Starting subtest: preservation-reset
[122.120688] Starting dynamic subtest: rcs0
[122.395936] Dynamic subtest rcs0: SUCCESS (0.281s)
[122.407910] Starting dynamic subtest: bcs0
[122.723268] Dynamic subtest bcs0: SUCCESS (0.327s)
[122.735059] Starting dynamic subtest: vcs0
[123.060245] Dynamic subtest vcs0: SUCCESS (0.337s)
[123.072737] Starting dynamic subtest: vcs1
[124.613070] Dynamic subtest vcs1: SUCCESS (1.552s)
[124.623670] Starting dynamic subtest: vecs0
[126.568815] Dynamic subtest vecs0: SUCCESS (1.956s)
[126.578876] Starting dynamic subtest: ccs0
[128.654578] Dynamic subtest ccs0: SUCCESS (2.085s)
[128.657060] Subtest preservation-reset: SUCCESS (6.542s)
[128.802845] [023/156] (889s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[128.860351] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[128.917558] [024/156] (889s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[129.029185] Starting subtest: x-tiled-16bpp-rotate-270
[129.048749] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[129.165639] [025/156] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[129.266089] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[129.270278] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[129.347069] [026/156] (888s left) kms_frontbuffer_tracking (fbc-tiling-4)
[129.451307] Starting subtest: fbc-tiling-4
[133.686558] Subtest fbc-tiling-4: SUCCESS (4.240s)
[134.887194] [027/156] (883s left) api_intel_bb (simple-bb)
[134.941726] Starting subtest: simple-bb
[134.948298] Subtest simple-bb: SUCCESS (0.009s)
[135.060823] [028/156] (883s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[135.114840] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[135.117275] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[135.201817] [029/156] (882s left) device_reset (unbind-cold-reset-rebind)
[135.253803] Starting subtest: unbind-cold-reset-rebind
[135.258284] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[135.330702] [030/156] (882s left) kms_prop_blob (blob-prop-validate)
[135.382969] Starting subtest: blob-prop-validate
[135.385880] Subtest blob-prop-validate: SUCCESS (0.000s)
[135.470649] [031/156] (882s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[135.570297] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[135.574580] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[135.666238] [032/156] (882s left) gem_ppgtt (flink-and-close-vma-leak)
[135.728004] Starting subtest: flink-and-close-vma-leak
[135.769743] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[135.902554] [033/156] (882s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[136.008488] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[140.223286] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.219s)
[141.398942] [034/156] (877s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[141.446841] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[141.449326] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[141.528475] [035/156] (876s left) syncobj_wait (invalid-signal-one-illegal-handle)
[141.586061] Starting subtest: invalid-signal-one-illegal-handle
[141.588256] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[141.682557] [036/156] (876s left) kms_vrr (seamless-rr-switch-drrs)
[141.781291] Starting subtest: seamless-rr-switch-drrs
[141.787851] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[141.855339] [037/156] (876s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[141.954690] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[141.958829] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[142.043754] [038/156] (876s left) kms_psr (pr-primary-mmap-cpu)
[142.142664] Starting subtest: pr-primary-mmap-cpu
[142.146859] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[142.217251] [039/156] (876s left) kms_dp_link_training (non-uhbr-mst)
[142.310617] Starting subtest: non-uhbr-mst
[142.317753] Subtest non-uhbr-mst: SKIP (0.000s)
[142.378740] [040/156] (876s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[142.466130] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[142.467957] Starting dynamic subtest: pipe-A-eDP-1
[142.475519] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[142.490872] Starting dynamic subtest: pipe-B-eDP-1
[142.498279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[142.507218] Starting dynamic subtest: pipe-C-eDP-1
[142.514075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[142.522876] Starting dynamic subtest: pipe-D-eDP-1
[142.529740] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[142.533179] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[144.745133] [041/156] (873s left) gem_exec_async (forked-writes)
[144.801076] Starting subtest: forked-writes
[144.803419] Starting dynamic subtest: rcs0
[144.827933] Dynamic subtest rcs0: SUCCESS (0.027s)
[144.840721] Starting dynamic subtest: bcs0
[144.854494] Dynamic subtest bcs0: SUCCESS (0.026s)
[144.864350] Starting dynamic subtest: vcs0
[144.876767] Dynamic subtest vcs0: SUCCESS (0.022s)
[144.889301] Starting dynamic subtest: vcs1
[144.899945] Dynamic subtest vcs1: SUCCESS (0.023s)
[144.910213] Starting dynamic subtest: vecs0
[144.921527] Dynamic subtest vecs0: SUCCESS (0.021s)
[144.931735] Starting dynamic subtest: ccs0
[144.944519] Dynamic subtest ccs0: SUCCESS (0.022s)
[144.946704] Subtest forked-writes: SUCCESS (0.144s)
[145.188944] [042/156] (873s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[145.287703] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[145.292096] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[145.376313] [043/156] (873s left) gem_create (create-massive)
[145.422864] Starting subtest: create-massive
[145.425078] Subtest create-massive: SUCCESS (0.000s)
[145.604488] [044/156] (873s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[145.696992] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[145.701492] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[145.793045] [045/156] (873s left) gem_eio (in-flight-external)
[146.024435] Starting subtest: in-flight-external
[147.353373] Subtest in-flight-external: SUCCESS (1.327s)
[147.501240] [046/156] (871s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[147.621072] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[158.807328] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.178s)
[159.687082] [047/156] (859s left) kms_rotation_crc (primary-rotation-180)
[159.782995] Starting subtest: primary-rotation-180
[166.815043] Subtest primary-rotation-180: SUCCESS (7.033s)
[168.049589] [048/156] (850s left) kms_pm_backlight (basic-brightness)
[168.151713] Starting subtest: basic-brightness
[168.203384] Starting dynamic subtest: eDP-1
[168.704695] Dynamic subtest eDP-1: SUCCESS (0.503s)
[168.707111] Subtest basic-brightness: SUCCESS (0.555s)
[169.596074] [049/156] (849s left) kms_pipe_crc_basic (bad-source)
[169.683509] Starting subtest: bad-source
[169.685442] Subtest bad-source: SUCCESS (0.000s)
[169.762058] [050/156] (849s left) gem_mmap_gtt (basic-read-write-distinct)
[169.818644] Subtest basic-read-write-distinct: SKIP (0.000s)
[169.881599] [051/156] (849s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[169.970279] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[169.972507] Starting dynamic subtest: pipe-A-default-mode
[171.158885] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[171.163316] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.189s)
[171.318500] [052/156] (847s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[171.417796] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[171.421766] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[171.532557] [053/156] (847s left) gem_tiled_pread_basic (basic)
[171.585250] Subtest basic: SKIP (0.000s)
[171.650593] [054/156] (847s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[171.761036] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[171.765418] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[171.860779] [055/156] (847s left) perf_pmu (multi-client)
[171.900505] Starting subtest: multi-client
[171.902495] Starting dynamic subtest: rcs0
[172.972421] Dynamic subtest rcs0: SUCCESS (1.074s)
[172.982823] Starting dynamic subtest: bcs0
[174.021211] Dynamic subtest bcs0: SUCCESS (1.045s)
[174.034095] Starting dynamic subtest: vcs0
[175.073835] Dynamic subtest vcs0: SUCCESS (1.049s)
[175.086223] Starting dynamic subtest: vcs1
[176.316104] Dynamic subtest vcs1: SUCCESS (1.239s)
[176.327386] Starting dynamic subtest: vecs0
[178.301095] Dynamic subtest vecs0: SUCCESS (1.982s)
[178.312836] Starting dynamic subtest: ccs0
[180.290442] Dynamic subtest ccs0: SUCCESS (1.986s)
[180.293331] Subtest multi-client: SUCCESS (8.392s)
[180.411802] [056/156] (838s left) kms_busy (extended-pageflip-hang-oldfb)
[180.512967] Starting subtest: extended-pageflip-hang-oldfb
[180.515760] Starting dynamic subtest: pipe-A
[180.918449] Dynamic subtest pipe-A: SUCCESS (0.404s)
[180.928517] Starting dynamic subtest: pipe-D
[182.026122] Dynamic subtest pipe-D: SUCCESS (1.107s)
[182.028501] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.516s)
[182.880947] [057/156] (836s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[182.972253] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[182.984598] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[183.085771] [058/156] (836s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[183.185354] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[183.189611] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[183.298574] [059/156] (836s left) sw_sync (sync_busy)
[183.334624] Starting subtest: sync_busy
[183.336880] Subtest sync_busy: SUCCESS (0.002s)
[183.387265] [060/156] (836s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[183.478698] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[183.483054] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[183.547681] [061/156] (835s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[183.649189] Starting subtest: pipe-fbc-rte
[183.655965] Starting dynamic subtest: pipe-B-eDP-1
[189.152117] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.508s)
[189.159644] Subtest pipe-fbc-rte: SUCCESS (5.510s)
[191.430883] [062/156] (828s left) gem_ccs (block-copy-uncompressed)
[191.494082] Starting subtest: block-copy-uncompressed
[191.496347] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[191.512939] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[191.524297] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[191.530565] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[191.539915] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[191.547531] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[191.559442] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[191.564755] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[191.567063] Subtest block-copy-uncompressed: SUCCESS (0.074s)
[191.694918] [063/156] (827s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[191.793119] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[191.797156] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[191.900817] [064/156] (827s left) kms_force_connector_basic (prune-stale-modes)
[191.978779] Starting subtest: prune-stale-modes
[192.421492] Subtest prune-stale-modes: SUCCESS (0.445s)
[192.560365] [065/156] (827s left) kms_async_flips (alternate-sync-async-flip)
[192.648354] Starting subtest: alternate-sync-async-flip
[193.028886] Starting dynamic subtest: pipe-A-eDP-1
[195.819086] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.790s)
[196.196822] Starting dynamic subtest: pipe-B-eDP-1
[199.014936] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.826s)
[199.401719] Starting dynamic subtest: pipe-C-eDP-1
[202.209027] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.818s)
[202.576381] Starting dynamic subtest: pipe-D-eDP-1
[205.417571] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.849s)
[205.419745] Subtest alternate-sync-async-flip: SUCCESS (12.770s)
[206.653457] [066/156] (813s left) gem_exec_balancer (parallel-balancer)
[206.915395] Starting subtest: parallel-balancer
[207.841304] Subtest parallel-balancer: SUCCESS (0.928s)
[207.948063] [067/156] (811s left) i915_drm_fdinfo (basics)
[207.989059] Starting subtest: basics
[207.990932] Subtest basics: SUCCESS (0.000s)
[208.057344] [068/156] (811s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[208.163812] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[208.167968] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[208.262446] [069/156] (811s left) kms_force_connector_basic (force-connector-state)
[208.331825] Starting subtest: force-connector-state
[208.938243] Subtest force-connector-state: SUCCESS (0.609s)
[209.877509] [070/156] (810s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[209.988072] Starting subtest: fbcpsr-rgb101010-draw-blt
[214.706486] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.723s)
[214.837132] [071/156] (805s left) i915_query (query-topology-garbage-items)
[214.885717] Starting subtest: query-topology-garbage-items
[214.887928] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[214.970431] [072/156] (805s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[215.062829] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[215.066832] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[215.169561] [073/156] (804s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[215.281727] Starting subtest: basic-flip-after-cursor-atomic
[216.198255] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[217.046573] [074/156] (803s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[217.143584] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[217.155424] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[217.259723] [075/156] (802s left) perf_pmu (invalid-init)
[217.300767] Starting subtest: invalid-init
[217.302724] Subtest invalid-init: SUCCESS (0.000s)
[217.412573] [076/156] (802s left) kms_psr (fbc-pr-cursor-plane-move)
[217.498170] Starting subtest: fbc-pr-cursor-plane-move
[217.502125] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[217.569260] [077/156] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[217.673679] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[224.673293] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.002s)
[224.823352] [078/156] (795s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[224.875513] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[224.877920] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[224.987738] [079/156] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[225.085908] Starting subtest: psr-1p-primscrn-spr-indfb-move
[232.418204] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.337s)
[232.543226] [080/156] (787s left) gen9_exec_parse (bb-start-cmd)
[232.601800] Subtest bb-start-cmd: SKIP (0.000s)
[232.671836] [081/156] (787s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[232.777426] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[232.781489] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[232.852327] [082/156] (787s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[232.957088] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[232.961238] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[233.052766] [083/156] (787s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[233.137830] Starting subtest: fbc-psr-sprite-mmap-cpu
[233.139799] Starting dynamic subtest: eDP-1
[233.144114] Dynamic subtest eDP-1: SKIP (0.000s)
[233.148263] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[233.209930] [084/156] (787s left) kms_content_protection (dp-mst-lic-type-1)
[233.352893] Starting subtest: dp-mst-lic-type-1
[233.356773] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[233.467680] [085/156] (787s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[233.556495] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[233.559794] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[233.658727] [086/156] (786s left) i915_pm_freq_api (freq-basic-api)
[233.709133] Starting subtest: freq-basic-api
[233.711159] Starting dynamic subtest: gt0
[233.713244] Dynamic subtest gt0: SUCCESS (0.003s)
[233.725221] Starting dynamic subtest: gt1
[233.727046] Dynamic subtest gt1: SUCCESS (0.003s)
[233.728961] Subtest freq-basic-api: SUCCESS (0.008s)
[233.827661] [087/156] (786s left) kms_flip (blocking-wf_vblank)
[233.917752] Starting subtest: blocking-wf_vblank
[233.919811] Starting dynamic subtest: A-eDP1
[242.871203] Dynamic subtest A-eDP1: SUCCESS (8.953s)
[242.881073] Starting dynamic subtest: B-eDP1
[251.766053] Dynamic subtest B-eDP1: SUCCESS (8.893s)
[251.778543] Starting dynamic subtest: C-eDP1
[260.666880] Dynamic subtest C-eDP1: SUCCESS (8.898s)
[260.679044] Starting dynamic subtest: D-eDP1
[269.560838] Dynamic subtest D-eDP1: SUCCESS (8.892s)
[269.563296] Subtest blocking-wf_vblank: SUCCESS (35.646s)
[270.760044] [088/156] (749s left) kms_frontbuffer_tracking (psrhdr-suspend)
[270.874865] Starting subtest: psrhdr-suspend
[270.879018] Subtest psrhdr-suspend: SKIP (0.000s)
[270.980510] [089/156] (749s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[271.101688] Starting subtest: flip-vs-cursor-busy-crc-atomic
[271.814790] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.711s)
[272.662661] [090/156] (748s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[272.778532] Starting subtest: flip-vs-cursor-toggle
[281.968401] Subtest flip-vs-cursor-toggle: SUCCESS (9.190s)
[282.849526] [091/156] (737s left) kms_properties (get_properties-sanity-non-atomic)
[282.936059] Starting subtest: get_properties-sanity-non-atomic
[282.938306] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[283.011094] [092/156] (737s left) syncobj_eventfd (binary-wait-signaled)
[283.065500] Starting subtest: binary-wait-signaled
[283.067771] Subtest binary-wait-signaled: SUCCESS (0.000s)
[283.183656] [093/156] (737s left) kms_cdclk (plane-scaling)
[283.278942] Starting subtest: plane-scaling
[283.281242] Starting dynamic subtest: pipe-A-eDP-1
[283.569720] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[283.579990] Starting dynamic subtest: pipe-B-eDP-1
[283.584430] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[283.594262] Starting dynamic subtest: pipe-C-eDP-1
[283.598800] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[283.610637] Starting dynamic subtest: pipe-D-eDP-1
[283.614673] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[283.618606] Subtest plane-scaling: SKIP (0.296s)
[284.447159] [094/156] (736s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[284.545366] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[284.550024] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[284.635822] [095/156] (736s left) syncobj_wait (single-wait-signaled)
[284.683914] Starting subtest: single-wait-signaled
[284.685807] Subtest single-wait-signaled: SUCCESS (0.000s)
[284.789511] [096/156] (736s left) gem_exec_flush (basic-uc-rw-default)
[284.844247] Starting subtest: basic-uc-rw-default
[290.300237] Subtest basic-uc-rw-default: SUCCESS (5.456s)
[290.493146] [097/156] (730s left) gem_mmap_gtt (flink-race)
[290.552882] Subtest flink-race: SKIP (0.000s)
[290.620530] [098/156] (730s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[290.676575] Starting subtest: wait-all-for-submit-delayed-submit
[290.781379] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[290.860421] [099/156] (730s left) kms_atomic_transition (modeset-transition-fencing)
[290.960821] Starting subtest: modeset-transition-fencing
[290.963483] Starting dynamic subtest: 1x-outputs
[301.820319] Dynamic subtest 1x-outputs: SUCCESS (10.862s)
[301.822768] Subtest modeset-transition-fencing: SUCCESS (10.863s)
[302.651815] [100/156] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[302.753044] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[302.757487] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[302.851900] [101/156] (718s left) gem_exec_fence (syncobj-wait)
[303.292148] Starting subtest: syncobj-wait
[304.358195] Subtest syncobj-wait: SUCCESS (1.065s)
[304.715310] [102/156] (716s left) gem_exec_balancer (sliced)
[304.765375] Starting subtest: sliced
[304.769547] Subtest sliced: SKIP (0.000s)
[305.061604] [103/156] (716s left) kms_cursor_legacy (forked-bo)
[305.176469] Starting subtest: forked-bo
[305.178738] Starting dynamic subtest: pipe-A
[310.642045] Dynamic subtest pipe-A: SUCCESS (5.462s)
[310.658634] Starting dynamic subtest: pipe-B
[316.110370] Dynamic subtest pipe-B: SUCCESS (5.466s)
[316.120884] Starting dynamic subtest: pipe-C
[321.589053] Dynamic subtest pipe-C: SUCCESS (5.476s)
[321.601583] Starting dynamic subtest: pipe-D
[327.064601] Dynamic subtest pipe-D: SUCCESS (5.474s)
[327.077077] Starting dynamic subtest: all-pipes
[332.566280] Dynamic subtest all-pipes: SUCCESS (5.498s)
[332.568856] Subtest forked-bo: SUCCESS (27.388s)
[332.709720] [104/156] (688s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[332.807090] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[333.788063] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.981s)
[333.933054] [105/156] (687s left) kms_pipe_crc_basic (read-crc)
[334.024274] Starting subtest: read-crc
[334.026532] Starting dynamic subtest: pipe-A-eDP-1
[334.750619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[334.760755] Starting dynamic subtest: pipe-B-eDP-1
[336.187028] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[336.197885] Starting dynamic subtest: pipe-C-eDP-1
[337.536634] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[337.547047] Starting dynamic subtest: pipe-D-eDP-1
[338.846757] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[338.849186] Subtest read-crc: SUCCESS (4.824s)
[339.740361] [106/156] (681s left) kms_invalid_mode (bad-vtotal)
[339.828936] Starting subtest: bad-vtotal
[339.831528] Starting dynamic subtest: pipe-A-eDP-1
[340.132401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[340.142619] Starting dynamic subtest: pipe-B-eDP-1
[340.144943] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[340.154587] Starting dynamic subtest: pipe-C-eDP-1
[340.156985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[340.166238] Starting dynamic subtest: pipe-D-eDP-1
[340.168695] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[340.171135] Subtest bad-vtotal: SUCCESS (0.311s)
[340.944573] [107/156] (680s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[341.039508] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[341.043930] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[341.111526] [108/156] (680s left) syncobj_basic (create-signaled)
[341.160780] Starting subtest: create-signaled
[341.162582] Subtest create-signaled: SUCCESS (0.000s)
[341.284597] [109/156] (680s left) i915_pm_rpm (gem-pread)
[343.520901] Starting subtest: gem-pread
[345.299035] Subtest gem-pread: SUCCESS (1.782s)
[345.388585] [110/156] (676s left) sysfs_heartbeat_interval (precise)
[345.441756] Starting subtest: precise
[345.444210] Starting dynamic subtest: vecs0
[353.282479] Dynamic subtest vecs0: SUCCESS (7.840s)
[353.298268] Starting dynamic subtest: ccs0
[354.414756] Dynamic subtest ccs0: SUCCESS (1.129s)
[354.427738] Starting dynamic subtest: vcs0
[362.311123] Dynamic subtest vcs0: SUCCESS (7.893s)
[362.324243] Starting dynamic subtest: bcs0
[363.394756] Dynamic subtest bcs0: SUCCESS (1.084s)
[363.407653] Starting dynamic subtest: rcs0
[364.534547] Dynamic subtest rcs0: SUCCESS (1.138s)
[364.547601] Starting dynamic subtest: vcs1
[372.294314] Dynamic subtest vcs1: SUCCESS (7.758s)
[372.296831] Subtest precise: SUCCESS (26.854s)
[372.391373] [111/156] (649s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[372.500076] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[372.504590] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[372.615316] [112/156] (649s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[372.707281] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[372.711461] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[372.809795] [113/156] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[372.907056] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[372.911614] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[373.003687] [114/156] (648s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[373.104737] Starting subtest: plane-ctm3x4-lut1d
[373.273255] Starting dynamic subtest: pipe-A-plane-0
[373.473252] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[373.483585] Starting dynamic subtest: pipe-A-plane-1
[373.650723] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[373.660540] Starting dynamic subtest: pipe-A-plane-2
[373.839548] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[375.054317] Starting dynamic subtest: pipe-B-plane-0
[375.210032] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[375.221189] Starting dynamic subtest: pipe-B-plane-1
[375.376314] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[375.387387] Starting dynamic subtest: pipe-B-plane-2
[375.566843] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[376.818175] Starting dynamic subtest: pipe-C-plane-0
[376.963054] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[376.974524] Starting dynamic subtest: pipe-C-plane-1
[377.118187] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[377.128740] Starting dynamic subtest: pipe-C-plane-2
[377.264178] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[378.517845] Starting dynamic subtest: pipe-D-plane-0
[378.654979] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[378.665484] Starting dynamic subtest: pipe-D-plane-1
[378.797550] Dynamic subtest pipe-D-plane-1: SUCCESS (0.142s)
[378.808171] Starting dynamic subtest: pipe-D-plane-2
[378.964118] Dynamic subtest pipe-D-plane-2: SUCCESS (0.165s)
[379.251253] Subtest plane-ctm3x4-lut1d: SUCCESS (6.145s)
[380.138501] [115/156] (641s left) gem_userptr_blits (process-exit)
[380.206643] Starting subtest: process-exit
[380.215959] Subtest process-exit: SUCCESS (0.011s)
[380.344528] [116/156] (641s left) kms_atomic_transition (plane-all-transition-fencing)
[380.443174] Starting subtest: plane-all-transition-fencing
[380.445435] Starting dynamic subtest: pipe-A-eDP-1
[382.937947] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[383.245935] Starting dynamic subtest: pipe-B-eDP-1
[386.548156] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.312s)
[386.869601] Subtest plane-all-transition-fencing: SUCCESS (6.426s)
[387.733286] [117/156] (634s left) syncobj_timeline (single-wait-signaled)
[387.795096] Starting subtest: single-wait-signaled
[387.797560] Subtest single-wait-signaled: SUCCESS (0.000s)
[387.905666] [118/156] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[388.003730] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[388.007705] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[388.109312] [119/156] (633s left) kms_sequence (get-forked-busy)
[388.204979] Starting subtest: get-forked-busy
[388.207316] Starting dynamic subtest: pipe-A-eDP-1
[390.141642] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[390.153547] Starting dynamic subtest: pipe-B-eDP-1
[392.788218] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[392.799701] Starting dynamic subtest: pipe-C-eDP-1
[395.383276] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.595s)
[395.395837] Starting dynamic subtest: pipe-D-eDP-1
[397.990885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s)
[397.993175] Subtest get-forked-busy: SUCCESS (9.787s)
[398.825990] [120/156] (623s left) kms_chamelium_frames (hdmi-aspect-ratio)
[399.217660] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[400.012643] [121/156] (622s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[400.122286] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[400.126199] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.211094] [122/156] (621s left) kms_pm_rpm (i2c)
[402.440230] Starting subtest: i2c
[407.837968] Subtest i2c: SUCCESS (5.396s)
[407.937551] [123/156] (614s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[407.992078] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[408.098346] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[408.187111] [124/156] (613s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[408.300220] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[408.304675] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[408.394857] [125/156] (613s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[408.598433] Starting subtest: cursor-rapid-movement-64x21
[408.645045] Subtest cursor-rapid-movement-64x21: SKIP (0.041s)
[408.898753] [126/156] (613s left) gem_vm_create (execbuf)
[408.954364] Starting subtest: execbuf
[408.957921] Subtest execbuf: SUCCESS (0.006s)
[409.080573] [127/156] (613s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[409.180903] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[409.184540] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[409.280309] [128/156] (613s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[409.379397] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[409.382813] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[409.484779] [129/156] (612s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[409.582433] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[409.584144] Starting dynamic subtest: A-eDP1
[413.254319] Dynamic subtest A-eDP1: SUCCESS (3.672s)
[413.265388] Starting dynamic subtest: B-eDP1
[416.557916] Dynamic subtest B-eDP1: SUCCESS (3.301s)
[416.568580] Starting dynamic subtest: C-eDP1
[419.764696] Dynamic subtest C-eDP1: SUCCESS (3.206s)
[419.776219] Starting dynamic subtest: D-eDP1
[422.999203] Dynamic subtest D-eDP1: SUCCESS (3.233s)
[423.001493] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.419s)
[423.801819] [130/156] (598s left) kms_cursor_crc (cursor-offscreen-512x512)
[424.106164] Starting subtest: cursor-offscreen-512x512
[424.110596] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[424.268377] [131/156] (598s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[424.357257] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[424.359552] Starting dynamic subtest: pipe-A-eDP-1
[424.380106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[424.394191] Starting dynamic subtest: pipe-B-eDP-1
[424.413965] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[424.423513] Starting dynamic subtest: pipe-C-eDP-1
[424.443025] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[424.452181] Starting dynamic subtest: pipe-D-eDP-1
[424.471663] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[424.473570] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[426.668800] [132/156] (595s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[426.768499] Starting subtest: bad-pixel-format-y-tiled-ccs
[426.770811] Starting dynamic subtest: pipe-A-eDP-1
[426.793877] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.806820] Starting dynamic subtest: pipe-B-eDP-1
[426.828378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.838826] Starting dynamic subtest: pipe-C-eDP-1
[426.861684] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.874554] Starting dynamic subtest: pipe-D-eDP-1
[426.898605] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.903119] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[429.030065] [133/156] (593s left) gem_render_tiled_blits (basic)
[429.107584] Subtest basic: SKIP (0.000s)
[429.177138] [134/156] (593s left) gem_ctx_persistence (saturated-hostile)
[429.227685] Starting subtest: saturated-hostile
[429.230112] Starting dynamic subtest: rcs0
[430.045606] Dynamic subtest rcs0: SUCCESS (0.816s)
[430.060046] Starting dynamic subtest: bcs0
[430.837265] Dynamic subtest bcs0: SUCCESS (0.789s)
[430.855479] Starting dynamic subtest: vcs0
[431.631735] Dynamic subtest vcs0: SUCCESS (0.791s)
[431.645649] Starting dynamic subtest: vcs1
[432.436497] Dynamic subtest vcs1: SUCCESS (0.803s)
[432.449312] Starting dynamic subtest: vecs0
[433.250332] Dynamic subtest vecs0: SUCCESS (0.812s)
[433.261694] Starting dynamic subtest: ccs0
[434.092054] Dynamic subtest ccs0: SUCCESS (0.839s)
[434.094996] Subtest saturated-hostile: SUCCESS (4.865s)
[434.180727] [135/156] (588s left) kms_psr (fbc-psr2-suspend)
[434.273986] Starting subtest: fbc-psr2-suspend
[434.276308] Starting dynamic subtest: eDP-1
[434.280683] Dynamic subtest eDP-1: SKIP (0.000s)
[434.285122] Subtest fbc-psr2-suspend: SKIP (0.001s)
[434.349915] [136/156] (588s left) gem_lmem_swapping (parallel-random-verify-ccs)
[434.392616] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[434.436105] [137/156] (588s left) kms_fb_coherency (memset-crc)
[434.524497] Starting subtest: memset-crc
[434.526399] Starting dynamic subtest: mmap-offset-wc
[434.913110] Dynamic subtest mmap-offset-wc: SUCCESS (0.388s)
[435.222599] Starting dynamic subtest: mmap-offset-uc
[441.410194] Dynamic subtest mmap-offset-uc: SUCCESS (6.196s)
[441.687090] Subtest memset-crc: SUCCESS (7.164s)
[442.507674] [138/156] (580s left) gem_render_copy (x-tiled)
[442.582052] Starting subtest: x-tiled
[442.584538] Starting dynamic subtest: smem
[442.625776] Dynamic subtest smem: SUCCESS (0.044s)
[442.628283] Subtest x-tiled: SUCCESS (0.044s)
[442.868113] [139/156] (579s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[442.968520] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[443.814906] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[443.980234] [140/156] (578s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[444.086366] Starting subtest: psr-1p-pri-indfb-multidraw
[467.191307] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.112s)
[467.321275] [141/156] (555s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[467.422578] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[467.425981] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[467.516139] [142/156] (555s left) gem_partial_pwrite_pread (write)
[467.575475] Subtest write: SKIP (0.000s)
[467.650893] [143/156] (555s left) kms_plane_lowres (tiling-y)
[467.736319] Starting subtest: tiling-y
[467.739721] Subtest tiling-y: SKIP (0.000s)
[467.822139] [144/156] (555s left) kms_plane_scaling (planes-downscale-factor-0-75)
[467.909496] Starting subtest: planes-downscale-factor-0-75
[467.911515] Starting dynamic subtest: pipe-A
[467.931301] Dynamic subtest pipe-A: SKIP (0.018s)
[467.941230] Starting dynamic subtest: pipe-B
[467.964165] Dynamic subtest pipe-B: SKIP (0.032s)
[467.973895] Starting dynamic subtest: pipe-C
[467.996168] Dynamic subtest pipe-C: SKIP (0.032s)
[468.005574] Starting dynamic subtest: pipe-D
[468.027690] Dynamic subtest pipe-D: SKIP (0.031s)
[468.030702] Subtest planes-downscale-factor-0-75: SKIP (0.117s)
[468.148531] [145/156] (554s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[468.236984] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[468.240726] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.335934] [146/156] (554s left) gem_exec_params (secure-non-root)
[468.397981] Starting subtest: secure-non-root
[468.401647] Subtest secure-non-root: SKIP (0.000s)
[468.504430] [147/156] (554s left) api_intel_allocator (reloc-allocator)
[468.548466] Starting subtest: reloc-allocator
[468.550119] Starting dynamic subtest: basic
[468.554112] Dynamic subtest basic: SUCCESS (0.005s)
[468.564466] Starting dynamic subtest: parallel-one
[468.566071] Dynamic subtest parallel-one: SUCCESS (0.007s)
[468.576540] Starting dynamic subtest: print
[468.578413] Dynamic subtest print: SUCCESS (0.000s)
[468.587363] Starting dynamic subtest: reuse
[468.588995] Dynamic subtest reuse: SUCCESS (0.000s)
[468.597960] Starting dynamic subtest: fork-reopen-allocator
[468.599570] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[468.601144] Subtest reloc-allocator: SUCCESS (0.029s)
[468.699693] [148/156] (554s left) kms_psr (psr-sprite-mmap-gtt)
[468.785410] Starting subtest: psr-sprite-mmap-gtt
[468.787370] Starting dynamic subtest: eDP-1
[470.217668] Dynamic subtest eDP-1: SKIP (1.428s)
[470.222983] Subtest psr-sprite-mmap-gtt: SKIP (1.430s)
[470.365274] [149/156] (552s left) gem_exec_params (sol-reset-invalid)
[470.415332] Starting subtest: sol-reset-invalid
[470.420569] Subtest sol-reset-invalid: SUCCESS (0.003s)
[472.394602] [150/156] (550s left) gem_pxp (create-valid-protected-context)
[472.497937] Starting subtest: create-valid-protected-context
[472.500411] Subtest create-valid-protected-context: SUCCESS (0.001s)
[472.603750] [151/156] (550s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[472.702166] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[472.704393] Starting dynamic subtest: pipe-A-eDP-1
[472.762691] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[472.773161] Starting dynamic subtest: pipe-B-eDP-1
[472.830539] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[472.841242] Starting dynamic subtest: pipe-C-eDP-1
[472.899669] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[472.913454] Starting dynamic subtest: pipe-D-eDP-1
[472.973066] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[472.977759] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[475.031472] [152/156] (548s left) gem_exec_schedule (semaphore-resolve)
[475.097274] Starting subtest: semaphore-resolve
[475.141439] Subtest semaphore-resolve: SUCCESS (0.052s)
[475.486315] [153/156] (547s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[475.588109] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[475.592555] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[475.673433] [154/156] (547s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[475.775680] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[475.780168] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[475.871732] [155/156] (547s left) kms_vblank (wait-forked)
[475.959244] Starting subtest: wait-forked
[475.961060] Starting dynamic subtest: pipe-A-eDP-1
[477.766832] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[477.785667] Starting dynamic subtest: pipe-D-eDP-1
[480.317734] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[480.319781] Subtest wait-forked: SUCCESS (4.358s)
[481.185476] [156/156] (542s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[481.281753] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[481.286208] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[481.374171] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_ctx_isolation
results: parsing output: 22/ for test: kms_pipe_b_c_ivb
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: device_reset
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_dp_link_training
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_exec_async
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_pm_backlight
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_tiled_pread_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_busy
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_force_connector_basic
results: parsing output: 64/ for test: kms_async_flips
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_force_connector_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: i915_pm_freq_api
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: syncobj_eventfd
results: parsing output: 92/ for test: kms_cdclk
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_exec_flush
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: sysfs_heartbeat_interval
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_sequence
results: parsing output: 119/ for test: kms_chamelium_frames
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_vm_create
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_render_tiled_blits
results: parsing output: 133/ for test: gem_ctx_persistence
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: gem_lmem_swapping
results: parsing output: 136/ for test: kms_fb_coherency
results: parsing output: 137/ for test: gem_render_copy
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_partial_pwrite_pread
results: parsing output: 142/ for test: kms_plane_lowres
results: parsing output: 143/ for test: kms_plane_scaling
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_params
results: parsing output: 146/ for test: api_intel_allocator
results: parsing output: 147/ for test: kms_psr
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: gem_pxp
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_vblank
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.