[58.786839] Initializing watchdogs
[58.786884]   /dev/watchdog0
[58.802259] [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]
[58.806699] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.809026] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.812481] [001/154] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[58.932994] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[58.935319] Starting dynamic subtest: pipe-A-eDP-1
[58.996970] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[59.009497] Starting dynamic subtest: pipe-B-eDP-1
[59.068859] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[59.079832] Starting dynamic subtest: pipe-C-eDP-1
[59.138719] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[59.148575] Starting dynamic subtest: pipe-D-eDP-1
[59.209133] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[59.213835] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[61.272963] [002/154] (958s left) gem_exec_balancer (semaphore)
[61.339896] Starting subtest: semaphore
[63.286882] Subtest semaphore: SUCCESS (1.947s)
[63.617722] [003/154] (955s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[63.713090] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[63.717100] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[63.793303] [004/154] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[63.889735] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[68.236628] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.354s)
[69.395186] [005/154] (950s left) kms_pm_rpm (system-suspend-idle)
[71.452959] Starting subtest: system-suspend-idle
[91.114122] Subtest system-suspend-idle: SUCCESS (4.814s)
[91.500921] [006/154] (927s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[91.607643] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[91.611801] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[91.727989] [007/154] (927s left) kms_psr (psr-cursor-render)
[91.831878] Starting subtest: psr-cursor-render
[91.834238] Starting dynamic subtest: eDP-1
[93.619071] Dynamic subtest eDP-1: SUCCESS (1.785s)
[93.621028] Subtest psr-cursor-render: SUCCESS (1.785s)
[94.483547] [008/154] (925s left) gem_exec_schedule (semaphore-noskip)
[94.560676] Starting subtest: semaphore-noskip
[94.968053] Subtest semaphore-noskip: SUCCESS (0.414s)
[95.309137] [009/154] (924s left) gem_userptr_blits (unsync-unmap)
[95.382002] Subtest unsync-unmap: SKIP (0.000s)
[95.517922] [010/154] (924s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[95.620422] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[102.189353] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.575s)
[102.303644] [011/154] (917s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[102.418903] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[103.256053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[103.440037] [012/154] (916s left) kms_cursor_crc (cursor-random-256x256)
[103.670512] Starting subtest: cursor-random-256x256
[103.675463] Starting dynamic subtest: pipe-A-eDP-1
[107.033917] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.358s)
[107.065264] Starting dynamic subtest: pipe-D-eDP-1
[111.032725] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.976s)
[111.035230] Subtest cursor-random-256x256: SUCCESS (7.361s)
[111.885692] [013/154] (907s left) gem_basic (bad-close)
[111.946138] Starting subtest: bad-close
[111.950117] Subtest bad-close: SUCCESS (0.000s)
[112.049328] [014/154] (907s left) gem_exec_fence (submit-chain)
[112.226951] Starting subtest: submit-chain
[112.243743] Subtest submit-chain: SUCCESS (0.017s)
[114.188437] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[114.192784] [015/154] (905s left) gem_eio (in-flight-10ms)
[114.408984] Starting subtest: in-flight-10ms
[123.013271] Subtest in-flight-10ms: SUCCESS (8.604s)
[123.183169] [016/154] (896s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[123.287589] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[123.289870] Starting dynamic subtest: pipe-A
[123.309858] Dynamic subtest pipe-A: SKIP (0.020s)
[123.320582] Starting dynamic subtest: pipe-B
[123.349977] Dynamic subtest pipe-B: SKIP (0.039s)
[123.360349] Starting dynamic subtest: pipe-C
[123.388120] Dynamic subtest pipe-C: SKIP (0.039s)
[123.397749] Starting dynamic subtest: pipe-D
[123.422932] Dynamic subtest pipe-D: SKIP (0.034s)
[123.427266] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.133s)
[123.531089] [017/154] (896s left) kms_addfb_basic (unused-modifier)
[123.584957] Starting subtest: unused-modifier
[123.587247] Subtest unused-modifier: SUCCESS (0.000s)
[123.723888] [018/154] (896s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[123.825237] Starting subtest: fb-8bpc-vs-panel-8bpc
[123.827173] Starting dynamic subtest: pipe-A-eDP-1
[125.278298] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.454s)
[125.280733] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.455s)
[126.133220] [019/154] (893s left) kms_content_protection (type1)
[126.278348] Starting subtest: type1
[126.283973] Subtest type1: SKIP (0.000s)
[126.398161] [020/154] (893s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[126.493647] Starting subtest: fbc-rgb565-draw-render
[130.768176] Subtest fbc-rgb565-draw-render: SUCCESS (4.281s)
[131.943100] [021/154] (888s left) kms_draw_crc (draw-method-blt)
[132.035450] Starting subtest: draw-method-blt
[132.037402] Starting dynamic subtest: xrgb8888-untiled
[132.300661] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[132.312807] Starting dynamic subtest: rgb565-untiled
[132.544937] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[132.557049] Starting dynamic subtest: xrgb2101010-untiled
[132.766982] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[132.777382] Starting dynamic subtest: xbgr16161616f-untiled
[133.000454] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[133.010544] Starting dynamic subtest: xrgb8888-xtiled
[133.122334] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[133.133115] Starting dynamic subtest: rgb565-xtiled
[133.244271] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[133.255863] Starting dynamic subtest: xrgb2101010-xtiled
[133.355499] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[133.365341] Starting dynamic subtest: xbgr16161616f-xtiled
[133.466636] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.109s)
[133.477179] Starting dynamic subtest: xrgb8888-4tiled
[133.588629] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[133.597917] Starting dynamic subtest: rgb565-4tiled
[133.712156] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[133.724301] Starting dynamic subtest: xrgb2101010-4tiled
[133.821982] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[133.831417] Starting dynamic subtest: xbgr16161616f-4tiled
[133.933090] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[133.935264] Subtest draw-method-blt: SUCCESS (1.900s)
[134.038330] [022/154] (886s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[134.143444] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[134.146723] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[134.238448] [023/154] (885s left) perf_pmu (busy-accuracy-2)
[134.276576] Starting subtest: busy-accuracy-2
[134.278562] Starting dynamic subtest: rcs0
[137.320019] Dynamic subtest rcs0: SUCCESS (3.040s)
[137.332571] Starting dynamic subtest: bcs0
[140.371281] Dynamic subtest bcs0: SUCCESS (3.051s)
[140.382036] Starting dynamic subtest: vcs0
[143.416886] Dynamic subtest vcs0: SUCCESS (3.045s)
[143.429159] Starting dynamic subtest: vcs1
[146.462567] Dynamic subtest vcs1: SUCCESS (3.045s)
[146.475033] Starting dynamic subtest: vecs0
[149.503762] Dynamic subtest vecs0: SUCCESS (3.040s)
[149.515612] Starting dynamic subtest: ccs0
[152.558446] Dynamic subtest ccs0: SUCCESS (3.054s)
[152.560735] Subtest busy-accuracy-2: SUCCESS (18.283s)
[152.687983] [024/154] (867s left) gem_exec_balancer (nop)
[152.756825] Starting subtest: nop
[199.365914] Subtest nop: SUCCESS (46.609s)
[199.673788] [025/154] (820s left) gem_sync (basic-store-each)
[199.755966] Starting subtest: basic-store-each
[202.359778] Subtest basic-store-each: SUCCESS (2.614s)
[202.548663] [026/154] (817s left) kms_psr (fbc-pr-sprite-plane-move)
[202.657171] Starting subtest: fbc-pr-sprite-plane-move
[202.661448] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[202.742971] [027/154] (817s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[202.859809] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[203.848694] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.987s)
[204.665413] [028/154] (815s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[204.777712] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[204.782132] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[204.879919] [029/154] (815s left) gem_mmap_gtt (fault-concurrent-y)
[204.931663] Subtest fault-concurrent-Y: SKIP (0.000s)
[204.987216] [030/154] (815s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[205.077822] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[205.079974] Starting dynamic subtest: pipe-A-eDP-1
[205.197387] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s)
[205.208994] Starting dynamic subtest: pipe-B-eDP-1
[206.438598] Dynamic subtest pipe-B-eDP-1: SKIP (1.239s)
[206.443329] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.364s)
[207.639106] [031/154] (812s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[207.733427] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[207.737765] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[207.837696] [032/154] (812s left) kms_psr (fbc-pr-primary-render)
[207.931903] Starting subtest: fbc-pr-primary-render
[207.935965] Subtest fbc-pr-primary-render: SKIP (0.000s)
[208.030506] [033/154] (812s left) gen9_exec_parse (secure-batches)
[208.087066] Subtest secure-batches: SKIP (0.000s)
[208.161471] [034/154] (812s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[208.278481] Starting subtest: fbchdr-tiling-linear
[208.282708] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[208.376503] [035/154] (812s left) sw_sync (sync_multi_producer_single_consumer)
[208.414432] Starting subtest: sync_multi_producer_single_consumer
[209.489318] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[209.553892] [036/154] (811s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[209.644575] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[209.649093] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[209.772576] [037/154] (811s left) gem_lmem_swapping (parallel-multi)
[209.817397] Subtest parallel-multi: SKIP (0.000s)
[209.865617] [038/154] (810s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[209.964777] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[209.969152] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[210.073333] [039/154] (810s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[210.164072] Starting subtest: fbchdr-farfromfence-mmap-gtt
[210.168530] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[210.267624] [040/154] (810s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[210.368667] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[210.373519] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[210.484633] [041/154] (810s left) gem_exec_flush (basic-uc-rw-default)
[210.542774] Starting subtest: basic-uc-rw-default
[216.003808] Subtest basic-uc-rw-default: SUCCESS (5.460s)
[216.195942] [042/154] (804s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[216.295185] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[216.297563] Starting dynamic subtest: pipe-A-eDP-1
[216.320646] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.332801] Starting dynamic subtest: pipe-B-eDP-1
[216.354431] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.364168] Starting dynamic subtest: pipe-C-eDP-1
[216.385830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.395338] Starting dynamic subtest: pipe-D-eDP-1
[216.419186] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.423613] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[218.602408] [043/154] (802s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[218.653962] Starting subtest: multi-wait-for-submit-submitted-signaled
[218.656484] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[218.770420] [044/154] (802s left) gem_exec_flush (basic-uc-set-default)
[218.840287] Starting subtest: basic-uc-set-default
[224.298921] Subtest basic-uc-set-default: SUCCESS (5.459s)
[224.483290] [045/154] (796s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[224.583874] Starting subtest: fbc-farfromfence-mmap-gtt
[224.588294] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[224.713895] [046/154] (796s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[224.818141] Starting subtest: fbcpsr-slowdraw
[250.102128] Subtest fbcpsr-slowdraw: SUCCESS (25.290s)
[250.240744] [047/154] (770s left) kms_vblank (ts-continuation-modeset-hang)
[250.345329] Starting subtest: ts-continuation-modeset-hang
[250.347621] Starting dynamic subtest: pipe-A-eDP-1
[276.934462] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.588s)
[276.952288] Starting dynamic subtest: pipe-D-eDP-1
[291.916252] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[291.918690] Subtest ts-continuation-modeset-hang: SUCCESS (41.573s)
[292.805041] [048/154] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[292.915626] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[292.920247] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[293.029551] [049/154] (728s left) gem_exec_reloc (basic-write-read-active)
[293.096505] Subtest basic-write-read-active: SKIP (0.000s)
[293.169079] [050/154] (728s left) kms_chamelium_color (ctm-negative)
[293.270407] Subtest ctm-negative: SKIP (0.000s)
[293.316350] [051/154] (728s left) kms_cursor_crc (cursor-sliding-32x10)
[293.493610] Starting subtest: cursor-sliding-32x10
[293.546191] Subtest cursor-sliding-32x10: SKIP (0.047s)
[293.812586] [052/154] (727s left) kms_frontbuffer_tracking (psr-suspend)
[293.908318] Starting subtest: psr-suspend
[332.516897] Subtest psr-suspend: SUCCESS (7.974s)
[332.655667] [053/154] (688s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[332.756607] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[332.761150] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[332.834284] [054/154] (688s left) gem_mmap_gtt (fault-concurrent)
[332.886203] Subtest fault-concurrent: SKIP (0.000s)
[332.945565] [055/154] (688s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[333.042196] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[333.046269] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[333.136647] [056/154] (688s left) kms_plane_alpha_blend (constant-alpha-max)
[333.219630] Starting subtest: constant-alpha-max
[333.510355] Starting dynamic subtest: pipe-A-eDP-1
[334.736753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.224s)
[334.748414] Starting dynamic subtest: pipe-D-eDP-1
[336.472201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.731s)
[336.475165] Subtest constant-alpha-max: SUCCESS (3.251s)
[337.285526] [057/154] (684s left) vgem_basic (second-client)
[337.336372] Starting subtest: second-client
[337.359117] Subtest second-client: SUCCESS (0.022s)
[337.417425] [058/154] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[337.521763] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[344.558689] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.037s)
[344.710872] [059/154] (677s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[344.822266] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[344.826706] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[344.912278] [060/154] (676s left) gem_exec_fence (syncobj-timeline-unused-fence)
[345.450830] Starting subtest: syncobj-timeline-unused-fence
[345.456892] Subtest syncobj-timeline-unused-fence: SUCCESS (0.008s)
[346.882471] [061/154] (674s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[346.942350] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[346.946788] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[347.142114] [062/154] (674s left) i915_drm_fdinfo (isolation)
[347.182606] Starting subtest: isolation
[347.184864] Starting dynamic subtest: rcs0
[347.207655] Dynamic subtest rcs0: SKIP (0.025s)
[347.220224] Starting dynamic subtest: bcs0
[347.224857] Dynamic subtest bcs0: SKIP (0.000s)
[347.235390] Starting dynamic subtest: vcs0
[347.239917] Dynamic subtest vcs0: SKIP (0.000s)
[347.250188] Starting dynamic subtest: vcs1
[347.254661] Dynamic subtest vcs1: SKIP (0.000s)
[347.264431] Starting dynamic subtest: vecs0
[347.268906] Dynamic subtest vecs0: SKIP (0.000s)
[347.278716] Starting dynamic subtest: ccs0
[347.283176] Dynamic subtest ccs0: SKIP (0.000s)
[347.287645] Subtest isolation: SKIP (0.030s)
[347.329839] [063/154] (674s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[347.424844] Starting subtest: 2x-flip-vs-rmfb-interruptible
[347.436953] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[347.514498] [064/154] (674s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[347.610231] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[347.614310] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[347.716200] [065/154] (674s left) gem_partial_pwrite_pread (write-display)
[347.769973] Subtest write-display: SKIP (0.000s)
[347.837809] [066/154] (674s left) gem_mmap (basic)
[347.886172] Subtest basic: SKIP (0.000s)
[347.951286] [067/154] (674s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[347.998113] Starting subtest: etime-single-wait-for-submit-unsubmitted
[348.105587] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[348.184894] [068/154] (673s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[348.284859] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[348.289203] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[348.377344] [069/154] (673s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[348.465320] Starting subtest: plane-lut1d-ctm3x4-lut1d
[348.634730] Starting dynamic subtest: pipe-A-plane-0
[348.812853] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[348.824391] Starting dynamic subtest: pipe-A-plane-1
[348.968057] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[348.979131] Starting dynamic subtest: pipe-A-plane-2
[349.123297] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[350.359202] Starting dynamic subtest: pipe-B-plane-0
[350.516478] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[350.527228] Starting dynamic subtest: pipe-B-plane-1
[350.694726] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[350.705517] Starting dynamic subtest: pipe-B-plane-2
[350.884342] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[352.059226] Starting dynamic subtest: pipe-C-plane-0
[352.206020] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[352.216791] Starting dynamic subtest: pipe-C-plane-1
[352.372756] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[352.383491] Starting dynamic subtest: pipe-C-plane-2
[352.539809] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[353.803762] Starting dynamic subtest: pipe-D-plane-0
[353.962085] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[353.973639] Starting dynamic subtest: pipe-D-plane-1
[354.128794] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[354.139589] Starting dynamic subtest: pipe-D-plane-2
[354.295614] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[354.583354] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.115s)
[355.440614] [070/154] (666s left) prime_mmap_kms (buffer-sharing)
[355.545905] Starting subtest: buffer-sharing
[355.990351] Subtest buffer-sharing: SUCCESS (0.444s)
[356.873505] [071/154] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[356.982748] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[356.986725] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[357.082310] [072/154] (665s left) i915_pm_freq_api (freq-reset-multiple)
[357.141118] Starting subtest: freq-reset-multiple
[357.143378] Starting dynamic subtest: gt0
[366.656415] Dynamic subtest gt0: SUCCESS (9.515s)
[366.668422] Starting dynamic subtest: gt1
[375.288149] Dynamic subtest gt1: SUCCESS (8.631s)
[375.290918] Subtest freq-reset-multiple: SUCCESS (18.148s)
[375.382063] [073/154] (646s left) kms_atomic_transition (plane-all-modeset-transition)
[375.488133] Starting subtest: plane-all-modeset-transition
[375.492632] Subtest plane-all-modeset-transition: SKIP (0.000s)
[375.562506] [074/154] (646s left) gem_ctx_param (set-priority-invalid-size)
[375.627336] Starting subtest: set-priority-invalid-size
[375.629583] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[375.702137] [075/154] (646s left) perf_pmu (enable-race)
[375.764129] Starting subtest: enable-race
[375.766430] Starting dynamic subtest: rcs0
[388.551374] Dynamic subtest rcs0: SUCCESS (12.791s)
[388.562451] Starting dynamic subtest: bcs0
[401.297927] Dynamic subtest bcs0: SUCCESS (12.743s)
[401.310771] Starting dynamic subtest: vcs0
[416.750092] Dynamic subtest vcs0: SUCCESS (15.446s)
[416.763191] Starting dynamic subtest: vcs1
[432.750410] Dynamic subtest vcs1: SUCCESS (15.996s)
[432.761781] Starting dynamic subtest: vecs0
[448.749018] Dynamic subtest vecs0: SUCCESS (15.997s)
[448.760547] Starting dynamic subtest: ccs0
[461.491646] Dynamic subtest ccs0: SUCCESS (12.741s)
[461.494114] Subtest enable-race: SUCCESS (85.729s)
[461.593690] [076/154] (560s left) api_intel_bb (blit-reloc-purge-cache)
[461.645876] Starting subtest: blit-reloc-purge-cache
[461.650470] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[461.768715] [077/154] (560s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[461.862669] Starting subtest: sprite-rotation-90-pos-100-0
[461.867145] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[461.938592] [078/154] (560s left) kms_invalid_mode (bad-vtotal)
[462.045477] Starting subtest: bad-vtotal
[462.048221] Starting dynamic subtest: pipe-A-eDP-1
[462.331710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[462.342801] Starting dynamic subtest: pipe-B-eDP-1
[462.344668] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[462.354801] Starting dynamic subtest: pipe-C-eDP-1
[462.356970] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[462.367249] Starting dynamic subtest: pipe-D-eDP-1
[462.369399] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[462.371632] Subtest bad-vtotal: SUCCESS (0.295s)
[463.200347] [079/154] (559s left) gem_ctx_engines (none)
[463.253694] Starting subtest: none
[463.256150] Subtest none: SUCCESS (0.001s)
[463.441239] [080/154] (559s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[463.545334] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[463.550013] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[463.668874] [081/154] (559s left) syncobj_eventfd (invalid-illegal-eventfd)
[463.723989] Starting subtest: invalid-illegal-eventfd
[463.725909] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[463.844484] [082/154] (558s left) gem_ctx_shared (exec-shared-gtt)
[463.910193] Starting subtest: exec-shared-gtt
[463.912138] Starting dynamic subtest: rcs0
[463.917901] Dynamic subtest rcs0: SUCCESS (0.010s)
[463.931030] Starting dynamic subtest: bcs0
[463.933175] Dynamic subtest bcs0: SUCCESS (0.007s)
[463.944323] Starting dynamic subtest: vcs0
[463.946798] Dynamic subtest vcs0: SUCCESS (0.009s)
[463.957771] Starting dynamic subtest: vcs1
[463.960036] Dynamic subtest vcs1: SUCCESS (0.007s)
[463.970265] Starting dynamic subtest: vecs0
[463.972461] Dynamic subtest vecs0: SUCCESS (0.006s)
[463.982677] Starting dynamic subtest: ccs0
[463.984863] Dynamic subtest ccs0: SUCCESS (0.007s)
[463.987074] Subtest exec-shared-gtt: SUCCESS (0.052s)
[464.145849] [083/154] (558s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[464.251879] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[464.255733] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[464.364992] [084/154] (558s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[464.477703] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[464.481279] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[464.567751] [085/154] (558s left) gem_exec_schedule (preempt-queue-chain)
[464.640863] Subtest preempt-queue-chain: SKIP (0.000s)
[464.937668] [086/154] (557s left) kms_pwrite_crc (basic)
[465.034677] Starting subtest: basic
[465.745645] Subtest basic: SUCCESS (0.712s)
[466.635517] [087/154] (556s left) gem_userptr_blits (vma-merge)
[466.704340] Starting subtest: vma-merge
[466.750433] Subtest vma-merge: SUCCESS (0.046s)
[466.878489] [088/154] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[466.980683] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[466.984728] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[467.071931] [089/154] (555s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[467.182779] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[467.187004] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[467.281748] [090/154] (555s left) kms_chamelium_hpd (hdmi-hpd-fast)
[467.660980] Subtest hdmi-hpd-fast: SKIP (0.000s)
[468.449849] [091/154] (554s left) gem_softpin (evict-snoop-interruptible)
[468.527831] Starting subtest: evict-snoop-interruptible
[468.532458] Subtest evict-snoop-interruptible: SKIP (0.000s)
[468.658861] [092/154] (554s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[468.756329] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[468.760418] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[468.874138] [093/154] (554s left) prime_vgem (fence-wait)
[468.954521] Starting subtest: fence-wait
[468.956752] Starting dynamic subtest: rcs0
[469.995129] Dynamic subtest rcs0: SUCCESS (1.039s)
[470.008275] Starting dynamic subtest: bcs0
[471.058623] Dynamic subtest bcs0: SUCCESS (1.062s)
[471.072330] Starting dynamic subtest: vcs0
[472.102300] Dynamic subtest vcs0: SUCCESS (1.041s)
[472.113425] Starting dynamic subtest: vcs1
[473.143043] Dynamic subtest vcs1: SUCCESS (1.039s)
[473.153554] Starting dynamic subtest: vecs0
[474.184452] Dynamic subtest vecs0: SUCCESS (1.039s)
[474.195483] Starting dynamic subtest: ccs0
[475.226500] Dynamic subtest ccs0: SUCCESS (1.039s)
[475.229426] Subtest fence-wait: SUCCESS (6.271s)
[475.354743] [094/154] (547s left) gem_pxp (reject-modify-context-protection-off-3)
[475.465872] Starting subtest: reject-modify-context-protection-off-3
[475.468482] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[475.576718] [095/154] (547s left) gem_busy (parallel)
[475.759317] Starting subtest: parallel
[475.761912] Starting dynamic subtest: rcs0
[477.806751] Dynamic subtest rcs0: SUCCESS (2.045s)
[477.820510] Starting dynamic subtest: bcs0
[479.790281] Dynamic subtest bcs0: SUCCESS (1.979s)
[479.803410] Starting dynamic subtest: vcs0
[481.774217] Dynamic subtest vcs0: SUCCESS (1.981s)
[481.788639] Starting dynamic subtest: vcs1
[483.757957] Dynamic subtest vcs1: SUCCESS (1.980s)
[483.771428] Starting dynamic subtest: vecs0
[485.805556] Dynamic subtest vecs0: SUCCESS (2.045s)
[485.818367] Starting dynamic subtest: ccs0
[487.790399] Dynamic subtest ccs0: SUCCESS (1.981s)
[487.793255] Subtest parallel: SUCCESS (12.030s)
[487.998215] [096/154] (535s left) kms_psr (psr2-cursor-render)
[488.094699] Starting subtest: psr2-cursor-render
[488.096894] Starting dynamic subtest: eDP-1
[489.837976] Dynamic subtest eDP-1: SUCCESS (1.742s)
[489.840229] Subtest psr2-cursor-render: SUCCESS (1.743s)
[490.731105] [097/154] (532s left) kms_lease (multimaster-lease)
[490.833333] Starting subtest: multimaster-lease
[490.835693] Subtest multimaster-lease: SUCCESS (0.003s)
[490.945431] [098/154] (532s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[491.044634] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[491.046514] Starting dynamic subtest: pipe-A-eDP-1
[493.384035] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.339s)
[493.399577] Starting dynamic subtest: pipe-B-eDP-1
[495.978259] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.594s)
[495.988814] Starting dynamic subtest: pipe-C-eDP-1
[498.360286] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.382s)
[498.371100] Starting dynamic subtest: pipe-D-eDP-1
[500.682400] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.321s)
[500.684448] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.640s)
[501.861471] [099/154] (521s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[501.970905] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[501.975089] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[502.077002] [100/154] (521s left) gem_ctx_param (invalid-param-get)
[502.136150] Starting subtest: invalid-param-get
[502.138676] Subtest invalid-param-get: SUCCESS (0.001s)
[502.262745] [101/154] (521s left) gem_softpin (allocator-fork)
[502.314621] Starting subtest: allocator-fork
[504.529997] Subtest allocator-fork: SUCCESS (2.215s)
[504.677342] [102/154] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[504.795742] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[504.799714] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[504.902106] [103/154] (518s left) i915_pm_rpm (gem-mmap-type)
[506.942985] Starting subtest: gem-mmap-type
[506.945916] Starting dynamic subtest: wb-smem0
[510.456836] Dynamic subtest wb-smem0: SUCCESS (3.511s)
[510.470122] Starting dynamic subtest: wc-smem0
[513.364296] Dynamic subtest wc-smem0: SUCCESS (2.906s)
[513.378760] Starting dynamic subtest: uc-smem0
[516.559485] Dynamic subtest uc-smem0: SUCCESS (3.194s)
[516.561729] Subtest gem-mmap-type: SUCCESS (9.615s)
[516.668242] [104/154] (507s left) gem_mmap_gtt (pf-nonblock)
[516.721279] Subtest pf-nonblock: SKIP (0.000s)
[516.787766] [105/154] (506s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[516.895517] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[516.899853] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[516.995746] [106/154] (506s left) syncobj_timeline (single-wait-available-signaled)
[517.044121] Starting subtest: single-wait-available-signaled
[517.046387] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[517.137935] [107/154] (506s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[517.241137] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[517.245504] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[517.353784] [108/154] (506s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[517.448282] Starting subtest: y-tiled-8bpp-rotate-90
[517.452676] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[517.558962] [109/154] (506s left) i915_pm_rps (thresholds-idle)
[517.611641] Starting subtest: thresholds-idle
[517.615250] Subtest thresholds-idle: SKIP (0.001s)
[517.720645] [110/154] (506s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[517.820430] Starting subtest: 4-tiled-32bpp-rotate-180
[519.300039] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.480s)
[519.469707] [111/154] (504s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[519.573341] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[519.576987] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[519.668268] [112/154] (504s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[520.068187] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[520.857220] [113/154] (503s left) kms_flip (plain-flip-interruptible)
[520.955124] Starting subtest: plain-flip-interruptible
[520.957525] Starting dynamic subtest: A-eDP1
[522.671653] Dynamic subtest A-eDP1: SUCCESS (1.715s)
[522.687843] Starting dynamic subtest: B-eDP1
[524.313076] Dynamic subtest B-eDP1: SUCCESS (1.637s)
[524.326171] Starting dynamic subtest: C-eDP1
[525.934880] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[525.946019] Starting dynamic subtest: D-eDP1
[527.559387] Dynamic subtest D-eDP1: SUCCESS (1.623s)
[527.561887] Subtest plain-flip-interruptible: SUCCESS (6.607s)
[528.731469] [114/154] (495s left) kms_psr (fbc-psr-sprite-blt)
[528.824487] Starting subtest: fbc-psr-sprite-blt
[528.826694] Starting dynamic subtest: eDP-1
[528.830733] Dynamic subtest eDP-1: SKIP (0.000s)
[528.834754] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[528.898874] [115/154] (495s left) core_debugfs (read-all-entries)
[528.953379] Starting subtest: read-all-entries
[529.051286] Subtest read-all-entries: SUCCESS (0.097s)
[529.119221] [116/154] (495s left) dumb_buffer (map-uaf)
[529.165218] Starting subtest: map-uaf
[529.167846] Subtest map-uaf: SUCCESS (0.005s)
[529.273247] [117/154] (494s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[529.365172] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[529.367397] Starting dynamic subtest: pipe-A-eDP-1
[529.389950] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[529.401920] Starting dynamic subtest: pipe-B-eDP-1
[529.424032] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[529.434771] Starting dynamic subtest: pipe-C-eDP-1
[529.456692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[529.468999] Starting dynamic subtest: pipe-D-eDP-1
[529.490703] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[529.494993] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[531.692785] [118/154] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[531.800789] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[531.805031] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[531.915459] [119/154] (492s left) gem_partial_pwrite_pread (reads)
[531.969576] Subtest reads: SKIP (0.000s)
[532.032452] [120/154] (492s left) kms_getfb (getfb-handle-valid)
[532.121040] Starting subtest: getfb-handle-valid
[532.123404] Subtest getfb-handle-valid: SUCCESS (0.000s)
[532.212702] [121/154] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[532.306385] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[539.096045] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.794s)
[539.258138] [122/154] (485s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[539.360451] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[539.362997] Starting dynamic subtest: pipe-A
[539.710462] Dynamic subtest pipe-A: SUCCESS (0.353s)
[539.722469] Starting dynamic subtest: pipe-B
[541.120694] Dynamic subtest pipe-B: SUCCESS (1.409s)
[541.132588] Starting dynamic subtest: pipe-C
[542.529313] Dynamic subtest pipe-C: SUCCESS (1.408s)
[542.542661] Starting dynamic subtest: pipe-D
[543.950524] Dynamic subtest pipe-D: SUCCESS (1.420s)
[543.952888] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.593s)
[545.123070] [123/154] (479s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[545.238402] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[545.242458] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[545.339090] [124/154] (479s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[545.432540] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[545.434842] Starting dynamic subtest: pipe-A-eDP-1
[545.507142] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[545.522377] Starting dynamic subtest: pipe-B-eDP-1
[546.708993] Dynamic subtest pipe-B-eDP-1: SKIP (1.197s)
[546.713808] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.280s)
[548.000130] [125/154] (476s left) gem_flink_race (flink_close)
[548.036538] Starting subtest: flink_close
[553.114267] Subtest flink_close: SUCCESS (5.079s)
[553.195470] [126/154] (471s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[553.310156] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[553.314521] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[553.434651] [127/154] (471s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[553.534570] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[553.538744] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[553.659124] [128/154] (471s left) kms_cursor_crc (cursor-onscreen-64x21)
[553.873434] Starting subtest: cursor-onscreen-64x21
[553.922258] Subtest cursor-onscreen-64x21: SKIP (0.047s)
[554.189789] [129/154] (470s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[554.287921] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[554.291591] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[554.360506] [130/154] (470s left) kms_atomic (plane-immutable-zpos)
[554.456737] Starting subtest: plane-immutable-zpos
[554.458622] Starting dynamic subtest: pipe-A-eDP-1
[555.103124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[555.105052] Subtest plane-immutable-zpos: SUCCESS (0.646s)
[555.943165] [131/154] (468s left) gem_pxp (create-regular-buffer)
[556.045241] Starting subtest: create-regular-buffer
[556.047535] Subtest create-regular-buffer: SUCCESS (0.000s)
[556.165902] [132/154] (468s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt)
[556.274369] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt
[556.278642] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[556.364112] [133/154] (468s left) kms_flip (wf_vblank-ts-check)
[556.451145] Starting subtest: wf_vblank-ts-check
[556.453525] Starting dynamic subtest: A-eDP1
[565.380225] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[565.394185] Starting dynamic subtest: B-eDP1
[574.317338] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[574.330199] Starting dynamic subtest: C-eDP1
[583.242634] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[583.253644] Starting dynamic subtest: D-eDP1
[592.164923] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[592.170437] Subtest wf_vblank-ts-check: SUCCESS (35.721s)
[593.401694] [134/154] (431s left) kms_hdr (static-swap)
[593.497978] Starting subtest: static-swap
[593.500360] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[593.504798] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[593.515975] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[593.520188] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[593.524615] Subtest static-swap: SKIP (0.003s)
[593.586238] [135/154] (431s left) kms_addfb_basic (legacy-format)
[593.635852] Starting subtest: legacy-format
[593.665423] Subtest legacy-format: SUCCESS (0.029s)
[593.804915] [136/154] (431s left) gem_exec_reloc (basic-cpu-gtt)
[593.863232] Subtest basic-cpu-gtt: SKIP (0.000s)
[593.944086] [137/154] (431s left) perf_pmu (frequency)
[593.986881] Starting subtest: frequency
[593.989303] Starting dynamic subtest: gt0
[596.100985] Dynamic subtest gt0: SUCCESS (2.109s)
[596.112598] Starting dynamic subtest: idle-gt0
[596.625531] Dynamic subtest idle-gt0: SUCCESS (0.523s)
[596.638899] Starting dynamic subtest: gt1
[600.850808] Dynamic subtest gt1: SUCCESS (4.190s)
[600.864162] Starting dynamic subtest: idle-gt1
[601.323150] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[601.326018] Subtest frequency: SUCCESS (7.339s)
[601.434973] [138/154] (423s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[601.546248] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[601.550365] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[601.660004] [139/154] (423s left) gem_ctx_isolation (nonpriv)
[601.728280] Starting subtest: nonpriv
[601.730610] Starting dynamic subtest: rcs0
[601.959460] Dynamic subtest rcs0: SUCCESS (0.234s)
[601.971106] Starting dynamic subtest: bcs0
[602.221112] Dynamic subtest bcs0: SUCCESS (0.261s)
[602.233053] Starting dynamic subtest: vcs0
[602.470299] Dynamic subtest vcs0: SUCCESS (0.248s)
[602.481037] Starting dynamic subtest: vcs1
[603.959155] Dynamic subtest vcs1: SUCCESS (1.487s)
[603.972787] Starting dynamic subtest: vecs0
[606.041320] Dynamic subtest vecs0: SUCCESS (2.081s)
[606.054622] Starting dynamic subtest: ccs0
[608.059211] Dynamic subtest ccs0: SUCCESS (2.017s)
[608.061697] Subtest nonpriv: SUCCESS (6.335s)
[608.322025] [140/154] (416s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[608.428669] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[608.432707] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[608.524821] [141/154] (416s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[608.618819] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[608.622685] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[608.692518] [142/154] (416s left) kms_vblank (query-idle)
[608.785437] Starting subtest: query-idle
[608.787635] Starting dynamic subtest: pipe-A-eDP-1
[610.534214] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[610.549659] Starting dynamic subtest: pipe-D-eDP-1
[612.946697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.409s)
[612.948993] Subtest query-idle: SUCCESS (4.162s)
[613.767005] [143/154] (411s left) gem_ctx_persistence (legacy-engines-mixed-process)
[613.833287] Starting subtest: legacy-engines-mixed-process
[613.835554] Starting dynamic subtest: render
[615.798701] Dynamic subtest render: SUCCESS (1.965s)
[615.809870] Starting dynamic subtest: bsd1
[617.789534] Dynamic subtest bsd1: SUCCESS (1.989s)
[617.802841] Starting dynamic subtest: bsd2
[619.780385] Dynamic subtest bsd2: SUCCESS (1.989s)
[619.796051] Starting dynamic subtest: blt
[621.828653] Dynamic subtest blt: SUCCESS (2.045s)
[621.841139] Starting dynamic subtest: vebox
[623.793350] Dynamic subtest vebox: SUCCESS (1.962s)
[623.795856] Subtest legacy-engines-mixed-process: SUCCESS (9.961s)
[623.877822] [144/154] (401s left) kms_properties (connector-properties-atomic)
[623.969518] Starting subtest: connector-properties-atomic
[623.971844] Starting dynamic subtest: pipe-A-eDP-1
[632.004699] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.034s)
[632.016388] Starting dynamic subtest: pipe-None-DP-1
[632.020967] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[632.031510] Starting dynamic subtest: pipe-None-HDMI-A-1
[632.036030] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[632.046083] Starting dynamic subtest: pipe-None-DP-2
[632.050794] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[632.061197] Starting dynamic subtest: pipe-None-HDMI-A-2
[632.065949] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[632.076383] Starting dynamic subtest: pipe-None-DP-3
[632.080937] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[632.091180] Starting dynamic subtest: pipe-None-DP-4
[632.095699] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[632.097983] Subtest connector-properties-atomic: SUCCESS (8.047s)
[632.872209] [145/154] (392s left) kms_getfb (getfb-handle-not-fb)
[632.971213] Starting subtest: getfb-handle-not-fb
[632.973534] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[633.082754] [146/154] (392s left) kms_addfb_basic (invalid-set-prop-any)
[633.144888] Starting subtest: invalid-set-prop-any
[633.146958] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[633.319080] [147/154] (392s left) syncobj_wait (multi-wait-signaled)
[633.370983] Starting subtest: multi-wait-signaled
[633.373310] Subtest multi-wait-signaled: SUCCESS (0.000s)
[633.471337] [148/154] (392s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[633.552642] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[633.557209] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[633.627991] [149/154] (392s left) gem_exec_whisper (basic-normal-all)
[633.687042] Starting subtest: basic-normal-all
[636.039313] Subtest basic-normal-all: SUCCESS (2.351s)
[636.236977] [150/154] (389s left) kms_flip (dpms-off-confusion-interruptible)
[636.337855] Starting subtest: dpms-off-confusion-interruptible
[636.340224] Starting dynamic subtest: A-eDP1
[644.972223] Dynamic subtest A-eDP1: SUCCESS (8.631s)
[644.986282] Starting dynamic subtest: B-eDP1
[653.602759] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[653.617371] Starting dynamic subtest: C-eDP1
[662.226050] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[662.238054] Starting dynamic subtest: D-eDP1
[670.865231] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[670.870526] Subtest dpms-off-confusion-interruptible: SUCCESS (34.530s)
[672.036308] [151/154] (353s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[672.153449] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[672.158083] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[672.282887] [152/154] (353s left) syncobj_timeline (invalid-transfer-bad-pad)
[672.341740] Starting subtest: invalid-transfer-bad-pad
[672.344041] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[672.458620] [153/154] (353s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[672.560787] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[673.617838] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.058s)
[673.778534] [154/154] (352s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[673.874052] Starting subtest: psr-rgb101010-draw-pwrite
[681.640357] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.770s)
[681.749620] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_basic
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_dither
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_draw_crc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_sync
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: sw_sync
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_flush
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_flush
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_chamelium_color
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_alpha_blend
results: parsing output: 56/ for test: vgem_basic
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_partial_pwrite_pread
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_color_pipeline
results: parsing output: 69/ for test: prime_mmap_kms
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: i915_pm_freq_api
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: kms_invalid_mode
results: parsing output: 78/ for test: gem_ctx_engines
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_eventfd
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_pwrite_crc
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_chamelium_hpd
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: gem_pxp
results: parsing output: 94/ for test: gem_busy
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ctx_param
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: i915_pm_rpm
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_chamelium_frames
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: core_debugfs
results: parsing output: 115/ for test: dumb_buffer
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: gem_flink_race
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_flip
results: parsing output: 133/ for test: kms_hdr
results: parsing output: 134/ for test: kms_addfb_basic
results: parsing output: 135/ for test: gem_exec_reloc
results: parsing output: 136/ for test: perf_pmu
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_ctx_isolation
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_plane
results: parsing output: 141/ for test: kms_vblank
results: parsing output: 142/ for test: gem_ctx_persistence
results: parsing output: 143/ for test: kms_properties
results: parsing output: 144/ for test: kms_getfb
results: parsing output: 145/ for test: kms_addfb_basic
results: parsing output: 146/ for test: syncobj_wait
results: parsing output: 147/ for test: kms_flip_scaled_crc
results: parsing output: 148/ for test: gem_exec_whisper
results: parsing output: 149/ for test: kms_flip
results: parsing output: 150/ for test: kms_big_fb
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.