[62.311251] Initializing watchdogs
[62.311298]   /dev/watchdog0
[62.326145] [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]
[62.330427] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.332726] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.336119] [001/131] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[62.440122] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[62.442478] Starting dynamic subtest: pipe-A
[64.028535] Dynamic subtest pipe-A: SUCCESS (1.589s)
[64.035722] Starting dynamic subtest: pipe-B
[66.694058] Dynamic subtest pipe-B: SUCCESS (2.665s)
[66.701833] Starting dynamic subtest: pipe-C
[67.906653] Dynamic subtest pipe-C: SUCCESS (1.211s)
[67.915681] Starting dynamic subtest: pipe-D
[69.133286] Dynamic subtest pipe-D: SUCCESS (1.227s)
[69.135690] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.693s)
[70.294906] [002/131] (952s left) kms_cursor_crc (cursor-random-128x128)
[70.530876] Starting subtest: cursor-random-128x128
[70.533202] Starting dynamic subtest: pipe-A-eDP-1
[74.420702] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.888s)
[74.452352] Starting dynamic subtest: pipe-D-eDP-1
[78.918253] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.470s)
[78.920553] Subtest cursor-random-128x128: SUCCESS (8.387s)
[79.747222] [003/131] (943s left) kms_content_protection (uevent)
[79.920815] Starting subtest: uevent
[83.282726] Subtest uevent: SKIP (3.359s)
[84.451685] [004/131] (938s left) api_intel_allocator (reopen)
[84.508493] Starting subtest: reopen
[84.510957] Subtest reopen: SUCCESS (0.004s)
[84.652241] [005/131] (938s left) kms_plane_alpha_blend (alpha-7efc)
[84.742049] Starting subtest: alpha-7efc
[85.191498] Starting dynamic subtest: pipe-A-eDP-1
[85.779173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[85.803523] Starting dynamic subtest: pipe-D-eDP-1
[87.025627] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[87.027646] Subtest alpha-7efc: SUCCESS (2.283s)
[87.889358] [006/131] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[87.989083] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[87.993331] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.089795] [007/131] (934s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[88.188018] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[88.190364] Starting dynamic subtest: A-eDP1
[91.804851] Dynamic subtest A-eDP1: SUCCESS (3.615s)
[91.812097] Starting dynamic subtest: B-eDP1
[94.975089] Dynamic subtest B-eDP1: SUCCESS (3.169s)
[94.983072] Starting dynamic subtest: C-eDP1
[98.031479] Dynamic subtest C-eDP1: SUCCESS (3.058s)
[98.039887] Starting dynamic subtest: D-eDP1
[101.117507] Dynamic subtest D-eDP1: SUCCESS (3.083s)
[101.119440] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.930s)
[101.903668] [008/131] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[102.007190] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[108.982364] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.979s)
[109.103987] [009/131] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[109.212179] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[109.216701] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[109.317307] [010/131] (913s left) perf_pmu (busy-double-start)
[109.361131] Starting subtest: busy-double-start
[109.363347] Starting dynamic subtest: rcs0
[113.005312] Dynamic subtest rcs0: FAIL (3.592s)
[113.013954] Starting dynamic subtest: bcs0
[116.528817] Dynamic subtest bcs0: SUCCESS (3.575s)
[116.537945] Starting dynamic subtest: vcs0
[120.407066] Dynamic subtest vcs0: SUCCESS (3.877s)
[120.417200] Starting dynamic subtest: vcs1
[124.444077] Dynamic subtest vcs1: SUCCESS (4.036s)
[124.456730] Starting dynamic subtest: vecs0
[128.432868] Dynamic subtest vecs0: SUCCESS (3.988s)
[128.443062] Starting dynamic subtest: ccs0
[132.070420] Dynamic subtest ccs0: FAIL (3.569s)
[132.072432] Subtest busy-double-start: FAIL (22.642s)
[132.127327] [011/131] (891s left) testdisplay
[132.462159] [012/131] (890s left) gem_exec_balancer (parallel)
[132.713097] Starting subtest: parallel
[133.607724] Subtest parallel: SUCCESS (0.893s)
[133.947361] [013/131] (889s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[134.057150] Starting subtest: 4-tiled-8bpp-rotate-90
[134.077605] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[134.187845] [014/131] (889s left) sriov_basic (bind-unbind-vf)
[134.250880] Starting subtest: bind-unbind-vf
[134.253560] Starting dynamic subtest: vf-1
[134.333965] Dynamic subtest vf-1: FAIL (0.006s)
[134.341834] Starting dynamic subtest: vf-2
[134.415915] Dynamic subtest vf-2: FAIL (0.004s)
[134.424901] Starting dynamic subtest: vf-3
[134.498248] Dynamic subtest vf-3: FAIL (0.004s)
[134.506916] Starting dynamic subtest: vf-4
[134.578483] Dynamic subtest vf-4: FAIL (0.003s)
[134.586765] Starting dynamic subtest: vf-5
[134.655929] Dynamic subtest vf-5: FAIL (0.004s)
[134.663274] Starting dynamic subtest: vf-6
[134.732417] Dynamic subtest vf-6: FAIL (0.003s)
[134.740512] Starting dynamic subtest: vf-7
[134.810401] Dynamic subtest vf-7: FAIL (0.003s)
[134.818074] Starting dynamic subtest: vf-random
[134.894626] Dynamic subtest vf-random: FAIL (0.003s)
[134.904341] Starting dynamic subtest: vf-last
[134.967754] Dynamic subtest vf-last: FAIL (0.497s)
[134.969571] Subtest bind-unbind-vf: FAIL (0.530s)
[135.001233] [015/131] (888s left) gem_exec_balancer (bonded-chain)
[135.056960] Starting subtest: bonded-chain
[142.016497] Subtest bonded-chain: SUCCESS (6.958s)
[142.342807] [016/131] (881s left) syncobj_timeline (multi-wait-available-submitted)
[142.399310] Starting subtest: multi-wait-available-submitted
[142.401732] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[142.511090] [017/131] (880s left) gem_partial_pwrite_pread (reads-snoop)
[142.567634] Subtest reads-snoop: SKIP (0.000s)
[142.650165] [018/131] (880s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[147.658376] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[147.660680] Starting dynamic subtest: pipe-A-eDP-1
[148.460948] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[148.470464] Starting dynamic subtest: pipe-B-eDP-1
[149.587744] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[149.592305] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.928s)
[150.777624] [019/131] (872s left) gem_ppgtt (flink-and-close-vma-leak)
[150.837043] Starting subtest: flink-and-close-vma-leak
[150.881065] Subtest flink-and-close-vma-leak: SUCCESS (0.044s)
[151.003144] [020/131] (872s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[151.105184] Starting subtest: fbc-rgb565-draw-mmap-gtt
[151.109457] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[151.205105] [021/131] (872s left) kms_joiner (invalid-modeset-force-big-joiner)
[151.308610] Starting subtest: invalid-modeset-force-big-joiner
[151.310965] Starting dynamic subtest: big_joiner_on_last_pipe
[151.648330] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.348s)
[151.650643] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.349s)
[152.382087] [022/131] (871s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[152.476827] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[152.479274] Starting dynamic subtest: pipe-A-eDP-1
[152.502495] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.516212] Starting dynamic subtest: pipe-B-eDP-1
[152.538454] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[152.547204] Starting dynamic subtest: pipe-C-eDP-1
[152.570086] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.579272] Starting dynamic subtest: pipe-D-eDP-1
[152.601593] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.605684] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[154.643104] [023/131] (868s left) vgem_basic (bad-pad)
[154.748698] Starting subtest: bad-pad
[154.750952] Subtest bad-pad: SUCCESS (0.000s)
[154.800850] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[154.804064] [024/131] (868s left) gem_exec_reloc (basic-wc-read-noreloc)
[154.854373] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[154.940847] [025/131] (868s left) api_intel_allocator (fork-simple-once)
[154.988841] Starting subtest: fork-simple-once
[155.002439] Subtest fork-simple-once: SUCCESS (0.014s)
[155.153336] [026/131] (868s left) kms_busy (basic-hang)
[155.253611] Starting subtest: basic-hang
[155.256202] Starting dynamic subtest: flip-pipe-A
[155.880828] Dynamic subtest flip-pipe-A: SUCCESS (0.624s)
[155.897140] Starting dynamic subtest: modeset-pipe-A
[159.242648] Dynamic subtest modeset-pipe-A: SUCCESS (3.361s)
[159.250470] Starting dynamic subtest: flip-pipe-D
[160.454322] Dynamic subtest flip-pipe-D: SUCCESS (1.210s)
[160.463596] Starting dynamic subtest: modeset-pipe-D
[163.855177] Dynamic subtest modeset-pipe-D: SUCCESS (3.401s)
[163.857457] Subtest basic-hang: SUCCESS (8.602s)
[164.641892] [027/131] (859s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[164.743327] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[164.745659] Starting dynamic subtest: pipe-A-eDP-1
[164.771089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.779408] Starting dynamic subtest: pipe-B-eDP-1
[164.804283] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.811676] Starting dynamic subtest: pipe-C-eDP-1
[164.835297] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.842545] Starting dynamic subtest: pipe-D-eDP-1
[164.866752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.871191] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[166.993899] [028/131] (856s left) kms_flip (wf_vblank-ts-check)
[167.098180] Starting subtest: wf_vblank-ts-check
[167.100491] Starting dynamic subtest: A-eDP1
[176.036439] Dynamic subtest A-eDP1: SUCCESS (8.937s)
[176.044567] Starting dynamic subtest: B-eDP1
[184.963246] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[184.970743] Starting dynamic subtest: C-eDP1
[193.877371] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[193.887069] Starting dynamic subtest: D-eDP1
[202.802034] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[202.804628] Subtest wf_vblank-ts-check: SUCCESS (35.706s)
[204.020286] [029/131] (819s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[204.137385] Starting subtest: cursorB-vs-flipB-atomic-transitions
[204.141990] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[204.281771] [030/131] (819s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[204.380428] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[204.382739] Starting dynamic subtest: A-eDP1
[207.917108] Dynamic subtest A-eDP1: SUCCESS (3.532s)
[207.927906] Starting dynamic subtest: B-eDP1
[211.079916] Dynamic subtest B-eDP1: SUCCESS (3.162s)
[211.088555] Starting dynamic subtest: C-eDP1
[214.148554] Dynamic subtest C-eDP1: SUCCESS (3.071s)
[214.157621] Starting dynamic subtest: D-eDP1
[217.222278] Dynamic subtest D-eDP1: SUCCESS (3.072s)
[217.224666] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.844s)
[218.019551] [031/131] (805s left) gem_ctx_exec (basic-nohangcheck)
[218.078112] Starting subtest: basic-nohangcheck
[218.337731] Subtest basic-nohangcheck: SUCCESS (0.261s)
[218.463105] [032/131] (805s left) sw_sync (sync_multi_timeline_wait)
[218.496326] Starting subtest: sync_multi_timeline_wait
[218.498653] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[218.549151] [033/131] (805s left) kms_cursor_legacy (forked-bo)
[218.665606] Starting subtest: forked-bo
[218.667792] Starting dynamic subtest: pipe-A
[224.136306] Dynamic subtest pipe-A: SUCCESS (5.469s)
[224.147503] Starting dynamic subtest: pipe-B
[229.627140] Dynamic subtest pipe-B: SUCCESS (5.486s)
[229.638772] Starting dynamic subtest: pipe-C
[235.091907] Dynamic subtest pipe-C: SUCCESS (5.465s)
[235.100650] Starting dynamic subtest: pipe-D
[240.574127] Dynamic subtest pipe-D: SUCCESS (5.479s)
[240.583423] Starting dynamic subtest: all-pipes
[246.072412] Dynamic subtest all-pipes: SUCCESS (5.497s)
[246.074832] Subtest forked-bo: SUCCESS (27.405s)
[246.220743] [034/131] (777s left) kms_cursor_crc (cursor-sliding-64x21)
[246.417715] Starting subtest: cursor-sliding-64x21
[246.467632] Subtest cursor-sliding-64x21: SKIP (0.043s)
[246.710440] [035/131] (777s left) kms_busy (extended-pageflip-hang-oldfb)
[246.814335] Starting subtest: extended-pageflip-hang-oldfb
[246.816578] Starting dynamic subtest: pipe-A
[247.239799] Dynamic subtest pipe-A: SUCCESS (0.423s)
[247.250421] Starting dynamic subtest: pipe-D
[248.339747] Dynamic subtest pipe-D: SUCCESS (1.098s)
[248.342208] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.525s)
[249.154781] [036/131] (775s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[249.219076] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[249.284511] [037/131] (774s left) gem_ctx_persistence (engines-hostile-preempt)
[249.345582] Starting subtest: engines-hostile-preempt
[249.347977] Starting dynamic subtest: rcs0
[249.461193] Dynamic subtest rcs0: SUCCESS (0.115s)
[249.472648] Starting dynamic subtest: bcs0
[249.540244] Dynamic subtest bcs0: SUCCESS (0.077s)
[249.551197] Starting dynamic subtest: vcs0
[250.921878] Dynamic subtest vcs0: SUCCESS (1.378s)
[250.931913] Starting dynamic subtest: vcs1
[252.904036] Dynamic subtest vcs1: SUCCESS (1.981s)
[252.914574] Starting dynamic subtest: vecs0
[254.952488] Dynamic subtest vecs0: SUCCESS (2.046s)
[254.966855] Starting dynamic subtest: ccs0
[255.038739] Dynamic subtest ccs0: SUCCESS (0.086s)
[255.041555] Subtest engines-hostile-preempt: SUCCESS (5.694s)
[255.117943] [038/131] (769s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[255.179052] Starting subtest: mixed-tiled-to-y-tiled-ccs
[255.183558] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[255.360991] [039/131] (768s left) kms_color (ctm-blue-to-red)
[255.457299] Starting subtest: ctm-blue-to-red
[255.459623] Starting dynamic subtest: pipe-A-eDP-1
[256.158125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[256.167849] Starting dynamic subtest: pipe-B-eDP-1
[257.513685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[257.522825] Starting dynamic subtest: pipe-C-eDP-1
[258.790821] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[258.799400] Starting dynamic subtest: pipe-D-eDP-1
[260.124940] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[260.127197] Subtest ctm-blue-to-red: SUCCESS (4.665s)
[260.936495] [040/131] (763s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[261.009907] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[261.140951] [041/131] (763s left) gem_userptr_blits (coherency-unsync)
[261.208799] Subtest coherency-unsync: SKIP (0.000s)
[261.333403] [042/131] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[261.427422] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[261.431483] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[261.538204] [043/131] (762s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[261.630148] Starting subtest: coverage-vs-premult-vs-constant
[262.079246] Starting dynamic subtest: pipe-A-eDP-1
[262.634133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[262.642756] Starting dynamic subtest: pipe-D-eDP-1
[263.948672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[263.950755] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.315s)
[264.791264] [044/131] (759s left) kms_scaling_modes (scaling-mode-full)
[264.878333] Starting subtest: scaling-mode-full
[264.880629] Starting dynamic subtest: pipe-A-eDP-1
[264.993588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.115s)
[265.004156] Starting dynamic subtest: pipe-B-eDP-1
[266.217208] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s)
[266.225645] Starting dynamic subtest: pipe-C-eDP-1
[267.425798] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[267.434063] Starting dynamic subtest: pipe-D-eDP-1
[268.557710] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[268.560087] Subtest scaling-mode-full: SUCCESS (3.680s)
[269.708266] [045/131] (754s left) gem_workarounds (suspend-resume-fd)
[269.777405] Starting subtest: suspend-resume-fd
[285.815557] Subtest suspend-resume-fd: SUCCESS (1.296s)
[285.960443] [046/131] (738s left) syncobj_basic (illegal-fd-to-handle)
[286.033625] Starting subtest: illegal-fd-to-handle
[286.035906] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[286.139881] [047/131] (738s left) fbdev (read)
[286.191182] Starting subtest: read
[286.732753] Subtest read: SUCCESS (0.538s)
[286.797880] [048/131] (737s left) syncobj_wait (wait-all-snapshot)
[286.847474] Starting subtest: wait-all-snapshot
[286.927406] Subtest wait-all-snapshot: SUCCESS (0.081s)
[287.007635] [049/131] (737s left) kms_psr (fbc-pr-sprite-plane-move)
[287.102785] Starting subtest: fbc-pr-sprite-plane-move
[287.106863] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[287.172654] [050/131] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[287.270215] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[287.274534] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[287.376739] [051/131] (737s left) gem_busy (parallel)
[287.576787] Starting subtest: parallel
[287.578960] Starting dynamic subtest: rcs0
[289.642819] Dynamic subtest rcs0: SUCCESS (2.062s)
[289.654765] Starting dynamic subtest: bcs0
[291.628697] Dynamic subtest bcs0: SUCCESS (1.982s)
[291.639750] Starting dynamic subtest: vcs0
[293.674838] Dynamic subtest vcs0: SUCCESS (2.042s)
[293.686784] Starting dynamic subtest: vcs1
[295.660740] Dynamic subtest vcs1: SUCCESS (1.983s)
[295.672422] Starting dynamic subtest: vecs0
[297.642999] Dynamic subtest vecs0: SUCCESS (1.979s)
[297.655581] Starting dynamic subtest: ccs0
[299.628180] Dynamic subtest ccs0: SUCCESS (1.982s)
[299.631034] Subtest parallel: SUCCESS (12.044s)
[299.866723] [052/131] (724s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[299.919517] Starting subtest: wait-all-for-submit-delayed-submit
[300.022404] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[300.099127] [053/131] (724s left) kms_pm_rpm (cursor-dpms)
[301.845866] Starting subtest: cursor-dpms
[301.851004] Subtest cursor-dpms: SKIP (0.000s)
[302.418961] [054/131] (722s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[302.479226] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[302.481488] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[302.578103] [055/131] (722s left) kms_addfb_basic (addfb25-bad-modifier)
[302.678927] Starting subtest: addfb25-bad-modifier
[302.680834] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[302.782193] [056/131] (722s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[302.871613] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[302.883167] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[302.986196] [057/131] (722s left) gem_exec_store (dword)
[303.047910] Starting subtest: dword
[303.050081] Starting dynamic subtest: rcs0
[303.111485] Dynamic subtest rcs0: SUCCESS (0.065s)
[303.122075] Starting dynamic subtest: bcs0
[303.176190] Dynamic subtest bcs0: SUCCESS (0.063s)
[303.187052] Starting dynamic subtest: vcs0
[303.217770] Dynamic subtest vcs0: SUCCESS (0.040s)
[303.227870] Starting dynamic subtest: vcs1
[303.258899] Dynamic subtest vcs1: SUCCESS (0.039s)
[303.268791] Starting dynamic subtest: vecs0
[303.299812] Dynamic subtest vecs0: SUCCESS (0.039s)
[303.309431] Starting dynamic subtest: ccs0
[303.340865] Dynamic subtest ccs0: SUCCESS (0.040s)
[303.342927] Subtest dword: SUCCESS (0.296s)
[303.523788] [058/131] (721s left) perf_pmu (rc6-suspend)
[303.563429] Starting subtest: rc6-suspend
[325.980041] Subtest rc6-suspend: SUCCESS (7.500s)
[326.884572] [059/131] (698s left) kms_flip (2x-busy-flip)
[326.974881] Starting subtest: 2x-busy-flip
[326.987030] Subtest 2x-busy-flip: SKIP (0.011s)
[327.062983] [060/131] (698s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[327.166614] Starting subtest: x-tiled-64bpp-rotate-270
[327.186754] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[327.323664] [061/131] (697s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[327.408595] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[327.410547] Starting dynamic subtest: pipe-A
[327.418426] Dynamic subtest pipe-A: SKIP (0.005s)
[327.430534] Starting dynamic subtest: pipe-B
[327.457623] Dynamic subtest pipe-B: SKIP (0.024s)
[327.467726] Starting dynamic subtest: pipe-C
[327.475050] Dynamic subtest pipe-C: SKIP (0.020s)
[327.483721] Starting dynamic subtest: pipe-D
[327.490607] Dynamic subtest pipe-D: SKIP (0.019s)
[327.494095] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.071s)
[327.573483] [062/131] (697s left) gem_lmem_swapping (smem-oom)
[327.616144] Subtest smem-oom: SKIP (0.000s)
[327.663990] [063/131] (697s left) perf (rc6-disable)
[327.774607] Starting subtest: rc6-disable
[327.962286] Subtest rc6-disable: SUCCESS (0.188s)
[328.002999] [064/131] (697s left) i915_query (query-regions-sanity-check)
[328.061552] Starting subtest: query-regions-sanity-check
[328.072856] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[328.216153] [065/131] (697s left) i915_drm_fdinfo (memory-info-active)
[328.250179] Starting subtest: memory-info-active
[328.252173] Starting dynamic subtest: smem0
[331.513688] Dynamic subtest smem0: SUCCESS (3.261s)
[331.516173] Subtest memory-info-active: SUCCESS (3.262s)
[331.591950] [066/131] (693s left) i915_suspend (forcewake)
[331.650593] Starting subtest: forcewake
[363.740290] Subtest forcewake: SUCCESS (2.388s)
[363.808372] [067/131] (661s left) kms_psr (fbc-psr-primary-render)
[363.912557] Starting subtest: fbc-psr-primary-render
[363.914432] Starting dynamic subtest: eDP-1
[363.918574] Dynamic subtest eDP-1: SKIP (0.000s)
[363.922657] Subtest fbc-psr-primary-render: SKIP (0.001s)
[363.985509] [068/131] (661s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[369.029681] Starting subtest: pr-plane-move-sf-dmg-area
[369.034313] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[369.864439] [069/131] (655s left) prime_vgem (basic-gtt)
[369.946962] Starting subtest: basic-gtt
[369.951492] Subtest basic-gtt: SKIP (0.000s)
[370.055070] [070/131] (655s left) kms_psr (fbc-psr2-sprite-plane-move)
[370.152158] Starting subtest: fbc-psr2-sprite-plane-move
[370.154268] Starting dynamic subtest: eDP-1
[370.158572] Dynamic subtest eDP-1: SKIP (0.000s)
[370.162786] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[370.225662] [071/131] (655s left) gem_pread (bench)
[370.283389] Subtest bench: SKIP (0.000s)
[370.347934] [072/131] (655s left) kms_lease (lease-unleased-connector)
[370.438701] Starting subtest: lease-unleased-connector
[370.440954] Starting dynamic subtest: pipe-A-eDP-1
[370.446201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[370.456084] Starting dynamic subtest: pipe-B-eDP-1
[370.458236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[370.467220] Starting dynamic subtest: pipe-C-eDP-1
[370.469402] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[370.478208] Starting dynamic subtest: pipe-D-eDP-1
[370.480783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[370.482921] Subtest lease-unleased-connector: SUCCESS (0.032s)
[370.600768] [073/131] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[370.705251] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[370.709651] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[370.791961] [074/131] (654s left) kms_rotation_crc (cursor-rotation-180)
[370.882484] Starting subtest: cursor-rotation-180
[372.329083] Subtest cursor-rotation-180: SUCCESS (1.444s)
[373.529764] [075/131] (652s left) gem_render_copy (linear)
[373.591835] Starting subtest: linear
[373.594070] Starting dynamic subtest: smem
[373.635606] Dynamic subtest smem: SUCCESS (0.043s)
[373.638185] Subtest linear: SUCCESS (0.044s)
[373.890381] [076/131] (651s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[373.991742] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[373.994126] Starting dynamic subtest: pipe-A-eDP-1
[374.017064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[374.028639] Starting dynamic subtest: pipe-B-eDP-1
[374.050377] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[374.059241] Starting dynamic subtest: pipe-C-eDP-1
[374.081113] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[374.089633] Starting dynamic subtest: pipe-D-eDP-1
[374.111451] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[374.115867] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[376.277426] [077/131] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[376.380216] Starting subtest: fbcpsr-modesetfrombusy
[382.510673] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.133s)
[382.647595] [078/131] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[382.708878] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[382.811860] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[382.892470] [079/131] (643s left) syncobj_wait (wait-all-complex)
[382.945314] Starting subtest: wait-all-complex
[383.159433] Subtest wait-all-complex: SUCCESS (0.213s)
[383.231256] [080/131] (642s left) gem_exec_fence (concurrent)
[383.404183] Starting subtest: concurrent
[383.408567] Subtest concurrent: SKIP (0.000s)
[385.310345] [081/131] (640s left) syncobj_wait (invalid-wait-illegal-handle)
[385.371787] Starting subtest: invalid-wait-illegal-handle
[385.374174] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[385.485285] [082/131] (640s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[385.590098] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[386.903494] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.315s)
[387.318555] [083/131] (638s left) gem_exec_schedule (promotion)
[387.391154] Starting subtest: promotion
[387.393045] Starting dynamic subtest: rcs0
[387.492509] Dynamic subtest rcs0: SUCCESS (0.108s)
[387.503023] Starting dynamic subtest: vcs0
[387.581981] Dynamic subtest vcs0: SUCCESS (0.088s)
[387.593559] Starting dynamic subtest: vcs1
[387.660984] Dynamic subtest vcs1: SUCCESS (0.079s)
[387.673114] Starting dynamic subtest: vecs0
[387.743587] Dynamic subtest vecs0: SUCCESS (0.082s)
[387.755407] Starting dynamic subtest: ccs0
[387.831030] Dynamic subtest ccs0: SUCCESS (0.087s)
[387.833409] Subtest promotion: SUCCESS (0.448s)
[389.337820] [084/131] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[389.435563] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[389.439677] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[389.527186] [085/131] (636s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[389.635651] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[393.657956] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.024s)
[394.782351] [086/131] (631s left) gem_exec_schedule (implicit-boths)
[394.852915] Starting subtest: implicit-boths
[394.855035] Starting dynamic subtest: rcs0
[394.957707] Dynamic subtest rcs0: SUCCESS (0.113s)
[394.969818] Starting dynamic subtest: vcs0
[395.042999] Dynamic subtest vcs0: SUCCESS (0.085s)
[395.054876] Starting dynamic subtest: vcs1
[395.126438] Dynamic subtest vcs1: SUCCESS (0.082s)
[395.136767] Starting dynamic subtest: vecs0
[395.208799] Dynamic subtest vecs0: SUCCESS (0.082s)
[395.217573] Starting dynamic subtest: ccs0
[395.299516] Dynamic subtest ccs0: SUCCESS (0.089s)
[395.301968] Subtest implicit-boths: SUCCESS (0.455s)
[396.363898] [087/131] (629s left) kms_big_fb (x-tiled-addfb)
[396.469712] Starting subtest: x-tiled-addfb
[396.471931] Subtest x-tiled-addfb: SUCCESS (0.000s)
[396.559352] [088/131] (629s left) gem_pxp (create-valid-protected-context)
[396.680327] Starting subtest: create-valid-protected-context
[396.682661] Subtest create-valid-protected-context: SUCCESS (0.002s)
[396.800047] [089/131] (629s left) gem_exec_whisper (basic-queues-priority)
[396.872748] Starting subtest: basic-queues-priority
[421.316386] Subtest basic-queues-priority: SUCCESS (24.434s)
[421.501539] [090/131] (604s left) gem_exec_params (dr4-dirt)
[421.571737] Starting subtest: DR4-dirt
[421.574096] Subtest DR4-dirt: SUCCESS (0.000s)
[421.672567] [091/131] (604s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[421.782994] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[428.653749] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (6.871s)
[428.805576] [092/131] (597s left) kms_draw_crc (draw-method-pwrite)
[428.912571] Starting subtest: draw-method-pwrite
[428.914500] Starting dynamic subtest: xrgb8888-untiled
[429.475402] Dynamic subtest xrgb8888-untiled: SUCCESS (0.565s)
[429.485566] Starting dynamic subtest: rgb565-untiled
[429.942194] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[429.952240] Starting dynamic subtest: xrgb2101010-untiled
[430.498161] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[430.508005] Starting dynamic subtest: xbgr16161616f-untiled
[431.275740] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[431.286685] Starting dynamic subtest: xrgb8888-xtiled
[433.087895] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.811s)
[433.097850] Starting dynamic subtest: rgb565-xtiled
[434.199306] Dynamic subtest rgb565-xtiled: SUCCESS (1.109s)
[434.209192] Starting dynamic subtest: xrgb2101010-xtiled
[436.000269] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.799s)
[436.011273] Starting dynamic subtest: xbgr16161616f-xtiled
[439.345587] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.344s)
[439.355334] Starting dynamic subtest: xrgb8888-4tiled
[440.490451] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.144s)
[440.502553] Starting dynamic subtest: rgb565-4tiled
[441.090564] Dynamic subtest rgb565-4tiled: SUCCESS (0.599s)
[441.100085] Starting dynamic subtest: xrgb2101010-4tiled
[442.226307] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.133s)
[442.236397] Starting dynamic subtest: xbgr16161616f-4tiled
[445.223761] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.998s)
[445.226054] Subtest draw-method-pwrite: SUCCESS (16.310s)
[445.322052] [093/131] (581s left) gem_exec_params (batch-first)
[445.382786] Starting subtest: batch-first
[445.388897] Subtest batch-first: SUCCESS (0.006s)
[445.520508] [094/131] (580s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[445.628235] Starting subtest: yf-tiled-32bpp-rotate-0
[445.632673] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[445.742707] [095/131] (580s left) prime_mmap (test_invalid_sync_flags)
[445.791639] Starting subtest: test_invalid_sync_flags
[445.793951] Starting dynamic subtest: test_invalid_sync_flags-smem
[445.795927] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[445.797911] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[445.881390] [096/131] (580s left) kms_chamelium_frames (hdmi-crc-single)
[446.262521] Subtest hdmi-crc-single: SKIP (0.000s)
[447.077699] [097/131] (579s left) gem_ctx_shared (q-independent)
[447.139264] Starting subtest: Q-independent
[447.141675] Starting dynamic subtest: rcs0
[447.204612] Dynamic subtest rcs0: SUCCESS (0.065s)
[447.215560] Starting dynamic subtest: vcs0
[447.248338] Dynamic subtest vcs0: SUCCESS (0.043s)
[447.257654] Starting dynamic subtest: vcs1
[447.286381] Dynamic subtest vcs1: SUCCESS (0.038s)
[447.295903] Starting dynamic subtest: vecs0
[447.324904] Dynamic subtest vecs0: SUCCESS (0.038s)
[447.334213] Starting dynamic subtest: ccs0
[447.372629] Dynamic subtest ccs0: SUCCESS (0.047s)
[447.374961] Subtest Q-independent: SUCCESS (0.234s)
[449.356478] [098/131] (577s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[449.465259] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[449.469296] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[449.560673] [099/131] (577s left) kms_flip (2x-nonexisting-fb-interruptible)
[449.666817] Starting subtest: 2x-nonexisting-fb-interruptible
[449.677965] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[449.798397] [100/131] (576s left) kms_psr (psr2-primary-mmap-cpu)
[449.890409] Starting subtest: psr2-primary-mmap-cpu
[449.892678] Starting dynamic subtest: eDP-1
[451.669677] Dynamic subtest eDP-1: SUCCESS (1.780s)
[451.672049] Subtest psr2-primary-mmap-cpu: SUCCESS (1.781s)
[452.542772] [101/131] (574s left) gen9_exec_parse (allowed-all)
[452.606880] Subtest allowed-all: SKIP (0.000s)
[452.682369] [102/131] (574s left) kms_atomic (plane-invalid-params)
[452.772617] Starting subtest: plane-invalid-params
[452.774938] Starting dynamic subtest: pipe-A-eDP-1
[453.183896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[453.186550] Subtest plane-invalid-params: SUCCESS (0.409s)
[453.960247] [103/131] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[454.057234] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[461.359674] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.306s)
[461.505809] [104/131] (565s left) syncobj_wait (multi-wait-submitted-signaled)
[461.562423] Starting subtest: multi-wait-submitted-signaled
[461.564743] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[461.678786] [105/131] (565s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[461.782724] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[461.785029] Starting dynamic subtest: pipe-A-eDP-1
[462.229115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[462.239316] Starting dynamic subtest: pipe-B-eDP-1
[463.665605] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[463.677481] Starting dynamic subtest: pipe-C-eDP-1
[465.050516] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[465.060127] Starting dynamic subtest: pipe-D-eDP-1
[466.374931] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[466.376825] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.563s)
[467.559510] [106/131] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[467.660183] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[467.664630] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.745317] [107/131] (559s left) vgem_basic (setversion)
[467.786841] Starting subtest: setversion
[467.790906] Subtest setversion: SUCCESS (0.000s)
[467.844241] [108/131] (559s left) kms_properties (get_properties-sanity-atomic)
[467.927315] Starting subtest: get_properties-sanity-atomic
[467.932434] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[468.002096] [109/131] (559s left) kms_big_fb (y-tiled-addfb)
[468.098333] Starting subtest: y-tiled-addfb
[468.102675] Subtest y-tiled-addfb: SKIP (0.000s)
[468.187037] [110/131] (558s left) kms_vrr (flip-basic)
[468.289694] Starting subtest: flip-basic
[468.296194] Subtest flip-basic: SKIP (0.000s)
[468.367054] [111/131] (558s left) syncobj_timeline (transfer-timeline-point)
[468.411356] Starting subtest: transfer-timeline-point
[468.413640] Subtest transfer-timeline-point: SUCCESS (0.000s)
[468.528875] [112/131] (558s left) kms_prop_blob (blob-multiple)
[468.589095] Starting subtest: blob-multiple
[468.590626] Subtest blob-multiple: SUCCESS (0.003s)
[468.699399] [113/131] (558s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[468.797285] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[468.800983] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[468.901832] [114/131] (558s left) core_setmaster (master-drop-set-user)
[468.954613] Starting subtest: master-drop-set-user
[468.966449] Subtest master-drop-set-user: SUCCESS (0.014s)
[469.002889] [115/131] (558s left) kms_psr (psr-cursor-plane-onoff)
[469.097556] Starting subtest: psr-cursor-plane-onoff
[469.099329] Starting dynamic subtest: eDP-1
[470.841035] Dynamic subtest eDP-1: SUCCESS (1.741s)
[470.843207] Subtest psr-cursor-plane-onoff: SUCCESS (1.742s)
[471.701605] [116/131] (555s left) kms_universal_plane (cursor-fb-leak)
[471.801522] Starting subtest: cursor-fb-leak
[471.803727] Starting dynamic subtest: pipe-A-eDP-1
[472.120635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.318s)
[472.130610] Starting dynamic subtest: pipe-B-eDP-1
[473.507583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[473.518323] Starting dynamic subtest: pipe-C-eDP-1
[474.798618] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s)
[474.810833] Starting dynamic subtest: pipe-D-eDP-1
[476.119293] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[476.121605] Subtest cursor-fb-leak: SUCCESS (4.317s)
[477.291766] [117/131] (550s left) gen9_exec_parse (batch-without-end)
[477.359641] Subtest batch-without-end: SKIP (0.000s)
[477.457152] [118/131] (550s left) gem_workarounds (reset-context)
[477.523572] Starting subtest: reset-context
[477.711093] Subtest reset-context: SUCCESS (0.186s)
[477.845041] [119/131] (549s left) gem_mmap_gtt (basic)
[477.902246] Subtest basic: SKIP (0.000s)
[477.966611] [120/131] (549s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[478.023028] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[478.123443] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[478.203443] [121/131] (549s left) gem_exec_reloc (basic-write-read-active)
[478.252090] Subtest basic-write-read-active: SKIP (0.000s)
[478.323638] [122/131] (549s left) kms_addfb_basic (too-high)
[478.422968] Starting subtest: too-high
[478.424959] Subtest too-high: SUCCESS (0.001s)
[478.549467] [123/131] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[478.651016] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[478.654504] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[478.767105] [124/131] (548s left) gem_exec_fence (syncobj-timeline-export)
[479.306692] Starting subtest: syncobj-timeline-export
[479.314479] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[480.313118] [125/131] (547s left) gem_softpin (32b-excludes-last-page)
[480.371405] Starting subtest: 32b-excludes-last-page
[480.376184] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[480.492126] [126/131] (547s left) kms_chamelium_color (gamma)
[480.582739] Subtest gamma: SKIP (0.000s)
[480.631309] [127/131] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[480.736042] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[480.740793] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[480.841259] [128/131] (547s left) i915_pm_rpm (gem-mmap-type)
[482.388909] Starting subtest: gem-mmap-type
[482.391967] Starting dynamic subtest: wb-smem0
[486.239207] Dynamic subtest wb-smem0: SUCCESS (3.847s)
[486.249584] Starting dynamic subtest: wc-smem0
[489.375530] Dynamic subtest wc-smem0: SUCCESS (3.136s)
[489.386298] Starting dynamic subtest: uc-smem0
[492.518901] Dynamic subtest uc-smem0: SUCCESS (3.141s)
[492.521235] Subtest gem-mmap-type: SUCCESS (10.128s)
[492.616604] [129/131] (535s left) kms_flip (dpms-vs-vblank-race-interruptible)
[492.728427] Starting subtest: dpms-vs-vblank-race-interruptible
[492.730766] Starting dynamic subtest: A-eDP1
[497.731327] Dynamic subtest A-eDP1: SUCCESS (4.997s)
[497.741715] Starting dynamic subtest: B-eDP1
[502.338820] Dynamic subtest B-eDP1: SUCCESS (4.605s)
[502.350086] Starting dynamic subtest: C-eDP1
[506.930157] Dynamic subtest C-eDP1: SUCCESS (4.592s)
[506.940580] Starting dynamic subtest: D-eDP1
[511.453022] Dynamic subtest D-eDP1: SUCCESS (4.519s)
[511.454873] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.721s)
[512.314590] [130/131] (515s left) kms_flip (busy-flip)
[512.416890] Starting subtest: busy-flip
[512.419265] Starting dynamic subtest: A-eDP1
[514.127183] Dynamic subtest A-eDP1: SUCCESS (1.710s)
[514.137372] Starting dynamic subtest: B-eDP1
[515.855201] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[515.867130] Starting dynamic subtest: C-eDP1
[517.573518] Dynamic subtest C-eDP1: SUCCESS (1.717s)
[517.586185] Starting dynamic subtest: D-eDP1
[519.297749] Dynamic subtest D-eDP1: SUCCESS (1.722s)
[519.300107] Subtest busy-flip: SUCCESS (6.883s)
[520.449465] [131/131] (507s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[520.542730] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[520.545078] Starting dynamic subtest: pipe-A-default-mode
[520.835142] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[520.839555] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.289s)
[521.664300] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: testdisplay
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: gem_ppgtt
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_ctx_exec
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: kms_scaling_modes
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: syncobj_basic
results: parsing output: 46/ for test: fbdev
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_exec_store
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: i915_query
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_draw_crc
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: kms_properties
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_vrr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_prop_blob
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: core_setmaster
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_universal_plane
results: parsing output: 116/ for test: gen9_exec_parse
results: parsing output: 117/ for test: gem_workarounds
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_chamelium_color
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_pm_rpm
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_flip_scaled_crc
Done.