[50.989083] Initializing watchdogs [50.989145] /dev/watchdog0 [51.004878] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [51.010713] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [51.013228] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [51.015007] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [51.117959] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite [51.119353] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [51.203730] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [51.295920] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [51.297288] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [51.373780] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [51.465156] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [51.466479] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [51.557048] [004/156] (960s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [51.595999] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [51.596744] Starting dynamic subtest: smem [51.681354] Dynamic subtest smem: SUCCESS (0.087s) [51.682098] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.087s) [51.853421] [005/156] (959s left) kms_color (invalid-degamma-lut-sizes) [51.940794] Starting subtest: invalid-degamma-lut-sizes [51.941546] Starting dynamic subtest: pipe-A [52.000757] Dynamic subtest pipe-A: SUCCESS (0.062s) [52.009165] Starting dynamic subtest: pipe-B [52.009951] Dynamic subtest pipe-B: SUCCESS (0.000s) [52.018779] Starting dynamic subtest: pipe-C [52.019540] Dynamic subtest pipe-C: SUCCESS (0.001s) [52.028537] Starting dynamic subtest: pipe-D [52.029268] Dynamic subtest pipe-D: SUCCESS (0.001s) [52.029983] Subtest invalid-degamma-lut-sizes: SUCCESS (0.065s) [52.124580] [006/156] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [52.224404] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [52.225868] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [52.313876] [007/156] (959s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [52.413283] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [52.414736] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [52.512428] [008/156] (959s left) kms_vblank (query-forked-hang) [52.598752] Starting subtest: query-forked-hang [52.600270] Starting dynamic subtest: pipe-A-HDMI-A-1 [66.703708] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.203s) [66.712736] Starting dynamic subtest: pipe-D-HDMI-A-1 [80.511594] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.818s) [80.512372] Subtest query-forked-hang: SUCCESS (28.026s) [80.664563] [009/156] (931s left) gem_sync (basic-many-each) [80.716916] Starting subtest: basic-many-each [82.975692] Subtest basic-many-each: SUCCESS (2.233s) [83.151639] [010/156] (928s left) kms_big_fb (4-tiled-16bpp-rotate-270) [83.250280] Starting subtest: 4-tiled-16bpp-rotate-270 [83.251689] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s) [83.341285] [011/156] (928s left) kms_vblank (wait-busy-hang) [83.428660] Starting subtest: wait-busy-hang [83.429352] Starting dynamic subtest: pipe-A-HDMI-A-1 [97.424357] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.995s) [97.433222] Starting dynamic subtest: pipe-D-HDMI-A-1 [111.743349] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.315s) [111.744091] Subtest wait-busy-hang: SUCCESS (28.315s) [111.881506] [012/156] (900s left) kms_plane (pixel-format-yf-tiled-modifier) [111.979555] Starting subtest: pixel-format-yf-tiled-modifier [111.981026] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [112.036654] [013/156] (899s left) gem_exec_whisper (basic-contexts) [112.079296] Starting subtest: basic-contexts [114.528692] Subtest basic-contexts: SUCCESS (2.448s) [114.719064] [014/156] (897s left) gem_eio (wait-1us) [114.762576] Starting subtest: wait-1us [114.911286] Subtest wait-1us: SUCCESS (0.148s) [115.029533] [015/156] (897s left) syncobj_timeline (single-wait-available-signaled) [115.063900] Starting subtest: single-wait-available-signaled [115.064606] Subtest single-wait-available-signaled: SUCCESS (0.001s) [115.131079] [016/156] (896s left) sw_sync (sync_busy_fork) [115.162898] Starting subtest: sync_busy_fork [116.184446] Subtest sync_busy_fork: SUCCESS (1.012s) [116.228120] [017/156] (895s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [116.323239] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [116.324678] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [116.423514] [018/156] (895s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move) [116.517125] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move [116.518519] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [116.613383] [019/156] (895s left) gen3_render_tiledx_blits [116.683786] [020/156] (895s left) perf_pmu (rc6-suspend) [116.720440] Starting subtest: rc6-suspend [139.646661] Subtest rc6-suspend: SUCCESS (7.689s) [143.961178] [021/156] (872s left) kms_psr (fbc-pr-basic) [144.065642] Subtest fbc-pr-basic: SKIP (0.000s) [144.106827] [022/156] (872s left) kms_big_fb (x-tiled-8bpp-rotate-90) [144.202071] Starting subtest: x-tiled-8bpp-rotate-90 [144.284141] Subtest x-tiled-8bpp-rotate-90: SKIP (0.083s) [144.384921] [023/156] (871s left) kms_cursor_crc (cursor-dpms) [144.475962] Starting subtest: cursor-dpms [144.476726] Starting dynamic subtest: pipe-A-HDMI-A-1 [145.121412] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.661s) [145.130276] Starting dynamic subtest: pipe-D-HDMI-A-1 [145.726812] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.617s) [145.727530] Subtest cursor-dpms: SUCCESS (1.281s) [145.892331] [024/156] (870s left) gem_ctx_persistence (saturated-hostile-nopreempt) [145.933478] Starting subtest: saturated-hostile-nopreempt [145.934302] Starting dynamic subtest: rcs0 [146.673427] Dynamic subtest rcs0: SUCCESS (0.748s) [146.682735] Starting dynamic subtest: bcs0 [147.434243] Dynamic subtest bcs0: SUCCESS (0.773s) [147.444746] Starting dynamic subtest: vcs0 [148.194917] Dynamic subtest vcs0: SUCCESS (0.772s) [148.205050] Starting dynamic subtest: vcs1 [148.952739] Dynamic subtest vcs1: SUCCESS (0.769s) [148.966083] Starting dynamic subtest: vecs0 [149.698771] Dynamic subtest vecs0: SUCCESS (0.755s) [149.699697] Subtest saturated-hostile-nopreempt: SUCCESS (3.820s) [149.795691] [025/156] (866s left) kms_cursor_edge_walk (256x256-left-edge) [149.884702] Starting subtest: 256x256-left-edge [149.885402] Starting dynamic subtest: pipe-A-HDMI-A-1 [151.603989] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.731s) [151.614354] Starting dynamic subtest: pipe-D-HDMI-A-1 [153.254398] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.671s) [153.255976] Subtest 256x256-left-edge: SUCCESS (3.404s) [153.373857] [026/156] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [153.474815] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [153.476292] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [153.572846] [027/156] (862s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [153.606294] Starting subtest: basic-write-cpu-read-gtt [153.838595] Subtest basic-write-cpu-read-gtt: SUCCESS (0.226s) [153.895755] [028/156] (862s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [153.981191] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [153.981905] Starting dynamic subtest: pipe-A-HDMI-A-1 [153.988739] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [153.996841] Starting dynamic subtest: pipe-B-HDMI-A-1 [154.003516] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [154.011394] Starting dynamic subtest: pipe-C-HDMI-A-1 [154.018107] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [154.025974] Starting dynamic subtest: pipe-D-HDMI-A-1 [154.032749] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [154.034167] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [154.247523] [029/156] (862s left) vgem_basic (create) [154.330206] Starting subtest: create [154.330937] Subtest create: SUCCESS (0.000s) [154.381379] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true [154.383067] [030/156] (862s left) kms_setmode (invalid-clone-exclusive-crtc) [154.415681] Starting subtest: invalid-clone-exclusive-crtc [154.418142] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [154.492673] [031/156] (862s left) gem_exec_gttfill (basic) [154.535609] Starting subtest: basic [158.399852] Subtest basic: SUCCESS (3.886s) [158.593175] [032/156] (858s left) gem_exec_balancer (hog) [158.695949] Starting subtest: hog [160.088053] Subtest hog: SUCCESS (1.389s) [160.278523] [033/156] (856s left) gem_exec_reloc (basic-wc-read-active) [160.317046] Starting subtest: basic-wc-read-active [160.443372] Subtest basic-wc-read-active: SUCCESS (0.119s) [160.576116] [034/156] (856s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite) [160.670876] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite [160.672378] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [160.772722] [035/156] (856s left) gem_exec_schedule (preempt) [160.827653] Starting subtest: preempt [160.828415] Starting dynamic subtest: rcs0 [160.847298] Dynamic subtest rcs0: SUCCESS (0.019s) [160.857405] Starting dynamic subtest: bcs0 [160.866580] Dynamic subtest bcs0: SUCCESS (0.019s) [160.876667] Starting dynamic subtest: vcs0 [160.884974] Dynamic subtest vcs0: SUCCESS (0.018s) [160.895615] Starting dynamic subtest: vcs1 [160.905557] Dynamic subtest vcs1: SUCCESS (0.020s) [160.915261] Starting dynamic subtest: vecs0 [160.923607] Dynamic subtest vecs0: SUCCESS (0.018s) [160.924355] Subtest preempt: SUCCESS (0.096s) [161.229649] [036/156] (855s left) kms_addfb_basic (small-bo) [161.318794] Starting subtest: small-bo [161.319530] Subtest small-bo: SUCCESS (0.000s) [161.418666] [037/156] (855s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render) [161.510868] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render [161.512263] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [161.618855] [038/156] (855s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [161.659035] Starting subtest: mixed-tiled-to-y-tiled-ccs [161.659761] Starting dynamic subtest: smem [161.771695] Dynamic subtest smem: SUCCESS (0.113s) [161.772449] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.114s) [161.952963] [039/156] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [162.044568] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [162.045948] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [162.150314] [040/156] (854s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [162.242821] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu [162.244235] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [162.340038] [041/156] (854s left) gem_exec_params (sol-reset-not-gen7) [162.377066] Starting subtest: sol-reset-not-gen7 [162.378619] Subtest sol-reset-not-gen7: SUCCESS (0.001s) [162.481866] [042/156] (854s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [162.571130] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [162.573312] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [162.629750] [043/156] (854s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff) [162.723904] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff [162.725301] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [162.840650] [044/156] (854s left) gem_ctx_param (invalid-ctx-set) [162.874079] Starting subtest: invalid-ctx-set [162.874857] Subtest invalid-ctx-set: SUCCESS (0.000s) [162.945406] [045/156] (854s left) gem_pwrite (basic-self) [162.978740] Starting subtest: basic-self [163.017784] Subtest basic-self: SUCCESS (0.039s) [163.102791] [046/156] (854s left) perf_pmu (busy-accuracy-50) [163.140590] Starting subtest: busy-accuracy-50 [163.141383] Starting dynamic subtest: rcs0 [164.664966] Dynamic subtest rcs0: SUCCESS (1.524s) [164.675813] Starting dynamic subtest: bcs0 [166.187595] Dynamic subtest bcs0: SUCCESS (1.525s) [166.197792] Starting dynamic subtest: vcs0 [167.711056] Dynamic subtest vcs0: SUCCESS (1.526s) [167.721146] Starting dynamic subtest: vcs1 [169.234609] Dynamic subtest vcs1: SUCCESS (1.525s) [169.243857] Starting dynamic subtest: vecs0 [170.756930] Dynamic subtest vecs0: SUCCESS (1.524s) [170.757748] Subtest busy-accuracy-50: SUCCESS (7.626s) [170.847963] [047/156] (846s left) i915_hangman (engine-error-state-capture) [170.892131] Starting subtest: engine-error-state-capture [170.892856] Starting dynamic subtest: rcs0 [174.665150] Dynamic subtest rcs0: SUCCESS (3.773s) [174.676709] Starting dynamic subtest: bcs0 [178.620868] Dynamic subtest bcs0: SUCCESS (3.956s) [178.632329] Starting dynamic subtest: vcs0 [182.657044] Dynamic subtest vcs0: SUCCESS (4.036s) [182.667318] Starting dynamic subtest: vcs1 [186.625070] Dynamic subtest vcs1: SUCCESS (3.968s) [186.637142] Starting dynamic subtest: vecs0 [190.654100] Dynamic subtest vecs0: SUCCESS (4.029s) [190.655311] Subtest engine-error-state-capture: SUCCESS (19.767s) [190.733014] [048/156] (826s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt) [190.827589] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt [190.828983] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [190.925802] [049/156] (826s left) gem_exec_schedule (semaphore-noskip) [190.971047] Starting subtest: semaphore-noskip [191.278943] Subtest semaphore-noskip: SUCCESS (0.299s) [191.568618] [050/156] (825s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [191.659895] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [191.668955] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.009s) [191.733967] [051/156] (825s left) dmabuf_sync_file (import-multiple-read-write) [191.770474] Starting subtest: import-multiple-read-write [191.775088] Subtest import-multiple-read-write: SUCCESS (0.005s) [191.833109] [052/156] (825s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [191.867817] Starting subtest: invalid-multi-wait-all-unsubmitted [191.868551] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [191.950216] [053/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc) [192.042817] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc [192.044313] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [192.147544] [054/156] (825s left) kms_pm_dc (dc6-dpms) [193.243037] Starting subtest: dc6-dpms [196.603726] Subtest dc6-dpms: FAIL (3.347s) [196.697753] [055/156] (820s left) kms_content_protection (dp-mst-type-0-hdcp14) [196.797756] Starting subtest: dp-mst-type-0-hdcp14 [196.799241] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [196.905969] [056/156] (820s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [196.997518] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [196.998940] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [197.096339] [057/156] (820s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [197.193263] Starting subtest: addfb25-yf-tiled-legacy [197.194032] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [197.286064] [058/156] (820s left) i915_drm_fdinfo (virtual-busy-hang) [197.322894] Starting subtest: virtual-busy-hang [202.516553] Subtest virtual-busy-hang: SUCCESS (5.195s) [202.583923] [059/156] (815s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [202.618061] Starting subtest: multi-wait-all-for-submit-available-submitted [202.618806] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [202.679778] [060/156] (815s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [202.770037] Starting subtest: addfb25-framebuffer-vs-set-tiling [202.770766] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [202.870266] [061/156] (815s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [202.958112] Starting subtest: primary-y-tiled-reflect-x-270 [207.434529] Subtest primary-y-tiled-reflect-x-270: SUCCESS (4.478s) [207.637488] [062/156] (810s left) gem_ctx_engines (invalid-engines) [207.684832] Starting subtest: invalid-engines [207.692946] Subtest invalid-engines: SUCCESS (0.008s) [207.880097] [063/156] (810s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [207.974804] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [207.976198] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [208.079883] [064/156] (809s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [208.168300] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [208.169005] Starting dynamic subtest: pipe-A-valid-mode [208.986139] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.817s) [208.986888] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.818s) [209.139207] [065/156] (808s left) gem_ctx_shared (q-out-order) [209.184114] Starting subtest: Q-out-order [209.184837] Starting dynamic subtest: rcs0 [209.232773] Dynamic subtest rcs0: SUCCESS (0.049s) [209.247533] Starting dynamic subtest: bcs0 [209.285614] Dynamic subtest bcs0: SUCCESS (0.052s) [209.299005] Starting dynamic subtest: vcs0 [209.338765] Dynamic subtest vcs0: SUCCESS (0.052s) [209.352430] Starting dynamic subtest: vcs1 [209.389208] Dynamic subtest vcs1: SUCCESS (0.049s) [209.403908] Starting dynamic subtest: vecs0 [209.439300] Dynamic subtest vecs0: SUCCESS (0.049s) [209.440258] Subtest Q-out-order: SUCCESS (0.256s) [209.623495] [066/156] (808s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [209.714265] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [209.715722] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [209.877487] [067/156] (808s left) gem_userptr_blits (access-control) [209.939393] Starting subtest: access-control [209.941182] Subtest access-control: SKIP (0.000s) [210.037702] [068/156] (808s left) api_intel_allocator (simple-allocator) [210.071997] Starting subtest: simple-allocator [210.072728] Starting dynamic subtest: basic [210.073475] Dynamic subtest basic: SUCCESS (0.002s) [210.083539] Starting dynamic subtest: parallel-one [210.253631] Dynamic subtest parallel-one: SUCCESS (0.171s) [210.264483] Starting dynamic subtest: print [210.265224] Dynamic subtest print: SUCCESS (0.000s) [210.274474] Starting dynamic subtest: reuse [210.275170] Dynamic subtest reuse: SUCCESS (0.000s) [210.283826] Starting dynamic subtest: reserve [210.284514] Dynamic subtest reserve: SUCCESS (0.000s) [210.293169] Starting dynamic subtest: fork-reopen-allocator [210.293856] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s) [210.294528] Subtest simple-allocator: SUCCESS (0.192s) [210.332983] [069/156] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [210.424602] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [210.426002] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [210.536499] [070/156] (807s left) gem_mmap_wc (write-cpu-read-wc) [210.571236] Starting subtest: write-cpu-read-wc [210.648704] Subtest write-cpu-read-wc: SUCCESS (0.078s) [210.728038] [071/156] (807s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [210.816274] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [210.817700] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [210.882163] [072/156] (807s left) kms_chamelium_frames (dp-crc-multiple) [211.028731] Subtest dp-crc-multiple: SKIP (0.000s) [211.125367] [073/156] (807s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [211.230389] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [211.231816] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [211.336149] [074/156] (807s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [211.432654] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [212.013731] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.581s) [212.133197] [075/156] (806s left) gem_exec_fence (submit-chain) [212.296210] Starting subtest: submit-chain [212.307952] Subtest submit-chain: SUCCESS (0.012s) [212.755011] [076/156] (805s left) kms_psr (pr-sprite-blt) [212.845832] Subtest pr-sprite-blt: SKIP (0.000s) [212.888047] [077/156] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [212.979642] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [212.980999] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [213.086055] [078/156] (805s left) syncobj_eventfd (binary-wait-before-signal) [213.121084] Starting subtest: binary-wait-before-signal [213.151638] Subtest binary-wait-before-signal: SUCCESS (0.031s) [213.237373] [079/156] (805s left) kms_flip (2x-plain-flip-fb-recreate) [213.324864] Starting subtest: 2x-plain-flip-fb-recreate [213.333590] Subtest 2x-plain-flip-fb-recreate: SKIP (0.009s) [213.415383] [080/156] (805s left) perf (invalid-open-flags) [213.510971] Starting subtest: invalid-open-flags [213.511703] Subtest invalid-open-flags: SUCCESS (0.000s) [213.548279] [081/156] (805s left) gem_media_fill (media-fill) [213.587175] Starting subtest: media-fill [213.587885] Starting dynamic subtest: smem [213.592044] Dynamic subtest smem: SUCCESS (0.005s) [213.592746] Subtest media-fill: SUCCESS (0.005s) [213.821250] [082/156] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [213.914790] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [213.916187] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [214.019729] [083/156] (804s left) gem_ccs (block-multicopy-inplace) [214.058312] Starting subtest: block-multicopy-inplace [214.059886] Subtest block-multicopy-inplace: SKIP (0.000s) [214.134499] [084/156] (804s left) kms_flip (flip-vs-absolute-wf_vblank) [214.222073] Starting subtest: flip-vs-absolute-wf_vblank [214.224834] Starting dynamic subtest: A-HDMI-A1 [222.164724] Dynamic subtest A-HDMI-A1: SUCCESS (7.924s) [222.173282] Starting dynamic subtest: B-HDMI-A1 [230.060057] Dynamic subtest B-HDMI-A1: SUCCESS (7.888s) [230.068415] Starting dynamic subtest: C-HDMI-A1 [237.872378] Dynamic subtest C-HDMI-A1: SUCCESS (7.810s) [237.880871] Starting dynamic subtest: D-HDMI-A1 [245.653434] Dynamic subtest D-HDMI-A1: SUCCESS (7.801s) [245.654241] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.435s) [245.824260] [085/156] (773s left) kms_getfb (getfb2-handle-not-fb) [245.917166] Starting subtest: getfb2-handle-not-fb [245.917878] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [246.033754] [086/156] (772s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [246.128082] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [246.128861] Starting dynamic subtest: pipe-A-HDMI-A-1 [246.980365] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.849s) [246.993154] Starting dynamic subtest: pipe-B-HDMI-A-1 [247.389389] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.405s) [247.406342] Starting dynamic subtest: pipe-C-HDMI-A-1 [247.800386] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.407s) [247.817101] Starting dynamic subtest: pipe-D-HDMI-A-1 [248.209004] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.405s) [248.209903] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.079s) [248.417641] [087/156] (770s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [248.515050] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [249.756074] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.242s) [249.904083] [088/156] (769s left) gen9_exec_parse (cmd-crossing-page) [249.942515] Subtest cmd-crossing-page: SKIP (0.000s) [249.987640] [089/156] (769s left) i915_pm_rc6_residency (rc6-accuracy) [250.022166] Starting subtest: rc6-accuracy [250.022853] Starting dynamic subtest: gt0 [253.225253] Dynamic subtest gt0: SUCCESS (3.168s) [253.226081] Subtest rc6-accuracy: SUCCESS (3.169s) [253.264157] [090/156] (765s left) kms_flip (flip-vs-rmfb-interruptible) [253.360146] Starting subtest: flip-vs-rmfb-interruptible [253.362141] Starting dynamic subtest: A-HDMI-A1 [261.009867] Dynamic subtest A-HDMI-A1: SUCCESS (7.646s) [261.029178] Starting dynamic subtest: B-HDMI-A1 [268.663897] Dynamic subtest B-HDMI-A1: SUCCESS (7.650s) [268.683080] Starting dynamic subtest: C-HDMI-A1 [276.304325] Dynamic subtest C-HDMI-A1: SUCCESS (7.637s) [276.318090] Starting dynamic subtest: D-HDMI-A1 [283.948535] Dynamic subtest D-HDMI-A1: SUCCESS (7.642s) [283.953487] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.594s) [284.117448] [091/156] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [284.219552] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [285.407872] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.189s) [285.539953] [092/156] (733s left) syncobj_wait (wait-any-snapshot) [285.575626] Starting subtest: wait-any-snapshot [285.657333] Subtest wait-any-snapshot: SUCCESS (0.082s) [285.740429] [093/156] (733s left) gem_mmap_gtt (basic-small-bo) [285.775543] Starting subtest: basic-small-bo [285.961239] Subtest basic-small-bo: SUCCESS (0.186s) [286.076095] [094/156] (733s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [286.224612] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [286.225375] Starting dynamic subtest: pipe-A-HDMI-A-1 [286.232447] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [286.241668] Starting dynamic subtest: pipe-B-HDMI-A-1 [286.248755] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [286.257948] Starting dynamic subtest: pipe-C-HDMI-A-1 [286.264959] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [286.274004] Starting dynamic subtest: pipe-D-HDMI-A-1 [286.280996] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [286.282381] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.008s) [286.481218] [095/156] (732s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [286.572134] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [286.573305] Starting dynamic subtest: pipe-A [286.719530] Dynamic subtest pipe-A: SUCCESS (0.148s) [286.730290] Starting dynamic subtest: pipe-B [286.869840] Dynamic subtest pipe-B: SUCCESS (0.149s) [286.880935] Starting dynamic subtest: pipe-C [287.021450] Dynamic subtest pipe-C: SUCCESS (0.151s) [287.034007] Starting dynamic subtest: pipe-D [287.163754] Dynamic subtest pipe-D: SUCCESS (0.141s) [287.164487] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.593s) [287.360679] [096/156] (732s left) kms_plane_cursor (overlay) [287.451515] Starting subtest: overlay [287.452866] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [288.764450] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.312s) [288.813892] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [290.106238] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.308s) [290.155832] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [291.456150] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.316s) [291.551180] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [292.893156] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.353s) [292.930985] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [294.234779] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.316s) [294.274223] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [295.601329] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.341s) [295.686882] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [297.037809] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.360s) [297.071498] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [298.412654] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.350s) [298.450402] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [299.745987] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.308s) [299.822802] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64 [301.276132] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.463s) [301.312043] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128 [302.634486] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.333s) [302.668633] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256 [303.984265] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.325s) [304.051014] Subtest overlay: SUCCESS (16.603s) [304.175174] [097/156] (715s left) kms_chamelium_hpd (vga-hpd-after-suspend) [304.330494] Subtest vga-hpd-after-suspend: SKIP (0.000s) [304.429283] [098/156] (715s left) gem_exec_flush (basic-batch-kernel-default-wb) [304.478098] Starting subtest: basic-batch-kernel-default-wb [310.118664] Subtest basic-batch-kernel-default-wb: SUCCESS (5.642s) [310.326805] [099/156] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [310.424998] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [310.426461] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [310.513565] [100/156] (709s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [310.606722] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [310.608159] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [310.717166] [101/156] (708s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [310.813122] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [310.814530] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [310.905563] [102/156] (708s left) gem_partial_pwrite_pread (write-snoop) [310.944033] Starting subtest: write-snoop [321.240017] Subtest write-snoop: SUCCESS (10.299s) [321.340144] [103/156] (698s left) kms_prime (basic-crc-vgem) [321.453143] Starting subtest: basic-crc-vgem [321.453914] Starting dynamic subtest: second-to-first [322.157519] Dynamic subtest second-to-first: SUCCESS (0.704s) [322.160665] Subtest basic-crc-vgem: SUCCESS (0.706s) [322.274258] [104/156] (697s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [322.369037] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [322.370542] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [322.472011] [105/156] (697s left) gem_vm_create (execbuf) [322.509844] Starting subtest: execbuf [322.513135] Subtest execbuf: SUCCESS (0.003s) [322.637430] [106/156] (697s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt) [322.737853] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt [322.739282] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [322.821736] [107/156] (697s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [322.859254] Starting subtest: etime-multi-wait-available-unsubmitted [322.965315] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s) [323.039623] [108/156] (696s left) kms_lease (lease-invalid-connector) [323.130002] Starting subtest: lease-invalid-connector [323.132339] Starting dynamic subtest: pipe-A-HDMI-A-1 [323.133178] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [323.145232] Starting dynamic subtest: pipe-B-HDMI-A-1 [323.145995] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [323.158377] Starting dynamic subtest: pipe-C-HDMI-A-1 [323.159177] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [323.168601] Starting dynamic subtest: pipe-D-HDMI-A-1 [323.169312] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [323.170021] Subtest lease-invalid-connector: SUCCESS (0.006s) [323.204338] [109/156] (696s left) gem_exec_fence (concurrent) [323.369376] Starting subtest: concurrent [323.370329] Starting dynamic subtest: rcs0 [323.399060] Dynamic subtest rcs0: SUCCESS (0.031s) [323.418921] Starting dynamic subtest: bcs0 [323.430907] Dynamic subtest bcs0: SUCCESS (0.030s) [323.446226] Starting dynamic subtest: vcs0 [323.461869] Dynamic subtest vcs0: SUCCESS (0.029s) [323.477853] Starting dynamic subtest: vcs1 [323.493813] Dynamic subtest vcs1: SUCCESS (0.030s) [323.509624] Starting dynamic subtest: vecs0 [323.524670] Dynamic subtest vecs0: SUCCESS (0.029s) [323.525666] Subtest concurrent: SUCCESS (0.159s) [323.978230] [110/156] (696s left) prime_mmap (test_forked) [324.013833] Starting subtest: test_forked [324.014566] Starting dynamic subtest: test_forked-smem [324.024695] Dynamic subtest test_forked-smem: SUCCESS (0.011s) [324.025532] Subtest test_forked: SUCCESS (0.012s) [324.120997] [111/156] (695s left) syncobj_wait (invalid-reset-one-illegal-handle) [324.155828] Starting subtest: invalid-reset-one-illegal-handle [324.156626] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [324.238571] [112/156] (695s left) kms_psr (fbc-psr-sprite-mmap-gtt) [324.333197] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [324.383675] [113/156] (695s left) sw_sync (alloc_fence_invalid_timeline) [324.417359] Starting subtest: alloc_fence_invalid_timeline [324.418108] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [324.469717] [114/156] (695s left) gem_exec_gttfill (all-engines) [324.513688] Starting subtest: all-engines [348.488002] Subtest all-engines: SUCCESS (23.981s) [348.673116] [115/156] (671s left) syncobj_wait (invalid-wait-bad-flags) [348.779827] Starting subtest: invalid-wait-bad-flags [348.780736] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [348.847990] [116/156] (671s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [348.947812] Starting subtest: hdr-rgb565-draw-blt [348.949280] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [349.042577] [117/156] (671s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [349.133886] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [349.179856] [118/156] (671s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [349.272845] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [349.274364] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [349.333503] [119/156] (671s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [349.426949] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [349.428486] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [349.516405] [120/156] (670s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [349.610615] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [349.612164] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [349.719576] [121/156] (670s left) syncobj_timeline (reset-unsignaled) [349.755603] Starting subtest: reset-unsignaled [349.756335] Subtest reset-unsignaled: SUCCESS (0.000s) [349.817578] [122/156] (670s left) kms_psr (psr-dpms) [349.908257] Subtest psr-dpms: SKIP (0.000s) [349.954531] [123/156] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [350.048937] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [350.050377] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [350.142224] [124/156] (670s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [350.245365] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [350.837030] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.592s) [350.950959] [125/156] (669s left) gem_softpin (evict-prime-sanity-check) [350.990691] Starting subtest: evict-prime-sanity-check [350.991480] Starting dynamic subtest: rcs0 [352.112088] Dynamic subtest rcs0: SUCCESS (1.121s) [352.127058] Starting dynamic subtest: bcs0 [353.239142] Dynamic subtest bcs0: SUCCESS (1.125s) [353.251638] Starting dynamic subtest: vcs0 [354.357061] Dynamic subtest vcs0: SUCCESS (1.116s) [354.373295] Starting dynamic subtest: vcs1 [355.478136] Dynamic subtest vcs1: SUCCESS (1.119s) [355.496574] Starting dynamic subtest: vecs0 [356.601629] Dynamic subtest vecs0: SUCCESS (1.122s) [356.621483] Starting dynamic subtest: all [357.717983] Dynamic subtest all: SUCCESS (1.115s) [357.718935] Subtest evict-prime-sanity-check: SUCCESS (6.730s) [357.797679] [126/156] (662s left) api_intel_bb (object-reloc-purge-cache) [357.833213] Starting subtest: object-reloc-purge-cache [357.837481] Subtest object-reloc-purge-cache: SUCCESS (0.004s) [357.942582] [127/156] (662s left) kms_invalid_mode (int-max-clock) [358.035046] Starting subtest: int-max-clock [358.035793] Starting dynamic subtest: pipe-A-HDMI-A-1 [358.087707] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s) [358.099782] Starting dynamic subtest: pipe-B-HDMI-A-1 [358.100565] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [358.110400] Starting dynamic subtest: pipe-C-HDMI-A-1 [358.111128] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [358.120979] Starting dynamic subtest: pipe-D-HDMI-A-1 [358.121695] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [358.122579] Subtest int-max-clock: SUCCESS (0.061s) [358.242696] [128/156] (662s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [358.340913] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [358.342350] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [358.443535] [129/156] (662s left) gem_flink_basic (flink-lifetime) [358.479100] Starting subtest: flink-lifetime [358.479828] Subtest flink-lifetime: SUCCESS (0.001s) [358.575769] [130/156] (662s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [358.670900] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [358.672329] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [358.756851] [131/156] (662s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [358.851211] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [358.852714] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [358.942353] [132/156] (662s left) kms_selftest (drm_dp_mst_helper) [358.980752] Starting subtest: drm_dp_mst_helper [358.987040] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [359.057504] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.069s) [359.075667] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [359.141382] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.082s) [359.153585] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [359.228093] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.083s) [359.229312] Subtest drm_dp_mst_helper: SUCCESS (0.248s) [359.358588] [133/156] (661s left) kms_psr (fbc-psr2-cursor-plane-onoff) [359.451194] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s) [359.493713] [134/156] (661s left) i915_query (query-topology-garbage-items) [359.528445] Starting subtest: query-topology-garbage-items [359.529219] Subtest query-topology-garbage-items: SUCCESS (0.000s) [359.606106] [135/156] (661s left) kms_plane (plane-panning-bottom-right-suspend) [359.696009] Starting subtest: plane-panning-bottom-right-suspend [359.698346] Starting dynamic subtest: pipe-A [376.586961] Dynamic subtest pipe-A: SUCCESS (1.586s) [376.601576] Starting dynamic subtest: pipe-B [393.587448] Dynamic subtest pipe-B: SUCCESS (1.576s) [393.588169] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.167s) [403.815036] [136/156] (627s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [403.916976] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [403.917681] Starting dynamic subtest: pipe-A-HDMI-A-1 [403.924068] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [403.933430] Starting dynamic subtest: pipe-B-HDMI-A-1 [403.939930] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [403.949314] Starting dynamic subtest: pipe-C-HDMI-A-1 [403.955701] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [403.964506] Starting dynamic subtest: pipe-D-HDMI-A-1 [403.971059] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [403.972359] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.006s) [404.178162] [137/156] (627s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [404.277850] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [404.279264] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [404.357524] [138/156] (626s left) kms_flip (modeset-vs-vblank-race-interruptible) [404.450737] Starting subtest: modeset-vs-vblank-race-interruptible [404.454065] Starting dynamic subtest: A-HDMI-A1 [404.790927] Dynamic subtest A-HDMI-A1: FAIL (0.321s) [404.800285] Starting dynamic subtest: B-HDMI-A1 [407.603533] Dynamic subtest B-HDMI-A1: SUCCESS (2.892s) [407.616055] Starting dynamic subtest: C-HDMI-A1 [410.394837] Dynamic subtest C-HDMI-A1: SUCCESS (2.830s) [410.406728] Starting dynamic subtest: D-HDMI-A1 [413.278317] Dynamic subtest D-HDMI-A1: SUCCESS (2.910s) [413.280499] Subtest modeset-vs-vblank-race-interruptible: FAIL (8.964s) [413.451488] [139/156] (617s left) gem_ctx_isolation (clean) [413.499275] Starting subtest: clean [413.500035] Starting dynamic subtest: rcs0 [413.522993] Dynamic subtest rcs0: SUCCESS (0.023s) [413.533892] Starting dynamic subtest: bcs0 [413.587319] Dynamic subtest bcs0: SUCCESS (0.064s) [413.598001] Starting dynamic subtest: vcs0 [413.644687] Dynamic subtest vcs0: SUCCESS (0.057s) [413.655419] Starting dynamic subtest: vcs1 [413.704249] Dynamic subtest vcs1: SUCCESS (0.059s) [413.714987] Starting dynamic subtest: vecs0 [413.771558] Dynamic subtest vecs0: SUCCESS (0.066s) [413.772461] Subtest clean: SUCCESS (0.275s) [413.957128] [140/156] (617s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [414.052452] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [414.053864] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [414.144978] [141/156] (617s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [414.237174] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [414.238585] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [414.325014] [142/156] (617s left) sysfs_timeslice_duration (idempotent) [414.363667] Starting subtest: idempotent [414.365552] Starting dynamic subtest: vecs0 [414.366260] Dynamic subtest vecs0: SUCCESS (0.001s) [414.376268] Starting dynamic subtest: vcs0 [414.376967] Dynamic subtest vcs0: SUCCESS (0.000s) [414.386208] Starting dynamic subtest: bcs0 [414.386919] Dynamic subtest bcs0: SUCCESS (0.001s) [414.395756] Starting dynamic subtest: rcs0 [414.396446] Dynamic subtest rcs0: SUCCESS (0.000s) [414.405447] Starting dynamic subtest: vcs1 [414.406144] Dynamic subtest vcs1: SUCCESS (0.001s) [414.406827] Subtest idempotent: SUCCESS (0.008s) [414.461754] [143/156] (616s left) gem_lmem_swapping (heavy-verify-random) [414.500797] Subtest heavy-verify-random: SKIP (0.000s) [414.544907] [144/156] (616s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [414.633446] Starting subtest: drrs-dirtyfb-ioctl [414.637617] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [414.708841] [145/156] (616s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [414.797215] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [414.797934] Starting dynamic subtest: pipe-A-valid-mode [415.685017] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.892s) [415.685810] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.895s) [415.850861] [146/156] (615s left) gem_mmap_gtt (flink-race) [415.889394] Starting subtest: flink-race [435.994530] Subtest flink-race: SUCCESS (20.118s) [436.077740] [147/156] (595s left) kms_explicit_fence (multiplane-atomic-fence-wait) [436.173932] Starting subtest: multiplane-atomic-fence-wait [436.392531] Subtest multiplane-atomic-fence-wait: SUCCESS (0.210s) [436.617675] [148/156] (595s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [436.714282] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [436.715784] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [436.818213] [149/156] (594s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [436.908116] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [439.430215] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.521s) [439.611972] [150/156] (592s left) gem_userptr_blits (readonly-unsync) [439.660115] Subtest readonly-unsync: SKIP (0.000s) [439.777385] [151/156] (592s left) kms_cursor_crc (cursor-random-256x256) [439.871541] Starting subtest: cursor-random-256x256 [439.876198] Starting dynamic subtest: pipe-A-HDMI-A-1 [441.780947] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.903s) [441.819112] Starting dynamic subtest: pipe-D-HDMI-A-1 [443.691026] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.883s) [443.691935] Subtest cursor-random-256x256: SUCCESS (3.819s) [443.858958] [152/156] (587s left) kms_big_fb (4-tiled-32bpp-rotate-90) [443.962853] Starting subtest: 4-tiled-32bpp-rotate-90 [443.964273] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s) [444.055188] [153/156] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [444.148557] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [444.150064] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [444.260971] [154/156] (587s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [444.350539] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [444.395337] [155/156] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [444.488452] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [444.489919] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [444.597870] [156/156] (587s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [444.691451] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [444.692946] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [444.799116] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_render_copy results: parsing output: 4/ for test: kms_color results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_vblank results: parsing output: 8/ for test: gem_sync results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_vblank results: parsing output: 11/ for test: kms_plane results: parsing output: 12/ for test: gem_exec_whisper results: parsing output: 13/ for test: gem_eio results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: sw_sync results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gen3_render_tiledx_blits results: parsing output: 19/ for test: perf_pmu results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: gem_ctx_persistence results: parsing output: 24/ for test: kms_cursor_edge_walk results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: vgem_basic results: parsing output: 29/ for test: kms_setmode results: parsing output: 30/ for test: gem_exec_gttfill results: parsing output: 31/ for test: gem_exec_balancer results: parsing output: 32/ for test: gem_exec_reloc results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: kms_addfb_basic results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_render_copy results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_params results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_ctx_param results: parsing output: 44/ for test: gem_pwrite results: parsing output: 45/ for test: perf_pmu results: parsing output: 46/ for test: i915_hangman results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: dmabuf_sync_file results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_pm_dc results: parsing output: 54/ for test: kms_content_protection results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: i915_drm_fdinfo results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_rotation_crc results: parsing output: 61/ for test: gem_ctx_engines results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_flip_scaled_crc results: parsing output: 64/ for test: gem_ctx_shared results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: gem_userptr_blits results: parsing output: 67/ for test: api_intel_allocator results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_mmap_wc results: parsing output: 70/ for test: kms_plane results: parsing output: 71/ for test: kms_chamelium_frames results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: gem_exec_fence results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_eventfd results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: perf results: parsing output: 80/ for test: gem_media_fill results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_ccs results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: kms_getfb results: parsing output: 85/ for test: kms_ccs results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gen9_exec_parse results: parsing output: 88/ for test: i915_pm_rc6_residency results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: gem_mmap_gtt results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: kms_plane_cursor results: parsing output: 96/ for test: kms_chamelium_hpd results: parsing output: 97/ for test: gem_exec_flush results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_partial_pwrite_pread results: parsing output: 102/ for test: kms_prime results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_vm_create results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_lease results: parsing output: 108/ for test: gem_exec_fence results: parsing output: 109/ for test: prime_mmap results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: sw_sync results: parsing output: 113/ for test: gem_exec_gttfill results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_flip_scaled_crc results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gem_softpin results: parsing output: 125/ for test: api_intel_bb results: parsing output: 126/ for test: kms_invalid_mode results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_flink_basic results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_selftest results: parsing output: 132/ for test: kms_psr results: parsing output: 133/ for test: i915_query results: parsing output: 134/ for test: kms_plane results: parsing output: 135/ for test: kms_ccs results: parsing output: 136/ for test: kms_big_fb results: parsing output: 137/ for test: kms_flip results: parsing output: 138/ for test: gem_ctx_isolation results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: sysfs_timeslice_duration results: parsing output: 142/ for test: gem_lmem_swapping results: parsing output: 143/ for test: kms_dirtyfb results: parsing output: 144/ for test: kms_flip_scaled_crc results: parsing output: 145/ for test: gem_mmap_gtt results: parsing output: 146/ for test: kms_explicit_fence results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_cursor_legacy results: parsing output: 149/ for test: gem_userptr_blits results: parsing output: 150/ for test: kms_cursor_crc results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_psr2_sf results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.