[56.797303] Initializing watchdogs
[56.797354]   /dev/watchdog0
[56.812598] [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.817295] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.819502] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.823109] [001/133] (960s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[56.980853] Starting subtest: yf-tiled-addfb-size-offset-overflow
[56.985486] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[57.082207] [002/133] (960s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[57.219064] Starting subtest: verify-pxp-key-change-after-suspend-resume
[65.287669] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.072s)
[65.403785] [003/133] (951s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[65.469344] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[65.577898] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[65.650255] [004/133] (951s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[65.719981] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[65.784507] [005/133] (951s left) kms_rotation_crc (primary-rotation-270)
[65.873832] Starting subtest: primary-rotation-270
[65.878295] Subtest primary-rotation-270: SKIP (0.001s)
[65.945732] [006/133] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[66.039278] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[66.043998] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[66.125973] [007/133] (951s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[66.229188] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[66.233271] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[66.324747] [008/133] (951s left) kms_getfb (getfb2-handle-closed)
[66.430105] Starting subtest: getfb2-handle-closed
[66.432472] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[66.532164] [009/133] (951s left) kms_invalid_mode (bad-vsync-start)
[66.630062] Starting subtest: bad-vsync-start
[66.632137] Starting dynamic subtest: pipe-A-eDP-1
[66.924777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[66.934459] Starting dynamic subtest: pipe-B-eDP-1
[66.936820] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[66.944441] Starting dynamic subtest: pipe-C-eDP-1
[66.946793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[66.956742] Starting dynamic subtest: pipe-D-eDP-1
[66.958863] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[66.961062] Subtest bad-vsync-start: SUCCESS (0.302s)
[67.799962] [010/133] (949s left) gem_mmap_gtt (coherency)
[67.899450] Subtest coherency: SKIP (0.000s)
[67.982161] [011/133] (949s left) kms_atomic_interruptible (legacy-cursor)
[68.115052] Starting subtest: legacy-cursor
[68.117432] Starting dynamic subtest: pipe-A-eDP-1
[75.490789] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.375s)
[75.493154] Subtest legacy-cursor: SUCCESS (7.376s)
[76.356908] [012/133] (941s left) kms_content_protection (uevent-hdcp14)
[76.505401] Starting subtest: uevent-hdcp14
[76.510122] Subtest uevent-hdcp14: SKIP (0.000s)
[76.657203] [013/133] (941s left) vgem_basic (dmabuf-fence-before)
[76.729831] Starting subtest: dmabuf-fence-before
[76.731775] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[76.781102] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[76.784407] [014/133] (941s left) gem_exec_reloc (basic-gtt-read)
[76.839119] Subtest basic-gtt-read: SKIP (0.000s)
[76.912371] [015/133] (941s left) i915_pm_freq_api (freq-basic-api)
[76.976993] Starting subtest: freq-basic-api
[76.979264] Starting dynamic subtest: gt0
[76.981580] Dynamic subtest gt0: SUCCESS (0.003s)
[76.989484] Starting dynamic subtest: gt1
[76.991397] Dynamic subtest gt1: SUCCESS (0.003s)
[76.993286] Subtest freq-basic-api: SUCCESS (0.007s)
[77.062034] [016/133] (940s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[77.151612] Starting subtest: fbc-pr-sprite-mmap-cpu
[77.156086] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[77.227193] [017/133] (940s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[77.314058] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[77.317527] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[77.412578] [018/133] (940s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[77.504500] Starting subtest: fbc-psr2-cursor-plane-update-sf
[77.506367] Starting dynamic subtest: pipe-A-eDP-1
[77.580075] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[77.590279] Starting dynamic subtest: pipe-B-eDP-1
[78.730342] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s)
[78.734922] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.227s)
[79.919867] [019/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[80.021857] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[86.804188] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.785s)
[86.968391] [020/133] (931s left) kms_big_fb (4-tiled-addfb)
[87.084614] Starting subtest: 4-tiled-addfb
[87.086939] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[87.193997] [021/133] (930s left) gem_exec_schedule (u-independent)
[87.261015] Starting subtest: u-independent
[87.262994] Starting dynamic subtest: rcs0
[88.920856] Dynamic subtest rcs0: SUCCESS (1.668s)
[88.932703] Starting dynamic subtest: vcs0
[90.911382] Dynamic subtest vcs0: SUCCESS (1.990s)
[90.921975] Starting dynamic subtest: vcs1
[92.897332] Dynamic subtest vcs1: SUCCESS (1.985s)
[92.907492] Starting dynamic subtest: vecs0
[94.945742] Dynamic subtest vecs0: SUCCESS (2.047s)
[94.957035] Starting dynamic subtest: ccs0
[96.917848] Dynamic subtest ccs0: SUCCESS (1.971s)
[96.920941] Subtest u-independent: SUCCESS (9.666s)
[97.237211] [022/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[97.338619] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[97.343266] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[97.436854] [023/133] (920s left) kms_plane (plane-position-covered)
[97.533896] Starting subtest: plane-position-covered
[98.073057] Starting dynamic subtest: pipe-A-plane-1
[99.348565] Dynamic subtest pipe-A-plane-1: SUCCESS (1.273s)
[99.358617] Starting dynamic subtest: pipe-A-plane-2
[100.627129] Dynamic subtest pipe-A-plane-2: SUCCESS (1.278s)
[100.636532] Starting dynamic subtest: pipe-A-plane-3
[101.869232] Dynamic subtest pipe-A-plane-3: SUCCESS (1.242s)
[101.877972] Starting dynamic subtest: pipe-A-plane-4
[103.208128] Dynamic subtest pipe-A-plane-4: SUCCESS (1.339s)
[103.218677] Starting dynamic subtest: pipe-A-plane-5
[103.232387] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[104.450201] Starting dynamic subtest: pipe-B-plane-1
[105.797155] Dynamic subtest pipe-B-plane-1: SUCCESS (1.354s)
[105.809443] Starting dynamic subtest: pipe-B-plane-2
[107.095440] Dynamic subtest pipe-B-plane-2: SUCCESS (1.298s)
[107.104974] Starting dynamic subtest: pipe-B-plane-3
[108.425769] Dynamic subtest pipe-B-plane-3: SUCCESS (1.327s)
[108.434943] Starting dynamic subtest: pipe-B-plane-4
[109.742094] Dynamic subtest pipe-B-plane-4: SUCCESS (1.317s)
[109.751975] Starting dynamic subtest: pipe-B-plane-5
[109.774961] Dynamic subtest pipe-B-plane-5: SUCCESS (0.032s)
[109.777182] Subtest plane-position-covered: SUCCESS (12.241s)
[110.543127] [024/133] (907s left) api_intel_allocator (fork-simple-once)
[110.597577] Starting subtest: fork-simple-once
[110.611954] Subtest fork-simple-once: SUCCESS (0.017s)
[110.729267] [025/133] (907s left) kms_properties (invalid-properties-atomic)
[110.840123] Starting subtest: invalid-properties-atomic
[111.147077] Subtest invalid-properties-atomic: SUCCESS (0.307s)
[111.221161] [026/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[111.327237] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[111.331662] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[111.421899] [027/133] (906s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[111.529794] Starting subtest: yf-tiled-16bpp-rotate-270
[111.534091] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[111.630339] [028/133] (906s left) gen7_exec_parse (batch-without-end)
[111.694588] Subtest batch-without-end: SKIP (0.000s)
[111.766750] [029/133] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[111.853320] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[111.857726] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[111.961877] [030/133] (906s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[112.023854] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[112.028875] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[112.217997] [031/133] (906s left) gem_exec_schedule (noreorder-corked)
[112.408814] Starting subtest: noreorder-corked
[112.411392] Starting dynamic subtest: rcs0
[113.538080] Dynamic subtest rcs0: SUCCESS (1.132s)
[113.549412] Starting dynamic subtest: vcs0
[114.898063] Dynamic subtest vcs0: SUCCESS (1.358s)
[114.909087] Starting dynamic subtest: vcs1
[116.862207] Dynamic subtest vcs1: SUCCESS (1.962s)
[116.873088] Starting dynamic subtest: vecs0
[118.871391] Dynamic subtest vecs0: SUCCESS (2.008s)
[118.886844] Starting dynamic subtest: ccs0
[120.014354] Dynamic subtest ccs0: SUCCESS (1.142s)
[120.017102] Subtest noreorder-corked: SUCCESS (7.609s)
[120.204295] [032/133] (898s left) kms_cursor_crc (cursor-offscreen-256x85)
[120.436543] Starting subtest: cursor-offscreen-256x85
[120.490375] Subtest cursor-offscreen-256x85: SKIP (0.049s)
[120.644860] [033/133] (898s left) api_intel_bb (object-noreloc-purge-cache-simple)
[120.696568] Starting subtest: object-noreloc-purge-cache-simple
[120.698923] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[120.828735] [034/133] (897s left) gem_lmem_swapping (heavy-verify-random)
[120.869140] Subtest heavy-verify-random: SKIP (0.000s)
[120.913678] [035/133] (897s left) kms_vrr (seamless-rr-switch-virtual)
[120.996220] Starting subtest: seamless-rr-switch-virtual
[121.002764] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[121.069379] [036/133] (897s left) kms_psr (fbc-psr-sprite-plane-onoff)
[121.156996] Starting subtest: fbc-psr-sprite-plane-onoff
[121.158782] Starting dynamic subtest: eDP-1
[121.162284] Dynamic subtest eDP-1: SKIP (0.000s)
[121.165777] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[121.240679] [037/133] (897s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[121.342590] Starting subtest: x-tiled-64bpp-rotate-180
[123.054993] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.712s)
[123.231637] [038/133] (895s left) gem_ctx_persistence (file)
[123.291066] Starting subtest: file
[123.393548] Subtest file: SUCCESS (0.105s)
[123.518663] [039/133] (895s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[123.641869] Starting subtest: cursorA-vs-flipA-atomic
[134.774243] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.133s)
[135.584776] [040/133] (883s left) gem_pwrite (basic-exhaustion)
[135.646244] Subtest basic-exhaustion: SKIP (0.000s)
[135.702161] [041/133] (883s left) gem_exec_params (sol-reset-not-gen7)
[135.752491] Starting subtest: sol-reset-not-gen7
[135.754842] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[135.881511] [042/133] (883s left) perf_pmu (idle)
[135.914409] Starting subtest: idle
[135.916681] Starting dynamic subtest: rcs0
[136.461570] Dynamic subtest rcs0: SUCCESS (0.544s)
[136.473188] Starting dynamic subtest: bcs0
[136.972685] Dynamic subtest bcs0: SUCCESS (0.512s)
[136.983978] Starting dynamic subtest: vcs0
[137.488321] Dynamic subtest vcs0: SUCCESS (0.515s)
[137.499681] Starting dynamic subtest: vcs1
[138.007348] Dynamic subtest vcs1: SUCCESS (0.514s)
[138.018344] Starting dynamic subtest: vecs0
[138.520680] Dynamic subtest vecs0: SUCCESS (0.514s)
[138.532034] Starting dynamic subtest: ccs0
[139.036810] Dynamic subtest ccs0: SUCCESS (0.514s)
[139.039969] Subtest idle: SUCCESS (3.124s)
[139.146121] [043/133] (879s left) kms_psr (psr2-no-drrs)
[139.240857] Starting subtest: psr2-no-drrs
[139.243053] Starting dynamic subtest: eDP-1
[140.851704] Dynamic subtest eDP-1: SUCCESS (1.611s)
[140.854093] Subtest psr2-no-drrs: SUCCESS (1.611s)
[141.641922] [044/133] (877s left) gem_exec_params (rel-constants-invalid)
[141.706151] Starting subtest: rel-constants-invalid
[141.708286] Subtest rel-constants-invalid: SUCCESS (0.000s)
[141.804342] [045/133] (877s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[141.896068] Starting subtest: plane-upscale-20x20-with-modifiers
[141.898404] Starting dynamic subtest: pipe-A
[142.231342] Dynamic subtest pipe-A: SUCCESS (0.338s)
[142.242323] Starting dynamic subtest: pipe-B
[143.635861] Dynamic subtest pipe-B: SUCCESS (1.404s)
[143.644792] Starting dynamic subtest: pipe-C
[145.070677] Dynamic subtest pipe-C: SUCCESS (1.434s)
[145.085783] Starting dynamic subtest: pipe-D
[146.500122] Dynamic subtest pipe-D: SUCCESS (1.428s)
[146.502536] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.607s)
[147.677180] [046/133] (871s left) kms_psr (fbc-pr-primary-mmap-gtt)
[147.772766] Starting subtest: fbc-pr-primary-mmap-gtt
[147.777352] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[147.846454] [047/133] (871s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[147.938490] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[155.333928] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.399s)
[155.462371] [048/133] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[155.560335] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[155.564650] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[155.668603] [049/133] (863s left) gen9_exec_parse (shadow-peek)
[155.736714] Subtest shadow-peek: SKIP (0.000s)
[155.822571] [050/133] (863s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[155.916486] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[155.920862] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[156.012107] [051/133] (863s left) gem_ccs (block-copy-uncompressed)
[156.071063] Starting subtest: block-copy-uncompressed
[156.073248] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[156.092698] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[156.103205] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[156.109881] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[156.118549] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[156.127038] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[156.135831] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[156.146742] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[156.149048] Subtest block-copy-uncompressed: SUCCESS (0.076s)
[156.276792] [052/133] (863s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[158.012233] Starting subtest: dpms-mode-unset-lpsp
[162.068875] Subtest dpms-mode-unset-lpsp: SUCCESS (4.059s)
[162.463366] [053/133] (857s left) kms_flip (plain-flip-fb-recreate)
[162.555731] Starting subtest: plain-flip-fb-recreate
[162.557658] Starting dynamic subtest: A-eDP1
[171.431789] Dynamic subtest A-eDP1: SUCCESS (8.878s)
[171.444250] Starting dynamic subtest: B-eDP1
[180.268158] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[180.280199] Starting dynamic subtest: C-eDP1
[189.101471] Dynamic subtest C-eDP1: SUCCESS (8.831s)
[189.114773] Starting dynamic subtest: D-eDP1
[197.927661] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[197.932305] Subtest plain-flip-fb-recreate: SUCCESS (35.381s)
[199.121565] [054/133] (820s left) perf (create-destroy-userspace-config)
[199.240042] Starting subtest: create-destroy-userspace-config
[199.258802] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[199.296867] [055/133] (820s left) syncobj_timeline (wait-delayed-signal)
[199.358014] Starting subtest: wait-delayed-signal
[199.461777] Subtest wait-delayed-signal: SUCCESS (0.103s)
[199.552847] [056/133] (820s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[199.649666] Starting subtest: pr-cursor-plane-update-sf
[199.653708] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[199.719974] [057/133] (819s left) gem_ppgtt (blt-vs-render-ctxn)
[199.775506] Starting subtest: blt-vs-render-ctxN
[232.686065] Subtest blt-vs-render-ctxN: SUCCESS (32.906s)
[232.825814] [058/133] (786s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[232.994728] Starting subtest: basic-busy-flip-before-cursor-varying-size
[232.999281] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[233.145706] [059/133] (786s left) vgem_basic (dmabuf-export)
[233.194177] Starting subtest: dmabuf-export
[233.225428] Subtest dmabuf-export: SUCCESS (0.035s)
[233.341418] [060/133] (786s left) kms_atomic (plane-primary-legacy)
[233.434741] Starting subtest: plane-primary-legacy
[233.436829] Starting dynamic subtest: pipe-A-eDP-1
[233.912075] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[233.914245] Subtest plane-primary-legacy: SUCCESS (0.477s)
[234.753085] [061/133] (785s left) gem_create (create-clear)
[234.810892] Starting subtest: create-clear
[234.814265] Starting dynamic subtest: smem0
[267.749502] Dynamic subtest smem0: SUCCESS (32.935s)
[267.751484] Subtest create-clear: SUCCESS (32.937s)
[267.944021] [062/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[268.055513] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[268.060159] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[268.166278] [063/133] (751s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[268.568612] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[269.364074] [064/133] (750s left) kms_plane (pixel-format-4-tiled-modifier)
[269.450984] Starting subtest: pixel-format-4-tiled-modifier
[269.476790] Starting dynamic subtest: pipe-A-plane-0
[270.120611] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[270.130775] Starting dynamic subtest: pipe-A-plane-3
[270.564536] Dynamic subtest pipe-A-plane-3: SUCCESS (0.442s)
[270.574298] Starting dynamic subtest: pipe-A-plane-5
[270.577758] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[271.678327] Starting dynamic subtest: pipe-B-plane-0
[272.326089] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[272.336553] Starting dynamic subtest: pipe-B-plane-3
[272.748043] Dynamic subtest pipe-B-plane-3: SUCCESS (0.420s)
[272.760295] Starting dynamic subtest: pipe-B-plane-5
[272.764024] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[273.071395] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.622s)
[273.971934] [065/133] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[274.083442] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[274.087558] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[274.182447] [066/133] (745s left) gem_exec_reloc (basic-wc-read-active)
[274.249612] Subtest basic-wc-read-active: SKIP (0.000s)
[274.337781] [067/133] (745s left) gem_ctx_param (get-priority-new-ctx)
[274.395930] Starting subtest: get-priority-new-ctx
[274.398359] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[274.507899] [068/133] (745s left) kms_vblank (wait-forked)
[274.605713] Starting subtest: wait-forked
[274.607773] Starting dynamic subtest: pipe-A-eDP-1
[276.418824] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[276.433261] Starting dynamic subtest: pipe-D-eDP-1
[278.966852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[278.968828] Subtest wait-forked: SUCCESS (4.360s)
[279.826158] [069/133] (740s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[279.891521] Starting subtest: invalid-bsd2-flag-on-blt
[279.893938] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[280.006897] [070/133] (740s left) gem_exec_fence (syncobj-invalid-flags)
[280.526588] Starting subtest: syncobj-invalid-flags
[280.529087] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[282.039918] [071/133] (738s left) gem_exec_params (readonly)
[282.093028] Starting subtest: readonly
[282.099596] Subtest readonly: SUCCESS (0.003s)
[282.226416] [072/133] (738s left) i915_pm_sseu (full-enable)
[282.288566] Subtest full-enable: SKIP (0.000s)
[282.403041] [073/133] (737s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[282.531334] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[282.535787] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[282.676245] [074/133] (737s left) perf_pmu (semaphore-wait)
[282.717773] Starting subtest: semaphore-wait
[282.719911] Starting dynamic subtest: rcs0
[283.233910] Dynamic subtest rcs0: SUCCESS (0.514s)
[283.244686] Starting dynamic subtest: bcs0
[283.746028] Dynamic subtest bcs0: SUCCESS (0.510s)
[283.757781] Starting dynamic subtest: vcs0
[284.260308] Dynamic subtest vcs0: SUCCESS (0.511s)
[284.272051] Starting dynamic subtest: vcs1
[284.773026] Dynamic subtest vcs1: SUCCESS (0.510s)
[284.785165] Starting dynamic subtest: vecs0
[285.286933] Dynamic subtest vecs0: SUCCESS (0.510s)
[285.299383] Starting dynamic subtest: ccs0
[285.803050] Dynamic subtest ccs0: SUCCESS (0.512s)
[285.805909] Subtest semaphore-wait: SUCCESS (3.085s)
[286.946768] [075/133] (733s left) kms_async_flips (async-flip-suspend-resume)
[287.035709] Starting subtest: async-flip-suspend-resume
[287.420351] Starting dynamic subtest: pipe-A-eDP-1
[304.831314] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.933s)
[305.223286] Starting dynamic subtest: pipe-B-eDP-1
[322.824453] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.844s)
[323.209718] Starting dynamic subtest: pipe-C-eDP-1
[340.846633] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.896s)
[341.220998] Starting dynamic subtest: pipe-D-eDP-1
[358.844313] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.867s)
[358.846607] Subtest async-flip-suspend-resume: SUCCESS (13.053s)
[360.023884] [076/133] (660s left) kms_color_pipeline (plane-lut1d)
[360.132983] Starting subtest: plane-lut1d
[360.326714] Starting dynamic subtest: pipe-A-plane-0
[360.675798] Dynamic subtest pipe-A-plane-0: FAIL (0.183s)
[360.689167] Starting dynamic subtest: pipe-A-plane-1
[360.909457] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[360.921179] Starting dynamic subtest: pipe-A-plane-2
[361.135131] Dynamic subtest pipe-A-plane-2: FAIL (0.165s)
[362.034556] Starting dynamic subtest: pipe-B-plane-0
[362.457343] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[362.469697] Starting dynamic subtest: pipe-B-plane-1
[362.772551] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[362.785136] Starting dynamic subtest: pipe-B-plane-2
[363.073555] Dynamic subtest pipe-B-plane-2: FAIL (0.165s)
[363.749914] Starting dynamic subtest: pipe-C-plane-0
[364.228984] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[364.239729] Starting dynamic subtest: pipe-C-plane-1
[364.632451] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[364.643776] Starting dynamic subtest: pipe-C-plane-2
[364.983162] Dynamic subtest pipe-C-plane-2: FAIL (0.638s)
[365.892295] Starting dynamic subtest: pipe-D-plane-0
[366.467957] Dynamic subtest pipe-D-plane-0: FAIL (0.139s)
[366.480188] Starting dynamic subtest: pipe-D-plane-1
[366.916415] Dynamic subtest pipe-D-plane-1: FAIL (0.624s)
[366.925788] Starting dynamic subtest: pipe-D-plane-2
[367.326634] Dynamic subtest pipe-D-plane-2: FAIL (0.543s)
[367.490791] Subtest plane-lut1d: FAIL (7.354s)
[368.359850] [077/133] (652s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[368.460209] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[375.500217] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.038s)
[375.633030] [078/133] (644s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[375.733886] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[375.736171] Starting dynamic subtest: pipe-A-eDP-1
[375.758838] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[375.769590] Starting dynamic subtest: pipe-B-eDP-1
[375.791207] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[375.800709] Starting dynamic subtest: pipe-C-eDP-1
[375.822230] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[375.831394] Starting dynamic subtest: pipe-D-eDP-1
[375.853102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[375.857142] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[378.023964] [079/133] (642s left) i915_pm_rps (min-max-config-idle)
[378.081648] Starting subtest: min-max-config-idle
[378.086074] Subtest min-max-config-idle: SKIP (0.001s)
[378.177896] [080/133] (642s left) syncobj_timeline (single-wait-available-signaled)
[378.234657] Starting subtest: single-wait-available-signaled
[378.237005] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[378.311506] [081/133] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[378.422836] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[378.426731] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[378.527505] [082/133] (642s left) kms_big_fb (linear-64bpp-rotate-90)
[378.639322] Starting subtest: linear-64bpp-rotate-90
[378.659025] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[378.763598] [083/133] (642s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[378.857608] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[378.859950] Starting dynamic subtest: pipe-A-eDP-1
[378.883110] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[378.895674] Starting dynamic subtest: pipe-B-eDP-1
[378.917610] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[378.930397] Starting dynamic subtest: pipe-C-eDP-1
[378.951962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[378.964078] Starting dynamic subtest: pipe-D-eDP-1
[378.982216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[378.985584] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[381.089710] [084/133] (639s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[381.150855] Starting subtest: invalid-multi-wait-all-unsubmitted
[381.152792] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[381.236460] [085/133] (639s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[381.328659] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[381.333160] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[381.402020] [086/133] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[381.495403] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[381.499444] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[381.586509] [087/133] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[381.688961] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[381.693312] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[381.786253] [088/133] (639s left) gem_fenced_exec_thrash (2-spare-fences)
[381.840672] Subtest 2-spare-fences: SKIP (0.000s)
[381.911068] [089/133] (639s left) sw_sync (sync_busy_fork_unixsocket)
[381.950021] Starting subtest: sync_busy_fork_unixsocket
[381.957363] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s)
[382.013496] [090/133] (639s left) gem_exec_flush (basic-wb-rw-default)
[382.077817] Starting subtest: basic-wb-rw-default
[387.545028] Subtest basic-wb-rw-default: SUCCESS (5.467s)
[387.740113] [091/133] (633s left) kms_chamelium_edid (dp-edid-resolution-list)
[388.128520] Subtest dp-edid-resolution-list: SKIP (0.000s)
[388.910020] [092/133] (632s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[389.002552] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[389.004899] Starting dynamic subtest: pipe-A-eDP-1
[389.027513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.039429] Starting dynamic subtest: pipe-B-eDP-1
[389.060797] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.071039] Starting dynamic subtest: pipe-C-eDP-1
[389.092507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.101807] Starting dynamic subtest: pipe-D-eDP-1
[389.123727] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.128009] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[391.283140] [093/133] (629s left) gem_exec_balancer (noheartbeat)
[391.550966] Starting subtest: noheartbeat
[391.555809] Subtest noheartbeat: SKIP (0.000s)
[391.658263] [094/133] (629s left) gem_ctx_shared (q-in-order)
[391.725435] Starting subtest: Q-in-order
[391.727842] Starting dynamic subtest: rcs0
[391.831026] Dynamic subtest rcs0: SUCCESS (0.104s)
[391.849663] Starting dynamic subtest: vcs0
[391.909937] Dynamic subtest vcs0: SUCCESS (0.078s)
[391.927692] Starting dynamic subtest: vcs1
[391.985540] Dynamic subtest vcs1: SUCCESS (0.074s)
[392.003662] Starting dynamic subtest: vecs0
[392.057128] Dynamic subtest vecs0: SUCCESS (0.071s)
[392.074731] Starting dynamic subtest: ccs0
[392.132814] Dynamic subtest ccs0: SUCCESS (0.075s)
[392.135486] Subtest Q-in-order: SUCCESS (0.407s)
[393.784591] [095/133] (627s left) kms_atomic_interruptible (legacy-pageflip)
[393.884307] Starting subtest: legacy-pageflip
[393.886412] Starting dynamic subtest: pipe-A-eDP-1
[401.295524] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[401.297898] Subtest legacy-pageflip: SUCCESS (7.410s)
[402.127481] [096/133] (619s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[402.227045] Starting subtest: fbc-indfb-scaledprimary
[405.212639] Subtest fbc-indfb-scaledprimary: SUCCESS (2.987s)
[406.346196] [097/133] (615s left) kms_psr (pr-sprite-plane-move)
[406.443304] Starting subtest: pr-sprite-plane-move
[406.447633] Subtest pr-sprite-plane-move: SKIP (0.000s)
[406.518056] [098/133] (614s left) kms_selftest (drm_plane_helper)
[406.559552] Starting subtest: drm_plane_helper
[406.565538] Starting dynamic subtest: drm_test_check_plane_state
[406.660772] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.095s)
[406.670723] Starting dynamic subtest: drm_test_check_invalid_plane_state
[406.739973] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.078s)
[406.742308] Subtest drm_plane_helper: SUCCESS (0.182s)
[406.906825] [099/133] (614s left) dmabuf_sync_file (export-basic)
[406.962337] Starting subtest: export-basic
[406.964657] Subtest export-basic: SUCCESS (0.001s)
[407.018173] [100/133] (614s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[407.080839] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[407.139754] [101/133] (614s left) kms_lease (lease-revoke)
[407.236404] Starting subtest: lease-revoke
[407.238686] Starting dynamic subtest: pipe-A-eDP-1
[407.267560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[407.278569] Starting dynamic subtest: pipe-B-eDP-1
[407.294567] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[407.304710] Starting dynamic subtest: pipe-C-eDP-1
[407.318432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.025s)
[407.328727] Starting dynamic subtest: pipe-D-eDP-1
[407.346315] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[407.348482] Subtest lease-revoke: SUCCESS (0.112s)
[407.462245] [102/133] (614s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[407.512875] Starting subtest: multi-wait-available-unsubmitted-submitted
[407.515130] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[407.601951] [103/133] (614s left) gem_ctx_param (root-set)
[407.650320] Starting subtest: root-set
[407.652657] Subtest root-set: SUCCESS (0.001s)
[407.738802] [104/133] (613s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[407.833436] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[407.837860] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[407.927332] [105/133] (613s left) kms_flip (basic-flip-vs-wf_vblank)
[408.018474] Starting subtest: basic-flip-vs-wf_vblank
[408.020439] Starting dynamic subtest: A-eDP1
[409.978964] Dynamic subtest A-eDP1: SUCCESS (1.960s)
[409.993402] Starting dynamic subtest: B-eDP1
[411.907499] Dynamic subtest B-eDP1: SUCCESS (1.925s)
[411.923137] Starting dynamic subtest: C-eDP1
[413.835964] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[413.847517] Starting dynamic subtest: D-eDP1
[415.761968] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[415.764372] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.745s)
[416.994400] [106/133] (604s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[417.085090] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[417.087517] Starting dynamic subtest: pipe-A-eDP-1
[417.111379] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[417.124224] Starting dynamic subtest: pipe-B-eDP-1
[417.146126] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[417.155967] Starting dynamic subtest: pipe-C-eDP-1
[417.177845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[417.186858] Starting dynamic subtest: pipe-D-eDP-1
[417.208760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[417.212835] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[419.341339] [107/133] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[419.437451] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[426.514935] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.077s)
[426.651725] [108/133] (595s left) gem_mmap_wc (set-cache-level)
[426.719779] Subtest set-cache-level: SKIP (0.000s)
[426.783157] [109/133] (595s left) kms_force_connector_basic (force-edid)
[426.862416] Starting subtest: force-edid
[427.227147] Subtest force-edid: SUCCESS (0.365s)
[427.371914] [110/133] (594s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[427.486832] Starting subtest: 2x-long-cursor-vs-flip-atomic
[427.490561] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[427.634687] [111/133] (594s left) kms_psr (psr-sprite-blt)
[427.727598] Starting subtest: psr-sprite-blt
[427.729365] Starting dynamic subtest: eDP-1
[429.486441] Dynamic subtest eDP-1: SUCCESS (1.755s)
[429.488718] Subtest psr-sprite-blt: SUCCESS (1.755s)
[430.304252] [112/133] (591s left) kms_cursor_crc (cursor-random-32x10)
[430.478252] Starting subtest: cursor-random-32x10
[430.524055] Subtest cursor-random-32x10: SKIP (0.042s)
[430.774868] [113/133] (591s left) kms_flip (flip-vs-dpms-on-nop)
[430.859487] Starting subtest: flip-vs-dpms-on-nop
[430.861757] Starting dynamic subtest: A-eDP1
[432.745683] Dynamic subtest A-eDP1: SUCCESS (1.884s)
[432.758901] Starting dynamic subtest: B-eDP1
[434.555771] Dynamic subtest B-eDP1: SUCCESS (1.808s)
[434.573089] Starting dynamic subtest: C-eDP1
[436.439676] Dynamic subtest C-eDP1: SUCCESS (1.879s)
[436.451660] Starting dynamic subtest: D-eDP1
[438.332805] Dynamic subtest D-eDP1: SUCCESS (1.892s)
[438.337760] Subtest flip-vs-dpms-on-nop: SUCCESS (7.476s)
[439.504531] [114/133] (582s left) gem_exec_whisper (basic-fds-forked-all)
[439.565846] Starting subtest: basic-fds-forked-all
[460.388746] Subtest basic-fds-forked-all: SUCCESS (20.815s)
[460.573268] [115/133] (561s left) gem_exec_balancer (smoke)
[460.643184] Starting subtest: smoke
[483.253053] Subtest smoke: SUCCESS (22.599s)
[484.744779] [116/133] (537s left) kms_pm_rpm (universal-planes-dpms)
[486.881282] Starting subtest: universal-planes-dpms
[486.883920] Starting dynamic subtest: plane-34
[495.205721] Dynamic subtest plane-34: SUCCESS (8.324s)
[495.221830] Starting dynamic subtest: plane-64
[503.549825] Dynamic subtest plane-64: SUCCESS (8.338s)
[503.563233] Starting dynamic subtest: plane-94
[511.873950] Dynamic subtest plane-94: SUCCESS (8.319s)
[511.887260] Starting dynamic subtest: plane-124
[520.205722] Dynamic subtest plane-124: SUCCESS (8.327s)
[520.217426] Starting dynamic subtest: plane-134
[528.514690] Dynamic subtest plane-134: SUCCESS (8.303s)
[528.531215] Starting dynamic subtest: plane-144
[536.811597] Dynamic subtest plane-144: SUCCESS (8.291s)
[536.814432] Subtest universal-planes-dpms: SUCCESS (49.919s)
[537.199204] [117/133] (485s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[537.263235] Starting subtest: etime-multi-wait-all-for-submit-submitted
[537.368676] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[537.462872] [118/133] (484s left) gem_ctx_exec (basic-nohangcheck)
[537.537463] Starting subtest: basic-nohangcheck
[537.784675] Subtest basic-nohangcheck: SUCCESS (0.248s)
[537.918538] [119/133] (484s left) gem_mmap_offset (clear-via-pagefault)
[537.982606] Starting subtest: clear-via-pagefault
[537.984544] Starting dynamic subtest: smem0
[568.022441] Dynamic subtest smem0: SUCCESS (30.025s)
[568.025125] Subtest clear-via-pagefault: SUCCESS (30.027s)
[568.145719] [120/133] (454s left) gem_softpin (allocator-basic-reserve)
[568.203149] Starting subtest: allocator-basic-reserve
[568.279687] Subtest allocator-basic-reserve: SUCCESS (0.076s)
[568.406922] [121/133] (453s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[568.504819] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[568.507432] Starting dynamic subtest: pipe-A-eDP-1
[569.803880] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.301s)
[569.815025] Starting dynamic subtest: pipe-B-eDP-1
[572.153695] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.346s)
[572.164372] Starting dynamic subtest: pipe-C-eDP-1
[574.460252] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.306s)
[574.473118] Starting dynamic subtest: pipe-D-eDP-1
[576.872164] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.408s)
[576.874543] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.368s)
[578.022836] [122/133] (444s left) gem_exec_params (rsvd2-dirt)
[578.080466] Starting subtest: rsvd2-dirt
[578.085150] Subtest rsvd2-dirt: SKIP (0.000s)
[578.187978] [123/133] (444s left) kms_cursor_legacy (forked-move)
[578.333579] Starting subtest: forked-move
[578.335548] Starting dynamic subtest: pipe-A
[583.791669] Dynamic subtest pipe-A: SUCCESS (5.454s)
[583.804411] Starting dynamic subtest: pipe-B
[589.273938] Dynamic subtest pipe-B: SUCCESS (5.478s)
[589.286454] Starting dynamic subtest: pipe-C
[594.758556] Dynamic subtest pipe-C: SUCCESS (5.478s)
[594.771069] Starting dynamic subtest: pipe-D
[600.238880] Dynamic subtest pipe-D: SUCCESS (5.477s)
[600.251576] Starting dynamic subtest: all-pipes
[605.745649] Dynamic subtest all-pipes: SUCCESS (5.502s)
[605.748343] Subtest forked-move: SUCCESS (27.402s)
[605.899137] [124/133] (416s left) kms_draw_crc (draw-method-pwrite)
[605.996981] Starting subtest: draw-method-pwrite
[605.998973] Starting dynamic subtest: xrgb8888-untiled
[606.596492] Dynamic subtest xrgb8888-untiled: SUCCESS (0.601s)
[606.607295] Starting dynamic subtest: rgb565-untiled
[607.040843] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[607.053531] Starting dynamic subtest: xrgb2101010-untiled
[607.585907] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.542s)
[607.598500] Starting dynamic subtest: xbgr16161616f-untiled
[608.352653] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.764s)
[608.363556] Starting dynamic subtest: xrgb8888-xtiled
[610.142153] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.787s)
[610.152908] Starting dynamic subtest: rgb565-xtiled
[611.231336] Dynamic subtest rgb565-xtiled: SUCCESS (1.087s)
[611.242720] Starting dynamic subtest: xrgb2101010-xtiled
[613.009966] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.776s)
[613.021606] Starting dynamic subtest: xbgr16161616f-xtiled
[616.332818] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.321s)
[616.343986] Starting dynamic subtest: xrgb8888-4tiled
[617.455919] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.120s)
[617.466816] Starting dynamic subtest: rgb565-4tiled
[618.022658] Dynamic subtest rgb565-4tiled: SUCCESS (0.565s)
[618.033645] Starting dynamic subtest: xrgb2101010-4tiled
[619.122875] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s)
[619.134004] Starting dynamic subtest: xbgr16161616f-4tiled
[622.213347] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.088s)
[622.215898] Subtest draw-method-pwrite: SUCCESS (16.213s)
[622.337051] [125/133] (400s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[622.388087] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[622.390294] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[622.487196] [126/133] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[622.581116] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[622.585212] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[622.678973] [127/133] (399s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[622.765246] Starting subtest: read-crc-frame-sequence
[622.767241] Starting dynamic subtest: pipe-A-eDP-1
[623.498275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[623.509077] Starting dynamic subtest: pipe-B-eDP-1
[624.869263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[624.880045] Starting dynamic subtest: pipe-C-eDP-1
[626.234551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[626.245861] Starting dynamic subtest: pipe-D-eDP-1
[627.560900] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[627.563240] Subtest read-crc-frame-sequence: SUCCESS (4.795s)
[628.439837] [128/133] (394s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[628.544360] Starting subtest: y-tiled-8bpp-rotate-0
[628.548801] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[628.650107] [129/133] (394s left) gem_wait (await)
[628.731265] Starting subtest: await
[628.733716] Starting dynamic subtest: all-engines
[629.839250] Dynamic subtest all-engines: SUCCESS (1.107s)
[629.852058] Starting dynamic subtest: rcs0
[630.909172] Dynamic subtest rcs0: SUCCESS (1.067s)
[630.922508] Starting dynamic subtest: bcs0
[631.976595] Dynamic subtest bcs0: SUCCESS (1.064s)
[631.993195] Starting dynamic subtest: vcs0
[633.031946] Dynamic subtest vcs0: SUCCESS (1.053s)
[633.049496] Starting dynamic subtest: vcs1
[634.086820] Dynamic subtest vcs1: SUCCESS (1.052s)
[634.104793] Starting dynamic subtest: vecs0
[635.142005] Dynamic subtest vecs0: SUCCESS (1.052s)
[635.159608] Starting dynamic subtest: ccs0
[636.198748] Dynamic subtest ccs0: SUCCESS (1.054s)
[636.201143] Subtest await: SUCCESS (7.466s)
[636.400953] [130/133] (386s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[636.521081] Starting subtest: cursorA-vs-flipA-legacy
[647.642835] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.124s)
[648.438218] [131/133] (374s left) kms_rmfb (rmfb-ioctl)
[648.526601] Starting subtest: rmfb-ioctl
[648.528489] Starting dynamic subtest: pipe-A-eDP-1
[648.630189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[648.640606] Starting dynamic subtest: pipe-B-eDP-1
[649.842071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[649.853310] Starting dynamic subtest: pipe-C-eDP-1
[651.031755] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.193s)
[651.043348] Starting dynamic subtest: pipe-D-eDP-1
[652.222769] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[652.225044] Subtest rmfb-ioctl: SUCCESS (3.716s)
[653.403194] [132/133] (369s left) kms_vblank (crtc-id)
[653.504688] Starting subtest: crtc-id
[653.506604] Starting dynamic subtest: pipe-A-eDP-1
[653.942558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[653.965272] Starting dynamic subtest: pipe-D-eDP-1
[655.102274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.161s)
[655.104381] Subtest crtc-id: SUCCESS (1.605s)
[655.903560] [133/133] (367s left) syncobj_wait (invalid-signal-bad-pad)
[655.966736] Starting subtest: invalid-signal-bad-pad
[655.968994] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[656.065352] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_pxp
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_getfb
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_atomic_interruptible
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: i915_pm_freq_api
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gen7_exec_parse
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_vrr
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: gem_pwrite
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ccs
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_ppgtt
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: kms_atomic
results: parsing output: 60/ for test: gem_create
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: i915_pm_sseu
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_color_pipeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_atomic_interruptible
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_selftest
results: parsing output: 98/ for test: dmabuf_sync_file
results: parsing output: 99/ for test: kms_pipe_b_c_ivb
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_ctx_param
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_force_connector_basic
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_ctx_exec
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_draw_crc
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pipe_crc_basic
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_rmfb
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: syncobj_wait
Done.