[57.373451] Initializing watchdogs
[57.373499]   /dev/watchdog0
[57.388248] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.392287] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.394484] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.397940] [001/133] (960s left) i915_drm_fdinfo (busy-hang)
[57.465837] Starting subtest: busy-hang
[57.468255] Starting dynamic subtest: rcs0
[57.493905] Dynamic subtest rcs0: SKIP (0.028s)
[57.503219] Starting dynamic subtest: bcs0
[57.507790] Dynamic subtest bcs0: SKIP (0.001s)
[57.515761] Starting dynamic subtest: vcs0
[57.519809] Dynamic subtest vcs0: SKIP (0.001s)
[57.527129] Starting dynamic subtest: vcs1
[57.531306] Dynamic subtest vcs1: SKIP (0.001s)
[57.539084] Starting dynamic subtest: vecs0
[57.543330] Dynamic subtest vecs0: SKIP (0.001s)
[57.549943] Starting dynamic subtest: ccs0
[57.554447] Dynamic subtest ccs0: SKIP (0.001s)
[57.558756] Subtest busy-hang: SKIP (0.035s)
[57.592953] [002/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.663763] Starting subtest: multiplane-rotation
[75.044059] Subtest multiplane-rotation: SUCCESS (17.436s)
[75.155143] [003/133] (942s left) gem_exec_schedule (preempt)
[75.222349] Starting subtest: preempt
[75.224184] Starting dynamic subtest: rcs0
[75.246332] Dynamic subtest rcs0: SUCCESS (0.026s)
[75.255824] Starting dynamic subtest: bcs0
[75.264695] Dynamic subtest bcs0: SUCCESS (0.018s)
[75.271995] Starting dynamic subtest: vcs0
[75.285962] Dynamic subtest vcs0: SUCCESS (0.021s)
[75.293177] Starting dynamic subtest: vcs1
[75.311394] Dynamic subtest vcs1: SUCCESS (0.024s)
[75.319122] Starting dynamic subtest: vecs0
[75.331657] Dynamic subtest vecs0: SUCCESS (0.022s)
[75.338674] Starting dynamic subtest: ccs0
[75.353877] Dynamic subtest ccs0: SUCCESS (0.022s)
[75.355808] Subtest preempt: SUCCESS (0.136s)
[76.893568] [004/133] (941s left) api_intel_bb (misplaced-blitter)
[76.959663] Starting subtest: misplaced-blitter
[76.965060] Subtest misplaced-blitter: SUCCESS (0.007s)
[77.067867] [005/133] (940s left) gem_exec_reloc (basic-cpu-wc)
[77.119853] Subtest basic-cpu-wc: SKIP (0.000s)
[77.185820] [006/133] (940s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[77.287064] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[77.291602] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[77.436530] [007/133] (940s left) gem_exec_balancer (bonded-dual)
[77.494635] Starting subtest: bonded-dual
[77.499132] Subtest bonded-dual: SKIP (0.000s)
[77.769832] [008/133] (940s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[77.829257] Starting subtest: yf-tiled-ccs-to-y-tiled
[77.834025] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[78.011286] [009/133] (940s left) syncobj_wait (single-wait-all-submitted)
[78.070840] Starting subtest: single-wait-all-submitted
[78.171649] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[78.247334] [010/133] (939s left) syncobj_wait (invalid-signal-one-illegal-handle)
[78.305209] Starting subtest: invalid-signal-one-illegal-handle
[78.307200] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[78.396654] [011/133] (939s left) kms_cursor_edge_walk (256x256-top-bottom)
[78.466914] Starting subtest: 256x256-top-bottom
[78.469286] Starting dynamic subtest: pipe-A-eDP-1
[81.894200] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[81.902556] Starting dynamic subtest: pipe-D-eDP-1
[85.020953] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[85.023425] Subtest 256x256-top-bottom: SUCCESS (6.553s)
[85.826098] [012/133] (932s left) gem_wait (write-wait)
[85.885792] Starting subtest: write-wait
[85.888119] Starting dynamic subtest: all-engines
[87.016794] Dynamic subtest all-engines: SUCCESS (1.131s)
[87.033140] Starting dynamic subtest: rcs0
[88.072200] Dynamic subtest rcs0: SUCCESS (1.054s)
[88.087476] Starting dynamic subtest: bcs0
[89.131397] Dynamic subtest bcs0: SUCCESS (1.058s)
[89.147506] Starting dynamic subtest: vcs0
[90.186181] Dynamic subtest vcs0: SUCCESS (1.053s)
[90.200817] Starting dynamic subtest: vcs1
[91.242998] Dynamic subtest vcs1: SUCCESS (1.055s)
[91.258964] Starting dynamic subtest: vecs0
[92.296560] Dynamic subtest vecs0: SUCCESS (1.052s)
[92.312250] Starting dynamic subtest: ccs0
[93.353723] Dynamic subtest ccs0: SUCCESS (1.056s)
[93.356243] Subtest write-wait: SUCCESS (7.468s)
[93.573201] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[93.576909] [013/133] (924s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[93.674093] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[93.676392] Starting dynamic subtest: pipe-A-eDP-1
[126.140328] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.075s)
[126.149409] Starting dynamic subtest: pipe-B-eDP-1
[159.077366] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.825s)
[159.085687] Starting dynamic subtest: pipe-C-eDP-1
[192.074189] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.732s)
[192.082928] Starting dynamic subtest: pipe-D-eDP-1
[225.071729] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.754s)
[225.074019] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.389s)
[226.253454] [014/133] (792s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[226.337069] Starting subtest: fbcpsr-stridechange
[232.633739] Subtest fbcpsr-stridechange: SUCCESS (6.455s)
[232.755952] [015/133] (785s left) gem_fenced_exec_thrash (2-spare-fences)
[232.824919] Subtest 2-spare-fences: SKIP (0.000s)
[232.885153] [016/133] (785s left) gem_ctx_persistence (hang)
[232.947291] Starting subtest: hang
[232.951744] Subtest hang: SKIP (0.000s)
[233.040895] [017/133] (785s left) kms_setmode (basic-clone-single-crtc)
[233.094078] Starting subtest: basic-clone-single-crtc
[233.100412] Subtest basic-clone-single-crtc: SKIP (0.000s)
[233.196767] [018/133] (785s left) gem_ctx_engines (independent)
[233.262277] Starting subtest: independent
[233.264621] Starting dynamic subtest: rcs0
[233.400579] Dynamic subtest rcs0: SUCCESS (0.138s)
[233.410167] Starting dynamic subtest: bcs0
[233.500382] Dynamic subtest bcs0: SUCCESS (0.101s)
[233.509911] Starting dynamic subtest: vcs0
[233.615180] Dynamic subtest vcs0: SUCCESS (0.115s)
[233.625938] Starting dynamic subtest: vcs1
[233.744579] Dynamic subtest vcs1: SUCCESS (0.131s)
[233.756142] Starting dynamic subtest: vecs0
[233.862703] Dynamic subtest vecs0: SUCCESS (0.119s)
[233.873995] Starting dynamic subtest: ccs0
[233.990480] Dynamic subtest ccs0: SUCCESS (0.129s)
[234.001973] Starting dynamic subtest: all-engines
[234.470449] Dynamic subtest all-engines: SUCCESS (0.485s)
[234.473507] Subtest independent: SUCCESS (1.223s)
[235.458165] [019/133] (783s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[235.527395] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[235.531771] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[235.597895] [020/133] (783s left) gem_mmap_wc (write-cpu-read-wc)
[235.655330] Subtest write-cpu-read-wc: SKIP (0.000s)
[235.710408] [021/133] (782s left) kms_invalid_mode (bad-hsync-end)
[235.789892] Starting subtest: bad-hsync-end
[235.792386] Starting dynamic subtest: pipe-A-eDP-1
[236.079040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[236.087999] Starting dynamic subtest: pipe-B-eDP-1
[236.089970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[236.097515] Starting dynamic subtest: pipe-C-eDP-1
[236.099478] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[236.107437] Starting dynamic subtest: pipe-D-eDP-1
[236.109753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.112090] Subtest bad-hsync-end: SUCCESS (0.299s)
[236.911225] [022/133] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[237.007093] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[237.011311] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[237.098561] [023/133] (781s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[237.170932] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[237.175128] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[237.276102] [024/133] (781s left) gem_eio (hibernate)
[237.496628] Starting subtest: hibernate
[250.923095] Subtest hibernate: SUCCESS (13.483s)
[259.060751] [025/133] (767s left) gem_mmap_gtt (bad-object)
[259.137267] Subtest bad-object: SKIP (0.000s)
[259.193063] [026/133] (767s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[259.272330] Starting subtest: fbc-pr-cursor-plane-update-sf
[259.276422] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[259.349113] [027/133] (767s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[259.424766] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[259.427022] Starting dynamic subtest: pipe-A-eDP-1
[259.450408] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[259.460985] Starting dynamic subtest: pipe-B-eDP-1
[259.482969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[259.491936] Starting dynamic subtest: pipe-C-eDP-1
[259.513898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.522796] Starting dynamic subtest: pipe-D-eDP-1
[259.544881] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.548874] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[261.661249] [028/133] (765s left) gem_ctx_param (invalid-ctx-get)
[261.720892] Starting subtest: invalid-ctx-get
[261.722775] Subtest invalid-ctx-get: SUCCESS (0.000s)
[261.809551] [029/133] (765s left) gem_exec_params (rs-invalid)
[261.868905] Starting subtest: rs-invalid
[261.871161] Subtest rs-invalid: SUCCESS (0.001s)
[262.005166] [030/133] (765s left) sw_sync (sync_multi_consumer)
[262.044699] Starting subtest: sync_multi_consumer
[262.472788] Subtest sync_multi_consumer: SUCCESS (0.433s)
[262.541826] [031/133] (764s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[262.617328] Starting subtest: fbc-pr-sprite-mmap-cpu
[262.621825] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[262.703336] [032/133] (764s left) gem_mmap_offset (basic-uaf)
[262.767024] Starting subtest: basic-uaf
[262.769376] Subtest basic-uaf: SUCCESS (0.001s)
[262.871716] [033/133] (764s left) kms_chamelium_color (ctm-blue-to-red)
[262.939763] Subtest ctm-blue-to-red: SKIP (0.000s)
[262.985146] [034/133] (764s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[263.082501] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[263.928280] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[264.104675] [035/133] (763s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[264.209506] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[265.204825] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.994s)
[266.012691] [036/133] (761s left) gen9_exec_parse (allowed-all)
[266.066978] Subtest allowed-all: SKIP (0.000s)
[266.144407] [037/133] (761s left) kms_getfb (getfb2-handle-closed)
[266.215964] Starting subtest: getfb2-handle-closed
[266.218236] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[266.319528] [038/133] (761s left) syncobj_timeline (invalid-query-illegal-handle)
[266.377689] Starting subtest: invalid-query-illegal-handle
[266.380012] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[266.488891] [039/133] (760s left) kms_async_flips (test-cursor-atomic)
[266.566692] Starting subtest: test-cursor-atomic
[266.962443] Starting dynamic subtest: pipe-A-eDP-1
[267.683813] Dynamic subtest pipe-A-eDP-1: SKIP (0.719s)
[268.069410] Starting dynamic subtest: pipe-B-eDP-1
[268.816009] Dynamic subtest pipe-B-eDP-1: SKIP (0.751s)
[269.187711] Starting dynamic subtest: pipe-C-eDP-1
[269.948100] Dynamic subtest pipe-C-eDP-1: SKIP (0.765s)
[270.312274] Starting dynamic subtest: pipe-D-eDP-1
[271.071990] Dynamic subtest pipe-D-eDP-1: SKIP (0.766s)
[271.076588] Subtest test-cursor-atomic: SKIP (4.506s)
[272.251639] [040/133] (755s left) kms_cursor_crc (cursor-onscreen-32x10)
[272.404277] Starting subtest: cursor-onscreen-32x10
[272.448016] Subtest cursor-onscreen-32x10: SKIP (0.039s)
[272.752554] [041/133] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[272.831901] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[272.836209] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[272.929880] [042/133] (754s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[273.043145] Starting subtest: cursorA-vs-flipA-legacy
[284.163738] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.127s)
[284.974617] [043/133] (742s left) kms_atomic_interruptible (legacy-cursor)
[285.050315] Starting subtest: legacy-cursor
[285.052569] Starting dynamic subtest: pipe-A-eDP-1
[292.495104] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.446s)
[292.497321] Subtest legacy-cursor: SUCCESS (7.447s)
[293.371198] [044/133] (734s left) gem_mmap_gtt (medium-copy-odd)
[293.439847] Subtest medium-copy-odd: SKIP (0.000s)
[293.502089] [045/133] (734s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[293.581173] Starting subtest: 4-tiled-64bpp-rotate-0
[295.193398] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.613s)
[295.341351] [046/133] (732s left) i915_selftest (mock)
[298.634885] Starting subtest: mock
[298.637364] Starting dynamic subtest: sanitycheck
[299.272550] Dynamic subtest sanitycheck: SUCCESS (0.637s)
[299.282789] Starting dynamic subtest: shmem
[299.901807] Dynamic subtest shmem: SUCCESS (0.628s)
[299.912274] Starting dynamic subtest: fence
[307.431848] Dynamic subtest fence: SUCCESS (7.531s)
[307.442103] Starting dynamic subtest: scatterlist
[309.060528] Dynamic subtest scatterlist: SUCCESS (1.627s)
[309.070814] Starting dynamic subtest: syncmap
[312.242386] Dynamic subtest syncmap: SUCCESS (3.181s)
[312.252783] Starting dynamic subtest: uncore
[312.919971] Dynamic subtest uncore: SUCCESS (0.676s)
[312.930299] Starting dynamic subtest: ring
[313.577799] Dynamic subtest ring: SUCCESS (0.655s)
[313.587819] Starting dynamic subtest: engine
[314.230870] Dynamic subtest engine: SUCCESS (0.651s)
[314.240732] Starting dynamic subtest: timelines
[317.969450] Dynamic subtest timelines: SUCCESS (3.738s)
[317.979069] Starting dynamic subtest: requests
[321.427064] Dynamic subtest requests: SUCCESS (3.458s)
[321.441994] Starting dynamic subtest: objects
[322.169890] Dynamic subtest objects: SUCCESS (0.742s)
[322.179546] Starting dynamic subtest: phys
[322.904768] Dynamic subtest phys: SUCCESS (0.733s)
[322.914549] Starting dynamic subtest: dmabuf
[323.706929] Dynamic subtest dmabuf: SUCCESS (0.801s)
[323.717117] Starting dynamic subtest: vma
[329.216060] Dynamic subtest vma: SUCCESS (5.510s)
[329.224884] Starting dynamic subtest: evict
[330.581804] Dynamic subtest evict: SUCCESS (1.365s)
[330.591732] Starting dynamic subtest: gtt
[334.129887] Dynamic subtest gtt: SUCCESS (3.548s)
[334.140079] Starting dynamic subtest: hugepages
[334.981694] Dynamic subtest hugepages: SUCCESS (0.851s)
[334.991847] Starting dynamic subtest: memory_region
[337.349026] Dynamic subtest memory_region: SUCCESS (2.367s)
[337.352136] Subtest mock: SUCCESS (38.735s)
[337.381402] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[337.382089] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[337.385465] [047/133] (690s left) perf (invalid-remove-userspace-config)
[338.914127] Starting subtest: invalid-remove-userspace-config
[338.923444] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[338.963516] [FACT perf (invalid-remove-userspace-config)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[338.964612] [FACT perf (invalid-remove-userspace-config)] new: kernel.kmod_is_loaded.i915: true
[338.968071] [048/133] (688s left) syncobj_timeline (multi-wait-for-submit-signaled)
[339.035928] Starting subtest: multi-wait-for-submit-signaled
[339.038262] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[339.159723] [049/133] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[339.232890] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[339.236762] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[339.333489] [050/133] (688s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[339.399270] Starting subtest: plane-scaler-unity-scaling-with-rotation
[339.401514] Starting dynamic subtest: pipe-A
[339.637111] Dynamic subtest pipe-A: SUCCESS (0.239s)
[339.646711] Starting dynamic subtest: pipe-B
[340.917761] Dynamic subtest pipe-B: SUCCESS (1.280s)
[340.927910] Starting dynamic subtest: pipe-C
[342.249085] Dynamic subtest pipe-C: SUCCESS (1.331s)
[342.260634] Starting dynamic subtest: pipe-D
[343.580166] Dynamic subtest pipe-D: SUCCESS (1.330s)
[343.582462] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.185s)
[344.760436] [051/133] (683s left) gem_bad_reloc (negative-reloc)
[344.823182] Subtest negative-reloc: SKIP (0.000s)
[344.891269] [052/133] (683s left) kms_prime (d3hot)
[344.955672] Subtest D3hot: SKIP (0.000s)
[345.049574] [053/133] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[345.126681] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[345.130719] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[345.224034] [054/133] (682s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[345.300058] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[345.302388] Starting dynamic subtest: pipe-A-eDP-1
[345.359769] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[345.369523] Starting dynamic subtest: pipe-B-eDP-1
[345.426037] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[345.436097] Starting dynamic subtest: pipe-C-eDP-1
[345.497099] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[345.508560] Starting dynamic subtest: pipe-D-eDP-1
[345.564716] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[345.568821] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[347.619026] [055/133] (680s left) gem_exec_whisper (basic-sync-all)
[347.686149] Starting subtest: basic-sync-all
[353.721270] Subtest basic-sync-all: SUCCESS (6.036s)
[353.906835] [056/133] (674s left) gem_spin_batch (legacy-resubmit)
[353.971437] Starting subtest: legacy-resubmit
[353.975102] Starting dynamic subtest: default
[353.977481] Dynamic subtest default: SUCCESS (0.009s)
[353.991711] Starting dynamic subtest: render
[353.993963] Dynamic subtest render: SUCCESS (0.002s)
[354.003571] Starting dynamic subtest: bsd
[354.005973] Dynamic subtest bsd: SUCCESS (0.004s)
[354.015419] Starting dynamic subtest: bsd1
[354.017710] Dynamic subtest bsd1: SUCCESS (0.003s)
[354.026473] Starting dynamic subtest: bsd2
[354.028778] Dynamic subtest bsd2: SUCCESS (0.001s)
[354.037649] Starting dynamic subtest: blt
[354.039971] Dynamic subtest blt: SUCCESS (0.004s)
[354.048803] Starting dynamic subtest: vebox
[354.050908] Dynamic subtest vebox: SUCCESS (0.003s)
[354.053039] Subtest legacy-resubmit: SUCCESS (0.031s)
[354.228271] [057/133] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[354.324130] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[358.595398] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.276s)
[359.812678] [058/133] (668s left) kms_plane_scaling (planes-downscale-factor-0-5)
[359.889153] Starting subtest: planes-downscale-factor-0-5
[359.891502] Starting dynamic subtest: pipe-A
[359.910548] Dynamic subtest pipe-A: SKIP (0.017s)
[359.927253] Starting dynamic subtest: pipe-B
[359.940929] Dynamic subtest pipe-B: SKIP (0.030s)
[359.953050] Starting dynamic subtest: pipe-C
[359.968473] Dynamic subtest pipe-C: SKIP (0.028s)
[359.977883] Starting dynamic subtest: pipe-D
[359.998233] Dynamic subtest pipe-D: SKIP (0.029s)
[360.002492] Subtest planes-downscale-factor-0-5: SKIP (0.106s)
[360.101920] [059/133] (668s left) kms_flip (basic-flip-vs-dpms)
[360.173913] Starting subtest: basic-flip-vs-dpms
[360.175889] Starting dynamic subtest: A-eDP1
[362.794379] Dynamic subtest A-eDP1: SUCCESS (2.622s)
[362.805871] Starting dynamic subtest: B-eDP1
[364.954567] Dynamic subtest B-eDP1: SUCCESS (2.157s)
[364.964319] Starting dynamic subtest: C-eDP1
[367.031252] Dynamic subtest C-eDP1: SUCCESS (2.077s)
[367.041548] Starting dynamic subtest: D-eDP1
[369.099430] Dynamic subtest D-eDP1: SUCCESS (2.068s)
[369.104277] Subtest basic-flip-vs-dpms: SUCCESS (8.936s)
[369.895330] [060/133] (658s left) gem_exec_whisper (basic-queues)
[369.971520] Starting subtest: basic-queues
[374.814572] Subtest basic-queues: SUCCESS (4.841s)
[374.996197] [061/133] (653s left) gem_mmap_gtt (basic-small-bo)
[375.061317] Subtest basic-small-bo: SKIP (0.000s)
[375.129406] [062/133] (653s left) i915_hangman (detector)
[375.206984] Starting subtest: detector
[375.208840] Starting dynamic subtest: rcs0
[385.293737] Dynamic subtest rcs0: SUCCESS (10.092s)
[385.310265] Starting dynamic subtest: bcs0
[396.239127] Dynamic subtest bcs0: SUCCESS (10.949s)
[396.252558] Starting dynamic subtest: vcs0
[407.309108] Dynamic subtest vcs0: SUCCESS (11.072s)
[407.322520] Starting dynamic subtest: vcs1
[419.278150] Dynamic subtest vcs1: SUCCESS (11.972s)
[419.293284] Starting dynamic subtest: vecs0
[431.243881] Dynamic subtest vecs0: SUCCESS (11.969s)
[431.256895] Starting dynamic subtest: ccs0
[442.252469] Dynamic subtest ccs0: SUCCESS (11.011s)
[442.255146] Subtest detector: SUCCESS (67.082s)
[442.378485] [063/133] (586s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[442.475728] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[442.479807] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[442.556704] [064/133] (585s left) vgem_basic (setversion)
[442.608168] Starting subtest: setversion
[442.612188] Subtest setversion: SUCCESS (0.000s)
[442.665063] [065/133] (585s left) perf_pmu (busy-accuracy-2)
[442.710592] Starting subtest: busy-accuracy-2
[442.712780] Starting dynamic subtest: rcs0
[445.755752] Dynamic subtest rcs0: SUCCESS (3.046s)
[445.766775] Starting dynamic subtest: bcs0
[448.812009] Dynamic subtest bcs0: SUCCESS (3.057s)
[448.823006] Starting dynamic subtest: vcs0
[451.856752] Dynamic subtest vcs0: SUCCESS (3.045s)
[451.867810] Starting dynamic subtest: vcs1
[454.906356] Dynamic subtest vcs1: SUCCESS (3.048s)
[454.917471] Starting dynamic subtest: vecs0
[457.951336] Dynamic subtest vecs0: SUCCESS (3.044s)
[457.964495] Starting dynamic subtest: ccs0
[461.009295] Dynamic subtest ccs0: SUCCESS (3.057s)
[461.011718] Subtest busy-accuracy-2: SUCCESS (18.310s)
[461.128526] [066/133] (567s left) kms_chamelium_hpd (dp-hpd)
[461.511023] Subtest dp-hpd: SKIP (0.000s)
[462.357141] [067/133] (566s left) kms_psr (psr-cursor-plane-move)
[462.428549] Starting subtest: psr-cursor-plane-move
[462.430804] Starting dynamic subtest: eDP-1
[464.167716] Dynamic subtest eDP-1: SUCCESS (1.740s)
[464.169882] Subtest psr-cursor-plane-move: SUCCESS (1.741s)
[465.044910] [068/133] (563s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[465.145131] Starting subtest: basic-busy-flip-before-cursor-legacy
[465.149823] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[465.290022] [069/133] (563s left) gem_pwrite (basic-self)
[465.342080] Subtest basic-self: SKIP (0.000s)
[465.399489] [070/133] (563s left) gem_ctx_persistence (engines-mixed-process)
[465.463949] Starting subtest: engines-mixed-process
[465.466121] Starting dynamic subtest: rcs0
[467.293264] Dynamic subtest rcs0: SUCCESS (1.830s)
[467.303876] Starting dynamic subtest: bcs0
[469.288699] Dynamic subtest bcs0: SUCCESS (1.998s)
[469.303086] Starting dynamic subtest: vcs0
[471.279682] Dynamic subtest vcs0: SUCCESS (1.991s)
[471.291992] Starting dynamic subtest: vcs1
[473.273352] Dynamic subtest vcs1: SUCCESS (1.992s)
[473.285949] Starting dynamic subtest: vecs0
[475.292958] Dynamic subtest vecs0: SUCCESS (2.018s)
[475.303928] Starting dynamic subtest: ccs0
[477.314480] Dynamic subtest ccs0: SUCCESS (2.021s)
[477.316981] Subtest engines-mixed-process: SUCCESS (11.860s)
[477.397736] [071/133] (551s left) gem_ctx_param (basic-default)
[477.451371] Starting subtest: basic-default
[477.453639] Subtest basic-default: SUCCESS (0.000s)
[477.527727] [072/133] (551s left) kms_dsc (dsc-with-bpc)
[477.606903] Starting subtest: dsc-with-bpc
[477.637825] Subtest dsc-with-bpc: SKIP (0.001s)
[477.680776] [073/133] (551s left) syncobj_timeline (wait-zero-handles)
[477.745096] Starting subtest: wait-zero-handles
[477.747330] Subtest wait-zero-handles: SUCCESS (0.000s)
[477.848767] [074/133] (551s left) kms_cursor_crc (cursor-size-hints)
[477.967317] Starting subtest: cursor-size-hints
[477.969467] Starting dynamic subtest: pipe-A-eDP-1
[478.587405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[478.597199] Starting dynamic subtest: pipe-D-eDP-1
[479.890574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s)
[479.892943] Subtest cursor-size-hints: SUCCESS (1.923s)
[480.686345] [075/133] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[480.773589] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[490.275217] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.395s)
[490.414716] [076/133] (538s left) gem_softpin (evict-snoop)
[490.494936] Starting subtest: evict-snoop
[490.499714] Subtest evict-snoop: SKIP (0.000s)
[490.620321] [077/133] (538s left) dumb_buffer (invalid-bpp)
[490.682091] Starting subtest: invalid-bpp
[490.684025] Subtest invalid-bpp: SUCCESS (0.000s)
[490.776524] [078/133] (538s left) kms_vblank (wait-busy-hang)
[490.859623] Starting subtest: wait-busy-hang
[490.862408] Starting dynamic subtest: pipe-A-eDP-1
[517.111259] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.185s)
[517.126556] Starting dynamic subtest: pipe-D-eDP-1
[542.149259] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s)
[542.151549] Subtest wait-busy-hang: SUCCESS (51.213s)
[542.963559] [079/133] (486s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[543.029798] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[543.032108] Starting dynamic subtest: pipe-A-default-mode
[545.832896] Dynamic subtest pipe-A-default-mode: SUCCESS (2.799s)
[545.834729] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.801s)
[546.668009] [080/133] (482s left) vgem_basic (dmabuf-mmap)
[546.716489] Starting subtest: dmabuf-mmap
[546.730497] Subtest dmabuf-mmap: SUCCESS (0.016s)
[546.787356] [081/133] (482s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[546.865876] Starting subtest: yf-tiled-32bpp-rotate-90
[546.870311] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[546.967666] [082/133] (482s left) kms_chamelium_edid (hdmi-mode-timings)
[547.330759] Subtest hdmi-mode-timings: SKIP (0.000s)
[548.170596] [083/133] (481s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[548.263401] Starting subtest: fbcpsr-modesetfrombusy
[554.487886] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.228s)
[554.625769] [084/133] (474s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[554.698924] Starting subtest: primary-yf-tiled-reflect-x-270
[554.702760] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[554.776598] [085/133] (474s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[554.852529] Starting subtest: blocking-absolute-wf_vblank-interruptible
[554.856507] Starting dynamic subtest: A-eDP1
[563.610273] Dynamic subtest A-eDP1: SUCCESS (8.751s)
[563.620560] Starting dynamic subtest: B-eDP1
[572.350748] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[572.365889] Starting dynamic subtest: C-eDP1
[581.064397] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[581.086238] Starting dynamic subtest: D-eDP1
[589.782758] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[589.788711] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.928s)
[590.991596] [086/133] (438s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[591.077953] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[591.081941] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[591.169134] [087/133] (438s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[591.255602] Starting subtest: x-tiled-64bpp-rotate-180
[592.734450] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.479s)
[592.888709] [088/133] (436s left) perf_pmu (busy-start)
[592.934707] Starting subtest: busy-start
[592.937500] Starting dynamic subtest: rcs0
[595.485271] Dynamic subtest rcs0: SUCCESS (2.552s)
[595.500892] Starting dynamic subtest: bcs0
[598.037420] Dynamic subtest bcs0: SUCCESS (2.551s)
[598.050677] Starting dynamic subtest: vcs0
[601.262110] Dynamic subtest vcs0: SUCCESS (3.222s)
[601.275369] Starting dynamic subtest: vcs1
[605.293868] Dynamic subtest vcs1: SUCCESS (4.031s)
[605.311553] Starting dynamic subtest: vecs0
[609.261890] Dynamic subtest vecs0: SUCCESS (3.966s)
[609.275336] Starting dynamic subtest: ccs0
[611.812299] Dynamic subtest ccs0: SUCCESS (2.550s)
[611.814976] Subtest busy-start: SUCCESS (18.885s)
[611.917299] [089/133] (417s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[612.503562] Starting subtest: syncobj-timeline-multiple-ext-nodes
[612.509732] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.008s)
[614.371891] [090/133] (415s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[614.456246] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[614.463383] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.007s)
[614.548844] [091/133] (415s left) kms_color (ctm-max)
[614.637982] Starting subtest: ctm-max
[614.640028] Starting dynamic subtest: pipe-A-eDP-1
[615.346713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[615.357938] Starting dynamic subtest: pipe-B-eDP-1
[616.820499] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.472s)
[616.834351] Starting dynamic subtest: pipe-C-eDP-1
[618.181057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[618.192177] Starting dynamic subtest: pipe-D-eDP-1
[619.518102] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[619.520438] Subtest ctm-max: SUCCESS (4.881s)
[620.315823] [092/133] (409s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[620.395594] Starting subtest: pixel-format-linear-modifier-source-clamping
[620.424218] Starting dynamic subtest: pipe-A-plane-0
[623.998289] Dynamic subtest pipe-A-plane-0: SUCCESS (3.577s)
[624.011238] Starting dynamic subtest: pipe-A-plane-3
[625.720383] Dynamic subtest pipe-A-plane-3: SUCCESS (1.722s)
[626.804317] Starting dynamic subtest: pipe-B-plane-0
[630.284341] Dynamic subtest pipe-B-plane-0: SUCCESS (3.489s)
[630.293901] Starting dynamic subtest: pipe-B-plane-3
[631.929051] Dynamic subtest pipe-B-plane-3: SUCCESS (1.643s)
[632.246302] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.851s)
[633.088125] [093/133] (396s left) tools_test (sysfs_l3_parity)
[633.144652] Starting subtest: sysfs_l3_parity
[633.213413] Subtest sysfs_l3_parity: SKIP (0.081s)
[633.268948] [094/133] (396s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[633.353262] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[633.357356] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[633.457217] [095/133] (396s left) kms_vblank (query-busy-hang)
[633.532732] Starting subtest: query-busy-hang
[633.534859] Starting dynamic subtest: pipe-A-eDP-1
[660.142173] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.603s)
[660.157261] Starting dynamic subtest: pipe-D-eDP-1
[675.123625] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[675.126000] Subtest query-busy-hang: SUCCESS (41.581s)
[675.931438] [096/133] (353s left) gem_exec_reloc (basic-softpin)
[676.004255] Subtest basic-softpin: SKIP (0.000s)
[676.094348] [097/133] (353s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[676.171108] Starting subtest: addfb25-yf-tiled-legacy
[676.173285] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[676.265918] [098/133] (353s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[676.359120] Starting subtest: fbc-rgb565-draw-mmap-cpu
[680.349642] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.992s)
[681.557117] [099/133] (348s left) gem_flink_basic (flink-lifetime)
[681.616013] Starting subtest: flink-lifetime
[681.618430] Subtest flink-lifetime: SUCCESS (0.002s)
[681.735386] [100/133] (348s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[681.822892] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[682.803026] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.982s)
[682.996102] [101/133] (347s left) gem_exec_flush (basic-wb-ro-default)
[683.053871] Starting subtest: basic-wb-ro-default
[688.530561] Subtest basic-wb-ro-default: SUCCESS (5.475s)
[688.721481] [102/133] (341s left) syncobj_timeline (single-wait-available-submitted)
[688.777431] Starting subtest: single-wait-available-submitted
[688.779878] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[688.888089] [103/133] (341s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[688.963120] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[695.434539] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.471s)
[695.549427] [104/133] (334s left) kms_flip (flip-vs-panning-interruptible)
[695.625525] Starting subtest: flip-vs-panning-interruptible
[695.627969] Starting dynamic subtest: A-eDP1
[704.371477] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[704.391908] Starting dynamic subtest: B-eDP1
[713.117361] Dynamic subtest B-eDP1: SUCCESS (8.744s)
[713.129347] Starting dynamic subtest: C-eDP1
[721.825689] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[721.837846] Starting dynamic subtest: D-eDP1
[730.476162] Dynamic subtest D-eDP1: SUCCESS (8.650s)
[730.480123] Subtest flip-vs-panning-interruptible: SUCCESS (34.856s)
[731.642747] [105/133] (298s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[731.698999] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[731.802928] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[731.900072] [106/133] (298s left) kms_flip (flip-vs-dpms-on-nop)
[731.978824] Starting subtest: flip-vs-dpms-on-nop
[731.981123] Starting dynamic subtest: A-eDP1
[733.835478] Dynamic subtest A-eDP1: SUCCESS (1.858s)
[733.846916] Starting dynamic subtest: B-eDP1
[735.667530] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[735.679540] Starting dynamic subtest: C-eDP1
[737.512061] Dynamic subtest C-eDP1: SUCCESS (1.842s)
[737.523711] Starting dynamic subtest: D-eDP1
[739.349941] Dynamic subtest D-eDP1: SUCCESS (1.837s)
[739.352398] Subtest flip-vs-dpms-on-nop: SUCCESS (7.377s)
[740.554105] [107/133] (289s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[740.637464] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[740.641642] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[740.733037] [108/133] (289s left) gem_exec_params (cliprects_ptr-dirt)
[740.790113] Starting subtest: cliprects_ptr-dirt
[740.792369] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[740.905273] [109/133] (289s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[740.992545] Starting subtest: y-tiled-64bpp-rotate-0
[740.996953] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[741.077600] [110/133] (289s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[741.152131] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[741.154356] Starting dynamic subtest: pipe-A-eDP-1
[741.173457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[741.186997] Starting dynamic subtest: pipe-B-eDP-1
[741.205773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[741.215746] Starting dynamic subtest: pipe-C-eDP-1
[741.234253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[741.243771] Starting dynamic subtest: pipe-D-eDP-1
[741.263287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[741.265552] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[743.417259] [111/133] (287s left) testdisplay
[743.709877] [112/133] (286s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[743.763366] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[743.828071] [113/133] (286s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[743.906892] Starting subtest: basic-max-pipe-crc-check
[743.911220] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[743.956297] [114/133] (286s left) kms_pm_dc (dc5-dpms)
[745.029502] Starting subtest: dc5-dpms
[747.075908] Subtest dc5-dpms: SUCCESS (2.045s)
[747.153183] [115/133] (283s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[747.211761] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[747.313707] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[747.404291] [116/133] (283s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[747.484456] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[747.488603] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[747.575530] [117/133] (283s left) kms_flip (dpms-vs-vblank-race-interruptible)
[747.658018] Starting subtest: dpms-vs-vblank-race-interruptible
[747.660379] Starting dynamic subtest: A-eDP1
[751.571771] Dynamic subtest A-eDP1: SUCCESS (3.911s)
[751.583365] Starting dynamic subtest: B-eDP1
[756.214941] Dynamic subtest B-eDP1: SUCCESS (4.642s)
[756.225788] Starting dynamic subtest: C-eDP1
[760.824339] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[760.835056] Starting dynamic subtest: D-eDP1
[765.465196] Dynamic subtest D-eDP1: SUCCESS (4.639s)
[765.467372] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.808s)
[766.342425] [118/133] (264s left) kms_psr2_su (page_flip-p010)
[766.404645] Subtest page_flip-P010: SKIP (0.000s)
[766.475186] [119/133] (264s left) kms_psr (pr-suspend)
[766.559536] Starting subtest: pr-suspend
[766.564025] Subtest pr-suspend: SKIP (0.000s)
[766.635382] [120/133] (264s left) kms_content_protection (lic-type-0)
[766.762897] Starting subtest: lic-type-0
[766.767410] Subtest lic-type-0: SKIP (0.000s)
[766.881763] [121/133] (264s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[766.966289] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[773.682673] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.722s)
[773.822691] [122/133] (257s left) prime_busy (before)
[773.890028] Starting subtest: before
[773.892322] Starting dynamic subtest: rcs0
[773.923846] Dynamic subtest rcs0: SUCCESS (0.034s)
[773.936413] Starting dynamic subtest: bcs0
[773.975027] Dynamic subtest bcs0: SUCCESS (0.051s)
[773.986766] Starting dynamic subtest: vcs0
[774.016702] Dynamic subtest vcs0: SUCCESS (0.041s)
[774.026914] Starting dynamic subtest: vcs1
[774.058230] Dynamic subtest vcs1: SUCCESS (0.041s)
[774.068506] Starting dynamic subtest: vecs0
[774.099749] Dynamic subtest vecs0: SUCCESS (0.041s)
[774.109742] Starting dynamic subtest: ccs0
[774.140412] Dynamic subtest ccs0: SUCCESS (0.040s)
[774.249224] Subtest before: SUCCESS (0.360s)
[774.325044] [123/133] (256s left) api_intel_allocator (standalone)
[774.393393] Starting subtest: standalone
[774.407549] Subtest standalone: SUCCESS (0.017s)
[774.540046] [124/133] (256s left) perf (invalid-oa-exponent)
[774.624752] Starting subtest: invalid-oa-exponent
[774.639798] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[774.679551] [125/133] (256s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[776.478842] Starting subtest: gem-execbuf-stress-pc8
[776.519795] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[776.882457] [126/133] (254s left) kms_psr (fbc-psr-sprite-blt)
[776.967618] Starting subtest: fbc-psr-sprite-blt
[776.969906] Starting dynamic subtest: eDP-1
[776.973919] Dynamic subtest eDP-1: SKIP (0.000s)
[776.977908] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[777.042056] [127/133] (254s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[777.138265] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[777.142293] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[777.228025] [128/133] (253s left) gem_exec_create (legacy)
[777.296244] Starting subtest: legacy
[777.298581] Starting dynamic subtest: smem
[781.293954] Dynamic subtest smem: SUCCESS (3.996s)
[781.296439] Subtest legacy: SUCCESS (3.998s)
[781.494764] [129/133] (249s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[781.631528] Starting subtest: verify-pxp-stale-buf-optout-execution
[782.694769] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.065s)
[782.815043] [130/133] (248s left) gem_exec_schedule (u-semaphore-resolve)
[782.877571] Starting subtest: u-semaphore-resolve
[782.936370] Subtest u-semaphore-resolve: SUCCESS (0.064s)
[783.275259] [131/133] (248s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[783.379797] Starting subtest: cursor-vs-flip-toggle
[814.147872] Subtest cursor-vs-flip-toggle: SUCCESS (30.761s)
[815.024824] [132/133] (216s left) gem_ctx_shared (q-out-order)
[815.087954] Starting subtest: Q-out-order
[815.090268] Starting dynamic subtest: rcs0
[815.211215] Dynamic subtest rcs0: SUCCESS (0.121s)
[815.225511] Starting dynamic subtest: vcs0
[815.309394] Dynamic subtest vcs0: SUCCESS (0.098s)
[815.328563] Starting dynamic subtest: vcs1
[815.395891] Dynamic subtest vcs1: SUCCESS (0.086s)
[815.416803] Starting dynamic subtest: vecs0
[815.480423] Dynamic subtest vecs0: SUCCESS (0.084s)
[815.498474] Starting dynamic subtest: ccs0
[815.570726] Dynamic subtest ccs0: SUCCESS (0.089s)
[815.573410] Subtest Q-out-order: SUCCESS (0.482s)
[816.384027] [133/133] (215s left) kms_lease (lease-again)
[816.464280] Starting subtest: lease-again
[816.466560] Starting dynamic subtest: pipe-A-eDP-1
[816.468831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[816.480715] Starting dynamic subtest: pipe-B-eDP-1
[816.482873] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[816.493306] Starting dynamic subtest: pipe-C-eDP-1
[816.495518] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[816.505980] Starting dynamic subtest: pipe-D-eDP-1
[816.508198] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[816.510405] Subtest lease-again: SUCCESS (0.013s)
[816.571100] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_cursor_edge_walk
results: parsing output: 11/ for test: gem_wait
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_fenced_exec_thrash
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_setmode
results: parsing output: 17/ for test: gem_ctx_engines
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_invalid_mode
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_chamelium_color
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: gen9_exec_parse
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_async_flips
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_atomic_interruptible
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: i915_selftest
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: gem_bad_reloc
results: parsing output: 51/ for test: kms_prime
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: gem_spin_batch
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: gem_exec_whisper
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: i915_hangman
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: vgem_basic
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_pwrite
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_dsc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: dumb_buffer
results: parsing output: 77/ for test: kms_vblank
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: tools_test
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_flink_basic
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: testdisplay
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_multipipe_modeset
results: parsing output: 113/ for test: kms_pm_dc
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_psr2_su
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_busy
results: parsing output: 122/ for test: api_intel_allocator
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_create
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: gem_ctx_shared
results: parsing output: 132/ for test: kms_lease
Done.