[57.690465] Initializing watchdogs
[57.690584]   /dev/watchdog0
[57.705829] [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.710146] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.712440] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.715939] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[57.833257] Starting subtest: plane-upscale-20x20-with-rotation
[57.835897] Starting dynamic subtest: pipe-A
[58.074868] Dynamic subtest pipe-A: SUCCESS (0.236s)
[58.083606] Starting dynamic subtest: pipe-B
[59.433766] Dynamic subtest pipe-B: SUCCESS (1.327s)
[59.442275] Starting dynamic subtest: pipe-C
[60.788093] Dynamic subtest pipe-C: SUCCESS (1.328s)
[60.797584] Starting dynamic subtest: pipe-D
[62.135388] Dynamic subtest pipe-D: SUCCESS (1.326s)
[62.137639] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.218s)
[63.342444] [002/130] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[63.449349] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[63.453468] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[63.550197] [003/130] (954s left) kms_big_fb (linear-8bpp-rotate-180)
[63.656254] Starting subtest: linear-8bpp-rotate-180
[64.802634] Subtest linear-8bpp-rotate-180: SUCCESS (1.135s)
[64.945379] [004/130] (953s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[65.031841] Starting subtest: blocking-absolute-wf_vblank-interruptible
[65.034183] Starting dynamic subtest: A-eDP1
[73.757719] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[73.767872] Starting dynamic subtest: B-eDP1
[82.499050] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[82.509096] Starting dynamic subtest: C-eDP1
[91.214381] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[91.224046] Starting dynamic subtest: D-eDP1
[99.943681] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[99.948780] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.838s)
[101.165959] [005/130] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[101.274252] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[101.278664] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[101.391061] [006/130] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[101.489254] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[108.118056] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.629s)
[108.264414] [007/130] (910s left) gem_ctx_exec (basic-norecovery)
[108.318877] Starting subtest: basic-norecovery
[108.613290] Subtest basic-norecovery: SUCCESS (0.293s)
[108.733183] [008/130] (909s left) kms_psr (psr-primary-page-flip)
[108.826637] Starting subtest: psr-primary-page-flip
[108.828935] Starting dynamic subtest: eDP-1
[110.579536] Dynamic subtest eDP-1: SUCCESS (1.753s)
[110.581885] Subtest psr-primary-page-flip: SUCCESS (1.753s)
[111.459240] [009/130] (907s left) core_getstats
[111.631681] [010/130] (906s left) i915_hangman (detector)
[111.703938] Starting subtest: detector
[111.706032] Starting dynamic subtest: rcs0
[122.866517] Dynamic subtest rcs0: SUCCESS (11.161s)
[122.876653] Starting dynamic subtest: bcs0
[134.898702] Dynamic subtest bcs0: SUCCESS (12.030s)
[134.909514] Starting dynamic subtest: vcs0
[146.803299] Dynamic subtest vcs0: SUCCESS (11.903s)
[146.814262] Starting dynamic subtest: vcs1
[156.850419] Dynamic subtest vcs1: SUCCESS (10.046s)
[156.860746] Starting dynamic subtest: vecs0
[168.818225] Dynamic subtest vecs0: SUCCESS (11.967s)
[168.827839] Starting dynamic subtest: ccs0
[179.890426] Dynamic subtest ccs0: SUCCESS (11.071s)
[179.893183] Subtest detector: SUCCESS (68.181s)
[179.996357] [011/130] (838s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[180.097516] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[180.099678] Starting dynamic subtest: pipe-A-eDP-1
[182.133991] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.037s)
[182.141933] Starting dynamic subtest: pipe-B-eDP-1
[184.190412] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.057s)
[184.198097] Starting dynamic subtest: pipe-C-eDP-1
[186.268402] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.077s)
[186.276932] Starting dynamic subtest: pipe-D-eDP-1
[188.316938] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.045s)
[188.319312] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.219s)
[189.587640] [012/130] (829s left) gem_lmem_swapping (parallel-random-engines)
[189.629734] Subtest parallel-random-engines: SKIP (0.000s)
[189.671656] [013/130] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[189.777621] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[189.782118] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[189.905490] [014/130] (828s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[190.002912] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[190.007096] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[190.117244] [015/130] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[190.213648] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[190.217811] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[190.342195] [016/130] (828s left) gem_ctx_persistence (legacy-engines-hostile)
[190.396453] Starting subtest: legacy-engines-hostile
[190.398828] Starting dynamic subtest: render
[190.541439] Dynamic subtest render: SUCCESS (0.145s)
[190.552102] Starting dynamic subtest: bsd1
[190.664709] Dynamic subtest bsd1: SUCCESS (0.121s)
[190.674782] Starting dynamic subtest: bsd2
[190.783742] Dynamic subtest bsd2: SUCCESS (0.117s)
[190.793951] Starting dynamic subtest: blt
[190.894503] Dynamic subtest blt: SUCCESS (0.109s)
[190.904326] Starting dynamic subtest: vebox
[191.018493] Dynamic subtest vebox: SUCCESS (0.122s)
[191.020793] Subtest legacy-engines-hostile: SUCCESS (0.623s)
[191.103808] [017/130] (827s left) prime_vgem (shrink)
[191.208088] Starting subtest: shrink
[191.221384] Subtest shrink: SUCCESS (0.012s)
[191.344646] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[191.347763] [018/130] (827s left) gem_exec_schedule (preempt-queue-chain)
[191.416386] Subtest preempt-queue-chain: SKIP (0.000s)
[191.710967] [019/130] (827s left) kms_flip (flip-vs-panning-vs-hang)
[191.812028] Starting subtest: flip-vs-panning-vs-hang
[191.813968] Starting dynamic subtest: A-eDP1
[232.378887] Dynamic subtest A-eDP1: SUCCESS (40.567s)
[232.391485] Starting dynamic subtest: D-eDP1
[272.385756] Dynamic subtest D-eDP1: SUCCESS (40.003s)
[272.388211] Subtest flip-vs-panning-vs-hang: SUCCESS (80.574s)
[273.657473] [020/130] (745s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[273.902062] Starting subtest: cursor-rapid-movement-256x256
[273.906786] Starting dynamic subtest: pipe-A-eDP-1
[274.459039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[274.481424] Starting dynamic subtest: pipe-D-eDP-1
[275.666781] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[275.669071] Subtest cursor-rapid-movement-256x256: SUCCESS (1.764s)
[276.543385] [021/130] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[276.639369] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[276.643627] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[276.753894] [022/130] (742s left) gem_exec_balancer (sliced)
[276.808412] Starting subtest: sliced
[276.812978] Subtest sliced: SKIP (0.000s)
[277.100616] [023/130] (741s left) kms_psr (fbc-psr-suspend)
[277.191709] Starting subtest: fbc-psr-suspend
[277.193827] Starting dynamic subtest: eDP-1
[277.198136] Dynamic subtest eDP-1: SKIP (0.000s)
[277.202302] Subtest fbc-psr-suspend: SKIP (0.001s)
[277.284742] [024/130] (741s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[277.383336] Starting subtest: fbcpsr-stridechange
[283.595275] Subtest fbcpsr-stridechange: SUCCESS (6.210s)
[283.741620] [025/130] (735s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[283.845969] Starting subtest: 4-tiled-32bpp-rotate-180
[285.191889] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.345s)
[285.378718] [026/130] (733s left) gem_mmap_gtt (basic-read-write-distinct)
[285.444138] Subtest basic-read-write-distinct: SKIP (0.000s)
[285.514907] [027/130] (733s left) perf_pmu (busy-accuracy-2)
[285.552408] Starting subtest: busy-accuracy-2
[285.554087] Starting dynamic subtest: rcs0
[288.595685] Dynamic subtest rcs0: SUCCESS (3.041s)
[288.606317] Starting dynamic subtest: bcs0
[291.656634] Dynamic subtest bcs0: SUCCESS (3.059s)
[291.668078] Starting dynamic subtest: vcs0
[294.698420] Dynamic subtest vcs0: SUCCESS (3.040s)
[294.708076] Starting dynamic subtest: vcs1
[297.748947] Dynamic subtest vcs1: SUCCESS (3.049s)
[297.757574] Starting dynamic subtest: vecs0
[300.794897] Dynamic subtest vecs0: SUCCESS (3.043s)
[300.805087] Starting dynamic subtest: ccs0
[303.856140] Dynamic subtest ccs0: SUCCESS (3.060s)
[303.858575] Subtest busy-accuracy-2: SUCCESS (18.304s)
[303.991258] [028/130] (715s left) gem_create (create-ext-set-pat)
[304.165044] Starting subtest: create-ext-set-pat
[304.167819] Subtest create-ext-set-pat: SUCCESS (0.000s)
[304.291364] [029/130] (715s left) gem_exec_reloc (basic-wc-cpu-active)
[304.356979] Subtest basic-wc-cpu-active: SKIP (0.000s)
[304.441970] [030/130] (714s left) gem_ctx_persistence (userptr)
[304.490863] Starting subtest: userptr
[304.715934] Subtest userptr: SUCCESS (0.225s)
[304.809232] [031/130] (714s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[304.861438] Starting subtest: multi-wait-all-for-submit-unsubmitted
[304.967215] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[305.057941] [032/130] (714s left) gem_busy (close-race)
[305.134098] Starting subtest: close-race
[328.906106] Subtest close-race: SUCCESS (23.771s)
[329.320450] [033/130] (690s left) kms_addfb_basic (small-bo)
[329.464214] Starting subtest: small-bo
[329.466070] Subtest small-bo: SUCCESS (0.000s)
[329.605306] [034/130] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[329.700738] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[334.134992] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.437s)
[335.266554] [035/130] (684s left) syncobj_timeline (invalid-transfer-non-existent-point)
[335.329332] Starting subtest: invalid-transfer-non-existent-point
[335.331744] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[335.460347] [036/130] (684s left) kms_lease (lease-revoke)
[335.544748] Starting subtest: lease-revoke
[335.546981] Starting dynamic subtest: pipe-A-eDP-1
[335.580346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[335.590546] Starting dynamic subtest: pipe-B-eDP-1
[335.608816] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[335.617636] Starting dynamic subtest: pipe-C-eDP-1
[335.633905] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[335.643457] Starting dynamic subtest: pipe-D-eDP-1
[335.666250] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[335.668115] Subtest lease-revoke: SUCCESS (0.121s)
[335.803329] [037/130] (683s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[335.904989] Starting subtest: psr-rgb101010-draw-pwrite
[343.554386] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.652s)
[343.713477] [038/130] (675s left) gem_mmap_offset (partial-remap)
[343.773530] Starting subtest: partial-remap
[343.775517] Starting dynamic subtest: smem0
[343.784103] Dynamic subtest smem0: SUCCESS (0.006s)
[343.786064] Subtest partial-remap: SUCCESS (0.007s)
[343.921091] [039/130] (675s left) gem_exec_whisper (basic-fds-priority)
[343.990278] Starting subtest: basic-fds-priority
[367.078814] Subtest basic-fds-priority: SUCCESS (23.083s)
[367.271906] [040/130] (652s left) gem_softpin (allocator-nopin)
[367.329615] Starting subtest: allocator-nopin
[367.437764] Subtest allocator-nopin: SUCCESS (0.106s)
[367.583727] [041/130] (652s left) gem_exec_reloc (basic-concurrent16)
[367.651419] Subtest basic-concurrent16: SKIP (0.000s)
[367.747210] [042/130] (652s left) kms_vrr (negative-basic)
[367.846890] Starting subtest: negative-basic
[367.853321] Starting dynamic subtest: pipe-A-eDP-1
[373.276828] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.415s)
[373.576016] Subtest negative-basic: SUCCESS (5.729s)
[374.422706] [043/130] (645s left) syncobj_timeline (single-wait-all-signaled)
[374.483459] Starting subtest: single-wait-all-signaled
[374.485710] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[374.615431] [044/130] (645s left) kms_psr (fbc-psr2-primary-page-flip)
[374.719223] Starting subtest: fbc-psr2-primary-page-flip
[374.721539] Starting dynamic subtest: eDP-1
[374.725898] Dynamic subtest eDP-1: SKIP (0.000s)
[374.730282] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[374.814460] [045/130] (645s left) kms_feature_discovery (display-4x)
[374.905161] Starting subtest: display-4x
[374.909617] Subtest display-4x: SKIP (0.000s)
[375.019168] [046/130] (644s left) kms_pm_rpm (universal-planes)
[377.075461] Starting subtest: universal-planes
[377.078226] Starting dynamic subtest: plane-33
[385.441693] Dynamic subtest plane-33: SUCCESS (8.365s)
[385.453488] Starting dynamic subtest: plane-43
[393.761375] Dynamic subtest plane-43: SUCCESS (8.317s)
[393.772387] Starting dynamic subtest: plane-53
[402.137979] Dynamic subtest plane-53: SUCCESS (8.374s)
[402.149548] Starting dynamic subtest: plane-63
[410.412846] Dynamic subtest plane-63: SUCCESS (8.273s)
[410.424699] Starting dynamic subtest: plane-73
[418.747282] Dynamic subtest plane-73: SUCCESS (8.332s)
[418.758066] Starting dynamic subtest: plane-83
[427.310709] Dynamic subtest plane-83: SUCCESS (8.561s)
[427.313552] Subtest universal-planes: SUCCESS (50.234s)
[427.703907] [047/130] (592s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[427.810125] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[428.764639] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s)
[428.952240] [048/130] (591s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[429.010396] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[429.093912] [049/130] (591s left) kms_scaling_modes (scaling-mode-full-aspect)
[429.194099] Starting subtest: scaling-mode-full-aspect
[429.195927] Starting dynamic subtest: pipe-A-eDP-1
[429.289303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[429.301370] Starting dynamic subtest: pipe-B-eDP-1
[430.422577] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s)
[430.432343] Starting dynamic subtest: pipe-C-eDP-1
[431.521806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.098s)
[431.532839] Starting dynamic subtest: pipe-D-eDP-1
[432.652133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[432.654375] Subtest scaling-mode-full-aspect: SUCCESS (3.459s)
[433.837781] [050/130] (586s left) kms_color (degamma)
[433.931712] Starting subtest: degamma
[433.933945] Starting dynamic subtest: pipe-A-eDP-1
[434.627342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[434.637335] Starting dynamic subtest: pipe-B-eDP-1
[435.996546] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[436.006562] Starting dynamic subtest: pipe-C-eDP-1
[437.379656] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[437.388757] Starting dynamic subtest: pipe-D-eDP-1
[438.754480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[438.756415] Subtest degamma: SUCCESS (4.821s)
[439.558297] [051/130] (580s left) kms_cursor_crc (cursor-offscreen-256x85)
[439.828261] Starting subtest: cursor-offscreen-256x85
[439.868093] Subtest cursor-offscreen-256x85: SKIP (0.038s)
[440.092420] [052/130] (580s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[440.216715] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[440.221386] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[440.390390] [053/130] (579s left) perf_pmu (busy-start)
[440.431741] Starting subtest: busy-start
[440.433715] Starting dynamic subtest: rcs0
[442.981183] Dynamic subtest rcs0: SUCCESS (2.551s)
[442.992862] Starting dynamic subtest: bcs0
[445.531324] Dynamic subtest bcs0: SUCCESS (2.548s)
[445.543198] Starting dynamic subtest: vcs0
[448.915239] Dynamic subtest vcs0: SUCCESS (3.380s)
[448.926913] Starting dynamic subtest: vcs1
[452.883294] Dynamic subtest vcs1: SUCCESS (3.966s)
[452.893795] Starting dynamic subtest: vecs0
[456.915376] Dynamic subtest vecs0: SUCCESS (4.030s)
[456.926358] Starting dynamic subtest: ccs0
[459.464643] Dynamic subtest ccs0: SUCCESS (2.548s)
[459.467288] Subtest busy-start: SUCCESS (19.034s)
[459.584067] [054/130] (560s left) gem_spin_batch (spin-each)
[459.642349] Starting subtest: spin-each
[463.004729] Subtest spin-each: SUCCESS (3.362s)
[464.976469] [055/130] (555s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[465.079576] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[465.084060] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[465.210102] [056/130] (555s left) kms_chamelium_frames (hdmi-crc-multiple)
[465.596489] Subtest hdmi-crc-multiple: SKIP (0.000s)
[466.447397] [057/130] (554s left) gen9_exec_parse (bb-start-out)
[466.515037] Subtest bb-start-out: SKIP (0.000s)
[466.614079] [058/130] (553s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[466.734114] Starting subtest: cursorB-vs-flipA-atomic-transitions
[466.738850] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[466.902949] [059/130] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[467.001380] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[467.005756] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[467.145616] [060/130] (553s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[467.236141] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[467.238413] Starting dynamic subtest: pipe-A-eDP-1
[467.261016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.271374] Starting dynamic subtest: pipe-B-eDP-1
[467.292863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.301906] Starting dynamic subtest: pipe-C-eDP-1
[467.324121] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.334108] Starting dynamic subtest: pipe-D-eDP-1
[467.355968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.360291] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[469.464442] [061/130] (551s left) kms_flip (absolute-wf_vblank)
[469.565057] Starting subtest: absolute-wf_vblank
[469.570043] Starting dynamic subtest: A-eDP1
[478.311039] Dynamic subtest A-eDP1: SUCCESS (8.742s)
[478.320302] Starting dynamic subtest: B-eDP1
[487.046591] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[487.057073] Starting dynamic subtest: C-eDP1
[495.767838] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[495.777730] Starting dynamic subtest: D-eDP1
[504.491379] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[504.493754] Subtest absolute-wf_vblank: SUCCESS (34.927s)
[505.731831] [062/130] (514s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[505.801765] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[505.903310] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[506.004610] [063/130] (514s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[506.056750] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[506.058912] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[506.173943] [064/130] (514s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[506.276906] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[506.288705] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[506.399830] [065/130] (514s left) kms_cursor_crc (cursor-onscreen-128x42)
[506.615014] Starting subtest: cursor-onscreen-128x42
[506.653650] Subtest cursor-onscreen-128x42: SKIP (0.038s)
[506.855456] [066/130] (513s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[506.946437] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[506.948441] Starting dynamic subtest: pipe-A-eDP-1
[506.997463] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[507.007961] Starting dynamic subtest: pipe-B-eDP-1
[507.055664] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[507.065077] Starting dynamic subtest: pipe-C-eDP-1
[507.113882] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[507.123705] Starting dynamic subtest: pipe-D-eDP-1
[507.172498] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[507.176207] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[509.102213] [067/130] (511s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[509.194043] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[509.196387] Starting dynamic subtest: pipe-A-eDP-1
[509.218611] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.228235] Starting dynamic subtest: pipe-B-eDP-1
[509.249147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.258313] Starting dynamic subtest: pipe-C-eDP-1
[509.280062] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.288631] Starting dynamic subtest: pipe-D-eDP-1
[509.310433] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.314761] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[511.374928] [068/130] (509s left) kms_vblank (query-idle)
[511.468686] Starting subtest: query-idle
[511.470771] Starting dynamic subtest: pipe-A-eDP-1
[513.208544] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.739s)
[513.224308] Starting dynamic subtest: pipe-D-eDP-1
[515.692073] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.481s)
[515.694407] Subtest query-idle: SUCCESS (4.224s)
[516.535808] [069/130] (504s left) gem_exec_reloc (basic-cpu-read-active)
[516.595089] Subtest basic-cpu-read-active: SKIP (0.000s)
[516.671566] [070/130] (504s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[516.775624] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[516.779826] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[516.901611] [071/130] (504s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[521.986585] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[521.989054] Starting dynamic subtest: pipe-A-eDP-1
[522.781734] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[522.791929] Starting dynamic subtest: pipe-B-eDP-1
[523.910065] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[523.914506] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.921s)
[525.101572] [072/130] (495s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[525.192430] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[531.476414] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.286s)
[532.616654] [073/130] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[532.711466] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[532.715516] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[532.832644] [074/130] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[532.936401] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[540.266986] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.334s)
[540.450157] [075/130] (480s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[540.548536] Starting subtest: fbc-modesetfrombusy
[544.276786] Subtest fbc-modesetfrombusy: SUCCESS (3.732s)
[545.474623] [076/130] (475s left) gem_tiled_blits (basic)
[545.547500] Subtest basic: SKIP (0.000s)
[545.641824] [077/130] (475s left) gem_eio (context-create)
[545.844299] Starting subtest: context-create
[546.156784] Subtest context-create: SUCCESS (0.313s)
[546.296780] [078/130] (475s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[546.352825] Starting subtest: x-tiled-to-vebox-y-tiled
[546.357372] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[546.564619] [079/130] (474s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[546.673401] Starting subtest: basic-busy-flip-before-cursor-varying-size
[546.677965] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[546.840666] [080/130] (474s left) kms_plane_alpha_blend (alpha-7efc)
[546.942118] Starting subtest: alpha-7efc
[547.234315] Starting dynamic subtest: pipe-A-eDP-1
[547.834778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[547.859853] Starting dynamic subtest: pipe-D-eDP-1
[549.145537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[549.147886] Subtest alpha-7efc: SUCCESS (2.203s)
[550.027226] [081/130] (471s left) i915_selftest (perf)
[553.563206] Starting subtest: perf
[553.565735] Starting dynamic subtest: engine_cs
[556.518262] Dynamic subtest engine_cs: SUCCESS (2.954s)
[556.526608] Starting dynamic subtest: request
[561.852218] Dynamic subtest request: SUCCESS (5.332s)
[561.860195] Starting dynamic subtest: migrate
[566.268678] Dynamic subtest migrate: SUCCESS (4.414s)
[566.277596] Starting dynamic subtest: region
[572.444685] Dynamic subtest region: SUCCESS (6.174s)
[572.447145] Subtest perf: SUCCESS (18.881s)
[572.475488] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[572.476255] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[572.479319] [082/130] (449s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[574.036375] Starting subtest: short-flip-before-cursor-toggle
[574.978845] Subtest short-flip-before-cursor-toggle: SUCCESS (0.941s)
[575.848420] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[575.849682] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[575.853609] [083/130] (445s left) kms_pm_rpm (modeset-lpsp-stress)
[578.073501] Starting subtest: modeset-lpsp-stress
[594.757585] Subtest modeset-lpsp-stress: SUCCESS (16.681s)
[594.905469] [084/130] (426s left) gem_exec_flush (basic-wb-rw-before-default)
[594.979390] Starting subtest: basic-wb-rw-before-default
[600.430311] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[600.638687] [085/130] (420s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[600.745162] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[601.513840] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[601.720279] [086/130] (419s left) i915_query (query-regions-unallocated)
[601.774475] Starting subtest: query-regions-unallocated
[601.776764] Subtest query-regions-unallocated: SUCCESS (0.000s)
[601.890824] [087/130] (419s left) gem_exec_flush (basic-batch-kernel-default-wb)
[601.944422] Starting subtest: basic-batch-kernel-default-wb
[608.819189] Subtest basic-batch-kernel-default-wb: SUCCESS (6.875s)
[609.018525] [088/130] (412s left) syncobj_wait (multi-wait-all-signaled)
[609.084552] Starting subtest: multi-wait-all-signaled
[609.086872] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[609.205024] [089/130] (412s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[609.301926] Starting subtest: fbc-dirtyfb-ioctl
[609.304304] Starting dynamic subtest: A-eDP-1
[611.890623] Dynamic subtest A-eDP-1: SUCCESS (2.590s)
[611.892934] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.591s)
[612.780650] [090/130] (409s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[617.755510] Starting subtest: psr2-overlay-plane-update-continuous-sf
[617.757842] Starting dynamic subtest: pipe-A-eDP-1
[619.508336] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[619.519434] Starting dynamic subtest: pipe-B-eDP-1
[621.275647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.762s)
[621.277886] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.519s)
[622.089472] [091/130] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[622.185172] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[622.189137] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[622.315434] [092/130] (399s left) kms_fbcon_fbt (fbc-suspend)
[622.367598] Starting subtest: fbc-suspend
[670.676594] Subtest fbc-suspend: SUCCESS (18.742s)
[671.853462] [093/130] (350s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[671.958284] Starting subtest: y-tiled-8bpp-rotate-270
[671.962711] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[672.079468] [094/130] (349s left) gem_exec_schedule (u-submit-early-slice)
[672.149504] Starting subtest: u-submit-early-slice
[672.151645] Starting dynamic subtest: rcs0
[672.190135] Dynamic subtest rcs0: SUCCESS (0.043s)
[672.200999] Starting dynamic subtest: bcs0
[672.228110] Dynamic subtest bcs0: SUCCESS (0.037s)
[672.237481] Starting dynamic subtest: vcs0
[672.268398] Dynamic subtest vcs0: SUCCESS (0.039s)
[672.278018] Starting dynamic subtest: vcs1
[672.304659] Dynamic subtest vcs1: SUCCESS (0.035s)
[672.314718] Starting dynamic subtest: vecs0
[672.344819] Dynamic subtest vecs0: SUCCESS (0.039s)
[672.355795] Starting dynamic subtest: ccs0
[672.382623] Dynamic subtest ccs0: SUCCESS (0.037s)
[672.384982] Subtest u-submit-early-slice: SUCCESS (0.233s)
[674.207604] [095/130] (347s left) vgem_basic (debugfs)
[674.253785] Starting subtest: debugfs
[674.256107] Subtest debugfs: SUCCESS (0.001s)
[674.323106] [096/130] (347s left) gen7_exec_parse (batch-without-end)
[674.389359] Subtest batch-without-end: SKIP (0.000s)
[674.473455] [097/130] (347s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[674.577647] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[697.042989] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.375s)
[697.226735] [098/130] (324s left) dmabuf_sync_file (export-basic)
[697.275148] Starting subtest: export-basic
[697.277178] Subtest export-basic: SUCCESS (0.001s)
[697.342960] [099/130] (324s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[697.447406] Starting subtest: random-ccs-data-y-tiled-ccs
[697.449305] Starting dynamic subtest: pipe-A-eDP-1
[697.470189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[697.481325] Starting dynamic subtest: pipe-B-eDP-1
[697.500809] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[697.510334] Starting dynamic subtest: pipe-C-eDP-1
[697.529205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[697.537537] Starting dynamic subtest: pipe-D-eDP-1
[697.557105] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[697.560785] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[699.618893] [100/130] (322s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[699.732595] Starting subtest: cursorB-vs-flipB-atomic
[699.736943] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[699.889081] [101/130] (322s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[699.947595] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[700.005505] [102/130] (322s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[700.128506] Starting subtest: protected-encrypted-src-copy-not-readible
[700.242161] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[700.413112] [103/130] (321s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[700.511411] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[700.513685] Starting dynamic subtest: pipe-A-default-mode
[701.662354] Dynamic subtest pipe-A-default-mode: SKIP (1.145s)
[701.666616] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.147s)
[701.868734] [104/130] (320s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[701.972823] Starting subtest: fbcpsr-tiling-y
[701.976963] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[702.099704] [105/130] (320s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[702.650689] Starting subtest: syncobj-timeline-invalid-flags
[702.653538] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[704.214381] [106/130] (318s left) gem_basic (create-close)
[704.272894] Starting subtest: create-close
[704.277033] Subtest create-close: SUCCESS (0.000s)
[704.400123] [107/130] (318s left) api_intel_allocator (reloc-allocator)
[704.454059] Starting subtest: reloc-allocator
[704.456427] Starting dynamic subtest: basic
[704.458797] Dynamic subtest basic: SUCCESS (0.004s)
[704.471619] Starting dynamic subtest: parallel-one
[704.473823] Dynamic subtest parallel-one: SUCCESS (0.008s)
[704.485381] Starting dynamic subtest: print
[704.487492] Dynamic subtest print: SUCCESS (0.000s)
[704.496575] Starting dynamic subtest: reuse
[704.498687] Dynamic subtest reuse: SUCCESS (0.000s)
[704.507914] Starting dynamic subtest: fork-reopen-allocator
[704.510088] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[704.512282] Subtest reloc-allocator: SUCCESS (0.026s)
[704.626213] [108/130] (317s left) kms_psr (pr-primary-blt)
[704.725365] Starting subtest: pr-primary-blt
[704.729890] Subtest pr-primary-blt: SKIP (0.000s)
[704.825882] [109/130] (317s left) gem_ctx_bad_destroy (double-destroy)
[704.869998] Starting subtest: double-destroy
[704.872357] Subtest double-destroy: SUCCESS (0.000s)
[704.956494] [110/130] (317s left) core_getclient
[705.145815] [111/130] (317s left) syncobj_wait (wait-all-delayed-signal)
[705.189973] Starting subtest: wait-all-delayed-signal
[705.294341] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[705.379111] [112/130] (317s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[705.472040] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[705.476450] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[705.603883] [113/130] (317s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[705.702618] Starting subtest: yf-tiled-16bpp-rotate-0
[705.706924] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[705.850828] [114/130] (316s left) kms_async_flips (test-time-stamp)
[705.940287] Starting subtest: test-time-stamp
[706.309936] Starting dynamic subtest: pipe-A-eDP-1
[707.138409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[707.512786] Starting dynamic subtest: pipe-B-eDP-1
[708.266428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[708.636413] Starting dynamic subtest: pipe-C-eDP-1
[709.397948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[709.761850] Starting dynamic subtest: pipe-D-eDP-1
[710.523910] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[710.526218] Subtest test-time-stamp: SUCCESS (4.583s)
[711.689053] [115/130] (311s left) kms_invalid_mode (bad-vsync-end)
[711.793961] Starting subtest: bad-vsync-end
[711.796290] Starting dynamic subtest: pipe-A-eDP-1
[712.078218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[712.088573] Starting dynamic subtest: pipe-B-eDP-1
[712.090752] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[712.099904] Starting dynamic subtest: pipe-C-eDP-1
[712.102174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[712.111768] Starting dynamic subtest: pipe-D-eDP-1
[712.114035] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[712.116363] Subtest bad-vsync-end: SUCCESS (0.290s)
[712.928060] [116/130] (309s left) gem_exec_suspend (basic)
[712.997930] Starting subtest: basic
[713.000261] Starting dynamic subtest: smem
[715.126182] Dynamic subtest smem: SUCCESS (2.125s)
[715.129067] Subtest basic: SUCCESS (2.127s)
[715.322961] [117/130] (307s left) api_intel_bb (blit-noreloc-purge-cache)
[715.391917] Starting subtest: blit-noreloc-purge-cache
[715.402190] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[715.569830] [118/130] (307s left) kms_plane (pixel-format-source-clamping)
[715.673342] Starting subtest: pixel-format-source-clamping
[715.700599] Starting dynamic subtest: pipe-A-plane-0
[720.646420] Dynamic subtest pipe-A-plane-0: SUCCESS (4.944s)
[720.656401] Starting dynamic subtest: pipe-A-plane-3
[723.025221] Dynamic subtest pipe-A-plane-3: SUCCESS (2.377s)
[723.035737] Starting dynamic subtest: pipe-A-plane-5
[723.037756] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[724.110098] Starting dynamic subtest: pipe-B-plane-0
[728.980514] Dynamic subtest pipe-B-plane-0: SUCCESS (4.878s)
[728.992439] Starting dynamic subtest: pipe-B-plane-3
[731.214786] Dynamic subtest pipe-B-plane-3: SUCCESS (2.233s)
[731.225144] Starting dynamic subtest: pipe-B-plane-5
[731.227200] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[731.521920] Subtest pixel-format-source-clamping: SUCCESS (15.844s)
[732.393201] [119/130] (290s left) i915_query (query-topology-kernel-writes)
[732.451021] Starting subtest: query-topology-kernel-writes
[732.452974] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[732.558824] [120/130] (290s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[732.934507] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[733.714760] [121/130] (289s left) gem_exec_reloc (basic-cpu-active)
[733.764391] Subtest basic-cpu-active: SKIP (0.000s)
[733.852157] [122/130] (289s left) gem_exec_fence (concurrent)
[734.034299] Starting subtest: concurrent
[734.038844] Subtest concurrent: SKIP (0.000s)
[736.219379] [123/130] (286s left) perf (short-reads)
[736.369036] Starting subtest: short-reads
[736.386552] Subtest short-reads: SUCCESS (0.018s)
[736.448315] [124/130] (286s left) dumb_buffer (create-clear)
[736.506636] Starting subtest: create-clear
[770.813999] Subtest create-clear: SUCCESS (34.297s)
[770.948703] [125/130] (252s left) kms_psr2_su (page_flip-p010)
[771.004931] Subtest page_flip-P010: SKIP (0.000s)
[771.061830] [126/130] (252s left) i915_pm_rc6_residency (rc6-idle)
[771.115285] Starting subtest: rc6-idle
[771.143565] Starting dynamic subtest: gt0-rcs0
[795.438303] Dynamic subtest gt0-rcs0: SUCCESS (24.296s)
[795.449853] Starting dynamic subtest: gt0-bcs0
[819.788964] Dynamic subtest gt0-bcs0: SUCCESS (24.346s)
[819.801232] Starting dynamic subtest: gt0-ccs0
[844.211685] Dynamic subtest gt0-ccs0: SUCCESS (24.414s)
[844.224705] Starting dynamic subtest: gt1-vcs0
[850.387051] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[850.399745] Starting dynamic subtest: gt1-vecs0
[856.560647] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[856.563205] Subtest rc6-idle: SUCCESS (85.436s)
[856.656275] [127/130] (166s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[856.753232] Starting subtest: plane-scaler-unity-scaling-with-rotation
[856.755499] Starting dynamic subtest: pipe-A
[856.979676] Dynamic subtest pipe-A: SUCCESS (0.229s)
[856.990619] Starting dynamic subtest: pipe-B
[858.321339] Dynamic subtest pipe-B: SUCCESS (1.340s)
[858.333350] Starting dynamic subtest: pipe-C
[859.656262] Dynamic subtest pipe-C: SUCCESS (1.334s)
[859.668417] Starting dynamic subtest: pipe-D
[860.982395] Dynamic subtest pipe-D: SUCCESS (1.325s)
[860.984610] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.231s)
[862.183255] [128/130] (161s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[862.291611] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[862.295894] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[862.408804] [129/130] (161s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[862.533893] Starting subtest: cursor-vs-flip-legacy
[891.905345] Subtest cursor-vs-flip-legacy: SUCCESS (29.363s)
[892.720039] [130/130] (130s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[892.783610] Starting subtest: multi-wait-available-submitted-signaled
[892.785942] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[892.902394] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_exec
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: core_getstats
results: parsing output: 9/ for test: i915_hangman
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: prime_vgem
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_scaling_modes
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_tiled_blits
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_fbcon_fbt
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: gen7_exec_parse
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: dmabuf_sync_file
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_basic
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: core_getclient
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_exec_suspend
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: dumb_buffer
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: syncobj_timeline
Done.