[120.316750] Initializing watchdogs
[120.316831]   /dev/watchdog0
[120.330704] [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]
[120.334782] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[120.337190] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[120.340596] [001/131] (960s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[120.462088] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[120.464444] Starting dynamic subtest: pipe-A-eDP-1
[120.487489] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[120.497618] Starting dynamic subtest: pipe-B-eDP-1
[120.518561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.525902] Starting dynamic subtest: pipe-C-eDP-1
[120.547746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.556137] Starting dynamic subtest: pipe-D-eDP-1
[120.578430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[120.582759] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[122.740646] [002/131] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[122.846071] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[122.850344] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.976643] [003/131] (957s left) gem_ctx_persistence (engines-hang)
[123.043687] Starting subtest: engines-hang
[123.046026] Starting dynamic subtest: rcs0
[123.213535] Dynamic subtest rcs0: SUCCESS (0.170s)
[123.223922] Starting dynamic subtest: bcs0
[123.346252] Dynamic subtest bcs0: SUCCESS (0.131s)
[123.356839] Starting dynamic subtest: vcs0
[123.469957] Dynamic subtest vcs0: SUCCESS (0.123s)
[123.480536] Starting dynamic subtest: vcs1
[123.593804] Dynamic subtest vcs1: SUCCESS (0.123s)
[123.604220] Starting dynamic subtest: vecs0
[123.721232] Dynamic subtest vecs0: SUCCESS (0.127s)
[123.728277] Starting dynamic subtest: ccs0
[123.842278] Dynamic subtest ccs0: SUCCESS (0.121s)
[123.844499] Subtest engines-hang: SUCCESS (0.799s)
[123.938539] [004/131] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[124.033358] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[124.036839] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[124.161236] [005/131] (956s left) kms_pipe_crc_basic (suspend-read-crc)
[124.252223] Starting subtest: suspend-read-crc
[124.254175] Starting dynamic subtest: pipe-A-eDP-1
[141.949526] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.190s)
[141.960171] Starting dynamic subtest: pipe-B-eDP-1
[159.960176] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.124s)
[159.968236] Starting dynamic subtest: pipe-C-eDP-1
[177.883056] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.072s)
[177.892761] Starting dynamic subtest: pipe-D-eDP-1
[195.885106] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.065s)
[195.888093] Subtest suspend-read-crc: SUCCESS (15.455s)
[196.775603] [006/131] (884s left) gem_readwrite (write-bad-handle)
[196.855680] Subtest write-bad-handle: SKIP (0.000s)
[196.919209] [007/131] (884s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[197.024856] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[197.029330] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[197.163194] [008/131] (883s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[197.270464] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[197.276055] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[197.408375] [009/131] (883s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[197.478096] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[197.480706] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[197.610863] [010/131] (883s left) kms_async_flips (test-cursor)
[197.703821] Starting subtest: test-cursor
[197.707793] Subtest test-cursor: SKIP (0.000s)
[198.941498] [011/131] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[199.054905] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[199.060040] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[199.196668] [012/131] (882s left) perf_pmu (busy-start)
[199.241424] Starting subtest: busy-start
[199.244105] Starting dynamic subtest: rcs0
[201.800077] Dynamic subtest rcs0: SUCCESS (2.528s)
[201.809205] Starting dynamic subtest: bcs0
[204.350228] Dynamic subtest bcs0: SUCCESS (2.528s)
[204.360737] Starting dynamic subtest: vcs0
[207.883912] Dynamic subtest vcs0: SUCCESS (3.509s)
[207.893989] Starting dynamic subtest: vcs1
[211.917124] Dynamic subtest vcs1: SUCCESS (4.017s)
[211.934223] Starting dynamic subtest: vecs0
[215.881785] Dynamic subtest vecs0: SUCCESS (3.953s)
[215.892133] Starting dynamic subtest: ccs0
[218.431102] Dynamic subtest ccs0: SUCCESS (2.545s)
[218.434612] Subtest busy-start: SUCCESS (19.087s)
[218.574218] [013/131] (862s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[218.644841] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[218.800848] [014/131] (862s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[218.914405] Starting subtest: extended-pageflip-modeset-hang-oldfb
[218.916999] Starting dynamic subtest: pipe-A
[226.861634] Dynamic subtest pipe-A: SUCCESS (7.937s)
[226.870496] Starting dynamic subtest: pipe-D
[235.440112] Dynamic subtest pipe-D: SUCCESS (8.577s)
[235.443054] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.518s)
[236.313863] [015/131] (845s left) kms_addfb_basic (unused-modifier)
[236.385042] Starting subtest: unused-modifier
[236.387536] Subtest unused-modifier: SUCCESS (0.000s)
[236.561955] [016/131] (844s left) gem_softpin (allocator-evict)
[236.622083] Starting subtest: allocator-evict
[236.624960] Starting dynamic subtest: rcs0
[259.645509] Dynamic subtest rcs0: SUCCESS (23.022s)
[259.658346] Starting dynamic subtest: bcs0
[283.438269] Dynamic subtest bcs0: SUCCESS (23.785s)
[283.448553] Starting dynamic subtest: vcs0
[307.207690] Dynamic subtest vcs0: SUCCESS (23.771s)
[307.219967] Starting dynamic subtest: vcs1
[330.849178] Dynamic subtest vcs1: SUCCESS (23.639s)
[330.866422] Starting dynamic subtest: vecs0
[354.534629] Dynamic subtest vecs0: SUCCESS (23.683s)
[354.547321] Starting dynamic subtest: ccs0
[377.939465] Dynamic subtest ccs0: SUCCESS (23.398s)
[377.942856] Subtest allocator-evict: SUCCESS (141.302s)
[378.048152] [017/131] (703s left) kms_hdr (static-swap)
[378.194744] Starting subtest: static-swap
[378.202845] Subtest static-swap: SKIP (0.000s)
[378.292318] [018/131] (703s left) kms_joiner (invalid-modeset-ultra-joiner)
[378.398088] Starting subtest: invalid-modeset-ultra-joiner
[378.403082] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[378.485859] [019/131] (703s left) kms_color (ctm-0-75)
[378.586684] Starting subtest: ctm-0-75
[378.588834] Starting dynamic subtest: pipe-A-eDP-1
[383.526034] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.940s)
[383.538107] Starting dynamic subtest: pipe-B-eDP-1
[389.178077] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.648s)
[389.187700] Starting dynamic subtest: pipe-C-eDP-1
[394.644101] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.466s)
[394.654710] Starting dynamic subtest: pipe-D-eDP-1
[399.970332] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.323s)
[399.973055] Subtest ctm-0-75: SUCCESS (21.379s)
[400.824793] [020/131] (680s left) gem_eio (wait-wedge-immediate)
[401.071061] Starting subtest: wait-wedge-immediate
[402.973207] Subtest wait-wedge-immediate: SUCCESS (1.900s)
[403.138922] [021/131] (678s left) kms_psr2_su (page_flip-nv12)
[403.201083] Subtest page_flip-NV12: SKIP (0.000s)
[403.255542] [022/131] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[403.344042] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[410.744497] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.403s)
[410.893317] [023/131] (670s left) kms_cursor_edge_walk (64x64-left-edge)
[410.980268] Starting subtest: 64x64-left-edge
[410.982489] Starting dynamic subtest: pipe-A-eDP-1
[414.443936] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[414.454636] Starting dynamic subtest: pipe-D-eDP-1
[417.634859] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.189s)
[417.637379] Subtest 64x64-left-edge: SUCCESS (6.652s)
[418.466358] [024/131] (663s left) kms_plane_scaling (planes-upscale-factor-0-25)
[418.567982] Starting subtest: planes-upscale-factor-0-25
[418.570751] Starting dynamic subtest: pipe-A
[418.628060] Dynamic subtest pipe-A: SUCCESS (0.062s)
[418.637860] Starting dynamic subtest: pipe-B
[419.751075] Dynamic subtest pipe-B: SUCCESS (1.121s)
[419.761949] Starting dynamic subtest: pipe-C
[420.861089] Dynamic subtest pipe-C: SUCCESS (1.110s)
[420.870941] Starting dynamic subtest: pipe-D
[422.000481] Dynamic subtest pipe-D: SUCCESS (1.138s)
[422.003074] Subtest planes-upscale-factor-0-25: SUCCESS (3.436s)
[423.178404] [025/131] (658s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[423.294346] Starting subtest: yf-tiled-16bpp-rotate-0
[423.299930] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[423.419353] [026/131] (658s left) gem_mmap_offset (bad-extensions)
[423.480835] Starting subtest: bad-extensions
[423.483799] Subtest bad-extensions: SUCCESS (0.000s)
[423.616609] [027/131] (658s left) kms_hdr (bpc-switch-dpms)
[423.714556] Starting subtest: bpc-switch-dpms
[424.832109] Starting dynamic subtest: pipe-A-eDP-1
[429.349183] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.521s)
[429.352047] Subtest bpc-switch-dpms: SUCCESS (5.640s)
[429.491779] [028/131] (652s left) gem_exec_reloc (basic-wc-gtt)
[429.566868] Subtest basic-wc-gtt: SKIP (0.000s)
[429.653080] [029/131] (652s left) syncobj_timeline (wait-all-for-submit-snapshot)
[429.736104] Starting subtest: wait-all-for-submit-snapshot
[429.814577] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[429.913585] [030/131] (652s left) syncobj_timeline (etime-multi-wait-all-submitted)
[429.982137] Starting subtest: etime-multi-wait-all-submitted
[430.086456] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[430.185386] [031/131] (651s left) dumb_buffer (map-invalid-size)
[430.254888] Starting subtest: map-invalid-size
[430.257906] Subtest map-invalid-size: SUCCESS (0.000s)
[430.403026] [032/131] (651s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[430.496912] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[430.499595] Starting dynamic subtest: pipe-A-eDP-1
[430.509674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[430.520748] Starting dynamic subtest: pipe-B-eDP-1
[430.531033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[430.540660] Starting dynamic subtest: pipe-C-eDP-1
[430.551198] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.560718] Starting dynamic subtest: pipe-D-eDP-1
[430.571035] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.576425] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[432.696658] [033/131] (649s left) gem_ctx_persistence (legacy-engines-queued)
[432.761699] Starting subtest: legacy-engines-queued
[432.764656] Starting dynamic subtest: render
[432.858164] Dynamic subtest render: SUCCESS (0.096s)
[432.871894] Starting dynamic subtest: bsd1
[434.855348] Dynamic subtest bsd1: SUCCESS (1.993s)
[434.868706] Starting dynamic subtest: bsd2
[436.840401] Dynamic subtest bsd2: SUCCESS (1.982s)
[436.853342] Starting dynamic subtest: blt
[436.923895] Dynamic subtest blt: SUCCESS (0.082s)
[436.936170] Starting dynamic subtest: vebox
[438.886790] Dynamic subtest vebox: SUCCESS (1.960s)
[438.889418] Subtest legacy-engines-queued: SUCCESS (6.127s)
[438.993356] [034/131] (643s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[439.119324] Starting subtest: cursor-tearing-framebuffer-change
[439.122112] Starting dynamic subtest: pipe-A-eDP-1
[439.685867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[439.697069] Starting dynamic subtest: pipe-D-eDP-1
[440.909230] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[440.911788] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.790s)
[441.759380] [035/131] (640s left) kms_prop_blob (blob-prop-lifetime)
[441.822053] Starting subtest: blob-prop-lifetime
[441.824682] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[441.953356] [036/131] (640s left) i915_pm_rpm (system-suspend-execbuf)
[444.079213] Starting subtest: system-suspend-execbuf
[502.006931] Subtest system-suspend-execbuf: SUCCESS (42.888s)
[502.405520] [037/131] (579s left) gem_exec_schedule (u-lateslice)
[502.492145] Starting subtest: u-lateslice
[502.494781] Starting dynamic subtest: rcs0
[502.503244] Dynamic subtest rcs0: SUCCESS (0.025s)
[502.514286] Starting dynamic subtest: bcs0
[502.521068] Dynamic subtest bcs0: SUCCESS (0.017s)
[502.531064] Starting dynamic subtest: vcs0
[502.539605] Dynamic subtest vcs0: SUCCESS (0.018s)
[502.554348] Starting dynamic subtest: vcs1
[502.560230] Dynamic subtest vcs1: SUCCESS (0.020s)
[502.570102] Starting dynamic subtest: vecs0
[502.578198] Dynamic subtest vecs0: SUCCESS (0.017s)
[502.587876] Starting dynamic subtest: ccs0
[502.598217] Dynamic subtest ccs0: SUCCESS (0.019s)
[502.601124] Subtest u-lateslice: SUCCESS (0.120s)
[503.878769] [038/131] (578s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[508.941207] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[508.946328] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[509.815569] [039/131] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[509.922289] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[516.145201] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.226s)
[517.320249] [040/131] (565s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[517.441320] Starting subtest: flip-vs-cursor-legacy
[524.411110] Subtest flip-vs-cursor-legacy: SUCCESS (6.969s)
[525.246501] [041/131] (557s left) gem_exec_params (cliprects-invalid)
[525.325592] Starting subtest: cliprects-invalid
[525.327990] Subtest cliprects-invalid: SUCCESS (0.000s)
[525.433004] [042/131] (557s left) i915_query (query-regions-unallocated)
[525.503319] Starting subtest: query-regions-unallocated
[525.506306] Subtest query-regions-unallocated: SUCCESS (0.000s)
[525.633582] [043/131] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[525.735286] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[525.740887] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[525.856645] [044/131] (556s left) gem_create (create-ext-cpu-access-big)
[526.033650] Starting subtest: create-ext-cpu-access-big
[526.039499] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[526.137745] [045/131] (556s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[526.236109] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[526.240814] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[526.368483] [046/131] (556s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[526.437466] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[526.495640] [047/131] (556s left) kms_dsc (dsc-with-bpc-formats)
[526.584066] Starting subtest: dsc-with-bpc-formats
[526.713786] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[526.750359] [048/131] (556s left) syncobj_wait (invalid-single-wait-unsubmitted)
[526.816199] Starting subtest: invalid-single-wait-unsubmitted
[526.819165] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[526.928873] [049/131] (555s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[527.023569] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[527.025964] Starting dynamic subtest: pipe-A-eDP-1
[527.046479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[527.056532] Starting dynamic subtest: pipe-B-eDP-1
[527.076050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[527.085089] Starting dynamic subtest: pipe-C-eDP-1
[527.103842] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[527.112788] Starting dynamic subtest: pipe-D-eDP-1
[527.132143] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[527.134521] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[529.308951] [050/131] (553s left) kms_psr (fbc-psr-sprite-render)
[529.416773] Starting subtest: fbc-psr-sprite-render
[529.419201] Starting dynamic subtest: eDP-1
[529.424292] Dynamic subtest eDP-1: SKIP (0.000s)
[529.429873] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[529.511485] [051/131] (553s left) kms_chamelium_frames (dp-crc-single)
[529.919427] Subtest dp-crc-single: SKIP (0.000s)
[530.698738] [052/131] (552s left) gem_ctx_param (basic)
[530.756093] Starting subtest: basic
[530.759192] Subtest basic: SUCCESS (0.001s)
[530.878322] [053/131] (552s left) kms_feature_discovery (display-4x)
[530.992308] Starting subtest: display-4x
[530.997050] Subtest display-4x: SKIP (0.000s)
[531.084420] [054/131] (551s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[531.185991] Starting subtest: x-tiled-64bpp-rotate-90
[531.207596] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[531.367831] [055/131] (551s left) kms_cdclk (mode-transition-all-outputs)
[531.465561] Starting subtest: mode-transition-all-outputs
[531.757132] Subtest mode-transition-all-outputs: SKIP (0.288s)
[532.571074] [056/131] (550s left) gem_ctx_shared (q-in-order)
[532.643242] Starting subtest: Q-in-order
[532.646151] Starting dynamic subtest: rcs0
[532.823155] Dynamic subtest rcs0: SUCCESS (0.183s)
[532.841502] Starting dynamic subtest: vcs0
[532.900465] Dynamic subtest vcs0: SUCCESS (0.076s)
[532.917035] Starting dynamic subtest: vcs1
[532.971749] Dynamic subtest vcs1: SUCCESS (0.070s)
[532.988026] Starting dynamic subtest: vecs0
[533.043296] Dynamic subtest vecs0: SUCCESS (0.071s)
[533.061081] Starting dynamic subtest: ccs0
[533.112555] Dynamic subtest ccs0: SUCCESS (0.069s)
[533.115176] Subtest Q-in-order: SUCCESS (0.473s)
[534.857897] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[534.861844] [057/131] (548s left) sysfs_preempt_timeout (timeout)
[534.930491] Starting subtest: timeout
[534.933136] Starting dynamic subtest: vecs0
[544.740955] Dynamic subtest vecs0: SUCCESS (9.809s)
[544.753692] Starting dynamic subtest: ccs0
[546.140878] Dynamic subtest ccs0: SUCCESS (1.395s)
[546.153360] Starting dynamic subtest: vcs0
[555.749690] Dynamic subtest vcs0: SUCCESS (9.602s)
[555.762924] Starting dynamic subtest: bcs0
[557.051491] Dynamic subtest bcs0: SUCCESS (1.300s)
[557.063236] Starting dynamic subtest: rcs0
[558.362284] Dynamic subtest rcs0: SUCCESS (1.309s)
[558.373068] Starting dynamic subtest: vcs1
[567.765489] Dynamic subtest vcs1: SUCCESS (9.404s)
[567.768309] Subtest timeout: SUCCESS (32.832s)
[567.873373] [058/131] (515s left) gem_mmap_gtt (basic-read-write-distinct)
[567.942134] Subtest basic-read-write-distinct: SKIP (0.000s)
[568.011043] [059/131] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[568.118110] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[572.205603] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.092s)
[573.385804] [060/131] (509s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[573.483546] Starting subtest: plane-downscale-factor-0-5-with-rotation
[573.486274] Starting dynamic subtest: pipe-A
[573.505031] Dynamic subtest pipe-A: SKIP (0.015s)
[573.520566] Starting dynamic subtest: pipe-B
[573.531149] Dynamic subtest pipe-B: SKIP (0.028s)
[573.542056] Starting dynamic subtest: pipe-C
[573.558856] Dynamic subtest pipe-C: SKIP (0.028s)
[573.568455] Starting dynamic subtest: pipe-D
[573.587134] Dynamic subtest pipe-D: SKIP (0.028s)
[573.591042] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.102s)
[573.719865] [061/131] (509s left) kms_psr (pr-dpms)
[573.811064] Starting subtest: pr-dpms
[573.816419] Subtest pr-dpms: SKIP (0.000s)
[573.905770] [062/131] (509s left) kms_psr (fbc-pr-suspend)
[573.999494] Starting subtest: fbc-pr-suspend
[574.004780] Subtest fbc-pr-suspend: SKIP (0.000s)
[574.094938] [063/131] (509s left) gem_exec_reloc (basic-gtt-active)
[574.158144] Subtest basic-gtt-active: SKIP (0.000s)
[574.238672] [064/131] (509s left) kms_cursor_crc (cursor-dpms)
[574.358771] Starting subtest: cursor-dpms
[574.361391] Starting dynamic subtest: pipe-A-eDP-1
[577.426583] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.066s)
[577.437036] Starting dynamic subtest: pipe-D-eDP-1
[581.004281] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.574s)
[581.007123] Subtest cursor-dpms: SUCCESS (6.644s)
[581.884871] [065/131] (501s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[581.989136] Starting subtest: 4-tiled-8bpp-rotate-0
[583.169741] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.181s)
[583.337324] [066/131] (500s left) kms_psr (psr-dpms)
[583.438090] Starting subtest: psr-dpms
[583.440228] Starting dynamic subtest: eDP-1
[586.369321] Dynamic subtest eDP-1: SUCCESS (2.930s)
[586.371783] Subtest psr-dpms: SUCCESS (2.931s)
[587.262054] [067/131] (496s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[587.322092] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[587.324872] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[587.453671] [068/131] (496s left) gem_fenced_exec_thrash (too-many-fences)
[587.524135] Subtest too-many-fences: SKIP (0.000s)
[587.585716] [069/131] (496s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[587.710980] Starting subtest: flip-vs-cursor-varying-size
[596.159132] Subtest flip-vs-cursor-varying-size: SUCCESS (8.449s)
[596.992647] [070/131] (486s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[597.232465] Starting subtest: cursor-rapid-movement-256x256
[597.235397] Starting dynamic subtest: pipe-A-eDP-1
[597.777277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[597.806012] Starting dynamic subtest: pipe-D-eDP-1
[598.976801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.177s)
[598.979368] Subtest cursor-rapid-movement-256x256: SUCCESS (1.744s)
[599.866756] [071/131] (483s left) gem_pxp (regular-baseline-src-copy-readible)
[599.995725] Starting subtest: regular-baseline-src-copy-readible
[600.051237] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[600.210595] [072/131] (483s left) gem_exercise_blt (fast-copy)
[600.273633] Starting subtest: fast-copy
[600.276200] Starting dynamic subtest: linear-smem-smem
[600.297855] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[600.309711] Starting dynamic subtest: xmajor-smem-smem
[600.316312] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[600.328949] Starting dynamic subtest: tile4-smem-smem
[600.334207] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[600.344202] Starting dynamic subtest: tile64-smem-smem
[600.350446] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[600.353147] Subtest fast-copy: SUCCESS (0.078s)
[600.524723] [073/131] (483s left) i915_drm_fdinfo (virtual-busy-all)
[600.569698] Starting subtest: virtual-busy-all
[600.575186] Subtest virtual-busy-all: SKIP (0.000s)
[600.656092] [074/131] (483s left) gen9_exec_parse (basic-rejected)
[600.733324] Subtest basic-rejected: SKIP (0.000s)
[600.805248] [075/131] (483s left) prime_vgem (shrink)
[600.895012] Starting subtest: shrink
[600.919042] Subtest shrink: SUCCESS (0.023s)
[601.054000] [076/131] (482s left) kms_vblank (wait-idle-hang)
[601.154092] Starting subtest: wait-idle-hang
[601.156206] Starting dynamic subtest: pipe-A-eDP-1
[627.537311] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.375s)
[627.555984] Starting dynamic subtest: pipe-D-eDP-1
[651.528321] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.985s)
[651.531235] Subtest wait-idle-hang: SUCCESS (50.365s)
[652.416605] [077/131] (431s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[652.530606] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[652.535964] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[652.648869] [078/131] (431s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[652.716334] Starting subtest: yf-tiled-to-vebox-x-tiled
[652.721679] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[652.926005] [079/131] (431s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[653.042823] Starting subtest: cursor-vs-flip-varying-size
[683.789172] Subtest cursor-vs-flip-varying-size: SUCCESS (30.739s)
[684.659545] [080/131] (399s left) perf_pmu (invalid-init)
[684.716192] Starting subtest: invalid-init
[684.719316] Subtest invalid-init: SUCCESS (0.000s)
[684.892250] [081/131] (399s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[684.981124] Starting subtest: basic-modeset-with-all-modifiers-formats
[685.370609] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[686.120049] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.750s)
[686.130346] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[686.141702] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[686.151287] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[686.163867] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[686.173828] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[686.319391] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[686.329946] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[686.341180] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[686.350692] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[686.363227] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[686.373071] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[686.385982] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[686.395786] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[686.408212] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[686.417840] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[686.430649] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[686.440126] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[686.452263] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[686.462353] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[686.474955] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[686.484968] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[686.497130] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[686.506765] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[686.652873] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[686.662590] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[686.674743] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[686.684291] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[686.697104] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[686.707155] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[686.719933] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[686.730053] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[686.741739] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[686.751313] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[686.763796] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[686.773290] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[686.785928] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[686.795334] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[686.808351] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.020s)
[686.817801] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[686.830791] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[686.840103] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[686.997735] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[687.008057] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[687.019454] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[687.029107] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[687.041633] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[687.051134] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[687.063908] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[687.073561] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[687.086131] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[687.095565] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[687.108332] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[687.117716] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[687.130382] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[687.139704] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[687.152842] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[687.162021] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[687.174985] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[687.567838] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.588s)
[688.452283] [082/131] (395s left) perf_pmu (busy-idle)
[688.497156] Starting subtest: busy-idle
[688.499888] Starting dynamic subtest: rcs0
[689.193055] Dynamic subtest rcs0: SUCCESS (0.697s)
[689.206244] Starting dynamic subtest: bcs0
[689.860271] Dynamic subtest bcs0: SUCCESS (0.665s)
[689.873297] Starting dynamic subtest: vcs0
[691.724687] Dynamic subtest vcs0: SUCCESS (1.861s)
[691.738086] Starting dynamic subtest: vcs1
[693.782702] Dynamic subtest vcs1: SUCCESS (2.045s)
[693.795293] Starting dynamic subtest: vecs0
[695.755899] Dynamic subtest vecs0: SUCCESS (1.983s)
[695.769326] Starting dynamic subtest: ccs0
[696.427495] Dynamic subtest ccs0: SUCCESS (0.670s)
[696.430490] Subtest busy-idle: SUCCESS (7.935s)
[696.570387] [083/131] (387s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[696.637975] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[696.702783] [084/131] (387s left) device_reset (unbind-reset-rebind)
[696.754958] Starting subtest: unbind-reset-rebind
[701.441012] Subtest unbind-reset-rebind: SUCCESS (4.683s)
[701.488842] [085/131] (382s left) gem_mmap_gtt (big-copy-odd)
[701.550075] Subtest big-copy-odd: SKIP (0.000s)
[701.621739] [086/131] (382s left) kms_vblank (query-forked-busy)
[701.714203] Starting subtest: query-forked-busy
[701.716862] Starting dynamic subtest: pipe-A-eDP-1
[703.612447] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.899s)
[703.627803] Starting dynamic subtest: pipe-D-eDP-1
[706.146115] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s)
[706.149019] Subtest query-forked-busy: SUCCESS (4.435s)
[706.971198] [087/131] (377s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[707.070715] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[707.073121] Starting dynamic subtest: pipe-A-default-mode
[707.364002] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[707.368660] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.292s)
[708.202493] [088/131] (376s left) kms_color (invalid-ctm-matrix-sizes)
[708.311563] Starting subtest: invalid-ctm-matrix-sizes
[708.314069] Starting dynamic subtest: pipe-A
[708.317405] Dynamic subtest pipe-A: SUCCESS (0.002s)
[708.330848] Starting dynamic subtest: pipe-B
[708.333308] Dynamic subtest pipe-B: SUCCESS (0.002s)
[708.343316] Starting dynamic subtest: pipe-C
[708.345715] Dynamic subtest pipe-C: SUCCESS (0.004s)
[708.355337] Starting dynamic subtest: pipe-D
[708.357841] Dynamic subtest pipe-D: SUCCESS (0.005s)
[708.360204] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.017s)
[708.425383] [089/131] (376s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[708.523700] Starting subtest: psr-2p-primscrn-spr-indfb-move
[708.528806] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[708.647300] [090/131] (375s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[708.751283] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[708.756241] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[708.861244] [091/131] (375s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[708.971213] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[708.976903] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[709.116015] [092/131] (375s left) prime_udl
[709.196624] [093/131] (375s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[709.313106] Starting subtest: short-flip-after-cursor-toggle
[710.229442] Subtest short-flip-after-cursor-toggle: SUCCESS (0.916s)
[711.126646] [094/131] (373s left) gem_exec_balancer (parallel-out-fence)
[711.389163] Starting subtest: parallel-out-fence
[712.646131] Subtest parallel-out-fence: SUCCESS (1.260s)
[712.795672] [095/131] (372s left) perf (invalid-open-flags)
[712.948521] Starting subtest: invalid-open-flags
[712.951152] Subtest invalid-open-flags: SUCCESS (0.000s)
[713.004771] [096/131] (371s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[713.105968] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[713.111122] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[713.242483] [097/131] (371s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[713.344216] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[713.349977] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[713.456826] [098/131] (371s left) gem_lmem_swapping (verify)
[713.501684] Subtest verify: SKIP (0.000s)
[713.549583] [099/131] (371s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[713.652871] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[713.657928] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[713.776959] [100/131] (371s left) gem_exec_balancer (bonded-pair)
[713.844971] Starting subtest: bonded-pair
[713.850178] Subtest bonded-pair: SKIP (0.000s)
[714.161878] [101/131] (370s left) kms_flip (2x-nonexisting-fb)
[714.258927] Starting subtest: 2x-nonexisting-fb
[714.269297] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[714.377740] [102/131] (370s left) gem_exec_fence (syncobj-repeat)
[714.799083] Starting subtest: syncobj-repeat
[714.964929] Subtest syncobj-repeat: SUCCESS (0.168s)
[716.878784] [103/131] (368s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[717.005097] Starting subtest: cursorB-vs-flipB-atomic-transitions
[717.010390] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[717.172805] [104/131] (368s left) kms_flip (flip-vs-panning-interruptible)
[717.272062] Starting subtest: flip-vs-panning-interruptible
[717.274724] Starting dynamic subtest: A-eDP1
[726.013614] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[726.027830] Starting dynamic subtest: B-eDP1
[734.742809] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[734.754110] Starting dynamic subtest: C-eDP1
[743.461883] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[743.472408] Starting dynamic subtest: D-eDP1
[752.183532] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[752.188591] Subtest flip-vs-panning-interruptible: SUCCESS (34.917s)
[753.382751] [105/131] (331s left) gem_mmap_wc (bad-object)
[753.458728] Subtest bad-object: SKIP (0.000s)
[753.533852] [106/131] (331s left) syncobj_wait (single-wait-all-signaled)
[753.594328] Starting subtest: single-wait-all-signaled
[753.597100] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[753.754408] [107/131] (331s left) api_intel_allocator (two-level-inception)
[753.805049] Starting subtest: two-level-inception
[759.204174] Subtest two-level-inception: SUCCESS (5.399s)
[759.350508] [108/131] (326s left) kms_addfb_basic (bad-pitch-0)
[759.414061] Starting subtest: bad-pitch-0
[759.416794] Subtest bad-pitch-0: SUCCESS (0.000s)
[759.601794] [109/131] (325s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[759.700747] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[760.569918] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[760.803123] [110/131] (324s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[760.911100] Starting subtest: invalidate-primary-flip-overlay
[771.699573] Subtest invalidate-primary-flip-overlay: SUCCESS (10.790s)
[771.838762] [111/131] (313s left) kms_prop_blob (invalid-set-prop)
[771.898027] Starting subtest: invalid-set-prop
[771.900161] Subtest invalid-set-prop: SUCCESS (0.000s)
[772.045441] [112/131] (313s left) gem_create (create-invalid-size)
[772.088864] Starting subtest: create-invalid-size
[772.091069] Subtest create-invalid-size: SUCCESS (0.000s)
[772.301652] [113/131] (313s left) kms_setmode (basic-clone-single-crtc)
[772.349493] Starting subtest: basic-clone-single-crtc
[772.357178] Subtest basic-clone-single-crtc: SKIP (0.000s)
[772.460633] [114/131] (313s left) i915_hangman (hangcheck-unterminated)
[772.512628] Starting subtest: hangcheck-unterminated
[783.721125] Subtest hangcheck-unterminated: SUCCESS (11.207s)
[783.884295] [115/131] (301s left) gem_ctx_exec (basic)
[783.946312] Starting subtest: basic
[783.954938] Subtest basic: SUCCESS (0.010s)
[784.118860] [116/131] (301s left) kms_pm_rpm (legacy-planes)
[785.944866] Starting subtest: legacy-planes
[785.947896] Starting dynamic subtest: plane-63
[796.959881] Dynamic subtest plane-63: SUCCESS (11.013s)
[796.974482] Starting dynamic subtest: plane-93
[808.750500] Dynamic subtest plane-93: SUCCESS (11.786s)
[808.763246] Starting dynamic subtest: plane-123
[817.163903] Dynamic subtest plane-123: SUCCESS (8.410s)
[817.177888] Starting dynamic subtest: plane-133
[825.445624] Dynamic subtest plane-133: SUCCESS (8.278s)
[825.448627] Subtest legacy-planes: SUCCESS (39.497s)
[825.832327] [117/131] (259s left) core_auth (getclient-master-drop)
[825.881091] Starting subtest: getclient-master-drop
[825.904319] Subtest getclient-master-drop: SUCCESS (0.022s)
[826.042166] [118/131] (259s left) gem_eio (throttle)
[826.247023] Starting subtest: throttle
[826.531589] Subtest throttle: SUCCESS (0.283s)
[826.710650] [119/131] (259s left) gem_exec_schedule (out-order)
[826.784593] Starting subtest: out-order
[826.786573] Starting dynamic subtest: rcs0
[826.880487] Dynamic subtest rcs0: SUCCESS (0.105s)
[826.893946] Starting dynamic subtest: vcs0
[826.963920] Dynamic subtest vcs0: SUCCESS (0.083s)
[826.977828] Starting dynamic subtest: vcs1
[827.049834] Dynamic subtest vcs1: SUCCESS (0.085s)
[827.063023] Starting dynamic subtest: vecs0
[827.129319] Dynamic subtest vecs0: SUCCESS (0.079s)
[827.142936] Starting dynamic subtest: ccs0
[827.230225] Dynamic subtest ccs0: SUCCESS (0.100s)
[827.233031] Subtest out-order: SUCCESS (0.455s)
[828.876609] [120/131] (257s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[828.982855] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[828.988092] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[829.111853] [121/131] (256s left) gem_ppgtt (blt-vs-render-ctxn)
[829.179215] Starting subtest: blt-vs-render-ctxN
[862.230307] Subtest blt-vs-render-ctxN: SUCCESS (33.042s)
[862.405635] [122/131] (223s left) kms_flip (plain-flip-ts-check)
[862.562685] Starting subtest: plain-flip-ts-check
[862.565140] Starting dynamic subtest: A-eDP1
[871.517144] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[871.534025] Starting dynamic subtest: B-eDP1
[880.357100] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[880.387927] Starting dynamic subtest: C-eDP1
[889.279512] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[889.295123] Starting dynamic subtest: D-eDP1
[898.101627] Dynamic subtest D-eDP1: SUCCESS (8.818s)
[898.104607] Subtest plain-flip-ts-check: SUCCESS (35.537s)
[899.303780] [123/131] (186s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[899.415324] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[899.420677] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[899.535788] [124/131] (186s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[899.634572] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[899.637035] Starting dynamic subtest: pipe-A-eDP-1
[899.662658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[899.674851] Starting dynamic subtest: pipe-B-eDP-1
[899.700938] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[899.711096] Starting dynamic subtest: pipe-C-eDP-1
[899.737116] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[899.747197] Starting dynamic subtest: pipe-D-eDP-1
[899.775244] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[899.781171] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[901.960775] [125/131] (184s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[902.069115] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[902.074369] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[902.204221] [126/131] (184s left) gem_exec_fence (syncobj-unused-fence)
[902.666297] Starting subtest: syncobj-unused-fence
[902.673619] Subtest syncobj-unused-fence: SUCCESS (0.008s)
[903.870811] [127/131] (182s left) gem_exec_reloc (basic-wc-cpu-active)
[903.931201] Subtest basic-wc-cpu-active: SKIP (0.000s)
[903.992516] [128/131] (182s left) gem_mmap_wc (fault-concurrent)
[904.058469] Subtest fault-concurrent: SKIP (0.000s)
[904.114521] [129/131] (182s left) syncobj_timeline (multi-wait-available-signaled)
[904.185819] Starting subtest: multi-wait-available-signaled
[904.188594] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[904.323470] [130/131] (182s left) gem_exec_whisper (basic-normal)
[904.382195] Starting subtest: basic-normal
[911.333789] Subtest basic-normal: SUCCESS (6.948s)
[911.548460] [131/131] (174s left) kms_plane_lowres (tiling-y)
[911.661882] Starting subtest: tiling-y
[911.667027] Subtest tiling-y: SKIP (0.000s)
[911.754883] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pipe_crc_basic
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_busy
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: kms_hdr
results: parsing output: 17/ for test: kms_joiner
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: kms_psr2_su
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_edge_walk
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_mmap_offset
results: parsing output: 26/ for test: kms_hdr
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: dumb_buffer
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_prop_blob
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: i915_query
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_create
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_fenced_exec_thrash
results: parsing output: 46/ for test: kms_dsc
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_feature_discovery
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_cdclk
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: sysfs_preempt_timeout
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_fenced_exec_thrash
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: gem_exercise_blt
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: prime_vgem
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: device_reset
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_color
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: prime_udl
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_psr_stress_test
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: kms_setmode
results: parsing output: 113/ for test: i915_hangman
results: parsing output: 114/ for test: gem_ctx_exec
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: core_auth
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ppgtt
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_plane_lowres
Done.