[59.890728] Initializing watchdogs
[59.890871]   /dev/watchdog0
[59.905556] [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]
[59.909738] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.912109] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.915378] [001/134] (960s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[62.107638] Starting subtest: dpms-mode-unset-non-lpsp
[63.268039] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s)
[63.641822] [002/134] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[63.737815] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[63.742227] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[63.854968] [003/134] (956s left) gem_lmem_swapping (heavy-multi)
[63.897929] Subtest heavy-multi: SKIP (0.000s)
[63.941217] [004/134] (956s left) kms_plane (plane-position-hole)
[64.039397] Starting subtest: plane-position-hole
[64.607244] Starting dynamic subtest: pipe-A-plane-1
[65.920355] Dynamic subtest pipe-A-plane-1: SUCCESS (1.307s)
[65.928055] Starting dynamic subtest: pipe-A-plane-2
[67.226632] Dynamic subtest pipe-A-plane-2: SUCCESS (1.305s)
[67.236060] Starting dynamic subtest: pipe-A-plane-3
[68.516368] Dynamic subtest pipe-A-plane-3: SUCCESS (1.286s)
[68.527880] Starting dynamic subtest: pipe-A-plane-4
[69.829444] Dynamic subtest pipe-A-plane-4: SUCCESS (1.310s)
[69.838112] Starting dynamic subtest: pipe-A-plane-5
[69.852394] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[71.027710] Starting dynamic subtest: pipe-B-plane-1
[72.264146] Dynamic subtest pipe-B-plane-1: SUCCESS (1.241s)
[72.273446] Starting dynamic subtest: pipe-B-plane-2
[73.499134] Dynamic subtest pipe-B-plane-2: SUCCESS (1.233s)
[73.506506] Starting dynamic subtest: pipe-B-plane-3
[74.746052] Dynamic subtest pipe-B-plane-3: SUCCESS (1.246s)
[74.755780] Starting dynamic subtest: pipe-B-plane-4
[76.023052] Dynamic subtest pipe-B-plane-4: SUCCESS (1.275s)
[76.031777] Starting dynamic subtest: pipe-B-plane-5
[76.048821] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[76.050823] Subtest plane-position-hole: SUCCESS (11.991s)
[76.876400] [005/134] (943s left) gem_exec_reloc (basic-cpu-wc-active)
[76.950907] Subtest basic-cpu-wc-active: SKIP (0.000s)
[77.035650] [006/134] (943s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[82.065612] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[82.068176] Starting dynamic subtest: pipe-A-eDP-1
[82.849834] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[82.858138] Starting dynamic subtest: pipe-B-eDP-1
[83.994041] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s)
[83.998725] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.927s)
[85.184208] [007/134] (935s left) kms_cdclk (plane-scaling)
[85.276282] Starting subtest: plane-scaling
[85.278592] Starting dynamic subtest: pipe-A-eDP-1
[85.564134] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[85.572570] Starting dynamic subtest: pipe-B-eDP-1
[85.577196] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[85.584069] Starting dynamic subtest: pipe-C-eDP-1
[85.588721] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[85.595563] Starting dynamic subtest: pipe-D-eDP-1
[85.600094] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[85.604417] Subtest plane-scaling: SKIP (0.293s)
[86.412653] [008/134] (934s left) gem_mmap_gtt (fault-concurrent-x)
[86.475084] Subtest fault-concurrent-X: SKIP (0.000s)
[86.540561] [009/134] (934s left) kms_psr (fbc-psr-basic)
[86.633569] Starting subtest: fbc-psr-basic
[86.635767] Starting dynamic subtest: eDP-1
[86.640158] Dynamic subtest eDP-1: SKIP (0.000s)
[86.644622] Subtest fbc-psr-basic: SKIP (0.001s)
[86.718958] [010/134] (934s left) gem_exec_schedule (semaphore-user)
[86.777341] Starting subtest: semaphore-user
[86.829030] Subtest semaphore-user: SUCCESS (0.057s)
[87.941823] [011/134] (932s left) api_intel_bb (add-remove-objects)
[88.013106] Starting subtest: add-remove-objects
[88.020174] Subtest add-remove-objects: SUCCESS (0.008s)
[88.162775] [012/134] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[88.271092] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[88.275383] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[88.403769] [013/134] (932s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[88.530166] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[97.604242] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.070s)
[98.445807] [014/134] (922s left) kms_setmode (invalid-clone-exclusive-crtc)
[98.507068] Starting subtest: invalid-clone-exclusive-crtc
[98.513829] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[98.614286] [015/134] (922s left) i915_query (query-topology-kernel-writes)
[98.669102] Starting subtest: query-topology-kernel-writes
[98.671485] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[98.777573] [016/134] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[98.874464] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[98.878833] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[98.982510] [017/134] (922s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[99.085552] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[99.090015] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[99.207656] [018/134] (921s left) kms_dsc (dsc-with-output-formats)
[99.324223] Starting subtest: dsc-with-output-formats
[99.345669] Subtest dsc-with-output-formats: SKIP (0.001s)
[99.412257] [019/134] (921s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[99.515691] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[99.517711] Starting dynamic subtest: pipe-A-eDP-1
[99.525776] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.534095] Starting dynamic subtest: pipe-B-eDP-1
[99.541911] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.548821] Starting dynamic subtest: pipe-C-eDP-1
[99.555964] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.562244] Starting dynamic subtest: pipe-D-eDP-1
[99.569465] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.573106] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[101.822143] [020/134] (919s left) gem_ctx_shared (q-smoketest-all)
[101.892795] Starting subtest: Q-smoketest-all
[134.270762] Subtest Q-smoketest-all: SUCCESS (32.329s)
[136.009714] [021/134] (885s left) kms_joiner (basic-big-joiner)
[136.121250] Starting subtest: basic-big-joiner
[136.125368] Subtest basic-big-joiner: SKIP (0.000s)
[136.209985] [022/134] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[136.308221] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[139.906884] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.603s)
[141.118266] [023/134] (880s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[141.226368] Starting subtest: basic-max-pipe-crc-check
[141.230911] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[141.273079] [024/134] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[141.368209] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[164.126325] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.761s)
[164.283631] [025/134] (857s left) kms_atomic_interruptible (legacy-pageflip)
[164.387426] Starting subtest: legacy-pageflip
[164.389491] Starting dynamic subtest: pipe-A-eDP-1
[171.842071] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.459s)
[171.844541] Subtest legacy-pageflip: SUCCESS (7.461s)
[172.674832] [026/134] (848s left) gem_exec_suspend (basic-s3-devices)
[172.728460] Starting subtest: basic-S3-devices
[172.730772] Starting dynamic subtest: smem
[183.895509] Dynamic subtest smem: SUCCESS (11.164s)
[183.898429] Subtest basic-S3-devices: SUCCESS (11.166s)
[184.104425] [027/134] (837s left) kms_properties (colorop-properties-legacy)
[184.215176] Starting subtest: colorop-properties-legacy
[184.217542] Starting dynamic subtest: pipe-A-eDP-1
[184.550718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s)
[184.558674] Starting dynamic subtest: pipe-B-eDP-1
[185.600354] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[185.609771] Starting dynamic subtest: pipe-C-eDP-1
[186.641806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.039s)
[186.650613] Starting dynamic subtest: pipe-D-eDP-1
[187.659566] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.018s)
[187.661778] Subtest colorop-properties-legacy: SUCCESS (3.445s)
[188.466076] [028/134] (832s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[188.567596] Starting subtest: fbc-rgb101010-draw-pwrite
[193.913901] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.349s)
[195.083996] [029/134] (826s left) kms_plane_multiple (2x-tiling-yf)
[195.167341] Starting subtest: 2x-tiling-yf
[195.171424] Subtest 2x-tiling-yf: SKIP (0.000s)
[195.251904] [030/134] (826s left) i915_query (query-garbage)
[195.312573] Starting subtest: query-garbage
[195.314965] Subtest query-garbage: SUCCESS (0.000s)
[195.427096] [031/134] (826s left) gem_exec_schedule (noreorder)
[195.603409] Starting subtest: noreorder
[195.606039] Starting dynamic subtest: rcs0
[195.686962] Dynamic subtest rcs0: SUCCESS (0.085s)
[195.697746] Starting dynamic subtest: vcs0
[196.909306] Dynamic subtest vcs0: SUCCESS (1.218s)
[196.920376] Starting dynamic subtest: vcs1
[198.962028] Dynamic subtest vcs1: SUCCESS (2.051s)
[198.976804] Starting dynamic subtest: vecs0
[200.962234] Dynamic subtest vecs0: SUCCESS (1.997s)
[200.973689] Starting dynamic subtest: ccs0
[201.057247] Dynamic subtest ccs0: SUCCESS (0.093s)
[201.060336] Subtest noreorder: SUCCESS (5.457s)
[201.264547] [032/134] (820s left) syncobj_timeline (wait-all-for-submit-complex)
[201.330674] Starting subtest: wait-all-for-submit-complex
[201.543753] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[201.631199] [033/134] (820s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[201.736376] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[201.762448] Starting dynamic subtest: pipe-A-plane-0
[202.373182] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[202.381200] Starting dynamic subtest: pipe-A-plane-3
[202.783936] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[202.791806] Starting dynamic subtest: pipe-A-plane-5
[202.795268] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[203.847293] Starting dynamic subtest: pipe-B-plane-0
[204.494652] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[204.506171] Starting dynamic subtest: pipe-B-plane-3
[204.905439] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s)
[204.913574] Starting dynamic subtest: pipe-B-plane-5
[204.916753] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[205.215046] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.479s)
[206.028361] [034/134] (815s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[206.123073] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[206.127544] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[207.251561] [035/134] (814s left) kms_universal_plane (universal-plane-sanity)
[207.343141] Starting subtest: universal-plane-sanity
[207.345278] Starting dynamic subtest: pipe-A-eDP-1
[207.943995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[207.952677] Starting dynamic subtest: pipe-B-eDP-1
[209.164288] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[209.173056] Starting dynamic subtest: pipe-C-eDP-1
[210.374065] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[210.382684] Starting dynamic subtest: pipe-D-eDP-1
[211.600018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[211.602379] Subtest universal-plane-sanity: SUCCESS (4.257s)
[212.472850] [036/134] (809s left) gem_ccs (suspend-resume)
[212.533843] Starting subtest: suspend-resume
[212.538275] Subtest suspend-resume: SKIP (0.000s)
[212.638203] [037/134] (809s left) gem_tiled_blits (normal)
[212.699332] Subtest normal: SKIP (0.000s)
[212.777961] [038/134] (809s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[212.883952] Starting subtest: plane-lut1d-ctm3x4-lut1d
[212.900911] Starting dynamic subtest: pipe-A-eDP-1
[213.597719] Dynamic subtest pipe-A-eDP-1: FAIL (0.341s)
[214.340932] Starting dynamic subtest: pipe-B-eDP-1
[215.187056] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[215.760282] Starting dynamic subtest: pipe-C-eDP-1
[216.577577] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[217.098016] Starting dynamic subtest: pipe-D-eDP-1
[217.920560] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[217.922887] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.742s)
[218.484831] [039/134] (803s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[218.584320] Starting subtest: fbc-dirtyfb-ioctl
[218.586676] Starting dynamic subtest: A-eDP-1
[221.143284] Dynamic subtest A-eDP-1: SUCCESS (2.555s)
[221.145291] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.557s)
[221.940206] [040/134] (799s left) core_sysfs (read-all-entries)
[221.998370] Starting subtest: read-all-entries
[222.000815] Subtest read-all-entries: SUCCESS (0.003s)
[222.105635] [041/134] (799s left) kms_scaling_modes (scaling-mode-full)
[222.209222] Starting subtest: scaling-mode-full
[222.211524] Starting dynamic subtest: pipe-A-eDP-1
[222.303686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[222.311821] Starting dynamic subtest: pipe-B-eDP-1
[223.455321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[223.464207] Starting dynamic subtest: pipe-C-eDP-1
[224.561457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[224.569510] Starting dynamic subtest: pipe-D-eDP-1
[225.685536] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[225.687909] Subtest scaling-mode-full: SUCCESS (3.479s)
[226.854839] [042/134] (795s left) gem_caching (reads)
[226.919245] Subtest reads: SKIP (0.000s)
[227.000545] [043/134] (795s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[227.099329] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[227.101664] Starting dynamic subtest: pipe-A-default-mode
[227.390795] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[227.395494] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.290s)
[228.193370] [044/134] (793s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[228.294041] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[229.316453] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s)
[229.470205] [045/134] (792s left) gem_exec_balancer (nohangcheck)
[229.738598] Starting subtest: nohangcheck
[230.606100] Subtest nohangcheck: SUCCESS (0.867s)
[230.762466] [046/134] (791s left) kms_vblank (ts-continuation-idle-hang)
[230.863816] Starting subtest: ts-continuation-idle-hang
[230.865665] Starting dynamic subtest: pipe-A-eDP-1
[257.693658] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.827s)
[257.707112] Starting dynamic subtest: pipe-D-eDP-1
[272.678120] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[272.680459] Subtest ts-continuation-idle-hang: SUCCESS (41.813s)
[273.567153] [047/134] (748s left) gem_exec_reloc (basic-concurrent16)
[273.638739] Subtest basic-concurrent16: SKIP (0.000s)
[273.722190] [048/134] (748s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[273.773476] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[273.775741] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[273.896174] [049/134] (748s left) kms_flip (plain-flip-ts-check-interruptible)
[274.005131] Starting subtest: plain-flip-ts-check-interruptible
[274.007363] Starting dynamic subtest: A-eDP1
[282.844819] Dynamic subtest A-eDP1: SUCCESS (8.838s)
[282.855084] Starting dynamic subtest: B-eDP1
[291.677936] Dynamic subtest B-eDP1: SUCCESS (8.831s)
[291.688116] Starting dynamic subtest: C-eDP1
[300.499600] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[300.509792] Starting dynamic subtest: D-eDP1
[309.322714] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[309.325149] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.319s)
[310.528181] [050/134] (711s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[310.626322] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[310.628629] Starting dynamic subtest: pipe-A-default-mode
[311.767392] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[311.771736] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.139s)
[311.943755] [051/134] (710s left) gem_flink_race (flink_close)
[311.983245] Starting subtest: flink_close
[317.102254] Subtest flink_close: SUCCESS (5.119s)
[317.187651] [052/134] (705s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[317.332817] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[318.179685] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s)
[318.385157] [053/134] (704s left) kms_properties (connector-properties-atomic)
[318.487255] Starting subtest: connector-properties-atomic
[318.489135] Starting dynamic subtest: pipe-A-eDP-1
[326.439553] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.952s)
[326.448111] Starting dynamic subtest: pipe-None-DP-1
[326.452539] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[326.460235] Starting dynamic subtest: pipe-None-HDMI-A-1
[326.464478] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[326.472451] Starting dynamic subtest: pipe-None-DP-2
[326.476448] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[326.484071] Starting dynamic subtest: pipe-None-HDMI-A-2
[326.488013] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[326.495923] Starting dynamic subtest: pipe-None-DP-3
[326.500084] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[326.508634] Starting dynamic subtest: pipe-None-DP-4
[326.512926] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[326.515153] Subtest connector-properties-atomic: SUCCESS (7.963s)
[327.327164] [054/134] (695s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[327.434959] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[334.204376] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.772s)
[334.343404] [055/134] (688s left) perf_pmu (busy-double-start)
[334.382446] Starting subtest: busy-double-start
[334.384581] Starting dynamic subtest: rcs0
[338.015477] Dynamic subtest rcs0: FAIL (3.568s)
[338.025199] Starting dynamic subtest: bcs0
[341.521935] Dynamic subtest bcs0: SUCCESS (3.572s)
[341.532519] Starting dynamic subtest: vcs0
[345.371650] Dynamic subtest vcs0: SUCCESS (3.848s)
[345.382969] Starting dynamic subtest: vcs1
[349.436070] Dynamic subtest vcs1: SUCCESS (4.062s)
[349.447631] Starting dynamic subtest: vecs0
[353.435821] Dynamic subtest vecs0: SUCCESS (3.998s)
[353.446715] Starting dynamic subtest: ccs0
[357.072263] Dynamic subtest ccs0: FAIL (3.564s)
[357.074763] Subtest busy-double-start: FAIL (22.621s)
[357.155193] [056/134] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[357.262295] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[357.266356] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[357.380324] [057/134] (665s left) prime_busy (hang-wait)
[357.437046] Starting subtest: hang-wait
[357.439528] Starting dynamic subtest: rcs0
[383.345026] Dynamic subtest rcs0: SUCCESS (25.903s)
[383.355461] Starting dynamic subtest: bcs0
[390.566871] Dynamic subtest bcs0: SUCCESS (7.217s)
[390.576804] Starting dynamic subtest: vcs0
[397.541902] Dynamic subtest vcs0: SUCCESS (6.975s)
[397.551781] Starting dynamic subtest: vcs1
[404.517856] Dynamic subtest vcs1: SUCCESS (6.972s)
[404.527556] Starting dynamic subtest: vecs0
[411.491994] Dynamic subtest vecs0: SUCCESS (6.974s)
[411.502618] Starting dynamic subtest: ccs0
[425.395594] Dynamic subtest ccs0: SUCCESS (13.896s)
[425.398177] Subtest hang-wait: SUCCESS (67.951s)
[425.552043] [058/134] (597s left) gem_exec_store (cachelines)
[425.619633] Starting subtest: cachelines
[425.622043] Starting dynamic subtest: rcs0
[425.760186] Dynamic subtest rcs0: SUCCESS (0.141s)
[425.771685] Starting dynamic subtest: bcs0
[425.828985] Dynamic subtest bcs0: SUCCESS (0.067s)
[425.840062] Starting dynamic subtest: vcs0
[425.889398] Dynamic subtest vcs0: SUCCESS (0.058s)
[425.900170] Starting dynamic subtest: vcs1
[425.954128] Dynamic subtest vcs1: SUCCESS (0.064s)
[425.964722] Starting dynamic subtest: vecs0
[426.023418] Dynamic subtest vecs0: SUCCESS (0.067s)
[426.033606] Starting dynamic subtest: ccs0
[426.095242] Dynamic subtest ccs0: SUCCESS (0.070s)
[426.097654] Subtest cachelines: SUCCESS (0.477s)
[426.301485] [059/134] (596s left) gem_exec_balancer (parallel-keep-submit-fence)
[426.569630] Starting subtest: parallel-keep-submit-fence
[427.645249] Subtest parallel-keep-submit-fence: SUCCESS (1.079s)
[427.765234] [060/134] (594s left) i915_drm_fdinfo (context-close-stress)
[427.804658] Starting subtest: context-close-stress
[438.550195] Subtest context-close-stress: SUCCESS (10.744s)
[438.630676] [061/134] (584s left) kms_getfb (getfb-handle-closed)
[438.915817] Starting subtest: getfb-handle-closed
[438.918073] Subtest getfb-handle-closed: SUCCESS (0.000s)
[439.053670] [062/134] (583s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[439.157361] Starting subtest: primary-x-tiled-reflect-x-180
[446.504769] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.348s)
[447.719830] [063/134] (575s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[447.824727] Starting subtest: pipe-fbc-rte
[447.831404] Starting dynamic subtest: pipe-B-eDP-1
[453.285058] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.462s)
[453.292599] Subtest pipe-fbc-rte: SUCCESS (5.465s)
[455.644466] [064/134] (567s left) kms_flip (bo-too-big-interruptible)
[455.748385] Starting subtest: bo-too-big-interruptible
[455.750744] Starting dynamic subtest: A-eDP1
[457.067240] Dynamic subtest A-eDP1: SUCCESS (1.318s)
[457.077317] Starting dynamic subtest: B-eDP1
[458.310983] Dynamic subtest B-eDP1: SUCCESS (1.242s)
[458.322738] Starting dynamic subtest: C-eDP1
[459.539763] Dynamic subtest C-eDP1: SUCCESS (1.228s)
[459.550935] Starting dynamic subtest: D-eDP1
[460.782861] Dynamic subtest D-eDP1: SUCCESS (1.242s)
[460.785402] Subtest bo-too-big-interruptible: SUCCESS (5.037s)
[462.012677] [065/134] (560s left) gem_softpin (reverse)
[462.079665] Starting subtest: reverse
[462.085018] Subtest reverse: SUCCESS (0.005s)
[462.240768] [066/134] (560s left) prime_vgem (basic-read)
[462.402078] Starting subtest: basic-read
[462.411110] Subtest basic-read: SKIP (0.006s)
[462.530087] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[462.533316] [067/134] (560s left) perf_pmu (pmu-read)
[462.569711] Starting subtest: pmu-read
[462.572068] Subtest pmu-read: SUCCESS (0.002s)
[462.683532] [068/134] (560s left) prime_self_import (basic-llseek-size)
[462.715702] Starting subtest: basic-llseek-size
[462.731392] Subtest basic-llseek-size: SUCCESS (0.018s)
[462.830878] [069/134] (560s left) kms_getfb (getfb2-accept-nv12)
[462.926174] Starting subtest: getfb2-accept-nv12
[462.928371] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[463.056588] [070/134] (560s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[463.174904] Starting subtest: basic-busy-flip-before-cursor-atomic
[463.178574] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[463.329609] [071/134] (559s left) sysfs_heartbeat_interval (invalid)
[463.397398] Starting subtest: invalid
[463.399453] Starting dynamic subtest: vecs0
[463.401355] Dynamic subtest vecs0: SUCCESS (0.000s)
[463.410743] Starting dynamic subtest: ccs0
[463.412450] Dynamic subtest ccs0: SUCCESS (0.000s)
[463.420164] Starting dynamic subtest: vcs0
[463.421868] Dynamic subtest vcs0: SUCCESS (0.000s)
[463.429561] Starting dynamic subtest: bcs0
[463.431268] Dynamic subtest bcs0: SUCCESS (0.000s)
[463.438922] Starting dynamic subtest: rcs0
[463.440648] Dynamic subtest rcs0: SUCCESS (0.000s)
[463.448489] Starting dynamic subtest: vcs1
[463.450208] Dynamic subtest vcs1: SUCCESS (0.000s)
[463.451966] Subtest invalid: SUCCESS (0.005s)
[463.525765] [072/134] (559s left) prime_mmap (test_forked_cpu_write)
[463.581485] Starting subtest: test_forked_cpu_write
[463.583341] Starting dynamic subtest: test_forked_cpu_write-smem
[463.585258] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[463.587229] Subtest test_forked_cpu_write: SUCCESS (0.006s)
[463.724947] [073/134] (559s left) sw_sync (sync_busy_fork_unixsocket)
[463.768281] Starting subtest: sync_busy_fork_unixsocket
[463.775438] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[463.850412] [074/134] (559s left) gem_render_copy (linear-to-vebox-yf-tiled)
[463.908647] Starting subtest: linear-to-vebox-yf-tiled
[463.912362] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[464.125942] [075/134] (559s left) kms_pm_rpm (modeset-lpsp)
[466.045661] Starting subtest: modeset-lpsp
[467.514059] Subtest modeset-lpsp: SUCCESS (1.471s)
[467.625132] [076/134] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[467.731669] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[475.065156] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.337s)
[475.223301] [077/134] (548s left) gem_userptr_blits (sync-unmap-cycles)
[475.297081] Starting subtest: sync-unmap-cycles
[480.670970] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[480.836419] [078/134] (542s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[480.961024] Starting subtest: y-tiled-8bpp-rotate-270
[480.964684] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[481.098038] [079/134] (542s left) kms_plane_scaling (planes-upscale-factor-0-25)
[481.199333] Starting subtest: planes-upscale-factor-0-25
[481.201071] Starting dynamic subtest: pipe-A
[481.260863] Dynamic subtest pipe-A: SUCCESS (0.063s)
[481.270109] Starting dynamic subtest: pipe-B
[482.432951] Dynamic subtest pipe-B: SUCCESS (1.170s)
[482.442774] Starting dynamic subtest: pipe-C
[483.542508] Dynamic subtest pipe-C: SUCCESS (1.109s)
[483.553187] Starting dynamic subtest: pipe-D
[484.673426] Dynamic subtest pipe-D: SUCCESS (1.130s)
[484.676086] Subtest planes-upscale-factor-0-25: SUCCESS (3.475s)
[485.843783] [080/134] (537s left) kms_async_flips (alternate-sync-async-flip)
[485.939032] Starting subtest: alternate-sync-async-flip
[486.319433] Starting dynamic subtest: pipe-A-eDP-1
[489.124733] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.806s)
[489.494603] Starting dynamic subtest: pipe-B-eDP-1
[492.261851] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[492.652788] Starting dynamic subtest: pipe-C-eDP-1
[495.401885] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[495.769790] Starting dynamic subtest: pipe-D-eDP-1
[498.533270] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[498.537535] Subtest alternate-sync-async-flip: SUCCESS (12.597s)
[499.720128] [081/134] (523s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[499.822171] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[499.824423] Starting dynamic subtest: pipe-A-eDP-1
[499.833292] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.843404] Starting dynamic subtest: pipe-B-eDP-1
[499.852483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.861539] Starting dynamic subtest: pipe-C-eDP-1
[499.870508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.878744] Starting dynamic subtest: pipe-D-eDP-1
[499.887104] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.890970] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[502.083394] [082/134] (521s left) gen9_exec_parse (bb-secure)
[502.143788] Subtest bb-secure: SKIP (0.000s)
[502.238074] [083/134] (521s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[502.338361] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[511.537993] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.201s)
[511.699496] [084/134] (511s left) gem_exec_fence (submit67)
[511.877690] Starting subtest: submit67
[511.882339] Subtest submit67: SKIP (0.000s)
[514.055130] [085/134] (509s left) gem_ctx_persistence (engines-queued)
[514.112069] Starting subtest: engines-queued
[514.114290] Starting dynamic subtest: rcs0
[514.165338] Dynamic subtest rcs0: SUCCESS (0.052s)
[514.174132] Starting dynamic subtest: bcs0
[514.281752] Dynamic subtest bcs0: SUCCESS (0.116s)
[514.293370] Starting dynamic subtest: vcs0
[515.893374] Dynamic subtest vcs0: SUCCESS (1.608s)
[515.903868] Starting dynamic subtest: vcs1
[517.877295] Dynamic subtest vcs1: SUCCESS (1.982s)
[517.889322] Starting dynamic subtest: vecs0
[519.860060] Dynamic subtest vecs0: SUCCESS (1.979s)
[519.871613] Starting dynamic subtest: ccs0
[520.044796] Dynamic subtest ccs0: SUCCESS (0.184s)
[520.047295] Subtest engines-queued: SUCCESS (5.933s)
[520.175588] [086/134] (503s left) kms_chamelium_color (ctm-red-to-blue)
[520.282898] Subtest ctm-red-to-blue: SKIP (0.000s)
[520.330142] [087/134] (503s left) kms_psr2_su (page_flip-p010)
[520.394076] Subtest page_flip-P010: SKIP (0.000s)
[520.462820] [088/134] (503s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[520.560212] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[520.562509] Starting dynamic subtest: pipe-A-default-mode
[521.716480] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[521.720886] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.155s)
[521.936348] [089/134] (501s left) i915_drm_fdinfo (virtual-idle)
[521.981557] Starting subtest: virtual-idle
[525.026593] Subtest virtual-idle: SUCCESS (3.043s)
[525.110663] [090/134] (498s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[525.176689] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[525.180967] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[525.385061] [091/134] (498s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[525.487298] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[525.491615] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[526.620727] [092/134] (497s left) kms_cursor_crc (cursor-onscreen-256x85)
[526.879955] Starting subtest: cursor-onscreen-256x85
[526.927315] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[527.124603] [093/134] (496s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[527.405684] Starting subtest: cursor-rapid-movement-512x512
[527.409447] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[527.607175] [094/134] (496s left) i915_suspend (forcewake)
[527.673362] Starting subtest: forcewake
[560.003217] Subtest forcewake: SUCCESS (2.265s)
[560.094240] [095/134] (464s left) syncobj_timeline (signal-array)
[560.160947] Starting subtest: signal-array
[560.163330] Subtest signal-array: SUCCESS (0.000s)
[560.275914] [096/134] (463s left) gem_exec_params (batch-first)
[560.337733] Starting subtest: batch-first
[560.343466] Subtest batch-first: SUCCESS (0.006s)
[560.492338] [097/134] (463s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[560.597967] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[560.602676] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[560.733967] [098/134] (463s left) kms_psr (psr2-primary-mmap-gtt)
[560.832559] Starting subtest: psr2-primary-mmap-gtt
[560.834970] Starting dynamic subtest: eDP-1
[562.296973] Dynamic subtest eDP-1: SKIP (1.421s)
[562.301672] Subtest psr2-primary-mmap-gtt: SKIP (1.423s)
[562.453270] [099/134] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[562.555819] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[562.559979] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[562.707514] [100/134] (461s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[562.803719] Starting subtest: fbc-rgb565-draw-mmap-gtt
[562.808187] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[562.924077] [101/134] (461s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[563.019461] Starting subtest: stress-xrgb8888-xtiled
[569.125168] Subtest stress-xrgb8888-xtiled: SUCCESS (6.008s)
[569.175463] [102/134] (455s left) gem_exec_params (rel-constants-invalid)
[569.229082] Starting subtest: rel-constants-invalid
[569.230979] Subtest rel-constants-invalid: SUCCESS (0.000s)
[569.357590] [103/134] (455s left) gem_eio (in-flight-external)
[569.586012] Starting subtest: in-flight-external
[571.016913] Subtest in-flight-external: SUCCESS (1.416s)
[571.190629] [104/134] (453s left) gem_wait (busy)
[571.269476] Starting subtest: busy
[571.271606] Starting dynamic subtest: all-engines
[572.987217] Dynamic subtest all-engines: SUCCESS (1.707s)
[572.998949] Starting dynamic subtest: rcs0
[573.528555] Dynamic subtest rcs0: SUCCESS (0.536s)
[573.539913] Starting dynamic subtest: bcs0
[574.069777] Dynamic subtest bcs0: SUCCESS (0.536s)
[574.081340] Starting dynamic subtest: vcs0
[575.996378] Dynamic subtest vcs0: SUCCESS (1.915s)
[576.008401] Starting dynamic subtest: vcs1
[577.979282] Dynamic subtest vcs1: SUCCESS (1.973s)
[577.990870] Starting dynamic subtest: vecs0
[579.963371] Dynamic subtest vecs0: SUCCESS (1.975s)
[579.976014] Starting dynamic subtest: ccs0
[580.504428] Dynamic subtest ccs0: SUCCESS (0.539s)
[580.507040] Subtest busy: SUCCESS (9.193s)
[580.725248] [105/134] (443s left) fbdev (pan)
[580.764891] Starting subtest: pan
[580.796677] Subtest pan: SUCCESS (0.034s)
[580.883206] [106/134] (443s left) kms_chamelium_hpd (hdmi-hpd-storm)
[581.279561] Subtest hdmi-hpd-storm: SKIP (0.000s)
[582.134222] [107/134] (442s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[582.249801] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[588.839274] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.581s)
[589.009148] [108/134] (435s left) kms_async_flips (test-time-stamp-atomic)
[589.105302] Starting subtest: test-time-stamp-atomic
[589.495213] Starting dynamic subtest: pipe-A-eDP-1
[590.299070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[590.687209] Starting dynamic subtest: pipe-B-eDP-1
[591.443227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[591.813793] Starting dynamic subtest: pipe-C-eDP-1
[592.568986] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.759s)
[592.934540] Starting dynamic subtest: pipe-D-eDP-1
[593.709346] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[593.711825] Subtest test-time-stamp-atomic: SUCCESS (4.600s)
[594.884738] [109/134] (429s left) kms_psr (pr-sprite-mmap-gtt)
[594.972466] Starting subtest: pr-sprite-mmap-gtt
[594.976683] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[595.056314] [110/134] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[595.167960] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[595.172060] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[595.305186] [111/134] (429s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[595.410020] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[596.399031] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.991s)
[596.563580] [112/134] (428s left) gem_exec_schedule (smoketest-all)
[596.634531] Starting subtest: smoketest-all
[629.018955] Subtest smoketest-all: SUCCESS (32.328s)
[631.098413] [113/134] (393s left) vgem_basic (create)
[631.134161] Starting subtest: create
[631.135962] Subtest create: SUCCESS (0.000s)
[631.201015] [114/134] (393s left) gem_ctx_isolation (dirty-create)
[631.258809] Starting subtest: dirty-create
[631.260959] Starting dynamic subtest: rcs0
[631.502969] Dynamic subtest rcs0: SUCCESS (0.244s)
[631.514705] Starting dynamic subtest: bcs0
[631.781175] Dynamic subtest bcs0: SUCCESS (0.277s)
[631.792427] Starting dynamic subtest: vcs0
[632.072689] Dynamic subtest vcs0: SUCCESS (0.290s)
[632.084468] Starting dynamic subtest: vcs1
[633.184599] Dynamic subtest vcs1: SUCCESS (1.110s)
[633.195959] Starting dynamic subtest: vecs0
[635.144951] Dynamic subtest vecs0: SUCCESS (1.959s)
[635.156872] Starting dynamic subtest: ccs0
[637.215774] Dynamic subtest ccs0: SUCCESS (2.069s)
[637.218172] Subtest dirty-create: SUCCESS (5.955s)
[637.473135] [115/134] (387s left) kms_content_protection (uevent-hdcp14)
[637.615174] Starting subtest: uevent-hdcp14
[637.619886] Subtest uevent-hdcp14: SKIP (0.000s)
[637.770196] [116/134] (387s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[637.827546] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[637.936369] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[638.025455] [117/134] (387s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[638.135562] Starting subtest: yf-tiled-32bpp-rotate-180
[638.139851] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[638.246449] [118/134] (386s left) gem_sync (basic-many-each)
[638.321891] Starting subtest: basic-many-each
[640.590803] Subtest basic-many-each: SUCCESS (2.278s)
[640.787877] [119/134] (384s left) kms_cursor_edge_walk (256x256-right-edge)
[640.881456] Starting subtest: 256x256-right-edge
[640.883794] Starting dynamic subtest: pipe-A-eDP-1
[644.362747] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[644.373012] Starting dynamic subtest: pipe-D-eDP-1
[647.487724] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[647.490002] Subtest 256x256-right-edge: SUCCESS (6.603s)
[648.298607] [120/134] (376s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[648.419325] Starting subtest: basic-flip-before-cursor-atomic
[649.333927] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[650.159528] [121/134] (375s left) kms_flip (nonblocking-read)
[650.256287] Starting subtest: nonblocking-read
[650.258159] Subtest nonblocking-read: SUCCESS (0.000s)
[650.375507] [122/134] (374s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[650.475452] Starting subtest: yf-tiled-64bpp-rotate-180
[650.479873] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[650.577251] [123/134] (374s left) gem_exec_reloc (basic-wc-gtt-active)
[650.633607] Subtest basic-wc-gtt-active: SKIP (0.000s)
[650.701107] [124/134] (374s left) gem_mmap_wc (write-prefaulted)
[650.755865] Subtest write-prefaulted: SKIP (0.000s)
[650.826649] [125/134] (374s left) api_intel_bb (full-batch)
[650.872513] Starting subtest: full-batch
[650.877764] Subtest full-batch: SUCCESS (0.005s)
[650.987299] [126/134] (374s left) gem_eio (in-flight-internal-10ms)
[651.219276] Starting subtest: in-flight-internal-10ms
[653.073362] Subtest in-flight-internal-10ms: SUCCESS (1.853s)
[653.241409] [127/134] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[653.334682] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[653.338799] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[653.444144] [128/134] (372s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[653.558829] Starting subtest: cursorA-vs-flipA-toggle
[664.685058] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.126s)
[665.574247] [129/134] (359s left) syncobj_timeline (etime-multi-wait-all-submitted)
[665.634661] Starting subtest: etime-multi-wait-all-submitted
[665.736432] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[665.828721] [130/134] (359s left) gem_exec_reloc (basic-cpu-noreloc)
[665.906315] Subtest basic-cpu-noreloc: SKIP (0.000s)
[666.035563] [131/134] (359s left) gem_mmap (bad-offset)
[666.099147] Subtest bad-offset: SKIP (0.000s)
[666.175160] [132/134] (359s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[666.296513] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[666.300985] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[666.453755] [133/134] (359s left) i915_pm_rc6_residency (rc6-idle)
[666.531067] Starting subtest: rc6-idle
[666.560893] Starting dynamic subtest: gt0-rcs0
[690.835337] Dynamic subtest gt0-rcs0: SUCCESS (24.277s)
[690.847344] Starting dynamic subtest: gt0-bcs0
[715.118373] Dynamic subtest gt0-bcs0: SUCCESS (24.278s)
[715.129801] Starting dynamic subtest: gt0-ccs0
[739.487007] Dynamic subtest gt0-ccs0: SUCCESS (24.361s)
[739.498505] Starting dynamic subtest: gt1-vcs0
[745.662039] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[745.674800] Starting dynamic subtest: gt1-vecs0
[751.836742] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[751.839741] Subtest rc6-idle: SUCCESS (85.298s)
[751.935319] [134/134] (273s left) kms_psr (fbc-psr2-primary-page-flip)
[752.030841] Starting subtest: fbc-psr2-primary-page-flip
[752.033136] Starting dynamic subtest: eDP-1
[752.037161] Dynamic subtest eDP-1: SKIP (0.000s)
[752.041254] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[752.115397] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_cdclk
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_setmode
results: parsing output: 14/ for test: i915_query
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_dsc
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_multipipe_modeset
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_atomic_interruptible
results: parsing output: 25/ for test: gem_exec_suspend
results: parsing output: 26/ for test: kms_properties
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_universal_plane
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_tiled_blits
results: parsing output: 37/ for test: kms_color_pipeline
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: core_sysfs
results: parsing output: 40/ for test: kms_scaling_modes
results: parsing output: 41/ for test: gem_caching
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_flink_race
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: gem_exec_store
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_getfb
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: prime_vgem
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: kms_getfb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: sysfs_heartbeat_interval
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_psr2_su
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: i915_suspend
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pipe_stress
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: fbdev
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_sync
results: parsing output: 118/ for test: kms_cursor_edge_walk
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: i915_pm_rc6_residency
results: parsing output: 133/ for test: kms_psr
Done.