[56.852028] Initializing watchdogs
[56.852076]   /dev/watchdog0
[56.866138] [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]
[56.870412] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.872767] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.876766] [001/133] (960s left) kms_sequence (get-idle)
[57.000140] Starting subtest: get-idle
[57.002568] Starting dynamic subtest: pipe-A-eDP-1
[58.810673] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.832s)
[58.819450] Starting dynamic subtest: pipe-B-eDP-1
[61.290467] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.497s)
[61.299650] Starting dynamic subtest: pipe-C-eDP-1
[63.774400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.500s)
[63.783260] Starting dynamic subtest: pipe-D-eDP-1
[66.197674] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s)
[66.200154] Subtest get-idle: SUCCESS (9.264s)
[67.072178] [002/133] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[67.341614] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[67.346369] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[67.613972] [003/133] (949s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[67.762684] Starting subtest: fbc-psr2-cursor-plane-update-sf
[67.764962] Starting dynamic subtest: pipe-A-eDP-1
[67.849572] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[67.859478] Starting dynamic subtest: pipe-B-eDP-1
[69.075843] Dynamic subtest pipe-B-eDP-1: SKIP (1.228s)
[69.080273] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.320s)
[70.274472] [004/133] (947s left) perf (gen12-unprivileged-single-ctx-counters)
[70.399484] Starting subtest: gen12-unprivileged-single-ctx-counters
[70.401552] Starting dynamic subtest: rcs0
[70.871277] Dynamic subtest rcs0: SUCCESS (0.474s)
[70.873614] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.475s)
[70.919398] [005/133] (946s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[71.043384] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[77.967751] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.934s)
[78.112706] [006/133] (939s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[78.210302] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[78.238364] Starting dynamic subtest: pipe-A-plane-0
[78.526951] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[78.534758] Starting dynamic subtest: pipe-A-plane-3
[78.760172] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[78.769239] Starting dynamic subtest: pipe-A-plane-5
[78.776727] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[79.853704] Starting dynamic subtest: pipe-B-plane-0
[80.146227] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[80.154140] Starting dynamic subtest: pipe-B-plane-3
[80.390621] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[80.399683] Starting dynamic subtest: pipe-B-plane-5
[80.403893] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[80.700805] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.489s)
[81.524997] [007/133] (936s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[81.616298] Starting subtest: fbc-psr2-primary-mmap-gtt
[81.618602] Starting dynamic subtest: eDP-1
[81.623265] Dynamic subtest eDP-1: SKIP (0.000s)
[81.627941] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[81.691346] [008/133] (936s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[81.752198] Starting subtest: y-tiled-ccs-to-y-tiled
[81.756702] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[81.932737] [009/133] (935s left) api_intel_allocator (two-level-inception-interruptible)
[81.985817] Starting subtest: two-level-inception-interruptible
[87.448351] Subtest two-level-inception-interruptible: SUCCESS (5.410s)
[87.549795] [010/133] (930s left) kms_flip (plain-flip-interruptible)
[87.674383] Starting subtest: plain-flip-interruptible
[87.676712] Starting dynamic subtest: A-eDP1
[89.340137] Dynamic subtest A-eDP1: SUCCESS (1.664s)
[89.350512] Starting dynamic subtest: B-eDP1
[90.960539] Dynamic subtest B-eDP1: SUCCESS (1.620s)
[90.970994] Starting dynamic subtest: C-eDP1
[92.587509] Dynamic subtest C-eDP1: SUCCESS (1.626s)
[92.597617] Starting dynamic subtest: D-eDP1
[94.210618] Dynamic subtest D-eDP1: SUCCESS (1.622s)
[94.213059] Subtest plain-flip-interruptible: SUCCESS (6.537s)
[95.388949] [011/133] (922s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[95.478259] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[95.482892] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[96.601951] [012/133] (921s left) kms_flip (2x-flip-vs-fences)
[96.708243] Starting subtest: 2x-flip-vs-fences
[96.712395] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[96.833360] [013/133] (921s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[97.230714] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[98.008960] [014/133] (919s left) gem_mmap_gtt (basic-small-copy-xy)
[98.077820] Subtest basic-small-copy-XY: SKIP (0.000s)
[98.129638] [015/133] (919s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[98.237303] Starting subtest: psr-rgb101010-draw-mmap-gtt
[98.241511] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[98.320499] [016/133] (919s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[98.381674] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[98.490783] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[98.575641] [017/133] (919s left) gem_exec_schedule (submit-golden-slice)
[98.647269] Starting subtest: submit-golden-slice
[98.649292] Starting dynamic subtest: rcs0
[98.670724] Dynamic subtest rcs0: SUCCESS (0.032s)
[98.681037] Starting dynamic subtest: bcs0
[98.701553] Dynamic subtest bcs0: SUCCESS (0.031s)
[98.709686] Starting dynamic subtest: vcs0
[98.733615] Dynamic subtest vcs0: SUCCESS (0.031s)
[98.742749] Starting dynamic subtest: vcs1
[98.781479] Dynamic subtest vcs1: SUCCESS (0.047s)
[98.790664] Starting dynamic subtest: vecs0
[98.812577] Dynamic subtest vecs0: SUCCESS (0.031s)
[98.820789] Starting dynamic subtest: ccs0
[98.850999] Dynamic subtest ccs0: SUCCESS (0.038s)
[98.853377] Subtest submit-golden-slice: SUCCESS (0.213s)
[100.007096] [018/133] (918s left) kms_psr (psr-cursor-mmap-cpu)
[100.111306] Starting subtest: psr-cursor-mmap-cpu
[100.113652] Starting dynamic subtest: eDP-1
[101.827267] Dynamic subtest eDP-1: SUCCESS (1.714s)
[101.829570] Subtest psr-cursor-mmap-cpu: SUCCESS (1.715s)
[102.682816] [019/133] (915s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[102.785541] Starting subtest: x-tiled-32bpp-rotate-270
[102.805110] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[102.915241] [020/133] (915s left) kms_flip (flip-vs-blocking-wf-vblank)
[103.008952] Starting subtest: flip-vs-blocking-wf-vblank
[103.011305] Starting dynamic subtest: A-eDP1
[111.924921] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[111.935169] Starting dynamic subtest: B-eDP1
[120.859429] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[120.871731] Starting dynamic subtest: C-eDP1
[129.816529] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[129.826149] Starting dynamic subtest: D-eDP1
[138.760997] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[138.763814] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.699s)
[139.922736] [021/133] (878s left) gem_mmap_gtt (isolation)
[139.988377] Subtest isolation: SKIP (0.000s)
[140.047891] [022/133] (878s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[140.151992] Starting subtest: plane-all-modeset-transition-internal-panels
[140.154217] Starting dynamic subtest: pipe-A-eDP-1
[141.461953] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.310s)
[141.741878] Starting dynamic subtest: pipe-B-eDP-1
[142.776862] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.042s)
[143.045773] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.896s)
[143.891470] [023/133] (874s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[143.954700] Starting subtest: single-wait-for-submit-available-submitted
[143.956605] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[144.036825] [024/133] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[144.153543] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[144.157753] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[144.249818] [025/133] (874s left) vgem_basic (setversion)
[144.338529] Starting subtest: setversion
[144.342761] Subtest setversion: SUCCESS (0.000s)
[144.399880] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[144.402861] [026/133] (874s left) syncobj_timeline (invalid-query-illegal-handle)
[144.472778] Starting subtest: invalid-query-illegal-handle
[144.475021] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[144.576369] [027/133] (873s left) gem_ctx_persistence (engines-persistence)
[144.650528] Starting subtest: engines-persistence
[144.652940] Starting dynamic subtest: rcs0
[145.424744] Dynamic subtest rcs0: SUCCESS (0.774s)
[145.435694] Starting dynamic subtest: bcs0
[146.197396] Dynamic subtest bcs0: SUCCESS (0.771s)
[146.207980] Starting dynamic subtest: vcs0
[146.955626] Dynamic subtest vcs0: SUCCESS (0.757s)
[146.966075] Starting dynamic subtest: vcs1
[147.737708] Dynamic subtest vcs1: SUCCESS (0.780s)
[147.748797] Starting dynamic subtest: vecs0
[148.506525] Dynamic subtest vecs0: SUCCESS (0.766s)
[148.516865] Starting dynamic subtest: ccs0
[149.274044] Dynamic subtest ccs0: SUCCESS (0.767s)
[149.276648] Subtest engines-persistence: SUCCESS (4.623s)
[149.352558] [028/133] (869s left) gem_request_retire (retire-vma-not-inactive)
[149.414331] Starting subtest: retire-vma-not-inactive
[149.478392] Subtest retire-vma-not-inactive: SUCCESS (0.061s)
[149.609322] [029/133] (868s left) kms_cursor_crc (cursor-onscreen-128x128)
[149.806649] Starting subtest: cursor-onscreen-128x128
[149.811343] Starting dynamic subtest: pipe-A-eDP-1
[151.930599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s)
[151.957372] Starting dynamic subtest: pipe-D-eDP-1
[154.672096] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.722s)
[154.674465] Subtest cursor-onscreen-128x128: SUCCESS (4.863s)
[155.468829] [030/133] (863s left) kms_color (invalid-ctm-matrix-sizes)
[155.571136] Starting subtest: invalid-ctm-matrix-sizes
[155.573441] Starting dynamic subtest: pipe-A
[155.575714] Dynamic subtest pipe-A: SUCCESS (0.002s)
[155.584750] Starting dynamic subtest: pipe-B
[155.586999] Dynamic subtest pipe-B: SUCCESS (0.003s)
[155.596609] Starting dynamic subtest: pipe-C
[155.598498] Dynamic subtest pipe-C: SUCCESS (0.003s)
[155.605857] Starting dynamic subtest: pipe-D
[155.608136] Dynamic subtest pipe-D: SUCCESS (0.004s)
[155.610226] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[155.655125] [031/133] (862s left) kms_pipe_crc_basic (bad-source)
[155.739768] Starting subtest: bad-source
[155.741975] Subtest bad-source: SUCCESS (0.000s)
[155.825182] [032/133] (862s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[155.927777] Starting subtest: psr-dirtyfb-ioctl
[155.929704] Starting dynamic subtest: A-eDP-1
[159.848070] Dynamic subtest A-eDP-1: SUCCESS (3.921s)
[159.850393] Subtest psr-dirtyfb-ioctl: SUCCESS (3.922s)
[160.680249] [033/133] (858s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[160.774382] Starting subtest: primary-y-tiled-reflect-x-90
[160.778906] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[160.850530] [034/133] (857s left) gem_exec_reloc (basic-gtt-active)
[160.917061] Subtest basic-gtt-active: SKIP (0.000s)
[160.984958] [035/133] (857s left) kms_rotation_crc (bad-tiling)
[161.088150] Starting subtest: bad-tiling
[161.092724] Subtest bad-tiling: SKIP (0.001s)
[161.160046] [036/133] (857s left) kms_async_flips (invalid-async-flip)
[161.254042] Starting subtest: invalid-async-flip
[161.642474] Starting dynamic subtest: pipe-A-eDP-1
[162.477906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[162.839737] Starting dynamic subtest: pipe-B-eDP-1
[163.693658] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.860s)
[164.049407] Starting dynamic subtest: pipe-C-eDP-1
[164.807733] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[165.169206] Starting dynamic subtest: pipe-D-eDP-1
[165.938710] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[165.941101] Subtest invalid-async-flip: SUCCESS (4.686s)
[167.100295] [037/133] (851s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[167.213349] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[167.217862] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[167.323643] [038/133] (851s left) gem_mmap_gtt (basic-small-bo-tiledx)
[167.381480] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[167.447584] [039/133] (851s left) gem_mmap_wc (coherency)
[167.506179] Subtest coherency: SKIP (0.000s)
[167.578557] [040/133] (851s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[167.671678] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[167.676104] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[167.745292] [041/133] (851s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[167.846065] Starting subtest: plane-upscale-20x20-with-rotation
[167.848308] Starting dynamic subtest: pipe-A
[168.070118] Dynamic subtest pipe-A: SUCCESS (0.227s)
[168.082018] Starting dynamic subtest: pipe-B
[169.369850] Dynamic subtest pipe-B: SUCCESS (1.298s)
[169.380256] Starting dynamic subtest: pipe-C
[170.713580] Dynamic subtest pipe-C: SUCCESS (1.343s)
[170.723768] Starting dynamic subtest: pipe-D
[172.036337] Dynamic subtest pipe-D: SUCCESS (1.322s)
[172.038722] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.194s)
[173.216716] [042/133] (845s left) kms_content_protection (atomic-dpms)
[173.370938] Starting subtest: atomic-dpms
[173.375662] Subtest atomic-dpms: SKIP (0.000s)
[173.496219] [043/133] (845s left) gem_basic (multigpu-create-close)
[173.555445] Starting subtest: multigpu-create-close
[173.559923] Subtest multigpu-create-close: SKIP (0.000s)
[173.685151] [044/133] (845s left) gem_exec_flush (basic-wb-ro-before-default)
[173.762144] Starting subtest: basic-wb-ro-before-default
[179.249258] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[179.400568] [045/133] (839s left) kms_atomic_interruptible (universal-setplane-cursor)
[179.493985] Starting subtest: universal-setplane-cursor
[179.496313] Starting dynamic subtest: pipe-A-eDP-1
[186.933234] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.438s)
[186.935616] Subtest universal-setplane-cursor: SUCCESS (7.439s)
[187.773425] [046/133] (831s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[187.866981] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[187.869211] Starting dynamic subtest: pipe-A-eDP-1
[188.009843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[188.017570] Starting dynamic subtest: pipe-B-eDP-1
[188.037438] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[188.044837] Starting dynamic subtest: pipe-C-eDP-1
[188.063514] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[188.070647] Starting dynamic subtest: pipe-D-eDP-1
[188.089196] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[188.091050] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.148s)
[190.343307] [047/133] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[190.455822] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[194.883987] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.432s)
[196.054210] [048/133] (823s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[196.149255] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[196.151588] Starting dynamic subtest: pipe-A-eDP-1
[196.160858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.169574] Starting dynamic subtest: pipe-B-eDP-1
[196.178340] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.186125] Starting dynamic subtest: pipe-C-eDP-1
[196.194488] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.201807] Starting dynamic subtest: pipe-D-eDP-1
[196.210155] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.214741] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[198.398026] [049/133] (820s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[198.493043] Starting subtest: yf-tiled-8bpp-rotate-90
[198.497521] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[198.613271] [050/133] (820s left) i915_drm_fdinfo (virtual-busy)
[198.660409] Starting subtest: virtual-busy
[198.664954] Subtest virtual-busy: SKIP (0.000s)
[198.736377] [051/133] (820s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[198.804316] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[198.912942] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[198.999205] [052/133] (820s left) gem_pxp (protected-raw-src-copy-not-readible)
[199.124875] Starting subtest: protected-raw-src-copy-not-readible
[199.183451] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[199.292338] [053/133] (820s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[199.840418] Starting subtest: syncobj-timeline-multiple-ext-nodes
[199.842789] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[200.992985] [054/133] (818s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[201.052062] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[201.056496] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[201.235236] [055/133] (818s left) gem_tiled_pread_pwrite
[201.349037] [056/133] (818s left) gem_exec_whisper (basic-queues-priority-all)
[201.422071] Starting subtest: basic-queues-priority-all
[223.352727] Subtest basic-queues-priority-all: SUCCESS (21.928s)
[223.548862] [057/133] (796s left) gem_render_copy_redux (flink)
[223.608901] Starting subtest: flink
[224.749432] Subtest flink: SUCCESS (1.143s)
[224.866434] [058/133] (794s left) kms_cursor_crc (cursor-random-64x64)
[225.033786] Starting subtest: cursor-random-64x64
[225.038071] Starting dynamic subtest: pipe-A-eDP-1
[228.410563] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.371s)
[228.440264] Starting dynamic subtest: pipe-D-eDP-1
[232.422784] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[232.425354] Subtest cursor-random-64x64: SUCCESS (7.388s)
[233.256063] [059/133] (786s left) gem_ctx_persistence (legacy-engines-mixed-process)
[233.328690] Starting subtest: legacy-engines-mixed-process
[233.331080] Starting dynamic subtest: render
[234.908808] Dynamic subtest render: SUCCESS (1.579s)
[234.920585] Starting dynamic subtest: bsd1
[236.893702] Dynamic subtest bsd1: SUCCESS (1.982s)
[236.905197] Starting dynamic subtest: bsd2
[238.917937] Dynamic subtest bsd2: SUCCESS (2.021s)
[238.927179] Starting dynamic subtest: blt
[240.857797] Dynamic subtest blt: SUCCESS (1.938s)
[240.867580] Starting dynamic subtest: vebox
[242.906298] Dynamic subtest vebox: SUCCESS (2.047s)
[242.908713] Subtest legacy-engines-mixed-process: SUCCESS (9.578s)
[242.986129] [060/133] (776s left) syncobj_wait (invalid-signal-zero-handles)
[243.047475] Starting subtest: invalid-signal-zero-handles
[243.049473] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[243.157395] [061/133] (776s left) vgem_basic (sysfs)
[243.194325] Starting subtest: sysfs
[243.196218] Subtest sysfs: SUCCESS (0.000s)
[243.252978] [062/133] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[243.353765] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[250.170317] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.819s)
[250.306732] [063/133] (769s left) gem_workarounds (suspend-resume-fd)
[250.386673] Starting subtest: suspend-resume-fd
[267.264195] Subtest suspend-resume-fd: SUCCESS (1.287s)
[267.410623] [064/133] (752s left) gen9_exec_parse (bb-start-out)
[267.480970] Subtest bb-start-out: SKIP (0.000s)
[267.560999] [065/133] (752s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[267.671354] Starting subtest: psr2-plane-move-sf-dmg-area
[267.673568] Starting dynamic subtest: pipe-A-eDP-1
[272.068353] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.553s)
[272.079553] Starting dynamic subtest: pipe-B-eDP-1
[277.274064] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.301s)
[277.276408] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.857s)
[278.134608] [066/133] (741s left) kms_psr (fbc-psr-sprite-render)
[278.228759] Starting subtest: fbc-psr-sprite-render
[278.230849] Starting dynamic subtest: eDP-1
[278.234767] Dynamic subtest eDP-1: SKIP (0.000s)
[278.238768] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[278.304587] [067/133] (741s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[278.425645] Starting subtest: cursorB-vs-flipB-toggle
[278.430374] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[278.571399] [068/133] (741s left) gem_ctx_shared (q-in-order)
[278.626617] Starting subtest: Q-in-order
[278.628896] Starting dynamic subtest: rcs0
[278.740320] Dynamic subtest rcs0: SUCCESS (0.113s)
[278.753043] Starting dynamic subtest: vcs0
[278.835263] Dynamic subtest vcs0: SUCCESS (0.095s)
[278.854230] Starting dynamic subtest: vcs1
[278.924491] Dynamic subtest vcs1: SUCCESS (0.087s)
[278.942678] Starting dynamic subtest: vecs0
[279.007638] Dynamic subtest vecs0: SUCCESS (0.082s)
[279.024774] Starting dynamic subtest: ccs0
[279.093337] Dynamic subtest ccs0: SUCCESS (0.086s)
[279.095833] Subtest Q-in-order: SUCCESS (0.471s)
[280.595999] [069/133] (739s left) gem_media_fill (media-fill)
[280.647588] Subtest media-fill: SKIP (0.000s)
[280.777115] [070/133] (739s left) api_intel_bb (render-ccs)
[280.841309] Starting subtest: render-ccs
[281.202231] Subtest render-ccs: SUCCESS (0.363s)
[281.306145] [071/133] (739s left) gem_userptr_blits (unsync-unmap-after-close)
[281.372092] Subtest unsync-unmap-after-close: SKIP (0.000s)
[281.497279] [072/133] (738s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[281.583737] Starting subtest: addfb25-y-tiled-small-legacy
[281.587721] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[281.679077] [073/133] (738s left) kms_pm_rpm (modeset-non-lpsp)
[283.571368] Starting subtest: modeset-non-lpsp
[284.734076] Subtest modeset-non-lpsp: SKIP (1.171s)
[285.101235] [074/133] (735s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[285.191743] Starting subtest: fbcpsr-tiling-4
[292.289020] Subtest fbcpsr-tiling-4: SUCCESS (7.125s)
[292.430825] [075/133] (728s left) gem_spin_batch (spin-each)
[292.485546] Starting subtest: spin-each
[295.748187] Subtest spin-each: SUCCESS (3.262s)
[296.524382] [076/133] (724s left) kms_invalid_mode (bad-htotal)
[296.632481] Starting subtest: bad-htotal
[296.634698] Starting dynamic subtest: pipe-A-eDP-1
[296.917764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[296.928030] Starting dynamic subtest: pipe-B-eDP-1
[296.930212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[296.939733] Starting dynamic subtest: pipe-C-eDP-1
[296.941883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[296.951457] Starting dynamic subtest: pipe-D-eDP-1
[296.953682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[296.955948] Subtest bad-htotal: SUCCESS (0.293s)
[297.725210] [077/133] (722s left) gem_unfence_active_buffers
[297.870952] [078/133] (722s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[297.963588] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[297.965808] Starting dynamic subtest: pipe-A-eDP-1
[297.987456] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[297.999339] Starting dynamic subtest: pipe-B-eDP-1
[298.020057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[298.029712] Starting dynamic subtest: pipe-C-eDP-1
[298.050125] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[298.059414] Starting dynamic subtest: pipe-D-eDP-1
[298.082134] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[298.086415] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[300.277260] [079/133] (720s left) kms_plane_alpha_blend (alpha-7efc)
[300.383838] Starting subtest: alpha-7efc
[300.668596] Starting dynamic subtest: pipe-A-eDP-1
[301.296135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[301.323554] Starting dynamic subtest: pipe-D-eDP-1
[302.594382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[302.596741] Subtest alpha-7efc: SUCCESS (2.210s)
[303.439528] [080/133] (717s left) gem_vm_create (isolation)
[303.492796] Starting subtest: isolation
[303.503443] Subtest isolation: SUCCESS (0.010s)
[303.629113] [081/133] (717s left) kms_chamelium_frames (hdmi-aspect-ratio)
[304.019987] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[304.856941] [082/133] (715s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[304.914054] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[304.986897] [083/133] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[305.073666] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[312.478956] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.407s)
[312.620264] [084/133] (708s left) kms_vblank (ts-continuation-idle)
[312.718776] Starting subtest: ts-continuation-idle
[312.720923] Starting dynamic subtest: pipe-A-eDP-1
[313.145784] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[313.160717] Starting dynamic subtest: pipe-D-eDP-1
[314.218718] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.070s)
[314.221008] Subtest ts-continuation-idle: SUCCESS (1.498s)
[315.091467] [085/133] (705s left) gem_exec_reloc (basic-range)
[315.160362] Subtest basic-range: SKIP (0.000s)
[315.249691] [086/133] (705s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[315.356939] Starting subtest: fbc-rgb565-draw-mmap-gtt
[315.361257] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[315.471596] [087/133] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[315.575291] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[323.302227] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.730s)
[323.426070] [088/133] (697s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[323.526073] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[330.559071] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.037s)
[330.697617] [089/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[330.801476] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[330.805625] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[330.911724] [090/133] (690s left) gem_exec_balancer (parallel)
[331.175691] Starting subtest: parallel
[332.133447] Subtest parallel: SUCCESS (0.960s)
[332.535850] [091/133] (688s left) gem_ctx_param (invalid-size-get)
[332.598125] Starting subtest: invalid-size-get
[332.600569] Subtest invalid-size-get: SUCCESS (0.001s)
[332.703939] [092/133] (688s left) sysfs_timeslice_duration (timeout)
[332.763468] Starting subtest: timeout
[332.765881] Starting dynamic subtest: vecs0
[341.497058] Dynamic subtest vecs0: SUCCESS (8.732s)
[341.509330] Starting dynamic subtest: ccs0
[342.776593] Dynamic subtest ccs0: SUCCESS (1.280s)
[342.789203] Starting dynamic subtest: vcs0
[351.482633] Dynamic subtest vcs0: SUCCESS (8.706s)
[351.494847] Starting dynamic subtest: bcs0
[352.111646] Dynamic subtest bcs0: SUCCESS (0.628s)
[352.124876] Starting dynamic subtest: rcs0
[353.349093] Dynamic subtest rcs0: SUCCESS (1.236s)
[353.361178] Starting dynamic subtest: vcs1
[362.487732] Dynamic subtest vcs1: SUCCESS (9.140s)
[362.490313] Subtest timeout: SUCCESS (29.731s)
[362.564102] [093/133] (658s left) syncobj_wait (multi-wait-all-submitted-signaled)
[362.635046] Starting subtest: multi-wait-all-submitted-signaled
[362.736194] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[362.815552] [094/133] (658s left) gem_exec_parallel (userptr)
[362.893840] Starting subtest: userptr
[362.896360] Starting dynamic subtest: rcs0
[364.411153] Dynamic subtest rcs0: SUCCESS (1.515s)
[364.421695] Starting dynamic subtest: bcs0
[365.907711] Dynamic subtest bcs0: SUCCESS (1.493s)
[365.920890] Starting dynamic subtest: vcs0
[367.514332] Dynamic subtest vcs0: SUCCESS (1.602s)
[367.535421] Starting dynamic subtest: vcs1
[369.469494] Dynamic subtest vcs1: SUCCESS (1.952s)
[369.482696] Starting dynamic subtest: vecs0
[371.451925] Dynamic subtest vecs0: SUCCESS (1.977s)
[371.463313] Starting dynamic subtest: ccs0
[372.965697] Dynamic subtest ccs0: SUCCESS (1.512s)
[372.968428] Subtest userptr: SUCCESS (10.068s)
[373.158279] [095/133] (648s left) kms_cdclk (mode-transition)
[373.252746] Starting subtest: mode-transition
[373.255089] Starting dynamic subtest: pipe-A-eDP-1
[373.543153] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[373.553904] Starting dynamic subtest: pipe-B-eDP-1
[373.558326] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[373.568041] Starting dynamic subtest: pipe-C-eDP-1
[373.572501] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[373.582385] Starting dynamic subtest: pipe-D-eDP-1
[373.586628] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[373.590863] Subtest mode-transition: SKIP (0.295s)
[374.374608] [096/133] (647s left) kms_psr (psr-dpms)
[374.464711] Starting subtest: psr-dpms
[374.466877] Starting dynamic subtest: eDP-1
[377.413815] Dynamic subtest eDP-1: SUCCESS (2.948s)
[377.416086] Subtest psr-dpms: SUCCESS (2.949s)
[378.274190] [097/133] (643s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[378.374249] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[378.378316] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[378.461882] [098/133] (643s left) gem_exec_schedule (wide)
[378.645729] Starting subtest: wide
[378.647923] Starting dynamic subtest: rcs0
[388.958965] Dynamic subtest rcs0: SUCCESS (10.261s)
[388.971709] Starting dynamic subtest: vcs0
[401.224962] Dynamic subtest vcs0: SUCCESS (12.315s)
[401.239340] Starting dynamic subtest: vcs1
[412.951511] Dynamic subtest vcs1: SUCCESS (11.726s)
[412.963963] Starting dynamic subtest: vecs0
[424.750982] Dynamic subtest vecs0: SUCCESS (11.800s)
[424.761404] Starting dynamic subtest: ccs0
[439.811017] Dynamic subtest ccs0: SUCCESS (15.010s)
[439.813422] Subtest wide: SUCCESS (61.117s)
[441.444259] [099/133] (580s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[441.555310] Starting subtest: 4-tiled-8bpp-rotate-180
[442.734255] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.180s)
[442.880392] [100/133] (578s left) syncobj_basic (bad-destroy)
[442.943293] Starting subtest: bad-destroy
[442.945348] Subtest bad-destroy: SUCCESS (0.000s)
[443.055852] [101/133] (578s left) gem_exec_balancer (sequential)
[443.131879] Starting subtest: sequential
[446.236234] Subtest sequential: SUCCESS (3.104s)
[446.519618] [102/133] (575s left) kms_rotation_crc (primary-rotation-90)
[446.625672] Starting subtest: primary-rotation-90
[446.630360] Subtest primary-rotation-90: SKIP (0.001s)
[446.704154] [103/133] (575s left) perf_pmu (most-busy-check-all)
[446.753979] Starting subtest: most-busy-check-all
[446.756270] Starting dynamic subtest: rcs0
[448.509693] Dynamic subtest rcs0: SUCCESS (1.755s)
[448.522749] Starting dynamic subtest: bcs0
[450.493457] Dynamic subtest bcs0: SUCCESS (1.981s)
[450.506712] Starting dynamic subtest: vcs0
[452.477459] Dynamic subtest vcs0: SUCCESS (1.981s)
[452.491479] Starting dynamic subtest: vcs1
[454.525030] Dynamic subtest vcs1: SUCCESS (2.045s)
[454.538936] Starting dynamic subtest: vecs0
[456.509149] Dynamic subtest vecs0: SUCCESS (1.981s)
[456.522598] Starting dynamic subtest: ccs0
[458.493715] Dynamic subtest ccs0: SUCCESS (1.981s)
[458.496687] Subtest most-busy-check-all: SUCCESS (11.744s)
[458.605631] [104/133] (563s left) i915_getparams_basic (basic-eu-total)
[458.662730] Starting subtest: basic-eu-total
[458.667290] Subtest basic-eu-total: SUCCESS (0.000s)
[458.760719] [105/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[458.862352] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[458.866899] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[458.957287] [106/133] (562s left) gem_create (create-massive)
[459.018108] Starting subtest: create-massive
[459.020501] Subtest create-massive: SUCCESS (0.000s)
[459.215182] [107/133] (562s left) kms_flip (nonexisting-fb)
[459.305144] Starting subtest: nonexisting-fb
[459.307131] Starting dynamic subtest: A-eDP1
[460.441358] Dynamic subtest A-eDP1: SUCCESS (1.138s)
[460.461391] Starting dynamic subtest: B-eDP1
[461.570480] Dynamic subtest B-eDP1: SUCCESS (1.127s)
[461.581569] Starting dynamic subtest: C-eDP1
[462.701835] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[462.715865] Starting dynamic subtest: D-eDP1
[463.829856] Dynamic subtest D-eDP1: SUCCESS (1.126s)
[463.835139] Subtest nonexisting-fb: SUCCESS (4.533s)
[465.011709] [108/133] (556s left) i915_pm_rpm (debugfs-read)
[466.644757] Starting subtest: debugfs-read
[467.804859] Subtest debugfs-read: SUCCESS (1.158s)
[468.185927] [109/133] (553s left) kms_feature_discovery (dp-mst)
[468.277865] Starting subtest: dp-mst
[468.281911] Subtest dp-mst: SKIP (0.000s)
[468.351182] [110/133] (553s left) kms_psr (fbc-psr-cursor-plane-onoff)
[468.449829] Starting subtest: fbc-psr-cursor-plane-onoff
[468.451706] Starting dynamic subtest: eDP-1
[468.455725] Dynamic subtest eDP-1: SKIP (0.000s)
[468.459726] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[468.536294] [111/133] (553s left) syncobj_timeline (multi-wait-available-submitted)
[468.597588] Starting subtest: multi-wait-available-submitted
[468.599785] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[468.694979] [112/133] (553s left) i915_suspend (debugfs-reader)
[468.750171] Starting subtest: debugfs-reader
[487.251011] Subtest debugfs-reader: SUCCESS (3.162s)
[487.407920] [113/133] (534s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[487.512030] Starting subtest: plane-downscale-factor-0-75-with-rotation
[487.514258] Starting dynamic subtest: pipe-A
[487.760076] Dynamic subtest pipe-A: SUCCESS (0.261s)
[487.770240] Starting dynamic subtest: pipe-B
[489.024067] Dynamic subtest pipe-B: SUCCESS (1.309s)
[489.034167] Starting dynamic subtest: pipe-C
[490.325872] Dynamic subtest pipe-C: SUCCESS (1.342s)
[490.338603] Starting dynamic subtest: pipe-D
[491.633040] Dynamic subtest pipe-D: SUCCESS (1.341s)
[491.635262] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.256s)
[492.801016] [114/133] (529s left) kms_lease (lease-invalid-crtc)
[492.884691] Starting subtest: lease-invalid-crtc
[492.886959] Starting dynamic subtest: pipe-A-eDP-1
[492.889241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[492.898989] Starting dynamic subtest: pipe-B-eDP-1
[492.901313] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[492.911172] Starting dynamic subtest: pipe-C-eDP-1
[492.913479] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[492.923322] Starting dynamic subtest: pipe-D-eDP-1
[492.925309] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[492.927272] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[492.966115] [115/133] (529s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[493.069837] Starting subtest: yf-tiled-32bpp-rotate-270
[493.074243] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[493.192195] [116/133] (529s left) gem_tiling_max_stride
[493.301097] [117/133] (529s left) kms_flip (2x-flip-vs-suspend)
[493.389022] Starting subtest: 2x-flip-vs-suspend
[493.400575] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[493.479426] [118/133] (529s left) gem_mmap_wc (pf-nonblock)
[493.530475] Subtest pf-nonblock: SKIP (0.000s)
[493.588423] [119/133] (528s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[493.671851] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[493.674102] Starting dynamic subtest: pipe-A-default-mode
[496.400060] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[496.402231] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.771s)
[497.220802] [120/133] (525s left) gem_ctx_exec (basic)
[497.277323] Starting subtest: basic
[497.281671] Subtest basic: SUCCESS (0.005s)
[497.397609] [121/133] (525s left) gem_exec_schedule (lateslice)
[497.464218] Starting subtest: lateslice
[497.466565] Starting dynamic subtest: rcs0
[497.475833] Dynamic subtest rcs0: SUCCESS (0.021s)
[497.489169] Starting dynamic subtest: bcs0
[497.493575] Dynamic subtest bcs0: SUCCESS (0.017s)
[497.504256] Starting dynamic subtest: vcs0
[497.512697] Dynamic subtest vcs0: SUCCESS (0.018s)
[497.522821] Starting dynamic subtest: vcs1
[497.531938] Dynamic subtest vcs1: SUCCESS (0.019s)
[497.541966] Starting dynamic subtest: vecs0
[497.548875] Dynamic subtest vecs0: SUCCESS (0.016s)
[497.558466] Starting dynamic subtest: ccs0
[497.566580] Dynamic subtest ccs0: SUCCESS (0.017s)
[497.568780] Subtest lateslice: SUCCESS (0.114s)
[498.986152] [122/133] (523s left) kms_cursor_crc (cursor-suspend)
[499.105335] Starting subtest: cursor-suspend
[499.107239] Starting dynamic subtest: pipe-A-eDP-1
[531.730966] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.146s)
[531.740892] Starting dynamic subtest: pipe-D-eDP-1
[565.721310] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.785s)
[565.723735] Subtest cursor-suspend: SUCCESS (6.933s)
[566.510800] [123/133] (456s left) gem_exec_reloc (basic-write-wc-active)
[566.583006] Subtest basic-write-wc-active: SKIP (0.000s)
[566.656332] [124/133] (456s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[566.754283] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[567.551679] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[567.697747] [125/133] (455s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[567.797587] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[567.802362] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[567.905259] [126/133] (454s left) gem_create (create-valid-nonaligned)
[567.955211] Starting subtest: create-valid-nonaligned
[567.957535] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[568.133747] [127/133] (454s left) gem_ctx_param (set-priority-range)
[568.185723] Starting subtest: set-priority-range
[568.199672] Subtest set-priority-range: SUCCESS (0.015s)
[568.309502] [128/133] (454s left) kms_big_fb (y-tiled-addfb-size-overflow)
[568.401895] Starting subtest: y-tiled-addfb-size-overflow
[568.407075] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[568.484463] [129/133] (454s left) prime_busy (hang)
[568.538756] Starting subtest: hang
[568.541744] Starting dynamic subtest: rcs0
[594.198855] Dynamic subtest rcs0: SUCCESS (25.865s)
[594.208898] Starting dynamic subtest: bcs0
[601.362643] Dynamic subtest bcs0: SUCCESS (7.168s)
[601.372328] Starting dynamic subtest: vcs0
[608.336907] Dynamic subtest vcs0: SUCCESS (6.970s)
[608.347338] Starting dynamic subtest: vcs1
[615.372544] Dynamic subtest vcs1: SUCCESS (7.033s)
[615.384987] Starting dynamic subtest: vecs0
[622.350017] Dynamic subtest vecs0: SUCCESS (6.976s)
[622.362161] Starting dynamic subtest: ccs0
[636.249896] Dynamic subtest ccs0: SUCCESS (13.902s)
[636.252638] Subtest hang: SUCCESS (67.921s)
[636.370831] [130/133] (386s left) device_reset (cold-reset-bound)
[636.420204] Starting subtest: cold-reset-bound
[636.425154] Subtest cold-reset-bound: SKIP (0.000s)
[636.496444] [131/133] (386s left) kms_plane_multiple (tiling-yf)
[636.589657] Starting subtest: tiling-yf
[636.594655] Subtest tiling-yf: SKIP (0.000s)
[636.666503] [132/133] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[636.759873] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[644.047632] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.292s)
[644.174781] [133/133] (378s left) kms_pm_dc (dc6-dpms)
[645.271857] Starting subtest: dc6-dpms
[647.334220] Subtest dc6-dpms: SUCCESS (2.063s)
[647.407092] Closing watchdogs
results: parsing output: 0/ for test: kms_sequence
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: api_intel_allocator
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: kms_atomic_transition
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: gem_request_retire
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: kms_dirtyfb
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: gem_basic
results: parsing output: 43/ for test: gem_exec_flush
results: parsing output: 44/ for test: kms_atomic_interruptible
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: gem_tiled_pread_pwrite
results: parsing output: 55/ for test: gem_exec_whisper
results: parsing output: 56/ for test: gem_render_copy_redux
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_workarounds
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: gem_media_fill
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: kms_invalid_mode
results: parsing output: 76/ for test: gem_unfence_active_buffers
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_plane_alpha_blend
results: parsing output: 79/ for test: gem_vm_create
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: gem_fenced_exec_thrash
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: sysfs_timeslice_duration
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: gem_exec_parallel
results: parsing output: 94/ for test: kms_cdclk
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: i915_getparams_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_create
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: i915_pm_rpm
results: parsing output: 108/ for test: kms_feature_discovery
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_suspend
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_lease
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_tiling_max_stride
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_create
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: prime_busy
results: parsing output: 129/ for test: device_reset
results: parsing output: 130/ for test: kms_plane_multiple
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_dc
Done.