[58.574961] Initializing watchdogs
[58.575013]   /dev/watchdog0
[58.589754] [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]
[58.594384] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.596613] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.600301] [001/133] (960s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[58.729852] Starting subtest: fbc-psr2-cursor-mmap-gtt
[58.731734] Starting dynamic subtest: eDP-1
[58.735724] Dynamic subtest eDP-1: SKIP (0.000s)
[58.739656] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[58.796620] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[58.901363] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[58.905721] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[58.994038] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[59.100647] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[59.105266] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[59.182345] [004/133] (960s left) kms_psr (psr2-primary-blt)
[59.279905] Starting subtest: psr2-primary-blt
[59.282273] Starting dynamic subtest: eDP-1
[61.027974] Dynamic subtest eDP-1: SUCCESS (1.744s)
[61.030154] Subtest psr2-primary-blt: SUCCESS (1.744s)
[61.902496] [005/133] (957s left) gem_exec_fence (nb-await)
[62.087803] Starting subtest: nb-await
[62.090290] Starting dynamic subtest: rcs0
[62.157098] Dynamic subtest rcs0: SUCCESS (0.068s)
[62.166974] Starting dynamic subtest: bcs0
[62.216069] Dynamic subtest bcs0: SUCCESS (0.058s)
[62.225714] Starting dynamic subtest: vcs0
[62.275362] Dynamic subtest vcs0: SUCCESS (0.058s)
[62.284985] Starting dynamic subtest: vcs1
[62.334343] Dynamic subtest vcs1: SUCCESS (0.058s)
[62.343084] Starting dynamic subtest: vecs0
[62.393956] Dynamic subtest vecs0: SUCCESS (0.058s)
[62.403610] Starting dynamic subtest: ccs0
[62.453820] Dynamic subtest ccs0: SUCCESS (0.059s)
[62.456387] Subtest nb-await: SUCCESS (0.366s)
[63.968254] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[63.971899] [006/133] (955s left) kms_plane_scaling (invalid-parameters)
[64.071299] Starting subtest: invalid-parameters
[64.073776] Starting dynamic subtest: less-than-1-height-src
[64.084649] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[64.093028] Starting dynamic subtest: less-than-1-width-src
[64.098151] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[64.100477] Subtest invalid-parameters: SUCCESS (0.028s)
[64.193968] [007/133] (955s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[64.304708] Starting subtest: psr2-cursor-plane-update-sf
[64.307077] Starting dynamic subtest: pipe-A-eDP-1
[64.880057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[64.887499] Starting dynamic subtest: pipe-B-eDP-1
[66.200597] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s)
[66.202978] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.900s)
[67.109863] [008/133] (952s left) kms_psr (pr-primary-mmap-gtt)
[67.300266] Starting subtest: pr-primary-mmap-gtt
[67.304779] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[67.409645] [009/133] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[67.587194] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[67.591695] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.714356] [010/133] (951s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[67.902213] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[68.049943] [011/133] (951s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[68.155666] Starting subtest: yf-tiled-8bpp-rotate-270
[68.159192] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[68.252600] [012/133] (951s left) kms_atomic (atomic-invalid-params)
[68.332375] Starting subtest: atomic-invalid-params
[68.334447] Starting dynamic subtest: pipe-A-eDP-1
[68.740636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[68.742642] Subtest atomic-invalid-params: SUCCESS (0.408s)
[69.602948] [013/133] (950s left) kms_psr (psr-dpms)
[69.700744] Starting subtest: psr-dpms
[69.703150] Starting dynamic subtest: eDP-1
[72.630211] Dynamic subtest eDP-1: SUCCESS (2.927s)
[72.632497] Subtest psr-dpms: SUCCESS (2.928s)
[73.486029] [014/133] (946s left) kms_getfb (getfb-repeated-different-handles)
[73.584451] Starting subtest: getfb-repeated-different-handles
[73.586650] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[73.687492] [015/133] (946s left) gem_vm_create (invalid-create)
[73.745752] Starting subtest: invalid-create
[73.750258] Subtest invalid-create: SUCCESS (0.002s)
[73.839199] [016/133] (945s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[73.953325] Starting subtest: cursorA-vs-flipA-varying-size
[85.105397] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.149s)
[85.924383] [017/133] (933s left) gem_workarounds (suspend-resume)
[86.003136] Starting subtest: suspend-resume
[102.198955] Subtest suspend-resume: SUCCESS (1.291s)
[102.338863] [018/133] (917s left) syncobj_timeline (invalid-query-one-illegal-handle)
[102.400785] Starting subtest: invalid-query-one-illegal-handle
[102.403178] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[102.507403] [019/133] (917s left) kms_vblank (ts-continuation-dpms-suspend)
[102.596615] Starting subtest: ts-continuation-dpms-suspend
[102.598694] Starting dynamic subtest: pipe-A-eDP-1
[119.737996] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.779s)
[119.755458] Starting dynamic subtest: pipe-D-eDP-1
[137.775021] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[137.777902] Subtest ts-continuation-dpms-suspend: SUCCESS (4.277s)
[138.583074] [020/133] (881s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[138.687868] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[139.681053] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[139.791983] [021/133] (880s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[139.921458] Starting subtest: flip-vs-cursor-toggle
[148.699289] Subtest flip-vs-cursor-toggle: SUCCESS (8.712s)
[149.497896] [022/133] (870s left) syncobj_eventfd (invalid-bad-flags)
[149.566726] Starting subtest: invalid-bad-flags
[149.569756] Subtest invalid-bad-flags: SUCCESS (0.000s)
[149.664532] [023/133] (870s left) gem_exec_reloc (basic-softpin)
[149.725232] Subtest basic-softpin: SKIP (0.000s)
[149.804930] [024/133] (870s left) i915_pm_rpm (system-suspend)
[151.855092] Starting subtest: system-suspend
[169.992533] Subtest system-suspend: SUCCESS (2.874s)
[170.389453] [025/133] (849s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[170.486871] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[170.489173] Starting dynamic subtest: pipe-A-eDP-1
[202.452726] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.810s)
[202.462357] Starting dynamic subtest: pipe-B-eDP-1
[235.398297] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.711s)
[235.407463] Starting dynamic subtest: pipe-C-eDP-1
[268.364332] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.656s)
[268.373443] Starting dynamic subtest: pipe-D-eDP-1
[301.361248] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.651s)
[301.363641] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.833s)
[302.598543] [026/133] (717s left) gem_lmem_swapping (parallel-random-verify-ccs)
[302.646603] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[302.688920] [027/133] (717s left) kms_atomic_transition (plane-all-transition-fencing)
[302.791655] Starting subtest: plane-all-transition-fencing
[302.793966] Starting dynamic subtest: pipe-A-eDP-1
[305.317924] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[305.628406] Starting dynamic subtest: pipe-B-eDP-1
[308.908625] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.263s)
[309.240390] Subtest plane-all-transition-fencing: SUCCESS (6.386s)
[310.064627] [028/133] (710s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[310.178183] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[310.182226] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[310.251352] [029/133] (710s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[310.310269] Subtest writes-after-reads-snoop: SKIP (0.000s)
[310.374029] [030/133] (710s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[310.431162] Starting subtest: wait-all-for-submit-delayed-submit
[310.535092] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[310.613491] [031/133] (709s left) gem_busy (extended)
[310.803612] Starting subtest: extended
[310.806268] Starting dynamic subtest: rcs0
[310.891405] Dynamic subtest rcs0: SUCCESS (0.088s)
[310.902552] Starting dynamic subtest: bcs0
[310.933319] Dynamic subtest bcs0: SUCCESS (0.040s)
[310.943611] Starting dynamic subtest: vcs0
[312.702466] Dynamic subtest vcs0: SUCCESS (1.758s)
[312.714492] Starting dynamic subtest: vcs1
[314.752903] Dynamic subtest vcs1: SUCCESS (2.039s)
[314.764405] Starting dynamic subtest: vecs0
[316.736969] Dynamic subtest vecs0: SUCCESS (1.975s)
[316.749293] Starting dynamic subtest: ccs0
[316.787185] Dynamic subtest ccs0: SUCCESS (0.048s)
[316.789891] Subtest extended: SUCCESS (5.963s)
[317.051438] [032/133] (703s left) kms_big_fb (linear-64bpp-rotate-270)
[317.160428] Starting subtest: linear-64bpp-rotate-270
[317.181182] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[317.307922] [033/133] (703s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[317.709737] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[318.481860] [034/133] (702s left) gem_render_copy (yf-tiled-to-vebox-linear)
[318.550426] Starting subtest: yf-tiled-to-vebox-linear
[318.555123] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[318.731186] [035/133] (701s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[318.819129] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[318.821449] Starting dynamic subtest: pipe-A-eDP-1
[319.110952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.261s)
[319.121819] Starting dynamic subtest: pipe-B-eDP-1
[320.425701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.309s)
[320.436571] Starting dynamic subtest: pipe-C-eDP-1
[321.705151] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.275s)
[321.714735] Starting dynamic subtest: pipe-D-eDP-1
[322.933969] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[322.936524] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.077s)
[324.046450] [036/133] (696s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[324.104318] Starting subtest: basic-batch-kernel-default-cmd
[324.108666] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[324.287199] [037/133] (696s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[324.342294] Starting subtest: invalid-multi-wait-unsubmitted
[324.344503] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[324.438475] [038/133] (696s left) gem_ctx_persistence (engines-hostile-preempt)
[324.491831] Starting subtest: engines-hostile-preempt
[324.494062] Starting dynamic subtest: rcs0
[324.540029] Dynamic subtest rcs0: SUCCESS (0.050s)
[324.550202] Starting dynamic subtest: bcs0
[324.631735] Dynamic subtest bcs0: SUCCESS (0.089s)
[324.642330] Starting dynamic subtest: vcs0
[325.668625] Dynamic subtest vcs0: SUCCESS (1.032s)
[325.679916] Starting dynamic subtest: vcs1
[327.741660] Dynamic subtest vcs1: SUCCESS (2.068s)
[327.752722] Starting dynamic subtest: vecs0
[329.702871] Dynamic subtest vecs0: SUCCESS (1.956s)
[329.713758] Starting dynamic subtest: ccs0
[329.785863] Dynamic subtest ccs0: SUCCESS (0.082s)
[329.788592] Subtest engines-hostile-preempt: SUCCESS (5.291s)
[329.871480] [039/133] (690s left) kms_cursor_edge_walk (64x64-right-edge)
[329.980989] Starting subtest: 64x64-right-edge
[329.983272] Starting dynamic subtest: pipe-A-eDP-1
[333.436944] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[333.448351] Starting dynamic subtest: pipe-D-eDP-1
[336.565626] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[336.568074] Subtest 64x64-right-edge: SUCCESS (6.582s)
[337.371097] [040/133] (683s left) core_auth (getclient-simple)
[337.412686] Starting subtest: getclient-simple
[337.443562] Subtest getclient-simple: SUCCESS (0.030s)
[337.559053] [041/133] (683s left) gem_exec_reloc (basic-write-read-noreloc)
[337.609575] Subtest basic-write-read-noreloc: SKIP (0.000s)
[337.667738] [042/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[337.772880] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[337.777103] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.872238] [043/133] (683s left) kms_color_pipeline (plane-lut1d)
[337.972009] Starting subtest: plane-lut1d
[338.141713] Starting dynamic subtest: pipe-A-plane-0
[338.462825] Dynamic subtest pipe-A-plane-0: FAIL (0.181s)
[338.472875] Starting dynamic subtest: pipe-A-plane-1
[338.668474] Dynamic subtest pipe-A-plane-1: FAIL (0.172s)
[338.677999] Starting dynamic subtest: pipe-A-plane-2
[338.872072] Dynamic subtest pipe-A-plane-2: FAIL (0.175s)
[339.890747] Starting dynamic subtest: pipe-B-plane-0
[340.324039] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[340.341332] Starting dynamic subtest: pipe-B-plane-1
[340.648947] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[340.667076] Starting dynamic subtest: pipe-B-plane-2
[340.957606] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[341.585340] Starting dynamic subtest: pipe-C-plane-0
[342.068524] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[342.078647] Starting dynamic subtest: pipe-C-plane-1
[342.450626] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[342.459239] Starting dynamic subtest: pipe-C-plane-2
[342.789908] Dynamic subtest pipe-C-plane-2: FAIL (0.658s)
[343.709709] Starting dynamic subtest: pipe-D-plane-0
[344.274516] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[344.284548] Starting dynamic subtest: pipe-D-plane-1
[344.719027] Dynamic subtest pipe-D-plane-1: FAIL (0.627s)
[344.728010] Starting dynamic subtest: pipe-D-plane-2
[345.144717] Dynamic subtest pipe-D-plane-2: FAIL (0.171s)
[345.146687] Subtest plane-lut1d: FAIL (6.956s)
[345.776547] [044/133] (675s left) kms_universal_plane (universal-plane-pageflip-windowed)
[345.877767] Starting subtest: universal-plane-pageflip-windowed
[345.879955] Starting dynamic subtest: pipe-A-eDP-1
[346.488207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[346.496654] Starting dynamic subtest: pipe-B-eDP-1
[347.729223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[347.748574] Starting dynamic subtest: pipe-C-eDP-1
[348.918534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s)
[348.927282] Starting dynamic subtest: pipe-D-eDP-1
[350.150878] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[350.153129] Subtest universal-plane-pageflip-windowed: SUCCESS (4.273s)
[351.007567] [045/133] (669s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[351.108117] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[351.110473] Starting dynamic subtest: A-eDP1
[354.709948] Dynamic subtest A-eDP1: SUCCESS (3.596s)
[354.720686] Starting dynamic subtest: B-eDP1
[357.913535] Dynamic subtest B-eDP1: SUCCESS (3.202s)
[357.922420] Starting dynamic subtest: C-eDP1
[361.035486] Dynamic subtest C-eDP1: SUCCESS (3.119s)
[361.044800] Starting dynamic subtest: D-eDP1
[364.134836] Dynamic subtest D-eDP1: SUCCESS (3.096s)
[364.137140] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.021s)
[364.930034] [046/133] (656s left) i915_hangman (gt-error-state-capture)
[364.999706] Starting subtest: gt-error-state-capture
[365.002005] Starting dynamic subtest: rcs0
[376.671121] Dynamic subtest rcs0: SUCCESS (11.664s)
[376.683420] Starting dynamic subtest: bcs0
[388.704119] Dynamic subtest bcs0: SUCCESS (12.024s)
[388.716238] Starting dynamic subtest: vcs0
[400.671386] Dynamic subtest vcs0: SUCCESS (11.965s)
[400.683626] Starting dynamic subtest: vcs1
[410.718203] Dynamic subtest vcs1: SUCCESS (10.051s)
[410.730359] Starting dynamic subtest: vecs0
[422.686916] Dynamic subtest vecs0: SUCCESS (11.971s)
[422.698871] Starting dynamic subtest: ccs0
[433.695197] Dynamic subtest ccs0: SUCCESS (11.007s)
[433.698609] Subtest gt-error-state-capture: SUCCESS (68.699s)
[433.844660] [047/133] (587s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[433.927609] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[433.929924] Starting dynamic subtest: pipe-A-eDP-1
[433.952148] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.963944] Starting dynamic subtest: pipe-B-eDP-1
[433.984267] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.992672] Starting dynamic subtest: pipe-C-eDP-1
[434.013906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[434.021911] Starting dynamic subtest: pipe-D-eDP-1
[434.044137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.048510] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[436.182430] [048/133] (584s left) perf_pmu (init-busy)
[436.229570] Starting subtest: init-busy
[436.231925] Starting dynamic subtest: rcs0
[436.234180] Dynamic subtest rcs0: SUCCESS (0.001s)
[436.244865] Starting dynamic subtest: bcs0
[436.247069] Dynamic subtest bcs0: SUCCESS (0.000s)
[436.255661] Starting dynamic subtest: vcs0
[436.257809] Dynamic subtest vcs0: SUCCESS (0.001s)
[436.266260] Starting dynamic subtest: vcs1
[436.268446] Dynamic subtest vcs1: SUCCESS (0.001s)
[436.277123] Starting dynamic subtest: vecs0
[436.279165] Dynamic subtest vecs0: SUCCESS (0.001s)
[436.287228] Starting dynamic subtest: ccs0
[436.289290] Dynamic subtest ccs0: SUCCESS (0.000s)
[436.291429] Subtest init-busy: SUCCESS (0.008s)
[436.352596] [049/133] (584s left) gem_workarounds (basic-read)
[436.427196] Starting subtest: basic-read
[436.438007] Subtest basic-read: SUCCESS (0.010s)
[436.567594] [050/133] (584s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[436.661387] Starting subtest: y-tiled-32bpp-rotate-90
[436.665899] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[436.766213] [051/133] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[436.873127] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[436.877036] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[436.968709] [052/133] (584s left) kms_mmap_write_crc (main)
[437.067123] Starting subtest: main
[437.069425] Starting dynamic subtest: pipe-A-eDP-1
[440.613081] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.543s)
[440.614924] Subtest main: SUCCESS (3.544s)
[441.406692] [053/133] (579s left) api_intel_allocator (fork-simple-stress)
[441.455288] Starting subtest: fork-simple-stress
[446.850876] Subtest fork-simple-stress: SUCCESS (5.396s)
[446.971400] [054/133] (574s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[447.081231] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[448.193160] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.114s)
[448.317364] [055/133] (573s left) kms_joiner (basic-max-non-joiner)
[448.423324] Starting subtest: basic-max-non-joiner
[448.426779] Subtest basic-max-non-joiner: SKIP (0.000s)
[448.495815] [056/133] (572s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[448.597680] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[448.601213] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[448.670436] [057/133] (572s left) kms_content_protection (lic-type-0-hdcp14)
[448.821385] Starting subtest: lic-type-0-hdcp14
[448.825185] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[448.975262] [058/133] (572s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[449.044245] Subtest untiled-to-tiled: SKIP (0.000s)
[449.145460] [059/133] (572s left) core_getversion (all-cards)
[449.182431] Starting subtest: all-cards
[449.189052] Subtest all-cards: SUCCESS (0.013s)
[449.234811] [060/133] (572s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[449.337632] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[449.340996] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[449.455923] [061/133] (572s left) gem_userptr_blits (map-fixed-invalidate)
[449.537211] Starting subtest: map-fixed-invalidate
[449.541107] Subtest map-fixed-invalidate: SKIP (0.000s)
[449.648265] [062/133] (572s left) gen9_exec_parse (basic-rejected)
[449.708073] Subtest basic-rejected: SKIP (0.000s)
[449.781655] [063/133] (571s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[449.877996] Starting subtest: fbcpsr-suspend
[489.877266] Subtest fbcpsr-suspend: SUCCESS (10.127s)
[490.004704] [064/133] (531s left) gem_sync (basic-store-each)
[490.087047] Starting subtest: basic-store-each
[492.554839] Subtest basic-store-each: SUCCESS (2.453s)
[492.743667] [065/133] (529s left) gem_exec_balancer (full)
[492.810956] Starting subtest: full
[497.458896] Subtest full: SUCCESS (4.613s)
[497.773066] [066/133] (524s left) syncobj_wait (wait-any-interrupted)
[497.839535] Starting subtest: wait-any-interrupted
[497.939820] Subtest wait-any-interrupted: SUCCESS (0.101s)
[498.018323] [067/133] (523s left) kms_setmode (invalid-clone-exclusive-crtc)
[498.067010] Starting subtest: invalid-clone-exclusive-crtc
[498.073666] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[498.174402] [068/133] (523s left) kms_vrr (negative-basic)
[498.266266] Starting subtest: negative-basic
[498.274216] Starting dynamic subtest: pipe-A-eDP-1
[503.746476] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.452s)
[504.045240] Subtest negative-basic: SUCCESS (5.760s)
[504.887730] [069/133] (517s left) gem_userptr_blits (stress-mm)
[504.951248] Starting subtest: stress-mm
[510.330927] Subtest stress-mm: SUCCESS (5.369s)
[510.450704] [070/133] (511s left) gem_exec_big (single)
[510.504946] Starting subtest: single
[515.376373] Subtest single: SUCCESS (4.864s)
[515.663375] [071/133] (506s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[515.810934] Starting subtest: psr-modesetfrombusy
[521.966217] Subtest psr-modesetfrombusy: SUCCESS (6.155s)
[522.094074] [072/133] (500s left) kms_chamelium_color (ctm-green-to-red)
[522.195132] Subtest ctm-green-to-red: SKIP (0.000s)
[522.244235] [073/133] (499s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[522.331804] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[522.333820] Starting dynamic subtest: pipe-A-eDP-1
[522.440046] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[522.450265] Starting dynamic subtest: pipe-B-eDP-1
[523.626489] Dynamic subtest pipe-B-eDP-1: SKIP (1.184s)
[523.631298] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.297s)
[524.810878] [074/133] (497s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[524.935792] Starting subtest: 2x-flip-vs-cursor-atomic
[524.941005] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[525.096491] [075/133] (497s left) sysfs_timeslice_duration (timeout)
[525.159813] Starting subtest: timeout
[525.162450] Starting dynamic subtest: vecs0
[533.578587] Dynamic subtest vecs0: SUCCESS (8.415s)
[533.589035] Starting dynamic subtest: ccs0
[534.858448] Dynamic subtest ccs0: SUCCESS (1.279s)
[534.870072] Starting dynamic subtest: vcs0
[544.582357] Dynamic subtest vcs0: SUCCESS (9.718s)
[544.598503] Starting dynamic subtest: bcs0
[545.181262] Dynamic subtest bcs0: SUCCESS (0.599s)
[545.191154] Starting dynamic subtest: rcs0
[546.430454] Dynamic subtest rcs0: SUCCESS (1.245s)
[546.441446] Starting dynamic subtest: vcs1
[555.597326] Dynamic subtest vcs1: SUCCESS (9.161s)
[555.600861] Subtest timeout: SUCCESS (30.431s)
[555.675258] [076/133] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[555.796891] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[562.606978] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.811s)
[562.732969] [077/133] (459s left) kms_cursor_crc (cursor-offscreen-512x512)
[563.001353] Starting subtest: cursor-offscreen-512x512
[563.006152] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[563.147886] [078/133] (459s left) kms_pm_rpm (pm-tiling)
[564.800390] Starting subtest: pm-tiling
[564.805197] Subtest pm-tiling: SKIP (0.000s)
[565.576736] [079/133] (456s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[565.674268] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[565.679446] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[565.768683] [080/133] (456s left) gem_spin_batch (legacy-resubmit)
[565.822228] Starting subtest: legacy-resubmit
[565.824882] Starting dynamic subtest: default
[565.830058] Dynamic subtest default: SUCCESS (0.005s)
[565.840469] Starting dynamic subtest: render
[565.843261] Dynamic subtest render: SUCCESS (0.001s)
[565.854531] Starting dynamic subtest: bsd
[565.857127] Dynamic subtest bsd: SUCCESS (0.003s)
[565.866309] Starting dynamic subtest: bsd1
[565.868753] Dynamic subtest bsd1: SUCCESS (0.001s)
[565.877951] Starting dynamic subtest: bsd2
[565.880240] Dynamic subtest bsd2: SUCCESS (0.003s)
[565.889480] Starting dynamic subtest: blt
[565.891941] Dynamic subtest blt: SUCCESS (0.002s)
[565.901107] Starting dynamic subtest: vebox
[565.903451] Dynamic subtest vebox: SUCCESS (0.003s)
[565.905838] Subtest legacy-resubmit: SUCCESS (0.023s)
[566.070214] [081/133] (456s left) gem_eio (wait-wedge-10ms)
[566.282397] Starting subtest: wait-wedge-10ms
[567.634186] Subtest wait-wedge-10ms: SUCCESS (1.352s)
[567.790495] [082/133] (454s left) gem_exec_params (sol-reset-not-gen7)
[567.847391] Starting subtest: sol-reset-not-gen7
[567.850230] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[567.957042] [083/133] (454s left) gem_ctx_shared (exec-single-timeline)
[568.015288] Starting subtest: exec-single-timeline
[568.017675] Starting dynamic subtest: rcs0
[569.066239] Dynamic subtest rcs0: SUCCESS (1.048s)
[569.078764] Starting dynamic subtest: bcs0
[570.154624] Dynamic subtest bcs0: SUCCESS (1.084s)
[570.167519] Starting dynamic subtest: vcs0
[571.245927] Dynamic subtest vcs0: SUCCESS (1.088s)
[571.261363] Starting dynamic subtest: vcs1
[572.331088] Dynamic subtest vcs1: SUCCESS (1.083s)
[572.344385] Starting dynamic subtest: vecs0
[573.418399] Dynamic subtest vecs0: SUCCESS (1.084s)
[573.431367] Starting dynamic subtest: ccs0
[574.506481] Dynamic subtest ccs0: SUCCESS (1.084s)
[574.509233] Subtest exec-single-timeline: SUCCESS (6.489s)
[574.699623] [084/133] (447s left) gem_exec_params (mmapped)
[574.759493] Starting subtest: mmapped
[574.766450] Subtest mmapped: SUCCESS (0.005s)
[574.885943] [085/133] (447s left) syncobj_timeline (host-signal-ordered)
[574.956313] Starting subtest: host-signal-ordered
[574.960951] Subtest host-signal-ordered: SUCCESS (0.000s)
[575.030823] [086/133] (447s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[575.087457] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[575.090292] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[575.193819] [087/133] (447s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[575.287097] Starting subtest: primary-x-tiled-reflect-x-180
[582.302179] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.013s)
[583.466832] [088/133] (439s left) gem_mmap_offset (partial-unmap)
[583.522135] Starting subtest: partial-unmap
[583.524360] Starting dynamic subtest: smem0
[584.013954] Dynamic subtest smem0: SUCCESS (0.493s)
[584.016839] Subtest partial-unmap: SUCCESS (0.494s)
[584.124398] [089/133] (438s left) tools_test (tools_test)
[584.183379] Starting subtest: tools_test
[584.244499] Subtest tools_test: SUCCESS (0.081s)
[584.312046] [090/133] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[584.406715] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[584.411151] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[584.494828] [091/133] (438s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[584.588928] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[584.614874] Starting dynamic subtest: pipe-A-plane-0
[585.037196] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[585.046629] Starting dynamic subtest: pipe-A-plane-3
[585.303123] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[586.447640] Starting dynamic subtest: pipe-B-plane-0
[586.895467] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[586.907649] Starting dynamic subtest: pipe-B-plane-3
[587.150965] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[587.463471] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.875s)
[588.314912] [092/133] (434s left) kms_pm_backlight (basic-brightness)
[588.402899] Starting subtest: basic-brightness
[588.452889] Starting dynamic subtest: eDP-1
[588.771510] Dynamic subtest eDP-1: SUCCESS (0.318s)
[588.776208] Subtest basic-brightness: SUCCESS (0.372s)
[589.657324] [093/133] (433s left) i915_pm_rps (thresholds-idle-park)
[589.715085] Starting subtest: thresholds-idle-park
[589.721146] Subtest thresholds-idle-park: SKIP (0.001s)
[589.814671] [094/133] (433s left) gem_exec_whisper (basic-contexts-all)
[589.875453] Starting subtest: basic-contexts-all
[600.362780] Subtest basic-contexts-all: SUCCESS (10.485s)
[600.558819] [095/133] (422s left) gem_mmap_gtt (basic-copy)
[600.623309] Subtest basic-copy: SKIP (0.000s)
[600.698012] [096/133] (422s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[601.089227] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[601.867936] [097/133] (421s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[601.928252] Starting subtest: legacy-engines-hostile-preempt
[601.931048] Starting dynamic subtest: render
[601.996012] Dynamic subtest render: SUCCESS (0.068s)
[602.009506] Starting dynamic subtest: bsd1
[603.598854] Dynamic subtest bsd1: SUCCESS (1.599s)
[603.613014] Starting dynamic subtest: bsd2
[605.571908] Dynamic subtest bsd2: SUCCESS (1.970s)
[605.584367] Starting dynamic subtest: blt
[605.629288] Dynamic subtest blt: SUCCESS (0.056s)
[605.640374] Starting dynamic subtest: vebox
[607.558916] Dynamic subtest vebox: SUCCESS (1.926s)
[607.561687] Subtest legacy-engines-hostile-preempt: SUCCESS (5.632s)
[607.643758] [098/133] (415s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[607.773296] Starting subtest: cursor-vs-flip-varying-size
[638.846315] Subtest cursor-vs-flip-varying-size: SUCCESS (31.071s)
[639.711719] [099/133] (383s left) gem_render_copy (linear-to-vebox-yf-tiled)
[639.779276] Starting subtest: linear-to-vebox-yf-tiled
[639.785105] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[639.968530] [100/133] (383s left) perf (gen8-unprivileged-single-ctx-counters)
[640.118301] Starting subtest: gen8-unprivileged-single-ctx-counters
[640.122881] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[640.163347] [101/133] (383s left) kms_cursor_crc (cursor-random-max-size)
[640.489448] Starting subtest: cursor-random-max-size
[640.497295] Subtest cursor-random-max-size: SKIP (0.000s)
[640.609813] [102/133] (382s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[640.708342] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[640.710831] Starting dynamic subtest: pipe-A-eDP-1
[640.854006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[640.866160] Starting dynamic subtest: pipe-B-eDP-1
[640.887505] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[640.897402] Starting dynamic subtest: pipe-C-eDP-1
[640.917150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[640.927135] Starting dynamic subtest: pipe-D-eDP-1
[640.946205] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[640.948307] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.147s)
[643.187105] [103/133] (380s left) kms_psr (fbc-psr-no-drrs)
[643.287166] Starting subtest: fbc-psr-no-drrs
[643.289766] Starting dynamic subtest: eDP-1
[643.294861] Dynamic subtest eDP-1: SKIP (0.000s)
[643.299501] Subtest fbc-psr-no-drrs: SKIP (0.002s)
[643.364911] [104/133] (380s left) gem_mmap_wc (bad-size)
[643.430490] Subtest bad-size: SKIP (0.000s)
[643.493082] [105/133] (380s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[643.593303] Starting subtest: fbc-shrfb-scaledprimary
[646.582211] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.992s)
[647.709008] [106/133] (375s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[647.809391] Starting subtest: fbc-farfromfence-mmap-gtt
[647.814327] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[647.906080] [107/133] (375s left) prime_vgem (fence-wait)
[647.983010] Starting subtest: fence-wait
[647.985260] Starting dynamic subtest: rcs0
[649.050712] Dynamic subtest rcs0: SUCCESS (1.067s)
[649.063475] Starting dynamic subtest: bcs0
[650.114859] Dynamic subtest bcs0: SUCCESS (1.063s)
[650.124812] Starting dynamic subtest: vcs0
[651.160664] Dynamic subtest vcs0: SUCCESS (1.044s)
[651.176657] Starting dynamic subtest: vcs1
[652.202089] Dynamic subtest vcs1: SUCCESS (1.040s)
[652.214189] Starting dynamic subtest: vecs0
[653.244202] Dynamic subtest vecs0: SUCCESS (1.040s)
[653.257415] Starting dynamic subtest: ccs0
[654.287360] Dynamic subtest ccs0: SUCCESS (1.041s)
[654.290328] Subtest fence-wait: SUCCESS (6.304s)
[654.399558] [108/133] (369s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[654.502125] Starting subtest: 4-tiled-32bpp-rotate-90
[654.522190] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[654.627820] [109/133] (369s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[654.728036] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[654.732833] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[654.816613] [110/133] (368s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[654.875105] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[654.956880] [111/133] (368s left) kms_fbcon_fbt (psr)
[655.011207] Starting subtest: psr
[662.300814] Subtest psr: SUCCESS (7.283s)
[662.379120] [112/133] (361s left) gem_huc_copy (huc-copy)
[662.444297] Starting subtest: huc-copy
[662.449872] Subtest huc-copy: SUCCESS (0.004s)
[662.594111] [113/133] (361s left) gem_exec_reloc (basic-cpu-gtt)
[662.662278] Subtest basic-cpu-gtt: SKIP (0.000s)
[662.737249] [114/133] (361s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[662.829400] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[662.834359] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[662.904772] [115/133] (361s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[663.001220] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[663.006342] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[663.110507] [116/133] (360s left) kms_flip_event_leak (basic)
[663.217320] Starting subtest: basic
[663.219758] Starting dynamic subtest: pipe-A-eDP-1
[663.635187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[663.646357] Starting dynamic subtest: pipe-B-eDP-1
[664.741211] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s)
[664.751595] Starting dynamic subtest: pipe-C-eDP-1
[665.839246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s)
[665.850184] Starting dynamic subtest: pipe-D-eDP-1
[666.968346] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[666.970786] Subtest basic: SUCCESS (3.750s)
[667.822228] [117/133] (356s left) gem_close_race (multigpu-basic-process)
[667.885486] Starting subtest: multigpu-basic-process
[667.891459] Subtest multigpu-basic-process: SKIP (0.000s)
[668.106350] [118/133] (356s left) perf (i915-ref-count)
[668.180658] Starting subtest: i915-ref-count
[668.231200] Subtest i915-ref-count: SUCCESS (0.048s)
[668.288106] [119/133] (355s left) gem_eio (in-flight-suspend)
[668.527206] Starting subtest: in-flight-suspend
[711.508566] Subtest in-flight-suspend: SUCCESS (14.115s)
[711.625516] [120/133] (312s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[711.758869] Starting subtest: modeset-atomic-cursor-hotspot
[711.763536] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[711.905891] [121/133] (312s left) kms_draw_crc (draw-method-pwrite)
[711.996606] Starting subtest: draw-method-pwrite
[711.998730] Starting dynamic subtest: xrgb8888-untiled
[712.605627] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[712.618611] Starting dynamic subtest: rgb565-untiled
[713.070793] Dynamic subtest rgb565-untiled: SUCCESS (0.453s)
[713.081891] Starting dynamic subtest: xrgb2101010-untiled
[713.632876] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.554s)
[713.643993] Starting dynamic subtest: xbgr16161616f-untiled
[714.398862] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[714.409675] Starting dynamic subtest: xrgb8888-xtiled
[716.242580] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.821s)
[716.252852] Starting dynamic subtest: rgb565-xtiled
[717.319005] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[717.329627] Starting dynamic subtest: xrgb2101010-xtiled
[719.111475] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.777s)
[719.122148] Starting dynamic subtest: xbgr16161616f-xtiled
[722.476388] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.344s)
[722.486872] Starting dynamic subtest: xrgb8888-4tiled
[723.581468] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[723.591842] Starting dynamic subtest: rgb565-4tiled
[724.138783] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[724.151958] Starting dynamic subtest: xrgb2101010-4tiled
[725.231850] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.088s)
[725.242857] Starting dynamic subtest: xbgr16161616f-4tiled
[728.263497] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.022s)
[728.266141] Subtest draw-method-pwrite: SUCCESS (16.145s)
[728.360384] [122/133] (295s left) kms_busy (extended-pageflip-hang-oldfb)
[728.463251] Starting subtest: extended-pageflip-hang-oldfb
[728.465713] Starting dynamic subtest: pipe-A
[728.881751] Dynamic subtest pipe-A: SUCCESS (0.416s)
[728.894109] Starting dynamic subtest: pipe-D
[730.010997] Dynamic subtest pipe-D: SUCCESS (1.124s)
[730.013720] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.545s)
[730.855399] [123/133] (293s left) gem_exec_schedule (preempt-queue-contexts)
[730.939398] Subtest preempt-queue-contexts: SKIP (0.000s)
[731.228836] [124/133] (293s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[731.315756] Starting subtest: psr-1p-primscrn-spr-indfb-move
[738.954764] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.633s)
[739.090164] [125/133] (285s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[739.185150] Starting subtest: plane-upscale-20x20-with-pixel-format
[739.187739] Starting dynamic subtest: pipe-A
[740.233458] Dynamic subtest pipe-A: SUCCESS (1.050s)
[740.243140] Starting dynamic subtest: pipe-B
[742.386475] Dynamic subtest pipe-B: SUCCESS (2.150s)
[742.396622] Starting dynamic subtest: pipe-C
[743.581366] Dynamic subtest pipe-C: SUCCESS (1.194s)
[743.591315] Starting dynamic subtest: pipe-D
[744.815414] Dynamic subtest pipe-D: SUCCESS (1.233s)
[744.818190] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.630s)
[746.020983] [126/133] (278s left) gem_exec_schedule (promotion)
[746.098888] Starting subtest: promotion
[746.101731] Starting dynamic subtest: rcs0
[746.206856] Dynamic subtest rcs0: SUCCESS (0.118s)
[746.219445] Starting dynamic subtest: vcs0
[746.299832] Dynamic subtest vcs0: SUCCESS (0.092s)
[746.312461] Starting dynamic subtest: vcs1
[746.392493] Dynamic subtest vcs1: SUCCESS (0.091s)
[746.405123] Starting dynamic subtest: vecs0
[746.479574] Dynamic subtest vecs0: SUCCESS (0.086s)
[746.492833] Starting dynamic subtest: ccs0
[746.579419] Dynamic subtest ccs0: SUCCESS (0.099s)
[746.582281] Subtest promotion: SUCCESS (0.492s)
[747.561941] [127/133] (277s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[747.659294] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[747.663605] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[747.758343] [128/133] (276s left) kms_lease (empty-lease)
[747.852989] Starting subtest: empty-lease
[747.855462] Starting dynamic subtest: pipe-A-eDP-1
[747.857648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[747.868210] Starting dynamic subtest: pipe-B-eDP-1
[747.870680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[747.880839] Starting dynamic subtest: pipe-C-eDP-1
[747.883442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[747.893097] Starting dynamic subtest: pipe-D-eDP-1
[747.895513] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[747.897834] Subtest empty-lease: SUCCESS (0.009s)
[747.961331] [129/133] (276s left) i915_drm_fdinfo (memory-info-purgeable)
[748.009941] Starting subtest: memory-info-purgeable
[748.012632] Starting dynamic subtest: smem0
[750.621487] Dynamic subtest smem0: SUCCESS (2.614s)
[750.624204] Subtest memory-info-purgeable: SUCCESS (2.615s)
[750.705636] [130/133] (273s left) i915_query (query-topology-known-pci-ids)
[750.753712] Starting subtest: query-topology-known-pci-ids
[750.758528] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[750.856128] [131/133] (273s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[750.953863] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[750.957975] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[751.064231] [132/133] (273s left) template (b)
[751.131431] Starting subtest: B
[751.134130] Subtest B: SUCCESS (0.000s)
[751.221835] [133/133] (273s left) kms_flip (2x-plain-flip-fb-recreate)
[751.312039] Starting subtest: 2x-plain-flip-fb-recreate
[751.323408] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[751.401072] 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.