[59.933331] Initializing watchdogs
[59.933373]   /dev/watchdog0
[59.946129] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.950457] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.952732] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.956031] [001/131] (960s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[60.388750] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[61.208201] [002/131] (959s left) gem_lmem_swapping (verify-ccs)
[61.259053] Subtest verify-ccs: SKIP (0.000s)
[61.293837] [003/131] (959s left) perf (missing-sample-flags)
[61.426953] Starting subtest: missing-sample-flags
[61.429233] Subtest missing-sample-flags: SUCCESS (0.000s)
[61.462239] [004/131] (959s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[66.507677] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[66.512535] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[67.408515] [005/131] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[67.597614] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[67.601900] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[67.916413] [006/131] (952s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[68.105140] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[68.107415] Starting dynamic subtest: pipe-A-eDP-1
[100.262085] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.545s)
[100.270847] Starting dynamic subtest: pipe-B-eDP-1
[133.173108] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.650s)
[133.181936] Starting dynamic subtest: pipe-C-eDP-1
[166.211149] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.717s)
[166.219931] Starting dynamic subtest: pipe-D-eDP-1
[199.175558] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.613s)
[199.177888] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.529s)
[200.420430] [007/131] (820s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[200.583123] Starting subtest: cursor-rapid-movement-32x32
[200.625641] Subtest cursor-rapid-movement-32x32: SKIP (0.039s)
[200.925694] [008/131] (819s left) perf (invalid-oa-exponent)
[201.027044] Starting subtest: invalid-oa-exponent
[201.040565] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[201.077343] [009/131] (819s left) gem_spin_batch (engines)
[201.149798] Starting subtest: engines
[201.152148] Starting dynamic subtest: rcs0
[204.383858] Dynamic subtest rcs0: SUCCESS (3.271s)
[204.394727] Starting dynamic subtest: bcs0
[207.613318] Dynamic subtest bcs0: SUCCESS (3.256s)
[207.621077] Starting dynamic subtest: vcs0
[210.842410] Dynamic subtest vcs0: SUCCESS (3.246s)
[210.850332] Starting dynamic subtest: vcs1
[214.074850] Dynamic subtest vcs1: SUCCESS (3.243s)
[214.082691] Starting dynamic subtest: vecs0
[217.306953] Dynamic subtest vecs0: SUCCESS (3.239s)
[217.316353] Starting dynamic subtest: ccs0
[220.538058] Dynamic subtest ccs0: SUCCESS (3.237s)
[220.540399] Subtest engines: SUCCESS (19.501s)
[220.743195] [010/131] (800s left) kms_psr (psr-sprite-plane-move)
[220.854229] Starting subtest: psr-sprite-plane-move
[220.856502] Starting dynamic subtest: eDP-1
[222.594175] Dynamic subtest eDP-1: SUCCESS (1.742s)
[222.596631] Subtest psr-sprite-plane-move: SUCCESS (1.743s)
[223.439792] [011/131] (797s left) gem_exec_fence (syncobj-repeat)
[223.891267] Starting subtest: syncobj-repeat
[224.061783] Subtest syncobj-repeat: SUCCESS (0.172s)
[225.752427] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[225.755613] [012/131] (795s left) gem_mmap_offset (perf)
[225.818970] Starting subtest: perf
[225.821137] Starting dynamic subtest: smem0
[226.164598] Dynamic subtest smem0: SUCCESS (0.344s)
[226.167180] Subtest perf: SUCCESS (0.345s)
[226.322314] [013/131] (794s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[226.427971] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[226.430282] Starting dynamic subtest: pipe-A-default-mode
[229.167689] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[229.169622] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.742s)
[230.023094] [014/131] (790s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[230.149196] Starting subtest: 2x-long-cursor-vs-flip-legacy
[230.154235] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[230.354858] [015/131] (790s left) kms_joiner (basic-ultra-joiner)
[230.457802] Starting subtest: basic-ultra-joiner
[230.462068] Subtest basic-ultra-joiner: SKIP (0.000s)
[230.541206] [016/131] (790s left) gem_ccs (block-copy-uncompressed)
[230.610331] Starting subtest: block-copy-uncompressed
[230.612800] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[230.632592] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[230.642835] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[230.649823] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[230.657443] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[230.666398] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[230.674048] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[230.684603] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[230.686972] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[230.852070] [017/131] (790s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[230.917427] Starting subtest: multi-wait-for-submit-available-submitted
[230.919752] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[231.045563] [018/131] (790s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[231.162672] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[231.166037] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[231.284455] [019/131] (789s left) gem_close (basic)
[231.345623] Starting subtest: basic
[231.347487] Subtest basic: SUCCESS (0.000s)
[231.474115] [020/131] (789s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[231.530655] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[231.534279] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[231.736722] [021/131] (789s left) kms_vblank (query-forked-busy-hang)
[231.834562] Starting subtest: query-forked-busy-hang
[231.836573] Starting dynamic subtest: pipe-A-eDP-1
[258.414913] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.574s)
[258.432901] Starting dynamic subtest: pipe-D-eDP-1
[273.391678] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[273.393967] Subtest query-forked-busy-hang: SUCCESS (41.559s)
[274.272511] [022/131] (747s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[274.386464] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[275.343136] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.956s)
[275.501237] [023/131] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[275.605449] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[275.609090] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[275.734971] [024/131] (745s left) syncobj_timeline (wait-any-snapshot)
[275.785213] Starting subtest: wait-any-snapshot
[275.865775] Subtest wait-any-snapshot: SUCCESS (0.081s)
[275.964632] [025/131] (745s left) gem_eio (execbuf)
[276.161120] Starting subtest: execbuf
[276.433059] Subtest execbuf: SUCCESS (0.271s)
[276.625521] [026/131] (744s left) kms_psr (psr2-primary-render)
[276.725529] Starting subtest: psr2-primary-render
[276.727487] Starting dynamic subtest: eDP-1
[278.450020] Dynamic subtest eDP-1: SUCCESS (1.724s)
[278.452656] Subtest psr2-primary-render: SUCCESS (1.725s)
[279.343673] [027/131] (742s left) i915_suspend (fence-restore-tiled2untiled)
[279.406072] Starting subtest: fence-restore-tiled2untiled
[279.411298] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[279.558537] [028/131] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[279.666797] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[279.670893] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[279.798259] [029/131] (741s left) perf (non-system-wide-paranoid)
[279.905003] Starting subtest: non-system-wide-paranoid
[279.930714] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[279.969786] [030/131] (741s left) kms_cursor_crc (cursor-sliding-128x42)
[280.191896] Starting subtest: cursor-sliding-128x42
[280.238475] Subtest cursor-sliding-128x42: SKIP (0.040s)
[280.488289] [031/131] (741s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[280.580391] Starting subtest: fbc-pr-sprite-mmap-gtt
[280.583754] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[280.677593] [032/131] (741s left) gem_exec_capture (capture-invisible)
[280.735726] Starting subtest: capture-invisible
[280.737411] Starting dynamic subtest: smem0
[280.741010] Dynamic subtest smem0: SKIP (0.000s)
[280.744597] Subtest capture-invisible: SKIP (0.000s)
[280.873629] [033/131] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[280.984349] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[280.987916] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[281.117645] [034/131] (740s left) kms_flip (nonexisting-fb)
[281.222168] Starting subtest: nonexisting-fb
[281.223782] Starting dynamic subtest: A-eDP1
[282.414461] Dynamic subtest A-eDP1: SUCCESS (1.194s)
[282.423798] Starting dynamic subtest: B-eDP1
[283.548942] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[283.558315] Starting dynamic subtest: C-eDP1
[284.675214] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[284.684387] Starting dynamic subtest: D-eDP1
[285.814676] Dynamic subtest D-eDP1: SUCCESS (1.139s)
[285.820240] Subtest nonexisting-fb: SUCCESS (4.602s)
[287.025216] [035/131] (734s left) syncobj_basic (bad-flags-handle-to-fd)
[287.087738] Starting subtest: bad-flags-handle-to-fd
[287.090136] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[287.213880] [036/131] (734s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[287.277589] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[287.381408] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[287.482199] [037/131] (734s left) kms_prime (basic-crc-hybrid)
[287.566840] Subtest basic-crc-hybrid: SKIP (0.000s)
[287.671839] [038/131] (734s left) syncobj_wait (multi-wait-submitted)
[287.729979] Starting subtest: multi-wait-submitted
[287.837186] Subtest multi-wait-submitted: SUCCESS (0.107s)
[287.935088] [039/131] (734s left) gem_exec_reloc (basic-wc-read)
[287.999026] Subtest basic-wc-read: SKIP (0.000s)
[288.085058] [040/131] (733s left) kms_flip (basic-plain-flip)
[288.181329] Starting subtest: basic-plain-flip
[288.183597] Starting dynamic subtest: A-eDP1
[289.826176] Dynamic subtest A-eDP1: SUCCESS (1.644s)
[289.838714] Starting dynamic subtest: B-eDP1
[291.554599] Dynamic subtest B-eDP1: SUCCESS (1.729s)
[291.566568] Starting dynamic subtest: C-eDP1
[293.186080] Dynamic subtest C-eDP1: SUCCESS (1.629s)
[293.194566] Starting dynamic subtest: D-eDP1
[294.806756] Dynamic subtest D-eDP1: SUCCESS (1.619s)
[294.811641] Subtest basic-plain-flip: SUCCESS (6.635s)
[296.118811] [041/131] (725s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[296.225167] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[297.204401] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s)
[297.382995] [042/131] (724s left) kms_color (invalid-gamma-lut-sizes)
[297.474519] Starting subtest: invalid-gamma-lut-sizes
[297.476340] Starting dynamic subtest: pipe-A
[297.758130] Dynamic subtest pipe-A: SUCCESS (0.284s)
[297.767391] Starting dynamic subtest: pipe-B
[297.769506] Dynamic subtest pipe-B: SUCCESS (0.001s)
[297.777514] Starting dynamic subtest: pipe-C
[297.779823] Dynamic subtest pipe-C: SUCCESS (0.001s)
[297.787846] Starting dynamic subtest: pipe-D
[297.790177] Dynamic subtest pipe-D: SUCCESS (0.001s)
[297.792025] Subtest invalid-gamma-lut-sizes: SUCCESS (0.288s)
[298.624445] [043/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[298.726721] Starting subtest: psr-2p-primscrn-cur-indfb-move
[298.731172] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[298.843017] [044/131] (723s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[298.939095] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[298.941451] Starting dynamic subtest: pipe-A
[299.986789] Dynamic subtest pipe-A: SUCCESS (1.050s)
[299.995223] Starting dynamic subtest: pipe-B
[302.137583] Dynamic subtest pipe-B: SUCCESS (2.149s)
[302.146706] Starting dynamic subtest: pipe-C
[303.302206] Dynamic subtest pipe-C: SUCCESS (1.163s)
[303.310427] Starting dynamic subtest: pipe-D
[304.448704] Dynamic subtest pipe-D: SUCCESS (1.145s)
[304.451525] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.511s)
[305.663783] [045/131] (716s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[305.801910] Starting subtest: cursorA-vs-flipA-legacy
[316.916644] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.110s)
[317.798940] [046/131] (704s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[317.899670] Starting subtest: 2x-flip-vs-rmfb-interruptible
[317.911309] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[318.006814] [047/131] (704s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[318.111416] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[318.115441] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[318.233711] [048/131] (704s left) kms_hdr (invalid-hdr)
[318.332246] Starting subtest: invalid-hdr
[320.395967] Starting dynamic subtest: pipe-A-eDP-1
[323.339155] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.943s)
[323.341636] Subtest invalid-hdr: SUCCESS (5.009s)
[323.501508] [049/131] (698s left) gem_softpin (invalid)
[323.565936] Starting subtest: invalid
[323.574009] Subtest invalid: SUCCESS (0.006s)
[323.737294] [050/131] (698s left) gem_wait (wait)
[323.806391] Starting subtest: wait
[323.808721] Starting dynamic subtest: all-engines
[325.616522] Dynamic subtest all-engines: SUCCESS (1.808s)
[325.626971] Starting dynamic subtest: rcs0
[326.662330] Dynamic subtest rcs0: SUCCESS (1.045s)
[326.673170] Starting dynamic subtest: bcs0
[327.709179] Dynamic subtest bcs0: SUCCESS (1.045s)
[327.720087] Starting dynamic subtest: vcs0
[328.753170] Dynamic subtest vcs0: SUCCESS (1.042s)
[328.763276] Starting dynamic subtest: vcs1
[329.800147] Dynamic subtest vcs1: SUCCESS (1.045s)
[329.810817] Starting dynamic subtest: vecs0
[330.846326] Dynamic subtest vecs0: SUCCESS (1.044s)
[330.857293] Starting dynamic subtest: ccs0
[331.894634] Dynamic subtest ccs0: SUCCESS (1.046s)
[331.897162] Subtest wait: SUCCESS (8.089s)
[332.110144] [051/131] (690s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[332.208168] Starting subtest: primary-y-tiled-reflect-x-270
[332.212113] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[332.301717] [052/131] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[332.401625] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[339.587494] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.188s)
[339.770951] [053/131] (682s left) kms_psr (pr-cursor-mmap-gtt)
[339.875132] Starting subtest: pr-cursor-mmap-gtt
[339.879215] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[339.970409] [054/131] (682s left) syncobj_timeline (invalid-transfer-non-existent-point)
[340.033659] Starting subtest: invalid-transfer-non-existent-point
[340.035928] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[340.159808] [055/131] (682s left) gem_tiled_blits (interruptible)
[340.228223] Subtest interruptible: SKIP (0.000s)
[340.313518] [056/131] (682s left) gem_exec_schedule (preempt-queue-chain)
[340.386820] Subtest preempt-queue-chain: SKIP (0.000s)
[340.694488] [057/131] (682s left) gem_mmap_gtt (basic-small-bo-tiledx)
[340.755030] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[340.811515] [058/131] (681s left) kms_legacy_colorkey (basic)
[340.898667] Starting subtest: basic
[340.900944] Starting dynamic subtest: pipe-A
[340.940639] Dynamic subtest pipe-A: SUCCESS (0.045s)
[340.952131] Starting dynamic subtest: pipe-B
[340.954466] Dynamic subtest pipe-B: SUCCESS (0.000s)
[340.963572] Starting dynamic subtest: pipe-C
[340.965454] Dynamic subtest pipe-C: SUCCESS (0.000s)
[340.972674] Starting dynamic subtest: pipe-D
[340.974593] Dynamic subtest pipe-D: SUCCESS (0.000s)
[340.976481] Subtest basic: SUCCESS (0.050s)
[341.032907] [059/131] (681s left) gem_exec_balancer (bonded-true-hang)
[341.297865] Starting subtest: bonded-true-hang
[341.302913] Subtest bonded-true-hang: SKIP (0.000s)
[341.426303] [060/131] (681s left) prime_vgem (shrink)
[341.519165] Starting subtest: shrink
[341.536343] Subtest shrink: SUCCESS (0.015s)
[341.692170] [061/131] (681s left) perf_pmu (most-busy-idle-check-all)
[341.735963] Starting subtest: most-busy-idle-check-all
[341.737929] Starting dynamic subtest: rcs0
[343.664435] Dynamic subtest rcs0: SUCCESS (1.930s)
[343.676331] Starting dynamic subtest: bcs0
[345.651287] Dynamic subtest bcs0: SUCCESS (1.984s)
[345.663454] Starting dynamic subtest: vcs0
[347.696831] Dynamic subtest vcs0: SUCCESS (2.043s)
[347.709047] Starting dynamic subtest: vcs1
[349.680492] Dynamic subtest vcs1: SUCCESS (1.981s)
[349.694979] Starting dynamic subtest: vecs0
[351.601876] Dynamic subtest vecs0: SUCCESS (1.917s)
[351.614054] Starting dynamic subtest: ccs0
[353.650714] Dynamic subtest ccs0: SUCCESS (2.046s)
[353.653733] Subtest most-busy-idle-check-all: SUCCESS (11.919s)
[353.779737] [062/131] (669s left) gem_exec_reloc (basic-write-wc)
[353.846807] Subtest basic-write-wc: SKIP (0.000s)
[353.920961] [063/131] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[354.023066] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[354.027173] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[354.148620] [064/131] (668s left) gem_ctx_exec (basic-norecovery)
[354.211788] Starting subtest: basic-norecovery
[354.466680] Subtest basic-norecovery: SUCCESS (0.255s)
[354.623636] [065/131] (668s left) gem_ctx_engines (invalid-engines)
[354.679362] Starting subtest: invalid-engines
[354.686590] Subtest invalid-engines: SUCCESS (0.007s)
[354.941020] [066/131] (668s left) gem_partial_pwrite_pread (writes-after-reads)
[355.006178] Subtest writes-after-reads: SKIP (0.000s)
[355.087458] [067/131] (668s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[355.184255] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[355.188231] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[355.325558] [068/131] (667s left) gem_pxp (reject-modify-context-protection-off-2)
[355.443900] Starting subtest: reject-modify-context-protection-off-2
[355.446231] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[355.587743] [069/131] (667s left) sysfs_heartbeat_interval (nopreempt)
[355.641652] Starting subtest: nopreempt
[355.644119] Starting dynamic subtest: vecs0
[365.710231] Dynamic subtest vecs0: SUCCESS (10.066s)
[365.720641] Starting dynamic subtest: ccs0
[369.749002] Dynamic subtest ccs0: SUCCESS (4.039s)
[369.758550] Starting dynamic subtest: vcs0
[378.675635] Dynamic subtest vcs0: SUCCESS (8.924s)
[378.686698] Starting dynamic subtest: bcs0
[382.591129] Dynamic subtest bcs0: SUCCESS (3.917s)
[382.603132] Starting dynamic subtest: rcs0
[386.653198] Dynamic subtest rcs0: SUCCESS (4.061s)
[386.662728] Starting dynamic subtest: vcs1
[396.668213] Dynamic subtest vcs1: SUCCESS (10.016s)
[396.670787] Subtest nopreempt: SUCCESS (41.035s)
[396.769004] [070/131] (626s left) kms_cursor_crc (cursor-offscreen-128x42)
[397.003891] Starting subtest: cursor-offscreen-128x42
[397.052344] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[397.292050] [071/131] (626s left) kms_pm_lpsp (screens-disabled)
[398.391933] Starting subtest: screens-disabled
[398.395958] Subtest screens-disabled: SKIP (0.000s)
[398.487569] [072/131] (624s left) perf_pmu (all-busy-idle-check-all)
[398.532223] Starting subtest: all-busy-idle-check-all
[399.665494] Subtest all-busy-idle-check-all: SUCCESS (1.134s)
[399.811627] [073/131] (623s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[399.867196] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[399.939579] [074/131] (623s left) gem_mmap_offset (bad-object)
[399.991172] Starting subtest: bad-object
[399.993428] Subtest bad-object: SUCCESS (0.001s)
[400.125370] [075/131] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[400.228407] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[400.232670] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[400.367283] [076/131] (623s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[400.464251] Starting subtest: fbc-psr-cursor-mmap-cpu
[400.466438] Starting dynamic subtest: eDP-1
[400.470373] Dynamic subtest eDP-1: SKIP (0.000s)
[400.474327] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[400.564932] [077/131] (622s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[400.671973] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[401.328682] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[401.503380] [078/131] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[401.607723] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[401.611984] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.748507] [079/131] (621s left) perf_pmu (busy-idle-check-all)
[401.796244] Starting subtest: busy-idle-check-all
[401.798516] Starting dynamic subtest: rcs0
[402.470136] Dynamic subtest rcs0: SUCCESS (0.674s)
[402.482095] Starting dynamic subtest: bcs0
[403.122515] Dynamic subtest bcs0: SUCCESS (0.651s)
[403.133675] Starting dynamic subtest: vcs0
[404.656891] Dynamic subtest vcs0: SUCCESS (1.531s)
[404.668242] Starting dynamic subtest: vcs1
[406.640789] Dynamic subtest vcs1: SUCCESS (1.982s)
[406.652164] Starting dynamic subtest: vecs0
[408.689129] Dynamic subtest vecs0: SUCCESS (2.046s)
[408.700990] Starting dynamic subtest: ccs0
[409.345378] Dynamic subtest ccs0: SUCCESS (0.655s)
[409.348015] Subtest busy-idle-check-all: SUCCESS (7.553s)
[409.489375] [080/131] (614s left) gem_workarounds (reset-context)
[409.570566] Starting subtest: reset-context
[409.730846] Subtest reset-context: SUCCESS (0.160s)
[409.904898] [081/131] (613s left) kms_atomic_transition (modeset-transition-fencing)
[410.011073] Starting subtest: modeset-transition-fencing
[410.013292] Starting dynamic subtest: 1x-outputs
[420.744080] Dynamic subtest 1x-outputs: SUCCESS (10.734s)
[420.746688] Subtest modeset-transition-fencing: SUCCESS (10.735s)
[421.626768] [082/131] (602s left) kms_chamelium_hpd (common-hpd-after-suspend)
[422.006105] Subtest common-hpd-after-suspend: SKIP (0.000s)
[422.813818] [083/131] (601s left) gem_exec_params (rsvd2-dirt)
[422.879535] Starting subtest: rsvd2-dirt
[422.884078] Subtest rsvd2-dirt: SKIP (0.000s)
[423.013004] [084/131] (600s left) kms_properties (crtc-properties-atomic)
[423.116448] Starting subtest: crtc-properties-atomic
[423.118817] Starting dynamic subtest: pipe-A-eDP-1
[423.574012] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[423.584313] Starting dynamic subtest: pipe-B-eDP-1
[424.705752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[424.715870] Starting dynamic subtest: pipe-C-eDP-1
[425.833739] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[425.843537] Starting dynamic subtest: pipe-D-eDP-1
[426.959666] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[426.961806] Subtest crtc-properties-atomic: SUCCESS (3.841s)
[427.798210] [085/131] (596s left) gem_userptr_blits (create-destroy-unsync)
[427.874318] Subtest create-destroy-unsync: SKIP (0.000s)
[428.037672] [086/131] (595s left) gem_exec_whisper (basic-contexts-priority)
[428.105948] Starting subtest: basic-contexts-priority
[453.050593] Subtest basic-contexts-priority: SUCCESS (24.934s)
[453.260935] [087/131] (570s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[453.373254] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[454.362363] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.990s)
[454.524440] [088/131] (569s left) kms_addfb_basic (basic-x-tiled-legacy)
[454.587151] Starting subtest: basic-x-tiled-legacy
[454.590749] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[454.756816] [089/131] (569s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[454.859152] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[454.861156] Starting dynamic subtest: pipe-A-eDP-1
[454.877996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[454.892549] Starting dynamic subtest: pipe-B-eDP-1
[454.908879] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[454.922550] Starting dynamic subtest: pipe-C-eDP-1
[454.938045] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[454.946833] Starting dynamic subtest: pipe-D-eDP-1
[454.962901] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[454.964477] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.008s)
[457.068573] [090/131] (567s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[457.169171] Starting subtest: plane-use-after-nonblocking-unbind
[457.171422] Starting dynamic subtest: pipe-A-eDP-1
[457.231077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[457.532474] Starting dynamic subtest: pipe-B-eDP-1
[458.337135] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.813s)
[458.635472] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.468s)
[459.530684] [091/131] (564s left) gem_ctx_persistence (idempotent)
[459.599464] Starting subtest: idempotent
[459.601933] Subtest idempotent: SUCCESS (0.000s)
[459.744430] [092/131] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[459.843187] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[466.500609] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.658s)
[466.673657] [093/131] (557s left) kms_vblank (wait-forked-busy)
[466.777218] Starting subtest: wait-forked-busy
[466.779162] Starting dynamic subtest: pipe-A-eDP-1
[468.672078] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[468.686520] Starting dynamic subtest: pipe-D-eDP-1
[471.251645] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[471.254055] Subtest wait-forked-busy: SUCCESS (4.477s)
[472.130234] [094/131] (552s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[477.182934] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[477.184911] Starting dynamic subtest: pipe-A-eDP-1
[477.986888] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s)
[477.996531] Starting dynamic subtest: pipe-B-eDP-1
[479.122722] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[479.127428] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.938s)
[480.365877] [095/131] (544s left) kms_flip (dpms-vs-vblank-race)
[480.474560] Starting subtest: dpms-vs-vblank-race
[480.476891] Starting dynamic subtest: A-eDP1
[484.376491] Dynamic subtest A-eDP1: SUCCESS (3.901s)
[484.386033] Starting dynamic subtest: B-eDP1
[488.997702] Dynamic subtest B-eDP1: SUCCESS (4.618s)
[489.007367] Starting dynamic subtest: C-eDP1
[493.633137] Dynamic subtest C-eDP1: SUCCESS (4.635s)
[493.643297] Starting dynamic subtest: D-eDP1
[498.254593] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[498.256799] Subtest dpms-vs-vblank-race: SUCCESS (17.785s)
[499.155575] [096/131] (525s left) gem_exec_parallel (userptr)
[499.218206] Starting subtest: userptr
[499.220411] Starting dynamic subtest: rcs0
[500.650265] Dynamic subtest rcs0: SUCCESS (1.432s)
[500.659884] Starting dynamic subtest: bcs0
[502.151241] Dynamic subtest bcs0: SUCCESS (1.499s)
[502.162769] Starting dynamic subtest: vcs0
[503.729670] Dynamic subtest vcs0: SUCCESS (1.575s)
[503.738923] Starting dynamic subtest: vcs1
[505.655493] Dynamic subtest vcs1: SUCCESS (1.922s)
[505.665527] Starting dynamic subtest: vecs0
[507.631870] Dynamic subtest vecs0: SUCCESS (1.975s)
[507.642041] Starting dynamic subtest: ccs0
[509.136719] Dynamic subtest ccs0: SUCCESS (1.503s)
[509.139565] Subtest userptr: SUCCESS (9.920s)
[509.346349] [097/131] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[509.455964] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[513.889023] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.439s)
[515.052160] [098/131] (509s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[515.152830] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[515.156951] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[515.280895] [099/131] (509s left) gem_exec_reloc (basic-cpu-wc-active)
[515.348258] Subtest basic-cpu-wc-active: SKIP (0.000s)
[515.431259] [100/131] (509s left) kms_psr (fbc-pr-primary-render)
[515.524057] Starting subtest: fbc-pr-primary-render
[515.528642] Subtest fbc-pr-primary-render: SKIP (0.000s)
[515.617213] [101/131] (509s left) kms_plane_multiple (2x-tiling-x)
[515.707025] Starting subtest: 2x-tiling-x
[515.711001] Subtest 2x-tiling-x: SKIP (0.000s)
[515.798516] [102/131] (508s left) i915_pm_rps (reset)
[515.858872] Starting subtest: reset
[524.297366] Subtest reset: SUCCESS (8.438s)
[524.452495] [103/131] (500s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[524.561012] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[524.563346] Starting dynamic subtest: pipe-A-eDP-1
[524.583665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[524.594641] Starting dynamic subtest: pipe-B-eDP-1
[524.613315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[524.622250] Starting dynamic subtest: pipe-C-eDP-1
[524.641161] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[524.649889] Starting dynamic subtest: pipe-D-eDP-1
[524.669151] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[524.671006] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[526.824993] [104/131] (497s left) kms_hdr (bpc-switch)
[526.913892] Starting subtest: bpc-switch
[526.926720] Starting dynamic subtest: pipe-A-eDP-1
[530.332318] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.405s)
[530.334782] Subtest bpc-switch: SUCCESS (3.422s)
[530.491024] [105/131] (494s left) kms_getfb (getfb-handle-zero)
[530.579724] Starting subtest: getfb-handle-zero
[530.581987] Subtest getfb-handle-zero: SUCCESS (0.000s)
[530.725172] [106/131] (494s left) api_intel_bb (full-batch)
[530.784506] Starting subtest: full-batch
[530.789353] Subtest full-batch: SUCCESS (0.008s)
[530.942880] [107/131] (493s left) prime_vgem (basic-fence-read)
[531.020954] Starting subtest: basic-fence-read
[531.040661] Subtest basic-fence-read: SKIP (0.018s)
[531.185128] [108/131] (493s left) api_intel_allocator (reopen-fork)
[531.243942] Starting subtest: reopen-fork
[534.777944] Subtest reopen-fork: SUCCESS (3.535s)
[534.884953] [109/131] (490s left) kms_chamelium_color (gamma)
[534.980348] Subtest gamma: SKIP (0.000s)
[535.025007] [110/131] (489s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[535.116145] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[535.118322] Starting dynamic subtest: pipe-A-eDP-1
[535.173953] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[535.182534] Starting dynamic subtest: pipe-B-eDP-1
[535.239578] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[535.249760] Starting dynamic subtest: pipe-C-eDP-1
[535.307661] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[535.317695] Starting dynamic subtest: pipe-D-eDP-1
[535.375197] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[535.379328] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[537.293160] [111/131] (487s left) drm_buddy (drm_buddy)
[537.330731] Starting subtest: drm_buddy
[537.371347] Starting dynamic subtest: drm_test_buddy_alloc_limit
[537.473506] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.103s)
[537.482287] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[537.586676] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.109s)
[537.595396] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[537.706305] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.119s)
[537.716350] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[537.821131] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.113s)
[537.830944] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[537.922126] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.102s)
[537.932249] Starting dynamic subtest: drm_test_buddy_alloc_clear
[538.069595] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.146s)
[538.080958] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[538.183569] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.113s)
[538.192387] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[542.407808] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.221s)
[542.410112] Subtest drm_buddy: SUCCESS (5.077s)
[542.603480] [112/131] (482s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[542.699150] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[542.703658] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[542.834689] [113/131] (482s left) kms_dsc (dsc-basic)
[542.925348] Starting subtest: dsc-basic
[542.937896] Subtest dsc-basic: SKIP (0.000s)
[543.023716] [114/131] (482s left) syncobj_wait (multi-wait-all-submitted-signaled)
[543.090589] Starting subtest: multi-wait-all-submitted-signaled
[543.197150] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[543.298567] [115/131] (481s left) gen9_exec_parse (unaligned-access)
[543.363399] Subtest unaligned-access: SKIP (0.000s)
[543.431320] [116/131] (481s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[543.527202] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[543.529434] Starting dynamic subtest: pipe-A-default-mode
[546.220044] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[546.222114] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.692s)
[547.079839] [117/131] (478s left) gen7_exec_parse (bitmasks)
[547.144489] Subtest bitmasks: SKIP (0.000s)
[547.225201] [118/131] (478s left) i915_getparams_basic (basic-subslice-total)
[547.289809] Starting subtest: basic-subslice-total
[547.294416] Subtest basic-subslice-total: SUCCESS (0.000s)
[547.407590] [119/131] (477s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[547.494296] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[547.498571] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[547.632329] [120/131] (477s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[547.729258] Starting subtest: fb-8bpc-vs-panel-8bpc
[547.731550] Starting dynamic subtest: pipe-A-eDP-1
[548.066225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[548.068552] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.338s)
[548.916909] [121/131] (476s left) gem_eio (create-ext)
[549.144918] Starting subtest: create-ext
[549.497576] Subtest create-ext: SUCCESS (0.352s)
[549.675029] [122/131] (475s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[549.782860] Starting subtest: y-tiled-64bpp-rotate-180
[549.786481] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[549.919520] [123/131] (475s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[550.036560] Starting subtest: flip-vs-cursor-busy-crc-legacy
[550.840165] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.802s)
[551.753144] [124/131] (473s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[551.850183] Starting subtest: plane-scaler-unity-scaling-with-rotation
[551.852442] Starting dynamic subtest: pipe-A
[552.076182] Dynamic subtest pipe-A: SUCCESS (0.228s)
[552.087727] Starting dynamic subtest: pipe-B
[553.390087] Dynamic subtest pipe-B: SUCCESS (1.312s)
[553.402080] Starting dynamic subtest: pipe-C
[554.721921] Dynamic subtest pipe-C: SUCCESS (1.331s)
[554.738569] Starting dynamic subtest: pipe-D
[556.046480] Dynamic subtest pipe-D: SUCCESS (1.322s)
[556.048940] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.199s)
[557.263139] [125/131] (468s left) kms_flip (plain-flip-fb-recreate-interruptible)
[557.364193] Starting subtest: plain-flip-fb-recreate-interruptible
[557.366590] Starting dynamic subtest: A-eDP1
[566.235559] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[566.245170] Starting dynamic subtest: B-eDP1
[575.061306] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[575.070932] Starting dynamic subtest: C-eDP1
[583.882684] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[583.896688] Starting dynamic subtest: D-eDP1
[592.704799] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[592.709357] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.350s)
[593.888563] [126/131] (431s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[593.951642] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[594.052169] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[594.176942] [127/131] (431s left) gem_exec_schedule (thriceslice)
[594.244921] Starting subtest: thriceslice
[594.246866] Starting dynamic subtest: rcs0
[594.264414] Dynamic subtest rcs0: SUCCESS (0.030s)
[594.273342] Starting dynamic subtest: bcs0
[594.294146] Dynamic subtest bcs0: SUCCESS (0.029s)
[594.303295] Starting dynamic subtest: vcs0
[594.323666] Dynamic subtest vcs0: SUCCESS (0.029s)
[594.332351] Starting dynamic subtest: vcs1
[594.354932] Dynamic subtest vcs1: SUCCESS (0.030s)
[594.364265] Starting dynamic subtest: vecs0
[594.407996] Dynamic subtest vecs0: SUCCESS (0.052s)
[594.420705] Starting dynamic subtest: ccs0
[594.462452] Dynamic subtest ccs0: SUCCESS (0.052s)
[594.465160] Subtest thriceslice: SUCCESS (0.229s)
[594.782691] [128/131] (431s left) gem_exec_whisper (basic-queues-all)
[594.848499] Starting subtest: basic-queues-all
[606.611714] Subtest basic-queues-all: SUCCESS (11.763s)
[606.817398] [129/131] (419s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[606.921519] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[606.925641] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[607.065703] [130/131] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[607.171580] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[611.662132] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.495s)
[612.894834] [131/131] (413s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[612.993917] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[612.998182] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[613.135606] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_spin_batch
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_close
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_exec_capture
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: syncobj_basic
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_prime
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_color
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_hdr
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: gem_wait
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_tiled_blits
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_legacy_colorkey
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_ctx_exec
results: parsing output: 64/ for test: gem_ctx_engines
results: parsing output: 65/ for test: gem_partial_pwrite_pread
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_pxp
results: parsing output: 68/ for test: sysfs_heartbeat_interval
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_pm_lpsp
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_fenced_exec_thrash
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_workarounds
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_exec_parallel
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_hdr
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: kms_chamelium_color
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: drm_buddy
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_dsc
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gen7_exec_parse
results: parsing output: 117/ for test: i915_getparams_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_dither
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.