[59.187561] Initializing watchdogs
[59.187615]   /dev/watchdog0
[59.209137] [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]
[59.213823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.216106] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.218880] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[59.313979] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[59.315831] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[59.421674] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[59.512488] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[59.514355] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[59.608976] [003/133] (960s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[59.708734] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[60.846682] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.146s)
[60.985647] [004/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[61.079013] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[67.606950] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.553s)
[67.897240] [005/133] (951s left) gem_exec_balancer (noheartbeat)
[68.255263] Starting subtest: noheartbeat
[68.257349] Subtest noheartbeat: SKIP (0.000s)
[68.346799] [006/133] (951s left) syncobj_wait (multi-wait-submitted-signaled)
[68.404979] Starting subtest: multi-wait-submitted-signaled
[68.406370] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[68.492907] [007/133] (951s left) gen7_exec_parse (batch-without-end)
[68.543345] Subtest batch-without-end: SKIP (0.000s)
[68.617039] [008/133] (951s left) gem_pread (exhaustion)
[68.668794] Subtest exhaustion: SKIP (0.000s)
[68.723834] [009/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[68.816806] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[68.818492] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.912133] [010/133] (951s left) kms_cursor_crc (cursor-sliding-max-size)
[69.189591] Starting subtest: cursor-sliding-max-size
[69.192487] Subtest cursor-sliding-max-size: SKIP (0.000s)
[69.320178] [011/133] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[69.421573] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[69.423460] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[69.509733] [012/133] (950s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[69.602551] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[69.603407] Starting dynamic subtest: pipe-A-eDP-1
[75.544025] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.948s)
[75.550390] Starting dynamic subtest: pipe-B-eDP-1
[82.198055] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.654s)
[82.198957] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.605s)
[83.063217] [013/133] (937s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[83.156286] Starting subtest: fbc-rgb565-draw-blt
[87.372482] Subtest fbc-rgb565-draw-blt: SUCCESS (4.215s)
[88.557092] [014/133] (931s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[88.652377] Starting subtest: plane-upscale-20x20-with-rotation
[88.653291] Starting dynamic subtest: pipe-A
[88.878067] Dynamic subtest pipe-A: SUCCESS (0.227s)
[88.889472] Starting dynamic subtest: pipe-B
[90.141103] Dynamic subtest pipe-B: SUCCESS (1.263s)
[90.147769] Starting dynamic subtest: pipe-C
[91.477517] Dynamic subtest pipe-C: SUCCESS (1.336s)
[91.483976] Starting dynamic subtest: pipe-D
[92.823939] Dynamic subtest pipe-D: SUCCESS (1.346s)
[92.824896] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.173s)
[94.002207] [015/133] (926s left) gem_exec_flush (basic-wb-ro-before-default)
[94.054418] Starting subtest: basic-wb-ro-before-default
[99.520595] Subtest basic-wb-ro-before-default: SUCCESS (5.465s)
[99.712729] [016/133] (920s left) gem_eio (in-flight-internal-immediate)
[99.934241] Starting subtest: in-flight-internal-immediate
[100.972095] Subtest in-flight-internal-immediate: SUCCESS (1.038s)
[101.125206] [017/133] (919s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[101.224074] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[101.252108] Starting dynamic subtest: pipe-A-plane-0
[101.540897] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[101.547971] Starting dynamic subtest: pipe-A-plane-3
[101.785692] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[102.895320] Starting dynamic subtest: pipe-B-plane-0
[103.188291] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[103.196120] Starting dynamic subtest: pipe-B-plane-3
[103.421729] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[103.742971] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.518s)
[104.568568] [018/133] (915s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[104.799169] Starting subtest: cursor-rapid-movement-256x256
[104.801936] Starting dynamic subtest: pipe-A-eDP-1
[105.345164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[105.373320] Starting dynamic subtest: pipe-D-eDP-1
[106.589254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[106.590083] Subtest cursor-rapid-movement-256x256: SUCCESS (1.790s)
[107.436736] [019/133] (912s left) kms_psr (psr2-sprite-plane-move)
[107.532466] Starting subtest: psr2-sprite-plane-move
[107.533399] Starting dynamic subtest: eDP-1
[109.260806] Dynamic subtest eDP-1: SUCCESS (1.728s)
[109.262245] Subtest psr2-sprite-plane-move: SUCCESS (1.728s)
[110.096638] [020/133] (910s left) kms_invalid_mode (bad-vsync-start)
[110.191632] Starting subtest: bad-vsync-start
[110.192669] Starting dynamic subtest: pipe-A-eDP-1
[110.476941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[110.484031] Starting dynamic subtest: pipe-B-eDP-1
[110.485049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[110.491164] Starting dynamic subtest: pipe-C-eDP-1
[110.491923] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[110.498231] Starting dynamic subtest: pipe-D-eDP-1
[110.499059] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[110.499861] Subtest bad-vsync-start: SUCCESS (0.290s)
[111.312851] [021/133] (909s left) kms_cursor_crc (cursor-size-change)
[111.390055] Starting subtest: cursor-size-change
[111.391122] Starting dynamic subtest: pipe-A-eDP-1
[112.189177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[112.196572] Starting dynamic subtest: pipe-D-eDP-1
[113.715019] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[113.715795] Subtest cursor-size-change: SUCCESS (2.325s)
[114.603117] [022/133] (905s left) kms_addfb_basic (legacy-format)
[114.655011] Starting subtest: legacy-format
[114.681075] Subtest legacy-format: SUCCESS (0.022s)
[114.832560] [023/133] (905s left) gem_exec_schedule (promotion)
[114.899014] Starting subtest: promotion
[114.899844] Starting dynamic subtest: rcs0
[115.014673] Dynamic subtest rcs0: SUCCESS (0.116s)
[115.024561] Starting dynamic subtest: vcs0
[115.113541] Dynamic subtest vcs0: SUCCESS (0.098s)
[115.123483] Starting dynamic subtest: vcs1
[115.202622] Dynamic subtest vcs1: SUCCESS (0.088s)
[115.213639] Starting dynamic subtest: vecs0
[115.300298] Dynamic subtest vecs0: SUCCESS (0.097s)
[115.313340] Starting dynamic subtest: ccs0
[115.413775] Dynamic subtest ccs0: SUCCESS (0.112s)
[115.414847] Subtest promotion: SUCCESS (0.516s)
[116.965138] [024/133] (903s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[117.073650] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[117.075385] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[117.172962] [025/133] (903s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[117.561599] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[118.394404] [026/133] (902s left) gem_exec_schedule (fairslice-all)
[118.467276] Starting subtest: fairslice-all
[120.520826] Subtest fairslice-all: SUCCESS (2.055s)
[120.809452] [027/133] (899s left) kms_lease (implicit-plane-lease)
[120.896725] Starting subtest: implicit-plane-lease
[120.897703] Subtest implicit-plane-lease: SUCCESS (0.002s)
[120.995735] [028/133] (899s left) kms_cursor_crc (cursor-alpha-opaque)
[121.075025] Starting subtest: cursor-alpha-opaque
[121.075923] Starting dynamic subtest: pipe-A-eDP-1
[121.710452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[121.718071] Starting dynamic subtest: pipe-D-eDP-1
[122.986510] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[122.987431] Subtest cursor-alpha-opaque: SUCCESS (1.911s)
[123.777427] [029/133] (896s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[123.878427] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[123.879357] Starting dynamic subtest: pipe-A-eDP-1
[123.889251] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.898496] Starting dynamic subtest: pipe-B-eDP-1
[123.906645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.913639] Starting dynamic subtest: pipe-C-eDP-1
[123.921571] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.928329] Starting dynamic subtest: pipe-D-eDP-1
[123.936376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.938121] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[126.094797] [030/133] (894s left) syncobj_timeline (reset-signaled)
[126.149526] Starting subtest: reset-signaled
[126.150543] Subtest reset-signaled: SUCCESS (0.001s)
[126.240195] [031/133] (894s left) gem_exec_reloc (basic-cpu-active)
[126.289907] Subtest basic-cpu-active: SKIP (0.000s)
[126.346542] [032/133] (894s left) gem_exec_parallel (fds)
[126.408751] Starting subtest: fds
[126.409718] Starting dynamic subtest: rcs0
[129.121673] Dynamic subtest rcs0: SUCCESS (2.703s)
[129.132582] Starting dynamic subtest: bcs0
[132.668753] Dynamic subtest bcs0: SUCCESS (3.544s)
[132.678337] Starting dynamic subtest: vcs0
[136.964069] Dynamic subtest vcs0: SUCCESS (4.301s)
[136.974329] Starting dynamic subtest: vcs1
[141.174245] Dynamic subtest vcs1: SUCCESS (4.200s)
[141.185138] Starting dynamic subtest: vecs0
[145.208875] Dynamic subtest vecs0: SUCCESS (4.032s)
[145.219088] Starting dynamic subtest: ccs0
[149.216569] Dynamic subtest ccs0: SUCCESS (4.005s)
[149.217840] Subtest fds: SUCCESS (22.799s)
[149.394674] [033/133] (871s left) kms_vblank (wait-busy)
[149.486925] Starting subtest: wait-busy
[149.487752] Starting dynamic subtest: pipe-A-eDP-1
[151.373294] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[151.382682] Starting dynamic subtest: pipe-D-eDP-1
[153.936668] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[153.938275] Subtest wait-busy: SUCCESS (4.448s)
[154.728802] [034/133] (866s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[154.821279] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[154.823041] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[154.888712] [035/133] (865s left) kms_sequence (queue-busy)
[154.981372] Starting subtest: queue-busy
[154.982278] Starting dynamic subtest: pipe-A-eDP-1
[156.938065] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[156.945147] Starting dynamic subtest: pipe-B-eDP-1
[159.547459] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.608s)
[159.554653] Starting dynamic subtest: pipe-C-eDP-1
[162.145660] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.597s)
[162.153407] Starting dynamic subtest: pipe-D-eDP-1
[164.687578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s)
[164.688593] Subtest queue-busy: SUCCESS (9.706s)
[165.490217] [036/133] (855s left) gem_exec_whisper (basic-fds-forked-all)
[165.539251] Starting subtest: basic-fds-forked-all
[187.408270] Subtest basic-fds-forked-all: SUCCESS (21.866s)
[187.590119] [037/133] (833s left) kms_cursor_legacy (torture-bo)
[187.707858] Starting subtest: torture-bo
[187.708726] Starting dynamic subtest: pipe-A
[193.474051] Dynamic subtest pipe-A: SUCCESS (5.756s)
[193.490463] Starting dynamic subtest: pipe-B
[199.958656] Dynamic subtest pipe-B: SUCCESS (6.490s)
[199.967530] Starting dynamic subtest: pipe-C
[206.831026] Dynamic subtest pipe-C: SUCCESS (6.871s)
[206.848872] Starting dynamic subtest: pipe-D
[213.594155] Dynamic subtest pipe-D: SUCCESS (6.761s)
[213.603474] Starting dynamic subtest: all-pipes
[220.166360] Dynamic subtest all-pipes: SUCCESS (6.563s)
[220.167726] Subtest torture-bo: SUCCESS (32.449s)
[220.310951] [038/133] (800s left) perf_pmu (most-busy-idle-check-all)
[220.347400] Starting subtest: most-busy-idle-check-all
[220.348275] Starting dynamic subtest: rcs0
[221.918508] Dynamic subtest rcs0: SUCCESS (1.561s)
[221.930274] Starting dynamic subtest: bcs0
[223.902971] Dynamic subtest bcs0: SUCCESS (1.982s)
[223.911050] Starting dynamic subtest: vcs0
[225.885869] Dynamic subtest vcs0: SUCCESS (1.980s)
[225.896294] Starting dynamic subtest: vcs1
[227.934984] Dynamic subtest vcs1: SUCCESS (2.046s)
[227.945524] Starting dynamic subtest: vecs0
[229.917767] Dynamic subtest vecs0: SUCCESS (1.980s)
[229.927749] Starting dynamic subtest: ccs0
[231.901888] Dynamic subtest ccs0: SUCCESS (1.982s)
[231.903042] Subtest most-busy-idle-check-all: SUCCESS (11.547s)
[231.989601] [039/133] (788s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[232.085104] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[238.891378] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.807s)
[239.010632] [040/133] (781s left) gem_exec_fence (basic-wait)
[239.184200] Starting subtest: basic-wait
[239.185304] Starting dynamic subtest: rcs0
[239.251324] Dynamic subtest rcs0: SUCCESS (0.076s)
[239.262838] Starting dynamic subtest: bcs0
[239.306508] Dynamic subtest bcs0: SUCCESS (0.053s)
[239.317226] Starting dynamic subtest: vcs0
[239.360400] Dynamic subtest vcs0: SUCCESS (0.051s)
[239.370888] Starting dynamic subtest: vcs1
[239.414056] Dynamic subtest vcs1: SUCCESS (0.052s)
[239.425159] Starting dynamic subtest: vecs0
[239.468546] Dynamic subtest vecs0: SUCCESS (0.052s)
[239.480594] Starting dynamic subtest: ccs0
[239.531429] Dynamic subtest ccs0: SUCCESS (0.061s)
[239.533067] Subtest basic-wait: SUCCESS (0.357s)
[242.053594] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[242.055581] [041/133] (778s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[242.157174] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[242.158392] Starting dynamic subtest: pipe-A-eDP-1
[242.182027] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[242.193825] Starting dynamic subtest: pipe-B-eDP-1
[242.215158] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[242.223489] Starting dynamic subtest: pipe-C-eDP-1
[242.245631] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[242.254568] Starting dynamic subtest: pipe-D-eDP-1
[242.275995] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[242.277617] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[244.371686] [042/133] (776s left) gem_lmem_swapping (verify-ccs)
[244.406465] Subtest verify-ccs: SKIP (0.000s)
[244.442813] [043/133] (776s left) sw_sync (timeline_closed_signaled)
[244.474133] Starting subtest: timeline_closed_signaled
[244.474983] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[244.534657] [044/133] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[244.621359] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[244.622951] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[244.711451] [045/133] (776s left) kms_prop_blob (invalid-set-prop-any)
[244.758453] Starting subtest: invalid-set-prop-any
[244.759212] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[244.864546] [046/133] (776s left) kms_flip (2x-flip-vs-expired-vblank)
[244.948076] Starting subtest: 2x-flip-vs-expired-vblank
[244.958547] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[245.035890] [047/133] (776s left) gem_lmem_swapping (parallel-random-engines)
[245.074591] Subtest parallel-random-engines: SKIP (0.000s)
[245.109071] [048/133] (776s left) kms_flip (plain-flip-fb-recreate-interruptible)
[245.208408] Starting subtest: plain-flip-fb-recreate-interruptible
[245.210846] Starting dynamic subtest: A-eDP1
[254.052470] Dynamic subtest A-eDP1: SUCCESS (8.841s)
[254.062758] Starting dynamic subtest: B-eDP1
[262.868267] Dynamic subtest B-eDP1: SUCCESS (8.814s)
[262.877653] Starting dynamic subtest: C-eDP1
[271.691923] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[271.701406] Starting dynamic subtest: D-eDP1
[280.524076] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[280.526420] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.316s)
[281.699879] [049/133] (739s left) api_intel_bb (object-reloc-keep-cache)
[281.749730] Starting subtest: object-reloc-keep-cache
[281.753306] Subtest object-reloc-keep-cache: SKIP (0.003s)
[281.832810] [050/133] (739s left) kms_pm_dc (dc5-dpms)
[282.919409] Starting subtest: dc5-dpms
[284.992505] Subtest dc5-dpms: SUCCESS (2.062s)
[285.055931] [051/133] (736s left) kms_plane_cursor (overlay)
[285.142428] Starting subtest: overlay
[285.144199] Starting dynamic subtest: pipe-A-eDP-1-size-64
[287.693036] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.551s)
[287.754147] Starting dynamic subtest: pipe-A-eDP-1-size-128
[290.195256] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[290.257254] Starting dynamic subtest: pipe-A-eDP-1-size-256
[292.818123] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[293.184626] Starting dynamic subtest: pipe-B-eDP-1-size-64
[296.329377] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.155s)
[296.396924] Starting dynamic subtest: pipe-B-eDP-1-size-128
[298.898736] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.517s)
[298.956905] Starting dynamic subtest: pipe-B-eDP-1-size-256
[301.475896] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[301.825985] Starting dynamic subtest: pipe-C-eDP-1-size-64
[304.594071] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.777s)
[304.636330] Starting dynamic subtest: pipe-C-eDP-1-size-128
[306.716557] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[306.755238] Starting dynamic subtest: pipe-C-eDP-1-size-256
[308.938508] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[309.269646] Starting dynamic subtest: pipe-D-eDP-1-size-64
[312.133385] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.872s)
[312.172454] Starting dynamic subtest: pipe-D-eDP-1-size-128
[314.300279] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[314.338965] Starting dynamic subtest: pipe-D-eDP-1-size-256
[316.455921] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s)
[316.782082] Subtest overlay: SUCCESS (31.638s)
[317.575212] [052/133] (703s left) gem_exec_reloc (basic-wc-active)
[317.626034] Subtest basic-wc-active: SKIP (0.000s)
[317.688060] [053/133] (703s left) kms_psr (pr-primary-mmap-gtt)
[317.766243] Starting subtest: pr-primary-mmap-gtt
[317.767818] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[317.834689] [054/133] (703s left) gem_exec_schedule (lateslice)
[317.903448] Starting subtest: lateslice
[317.904329] Starting dynamic subtest: rcs0
[317.928876] Dynamic subtest rcs0: SUCCESS (0.027s)
[317.942083] Starting dynamic subtest: bcs0
[317.945701] Dynamic subtest bcs0: SUCCESS (0.016s)
[317.953119] Starting dynamic subtest: vcs0
[317.965282] Dynamic subtest vcs0: SUCCESS (0.019s)
[317.972460] Starting dynamic subtest: vcs1
[317.983729] Dynamic subtest vcs1: SUCCESS (0.018s)
[317.991355] Starting dynamic subtest: vecs0
[318.000460] Dynamic subtest vecs0: SUCCESS (0.016s)
[318.008057] Starting dynamic subtest: ccs0
[318.018785] Dynamic subtest ccs0: SUCCESS (0.018s)
[318.019705] Subtest lateslice: SUCCESS (0.118s)
[319.967717] [055/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[320.058151] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[327.635508] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.578s)
[327.745399] [056/133] (693s left) kms_color (ctm-max)
[327.825216] Starting subtest: ctm-max
[327.826136] Starting dynamic subtest: pipe-A-eDP-1
[328.543520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[328.551271] Starting dynamic subtest: pipe-B-eDP-1
[329.926341] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[329.936051] Starting dynamic subtest: pipe-C-eDP-1
[331.314631] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[331.322276] Starting dynamic subtest: pipe-D-eDP-1
[332.639150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[332.640033] Subtest ctm-max: SUCCESS (4.815s)
[333.456862] [057/133] (688s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[333.506331] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[333.507222] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[333.596584] [058/133] (688s left) gem_eio (reset-stress)
[333.836256] Starting subtest: reset-stress
[333.837207] Starting dynamic subtest: render
[338.925255] Dynamic subtest render: SUCCESS (5.087s)
[338.941511] Starting dynamic subtest: bsd1
[357.408670] Dynamic subtest bsd1: SUCCESS (18.480s)
[357.423455] Starting dynamic subtest: bsd2
[375.478383] Dynamic subtest bsd2: SUCCESS (18.068s)
[375.494481] Starting dynamic subtest: blt
[375.496320] Dynamic subtest blt: SKIP (0.000s)
[375.504510] Starting dynamic subtest: vebox
[393.470052] Dynamic subtest vebox: SUCCESS (17.988s)
[393.471231] Subtest reset-stress: SUCCESS (59.630s)
[394.935815] [059/133] (626s left) kms_addfb_basic (bad-pitch-256)
[394.987053] Starting subtest: bad-pitch-256
[394.987983] Subtest bad-pitch-256: SUCCESS (0.000s)
[395.113901] [060/133] (626s left) kms_addfb_basic (bo-too-small)
[395.210394] Starting subtest: bo-too-small
[395.211243] Subtest bo-too-small: SUCCESS (0.000s)
[395.304965] [061/133] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[395.394332] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[395.395953] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[395.499732] [062/133] (626s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[395.596528] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[395.598097] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[395.663582] [063/133] (626s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[395.749377] Starting subtest: disable-crc-after-crtc
[395.750378] Starting dynamic subtest: pipe-A-eDP-1
[397.371497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.621s)
[397.379481] Starting dynamic subtest: pipe-B-eDP-1
[399.651473] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.278s)
[399.659521] Starting dynamic subtest: pipe-C-eDP-1
[401.881319] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.230s)
[401.889949] Starting dynamic subtest: pipe-D-eDP-1
[404.150286] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.267s)
[404.151111] Subtest disable-crc-after-crtc: SUCCESS (8.402s)
[404.974987] [064/133] (616s left) kms_chamelium_frames (hdmi-crc-multiple)
[405.352082] Subtest hdmi-crc-multiple: SKIP (0.000s)
[406.185878] [065/133] (615s left) perf (oa-formats)
[406.308380] Starting subtest: oa-formats
[406.309216] Starting dynamic subtest: 0-rcs0
[406.326272] Dynamic subtest 0-rcs0: SUCCESS (0.018s)
[406.339393] Starting dynamic subtest: 1-vecs0
[406.350911] Dynamic subtest 1-vecs0: SUCCESS (0.023s)
[406.351813] Subtest oa-formats: SUCCESS (0.044s)
[406.395996] [066/133] (615s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[406.484399] Starting subtest: dsc-fractional-bpp-with-bpc
[406.495951] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[406.566934] [067/133] (615s left) syncobj_eventfd (timeline-wait)
[406.619840] Starting subtest: timeline-wait
[406.629770] Subtest timeline-wait: SUCCESS (0.011s)
[406.714490] [068/133] (615s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[406.802111] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[406.803080] Starting dynamic subtest: pipe-A-eDP-1
[424.088926] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.989s)
[424.097779] Starting dynamic subtest: pipe-B-eDP-1
[442.005392] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[442.013749] Starting dynamic subtest: pipe-C-eDP-1
[460.001817] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.751s)
[460.013545] Starting dynamic subtest: pipe-D-eDP-1
[477.947219] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.686s)
[477.948014] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.203s)
[485.114702] [069/133] (542s left) gem_mmap_offset (isolation)
[485.161445] Starting subtest: isolation
[485.168225] Subtest isolation: SUCCESS (0.006s)
[485.258025] [070/133] (542s left) kms_chamelium_color (ctm-negative)
[485.343509] Subtest ctm-negative: SKIP (0.000s)
[485.388238] [071/133] (542s left) kms_hdmi_inject (inject-audio)
[485.741262] Starting subtest: inject-audio
[486.017862] Subtest inject-audio: SUCCESS (0.282s)
[486.555439] [072/133] (541s left) i915_drm_fdinfo (virtual-idle)
[486.590970] Starting subtest: virtual-idle
[489.663665] Subtest virtual-idle: SUCCESS (3.144s)
[489.724922] [073/133] (538s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[489.826211] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[489.827942] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[489.918866] [074/133] (538s left) gem_set_tiling_vs_gtt
[490.037658] [075/133] (538s left) api_intel_allocator (reopen-fork)
[490.082429] Starting subtest: reopen-fork
[493.385734] Subtest reopen-fork: SUCCESS (3.347s)
[493.448260] [076/133] (534s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[493.541834] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[493.542859] Starting dynamic subtest: pipe-A-default-mode
[496.213608] Dynamic subtest pipe-A-default-mode: SUCCESS (2.699s)
[496.214737] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.701s)
[497.021831] [077/133] (531s left) gem_eio (wait-1us)
[497.261938] Starting subtest: wait-1us
[497.631349] Subtest wait-1us: SUCCESS (0.374s)
[497.767761] [078/133] (530s left) gem_exec_create (forked)
[497.820256] Starting subtest: forked
[497.821189] Starting dynamic subtest: smem
[518.012321] Dynamic subtest smem: SUCCESS (20.247s)
[518.013550] Subtest forked: SUCCESS (20.248s)
[518.194229] [079/133] (510s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[518.254050] Starting subtest: etime-single-wait-all-for-submit-submitted
[518.359367] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[518.435393] [080/133] (510s left) gem_exec_params (rel-constants-invalid-ring)
[518.489651] Starting subtest: rel-constants-invalid-ring
[518.490594] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[518.583791] [081/133] (509s left) kms_flip (plain-flip-interruptible)
[518.678325] Starting subtest: plain-flip-interruptible
[518.680587] Starting dynamic subtest: A-eDP1
[520.344198] Dynamic subtest A-eDP1: SUCCESS (1.662s)
[520.357428] Starting dynamic subtest: B-eDP1
[522.051644] Dynamic subtest B-eDP1: SUCCESS (1.702s)
[522.063055] Starting dynamic subtest: C-eDP1
[523.737884] Dynamic subtest C-eDP1: SUCCESS (1.683s)
[523.746535] Starting dynamic subtest: D-eDP1
[525.342355] Dynamic subtest D-eDP1: SUCCESS (1.601s)
[525.346221] Subtest plain-flip-interruptible: SUCCESS (6.664s)
[526.495155] [082/133] (502s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[526.620379] Starting subtest: short-flip-before-cursor-atomic-transitions
[527.583923] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.963s)
[528.385935] [083/133] (500s left) gem_userptr_blits (forbidden-operations)
[528.443499] Starting subtest: forbidden-operations
[528.445185] Subtest forbidden-operations: SKIP (0.000s)
[528.552539] [084/133] (500s left) gem_ctx_engines (invalid-engines)
[528.609276] Starting subtest: invalid-engines
[528.617520] Subtest invalid-engines: SUCCESS (0.008s)
[528.828225] [085/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[528.910936] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[528.912743] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[529.002185] [086/133] (499s left) kms_pm_rpm (i2c)
[531.027448] Starting subtest: i2c
[536.364843] Subtest i2c: SUCCESS (5.338s)
[536.463218] [087/133] (492s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[536.557320] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[543.309720] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.754s)
[543.427534] [088/133] (485s left) kms_atomic (plane-overlay-legacy)
[543.524826] Starting subtest: plane-overlay-legacy
[543.525755] Starting dynamic subtest: pipe-A-eDP-1
[543.936451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[543.937418] Subtest plane-overlay-legacy: SUCCESS (0.413s)
[544.792324] [089/133] (483s left) syncobj_timeline (wait-all-for-submit-complex)
[544.843547] Starting subtest: wait-all-for-submit-complex
[545.065209] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[545.142416] [090/133] (483s left) gem_request_retire (retire-vma-not-inactive)
[545.194925] Starting subtest: retire-vma-not-inactive
[545.255177] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[545.398510] [091/133] (483s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[545.454294] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[545.456076] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[545.636327] [092/133] (483s left) gem_pxp (reject-modify-context-protection-on)
[545.764009] Starting subtest: reject-modify-context-protection-on
[545.765140] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[545.879869] [093/133] (483s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[545.972771] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[545.973716] Starting dynamic subtest: pipe-A-eDP-1
[545.990735] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[546.000552] Starting dynamic subtest: pipe-B-eDP-1
[546.008833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[546.017297] Starting dynamic subtest: pipe-C-eDP-1
[546.025071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[546.033281] Starting dynamic subtest: pipe-D-eDP-1
[546.041397] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[546.043141] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[548.283720] [094/133] (480s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[548.381818] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[548.383629] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[548.450300] [095/133] (480s left) gem_exec_fence (syncobj-export)
[548.916846] Starting subtest: syncobj-export
[548.921394] Subtest syncobj-export: SUCCESS (0.005s)
[550.961663] [096/133] (478s left) dumb_buffer (map-invalid-size)
[551.008303] Starting subtest: map-invalid-size
[551.009272] Subtest map-invalid-size: SUCCESS (0.000s)
[551.102209] [097/133] (477s left) kms_psr (fbc-psr-primary-render)
[551.193453] Starting subtest: fbc-psr-primary-render
[551.194333] Starting dynamic subtest: eDP-1
[551.196234] Dynamic subtest eDP-1: SKIP (0.000s)
[551.198000] Subtest fbc-psr-primary-render: SKIP (0.001s)
[551.282164] [098/133] (477s left) fbdev (eof)
[551.319870] Starting subtest: eof
[551.320945] Subtest eof: SUCCESS (0.000s)
[551.401335] [099/133] (477s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[551.486435] Starting subtest: fbc-rgb101010-draw-pwrite
[556.907891] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.422s)
[558.077178] [100/133] (471s left) kms_vrr (negative-basic)
[558.172743] Starting subtest: negative-basic
[558.175338] Starting dynamic subtest: pipe-A-eDP-1
[563.646538] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.427s)
[563.908478] Subtest negative-basic: SUCCESS (5.738s)
[564.702688] [101/133] (464s left) gem_exec_schedule (smoketest-all)
[564.769088] Starting subtest: smoketest-all
[597.116283] Subtest smoketest-all: SUCCESS (32.319s)
[598.920649] [102/133] (430s left) kms_big_fb (y-tiled-addfb-size-overflow)
[599.031023] Starting subtest: y-tiled-addfb-size-overflow
[599.033289] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[599.123542] [103/133] (430s left) vgem_basic (bad-fence)
[599.156482] Starting subtest: bad-fence
[599.157533] Subtest bad-fence: SUCCESS (0.000s)
[599.222802] [104/133] (430s left) gem_ctx_persistence (engines-hostile)
[599.274351] Starting subtest: engines-hostile
[599.275255] Starting dynamic subtest: rcs0
[599.395123] Dynamic subtest rcs0: SUCCESS (0.122s)
[599.407950] Starting dynamic subtest: bcs0
[599.492990] Dynamic subtest bcs0: SUCCESS (0.095s)
[599.506970] Starting dynamic subtest: vcs0
[599.579693] Dynamic subtest vcs0: SUCCESS (0.085s)
[599.592264] Starting dynamic subtest: vcs1
[599.689045] Dynamic subtest vcs1: SUCCESS (0.107s)
[599.704101] Starting dynamic subtest: vecs0
[599.787996] Dynamic subtest vecs0: SUCCESS (0.095s)
[599.803674] Starting dynamic subtest: ccs0
[599.875974] Dynamic subtest ccs0: SUCCESS (0.086s)
[599.877285] Subtest engines-hostile: SUCCESS (0.604s)
[599.985952] [105/133] (429s left) prime_mmap (test_forked)
[600.038866] Starting subtest: test_forked
[600.039743] Starting dynamic subtest: test_forked-smem
[600.081472] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[600.082596] Subtest test_forked: SUCCESS (0.044s)
[600.186357] [106/133] (429s left) gem_spin_batch (resubmit-all)
[600.241372] Starting subtest: resubmit-all
[600.242573] Starting dynamic subtest: rcs0
[600.253145] Dynamic subtest rcs0: SUCCESS (0.012s)
[600.267017] Starting dynamic subtest: bcs0
[600.267908] Dynamic subtest bcs0: SUCCESS (0.003s)
[600.277180] Starting dynamic subtest: vcs0
[600.278147] Dynamic subtest vcs0: SUCCESS (0.002s)
[600.286842] Starting dynamic subtest: vcs1
[600.287823] Dynamic subtest vcs1: SUCCESS (0.002s)
[600.299396] Starting dynamic subtest: vecs0
[600.300518] Dynamic subtest vecs0: SUCCESS (0.002s)
[600.308819] Starting dynamic subtest: ccs0
[600.309769] Dynamic subtest ccs0: SUCCESS (0.002s)
[600.310681] Subtest resubmit-all: SUCCESS (0.027s)
[601.863401] [107/133] (427s left) i915_drm_fdinfo (busy-idle)
[601.904794] Starting subtest: busy-idle
[601.905667] Starting dynamic subtest: rcs0
[601.928064] Dynamic subtest rcs0: SKIP (0.023s)
[601.939472] Starting dynamic subtest: bcs0
[601.941447] Dynamic subtest bcs0: SKIP (0.000s)
[601.950415] Starting dynamic subtest: vcs0
[601.952236] Dynamic subtest vcs0: SKIP (0.000s)
[601.960682] Starting dynamic subtest: vcs1
[601.962451] Dynamic subtest vcs1: SKIP (0.000s)
[601.971224] Starting dynamic subtest: vecs0
[601.973459] Dynamic subtest vecs0: SKIP (0.000s)
[601.986529] Starting dynamic subtest: ccs0
[601.988131] Dynamic subtest ccs0: SKIP (0.000s)
[601.989915] Subtest busy-idle: SKIP (0.028s)
[602.020230] [108/133] (427s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[602.112664] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[602.926990] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[603.083446] [109/133] (426s left) perf (non-sampling-read-error)
[603.234610] Starting subtest: non-sampling-read-error
[603.244846] Subtest non-sampling-read-error: SUCCESS (0.010s)
[603.282203] [110/133] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[603.374959] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[612.333326] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.959s)
[612.446348] [111/133] (417s left) kms_force_connector_basic (force-load-detect)
[612.523821] Starting subtest: force-load-detect
[612.525595] Subtest force-load-detect: SKIP (0.000s)
[612.635968] [112/133] (416s left) kms_content_protection (lic-type-0-hdcp14)
[612.779086] Starting subtest: lic-type-0-hdcp14
[612.780924] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[612.913879] [113/133] (416s left) gem_ctx_shared (q-in-order)
[612.982032] Starting subtest: Q-in-order
[612.983078] Starting dynamic subtest: rcs0
[613.091354] Dynamic subtest rcs0: SUCCESS (0.108s)
[613.107934] Starting dynamic subtest: vcs0
[613.193366] Dynamic subtest vcs0: SUCCESS (0.101s)
[613.211984] Starting dynamic subtest: vcs1
[613.290879] Dynamic subtest vcs1: SUCCESS (0.096s)
[613.315338] Starting dynamic subtest: vecs0
[613.377314] Dynamic subtest vecs0: SUCCESS (0.085s)
[613.394510] Starting dynamic subtest: ccs0
[613.469849] Dynamic subtest ccs0: SUCCESS (0.092s)
[613.471110] Subtest Q-in-order: SUCCESS (0.488s)
[614.903884] [114/133] (414s left) i915_suspend (basic-s3-without-i915)
[614.936735] Starting subtest: basic-s3-without-i915
[618.246968] Subtest basic-s3-without-i915: SKIP (3.302s)
[619.895597] [115/133] (409s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[619.995673] Starting subtest: yf-tiled-32bpp-rotate-270
[619.997520] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[620.091407] [116/133] (409s left) gem_ctx_persistence (legacy-engines-persistence)
[620.152290] Starting subtest: legacy-engines-persistence
[620.155292] Starting dynamic subtest: render
[620.967963] Dynamic subtest render: SUCCESS (0.814s)
[620.978646] Starting dynamic subtest: bsd1
[621.728829] Dynamic subtest bsd1: SUCCESS (0.758s)
[621.739733] Starting dynamic subtest: bsd2
[622.496929] Dynamic subtest bsd2: SUCCESS (0.765s)
[622.507844] Starting dynamic subtest: blt
[623.249111] Dynamic subtest blt: SUCCESS (0.749s)
[623.259680] Starting dynamic subtest: vebox
[624.033093] Dynamic subtest vebox: SUCCESS (0.781s)
[624.036049] Subtest legacy-engines-persistence: SUCCESS (3.882s)
[624.108847] [117/133] (405s left) kms_rotation_crc (primary-rotation-90)
[624.200505] Starting subtest: primary-rotation-90
[624.202231] Subtest primary-rotation-90: SKIP (0.001s)
[624.282945] [118/133] (405s left) syncobj_wait (multi-wait-all-signaled)
[624.334840] Starting subtest: multi-wait-all-signaled
[624.335768] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[624.430467] [119/133] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[624.524237] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[624.526208] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[624.616026] [120/133] (405s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[624.707872] Starting subtest: fbc-pr-sprite-mmap-gtt
[624.709719] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[624.783498] [121/133] (405s left) kms_force_connector_basic (prune-stale-modes)
[624.856701] Starting subtest: prune-stale-modes
[625.295083] Subtest prune-stale-modes: SUCCESS (0.439s)
[625.433001] [122/133] (404s left) perf (stress-open-close)
[625.539578] Starting subtest: stress-open-close
[625.540434] Starting dynamic subtest: 0-rcs0
[627.715214] Dynamic subtest 0-rcs0: SUCCESS (2.176s)
[627.729285] Starting dynamic subtest: 1-vcs0
[629.885161] Dynamic subtest 1-vcs0: SUCCESS (2.169s)
[629.886060] Subtest stress-open-close: SUCCESS (4.347s)
[629.928525] [123/133] (400s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[629.986672] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[629.987699] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[630.094215] [124/133] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[630.190671] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[630.192527] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[630.282738] [125/133] (399s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[630.374413] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[630.375337] Starting dynamic subtest: pipe-A-eDP-1
[630.499606] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[630.508264] Starting dynamic subtest: pipe-B-eDP-1
[631.696230] Dynamic subtest pipe-B-eDP-1: SKIP (1.195s)
[631.697942] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.323s)
[633.091341] [126/133] (397s left) sw_sync (sync_merge_same)
[633.123127] Starting subtest: sync_merge_same
[633.123874] Subtest sync_merge_same: SUCCESS (0.000s)
[633.176706] [127/133] (396s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[633.272100] Starting subtest: 4-tiled-32bpp-rotate-0
[634.676064] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.404s)
[634.838674] [128/133] (395s left) i915_pm_rc6_residency (media-rc6-accuracy)
[634.894377] Starting subtest: media-rc6-accuracy
[634.896100] Subtest media-rc6-accuracy: SKIP (0.000s)
[634.993190] [129/133] (395s left) kms_psr (psr-primary-render)
[635.082831] Starting subtest: psr-primary-render
[635.083634] Starting dynamic subtest: eDP-1
[636.828641] Dynamic subtest eDP-1: SUCCESS (1.745s)
[636.829601] Subtest psr-primary-render: SUCCESS (1.746s)
[637.649919] [130/133] (392s left) kms_getfb (getfb2-handle-closed)
[637.740949] Starting subtest: getfb2-handle-closed
[637.741838] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[637.834709] [131/133] (392s left) gem_wait (write-busy)
[637.888156] Starting subtest: write-busy
[637.889010] Starting dynamic subtest: all-engines
[638.455275] Dynamic subtest all-engines: SUCCESS (0.568s)
[638.473929] Starting dynamic subtest: rcs0
[639.008111] Dynamic subtest rcs0: SUCCESS (0.551s)
[639.024064] Starting dynamic subtest: bcs0
[639.556633] Dynamic subtest bcs0: SUCCESS (0.548s)
[639.571517] Starting dynamic subtest: vcs0
[640.880001] Dynamic subtest vcs0: SUCCESS (1.309s)
[640.888522] Starting dynamic subtest: vcs1
[642.864337] Dynamic subtest vcs1: SUCCESS (1.982s)
[642.873044] Starting dynamic subtest: vecs0
[644.846701] Dynamic subtest vecs0: SUCCESS (1.980s)
[644.855457] Starting dynamic subtest: ccs0
[645.384561] Dynamic subtest ccs0: SUCCESS (0.548s)
[645.386344] Subtest write-busy: SUCCESS (7.499s)
[645.578900] [132/133] (384s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[645.714964] Starting subtest: cursorB-vs-flipB-legacy
[645.716651] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[645.863574] [133/133] (384s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[645.946842] Starting subtest: primary-x-tiled-reflect-x-0
[652.939895] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.994s)
[654.148000] 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.