[60.351347] Initializing watchdogs
[60.351390]   /dev/watchdog0
[60.364486] [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]
[60.368695] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.370855] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.374206] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[60.503795] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[60.507836] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[60.578763] [002/133] (960s left) kms_hdr (bpc-switch-dpms)
[60.685124] Starting subtest: bpc-switch-dpms
[61.748675] Starting dynamic subtest: pipe-A-eDP-1
[66.277377] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.527s)
[66.279836] Subtest bpc-switch-dpms: SUCCESS (5.594s)
[66.408072] [003/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[66.513405] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[66.517680] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[66.640864] [004/133] (954s left) gem_pxp (display-protected-crc)
[66.837451] Starting subtest: display-protected-crc
[68.396724] Subtest display-protected-crc: SUCCESS (1.561s)
[68.546627] [005/133] (952s left) kms_cursor_crc (cursor-alpha-transparent)
[68.645292] Starting subtest: cursor-alpha-transparent
[68.647498] Starting dynamic subtest: pipe-A-eDP-1
[69.255016] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[69.263798] Starting dynamic subtest: pipe-D-eDP-1
[70.534202] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[70.537899] Subtest cursor-alpha-transparent: SUCCESS (1.888s)
[71.424306] [006/133] (949s left) i915_query (query-topology-garbage-items)
[71.486089] Starting subtest: query-topology-garbage-items
[71.488498] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[71.608216] [007/133] (949s left) kms_psr2_su (page_flip-xrgb8888)
[71.674582] Subtest page_flip-XRGB8888: SKIP (0.000s)
[71.740180] [008/133] (949s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[72.137669] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[72.915168] [009/133] (948s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[73.015761] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[73.017661] Starting dynamic subtest: pipe-A-eDP-1
[75.049598] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.036s)
[75.057075] Starting dynamic subtest: pipe-B-eDP-1
[77.108498] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.056s)
[77.115359] Starting dynamic subtest: pipe-C-eDP-1
[79.165810] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.056s)
[79.179705] Starting dynamic subtest: pipe-D-eDP-1
[81.212548] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.046s)
[81.214847] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.198s)
[82.489659] [010/133] (938s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[82.601930] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[87.832967] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.237s)
[88.971597] [011/133] (932s left) kms_flip (plain-flip-ts-check-interruptible)
[89.075509] Starting subtest: plain-flip-ts-check-interruptible
[89.077888] Starting dynamic subtest: A-eDP1
[97.939202] Dynamic subtest A-eDP1: SUCCESS (8.862s)
[97.951564] Starting dynamic subtest: B-eDP1
[106.779764] Dynamic subtest B-eDP1: SUCCESS (8.839s)
[106.786803] Starting dynamic subtest: C-eDP1
[115.602479] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[115.611075] Starting dynamic subtest: D-eDP1
[124.427858] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[124.433183] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.356s)
[125.621667] [012/133] (895s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[125.688342] Starting subtest: verify-pxp-execution-after-suspend-resume
[132.860759] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.170s)
[133.011528] [013/133] (888s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[133.075781] Starting subtest: invalid-single-wait-unsubmitted
[133.077967] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[133.199575] [014/133] (888s left) i915_drm_fdinfo (memory-info-purgeable)
[133.244397] Starting subtest: memory-info-purgeable
[133.246648] Starting dynamic subtest: smem0
[136.171388] Dynamic subtest smem0: SUCCESS (2.927s)
[136.174057] Subtest memory-info-purgeable: SUCCESS (2.928s)
[136.257026] [015/133] (885s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[136.364025] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[140.458238] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.096s)
[141.636047] [016/133] (879s left) prime_busy (before-wait)
[141.694701] Starting subtest: before-wait
[141.700084] Starting dynamic subtest: rcs0
[141.734513] Dynamic subtest rcs0: SUCCESS (0.037s)
[141.744537] Starting dynamic subtest: bcs0
[141.798223] Dynamic subtest bcs0: SUCCESS (0.063s)
[141.807689] Starting dynamic subtest: vcs0
[141.838479] Dynamic subtest vcs0: SUCCESS (0.040s)
[141.846739] Starting dynamic subtest: vcs1
[141.880385] Dynamic subtest vcs1: SUCCESS (0.041s)
[141.889120] Starting dynamic subtest: vecs0
[141.920514] Dynamic subtest vecs0: SUCCESS (0.040s)
[141.929102] Starting dynamic subtest: ccs0
[141.961749] Dynamic subtest ccs0: SUCCESS (0.041s)
[142.070047] Subtest before-wait: SUCCESS (0.374s)
[142.156250] [017/133] (879s left) api_intel_bb (simple-bb)
[142.210248] Starting subtest: simple-bb
[142.212773] Subtest simple-bb: SUCCESS (0.005s)
[142.369656] [018/133] (879s left) kms_draw_crc (draw-method-mmap-gtt)
[142.461127] Starting subtest: draw-method-mmap-gtt
[142.465567] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[142.581815] [019/133] (878s left) perf (sysctl-defaults)
[142.666657] Starting subtest: sysctl-defaults
[142.669290] Subtest sysctl-defaults: SUCCESS (0.000s)
[142.745381] [020/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[142.843608] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[149.790206] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.949s)
[149.946245] [021/133] (871s left) kms_flip (nonexisting-fb)
[150.051497] Starting subtest: nonexisting-fb
[150.053341] Starting dynamic subtest: A-eDP1
[151.206413] Dynamic subtest A-eDP1: SUCCESS (1.156s)
[151.215297] Starting dynamic subtest: B-eDP1
[152.347202] Dynamic subtest B-eDP1: SUCCESS (1.140s)
[152.356217] Starting dynamic subtest: C-eDP1
[153.469651] Dynamic subtest C-eDP1: SUCCESS (1.121s)
[153.482392] Starting dynamic subtest: D-eDP1
[154.611561] Dynamic subtest D-eDP1: SUCCESS (1.141s)
[154.616435] Subtest nonexisting-fb: SUCCESS (4.566s)
[155.780699] [022/133] (865s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[155.876763] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[155.881115] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[155.955211] [023/133] (865s left) gem_exec_schedule (timeslicing)
[156.031436] Starting subtest: timeslicing
[156.033414] Starting dynamic subtest: rcs0
[156.041776] Dynamic subtest rcs0: SUCCESS (0.021s)
[156.051494] Starting dynamic subtest: bcs0
[156.062172] Dynamic subtest bcs0: SUCCESS (0.020s)
[156.070040] Starting dynamic subtest: vcs0
[156.083383] Dynamic subtest vcs0: SUCCESS (0.021s)
[156.094087] Starting dynamic subtest: vcs1
[156.111754] Dynamic subtest vcs1: SUCCESS (0.026s)
[156.120215] Starting dynamic subtest: vecs0
[156.132586] Dynamic subtest vecs0: SUCCESS (0.020s)
[156.140589] Starting dynamic subtest: ccs0
[156.153541] Dynamic subtest ccs0: SUCCESS (0.020s)
[156.155921] Subtest timeslicing: SUCCESS (0.134s)
[157.959086] [024/133] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[158.057293] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[158.061459] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[158.177232] [025/133] (863s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[158.292335] Starting subtest: flip-vs-cursor-atomic-transitions
[165.740168] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.448s)
[166.605245] [026/133] (855s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[166.700126] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[166.704442] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[166.783072] [027/133] (855s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[166.910397] Starting subtest: basic-flip-after-cursor-legacy
[167.827224] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.915s)
[168.642252] [028/133] (853s left) prime_self_import (export-vs-gem_close-race)
[168.674565] Starting subtest: export-vs-gem_close-race
[173.776300] Subtest export-vs-gem_close-race: SUCCESS (5.103s)
[173.869068] [029/133] (848s left) gem_mmap_gtt (zero-extend)
[173.936084] Subtest zero-extend: SKIP (0.000s)
[174.002823] [030/133] (847s left) gem_ctx_persistence (legacy-engines-persistence)
[174.077048] Starting subtest: legacy-engines-persistence
[174.079356] Starting dynamic subtest: render
[174.974467] Dynamic subtest render: SUCCESS (0.899s)
[174.985629] Starting dynamic subtest: bsd1
[175.788352] Dynamic subtest bsd1: SUCCESS (0.811s)
[175.799277] Starting dynamic subtest: bsd2
[176.619340] Dynamic subtest bsd2: SUCCESS (0.828s)
[176.630375] Starting dynamic subtest: blt
[177.449462] Dynamic subtest blt: SUCCESS (0.827s)
[177.460232] Starting dynamic subtest: vebox
[178.212313] Dynamic subtest vebox: SUCCESS (0.760s)
[178.214919] Subtest legacy-engines-persistence: SUCCESS (4.138s)
[178.303306] [031/133] (843s left) i915_module_load (reload)
[178.342177] Starting subtest: reload
[183.316497] Subtest reload: SUCCESS (4.979s)
[183.354950] [032/133] (838s left) kms_color (degamma)
[184.928961] Starting subtest: degamma
[184.931224] Starting dynamic subtest: pipe-A-eDP-1
[185.668800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[185.684308] Starting dynamic subtest: pipe-B-eDP-1
[187.076107] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[187.083606] Starting dynamic subtest: pipe-C-eDP-1
[188.448399] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[188.455691] Starting dynamic subtest: pipe-D-eDP-1
[189.786525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[189.788711] Subtest degamma: SUCCESS (4.857s)
[190.592087] [033/133] (831s left) prime_vgem (basic-fence-mmap)
[190.701998] Starting subtest: basic-fence-mmap
[190.706456] Subtest basic-fence-mmap: SKIP (0.000s)
[190.824670] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[190.827820] [034/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[190.929761] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[190.933978] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[191.027894] [035/133] (831s left) gem_lmem_swapping (parallel-random-engines)
[191.068180] Subtest parallel-random-engines: SKIP (0.000s)
[191.111916] [036/133] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[191.204454] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[198.226713] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.024s)
[198.386335] [037/133] (823s left) perf_pmu (init-busy)
[198.427674] Starting subtest: init-busy
[198.430095] Starting dynamic subtest: rcs0
[198.432379] Dynamic subtest rcs0: SUCCESS (0.002s)
[198.440370] Starting dynamic subtest: bcs0
[198.442676] Dynamic subtest bcs0: SUCCESS (0.000s)
[198.449668] Starting dynamic subtest: vcs0
[198.451576] Dynamic subtest vcs0: SUCCESS (0.001s)
[198.458962] Starting dynamic subtest: vcs1
[198.461151] Dynamic subtest vcs1: SUCCESS (0.001s)
[198.468177] Starting dynamic subtest: vecs0
[198.470408] Dynamic subtest vecs0: SUCCESS (0.001s)
[198.477579] Starting dynamic subtest: ccs0
[198.479819] Dynamic subtest ccs0: SUCCESS (0.000s)
[198.482028] Subtest init-busy: SUCCESS (0.009s)
[198.585380] [038/133] (823s left) kms_frontbuffer_tracking (fbc-1p-rte)
[198.676907] Starting subtest: fbc-1p-rte
[204.215041] Subtest fbc-1p-rte: SUCCESS (5.542s)
[205.425079] [039/133] (816s left) gem_ringfill (basic-all)
[210.906978] Starting subtest: basic-all
[212.068433] Subtest basic-all: SUCCESS (1.160s)
[212.265645] [040/133] (810s left) kms_cursor_edge_walk (128x128-left-edge)
[212.364312] Starting subtest: 128x128-left-edge
[212.366527] Starting dynamic subtest: pipe-A-eDP-1
[215.864905] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[215.874406] Starting dynamic subtest: pipe-D-eDP-1
[218.990403] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[218.992700] Subtest 128x128-left-edge: SUCCESS (6.628s)
[219.801397] [041/133] (802s left) gem_vm_create (create-ext)
[219.864830] Starting subtest: create-ext
[219.870250] Subtest create-ext: SUCCESS (0.005s)
[220.025761] [042/133] (802s left) gem_exec_capture (userptr)
[220.090476] Starting subtest: userptr
[220.925072] Subtest userptr: SUCCESS (0.834s)
[221.078611] [043/133] (801s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[221.320468] Starting subtest: cursor-rapid-movement-256x256
[221.322729] Starting dynamic subtest: pipe-A-eDP-1
[221.874357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[221.902924] Starting dynamic subtest: pipe-D-eDP-1
[223.100873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[223.103107] Subtest cursor-rapid-movement-256x256: SUCCESS (1.781s)
[223.970761] [044/133] (798s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[224.064065] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[224.066208] Starting dynamic subtest: pipe-A-eDP-1
[224.088101] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.098124] Starting dynamic subtest: pipe-B-eDP-1
[224.118604] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.126184] Starting dynamic subtest: pipe-C-eDP-1
[224.146688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.154518] Starting dynamic subtest: pipe-D-eDP-1
[224.175895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.179928] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[226.259931] [045/133] (796s left) kms_invalid_mode (zero-hdisplay)
[226.357289] Starting subtest: zero-hdisplay
[226.359507] Starting dynamic subtest: pipe-A-eDP-1
[226.640866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[226.650087] Starting dynamic subtest: pipe-B-eDP-1
[226.652041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[226.659632] Starting dynamic subtest: pipe-C-eDP-1
[226.661568] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[226.669718] Starting dynamic subtest: pipe-D-eDP-1
[226.671924] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[226.674140] Subtest zero-hdisplay: SUCCESS (0.289s)
[227.505021] [046/133] (795s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[227.615430] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[228.583894] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.968s)
[228.750528] [047/133] (793s left) gem_softpin (evict-snoop)
[228.805175] Starting subtest: evict-snoop
[228.809817] Subtest evict-snoop: SKIP (0.000s)
[228.933277] [048/133] (793s left) prime_vgem (basic-write)
[229.023351] Starting subtest: basic-write
[229.033746] Subtest basic-write: SKIP (0.008s)
[229.132408] [049/133] (793s left) kms_atomic (plane-invalid-params)
[229.220363] Starting subtest: plane-invalid-params
[229.222303] Starting dynamic subtest: pipe-A-eDP-1
[229.622644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[229.624573] Subtest plane-invalid-params: SUCCESS (0.402s)
[230.429092] [050/133] (792s left) gem_userptr_blits (unsync-unmap-cycles)
[230.494584] Subtest unsync-unmap-cycles: SKIP (0.000s)
[230.626820] [051/133] (792s left) gem_exec_schedule (preempt-contexts)
[230.685358] Starting subtest: preempt-contexts
[230.687591] Starting dynamic subtest: rcs0
[230.733758] Dynamic subtest rcs0: SUCCESS (0.055s)
[230.742431] Starting dynamic subtest: bcs0
[230.797907] Dynamic subtest bcs0: SUCCESS (0.063s)
[230.806386] Starting dynamic subtest: vcs0
[230.843378] Dynamic subtest vcs0: SUCCESS (0.045s)
[230.851807] Starting dynamic subtest: vcs1
[230.883844] Dynamic subtest vcs1: SUCCESS (0.040s)
[230.892474] Starting dynamic subtest: vecs0
[230.925556] Dynamic subtest vecs0: SUCCESS (0.042s)
[230.933967] Starting dynamic subtest: ccs0
[230.973321] Dynamic subtest ccs0: SUCCESS (0.047s)
[230.975568] Subtest preempt-contexts: SUCCESS (0.295s)
[232.020337] [052/133] (790s left) syncobj_wait (wait-any-interrupted)
[232.082685] Starting subtest: wait-any-interrupted
[232.185865] Subtest wait-any-interrupted: SUCCESS (0.102s)
[232.275968] [053/133] (790s left) gem_madvise (dontneed-before-exec)
[232.308726] Starting subtest: dontneed-before-exec
[232.338860] Subtest dontneed-before-exec: SKIP (0.029s)
[232.405873] [054/133] (790s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[232.498163] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[232.500386] Starting dynamic subtest: pipe-A-eDP-1
[232.522679] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.531311] Starting dynamic subtest: pipe-B-eDP-1
[232.552139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.559626] Starting dynamic subtest: pipe-C-eDP-1
[232.580184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.587742] Starting dynamic subtest: pipe-D-eDP-1
[232.608700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.612596] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[234.711136] [055/133] (788s left) kms_psr (psr2-basic)
[234.805166] Starting subtest: psr2-basic
[234.807420] Starting dynamic subtest: eDP-1
[236.364881] Dynamic subtest eDP-1: SUCCESS (1.560s)
[236.367310] Subtest psr2-basic: SUCCESS (1.561s)
[237.172480] [056/133] (785s left) kms_chamelium_color (gamma)
[237.275053] Subtest gamma: SKIP (0.000s)
[237.317948] [057/133] (785s left) i915_pm_rpm (system-suspend-devices)
[239.051483] Starting subtest: system-suspend-devices
[246.709904] Subtest system-suspend-devices: SUCCESS (7.657s)
[247.101656] [058/133] (775s left) kms_chamelium_color (ctm-0-25)
[247.193709] Subtest ctm-0-25: SKIP (0.000s)
[247.238684] [059/133] (775s left) kms_rotation_crc (primary-rotation-90)
[247.332206] Starting subtest: primary-rotation-90
[247.336635] Subtest primary-rotation-90: SKIP (0.001s)
[247.417760] [060/133] (775s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[247.507513] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[247.885694] Starting dynamic subtest: pipe-A-eDP-1
[250.653153] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.767s)
[251.019428] Starting dynamic subtest: pipe-B-eDP-1
[253.774539] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[254.148652] Starting dynamic subtest: pipe-C-eDP-1
[256.904235] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[257.266284] Starting dynamic subtest: pipe-D-eDP-1
[260.029331] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[260.031784] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.523s)
[261.207600] [061/133] (761s left) gem_exec_whisper (basic-queues)
[261.289487] Starting subtest: basic-queues
[266.943564] Subtest basic-queues: SUCCESS (5.650s)
[267.140614] [062/133] (756s left) kms_big_fb (4-tiled-addfb-size-overflow)
[267.246586] Starting subtest: 4-tiled-addfb-size-overflow
[267.248445] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[267.352915] [063/133] (755s left) gem_eio (suspend)
[267.595841] Starting subtest: suspend
[279.854140] Subtest suspend: SUCCESS (12.260s)
[280.010565] [064/133] (743s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[280.108971] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[280.111371] Starting dynamic subtest: pipe-A
[280.170068] Dynamic subtest pipe-A: SUCCESS (0.064s)
[280.180144] Starting dynamic subtest: pipe-B
[281.334847] Dynamic subtest pipe-B: SUCCESS (1.162s)
[281.346810] Starting dynamic subtest: pipe-C
[282.449056] Dynamic subtest pipe-C: SUCCESS (1.113s)
[282.458979] Starting dynamic subtest: pipe-D
[283.560920] Dynamic subtest pipe-D: SUCCESS (1.111s)
[283.563213] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.455s)
[284.728582] [065/133] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[284.832207] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[284.836302] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[284.962997] [066/133] (738s left) kms_psr (fbc-psr2-suspend)
[285.052170] Starting subtest: fbc-psr2-suspend
[285.054386] Starting dynamic subtest: eDP-1
[285.058408] Dynamic subtest eDP-1: SKIP (0.000s)
[285.062454] Subtest fbc-psr2-suspend: SKIP (0.001s)
[285.153240] [067/133] (738s left) gem_ctx_sseu (engines)
[285.220199] Subtest engines: SKIP (0.000s)
[285.307409] [068/133] (738s left) kms_vblank (wait-idle)
[285.397120] Starting subtest: wait-idle
[285.398977] Starting dynamic subtest: pipe-A-eDP-1
[287.159574] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.762s)
[287.174074] Starting dynamic subtest: pipe-D-eDP-1
[289.574201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.411s)
[289.576482] Subtest wait-idle: SUCCESS (4.178s)
[290.400151] [069/133] (733s left) kms_busy (extended-pageflip-hang-oldfb)
[290.511414] Starting subtest: extended-pageflip-hang-oldfb
[290.513615] Starting dynamic subtest: pipe-A
[290.928699] Dynamic subtest pipe-A: SUCCESS (0.417s)
[290.938211] Starting dynamic subtest: pipe-D
[291.999846] Dynamic subtest pipe-D: SUCCESS (1.068s)
[292.002090] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.490s)
[292.864860] [070/133] (730s left) kms_dp_linktrain_fallback (dsc-fallback)
[292.968058] Starting subtest: dsc-fallback
[292.974582] Subtest dsc-fallback: SKIP (0.000s)
[293.053393] [071/133] (730s left) perf_pmu (invalid-init)
[293.092615] Starting subtest: invalid-init
[293.095040] Subtest invalid-init: SUCCESS (0.000s)
[293.211584] [072/133] (730s left) kms_addfb_basic (bad-pitch-63)
[293.265069] Starting subtest: bad-pitch-63
[293.267203] Subtest bad-pitch-63: SUCCESS (0.000s)
[293.416765] [073/133] (730s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[293.518225] Starting subtest: fbc-2p-pri-indfb-multidraw
[293.522421] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[293.657284] [074/133] (730s left) perf_pmu (busy-double-start)
[293.701856] Starting subtest: busy-double-start
[293.704201] Starting dynamic subtest: rcs0
[297.336956] Dynamic subtest rcs0: FAIL (3.578s)
[297.347969] Starting dynamic subtest: bcs0
[300.845727] Dynamic subtest bcs0: SUCCESS (3.566s)
[300.857100] Starting dynamic subtest: vcs0
[305.434611] Dynamic subtest vcs0: SUCCESS (4.586s)
[305.445250] Starting dynamic subtest: vcs1
[309.404773] Dynamic subtest vcs1: SUCCESS (3.968s)
[309.416160] Starting dynamic subtest: vecs0
[313.471843] Dynamic subtest vecs0: SUCCESS (4.064s)
[313.483755] Starting dynamic subtest: ccs0
[317.107537] Dynamic subtest ccs0: FAIL (3.566s)
[317.109666] Subtest busy-double-start: FAIL (23.340s)
[317.209589] [075/133] (706s left) gem_exec_balancer (parallel-bb-first)
[317.489533] Starting subtest: parallel-bb-first
[318.380484] Subtest parallel-bb-first: SUCCESS (0.893s)
[318.986867] [076/133] (704s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[319.116142] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[319.164999] [077/133] (704s left) gem_mmap_gtt (bad-object)
[319.234203] Subtest bad-object: SKIP (0.000s)
[319.297901] [078/133] (704s left) gem_pread (snoop)
[319.363508] Subtest snoop: SKIP (0.000s)
[319.420924] [079/133] (704s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[319.519983] Starting subtest: y-tiled-addfb-size-offset-overflow
[319.524397] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[319.628573] [080/133] (704s left) syncobj_basic (bad-handle-to-fd)
[319.693179] Starting subtest: bad-handle-to-fd
[319.695300] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[319.806119] [081/133] (704s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[319.866716] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[319.971069] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[320.058249] [082/133] (704s left) gem_ppgtt (blt-vs-render-ctx0)
[320.126628] Starting subtest: blt-vs-render-ctx0
[353.251756] Subtest blt-vs-render-ctx0: SUCCESS (33.122s)
[353.411266] [083/133] (670s left) kms_pm_rpm (pm-tiling)
[355.007905] Starting subtest: pm-tiling
[355.012781] Subtest pm-tiling: SKIP (0.000s)
[355.793921] [084/133] (668s left) perf_pmu (all-busy-idle-check-all)
[355.833881] Starting subtest: all-busy-idle-check-all
[356.886690] Subtest all-busy-idle-check-all: SUCCESS (1.054s)
[357.004428] [085/133] (667s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[357.070690] Subtest untiled-to-tiled: SKIP (0.000s)
[357.161184] [086/133] (667s left) gem_create (create-ext-set-pat)
[357.337561] Starting subtest: create-ext-set-pat
[357.339845] Subtest create-ext-set-pat: SUCCESS (0.001s)
[357.455210] [087/133] (666s left) kms_plane_lowres (tiling-4)
[357.570944] Starting subtest: tiling-4
[357.573099] Starting dynamic subtest: pipe-A-eDP-1
[357.577515] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.869340] Starting dynamic subtest: pipe-B-eDP-1
[357.874238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.890275] Starting dynamic subtest: pipe-C-eDP-1
[357.895100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.906650] Starting dynamic subtest: pipe-D-eDP-1
[357.910774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.914967] Subtest tiling-4: SKIP (0.297s)
[358.712938] [088/133] (665s left) syncobj_timeline (wait-any-interrupted)
[358.771644] Starting subtest: wait-any-interrupted
[358.875776] Subtest wait-any-interrupted: SUCCESS (0.102s)
[358.992122] [089/133] (665s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[359.099895] Starting subtest: pr-cursor-plane-move-continuous-sf
[359.104137] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[359.206438] [090/133] (665s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[359.260508] Starting subtest: etime-multi-wait-all-for-submit-submitted
[359.363682] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[359.462988] [091/133] (665s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[359.574583] Starting subtest: short-flip-after-cursor-atomic-transitions
[360.508190] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.935s)
[361.343307] [092/133] (663s left) drm_mm (drm_mm)
[361.386067] Starting subtest: drm_mm
[361.436789] Starting dynamic subtest: drm_test_mm_init
[361.586526] Dynamic subtest drm_test_mm_init: SUCCESS (0.149s)
[361.598069] Starting dynamic subtest: drm_test_mm_debug
[361.689048] Dynamic subtest drm_test_mm_debug: SUCCESS (0.102s)
[361.700592] Starting dynamic subtest: drm_test_mm_align32
[361.796210] Dynamic subtest drm_test_mm_align32: SUCCESS (0.108s)
[361.806382] Starting dynamic subtest: drm_test_mm_align64
[361.933074] Dynamic subtest drm_test_mm_align64: SUCCESS (0.135s)
[361.944224] Starting dynamic subtest: drm_test_mm_lowest
[362.079955] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.145s)
[362.090579] Starting dynamic subtest: drm_test_mm_highest
[362.241149] Dynamic subtest drm_test_mm_highest: SUCCESS (0.159s)
[362.243184] Subtest drm_mm: SUCCESS (0.854s)
[362.461927] [093/133] (662s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[362.561158] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[362.565730] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[363.681356] [094/133] (660s left) gem_exec_balancer (smoke)
[363.750469] Starting subtest: smoke
[386.349860] Subtest smoke: SUCCESS (22.597s)
[388.052134] [095/133] (636s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[388.160457] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[389.283516] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.123s)
[389.449163] [096/133] (635s left) kms_flip (2x-flip-vs-fences-interruptible)
[389.555909] Starting subtest: 2x-flip-vs-fences-interruptible
[389.559941] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[389.696867] [097/133] (635s left) kms_content_protection (legacy-hdcp14)
[389.847298] Starting subtest: legacy-hdcp14
[389.851530] Subtest legacy-hdcp14: SKIP (0.000s)
[390.007931] [098/133] (634s left) gem_mmap_gtt (basic-write-read)
[390.067924] Subtest basic-write-read: SKIP (0.000s)
[390.139459] [099/133] (634s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[390.237527] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[390.239539] Starting dynamic subtest: pipe-A-eDP-1
[390.298070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[390.595481] Starting dynamic subtest: pipe-B-eDP-1
[391.352132] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.767s)
[391.642418] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.404s)
[392.518907] [100/133] (632s left) kms_lease (invalid-create-leases)
[392.610342] Starting subtest: invalid-create-leases
[392.612350] Subtest invalid-create-leases: SUCCESS (0.005s)
[392.742040] [101/133] (632s left) gem_exec_reloc (basic-cpu-wc)
[392.807798] Subtest basic-cpu-wc: SKIP (0.000s)
[392.882643] [102/133] (632s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[392.982183] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[392.984861] Starting dynamic subtest: pipe-A
[393.208080] Dynamic subtest pipe-A: SUCCESS (0.229s)
[393.217768] Starting dynamic subtest: pipe-B
[394.483488] Dynamic subtest pipe-B: SUCCESS (1.274s)
[394.493318] Starting dynamic subtest: pipe-C
[395.813060] Dynamic subtest pipe-C: SUCCESS (1.329s)
[395.822931] Starting dynamic subtest: pipe-D
[397.148764] Dynamic subtest pipe-D: SUCCESS (1.335s)
[397.151077] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.170s)
[398.342571] [103/133] (626s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[398.447752] Starting subtest: primary-yf-tiled-reflect-x-180
[398.507197] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[398.620202] [104/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[398.722700] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[398.726878] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[398.843089] [105/133] (626s left) perf (invalid-oa-metric-set-id)
[398.999742] Starting subtest: invalid-oa-metric-set-id
[399.010927] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[399.054678] [106/133] (626s left) gem_exec_fence (syncobj-repeat)
[399.529170] Starting subtest: syncobj-repeat
[399.709261] Subtest syncobj-repeat: SUCCESS (0.179s)
[400.960815] [107/133] (624s left) kms_rotation_crc (multiplane-rotation)
[401.059511] Starting subtest: multiplane-rotation
[418.595674] Subtest multiplane-rotation: SUCCESS (17.537s)
[418.734823] [108/133] (606s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[418.798682] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[418.800721] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[418.908678] [109/133] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[418.997407] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[419.000881] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[419.134437] [110/133] (606s left) syncobj_timeline (etime-single-wait-all-submitted)
[419.188936] Starting subtest: etime-single-wait-all-submitted
[419.290792] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s)
[419.379634] [111/133] (605s left) gem_exec_params (invalid-flag)
[419.447425] Starting subtest: invalid-flag
[419.449445] Subtest invalid-flag: SUCCESS (0.000s)
[419.566300] [112/133] (605s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[419.660853] Starting subtest: yf-tiled-64bpp-rotate-0
[419.665271] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[419.780226] [113/133] (605s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[419.876965] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[420.875988] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s)
[421.046934] [114/133] (604s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[421.141197] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[421.167916] Starting dynamic subtest: pipe-A-plane-0
[421.445699] Dynamic subtest pipe-A-plane-0: SUCCESS (0.278s)
[421.461837] Starting dynamic subtest: pipe-A-plane-3
[421.678772] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[422.812566] Starting dynamic subtest: pipe-B-plane-0
[423.104687] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[423.114864] Starting dynamic subtest: pipe-B-plane-3
[423.338129] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[423.648449] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.507s)
[424.495218] [115/133] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[424.606793] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[433.178982] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.574s)
[433.294409] [116/133] (592s left) api_intel_bb (add-remove-objects)
[433.360480] Starting subtest: add-remove-objects
[433.369230] Subtest add-remove-objects: SUCCESS (0.010s)
[433.509626] [117/133] (592s left) kms_pm_rpm (cursor-dpms)
[435.029678] Starting subtest: cursor-dpms
[435.034400] Subtest cursor-dpms: SKIP (0.000s)
[435.801203] [118/133] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[435.903891] Starting subtest: fbcpsr-rgb101010-draw-render
[442.627147] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.725s)
[442.763669] [119/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[442.871715] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[442.876561] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[443.010774] [120/133] (582s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[443.110196] Starting subtest: disable-crc-after-crtc
[443.112611] Starting dynamic subtest: pipe-A-eDP-1
[444.724025] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.613s)
[444.735104] Starting dynamic subtest: pipe-B-eDP-1
[447.085456] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.360s)
[447.095841] Starting dynamic subtest: pipe-C-eDP-1
[449.364618] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.280s)
[449.374536] Starting dynamic subtest: pipe-D-eDP-1
[451.590604] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.224s)
[451.593054] Subtest disable-crc-after-crtc: SUCCESS (8.484s)
[452.444894] [121/133] (573s left) gem_ctx_isolation (clean)
[452.518614] Starting subtest: clean
[452.520849] Starting dynamic subtest: rcs0
[452.563889] Dynamic subtest rcs0: SUCCESS (0.045s)
[452.575301] Starting dynamic subtest: bcs0
[452.654093] Dynamic subtest bcs0: SUCCESS (0.089s)
[452.663697] Starting dynamic subtest: vcs0
[452.742317] Dynamic subtest vcs0: SUCCESS (0.087s)
[452.751948] Starting dynamic subtest: vcs1
[453.960040] Dynamic subtest vcs1: SUCCESS (1.217s)
[453.971856] Starting dynamic subtest: vecs0
[455.899313] Dynamic subtest vecs0: SUCCESS (1.938s)
[455.911073] Starting dynamic subtest: ccs0
[458.000500] Dynamic subtest ccs0: SUCCESS (2.100s)
[458.002821] Subtest clean: SUCCESS (5.482s)
[458.283998] [122/133] (567s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[458.349301] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[458.351651] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[458.492981] [123/133] (567s left) kms_psr (fbc-psr2-primary-page-flip)
[458.601095] Starting subtest: fbc-psr2-primary-page-flip
[458.603333] Starting dynamic subtest: eDP-1
[458.607356] Dynamic subtest eDP-1: SKIP (0.000s)
[458.611441] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[458.684489] [124/133] (567s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[458.781702] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[458.786069] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[458.913488] [125/133] (566s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[459.009426] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[459.013623] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[459.130513] [126/133] (566s left) kms_psr (psr-basic)
[459.226419] Starting subtest: psr-basic
[459.228245] Starting dynamic subtest: eDP-1
[460.820730] Dynamic subtest eDP-1: SUCCESS (1.594s)
[460.823069] Subtest psr-basic: SUCCESS (1.595s)
[461.702798] [127/133] (564s left) gem_softpin (allocator-fork)
[461.772801] Starting subtest: allocator-fork
[463.982454] Subtest allocator-fork: SUCCESS (2.208s)
[464.141319] [128/133] (561s left) gen9_exec_parse (bb-start-cmd)
[464.192775] Subtest bb-start-cmd: SKIP (0.000s)
[464.283491] [129/133] (561s left) gem_barrier_race (remote-request)
[464.349453] Starting subtest: remote-request
[464.351748] Starting dynamic subtest: rcs0
[469.480573] Dynamic subtest rcs0: SUCCESS (5.132s)
[469.482623] Subtest remote-request: SUCCESS (5.134s)
[469.661461] [130/133] (556s left) gem_exec_flush (basic-uc-ro-default)
[469.731127] Starting subtest: basic-uc-ro-default
[475.204285] Subtest basic-uc-ro-default: SUCCESS (5.472s)
[475.401267] [131/133] (550s left) gem_exec_schedule (implicit-boths)
[475.468210] Starting subtest: implicit-boths
[475.470467] Starting dynamic subtest: rcs0
[475.638048] Dynamic subtest rcs0: SUCCESS (0.179s)
[475.650740] Starting dynamic subtest: vcs0
[475.744524] Dynamic subtest vcs0: SUCCESS (0.105s)
[475.761475] Starting dynamic subtest: vcs1
[475.857947] Dynamic subtest vcs1: SUCCESS (0.113s)
[475.870902] Starting dynamic subtest: vecs0
[475.982832] Dynamic subtest vecs0: SUCCESS (0.124s)
[475.996056] Starting dynamic subtest: ccs0
[476.120706] Dynamic subtest ccs0: SUCCESS (0.137s)
[476.123124] Subtest implicit-boths: SUCCESS (0.663s)
[477.020457] [132/133] (549s left) sysfs_timeslice_duration (timeout)
[477.087624] Starting subtest: timeout
[477.090049] Starting dynamic subtest: vecs0
[486.926867] Dynamic subtest vecs0: SUCCESS (9.835s)
[486.939309] Starting dynamic subtest: ccs0
[488.298377] Dynamic subtest ccs0: SUCCESS (1.370s)
[488.309723] Starting dynamic subtest: vcs0
[497.906089] Dynamic subtest vcs0: SUCCESS (9.604s)
[497.918612] Starting dynamic subtest: bcs0
[498.571614] Dynamic subtest bcs0: SUCCESS (0.666s)
[498.581037] Starting dynamic subtest: rcs0
[499.996042] Dynamic subtest rcs0: SUCCESS (1.421s)
[500.008904] Starting dynamic subtest: vcs1
[509.930880] Dynamic subtest vcs1: SUCCESS (9.931s)
[509.933305] Subtest timeout: SUCCESS (32.840s)
[510.018653] [133/133] (516s left) syncobj_wait (multi-wait-for-submit-submitted)
[510.083087] Starting subtest: multi-wait-for-submit-submitted
[510.186888] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[510.274675] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: i915_query
results: parsing output: 6/ for test: kms_psr2_su
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: prime_busy
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: i915_module_load
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: kms_cursor_edge_walk
results: parsing output: 40/ for test: gem_vm_create
results: parsing output: 41/ for test: gem_exec_capture
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: gem_madvise
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: i915_pm_rpm
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_ctx_sseu
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_dp_linktrain_fallback
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_tiled_display
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: gem_pread
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_ppgtt
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: gem_set_tiling_vs_blt
results: parsing output: 85/ for test: gem_create
results: parsing output: 86/ for test: kms_plane_lowres
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: drm_mm
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: gem_ctx_isolation
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: gem_barrier_race
results: parsing output: 129/ for test: gem_exec_flush
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: sysfs_timeslice_duration
results: parsing output: 132/ for test: syncobj_wait
Done.