[57.219682] Initializing watchdogs
[57.219732]   /dev/watchdog0
[57.233909] [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]
[57.238040] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.240351] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.243572] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[57.366332] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[57.368617] Starting dynamic subtest: pipe-A
[57.453525] Dynamic subtest pipe-A: SUCCESS (0.087s)
[57.462968] Starting dynamic subtest: pipe-B
[58.603107] Dynamic subtest pipe-B: SUCCESS (1.149s)
[58.612385] Starting dynamic subtest: pipe-C
[59.716901] Dynamic subtest pipe-C: SUCCESS (1.113s)
[59.725648] Starting dynamic subtest: pipe-D
[60.843194] Dynamic subtest pipe-D: SUCCESS (1.125s)
[60.845658] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.477s)
[62.015294] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[62.094503] Starting subtest: forbidden-operations
[62.099079] Subtest forbidden-operations: SKIP (0.000s)
[62.256237] [003/134] (955s left) gem_mmap_gtt (big-bo)
[62.321111] Subtest big-bo: SKIP (0.000s)
[62.386953] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[62.494572] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[69.833950] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.343s)
[70.012733] [005/134] (947s left) kms_fence_pin_leak
[70.202057] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[70.298547] Starting subtest: x-tiled-16bpp-rotate-180
[71.699358] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.401s)
[71.853879] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[71.904057] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[71.966458] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.054413] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[72.067086] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[72.203216] [009/134] (945s left) perf_pmu (busy-check-all)
[72.242746] Starting subtest: busy-check-all
[72.244706] Starting dynamic subtest: rcs0
[72.813218] Dynamic subtest rcs0: SUCCESS (0.570s)
[72.824255] Starting dynamic subtest: bcs0
[73.361504] Dynamic subtest bcs0: SUCCESS (0.548s)
[73.372680] Starting dynamic subtest: vcs0
[74.901570] Dynamic subtest vcs0: SUCCESS (1.537s)
[74.912251] Starting dynamic subtest: vcs1
[76.884774] Dynamic subtest vcs1: SUCCESS (1.983s)
[76.894726] Starting dynamic subtest: vecs0
[78.935262] Dynamic subtest vecs0: SUCCESS (2.048s)
[78.946180] Starting dynamic subtest: ccs0
[79.488047] Dynamic subtest ccs0: SUCCESS (0.554s)
[79.490545] Subtest busy-check-all: SUCCESS (7.246s)
[79.627743] [010/134] (938s left) gem_mmap_wc (coherency)
[79.693824] Subtest coherency: SKIP (0.000s)
[79.759757] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[79.857095] Starting subtest: yf-tiled-addfb
[79.861604] Subtest yf-tiled-addfb: SKIP (0.000s)
[79.971010] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[80.071293] Starting subtest: extended-modeset-hang-oldfb-with-reset
[80.073584] Starting dynamic subtest: pipe-A
[91.590535] Dynamic subtest pipe-A: SUCCESS (11.515s)
[91.601102] Starting dynamic subtest: pipe-D
[103.850792] Dynamic subtest pipe-D: SUCCESS (12.259s)
[103.853220] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.779s)
[104.663927] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[104.769041] Starting subtest: constant-alpha-min
[105.047572] Starting dynamic subtest: pipe-A-eDP-1
[105.746820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[105.756596] Starting dynamic subtest: pipe-D-eDP-1
[107.234046] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s)
[107.236557] Subtest constant-alpha-min: SUCCESS (2.467s)
[108.120635] [014/134] (910s left) sysfs_timeslice_duration (duration)
[108.183515] Starting subtest: duration
[108.185613] Starting dynamic subtest: vecs0
[121.853526] Dynamic subtest vecs0: SUCCESS (13.660s)
[121.863942] Starting dynamic subtest: ccs0
[134.965173] Dynamic subtest ccs0: SUCCESS (13.122s)
[134.981995] Starting dynamic subtest: vcs0
[148.852524] Dynamic subtest vcs0: SUCCESS (13.884s)
[148.869088] Starting dynamic subtest: bcs0
[162.010331] Dynamic subtest bcs0: SUCCESS (13.157s)
[162.024557] Starting dynamic subtest: rcs0
[175.172946] Dynamic subtest rcs0: SUCCESS (13.162s)
[175.182863] Starting dynamic subtest: vcs1
[188.851447] Dynamic subtest vcs1: SUCCESS (13.675s)
[188.854566] Subtest duration: SUCCESS (80.666s)
[188.983433] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[189.096538] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[192.701895] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.609s)
[193.918613] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[194.102058] Starting subtest: cursor-onscreen-64x64
[194.106578] Starting dynamic subtest: pipe-A-eDP-1
[196.236490] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[196.263705] Starting dynamic subtest: pipe-D-eDP-1
[199.044873] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s)
[199.047249] Subtest cursor-onscreen-64x64: SUCCESS (4.941s)
[199.864018] [017/134] (818s left) kms_color (ctm-red-to-blue)
[199.963160] Starting subtest: ctm-red-to-blue
[199.965073] Starting dynamic subtest: pipe-A-eDP-1
[200.670603] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[200.686527] Starting dynamic subtest: pipe-B-eDP-1
[202.041292] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[202.051568] Starting dynamic subtest: pipe-C-eDP-1
[203.416039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[203.425775] Starting dynamic subtest: pipe-D-eDP-1
[204.765875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[204.767914] Subtest ctm-red-to-blue: SUCCESS (4.802s)
[205.603787] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[205.677354] Subtest writes-after-reads-uncached: SKIP (0.000s)
[205.747812] [019/134] (812s left) dumb_buffer (invalid-bpp)
[205.809266] Starting subtest: invalid-bpp
[205.811115] Subtest invalid-bpp: SUCCESS (0.000s)
[205.938389] [020/134] (812s left) gem_mmap_gtt (ptrace)
[205.997233] Subtest ptrace: SKIP (0.000s)
[206.050272] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[206.167396] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[206.171969] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[206.331117] [022/134] (812s left) gem_lmem_swapping (verify)
[206.382176] Subtest verify: SKIP (0.000s)
[206.418331] [023/134] (812s left) gem_spin_batch (resubmit-new)
[206.488556] Starting subtest: resubmit-new
[206.491039] Starting dynamic subtest: rcs0
[206.495656] Dynamic subtest rcs0: SUCCESS (0.007s)
[206.505691] Starting dynamic subtest: bcs0
[206.507550] Dynamic subtest bcs0: SUCCESS (0.003s)
[206.515723] Starting dynamic subtest: vcs0
[206.517825] Dynamic subtest vcs0: SUCCESS (0.004s)
[206.525542] Starting dynamic subtest: vcs1
[206.527139] Dynamic subtest vcs1: SUCCESS (0.005s)
[206.534582] Starting dynamic subtest: vecs0
[206.536202] Dynamic subtest vecs0: SUCCESS (0.004s)
[206.543389] Starting dynamic subtest: ccs0
[206.545102] Dynamic subtest ccs0: SUCCESS (0.003s)
[206.546731] Subtest resubmit-new: SUCCESS (0.028s)
[207.950742] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[208.227073] Starting subtest: cursor-random-512x512
[208.231414] Subtest cursor-random-512x512: SKIP (0.001s)
[208.400370] [025/134] (810s left) kms_properties (plane-properties-legacy)
[208.493320] Starting subtest: plane-properties-legacy
[208.495690] Starting dynamic subtest: pipe-A-eDP-1
[209.035493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[209.045113] Starting dynamic subtest: pipe-B-eDP-1
[210.343201] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s)
[210.352796] Starting dynamic subtest: pipe-C-eDP-1
[211.575543] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[211.585478] Starting dynamic subtest: pipe-D-eDP-1
[212.806574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[212.808857] Subtest plane-properties-legacy: SUCCESS (4.315s)
[213.627317] [026/134] (805s left) kms_vrr (flipline)
[213.721168] Starting subtest: flipline
[213.727598] Subtest flipline: SKIP (0.000s)
[213.813813] [027/134] (804s left) gem_exec_params (secure-non-master)
[213.869961] Starting subtest: secure-non-master
[213.874429] Subtest secure-non-master: SKIP (0.000s)
[214.004030] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[214.250932] Starting subtest: parallel-dmabuf-import-out-fence
[215.321614] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.071s)
[215.455931] [029/134] (803s left) kms_pm_dc (dc5-dpms-negative)
[216.549030] Starting subtest: dc5-dpms-negative
[216.553664] Subtest dc5-dpms-negative: SKIP (0.000s)
[216.642691] [030/134] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[216.742712] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[216.746950] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.858826] [031/134] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[216.957712] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[223.773187] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.819s)
[223.930989] [032/134] (795s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[224.049175] Starting subtest: psr-argb161616f-draw-mmap-cpu
[224.053185] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[224.186426] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[224.248406] Starting subtest: basic-fds-all
[235.693277] Subtest basic-fds-all: SUCCESS (11.442s)
[235.903379] [034/134] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[236.003478] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[236.007528] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[236.141443] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[236.251574] Starting subtest: psr-rgb565-draw-render
[243.349190] Subtest psr-rgb565-draw-render: SUCCESS (7.101s)
[243.494970] [036/134] (775s left) gem_render_copy_redux (flink)
[243.571810] Starting subtest: flink
[244.352135] Subtest flink: SUCCESS (0.781s)
[244.522974] [037/134] (774s left) gem_mmap_wc (bad-offset)
[244.579859] Subtest bad-offset: SKIP (0.000s)
[244.645315] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[244.770630] Starting subtest: reject-modify-context-protection-off-2
[244.772957] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[244.914312] [039/134] (774s left) kms_3d (basic)
[244.974750] Starting subtest: basic
[246.937563] Subtest basic: SUCCESS (1.964s)
[247.453385] [040/134] (771s left) gem_ctx_persistence (smoketest)
[247.523868] Starting subtest: smoketest
[287.795847] Subtest smoketest: SUCCESS (40.268s)
[287.893897] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[287.998062] Starting subtest: fbc-pr-suspend
[288.002310] Subtest fbc-pr-suspend: SKIP (0.000s)
[288.117856] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[288.188513] Starting subtest: multi-wait-for-submit-signaled
[288.190942] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[288.329216] [043/134] (731s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.425249] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.427513] Starting dynamic subtest: pipe-A-default-mode
[291.179091] Dynamic subtest pipe-A-default-mode: SUCCESS (2.755s)
[291.181512] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.756s)
[292.087365] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[292.191088] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[292.193266] Starting dynamic subtest: pipe-A-default-mode
[294.881488] Dynamic subtest pipe-A-default-mode: SUCCESS (2.690s)
[294.883675] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.691s)
[295.782892] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[295.899926] Starting subtest: psr-rgb565-draw-mmap-cpu
[302.735904] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.836s)
[302.884207] [046/134] (716s left) vgem_basic (mmap)
[303.052665] Starting subtest: mmap
[303.070591] Subtest mmap: SUCCESS (0.019s)
[303.172024] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.175613] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[303.244327] Starting subtest: sync-unmap-after-close
[303.251751] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[303.393097] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[303.770248] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[304.546176] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[304.654366] Starting subtest: basic
[307.895801] Subtest basic: SUCCESS (3.245s)
[308.045246] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.149233] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.076860] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.930s)
[315.250255] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[315.359529] Starting subtest: fbc-rgb101010-draw-blt
[319.926501] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.570s)
[321.088144] [052/134] (698s left) kms_lease (lease-unleased-connector)
[321.182119] Starting subtest: lease-unleased-connector
[321.184387] Starting dynamic subtest: pipe-A-eDP-1
[321.189413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[321.200626] Starting dynamic subtest: pipe-B-eDP-1
[321.202725] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[321.212942] Starting dynamic subtest: pipe-C-eDP-1
[321.215125] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[321.223738] Starting dynamic subtest: pipe-D-eDP-1
[321.225823] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[321.227907] Subtest lease-unleased-connector: SUCCESS (0.034s)
[321.354083] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[321.416717] Subtest reads: SKIP (0.000s)
[321.481072] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[321.568391] Starting subtest: uhbr-sst
[321.577371] Subtest uhbr-sst: SKIP (0.000s)
[321.667064] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[321.730635] Starting subtest: etime-multi-wait-all-submitted-signaled
[321.833669] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[321.930436] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[322.020146] Starting subtest: overflow-vrefresh
[322.022400] Starting dynamic subtest: pipe-A-eDP-1
[322.307407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[322.317133] Starting dynamic subtest: pipe-B-eDP-1
[322.318994] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.327466] Starting dynamic subtest: pipe-C-eDP-1
[322.329647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.337999] Starting dynamic subtest: pipe-D-eDP-1
[322.340171] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.342378] Subtest overflow-vrefresh: SUCCESS (0.290s)
[323.185939] [057/134] (696s left) kms_pm_rpm (i2c)
[325.010604] Starting subtest: i2c
[330.134476] Subtest i2c: SUCCESS (5.123s)
[330.244930] [058/134] (689s left) gem_exec_balancer (busy)
[330.306289] Starting subtest: busy
[331.964358] Subtest busy: SUCCESS (1.659s)
[332.311417] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[337.308702] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[337.313271] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[338.172446] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[338.237602] Subtest batch-without-end: SKIP (0.000s)
[338.324688] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[338.388151] Starting subtest: exec-shared-gtt
[338.390392] Starting dynamic subtest: rcs0
[338.395018] Dynamic subtest rcs0: SUCCESS (0.007s)
[338.405179] Starting dynamic subtest: bcs0
[338.407289] Dynamic subtest bcs0: SUCCESS (0.005s)
[338.416196] Starting dynamic subtest: vcs0
[338.418418] Dynamic subtest vcs0: SUCCESS (0.007s)
[338.427236] Starting dynamic subtest: vcs1
[338.429057] Dynamic subtest vcs1: SUCCESS (0.007s)
[338.437709] Starting dynamic subtest: vecs0
[338.439801] Dynamic subtest vecs0: SUCCESS (0.006s)
[338.448380] Starting dynamic subtest: ccs0
[338.450501] Dynamic subtest ccs0: SUCCESS (0.006s)
[338.452687] Subtest exec-shared-gtt: SUCCESS (0.042s)
[338.637222] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[338.773598] Starting subtest: invalid-oa-metric-set-id
[338.783999] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[338.823884] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[338.882595] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[338.884973] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[339.005436] [064/134] (681s left) gem_tiled_pread_pwrite
[339.139322] [065/134] (681s left) i915_pm_rps (thresholds-park)
[339.199227] Starting subtest: thresholds-park
[339.203061] Subtest thresholds-park: SKIP (0.001s)
[339.335449] [066/134] (681s left) gem_ctx_engines (invalid-engines)
[339.395354] Starting subtest: invalid-engines
[339.403175] Subtest invalid-engines: SUCCESS (0.008s)
[339.683130] [067/134] (680s left) vgem_basic (create)
[339.733934] Starting subtest: create
[339.735984] Subtest create: SUCCESS (0.000s)
[339.820477] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[339.912126] Starting subtest: fbc-psr2-sprite-mmap-cpu
[339.914414] Starting dynamic subtest: eDP-1
[339.918808] Dynamic subtest eDP-1: SKIP (0.000s)
[339.923160] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[340.007848] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[340.073662] Subtest big-copy-odd: SKIP (0.000s)
[340.144205] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[340.207785] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[340.299987] [071/134] (680s left) prime_busy (before-wait)
[340.367410] Starting subtest: before-wait
[340.373043] Starting dynamic subtest: rcs0
[340.427220] Dynamic subtest rcs0: SUCCESS (0.056s)
[340.438796] Starting dynamic subtest: bcs0
[340.501515] Dynamic subtest bcs0: SUCCESS (0.073s)
[340.512313] Starting dynamic subtest: vcs0
[340.541468] Dynamic subtest vcs0: SUCCESS (0.040s)
[340.550248] Starting dynamic subtest: vcs1
[340.582476] Dynamic subtest vcs1: SUCCESS (0.040s)
[340.593626] Starting dynamic subtest: vecs0
[340.624996] Dynamic subtest vecs0: SUCCESS (0.040s)
[340.633966] Starting dynamic subtest: ccs0
[340.666061] Dynamic subtest ccs0: SUCCESS (0.039s)
[340.774766] Subtest before-wait: SUCCESS (0.405s)
[340.873572] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[341.048324] Starting subtest: keep-in-fence
[341.050920] Starting dynamic subtest: rcs0
[341.122337] Dynamic subtest rcs0: SUCCESS (0.073s)
[341.134104] Starting dynamic subtest: bcs0
[341.176089] Dynamic subtest bcs0: SUCCESS (0.052s)
[341.187884] Starting dynamic subtest: vcs0
[342.870494] Dynamic subtest vcs0: SUCCESS (1.690s)
[342.883032] Starting dynamic subtest: vcs1
[344.917363] Dynamic subtest vcs1: SUCCESS (2.045s)
[344.929887] Starting dynamic subtest: vecs0
[346.906580] Dynamic subtest vecs0: SUCCESS (1.981s)
[346.918067] Starting dynamic subtest: ccs0
[347.136927] Dynamic subtest ccs0: SUCCESS (0.235s)
[347.139690] Subtest keep-in-fence: SUCCESS (6.089s)
[349.019523] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[349.130243] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[352.877044] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.750s)
[354.084293] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[354.209859] Starting subtest: 4-tiled-8bpp-rotate-270
[354.245464] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.031s)
[354.391341] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[359.434661] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[359.437097] Starting dynamic subtest: pipe-A-eDP-1
[360.229240] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[360.239207] Starting dynamic subtest: pipe-B-eDP-1
[361.355063] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[361.359876] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.917s)
[362.581120] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[362.646497] Starting subtest: block-multicopy-inplace
[362.651165] Subtest block-multicopy-inplace: SKIP (0.000s)
[362.782701] [077/134] (658s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[362.879359] Starting subtest: x-tiled-addfb-size-offset-overflow
[362.881250] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[363.008671] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[363.100061] Starting subtest: crtc-invalid-params
[363.102179] Starting dynamic subtest: pipe-A-eDP-1
[363.477736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.378s)
[363.480092] Subtest crtc-invalid-params: SUCCESS (0.380s)
[364.316989] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[364.412399] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[364.414667] Starting dynamic subtest: pipe-A-eDP-1
[364.434335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[364.445589] Starting dynamic subtest: pipe-B-eDP-1
[364.465444] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[364.474919] Starting dynamic subtest: pipe-C-eDP-1
[364.494788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[364.504171] Starting dynamic subtest: pipe-D-eDP-1
[364.524367] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[364.526271] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[366.695424] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[366.748962] Subtest heavy-verify-multi: SKIP (0.000s)
[366.795947] [081/134] (654s left) kms_chamelium_frames (hdmi-crc-fast)
[367.190910] Subtest hdmi-crc-fast: SKIP (0.000s)
[367.987128] [082/134] (653s left) kms_vblank (query-forked-busy-hang)
[368.078236] Starting subtest: query-forked-busy-hang
[368.080391] Starting dynamic subtest: pipe-A-eDP-1
[394.652525] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.572s)
[394.667302] Starting dynamic subtest: pipe-D-eDP-1
[409.693112] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s)
[409.695066] Subtest query-forked-busy-hang: SUCCESS (41.613s)
[410.577529] [083/134] (610s left) kms_big_fb (linear-16bpp-rotate-90)
[410.686364] Starting subtest: linear-16bpp-rotate-90
[410.707930] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[410.869981] [084/134] (610s left) gem_flink_race (flink_close)
[410.908853] Starting subtest: flink_close
[416.009674] Subtest flink_close: SUCCESS (5.102s)
[416.110856] [085/134] (605s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[416.219395] Starting subtest: fbcpsr-modesetfrombusy
[422.407475] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.192s)
[422.634455] [086/134] (598s left) gem_exec_schedule (thriceslice)
[422.713155] Starting subtest: thriceslice
[422.714732] Starting dynamic subtest: rcs0
[422.738153] Dynamic subtest rcs0: SUCCESS (0.030s)
[422.750106] Starting dynamic subtest: bcs0
[422.767334] Dynamic subtest bcs0: SUCCESS (0.028s)
[422.779764] Starting dynamic subtest: vcs0
[422.817413] Dynamic subtest vcs0: SUCCESS (0.049s)
[422.828047] Starting dynamic subtest: vcs1
[422.848346] Dynamic subtest vcs1: SUCCESS (0.029s)
[422.857484] Starting dynamic subtest: vecs0
[422.897305] Dynamic subtest vecs0: SUCCESS (0.048s)
[422.907469] Starting dynamic subtest: ccs0
[422.926836] Dynamic subtest ccs0: SUCCESS (0.028s)
[422.928661] Subtest thriceslice: SUCCESS (0.219s)
[423.954635] [087/134] (597s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[424.059175] Starting subtest: flip-vs-dpms-off-vs-modeset
[424.061016] Starting dynamic subtest: A-eDP1
[427.636699] Dynamic subtest A-eDP1: SUCCESS (3.575s)
[427.646027] Starting dynamic subtest: B-eDP1
[430.829534] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[430.839937] Starting dynamic subtest: C-eDP1
[433.916990] Dynamic subtest C-eDP1: SUCCESS (3.084s)
[433.927042] Starting dynamic subtest: D-eDP1
[437.027069] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[437.029339] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.972s)
[437.843322] [088/134] (583s left) i915_pm_rps (min-max-config-idle)
[437.917851] Starting subtest: min-max-config-idle
[437.922414] Subtest min-max-config-idle: SKIP (0.001s)
[438.067983] [089/134] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[438.172679] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[444.608324] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.438s)
[444.785863] [090/134] (576s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[449.794062] Starting subtest: psr2-overlay-plane-move-continuous-sf
[449.796423] Starting dynamic subtest: pipe-A-eDP-1
[456.494707] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.698s)
[456.504997] Starting dynamic subtest: pipe-B-eDP-1
[463.129153] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.634s)
[463.131610] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.337s)
[464.029687] [091/134] (557s left) kms_concurrent (multi-plane-atomic-lowres)
[464.133274] Starting subtest: multi-plane-atomic-lowres
[464.135545] Starting dynamic subtest: pipe-A-eDP-1
[464.649790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[464.652268] Subtest multi-plane-atomic-lowres: SUCCESS (0.517s)
[465.465494] [092/134] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[465.568610] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[465.572727] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[465.715326] [093/134] (555s left) api_intel_allocator (reopen)
[465.774633] Starting subtest: reopen
[465.777113] Subtest reopen: SUCCESS (0.004s)
[465.932665] [094/134] (555s left) kms_flip (dpms-vs-vblank-race)
[466.035846] Starting subtest: dpms-vs-vblank-race
[466.037959] Starting dynamic subtest: A-eDP1
[469.909536] Dynamic subtest A-eDP1: SUCCESS (3.873s)
[469.919113] Starting dynamic subtest: B-eDP1
[473.509241] Dynamic subtest B-eDP1: SUCCESS (3.598s)
[473.519117] Starting dynamic subtest: C-eDP1
[478.109516] Dynamic subtest C-eDP1: SUCCESS (4.598s)
[478.119850] Starting dynamic subtest: D-eDP1
[482.676491] Dynamic subtest D-eDP1: SUCCESS (4.567s)
[482.678808] Subtest dpms-vs-vblank-race: SUCCESS (16.644s)
[483.578245] [095/134] (538s left) syncobj_timeline (single-wait-all-available-signaled)
[483.642598] Starting subtest: single-wait-all-available-signaled
[483.644853] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[483.758917] [096/134] (537s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[483.856304] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[483.858595] Starting dynamic subtest: pipe-A-eDP-1
[485.204929] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.348s)
[485.488571] Starting dynamic subtest: pipe-B-eDP-1
[486.531238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[486.804698] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.950s)
[487.666079] [097/134] (533s left) gem_exec_params (rs-invalid)
[487.729550] Starting subtest: rs-invalid
[487.731723] Subtest rs-invalid: SUCCESS (0.003s)
[487.881622] [098/134] (533s left) kms_scaling_modes (scaling-mode-full-aspect)
[487.964248] Starting subtest: scaling-mode-full-aspect
[487.966186] Starting dynamic subtest: pipe-A-eDP-1
[488.054725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s)
[488.064134] Starting dynamic subtest: pipe-B-eDP-1
[489.266694] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.210s)
[489.279855] Starting dynamic subtest: pipe-C-eDP-1
[490.471048] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[490.480879] Starting dynamic subtest: pipe-D-eDP-1
[491.602032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[491.604410] Subtest scaling-mode-full-aspect: SUCCESS (3.640s)
[492.787533] [099/134] (528s left) kms_plane (plane-panning-top-left)
[492.886037] Starting subtest: plane-panning-top-left
[492.888278] Starting dynamic subtest: pipe-A
[494.510764] Dynamic subtest pipe-A: SUCCESS (1.624s)
[494.521188] Starting dynamic subtest: pipe-B
[496.887380] Dynamic subtest pipe-B: SUCCESS (2.374s)
[496.889667] Subtest plane-panning-top-left: SUCCESS (4.001s)
[497.718220] [100/134] (524s left) kms_psr (psr2-sprite-mmap-cpu)
[497.816935] Starting subtest: psr2-sprite-mmap-cpu
[497.819249] Starting dynamic subtest: eDP-1
[499.478716] Dynamic subtest eDP-1: SUCCESS (1.659s)
[499.480852] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.660s)
[500.371258] [101/134] (521s left) gem_exec_params (rel-constants-invalid-ring)
[500.427797] Starting subtest: rel-constants-invalid-ring
[500.430085] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[500.548903] [102/134] (521s left) i915_query (query-garbage)
[500.606704] Starting subtest: query-garbage
[500.608999] Subtest query-garbage: SUCCESS (0.000s)
[500.740342] [103/134] (521s left) kms_psr (psr-cursor-mmap-cpu)
[500.827058] Starting subtest: psr-cursor-mmap-cpu
[500.829302] Starting dynamic subtest: eDP-1
[502.532844] Dynamic subtest eDP-1: SUCCESS (1.705s)
[502.535361] Subtest psr-cursor-mmap-cpu: SUCCESS (1.706s)
[503.419795] [104/134] (518s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[503.523618] Starting subtest: y-tiled-16bpp-rotate-90
[503.527869] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[503.660931] [105/134] (518s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[503.764546] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[503.769272] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[504.954763] [106/134] (517s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[505.088785] Starting subtest: flip-vs-cursor-legacy
[512.093757] Subtest flip-vs-cursor-legacy: SUCCESS (7.007s)
[512.983933] [107/134] (509s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[513.107026] Starting subtest: fbcpsr-argb161616f-draw-blt
[513.111501] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[513.262193] [108/134] (508s left) kms_flip (flip-vs-fences)
[513.358638] Starting subtest: flip-vs-fences
[513.362803] Subtest flip-vs-fences: SKIP (0.000s)
[513.503272] [109/134] (508s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[513.559058] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[513.643625] [110/134] (508s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[513.731926] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[513.734239] Starting dynamic subtest: pipe-A-eDP-1
[514.604497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[514.613597] Starting dynamic subtest: pipe-B-eDP-1
[516.175676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.567s)
[516.186385] Starting dynamic subtest: pipe-C-eDP-1
[517.753634] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.578s)
[517.763730] Starting dynamic subtest: pipe-D-eDP-1
[519.270949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s)
[519.273167] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.532s)
[520.531588] [111/134] (501s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[520.630961] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[520.635172] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[520.758834] [112/134] (501s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[520.847941] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[520.849815] Starting dynamic subtest: pipe-A-eDP-1
[521.575217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[521.584915] Starting dynamic subtest: pipe-B-eDP-1
[523.320476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.745s)
[523.329520] Starting dynamic subtest: pipe-C-eDP-1
[525.053872] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.732s)
[525.064182] Starting dynamic subtest: pipe-D-eDP-1
[526.791517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.736s)
[526.793453] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.937s)
[527.992040] [113/134] (494s left) i915_drm_fdinfo (memory-info-shared)
[528.037265] Starting subtest: memory-info-shared
[528.039797] Starting dynamic subtest: smem0
[528.108352] Dynamic subtest smem0: SUCCESS (0.071s)
[528.111078] Subtest memory-info-shared: SUCCESS (0.072s)
[528.203539] [114/134] (494s left) gem_exec_flush (basic-wb-set-default)
[528.263256] Starting subtest: basic-wb-set-default
[533.715255] Subtest basic-wb-set-default: SUCCESS (5.453s)
[533.926860] [115/134] (488s left) sysfs_timeslice_duration (timeout)
[534.002164] Starting subtest: timeout
[534.004330] Starting dynamic subtest: vecs0
[543.915054] Dynamic subtest vecs0: SUCCESS (9.911s)
[543.927710] Starting dynamic subtest: ccs0
[545.226056] Dynamic subtest ccs0: SUCCESS (1.310s)
[545.240188] Starting dynamic subtest: vcs0
[554.919023] Dynamic subtest vcs0: SUCCESS (9.689s)
[554.931171] Starting dynamic subtest: bcs0
[555.572615] Dynamic subtest bcs0: SUCCESS (0.652s)
[555.584030] Starting dynamic subtest: rcs0
[556.916702] Dynamic subtest rcs0: SUCCESS (1.342s)
[556.926611] Starting dynamic subtest: vcs1
[566.952414] Dynamic subtest vcs1: SUCCESS (10.031s)
[566.955605] Subtest timeout: SUCCESS (32.949s)
[567.050372] [116/134] (455s left) sriov_basic (enable-vfs-bind-unbind-each)
[567.106750] Starting subtest: enable-vfs-bind-unbind-each
[567.108818] Starting dynamic subtest: numvfs-1
[567.189773] Dynamic subtest numvfs-1: FAIL (0.033s)
[567.199821] Starting dynamic subtest: numvfs-2
[567.269781] Dynamic subtest numvfs-2: FAIL (0.003s)
[567.279668] Starting dynamic subtest: numvfs-3
[567.352060] Dynamic subtest numvfs-3: FAIL (0.003s)
[567.361990] Starting dynamic subtest: numvfs-4
[567.433719] Dynamic subtest numvfs-4: FAIL (0.003s)
[567.444461] Starting dynamic subtest: numvfs-5
[567.516969] Dynamic subtest numvfs-5: FAIL (0.003s)
[567.527621] Starting dynamic subtest: numvfs-6
[567.600731] Dynamic subtest numvfs-6: FAIL (0.003s)
[567.611612] Starting dynamic subtest: numvfs-7
[567.684258] Dynamic subtest numvfs-7: FAIL (0.003s)
[567.694612] Starting dynamic subtest: numvfs-random
[567.766582] Dynamic subtest numvfs-random: FAIL (0.003s)
[567.768959] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s)
[567.807678] [117/134] (454s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[567.901703] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[567.906100] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[569.009994] [118/134] (453s left) kms_getfb (getfb-handle-not-fb)
[569.107096] Starting subtest: getfb-handle-not-fb
[569.109275] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[569.244691] [119/134] (453s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[569.294281] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[569.298667] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[569.504347] [120/134] (453s left) gem_workarounds (reset-context)
[569.571865] Starting subtest: reset-context
[569.735287] Subtest reset-context: SUCCESS (0.162s)
[569.877564] [121/134] (452s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[569.984320] Starting subtest: psr-farfromfence-mmap-gtt
[569.988616] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[570.092162] [122/134] (452s left) gem_wait (write-busy)
[570.159736] Starting subtest: write-busy
[570.162094] Starting dynamic subtest: all-engines
[570.805791] Dynamic subtest all-engines: SUCCESS (0.646s)
[570.822849] Starting dynamic subtest: rcs0
[571.364290] Dynamic subtest rcs0: SUCCESS (0.556s)
[571.380098] Starting dynamic subtest: bcs0
[571.916405] Dynamic subtest bcs0: SUCCESS (0.551s)
[571.930553] Starting dynamic subtest: vcs0
[573.909388] Dynamic subtest vcs0: SUCCESS (1.990s)
[573.929755] Starting dynamic subtest: vcs1
[575.893253] Dynamic subtest vcs1: SUCCESS (1.981s)
[575.909685] Starting dynamic subtest: vecs0
[577.879741] Dynamic subtest vecs0: SUCCESS (1.983s)
[577.895904] Starting dynamic subtest: ccs0
[578.429128] Dynamic subtest ccs0: SUCCESS (0.549s)
[578.431519] Subtest write-busy: SUCCESS (8.269s)
[578.650584] [123/134] (444s left) i915_hangman (detector)
[578.716785] Starting subtest: detector
[578.719131] Starting dynamic subtest: rcs0
[589.876650] Dynamic subtest rcs0: SUCCESS (11.159s)
[589.888642] Starting dynamic subtest: bcs0
[601.926674] Dynamic subtest bcs0: SUCCESS (12.026s)
[601.938850] Starting dynamic subtest: vcs0
[613.812463] Dynamic subtest vcs0: SUCCESS (11.902s)
[613.824881] Starting dynamic subtest: vcs1
[625.844615] Dynamic subtest vcs1: SUCCESS (12.029s)
[625.858460] Starting dynamic subtest: vecs0
[637.812526] Dynamic subtest vecs0: SUCCESS (11.964s)
[637.824960] Starting dynamic subtest: ccs0
[649.844620] Dynamic subtest ccs0: SUCCESS (12.029s)
[649.847561] Subtest detector: SUCCESS (71.125s)
[650.007053] [124/134] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[650.116378] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[650.120720] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[650.239991] [125/134] (372s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[650.355049] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[650.359631] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[650.519939] [126/134] (372s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[650.583686] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[650.655619] [127/134] (372s left) gem_exec_schedule (noreorder-corked)
[650.838903] Starting subtest: noreorder-corked
[650.841674] Starting dynamic subtest: rcs0
[651.990219] Dynamic subtest rcs0: SUCCESS (1.152s)
[652.000987] Starting dynamic subtest: vcs0
[653.941035] Dynamic subtest vcs0: SUCCESS (1.947s)
[653.957079] Starting dynamic subtest: vcs1
[655.909479] Dynamic subtest vcs1: SUCCESS (1.965s)
[655.924318] Starting dynamic subtest: vecs0
[657.910436] Dynamic subtest vecs0: SUCCESS (1.998s)
[657.922416] Starting dynamic subtest: ccs0
[659.075413] Dynamic subtest ccs0: SUCCESS (1.163s)
[659.077951] Subtest noreorder-corked: SUCCESS (8.238s)
[659.284617] [128/134] (363s left) kms_psr (pr-cursor-mmap-cpu)
[659.370036] Starting subtest: pr-cursor-mmap-cpu
[659.374331] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[659.463961] [129/134] (363s left) perf (invalid-oa-format-id)
[659.567129] Starting subtest: invalid-oa-format-id
[659.574300] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[659.617114] [130/134] (363s left) gem_eio (in-flight-internal-immediate)
[659.805983] Starting subtest: in-flight-internal-immediate
[660.933315] Subtest in-flight-internal-immediate: SUCCESS (1.128s)
[661.072954] [131/134] (362s left) kms_cursor_edge_walk (256x256-top-edge)
[661.166830] Starting subtest: 256x256-top-edge
[661.169043] Starting dynamic subtest: pipe-A-eDP-1
[664.652769] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[664.663012] Starting dynamic subtest: pipe-D-eDP-1
[667.781579] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[667.783832] Subtest 256x256-top-edge: SUCCESS (6.614s)
[668.603059] [132/134] (354s left) gem_ctx_persistence (engines-persistence)
[668.667032] Starting subtest: engines-persistence
[668.669270] Starting dynamic subtest: rcs0
[669.493184] Dynamic subtest rcs0: SUCCESS (0.825s)
[669.505917] Starting dynamic subtest: bcs0
[670.315282] Dynamic subtest bcs0: SUCCESS (0.820s)
[670.327901] Starting dynamic subtest: vcs0
[671.138232] Dynamic subtest vcs0: SUCCESS (0.821s)
[671.150395] Starting dynamic subtest: vcs1
[671.905951] Dynamic subtest vcs1: SUCCESS (0.766s)
[671.918028] Starting dynamic subtest: vecs0
[672.670842] Dynamic subtest vecs0: SUCCESS (0.763s)
[672.682918] Starting dynamic subtest: ccs0
[673.403838] Dynamic subtest ccs0: SUCCESS (0.731s)
[673.406354] Subtest engines-persistence: SUCCESS (4.738s)
[673.573603] [133/134] (349s left) api_intel_bb (render-ccs)
[673.629780] Starting subtest: render-ccs
[673.974715] Subtest render-ccs: SUCCESS (0.346s)
[674.136506] [134/134] (349s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[674.243173] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[674.247492] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[674.374678] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_3d
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_tiled_pread_pwrite
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_concurrent
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: sriov_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.