[57.529549] Initializing watchdogs
[57.529632]   /dev/watchdog0
[57.544364] [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.548640] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.551237] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.554509] [001/156] (960s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[57.636524] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[57.697682] [002/156] (960s left) gem_exec_fence (syncobj-invalid-flags)
[58.145673] Starting subtest: syncobj-invalid-flags
[58.148758] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[59.348066] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[59.351164] [003/156] (958s left) gem_exec_reloc (basic-wc-active)
[59.409612] Subtest basic-wc-active: SKIP (0.000s)
[59.477701] [004/156] (958s left) syncobj_timeline (invalid-wait-illegal-handle)
[59.538963] Starting subtest: invalid-wait-illegal-handle
[59.541412] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[59.659532] [005/156] (958s left) gen9_exec_parse (cmd-crossing-page)
[59.711814] Subtest cmd-crossing-page: SKIP (0.000s)
[59.796792] [006/156] (958s left) kms_frontbuffer_tracking (fbc-suspend)
[59.896835] Starting subtest: fbc-suspend
[98.571555] Subtest fbc-suspend: SUCCESS (7.847s)
[99.770098] [007/156] (918s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[99.921583] Starting subtest: multiplane-atomic-fence-wait
[100.165950] Subtest multiplane-atomic-fence-wait: SUCCESS (0.244s)
[101.274698] [008/156] (917s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[101.379227] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[101.383558] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[101.490221] [009/156] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[101.587748] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[101.591860] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[101.690246] [010/156] (916s left) kms_plane_alpha_blend (constant-alpha-mid)
[101.788190] Starting subtest: constant-alpha-mid
[102.068018] Starting dynamic subtest: pipe-A-eDP-1
[102.821375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[102.830577] Starting dynamic subtest: pipe-D-eDP-1
[104.349528] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[104.351849] Subtest constant-alpha-mid: SUCCESS (2.564s)
[105.239025] [011/156] (913s left) kms_flip (2x-busy-flip)
[105.331050] Starting subtest: 2x-busy-flip
[105.341787] Subtest 2x-busy-flip: SKIP (0.010s)
[105.433870] [012/156] (913s left) gem_exec_capture (capture)
[105.487259] Starting subtest: capture
[105.489575] Starting dynamic subtest: rcs0-smem
[106.302010] Dynamic subtest rcs0-smem: SUCCESS (0.813s)
[106.312830] Starting dynamic subtest: bcs0-smem
[107.106930] Dynamic subtest bcs0-smem: SUCCESS (0.807s)
[107.115254] Starting dynamic subtest: vcs0-smem
[107.899786] Dynamic subtest vcs0-smem: SUCCESS (0.793s)
[107.911019] Starting dynamic subtest: vcs1-smem
[108.698856] Dynamic subtest vcs1-smem: SUCCESS (0.800s)
[108.710226] Starting dynamic subtest: vecs0-smem
[110.104398] Dynamic subtest vecs0-smem: FAIL (1.347s)
[110.114062] Starting dynamic subtest: ccs0-smem
[111.367796] Dynamic subtest ccs0-smem: SUCCESS (1.321s)
[111.370263] Subtest capture: FAIL (5.883s)
[111.491029] [013/156] (907s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[111.594373] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[111.598509] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[111.659917] [014/156] (906s left) gem_exec_balancer (invalid-bonds)
[111.718416] Starting subtest: invalid-bonds
[111.722907] Subtest invalid-bonds: SKIP (0.000s)
[112.039237] [015/156] (906s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt)
[112.139876] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt
[112.144254] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[112.249596] [016/156] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[112.345005] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[112.349769] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[112.454681] [017/156] (906s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[112.553523] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[112.555701] Starting dynamic subtest: pipe-A-eDP-1
[112.575814] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[112.585960] Starting dynamic subtest: pipe-B-eDP-1
[112.604501] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[112.612779] Starting dynamic subtest: pipe-C-eDP-1
[112.631978] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[112.641104] Starting dynamic subtest: pipe-D-eDP-1
[112.660529] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[112.662398] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[114.809660] [018/156] (903s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[114.908703] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[114.912746] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[114.999098] [019/156] (903s left) gem_eio (wait-wedge-immediate)
[115.184263] Starting subtest: wait-wedge-immediate
[116.209103] Subtest wait-wedge-immediate: SUCCESS (1.025s)
[116.356906] [020/156] (902s left) kms_force_connector_basic (force-edid)
[116.424531] Starting subtest: force-edid
[116.794648] Subtest force-edid: SUCCESS (0.370s)
[116.931505] [021/156] (901s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[117.028486] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[117.032951] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[117.137556] [022/156] (901s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[117.243439] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[117.247107] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[117.360009] [023/156] (901s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render)
[117.448075] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render
[117.451556] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[117.542306] [024/156] (901s left) sysfs_heartbeat_interval (precise)
[117.590488] Starting subtest: precise
[117.592009] Starting dynamic subtest: vecs0
[125.109217] Dynamic subtest vecs0: SUCCESS (7.520s)
[125.120452] Starting dynamic subtest: ccs0
[126.202072] Dynamic subtest ccs0: SUCCESS (1.095s)
[126.213882] Starting dynamic subtest: vcs0
[134.134747] Dynamic subtest vcs0: SUCCESS (7.928s)
[134.147913] Starting dynamic subtest: bcs0
[135.257989] Dynamic subtest bcs0: SUCCESS (1.122s)
[135.268847] Starting dynamic subtest: rcs0
[136.361913] Dynamic subtest rcs0: SUCCESS (1.103s)
[136.373112] Starting dynamic subtest: vcs1
[144.113953] Dynamic subtest vcs1: SUCCESS (7.747s)
[144.116382] Subtest precise: SUCCESS (26.521s)
[144.187748] [025/156] (874s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[144.290415] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[144.295097] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[144.360513] [026/156] (874s left) gem_ccs (block-copy-uncompressed)
[144.421593] Starting subtest: block-copy-uncompressed
[144.423875] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[144.443715] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[144.454257] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[144.462916] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[144.472072] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[144.479904] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[144.488471] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[144.497882] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[144.500248] Subtest block-copy-uncompressed: SUCCESS (0.077s)
[144.625172] [027/156] (874s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[144.728723] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[144.732745] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[144.845255] [028/156] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[144.952619] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[144.956778] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[145.045153] [029/156] (874s left) api_intel_bb (full-batch)
[145.108263] Starting subtest: full-batch
[145.112940] Subtest full-batch: SUCCESS (0.005s)
[145.247131] [030/156] (874s left) kms_plane (pixel-format-x-tiled-modifier)
[145.330467] Starting subtest: pixel-format-x-tiled-modifier
[145.357439] Starting dynamic subtest: pipe-A-plane-0
[145.734702] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s)
[145.744756] Starting dynamic subtest: pipe-A-plane-3
[146.035696] Dynamic subtest pipe-A-plane-3: SUCCESS (0.300s)
[146.049090] Starting dynamic subtest: pipe-A-plane-5
[146.053085] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[147.188016] Starting dynamic subtest: pipe-B-plane-0
[147.567966] Dynamic subtest pipe-B-plane-0: SUCCESS (0.389s)
[147.578115] Starting dynamic subtest: pipe-B-plane-3
[147.879165] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[147.887990] Starting dynamic subtest: pipe-B-plane-5
[147.893982] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[148.187467] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.857s)
[149.033172] [031/156] (870s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[149.125763] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[149.128047] Starting dynamic subtest: pipe-A-default-mode
[151.817636] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[151.819763] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.691s)
[152.625893] [032/156] (866s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[152.683860] Starting subtest: y-tiled-ccs-to-yf-tiled
[152.687848] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[152.865987] [033/156] (866s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[152.958445] Starting subtest: compare-crc-sanitycheck-nv12
[152.960851] Starting dynamic subtest: pipe-A-eDP-1
[153.652317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[153.666278] Starting dynamic subtest: pipe-B-eDP-1
[154.993000] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[155.003798] Starting dynamic subtest: pipe-C-eDP-1
[156.208807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[156.218819] Starting dynamic subtest: pipe-D-eDP-1
[157.426052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[157.427984] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.468s)
[158.247086] [034/156] (861s left) gem_eio (in-flight-internal-10ms)
[158.457437] Starting subtest: in-flight-internal-10ms
[160.181572] Subtest in-flight-internal-10ms: SUCCESS (1.724s)
[160.314957] [035/156] (859s left) gem_render_tiled_blits (basic)
[160.377085] Subtest basic: SKIP (0.000s)
[160.447582] [036/156] (859s left) perf (gen12-invalid-class-instance)
[160.579870] Starting subtest: gen12-invalid-class-instance
[160.592396] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[160.660278] [037/156] (858s left) kms_pm_rpm (modeset-non-lpsp-stress)
[162.207418] Starting subtest: modeset-non-lpsp-stress
[163.361581] Subtest modeset-non-lpsp-stress: SKIP (1.152s)
[163.738649] [038/156] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[163.836413] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[170.491731] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.661s)
[170.613955] [039/156] (849s left) prime_mmap (test_invalid_sync_flags)
[170.680455] Starting subtest: test_invalid_sync_flags
[170.682847] Starting dynamic subtest: test_invalid_sync_flags-smem
[170.685011] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[170.687202] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[170.772591] [040/156] (848s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[170.856708] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[170.861270] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[172.026513] [041/156] (847s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[172.124896] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[172.129022] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.229782] [042/156] (847s left) syncobj_wait (invalid-reset-zero-handles)
[172.288467] Starting subtest: invalid-reset-zero-handles
[172.290414] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[172.396818] [043/156] (847s left) kms_psr (psr-cursor-render)
[172.485266] Starting subtest: psr-cursor-render
[172.487699] Starting dynamic subtest: eDP-1
[174.181964] Dynamic subtest eDP-1: SUCCESS (1.697s)
[174.184294] Subtest psr-cursor-render: SUCCESS (1.698s)
[175.028696] [044/156] (844s left) kms_universal_plane (universal-plane-functional)
[175.128411] Starting subtest: universal-plane-functional
[175.130401] Starting dynamic subtest: pipe-A-eDP-1
[178.949938] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.824s)
[178.960422] Starting dynamic subtest: pipe-B-eDP-1
[183.451269] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.499s)
[183.460731] Starting dynamic subtest: pipe-C-eDP-1
[187.636719] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.185s)
[187.646543] Starting dynamic subtest: pipe-D-eDP-1
[191.918779] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.284s)
[191.921227] Subtest universal-plane-functional: SUCCESS (16.797s)
[192.722349] [045/156] (827s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[192.827995] Starting subtest: pr-primary-plane-update-sf-dmg-area
[192.832214] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[192.897845] [046/156] (827s left) gem_exec_create (forked)
[192.953169] Starting subtest: forked
[192.955471] Starting dynamic subtest: smem
[214.138158] Dynamic subtest smem: SUCCESS (21.177s)
[214.141385] Subtest forked: SUCCESS (21.179s)
[214.323670] [047/156] (805s left) gem_exec_schedule (implicit-read-write)
[214.393016] Starting subtest: implicit-read-write
[214.395351] Starting dynamic subtest: rcs0
[214.541981] Dynamic subtest rcs0: SUCCESS (0.159s)
[214.551365] Starting dynamic subtest: vcs0
[214.649045] Dynamic subtest vcs0: SUCCESS (0.105s)
[214.660203] Starting dynamic subtest: vcs1
[214.759110] Dynamic subtest vcs1: SUCCESS (0.111s)
[214.771207] Starting dynamic subtest: vecs0
[214.859751] Dynamic subtest vecs0: SUCCESS (0.100s)
[214.871406] Starting dynamic subtest: ccs0
[214.991856] Dynamic subtest ccs0: SUCCESS (0.130s)
[214.994892] Subtest implicit-read-write: SUCCESS (0.608s)
[216.205659] [048/156] (803s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[216.261400] Starting subtest: x-tiled-to-vebox-y-tiled
[216.265950] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[216.446012] [049/156] (803s left) kms_atomic_interruptible (legacy-setmode)
[216.535192] Starting subtest: legacy-setmode
[216.537527] Starting dynamic subtest: pipe-A-eDP-1
[223.411439] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.876s)
[223.413863] Subtest legacy-setmode: SUCCESS (6.877s)
[224.219566] [050/156] (795s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[224.320485] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[224.324715] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[224.437356] [051/156] (795s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[224.532396] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[224.536521] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[224.630156] [052/156] (795s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[224.716202] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[224.720098] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[224.794558] [053/156] (795s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[224.899381] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[224.903772] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[224.997857] [054/156] (795s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[225.090675] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite
[225.095112] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[225.193926] [055/156] (795s left) prime_vgem (basic-gtt)
[225.272109] Starting subtest: basic-gtt
[225.276121] Subtest basic-gtt: SKIP (0.000s)
[225.380573] [056/156] (794s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[225.480654] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[225.484140] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[225.574771] [057/156] (794s left) kms_cursor_crc (cursor-random-128x42)
[225.799582] Starting subtest: cursor-random-128x42
[225.843400] Subtest cursor-random-128x42: SKIP (0.040s)
[226.053870] [058/156] (794s left) gem_userptr_blits (sd-probe)
[226.111931] Starting subtest: sd-probe
[226.113637] Subtest sd-probe: SUCCESS (0.000s)
[226.247353] [059/156] (794s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[226.303338] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[226.305195] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[226.417263] [060/156] (794s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[226.510118] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[226.513779] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[226.610414] [061/156] (793s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[226.707777] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[226.711302] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[226.776543] [062/156] (793s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[226.871258] Starting subtest: fbc-rgb101010-draw-pwrite
[230.198574] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.331s)
[231.342490] [063/156] (789s left) kms_addfb_basic (bad-pitch-63)
[231.400096] Starting subtest: bad-pitch-63
[231.402084] Subtest bad-pitch-63: SUCCESS (0.000s)
[231.536554] [064/156] (789s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[231.631171] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[231.633122] Starting dynamic subtest: pipe-A
[231.967751] Dynamic subtest pipe-A: SUCCESS (0.339s)
[231.985054] Starting dynamic subtest: pipe-B
[233.376609] Dynamic subtest pipe-B: SUCCESS (1.407s)
[233.386735] Starting dynamic subtest: pipe-C
[234.786542] Dynamic subtest pipe-C: SUCCESS (1.409s)
[234.797106] Starting dynamic subtest: pipe-D
[236.193686] Dynamic subtest pipe-D: SUCCESS (1.406s)
[236.195997] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.567s)
[237.420191] [065/156] (783s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[237.521971] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[237.526670] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[238.635862] [066/156] (782s left) kms_cursor_crc (cursor-dpms)
[238.756917] Starting subtest: cursor-dpms
[238.759189] Starting dynamic subtest: pipe-A-eDP-1
[241.725028] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.963s)
[241.735000] Starting dynamic subtest: pipe-D-eDP-1
[245.406726] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.682s)
[245.408935] Subtest cursor-dpms: SUCCESS (6.648s)
[246.222544] [067/156] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[246.331065] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[246.335642] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[246.452563] [068/156] (774s left) gem_render_linear_blits (basic)
[246.503888] Starting subtest: basic
[246.524062] Subtest basic: SUCCESS (0.020s)
[246.607416] [069/156] (774s left) gem_exec_schedule (pi-distinct-iova)
[246.790466] Starting subtest: pi-distinct-iova
[246.792826] Starting dynamic subtest: rcs0
[246.864173] Dynamic subtest rcs0: SUCCESS (0.076s)
[246.879779] Starting dynamic subtest: vcs0
[246.926085] Dynamic subtest vcs0: SUCCESS (0.060s)
[246.939081] Starting dynamic subtest: vcs1
[246.986062] Dynamic subtest vcs1: SUCCESS (0.059s)
[246.997155] Starting dynamic subtest: vecs0
[247.047481] Dynamic subtest vecs0: SUCCESS (0.060s)
[247.056610] Starting dynamic subtest: ccs0
[247.119047] Dynamic subtest ccs0: SUCCESS (0.071s)
[247.121604] Subtest pi-distinct-iova: SUCCESS (0.333s)
[248.216875] [070/156] (772s left) gem_exec_whisper (basic-contexts-priority-all)
[248.275110] Starting subtest: basic-contexts-priority-all
[271.317037] Subtest basic-contexts-priority-all: SUCCESS (23.040s)
[271.499852] [071/156] (749s left) gem_exec_parallel (contexts)
[271.558201] Starting subtest: contexts
[271.562442] Starting dynamic subtest: rcs0
[276.148656] Dynamic subtest rcs0: SUCCESS (4.589s)
[276.162258] Starting dynamic subtest: bcs0
[280.285207] Dynamic subtest bcs0: SUCCESS (4.134s)
[280.298544] Starting dynamic subtest: vcs0
[284.577098] Dynamic subtest vcs0: SUCCESS (4.290s)
[284.588529] Starting dynamic subtest: vcs1
[288.660226] Dynamic subtest vcs1: SUCCESS (4.081s)
[288.673287] Starting dynamic subtest: vecs0
[292.645112] Dynamic subtest vecs0: SUCCESS (3.984s)
[292.658204] Starting dynamic subtest: ccs0
[296.648003] Dynamic subtest ccs0: SUCCESS (4.002s)
[296.650848] Subtest contexts: SUCCESS (25.094s)
[296.852823] [072/156] (724s left) kms_psr (pr-cursor-mmap-gtt)
[296.965148] Starting subtest: pr-cursor-mmap-gtt
[296.969483] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[297.038473] [073/156] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[297.137707] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[297.141928] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.220842] [074/156] (723s left) dmabuf_sync_file (export-before-signal)
[297.261017] Starting subtest: export-before-signal
[297.263313] Subtest export-before-signal: SUCCESS (0.001s)
[297.316598] [075/156] (723s left) syncobj_wait (reset-signaled)
[297.364676] Starting subtest: reset-signaled
[297.367099] Subtest reset-signaled: SUCCESS (0.000s)
[297.465137] [076/156] (723s left) kms_psr (pr-dpms)
[297.562474] Starting subtest: pr-dpms
[297.566564] Subtest pr-dpms: SKIP (0.000s)
[297.633693] [077/156] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[297.737492] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[305.000713] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.271s)
[305.143282] [078/156] (716s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[305.250245] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[306.227701] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.978s)
[306.338666] [079/156] (714s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[306.437661] Starting subtest: x-tiled-8bpp-rotate-0
[307.699801] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.262s)
[307.834117] [080/156] (713s left) i915_pm_rpm (reg-read-ioctl)
[309.362839] Starting subtest: reg-read-ioctl
[311.663198] Subtest reg-read-ioctl: SUCCESS (2.305s)
[312.062939] [081/156] (709s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[312.163501] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[312.165775] Starting dynamic subtest: pipe-A-eDP-1
[312.187842] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[312.198831] Starting dynamic subtest: pipe-B-eDP-1
[312.219443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[312.228913] Starting dynamic subtest: pipe-C-eDP-1
[312.249951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[312.259504] Starting dynamic subtest: pipe-D-eDP-1
[312.281506] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[312.285885] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[314.399239] [082/156] (707s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[314.458041] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[314.460134] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[314.559221] [083/156] (706s left) kms_addfb_basic (tile-pitch-mismatch)
[314.599959] Starting subtest: tile-pitch-mismatch
[314.604079] Subtest tile-pitch-mismatch: SKIP (0.000s)
[314.732077] [084/156] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[314.827410] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[314.831400] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[314.936379] [085/156] (706s left) intel_hwmon (hwmon-read)
[314.993996] Subtest hwmon-read: SKIP (0.000s)
[315.060480] [086/156] (706s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[315.152575] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[315.156925] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[315.259801] [087/156] (706s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[315.359102] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[315.362382] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[315.477237] [088/156] (706s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[315.582789] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[315.586076] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[315.702444] [089/156] (706s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[315.796390] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[315.799829] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[315.888914] [090/156] (705s left) gem_softpin (allocator-basic-reserve)
[315.935364] Starting subtest: allocator-basic-reserve
[316.002686] Subtest allocator-basic-reserve: SUCCESS (0.067s)
[316.118239] [091/156] (705s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[316.205916] Starting subtest: fbcpsrhdr-modesetfrombusy
[316.209473] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[316.304791] [092/156] (705s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[316.367612] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[316.434036] [093/156] (705s left) kms_cursor_crc (cursor-alpha-opaque)
[316.517511] Starting subtest: cursor-alpha-opaque
[316.519310] Starting dynamic subtest: pipe-A-eDP-1
[317.138742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[317.149216] Starting dynamic subtest: pipe-D-eDP-1
[318.452111] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[318.454484] Subtest cursor-alpha-opaque: SUCCESS (1.935s)
[319.298759] [094/156] (702s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[319.360298] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[319.471790] [095/156] (702s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[319.573050] Starting subtest: fbc-psr2-primary-mmap-gtt
[319.575007] Starting dynamic subtest: eDP-1
[319.579204] Dynamic subtest eDP-1: SKIP (0.000s)
[319.583476] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[319.646587] [096/156] (702s left) gem_partial_pwrite_pread (write-display)
[319.699405] Subtest write-display: SKIP (0.000s)
[319.765522] [097/156] (702s left) syncobj_timeline (wait-any-snapshot)
[319.816045] Starting subtest: wait-any-snapshot
[319.898998] Subtest wait-any-snapshot: SUCCESS (0.081s)
[319.972687] [098/156] (702s left) gem_exec_schedule (u-fairslice)
[320.040499] Starting subtest: u-fairslice
[320.042646] Starting dynamic subtest: rcs0
[322.058609] Dynamic subtest rcs0: SUCCESS (2.023s)
[322.070188] Starting dynamic subtest: bcs0
[324.081265] Dynamic subtest bcs0: SUCCESS (2.023s)
[324.092429] Starting dynamic subtest: vcs0
[326.109841] Dynamic subtest vcs0: SUCCESS (2.025s)
[326.121277] Starting dynamic subtest: vcs1
[328.134095] Dynamic subtest vcs1: SUCCESS (2.021s)
[328.145174] Starting dynamic subtest: vecs0
[330.152782] Dynamic subtest vecs0: SUCCESS (2.019s)
[330.163976] Starting dynamic subtest: ccs0
[332.182711] Dynamic subtest ccs0: SUCCESS (2.028s)
[332.185009] Subtest u-fairslice: SUCCESS (12.146s)
[332.480719] [099/156] (689s left) kms_color (ctm-blue-to-red)
[332.575186] Starting subtest: ctm-blue-to-red
[332.577088] Starting dynamic subtest: pipe-A-eDP-1
[333.262449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[333.275077] Starting dynamic subtest: pipe-B-eDP-1
[334.628778] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s)
[334.640360] Starting dynamic subtest: pipe-C-eDP-1
[335.995754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[336.006671] Starting dynamic subtest: pipe-D-eDP-1
[337.324270] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[337.326796] Subtest ctm-blue-to-red: SUCCESS (4.749s)
[338.209866] [100/156] (683s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[338.302233] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[338.306642] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[338.388656] [101/156] (683s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[338.488468] Starting subtest: y-tiled-64bpp-rotate-90
[338.492712] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[338.599719] [102/156] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[338.694788] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[347.187718] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.496s)
[347.323689] [103/156] (674s left) gem_pxp (create-valid-protected-context)
[347.452880] Starting subtest: create-valid-protected-context
[347.455387] Subtest create-valid-protected-context: SUCCESS (0.002s)
[347.570852] [104/156] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[347.670027] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[347.674582] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[347.776400] [105/156] (674s left) api_intel_allocator (fork-simple-stress)
[347.837144] Starting subtest: fork-simple-stress
[353.235786] Subtest fork-simple-stress: SUCCESS (5.398s)
[353.354026] [106/156] (669s left) perf_pmu (event-wait)
[353.393079] Starting subtest: event-wait
[353.395415] Starting dynamic subtest: rcs0
[353.399715] Dynamic subtest rcs0: SKIP (0.000s)
[353.404032] Subtest event-wait: SKIP (0.001s)
[353.518665] [107/156] (668s left) gem_exec_suspend (basic-s4-devices)
[353.577160] Starting subtest: basic-S4-devices
[353.579119] Starting dynamic subtest: smem
[365.112080] Dynamic subtest smem: SUCCESS (11.534s)
[365.114881] Subtest basic-S4-devices: SUCCESS (11.536s)
[372.329471] [108/156] (657s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[372.446016] Starting subtest: fbc-pr-cursor-mmap-gtt
[372.450210] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[372.530973] [109/156] (657s left) tools_test (sysfs_l3_parity)
[372.578230] Starting subtest: sysfs_l3_parity
[372.645267] Subtest sysfs_l3_parity: SKIP (0.077s)
[372.699631] [110/156] (656s left) gem_lmem_swapping (parallel-random-verify-ccs)
[372.744854] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[372.786624] [111/156] (656s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[372.838720] Starting subtest: etime-multi-wait-all-submitted-signaled
[372.948156] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[373.030537] [112/156] (656s left) gem_mmap_gtt (hang-busy)
[373.083048] Subtest hang-busy: SKIP (0.000s)
[373.150633] [113/156] (656s left) gem_ctx_persistence (engines-mixed)
[373.202968] Starting subtest: engines-mixed
[373.205274] Starting dynamic subtest: rcs0
[373.296161] Dynamic subtest rcs0: SUCCESS (0.092s)
[373.308073] Starting dynamic subtest: bcs0
[373.373391] Dynamic subtest bcs0: SUCCESS (0.075s)
[373.386869] Starting dynamic subtest: vcs0
[373.429497] Dynamic subtest vcs0: SUCCESS (0.054s)
[373.442235] Starting dynamic subtest: vcs1
[373.472075] Dynamic subtest vcs1: SUCCESS (0.041s)
[373.483094] Starting dynamic subtest: vecs0
[373.511826] Dynamic subtest vecs0: SUCCESS (0.038s)
[373.523246] Starting dynamic subtest: ccs0
[373.557378] Dynamic subtest ccs0: SUCCESS (0.044s)
[373.560044] Subtest engines-mixed: SUCCESS (0.354s)
[373.649698] [114/156] (656s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[373.756251] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[373.758515] Starting dynamic subtest: pipe-A
[374.805522] Dynamic subtest pipe-A: SUCCESS (1.050s)
[374.816124] Starting dynamic subtest: pipe-B
[376.973822] Dynamic subtest pipe-B: SUCCESS (2.169s)
[376.985175] Starting dynamic subtest: pipe-C
[378.136607] Dynamic subtest pipe-C: SUCCESS (1.162s)
[378.148303] Starting dynamic subtest: pipe-D
[379.347552] Dynamic subtest pipe-D: SUCCESS (1.210s)
[379.349925] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.594s)
[380.504941] [115/156] (649s left) prime_mmap (test_forked)
[380.563923] Starting subtest: test_forked
[380.565896] Starting dynamic subtest: test_forked-smem
[380.609783] Dynamic subtest test_forked-smem: SUCCESS (0.047s)
[380.612121] Subtest test_forked: SUCCESS (0.048s)
[380.716503] [116/156] (649s left) kms_cursor_edge_walk (256x256-top-edge)
[380.802698] Starting subtest: 256x256-top-edge
[380.805254] Starting dynamic subtest: pipe-A-eDP-1
[384.252722] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[384.263812] Starting dynamic subtest: pipe-D-eDP-1
[387.422437] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.167s)
[387.424814] Subtest 256x256-top-edge: SUCCESS (6.621s)
[388.305076] [117/156] (641s left) kms_big_fb (linear-32bpp-rotate-90)
[388.410977] Starting subtest: linear-32bpp-rotate-90
[388.430075] Subtest linear-32bpp-rotate-90: SKIP (0.018s)
[388.545454] [118/156] (641s left) syncobj_wait (invalid-wait-bad-flags)
[388.595746] Starting subtest: invalid-wait-bad-flags
[388.598080] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[388.709523] [119/156] (641s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[388.802756] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[388.806618] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[388.910303] [120/156] (641s left) gem_lmem_swapping (heavy-multi)
[388.946956] Subtest heavy-multi: SKIP (0.000s)
[388.996258] [121/156] (641s left) kms_cdclk (plane-scaling)
[389.092198] Starting subtest: plane-scaling
[389.094475] Starting dynamic subtest: pipe-A-eDP-1
[389.387758] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[389.401245] Starting dynamic subtest: pipe-B-eDP-1
[389.405682] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[389.419567] Starting dynamic subtest: pipe-C-eDP-1
[389.423967] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[389.434279] Starting dynamic subtest: pipe-D-eDP-1
[389.438419] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[389.442400] Subtest plane-scaling: SKIP (0.300s)
[390.206461] [122/156] (639s left) i915_hangman (engine-error-state-capture)
[390.284565] Starting subtest: engine-error-state-capture
[390.287002] Starting dynamic subtest: rcs0
[394.069096] Dynamic subtest rcs0: SUCCESS (3.786s)
[394.085278] Starting dynamic subtest: bcs0
[400.086079] Dynamic subtest bcs0: SUCCESS (6.014s)
[400.100759] Starting dynamic subtest: vcs0
[406.037982] Dynamic subtest vcs0: SUCCESS (5.950s)
[406.052395] Starting dynamic subtest: vcs1
[411.029845] Dynamic subtest vcs1: SUCCESS (4.989s)
[411.044189] Starting dynamic subtest: vecs0
[416.022257] Dynamic subtest vecs0: SUCCESS (4.989s)
[416.037539] Starting dynamic subtest: ccs0
[421.077559] Dynamic subtest ccs0: SUCCESS (5.053s)
[421.080775] Subtest engine-error-state-capture: SUCCESS (30.797s)
[421.158927] [123/156] (609s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[421.263892] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[421.268266] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[421.365146] [124/156] (608s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[421.477445] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[421.481562] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[421.583586] [125/156] (608s left) i915_drm_fdinfo (most-busy-idle-check-all)
[421.624602] Starting subtest: most-busy-idle-check-all
[421.626532] Starting dynamic subtest: rcs0
[421.631308] Dynamic subtest rcs0: SKIP (0.003s)
[421.644555] Starting dynamic subtest: bcs0
[421.648623] Dynamic subtest bcs0: SKIP (0.000s)
[421.659296] Starting dynamic subtest: vcs0
[421.663637] Dynamic subtest vcs0: SKIP (0.000s)
[421.674111] Starting dynamic subtest: vcs1
[421.678539] Dynamic subtest vcs1: SKIP (0.000s)
[421.688606] Starting dynamic subtest: vecs0
[421.692976] Dynamic subtest vecs0: SKIP (0.000s)
[421.703151] Starting dynamic subtest: ccs0
[421.707739] Dynamic subtest ccs0: SKIP (0.000s)
[421.712037] Subtest most-busy-idle-check-all: SKIP (0.009s)
[421.751084] [126/156] (608s left) kms_big_fb (4-tiled-addfb)
[421.865436] Starting subtest: 4-tiled-addfb
[421.867570] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[421.966528] [127/156] (608s left) kms_dp_aux_dev (basic)
[422.021371] Starting subtest: basic
[422.246065] Subtest basic: SUCCESS (0.224s)
[422.332911] [128/156] (608s left) gem_create (busy-create)
[422.378000] Starting subtest: busy-create
[422.380427] Starting dynamic subtest: smem0
[455.165555] Dynamic subtest smem0: SUCCESS (32.788s)
[455.168218] Subtest busy-create: SUCCESS (32.790s)
[455.349662] [129/156] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[455.445569] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[455.449478] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[455.543705] [130/156] (574s left) gem_ctx_shared (exec-single-timeline)
[455.613919] Starting subtest: exec-single-timeline
[455.616251] Starting dynamic subtest: rcs0
[456.659381] Dynamic subtest rcs0: SUCCESS (1.043s)
[456.673488] Starting dynamic subtest: bcs0
[457.684266] Dynamic subtest bcs0: SUCCESS (1.022s)
[457.698396] Starting dynamic subtest: vcs0
[458.774054] Dynamic subtest vcs0: SUCCESS (1.087s)
[458.789759] Starting dynamic subtest: vcs1
[459.859981] Dynamic subtest vcs1: SUCCESS (1.083s)
[459.872721] Starting dynamic subtest: vecs0
[460.949464] Dynamic subtest vecs0: SUCCESS (1.086s)
[460.963772] Starting dynamic subtest: ccs0
[462.036380] Dynamic subtest ccs0: SUCCESS (1.085s)
[462.039355] Subtest exec-single-timeline: SUCCESS (6.424s)
[462.229579] [131/156] (568s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt)
[462.330491] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt
[462.334466] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[462.425015] [132/156] (568s left) kms_pm_dc (dc5-retention-flops)
[463.527178] Starting subtest: dc5-retention-flops
[463.531537] Subtest dc5-retention-flops: SKIP (0.000s)
[463.604925] [133/156] (567s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[463.732829] Starting subtest: cursorA-vs-flipA-atomic-transitions
[474.911566] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.179s)
[475.778889] [134/156] (554s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[475.903092] Starting subtest: cursorB-vs-flipA-atomic
[475.907683] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[476.063512] [135/156] (554s left) kms_addfb_basic (basic)
[476.122617] Starting subtest: basic
[476.124633] Subtest basic: SUCCESS (0.000s)
[476.275141] [136/156] (554s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[476.373132] Starting subtest: invalidate-primary-flip-overlay
[487.084096] Subtest invalidate-primary-flip-overlay: SUCCESS (10.714s)
[487.200266] [137/156] (543s left) kms_chamelium_hpd (dp-hpd-fast)
[487.588965] Subtest dp-hpd-fast: SKIP (0.000s)
[488.385578] [138/156] (542s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[488.479364] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[488.490937] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[488.590841] [139/156] (542s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[488.686289] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[492.615028] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.935s)
[493.782372] [140/156] (537s left) kms_frontbuffer_tracking (psrhdr-suspend)
[493.886782] Starting subtest: psrhdr-suspend
[493.891106] Subtest psrhdr-suspend: SKIP (0.000s)
[494.009288] [141/156] (536s left) prime_mmap (test_dup)
[494.065695] Starting subtest: test_dup
[494.067592] Starting dynamic subtest: test_dup-smem
[494.107605] Dynamic subtest test_dup-smem: SUCCESS (0.044s)
[494.110005] Subtest test_dup: SUCCESS (0.045s)
[494.182551] [142/156] (536s left) gem_mmap (big-bo)
[494.229813] Subtest big-bo: SKIP (0.000s)
[494.287734] [143/156] (536s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[494.394746] Starting subtest: hdr-farfromfence-mmap-gtt
[494.398723] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[494.507922] [144/156] (536s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[494.892880] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[495.688921] [145/156] (535s left) gen3_render_mixed_blits
[495.805499] [146/156] (535s left) tools_test (tools_test)
[495.851983] Starting subtest: tools_test
[495.896364] Subtest tools_test: SUCCESS (0.065s)
[495.959538] [147/156] (535s left) prime_vgem (sync)
[496.022297] Starting subtest: sync
[496.024557] Starting dynamic subtest: rcs0
[496.094122] Dynamic subtest rcs0: SUCCESS (0.071s)
[496.105137] Starting dynamic subtest: bcs0
[496.156734] Dynamic subtest bcs0: SUCCESS (0.061s)
[496.167296] Starting dynamic subtest: vcs0
[496.204571] Dynamic subtest vcs0: SUCCESS (0.047s)
[496.214955] Starting dynamic subtest: vcs1
[496.251541] Dynamic subtest vcs1: SUCCESS (0.046s)
[496.262424] Starting dynamic subtest: vecs0
[496.296854] Dynamic subtest vecs0: SUCCESS (0.045s)
[496.307837] Starting dynamic subtest: ccs0
[496.342060] Dynamic subtest ccs0: SUCCESS (0.044s)
[496.344261] Subtest sync: SUCCESS (0.320s)
[496.475529] [148/156] (534s left) kms_atomic (atomic-plane-damage)
[496.567220] Starting subtest: atomic-plane-damage
[496.616449] Starting dynamic subtest: pipe-A-eDP-1
[497.136093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[497.138509] Subtest atomic-plane-damage: SUCCESS (0.570s)
[497.973472] [149/156] (533s left) kms_vrr (flip-basic)
[498.067263] Starting subtest: flip-basic
[498.073996] Subtest flip-basic: SKIP (0.000s)
[498.142263] [150/156] (533s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[498.232904] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[498.237283] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[498.340093] [151/156] (533s left) kms_3d (basic)
[498.396921] Starting subtest: basic
[500.650478] Subtest basic: SUCCESS (2.257s)
[501.145116] [152/156] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[501.242537] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[501.246909] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[501.386388] [153/156] (530s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[501.475858] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[501.479993] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[501.563167] [154/156] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[501.662141] Starting subtest: psr-2p-primscrn-cur-indfb-move
[501.666584] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[501.786611] [155/156] (529s left) gem_workarounds (reset)
[501.847414] Starting subtest: reset
[502.024905] Subtest reset: SUCCESS (0.178s)
[502.167824] [156/156] (529s left) gem_ctx_persistence (hang)
[502.219871] Starting subtest: hang
[502.223577] Subtest hang: SKIP (0.000s)
[502.318454] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_b_c_ivb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_explicit_fence
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_alpha_blend
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_force_connector_basic
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: sysfs_heartbeat_interval
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_pipe_crc_basic
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: gem_render_tiled_blits
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_universal_plane
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: gem_exec_create
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_atomic_interruptible
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: prime_vgem
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_render_linear_blits
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: dmabuf_sync_file
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: intel_hwmon
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_partial_pwrite_pread
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_exec_suspend
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: tools_test
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: prime_mmap
results: parsing output: 115/ for test: kms_cursor_edge_walk
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_cdclk
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_dp_aux_dev
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_shared
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_pm_dc
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: kms_cursor_legacy
results: parsing output: 134/ for test: kms_addfb_basic
results: parsing output: 135/ for test: kms_psr_stress_test
results: parsing output: 136/ for test: kms_chamelium_hpd
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: prime_mmap
results: parsing output: 141/ for test: gem_mmap
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_chamelium_frames
results: parsing output: 144/ for test: gen3_render_mixed_blits
results: parsing output: 145/ for test: tools_test
results: parsing output: 146/ for test: prime_vgem
results: parsing output: 147/ for test: kms_atomic
results: parsing output: 148/ for test: kms_vrr
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_3d
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_workarounds
results: parsing output: 155/ for test: gem_ctx_persistence
Done.