[55.659492] Initializing watchdogs
[55.659604]   /dev/watchdog0
[55.674989] [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]
[55.679366] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.681522] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.684796] [001/155] (960s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[55.817770] Starting subtest: cursor-tearing-framebuffer-change
[55.820139] Starting dynamic subtest: pipe-A-eDP-1
[56.437991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[56.446959] Starting dynamic subtest: pipe-D-eDP-1
[57.654843] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[57.657116] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.832s)
[58.486782] [002/155] (957s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[58.539276] Starting subtest: yf-tiled-to-vebox-y-tiled
[58.543793] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[58.717495] [003/155] (957s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[58.806156] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[58.809774] Starting dynamic subtest: pipe-A-eDP-1
[58.833083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.843208] Starting dynamic subtest: pipe-B-eDP-1
[58.864312] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.871609] Starting dynamic subtest: pipe-C-eDP-1
[58.893826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.902335] Starting dynamic subtest: pipe-D-eDP-1
[58.923111] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.927250] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[61.064204] [004/155] (955s left) i915_drm_fdinfo (all-busy-idle-check-all)
[61.102831] Starting subtest: all-busy-idle-check-all
[61.110202] Subtest all-busy-idle-check-all: SKIP (0.003s)
[61.170860] [005/155] (955s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[61.301122] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[61.305203] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[61.378784] [006/155] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[61.479967] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[61.484076] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[61.574209] [007/155] (954s left) kms_psr (psr2-primary-mmap-gtt)
[61.669025] Starting subtest: psr2-primary-mmap-gtt
[61.671323] Starting dynamic subtest: eDP-1
[63.087661] Dynamic subtest eDP-1: SKIP (1.415s)
[63.092583] Subtest psr2-primary-mmap-gtt: SKIP (1.416s)
[63.211971] [008/155] (953s left) gem_lmem_swapping (verify)
[63.251112] Subtest verify: SKIP (0.000s)
[63.288024] [009/155] (953s left) gem_busy (parallel)
[63.465115] Starting subtest: parallel
[63.467639] Starting dynamic subtest: rcs0
[65.281806] Dynamic subtest rcs0: SUCCESS (1.813s)
[65.293542] Starting dynamic subtest: bcs0
[67.266824] Dynamic subtest bcs0: SUCCESS (1.981s)
[67.276783] Starting dynamic subtest: vcs0
[69.249325] Dynamic subtest vcs0: SUCCESS (1.980s)
[69.259093] Starting dynamic subtest: vcs1
[71.296418] Dynamic subtest vcs1: SUCCESS (2.046s)
[71.307353] Starting dynamic subtest: vecs0
[73.281124] Dynamic subtest vecs0: SUCCESS (1.982s)
[73.292933] Starting dynamic subtest: ccs0
[75.264821] Dynamic subtest ccs0: SUCCESS (1.982s)
[75.267807] Subtest parallel: SUCCESS (11.791s)
[75.507875] [010/155] (941s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[75.609127] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[75.613351] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[75.701981] [011/155] (940s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[75.804147] Starting subtest: 4-tiled-8bpp-rotate-180
[77.007262] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.204s)
[77.146079] [012/155] (939s left) kms_sequence (queue-idle)
[77.239018] Starting subtest: queue-idle
[77.241069] Starting dynamic subtest: pipe-A-eDP-1
[79.049281] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[79.059618] Starting dynamic subtest: pipe-B-eDP-1
[81.517198] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.466s)
[81.527283] Starting dynamic subtest: pipe-C-eDP-1
[84.026116] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.507s)
[84.033928] Starting dynamic subtest: pipe-D-eDP-1
[86.466184] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.440s)
[86.468504] Subtest queue-idle: SUCCESS (9.224s)
[87.271193] [013/155] (929s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[87.374875] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[94.560693] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.189s)
[94.672106] [014/155] (921s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[94.776229] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[94.780255] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[94.875742] [015/155] (921s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[94.982357] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[94.986848] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[95.080774] [016/155] (921s left) gem_pxp (hw-rejects-pxp-buffer)
[95.222304] Starting subtest: hw-rejects-pxp-buffer
[95.227031] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[95.338688] [017/155] (921s left) kms_flip (absolute-wf_vblank)
[95.433084] Starting subtest: absolute-wf_vblank
[95.435498] Starting dynamic subtest: A-eDP1
[104.222392] Dynamic subtest A-eDP1: SUCCESS (8.790s)
[104.230269] Starting dynamic subtest: B-eDP1
[112.950374] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[112.960615] Starting dynamic subtest: C-eDP1
[121.665669] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[121.673936] Starting dynamic subtest: D-eDP1
[130.400452] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[130.404831] Subtest absolute-wf_vblank: SUCCESS (34.974s)
[131.607251] [018/155] (885s left) syncobj_timeline (etime-single-wait-submitted)
[131.669902] Starting subtest: etime-single-wait-submitted
[131.772374] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[131.856895] [019/155] (885s left) syncobj_wait (multi-wait-all-submitted-signaled)
[131.922419] Starting subtest: multi-wait-all-submitted-signaled
[132.027916] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[132.112036] [020/155] (884s left) kms_cursor_crc (cursor-offscreen-512x170)
[132.387708] Starting subtest: cursor-offscreen-512x170
[132.392281] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[132.539428] [021/155] (884s left) kms_big_fb (linear-32bpp-rotate-180)
[132.635061] Starting subtest: linear-32bpp-rotate-180
[134.103152] Subtest linear-32bpp-rotate-180: SUCCESS (1.469s)
[134.236782] [022/155] (882s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[134.323369] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[134.325391] Starting dynamic subtest: pipe-A
[134.386578] Dynamic subtest pipe-A: SUCCESS (0.065s)
[134.396372] Starting dynamic subtest: pipe-B
[135.536415] Dynamic subtest pipe-B: SUCCESS (1.149s)
[135.547080] Starting dynamic subtest: pipe-C
[136.663863] Dynamic subtest pipe-C: SUCCESS (1.126s)
[136.673742] Starting dynamic subtest: pipe-D
[137.791878] Dynamic subtest pipe-D: SUCCESS (1.128s)
[137.794278] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.470s)
[138.956254] [023/155] (878s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[139.058099] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[139.062592] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[139.145026] [024/155] (877s left) kms_busy (extended-modeset-hang-oldfb)
[139.239140] Starting subtest: extended-modeset-hang-oldfb
[139.241396] Starting dynamic subtest: pipe-A
[150.837160] Dynamic subtest pipe-A: SUCCESS (11.597s)
[150.846840] Starting dynamic subtest: pipe-D
[163.105863] Dynamic subtest pipe-D: SUCCESS (12.266s)
[163.108316] Subtest extended-modeset-hang-oldfb: SUCCESS (23.868s)
[163.906488] [025/155] (853s left) prime_busy (before-wait)
[163.961032] Starting subtest: before-wait
[163.963428] Starting dynamic subtest: rcs0
[163.990310] Dynamic subtest rcs0: SUCCESS (0.029s)
[164.000160] Starting dynamic subtest: bcs0
[164.031106] Dynamic subtest bcs0: SUCCESS (0.040s)
[164.039915] Starting dynamic subtest: vcs0
[164.073070] Dynamic subtest vcs0: SUCCESS (0.041s)
[164.081599] Starting dynamic subtest: vcs1
[164.115757] Dynamic subtest vcs1: SUCCESS (0.042s)
[164.123404] Starting dynamic subtest: vecs0
[164.155683] Dynamic subtest vecs0: SUCCESS (0.040s)
[164.163275] Starting dynamic subtest: ccs0
[164.195435] Dynamic subtest ccs0: SUCCESS (0.039s)
[164.305828] Subtest before-wait: SUCCESS (0.344s)
[164.378945] [026/155] (852s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[164.487172] Starting subtest: x-tiled-32bpp-rotate-0
[165.977134] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.489s)
[166.117562] [027/155] (851s left) kms_hdmi_inject (inject-4k)
[166.456092] Starting subtest: inject-4k
[166.803595] Subtest inject-4k: SUCCESS (0.349s)
[167.376441] [028/155] (849s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[167.472022] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[167.476178] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[167.543631] [029/155] (849s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[167.664401] Starting subtest: cursorB-vs-flipB-atomic
[167.668932] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[167.815593] [030/155] (849s left) perf (gen12-group-exclusive-stream-sample-oa)
[167.974592] Starting subtest: gen12-group-exclusive-stream-sample-oa
[167.993660] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[168.038521] [031/155] (849s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[168.134013] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[168.136340] Starting dynamic subtest: pipe-A-eDP-1
[168.192702] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[168.200757] Starting dynamic subtest: pipe-B-eDP-1
[168.255321] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[168.263086] Starting dynamic subtest: pipe-C-eDP-1
[168.307186] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[168.314413] Starting dynamic subtest: pipe-D-eDP-1
[168.359281] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[168.362602] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[170.389897] [032/155] (846s left) gem_ctx_persistence (heartbeat-stop)
[170.441639] Starting subtest: heartbeat-stop
[170.446429] Subtest heartbeat-stop: SKIP (0.000s)
[170.537581] [033/155] (846s left) gem_close_race (basic-threads)
[170.595217] Starting subtest: basic-threads
[171.925208] Subtest basic-threads: SUCCESS (1.330s)
[172.120115] [034/155] (845s left) prime_vgem (fence-flip-hang)
[172.276252] Subtest fence-flip-hang: SKIP (0.000s)
[172.372470] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[172.375940] [035/155] (845s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[172.470835] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[172.475101] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[172.565446] [036/155] (844s left) gem_exec_whisper (basic-fds-all)
[172.627450] Starting subtest: basic-fds-all
[184.225983] Subtest basic-fds-all: SUCCESS (11.596s)
[184.410758] [037/155] (833s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[184.523976] Starting subtest: yf-tiled-8bpp-rotate-180
[184.528437] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[184.621202] [038/155] (833s left) kms_hdr (invalid-hdr)
[184.718041] Starting subtest: invalid-hdr
[184.720250] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[189.861055] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.139s)
[189.876871] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[193.988243] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.113s)
[194.002450] Subtest invalid-hdr: SUCCESS (9.286s)
[194.120082] [039/155] (823s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[194.192166] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[194.296730] [040/155] (823s left) kms_async_flips (alternate-sync-async-flip-atomic)
[194.402173] Starting subtest: alternate-sync-async-flip-atomic
[194.774849] Starting dynamic subtest: pipe-A-eDP-1
[197.608233] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.835s)
[197.982752] Starting dynamic subtest: pipe-B-eDP-1
[200.746394] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[201.128588] Starting dynamic subtest: pipe-C-eDP-1
[203.878147] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.760s)
[204.245983] Starting dynamic subtest: pipe-D-eDP-1
[207.007445] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[207.009415] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.606s)
[208.172177] [041/155] (809s left) gem_eio (reset-stress)
[208.394607] Starting subtest: reset-stress
[208.396982] Starting dynamic subtest: render
[213.354727] Dynamic subtest render: SUCCESS (4.957s)
[213.366919] Starting dynamic subtest: bsd1
[231.811564] Dynamic subtest bsd1: SUCCESS (18.457s)
[231.826188] Starting dynamic subtest: bsd2
[249.809882] Dynamic subtest bsd2: SUCCESS (17.996s)
[249.826714] Starting dynamic subtest: blt
[249.830754] Dynamic subtest blt: SKIP (0.000s)
[249.839871] Starting dynamic subtest: vebox
[267.769038] Dynamic subtest vebox: SUCCESS (17.956s)
[267.771727] Subtest reset-stress: SUCCESS (59.371s)
[269.350868] [042/155] (748s left) gem_exec_create (forked)
[269.415920] Starting subtest: forked
[269.418431] Starting dynamic subtest: smem
[289.606896] Dynamic subtest smem: SUCCESS (20.189s)
[289.609337] Subtest forked: SUCCESS (20.190s)
[289.790657] [043/155] (728s left) kms_async_flips (test-time-stamp-atomic)
[289.884631] Starting subtest: test-time-stamp-atomic
[290.260674] Starting dynamic subtest: pipe-A-eDP-1
[291.065185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[291.458244] Starting dynamic subtest: pipe-B-eDP-1
[292.300824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.848s)
[292.682114] Starting dynamic subtest: pipe-C-eDP-1
[293.527855] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.854s)
[293.893481] Starting dynamic subtest: pipe-D-eDP-1
[294.662779] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[294.665198] Subtest test-time-stamp-atomic: SUCCESS (4.778s)
[295.820433] [044/155] (722s left) kms_plane (plane-panning-bottom-right)
[295.914422] Starting subtest: plane-panning-bottom-right
[295.916724] Starting dynamic subtest: pipe-A
[297.582686] Dynamic subtest pipe-A: SUCCESS (1.667s)
[297.592703] Starting dynamic subtest: pipe-B
[299.938798] Dynamic subtest pipe-B: SUCCESS (2.355s)
[299.941073] Subtest plane-panning-bottom-right: SUCCESS (4.025s)
[300.748780] [045/155] (717s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[300.840993] Starting subtest: fbcpsr-stridechange
[307.067422] Subtest fbcpsr-stridechange: SUCCESS (6.231s)
[307.213505] [046/155] (710s left) kms_lease (possible-crtcs-filtering)
[307.315107] Starting subtest: possible-crtcs-filtering
[307.320489] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[307.414213] [047/155] (710s left) kms_plane (plane-panning-top-left)
[307.502056] Starting subtest: plane-panning-top-left
[307.503903] Starting dynamic subtest: pipe-A
[309.184116] Dynamic subtest pipe-A: SUCCESS (1.680s)
[309.193630] Starting dynamic subtest: pipe-B
[311.634526] Dynamic subtest pipe-B: SUCCESS (2.449s)
[311.636916] Subtest plane-panning-top-left: SUCCESS (4.132s)
[312.445174] [048/155] (705s left) gem_exec_nop (basic-parallel)
[312.509657] Starting subtest: basic-parallel
[328.320567] Subtest basic-parallel: SUCCESS (15.817s)
[328.537506] [049/155] (689s left) i915_pm_rpm (gem-mmap-type)
[330.485047] Starting subtest: gem-mmap-type
[330.487687] Starting dynamic subtest: wb-smem0
[333.727989] Dynamic subtest wb-smem0: SUCCESS (3.245s)
[333.737374] Starting dynamic subtest: wc-smem0
[336.617320] Dynamic subtest wc-smem0: SUCCESS (2.889s)
[336.628250] Starting dynamic subtest: uc-smem0
[339.795088] Dynamic subtest uc-smem0: SUCCESS (3.176s)
[339.797666] Subtest gem-mmap-type: SUCCESS (9.316s)
[339.907616] [050/155] (678s left) gem_workarounds (basic-read-context)
[339.973444] Starting subtest: basic-read-context
[339.985099] Subtest basic-read-context: SUCCESS (0.010s)
[340.119498] [051/155] (678s left) i915_suspend (basic-s3-without-i915)
[340.158640] Starting subtest: basic-s3-without-i915
[344.759159] Subtest basic-s3-without-i915: SKIP (4.601s)
[346.342177] [052/155] (671s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[346.459066] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[346.463296] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[346.569758] [053/155] (671s left) prime_mmap (test_forked)
[346.626324] Starting subtest: test_forked
[346.628254] Starting dynamic subtest: test_forked-smem
[346.664431] Dynamic subtest test_forked-smem: SUCCESS (0.040s)
[346.666785] Subtest test_forked: SUCCESS (0.041s)
[346.756315] [054/155] (671s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[346.851301] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[346.853576] Starting dynamic subtest: pipe-A-eDP-1
[346.862871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.871587] Starting dynamic subtest: pipe-B-eDP-1
[346.880289] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.890579] Starting dynamic subtest: pipe-C-eDP-1
[346.899181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.907122] Starting dynamic subtest: pipe-D-eDP-1
[346.916194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.920565] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[349.175439] [055/155] (669s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[349.339687] Starting subtest: dp-mst-lic-type-0-hdcp14
[349.344142] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[349.472425] [056/155] (668s left) syncobj_wait (wait-any-complex)
[349.523143] Starting subtest: wait-any-complex
[349.584295] Subtest wait-any-complex: SUCCESS (0.061s)
[349.673583] [057/155] (668s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[349.765891] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[349.770088] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[349.850148] [058/155] (668s left) gem_softpin (evict-prime)
[349.913344] Starting subtest: evict-prime
[349.915621] Starting dynamic subtest: rcs0
[351.048954] Dynamic subtest rcs0: SUCCESS (1.135s)
[351.060600] Starting dynamic subtest: bcs0
[352.198333] Dynamic subtest bcs0: SUCCESS (1.147s)
[352.212252] Starting dynamic subtest: vcs0
[354.233632] Dynamic subtest vcs0: SUCCESS (2.032s)
[354.249833] Starting dynamic subtest: vcs1
[356.298764] Dynamic subtest vcs1: SUCCESS (2.064s)
[356.311730] Starting dynamic subtest: vecs0
[358.266326] Dynamic subtest vecs0: SUCCESS (1.965s)
[358.280321] Starting dynamic subtest: ccs0
[359.406828] Dynamic subtest ccs0: SUCCESS (1.139s)
[359.420158] Starting dynamic subtest: all
[361.289359] Dynamic subtest all: SUCCESS (1.879s)
[361.291988] Subtest evict-prime: SUCCESS (11.375s)
[361.382571] [059/155] (657s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[361.488076] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[361.492469] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[361.585294] [060/155] (656s left) kms_psr (fbc-psr2-primary-render)
[361.669160] Starting subtest: fbc-psr2-primary-render
[361.671448] Starting dynamic subtest: eDP-1
[361.675892] Dynamic subtest eDP-1: SKIP (0.000s)
[361.680321] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[361.742230] [061/155] (656s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[361.830739] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[361.834750] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[361.928634] [062/155] (656s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[362.023409] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[362.027701] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[362.115248] [063/155] (656s left) syncobj_timeline (wait-all-snapshot)
[362.166591] Starting subtest: wait-all-snapshot
[362.247229] Subtest wait-all-snapshot: SUCCESS (0.082s)
[362.348433] [064/155] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[362.450700] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[362.454192] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[362.551525] [065/155] (656s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[362.650757] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[363.744423] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.095s)
[363.855206] [066/155] (654s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[363.972532] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[363.976476] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[364.116330] [067/155] (654s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[364.209368] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[364.211315] Starting dynamic subtest: pipe-A-eDP-1
[364.939443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[364.950532] Starting dynamic subtest: pipe-B-eDP-1
[366.807637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.867s)
[366.818078] Starting dynamic subtest: pipe-C-eDP-1
[368.613400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.805s)
[368.623290] Starting dynamic subtest: pipe-D-eDP-1
[370.449070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[370.450947] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.232s)
[371.598116] [068/155] (647s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[371.696125] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[371.700652] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[371.797491] [069/155] (647s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[371.888119] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[371.890354] Starting dynamic subtest: pipe-A-eDP-1
[372.733897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s)
[372.742743] Starting dynamic subtest: pipe-B-eDP-1
[374.421269] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.683s)
[374.431506] Starting dynamic subtest: pipe-C-eDP-1
[375.928427] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[375.939737] Starting dynamic subtest: pipe-D-eDP-1
[377.466587] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s)
[377.468496] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.573s)
[378.629514] [070/155] (640s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[378.745843] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[384.081085] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.341s)
[385.228544] [071/155] (633s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[385.283663] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[385.387811] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[385.473923] [072/155] (633s left) kms_rotation_crc (primary-rotation-90)
[385.567190] Starting subtest: primary-rotation-90
[385.571661] Subtest primary-rotation-90: SKIP (0.001s)
[385.641086] [073/155] (633s left) gem_mmap_gtt (basic-small-copy)
[385.687288] Subtest basic-small-copy: SKIP (0.000s)
[385.749074] [074/155] (633s left) kms_prop_blob (invalid-set-prop)
[385.803137] Starting subtest: invalid-set-prop
[385.805640] Subtest invalid-set-prop: SUCCESS (0.000s)
[385.914447] [075/155] (633s left) dmabuf_sync_file (import-multiple-read-write)
[385.956712] Starting subtest: import-multiple-read-write
[385.959194] Subtest import-multiple-read-write: SUCCESS (0.004s)
[386.022816] [076/155] (633s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[386.125206] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[386.138280] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[386.231941] [077/155] (632s left) kms_psr (fbc-psr-cursor-plane-move)
[386.322680] Starting subtest: fbc-psr-cursor-plane-move
[386.324950] Starting dynamic subtest: eDP-1
[386.329079] Dynamic subtest eDP-1: SKIP (0.000s)
[386.333097] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[386.394326] [078/155] (632s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[386.496097] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[386.499476] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[386.588938] [079/155] (632s left) api_intel_bb (misplaced-blitter)
[386.644128] Starting subtest: misplaced-blitter
[386.650899] Subtest misplaced-blitter: SUCCESS (0.008s)
[386.790585] [080/155] (632s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[386.900977] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[386.904466] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[386.994835] [081/155] (632s left) kms_pm_dc (dc5-psr)
[388.096051] Starting subtest: dc5-psr
[391.083342] Subtest dc5-psr: SUCCESS (2.987s)
[391.964054] [082/155] (627s left) gem_exec_gttfill (multigpu-basic)
[392.132613] Starting subtest: multigpu-basic
[405.360694] Subtest multigpu-basic: SUCCESS (13.230s)
[405.456537] [083/155] (614s left) gem_exec_fence (parallel)
[405.668874] Starting subtest: parallel
[405.671274] Starting dynamic subtest: rcs0
[407.820810] Dynamic subtest rcs0: SUCCESS (2.152s)
[407.829696] Starting dynamic subtest: bcs0
[409.971295] Dynamic subtest bcs0: SUCCESS (2.150s)
[409.982351] Starting dynamic subtest: vcs0
[412.119914] Dynamic subtest vcs0: SUCCESS (2.148s)
[412.130645] Starting dynamic subtest: vcs1
[414.272850] Dynamic subtest vcs1: SUCCESS (2.152s)
[414.284876] Starting dynamic subtest: vecs0
[416.426656] Dynamic subtest vecs0: SUCCESS (2.153s)
[416.437083] Starting dynamic subtest: ccs0
[418.576395] Dynamic subtest ccs0: SUCCESS (2.149s)
[418.578479] Subtest parallel: SUCCESS (12.908s)
[419.350020] [084/155] (600s left) gem_exec_params (invalid-ring)
[419.415430] Starting subtest: invalid-ring
[419.417997] Subtest invalid-ring: SUCCESS (0.000s)
[419.552018] [085/155] (600s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff)
[419.663613] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff
[419.667634] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[419.774821] [086/155] (599s left) gem_userptr_blits (dmabuf-unsync)
[419.857131] Subtest dmabuf-unsync: SKIP (0.000s)
[419.983428] [087/155] (599s left) gem_exercise_blt (fast-copy)
[420.035363] Starting subtest: fast-copy
[420.037356] Starting dynamic subtest: linear-smem-smem
[420.063283] Dynamic subtest linear-smem-smem: SUCCESS (0.031s)
[420.076079] Starting dynamic subtest: xmajor-smem-smem
[420.083373] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[420.095078] Starting dynamic subtest: tile4-smem-smem
[420.100552] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[420.109818] Starting dynamic subtest: tile64-smem-smem
[420.119058] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[420.121591] Subtest fast-copy: SUCCESS (0.087s)
[420.231079] [088/155] (599s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[420.329807] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[420.333100] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[420.422962] [089/155] (599s left) gem_ctx_shared (q-smoketest)
[420.483217] Starting subtest: Q-smoketest
[420.485231] Starting dynamic subtest: rcs0
[426.049564] Dynamic subtest rcs0: SUCCESS (5.515s)
[426.061571] Starting dynamic subtest: bcs0
[431.552904] Dynamic subtest bcs0: SUCCESS (5.502s)
[431.564679] Starting dynamic subtest: vcs0
[437.029064] Dynamic subtest vcs0: SUCCESS (5.477s)
[437.041087] Starting dynamic subtest: vcs1
[442.517791] Dynamic subtest vcs1: SUCCESS (5.485s)
[442.529611] Starting dynamic subtest: vecs0
[448.004239] Dynamic subtest vecs0: SUCCESS (5.485s)
[448.014606] Starting dynamic subtest: ccs0
[453.492336] Dynamic subtest ccs0: SUCCESS (5.489s)
[453.494289] Subtest Q-smoketest: SUCCESS (32.961s)
[453.633148] [090/155] (566s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[453.761440] Starting subtest: cursor-vs-flip-legacy
[484.298846] Subtest cursor-vs-flip-legacy: SUCCESS (30.533s)
[484.686982] [091/155] (535s left) gem_mmap_wc (write-read-distinct)
[484.745418] Subtest write-read-distinct: SKIP (0.000s)
[484.798876] [092/155] (535s left) gen9_exec_parse (shadow-peek)
[484.867706] Subtest shadow-peek: SKIP (0.000s)
[484.969297] [093/155] (534s left) kms_psr2_su (page_flip-xrgb8888)
[485.029979] Subtest page_flip-XRGB8888: SKIP (0.000s)
[485.099252] [094/155] (534s left) kms_psr (psr2-cursor-render)
[485.186103] Starting subtest: psr2-cursor-render
[485.188433] Starting dynamic subtest: eDP-1
[486.867632] Dynamic subtest eDP-1: SUCCESS (1.681s)
[486.869959] Subtest psr2-cursor-render: SUCCESS (1.682s)
[487.758744] [095/155] (532s left) gem_mmap_gtt (coherency)
[487.808165] Subtest coherency: SKIP (0.000s)
[487.874103] [096/155] (532s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[488.257610] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[489.062641] [097/155] (531s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[489.155884] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[489.160198] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[489.255855] [098/155] (530s left) gem_exec_balancer (parallel-ordering)
[489.525782] Starting subtest: parallel-ordering
[490.508245] Subtest parallel-ordering: SUCCESS (0.982s)
[490.650089] [099/155] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[490.748904] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[497.542800] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.798s)
[497.676623] [100/155] (522s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[497.739369] Starting subtest: rel-constants-invalid-rel-gen5
[497.741643] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[497.845856] [101/155] (522s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[497.942260] Starting subtest: psr-rgb101010-draw-mmap-wc
[505.005458] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.067s)
[505.133231] [102/155] (515s left) gem_render_copy (linear-to-vebox-y-tiled)
[505.191102] Starting subtest: linear-to-vebox-y-tiled
[505.195314] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[505.404662] [103/155] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[505.510651] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[505.514967] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[505.605711] [104/155] (514s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[505.713277] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[505.717319] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[505.804729] [105/155] (514s left) kms_lease (atomic-implicit-crtc)
[505.901993] Starting subtest: atomic-implicit-crtc
[505.904646] Starting dynamic subtest: pipe-A-eDP-1
[505.916290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[505.927729] Starting dynamic subtest: pipe-B-eDP-1
[505.938666] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[505.948474] Starting dynamic subtest: pipe-C-eDP-1
[505.959190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[505.968505] Starting dynamic subtest: pipe-D-eDP-1
[505.979221] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[505.981442] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[506.060425] [106/155] (514s left) gem_eio (in-flight-contexts-1us)
[506.292365] Starting subtest: in-flight-contexts-1us
[520.330533] Subtest in-flight-contexts-1us: SUCCESS (14.038s)
[520.496771] [107/155] (499s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[520.736395] Starting subtest: cursor-rapid-movement-256x256
[520.741323] Starting dynamic subtest: pipe-A-eDP-1
[521.321070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[521.349350] Starting dynamic subtest: pipe-D-eDP-1
[522.554580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[522.556811] Subtest cursor-rapid-movement-256x256: SUCCESS (1.816s)
[523.397999] [108/155] (497s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[523.497713] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[527.626345] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.135s)
[528.844398] [109/155] (491s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[528.939165] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[528.943621] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[529.035399] [110/155] (491s left) perf (rc6-disable)
[529.166999] Starting subtest: rc6-disable
[529.346341] Subtest rc6-disable: SUCCESS (0.181s)
[529.442305] [111/155] (491s left) kms_addfb_basic (small-bo)
[529.544124] Starting subtest: small-bo
[529.546325] Subtest small-bo: SUCCESS (0.000s)
[529.658665] [112/155] (491s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[529.754836] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[529.758238] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[529.846429] [113/155] (490s left) syncobj_wait (multi-wait-all-submitted)
[529.898079] Starting subtest: multi-wait-all-submitted
[530.004854] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[530.093970] [114/155] (490s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[530.195997] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[530.200086] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[530.299468] [115/155] (490s left) syncobj_timeline (invalid-signal-illegal-handle)
[530.363648] Starting subtest: invalid-signal-illegal-handle
[530.365833] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[530.478990] [116/155] (490s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[530.562980] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[530.565187] Starting dynamic subtest: pipe-A-default-mode
[531.748210] Dynamic subtest pipe-A-default-mode: SKIP (1.181s)
[531.752020] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.182s)
[531.893757] [117/155] (489s left) gem_fenced_exec_thrash (2-spare-fences)
[531.961891] Subtest 2-spare-fences: SKIP (0.000s)
[532.041990] [118/155] (488s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[532.152437] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[532.156620] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[532.252396] [119/155] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[532.358086] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[532.362106] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[532.452438] [120/155] (488s left) syncobj_timeline (reset-multiple-signaled)
[532.512608] Starting subtest: reset-multiple-signaled
[532.514958] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[532.605386] [121/155] (488s left) kms_draw_crc (draw-method-mmap-cpu)
[532.702447] Starting subtest: draw-method-mmap-cpu
[532.704361] Starting dynamic subtest: xrgb8888-untiled
[532.922128] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[532.932590] Starting dynamic subtest: rgb565-untiled
[533.122241] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[533.134688] Starting dynamic subtest: xrgb2101010-untiled
[533.333327] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.209s)
[533.347281] Starting dynamic subtest: xbgr16161616f-untiled
[533.555647] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[533.565735] Starting dynamic subtest: xrgb8888-xtiled
[533.677878] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[533.687557] Starting dynamic subtest: rgb565-xtiled
[533.811505] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[533.821488] Starting dynamic subtest: xrgb2101010-xtiled
[533.933561] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[533.943660] Starting dynamic subtest: xbgr16161616f-xtiled
[534.066755] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[534.077539] Starting dynamic subtest: xrgb8888-4tiled
[534.200313] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[534.212720] Starting dynamic subtest: rgb565-4tiled
[534.333768] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[534.346421] Starting dynamic subtest: xrgb2101010-4tiled
[534.466675] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[534.477056] Starting dynamic subtest: xbgr16161616f-4tiled
[534.611257] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[534.613131] Subtest draw-method-mmap-cpu: SUCCESS (1.911s)
[534.731142] [122/155] (486s left) kms_prime (basic-crc-vgem)
[534.820960] Starting subtest: basic-crc-vgem
[534.822857] Starting dynamic subtest: second-to-first
[535.847173] Dynamic subtest second-to-first: SUCCESS (1.028s)
[535.848938] Subtest basic-crc-vgem: SUCCESS (1.029s)
[535.936992] [123/155] (485s left) perf (blocking)
[536.021441] Starting subtest: blocking
[536.023285] Starting dynamic subtest: 0-rcs0
[546.048620] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[546.061027] Starting dynamic subtest: 1-vcs1
[556.068809] Dynamic subtest 1-vcs1: SUCCESS (10.018s)
[556.071283] Subtest blocking: SUCCESS (20.047s)
[556.120273] [124/155] (465s left) gem_exec_reloc (basic-gtt-read)
[556.176923] Subtest basic-gtt-read: SKIP (0.000s)
[556.246512] [125/155] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[556.343251] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[556.347316] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[556.462901] [126/155] (464s left) api_intel_allocator (fork-simple-stress-signal)
[556.515992] Starting subtest: fork-simple-stress-signal
[561.917827] Subtest fork-simple-stress-signal: SUCCESS (5.403s)
[562.045548] [127/155] (459s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[562.154839] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[562.158971] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[562.267633] [128/155] (459s left) kms_vblank (wait-forked-hang)
[562.359144] Starting subtest: wait-forked-hang
[562.361421] Starting dynamic subtest: pipe-A-eDP-1
[589.058484] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.697s)
[589.073697] Starting dynamic subtest: pipe-D-eDP-1
[604.093744] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s)
[604.096192] Subtest wait-forked-hang: SUCCESS (41.735s)
[604.954059] [129/155] (416s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[605.052433] Starting subtest: fbchdr-rgb101010-draw-render
[605.057140] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[605.175518] [130/155] (416s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[605.275751] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[605.279841] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[605.380698] [131/155] (416s left) kms_chamelium_frames (dp-crc-multiple)
[605.778311] Subtest dp-crc-multiple: SKIP (0.000s)
[606.572409] [132/155] (415s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[606.667370] Starting subtest: psr2-overlay-plane-update-continuous-sf
[606.669697] Starting dynamic subtest: pipe-A-eDP-1
[607.776196] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.113s)
[607.787449] Starting dynamic subtest: pipe-B-eDP-1
[609.556206] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.781s)
[609.558484] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.896s)
[610.396462] [133/155] (411s left) gem_create (create-massive)
[610.451932] Starting subtest: create-massive
[610.454198] Subtest create-massive: SUCCESS (0.000s)
[610.649038] [134/155] (411s left) gem_exec_balancer (nop)
[610.712090] Starting subtest: nop
[657.320676] Subtest nop: SUCCESS (46.606s)
[657.638993] [135/155] (364s left) gem_eio (execbuf)
[657.868705] Starting subtest: execbuf
[658.214544] Subtest execbuf: SUCCESS (0.345s)
[658.388984] [136/155] (363s left) syncobj_wait (multi-wait-all-signaled)
[658.442548] Starting subtest: multi-wait-all-signaled
[658.444966] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[658.566716] [137/155] (363s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[658.626076] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[658.732092] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[658.835662] [138/155] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[658.931551] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[658.935698] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[659.041572] [139/155] (362s left) kms_rotation_crc (bad-pixel-format)
[659.124232] Starting subtest: bad-pixel-format
[659.128268] Subtest bad-pixel-format: SKIP (0.001s)
[659.208938] [140/155] (362s left) kms_plane_lowres (tiling-4)
[659.301113] Starting subtest: tiling-4
[659.303253] Starting dynamic subtest: pipe-A-eDP-1
[659.307629] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[659.618876] Starting dynamic subtest: pipe-B-eDP-1
[659.623323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[659.634136] Starting dynamic subtest: pipe-C-eDP-1
[659.638363] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[659.648707] Starting dynamic subtest: pipe-D-eDP-1
[659.652689] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[659.656753] Subtest tiling-4: SKIP (0.313s)
[660.419338] [141/155] (361s left) gem_ctx_persistence (engines-hang)
[660.478369] Starting subtest: engines-hang
[660.480636] Starting dynamic subtest: rcs0
[660.540685] Dynamic subtest rcs0: SUCCESS (0.065s)
[660.553822] Starting dynamic subtest: bcs0
[660.616849] Dynamic subtest bcs0: SUCCESS (0.074s)
[660.628044] Starting dynamic subtest: vcs0
[660.759850] Dynamic subtest vcs0: SUCCESS (0.141s)
[660.771298] Starting dynamic subtest: vcs1
[660.850663] Dynamic subtest vcs1: SUCCESS (0.089s)
[660.863366] Starting dynamic subtest: vecs0
[660.944634] Dynamic subtest vecs0: SUCCESS (0.092s)
[660.956746] Starting dynamic subtest: ccs0
[661.034706] Dynamic subtest ccs0: SUCCESS (0.088s)
[661.037201] Subtest engines-hang: SUCCESS (0.561s)
[661.114320] [142/155] (360s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[661.227187] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[666.280020] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.059s)
[666.380684] [143/155] (355s left) syncobj_wait (multi-wait-for-submit-signaled)
[666.437509] Starting subtest: multi-wait-for-submit-signaled
[666.439740] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[666.535660] [144/155] (355s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[666.626628] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[670.852791] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.231s)
[672.013043] [145/155] (350s left) i915_getparams_basic (basic-eu-total)
[672.061407] Starting subtest: basic-eu-total
[672.065691] Subtest basic-eu-total: SUCCESS (0.000s)
[672.173258] [146/155] (350s left) gem_exec_schedule (lateslice)
[672.232731] Starting subtest: lateslice
[672.234997] Starting dynamic subtest: rcs0
[672.242337] Dynamic subtest rcs0: SUCCESS (0.020s)
[672.252876] Starting dynamic subtest: bcs0
[672.259270] Dynamic subtest bcs0: SUCCESS (0.016s)
[672.269545] Starting dynamic subtest: vcs0
[672.277279] Dynamic subtest vcs0: SUCCESS (0.017s)
[672.287191] Starting dynamic subtest: vcs1
[672.296168] Dynamic subtest vcs1: SUCCESS (0.019s)
[672.306361] Starting dynamic subtest: vecs0
[672.315111] Dynamic subtest vecs0: SUCCESS (0.017s)
[672.325223] Starting dynamic subtest: ccs0
[672.336142] Dynamic subtest ccs0: SUCCESS (0.021s)
[672.338498] Subtest lateslice: SUCCESS (0.114s)
[674.385636] [147/155] (347s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[674.487708] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[674.491803] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[674.573291] [148/155] (347s left) syncobj_wait (wait-any-snapshot)
[674.624553] Starting subtest: wait-any-snapshot
[674.705937] Subtest wait-any-snapshot: SUCCESS (0.081s)
[674.782723] [149/155] (347s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[674.873333] Starting subtest: flip-primary-invalidate-overlay
[686.508807] Subtest flip-primary-invalidate-overlay: SUCCESS (11.637s)
[686.653923] [150/155] (335s left) gem_exec_schedule (u-lateslice)
[686.726728] Starting subtest: u-lateslice
[686.728574] Starting dynamic subtest: rcs0
[686.740363] Dynamic subtest rcs0: SUCCESS (0.021s)
[686.750744] Starting dynamic subtest: bcs0
[686.758819] Dynamic subtest bcs0: SUCCESS (0.017s)
[686.771378] Starting dynamic subtest: vcs0
[686.778244] Dynamic subtest vcs0: SUCCESS (0.019s)
[686.789778] Starting dynamic subtest: vcs1
[686.797795] Dynamic subtest vcs1: SUCCESS (0.019s)
[686.807704] Starting dynamic subtest: vecs0
[686.816676] Dynamic subtest vecs0: SUCCESS (0.018s)
[686.829147] Starting dynamic subtest: ccs0
[686.835641] Dynamic subtest ccs0: SUCCESS (0.018s)
[686.837556] Subtest u-lateslice: SUCCESS (0.117s)
[688.408517] [151/155] (334s left) kms_color (invalid-degamma-lut-sizes)
[688.499071] Starting subtest: invalid-degamma-lut-sizes
[688.501461] Starting dynamic subtest: pipe-A
[688.795061] Dynamic subtest pipe-A: SUCCESS (0.294s)
[688.806700] Starting dynamic subtest: pipe-B
[688.809057] Dynamic subtest pipe-B: SUCCESS (0.000s)
[688.819383] Starting dynamic subtest: pipe-C
[688.821629] Dynamic subtest pipe-C: SUCCESS (0.000s)
[688.831623] Starting dynamic subtest: pipe-D
[688.833529] Dynamic subtest pipe-D: SUCCESS (0.000s)
[688.835407] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s)
[689.639280] [152/155] (332s left) gem_mmap_offset (bad-flags)
[689.692480] Starting subtest: bad-flags
[689.694737] Subtest bad-flags: SUCCESS (0.000s)
[689.812871] [153/155] (332s left) perf_pmu (most-busy-check-all)
[689.860541] Starting subtest: most-busy-check-all
[689.862978] Starting dynamic subtest: rcs0
[691.328812] Dynamic subtest rcs0: SUCCESS (1.467s)
[691.342828] Starting dynamic subtest: bcs0
[693.312851] Dynamic subtest bcs0: SUCCESS (1.981s)
[693.327919] Starting dynamic subtest: vcs0
[695.294459] Dynamic subtest vcs0: SUCCESS (1.979s)
[695.309518] Starting dynamic subtest: vcs1
[697.280807] Dynamic subtest vcs1: SUCCESS (1.983s)
[697.294218] Starting dynamic subtest: vecs0
[699.264417] Dynamic subtest vecs0: SUCCESS (1.980s)
[699.280345] Starting dynamic subtest: ccs0
[701.312614] Dynamic subtest ccs0: SUCCESS (2.045s)
[701.315872] Subtest most-busy-check-all: SUCCESS (11.453s)
[701.409453] [154/155] (321s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[701.502973] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[701.507062] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[701.605266] [155/155] (320s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[701.711649] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[701.715968] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[701.816537] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: gem_busy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_sequence
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_busy
results: parsing output: 24/ for test: prime_busy
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_hdmi_inject
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_close_race
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_async_flips
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_exec_create
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: gem_exec_nop
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: gem_workarounds
results: parsing output: 50/ for test: i915_suspend
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: prime_mmap
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_prop_blob
results: parsing output: 74/ for test: dmabuf_sync_file
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pm_dc
results: parsing output: 81/ for test: gem_exec_gttfill
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: gem_exercise_blt
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_mmap_wc
results: parsing output: 91/ for test: gen9_exec_parse
results: parsing output: 92/ for test: kms_psr2_su
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_fenced_exec_thrash
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_draw_crc
results: parsing output: 121/ for test: kms_prime
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_vblank
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_chamelium_frames
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_create
results: parsing output: 133/ for test: gem_exec_balancer
results: parsing output: 134/ for test: gem_eio
results: parsing output: 135/ for test: syncobj_wait
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: kms_plane_lowres
results: parsing output: 140/ for test: gem_ctx_persistence
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: i915_getparams_basic
results: parsing output: 145/ for test: gem_exec_schedule
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: syncobj_wait
results: parsing output: 148/ for test: kms_psr_stress_test
results: parsing output: 149/ for test: gem_exec_schedule
results: parsing output: 150/ for test: kms_color
results: parsing output: 151/ for test: gem_mmap_offset
results: parsing output: 152/ for test: perf_pmu
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.