[60.832472] Initializing watchdogs
[60.832539]   /dev/watchdog0
[60.846404] [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]
[60.850668] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.853150] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.856264] [001/132] (960s left) gen9_exec_parse (allowed-single)
[60.942440] Subtest allowed-single: SKIP (0.000s)
[61.012120] [002/132] (960s left) kms_psr (psr2-cursor-blt)
[61.109229] Starting subtest: psr2-cursor-blt
[61.111558] Starting dynamic subtest: eDP-1
[62.788854] Dynamic subtest eDP-1: SUCCESS (1.679s)
[62.791334] Subtest psr2-cursor-blt: SUCCESS (1.679s)
[63.595873] [003/132] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[63.708985] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[71.090670] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.382s)
[71.222286] [004/132] (950s left) kms_joiner (basic-big-joiner)
[71.324249] Starting subtest: basic-big-joiner
[71.328539] Subtest basic-big-joiner: SKIP (0.000s)
[71.384884] [005/132] (950s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[71.484260] Starting subtest: fbc-rgb565-draw-mmap-wc
[75.508050] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.025s)
[76.693943] [006/132] (944s left) kms_vblank (wait-idle)
[76.787023] Starting subtest: wait-idle
[76.789212] Starting dynamic subtest: pipe-A-eDP-1
[78.542293] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[78.558238] Starting dynamic subtest: pipe-D-eDP-1
[81.023634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.478s)
[81.025856] Subtest wait-idle: SUCCESS (4.237s)
[81.837074] [007/132] (939s left) api_intel_allocator (fork-simple-stress-signal)
[81.891770] Starting subtest: fork-simple-stress-signal
[87.346580] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[87.436494] [008/132] (934s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[87.573422] Starting subtest: cursorA-vs-flipA-varying-size
[98.758207] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.185s)
[99.580957] [009/132] (922s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[99.679170] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[99.681562] Starting dynamic subtest: pipe-A
[99.803591] Dynamic subtest pipe-A: SKIP (0.122s)
[99.810786] Starting dynamic subtest: pipe-B
[100.946272] Dynamic subtest pipe-B: SKIP (1.141s)
[100.953601] Starting dynamic subtest: pipe-C
[102.080450] Dynamic subtest pipe-C: SUCCESS (1.141s)
[102.087703] Starting dynamic subtest: pipe-D
[103.310413] Dynamic subtest pipe-D: SUCCESS (1.229s)
[103.312737] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.634s)
[104.500884] [010/132] (917s left) gem_exec_fence (basic-wait)
[104.686411] Starting subtest: basic-wait
[104.688990] Starting dynamic subtest: rcs0
[104.738303] Dynamic subtest rcs0: SUCCESS (0.052s)
[104.747579] Starting dynamic subtest: bcs0
[104.803509] Dynamic subtest bcs0: SUCCESS (0.063s)
[104.812759] Starting dynamic subtest: vcs0
[104.858883] Dynamic subtest vcs0: SUCCESS (0.055s)
[104.870048] Starting dynamic subtest: vcs1
[104.916297] Dynamic subtest vcs1: SUCCESS (0.056s)
[104.927795] Starting dynamic subtest: vecs0
[104.972778] Dynamic subtest vecs0: SUCCESS (0.056s)
[104.982309] Starting dynamic subtest: ccs0
[105.035517] Dynamic subtest ccs0: SUCCESS (0.061s)
[105.038057] Subtest basic-wait: SUCCESS (0.351s)
[106.977425] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[106.980711] [011/132] (914s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[107.087227] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[111.704948] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.611s)
[112.807852] [012/132] (908s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[112.924823] Starting subtest: 4-tiled-32bpp-rotate-270
[112.943642] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[113.053281] [013/132] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[113.144707] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[113.148729] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[113.244157] [014/132] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[113.341475] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[113.345741] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[113.422247] [015/132] (908s left) gem_flink_basic (flink-lifetime)
[113.473087] Starting subtest: flink-lifetime
[113.475263] Subtest flink-lifetime: SUCCESS (0.002s)
[113.584941] [016/132] (908s left) gem_exec_schedule (u-independent)
[113.655778] Starting subtest: u-independent
[113.658105] Starting dynamic subtest: rcs0
[114.903308] Dynamic subtest rcs0: SUCCESS (1.256s)
[114.914318] Starting dynamic subtest: vcs0
[116.895225] Dynamic subtest vcs0: SUCCESS (1.990s)
[116.905577] Starting dynamic subtest: vcs1
[118.945520] Dynamic subtest vcs1: SUCCESS (2.048s)
[118.956934] Starting dynamic subtest: vecs0
[120.934678] Dynamic subtest vecs0: SUCCESS (1.987s)
[120.945400] Starting dynamic subtest: ccs0
[122.901912] Dynamic subtest ccs0: SUCCESS (1.966s)
[122.904455] Subtest u-independent: SUCCESS (9.255s)
[123.202416] [017/132] (898s left) api_intel_bb (delta-check)
[123.264712] Starting subtest: delta-check
[123.270740] Subtest delta-check: SUCCESS (0.007s)
[123.360370] [018/132] (898s left) syncobj_wait (invalid-reset-illegal-handle)
[123.416699] Starting subtest: invalid-reset-illegal-handle
[123.419124] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[123.525358] [019/132] (898s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[123.587240] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[123.652604] [020/132] (898s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[123.765711] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[123.769768] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[123.836008] [021/132] (898s left) syncobj_wait (invalid-reset-zero-handles)
[123.893125] Starting subtest: invalid-reset-zero-handles
[123.894983] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[124.000360] [022/132] (898s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[124.104617] Starting subtest: plane-primary-overlay-mutable-zpos
[127.543836] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.438s)
[128.726257] [023/132] (893s left) kms_properties (crtc-properties-atomic)
[128.820072] Starting subtest: crtc-properties-atomic
[128.822425] Starting dynamic subtest: pipe-A-eDP-1
[129.257794] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[129.270394] Starting dynamic subtest: pipe-B-eDP-1
[130.375319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.116s)
[130.384461] Starting dynamic subtest: pipe-C-eDP-1
[131.502194] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[131.510850] Starting dynamic subtest: pipe-D-eDP-1
[132.631725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[132.634049] Subtest crtc-properties-atomic: SUCCESS (3.814s)
[133.445514] [024/132] (888s left) kms_sequence (queue-idle)
[133.533314] Starting subtest: queue-idle
[133.535270] Starting dynamic subtest: pipe-A-eDP-1
[135.350964] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[135.359312] Starting dynamic subtest: pipe-B-eDP-1
[137.805480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.453s)
[137.814374] Starting dynamic subtest: pipe-C-eDP-1
[140.227383] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[140.236494] Starting dynamic subtest: pipe-D-eDP-1
[142.651546] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[142.653864] Subtest queue-idle: SUCCESS (9.118s)
[143.454370] [025/132] (878s left) gem_media_vme
[143.592788] [026/132] (878s left) kms_prop_blob (blob-multiple)
[143.663271] Starting subtest: blob-multiple
[143.665685] Subtest blob-multiple: SUCCESS (0.002s)
[143.760386] [027/132] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[143.867772] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[143.872282] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[143.974707] [028/132] (878s left) kms_hdr (bpc-switch)
[144.064158] Starting subtest: bpc-switch
[145.130956] Starting dynamic subtest: pipe-A-eDP-1
[148.629841] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[148.632188] Subtest bpc-switch: SUCCESS (4.568s)
[148.742177] [029/132] (873s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[148.852589] Starting subtest: short-flip-before-cursor-atomic-transitions
[149.803311] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.950s)
[150.622482] [030/132] (871s left) gem_exec_balancer (parallel-balancer)
[150.880400] Starting subtest: parallel-balancer
[151.757179] Subtest parallel-balancer: SUCCESS (0.878s)
[151.872999] [031/132] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[151.969128] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[151.973068] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[152.048661] [032/132] (870s left) kms_psr (fbc-psr-no-drrs)
[152.127730] Starting subtest: fbc-psr-no-drrs
[152.129979] Starting dynamic subtest: eDP-1
[152.134116] Dynamic subtest eDP-1: SKIP (0.000s)
[152.138303] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[152.208551] [033/132] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[152.297341] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[152.301399] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[152.384508] [034/132] (870s left) kms_plane_alpha_blend (alpha-basic)
[152.487625] Starting subtest: alpha-basic
[152.759853] Starting dynamic subtest: pipe-A-eDP-1
[154.693429] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[154.723204] Starting dynamic subtest: pipe-D-eDP-1
[157.402846] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.685s)
[157.405100] Subtest alpha-basic: SUCCESS (4.916s)
[158.189161] [035/132] (864s left) i915_suspend (sysfs-reader)
[158.250445] Starting subtest: sysfs-reader
[176.118552] Subtest sysfs-reader: SUCCESS (3.234s)
[176.211623] [036/132] (846s left) kms_pwrite_crc
[177.839977] [037/132] (844s left) kms_draw_crc (draw-method-mmap-gtt)
[177.945443] Starting subtest: draw-method-mmap-gtt
[177.950011] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[178.043207] [038/132] (844s left) gem_create (create-clear)
[178.105603] Starting subtest: create-clear
[178.107937] Starting dynamic subtest: smem0
[210.816856] Dynamic subtest smem0: SUCCESS (32.646s)
[210.818768] Subtest create-clear: SUCCESS (32.647s)
[211.015754] [039/132] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[211.131698] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[215.064913] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.935s)
[216.202330] [040/132] (806s left) gem_pxp (create-regular-context-2)
[216.319180] Starting subtest: create-regular-context-2
[216.321864] Subtest create-regular-context-2: SUCCESS (0.002s)
[216.433338] [041/132] (806s left) gem_ctx_bad_destroy (invalid-pad)
[216.499033] Starting subtest: invalid-pad
[216.501517] Subtest invalid-pad: SUCCESS (0.000s)
[216.584596] [042/132] (806s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[216.691543] Starting subtest: x-tiled-8bpp-rotate-90
[216.712642] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[216.815421] [043/132] (806s left) template (a)
[216.881690] Starting subtest: A
[216.883600] Subtest A: SUCCESS (0.000s)
[216.995866] [044/132] (806s left) gem_render_copy_redux (normal)
[217.051621] Starting subtest: normal
[217.294818] Subtest normal: SUCCESS (0.243s)
[217.417099] [045/132] (805s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[217.505772] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[217.509731] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[218.622654] [046/132] (804s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[218.741137] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[218.745706] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[218.865158] [047/132] (804s left) kms_frontbuffer_tracking (fbc-tiling-y)
[218.982748] Starting subtest: fbc-tiling-y
[218.986894] Subtest fbc-tiling-y: SKIP (0.000s)
[219.080333] [048/132] (804s left) gem_exec_reloc (basic-write-gtt-noreloc)
[219.143263] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[219.222758] [049/132] (804s left) perf (mi-rpc)
[219.329748] Starting subtest: mi-rpc
[219.333526] Subtest mi-rpc: SKIP (0.000s)
[219.372212] [050/132] (803s left) kms_psr (fbc-pr-sprite-blt)
[219.462135] Starting subtest: fbc-pr-sprite-blt
[219.466548] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[219.532700] [051/132] (803s left) syncobj_wait (multi-wait-all-submitted-signaled)
[219.589592] Starting subtest: multi-wait-all-submitted-signaled
[219.697138] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[219.772069] [052/132] (803s left) gem_exec_whisper (basic-forked)
[219.830993] Starting subtest: basic-forked
[227.324314] Subtest basic-forked: SUCCESS (7.487s)
[227.511378] [053/132] (795s left) kms_async_flips (async-flip-dpms)
[227.623315] Starting subtest: async-flip-dpms
[227.995166] Starting dynamic subtest: pipe-A-eDP-1
[231.850208] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.851s)
[232.965628] Starting dynamic subtest: pipe-B-eDP-1
[235.310670] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.351s)
[235.702333] Starting dynamic subtest: pipe-C-eDP-1
[238.479468] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.783s)
[238.854378] Starting dynamic subtest: pipe-D-eDP-1
[241.645034] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s)
[241.647283] Subtest async-flip-dpms: SUCCESS (14.017s)
[242.827418] [054/132] (780s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[243.235309] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[244.042800] [055/132] (779s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[244.101979] Starting subtest: invalid-multi-wait-unsubmitted
[244.104362] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[244.208715] [056/132] (779s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[244.305260] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[244.307467] Starting dynamic subtest: pipe-A-eDP-1
[244.331668] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.341456] Starting dynamic subtest: pipe-B-eDP-1
[244.363632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.372435] Starting dynamic subtest: pipe-C-eDP-1
[244.395815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.406714] Starting dynamic subtest: pipe-D-eDP-1
[244.430611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.434925] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[246.533736] [057/132] (777s left) kms_atomic_transition (plane-toggle-modeset-transition)
[246.633264] Starting subtest: plane-toggle-modeset-transition
[246.635552] Starting dynamic subtest: pipe-A-eDP-1
[259.390147] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.747s)
[259.401303] Starting dynamic subtest: pipe-B-eDP-1
[271.859658] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.463s)
[271.862314] Subtest plane-toggle-modeset-transition: SUCCESS (25.218s)
[272.685632] [058/132] (750s left) kms_addfb_basic (small-bo)
[272.795890] Starting subtest: small-bo
[272.798139] Subtest small-bo: SUCCESS (0.000s)
[272.907374] [059/132] (750s left) gem_mmap_offset (basic-uaf)
[272.967002] Starting subtest: basic-uaf
[272.969374] Subtest basic-uaf: SUCCESS (0.001s)
[273.084300] [060/132] (750s left) prime_vgem (basic-fence-mmap)
[273.162917] Starting subtest: basic-fence-mmap
[273.167321] Subtest basic-fence-mmap: SKIP (0.000s)
[273.288706] [061/132] (750s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[273.380422] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[273.393233] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s)
[273.503185] [062/132] (750s left) perf (polling-small-buf)
[273.596478] Starting subtest: polling-small-buf
[273.688712] Subtest polling-small-buf: SUCCESS (0.091s)
[273.735184] [063/132] (750s left) kms_cursor_legacy (forked-bo)
[273.853887] Starting subtest: forked-bo
[273.855826] Starting dynamic subtest: pipe-A
[279.399010] Dynamic subtest pipe-A: SUCCESS (5.494s)
[279.412343] Starting dynamic subtest: pipe-B
[284.877078] Dynamic subtest pipe-B: SUCCESS (5.479s)
[284.894762] Starting dynamic subtest: pipe-C
[290.359639] Dynamic subtest pipe-C: SUCCESS (5.482s)
[290.381486] Starting dynamic subtest: pipe-D
[295.820299] Dynamic subtest pipe-D: SUCCESS (5.460s)
[295.845798] Starting dynamic subtest: all-pipes
[301.338222] Dynamic subtest all-pipes: SUCCESS (5.517s)
[301.340980] Subtest forked-bo: SUCCESS (27.443s)
[301.436824] [064/132] (722s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[301.499585] Starting subtest: mixed-tiled-to-y-tiled-ccs
[301.504413] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[301.696005] [065/132] (722s left) kms_pm_rpm (package-g7)
[303.723656] Starting subtest: package-g7
[303.728833] Subtest package-g7: SKIP (0.000s)
[304.088409] [066/132] (719s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[304.181531] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[304.185577] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[304.286044] [067/132] (719s left) gem_pipe_control_store_loop (fresh-buffer)
[304.347675] Starting subtest: fresh-buffer
[306.501468] Subtest fresh-buffer: SUCCESS (2.152s)
[306.613708] [068/132] (717s left) sysfs_timeslice_duration (idempotent)
[306.680917] Starting subtest: idempotent
[306.683380] Starting dynamic subtest: vecs0
[306.685722] Dynamic subtest vecs0: SUCCESS (0.000s)
[306.696624] Starting dynamic subtest: ccs0
[306.698512] Dynamic subtest ccs0: SUCCESS (0.000s)
[306.706814] Starting dynamic subtest: vcs0
[306.708735] Dynamic subtest vcs0: SUCCESS (0.000s)
[306.717737] Starting dynamic subtest: bcs0
[306.719952] Dynamic subtest bcs0: SUCCESS (0.000s)
[306.728419] Starting dynamic subtest: rcs0
[306.730301] Dynamic subtest rcs0: SUCCESS (0.000s)
[306.738751] Starting dynamic subtest: vcs1
[306.740994] Dynamic subtest vcs1: SUCCESS (0.000s)
[306.743227] Subtest idempotent: SUCCESS (0.005s)
[306.781918] [069/132] (717s left) kms_cursor_crc (cursor-offscreen-256x256)
[307.036586] Starting subtest: cursor-offscreen-256x256
[307.041617] Starting dynamic subtest: pipe-A-eDP-1
[308.974785] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[309.002108] Starting dynamic subtest: pipe-D-eDP-1
[311.579689] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[311.581893] Subtest cursor-offscreen-256x256: SUCCESS (4.543s)
[312.437803] [070/132] (711s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[312.819594] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[313.653769] [071/132] (710s left) gem_exec_schedule (lateslice)
[313.733449] Starting subtest: lateslice
[313.735487] Starting dynamic subtest: rcs0
[313.748078] Dynamic subtest rcs0: SUCCESS (0.025s)
[313.761232] Starting dynamic subtest: bcs0
[313.772159] Dynamic subtest bcs0: SUCCESS (0.023s)
[313.781399] Starting dynamic subtest: vcs0
[313.792709] Dynamic subtest vcs0: SUCCESS (0.020s)
[313.801554] Starting dynamic subtest: vcs1
[313.815571] Dynamic subtest vcs1: SUCCESS (0.022s)
[313.824328] Starting dynamic subtest: vecs0
[313.834145] Dynamic subtest vecs0: SUCCESS (0.018s)
[313.842935] Starting dynamic subtest: ccs0
[313.850880] Dynamic subtest ccs0: SUCCESS (0.016s)
[313.853054] Subtest lateslice: SUCCESS (0.129s)
[315.609598] [072/132] (708s left) gem_exec_schedule (deep)
[315.801826] Starting subtest: deep
[315.804576] Starting dynamic subtest: rcs0
[321.822656] Dynamic subtest rcs0: SKIP (6.019s)
[321.834514] Starting dynamic subtest: vcs0
[331.993606] Dynamic subtest vcs0: SUCCESS (10.168s)
[332.005550] Starting dynamic subtest: vcs1
[342.778140] Dynamic subtest vcs1: SUCCESS (10.781s)
[342.793268] Starting dynamic subtest: vecs0
[353.925509] Dynamic subtest vecs0: SUCCESS (11.143s)
[353.939204] Starting dynamic subtest: ccs0
[365.998901] Dynamic subtest ccs0: SUCCESS (12.069s)
[366.001355] Subtest deep: SUCCESS (50.188s)
[367.279610] [073/132] (657s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[367.378299] Starting subtest: bad-aux-stride-yf-tiled-ccs
[367.380510] Starting dynamic subtest: pipe-A-eDP-1
[367.403588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.415215] Starting dynamic subtest: pipe-B-eDP-1
[367.436894] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.446280] Starting dynamic subtest: pipe-C-eDP-1
[367.468017] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.477001] Starting dynamic subtest: pipe-D-eDP-1
[367.500318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.504531] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[369.646666] [074/132] (654s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[369.706605] Starting subtest: yf-tiled-to-vebox-y-tiled
[369.711575] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[369.884951] [075/132] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[369.986372] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[376.883261] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.897s)
[377.007907] [076/132] (647s left) kms_cursor_crc (cursor-tearing-position-change)
[377.124404] Starting subtest: cursor-tearing-position-change
[377.126581] Starting dynamic subtest: pipe-A-eDP-1
[377.728208] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[377.738856] Starting dynamic subtest: pipe-D-eDP-1
[379.010547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[379.012800] Subtest cursor-tearing-position-change: SUCCESS (1.884s)
[379.844054] [077/132] (644s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[379.958671] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[380.960467] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.000s)
[381.772551] [078/132] (642s left) vgem_basic (debugfs)
[381.810946] Starting subtest: debugfs
[381.813334] Subtest debugfs: SUCCESS (0.000s)
[381.885541] [079/132] (642s left) gem_ctx_isolation (dirty-switch)
[381.950138] Starting subtest: dirty-switch
[381.952433] Starting dynamic subtest: rcs0
[382.142521] Dynamic subtest rcs0: SUCCESS (0.192s)
[382.154417] Starting dynamic subtest: bcs0
[382.351556] Dynamic subtest bcs0: SUCCESS (0.208s)
[382.363115] Starting dynamic subtest: vcs0
[382.606941] Dynamic subtest vcs0: SUCCESS (0.255s)
[382.618507] Starting dynamic subtest: vcs1
[383.718971] Dynamic subtest vcs1: SUCCESS (1.111s)
[383.728629] Starting dynamic subtest: vecs0
[385.732930] Dynamic subtest vecs0: SUCCESS (2.012s)
[385.744557] Starting dynamic subtest: ccs0
[387.734740] Dynamic subtest ccs0: SUCCESS (2.000s)
[387.737090] Subtest dirty-switch: SUCCESS (5.783s)
[387.991669] [080/132] (636s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[388.089148] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[394.776421] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.688s)
[394.902353] [081/132] (629s left) gem_eio (hibernate)
[395.122221] Starting subtest: hibernate
[409.845896] Subtest hibernate: SUCCESS (14.718s)
[417.004206] [082/132] (614s left) gem_exec_params (secure-non-root)
[417.076929] Starting subtest: secure-non-root
[417.081459] Subtest secure-non-root: SKIP (0.000s)
[417.178178] [083/132] (614s left) gem_wait (await)
[417.243373] Starting subtest: await
[417.245768] Starting dynamic subtest: all-engines
[418.377517] Dynamic subtest all-engines: SUCCESS (1.134s)
[418.398707] Starting dynamic subtest: rcs0
[419.444986] Dynamic subtest rcs0: SUCCESS (1.065s)
[419.462704] Starting dynamic subtest: bcs0
[420.505635] Dynamic subtest bcs0: SUCCESS (1.059s)
[420.522421] Starting dynamic subtest: vcs0
[421.561971] Dynamic subtest vcs0: SUCCESS (1.054s)
[421.580620] Starting dynamic subtest: vcs1
[422.617682] Dynamic subtest vcs1: SUCCESS (1.053s)
[422.635019] Starting dynamic subtest: vecs0
[423.670519] Dynamic subtest vecs0: SUCCESS (1.051s)
[423.693008] Starting dynamic subtest: ccs0
[424.728601] Dynamic subtest ccs0: SUCCESS (1.056s)
[424.733404] Subtest await: SUCCESS (7.487s)
[424.930122] [084/132] (606s left) gem_busy (semaphore)
[425.122788] Subtest semaphore: SKIP (0.000s)
[425.349189] [085/132] (606s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[425.447037] Starting subtest: plane-lut1d-pre-ctm3x4
[425.574262] Starting dynamic subtest: pipe-A-plane-0
[425.715941] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[425.726813] Starting dynamic subtest: pipe-A-plane-1
[425.864890] Dynamic subtest pipe-A-plane-1: SUCCESS (0.145s)
[425.875762] Starting dynamic subtest: pipe-A-plane-2
[426.049748] Dynamic subtest pipe-A-plane-2: SUCCESS (0.186s)
[427.241704] Starting dynamic subtest: pipe-B-plane-0
[427.374917] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[427.385437] Starting dynamic subtest: pipe-B-plane-1
[427.552690] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[427.563349] Starting dynamic subtest: pipe-B-plane-2
[427.698197] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[428.844643] Starting dynamic subtest: pipe-C-plane-0
[428.980888] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[428.991872] Starting dynamic subtest: pipe-C-plane-1
[429.148141] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[429.166375] Starting dynamic subtest: pipe-C-plane-2
[429.291627] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[430.480553] Starting dynamic subtest: pipe-D-plane-0
[430.627762] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[430.638847] Starting dynamic subtest: pipe-D-plane-1
[430.783155] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[430.796694] Starting dynamic subtest: pipe-D-plane-2
[430.916457] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[431.204135] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.756s)
[432.072132] [086/132] (599s left) gem_lmem_swapping (massive-random)
[432.119216] Subtest massive-random: SKIP (0.000s)
[432.164570] [087/132] (599s left) kms_addfb_basic (invalid-set-prop)
[432.219312] Starting subtest: invalid-set-prop
[432.222089] Subtest invalid-set-prop: SUCCESS (0.000s)
[432.361708] [088/132] (599s left) syncobj_timeline (32bits-limit)
[432.426959] Starting subtest: 32bits-limit
[432.429380] Subtest 32bits-limit: SUCCESS (0.001s)
[432.549679] [089/132] (599s left) kms_content_protection (type1)
[432.692179] Starting subtest: type1
[432.696356] Subtest type1: SKIP (0.000s)
[432.811277] [090/132] (599s left) kms_lease (lease-invalid-connector)
[432.911671] Starting subtest: lease-invalid-connector
[432.913948] Starting dynamic subtest: pipe-A-eDP-1
[432.916138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[432.926861] Starting dynamic subtest: pipe-B-eDP-1
[432.929204] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[432.939449] Starting dynamic subtest: pipe-C-eDP-1
[432.941315] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[432.950498] Starting dynamic subtest: pipe-D-eDP-1
[432.952377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[432.954566] Subtest lease-invalid-connector: SUCCESS (0.004s)
[432.995132] [091/132] (599s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[433.084028] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[433.087886] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[433.157173] [092/132] (598s left) kms_plane_multiple (2x-tiling-4)
[433.253551] Starting subtest: 2x-tiling-4
[433.257052] Subtest 2x-tiling-4: SKIP (0.000s)
[433.327197] [093/132] (598s left) gem_flink_basic (double-flink)
[433.377804] Starting subtest: double-flink
[433.379427] Subtest double-flink: SUCCESS (0.000s)
[433.495404] [094/132] (598s left) kms_psr (psr-sprite-plane-move)
[433.586391] Starting subtest: psr-sprite-plane-move
[433.588289] Starting dynamic subtest: eDP-1
[435.412946] Dynamic subtest eDP-1: SUCCESS (1.825s)
[435.415138] Subtest psr-sprite-plane-move: SUCCESS (1.826s)
[436.226781] [095/132] (596s left) kms_flip (2x-flip-vs-fences-interruptible)
[436.319873] Starting subtest: 2x-flip-vs-fences-interruptible
[436.324403] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[436.448333] [096/132] (595s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[436.551061] Starting subtest: psr-rgb565-draw-mmap-gtt
[436.555308] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[436.670065] [097/132] (595s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[436.769384] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[436.771661] Starting dynamic subtest: pipe-A-eDP-1
[436.864423] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[436.877555] Starting dynamic subtest: pipe-B-eDP-1
[438.016789] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[438.021310] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.250s)
[439.186128] [098/132] (593s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[439.303101] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[440.395170] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.091s)
[440.531770] [099/132] (591s left) kms_psr (psr2-cursor-plane-onoff)
[440.622700] Starting subtest: psr2-cursor-plane-onoff
[440.624515] Starting dynamic subtest: eDP-1
[442.388547] Dynamic subtest eDP-1: SUCCESS (1.765s)
[442.391251] Subtest psr2-cursor-plane-onoff: SUCCESS (1.766s)
[443.183017] [100/132] (589s left) gem_ctx_shared (q-independent)
[443.248232] Starting subtest: Q-independent
[443.250682] Starting dynamic subtest: rcs0
[443.306636] Dynamic subtest rcs0: SUCCESS (0.058s)
[443.319854] Starting dynamic subtest: vcs0
[443.354668] Dynamic subtest vcs0: SUCCESS (0.048s)
[443.364735] Starting dynamic subtest: vcs1
[443.396753] Dynamic subtest vcs1: SUCCESS (0.042s)
[443.406852] Starting dynamic subtest: vecs0
[443.445943] Dynamic subtest vecs0: SUCCESS (0.048s)
[443.459282] Starting dynamic subtest: ccs0
[443.502730] Dynamic subtest ccs0: SUCCESS (0.056s)
[443.505829] Subtest Q-independent: SUCCESS (0.254s)
[444.636759] [101/132] (587s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[444.747473] Starting subtest: yf-tiled-64bpp-rotate-270
[444.751499] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[444.843221] [102/132] (587s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[444.933314] Starting subtest: fbc-pr-cursor-mmap-gtt
[444.937723] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[445.010156] [103/132] (587s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[445.059286] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[445.161636] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[445.265325] [104/132] (587s left) perf_pmu (busy-idle-no-semaphores)
[445.300726] Starting subtest: busy-idle-no-semaphores
[445.302903] Starting dynamic subtest: rcs0
[445.967398] Dynamic subtest rcs0: SUCCESS (0.666s)
[445.978963] Starting dynamic subtest: bcs0
[446.623785] Dynamic subtest bcs0: SUCCESS (0.653s)
[446.636829] Starting dynamic subtest: vcs0
[447.276198] Dynamic subtest vcs0: SUCCESS (0.649s)
[447.288547] Starting dynamic subtest: vcs1
[449.189661] Dynamic subtest vcs1: SUCCESS (1.911s)
[449.202986] Starting dynamic subtest: vecs0
[451.172923] Dynamic subtest vecs0: SUCCESS (1.980s)
[451.186295] Starting dynamic subtest: ccs0
[453.157745] Dynamic subtest ccs0: SUCCESS (1.982s)
[453.160618] Subtest busy-idle-no-semaphores: SUCCESS (7.858s)
[453.279714] [105/132] (579s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[453.336133] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[453.338349] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[453.437523] [106/132] (579s left) gem_sync (basic-store-each)
[453.497441] Starting subtest: basic-store-each
[456.212556] Subtest basic-store-each: SUCCESS (2.725s)
[456.402926] [107/132] (576s left) drm_read (short-buffer-wakeup)
[456.549304] Starting subtest: short-buffer-wakeup
[488.768148] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[488.920003] [108/132] (543s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[489.115232] Starting subtest: cursor-rapid-movement-64x21
[489.162728] Subtest cursor-rapid-movement-64x21: SKIP (0.042s)
[489.410452] [109/132] (543s left) kms_addfb_basic (unused-handle)
[489.461874] Starting subtest: unused-handle
[489.463830] Subtest unused-handle: SUCCESS (0.000s)
[489.594911] [110/132] (543s left) syncobj_timeline (single-wait-for-submit-signaled)
[489.655870] Starting subtest: single-wait-for-submit-signaled
[489.657740] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[489.741580] [111/132] (543s left) i915_hangman (engine-engine-hang)
[489.809986] Starting subtest: engine-engine-hang
[489.811563] Starting dynamic subtest: rcs0
[491.483671] Dynamic subtest rcs0: SUCCESS (1.672s)
[491.498567] Starting dynamic subtest: bcs0
[493.531817] Dynamic subtest bcs0: SUCCESS (2.045s)
[493.547534] Starting dynamic subtest: vcs0
[495.515341] Dynamic subtest vcs0: SUCCESS (1.980s)
[495.528812] Starting dynamic subtest: vcs1
[497.500049] Dynamic subtest vcs1: SUCCESS (1.981s)
[497.512718] Starting dynamic subtest: vecs0
[499.484089] Dynamic subtest vecs0: SUCCESS (1.981s)
[499.497568] Starting dynamic subtest: ccs0
[501.531165] Dynamic subtest ccs0: SUCCESS (2.044s)
[501.534044] Subtest engine-engine-hang: SUCCESS (11.721s)
[501.611431] [112/132] (531s left) i915_pm_rpm (system-suspend)
[503.733054] Starting subtest: system-suspend
[521.975745] Subtest system-suspend: SUCCESS (2.975s)
[522.351265] [113/132] (510s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[522.454655] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[523.243560] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[523.407804] [114/132] (509s left) gem_softpin (allocator-evict)
[523.464172] Starting subtest: allocator-evict
[523.466381] Starting dynamic subtest: rcs0
[547.095088] Dynamic subtest rcs0: SUCCESS (23.563s)
[547.105602] Starting dynamic subtest: bcs0
[571.272452] Dynamic subtest bcs0: SUCCESS (24.173s)
[571.285270] Starting dynamic subtest: vcs0
[595.173168] Dynamic subtest vcs0: SUCCESS (23.893s)
[595.183589] Starting dynamic subtest: vcs1
[618.725689] Dynamic subtest vcs1: SUCCESS (23.542s)
[618.735974] Starting dynamic subtest: vecs0
[642.538950] Dynamic subtest vecs0: SUCCESS (23.818s)
[642.549710] Starting dynamic subtest: ccs0
[666.113580] Dynamic subtest ccs0: SUCCESS (23.571s)
[666.116701] Subtest allocator-evict: SUCCESS (142.567s)
[666.198526] [115/132] (366s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[666.359534] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[673.165228] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.808s)
[673.280430] [116/132] (359s left) kms_pm_rpm (cursor)
[674.939170] Starting subtest: cursor
[674.944637] Subtest cursor: SKIP (0.000s)
[675.611029] [117/132] (357s left) i915_drm_fdinfo (memory-info-active)
[675.656469] Starting subtest: memory-info-active
[675.658853] Starting dynamic subtest: smem0
[678.326726] Dynamic subtest smem0: SUCCESS (2.672s)
[678.329228] Subtest memory-info-active: SUCCESS (2.673s)
[678.401367] [118/132] (354s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[678.523491] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[678.526961] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[678.622812] [119/132] (354s left) gem_exec_fence (syncobj-channel)
[679.095126] Starting subtest: syncobj-channel
[680.123894] Subtest syncobj-channel: SUCCESS (1.024s)
[680.893862] [120/132] (352s left) gem_exec_flush (basic-wb-prw-default)
[680.960304] Starting subtest: basic-wb-prw-default
[686.453686] Subtest basic-wb-prw-default: SUCCESS (5.483s)
[686.644832] [121/132] (346s left) gem_mmap_gtt (basic-small-copy-odd)
[686.706286] Subtest basic-small-copy-odd: SKIP (0.000s)
[686.765908] [122/132] (346s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[686.865677] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[686.867992] Starting dynamic subtest: pipe-A-eDP-1
[686.890398] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.902637] Starting dynamic subtest: pipe-B-eDP-1
[686.923232] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.933086] Starting dynamic subtest: pipe-C-eDP-1
[686.953589] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.963474] Starting dynamic subtest: pipe-D-eDP-1
[686.984388] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.988538] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[689.090631] [123/132] (344s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[689.196268] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[689.198417] Starting dynamic subtest: pipe-A
[690.246861] Dynamic subtest pipe-A: SUCCESS (1.050s)
[690.262826] Starting dynamic subtest: pipe-B
[692.403699] Dynamic subtest pipe-B: SUCCESS (2.155s)
[692.414010] Starting dynamic subtest: pipe-C
[693.596334] Dynamic subtest pipe-C: SUCCESS (1.190s)
[693.607754] Starting dynamic subtest: pipe-D
[694.740456] Dynamic subtest pipe-D: SUCCESS (1.143s)
[694.742819] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.543s)
[695.925565] [124/132] (337s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[696.032498] Starting subtest: y-tiled-64bpp-rotate-90
[696.036622] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[696.145220] [125/132] (337s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[696.233206] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[696.237480] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[696.327069] [126/132] (337s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[696.419865] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[696.422217] Starting dynamic subtest: pipe-A-eDP-1
[696.446089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.025s)
[696.456935] Starting dynamic subtest: pipe-B-eDP-1
[696.476565] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[696.486711] Starting dynamic subtest: pipe-C-eDP-1
[696.506041] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[696.516196] Starting dynamic subtest: pipe-D-eDP-1
[696.536124] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[696.538411] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[698.795823] [127/132] (334s left) gem_mmap_gtt (big-copy)
[698.855997] Subtest big-copy: SKIP (0.000s)
[698.929204] [128/132] (334s left) gem_ctx_persistence (legacy-engines-persistence)
[698.997478] Starting subtest: legacy-engines-persistence
[698.999624] Starting dynamic subtest: render
[699.808504] Dynamic subtest render: SUCCESS (0.813s)
[699.824794] Starting dynamic subtest: bsd1
[700.566729] Dynamic subtest bsd1: SUCCESS (0.755s)
[700.580509] Starting dynamic subtest: bsd2
[701.339733] Dynamic subtest bsd2: SUCCESS (0.770s)
[701.354597] Starting dynamic subtest: blt
[702.103726] Dynamic subtest blt: SUCCESS (0.761s)
[702.117838] Starting dynamic subtest: vebox
[702.878112] Dynamic subtest vebox: SUCCESS (0.771s)
[702.880855] Subtest legacy-engines-persistence: SUCCESS (3.883s)
[702.968152] [129/132] (330s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[703.069596] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[703.073753] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[703.159279] [130/132] (330s left) kms_flip (flip-vs-suspend-interruptible)
[703.260460] Starting subtest: flip-vs-suspend-interruptible
[703.262864] Starting dynamic subtest: A-eDP1
[752.128417] Dynamic subtest A-eDP1: SUCCESS (4.529s)
[752.147539] Starting dynamic subtest: B-eDP1
[801.129985] Dynamic subtest B-eDP1: SUCCESS (4.449s)
[801.141653] Starting dynamic subtest: C-eDP1
[850.114919] Dynamic subtest C-eDP1: SUCCESS (4.510s)
[850.128576] Starting dynamic subtest: D-eDP1
[899.129368] Dynamic subtest D-eDP1: SUCCESS (4.558s)
[899.131779] Subtest flip-vs-suspend-interruptible: SUCCESS (18.056s)
[900.342241] [131/132] (133s left) gem_exec_flush (basic-batch-kernel-default-wb)
[900.410746] Starting subtest: basic-batch-kernel-default-wb
[906.712524] Subtest basic-batch-kernel-default-wb: SUCCESS (6.286s)
[906.900637] [132/132] (126s left) kms_vrr (seamless-rr-switch-virtual)
[906.996264] Starting subtest: seamless-rr-switch-virtual
[907.002783] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[907.066714] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_flink_basic
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_pipe_b_c_ivb
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_atomic
results: parsing output: 22/ for test: kms_properties
results: parsing output: 23/ for test: kms_sequence
results: parsing output: 24/ for test: gem_media_vme
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_alpha_blend
results: parsing output: 34/ for test: i915_suspend
results: parsing output: 35/ for test: kms_pwrite_crc
results: parsing output: 36/ for test: kms_draw_crc
results: parsing output: 37/ for test: gem_create
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: gem_ctx_bad_destroy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: template
results: parsing output: 43/ for test: gem_render_copy_redux
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_async_flips
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_pipe_control_store_loop
results: parsing output: 67/ for test: sysfs_timeslice_duration
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_chamelium_edid
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: vgem_basic
results: parsing output: 78/ for test: gem_ctx_isolation
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: gem_busy
results: parsing output: 84/ for test: kms_color_pipeline
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_plane_multiple
results: parsing output: 92/ for test: gem_flink_basic
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_ctx_shared
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_sync
results: parsing output: 106/ for test: drm_read
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: i915_hangman
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_fence
results: parsing output: 119/ for test: gem_exec_flush
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_exec_flush
results: parsing output: 131/ for test: kms_vrr
Done.