[63.508439] Initializing watchdogs
[63.508507]   /dev/watchdog0
[63.523089] [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]
[63.527849] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.530084] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.533661] [001/133] (960s left) gem_mmap_gtt (cpuset-basic-small-copy)
[63.613366] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[63.672371] [002/133] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[63.718422] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[63.773599] [003/133] (960s left) gem_exec_await (wide-all)
[63.992546] Starting subtest: wide-all
[87.819564] Subtest wide-all: SUCCESS (23.824s)
[88.001820] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[88.005940] [004/133] (936s left) kms_pm_dc (dc3co-vpb-simulation)
[89.149635] Starting subtest: dc3co-vpb-simulation
[98.433999] Subtest dc3co-vpb-simulation: SKIP (9.278s)
[98.562919] [005/133] (925s left) gem_userptr_blits (map-fixed-invalidate)
[98.639076] Starting subtest: map-fixed-invalidate
[98.643425] Subtest map-fixed-invalidate: SKIP (0.000s)
[98.762411] [006/133] (925s left) kms_flip (2x-flip-vs-suspend)
[98.860899] Starting subtest: 2x-flip-vs-suspend
[98.871282] Subtest 2x-flip-vs-suspend: SKIP (0.012s)
[98.948387] [007/133] (925s left) gem_ppgtt (blt-vs-render-ctx0)
[99.002167] Starting subtest: blt-vs-render-ctx0
[131.716404] Subtest blt-vs-render-ctx0: SUCCESS (32.712s)
[131.864710] [008/133] (892s left) i915_drm_fdinfo (busy-check-all)
[131.943061] Starting subtest: busy-check-all
[131.945406] Starting dynamic subtest: rcs0
[131.952551] Dynamic subtest rcs0: SKIP (0.007s)
[131.962078] Starting dynamic subtest: bcs0
[131.966301] Dynamic subtest bcs0: SKIP (0.000s)
[131.974076] Starting dynamic subtest: vcs0
[131.978391] Dynamic subtest vcs0: SKIP (0.000s)
[131.985534] Starting dynamic subtest: vcs1
[131.989578] Dynamic subtest vcs1: SKIP (0.000s)
[131.996687] Starting dynamic subtest: vecs0
[132.000774] Dynamic subtest vecs0: SKIP (0.000s)
[132.010438] Starting dynamic subtest: ccs0
[132.014660] Dynamic subtest ccs0: SKIP (0.000s)
[132.018807] Subtest busy-check-all: SKIP (0.010s)
[132.053523] [009/133] (892s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[132.187911] Starting subtest: basic-flip-before-cursor-atomic
[133.176099] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.988s)
[134.041425] [010/133] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[134.151120] Starting subtest: basic-busy-flip-before-cursor-atomic
[134.155714] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[134.296384] [011/133] (890s left) kms_psr (fbc-psr2-no-drrs)
[134.389854] Starting subtest: fbc-psr2-no-drrs
[134.392295] Starting dynamic subtest: eDP-1
[134.396721] Dynamic subtest eDP-1: SKIP (0.000s)
[134.401253] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[134.463996] [012/133] (890s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[134.558041] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[134.562485] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[134.642097] [013/133] (889s left) gem_eio (in-flight-internal-10ms)
[134.883576] Starting subtest: in-flight-internal-10ms
[135.970044] Subtest in-flight-internal-10ms: SUCCESS (1.086s)
[136.091640] [014/133] (888s left) kms_psr (pr-cursor-mmap-cpu)
[136.199453] Starting subtest: pr-cursor-mmap-cpu
[136.203786] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[136.284004] [015/133] (888s left) kms_plane (plane-position-hole)
[136.391776] Starting subtest: plane-position-hole
[136.913848] Starting dynamic subtest: pipe-A-plane-1
[138.244494] Dynamic subtest pipe-A-plane-1: SUCCESS (1.329s)
[138.254934] Starting dynamic subtest: pipe-A-plane-2
[139.538471] Dynamic subtest pipe-A-plane-2: SUCCESS (1.294s)
[139.547495] Starting dynamic subtest: pipe-A-plane-3
[140.795331] Dynamic subtest pipe-A-plane-3: SUCCESS (1.255s)
[140.803759] Starting dynamic subtest: pipe-A-plane-4
[142.126076] Dynamic subtest pipe-A-plane-4: SUCCESS (1.331s)
[142.135542] Starting dynamic subtest: pipe-A-plane-5
[142.151248] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[143.380233] Starting dynamic subtest: pipe-B-plane-1
[144.697462] Dynamic subtest pipe-B-plane-1: SUCCESS (1.325s)
[144.708046] Starting dynamic subtest: pipe-B-plane-2
[146.023510] Dynamic subtest pipe-B-plane-2: SUCCESS (1.325s)
[146.032940] Starting dynamic subtest: pipe-B-plane-3
[147.376070] Dynamic subtest pipe-B-plane-3: SUCCESS (1.353s)
[147.386074] Starting dynamic subtest: pipe-B-plane-4
[148.696947] Dynamic subtest pipe-B-plane-4: SUCCESS (1.319s)
[148.706907] Starting dynamic subtest: pipe-B-plane-5
[148.724265] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[148.726814] Subtest plane-position-hole: SUCCESS (12.331s)
[149.568128] [016/133] (875s left) gem_spin_batch (resubmit-new-all)
[149.626281] Starting subtest: resubmit-new-all
[149.628570] Starting dynamic subtest: rcs0
[149.642732] Dynamic subtest rcs0: SUCCESS (0.016s)
[149.652978] Starting dynamic subtest: bcs0
[149.655387] Dynamic subtest bcs0: SUCCESS (0.010s)
[149.663290] Starting dynamic subtest: vcs0
[149.665073] Dynamic subtest vcs0: SUCCESS (0.009s)
[149.672948] Starting dynamic subtest: vcs1
[149.675111] Dynamic subtest vcs1: SUCCESS (0.009s)
[149.684437] Starting dynamic subtest: vecs0
[149.686268] Dynamic subtest vecs0: SUCCESS (0.009s)
[149.695420] Starting dynamic subtest: ccs0
[149.697587] Dynamic subtest ccs0: SUCCESS (0.011s)
[149.699776] Subtest resubmit-new-all: SUCCESS (0.066s)
[150.973629] [017/133] (873s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[151.084459] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[151.088760] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[151.177874] [018/133] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[151.276828] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[158.783197] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.509s)
[158.893392] [019/133] (865s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[158.990898] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[165.929727] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.942s)
[166.096967] [020/133] (858s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[166.195110] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[166.197456] Starting dynamic subtest: A-eDP1
[169.844096] Dynamic subtest A-eDP1: SUCCESS (3.647s)
[169.853428] Starting dynamic subtest: B-eDP1
[173.060102] Dynamic subtest B-eDP1: SUCCESS (3.215s)
[173.069692] Starting dynamic subtest: C-eDP1
[176.148495] Dynamic subtest C-eDP1: SUCCESS (3.087s)
[176.158571] Starting dynamic subtest: D-eDP1
[179.291480] Dynamic subtest D-eDP1: SUCCESS (3.141s)
[179.293857] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.096s)
[180.100304] [021/133] (844s left) gem_exec_reloc (basic-gtt-cpu)
[180.161928] Subtest basic-gtt-cpu: SKIP (0.000s)
[180.234536] [022/133] (844s left) kms_vblank (wait-busy-hang)
[180.332708] Starting subtest: wait-busy-hang
[180.334980] Starting dynamic subtest: pipe-A-eDP-1
[206.677904] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.343s)
[206.691498] Starting dynamic subtest: pipe-D-eDP-1
[232.656263] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.976s)
[232.658604] Subtest wait-busy-hang: SUCCESS (52.323s)
[233.469440] [023/133] (791s left) gem_userptr_blits (mmap-offset-banned)
[233.540360] Starting subtest: mmap-offset-banned
[233.542860] Starting dynamic subtest: wb
[233.545295] Dynamic subtest wb: SUCCESS (0.000s)
[233.555921] Starting dynamic subtest: wc
[233.557904] Dynamic subtest wc: SUCCESS (0.000s)
[233.565458] Starting dynamic subtest: uc
[233.567421] Dynamic subtest uc: SUCCESS (0.000s)
[233.569386] Subtest mmap-offset-banned: SUCCESS (0.006s)
[233.664981] [024/133] (791s left) i915_query (query-garbage)
[233.716208] Starting subtest: query-garbage
[233.718454] Subtest query-garbage: SUCCESS (0.000s)
[233.820753] [025/133] (791s left) kms_content_protection (atomic)
[233.959031] Starting subtest: atomic
[233.963516] Subtest atomic: SKIP (0.000s)
[234.070862] [026/133] (790s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[234.167421] Starting subtest: psr-rgb565-draw-mmap-gtt
[234.171607] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[234.254811] [027/133] (790s left) syncobj_timeline (wait-any-complex)
[234.322090] Starting subtest: wait-any-complex
[234.383040] Subtest wait-any-complex: SUCCESS (0.063s)
[234.458493] [028/133] (790s left) syncobj_timeline (device-signal-unordered)
[234.501627] Starting subtest: device-signal-unordered
[234.503742] Subtest device-signal-unordered: SUCCESS (0.000s)
[234.603245] [029/133] (790s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[234.666287] Starting subtest: rel-constants-invalid-rel-gen5
[234.668392] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s)
[234.764994] [030/133] (790s left) gem_exec_schedule (wide)
[234.936835] Starting subtest: wide
[234.939279] Starting dynamic subtest: rcs0
[245.694480] Dynamic subtest rcs0: SUCCESS (10.756s)
[245.708178] Starting dynamic subtest: vcs0
[255.464730] Dynamic subtest vcs0: SUCCESS (9.769s)
[255.477359] Starting dynamic subtest: vcs1
[268.575985] Dynamic subtest vcs1: SUCCESS (13.110s)
[268.587539] Starting dynamic subtest: vecs0
[279.779697] Dynamic subtest vecs0: SUCCESS (11.201s)
[279.790685] Starting dynamic subtest: ccs0
[292.678680] Dynamic subtest ccs0: SUCCESS (12.898s)
[292.681314] Subtest wide: SUCCESS (57.740s)
[295.120438] [031/133] (730s left) gem_pxp (reject-modify-context-protection-off-1)
[295.241303] Starting subtest: reject-modify-context-protection-off-1
[295.243851] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[295.347366] [032/133] (729s left) gem_create (create-ext-set-pat)
[295.513053] Starting subtest: create-ext-set-pat
[295.515853] Subtest create-ext-set-pat: SUCCESS (0.001s)
[295.625955] [033/133] (729s left) kms_cursor_crc (cursor-onscreen-max-size)
[295.964886] Starting subtest: cursor-onscreen-max-size
[295.971188] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[296.091220] [034/133] (729s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[296.337063] Starting subtest: cursor-rapid-movement-128x42
[296.387157] Subtest cursor-rapid-movement-128x42: SKIP (0.046s)
[296.611717] [035/133] (728s left) kms_plane_multiple (2x-tiling-4)
[296.709489] Starting subtest: 2x-tiling-4
[296.712977] Subtest 2x-tiling-4: SKIP (0.000s)
[296.778790] [036/133] (728s left) sw_sync (alloc_fence)
[296.811637] Starting subtest: alloc_fence
[296.813348] Subtest alloc_fence: SUCCESS (0.000s)
[296.870567] [037/133] (728s left) kms_vrr (seamless-rr-switch-drrs)
[296.970309] Starting subtest: seamless-rr-switch-drrs
[296.975611] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[297.048757] [038/133] (728s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[299.093068] Starting subtest: gem-execbuf-stress-pc8
[299.143332] Subtest gem-execbuf-stress-pc8: SKIP (0.046s)
[299.471734] [039/133] (726s left) sw_sync (sync_busy_fork)
[299.513774] Starting subtest: sync_busy_fork
[300.524158] Subtest sync_busy_fork: SUCCESS (1.012s)
[300.588372] [040/133] (725s left) gem_ccs (block-copy-uncompressed)
[300.649627] Starting subtest: block-copy-uncompressed
[300.651892] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[300.674472] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.024s)
[300.684699] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[300.691790] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[300.699792] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[300.710230] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[300.718429] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[300.727073] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[300.729448] Subtest block-copy-uncompressed: SUCCESS (0.078s)
[300.811252] [041/133] (724s left) kms_addfb_basic (tile-pitch-mismatch)
[300.868890] Starting subtest: tile-pitch-mismatch
[300.873211] Subtest tile-pitch-mismatch: SKIP (0.000s)
[301.011825] [042/133] (724s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[301.100522] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[301.102782] Starting dynamic subtest: pipe-A-eDP-1
[301.125114] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[301.134145] Starting dynamic subtest: pipe-B-eDP-1
[301.154200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[301.163287] Starting dynamic subtest: pipe-C-eDP-1
[301.183779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[301.191538] Starting dynamic subtest: pipe-D-eDP-1
[301.212191] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[301.216395] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[303.336866] [043/133] (722s left) kms_addfb_basic (basic-x-tiled-legacy)
[303.392341] Starting subtest: basic-x-tiled-legacy
[303.396577] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[303.520105] [044/133] (722s left) prime_busy (before-wait)
[303.573093] Starting subtest: before-wait
[303.577675] Starting dynamic subtest: rcs0
[303.620007] Dynamic subtest rcs0: SUCCESS (0.043s)
[303.634302] Starting dynamic subtest: bcs0
[303.678237] Dynamic subtest bcs0: SUCCESS (0.057s)
[303.687868] Starting dynamic subtest: vcs0
[303.718283] Dynamic subtest vcs0: SUCCESS (0.039s)
[303.727271] Starting dynamic subtest: vcs1
[303.759258] Dynamic subtest vcs1: SUCCESS (0.041s)
[303.767988] Starting dynamic subtest: vecs0
[303.800056] Dynamic subtest vecs0: SUCCESS (0.040s)
[303.808487] Starting dynamic subtest: ccs0
[303.841167] Dynamic subtest ccs0: SUCCESS (0.041s)
[303.949150] Subtest before-wait: SUCCESS (0.374s)
[304.035853] [045/133] (721s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[304.137507] Starting subtest: plane-lut1d-pre-ctm3x4
[304.283257] Starting dynamic subtest: pipe-A-plane-0
[304.644409] Dynamic subtest pipe-A-plane-0: FAIL (0.180s)
[304.654403] Starting dynamic subtest: pipe-A-plane-1
[304.869168] Dynamic subtest pipe-A-plane-1: FAIL (0.171s)
[304.877600] Starting dynamic subtest: pipe-A-plane-2
[305.102137] Dynamic subtest pipe-A-plane-2: FAIL (0.178s)
[306.030625] Starting dynamic subtest: pipe-B-plane-0
[306.487598] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[306.496676] Starting dynamic subtest: pipe-B-plane-1
[306.811591] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[306.821285] Starting dynamic subtest: pipe-B-plane-2
[307.115491] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[307.791187] Starting dynamic subtest: pipe-C-plane-0
[308.290702] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[308.302299] Starting dynamic subtest: pipe-C-plane-1
[308.703283] Dynamic subtest pipe-C-plane-1: FAIL (0.621s)
[308.712409] Starting dynamic subtest: pipe-C-plane-2
[309.078209] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[309.894399] Starting dynamic subtest: pipe-D-plane-0
[310.511320] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[310.522522] Starting dynamic subtest: pipe-D-plane-1
[310.981104] Dynamic subtest pipe-D-plane-1: FAIL (0.623s)
[310.990776] Starting dynamic subtest: pipe-D-plane-2
[311.422434] Dynamic subtest pipe-D-plane-2: FAIL (0.537s)
[311.499252] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.362s)
[312.365369] [046/133] (713s left) kms_async_flips (crc-atomic)
[312.470120] Starting subtest: crc-atomic
[312.850949] Starting dynamic subtest: pipe-A-eDP-1
[315.794454] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.941s)
[316.170992] Starting dynamic subtest: pipe-B-eDP-1
[319.089808] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.927s)
[319.474307] Starting dynamic subtest: pipe-C-eDP-1
[322.325799] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.859s)
[322.689601] Starting dynamic subtest: pipe-D-eDP-1
[325.552956] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[325.555147] Subtest crc-atomic: SUCCESS (13.084s)
[326.719365] [047/133] (699s left) gem_exec_balancer (bonded-true-hang)
[326.994261] Starting subtest: bonded-true-hang
[326.999083] Subtest bonded-true-hang: SKIP (0.000s)
[327.115319] [048/133] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[327.215227] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[327.219120] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[327.311225] [049/133] (698s left) gem_mmap_offset (bad-flags)
[327.374223] Starting subtest: bad-flags
[327.376065] Subtest bad-flags: SUCCESS (0.000s)
[327.481787] [050/133] (698s left) gem_tiled_wb
[327.600275] [051/133] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[327.694034] Starting subtest: psr-1p-primscrn-cur-indfb-move
[335.075077] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.386s)
[335.174822] [052/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[335.268349] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[343.881017] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.615s)
[344.029919] [053/133] (682s left) gem_exec_params (larger-than-life-batch)
[344.088704] Starting subtest: larger-than-life-batch
[346.211372] Subtest larger-than-life-batch: SUCCESS (2.121s)
[346.950913] [054/133] (679s left) gem_exec_balancer (parallel-out-fence)
[347.241644] Starting subtest: parallel-out-fence
[348.482634] Subtest parallel-out-fence: SUCCESS (1.241s)
[348.597230] [055/133] (677s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[348.699346] Starting subtest: fbcpsr-indfb-scaledprimary
[354.570932] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.874s)
[354.733050] [056/133] (671s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[354.832306] Starting subtest: primary-4-tiled-reflect-x-180
[361.953834] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.123s)
[363.161376] [057/133] (663s left) gem_exec_schedule (preempt-contexts)
[363.263177] Starting subtest: preempt-contexts
[363.265561] Starting dynamic subtest: rcs0
[363.329995] Dynamic subtest rcs0: SUCCESS (0.068s)
[363.339413] Starting dynamic subtest: bcs0
[363.384819] Dynamic subtest bcs0: SUCCESS (0.054s)
[363.398198] Starting dynamic subtest: vcs0
[363.439591] Dynamic subtest vcs0: SUCCESS (0.054s)
[363.448301] Starting dynamic subtest: vcs1
[363.490416] Dynamic subtest vcs1: SUCCESS (0.050s)
[363.499458] Starting dynamic subtest: vecs0
[363.541355] Dynamic subtest vecs0: SUCCESS (0.049s)
[363.550275] Starting dynamic subtest: ccs0
[363.595070] Dynamic subtest ccs0: SUCCESS (0.053s)
[363.597242] Subtest preempt-contexts: SUCCESS (0.334s)
[364.992357] [058/133] (661s left) kms_big_fb (linear-addfb)
[365.103769] Starting subtest: linear-addfb
[365.106080] Subtest linear-addfb: SUCCESS (0.000s)
[365.195850] [059/133] (661s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[365.296938] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[371.875184] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.582s)
[372.014057] [060/133] (654s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[372.113731] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[372.115938] Starting dynamic subtest: pipe-A-eDP-1
[372.136182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[372.146908] Starting dynamic subtest: pipe-B-eDP-1
[372.167176] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[372.175312] Starting dynamic subtest: pipe-C-eDP-1
[372.194350] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.202404] Starting dynamic subtest: pipe-D-eDP-1
[372.221656] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.223538] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[374.366724] [061/133] (652s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[374.465684] Starting subtest: y-tiled-64bpp-rotate-90
[374.469837] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[374.573049] [062/133] (652s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[374.687366] Starting subtest: x-tiled-32bpp-rotate-90
[374.707430] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[374.808916] [063/133] (651s left) vgem_basic (bad-flag)
[374.854729] Starting subtest: bad-flag
[374.856649] Subtest bad-flag: SUCCESS (0.000s)
[374.909173] [064/133] (651s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[375.000617] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[375.002734] Starting dynamic subtest: pipe-A-default-mode
[376.129439] Dynamic subtest pipe-A-default-mode: SKIP (1.127s)
[376.133869] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.128s)
[376.264972] [065/133] (650s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[376.355797] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[376.360071] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[376.455934] [066/133] (650s left) syncobj_timeline (invalid-query-illegal-handle)
[376.515495] Starting subtest: invalid-query-illegal-handle
[376.517727] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[376.619537] [067/133] (650s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[376.670755] Starting subtest: multi-wait-available-unsubmitted-signaled
[376.672919] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[376.765373] [068/133] (650s left) kms_selftest (drm_damage_helper)
[376.812532] Starting subtest: drm_damage_helper
[376.862430] Starting dynamic subtest: drm_test_damage_iter_no_damage
[376.951061] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.087s)
[376.960577] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[377.035659] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.083s)
[377.044054] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[377.118627] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.083s)
[377.126816] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[377.215322] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.096s)
[377.224767] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[377.329165] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.113s)
[377.339068] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[377.426832] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.097s)
[377.436968] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[377.540152] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.111s)
[377.550251] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[377.634043] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.094s)
[377.644163] Starting dynamic subtest: drm_test_damage_iter_single_damage
[377.736077] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.101s)
[377.744663] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[377.820437] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.085s)
[377.828514] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[377.916798] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.094s)
[377.925126] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[378.001184] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.082s)
[378.010685] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[378.105975] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.104s)
[378.115093] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[378.209172] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.102s)
[378.218806] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[378.306519] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.097s)
[378.314837] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[378.404380] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.097s)
[378.414312] Starting dynamic subtest: drm_test_damage_iter_damage
[378.491781] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.087s)
[378.500340] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[378.595589] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.101s)
[378.604745] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[378.697537] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.101s)
[378.706529] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[378.788599] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.091s)
[378.796683] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[378.886541] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.097s)
[378.888341] Subtest drm_damage_helper: SUCCESS (2.074s)
[379.032646] [069/133] (647s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[379.098521] Starting subtest: invalid-multi-wait-all-unsubmitted
[379.100506] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[379.210982] [070/133] (647s left) gem_ringfill (engines-basic)
[384.921132] Starting subtest: engines-basic
[384.923591] Starting dynamic subtest: rcs0
[384.990068] Dynamic subtest rcs0: SUCCESS (0.068s)
[385.001823] Starting dynamic subtest: bcs0
[385.036528] Dynamic subtest bcs0: SUCCESS (0.044s)
[385.047305] Starting dynamic subtest: vcs0
[385.079231] Dynamic subtest vcs0: SUCCESS (0.041s)
[385.088837] Starting dynamic subtest: vcs1
[385.125415] Dynamic subtest vcs1: SUCCESS (0.043s)
[385.136736] Starting dynamic subtest: vecs0
[385.166923] Dynamic subtest vecs0: SUCCESS (0.040s)
[385.177683] Starting dynamic subtest: ccs0
[385.211882] Dynamic subtest ccs0: SUCCESS (0.043s)
[385.214415] Subtest engines-basic: SUCCESS (0.293s)
[385.290137] [071/133] (641s left) kms_prop_blob (invalid-set-prop-any)
[385.349083] Starting subtest: invalid-set-prop-any
[385.351273] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[385.448423] [072/133] (641s left) kms_chamelium_edid (hdmi-mode-timings)
[385.834582] Subtest hdmi-mode-timings: SKIP (0.000s)
[386.605859] [073/133] (640s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[386.713304] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[387.791674] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.079s)
[387.917169] [074/133] (639s left) kms_atomic_interruptible (universal-setplane-cursor)
[388.008488] Starting subtest: universal-setplane-cursor
[388.010429] Starting dynamic subtest: pipe-A-eDP-1
[395.443986] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.435s)
[395.446523] Subtest universal-setplane-cursor: SUCCESS (7.436s)
[396.294940] [075/133] (630s left) vgem_basic (mmap)
[396.330340] Starting subtest: mmap
[396.336345] Subtest mmap: SUCCESS (0.009s)
[396.388243] [076/133] (630s left) prime_self_import (export-vs-gem_close-race)
[396.423581] Starting subtest: export-vs-gem_close-race
[401.530291] Subtest export-vs-gem_close-race: SUCCESS (5.108s)
[401.606301] [077/133] (625s left) kms_psr (fbc-psr-sprite-plane-move)
[401.723715] Starting subtest: fbc-psr-sprite-plane-move
[401.726056] Starting dynamic subtest: eDP-1
[401.730238] Dynamic subtest eDP-1: SKIP (0.000s)
[401.734385] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[401.799013] [078/133] (625s left) prime_vgem (basic-gtt)
[401.889311] Starting subtest: basic-gtt
[401.893685] Subtest basic-gtt: SKIP (0.000s)
[402.022473] [079/133] (625s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[402.141537] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[402.143806] Starting dynamic subtest: pipe-A
[402.172156] Dynamic subtest pipe-A: SKIP (0.028s)
[402.187059] Starting dynamic subtest: pipe-B
[402.211169] Dynamic subtest pipe-B: SKIP (0.035s)
[402.225946] Starting dynamic subtest: pipe-C
[402.243804] Dynamic subtest pipe-C: SKIP (0.032s)
[402.252953] Starting dynamic subtest: pipe-D
[402.276275] Dynamic subtest pipe-D: SKIP (0.033s)
[402.279917] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.133s)
[402.389493] [080/133] (624s left) kms_dsc (dsc-with-formats)
[402.503519] Starting subtest: dsc-with-formats
[402.537532] Subtest dsc-with-formats: SKIP (0.002s)
[402.582229] [081/133] (624s left) gem_pxp (create-valid-protected-context)
[402.676922] Starting subtest: create-valid-protected-context
[402.678965] Subtest create-valid-protected-context: SUCCESS (0.001s)
[402.781140] [082/133] (624s left) gem_eio (in-flight-10ms)
[403.027797] Starting subtest: in-flight-10ms
[412.005061] Subtest in-flight-10ms: SUCCESS (8.976s)
[412.124319] [083/133] (615s left) syncobj_wait (wait-any-snapshot)
[412.188290] Starting subtest: wait-any-snapshot
[412.268848] Subtest wait-any-snapshot: SUCCESS (0.081s)
[412.346320] [084/133] (615s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[412.451408] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[412.455812] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[412.553677] [085/133] (614s left) kms_joiner (basic-ultra-joiner)
[412.643110] Starting subtest: basic-ultra-joiner
[412.647326] Subtest basic-ultra-joiner: SKIP (0.000s)
[412.709927] [086/133] (614s left) kms_cursor_crc (cursor-suspend)
[412.844161] Starting subtest: cursor-suspend
[412.846105] Starting dynamic subtest: pipe-A-eDP-1
[446.250473] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.357s)
[446.266592] Starting dynamic subtest: pipe-D-eDP-1
[480.175044] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.699s)
[480.176930] Subtest cursor-suspend: SUCCESS (7.061s)
[481.009077] [087/133] (546s left) gem_lmem_swapping (massive-random)
[481.067873] Subtest massive-random: SKIP (0.000s)
[481.112761] [088/133] (546s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[481.214419] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[481.217291] Starting dynamic subtest: pipe-A-eDP-1
[481.358842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[481.369680] Starting dynamic subtest: pipe-B-eDP-1
[481.393271] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[481.403217] Starting dynamic subtest: pipe-C-eDP-1
[481.426318] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[481.436234] Starting dynamic subtest: pipe-D-eDP-1
[481.460057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[481.462410] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[483.679637] [089/133] (544s left) dmabuf_sync_file (import-multiple-read-write)
[483.742930] Starting subtest: import-multiple-read-write
[483.749373] Subtest import-multiple-read-write: SUCCESS (0.005s)
[483.803253] [090/133] (543s left) kms_properties (get_properties-sanity-non-atomic)
[483.897705] Starting subtest: get_properties-sanity-non-atomic
[483.900056] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[483.972916] [091/133] (543s left) perf (invalid-oa-format-id)
[484.125631] Starting subtest: invalid-oa-format-id
[484.134632] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[484.185777] [092/133] (543s left) kms_rotation_crc (sprite-rotation-180)
[484.275174] Starting subtest: sprite-rotation-180
[491.349852] Subtest sprite-rotation-180: SUCCESS (7.069s)
[492.539422] [093/133] (535s left) kms_cdclk (mode-transition)
[492.637123] Starting subtest: mode-transition
[492.639849] Starting dynamic subtest: pipe-A-eDP-1
[492.932925] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[492.946373] Starting dynamic subtest: pipe-B-eDP-1
[492.952225] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[492.962977] Starting dynamic subtest: pipe-C-eDP-1
[492.968239] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[492.977791] Starting dynamic subtest: pipe-D-eDP-1
[492.983136] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[492.988387] Subtest mode-transition: SKIP (0.296s)
[493.768998] [094/133] (534s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[493.870018] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[493.875028] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[493.967547] [095/133] (534s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[494.051281] Starting subtest: primary-yf-tiled-reflect-x-0
[494.111251] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[494.213927] [096/133] (533s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[494.313249] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[494.318821] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[494.412707] [097/133] (533s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[494.520307] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[499.060106] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.545s)
[500.194419] [098/133] (527s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[500.293295] Starting subtest: fbc-1p-pri-indfb-multidraw
[513.422060] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.130s)
[514.796038] [099/133] (513s left) gen9_exec_parse (bb-secure)
[514.859141] Subtest bb-secure: SKIP (0.000s)
[514.915773] [100/133] (513s left) gem_userptr_blits (invalid-null-pointer)
[514.980890] Starting subtest: invalid-null-pointer
[514.983180] Subtest invalid-null-pointer: SUCCESS (0.001s)
[515.119545] [101/133] (513s left) gem_userptr_blits (forbidden-operations)
[515.200068] Starting subtest: forbidden-operations
[515.204967] Subtest forbidden-operations: SKIP (0.000s)
[515.327303] [102/133] (512s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[515.418123] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[515.420799] Starting dynamic subtest: pipe-A-eDP-1
[515.511800] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[515.523178] Starting dynamic subtest: pipe-B-eDP-1
[516.660734] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[516.666071] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.247s)
[517.845636] [103/133] (510s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[518.236119] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[519.049075] [104/133] (509s left) gem_partial_pwrite_pread (reads)
[519.110828] Subtest reads: SKIP (0.000s)
[519.168922] [105/133] (509s left) kms_flip (2x-flip-vs-fences)
[519.262039] Starting subtest: 2x-flip-vs-fences
[519.266741] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[519.382432] [106/133] (509s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[519.503181] Starting subtest: cursorA-vs-flipA-atomic
[530.628419] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.124s)
[531.507168] [107/133] (496s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[531.615164] Starting subtest: plane-all-modeset-transition-internal-panels
[531.617716] Starting dynamic subtest: pipe-A-eDP-1
[532.949797] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.334s)
[533.228167] Starting dynamic subtest: pipe-B-eDP-1
[534.272007] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[534.536537] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.922s)
[535.392153] [108/133] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[535.498134] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[535.503166] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[535.596378] [109/133] (492s left) api_intel_allocator (open-vm)
[535.659801] Starting subtest: open-vm
[535.662297] Subtest open-vm: SUCCESS (0.004s)
[535.776159] [110/133] (492s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[536.322993] Starting subtest: syncobj-timeline-invalid-flags
[536.325556] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[538.235174] [111/133] (490s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[538.331135] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[538.333764] Starting dynamic subtest: pipe-A-eDP-1
[538.343023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[538.353822] Starting dynamic subtest: pipe-B-eDP-1
[538.362721] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[538.372392] Starting dynamic subtest: pipe-C-eDP-1
[538.382045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[538.391381] Starting dynamic subtest: pipe-D-eDP-1
[538.401176] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[538.405888] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[540.570108] [112/133] (488s left) syncobj_timeline (etime-multi-wait-submitted)
[540.631804] Starting subtest: etime-multi-wait-submitted
[540.733574] Subtest etime-multi-wait-submitted: SUCCESS (0.101s)
[540.812746] [113/133] (487s left) kms_lease (atomic-implicit-crtc)
[540.903641] Starting subtest: atomic-implicit-crtc
[540.906107] Starting dynamic subtest: pipe-A-eDP-1
[540.918264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[540.931589] Starting dynamic subtest: pipe-B-eDP-1
[540.943604] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[540.952542] Starting dynamic subtest: pipe-C-eDP-1
[540.963593] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[540.973240] Starting dynamic subtest: pipe-D-eDP-1
[540.984190] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[540.986091] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[541.028728] [114/133] (487s left) kms_psr (psr-cursor-mmap-gtt)
[541.113988] Starting subtest: psr-cursor-mmap-gtt
[541.116373] Starting dynamic subtest: eDP-1
[542.874016] Dynamic subtest eDP-1: SUCCESS (1.759s)
[542.876328] Subtest psr-cursor-mmap-gtt: SUCCESS (1.760s)
[543.732424] [115/133] (485s left) kms_addfb_basic (bad-pitch-128)
[543.791853] Starting subtest: bad-pitch-128
[543.794231] Subtest bad-pitch-128: SUCCESS (0.000s)
[543.918829] [116/133] (484s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[544.017965] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[544.029955] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[544.106449] [117/133] (484s left) perf_pmu (most-busy-idle-check-all)
[544.156153] Starting subtest: most-busy-idle-check-all
[544.158687] Starting dynamic subtest: rcs0
[546.170598] Dynamic subtest rcs0: SUCCESS (2.015s)
[546.184358] Starting dynamic subtest: bcs0
[548.154087] Dynamic subtest bcs0: SUCCESS (1.979s)
[548.167502] Starting dynamic subtest: vcs0
[550.138616] Dynamic subtest vcs0: SUCCESS (1.981s)
[550.152280] Starting dynamic subtest: vcs1
[552.187186] Dynamic subtest vcs1: SUCCESS (2.045s)
[552.200007] Starting dynamic subtest: vecs0
[554.170771] Dynamic subtest vecs0: SUCCESS (1.980s)
[554.185409] Starting dynamic subtest: ccs0
[556.154999] Dynamic subtest ccs0: SUCCESS (1.981s)
[556.157781] Subtest most-busy-idle-check-all: SUCCESS (11.998s)
[556.264700] [118/133] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[556.361204] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[556.365834] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[556.454588] [119/133] (472s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[556.557272] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[563.505699] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.950s)
[563.648623] [120/133] (465s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[563.744966] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[564.812948] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.069s)
[564.952712] [121/133] (464s left) i915_suspend (fence-restore-untiled)
[565.017706] Starting subtest: fence-restore-untiled
[565.022012] Subtest fence-restore-untiled: SKIP (0.000s)
[565.125126] [122/133] (464s left) kms_flip (2x-flip-vs-rmfb)
[565.233917] Starting subtest: 2x-flip-vs-rmfb
[565.259845] Subtest 2x-flip-vs-rmfb: SKIP (0.024s)
[565.355048] [123/133] (463s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[565.482857] Starting subtest: modeset-atomic-cursor-hotspot
[565.487115] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[565.637924] [124/133] (463s left) i915_hangman (gt-engine-error)
[565.704407] Starting subtest: gt-engine-error
[565.706211] Starting dynamic subtest: rcs0
[567.128661] Dynamic subtest rcs0: SUCCESS (1.422s)
[567.142785] Starting dynamic subtest: bcs0
[569.113609] Dynamic subtest bcs0: SUCCESS (1.981s)
[569.129821] Starting dynamic subtest: vcs0
[571.159512] Dynamic subtest vcs0: SUCCESS (2.042s)
[571.175676] Starting dynamic subtest: vcs1
[573.144470] Dynamic subtest vcs1: SUCCESS (1.981s)
[573.157851] Starting dynamic subtest: vecs0
[575.127380] Dynamic subtest vecs0: SUCCESS (1.980s)
[575.141764] Starting dynamic subtest: ccs0
[577.111910] Dynamic subtest ccs0: SUCCESS (1.982s)
[577.114883] Subtest gt-engine-error: SUCCESS (11.406s)
[577.207726] [125/133] (452s left) gem_ctx_shared (q-smoketest)
[577.281513] Starting subtest: Q-smoketest
[577.283556] Starting dynamic subtest: rcs0
[582.866404] Dynamic subtest rcs0: SUCCESS (5.538s)
[582.877219] Starting dynamic subtest: bcs0
[588.372972] Dynamic subtest bcs0: SUCCESS (5.505s)
[588.386390] Starting dynamic subtest: vcs0
[593.864889] Dynamic subtest vcs0: SUCCESS (5.487s)
[593.879935] Starting dynamic subtest: vcs1
[599.366124] Dynamic subtest vcs1: SUCCESS (5.496s)
[599.378516] Starting dynamic subtest: vecs0
[604.854737] Dynamic subtest vecs0: SUCCESS (5.488s)
[604.872037] Starting dynamic subtest: ccs0
[610.369107] Dynamic subtest ccs0: SUCCESS (5.513s)
[610.371375] Subtest Q-smoketest: SUCCESS (33.035s)
[610.519100] [126/133] (418s left) gem_exec_schedule (u-submit-early-slice)
[610.587535] Starting subtest: u-submit-early-slice
[610.590004] Starting dynamic subtest: rcs0
[610.647650] Dynamic subtest rcs0: SUCCESS (0.069s)
[610.664386] Starting dynamic subtest: bcs0
[610.701882] Dynamic subtest bcs0: SUCCESS (0.053s)
[610.715020] Starting dynamic subtest: vcs0
[610.760729] Dynamic subtest vcs0: SUCCESS (0.058s)
[610.772885] Starting dynamic subtest: vcs1
[610.806923] Dynamic subtest vcs1: SUCCESS (0.046s)
[610.818980] Starting dynamic subtest: vecs0
[610.855379] Dynamic subtest vecs0: SUCCESS (0.048s)
[610.870543] Starting dynamic subtest: ccs0
[610.911770] Dynamic subtest ccs0: SUCCESS (0.056s)
[610.914191] Subtest u-submit-early-slice: SUCCESS (0.334s)
[612.241472] [127/133] (417s left) gem_ctx_isolation (preservation-reset)
[612.415314] Starting subtest: preservation-reset
[612.418142] Starting dynamic subtest: rcs0
[612.735117] Dynamic subtest rcs0: SUCCESS (0.323s)
[612.747960] Starting dynamic subtest: bcs0
[613.108583] Dynamic subtest bcs0: SUCCESS (0.372s)
[613.122757] Starting dynamic subtest: vcs0
[613.459621] Dynamic subtest vcs0: SUCCESS (0.350s)
[613.469658] Starting dynamic subtest: vcs1
[615.470932] Dynamic subtest vcs1: SUCCESS (2.010s)
[615.481780] Starting dynamic subtest: vecs0
[617.445821] Dynamic subtest vecs0: SUCCESS (1.974s)
[617.457396] Starting dynamic subtest: ccs0
[619.509279] Dynamic subtest ccs0: SUCCESS (2.063s)
[619.512236] Subtest preservation-reset: SUCCESS (7.100s)
[619.626812] [128/133] (409s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[619.678076] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[619.736520] [129/133] (409s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[619.826485] Starting subtest: compare-crc-sanitycheck-nv12
[619.828565] Starting dynamic subtest: pipe-A-eDP-1
[620.536870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[620.548396] Starting dynamic subtest: pipe-B-eDP-1
[621.850412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.309s)
[621.863067] Starting dynamic subtest: pipe-C-eDP-1
[623.120703] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s)
[623.138061] Starting dynamic subtest: pipe-D-eDP-1
[624.362247] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[624.365393] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.535s)
[625.178448] [130/133] (404s left) gem_ctx_persistence (legacy-engines-cleanup)
[625.231818] Starting subtest: legacy-engines-cleanup
[625.234260] Starting dynamic subtest: render
[625.316327] Dynamic subtest render: SUCCESS (0.083s)
[625.329227] Starting dynamic subtest: bsd1
[625.356894] Dynamic subtest bsd1: SUCCESS (0.037s)
[625.374091] Starting dynamic subtest: bsd2
[625.406474] Dynamic subtest bsd2: SUCCESS (0.047s)
[625.419794] Starting dynamic subtest: blt
[625.450511] Dynamic subtest blt: SUCCESS (0.041s)
[625.461384] Starting dynamic subtest: vebox
[625.489373] Dynamic subtest vebox: SUCCESS (0.037s)
[625.492071] Subtest legacy-engines-cleanup: SUCCESS (0.258s)
[625.583810] [131/133] (403s left) kms_pm_rpm (pc8-residency)
[627.315198] Starting subtest: pc8-residency
[627.320002] Subtest pc8-residency: SKIP (0.000s)
[627.824683] [132/133] (401s left) gem_mmap_gtt (basic-short)
[627.881416] Subtest basic-short: SKIP (0.000s)
[627.950637] [133/133] (401s left) api_intel_bb (object-reloc-keep-cache)
[628.012645] Starting subtest: object-reloc-keep-cache
[628.017406] Subtest object-reloc-keep-cache: SKIP (0.003s)
[628.125642] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_psr2_su
results: parsing output: 2/ for test: gem_exec_await
results: parsing output: 3/ for test: kms_pm_dc
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_ppgtt
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_content_protection
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: gem_create
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_plane_multiple
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: i915_pm_rpm
results: parsing output: 38/ for test: sw_sync
results: parsing output: 39/ for test: gem_ccs
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: prime_busy
results: parsing output: 44/ for test: kms_color_pipeline
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_tiled_wb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_params
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: vgem_basic
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_selftest
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: gem_ringfill
results: parsing output: 70/ for test: kms_prop_blob
results: parsing output: 71/ for test: kms_chamelium_edid
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_atomic_interruptible
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: prime_self_import
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_dsc
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_joiner
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: dmabuf_sync_file
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: kms_cdclk
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_atomic_transition
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: i915_suspend
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: gem_ctx_isolation
results: parsing output: 127/ for test: gem_fenced_exec_thrash
results: parsing output: 128/ for test: kms_pipe_crc_basic
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: api_intel_bb
Done.