[58.866366] Initializing watchdogs
[58.866409]   /dev/watchdog0
[58.881350] [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.885660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.887941] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.891363] [001/132] (960s left) api_intel_bb (full-batch)
[58.973267] Starting subtest: full-batch
[58.979650] Subtest full-batch: SUCCESS (0.009s)
[59.083959] [002/132] (960s left) kms_color (ctm-blue-to-red)
[59.183579] Starting subtest: ctm-blue-to-red
[59.185688] Starting dynamic subtest: pipe-A-eDP-1
[59.921750] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[59.929092] Starting dynamic subtest: pipe-B-eDP-1
[61.289355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[61.298592] Starting dynamic subtest: pipe-C-eDP-1
[62.682223] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[62.690049] Starting dynamic subtest: pipe-D-eDP-1
[64.002537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[64.004983] Subtest ctm-blue-to-red: SUCCESS (4.814s)
[64.830985] [003/132] (954s left) gem_render_copy (y-tiled-to-vebox-linear)
[64.891551] Starting subtest: y-tiled-to-vebox-linear
[64.896281] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[65.100217] [004/132] (954s left) kms_atomic_transition (plane-all-modeset-transition)
[65.194383] Starting subtest: plane-all-modeset-transition
[65.198661] Subtest plane-all-modeset-transition: SKIP (0.000s)
[65.263564] [005/132] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[65.366949] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[65.369311] Starting dynamic subtest: pipe-A-eDP-1
[65.680433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[65.688825] Starting dynamic subtest: pipe-B-eDP-1
[66.945464] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[66.953238] Starting dynamic subtest: pipe-C-eDP-1
[68.236690] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.295s)
[68.245529] Starting dynamic subtest: pipe-D-eDP-1
[69.449321] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[69.451284] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.050s)
[70.569601] [006/132] (949s left) gem_mmap_gtt (flink-race)
[70.633787] Subtest flink-race: SKIP (0.000s)
[70.690151] [007/132] (948s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[70.785540] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[70.787906] Starting dynamic subtest: pipe-A-eDP-1
[70.810142] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.817961] Starting dynamic subtest: pipe-B-eDP-1
[70.839378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.846250] Starting dynamic subtest: pipe-C-eDP-1
[70.867304] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.876688] Starting dynamic subtest: pipe-D-eDP-1
[70.898533] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.903063] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[72.945534] [008/132] (946s left) kms_psr (fbc-psr-primary-mmap-cpu)
[73.050583] Starting subtest: fbc-psr-primary-mmap-cpu
[73.052604] Starting dynamic subtest: eDP-1
[73.056840] Dynamic subtest eDP-1: SKIP (0.000s)
[73.061132] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[73.133715] [009/132] (946s left) kms_prop_blob (blob-multiple)
[73.180386] Starting subtest: blob-multiple
[73.182823] Subtest blob-multiple: SUCCESS (0.002s)
[73.281010] [010/132] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[73.372526] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[80.741632] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.369s)
[80.875041] [011/132] (938s left) kms_vblank (wait-forked)
[80.961590] Starting subtest: wait-forked
[80.963697] Starting dynamic subtest: pipe-A-eDP-1
[82.770849] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[82.784274] Starting dynamic subtest: pipe-D-eDP-1
[85.277080] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s)
[85.279282] Subtest wait-forked: SUCCESS (4.314s)
[86.141798] [012/132] (933s left) sw_sync (sync_busy_fork)
[86.182643] Starting subtest: sync_busy_fork
[87.197509] Subtest sync_busy_fork: SUCCESS (1.013s)
[87.261188] [013/132] (932s left) kms_plane_alpha_blend (alpha-7efc)
[87.359832] Starting subtest: alpha-7efc
[87.655351] Starting dynamic subtest: pipe-A-eDP-1
[88.242951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[88.271181] Starting dynamic subtest: pipe-D-eDP-1
[89.564784] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[89.567168] Subtest alpha-7efc: SUCCESS (2.205s)
[90.402261] [014/132] (929s left) perf (polling)
[90.540134] Starting subtest: polling
[90.542380] Starting dynamic subtest: 0-rcs0
[100.552035] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[100.559435] Starting dynamic subtest: 1-vcs0
[110.572608] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[110.575431] Subtest polling: SUCCESS (20.032s)
[110.618546] [015/132] (909s left) perf (disabled-read-error)
[110.716314] Starting subtest: disabled-read-error
[110.727927] Subtest disabled-read-error: SUCCESS (0.014s)
[110.766945] [016/132] (909s left) i915_pm_rc6_residency (rc6-idle)
[110.821084] Starting subtest: rc6-idle
[110.857604] Starting dynamic subtest: gt0-rcs0
[135.140066] Dynamic subtest gt0-rcs0: SUCCESS (24.282s)
[135.147850] Starting dynamic subtest: gt0-bcs0
[159.507371] Dynamic subtest gt0-bcs0: SUCCESS (24.364s)
[159.515631] Starting dynamic subtest: gt0-ccs0
[183.890902] Dynamic subtest gt0-ccs0: SUCCESS (24.381s)
[183.898920] Starting dynamic subtest: gt1-vcs0
[190.065114] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[190.075556] Starting dynamic subtest: gt1-vecs0
[196.235122] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[196.240927] Subtest rc6-idle: SUCCESS (85.416s)
[196.313068] [017/132] (823s left) gem_mmap_wc (bad-object)
[196.376279] Subtest bad-object: SKIP (0.000s)
[196.435988] [018/132] (823s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[196.537745] Starting subtest: 4-tiled-8bpp-rotate-90
[196.559098] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[196.669353] [019/132] (823s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[196.787952] Starting subtest: cursorB-vs-flipB-atomic-transitions
[196.792272] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[196.941434] [020/132] (823s left) kms_atomic_interruptible (atomic-setmode)
[197.038951] Starting subtest: atomic-setmode
[197.041287] Starting dynamic subtest: pipe-A-eDP-1
[203.941046] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.900s)
[203.943129] Subtest atomic-setmode: SUCCESS (6.901s)
[204.821278] [021/132] (815s left) gem_lmem_swapping (verify)
[204.864494] Subtest verify: SKIP (0.000s)
[204.907031] [022/132] (815s left) perf (non-sampling-read-error)
[204.995459] Starting subtest: non-sampling-read-error
[205.004033] Subtest non-sampling-read-error: SUCCESS (0.006s)
[205.037607] [023/132] (815s left) kms_content_protection (dp-mst-lic-type-1)
[205.185548] Starting subtest: dp-mst-lic-type-1
[205.190067] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[205.301682] [024/132] (814s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[205.544733] Starting subtest: cursor-rapid-movement-256x85
[205.594377] Subtest cursor-rapid-movement-256x85: SKIP (0.045s)
[205.765811] [025/132] (814s left) kms_flip (dpms-off-confusion)
[205.867424] Starting subtest: dpms-off-confusion
[205.869291] Starting dynamic subtest: A-eDP1
[214.515794] Dynamic subtest A-eDP1: SUCCESS (8.649s)
[214.523694] Starting dynamic subtest: B-eDP1
[223.154070] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[223.164284] Starting dynamic subtest: C-eDP1
[231.779282] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[231.788604] Starting dynamic subtest: D-eDP1
[240.413078] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[240.418161] Subtest dpms-off-confusion: SUCCESS (34.552s)
[241.580436] [026/132] (778s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[241.677471] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[241.704556] Starting dynamic subtest: pipe-A-plane-0
[242.147188] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[242.155733] Starting dynamic subtest: pipe-A-plane-3
[242.403942] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[243.478888] Starting dynamic subtest: pipe-B-plane-0
[243.927889] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[243.936884] Starting dynamic subtest: pipe-B-plane-3
[244.196306] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[244.514684] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.839s)
[246.145574] [027/132] (774s left) gem_wait (invalid-buf)
[246.194856] Starting subtest: invalid-buf
[246.197078] Subtest invalid-buf: SUCCESS (0.000s)
[246.395371] [028/132] (774s left) gem_render_copy (linear-to-vebox-yf-tiled)
[246.460825] Starting subtest: linear-to-vebox-yf-tiled
[246.464965] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[246.663204] [029/132] (773s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[246.726324] Starting subtest: invalid-bsd2-flag-on-blt
[246.728623] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[246.822643] [030/132] (773s left) gem_spin_batch (resubmit-new-all)
[246.888791] Starting subtest: resubmit-new-all
[246.891244] Starting dynamic subtest: rcs0
[246.905913] Dynamic subtest rcs0: SUCCESS (0.020s)
[246.918785] Starting dynamic subtest: bcs0
[246.920917] Dynamic subtest bcs0: SUCCESS (0.010s)
[246.928537] Starting dynamic subtest: vcs0
[246.930415] Dynamic subtest vcs0: SUCCESS (0.008s)
[246.938522] Starting dynamic subtest: vcs1
[246.941361] Dynamic subtest vcs1: SUCCESS (0.008s)
[246.951896] Starting dynamic subtest: vecs0
[246.954176] Dynamic subtest vecs0: SUCCESS (0.009s)
[246.961655] Starting dynamic subtest: ccs0
[246.963796] Dynamic subtest ccs0: SUCCESS (0.008s)
[246.965951] Subtest resubmit-new-all: SUCCESS (0.066s)
[248.903227] [031/132] (771s left) kms_flip (2x-flip-vs-rmfb)
[249.005782] Starting subtest: 2x-flip-vs-rmfb
[249.015094] Subtest 2x-flip-vs-rmfb: SKIP (0.012s)
[249.093714] [032/132] (771s left) gem_exec_params (rs-invalid)
[249.148715] Starting subtest: rs-invalid
[249.151385] Subtest rs-invalid: SUCCESS (0.003s)
[249.254712] [033/132] (771s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[249.347422] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[256.081455] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.735s)
[256.193760] [034/132] (764s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[256.256352] Starting subtest: rel-constants-invalid-rel-gen5
[256.258844] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[256.357775] [035/132] (764s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[256.459097] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[256.463575] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[256.553697] [036/132] (764s left) syncobj_timeline (reset-multiple-signaled)
[256.608057] Starting subtest: reset-multiple-signaled
[256.610931] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[256.703621] [037/132] (764s left) gem_ctx_param (get-priority-new-ctx)
[256.761672] Starting subtest: get-priority-new-ctx
[256.764153] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[256.878351] [038/132] (763s left) gen9_exec_parse (bb-large)
[256.934278] Subtest bb-large: SKIP (0.000s)
[256.997610] [039/132] (763s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[257.106379] Starting subtest: yf-tiled-8bpp-rotate-0
[257.110034] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[257.200602] [040/132] (763s left) gem_exec_reloc (basic-write-wc-noreloc)
[257.259984] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[257.327965] [041/132] (763s left) gem_ctx_create (basic-files)
[257.396714] Starting subtest: basic-files
[259.406714] Subtest basic-files: SUCCESS (2.011s)
[260.969063] [042/132] (760s left) perf_pmu (busy-idle-no-semaphores)
[261.012777] Starting subtest: busy-idle-no-semaphores
[261.015072] Starting dynamic subtest: rcs0
[261.664564] Dynamic subtest rcs0: SUCCESS (0.651s)
[261.675055] Starting dynamic subtest: bcs0
[262.319986] Dynamic subtest bcs0: SUCCESS (0.654s)
[262.330724] Starting dynamic subtest: vcs0
[262.974839] Dynamic subtest vcs0: SUCCESS (0.652s)
[262.988967] Starting dynamic subtest: vcs1
[264.513464] Dynamic subtest vcs1: SUCCESS (1.537s)
[264.524051] Starting dynamic subtest: vecs0
[266.559069] Dynamic subtest vecs0: SUCCESS (2.044s)
[266.568824] Starting dynamic subtest: ccs0
[268.541614] Dynamic subtest ccs0: SUCCESS (1.980s)
[268.544565] Subtest busy-idle-no-semaphores: SUCCESS (7.530s)
[268.656407] [043/132] (752s left) gem_ctx_persistence (many-contexts)
[268.708974] Starting subtest: many-contexts
[306.394489] Subtest many-contexts: SUCCESS (37.683s)
[306.467393] [044/132] (714s left) kms_flip (flip-vs-wf_vblank-interruptible)
[306.565829] Starting subtest: flip-vs-wf_vblank-interruptible
[306.568080] Starting dynamic subtest: A-eDP1
[308.442552] Dynamic subtest A-eDP1: SUCCESS (1.875s)
[308.453049] Starting dynamic subtest: B-eDP1
[310.374768] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[310.386144] Starting dynamic subtest: C-eDP1
[312.293920] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[312.303146] Starting dynamic subtest: D-eDP1
[314.214812] Dynamic subtest D-eDP1: SUCCESS (1.919s)
[314.220068] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.654s)
[315.436127] [045/132] (705s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[315.542696] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[315.547103] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[315.615157] [046/132] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[315.710559] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[315.714958] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[315.805358] [047/132] (705s left) perf_pmu (busy-double-start)
[315.848143] Starting subtest: busy-double-start
[315.849963] Starting dynamic subtest: rcs0
[319.485353] Dynamic subtest rcs0: FAIL (3.583s)
[319.494642] Starting dynamic subtest: bcs0
[323.000901] Dynamic subtest bcs0: SUCCESS (3.569s)
[323.010208] Starting dynamic subtest: vcs0
[327.461684] Dynamic subtest vcs0: SUCCESS (4.459s)
[327.470985] Starting dynamic subtest: vcs1
[331.411332] Dynamic subtest vcs1: SUCCESS (3.947s)
[331.422379] Starting dynamic subtest: vecs0
[335.458758] Dynamic subtest vecs0: SUCCESS (4.046s)
[335.469847] Starting dynamic subtest: ccs0
[339.100272] Dynamic subtest ccs0: FAIL (3.569s)
[339.102748] Subtest busy-double-start: FAIL (23.183s)
[339.154347] [048/132] (682s left) kms_pm_dc (dc6-dpms)
[340.259079] Starting subtest: dc6-dpms
[342.308275] Subtest dc6-dpms: SUCCESS (2.048s)
[342.381187] [049/132] (678s left) gem_blits (basic)
[342.435821] Starting subtest: basic
[343.766073] Subtest basic: SUCCESS (1.328s)
[343.899419] [050/132] (677s left) gem_create (create-size-update)
[343.948929] Starting subtest: create-size-update
[343.951090] Subtest create-size-update: SUCCESS (0.000s)
[344.164935] [051/132] (677s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[344.230331] Subtest untiled-to-tiled: SKIP (0.000s)
[344.301457] [052/132] (677s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[344.908733] Starting subtest: syncobj-timeline-invalid-flags
[344.910692] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[345.928100] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[345.931781] [053/132] (675s left) kms_pm_backlight (bad-brightness)
[346.028067] Starting subtest: bad-brightness
[346.078244] Starting dynamic subtest: eDP-1
[346.392288] Dynamic subtest eDP-1: SUCCESS (0.311s)
[346.394556] Subtest bad-brightness: SUCCESS (0.364s)
[347.192392] [054/132] (674s left) kms_addfb_basic (invalid-get-prop-any)
[347.254673] Starting subtest: invalid-get-prop-any
[347.257022] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[347.398283] [055/132] (674s left) i915_selftest (mock)
[349.035521] Starting subtest: mock
[349.037670] Starting dynamic subtest: sanitycheck
[349.719296] Dynamic subtest sanitycheck: SUCCESS (0.684s)
[349.728367] Starting dynamic subtest: shmem
[350.383874] Dynamic subtest shmem: SUCCESS (0.663s)
[350.393050] Starting dynamic subtest: fence
[358.050798] Dynamic subtest fence: SUCCESS (7.666s)
[358.059828] Starting dynamic subtest: scatterlist
[359.763053] Dynamic subtest scatterlist: SUCCESS (1.710s)
[359.772799] Starting dynamic subtest: syncmap
[362.862369] Dynamic subtest syncmap: SUCCESS (3.098s)
[362.876885] Starting dynamic subtest: uncore
[363.535378] Dynamic subtest uncore: SUCCESS (0.671s)
[363.543839] Starting dynamic subtest: ring
[364.227123] Dynamic subtest ring: SUCCESS (0.690s)
[364.235261] Starting dynamic subtest: engine
[364.911468] Dynamic subtest engine: SUCCESS (0.682s)
[364.925969] Starting dynamic subtest: timelines
[368.735062] Dynamic subtest timelines: SUCCESS (3.821s)
[368.744068] Starting dynamic subtest: requests
[372.372769] Dynamic subtest requests: SUCCESS (3.636s)
[372.383158] Starting dynamic subtest: objects
[373.148895] Dynamic subtest objects: SUCCESS (0.776s)
[373.158522] Starting dynamic subtest: phys
[373.936452] Dynamic subtest phys: SUCCESS (0.785s)
[373.945936] Starting dynamic subtest: dmabuf
[374.708229] Dynamic subtest dmabuf: SUCCESS (0.770s)
[374.717174] Starting dynamic subtest: vma
[380.479060] Dynamic subtest vma: SUCCESS (5.768s)
[380.487027] Starting dynamic subtest: evict
[381.852439] Dynamic subtest evict: SUCCESS (1.371s)
[381.861091] Starting dynamic subtest: gtt
[385.145975] Dynamic subtest gtt: SUCCESS (3.292s)
[385.154929] Starting dynamic subtest: hugepages
[386.046576] Dynamic subtest hugepages: SUCCESS (0.900s)
[386.055736] Starting dynamic subtest: memory_region
[388.574609] Dynamic subtest memory_region: SUCCESS (2.526s)
[388.577060] Subtest mock: SUCCESS (39.538s)
[388.607979] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.608686] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[388.611819] [056/132] (632s left) gem_vm_create (invalid-destroy)
[390.134490] Starting subtest: invalid-destroy
[390.136980] Subtest invalid-destroy: SUCCESS (0.003s)
[390.209395] [FACT gem_vm_create (invalid-destroy)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[390.210939] [FACT gem_vm_create (invalid-destroy)] new: kernel.kmod_is_loaded.i915: true
[390.214647] [057/132] (631s left) gem_lmem_swapping (heavy-verify-random)
[390.264123] Subtest heavy-verify-random: SKIP (0.000s)
[390.313678] [058/132] (631s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[390.411294] Starting subtest: fbc-shrfb-scaledprimary
[393.425044] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.016s)
[394.607482] [059/132] (627s left) gen9_exec_parse (unaligned-access)
[394.664249] Subtest unaligned-access: SKIP (0.000s)
[394.742472] [060/132] (626s left) prime_udl
[394.830994] [061/132] (626s left) kms_invalid_mode (overflow-vrefresh)
[394.926084] Starting subtest: overflow-vrefresh
[394.928366] Starting dynamic subtest: pipe-A-eDP-1
[395.212332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[395.220586] Starting dynamic subtest: pipe-B-eDP-1
[395.222731] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[395.230234] Starting dynamic subtest: pipe-C-eDP-1
[395.232485] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[395.240107] Starting dynamic subtest: pipe-D-eDP-1
[395.242068] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[395.244037] Subtest overflow-vrefresh: SUCCESS (0.292s)
[396.019533] [062/132] (625s left) gem_mmap (bad-object)
[396.083690] Subtest bad-object: SKIP (0.000s)
[396.138714] [063/132] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[396.240312] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[403.584352] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.346s)
[403.719832] [064/132] (618s left) sysfs_timeslice_duration (duration)
[403.780619] Starting subtest: duration
[403.782964] Starting dynamic subtest: vecs0
[418.804116] Dynamic subtest vecs0: SUCCESS (15.020s)
[418.814957] Starting dynamic subtest: ccs0
[431.953265] Dynamic subtest ccs0: SUCCESS (13.147s)
[431.962217] Starting dynamic subtest: vcs0
[445.811330] Dynamic subtest vcs0: SUCCESS (13.854s)
[445.821549] Starting dynamic subtest: bcs0
[458.950083] Dynamic subtest bcs0: SUCCESS (13.137s)
[458.960661] Starting dynamic subtest: rcs0
[472.108218] Dynamic subtest rcs0: SUCCESS (13.155s)
[472.119639] Starting dynamic subtest: vcs1
[485.810996] Dynamic subtest vcs1: SUCCESS (13.698s)
[485.813909] Subtest duration: SUCCESS (82.027s)
[485.887694] [065/132] (536s left) syncobj_timeline (invalid-wait-bad-flags)
[485.944680] Starting subtest: invalid-wait-bad-flags
[485.946863] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[486.057146] [066/132] (535s left) kms_busy (extended-modeset-hang-oldfb)
[486.155515] Starting subtest: extended-modeset-hang-oldfb
[486.157473] Starting dynamic subtest: pipe-A
[498.403588] Dynamic subtest pipe-A: SUCCESS (12.246s)
[498.412480] Starting dynamic subtest: pipe-D
[510.866061] Dynamic subtest pipe-D: SUCCESS (12.461s)
[510.868612] Subtest extended-modeset-hang-oldfb: SUCCESS (24.713s)
[511.669544] [067/132] (510s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[511.774628] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[511.778908] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[511.866367] [068/132] (510s left) kms_draw_crc (draw-method-mmap-gtt)
[511.959475] Starting subtest: draw-method-mmap-gtt
[511.963975] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[512.061539] [069/132] (509s left) kms_atomic (crtc-invalid-params-fence)
[512.162043] Starting subtest: crtc-invalid-params-fence
[512.164360] Starting dynamic subtest: pipe-A-eDP-1
[512.584838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[512.587441] Subtest crtc-invalid-params-fence: SUCCESS (0.421s)
[513.405369] [070/132] (508s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[513.507203] Starting subtest: psr2-overlay-plane-update-continuous-sf
[513.509638] Starting dynamic subtest: pipe-A-eDP-1
[514.634929] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.130s)
[514.644097] Starting dynamic subtest: pipe-B-eDP-1
[516.348712] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.712s)
[516.351134] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.845s)
[517.165938] [071/132] (504s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[517.251966] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[517.256433] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[517.324577] [072/132] (504s left) kms_prime (d3hot)
[517.403735] Subtest D3hot: SKIP (0.000s)
[517.510439] [073/132] (504s left) api_intel_bb (blit-noreloc-keep-cache)
[517.561111] Starting subtest: blit-noreloc-keep-cache
[517.569620] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[517.717794] [074/132] (504s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[517.763437] Starting subtest: etime-single-wait-available-unsubmitted
[517.863509] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[517.941278] [075/132] (504s left) intel_hwmon (hwmon-write)
[518.005074] Subtest hwmon-write: SKIP (0.000s)
[518.067520] [076/132] (504s left) kms_psr (pr-sprite-plane-onoff)
[518.169421] Starting subtest: pr-sprite-plane-onoff
[518.173031] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[518.252920] [077/132] (504s left) kms_flip (basic-flip-vs-wf_vblank)
[518.338462] Starting subtest: basic-flip-vs-wf_vblank
[518.340431] Starting dynamic subtest: A-eDP1
[520.227088] Dynamic subtest A-eDP1: SUCCESS (1.887s)
[520.237552] Starting dynamic subtest: B-eDP1
[522.159940] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[522.170350] Starting dynamic subtest: C-eDP1
[524.081687] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[524.090437] Starting dynamic subtest: D-eDP1
[526.012818] Dynamic subtest D-eDP1: SUCCESS (1.928s)
[526.018251] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.677s)
[527.248195] [078/132] (495s left) gem_ctx_isolation (preservation)
[527.312216] Starting subtest: preservation
[527.314643] Starting dynamic subtest: rcs0
[527.448480] Dynamic subtest rcs0: SUCCESS (0.135s)
[527.459692] Starting dynamic subtest: bcs0
[527.620544] Dynamic subtest bcs0: SUCCESS (0.171s)
[527.629680] Starting dynamic subtest: vcs0
[527.787110] Dynamic subtest vcs0: SUCCESS (0.165s)
[527.798464] Starting dynamic subtest: vcs1
[529.000378] Dynamic subtest vcs1: SUCCESS (1.212s)
[529.011784] Starting dynamic subtest: vecs0
[531.015892] Dynamic subtest vecs0: SUCCESS (2.015s)
[531.025234] Starting dynamic subtest: ccs0
[533.016013] Dynamic subtest ccs0: SUCCESS (1.999s)
[533.018822] Subtest preservation: SUCCESS (5.704s)
[533.262404] [079/132] (489s left) gem_ctx_param (invalid-param-set)
[533.319131] Starting subtest: invalid-param-set
[533.321575] Subtest invalid-param-set: SUCCESS (0.000s)
[533.408156] [080/132] (489s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[533.528071] Starting subtest: basic-flip-after-cursor-varying-size
[534.451184] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.922s)
[535.278121] [081/132] (487s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[535.375827] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[536.594835] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.616s)
[536.635159] [082/132] (485s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[536.731504] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[536.733495] Starting dynamic subtest: pipe-A-eDP-1
[536.752597] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.764671] Starting dynamic subtest: pipe-B-eDP-1
[536.783043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.790791] Starting dynamic subtest: pipe-C-eDP-1
[536.808997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.816873] Starting dynamic subtest: pipe-D-eDP-1
[536.835166] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.838521] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[539.036722] [083/132] (483s left) kms_psr (fbc-psr2-no-drrs)
[539.130376] Starting subtest: fbc-psr2-no-drrs
[539.132344] Starting dynamic subtest: eDP-1
[539.136463] Dynamic subtest eDP-1: SKIP (0.000s)
[539.140644] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[539.207221] [084/132] (483s left) kms_cursor_edge_walk (64x64-left-edge)
[539.304951] Starting subtest: 64x64-left-edge
[539.307257] Starting dynamic subtest: pipe-A-eDP-1
[542.811408] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.506s)
[542.819854] Starting dynamic subtest: pipe-D-eDP-1
[545.946572] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[545.948449] Subtest 64x64-left-edge: SUCCESS (6.642s)
[546.743838] [085/132] (475s left) syncobj_eventfd (binary-wait-before-signal)
[546.802749] Starting subtest: binary-wait-before-signal
[546.831755] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[546.908214] [086/132] (475s left) gem_ctx_param (basic)
[546.960626] Starting subtest: basic
[546.962828] Subtest basic: SUCCESS (0.002s)
[547.058943] [087/132] (475s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[547.455805] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[548.278665] [088/132] (474s left) kms_big_fb (x-tiled-addfb)
[548.388576] Starting subtest: x-tiled-addfb
[548.390934] Subtest x-tiled-addfb: SUCCESS (0.000s)
[548.479860] [089/132] (474s left) prime_mmap (test_forked)
[548.542356] Starting subtest: test_forked
[548.544239] Starting dynamic subtest: test_forked-smem
[548.578274] Dynamic subtest test_forked-smem: SUCCESS (0.037s)
[548.582042] Subtest test_forked: SUCCESS (0.039s)
[548.682384] [090/132] (474s left) sriov_basic (bind-unbind-vf)
[548.740507] Starting subtest: bind-unbind-vf
[548.742794] Starting dynamic subtest: vf-1
[548.816840] Dynamic subtest vf-1: FAIL (0.009s)
[548.826958] Starting dynamic subtest: vf-2
[548.901997] Dynamic subtest vf-2: FAIL (0.007s)
[548.912393] Starting dynamic subtest: vf-3
[548.986702] Dynamic subtest vf-3: FAIL (0.005s)
[548.996649] Starting dynamic subtest: vf-4
[549.070153] Dynamic subtest vf-4: FAIL (0.004s)
[549.080308] Starting dynamic subtest: vf-5
[549.153833] Dynamic subtest vf-5: FAIL (0.004s)
[549.163069] Starting dynamic subtest: vf-6
[549.231910] Dynamic subtest vf-6: FAIL (0.004s)
[549.243323] Starting dynamic subtest: vf-7
[549.303025] Dynamic subtest vf-7: FAIL (0.004s)
[549.311650] Starting dynamic subtest: vf-random
[549.368794] Dynamic subtest vf-random: FAIL (0.004s)
[549.378055] Starting dynamic subtest: vf-last
[549.436997] Dynamic subtest vf-last: FAIL (0.503s)
[549.438850] Subtest bind-unbind-vf: FAIL (0.553s)
[549.475338] [091/132] (473s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[549.573934] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[549.577469] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[549.684710] [092/132] (473s left) prime_mmap (test_forked_cpu_write)
[549.745923] Starting subtest: test_forked_cpu_write
[549.747614] Starting dynamic subtest: test_forked_cpu_write-smem
[549.751894] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[549.753829] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[549.849376] [093/132] (473s left) gem_exec_balancer (indices)
[549.921236] Starting subtest: indices
[551.858077] Subtest indices: SUCCESS (1.934s)
[552.169686] [094/132] (470s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[552.275988] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[552.280220] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[552.348081] [095/132] (470s left) i915_hangman (gt-engine-error)
[552.414170] Starting subtest: gt-engine-error
[552.416021] Starting dynamic subtest: rcs0
[553.843982] Dynamic subtest rcs0: SUCCESS (1.430s)
[553.856740] Starting dynamic subtest: bcs0
[555.891544] Dynamic subtest bcs0: SUCCESS (2.044s)
[555.903956] Starting dynamic subtest: vcs0
[557.874575] Dynamic subtest vcs0: SUCCESS (1.980s)
[557.886244] Starting dynamic subtest: vcs1
[559.858370] Dynamic subtest vcs1: SUCCESS (1.981s)
[559.870219] Starting dynamic subtest: vecs0
[561.842958] Dynamic subtest vecs0: SUCCESS (1.982s)
[561.854089] Starting dynamic subtest: ccs0
[563.891447] Dynamic subtest ccs0: SUCCESS (2.045s)
[563.894283] Subtest gt-engine-error: SUCCESS (11.478s)
[564.018933] [096/132] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[564.123607] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[564.127763] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[564.219727] [097/132] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[564.325452] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[571.111402] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.790s)
[571.238203] [098/132] (452s left) kms_cursor_legacy (torture-bo)
[571.352259] Starting subtest: torture-bo
[571.354390] Starting dynamic subtest: pipe-A
[577.227078] Dynamic subtest pipe-A: SUCCESS (5.870s)
[577.238401] Starting dynamic subtest: pipe-B
[584.195111] Dynamic subtest pipe-B: SUCCESS (6.967s)
[584.203931] Starting dynamic subtest: pipe-C
[591.225602] Dynamic subtest pipe-C: SUCCESS (7.027s)
[591.238089] Starting dynamic subtest: pipe-D
[598.236900] Dynamic subtest pipe-D: SUCCESS (7.010s)
[598.251182] Starting dynamic subtest: all-pipes
[605.264670] Dynamic subtest all-pipes: SUCCESS (7.024s)
[605.267081] Subtest torture-bo: SUCCESS (33.909s)
[605.446554] [099/132] (417s left) kms_chamelium_hpd (hdmi-hpd-storm)
[605.860126] Subtest hdmi-hpd-storm: SKIP (0.000s)
[606.636586] [100/132] (416s left) gem_exec_schedule (implicit-read-write)
[606.704877] Starting subtest: implicit-read-write
[606.706872] Starting dynamic subtest: rcs0
[606.811253] Dynamic subtest rcs0: SUCCESS (0.116s)
[606.820981] Starting dynamic subtest: vcs0
[606.896887] Dynamic subtest vcs0: SUCCESS (0.085s)
[606.908222] Starting dynamic subtest: vcs1
[606.976564] Dynamic subtest vcs1: SUCCESS (0.079s)
[606.987657] Starting dynamic subtest: vecs0
[607.052390] Dynamic subtest vecs0: SUCCESS (0.074s)
[607.064823] Starting dynamic subtest: ccs0
[607.151032] Dynamic subtest ccs0: SUCCESS (0.098s)
[607.153678] Subtest implicit-read-write: SUCCESS (0.457s)
[607.984154] [101/132] (415s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[608.079555] Starting subtest: fbc-rgb565-draw-mmap-gtt
[608.083912] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[608.174071] [102/132] (415s left) gem_exec_schedule (semaphore-noskip)
[608.239446] Starting subtest: semaphore-noskip
[608.642591] Subtest semaphore-noskip: SUCCESS (0.405s)
[608.986279] [103/132] (414s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[609.095294] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[609.099646] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[609.193441] [104/132] (414s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[609.289851] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[610.058969] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[610.220326] [105/132] (413s left) gem_exec_flush (basic-uc-rw-default)
[610.284722] Starting subtest: basic-uc-rw-default
[615.740906] Subtest basic-uc-rw-default: SUCCESS (5.458s)
[615.927473] [106/132] (407s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[616.019681] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[616.023782] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[616.104217] [107/132] (407s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[616.197641] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[620.590611] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.396s)
[621.741869] [108/132] (401s left) kms_psr (psr2-sprite-blt)
[621.839989] Starting subtest: psr2-sprite-blt
[621.842747] Starting dynamic subtest: eDP-1
[623.555492] Dynamic subtest eDP-1: SUCCESS (1.713s)
[623.557820] Subtest psr2-sprite-blt: SUCCESS (1.714s)
[624.413166] [109/132] (399s left) kms_plane (plane-position-covered)
[624.513224] Starting subtest: plane-position-covered
[625.043805] Starting dynamic subtest: pipe-A-plane-1
[626.318540] Dynamic subtest pipe-A-plane-1: SUCCESS (1.276s)
[626.327543] Starting dynamic subtest: pipe-A-plane-2
[627.614627] Dynamic subtest pipe-A-plane-2: SUCCESS (1.296s)
[627.625111] Starting dynamic subtest: pipe-A-plane-3
[628.875236] Dynamic subtest pipe-A-plane-3: SUCCESS (1.258s)
[628.886691] Starting dynamic subtest: pipe-A-plane-4
[630.187390] Dynamic subtest pipe-A-plane-4: SUCCESS (1.309s)
[630.196107] Starting dynamic subtest: pipe-A-plane-5
[630.208644] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[631.356881] Starting dynamic subtest: pipe-B-plane-1
[632.677253] Dynamic subtest pipe-B-plane-1: SUCCESS (1.332s)
[632.686183] Starting dynamic subtest: pipe-B-plane-2
[633.999378] Dynamic subtest pipe-B-plane-2: SUCCESS (1.321s)
[634.008993] Starting dynamic subtest: pipe-B-plane-3
[635.332652] Dynamic subtest pipe-B-plane-3: SUCCESS (1.334s)
[635.341831] Starting dynamic subtest: pipe-B-plane-4
[636.663719] Dynamic subtest pipe-B-plane-4: SUCCESS (1.327s)
[636.673157] Starting dynamic subtest: pipe-B-plane-5
[636.688293] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[636.690460] Subtest plane-position-covered: SUCCESS (12.176s)
[637.535283] [110/132] (386s left) gem_exec_endless (dispatch)
[637.602692] Starting subtest: dispatch
[637.604967] Starting dynamic subtest: rcs0
[637.613123] Dynamic subtest rcs0: SUCCESS (0.008s)
[637.628688] Starting dynamic subtest: bcs0
[637.633164] Dynamic subtest bcs0: SUCCESS (0.005s)
[637.648266] Starting dynamic subtest: vcs0
[637.652696] Dynamic subtest vcs0: SUCCESS (0.004s)
[637.660681] Starting dynamic subtest: vcs1
[637.664783] Dynamic subtest vcs1: SUCCESS (0.005s)
[637.672835] Starting dynamic subtest: vecs0
[637.677030] Dynamic subtest vecs0: SUCCESS (0.005s)
[637.686832] Starting dynamic subtest: ccs0
[637.690994] Dynamic subtest ccs0: SUCCESS (0.006s)
[637.692922] Subtest dispatch: SUCCESS (0.039s)
[638.971446] [111/132] (384s left) gem_exec_schedule (u-submit-golden-slice)
[639.047520] Starting subtest: u-submit-golden-slice
[639.049434] Starting dynamic subtest: rcs0
[639.074807] Dynamic subtest rcs0: SUCCESS (0.032s)
[639.084950] Starting dynamic subtest: bcs0
[639.105952] Dynamic subtest bcs0: SUCCESS (0.030s)
[639.116150] Starting dynamic subtest: vcs0
[639.139653] Dynamic subtest vcs0: SUCCESS (0.033s)
[639.149797] Starting dynamic subtest: vcs1
[639.172151] Dynamic subtest vcs1: SUCCESS (0.032s)
[639.180604] Starting dynamic subtest: vecs0
[639.200915] Dynamic subtest vecs0: SUCCESS (0.027s)
[639.209918] Starting dynamic subtest: ccs0
[639.236974] Dynamic subtest ccs0: SUCCESS (0.035s)
[639.239213] Subtest u-submit-golden-slice: SUCCESS (0.195s)
[640.995609] [112/132] (382s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[641.089392] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[641.093665] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[641.208600] [113/132] (382s left) kms_rotation_crc (sprite-rotation-90)
[641.294993] Starting subtest: sprite-rotation-90
[641.299393] Subtest sprite-rotation-90: SKIP (0.001s)
[641.367924] [114/132] (382s left) gem_ctx_param (root-set)
[641.423905] Starting subtest: root-set
[641.426731] Subtest root-set: SUCCESS (0.001s)
[641.544378] [115/132] (382s left) kms_plane_lowres (tiling-y)
[641.625873] Starting subtest: tiling-y
[641.630237] Subtest tiling-y: SKIP (0.000s)
[641.698997] [116/132] (382s left) gem_userptr_blits (unsync-unmap-after-close)
[641.770648] Subtest unsync-unmap-after-close: SKIP (0.000s)
[641.899496] [117/132] (382s left) gem_mmap_gtt (big-bo-tiledx)
[641.957282] Subtest big-bo-tiledX: SKIP (0.000s)
[642.013101] [118/132] (382s left) dmabuf_sync_file (export-basic)
[642.061218] Starting subtest: export-basic
[642.062882] Subtest export-basic: SUCCESS (0.002s)
[642.122509] [119/132] (382s left) kms_chamelium_color (ctm-0-50)
[642.219472] Subtest ctm-0-50: SKIP (0.000s)
[642.264976] [120/132] (381s left) kms_addfb_basic (addfb25-modifier-no-flag)
[642.360505] Starting subtest: addfb25-modifier-no-flag
[642.362467] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[642.450462] [121/132] (381s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[642.560155] Starting subtest: psr-indfb-scaledprimary
[648.302701] Subtest psr-indfb-scaledprimary: SUCCESS (5.748s)
[648.444758] [122/132] (375s left) syncobj_wait (invalid-reset-bad-pad)
[648.501521] Starting subtest: invalid-reset-bad-pad
[648.503712] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[648.590480] [123/132] (375s left) kms_flip (wf_vblank-ts-check-interruptible)
[648.675234] Starting subtest: wf_vblank-ts-check-interruptible
[648.677590] Starting dynamic subtest: A-eDP1
[657.594184] Dynamic subtest A-eDP1: SUCCESS (8.917s)
[657.603856] Starting dynamic subtest: B-eDP1
[666.530527] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[666.539219] Starting dynamic subtest: C-eDP1
[675.455640] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[675.465195] Starting dynamic subtest: D-eDP1
[684.381525] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[684.383817] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.707s)
[685.608350] [124/132] (338s left) gem_softpin (evict-snoop)
[685.668313] Starting subtest: evict-snoop
[685.672791] Subtest evict-snoop: SKIP (0.000s)
[685.743301] [125/132] (338s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[685.830825] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[685.832717] Starting dynamic subtest: pipe-A-eDP-1
[685.979290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[685.988770] Starting dynamic subtest: pipe-B-eDP-1
[686.007727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[686.018876] Starting dynamic subtest: pipe-C-eDP-1
[686.039079] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[686.047461] Starting dynamic subtest: pipe-D-eDP-1
[686.065949] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[686.067781] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[688.276440] [126/132] (336s left) kms_vblank (query-busy-hang)
[688.370266] Starting subtest: query-busy-hang
[688.372344] Starting dynamic subtest: pipe-A-eDP-1
[714.639501] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.266s)
[714.653389] Starting dynamic subtest: pipe-D-eDP-1
[739.671947] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.032s)
[739.674317] Subtest query-busy-hang: SUCCESS (51.302s)
[740.521461] [127/132] (283s left) kms_psr (psr-suspend)
[740.625998] Starting subtest: psr-suspend
[740.628241] Starting dynamic subtest: eDP-1
[758.508655] Dynamic subtest eDP-1: SUCCESS (2.981s)
[758.511225] Subtest psr-suspend: SUCCESS (2.982s)
[759.385610] [128/132] (265s left) kms_cursor_crc (cursor-offscreen-256x85)
[759.656280] Starting subtest: cursor-offscreen-256x85
[759.701636] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[759.878672] [129/132] (264s left) gem_mmap_gtt (basic)
[759.935909] Subtest basic: SKIP (0.000s)
[759.993134] [130/132] (264s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[760.094702] Starting subtest: pr-overlay-plane-move-continuous-sf
[760.099855] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[760.170933] [131/132] (264s left) syncobj_timeline (single-wait-available-signaled)
[760.238701] Starting subtest: single-wait-available-signaled
[760.241257] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[760.351551] [132/132] (264s left) kms_lease (page-flip-implicit-plane)
[760.438967] Starting subtest: page-flip-implicit-plane
[760.440995] Starting dynamic subtest: pipe-A-eDP-1
[760.906427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s)
[760.916752] Starting dynamic subtest: pipe-B-eDP-1
[762.029042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.118s)
[762.041235] Starting dynamic subtest: pipe-C-eDP-1
[763.140906] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[763.151117] Starting dynamic subtest: pipe-D-eDP-1
[764.282292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[764.285082] Subtest page-flip-implicit-plane: SUCCESS (3.843s)
[765.117159] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_prop_blob
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: sw_sync
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: i915_pm_rc6_residency
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_atomic_interruptible
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_ctx_create
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_pm_dc
results: parsing output: 48/ for test: gem_blits
results: parsing output: 49/ for test: gem_create
results: parsing output: 50/ for test: gem_set_tiling_vs_blt
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_pm_backlight
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: i915_selftest
results: parsing output: 55/ for test: gem_vm_create
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gen9_exec_parse
results: parsing output: 59/ for test: prime_udl
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gem_mmap
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: sysfs_timeslice_duration
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_busy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: kms_atomic
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_prime
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: intel_hwmon
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_cursor_edge_walk
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: kms_chamelium_edid
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: sriov_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: prime_mmap
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: i915_hangman
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_cursor_legacy
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: gem_exec_endless
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: dmabuf_sync_file
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_lease
Done.