[74.382828] Initializing watchdogs
[74.382927]   /dev/watchdog0
[74.398275] [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]
[74.402871] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.405376] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.408824] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[74.539585] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[74.543716] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[74.628271] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[74.723454] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[74.727937] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[74.814250] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[74.911358] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[75.978785] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.067s)
[76.111217] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[76.203932] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[82.735928] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.536s)
[82.859232] [005/133] (952s left) gem_exec_balancer (noheartbeat)
[83.130400] Starting subtest: noheartbeat
[83.135463] Subtest noheartbeat: SKIP (0.000s)
[83.230397] [006/133] (951s left) syncobj_wait (multi-wait-submitted-signaled)
[83.281579] Starting subtest: multi-wait-submitted-signaled
[83.283492] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[83.366807] [007/133] (951s left) gen7_exec_parse (batch-without-end)
[83.421593] Subtest batch-without-end: SKIP (0.000s)
[83.488514] [008/133] (951s left) gem_pread (exhaustion)
[83.541398] Subtest exhaustion: SKIP (0.000s)
[83.607517] [009/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[83.718175] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[83.722371] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[83.817394] [010/133] (951s left) kms_cursor_crc (cursor-sliding-max-size)
[84.122880] Starting subtest: cursor-sliding-max-size
[84.129687] Subtest cursor-sliding-max-size: SKIP (0.000s)
[84.253260] [011/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[84.356476] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[84.359930] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[84.454747] [012/133] (950s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[84.552198] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[84.554111] Starting dynamic subtest: pipe-A-eDP-1
[90.486694] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.934s)
[90.496446] Starting dynamic subtest: pipe-B-eDP-1
[97.130589] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[97.132979] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.578s)
[97.991403] [013/133] (937s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[98.099366] Starting subtest: fbc-rgb565-draw-blt
[102.276981] Subtest fbc-rgb565-draw-blt: SUCCESS (4.181s)
[103.398563] [014/133] (932s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[103.503628] Starting subtest: plane-upscale-20x20-with-rotation
[103.505929] Starting dynamic subtest: pipe-A
[103.729543] Dynamic subtest pipe-A: SUCCESS (0.227s)
[103.738565] Starting dynamic subtest: pipe-B
[104.996206] Dynamic subtest pipe-B: SUCCESS (1.265s)
[105.005811] Starting dynamic subtest: pipe-C
[106.341354] Dynamic subtest pipe-C: SUCCESS (1.345s)
[106.351636] Starting dynamic subtest: pipe-D
[107.673537] Dynamic subtest pipe-D: SUCCESS (1.332s)
[107.675955] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.172s)
[108.864928] [015/133] (926s left) gem_exec_flush (basic-wb-ro-before-default)
[108.927583] Starting subtest: basic-wb-ro-before-default
[114.420768] Subtest basic-wb-ro-before-default: SUCCESS (5.494s)
[114.608755] [016/133] (920s left) gem_eio (in-flight-internal-immediate)
[114.836434] Starting subtest: in-flight-internal-immediate
[115.995970] Subtest in-flight-internal-immediate: SUCCESS (1.159s)
[116.129388] [017/133] (919s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[116.223833] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[116.250484] Starting dynamic subtest: pipe-A-plane-0
[116.539269] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[116.547591] Starting dynamic subtest: pipe-A-plane-3
[116.772585] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[117.837041] Starting dynamic subtest: pipe-B-plane-0
[118.129696] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[118.139156] Starting dynamic subtest: pipe-B-plane-3
[118.374110] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[118.684272] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.461s)
[119.500453] [018/133] (916s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[119.763931] Starting subtest: cursor-rapid-movement-256x256
[119.766256] Starting dynamic subtest: pipe-A-eDP-1
[120.305146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[120.332273] Starting dynamic subtest: pipe-D-eDP-1
[121.524077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[121.526089] Subtest cursor-rapid-movement-256x256: SUCCESS (1.760s)
[122.372193] [019/133] (913s left) kms_psr (psr2-sprite-plane-move)
[122.462055] Starting subtest: psr2-sprite-plane-move
[122.464393] Starting dynamic subtest: eDP-1
[124.208088] Dynamic subtest eDP-1: SUCCESS (1.747s)
[124.210305] Subtest psr2-sprite-plane-move: SUCCESS (1.748s)
[125.041059] [020/133] (910s left) kms_invalid_mode (bad-vsync-start)
[125.145164] Starting subtest: bad-vsync-start
[125.147556] Starting dynamic subtest: pipe-A-eDP-1
[125.428848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[125.437518] Starting dynamic subtest: pipe-B-eDP-1
[125.439672] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[125.447350] Starting dynamic subtest: pipe-C-eDP-1
[125.449516] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[125.457089] Starting dynamic subtest: pipe-D-eDP-1
[125.458922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[125.460767] Subtest bad-vsync-start: SUCCESS (0.291s)
[126.276403] [021/133] (909s left) kms_cursor_crc (cursor-size-change)
[126.377588] Starting subtest: cursor-size-change
[126.379727] Starting dynamic subtest: pipe-A-eDP-1
[127.166269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[127.175759] Starting dynamic subtest: pipe-D-eDP-1
[128.637187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.472s)
[128.639459] Subtest cursor-size-change: SUCCESS (2.261s)
[129.437857] [022/133] (906s left) kms_addfb_basic (legacy-format)
[129.496393] Starting subtest: legacy-format
[129.519572] Subtest legacy-format: SUCCESS (0.022s)
[129.659824] [023/133] (906s left) gem_exec_schedule (promotion)
[129.726043] Starting subtest: promotion
[129.728128] Starting dynamic subtest: rcs0
[129.838833] Dynamic subtest rcs0: SUCCESS (0.118s)
[129.850857] Starting dynamic subtest: vcs0
[129.941501] Dynamic subtest vcs0: SUCCESS (0.101s)
[129.952912] Starting dynamic subtest: vcs1
[130.039794] Dynamic subtest vcs1: SUCCESS (0.097s)
[130.053167] Starting dynamic subtest: vecs0
[130.128853] Dynamic subtest vecs0: SUCCESS (0.088s)
[130.139162] Starting dynamic subtest: ccs0
[130.235337] Dynamic subtest ccs0: SUCCESS (0.105s)
[130.237845] Subtest promotion: SUCCESS (0.515s)
[130.992585] [024/133] (904s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[131.088622] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[131.093071] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[131.188480] [025/133] (904s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[131.573613] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[132.345305] [026/133] (903s left) gem_exec_schedule (fairslice-all)
[132.428051] Starting subtest: fairslice-all
[134.482883] Subtest fairslice-all: SUCCESS (2.056s)
[134.776393] [027/133] (901s left) kms_lease (implicit-plane-lease)
[134.871185] Starting subtest: implicit-plane-lease
[134.873464] Subtest implicit-plane-lease: SUCCESS (0.002s)
[134.988506] [028/133] (901s left) kms_cursor_crc (cursor-alpha-opaque)
[135.074708] Starting subtest: cursor-alpha-opaque
[135.076988] Starting dynamic subtest: pipe-A-eDP-1
[135.702658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.630s)
[135.711815] Starting dynamic subtest: pipe-D-eDP-1
[136.964488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s)
[136.967148] Subtest cursor-alpha-opaque: SUCCESS (1.895s)
[137.828363] [029/133] (898s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[137.921959] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[137.926549] Starting dynamic subtest: pipe-A-eDP-1
[137.948890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[137.959603] Starting dynamic subtest: pipe-B-eDP-1
[137.980541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[137.988354] Starting dynamic subtest: pipe-C-eDP-1
[138.009445] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.017271] Starting dynamic subtest: pipe-D-eDP-1
[138.039190] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.043528] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[140.191917] [030/133] (895s left) syncobj_timeline (reset-signaled)
[140.238954] Starting subtest: reset-signaled
[140.241186] Subtest reset-signaled: SUCCESS (0.001s)
[140.336752] [031/133] (895s left) gem_exec_reloc (basic-cpu-active)
[140.394030] Subtest basic-cpu-active: SKIP (0.000s)
[140.463477] [032/133] (895s left) gem_exec_parallel (fds)
[140.523861] Starting subtest: fds
[140.526258] Starting dynamic subtest: rcs0
[143.416820] Dynamic subtest rcs0: SUCCESS (2.891s)
[143.425538] Starting dynamic subtest: bcs0
[147.147701] Dynamic subtest bcs0: SUCCESS (3.728s)
[147.156864] Starting dynamic subtest: vcs0
[151.199324] Dynamic subtest vcs0: SUCCESS (4.051s)
[151.210536] Starting dynamic subtest: vcs1
[155.327745] Dynamic subtest vcs1: SUCCESS (4.126s)
[155.338959] Starting dynamic subtest: vecs0
[160.939729] Dynamic subtest vecs0: SUCCESS (5.612s)
[160.951201] Starting dynamic subtest: ccs0
[165.485601] Dynamic subtest ccs0: SUCCESS (4.544s)
[165.488526] Subtest fds: SUCCESS (24.962s)
[165.694754] [033/133] (870s left) kms_vblank (wait-busy)
[165.789936] Starting subtest: wait-busy
[165.792237] Starting dynamic subtest: pipe-A-eDP-1
[167.668254] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[167.682260] Starting dynamic subtest: pipe-D-eDP-1
[170.247445] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[170.249413] Subtest wait-busy: SUCCESS (4.456s)
[171.043405] [034/133] (865s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[171.132076] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[171.136162] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[171.215764] [035/133] (865s left) kms_sequence (queue-busy)
[171.306139] Starting subtest: queue-busy
[171.308047] Starting dynamic subtest: pipe-A-eDP-1
[173.236743] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[173.245871] Starting dynamic subtest: pipe-B-eDP-1
[175.846403] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.609s)
[175.855912] Starting dynamic subtest: pipe-C-eDP-1
[178.446069] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.600s)
[178.455660] Starting dynamic subtest: pipe-D-eDP-1
[180.996928] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[180.998855] Subtest queue-busy: SUCCESS (9.691s)
[181.803781] [036/133] (854s left) gem_exec_whisper (basic-fds-forked-all)
[181.869071] Starting subtest: basic-fds-forked-all
[204.330037] Subtest basic-fds-forked-all: SUCCESS (22.456s)
[204.513102] [037/133] (831s left) kms_cursor_legacy (torture-bo)
[204.628069] Starting subtest: torture-bo
[204.630368] Starting dynamic subtest: pipe-A
[210.299513] Dynamic subtest pipe-A: SUCCESS (5.669s)
[210.319707] Starting dynamic subtest: pipe-B
[217.349982] Dynamic subtest pipe-B: SUCCESS (7.049s)
[217.359724] Starting dynamic subtest: pipe-C
[224.817098] Dynamic subtest pipe-C: SUCCESS (7.466s)
[224.827887] Starting dynamic subtest: pipe-D
[231.559525] Dynamic subtest pipe-D: SUCCESS (6.740s)
[231.568909] Starting dynamic subtest: all-pipes
[238.421534] Dynamic subtest all-pipes: SUCCESS (6.859s)
[238.424216] Subtest torture-bo: SUCCESS (33.791s)
[238.579642] [038/133] (797s left) perf_pmu (most-busy-idle-check-all)
[238.624474] Starting subtest: most-busy-idle-check-all
[238.626469] Starting dynamic subtest: rcs0
[239.892317] Dynamic subtest rcs0: SUCCESS (1.267s)
[239.904739] Starting dynamic subtest: bcs0
[241.877537] Dynamic subtest bcs0: SUCCESS (1.983s)
[241.889466] Starting dynamic subtest: vcs0
[243.924859] Dynamic subtest vcs0: SUCCESS (2.045s)
[243.937242] Starting dynamic subtest: vcs1
[245.909634] Dynamic subtest vcs1: SUCCESS (1.982s)
[245.922599] Starting dynamic subtest: vecs0
[247.895400] Dynamic subtest vecs0: SUCCESS (1.982s)
[247.907909] Starting dynamic subtest: ccs0
[249.898023] Dynamic subtest ccs0: SUCCESS (1.978s)
[249.902395] Subtest most-busy-idle-check-all: SUCCESS (11.252s)
[250.009903] [039/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[250.117529] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[256.990078] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.873s)
[257.138660] [040/133] (779s left) gem_exec_fence (basic-wait)
[257.322836] Starting subtest: basic-wait
[257.325234] Starting dynamic subtest: rcs0
[257.377836] Dynamic subtest rcs0: SUCCESS (0.057s)
[257.389594] Starting dynamic subtest: bcs0
[257.437543] Dynamic subtest bcs0: SUCCESS (0.058s)
[257.448904] Starting dynamic subtest: vcs0
[257.507909] Dynamic subtest vcs0: SUCCESS (0.069s)
[257.519029] Starting dynamic subtest: vcs1
[257.572219] Dynamic subtest vcs1: SUCCESS (0.062s)
[257.584424] Starting dynamic subtest: vecs0
[257.635320] Dynamic subtest vecs0: SUCCESS (0.061s)
[257.645467] Starting dynamic subtest: ccs0
[257.694427] Dynamic subtest ccs0: SUCCESS (0.057s)
[257.696760] Subtest basic-wait: SUCCESS (0.376s)
[259.929935] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[259.933379] [041/133] (776s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[260.027703] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[260.029898] Starting dynamic subtest: pipe-A-eDP-1
[260.085174] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[260.093730] Starting dynamic subtest: pipe-B-eDP-1
[260.149060] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[260.159486] Starting dynamic subtest: pipe-C-eDP-1
[260.216491] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[260.226876] Starting dynamic subtest: pipe-D-eDP-1
[260.284630] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[260.288683] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[262.254900] [042/133] (774s left) gem_lmem_swapping (verify-ccs)
[262.301519] Subtest verify-ccs: SKIP (0.000s)
[262.343089] [043/133] (774s left) sw_sync (timeline_closed_signaled)
[262.383817] Starting subtest: timeline_closed_signaled
[262.386088] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[262.446451] [044/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[262.536086] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[262.540104] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[262.627863] [045/133] (774s left) kms_prop_blob (invalid-set-prop-any)
[262.678341] Starting subtest: invalid-set-prop-any
[262.680266] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[262.761655] [046/133] (773s left) kms_flip (2x-flip-vs-expired-vblank)
[262.853196] Starting subtest: 2x-flip-vs-expired-vblank
[262.865038] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[262.953230] [047/133] (773s left) gem_lmem_swapping (parallel-random-engines)
[262.993222] Subtest parallel-random-engines: SKIP (0.000s)
[263.045617] [048/133] (773s left) kms_flip (plain-flip-fb-recreate-interruptible)
[263.147723] Starting subtest: plain-flip-fb-recreate-interruptible
[263.149996] Starting dynamic subtest: A-eDP1
[272.048038] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[272.058302] Starting dynamic subtest: B-eDP1
[280.888091] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[280.900834] Starting dynamic subtest: C-eDP1
[289.707497] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[289.719226] Starting dynamic subtest: D-eDP1
[298.529322] Dynamic subtest D-eDP1: SUCCESS (8.819s)
[298.533312] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.382s)
[299.720037] [049/133] (737s left) api_intel_bb (object-reloc-keep-cache)
[299.780236] Starting subtest: object-reloc-keep-cache
[299.784909] Subtest object-reloc-keep-cache: SKIP (0.003s)
[299.907516] [050/133] (736s left) kms_pm_dc (dc5-dpms)
[301.006746] Starting subtest: dc5-dpms
[303.094108] Subtest dc5-dpms: SUCCESS (2.086s)
[303.172340] [051/133] (733s left) kms_plane_cursor (overlay)
[303.263818] Starting subtest: overlay
[303.268332] Starting dynamic subtest: pipe-A-eDP-1-size-64
[305.907459] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.644s)
[305.972429] Starting dynamic subtest: pipe-A-eDP-1-size-128
[308.620345] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.659s)
[308.679579] Starting dynamic subtest: pipe-A-eDP-1-size-256
[311.210361] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[311.570707] Starting dynamic subtest: pipe-B-eDP-1-size-64
[314.732063] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.170s)
[314.797904] Starting dynamic subtest: pipe-B-eDP-1-size-128
[317.320658] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.537s)
[317.381343] Starting dynamic subtest: pipe-B-eDP-1-size-256
[319.933330] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[320.293740] Starting dynamic subtest: pipe-C-eDP-1-size-64
[323.152135] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.872s)
[323.190698] Starting dynamic subtest: pipe-C-eDP-1-size-128
[325.297739] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.114s)
[325.335140] Starting dynamic subtest: pipe-C-eDP-1-size-256
[327.441709] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[327.770848] Starting dynamic subtest: pipe-D-eDP-1-size-64
[330.637219] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.878s)
[330.675745] Starting dynamic subtest: pipe-D-eDP-1-size-128
[332.793080] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[332.831125] Starting dynamic subtest: pipe-D-eDP-1-size-256
[334.982095] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[335.302718] Subtest overlay: SUCCESS (32.037s)
[336.163990] [052/133] (700s left) gem_exec_reloc (basic-wc-active)
[336.236145] Subtest basic-wc-active: SKIP (0.000s)
[336.307429] [053/133] (700s left) kms_psr (pr-primary-mmap-gtt)
[336.407895] Starting subtest: pr-primary-mmap-gtt
[336.412155] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[336.480542] [054/133] (700s left) gem_exec_schedule (lateslice)
[336.550144] Starting subtest: lateslice
[336.552042] Starting dynamic subtest: rcs0
[336.560657] Dynamic subtest rcs0: SUCCESS (0.020s)
[336.570308] Starting dynamic subtest: bcs0
[336.579030] Dynamic subtest bcs0: SUCCESS (0.018s)
[336.588300] Starting dynamic subtest: vcs0
[336.598064] Dynamic subtest vcs0: SUCCESS (0.018s)
[336.607018] Starting dynamic subtest: vcs1
[336.618594] Dynamic subtest vcs1: SUCCESS (0.020s)
[336.627450] Starting dynamic subtest: vecs0
[336.638039] Dynamic subtest vecs0: SUCCESS (0.019s)
[336.651631] Starting dynamic subtest: ccs0
[336.659914] Dynamic subtest ccs0: SUCCESS (0.021s)
[336.662113] Subtest lateslice: SUCCESS (0.120s)
[338.019824] [055/133] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[338.123329] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[345.676264] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.557s)
[345.825671] [056/133] (691s left) kms_color (ctm-max)
[345.912892] Starting subtest: ctm-max
[345.915137] Starting dynamic subtest: pipe-A-eDP-1
[346.625827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[346.635576] Starting dynamic subtest: pipe-B-eDP-1
[348.038122] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[348.047586] Starting dynamic subtest: pipe-C-eDP-1
[349.403530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[349.412777] Starting dynamic subtest: pipe-D-eDP-1
[350.746838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[350.749185] Subtest ctm-max: SUCCESS (4.835s)
[351.544962] [057/133] (685s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[351.602114] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[351.604374] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[351.703489] [058/133] (685s left) gem_eio (reset-stress)
[351.935629] Starting subtest: reset-stress
[351.937981] Starting dynamic subtest: render
[356.962067] Dynamic subtest render: SUCCESS (5.024s)
[356.980026] Starting dynamic subtest: bsd1
[375.461974] Dynamic subtest bsd1: SUCCESS (18.499s)
[375.479086] Starting dynamic subtest: bsd2
[393.470644] Dynamic subtest bsd2: SUCCESS (18.006s)
[393.486990] Starting dynamic subtest: blt
[393.492033] Dynamic subtest blt: SKIP (0.000s)
[393.500921] Starting dynamic subtest: vebox
[411.444698] Dynamic subtest vebox: SUCCESS (17.971s)
[411.447645] Subtest reset-stress: SUCCESS (59.505s)
[412.921796] [059/133] (624s left) kms_addfb_basic (bad-pitch-256)
[413.004353] Starting subtest: bad-pitch-256
[413.006653] Subtest bad-pitch-256: SUCCESS (0.000s)
[413.146046] [060/133] (624s left) kms_addfb_basic (bo-too-small)
[413.248775] Starting subtest: bo-too-small
[413.251094] Subtest bo-too-small: SUCCESS (0.000s)
[413.351353] [061/133] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[413.457725] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[413.461813] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[413.561868] [062/133] (623s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[413.653838] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[413.658238] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[413.726098] [063/133] (623s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[413.813024] Starting subtest: disable-crc-after-crtc
[413.815375] Starting dynamic subtest: pipe-A-eDP-1
[415.484156] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.671s)
[415.494533] Starting dynamic subtest: pipe-B-eDP-1
[417.765917] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.279s)
[417.776271] Starting dynamic subtest: pipe-C-eDP-1
[419.998907] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.231s)
[420.013640] Starting dynamic subtest: pipe-D-eDP-1
[422.274684] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[422.276794] Subtest disable-crc-after-crtc: SUCCESS (8.464s)
[423.102943] [064/133] (614s left) kms_chamelium_frames (hdmi-crc-multiple)
[423.502042] Subtest hdmi-crc-multiple: SKIP (0.000s)
[424.324012] [065/133] (613s left) perf (oa-formats)
[424.447651] Starting subtest: oa-formats
[424.449819] Starting dynamic subtest: 0-rcs0
[424.461143] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[424.470768] Starting dynamic subtest: 1-vecs0
[424.482757] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[424.485080] Subtest oa-formats: SUCCESS (0.037s)
[424.534430] [066/133] (613s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[424.634398] Starting subtest: dsc-fractional-bpp-with-bpc
[424.664425] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[424.704342] [067/133] (612s left) syncobj_eventfd (timeline-wait)
[424.772106] Starting subtest: timeline-wait
[424.781843] Subtest timeline-wait: SUCCESS (0.012s)
[424.863641] [068/133] (612s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[424.958212] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[424.960117] Starting dynamic subtest: pipe-A-eDP-1
[441.317992] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.507s)
[441.328239] Starting dynamic subtest: pipe-B-eDP-1
[458.248618] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.446s)
[458.259044] Starting dynamic subtest: pipe-C-eDP-1
[475.244746] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.367s)
[475.255479] Starting dynamic subtest: pipe-D-eDP-1
[492.252681] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.385s)
[492.254568] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.711s)
[493.454761] [069/133] (544s left) gem_mmap_offset (isolation)
[493.511834] Starting subtest: isolation
[493.528744] Subtest isolation: SUCCESS (0.007s)
[493.610288] [070/133] (544s left) kms_chamelium_color (ctm-negative)
[493.697330] Subtest ctm-negative: SKIP (0.000s)
[493.742138] [071/133] (544s left) kms_hdmi_inject (inject-audio)
[494.084864] Starting subtest: inject-audio
[494.366646] Subtest inject-audio: SUCCESS (0.293s)
[494.979537] [072/133] (542s left) i915_drm_fdinfo (virtual-idle)
[495.017481] Starting subtest: virtual-idle
[498.065655] Subtest virtual-idle: SUCCESS (3.117s)
[498.142006] [073/133] (539s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[498.236043] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[498.240112] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[498.344308] [074/133] (539s left) gem_set_tiling_vs_gtt
[498.466253] [075/133] (539s left) api_intel_allocator (reopen-fork)
[498.517682] Starting subtest: reopen-fork
[501.970988] Subtest reopen-fork: SUCCESS (3.501s)
[502.045171] [076/133] (535s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[502.141128] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[502.143399] Starting dynamic subtest: pipe-A-default-mode
[504.855926] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[504.858350] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.740s)
[505.675781] [077/133] (532s left) gem_eio (wait-1us)
[505.910723] Starting subtest: wait-1us
[506.369919] Subtest wait-1us: SUCCESS (0.462s)
[506.480985] [078/133] (531s left) gem_exec_create (forked)
[506.529270] Starting subtest: forked
[506.531665] Starting dynamic subtest: smem
[527.702648] Dynamic subtest smem: SUCCESS (21.213s)
[527.705743] Subtest forked: SUCCESS (21.215s)
[527.898981] [079/133] (510s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[527.963657] Starting subtest: etime-single-wait-all-for-submit-submitted
[528.065202] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[528.151606] [080/133] (509s left) gem_exec_params (rel-constants-invalid-ring)
[528.219060] Starting subtest: rel-constants-invalid-ring
[528.221518] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[528.330923] [081/133] (509s left) kms_flip (plain-flip-interruptible)
[528.435135] Starting subtest: plain-flip-interruptible
[528.437012] Starting dynamic subtest: A-eDP1
[530.104500] Dynamic subtest A-eDP1: SUCCESS (1.666s)
[530.118177] Starting dynamic subtest: B-eDP1
[531.713016] Dynamic subtest B-eDP1: SUCCESS (1.606s)
[531.725617] Starting dynamic subtest: C-eDP1
[533.386226] Dynamic subtest C-eDP1: SUCCESS (1.671s)
[533.397729] Starting dynamic subtest: D-eDP1
[534.996475] Dynamic subtest D-eDP1: SUCCESS (1.600s)
[534.999007] Subtest plain-flip-interruptible: SUCCESS (6.553s)
[536.147826] [082/133] (502s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[536.259586] Starting subtest: short-flip-before-cursor-atomic-transitions
[537.221487] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.963s)
[538.034579] [083/133] (500s left) gem_userptr_blits (forbidden-operations)
[538.097620] Starting subtest: forbidden-operations
[538.102130] Subtest forbidden-operations: SKIP (0.000s)
[538.237851] [084/133] (500s left) gem_ctx_engines (invalid-engines)
[538.308562] Starting subtest: invalid-engines
[538.314038] Subtest invalid-engines: SUCCESS (0.008s)
[538.563723] [085/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[538.672779] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[538.677116] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[538.784908] [086/133] (499s left) kms_pm_rpm (i2c)
[540.933952] Starting subtest: i2c
[546.272061] Subtest i2c: SUCCESS (5.341s)
[546.375235] [087/133] (492s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[546.471626] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[553.235398] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.767s)
[553.370815] [088/133] (485s left) kms_atomic (plane-overlay-legacy)
[553.467574] Starting subtest: plane-overlay-legacy
[553.469856] Starting dynamic subtest: pipe-A-eDP-1
[553.887062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[553.889487] Subtest plane-overlay-legacy: SUCCESS (0.420s)
[554.725628] [089/133] (483s left) syncobj_timeline (wait-all-for-submit-complex)
[554.782998] Starting subtest: wait-all-for-submit-complex
[554.998279] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[555.087723] [090/133] (483s left) gem_request_retire (retire-vma-not-inactive)
[555.151060] Starting subtest: retire-vma-not-inactive
[555.211747] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[555.341457] [091/133] (483s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[555.401983] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[555.406274] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[555.603034] [092/133] (483s left) gem_pxp (reject-modify-context-protection-on)
[555.731109] Starting subtest: reject-modify-context-protection-on
[555.733613] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[555.830336] [093/133] (482s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[555.924203] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[555.926490] Starting dynamic subtest: pipe-A-eDP-1
[555.948143] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.960170] Starting dynamic subtest: pipe-B-eDP-1
[555.981194] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.991679] Starting dynamic subtest: pipe-C-eDP-1
[556.012735] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[556.023224] Starting dynamic subtest: pipe-D-eDP-1
[556.045157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.049505] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[558.196771] [094/133] (480s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[558.297364] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[558.301689] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[558.387571] [095/133] (480s left) gem_exec_fence (syncobj-export)
[558.885315] Starting subtest: syncobj-export
[558.891036] Subtest syncobj-export: SUCCESS (0.005s)
[560.785677] [096/133] (478s left) dumb_buffer (map-invalid-size)
[560.854074] Starting subtest: map-invalid-size
[560.856045] Subtest map-invalid-size: SUCCESS (0.000s)
[560.986612] [097/133] (477s left) kms_psr (fbc-psr-primary-render)
[561.084512] Starting subtest: fbc-psr-primary-render
[561.086734] Starting dynamic subtest: eDP-1
[561.090842] Dynamic subtest eDP-1: SKIP (0.000s)
[561.094948] Subtest fbc-psr-primary-render: SKIP (0.001s)
[561.184351] [098/133] (477s left) fbdev (eof)
[561.221586] Starting subtest: eof
[561.223936] Subtest eof: SUCCESS (0.000s)
[561.305654] [099/133] (477s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[561.414952] Starting subtest: fbc-rgb101010-draw-pwrite
[566.789239] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.379s)
[567.911596] [100/133] (471s left) kms_vrr (negative-basic)
[568.010314] Starting subtest: negative-basic
[568.016721] Starting dynamic subtest: pipe-A-eDP-1
[573.435031] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.418s)
[573.732995] Subtest negative-basic: SUCCESS (5.725s)
[574.544873] [101/133] (464s left) gem_exec_schedule (smoketest-all)
[574.628129] Starting subtest: smoketest-all
[607.006523] Subtest smoketest-all: SUCCESS (32.333s)
[608.818963] [102/133] (430s left) kms_big_fb (y-tiled-addfb-size-overflow)
[608.937187] Starting subtest: y-tiled-addfb-size-overflow
[608.941643] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[609.037404] [103/133] (430s left) vgem_basic (bad-fence)
[609.083864] Starting subtest: bad-fence
[609.085825] Subtest bad-fence: SUCCESS (0.000s)
[609.147376] [104/133] (430s left) gem_ctx_persistence (engines-hostile)
[609.211866] Starting subtest: engines-hostile
[609.213760] Starting dynamic subtest: rcs0
[609.293362] Dynamic subtest rcs0: SUCCESS (0.084s)
[609.308290] Starting dynamic subtest: bcs0
[609.380165] Dynamic subtest bcs0: SUCCESS (0.085s)
[609.395424] Starting dynamic subtest: vcs0
[609.468049] Dynamic subtest vcs0: SUCCESS (0.086s)
[609.480586] Starting dynamic subtest: vcs1
[609.561655] Dynamic subtest vcs1: SUCCESS (0.091s)
[609.575116] Starting dynamic subtest: vecs0
[609.655478] Dynamic subtest vecs0: SUCCESS (0.092s)
[609.669371] Starting dynamic subtest: ccs0
[609.748305] Dynamic subtest ccs0: SUCCESS (0.091s)
[609.751146] Subtest engines-hostile: SUCCESS (0.540s)
[609.832760] [105/133] (429s left) prime_mmap (test_forked)
[609.893640] Starting subtest: test_forked
[609.895156] Starting dynamic subtest: test_forked-smem
[609.931606] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[609.933626] Subtest test_forked: SUCCESS (0.041s)
[610.058841] [106/133] (429s left) gem_spin_batch (resubmit-all)
[610.118951] Starting subtest: resubmit-all
[610.120885] Starting dynamic subtest: rcs0
[610.128729] Dynamic subtest rcs0: SUCCESS (0.012s)
[610.142347] Starting dynamic subtest: bcs0
[610.144368] Dynamic subtest bcs0: SUCCESS (0.002s)
[610.154455] Starting dynamic subtest: vcs0
[610.156093] Dynamic subtest vcs0: SUCCESS (0.002s)
[610.165651] Starting dynamic subtest: vcs1
[610.167210] Dynamic subtest vcs1: SUCCESS (0.002s)
[610.177266] Starting dynamic subtest: vecs0
[610.178998] Dynamic subtest vecs0: SUCCESS (0.002s)
[610.188808] Starting dynamic subtest: ccs0
[610.190477] Dynamic subtest ccs0: SUCCESS (0.002s)
[610.192057] Subtest resubmit-all: SUCCESS (0.027s)
[611.778029] [107/133] (427s left) i915_drm_fdinfo (busy-idle)
[611.822800] Starting subtest: busy-idle
[611.825147] Starting dynamic subtest: rcs0
[611.855385] Dynamic subtest rcs0: SKIP (0.032s)
[611.868514] Starting dynamic subtest: bcs0
[611.872945] Dynamic subtest bcs0: SKIP (0.000s)
[611.882676] Starting dynamic subtest: vcs0
[611.887058] Dynamic subtest vcs0: SKIP (0.000s)
[611.897016] Starting dynamic subtest: vcs1
[611.901424] Dynamic subtest vcs1: SKIP (0.000s)
[611.911412] Starting dynamic subtest: vecs0
[611.915716] Dynamic subtest vecs0: SKIP (0.000s)
[611.925498] Starting dynamic subtest: ccs0
[611.929756] Dynamic subtest ccs0: SKIP (0.000s)
[611.934148] Subtest busy-idle: SKIP (0.038s)
[611.974174] [108/133] (427s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[612.084578] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[612.875350] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[613.038854] [109/133] (426s left) perf (non-sampling-read-error)
[613.126176] Starting subtest: non-sampling-read-error
[613.135770] Subtest non-sampling-read-error: SUCCESS (0.007s)
[613.181889] [110/133] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[613.288751] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[621.881861] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.595s)
[622.008367] [111/133] (417s left) kms_force_connector_basic (force-load-detect)
[622.095081] Starting subtest: force-load-detect
[622.099310] Subtest force-load-detect: SKIP (0.000s)
[622.230034] [112/133] (417s left) kms_content_protection (lic-type-0-hdcp14)
[622.375354] Starting subtest: lic-type-0-hdcp14
[622.379740] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[622.505650] [113/133] (417s left) gem_ctx_shared (q-in-order)
[622.571673] Starting subtest: Q-in-order
[622.574077] Starting dynamic subtest: rcs0
[622.691424] Dynamic subtest rcs0: SUCCESS (0.117s)
[622.706497] Starting dynamic subtest: vcs0
[622.791901] Dynamic subtest vcs0: SUCCESS (0.101s)
[622.809802] Starting dynamic subtest: vcs1
[622.885723] Dynamic subtest vcs1: SUCCESS (0.093s)
[622.905631] Starting dynamic subtest: vecs0
[622.969475] Dynamic subtest vecs0: SUCCESS (0.082s)
[622.989034] Starting dynamic subtest: ccs0
[623.061993] Dynamic subtest ccs0: SUCCESS (0.092s)
[623.065180] Subtest Q-in-order: SUCCESS (0.490s)
[624.829209] [114/133] (414s left) i915_suspend (basic-s3-without-i915)
[624.866864] Starting subtest: basic-s3-without-i915
[628.128731] Subtest basic-s3-without-i915: SKIP (3.256s)
[629.704821] [115/133] (410s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[629.805245] Starting subtest: yf-tiled-32bpp-rotate-270
[629.809542] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[629.896409] [116/133] (409s left) gem_ctx_persistence (legacy-engines-persistence)
[629.950703] Starting subtest: legacy-engines-persistence
[629.953296] Starting dynamic subtest: render
[630.754470] Dynamic subtest render: SUCCESS (0.802s)
[630.767078] Starting dynamic subtest: bsd1
[631.504164] Dynamic subtest bsd1: SUCCESS (0.747s)
[631.518477] Starting dynamic subtest: bsd2
[632.278423] Dynamic subtest bsd2: SUCCESS (0.771s)
[632.291846] Starting dynamic subtest: blt
[633.022621] Dynamic subtest blt: SUCCESS (0.741s)
[633.033898] Starting dynamic subtest: vebox
[633.826463] Dynamic subtest vebox: SUCCESS (0.801s)
[633.829206] Subtest legacy-engines-persistence: SUCCESS (3.877s)
[633.915790] [117/133] (405s left) kms_rotation_crc (primary-rotation-90)
[634.007360] Starting subtest: primary-rotation-90
[634.011886] Subtest primary-rotation-90: SKIP (0.001s)
[634.079494] [118/133] (405s left) syncobj_wait (multi-wait-all-signaled)
[634.145915] Starting subtest: multi-wait-all-signaled
[634.147906] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[634.276684] [119/133] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[634.380576] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[634.384689] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[634.482470] [120/133] (405s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[634.570365] Starting subtest: fbc-pr-sprite-mmap-gtt
[634.574712] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[634.642896] [121/133] (405s left) kms_force_connector_basic (prune-stale-modes)
[634.716530] Starting subtest: prune-stale-modes
[635.030508] Subtest prune-stale-modes: SUCCESS (0.314s)
[635.169562] [122/133] (404s left) perf (stress-open-close)
[635.296283] Starting subtest: stress-open-close
[635.298158] Starting dynamic subtest: 0-rcs0
[637.468194] Dynamic subtest 0-rcs0: SUCCESS (2.172s)
[637.477469] Starting dynamic subtest: 1-vcs0
[639.631783] Dynamic subtest 1-vcs0: SUCCESS (2.163s)
[639.633521] Subtest stress-open-close: SUCCESS (4.336s)
[639.683015] [123/133] (400s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[639.737955] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[639.739854] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[639.854642] [124/133] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[639.953073] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[639.956281] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[640.057090] [125/133] (400s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[640.165184] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[640.167182] Starting dynamic subtest: pipe-A-eDP-1
[640.288271] Dynamic subtest pipe-A-eDP-1: SKIP (0.126s)
[640.300862] Starting dynamic subtest: pipe-B-eDP-1
[641.551779] Dynamic subtest pipe-B-eDP-1: SKIP (1.260s)
[641.556114] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.388s)
[642.804845] [126/133] (397s left) sw_sync (sync_merge_same)
[642.839872] Starting subtest: sync_merge_same
[642.842138] Subtest sync_merge_same: SUCCESS (0.000s)
[642.900818] [127/133] (397s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[642.995962] Starting subtest: 4-tiled-32bpp-rotate-0
[644.453120] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.457s)
[644.594865] [128/133] (395s left) i915_pm_rc6_residency (media-rc6-accuracy)
[644.642518] Starting subtest: media-rc6-accuracy
[644.646134] Subtest media-rc6-accuracy: SKIP (0.000s)
[644.787562] [129/133] (395s left) kms_psr (psr-primary-render)
[644.883587] Starting subtest: psr-primary-render
[644.885347] Starting dynamic subtest: eDP-1
[646.582705] Dynamic subtest eDP-1: SUCCESS (1.698s)
[646.585024] Subtest psr-primary-render: SUCCESS (1.699s)
[647.413580] [130/133] (392s left) kms_getfb (getfb2-handle-closed)
[647.516374] Starting subtest: getfb2-handle-closed
[647.518381] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[647.612761] [131/133] (392s left) gem_wait (write-busy)
[647.671577] Starting subtest: write-busy
[647.673837] Starting dynamic subtest: all-engines
[648.258031] Dynamic subtest all-engines: SUCCESS (0.586s)
[648.275461] Starting dynamic subtest: rcs0
[648.807186] Dynamic subtest rcs0: SUCCESS (0.549s)
[648.823396] Starting dynamic subtest: bcs0
[649.354153] Dynamic subtest bcs0: SUCCESS (0.546s)
[649.370292] Starting dynamic subtest: vcs0
[650.710615] Dynamic subtest vcs0: SUCCESS (1.354s)
[650.728206] Starting dynamic subtest: vcs1
[652.694310] Dynamic subtest vcs1: SUCCESS (1.981s)
[652.711396] Starting dynamic subtest: vecs0
[654.741771] Dynamic subtest vecs0: SUCCESS (2.045s)
[654.758893] Starting dynamic subtest: ccs0
[655.292622] Dynamic subtest ccs0: SUCCESS (0.550s)
[655.294938] Subtest write-busy: SUCCESS (7.623s)
[655.504497] [132/133] (384s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[655.628910] Starting subtest: cursorB-vs-flipB-legacy
[655.633311] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[655.775977] [133/133] (384s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[655.869486] Starting subtest: primary-x-tiled-reflect-x-0
[662.700076] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.834s)
[663.905101] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: gen7_exec_parse
results: parsing output: 7/ for test: gem_pread
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_invalid_mode
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_sequence
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_prop_blob
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_pm_dc
results: parsing output: 50/ for test: kms_plane_cursor
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_chamelium_frames
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: syncobj_eventfd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: kms_hdmi_inject
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_set_tiling_vs_gtt
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_exec_create
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_ctx_engines
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_request_retire
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: dumb_buffer
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: gem_spin_batch
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_pm_rc6_residency
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_getfb
results: parsing output: 130/ for test: gem_wait
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_rotation_crc
Done.