[62.331153] Initializing watchdogs
[62.331199]   /dev/watchdog0
[62.346052] [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]
[62.350675] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.353380] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.355735] [001/133] (960s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[62.458790] Starting subtest: fbc-psr2-cursor-mmap-gtt
[62.459625] Starting dynamic subtest: eDP-1
[62.461312] Dynamic subtest eDP-1: SKIP (0.000s)
[62.462917] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[62.534107] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[62.616875] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[62.618753] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[62.707186] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[62.800037] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[62.801984] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[62.905997] [004/133] (960s left) kms_psr (psr2-primary-blt)
[62.984634] Starting subtest: psr2-primary-blt
[62.985390] Starting dynamic subtest: eDP-1
[64.745830] Dynamic subtest eDP-1: SUCCESS (1.760s)
[64.746832] Subtest psr2-primary-blt: SUCCESS (1.760s)
[65.612149] [005/133] (957s left) gem_exec_fence (nb-await)
[65.794387] Starting subtest: nb-await
[65.795501] Starting dynamic subtest: rcs0
[65.858934] Dynamic subtest rcs0: SUCCESS (0.070s)
[65.868092] Starting dynamic subtest: bcs0
[65.918791] Dynamic subtest bcs0: SUCCESS (0.059s)
[65.927236] Starting dynamic subtest: vcs0
[65.977911] Dynamic subtest vcs0: SUCCESS (0.058s)
[65.985859] Starting dynamic subtest: vcs1
[66.036952] Dynamic subtest vcs1: SUCCESS (0.058s)
[66.045573] Starting dynamic subtest: vecs0
[66.095808] Dynamic subtest vecs0: SUCCESS (0.058s)
[66.104334] Starting dynamic subtest: ccs0
[66.156530] Dynamic subtest ccs0: SUCCESS (0.060s)
[66.157991] Subtest nb-await: SUCCESS (0.368s)
[68.032666] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[68.034680] [006/133] (954s left) kms_plane_scaling (invalid-parameters)
[68.153098] Starting subtest: invalid-parameters
[68.154050] Starting dynamic subtest: less-than-1-height-src
[68.167034] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[68.173952] Starting dynamic subtest: less-than-1-width-src
[68.180020] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[68.181072] Subtest invalid-parameters: SUCCESS (0.028s)
[68.283194] [007/133] (954s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[68.386759] Starting subtest: psr2-cursor-plane-update-sf
[68.387657] Starting dynamic subtest: pipe-A-eDP-1
[68.948524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[68.955171] Starting dynamic subtest: pipe-B-eDP-1
[70.199880] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[70.200949] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.814s)
[71.075725] [008/133] (952s left) kms_psr (pr-primary-mmap-gtt)
[71.176255] Starting subtest: pr-primary-mmap-gtt
[71.177827] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[71.256297] [009/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[71.348293] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[71.349968] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.424351] [010/133] (951s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.510978] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[71.601570] [011/133] (951s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[71.694473] Starting subtest: yf-tiled-8bpp-rotate-270
[71.696352] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[71.778218] [012/133] (951s left) kms_atomic (atomic-invalid-params)
[71.872209] Starting subtest: atomic-invalid-params
[71.873642] Starting dynamic subtest: pipe-A-eDP-1
[72.281555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[72.282527] Subtest atomic-invalid-params: SUCCESS (0.409s)
[73.101146] [013/133] (950s left) kms_psr (psr-dpms)
[73.200330] Starting subtest: psr-dpms
[73.201470] Starting dynamic subtest: eDP-1
[76.143190] Dynamic subtest eDP-1: SUCCESS (2.943s)
[76.144108] Subtest psr-dpms: SUCCESS (2.944s)
[76.993249] [014/133] (946s left) kms_getfb (getfb-repeated-different-handles)
[77.086340] Starting subtest: getfb-repeated-different-handles
[77.087244] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[77.179946] [015/133] (946s left) gem_vm_create (invalid-create)
[77.228618] Starting subtest: invalid-create
[77.230623] Subtest invalid-create: SUCCESS (0.001s)
[77.337457] [016/133] (945s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[77.443334] Starting subtest: cursorA-vs-flipA-varying-size
[88.603272] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.147s)
[89.413012] [017/133] (933s left) gem_workarounds (suspend-resume)
[89.478291] Starting subtest: suspend-resume
[106.196096] Subtest suspend-resume: SUCCESS (1.680s)
[113.334920] [018/133] (917s left) syncobj_timeline (invalid-query-one-illegal-handle)
[113.389066] Starting subtest: invalid-query-one-illegal-handle
[113.389982] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[113.494788] [019/133] (916s left) kms_vblank (ts-continuation-dpms-suspend)
[113.592771] Starting subtest: ts-continuation-dpms-suspend
[113.593646] Starting dynamic subtest: pipe-A-eDP-1
[130.745965] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.250s)
[130.760230] Starting dynamic subtest: pipe-D-eDP-1
[148.757805] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.850s)
[148.758690] Subtest ts-continuation-dpms-suspend: SUCCESS (5.103s)
[154.615071] [020/133] (880s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[154.711154] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[155.722448] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.011s)
[155.840803] [021/133] (879s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[155.951457] Starting subtest: flip-vs-cursor-toggle
[164.808177] Subtest flip-vs-cursor-toggle: SUCCESS (8.855s)
[165.600988] [022/133] (870s left) syncobj_eventfd (invalid-bad-flags)
[165.651877] Starting subtest: invalid-bad-flags
[165.652859] Subtest invalid-bad-flags: SUCCESS (0.000s)
[165.741923] [023/133] (869s left) gem_exec_reloc (basic-softpin)
[165.793740] Subtest basic-softpin: SKIP (0.000s)
[165.872863] [024/133] (869s left) i915_pm_rpm (system-suspend)
[168.214335] Starting subtest: system-suspend
[186.967585] Subtest system-suspend: SUCCESS (3.252s)
[193.401652] [025/133] (848s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[193.497327] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[193.505865] Starting dynamic subtest: pipe-A-eDP-1
[227.494651] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.709s)
[227.502058] Starting dynamic subtest: pipe-B-eDP-1
[262.377206] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.536s)
[262.385156] Starting dynamic subtest: pipe-C-eDP-1
[297.363686] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.531s)
[297.371948] Starting dynamic subtest: pipe-D-eDP-1
[332.342825] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.428s)
[332.343671] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.210s)
[338.611207] [026/133] (708s left) gem_lmem_swapping (parallel-random-verify-ccs)
[338.649822] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[338.691939] [027/133] (708s left) kms_atomic_transition (plane-all-transition-fencing)
[338.790864] Starting subtest: plane-all-transition-fencing
[338.791709] Starting dynamic subtest: pipe-A-eDP-1
[341.289662] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[341.600851] Starting dynamic subtest: pipe-B-eDP-1
[344.796038] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.199s)
[345.100408] Subtest plane-all-transition-fencing: SUCCESS (6.305s)
[345.913587] [028/133] (701s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[346.022929] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[346.024683] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[346.091715] [029/133] (700s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[346.141757] Subtest writes-after-reads-snoop: SKIP (0.000s)
[346.209994] [030/133] (700s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[346.255174] Starting subtest: wait-all-for-submit-delayed-submit
[346.358244] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[346.461687] [031/133] (700s left) gem_busy (extended)
[346.644377] Starting subtest: extended
[346.645240] Starting dynamic subtest: rcs0
[346.715635] Dynamic subtest rcs0: SUCCESS (0.077s)
[346.730489] Starting dynamic subtest: bcs0
[346.758794] Dynamic subtest bcs0: SUCCESS (0.041s)
[346.769058] Starting dynamic subtest: vcs0
[348.164148] Dynamic subtest vcs0: SUCCESS (1.394s)
[348.173134] Starting dynamic subtest: vcs1
[350.148291] Dynamic subtest vcs1: SUCCESS (1.980s)
[350.157436] Starting dynamic subtest: vecs0
[352.133754] Dynamic subtest vecs0: SUCCESS (1.981s)
[352.140439] Starting dynamic subtest: ccs0
[352.170349] Dynamic subtest ccs0: SUCCESS (0.043s)
[352.171396] Subtest extended: SUCCESS (5.531s)
[352.409482] [032/133] (694s left) kms_big_fb (linear-64bpp-rotate-270)
[352.510535] Starting subtest: linear-64bpp-rotate-270
[352.530582] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[352.628945] [033/133] (694s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[353.001193] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[353.826497] [034/133] (693s left) gem_render_copy (yf-tiled-to-vebox-linear)
[353.882942] Starting subtest: yf-tiled-to-vebox-linear
[353.884788] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[354.062428] [035/133] (693s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[354.141395] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[354.142353] Starting dynamic subtest: pipe-A-eDP-1
[354.415670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.262s)
[354.423128] Starting dynamic subtest: pipe-B-eDP-1
[355.740851] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[355.750997] Starting dynamic subtest: pipe-C-eDP-1
[357.022454] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[357.029590] Starting dynamic subtest: pipe-D-eDP-1
[358.240988] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[358.242136] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.089s)
[359.384440] [036/133] (687s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[359.437005] Starting subtest: basic-batch-kernel-default-cmd
[359.438818] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[359.613660] [037/133] (687s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[359.663357] Starting subtest: invalid-multi-wait-unsubmitted
[359.664391] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[359.747696] [038/133] (687s left) gem_ctx_persistence (engines-hostile-preempt)
[359.792857] Starting subtest: engines-hostile-preempt
[359.793851] Starting dynamic subtest: rcs0
[359.859144] Dynamic subtest rcs0: SUCCESS (0.066s)
[359.870346] Starting dynamic subtest: bcs0
[359.886556] Dynamic subtest bcs0: SUCCESS (0.026s)
[359.893968] Starting dynamic subtest: vcs0
[361.130315] Dynamic subtest vcs0: SUCCESS (1.233s)
[361.138637] Starting dynamic subtest: vcs1
[363.133216] Dynamic subtest vcs1: SUCCESS (2.000s)
[363.143135] Starting dynamic subtest: vecs0
[365.177085] Dynamic subtest vecs0: SUCCESS (2.041s)
[365.186835] Starting dynamic subtest: ccs0
[365.216888] Dynamic subtest ccs0: SUCCESS (0.046s)
[365.219071] Subtest engines-hostile-preempt: SUCCESS (5.424s)
[365.306332] [039/133] (681s left) kms_cursor_edge_walk (64x64-right-edge)
[365.401356] Starting subtest: 64x64-right-edge
[365.402250] Starting dynamic subtest: pipe-A-eDP-1
[368.844103] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[368.851116] Starting dynamic subtest: pipe-D-eDP-1
[371.970010] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[371.970872] Subtest 64x64-right-edge: SUCCESS (6.568s)
[372.765094] [040/133] (674s left) core_auth (getclient-simple)
[372.796716] Starting subtest: getclient-simple
[372.813669] Subtest getclient-simple: SUCCESS (0.017s)
[372.905608] [041/133] (674s left) gem_exec_reloc (basic-write-read-noreloc)
[372.964293] Subtest basic-write-read-noreloc: SKIP (0.000s)
[373.030538] [042/133] (674s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[373.112666] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[373.114614] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[373.217657] [043/133] (674s left) kms_color_pipeline (plane-lut1d)
[373.310301] Starting subtest: plane-lut1d
[373.457536] Starting dynamic subtest: pipe-A-plane-0
[373.728667] Dynamic subtest pipe-A-plane-0: FAIL (0.203s)
[373.739551] Starting dynamic subtest: pipe-A-plane-1
[373.906927] Dynamic subtest pipe-A-plane-1: FAIL (0.171s)
[373.918955] Starting dynamic subtest: pipe-A-plane-2
[374.100073] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[375.177703] Starting dynamic subtest: pipe-B-plane-0
[375.438941] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[375.446543] Starting dynamic subtest: pipe-B-plane-1
[375.617589] Dynamic subtest pipe-B-plane-1: FAIL (0.165s)
[375.625027] Starting dynamic subtest: pipe-B-plane-2
[375.806279] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[376.885675] Starting dynamic subtest: pipe-C-plane-0
[377.165588] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[377.173794] Starting dynamic subtest: pipe-C-plane-1
[377.338251] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[377.346284] Starting dynamic subtest: pipe-C-plane-2
[377.499280] Dynamic subtest pipe-C-plane-2: FAIL (0.155s)
[378.557089] Starting dynamic subtest: pipe-D-plane-0
[378.846360] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[378.854082] Starting dynamic subtest: pipe-D-plane-1
[379.022073] Dynamic subtest pipe-D-plane-1: FAIL (0.144s)
[379.029962] Starting dynamic subtest: pipe-D-plane-2
[379.220038] Dynamic subtest pipe-D-plane-2: FAIL (0.166s)
[379.301945] Subtest plane-lut1d: FAIL (5.991s)
[380.090486] [044/133] (667s left) kms_universal_plane (universal-plane-pageflip-windowed)
[380.193816] Starting subtest: universal-plane-pageflip-windowed
[380.194578] Starting dynamic subtest: pipe-A-eDP-1
[380.804826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[380.813056] Starting dynamic subtest: pipe-B-eDP-1
[382.035654] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[382.044506] Starting dynamic subtest: pipe-C-eDP-1
[383.253726] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[383.261214] Starting dynamic subtest: pipe-D-eDP-1
[384.479167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[384.480052] Subtest universal-plane-pageflip-windowed: SUCCESS (4.285s)
[385.327761] [045/133] (662s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[385.413095] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[385.415394] Starting dynamic subtest: A-eDP1
[388.965138] Dynamic subtest A-eDP1: SUCCESS (3.548s)
[388.972431] Starting dynamic subtest: B-eDP1
[392.158553] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[392.166407] Starting dynamic subtest: C-eDP1
[395.264192] Dynamic subtest C-eDP1: SUCCESS (3.104s)
[395.271540] Starting dynamic subtest: D-eDP1
[398.365692] Dynamic subtest D-eDP1: SUCCESS (3.099s)
[398.368305] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.951s)
[399.175717] [046/133] (648s left) i915_hangman (gt-error-state-capture)
[399.239981] Starting subtest: gt-error-state-capture
[399.240766] Starting dynamic subtest: rcs0
[411.170850] Dynamic subtest rcs0: SUCCESS (11.918s)
[411.181129] Starting dynamic subtest: bcs0
[423.138819] Dynamic subtest bcs0: SUCCESS (11.964s)
[423.148377] Starting dynamic subtest: vcs0
[434.146720] Dynamic subtest vcs0: SUCCESS (11.003s)
[434.159556] Starting dynamic subtest: vcs1
[445.090716] Dynamic subtest vcs1: SUCCESS (10.943s)
[445.100228] Starting dynamic subtest: vecs0
[455.074124] Dynamic subtest vecs0: SUCCESS (9.982s)
[455.084321] Starting dynamic subtest: ccs0
[465.123085] Dynamic subtest ccs0: SUCCESS (10.046s)
[465.124441] Subtest gt-error-state-capture: SUCCESS (65.872s)
[465.244719] [047/133] (582s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[465.336490] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[465.337399] Starting dynamic subtest: pipe-A-eDP-1
[465.345816] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[465.353087] Starting dynamic subtest: pipe-B-eDP-1
[465.361420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[465.368825] Starting dynamic subtest: pipe-C-eDP-1
[465.377183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.384271] Starting dynamic subtest: pipe-D-eDP-1
[465.392699] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.394631] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[467.532327] [048/133] (580s left) perf_pmu (init-busy)
[467.572051] Starting subtest: init-busy
[467.573155] Starting dynamic subtest: rcs0
[467.574120] Dynamic subtest rcs0: SUCCESS (0.001s)
[467.583683] Starting dynamic subtest: bcs0
[467.584523] Dynamic subtest bcs0: SUCCESS (0.000s)
[467.591431] Starting dynamic subtest: vcs0
[467.592425] Dynamic subtest vcs0: SUCCESS (0.001s)
[467.599635] Starting dynamic subtest: vcs1
[467.600642] Dynamic subtest vcs1: SUCCESS (0.001s)
[467.607858] Starting dynamic subtest: vecs0
[467.608725] Dynamic subtest vecs0: SUCCESS (0.000s)
[467.615916] Starting dynamic subtest: ccs0
[467.616767] Dynamic subtest ccs0: SUCCESS (0.000s)
[467.617581] Subtest init-busy: SUCCESS (0.008s)
[467.673963] [049/133] (579s left) gem_workarounds (basic-read)
[467.750025] Starting subtest: basic-read
[467.759793] Subtest basic-read: SUCCESS (0.011s)
[467.882109] [050/133] (579s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[467.988003] Starting subtest: y-tiled-32bpp-rotate-90
[467.989954] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[468.072566] [051/133] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[468.154999] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[468.156871] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[468.249573] [052/133] (579s left) kms_mmap_write_crc (main)
[468.338152] Starting subtest: main
[468.339030] Starting dynamic subtest: pipe-A-eDP-1
[471.953544] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.614s)
[471.954531] Subtest main: SUCCESS (3.616s)
[472.754582] [053/133] (575s left) api_intel_allocator (fork-simple-stress)
[472.809045] Starting subtest: fork-simple-stress
[478.250658] Subtest fork-simple-stress: SUCCESS (5.397s)
[478.321056] [054/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[478.423515] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[479.547317] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.124s)
[479.667498] [055/133] (568s left) kms_joiner (basic-max-non-joiner)
[479.754608] Starting subtest: basic-max-non-joiner
[479.756337] Subtest basic-max-non-joiner: SKIP (0.000s)
[479.826789] [056/133] (568s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[479.922590] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[479.924473] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[479.994912] [057/133] (567s left) kms_content_protection (lic-type-0-hdcp14)
[480.133137] Starting subtest: lic-type-0-hdcp14
[480.134860] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[480.234978] [058/133] (567s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[480.296880] Subtest untiled-to-tiled: SKIP (0.000s)
[480.353391] [059/133] (567s left) core_getversion (all-cards)
[480.384870] Starting subtest: all-cards
[480.401469] Subtest all-cards: SUCCESS (0.017s)
[480.442461] [060/133] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[480.526420] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[480.528111] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[480.623062] [061/133] (567s left) gem_userptr_blits (map-fixed-invalidate)
[480.682767] Starting subtest: map-fixed-invalidate
[480.685205] Subtest map-fixed-invalidate: SKIP (0.000s)
[480.803978] [062/133] (567s left) gen9_exec_parse (basic-rejected)
[480.858250] Subtest basic-rejected: SKIP (0.000s)
[480.920356] [063/133] (567s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[481.015242] Starting subtest: fbcpsr-suspend
[521.825086] Subtest fbcpsr-suspend: SUCCESS (10.762s)
[525.000908] [064/133] (526s left) gem_sync (basic-store-each)
[525.058792] Starting subtest: basic-store-each
[527.461665] Subtest basic-store-each: SUCCESS (2.401s)
[527.655459] [065/133] (523s left) gem_exec_balancer (full)
[527.709969] Starting subtest: full
[532.080400] Subtest full: SUCCESS (4.366s)
[532.396082] [066/133] (518s left) syncobj_wait (wait-any-interrupted)
[532.452583] Starting subtest: wait-any-interrupted
[532.559909] Subtest wait-any-interrupted: SUCCESS (0.106s)
[532.649839] [067/133] (518s left) kms_setmode (invalid-clone-exclusive-crtc)
[532.689789] Starting subtest: invalid-clone-exclusive-crtc
[532.692347] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[532.776511] [068/133] (518s left) kms_vrr (negative-basic)
[532.866921] Starting subtest: negative-basic
[532.869534] Starting dynamic subtest: pipe-A-eDP-1
[538.501725] Dynamic subtest pipe-A-eDP-1: FAIL (5.410s)
[538.571929] Subtest negative-basic: FAIL (5.700s)
[539.449461] [069/133] (511s left) gem_userptr_blits (stress-mm)
[539.510523] Starting subtest: stress-mm
[544.925687] Subtest stress-mm: SUCCESS (5.369s)
[544.995038] [070/133] (506s left) gem_exec_big (single)
[545.040589] Starting subtest: single
[550.328714] Subtest single: SUCCESS (5.277s)
[550.588155] [071/133] (500s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[550.731901] Starting subtest: psr-modesetfrombusy
[556.904061] Subtest psr-modesetfrombusy: SUCCESS (6.173s)
[557.038608] [072/133] (494s left) kms_chamelium_color (ctm-green-to-red)
[557.129575] Subtest ctm-green-to-red: SKIP (0.000s)
[557.170219] [073/133] (494s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[557.260364] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[557.261259] Starting dynamic subtest: pipe-A-eDP-1
[557.362929] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[557.382289] Starting dynamic subtest: pipe-B-eDP-1
[558.492235] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[558.494110] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.232s)
[559.661781] [074/133] (491s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[559.783342] Starting subtest: 2x-flip-vs-cursor-atomic
[559.786441] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[559.923522] [075/133] (491s left) sysfs_timeslice_duration (timeout)
[559.984624] Starting subtest: timeout
[559.985742] Starting dynamic subtest: vecs0
[569.184438] Dynamic subtest vecs0: SUCCESS (9.189s)
[569.194408] Starting dynamic subtest: ccs0
[570.450149] Dynamic subtest ccs0: SUCCESS (1.275s)
[570.459915] Starting dynamic subtest: vcs0
[580.189997] Dynamic subtest vcs0: SUCCESS (9.725s)
[580.200216] Starting dynamic subtest: bcs0
[580.822555] Dynamic subtest bcs0: SUCCESS (0.641s)
[580.833071] Starting dynamic subtest: rcs0
[582.056913] Dynamic subtest rcs0: SUCCESS (1.233s)
[582.069253] Starting dynamic subtest: vcs1
[591.204468] Dynamic subtest vcs1: SUCCESS (9.133s)
[591.205397] Subtest timeout: SUCCESS (31.207s)
[591.283529] [076/133] (460s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[591.387907] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[598.143249] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.754s)
[598.265587] [077/133] (453s left) kms_cursor_crc (cursor-offscreen-512x512)
[598.527721] Starting subtest: cursor-offscreen-512x512
[598.529671] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[598.676033] [078/133] (453s left) kms_pm_rpm (pm-tiling)
[600.347321] Starting subtest: pm-tiling
[600.349454] Subtest pm-tiling: SKIP (0.000s)
[600.944770] [079/133] (450s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[601.055279] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[601.056777] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[601.139656] [080/133] (450s left) gem_spin_batch (legacy-resubmit)
[601.199119] Starting subtest: legacy-resubmit
[601.200097] Starting dynamic subtest: default
[601.204025] Dynamic subtest default: SUCCESS (0.004s)
[601.213686] Starting dynamic subtest: render
[601.214588] Dynamic subtest render: SUCCESS (0.001s)
[601.222915] Starting dynamic subtest: bsd
[601.223756] Dynamic subtest bsd: SUCCESS (0.002s)
[601.231481] Starting dynamic subtest: bsd1
[601.232387] Dynamic subtest bsd1: SUCCESS (0.001s)
[601.240216] Starting dynamic subtest: bsd2
[601.241098] Dynamic subtest bsd2: SUCCESS (0.003s)
[601.248832] Starting dynamic subtest: blt
[601.249727] Dynamic subtest blt: SUCCESS (0.003s)
[601.257637] Starting dynamic subtest: vebox
[601.258536] Dynamic subtest vebox: SUCCESS (0.003s)
[601.259538] Subtest legacy-resubmit: SUCCESS (0.023s)
[601.430803] [081/133] (450s left) gem_eio (wait-wedge-10ms)
[601.660841] Starting subtest: wait-wedge-10ms
[603.294137] Subtest wait-wedge-10ms: SUCCESS (1.633s)
[603.449803] [082/133] (448s left) gem_exec_params (sol-reset-not-gen7)
[603.523799] Starting subtest: sol-reset-not-gen7
[603.525072] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[603.628531] [083/133] (448s left) gem_ctx_shared (exec-single-timeline)
[603.690532] Starting subtest: exec-single-timeline
[603.691454] Starting dynamic subtest: rcs0
[604.736907] Dynamic subtest rcs0: SUCCESS (1.037s)
[604.748570] Starting dynamic subtest: bcs0
[605.824547] Dynamic subtest bcs0: SUCCESS (1.084s)
[605.836515] Starting dynamic subtest: vcs0
[606.913562] Dynamic subtest vcs0: SUCCESS (1.086s)
[606.926214] Starting dynamic subtest: vcs1
[608.001771] Dynamic subtest vcs1: SUCCESS (1.084s)
[608.013209] Starting dynamic subtest: vecs0
[609.089540] Dynamic subtest vecs0: SUCCESS (1.085s)
[609.105857] Starting dynamic subtest: ccs0
[610.177156] Dynamic subtest ccs0: SUCCESS (1.085s)
[610.178121] Subtest exec-single-timeline: SUCCESS (6.480s)
[610.352653] [084/133] (441s left) gem_exec_params (mmapped)
[610.402350] Starting subtest: mmapped
[610.405696] Subtest mmapped: SUCCESS (0.003s)
[610.541179] [085/133] (441s left) syncobj_timeline (host-signal-ordered)
[610.586078] Starting subtest: host-signal-ordered
[610.587138] Subtest host-signal-ordered: SUCCESS (0.000s)
[610.673599] [086/133] (441s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[610.720452] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[610.721379] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[610.808595] [087/133] (441s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[610.887846] Starting subtest: primary-x-tiled-reflect-x-180
[617.849544] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.961s)
[619.022716] [088/133] (433s left) gem_mmap_offset (partial-unmap)
[619.079308] Starting subtest: partial-unmap
[619.080158] Starting dynamic subtest: smem0
[619.597657] Dynamic subtest smem0: SUCCESS (0.508s)
[619.598646] Subtest partial-unmap: SUCCESS (0.510s)
[619.709209] [089/133] (432s left) tools_test (tools_test)
[619.743671] Starting subtest: tools_test
[619.804094] Subtest tools_test: SUCCESS (0.068s)
[619.877906] [090/133] (432s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[619.979242] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[619.980845] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[620.068263] [091/133] (432s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[620.161202] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[620.188851] Starting dynamic subtest: pipe-A-plane-0
[620.610658] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[620.619129] Starting dynamic subtest: pipe-A-plane-3
[620.877380] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[621.991312] Starting dynamic subtest: pipe-B-plane-0
[622.431655] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[622.441716] Starting dynamic subtest: pipe-B-plane-3
[622.698258] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[623.015543] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.855s)
[623.860306] [092/133] (428s left) kms_pm_backlight (basic-brightness)
[623.947190] Starting subtest: basic-brightness
[623.997159] Starting dynamic subtest: eDP-1
[624.315540] Dynamic subtest eDP-1: SUCCESS (0.319s)
[624.316382] Subtest basic-brightness: SUCCESS (0.369s)
[625.192004] [093/133] (427s left) i915_pm_rps (thresholds-idle-park)
[625.253671] Starting subtest: thresholds-idle-park
[625.255891] Subtest thresholds-idle-park: SKIP (0.001s)
[625.350309] [094/133] (427s left) gem_exec_whisper (basic-contexts-all)
[625.404284] Starting subtest: basic-contexts-all
[636.309271] Subtest basic-contexts-all: SUCCESS (10.895s)
[636.481328] [095/133] (415s left) gem_mmap_gtt (basic-copy)
[636.533188] Subtest basic-copy: SKIP (0.000s)
[636.592045] [096/133] (415s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[636.962683] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[637.793826] [097/133] (414s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[637.847081] Starting subtest: legacy-engines-hostile-preempt
[637.848500] Starting dynamic subtest: render
[637.910252] Dynamic subtest render: SUCCESS (0.063s)
[637.923278] Starting dynamic subtest: bsd1
[639.179692] Dynamic subtest bsd1: SUCCESS (1.258s)
[639.190804] Starting dynamic subtest: bsd2
[641.178956] Dynamic subtest bsd2: SUCCESS (1.996s)
[641.190592] Starting dynamic subtest: blt
[641.234715] Dynamic subtest blt: SUCCESS (0.062s)
[641.246850] Starting dynamic subtest: vebox
[643.171837] Dynamic subtest vebox: SUCCESS (1.925s)
[643.173120] Subtest legacy-engines-hostile-preempt: SUCCESS (5.317s)
[643.239003] [098/133] (409s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[643.347590] Starting subtest: cursor-vs-flip-varying-size
[674.443116] Subtest cursor-vs-flip-varying-size: SUCCESS (31.092s)
[675.252677] [099/133] (377s left) gem_render_copy (linear-to-vebox-yf-tiled)
[675.315887] Starting subtest: linear-to-vebox-yf-tiled
[675.317895] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[675.496578] [100/133] (377s left) perf (gen8-unprivileged-single-ctx-counters)
[675.623407] Starting subtest: gen8-unprivileged-single-ctx-counters
[675.625199] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[675.658873] [101/133] (376s left) kms_cursor_crc (cursor-random-max-size)
[675.974044] Starting subtest: cursor-random-max-size
[675.976888] Subtest cursor-random-max-size: SKIP (0.000s)
[676.097848] [102/133] (376s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[676.193944] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[676.194909] Starting dynamic subtest: pipe-A-eDP-1
[676.332327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.134s)
[676.342247] Starting dynamic subtest: pipe-B-eDP-1
[676.350511] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[676.359017] Starting dynamic subtest: pipe-C-eDP-1
[676.366705] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[676.375170] Starting dynamic subtest: pipe-D-eDP-1
[676.382630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[676.383518] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[678.625442] [103/133] (374s left) kms_psr (fbc-psr-no-drrs)
[678.715597] Starting subtest: fbc-psr-no-drrs
[678.716519] Starting dynamic subtest: eDP-1
[678.718249] Dynamic subtest eDP-1: SKIP (0.000s)
[678.720121] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[678.784737] [104/133] (373s left) gem_mmap_wc (bad-size)
[678.833037] Subtest bad-size: SKIP (0.000s)
[678.901887] [105/133] (373s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[678.991362] Starting subtest: fbc-shrfb-scaledprimary
[682.006457] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.014s)
[683.148752] [106/133] (369s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[683.254827] Starting subtest: fbc-farfromfence-mmap-gtt
[683.256554] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[683.372386] [107/133] (369s left) prime_vgem (fence-wait)
[683.441841] Starting subtest: fence-wait
[683.442747] Starting dynamic subtest: rcs0
[684.504532] Dynamic subtest rcs0: SUCCESS (1.054s)
[684.515745] Starting dynamic subtest: bcs0
[685.569635] Dynamic subtest bcs0: SUCCESS (1.064s)
[685.580346] Starting dynamic subtest: vcs0
[686.610096] Dynamic subtest vcs0: SUCCESS (1.039s)
[686.620198] Starting dynamic subtest: vcs1
[687.654154] Dynamic subtest vcs1: SUCCESS (1.042s)
[687.665243] Starting dynamic subtest: vecs0
[688.696701] Dynamic subtest vecs0: SUCCESS (1.040s)
[688.707414] Starting dynamic subtest: ccs0
[689.739933] Dynamic subtest ccs0: SUCCESS (1.041s)
[689.741201] Subtest fence-wait: SUCCESS (6.290s)
[689.857657] [108/133] (363s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[689.959856] Starting subtest: 4-tiled-32bpp-rotate-90
[689.979253] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[690.092675] [109/133] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[690.185319] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[690.187109] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[690.281141] [110/133] (362s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[690.336468] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[690.402504] [111/133] (362s left) kms_fbcon_fbt (psr)
[690.454696] Starting subtest: psr
[697.768570] Subtest psr: SUCCESS (7.301s)
[697.834862] [112/133] (355s left) gem_huc_copy (huc-copy)
[697.897472] Starting subtest: huc-copy
[697.900811] Subtest huc-copy: SUCCESS (0.003s)
[698.007872] [113/133] (355s left) gem_exec_reloc (basic-cpu-gtt)
[698.062018] Subtest basic-cpu-gtt: SKIP (0.000s)
[698.126050] [114/133] (354s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[698.214997] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[698.216468] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[698.283632] [115/133] (354s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[698.371499] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[698.373380] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[698.460506] [116/133] (354s left) kms_flip_event_leak (basic)
[698.553098] Starting subtest: basic
[698.553943] Starting dynamic subtest: pipe-A-eDP-1
[698.972013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[698.980399] Starting dynamic subtest: pipe-B-eDP-1
[700.094903] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[700.103473] Starting dynamic subtest: pipe-C-eDP-1
[701.212104] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[701.220519] Starting dynamic subtest: pipe-D-eDP-1
[702.345931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[702.346787] Subtest basic: SUCCESS (3.794s)
[703.207221] [117/133] (349s left) gem_close_race (multigpu-basic-process)
[703.272224] Starting subtest: multigpu-basic-process
[703.273890] Subtest multigpu-basic-process: SKIP (0.000s)
[703.505533] [118/133] (349s left) perf (i915-ref-count)
[703.557747] Starting subtest: i915-ref-count
[703.606863] Subtest i915-ref-count: SUCCESS (0.047s)
[703.661569] [119/133] (349s left) gem_eio (in-flight-suspend)
[703.906383] Starting subtest: in-flight-suspend
[747.507372] Subtest in-flight-suspend: SUCCESS (13.759s)
[754.669077] [120/133] (305s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[754.795108] Starting subtest: modeset-atomic-cursor-hotspot
[754.796913] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[754.972305] [121/133] (305s left) kms_draw_crc (draw-method-pwrite)
[755.067394] Starting subtest: draw-method-pwrite
[755.068326] Starting dynamic subtest: xrgb8888-untiled
[755.689289] Dynamic subtest xrgb8888-untiled: SUCCESS (0.622s)
[755.699223] Starting dynamic subtest: rgb565-untiled
[756.149226] Dynamic subtest rgb565-untiled: SUCCESS (0.453s)
[756.157892] Starting dynamic subtest: xrgb2101010-untiled
[756.711641] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[756.720600] Starting dynamic subtest: xbgr16161616f-untiled
[757.489519] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[757.498448] Starting dynamic subtest: xrgb8888-xtiled
[759.378632] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.888s)
[759.387855] Starting dynamic subtest: rgb565-xtiled
[760.513072] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[760.529823] Starting dynamic subtest: xrgb2101010-xtiled
[762.456998] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.941s)
[762.468769] Starting dynamic subtest: xbgr16161616f-xtiled
[765.935405] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.477s)
[765.944643] Starting dynamic subtest: xrgb8888-4tiled
[767.113238] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.177s)
[767.122183] Starting dynamic subtest: rgb565-4tiled
[767.702041] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[767.710887] Starting dynamic subtest: xrgb2101010-4tiled
[768.846711] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.144s)
[768.855467] Starting dynamic subtest: xbgr16161616f-4tiled
[772.025220] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.177s)
[772.026010] Subtest draw-method-pwrite: SUCCESS (16.956s)
[772.124712] [122/133] (288s left) kms_busy (extended-pageflip-hang-oldfb)
[772.210226] Starting subtest: extended-pageflip-hang-oldfb
[772.211059] Starting dynamic subtest: pipe-A
[772.612200] Dynamic subtest pipe-A: SUCCESS (0.401s)
[772.622981] Starting dynamic subtest: pipe-D
[773.765249] Dynamic subtest pipe-D: SUCCESS (1.150s)
[773.766132] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.556s)
[774.600655] [123/133] (285s left) gem_exec_schedule (preempt-queue-contexts)
[774.662536] Subtest preempt-queue-contexts: SKIP (0.000s)
[774.969505] [124/133] (285s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[775.063185] Starting subtest: psr-1p-primscrn-spr-indfb-move
[782.727750] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.665s)
[782.867437] [125/133] (277s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[782.945014] Starting subtest: plane-upscale-20x20-with-pixel-format
[782.945866] Starting dynamic subtest: pipe-A
[783.993640] Dynamic subtest pipe-A: SUCCESS (1.049s)
[784.002226] Starting dynamic subtest: pipe-B
[786.134471] Dynamic subtest pipe-B: SUCCESS (2.140s)
[786.144497] Starting dynamic subtest: pipe-C
[787.333846] Dynamic subtest pipe-C: SUCCESS (1.198s)
[787.344117] Starting dynamic subtest: pipe-D
[788.560392] Dynamic subtest pipe-D: SUCCESS (1.225s)
[788.561202] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.616s)
[789.745229] [126/133] (270s left) gem_exec_schedule (promotion)
[789.798954] Starting subtest: promotion
[789.799962] Starting dynamic subtest: rcs0
[789.909730] Dynamic subtest rcs0: SUCCESS (0.110s)
[789.921994] Starting dynamic subtest: vcs0
[790.001631] Dynamic subtest vcs0: SUCCESS (0.091s)
[790.013072] Starting dynamic subtest: vcs1
[790.088648] Dynamic subtest vcs1: SUCCESS (0.085s)
[790.100301] Starting dynamic subtest: vecs0
[790.197415] Dynamic subtest vecs0: SUCCESS (0.109s)
[790.211532] Starting dynamic subtest: ccs0
[790.309792] Dynamic subtest ccs0: SUCCESS (0.110s)
[790.311012] Subtest promotion: SUCCESS (0.511s)
[791.123768] [127/133] (269s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[791.209783] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[791.211499] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[791.319421] [128/133] (269s left) kms_lease (empty-lease)
[791.403527] Starting subtest: empty-lease
[791.404586] Starting dynamic subtest: pipe-A-eDP-1
[791.405517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[791.415894] Starting dynamic subtest: pipe-B-eDP-1
[791.416700] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[791.425189] Starting dynamic subtest: pipe-C-eDP-1
[791.426017] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[791.434331] Starting dynamic subtest: pipe-D-eDP-1
[791.435259] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[791.436082] Subtest empty-lease: SUCCESS (0.009s)
[791.525257] [129/133] (269s left) i915_drm_fdinfo (memory-info-purgeable)
[791.561820] Starting subtest: memory-info-purgeable
[791.562827] Starting dynamic subtest: smem0
[794.357475] Dynamic subtest smem0: SUCCESS (2.794s)
[794.358723] Subtest memory-info-purgeable: SUCCESS (2.795s)
[794.435951] [130/133] (266s left) i915_query (query-topology-known-pci-ids)
[794.491497] Starting subtest: query-topology-known-pci-ids
[794.493279] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[794.591718] [131/133] (266s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[794.683858] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[794.685620] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[794.775514] [132/133] (265s left) template (b)
[794.829014] Starting subtest: B
[794.830208] Subtest B: SUCCESS (0.000s)
[794.916880] [133/133] (265s left) kms_flip (2x-plain-flip-fb-recreate)
[795.031349] Starting subtest: 2x-plain-flip-fb-recreate
[795.041658] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[795.116046] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_atomic
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_lmem_swapping
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: core_auth
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: kms_universal_plane
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: gem_workarounds
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_mmap_write_crc
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_set_tiling_vs_blt
results: parsing output: 58/ for test: core_getversion
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_sync
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_setmode
results: parsing output: 67/ for test: kms_vrr
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: sysfs_timeslice_duration
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_ctx_shared
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: tools_test
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_pm_backlight
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_chamelium_edid
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_fenced_exec_thrash
results: parsing output: 110/ for test: kms_fbcon_fbt
results: parsing output: 111/ for test: gem_huc_copy
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip_event_leak
results: parsing output: 116/ for test: gem_close_race
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_draw_crc
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: template
results: parsing output: 132/ for test: kms_flip
Done.