[58.463674] Initializing watchdogs
[58.463727]   /dev/watchdog0
[58.479160] [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]
[58.484493] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.486964] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.490381] [001/133] (960s left) gem_exec_reloc (basic-write-wc-active)
[58.580188] Subtest basic-write-wc-active: SKIP (0.000s)
[58.645721] [002/133] (960s left) gem_partial_pwrite_pread (reads)
[58.715086] Subtest reads: SKIP (0.000s)
[58.777191] [003/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[58.879624] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[58.928813] Starting dynamic subtest: pipe-A-plane-0
[59.380318] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[59.389221] Starting dynamic subtest: pipe-A-plane-3
[59.640133] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[60.748065] Starting dynamic subtest: pipe-B-plane-0
[61.182535] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[61.191662] Starting dynamic subtest: pipe-B-plane-3
[61.451476] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[61.763895] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.839s)
[62.647005] [004/133] (956s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[62.769768] Starting subtest: cursorA-vs-flipB-atomic-transitions
[62.774528] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[62.913274] [005/133] (956s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[63.011330] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[63.015776] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[63.083681] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[63.191914] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[63.196322] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[63.272418] [007/133] (955s left) kms_psr (pr-dpms)
[63.367887] Starting subtest: pr-dpms
[63.372383] Subtest pr-dpms: SKIP (0.000s)
[63.437185] [008/133] (955s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[63.499514] Starting subtest: multi-wait-for-submit-unsubmitted
[63.607436] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[63.684798] [009/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[63.783918] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[63.788211] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[63.888898] [010/133] (955s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[63.996655] Starting subtest: yf-tiled-8bpp-rotate-270
[64.001350] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[64.090235] [011/133] (955s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[64.200109] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[70.771335] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.535s)
[70.869347] [012/133] (948s left) prime_busy (before-wait)
[70.926045] Starting subtest: before-wait
[70.930488] Starting dynamic subtest: rcs0
[70.958084] Dynamic subtest rcs0: SUCCESS (0.030s)
[70.965592] Starting dynamic subtest: bcs0
[71.009515] Dynamic subtest bcs0: SUCCESS (0.051s)
[71.017411] Starting dynamic subtest: vcs0
[71.047696] Dynamic subtest vcs0: SUCCESS (0.038s)
[71.054894] Starting dynamic subtest: vcs1
[71.087824] Dynamic subtest vcs1: SUCCESS (0.040s)
[71.095136] Starting dynamic subtest: vecs0
[71.127467] Dynamic subtest vecs0: SUCCESS (0.039s)
[71.134767] Starting dynamic subtest: ccs0
[71.166927] Dynamic subtest ccs0: SUCCESS (0.039s)
[71.277380] Subtest before-wait: SUCCESS (0.349s)
[71.366692] [013/133] (948s left) perf (blocking-parameterized)
[71.494740] Starting subtest: blocking-parameterized
[91.516111] Subtest blocking-parameterized: SUCCESS (19.991s)
[91.561037] [014/133] (927s left) kms_atomic_interruptible (universal-setplane-cursor)
[91.649960] Starting subtest: universal-setplane-cursor
[91.652322] Starting dynamic subtest: pipe-A-eDP-1
[99.072576] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[99.074867] Subtest universal-setplane-cursor: SUCCESS (7.418s)
[99.919009] [015/133] (919s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[100.027952] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[101.089262] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.061s)
[101.207524] [016/133] (918s left) gem_softpin (allocator-nopin)
[101.260670] Starting subtest: allocator-nopin
[101.352623] Subtest allocator-nopin: SUCCESS (0.092s)
[101.463519] [017/133] (918s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[101.556535] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[101.568317] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[101.669296] [018/133] (917s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[101.769216] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[101.771193] Starting dynamic subtest: pipe-A-eDP-1
[101.788105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[101.797458] Starting dynamic subtest: pipe-B-eDP-1
[101.813461] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[101.820395] Starting dynamic subtest: pipe-C-eDP-1
[101.836211] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[101.842950] Starting dynamic subtest: pipe-D-eDP-1
[101.859254] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[101.861222] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[103.986640] [019/133] (915s left) gem_exec_schedule (pi-distinct-iova)
[104.175547] Starting subtest: pi-distinct-iova
[104.177973] Starting dynamic subtest: rcs0
[104.250292] Dynamic subtest rcs0: SUCCESS (0.077s)
[104.263219] Starting dynamic subtest: vcs0
[104.305948] Dynamic subtest vcs0: SUCCESS (0.055s)
[104.317656] Starting dynamic subtest: vcs1
[104.372777] Dynamic subtest vcs1: SUCCESS (0.067s)
[104.380709] Starting dynamic subtest: vecs0
[104.425716] Dynamic subtest vecs0: SUCCESS (0.053s)
[104.434320] Starting dynamic subtest: ccs0
[104.490078] Dynamic subtest ccs0: SUCCESS (0.064s)
[104.492369] Subtest pi-distinct-iova: SUCCESS (0.318s)
[105.411522] [020/133] (914s left) core_hotunplug (unbind-rebind)
[105.503989] Starting subtest: unbind-rebind
[111.375962] Subtest unbind-rebind: SUCCESS (5.872s)
[111.423703] [021/133] (908s left) i915_hangman (engine-engine-hang)
[113.301389] Starting subtest: engine-engine-hang
[113.303310] Starting dynamic subtest: rcs0
[115.265297] Dynamic subtest rcs0: SUCCESS (1.964s)
[115.275654] Starting dynamic subtest: bcs0
[117.249419] Dynamic subtest bcs0: SUCCESS (1.981s)
[117.262107] Starting dynamic subtest: vcs0
[118.273259] Dynamic subtest vcs0: SUCCESS (1.024s)
[118.292157] Starting dynamic subtest: vcs1
[120.321229] Dynamic subtest vcs1: SUCCESS (2.046s)
[120.332825] Starting dynamic subtest: vecs0
[122.305982] Dynamic subtest vecs0: SUCCESS (1.983s)
[122.317459] Starting dynamic subtest: ccs0
[124.290565] Dynamic subtest ccs0: SUCCESS (1.983s)
[124.293289] Subtest engine-engine-hang: SUCCESS (10.988s)
[124.416080] [022/133] (895s left) kms_chamelium_hpd (dp-hpd-fast)
[124.809524] Subtest dp-hpd-fast: SKIP (0.000s)
[125.589910] [023/133] (894s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[125.710528] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[125.715275] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[125.805805] [024/133] (894s left) kms_psr (fbc-pr-sprite-plane-onoff)
[125.908203] Starting subtest: fbc-pr-sprite-plane-onoff
[125.912220] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[125.981055] [025/133] (893s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[126.078711] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[126.080852] Starting dynamic subtest: pipe-A-eDP-1
[132.880664] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.801s)
[132.892087] Starting dynamic subtest: pipe-B-eDP-1
[139.970853] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.090s)
[139.973181] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.894s)
[140.834211] [026/133] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[140.934560] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[148.442478] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.510s)
[148.568371] [027/133] (871s left) syncobj_timeline (wait-for-submit-delayed-submit)
[148.618262] Starting subtest: wait-for-submit-delayed-submit
[148.721651] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[148.812231] [028/133] (871s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[148.906668] Starting subtest: yf-tiled-32bpp-rotate-180
[148.910839] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[148.990612] [029/133] (871s left) core_setmaster_vs_auth
[149.156814] [030/133] (871s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[149.248302] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[149.250561] Starting dynamic subtest: pipe-A-eDP-1
[149.259608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.273594] Starting dynamic subtest: pipe-B-eDP-1
[149.282641] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.291474] Starting dynamic subtest: pipe-C-eDP-1
[149.300083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.308281] Starting dynamic subtest: pipe-D-eDP-1
[149.316675] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.320915] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[151.526823] [031/133] (868s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[151.622343] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[151.624578] Starting dynamic subtest: pipe-A-eDP-1
[151.647444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.658751] Starting dynamic subtest: pipe-B-eDP-1
[151.680119] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.688498] Starting dynamic subtest: pipe-C-eDP-1
[151.710031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.718103] Starting dynamic subtest: pipe-D-eDP-1
[151.740251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.744214] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[153.892804] [032/133] (866s left) kms_rotation_crc (primary-rotation-180)
[153.978711] Starting subtest: primary-rotation-180
[160.896556] Subtest primary-rotation-180: SUCCESS (6.920s)
[162.089234] [033/133] (858s left) perf (buffer-fill)
[162.218035] Starting subtest: buffer-fill
[162.220232] Starting dynamic subtest: 0-rcs0
[164.477394] Dynamic subtest 0-rcs0: SUCCESS (2.260s)
[164.487539] Starting dynamic subtest: 1-vcs0
[168.924444] Dynamic subtest 1-vcs0: SUCCESS (4.446s)
[168.926707] Subtest buffer-fill: SUCCESS (6.708s)
[168.972981] [034/133] (851s left) kms_lease (lease-again)
[169.074914] Starting subtest: lease-again
[169.077072] Starting dynamic subtest: pipe-A-eDP-1
[169.079344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[169.089066] Starting dynamic subtest: pipe-B-eDP-1
[169.090861] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[169.098748] Starting dynamic subtest: pipe-C-eDP-1
[169.100618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[169.108697] Starting dynamic subtest: pipe-D-eDP-1
[169.110601] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[169.112511] Subtest lease-again: SUCCESS (0.012s)
[169.183155] [035/133] (851s left) gem_exec_params (invalid-ring)
[169.242998] Starting subtest: invalid-ring
[169.244955] Subtest invalid-ring: SUCCESS (0.000s)
[169.340752] [036/133] (851s left) kms_setmode (invalid-clone-single-crtc)
[169.396972] Starting subtest: invalid-clone-single-crtc
[169.403582] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[169.495758] [037/133] (850s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[169.593118] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[169.597403] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[169.662991] [038/133] (850s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[169.785908] Starting subtest: 2x-cursor-vs-flip-legacy
[169.790464] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[169.929453] [039/133] (850s left) syncobj_wait (wait-any-snapshot)
[169.982398] Starting subtest: wait-any-snapshot
[170.064757] Subtest wait-any-snapshot: SUCCESS (0.082s)
[170.135975] [040/133] (850s left) kms_frontbuffer_tracking (psr-slowdraw)
[170.232163] Starting subtest: psr-slowdraw
[195.495940] Subtest psr-slowdraw: SUCCESS (25.265s)
[195.631920] [041/133] (824s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[195.730788] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[195.734969] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[195.826626] [042/133] (824s left) api_intel_allocator (execbuf-with-allocator)
[195.883883] Starting subtest: execbuf-with-allocator
[195.887416] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[195.973112] [043/133] (824s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[196.074752] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[196.079178] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[196.142421] [044/133] (824s left) kms_async_flips (async-flip-hang)
[196.229489] Starting subtest: async-flip-hang
[196.603512] Starting dynamic subtest: pipe-A-eDP-1
[211.848985] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.234s)
[212.223905] Starting dynamic subtest: pipe-B-eDP-1
[227.838643] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.615s)
[228.219584] Starting dynamic subtest: pipe-C-eDP-1
[243.837775] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.621s)
[244.212419] Starting dynamic subtest: pipe-D-eDP-1
[259.835770] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.627s)
[259.838371] Subtest async-flip-hang: SUCCESS (63.602s)
[261.070503] [045/133] (759s left) gem_exec_params (invalid-ring2)
[261.126132] Starting subtest: invalid-ring2
[261.128340] Subtest invalid-ring2: SUCCESS (0.000s)
[261.237632] [046/133] (759s left) kms_feature_discovery (psr1)
[261.335040] Starting subtest: psr1
[261.337166] Subtest psr1: SUCCESS (0.000s)
[261.414168] [047/133] (759s left) perf_pmu (all-busy-idle-check-all)
[261.454827] Starting subtest: all-busy-idle-check-all
[263.330249] Subtest all-busy-idle-check-all: SUCCESS (1.875s)
[263.439741] [048/133] (757s left) gem_tiled_partial_pwrite_pread (writes)
[263.501265] Subtest writes: SKIP (0.000s)
[263.564296] [049/133] (757s left) gem_eio (in-flight-contexts-1us)
[263.768410] Starting subtest: in-flight-contexts-1us
[277.359511] Subtest in-flight-contexts-1us: SUCCESS (13.589s)
[277.517134] [050/133] (743s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[277.584988] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[277.686052] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[277.761354] [051/133] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[277.867443] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[285.228452] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.364s)
[285.376404] [052/133] (735s left) kms_psr (psr2-primary-render)
[285.476444] Starting subtest: psr2-primary-render
[285.478798] Starting dynamic subtest: eDP-1
[287.183232] Dynamic subtest eDP-1: SUCCESS (1.706s)
[287.185519] Subtest psr2-primary-render: SUCCESS (1.707s)
[288.040277] [053/133] (733s left) gem_compute (compute-square)
[288.094946] Starting subtest: compute-square
[288.098846] Subtest compute-square: SUCCESS (0.007s)
[288.211917] [054/133] (732s left) gem_mmap_offset (bad-extensions)
[288.270276] Starting subtest: bad-extensions
[288.272456] Subtest bad-extensions: SUCCESS (0.000s)
[288.356723] [055/133] (732s left) i915_query (query-topology-garbage-items)
[288.417032] Starting subtest: query-topology-garbage-items
[288.419244] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[288.511755] [056/133] (732s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[288.626485] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[289.729520] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.512s)
[289.769194] [057/133] (731s left) kms_async_flips (invalid-async-flip)
[289.863255] Starting subtest: invalid-async-flip
[290.237068] Starting dynamic subtest: pipe-A-eDP-1
[291.076300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[291.441231] Starting dynamic subtest: pipe-B-eDP-1
[292.295042] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.860s)
[292.650254] Starting dynamic subtest: pipe-C-eDP-1
[293.417442] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[293.777033] Starting dynamic subtest: pipe-D-eDP-1
[294.548679] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[294.551077] Subtest invalid-async-flip: SUCCESS (4.689s)
[295.712413] [058/133] (725s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[295.774427] Starting subtest: yf-tiled-ccs-to-x-tiled
[295.778992] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[295.948330] [059/133] (725s left) gem_vm_create (create-ext)
[296.008454] Starting subtest: create-ext
[296.013649] Subtest create-ext: SUCCESS (0.005s)
[296.133721] [060/133] (725s left) gem_render_copy (linear)
[296.198387] Starting subtest: linear
[296.200580] Starting dynamic subtest: smem
[296.240566] Dynamic subtest smem: SUCCESS (0.041s)
[296.242987] Subtest linear: SUCCESS (0.042s)
[296.424179] [061/133] (724s left) gen9_exec_parse (bb-start-cmd)
[296.473875] Subtest bb-start-cmd: SKIP (0.000s)
[296.540233] [062/133] (724s left) i915_pm_rpm (gem-execbuf)
[298.471905] Starting subtest: gem-execbuf
[298.473983] Starting dynamic subtest: smem0
[300.204691] Dynamic subtest smem0: SUCCESS (1.735s)
[300.206977] Subtest gem-execbuf: SUCCESS (1.737s)
[300.291070] [063/133] (721s left) kms_flip (dpms-off-confusion-interruptible)
[300.384479] Starting subtest: dpms-off-confusion-interruptible
[300.386907] Starting dynamic subtest: A-eDP1
[309.094758] Dynamic subtest A-eDP1: SUCCESS (8.675s)
[309.106200] Starting dynamic subtest: B-eDP1
[317.722041] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[317.734221] Starting dynamic subtest: C-eDP1
[326.349263] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[326.361393] Starting dynamic subtest: D-eDP1
[334.977948] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[334.980719] Subtest dpms-off-confusion-interruptible: SUCCESS (34.551s)
[336.092986] [064/133] (685s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[336.201033] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[336.203330] Starting dynamic subtest: pipe-A
[336.313136] Dynamic subtest pipe-A: SKIP (0.108s)
[336.323097] Starting dynamic subtest: pipe-B
[337.459516] Dynamic subtest pipe-B: SKIP (1.146s)
[337.469496] Starting dynamic subtest: pipe-C
[338.605189] Dynamic subtest pipe-C: SUCCESS (1.150s)
[338.615417] Starting dynamic subtest: pipe-D
[339.843390] Dynamic subtest pipe-D: SUCCESS (1.237s)
[339.845733] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.645s)
[341.041086] [065/133] (680s left) gem_exec_whisper (basic-queues-priority-all)
[341.111811] Starting subtest: basic-queues-priority-all
[364.669774] Subtest basic-queues-priority-all: SUCCESS (23.552s)
[364.853715] [066/133] (656s left) gem_eio (context-create)
[365.081326] Starting subtest: context-create
[365.416722] Subtest context-create: SUCCESS (0.334s)
[365.531325] [067/133] (656s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[365.628103] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[365.632592] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[365.730432] [068/133] (655s left) kms_vblank (query-idle-hang)
[365.810595] Starting subtest: query-idle-hang
[365.812393] Starting dynamic subtest: pipe-A-eDP-1
[367.613671] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.801s)
[367.628510] Starting dynamic subtest: pipe-D-eDP-1
[370.083931] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[370.086374] Subtest query-idle-hang: SUCCESS (4.274s)
[370.918539] [069/133] (650s left) kms_dp_link_training (non-uhbr-mst)
[371.008385] Starting subtest: non-uhbr-mst
[371.017046] Subtest non-uhbr-mst: SKIP (0.000s)
[371.091436] [070/133] (650s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[371.183742] Starting subtest: psr-rgb101010-draw-mmap-wc
[378.286291] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.105s)
[378.384424] [071/133] (643s left) kms_scaling_modes (scaling-mode-none)
[378.487310] Starting subtest: scaling-mode-none
[378.489940] Starting dynamic subtest: pipe-A-eDP-1
[378.581550] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[378.593554] Starting dynamic subtest: pipe-B-eDP-1
[378.621429] Dynamic subtest pipe-B-eDP-1: SKIP (0.037s)
[378.631261] Starting dynamic subtest: pipe-C-eDP-1
[378.658297] Dynamic subtest pipe-C-eDP-1: SKIP (0.035s)
[378.668295] Starting dynamic subtest: pipe-D-eDP-1
[378.690211] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[378.694177] Subtest scaling-mode-none: SKIP (0.204s)
[378.822222] [072/133] (643s left) kms_flip (plain-flip-ts-check-interruptible)
[378.905212] Starting subtest: plain-flip-ts-check-interruptible
[378.907541] Starting dynamic subtest: A-eDP1
[387.764275] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[387.775112] Starting dynamic subtest: B-eDP1
[396.585174] Dynamic subtest B-eDP1: SUCCESS (8.818s)
[396.595311] Starting dynamic subtest: C-eDP1
[405.420189] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[405.432038] Starting dynamic subtest: D-eDP1
[414.248745] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[414.251130] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.302s)
[415.389552] [073/133] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[415.484054] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[415.488081] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[415.586715] [074/133] (606s left) syncobj_timeline (single-wait-all-signaled)
[415.635372] Starting subtest: single-wait-all-signaled
[415.637590] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[415.761987] [075/133] (606s left) kms_chamelium_color (ctm-0-75)
[415.851353] Subtest ctm-0-75: SKIP (0.000s)
[415.896327] [076/133] (606s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[416.000708] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[416.005172] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[416.098420] [077/133] (605s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[416.158013] Starting subtest: y-tiled-to-vebox-y-tiled
[416.162578] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[416.342336] [078/133] (605s left) syncobj_timeline (invalid-transfer-bad-pad)
[416.389201] Starting subtest: invalid-transfer-bad-pad
[416.391505] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[416.481496] [079/133] (605s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[416.565055] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[416.567391] Starting dynamic subtest: pipe-A-eDP-1
[416.590671] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.603084] Starting dynamic subtest: pipe-B-eDP-1
[416.624225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.634205] Starting dynamic subtest: pipe-C-eDP-1
[416.656196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.665801] Starting dynamic subtest: pipe-D-eDP-1
[416.687529] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.691587] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[418.885622] [080/133] (603s left) kms_flip (2x-nonexisting-fb-interruptible)
[418.988627] Starting subtest: 2x-nonexisting-fb-interruptible
[419.000569] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[419.100406] [081/133] (603s left) i915_query (query-topology-kernel-writes)
[419.151539] Starting subtest: query-topology-kernel-writes
[419.153473] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[419.257174] [082/133] (603s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[419.349772] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[426.595238] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.251s)
[427.785472] [083/133] (594s left) kms_color (ctm-0-75)
[427.873675] Starting subtest: ctm-0-75
[427.876017] Starting dynamic subtest: pipe-A-eDP-1
[432.714919] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.844s)
[432.725885] Starting dynamic subtest: pipe-B-eDP-1
[438.434979] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.719s)
[438.448146] Starting dynamic subtest: pipe-C-eDP-1
[443.811373] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.375s)
[443.821760] Starting dynamic subtest: pipe-D-eDP-1
[449.131989] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.319s)
[449.134382] Subtest ctm-0-75: SUCCESS (21.260s)
[449.961499] [084/133] (572s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[450.064493] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[450.068810] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[450.154669] [085/133] (572s left) kms_pm_dc (dc9-dpms)
[451.237794] Starting subtest: dc9-dpms
[452.679277] Subtest dc9-dpms: SUCCESS (1.441s)
[452.758972] [086/133] (569s left) gem_exec_whisper (basic-contexts-all)
[452.823420] Starting subtest: basic-contexts-all
[463.677040] Subtest basic-contexts-all: SUCCESS (10.852s)
[463.871407] [087/133] (558s left) gem_pwrite (basic-random)
[463.926352] Subtest basic-random: SKIP (0.000s)
[463.981528] [088/133] (558s left) kms_psr (psr-primary-blt)
[464.080705] Starting subtest: psr-primary-blt
[464.082824] Starting dynamic subtest: eDP-1
[465.812496] Dynamic subtest eDP-1: SUCCESS (1.732s)
[465.814872] Subtest psr-primary-blt: SUCCESS (1.733s)
[466.708146] [089/133] (555s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[467.316530] Starting subtest: syncobj-timeline-invalid-flags
[467.319107] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[468.403832] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[468.407438] [090/133] (554s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[468.506826] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[468.509131] Starting dynamic subtest: pipe-A
[468.536180] Dynamic subtest pipe-A: SKIP (0.026s)
[468.546246] Starting dynamic subtest: pipe-B
[468.578467] Dynamic subtest pipe-B: SKIP (0.040s)
[468.588218] Starting dynamic subtest: pipe-C
[468.610305] Dynamic subtest pipe-C: SKIP (0.031s)
[468.619776] Starting dynamic subtest: pipe-D
[468.641621] Dynamic subtest pipe-D: SKIP (0.031s)
[468.645208] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.131s)
[468.743279] [091/133] (553s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[468.833253] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[468.918284] [092/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[469.010411] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[469.014750] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[469.104736] [093/133] (553s left) gem_exec_reloc (basic-cpu-read-active)
[469.166145] Subtest basic-cpu-read-active: SKIP (0.000s)
[469.233464] [094/133] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[469.325207] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[469.329156] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[469.419833] [095/133] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[469.516365] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[469.519695] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[469.633450] [096/133] (553s left) gem_exec_balancer (invalid-bonds)
[469.682849] Starting subtest: invalid-bonds
[469.686636] Subtest invalid-bonds: SKIP (0.000s)
[469.991440] [097/133] (552s left) gem_exec_params (mmapped)
[470.055921] Starting subtest: mmapped
[470.061519] Subtest mmapped: SUCCESS (0.003s)
[470.183904] [098/133] (552s left) drm_read (empty-nonblock)
[470.328369] Starting subtest: empty-nonblock
[470.330753] Subtest empty-nonblock: SUCCESS (0.000s)
[470.465478] [099/133] (552s left) gem_exec_schedule (u-semaphore-noskip)
[470.538421] Starting subtest: u-semaphore-noskip
[470.954605] Subtest u-semaphore-noskip: SUCCESS (0.416s)
[471.307336] [100/133] (551s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[471.429185] Starting subtest: basic-busy-flip-before-cursor-varying-size
[471.433376] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[471.620979] [101/133] (551s left) gem_userptr_blits (invalid-null-pointer)
[471.692453] Starting subtest: invalid-null-pointer
[471.694760] Subtest invalid-null-pointer: SUCCESS (0.001s)
[471.812998] [102/133] (551s left) api_intel_bb (reset-flags)
[471.863813] Starting subtest: reset-flags
[471.869023] Subtest reset-flags: SUCCESS (0.007s)
[471.977723] [103/133] (551s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[472.060228] Starting subtest: fbc-psr-cursor-mmap-cpu
[472.062383] Starting dynamic subtest: eDP-1
[472.066371] Dynamic subtest eDP-1: SKIP (0.000s)
[472.070377] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[472.142735] [104/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[472.234942] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[472.238261] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[472.330467] [105/133] (550s left) prime_mmap_coherency (write)
[472.392813] Starting subtest: write
[477.821992] Subtest write: SUCCESS (5.376s)
[477.897682] [106/133] (545s left) kms_rotation_crc (bad-pixel-format)
[477.999380] Starting subtest: bad-pixel-format
[478.003661] Subtest bad-pixel-format: SKIP (0.001s)
[478.090215] [107/133] (545s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[478.184688] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[478.188811] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[478.268368] [108/133] (545s left) syncobj_wait (reset-during-wait-for-submit)
[478.330538] Starting subtest: reset-during-wait-for-submit
[478.432323] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[478.513757] [109/133] (544s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[478.608592] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[478.611154] Starting dynamic subtest: pipe-A-default-mode
[481.359046] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[481.361579] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.752s)
[482.220958] [110/133] (541s left) gem_lmem_swapping (random-engines)
[482.263810] Subtest random-engines: SKIP (0.000s)
[482.302600] [111/133] (541s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[482.412738] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[483.435449] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.022s)
[483.572303] [112/133] (539s left) kms_properties (colorop-properties-atomic)
[483.660337] Starting subtest: colorop-properties-atomic
[483.662294] Starting dynamic subtest: pipe-A-eDP-1
[483.993192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s)
[484.007956] Starting dynamic subtest: pipe-B-eDP-1
[485.065328] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.068s)
[485.075940] Starting dynamic subtest: pipe-C-eDP-1
[486.077188] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.013s)
[486.087553] Starting dynamic subtest: pipe-D-eDP-1
[487.124150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[487.126090] Subtest colorop-properties-atomic: SUCCESS (3.462s)
[487.932238] [113/133] (535s left) syncobj_timeline (reset-during-wait-for-submit)
[487.988529] Starting subtest: reset-during-wait-for-submit
[488.091340] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[488.184948] [114/133] (535s left) i915_drm_fdinfo (memory-info-purgeable)
[488.227401] Starting subtest: memory-info-purgeable
[488.229869] Starting dynamic subtest: smem0
[490.804505] Dynamic subtest smem0: SUCCESS (2.580s)
[490.806889] Subtest memory-info-purgeable: SUCCESS (2.581s)
[490.888192] [115/133] (532s left) perf_pmu (event-wait)
[490.930770] Starting subtest: event-wait
[490.932640] Starting dynamic subtest: rcs0
[490.936102] Dynamic subtest rcs0: SKIP (0.000s)
[490.939574] Subtest event-wait: SKIP (0.001s)
[491.063548] [116/133] (532s left) gem_ccs (block-copy-uncompressed)
[491.134063] Starting subtest: block-copy-uncompressed
[491.136055] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[491.162593] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.026s)
[491.174208] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[491.181558] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[491.191583] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[491.198700] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[491.207925] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[491.218876] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[491.220858] Subtest block-copy-uncompressed: SUCCESS (0.086s)
[491.328505] [117/133] (532s left) gem_ctx_create (basic)
[491.393547] Starting subtest: basic
[491.395424] Subtest basic: SUCCESS (0.000s)
[491.578376] [118/133] (532s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[491.631321] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[491.707530] [119/133] (532s left) gem_ctx_param (invalid-set-ringsize)
[491.760950] Starting subtest: invalid-set-ringsize
[491.763099] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[491.836075] [120/133] (532s left) kms_cursor_crc (cursor-random-64x21)
[492.038783] Starting subtest: cursor-random-64x21
[492.089323] Subtest cursor-random-64x21: SKIP (0.045s)
[492.350863] [121/133] (531s left) gem_exec_reloc (basic-cpu-read)
[492.419038] Subtest basic-cpu-read: SKIP (0.000s)
[492.490743] [122/133] (531s left) kms_prime (d3hot)
[492.568766] Subtest D3hot: SKIP (0.000s)
[492.665414] [123/133] (531s left) kms_addfb_basic (no-handle)
[492.722173] Starting subtest: no-handle
[492.724050] Subtest no-handle: SUCCESS (0.000s)
[492.852829] [124/133] (531s left) syncobj_eventfd (invalid-illegal-handle)
[492.912617] Starting subtest: invalid-illegal-handle
[492.914478] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[493.005609] [125/133] (531s left) kms_cursor_crc (cursor-dpms)
[493.120258] Starting subtest: cursor-dpms
[493.122063] Starting dynamic subtest: pipe-A-eDP-1
[496.189895] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.065s)
[496.200891] Starting dynamic subtest: pipe-D-eDP-1
[499.901632] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.711s)
[499.903937] Subtest cursor-dpms: SUCCESS (6.779s)
[500.715324] [126/133] (523s left) kms_chamelium_edid (vga-edid-read)
[501.095333] Subtest vga-edid-read: SKIP (0.000s)
[501.929028] [127/133] (522s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[502.023455] Starting subtest: plane-all-transition-nonblocking-fencing
[502.025635] Starting dynamic subtest: pipe-A-eDP-1
[504.522943] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[504.842562] Starting dynamic subtest: pipe-B-eDP-1
[508.088345] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.255s)
[508.389927] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.365s)
[509.217817] [128/133] (515s left) syncobj_wait (single-wait-signaled)
[509.282040] Starting subtest: single-wait-signaled
[509.284312] Subtest single-wait-signaled: SUCCESS (0.000s)
[509.410658] [129/133] (514s left) kms_content_protection (atomic-dpms)
[509.554531] Starting subtest: atomic-dpms
[509.559087] Subtest atomic-dpms: SKIP (0.000s)
[509.673488] [130/133] (514s left) kms_joiner (basic-big-joiner)
[509.797702] Starting subtest: basic-big-joiner
[509.801826] Subtest basic-big-joiner: SKIP (0.000s)
[509.864512] [131/133] (514s left) gem_exec_create (legacy)
[509.920301] Starting subtest: legacy
[509.922616] Starting dynamic subtest: smem
[512.011393] Dynamic subtest smem: SUCCESS (2.090s)
[512.013812] Subtest legacy: SUCCESS (2.092s)
[512.197472] [132/133] (512s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[512.291079] Starting subtest: coverage-vs-premult-vs-constant
[512.579321] Starting dynamic subtest: pipe-A-eDP-1
[513.163095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[513.172863] Starting dynamic subtest: pipe-D-eDP-1
[514.432974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.268s)
[514.435449] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.144s)
[515.299876] [133/133] (509s left) gem_ctx_persistence (legacy-engines-persistence)
[515.355076] Starting subtest: legacy-engines-persistence
[515.357452] Starting dynamic subtest: render
[516.139281] Dynamic subtest render: SUCCESS (0.783s)
[516.152182] Starting dynamic subtest: bsd1
[516.895383] Dynamic subtest bsd1: SUCCESS (0.753s)
[516.908745] Starting dynamic subtest: bsd2
[517.660292] Dynamic subtest bsd2: SUCCESS (0.762s)
[517.677686] Starting dynamic subtest: blt
[518.409761] Dynamic subtest blt: SUCCESS (0.746s)
[518.423830] Starting dynamic subtest: vebox
[519.192812] Dynamic subtest vebox: SUCCESS (0.780s)
[519.195295] Subtest legacy-engines-persistence: SUCCESS (3.839s)
[519.272737] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: gem_partial_pwrite_pread
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: prime_busy
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: core_hotunplug
results: parsing output: 20/ for test: i915_hangman
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: core_setmaster_vs_auth
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_lease
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_setmode
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_feature_discovery
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 48/ for test: gem_eio
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_compute
results: parsing output: 53/ for test: gem_mmap_offset
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: gem_vm_create
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gen9_exec_parse
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: gem_exec_whisper
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_dp_link_training
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_scaling_modes
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_chamelium_color
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: gem_pwrite
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: prime_mmap_coherency
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: gem_ctx_create
results: parsing output: 117/ for test: gem_fenced_exec_thrash
results: parsing output: 118/ for test: gem_ctx_param
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_prime
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: syncobj_eventfd
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_edid
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: gem_exec_create
results: parsing output: 131/ for test: kms_plane_alpha_blend
results: parsing output: 132/ for test: gem_ctx_persistence
Done.