[56.859863] Initializing watchdogs
[56.859907]   /dev/watchdog0
[56.873247] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.877745] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.879979] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.883165] [001/134] (960s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[59.058482] Starting subtest: dpms-mode-unset-non-lpsp
[60.205447] Subtest dpms-mode-unset-non-lpsp: SKIP (1.153s)
[60.627354] [002/134] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[60.721264] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[60.725097] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[60.807050] [003/134] (956s left) gem_lmem_swapping (heavy-multi)
[60.851636] Subtest heavy-multi: SKIP (0.000s)
[60.897181] [004/134] (956s left) kms_plane (plane-position-hole)
[60.987806] Starting subtest: plane-position-hole
[61.510418] Starting dynamic subtest: pipe-A-plane-1
[62.798562] Dynamic subtest pipe-A-plane-1: SUCCESS (1.295s)
[62.805805] Starting dynamic subtest: pipe-A-plane-2
[64.081141] Dynamic subtest pipe-A-plane-2: SUCCESS (1.289s)
[64.091508] Starting dynamic subtest: pipe-A-plane-3
[65.313462] Dynamic subtest pipe-A-plane-3: SUCCESS (1.236s)
[65.322222] Starting dynamic subtest: pipe-A-plane-4
[66.546536] Dynamic subtest pipe-A-plane-4: SUCCESS (1.237s)
[66.555509] Starting dynamic subtest: pipe-A-plane-5
[66.571466] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[67.687795] Starting dynamic subtest: pipe-B-plane-1
[68.984327] Dynamic subtest pipe-B-plane-1: SUCCESS (1.305s)
[68.992496] Starting dynamic subtest: pipe-B-plane-2
[70.217444] Dynamic subtest pipe-B-plane-2: SUCCESS (1.236s)
[70.226472] Starting dynamic subtest: pipe-B-plane-3
[71.476396] Dynamic subtest pipe-B-plane-3: SUCCESS (1.259s)
[71.485682] Starting dynamic subtest: pipe-B-plane-4
[72.783039] Dynamic subtest pipe-B-plane-4: SUCCESS (1.308s)
[72.792216] Starting dynamic subtest: pipe-B-plane-5
[72.808875] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[72.811240] Subtest plane-position-hole: SUCCESS (11.858s)
[73.585577] [005/134] (943s left) gem_exec_reloc (basic-cpu-wc-active)
[73.655686] Subtest basic-cpu-wc-active: SKIP (0.000s)
[73.727448] [006/134] (943s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[78.711967] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[78.714452] Starting dynamic subtest: pipe-A-eDP-1
[79.516761] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[79.525983] Starting dynamic subtest: pipe-B-eDP-1
[80.659621] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[80.663939] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.947s)
[81.854201] [007/134] (935s left) kms_cdclk (plane-scaling)
[81.957451] Starting subtest: plane-scaling
[81.959837] Starting dynamic subtest: pipe-A-eDP-1
[82.258078] Dynamic subtest pipe-A-eDP-1: SKIP (0.298s)
[82.266206] Starting dynamic subtest: pipe-B-eDP-1
[82.270813] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[82.277725] Starting dynamic subtest: pipe-C-eDP-1
[82.282340] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[82.289072] Starting dynamic subtest: pipe-D-eDP-1
[82.293212] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[82.297236] Subtest plane-scaling: SKIP (0.305s)
[83.093338] [008/134] (934s left) gem_mmap_gtt (fault-concurrent-x)
[83.163319] Subtest fault-concurrent-X: SKIP (0.000s)
[83.228857] [009/134] (934s left) kms_psr (fbc-psr-basic)
[83.318968] Starting subtest: fbc-psr-basic
[83.321172] Starting dynamic subtest: eDP-1
[83.325496] Dynamic subtest eDP-1: SKIP (0.000s)
[83.329670] Subtest fbc-psr-basic: SKIP (0.001s)
[83.398126] [010/134] (934s left) gem_exec_schedule (semaphore-user)
[83.474743] Starting subtest: semaphore-user
[83.525667] Subtest semaphore-user: SUCCESS (0.056s)
[84.937848] [011/134] (932s left) api_intel_bb (add-remove-objects)
[84.995836] Starting subtest: add-remove-objects
[85.002768] Subtest add-remove-objects: SUCCESS (0.007s)
[85.142594] [012/134] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[85.256683] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[85.261071] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[85.382657] [013/134] (932s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[85.518118] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[94.389220] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.869s)
[95.211667] [014/134] (922s left) kms_setmode (invalid-clone-exclusive-crtc)
[95.275117] Starting subtest: invalid-clone-exclusive-crtc
[95.281971] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[95.392956] [015/134] (922s left) i915_query (query-topology-kernel-writes)
[95.447788] Starting subtest: query-topology-kernel-writes
[95.450158] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[95.559225] [016/134] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[95.655245] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[95.659243] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[95.780391] [017/134] (922s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[95.871630] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[95.875758] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[95.984285] [018/134] (922s left) kms_dsc (dsc-with-output-formats)
[96.091263] Starting subtest: dsc-with-output-formats
[96.113231] Subtest dsc-with-output-formats: SKIP (0.000s)
[96.168865] [019/134] (921s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[96.263235] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[96.265105] Starting dynamic subtest: pipe-A-eDP-1
[96.273298] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[96.282170] Starting dynamic subtest: pipe-B-eDP-1
[96.289991] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[96.297865] Starting dynamic subtest: pipe-C-eDP-1
[96.305155] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[96.313600] Starting dynamic subtest: pipe-D-eDP-1
[96.320507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[96.323815] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[98.467654] [020/134] (919s left) gem_ctx_shared (q-smoketest-all)
[98.533249] Starting subtest: Q-smoketest-all
[130.919745] Subtest Q-smoketest-all: SUCCESS (32.337s)
[131.979893] [021/134] (886s left) kms_joiner (basic-big-joiner)
[132.090774] Starting subtest: basic-big-joiner
[132.094826] Subtest basic-big-joiner: SKIP (0.000s)
[132.164840] [022/134] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[132.271971] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[135.888368] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.622s)
[137.089033] [023/134] (881s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[137.181436] Starting subtest: basic-max-pipe-crc-check
[137.185963] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[137.227991] [024/134] (881s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[137.331405] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[160.231561] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.901s)
[160.399483] [025/134] (857s left) kms_atomic_interruptible (legacy-pageflip)
[160.504525] Starting subtest: legacy-pageflip
[160.506299] Starting dynamic subtest: pipe-A-eDP-1
[167.919352] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.412s)
[167.921543] Subtest legacy-pageflip: SUCCESS (7.414s)
[168.754205] [026/134] (849s left) gem_exec_suspend (basic-s3-devices)
[168.812280] Starting subtest: basic-S3-devices
[168.814644] Starting dynamic subtest: smem
[180.887324] Dynamic subtest smem: SUCCESS (12.074s)
[180.890074] Subtest basic-S3-devices: SUCCESS (12.076s)
[181.085179] [027/134] (837s left) kms_properties (colorop-properties-legacy)
[181.198781] Starting subtest: colorop-properties-legacy
[181.201617] Starting dynamic subtest: pipe-A-eDP-1
[181.533758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[181.542903] Starting dynamic subtest: pipe-B-eDP-1
[182.570866] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.038s)
[182.580667] Starting dynamic subtest: pipe-C-eDP-1
[183.599446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.025s)
[183.607708] Starting dynamic subtest: pipe-D-eDP-1
[184.634071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.033s)
[184.636204] Subtest colorop-properties-legacy: SUCCESS (3.436s)
[185.445766] [028/134] (832s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[185.550453] Starting subtest: fbc-rgb101010-draw-pwrite
[190.853500] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.306s)
[192.048086] [029/134] (826s left) kms_plane_multiple (2x-tiling-yf)
[192.144270] Starting subtest: 2x-tiling-yf
[192.148635] Subtest 2x-tiling-yf: SKIP (0.000s)
[192.227840] [030/134] (826s left) i915_query (query-garbage)
[192.291257] Starting subtest: query-garbage
[192.293108] Subtest query-garbage: SUCCESS (0.000s)
[192.421449] [031/134] (826s left) gem_exec_schedule (noreorder)
[192.600826] Starting subtest: noreorder
[192.603433] Starting dynamic subtest: rcs0
[192.693047] Dynamic subtest rcs0: SUCCESS (0.093s)
[192.703549] Starting dynamic subtest: vcs0
[193.894905] Dynamic subtest vcs0: SUCCESS (1.199s)
[193.904822] Starting dynamic subtest: vcs1
[195.908245] Dynamic subtest vcs1: SUCCESS (2.011s)
[195.918122] Starting dynamic subtest: vecs0
[197.913580] Dynamic subtest vecs0: SUCCESS (1.976s)
[197.921814] Starting dynamic subtest: ccs0
[197.960961] Dynamic subtest ccs0: SUCCESS (0.074s)
[197.963811] Subtest noreorder: SUCCESS (5.362s)
[198.159249] [032/134] (820s left) syncobj_timeline (wait-all-for-submit-complex)
[198.215503] Starting subtest: wait-all-for-submit-complex
[198.430130] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[198.528493] [033/134] (820s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[198.634181] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[198.659501] Starting dynamic subtest: pipe-A-plane-0
[199.259139] Dynamic subtest pipe-A-plane-0: SUCCESS (0.600s)
[199.267381] Starting dynamic subtest: pipe-A-plane-3
[199.670472] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[199.677851] Starting dynamic subtest: pipe-A-plane-5
[199.681292] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[200.811059] Starting dynamic subtest: pipe-B-plane-0
[201.448739] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[201.458147] Starting dynamic subtest: pipe-B-plane-3
[201.870904] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[201.878968] Starting dynamic subtest: pipe-B-plane-5
[201.882634] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[202.180287] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.548s)
[202.991162] [034/134] (815s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[203.090360] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[203.095025] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[204.223458] [035/134] (814s left) kms_universal_plane (universal-plane-sanity)
[204.322565] Starting subtest: universal-plane-sanity
[204.324567] Starting dynamic subtest: pipe-A-eDP-1
[204.922115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[204.930593] Starting dynamic subtest: pipe-B-eDP-1
[206.138092] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[206.146770] Starting dynamic subtest: pipe-C-eDP-1
[207.353379] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[207.361794] Starting dynamic subtest: pipe-D-eDP-1
[208.573762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[208.576211] Subtest universal-plane-sanity: SUCCESS (4.253s)
[209.448177] [036/134] (809s left) gem_ccs (suspend-resume)
[209.513869] Starting subtest: suspend-resume
[209.518511] Subtest suspend-resume: SKIP (0.000s)
[209.623287] [037/134] (809s left) gem_tiled_blits (normal)
[209.681439] Subtest normal: SKIP (0.000s)
[209.765221] [038/134] (809s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[209.857118] Starting subtest: plane-lut1d-ctm3x4-lut1d
[209.870309] Starting dynamic subtest: pipe-A-eDP-1
[210.544816] Dynamic subtest pipe-A-eDP-1: FAIL (0.324s)
[211.231653] Starting dynamic subtest: pipe-B-eDP-1
[212.059393] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[212.565174] Starting dynamic subtest: pipe-C-eDP-1
[213.399329] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[213.899272] Starting dynamic subtest: pipe-D-eDP-1
[214.738132] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[214.740077] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.584s)
[215.298732] [039/134] (803s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[215.394053] Starting subtest: fbc-dirtyfb-ioctl
[215.396251] Starting dynamic subtest: A-eDP-1
[217.952996] Dynamic subtest A-eDP-1: SUCCESS (2.558s)
[217.955377] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.560s)
[218.763259] [040/134] (800s left) core_sysfs (read-all-entries)
[218.836429] Starting subtest: read-all-entries
[218.842521] Subtest read-all-entries: SUCCESS (0.007s)
[218.967634] [041/134] (799s left) kms_scaling_modes (scaling-mode-full)
[219.060946] Starting subtest: scaling-mode-full
[219.063199] Starting dynamic subtest: pipe-A-eDP-1
[219.156080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[219.165308] Starting dynamic subtest: pipe-B-eDP-1
[220.291588] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[220.299524] Starting dynamic subtest: pipe-C-eDP-1
[221.405255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[221.413516] Starting dynamic subtest: pipe-D-eDP-1
[222.531176] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[222.533329] Subtest scaling-mode-full: SUCCESS (3.473s)
[223.808489] [042/134] (795s left) gem_caching (reads)
[223.872702] Subtest reads: SKIP (0.000s)
[223.946325] [043/134] (795s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[224.029929] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[224.032186] Starting dynamic subtest: pipe-A-default-mode
[224.335769] Dynamic subtest pipe-A-default-mode: SKIP (0.303s)
[224.340435] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.306s)
[225.150106] [044/134] (793s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[225.252276] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[226.387075] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.137s)
[226.565628] [045/134] (792s left) gem_exec_balancer (nohangcheck)
[226.826191] Starting subtest: nohangcheck
[227.685763] Subtest nohangcheck: SUCCESS (0.859s)
[227.850911] [046/134] (791s left) kms_vblank (ts-continuation-idle-hang)
[227.943260] Starting subtest: ts-continuation-idle-hang
[227.945415] Starting dynamic subtest: pipe-A-eDP-1
[255.645268] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.699s)
[255.658981] Starting dynamic subtest: pipe-D-eDP-1
[270.747646] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.099s)
[270.749925] Subtest ts-continuation-idle-hang: SUCCESS (42.803s)
[271.635450] [047/134] (747s left) gem_exec_reloc (basic-concurrent16)
[271.684851] Subtest basic-concurrent16: SKIP (0.000s)
[271.768341] [048/134] (747s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[271.834867] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[271.837078] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[271.950589] [049/134] (747s left) kms_flip (plain-flip-ts-check-interruptible)
[272.050036] Starting subtest: plain-flip-ts-check-interruptible
[272.052239] Starting dynamic subtest: A-eDP1
[280.879074] Dynamic subtest A-eDP1: SUCCESS (8.827s)
[280.888871] Starting dynamic subtest: B-eDP1
[289.712205] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[289.723841] Starting dynamic subtest: C-eDP1
[298.524653] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[298.537223] Starting dynamic subtest: D-eDP1
[307.360406] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[307.362854] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.312s)
[308.547405] [050/134] (710s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[308.639150] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[308.641394] Starting dynamic subtest: pipe-A-default-mode
[309.795272] Dynamic subtest pipe-A-default-mode: SKIP (1.155s)
[309.800459] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.156s)
[309.972637] [051/134] (709s left) gem_flink_race (flink_close)
[310.018382] Starting subtest: flink_close
[315.129133] Subtest flink_close: SUCCESS (5.110s)
[315.214073] [052/134] (704s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[315.330898] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[316.119831] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[316.303572] [053/134] (703s left) kms_properties (connector-properties-atomic)
[316.402906] Starting subtest: connector-properties-atomic
[316.405080] Starting dynamic subtest: pipe-A-eDP-1
[324.230174] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.825s)
[324.241341] Starting dynamic subtest: pipe-None-DP-1
[324.246046] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[324.253697] Starting dynamic subtest: pipe-None-HDMI-A-1
[324.257853] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[324.265976] Starting dynamic subtest: pipe-None-DP-2
[324.270049] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[324.277798] Starting dynamic subtest: pipe-None-HDMI-A-2
[324.281893] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[324.289835] Starting dynamic subtest: pipe-None-DP-3
[324.294110] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[324.303828] Starting dynamic subtest: pipe-None-DP-4
[324.308366] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[324.310580] Subtest connector-properties-atomic: SUCCESS (7.838s)
[325.092146] [054/134] (694s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[325.184164] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[331.969255] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.787s)
[332.137031] [055/134] (687s left) perf_pmu (busy-double-start)
[332.183183] Starting subtest: busy-double-start
[332.185386] Starting dynamic subtest: rcs0
[335.762964] Dynamic subtest rcs0: SUCCESS (3.581s)
[335.772743] Starting dynamic subtest: bcs0
[339.379698] Dynamic subtest bcs0: SUCCESS (3.615s)
[339.389765] Starting dynamic subtest: vcs0
[343.494185] Dynamic subtest vcs0: SUCCESS (4.111s)
[343.505903] Starting dynamic subtest: vcs1
[347.461363] Dynamic subtest vcs1: SUCCESS (3.964s)
[347.472870] Starting dynamic subtest: vecs0
[351.489101] Dynamic subtest vecs0: SUCCESS (4.025s)
[351.498810] Starting dynamic subtest: ccs0
[355.125973] Dynamic subtest ccs0: FAIL (3.567s)
[355.128052] Subtest busy-double-start: FAIL (22.877s)
[355.184179] [056/134] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[355.294291] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[355.298554] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[355.439426] [057/134] (664s left) prime_busy (hang-wait)
[355.498826] Starting subtest: hang-wait
[355.501124] Starting dynamic subtest: rcs0
[382.387231] Dynamic subtest rcs0: SUCCESS (26.883s)
[382.398021] Starting dynamic subtest: bcs0
[389.545910] Dynamic subtest bcs0: SUCCESS (7.155s)
[389.554869] Starting dynamic subtest: vcs0
[396.580238] Dynamic subtest vcs0: SUCCESS (7.029s)
[396.593206] Starting dynamic subtest: vcs1
[403.494390] Dynamic subtest vcs1: SUCCESS (6.914s)
[403.505845] Starting dynamic subtest: vecs0
[410.532816] Dynamic subtest vecs0: SUCCESS (7.034s)
[410.545858] Starting dynamic subtest: ccs0
[424.370514] Dynamic subtest ccs0: SUCCESS (13.837s)
[424.372780] Subtest hang-wait: SUCCESS (68.868s)
[424.518571] [058/134] (595s left) gem_exec_store (cachelines)
[424.586919] Starting subtest: cachelines
[424.589084] Starting dynamic subtest: rcs0
[424.714896] Dynamic subtest rcs0: SUCCESS (0.130s)
[424.725772] Starting dynamic subtest: bcs0
[424.788728] Dynamic subtest bcs0: SUCCESS (0.072s)
[424.800285] Starting dynamic subtest: vcs0
[424.850139] Dynamic subtest vcs0: SUCCESS (0.060s)
[424.860089] Starting dynamic subtest: vcs1
[424.917793] Dynamic subtest vcs1: SUCCESS (0.067s)
[424.928436] Starting dynamic subtest: vecs0
[424.978797] Dynamic subtest vecs0: SUCCESS (0.059s)
[424.988532] Starting dynamic subtest: ccs0
[425.045675] Dynamic subtest ccs0: SUCCESS (0.066s)
[425.048139] Subtest cachelines: SUCCESS (0.463s)
[425.244342] [059/134] (594s left) gem_exec_balancer (parallel-keep-submit-fence)
[425.498602] Starting subtest: parallel-keep-submit-fence
[426.584059] Subtest parallel-keep-submit-fence: SUCCESS (1.089s)
[426.730538] [060/134] (592s left) i915_drm_fdinfo (context-close-stress)
[426.785258] Starting subtest: context-close-stress
[437.530536] Subtest context-close-stress: SUCCESS (10.745s)
[437.624289] [061/134] (582s left) kms_getfb (getfb-handle-closed)
[437.930331] Starting subtest: getfb-handle-closed
[437.932506] Subtest getfb-handle-closed: SUCCESS (0.000s)
[438.043672] [062/134] (581s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[438.133600] Starting subtest: primary-x-tiled-reflect-x-180
[445.311047] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.178s)
[446.549396] [063/134] (573s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[446.665999] Starting subtest: pipe-fbc-rte
[446.672963] Starting dynamic subtest: pipe-B-eDP-1
[452.112621] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.450s)
[452.119787] Subtest pipe-fbc-rte: SUCCESS (5.453s)
[454.457145] [064/134] (565s left) kms_flip (bo-too-big-interruptible)
[454.563325] Starting subtest: bo-too-big-interruptible
[454.565570] Starting dynamic subtest: A-eDP1
[455.903082] Dynamic subtest A-eDP1: SUCCESS (1.339s)
[455.913770] Starting dynamic subtest: B-eDP1
[457.122436] Dynamic subtest B-eDP1: SUCCESS (1.218s)
[457.132750] Starting dynamic subtest: C-eDP1
[458.362433] Dynamic subtest C-eDP1: SUCCESS (1.239s)
[458.373427] Starting dynamic subtest: D-eDP1
[459.614432] Dynamic subtest D-eDP1: SUCCESS (1.251s)
[459.619682] Subtest bo-too-big-interruptible: SUCCESS (5.055s)
[460.842563] [065/134] (559s left) gem_softpin (reverse)
[460.919632] Starting subtest: reverse
[460.927822] Subtest reverse: SUCCESS (0.008s)
[461.069418] [066/134] (558s left) prime_vgem (basic-read)
[461.209484] Starting subtest: basic-read
[461.217799] Subtest basic-read: SKIP (0.006s)
[461.329921] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[461.333176] [067/134] (558s left) perf_pmu (pmu-read)
[461.372908] Starting subtest: pmu-read
[461.375599] Subtest pmu-read: SUCCESS (0.002s)
[461.499501] [068/134] (558s left) prime_self_import (basic-llseek-size)
[461.538968] Starting subtest: basic-llseek-size
[461.569714] Subtest basic-llseek-size: SUCCESS (0.030s)
[461.699027] [069/134] (558s left) kms_getfb (getfb2-accept-nv12)
[461.806290] Starting subtest: getfb2-accept-nv12
[461.808147] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[461.930821] [070/134] (558s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[462.050922] Starting subtest: basic-busy-flip-before-cursor-atomic
[462.054976] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[462.231363] [071/134] (557s left) sysfs_heartbeat_interval (invalid)
[462.284048] Starting subtest: invalid
[462.286048] Starting dynamic subtest: vecs0
[462.287950] Dynamic subtest vecs0: SUCCESS (0.000s)
[462.296579] Starting dynamic subtest: ccs0
[462.298296] Dynamic subtest ccs0: SUCCESS (0.000s)
[462.306123] Starting dynamic subtest: vcs0
[462.307813] Dynamic subtest vcs0: SUCCESS (0.000s)
[462.315462] Starting dynamic subtest: bcs0
[462.317166] Dynamic subtest bcs0: SUCCESS (0.000s)
[462.324694] Starting dynamic subtest: rcs0
[462.326534] Dynamic subtest rcs0: SUCCESS (0.000s)
[462.334263] Starting dynamic subtest: vcs1
[462.335994] Dynamic subtest vcs1: SUCCESS (0.000s)
[462.337698] Subtest invalid: SUCCESS (0.005s)
[462.417149] [072/134] (557s left) prime_mmap (test_forked_cpu_write)
[462.478076] Starting subtest: test_forked_cpu_write
[462.479757] Starting dynamic subtest: test_forked_cpu_write-smem
[462.484048] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[462.486057] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[462.615339] [073/134] (557s left) sw_sync (sync_busy_fork_unixsocket)
[462.650329] Starting subtest: sync_busy_fork_unixsocket
[462.654336] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[462.721256] [074/134] (557s left) gem_render_copy (linear-to-vebox-yf-tiled)
[462.788174] Starting subtest: linear-to-vebox-yf-tiled
[462.791987] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[462.982873] [075/134] (557s left) kms_pm_rpm (modeset-lpsp)
[465.106509] Starting subtest: modeset-lpsp
[466.572833] Subtest modeset-lpsp: SUCCESS (1.471s)
[466.684382] [076/134] (553s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[466.776045] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[473.952098] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.179s)
[474.100673] [077/134] (546s left) gem_userptr_blits (sync-unmap-cycles)
[474.170351] Starting subtest: sync-unmap-cycles
[479.548847] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[479.718535] [078/134] (540s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[479.832570] Starting subtest: y-tiled-8bpp-rotate-270
[479.836199] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[479.961372] [079/134] (540s left) kms_plane_scaling (planes-upscale-factor-0-25)
[480.048245] Starting subtest: planes-upscale-factor-0-25
[480.050124] Starting dynamic subtest: pipe-A
[480.108138] Dynamic subtest pipe-A: SUCCESS (0.062s)
[480.119086] Starting dynamic subtest: pipe-B
[481.264951] Dynamic subtest pipe-B: SUCCESS (1.155s)
[481.277304] Starting dynamic subtest: pipe-C
[482.376089] Dynamic subtest pipe-C: SUCCESS (1.110s)
[482.384589] Starting dynamic subtest: pipe-D
[483.517247] Dynamic subtest pipe-D: SUCCESS (1.140s)
[483.519530] Subtest planes-upscale-factor-0-25: SUCCESS (3.471s)
[484.673319] [080/134] (535s left) kms_async_flips (alternate-sync-async-flip)
[484.770756] Starting subtest: alternate-sync-async-flip
[485.143645] Starting dynamic subtest: pipe-A-eDP-1
[487.955135] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[488.340633] Starting dynamic subtest: pipe-B-eDP-1
[491.090872] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[491.458401] Starting dynamic subtest: pipe-C-eDP-1
[494.215089] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[494.580092] Starting dynamic subtest: pipe-D-eDP-1
[497.356191] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s)
[497.358335] Subtest alternate-sync-async-flip: SUCCESS (12.588s)
[498.545383] [081/134] (521s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[498.650964] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[498.653162] Starting dynamic subtest: pipe-A-eDP-1
[498.661694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[498.670663] Starting dynamic subtest: pipe-B-eDP-1
[498.679266] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[498.688074] Starting dynamic subtest: pipe-C-eDP-1
[498.696144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[498.703847] Starting dynamic subtest: pipe-D-eDP-1
[498.712070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[498.715960] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[500.825600] [082/134] (519s left) gen9_exec_parse (bb-secure)
[500.887095] Subtest bb-secure: SKIP (0.000s)
[500.981397] [083/134] (519s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[501.079241] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[510.214804] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.137s)
[510.376578] [084/134] (510s left) gem_exec_fence (submit67)
[510.556080] Starting subtest: submit67
[510.561312] Subtest submit67: SKIP (0.000s)
[512.008345] [085/134] (508s left) gem_ctx_persistence (engines-queued)
[512.073293] Starting subtest: engines-queued
[512.075700] Starting dynamic subtest: rcs0
[512.200854] Dynamic subtest rcs0: SUCCESS (0.127s)
[512.213632] Starting dynamic subtest: bcs0
[512.233375] Dynamic subtest bcs0: SUCCESS (0.031s)
[512.242442] Starting dynamic subtest: vcs0
[513.845211] Dynamic subtest vcs0: SUCCESS (1.609s)
[513.857864] Starting dynamic subtest: vcs1
[515.893489] Dynamic subtest vcs1: SUCCESS (2.047s)
[515.905798] Starting dynamic subtest: vecs0
[517.877436] Dynamic subtest vecs0: SUCCESS (1.980s)
[517.895884] Starting dynamic subtest: ccs0
[518.064750] Dynamic subtest ccs0: SUCCESS (0.186s)
[518.067214] Subtest engines-queued: SUCCESS (5.991s)
[518.219152] [086/134] (502s left) kms_chamelium_color (ctm-red-to-blue)
[518.314406] Subtest ctm-red-to-blue: SKIP (0.000s)
[518.360695] [087/134] (502s left) kms_psr2_su (page_flip-p010)
[518.418451] Subtest page_flip-P010: SKIP (0.000s)
[518.481026] [088/134] (502s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[518.573495] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[518.575767] Starting dynamic subtest: pipe-A-default-mode
[519.768632] Dynamic subtest pipe-A-default-mode: SKIP (1.193s)
[519.773507] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.195s)
[519.972911] [089/134] (500s left) i915_drm_fdinfo (virtual-idle)
[520.009298] Starting subtest: virtual-idle
[523.094579] Subtest virtual-idle: SUCCESS (3.082s)
[523.182499] [090/134] (497s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[523.244052] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[523.248130] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[523.443429] [091/134] (497s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[523.550248] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[523.555088] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[524.678898] [092/134] (496s left) kms_cursor_crc (cursor-onscreen-256x85)
[524.943744] Starting subtest: cursor-onscreen-256x85
[524.992586] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[525.201726] [093/134] (495s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[525.475064] Starting subtest: cursor-rapid-movement-512x512
[525.479641] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[525.662721] [094/134] (495s left) i915_suspend (forcewake)
[525.718835] Starting subtest: forcewake
[558.068415] Subtest forcewake: SUCCESS (2.267s)
[559.152360] [095/134] (462s left) syncobj_timeline (signal-array)
[559.217337] Starting subtest: signal-array
[559.219568] Subtest signal-array: SUCCESS (0.000s)
[559.362887] [096/134] (462s left) gem_exec_params (batch-first)
[559.422653] Starting subtest: batch-first
[559.424963] Subtest batch-first: SUCCESS (0.005s)
[559.589785] [097/134] (462s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[559.699611] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[559.703352] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[559.815648] [098/134] (462s left) kms_psr (psr2-primary-mmap-gtt)
[559.914784] Starting subtest: psr2-primary-mmap-gtt
[559.916862] Starting dynamic subtest: eDP-1
[561.338597] Dynamic subtest eDP-1: SKIP (1.472s)
[561.343306] Subtest psr2-primary-mmap-gtt: SKIP (1.474s)
[561.541514] [099/134] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[561.654106] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[561.658616] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[561.772560] [100/134] (460s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[561.876993] Starting subtest: fbc-rgb565-draw-mmap-gtt
[561.880960] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[562.015971] [101/134] (460s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[562.139278] Starting subtest: stress-xrgb8888-xtiled
[567.933516] Subtest stress-xrgb8888-xtiled: SUCCESS (5.912s)
[567.983265] [102/134] (454s left) gem_exec_params (rel-constants-invalid)
[568.051127] Starting subtest: rel-constants-invalid
[568.053087] Subtest rel-constants-invalid: SUCCESS (0.000s)
[568.175621] [103/134] (454s left) gem_eio (in-flight-external)
[568.408510] Starting subtest: in-flight-external
[570.079160] Subtest in-flight-external: SUCCESS (1.687s)
[570.263822] [104/134] (452s left) gem_wait (busy)
[570.339333] Starting subtest: busy
[570.341180] Starting dynamic subtest: all-engines
[571.990397] Dynamic subtest all-engines: SUCCESS (1.666s)
[572.002966] Starting dynamic subtest: rcs0
[572.530952] Dynamic subtest rcs0: SUCCESS (0.544s)
[572.541722] Starting dynamic subtest: bcs0
[573.070871] Dynamic subtest bcs0: SUCCESS (0.542s)
[573.083376] Starting dynamic subtest: vcs0
[574.997927] Dynamic subtest vcs0: SUCCESS (1.936s)
[575.010378] Starting dynamic subtest: vcs1
[576.981822] Dynamic subtest vcs1: SUCCESS (1.991s)
[576.994024] Starting dynamic subtest: vecs0
[578.966312] Dynamic subtest vecs0: SUCCESS (1.989s)
[578.978657] Starting dynamic subtest: ccs0
[579.508792] Dynamic subtest ccs0: SUCCESS (0.543s)
[579.511348] Subtest busy: SUCCESS (9.225s)
[579.735770] [105/134] (442s left) fbdev (pan)
[579.778624] Starting subtest: pan
[579.801925] Subtest pan: SUCCESS (0.028s)
[579.890044] [106/134] (442s left) kms_chamelium_hpd (hdmi-hpd-storm)
[580.272922] Subtest hdmi-hpd-storm: SKIP (0.000s)
[581.049348] [107/134] (441s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[581.160326] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[587.736092] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.590s)
[587.888625] [108/134] (434s left) kms_async_flips (test-time-stamp-atomic)
[587.990600] Starting subtest: test-time-stamp-atomic
[588.373818] Starting dynamic subtest: pipe-A-eDP-1
[589.193982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[589.561342] Starting dynamic subtest: pipe-B-eDP-1
[590.328482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s)
[590.715802] Starting dynamic subtest: pipe-C-eDP-1
[591.478939] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[591.860088] Starting dynamic subtest: pipe-D-eDP-1
[592.619400] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[592.621913] Subtest test-time-stamp-atomic: SUCCESS (4.628s)
[593.788330] [109/134] (428s left) kms_psr (pr-sprite-mmap-gtt)
[593.883675] Starting subtest: pr-sprite-mmap-gtt
[593.887728] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[593.967241] [110/134] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[594.073354] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[594.077829] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[594.206013] [111/134] (428s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[594.312208] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[595.357096] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.044s)
[595.496180] [112/134] (427s left) gem_exec_schedule (smoketest-all)
[595.570863] Starting subtest: smoketest-all
[627.949633] Subtest smoketest-all: SUCCESS (32.336s)
[629.066754] [113/134] (393s left) vgem_basic (create)
[629.114803] Starting subtest: create
[629.117166] Subtest create: SUCCESS (0.000s)
[629.184517] [114/134] (393s left) gem_ctx_isolation (dirty-create)
[629.261999] Starting subtest: dirty-create
[629.264237] Starting dynamic subtest: rcs0
[629.516923] Dynamic subtest rcs0: SUCCESS (0.258s)
[629.529055] Starting dynamic subtest: bcs0
[629.803215] Dynamic subtest bcs0: SUCCESS (0.285s)
[629.815245] Starting dynamic subtest: vcs0
[630.060500] Dynamic subtest vcs0: SUCCESS (0.256s)
[630.071685] Starting dynamic subtest: vcs1
[631.226774] Dynamic subtest vcs1: SUCCESS (1.165s)
[631.239636] Starting dynamic subtest: vecs0
[633.202723] Dynamic subtest vecs0: SUCCESS (1.975s)
[633.212479] Starting dynamic subtest: ccs0
[635.196171] Dynamic subtest ccs0: SUCCESS (1.994s)
[635.198588] Subtest dirty-create: SUCCESS (5.940s)
[635.449977] [115/134] (387s left) kms_content_protection (uevent-hdcp14)
[635.602440] Starting subtest: uevent-hdcp14
[635.606844] Subtest uevent-hdcp14: SKIP (0.000s)
[635.748525] [116/134] (387s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[635.810770] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[635.914502] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[636.002795] [117/134] (387s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[636.104122] Starting subtest: yf-tiled-32bpp-rotate-180
[636.108606] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[636.221825] [118/134] (386s left) gem_sync (basic-many-each)
[636.309944] Starting subtest: basic-many-each
[638.608889] Subtest basic-many-each: SUCCESS (2.311s)
[638.806011] [119/134] (384s left) kms_cursor_edge_walk (256x256-right-edge)
[638.909550] Starting subtest: 256x256-right-edge
[638.911862] Starting dynamic subtest: pipe-A-eDP-1
[642.318017] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.410s)
[642.327392] Starting dynamic subtest: pipe-D-eDP-1
[645.446663] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[645.448954] Subtest 256x256-right-edge: SUCCESS (6.540s)
[646.266691] [120/134] (376s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[646.385188] Starting subtest: basic-flip-before-cursor-atomic
[647.302603] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.917s)
[648.118265] [121/134] (375s left) kms_flip (nonblocking-read)
[648.215854] Starting subtest: nonblocking-read
[648.218094] Subtest nonblocking-read: SUCCESS (0.000s)
[648.360264] [122/134] (374s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[648.461943] Starting subtest: yf-tiled-64bpp-rotate-180
[648.465996] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[648.567683] [123/134] (374s left) gem_exec_reloc (basic-wc-gtt-active)
[648.624444] Subtest basic-wc-gtt-active: SKIP (0.000s)
[648.705695] [124/134] (374s left) gem_mmap_wc (write-prefaulted)
[648.764128] Subtest write-prefaulted: SKIP (0.000s)
[648.825804] [125/134] (374s left) api_intel_bb (full-batch)
[648.875581] Starting subtest: full-batch
[648.880336] Subtest full-batch: SUCCESS (0.005s)
[649.024039] [126/134] (374s left) gem_eio (in-flight-internal-10ms)
[649.250698] Starting subtest: in-flight-internal-10ms
[651.052888] Subtest in-flight-internal-10ms: SUCCESS (1.800s)
[651.217744] [127/134] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[651.300889] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[651.304772] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[651.402904] [128/134] (372s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[651.522862] Starting subtest: cursorA-vs-flipA-toggle
[662.660308] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.134s)
[663.550772] [129/134] (360s left) syncobj_timeline (etime-multi-wait-all-submitted)
[663.609995] Starting subtest: etime-multi-wait-all-submitted
[663.714617] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[663.806472] [130/134] (359s left) gem_exec_reloc (basic-cpu-noreloc)
[663.872107] Subtest basic-cpu-noreloc: SKIP (0.000s)
[663.961535] [131/134] (359s left) gem_mmap (bad-offset)
[664.021968] Subtest bad-offset: SKIP (0.000s)
[664.089068] [132/134] (359s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[664.195142] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[664.199556] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[664.350533] [133/134] (359s left) i915_pm_rc6_residency (rc6-idle)
[664.412421] Starting subtest: rc6-idle
[664.462768] Starting dynamic subtest: gt0-rcs0
[688.759846] Dynamic subtest gt0-rcs0: SUCCESS (24.292s)
[688.769497] Starting dynamic subtest: gt0-bcs0
[713.047630] Dynamic subtest gt0-bcs0: SUCCESS (24.287s)
[713.056737] Starting dynamic subtest: gt0-ccs0
[737.396839] Dynamic subtest gt0-ccs0: SUCCESS (24.350s)
[737.410618] Starting dynamic subtest: gt1-vcs0
[743.570628] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[743.583959] Starting dynamic subtest: gt1-vecs0
[749.742083] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[749.745065] Subtest rc6-idle: SUCCESS (85.335s)
[749.836527] [134/134] (273s left) kms_psr (fbc-psr2-primary-page-flip)
[749.934742] Starting subtest: fbc-psr2-primary-page-flip
[749.936904] Starting dynamic subtest: eDP-1
[749.940857] Dynamic subtest eDP-1: SKIP (0.000s)
[749.944814] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[750.016027] 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.