[60.472568] Initializing watchdogs
[60.472658]   /dev/watchdog0
[60.487315] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.491842] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.494230] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.497417] [001/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[60.621904] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[60.633945] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[60.706746] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[60.804378] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[60.808881] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[60.882622] [003/133] (960s left) perf_pmu (init-busy)
[60.926577] Starting subtest: init-busy
[60.928797] Starting dynamic subtest: rcs0
[60.931164] Dynamic subtest rcs0: SUCCESS (0.002s)
[60.939416] Starting dynamic subtest: bcs0
[60.941247] Dynamic subtest bcs0: SUCCESS (0.001s)
[60.947714] Starting dynamic subtest: vcs0
[60.949579] Dynamic subtest vcs0: SUCCESS (0.001s)
[60.956049] Starting dynamic subtest: vcs1
[60.957923] Dynamic subtest vcs1: SUCCESS (0.001s)
[60.964776] Starting dynamic subtest: vecs0
[60.966956] Dynamic subtest vecs0: SUCCESS (0.001s)
[60.973565] Starting dynamic subtest: ccs0
[60.975804] Dynamic subtest ccs0: SUCCESS (0.000s)
[60.978075] Subtest init-busy: SUCCESS (0.006s)
[61.034369] [004/133] (960s left) kms_flip (flip-vs-rmfb)
[61.121939] Starting subtest: flip-vs-rmfb
[61.123879] Starting dynamic subtest: A-eDP1
[69.809521] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[69.818364] Starting dynamic subtest: B-eDP1
[78.485932] Dynamic subtest B-eDP1: SUCCESS (8.686s)
[78.494747] Starting dynamic subtest: C-eDP1
[87.111252] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[87.121081] Starting dynamic subtest: D-eDP1
[95.739599] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[95.746106] Subtest flip-vs-rmfb: SUCCESS (34.671s)
[96.914894] [005/133] (924s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[97.021210] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[97.023452] Starting dynamic subtest: pipe-A-eDP-1
[97.046257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.054123] Starting dynamic subtest: pipe-B-eDP-1
[97.075178] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.081783] Starting dynamic subtest: pipe-C-eDP-1
[97.102404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.109097] Starting dynamic subtest: pipe-D-eDP-1
[97.130757] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.135227] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[99.288668] [006/133] (921s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[99.351616] Starting subtest: x-tiled-to-vebox-y-tiled
[99.356219] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[99.545724] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[99.641633] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[99.646079] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[99.739098] [008/133] (921s left) gem_ctx_persistence (legacy-engines-mixed-process)
[99.802715] Starting subtest: legacy-engines-mixed-process
[99.804632] Starting dynamic subtest: render
[100.897756] Dynamic subtest render: SUCCESS (1.097s)
[100.907642] Starting dynamic subtest: bsd1
[102.886824] Dynamic subtest bsd1: SUCCESS (1.987s)
[102.896394] Starting dynamic subtest: bsd2
[104.930351] Dynamic subtest bsd2: SUCCESS (2.041s)
[104.940906] Starting dynamic subtest: blt
[106.835990] Dynamic subtest blt: SUCCESS (1.903s)
[106.846173] Starting dynamic subtest: vebox
[108.887678] Dynamic subtest vebox: SUCCESS (2.050s)
[108.890401] Subtest legacy-engines-mixed-process: SUCCESS (9.088s)
[109.011752] [009/133] (912s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[109.075826] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[109.134572] [010/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[109.242981] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[115.968322] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.726s)
[116.093798] [011/133] (905s left) gem_exec_fence (basic-await)
[116.293660] Starting subtest: basic-await
[116.295649] Starting dynamic subtest: rcs0
[116.368463] Dynamic subtest rcs0: SUCCESS (0.077s)
[116.379968] Starting dynamic subtest: bcs0
[116.442238] Dynamic subtest bcs0: SUCCESS (0.072s)
[116.452997] Starting dynamic subtest: vcs0
[116.515888] Dynamic subtest vcs0: SUCCESS (0.072s)
[116.526858] Starting dynamic subtest: vcs1
[116.589363] Dynamic subtest vcs1: SUCCESS (0.072s)
[116.600055] Starting dynamic subtest: vecs0
[116.663229] Dynamic subtest vecs0: SUCCESS (0.072s)
[116.673914] Starting dynamic subtest: ccs0
[116.736846] Dynamic subtest ccs0: SUCCESS (0.072s)
[116.739623] Subtest basic-await: SUCCESS (0.447s)
[119.017063] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[119.020722] [012/133] (902s left) kms_vblank (query-forked)
[119.122927] Starting subtest: query-forked
[119.125211] Starting dynamic subtest: pipe-A-eDP-1
[120.934226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[120.947075] Starting dynamic subtest: pipe-D-eDP-1
[123.427762] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.493s)
[123.430069] Subtest query-forked: SUCCESS (4.308s)
[124.286827] [013/133] (897s left) gem_create (hog-create)
[124.342654] Starting subtest: hog-create
[124.344918] Starting dynamic subtest: smem0
[157.854478] Dynamic subtest smem0: SUCCESS (33.508s)
[157.857081] Subtest hog-create: SUCCESS (33.510s)
[158.037935] [014/133] (863s left) syncobj_wait (single-wait-all-for-submit-signaled)
[158.104441] Starting subtest: single-wait-all-for-submit-signaled
[158.106883] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[158.211811] [015/133] (863s left) gem_exec_balancer (hang)
[158.477876] Starting subtest: hang
[160.205793] Subtest hang: SUCCESS (1.732s)
[160.334519] [016/133] (861s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[160.432087] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[160.434302] Starting dynamic subtest: pipe-A-eDP-1
[160.443157] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.451739] Starting dynamic subtest: pipe-B-eDP-1
[160.460882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.471743] Starting dynamic subtest: pipe-C-eDP-1
[160.480274] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.487928] Starting dynamic subtest: pipe-D-eDP-1
[160.496250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.500198] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[162.758403] [017/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[162.854764] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[162.858508] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[162.953821] [018/133] (858s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[163.337211] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[164.157561] [019/133] (857s left) vgem_basic (bad-flag)
[164.208314] Starting subtest: bad-flag
[164.210709] Subtest bad-flag: SUCCESS (0.000s)
[164.265570] [020/133] (857s left) kms_flip (flip-vs-panning)
[164.366580] Starting subtest: flip-vs-panning
[164.369042] Starting dynamic subtest: A-eDP1
[173.090415] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[173.101327] Starting dynamic subtest: B-eDP1
[181.822812] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[181.834077] Starting dynamic subtest: C-eDP1
[190.550534] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[190.559415] Starting dynamic subtest: D-eDP1
[199.279742] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[199.281887] Subtest flip-vs-panning: SUCCESS (34.915s)
[200.433685] [021/133] (821s left) kms_setmode (invalid-clone-exclusive-crtc)
[200.499697] Starting subtest: invalid-clone-exclusive-crtc
[200.506071] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[200.602139] [022/133] (821s left) gem_exec_reloc (basic-softpin)
[200.663153] Subtest basic-softpin: SKIP (0.000s)
[200.734065] [023/133] (821s left) gen9_exec_parse (unaligned-access)
[200.786264] Subtest unaligned-access: SKIP (0.000s)
[200.854369] [024/133] (821s left) kms_rotation_crc (primary-rotation-180)
[200.942471] Starting subtest: primary-rotation-180
[207.973657] Subtest primary-rotation-180: SUCCESS (7.033s)
[209.224952] [025/133] (812s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[209.337067] Starting subtest: y-tiled-8bpp-rotate-0
[209.341542] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[209.435994] [026/133] (812s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[210.974967] Starting subtest: modeset-lpsp-stress-no-wait
[221.401508] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.428s)
[221.479601] [027/133] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[221.586617] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[221.591100] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[221.700578] [028/133] (800s left) prime_vgem (busy)
[221.771696] Starting subtest: busy
[221.774040] Starting dynamic subtest: rcs0
[221.850226] Dynamic subtest rcs0: SUCCESS (0.078s)
[221.859610] Starting dynamic subtest: bcs0
[221.921996] Dynamic subtest bcs0: SUCCESS (0.071s)
[221.929976] Starting dynamic subtest: vcs0
[221.969086] Dynamic subtest vcs0: SUCCESS (0.046s)
[221.977210] Starting dynamic subtest: vcs1
[222.015438] Dynamic subtest vcs1: SUCCESS (0.045s)
[222.023557] Starting dynamic subtest: vecs0
[222.060374] Dynamic subtest vecs0: SUCCESS (0.044s)
[222.068327] Starting dynamic subtest: ccs0
[222.106648] Dynamic subtest ccs0: SUCCESS (0.045s)
[222.108947] Subtest busy: SUCCESS (0.336s)
[222.238571] [029/133] (799s left) gem_ctx_param (basic)
[222.290902] Starting subtest: basic
[222.293310] Subtest basic: SUCCESS (0.001s)
[222.399078] [030/133] (799s left) syncobj_timeline (multi-wait-signaled)
[222.445514] Starting subtest: multi-wait-signaled
[222.447480] Subtest multi-wait-signaled: SUCCESS (0.001s)
[222.550806] [031/133] (799s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[222.603681] Starting subtest: invalid-bsd1-flag-on-blt
[222.605753] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[222.713329] [032/133] (799s left) i915_query (test-query-geometry-subslices)
[222.783043] Starting subtest: test-query-geometry-subslices
[222.784972] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[222.889331] [033/133] (799s left) kms_psr2_su (frontbuffer-xrgb8888)
[222.944788] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[223.036674] [034/133] (799s left) kms_color (ctm-negative)
[223.126609] Starting subtest: ctm-negative
[223.128519] Starting dynamic subtest: pipe-A-eDP-1
[223.846468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[223.855446] Starting dynamic subtest: pipe-B-eDP-1
[225.295154] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[225.303306] Starting dynamic subtest: pipe-C-eDP-1
[226.656971] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[226.666309] Starting dynamic subtest: pipe-D-eDP-1
[227.987154] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[227.990234] Subtest ctm-negative: SUCCESS (4.860s)
[228.790794] [035/133] (793s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[228.884044] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[228.888311] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[228.954773] [036/133] (793s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[229.017503] Subtest no-spare-fences-busy: SKIP (0.000s)
[229.102716] [037/133] (793s left) gem_exec_schedule (independent)
[229.165073] Starting subtest: independent
[229.166997] Starting dynamic subtest: rcs0
[230.936063] Dynamic subtest rcs0: SUCCESS (1.779s)
[230.947932] Starting dynamic subtest: vcs0
[232.948833] Dynamic subtest vcs0: SUCCESS (2.010s)
[232.959580] Starting dynamic subtest: vcs1
[234.909450] Dynamic subtest vcs1: SUCCESS (1.958s)
[234.919913] Starting dynamic subtest: vecs0
[236.897406] Dynamic subtest vecs0: SUCCESS (1.985s)
[236.908615] Starting dynamic subtest: ccs0
[238.935888] Dynamic subtest ccs0: SUCCESS (2.036s)
[238.939115] Subtest independent: SUCCESS (9.780s)
[239.238981] [038/133] (783s left) kms_cursor_crc (cursor-alpha-opaque)
[239.346072] Starting subtest: cursor-alpha-opaque
[239.348017] Starting dynamic subtest: pipe-A-eDP-1
[239.967355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[239.976652] Starting dynamic subtest: pipe-D-eDP-1
[241.253644] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.285s)
[241.255974] Subtest cursor-alpha-opaque: SUCCESS (1.907s)
[242.047683] [039/133] (780s left) gem_mmap_gtt (basic-write-read)
[242.114729] Subtest basic-write-read: SKIP (0.000s)
[242.170398] [040/133] (780s left) gen9_exec_parse (bb-secure)
[242.228020] Subtest bb-secure: SKIP (0.000s)
[242.298618] [041/133] (780s left) api_intel_bb (lot-of-buffers)
[242.347755] Starting subtest: lot-of-buffers
[243.394217] Subtest lot-of-buffers: SUCCESS (1.047s)
[243.825025] [042/133] (778s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[243.860761] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[243.910937] [043/133] (778s left) gem_exec_params (invalid-fence-in)
[243.958895] Starting subtest: invalid-fence-in
[243.961305] Subtest invalid-fence-in: SUCCESS (0.000s)
[244.085692] [044/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[244.184593] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[251.215985] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.034s)
[251.330185] [045/133] (771s left) gem_mmap_gtt (big-bo-tiledy)
[251.386786] Subtest big-bo-tiledY: SKIP (0.000s)
[251.450992] [046/133] (771s left) gem_softpin (evict-single-offset)
[251.507817] Starting subtest: evict-single-offset
[277.913225] Subtest evict-single-offset: SUCCESS (26.402s)
[278.029449] [047/133] (744s left) syncobj_wait (invalid-signal-illegal-handle)
[278.134233] Starting subtest: invalid-signal-illegal-handle
[278.136930] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[278.232149] [048/133] (744s left) kms_addfb_basic (master-rmfb)
[278.284233] Starting subtest: master-rmfb
[278.286662] Subtest master-rmfb: SUCCESS (0.001s)
[278.443618] [049/133] (744s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[278.531020] Starting subtest: plane-use-after-nonblocking-unbind
[278.533238] Starting dynamic subtest: pipe-A-eDP-1
[278.592775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[278.907907] Starting dynamic subtest: pipe-B-eDP-1
[279.676265] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s)
[279.977550] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.446s)
[280.830885] [050/133] (742s left) i915_pm_rpm (debugfs-forcewake-user)
[283.098999] Starting subtest: debugfs-forcewake-user
[294.487075] Subtest debugfs-forcewake-user: SUCCESS (11.392s)
[294.888970] [051/133] (728s left) kms_pm_dc (dc5-dpms-negative)
[295.979749] Starting subtest: dc5-dpms-negative
[295.984119] Subtest dc5-dpms-negative: SKIP (0.000s)
[296.054130] [052/133] (727s left) gem_ctx_sseu (engines)
[296.129736] Subtest engines: SKIP (0.000s)
[296.211572] [053/133] (727s left) kms_flip (2x-busy-flip)
[296.315076] Starting subtest: 2x-busy-flip
[296.326626] Subtest 2x-busy-flip: SKIP (0.011s)
[296.416033] [054/133] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[296.511460] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[296.515568] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[296.617209] [055/133] (726s left) kms_content_protection (suspend-resume)
[296.754053] Starting subtest: suspend-resume
[296.758655] Subtest suspend-resume: SKIP (0.000s)
[296.873826] [056/133] (726s left) gem_busy (busy)
[296.939461] Starting subtest: busy
[296.941482] Starting dynamic subtest: all-engines
[296.998994] Dynamic subtest all-engines: SUCCESS (0.059s)
[297.010348] Starting dynamic subtest: rcs0
[298.911962] Dynamic subtest rcs0: SUCCESS (1.910s)
[298.922440] Starting dynamic subtest: bcs0
[298.962305] Dynamic subtest bcs0: SUCCESS (0.048s)
[298.972075] Starting dynamic subtest: vcs0
[299.001109] Dynamic subtest vcs0: SUCCESS (0.039s)
[299.010219] Starting dynamic subtest: vcs1
[300.894662] Dynamic subtest vcs1: SUCCESS (1.888s)
[300.904872] Starting dynamic subtest: vecs0
[302.941522] Dynamic subtest vecs0: SUCCESS (2.046s)
[302.950943] Starting dynamic subtest: ccs0
[304.927244] Dynamic subtest ccs0: SUCCESS (1.984s)
[304.929302] Subtest busy: SUCCESS (7.983s)
[305.295009] [057/133] (718s left) kms_chamelium_frames (dp-crc-multiple)
[305.685949] Subtest dp-crc-multiple: SKIP (0.000s)
[306.492516] [058/133] (716s left) gem_userptr_blits (nohangcheck)
[306.562839] Starting subtest: nohangcheck
[306.804358] Subtest nohangcheck: SUCCESS (0.238s)
[306.929965] [059/133] (716s left) kms_invalid_mode (bad-vtotal)
[307.015513] Starting subtest: bad-vtotal
[307.017856] Starting dynamic subtest: pipe-A-eDP-1
[307.301637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[307.310955] Starting dynamic subtest: pipe-B-eDP-1
[307.313032] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[307.320894] Starting dynamic subtest: pipe-C-eDP-1
[307.322884] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[307.331290] Starting dynamic subtest: pipe-D-eDP-1
[307.333671] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[307.336055] Subtest bad-vtotal: SUCCESS (0.292s)
[308.159444] [060/133] (715s left) gem_partial_pwrite_pread (write-uncached)
[308.210723] Subtest write-uncached: SKIP (0.000s)
[308.285128] [061/133] (715s left) gem_mmap_gtt (bad-object)
[308.349709] Subtest bad-object: SKIP (0.000s)
[308.421035] [062/133] (715s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[308.507538] Starting subtest: psr-rgb565-draw-mmap-cpu
[315.415014] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.911s)
[315.515990] [063/133] (708s left) kms_big_fb (yf-tiled-addfb)
[315.626957] Starting subtest: yf-tiled-addfb
[315.631399] Subtest yf-tiled-addfb: SKIP (0.000s)
[315.712850] [064/133] (707s left) gem_exec_reloc (basic-write-read-active)
[315.781533] Subtest basic-write-read-active: SKIP (0.000s)
[315.847098] [065/133] (707s left) kms_lease (setcrtc-implicit-plane)
[315.932862] Starting subtest: setcrtc-implicit-plane
[315.935075] Starting dynamic subtest: pipe-A-eDP-1
[316.424311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[316.436234] Starting dynamic subtest: pipe-B-eDP-1
[317.592860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[317.605362] Starting dynamic subtest: pipe-C-eDP-1
[318.709710] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[318.718828] Starting dynamic subtest: pipe-D-eDP-1
[319.848116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[319.850451] Subtest setcrtc-implicit-plane: SUCCESS (3.916s)
[320.682884] [066/133] (703s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[320.778329] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[321.846390] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s)
[321.970267] [067/133] (701s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[322.064142] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[322.065986] Starting dynamic subtest: pipe-A-eDP-1
[322.083889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.092566] Starting dynamic subtest: pipe-B-eDP-1
[322.109606] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.117708] Starting dynamic subtest: pipe-C-eDP-1
[322.134898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.143770] Starting dynamic subtest: pipe-D-eDP-1
[322.162088] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.166045] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[324.331257] [068/133] (699s left) kms_chamelium_audio (hdmi-audio-edid)
[324.715843] Subtest hdmi-audio-edid: SKIP (0.000s)
[325.543787] [069/133] (698s left) vgem_basic (sysfs)
[325.602580] Starting subtest: sysfs
[325.604919] Subtest sysfs: SUCCESS (0.000s)
[325.678029] [070/133] (698s left) kms_vrr (negative-basic)
[325.771200] Starting subtest: negative-basic
[325.777571] Starting dynamic subtest: pipe-A-eDP-1
[331.194168] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[331.491833] Subtest negative-basic: SUCCESS (5.720s)
[332.292384] [071/133] (691s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[332.395212] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[332.399663] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[333.512448] [072/133] (690s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[333.606207] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[333.618433] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[333.694941] [073/133] (690s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[333.802205] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[333.806204] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[333.875351] [074/133] (690s left) gem_exec_whisper (basic-forked)
[333.959185] Starting subtest: basic-forked
[341.827831] Subtest basic-forked: SUCCESS (7.865s)
[342.012343] [075/133] (682s left) gem_exec_reloc (basic-write-read-noreloc)
[342.087923] Subtest basic-write-read-noreloc: SKIP (0.000s)
[342.160829] [076/133] (682s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[342.255946] Starting subtest: multiplane-rotation-cropping-top
[359.758477] Subtest multiplane-rotation-cropping-top: SUCCESS (17.504s)
[359.877965] [077/133] (664s left) gen3_mixed_blits
[360.011246] [078/133] (664s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[360.101616] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[366.883494] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.783s)
[367.018502] [079/133] (657s left) kms_hdmi_inject (inject-audio)
[367.364596] Starting subtest: inject-audio
[367.643378] Subtest inject-audio: SUCCESS (0.281s)
[368.211794] [080/133] (656s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[368.324318] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[368.328597] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[368.434990] [081/133] (655s left) gem_mmap_gtt (hang-user)
[368.507830] Subtest hang-user: SKIP (0.000s)
[368.572596] [082/133] (655s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[368.628100] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[368.703624] [083/133] (655s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[368.794630] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[368.797116] Starting dynamic subtest: pipe-A
[368.814754] Dynamic subtest pipe-A: SKIP (0.018s)
[368.824411] Starting dynamic subtest: pipe-B
[368.848094] Dynamic subtest pipe-B: SKIP (0.032s)
[368.857532] Starting dynamic subtest: pipe-C
[368.881421] Dynamic subtest pipe-C: SKIP (0.032s)
[368.892566] Starting dynamic subtest: pipe-D
[368.916820] Dynamic subtest pipe-D: SKIP (0.035s)
[368.921230] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.121s)
[369.030811] [084/133] (655s left) kms_hdr (static-swap)
[369.122052] Starting subtest: static-swap
[369.127273] Subtest static-swap: SKIP (0.000s)
[369.195895] [085/133] (655s left) gem_exec_fence (syncobj-timeline-repeat)
[369.777833] Starting subtest: syncobj-timeline-repeat
[370.021077] Subtest syncobj-timeline-repeat: SUCCESS (0.247s)
[370.994874] [086/133] (653s left) gem_ctx_isolation (preservation-reset)
[371.164213] Starting subtest: preservation-reset
[371.167079] Starting dynamic subtest: rcs0
[371.444224] Dynamic subtest rcs0: SUCCESS (0.280s)
[371.454084] Starting dynamic subtest: bcs0
[371.762492] Dynamic subtest bcs0: SUCCESS (0.317s)
[371.774908] Starting dynamic subtest: vcs0
[372.112919] Dynamic subtest vcs0: SUCCESS (0.349s)
[372.124467] Starting dynamic subtest: vcs1
[373.194201] Dynamic subtest vcs1: SUCCESS (1.081s)
[373.205517] Starting dynamic subtest: vecs0
[375.234908] Dynamic subtest vecs0: SUCCESS (2.040s)
[375.244649] Starting dynamic subtest: ccs0
[377.228179] Dynamic subtest ccs0: SUCCESS (1.992s)
[377.230542] Subtest preservation-reset: SUCCESS (6.067s)
[377.366869] [087/133] (647s left) kms_async_flips (crc-atomic)
[377.462182] Starting subtest: crc-atomic
[377.849332] Starting dynamic subtest: pipe-A-eDP-1
[380.759873] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.908s)
[381.138367] Starting dynamic subtest: pipe-B-eDP-1
[384.047475] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.921s)
[384.431642] Starting dynamic subtest: pipe-C-eDP-1
[387.333077] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.915s)
[387.714228] Starting dynamic subtest: pipe-D-eDP-1
[390.635919] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.930s)
[390.638145] Subtest crc-atomic: SUCCESS (13.175s)
[391.870850] [088/133] (632s left) kms_cursor_legacy (forked-bo)
[391.991832] Starting subtest: forked-bo
[391.993768] Starting dynamic subtest: pipe-A
[397.489453] Dynamic subtest pipe-A: SUCCESS (5.496s)
[397.504548] Starting dynamic subtest: pipe-B
[402.966685] Dynamic subtest pipe-B: SUCCESS (5.474s)
[402.978357] Starting dynamic subtest: pipe-C
[408.436385] Dynamic subtest pipe-C: SUCCESS (5.467s)
[408.448280] Starting dynamic subtest: pipe-D
[413.903083] Dynamic subtest pipe-D: SUCCESS (5.464s)
[413.914999] Starting dynamic subtest: all-pipes
[419.415846] Dynamic subtest all-pipes: SUCCESS (5.509s)
[419.418531] Subtest forked-bo: SUCCESS (27.423s)
[419.560757] [089/133] (605s left) syncobj_eventfd (timeline-wait-signaled)
[419.617140] Starting subtest: timeline-wait-signaled
[419.619399] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[419.716460] [090/133] (605s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[419.813107] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[427.095254] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.285s)
[427.233682] [091/133] (597s left) syncobj_timeline (invalid-transfer-non-existent-point)
[427.295403] Starting subtest: invalid-transfer-non-existent-point
[427.297285] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[427.397964] [092/133] (597s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[427.521912] Starting subtest: cursorB-vs-flipA-atomic-transitions
[427.526490] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[427.667614] [093/133] (597s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[427.762155] Starting subtest: x-tiled-32bpp-rotate-90
[427.783135] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[427.891399] [094/133] (597s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[427.999920] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[428.026335] Starting dynamic subtest: pipe-A-plane-0
[428.681516] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[428.693394] Starting dynamic subtest: pipe-A-plane-3
[429.103477] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[430.231182] Starting dynamic subtest: pipe-B-plane-0
[430.889881] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[430.899768] Starting dynamic subtest: pipe-B-plane-3
[431.323535] Dynamic subtest pipe-B-plane-3: SUCCESS (0.431s)
[431.630905] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.632s)
[432.490523] [095/133] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[432.598399] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[432.602865] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[432.702081] [096/133] (592s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[432.752581] Starting subtest: single-wait-for-submit-available-signaled
[432.754820] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[432.859196] [097/133] (592s left) gem_exec_flush (basic-batch-kernel-default-uc)
[432.926966] Starting subtest: basic-batch-kernel-default-uc
[439.590553] Subtest basic-batch-kernel-default-uc: SUCCESS (6.663s)
[439.783752] [098/133] (585s left) gem_fence_thrash (bo-write-verify-threaded-y)
[439.823620] Starting subtest: bo-write-verify-threaded-y
[439.847089] Subtest bo-write-verify-threaded-y: SKIP (0.020s)
[439.905122] [099/133] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[440.016281] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[440.020581] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[440.121574] [100/133] (585s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[440.218368] Starting subtest: psr2-cursor-plane-update-sf
[440.220528] Starting dynamic subtest: pipe-A-eDP-1
[440.781977] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[440.794192] Starting dynamic subtest: pipe-B-eDP-1
[442.039636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[442.041963] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.824s)
[442.886613] [101/133] (582s left) kms_cursor_crc (cursor-random-256x85)
[443.158210] Starting subtest: cursor-random-256x85
[443.206437] Subtest cursor-random-256x85: SKIP (0.042s)
[443.390190] [102/133] (581s left) gem_mmap_offset (ptrace)
[443.443833] Starting subtest: ptrace
[443.446950] Starting dynamic subtest: smem0-wb
[443.456574] Dynamic subtest smem0-wb: SUCCESS (0.014s)
[443.468573] Starting dynamic subtest: smem0-wc
[443.477753] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[443.491156] Starting dynamic subtest: smem0-uc
[443.498299] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[443.500570] Subtest ptrace: SUCCESS (0.059s)
[443.621431] [103/133] (581s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[443.726052] Starting subtest: compare-crc-sanitycheck-xr24
[443.728287] Starting dynamic subtest: pipe-A-eDP-1
[444.391957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.666s)
[444.402217] Starting dynamic subtest: pipe-B-eDP-1
[445.772084] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[445.784028] Starting dynamic subtest: pipe-C-eDP-1
[447.007340] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[447.016563] Starting dynamic subtest: pipe-D-eDP-1
[448.309981] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[448.312310] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.586s)
[449.173957] [104/133] (576s left) kms_force_connector_basic (prune-stale-modes)
[449.253797] Starting subtest: prune-stale-modes
[449.700324] Subtest prune-stale-modes: SUCCESS (0.447s)
[449.847386] [105/133] (575s left) kms_psr (psr-cursor-plane-move)
[449.938888] Starting subtest: psr-cursor-plane-move
[449.941092] Starting dynamic subtest: eDP-1
[451.628631] Dynamic subtest eDP-1: SUCCESS (1.689s)
[451.631087] Subtest psr-cursor-plane-move: SUCCESS (1.690s)
[452.474186] [106/133] (573s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[452.569515] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[452.573953] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[452.670306] [107/133] (572s left) kms_big_fb (linear-8bpp-rotate-270)
[452.766609] Starting subtest: linear-8bpp-rotate-270
[452.790163] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[452.912973] [108/133] (572s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[452.966926] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[453.038752] [109/133] (572s left) gem_exec_schedule (fairslice-all)
[453.105872] Starting subtest: fairslice-all
[455.161654] Subtest fairslice-all: SUCCESS (2.061s)
[455.466794] [110/133] (570s left) kms_psr (pr-no-drrs)
[455.554885] Starting subtest: pr-no-drrs
[455.559365] Subtest pr-no-drrs: SKIP (0.000s)
[455.627803] [111/133] (570s left) gem_exec_reloc (basic-wc-gtt)
[455.685651] Subtest basic-wc-gtt: SKIP (0.000s)
[455.743354] [112/133] (570s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[455.835151] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[455.839365] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[455.905206] [113/133] (569s left) kms_dsc (dsc-with-bpc)
[455.995185] Starting subtest: dsc-with-bpc
[456.024303] Subtest dsc-with-bpc: SKIP (0.001s)
[456.080176] [114/133] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[456.181572] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[456.185767] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[456.273281] [115/133] (569s left) i915_module_load (reload-no-display)
[456.311440] Starting subtest: reload-no-display
[460.714251] Subtest reload-no-display: SUCCESS (4.405s)
[460.744253] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[460.744975] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[460.748181] [116/133] (565s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[462.273304] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[462.378792] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[462.446994] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[462.448217] [FACT syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[462.453056] [117/133] (563s left) dmabuf (all-tests)
[462.496417] Starting subtest: all-tests
[462.498800] Starting dynamic subtest: sanitycheck
[462.588169] Dynamic subtest sanitycheck: SUCCESS (0.094s)
[462.600465] Starting dynamic subtest: dma_fence
[462.793738] Dynamic subtest dma_fence: SUCCESS (0.203s)
[462.805585] Starting dynamic subtest: dma_fence_chain
[472.121285] Dynamic subtest dma_fence_chain: SUCCESS (9.324s)
[472.132222] Starting dynamic subtest: dma_fence_unwrap
[472.220640] Dynamic subtest dma_fence_unwrap: SUCCESS (0.098s)
[472.231961] Starting dynamic subtest: dma_resv
[472.310521] Dynamic subtest dma_resv: SUCCESS (0.088s)
[472.313164] Subtest all-tests: SUCCESS (9.817s)
[472.391840] [118/133] (553s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[472.450211] Starting subtest: single-wait-all-for-submit-unsubmitted
[472.556310] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[472.652943] [119/133] (553s left) api_intel_allocator (simple-allocator)
[472.713838] Starting subtest: simple-allocator
[472.716568] Starting dynamic subtest: basic
[472.722135] Dynamic subtest basic: SUCCESS (0.010s)
[472.735772] Starting dynamic subtest: parallel-one
[472.933291] Dynamic subtest parallel-one: SUCCESS (0.209s)
[472.941387] Starting dynamic subtest: print
[472.943630] Dynamic subtest print: SUCCESS (0.000s)
[472.951657] Starting dynamic subtest: reuse
[472.953970] Dynamic subtest reuse: SUCCESS (0.000s)
[472.961819] Starting dynamic subtest: reserve
[472.963877] Dynamic subtest reserve: SUCCESS (0.000s)
[472.971980] Starting dynamic subtest: fork-reopen-allocator
[472.973911] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[472.975840] Subtest simple-allocator: SUCCESS (0.239s)
[473.095938] [120/133] (552s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[473.216067] Starting subtest: yf-tiled-16bpp-rotate-180
[473.220544] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[473.312506] [121/133] (552s left) gem_exec_schedule (u-independent)
[473.389630] Starting subtest: u-independent
[473.391591] Starting dynamic subtest: rcs0
[474.907652] Dynamic subtest rcs0: SUCCESS (1.523s)
[474.919307] Starting dynamic subtest: vcs0
[476.904758] Dynamic subtest vcs0: SUCCESS (1.995s)
[476.915977] Starting dynamic subtest: vcs1
[478.951961] Dynamic subtest vcs1: SUCCESS (2.045s)
[478.964389] Starting dynamic subtest: vecs0
[480.936359] Dynamic subtest vecs0: SUCCESS (1.982s)
[480.947215] Starting dynamic subtest: ccs0
[482.903957] Dynamic subtest ccs0: SUCCESS (1.964s)
[482.906983] Subtest u-independent: SUCCESS (9.521s)
[483.209366] [122/133] (542s left) gem_exec_params (sol-reset-not-gen7)
[483.274674] Starting subtest: sol-reset-not-gen7
[483.280109] Subtest sol-reset-not-gen7: SUCCESS (0.005s)
[483.416249] [123/133] (542s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[483.471236] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[483.475132] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[483.682782] [124/133] (542s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[483.772519] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[490.810462] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.038s)
[490.921374] [125/133] (535s left) kms_cursor_crc (cursor-suspend)
[491.049903] Starting subtest: cursor-suspend
[491.052070] Starting dynamic subtest: pipe-A-eDP-1
[523.833440] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.261s)
[523.843231] Starting dynamic subtest: pipe-D-eDP-1
[557.806402] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.811s)
[557.808573] Subtest cursor-suspend: SUCCESS (7.078s)
[558.822471] [126/133] (467s left) gem_userptr_blits (sync-unmap-after-close)
[558.894643] Starting subtest: sync-unmap-after-close
[558.902482] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[559.047082] [127/133] (467s left) kms_vblank (ts-continuation-modeset-rpm)
[559.146152] Starting subtest: ts-continuation-modeset-rpm
[559.148343] Starting dynamic subtest: pipe-A-eDP-1
[561.617907] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.539s)
[561.632622] Starting dynamic subtest: pipe-D-eDP-1
[563.811342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.236s)
[563.813609] Subtest ts-continuation-modeset-rpm: SUCCESS (4.779s)
[564.817980] [128/133] (461s left) gem_userptr_blits (create-destroy-sync)
[564.876376] Starting subtest: create-destroy-sync
[569.889719] Subtest create-destroy-sync: SUCCESS (5.068s)
[570.015926] [129/133] (456s left) gem_sync (basic-many-each)
[570.104589] Starting subtest: basic-many-each
[572.381131] Subtest basic-many-each: SUCCESS (2.301s)
[572.567371] [130/133] (453s left) kms_psr (fbc-psr2-no-drrs)
[572.670381] Starting subtest: fbc-psr2-no-drrs
[572.672672] Starting dynamic subtest: eDP-1
[572.676642] Dynamic subtest eDP-1: SKIP (0.000s)
[572.680627] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[572.746202] [131/133] (453s left) kms_plane (plane-position-covered)
[572.835393] Starting subtest: plane-position-covered
[573.374207] Starting dynamic subtest: pipe-A-plane-1
[574.653821] Dynamic subtest pipe-A-plane-1: SUCCESS (1.286s)
[574.665205] Starting dynamic subtest: pipe-A-plane-2
[575.954859] Dynamic subtest pipe-A-plane-2: SUCCESS (1.306s)
[575.965628] Starting dynamic subtest: pipe-A-plane-3
[577.298788] Dynamic subtest pipe-A-plane-3: SUCCESS (1.349s)
[577.310095] Starting dynamic subtest: pipe-A-plane-4
[578.632638] Dynamic subtest pipe-A-plane-4: SUCCESS (1.337s)
[578.645493] Starting dynamic subtest: pipe-A-plane-5
[578.658493] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[579.871986] Starting dynamic subtest: pipe-B-plane-1
[581.174688] Dynamic subtest pipe-B-plane-1: SUCCESS (1.315s)
[581.186457] Starting dynamic subtest: pipe-B-plane-2
[582.507434] Dynamic subtest pipe-B-plane-2: SUCCESS (1.334s)
[582.518286] Starting dynamic subtest: pipe-B-plane-3
[583.838246] Dynamic subtest pipe-B-plane-3: SUCCESS (1.331s)
[583.848356] Starting dynamic subtest: pipe-B-plane-4
[585.196909] Dynamic subtest pipe-B-plane-4: SUCCESS (1.359s)
[585.208103] Starting dynamic subtest: pipe-B-plane-5
[585.222133] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[585.224492] Subtest plane-position-covered: SUCCESS (12.425s)
[586.031296] [132/133] (440s left) kms_psr (fbc-psr-sprite-render)
[586.124870] Starting subtest: fbc-psr-sprite-render
[586.126816] Starting dynamic subtest: eDP-1
[586.130969] Dynamic subtest eDP-1: SKIP (0.000s)
[586.135154] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[586.199624] [133/133] (440s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[586.293157] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[586.297224] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[586.389981] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_pipe_b_c_ivb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: vgem_basic
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_psr2_su
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_fenced_exec_thrash
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: api_intel_bb
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_atomic_transition
results: parsing output: 49/ for test: i915_pm_rpm
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_busy
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: gen3_mixed_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_hdmi_inject
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_ctx_isolation
results: parsing output: 86/ for test: kms_async_flips
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: gem_exec_flush
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: kms_pipe_crc_basic
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_dsc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_module_load
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: dmabuf
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: gem_sync
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.