[42.777464] Initializing watchdogs [42.777530] /dev/watchdog0 [42.793377] [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] [42.799696] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [42.802381] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [42.804547] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [42.913151] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite [42.914534] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [43.023066] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [43.116065] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [43.117442] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [43.203367] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [43.296436] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [43.297915] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [43.396929] [004/156] (960s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [43.436252] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [43.437038] Starting dynamic subtest: smem [43.521768] Dynamic subtest smem: SUCCESS (0.085s) [43.522578] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.085s) [43.705722] [005/156] (959s left) kms_color (invalid-degamma-lut-sizes) [43.798056] Starting subtest: invalid-degamma-lut-sizes [43.798832] Starting dynamic subtest: pipe-A [43.855468] Dynamic subtest pipe-A: SUCCESS (0.057s) [43.864632] Starting dynamic subtest: pipe-B [43.865472] Dynamic subtest pipe-B: SUCCESS (0.001s) [43.873331] Starting dynamic subtest: pipe-C [43.874112] Dynamic subtest pipe-C: SUCCESS (0.001s) [43.880358] Starting dynamic subtest: pipe-D [43.881123] Dynamic subtest pipe-D: SUCCESS (0.001s) [43.881881] Subtest invalid-degamma-lut-sizes: SUCCESS (0.060s) [43.977564] [006/156] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [44.073230] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [44.074624] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [44.174304] [007/156] (959s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [44.274641] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [44.276050] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [44.364623] [008/156] (959s left) kms_vblank (query-forked-hang) [44.452765] Starting subtest: query-forked-hang [44.454327] Starting dynamic subtest: pipe-A-HDMI-A-1 [58.511782] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.894s) [58.520269] Starting dynamic subtest: pipe-D-HDMI-A-1 [72.837129] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.286s) [72.837907] Subtest query-forked-hang: SUCCESS (28.185s) [72.994114] [009/156] (930s left) gem_sync (basic-many-each) [73.045710] Starting subtest: basic-many-each [75.308175] Subtest basic-many-each: SUCCESS (2.235s) [75.478923] [010/156] (928s left) kms_big_fb (4-tiled-16bpp-rotate-270) [75.579092] Starting subtest: 4-tiled-16bpp-rotate-270 [75.580511] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s) [75.670505] [011/156] (928s left) kms_vblank (wait-busy-hang) [75.758725] Starting subtest: wait-busy-hang [75.759423] Starting dynamic subtest: pipe-A-HDMI-A-1 [89.734499] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.970s) [89.743686] Starting dynamic subtest: pipe-D-HDMI-A-1 [103.560182] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.820s) [103.560968] Subtest wait-busy-hang: SUCCESS (27.795s) [103.735042] [012/156] (899s left) kms_plane (pixel-format-yf-tiled-modifier) [103.828389] Starting subtest: pixel-format-yf-tiled-modifier [103.829934] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [103.880632] [013/156] (899s left) gem_exec_whisper (basic-contexts) [103.924204] Starting subtest: basic-contexts [106.405442] Subtest basic-contexts: SUCCESS (2.480s) [106.602990] [014/156] (897s left) gem_eio (wait-1us) [106.645827] Starting subtest: wait-1us [106.790653] Subtest wait-1us: SUCCESS (0.145s) [106.924115] [015/156] (896s left) syncobj_timeline (single-wait-available-signaled) [106.957852] Starting subtest: single-wait-available-signaled [106.958562] Subtest single-wait-available-signaled: SUCCESS (0.001s) [107.017517] [016/156] (896s left) sw_sync (sync_busy_fork) [107.050244] Starting subtest: sync_busy_fork [108.074209] Subtest sync_busy_fork: SUCCESS (1.015s) [108.127938] [017/156] (895s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [108.225159] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [108.226805] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [108.307768] [018/156] (895s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move) [108.399239] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move [108.400669] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [108.492519] [019/156] (895s left) gen3_render_tiledx_blits [108.578161] [020/156] (895s left) perf_pmu (rc6-suspend) [108.614146] Starting subtest: rc6-suspend [131.658651] Subtest rc6-suspend: SUCCESS (7.694s) [135.977268] [021/156] (872s left) kms_psr (fbc-pr-basic) [136.081086] Subtest fbc-pr-basic: SKIP (0.000s) [136.119877] [022/156] (872s left) kms_big_fb (x-tiled-8bpp-rotate-90) [136.223557] Starting subtest: x-tiled-8bpp-rotate-90 [136.309412] Subtest x-tiled-8bpp-rotate-90: SKIP (0.083s) [136.403053] [023/156] (871s left) kms_cursor_crc (cursor-dpms) [136.495663] Starting subtest: cursor-dpms [136.496426] Starting dynamic subtest: pipe-A-HDMI-A-1 [137.147747] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.639s) [137.157371] Starting dynamic subtest: pipe-D-HDMI-A-1 [137.768375] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.605s) [137.769239] Subtest cursor-dpms: SUCCESS (1.247s) [137.911516] [024/156] (870s left) gem_ctx_persistence (saturated-hostile-nopreempt) [137.954178] Starting subtest: saturated-hostile-nopreempt [137.954999] Starting dynamic subtest: rcs0 [138.707794] Dynamic subtest rcs0: SUCCESS (0.734s) [138.718178] Starting dynamic subtest: bcs0 [139.471421] Dynamic subtest bcs0: SUCCESS (0.750s) [139.482000] Starting dynamic subtest: vcs0 [140.222730] Dynamic subtest vcs0: SUCCESS (0.741s) [140.233179] Starting dynamic subtest: vcs1 [140.971525] Dynamic subtest vcs1: SUCCESS (0.739s) [140.982125] Starting dynamic subtest: vecs0 [141.726683] Dynamic subtest vecs0: SUCCESS (0.745s) [141.727546] Subtest saturated-hostile-nopreempt: SUCCESS (3.711s) [141.821677] [025/156] (866s left) kms_cursor_edge_walk (256x256-left-edge) [141.911374] Starting subtest: 256x256-left-edge [141.912905] Starting dynamic subtest: pipe-A-HDMI-A-1 [143.662160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.733s) [143.672318] Starting dynamic subtest: pipe-D-HDMI-A-1 [145.335884] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.660s) [145.336587] Subtest 256x256-left-edge: SUCCESS (3.395s) [145.469072] [026/156] (862s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [145.572478] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [145.573900] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [145.669495] [027/156] (862s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [145.704604] Starting subtest: basic-write-cpu-read-gtt [145.940260] Subtest basic-write-cpu-read-gtt: SUCCESS (0.227s) [146.021212] [028/156] (862s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [146.108984] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [146.109710] Starting dynamic subtest: pipe-A-HDMI-A-1 [146.124423] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [146.132640] Starting dynamic subtest: pipe-B-HDMI-A-1 [146.140029] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [146.148168] Starting dynamic subtest: pipe-C-HDMI-A-1 [146.154946] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [146.162816] Starting dynamic subtest: pipe-D-HDMI-A-1 [146.169981] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [146.171373] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [146.359485] [029/156] (862s left) vgem_basic (create) [146.434385] Starting subtest: create [146.435180] Subtest create: SUCCESS (0.000s) [146.499032] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true [146.500951] [030/156] (861s left) kms_setmode (invalid-clone-exclusive-crtc) [146.534193] Starting subtest: invalid-clone-exclusive-crtc [146.536291] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [146.613777] [031/156] (861s left) gem_exec_gttfill (basic) [146.657524] Starting subtest: basic [150.510169] Subtest basic: SUCCESS (3.834s) [150.695785] [032/156] (857s left) gem_exec_balancer (hog) [150.799801] Starting subtest: hog [152.188483] Subtest hog: SUCCESS (1.375s) [152.384850] [033/156] (856s left) gem_exec_reloc (basic-wc-read-active) [152.425623] Starting subtest: basic-wc-read-active [152.554064] Subtest basic-wc-read-active: SUCCESS (0.120s) [152.695247] [034/156] (855s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite) [152.793495] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite [152.794955] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [152.881674] [035/156] (855s left) gem_exec_schedule (preempt) [152.936481] Starting subtest: preempt [152.937263] Starting dynamic subtest: rcs0 [152.956086] Dynamic subtest rcs0: SUCCESS (0.019s) [152.965147] Starting dynamic subtest: bcs0 [152.976591] Dynamic subtest bcs0: SUCCESS (0.020s) [152.986699] Starting dynamic subtest: vcs0 [152.995959] Dynamic subtest vcs0: SUCCESS (0.019s) [153.006337] Starting dynamic subtest: vcs1 [153.015492] Dynamic subtest vcs1: SUCCESS (0.019s) [153.025005] Starting dynamic subtest: vecs0 [153.035953] Dynamic subtest vecs0: SUCCESS (0.020s) [153.036733] Subtest preempt: SUCCESS (0.099s) [153.346712] [036/156] (855s left) kms_addfb_basic (small-bo) [153.435782] Starting subtest: small-bo [153.436520] Subtest small-bo: SUCCESS (0.000s) [153.535533] [037/156] (855s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render) [153.630433] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render [153.631832] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [153.739034] [038/156] (855s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [153.779407] Starting subtest: mixed-tiled-to-y-tiled-ccs [153.780168] Starting dynamic subtest: smem [153.893312] Dynamic subtest smem: SUCCESS (0.113s) [153.894059] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.114s) [154.081101] [039/156] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [154.173841] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [154.175202] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [154.271660] [040/156] (854s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [154.363590] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu [154.364998] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [154.464473] [041/156] (854s left) gem_exec_params (sol-reset-not-gen7) [154.503151] Starting subtest: sol-reset-not-gen7 [154.504842] Subtest sol-reset-not-gen7: SUCCESS (0.001s) [154.624206] [042/156] (854s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [154.713417] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [154.714918] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [154.770026] [043/156] (854s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff) [154.867575] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff [154.868946] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [154.973338] [044/156] (854s left) gem_ctx_param (invalid-ctx-set) [155.007804] Starting subtest: invalid-ctx-set [155.008529] Subtest invalid-ctx-set: SUCCESS (0.000s) [155.064696] [045/156] (854s left) gem_pwrite (basic-self) [155.098889] Starting subtest: basic-self [155.137534] Subtest basic-self: SUCCESS (0.039s) [155.231837] [046/156] (853s left) perf_pmu (busy-accuracy-50) [155.269348] Starting subtest: busy-accuracy-50 [155.270095] Starting dynamic subtest: rcs0 [156.793825] Dynamic subtest rcs0: SUCCESS (1.518s) [156.805453] Starting dynamic subtest: bcs0 [158.316615] Dynamic subtest bcs0: SUCCESS (1.520s) [158.326613] Starting dynamic subtest: vcs0 [159.840273] Dynamic subtest vcs0: SUCCESS (1.521s) [159.851783] Starting dynamic subtest: vcs1 [161.364578] Dynamic subtest vcs1: SUCCESS (1.521s) [161.374246] Starting dynamic subtest: vecs0 [162.887188] Dynamic subtest vecs0: SUCCESS (1.520s) [162.888185] Subtest busy-accuracy-50: SUCCESS (7.602s) [162.952980] [047/156] (846s left) i915_hangman (engine-error-state-capture) [163.001586] Starting subtest: engine-error-state-capture [163.002313] Starting dynamic subtest: rcs0 [166.733065] Dynamic subtest rcs0: SUCCESS (3.727s) [166.744606] Starting dynamic subtest: bcs0 [170.703692] Dynamic subtest bcs0: SUCCESS (3.970s) [170.715297] Starting dynamic subtest: vcs0 [174.740319] Dynamic subtest vcs0: SUCCESS (4.036s) [174.749015] Starting dynamic subtest: vcs1 [178.703885] Dynamic subtest vcs1: SUCCESS (3.962s) [178.714470] Starting dynamic subtest: vecs0 [182.737780] Dynamic subtest vecs0: SUCCESS (4.032s) [182.738884] Subtest engine-error-state-capture: SUCCESS (19.731s) [182.808478] [048/156] (826s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt) [182.903570] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt [182.904987] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [183.005733] [049/156] (826s left) gem_exec_schedule (semaphore-noskip) [183.052096] Starting subtest: semaphore-noskip [183.364353] Subtest semaphore-noskip: SUCCESS (0.303s) [183.658889] [050/156] (825s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [183.751419] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [183.761068] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.009s) [183.829820] [051/156] (825s left) dmabuf_sync_file (import-multiple-read-write) [183.866918] Starting subtest: import-multiple-read-write [183.871384] Subtest import-multiple-read-write: SUCCESS (0.005s) [183.945925] [052/156] (825s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [183.979421] Starting subtest: invalid-multi-wait-all-unsubmitted [183.980161] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [184.050974] [053/156] (825s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc) [184.142592] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc [184.144083] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [184.237726] [054/156] (825s left) kms_pm_dc (dc6-dpms) [185.333485] Starting subtest: dc6-dpms [188.700261] Subtest dc6-dpms: FAIL (3.350s) [188.799417] [055/156] (820s left) kms_content_protection (dp-mst-type-0-hdcp14) [188.898662] Starting subtest: dp-mst-type-0-hdcp14 [188.900153] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [189.000771] [056/156] (820s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [189.092381] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [189.093803] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [189.192165] [057/156] (820s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [189.280522] Starting subtest: addfb25-yf-tiled-legacy [189.281239] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [189.392273] [058/156] (820s left) i915_drm_fdinfo (virtual-busy-hang) [189.429193] Starting subtest: virtual-busy-hang [194.617043] Subtest virtual-busy-hang: SUCCESS (5.186s) [194.686957] [059/156] (814s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [194.720825] Starting subtest: multi-wait-all-for-submit-available-submitted [194.721592] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [194.792308] [060/156] (814s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [194.882516] Starting subtest: addfb25-framebuffer-vs-set-tiling [194.883243] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [194.987467] [061/156] (814s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [195.075952] Starting subtest: primary-y-tiled-reflect-x-270 [199.628169] Subtest primary-y-tiled-reflect-x-270: SUCCESS (4.551s) [199.830790] [062/156] (809s left) gem_ctx_engines (invalid-engines) [199.874524] Starting subtest: invalid-engines [199.879415] Subtest invalid-engines: SUCCESS (0.005s) [200.066218] [063/156] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [200.159319] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [200.160710] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [200.255702] [064/156] (809s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [200.343995] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [200.345641] Starting dynamic subtest: pipe-A-valid-mode [201.140133] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.794s) [201.140858] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.796s) [201.288196] [065/156] (808s left) gem_ctx_shared (q-out-order) [201.333324] Starting subtest: Q-out-order [201.334055] Starting dynamic subtest: rcs0 [201.382365] Dynamic subtest rcs0: SUCCESS (0.048s) [201.396264] Starting dynamic subtest: bcs0 [201.433471] Dynamic subtest bcs0: SUCCESS (0.050s) [201.450012] Starting dynamic subtest: vcs0 [201.491286] Dynamic subtest vcs0: SUCCESS (0.057s) [201.505805] Starting dynamic subtest: vcs1 [201.544567] Dynamic subtest vcs1: SUCCESS (0.052s) [201.558126] Starting dynamic subtest: vecs0 [201.594948] Dynamic subtest vecs0: SUCCESS (0.049s) [201.596123] Subtest Q-out-order: SUCCESS (0.262s) [201.789641] [066/156] (808s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [201.879893] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [201.881335] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [202.043894] [067/156] (807s left) gem_userptr_blits (access-control) [202.101604] Starting subtest: access-control [202.103164] Subtest access-control: SKIP (0.000s) [202.231546] [068/156] (807s left) api_intel_allocator (simple-allocator) [202.266569] Starting subtest: simple-allocator [202.267303] Starting dynamic subtest: basic [202.269096] Dynamic subtest basic: SUCCESS (0.003s) [202.279948] Starting dynamic subtest: parallel-one [202.452236] Dynamic subtest parallel-one: SUCCESS (0.176s) [202.461959] Starting dynamic subtest: print [202.462766] Dynamic subtest print: SUCCESS (0.000s) [202.471768] Starting dynamic subtest: reuse [202.472551] Dynamic subtest reuse: SUCCESS (0.000s) [202.481940] Starting dynamic subtest: reserve [202.482672] Dynamic subtest reserve: SUCCESS (0.000s) [202.493568] Starting dynamic subtest: fork-reopen-allocator [202.494322] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [202.495068] Subtest simple-allocator: SUCCESS (0.196s) [202.528198] [069/156] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [202.622069] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [202.623509] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [202.698793] [070/156] (807s left) gem_mmap_wc (write-cpu-read-wc) [202.734261] Starting subtest: write-cpu-read-wc [202.810861] Subtest write-cpu-read-wc: SUCCESS (0.077s) [202.891975] [071/156] (807s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [202.981305] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [202.982820] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [203.043007] [072/156] (807s left) kms_chamelium_frames (dp-crc-multiple) [203.181675] Subtest dp-crc-multiple: SKIP (0.000s) [203.281241] [073/156] (806s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [203.396981] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [203.398361] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [203.501305] [074/156] (806s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [203.600203] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [204.211915] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.611s) [204.356775] [075/156] (805s left) gem_exec_fence (submit-chain) [204.532799] Starting subtest: submit-chain [204.543313] Subtest submit-chain: SUCCESS (0.015s) [205.001053] [076/156] (805s left) kms_psr (pr-sprite-blt) [205.092672] Subtest pr-sprite-blt: SKIP (0.000s) [205.136729] [077/156] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [205.228479] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [205.229890] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [205.335229] [078/156] (805s left) syncobj_eventfd (binary-wait-before-signal) [205.371336] Starting subtest: binary-wait-before-signal [205.402746] Subtest binary-wait-before-signal: SUCCESS (0.031s) [205.478383] [079/156] (805s left) kms_flip (2x-plain-flip-fb-recreate) [205.566570] Starting subtest: 2x-plain-flip-fb-recreate [205.575357] Subtest 2x-plain-flip-fb-recreate: SKIP (0.009s) [205.641701] [080/156] (804s left) perf (invalid-open-flags) [205.738854] Starting subtest: invalid-open-flags [205.739646] Subtest invalid-open-flags: SUCCESS (0.000s) [205.782748] [081/156] (804s left) gem_media_fill (media-fill) [205.822564] Starting subtest: media-fill [205.823674] Starting dynamic subtest: smem [205.827976] Dynamic subtest smem: SUCCESS (0.005s) [205.828669] Subtest media-fill: SUCCESS (0.006s) [206.052716] [082/156] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [206.143486] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [206.144913] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [206.260784] [083/156] (804s left) gem_ccs (block-multicopy-inplace) [206.299671] Starting subtest: block-multicopy-inplace [206.301225] Subtest block-multicopy-inplace: SKIP (0.000s) [206.359222] [084/156] (804s left) kms_flip (flip-vs-absolute-wf_vblank) [206.446689] Starting subtest: flip-vs-absolute-wf_vblank [206.449701] Starting dynamic subtest: A-HDMI-A1 [214.290694] Dynamic subtest A-HDMI-A1: SUCCESS (7.819s) [214.299339] Starting dynamic subtest: B-HDMI-A1 [222.105768] Dynamic subtest B-HDMI-A1: SUCCESS (7.801s) [222.113843] Starting dynamic subtest: C-HDMI-A1 [229.886658] Dynamic subtest C-HDMI-A1: SUCCESS (7.801s) [229.896795] Starting dynamic subtest: D-HDMI-A1 [237.778218] Dynamic subtest D-HDMI-A1: SUCCESS (7.892s) [237.778993] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.324s) [237.940298] [085/156] (772s left) kms_getfb (getfb2-handle-not-fb) [238.035095] Starting subtest: getfb2-handle-not-fb [238.035933] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [238.140278] [086/156] (772s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [238.228903] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [238.230570] Starting dynamic subtest: pipe-A-HDMI-A-1 [239.063841] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.831s) [239.075612] Starting dynamic subtest: pipe-B-HDMI-A-1 [239.464335] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.398s) [239.480585] Starting dynamic subtest: pipe-C-HDMI-A-1 [239.882240] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.414s) [239.899790] Starting dynamic subtest: pipe-D-HDMI-A-1 [240.293590] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.408s) [240.294600] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.063s) [240.512782] [087/156] (770s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [240.610015] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [241.867412] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.259s) [241.978787] [088/156] (768s left) gen9_exec_parse (cmd-crossing-page) [242.016985] Subtest cmd-crossing-page: SKIP (0.000s) [242.057456] [089/156] (768s left) i915_pm_rc6_residency (rc6-accuracy) [242.091168] Starting subtest: rc6-accuracy [242.092010] Starting dynamic subtest: gt0 [245.294663] Dynamic subtest gt0: SUCCESS (3.169s) [245.295655] Subtest rc6-accuracy: SUCCESS (3.171s) [245.345888] [090/156] (765s left) kms_flip (flip-vs-rmfb-interruptible) [245.441446] Starting subtest: flip-vs-rmfb-interruptible [245.444330] Starting dynamic subtest: A-HDMI-A1 [253.086788] Dynamic subtest A-HDMI-A1: SUCCESS (7.643s) [253.103724] Starting dynamic subtest: B-HDMI-A1 [260.720967] Dynamic subtest B-HDMI-A1: SUCCESS (7.632s) [260.738376] Starting dynamic subtest: C-HDMI-A1 [268.356907] Dynamic subtest C-HDMI-A1: SUCCESS (7.633s) [268.372850] Starting dynamic subtest: D-HDMI-A1 [275.993806] Dynamic subtest D-HDMI-A1: SUCCESS (7.633s) [275.998458] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.558s) [276.161601] [091/156] (734s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [276.259579] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [277.437137] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.177s) [277.557990] [092/156] (733s left) syncobj_wait (wait-any-snapshot) [277.593740] Starting subtest: wait-any-snapshot [277.676309] Subtest wait-any-snapshot: SUCCESS (0.082s) [277.751753] [093/156] (733s left) gem_mmap_gtt (basic-small-bo) [277.785835] Starting subtest: basic-small-bo [277.973769] Subtest basic-small-bo: SUCCESS (0.188s) [278.086997] [094/156] (733s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [278.235394] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [278.236168] Starting dynamic subtest: pipe-A-HDMI-A-1 [278.243224] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [278.252306] Starting dynamic subtest: pipe-B-HDMI-A-1 [278.259741] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [278.268756] Starting dynamic subtest: pipe-C-HDMI-A-1 [278.275844] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [278.284306] Starting dynamic subtest: pipe-D-HDMI-A-1 [278.291440] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [278.292871] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s) [278.495702] [095/156] (732s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [278.587269] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [278.588003] Starting dynamic subtest: pipe-A [278.726785] Dynamic subtest pipe-A: SUCCESS (0.139s) [278.737483] Starting dynamic subtest: pipe-B [278.861361] Dynamic subtest pipe-B: SUCCESS (0.133s) [278.872000] Starting dynamic subtest: pipe-C [279.003995] Dynamic subtest pipe-C: SUCCESS (0.142s) [279.014447] Starting dynamic subtest: pipe-D [279.138147] Dynamic subtest pipe-D: SUCCESS (0.133s) [279.138890] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.552s) [279.337400] [096/156] (731s left) kms_plane_cursor (overlay) [279.429261] Starting subtest: overlay [279.430836] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [280.748312] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.317s) [280.795778] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [282.107048] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.324s) [282.156023] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [283.457463] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.316s) [283.550262] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [284.893912] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.353s) [284.927574] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [286.302823] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.383s) [286.337506] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [287.636481] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.308s) [287.715089] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [289.213772] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.506s) [289.254217] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [290.589349] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.350s) [290.623590] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [291.939480] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.325s) [292.025529] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64 [293.372180] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.355s) [293.407034] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128 [294.705920] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.308s) [294.740963] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256 [296.047928] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.317s) [296.125872] Subtest overlay: SUCCESS (16.693s) [296.263960] [097/156] (714s left) kms_chamelium_hpd (vga-hpd-after-suspend) [296.434510] Subtest vga-hpd-after-suspend: SKIP (0.000s) [296.540283] [098/156] (714s left) gem_exec_flush (basic-batch-kernel-default-wb) [296.587288] Starting subtest: basic-batch-kernel-default-wb [302.197197] Subtest basic-batch-kernel-default-wb: SUCCESS (5.609s) [302.400686] [099/156] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [302.498666] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [302.500094] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [302.589828] [100/156] (708s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [302.685326] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [302.686816] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [302.771478] [101/156] (708s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [302.865118] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [302.866527] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [302.968159] [102/156] (708s left) gem_partial_pwrite_pread (write-snoop) [303.007998] Starting subtest: write-snoop [313.293357] Subtest write-snoop: SUCCESS (10.284s) [313.407038] [103/156] (698s left) kms_prime (basic-crc-vgem) [313.519735] Starting subtest: basic-crc-vgem [313.520483] Starting dynamic subtest: second-to-first [314.215563] Dynamic subtest second-to-first: SUCCESS (0.696s) [314.216628] Subtest basic-crc-vgem: SUCCESS (0.697s) [314.321856] [104/156] (697s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [314.418550] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [314.420038] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [314.523209] [105/156] (697s left) gem_vm_create (execbuf) [314.563004] Starting subtest: execbuf [314.565932] Subtest execbuf: SUCCESS (0.004s) [314.689456] [106/156] (696s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt) [314.782218] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt [314.783616] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [314.877244] [107/156] (696s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [314.913240] Starting subtest: etime-multi-wait-available-unsubmitted [315.016634] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s) [315.099156] [108/156] (696s left) kms_lease (lease-invalid-connector) [315.189422] Starting subtest: lease-invalid-connector [315.190198] Starting dynamic subtest: pipe-A-HDMI-A-1 [315.190977] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [315.200499] Starting dynamic subtest: pipe-B-HDMI-A-1 [315.201241] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [315.210317] Starting dynamic subtest: pipe-C-HDMI-A-1 [315.211030] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [315.219950] Starting dynamic subtest: pipe-D-HDMI-A-1 [315.220663] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [315.221382] Subtest lease-invalid-connector: SUCCESS (0.006s) [315.274062] [109/156] (696s left) gem_exec_fence (concurrent) [315.438259] Starting subtest: concurrent [315.439378] Starting dynamic subtest: rcs0 [315.469825] Dynamic subtest rcs0: SUCCESS (0.030s) [315.487706] Starting dynamic subtest: bcs0 [315.501796] Dynamic subtest bcs0: SUCCESS (0.029s) [315.517747] Starting dynamic subtest: vcs0 [315.533670] Dynamic subtest vcs0: SUCCESS (0.030s) [315.549274] Starting dynamic subtest: vcs1 [315.564544] Dynamic subtest vcs1: SUCCESS (0.029s) [315.579788] Starting dynamic subtest: vecs0 [315.595630] Dynamic subtest vecs0: SUCCESS (0.029s) [315.596597] Subtest concurrent: SUCCESS (0.158s) [316.044912] [110/156] (695s left) prime_mmap (test_forked) [316.080297] Starting subtest: test_forked [316.081043] Starting dynamic subtest: test_forked-smem [316.091220] Dynamic subtest test_forked-smem: SUCCESS (0.011s) [316.092011] Subtest test_forked: SUCCESS (0.012s) [316.212197] [111/156] (695s left) syncobj_wait (invalid-reset-one-illegal-handle) [316.257043] Starting subtest: invalid-reset-one-illegal-handle [316.257993] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [316.311946] [112/156] (695s left) kms_psr (fbc-psr-sprite-mmap-gtt) [316.406853] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [316.449887] [113/156] (695s left) sw_sync (alloc_fence_invalid_timeline) [316.485372] Starting subtest: alloc_fence_invalid_timeline [316.486098] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [316.537527] [114/156] (695s left) gem_exec_gttfill (all-engines) [316.581915] Starting subtest: all-engines [340.207734] Subtest all-engines: SUCCESS (23.619s) [340.406514] [115/156] (671s left) syncobj_wait (invalid-wait-bad-flags) [340.483458] Starting subtest: invalid-wait-bad-flags [340.484326] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [340.556623] [116/156] (671s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [340.657861] Starting subtest: hdr-rgb565-draw-blt [340.659330] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [340.748362] [117/156] (671s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [340.840892] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [340.885522] [118/156] (671s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [340.976110] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [340.977684] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [341.040856] [119/156] (671s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [341.136377] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [341.137861] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [341.233132] [120/156] (671s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [341.326597] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [341.328040] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [341.434282] [121/156] (670s left) syncobj_timeline (reset-unsignaled) [341.470149] Starting subtest: reset-unsignaled [341.470870] Subtest reset-unsignaled: SUCCESS (0.000s) [341.537116] [122/156] (670s left) kms_psr (psr-dpms) [341.627000] Subtest psr-dpms: SKIP (0.000s) [341.670216] [123/156] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [341.768249] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [341.769727] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [341.865009] [124/156] (670s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [341.967686] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [342.561534] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.594s) [342.674556] [125/156] (669s left) gem_softpin (evict-prime-sanity-check) [342.715855] Starting subtest: evict-prime-sanity-check [342.716602] Starting dynamic subtest: rcs0 [343.833777] Dynamic subtest rcs0: SUCCESS (1.117s) [343.851887] Starting dynamic subtest: bcs0 [344.947782] Dynamic subtest bcs0: SUCCESS (1.111s) [344.962459] Starting dynamic subtest: vcs0 [346.064683] Dynamic subtest vcs0: SUCCESS (1.115s) [346.081297] Starting dynamic subtest: vcs1 [347.179829] Dynamic subtest vcs1: SUCCESS (1.113s) [347.198837] Starting dynamic subtest: vecs0 [348.294593] Dynamic subtest vecs0: SUCCESS (1.112s) [348.311455] Starting dynamic subtest: all [349.412720] Dynamic subtest all: SUCCESS (1.116s) [349.413799] Subtest evict-prime-sanity-check: SUCCESS (6.696s) [349.505808] [126/156] (663s left) api_intel_bb (object-reloc-purge-cache) [349.542532] Starting subtest: object-reloc-purge-cache [349.546175] Subtest object-reloc-purge-cache: SUCCESS (0.004s) [349.644472] [127/156] (662s left) kms_invalid_mode (int-max-clock) [349.738768] Starting subtest: int-max-clock [349.739553] Starting dynamic subtest: pipe-A-HDMI-A-1 [349.788694] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s) [349.799031] Starting dynamic subtest: pipe-B-HDMI-A-1 [349.799758] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [349.810228] Starting dynamic subtest: pipe-C-HDMI-A-1 [349.811027] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [349.820090] Starting dynamic subtest: pipe-D-HDMI-A-1 [349.820906] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [349.821613] Subtest int-max-clock: SUCCESS (0.057s) [349.939276] [128/156] (662s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [350.038410] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [350.039810] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [350.148466] [129/156] (662s left) gem_flink_basic (flink-lifetime) [350.184330] Starting subtest: flink-lifetime [350.185051] Subtest flink-lifetime: SUCCESS (0.002s) [350.290259] [130/156] (662s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [350.383462] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [350.384876] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [350.481734] [131/156] (662s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [350.576491] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [350.577946] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [350.673982] [132/156] (662s left) kms_selftest (drm_dp_mst_helper) [350.715008] Starting subtest: drm_dp_mst_helper [350.720331] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [350.795563] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.073s) [350.811050] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [350.875984] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.080s) [350.888229] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [350.976407] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.096s) [350.977177] Subtest drm_dp_mst_helper: SUCCESS (0.261s) [351.123921] [133/156] (661s left) kms_psr (fbc-psr2-cursor-plane-onoff) [351.214849] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s) [351.259021] [134/156] (661s left) i915_query (query-topology-garbage-items) [351.293203] Starting subtest: query-topology-garbage-items [351.293951] Subtest query-topology-garbage-items: SUCCESS (0.000s) [351.356213] [135/156] (661s left) kms_plane (plane-panning-bottom-right-suspend) [351.445661] Starting subtest: plane-panning-bottom-right-suspend [351.448070] Starting dynamic subtest: pipe-A [367.571844] Dynamic subtest pipe-A: SUCCESS (1.599s) [367.585822] Starting dynamic subtest: pipe-B [384.545825] Dynamic subtest pipe-B: SUCCESS (1.540s) [384.546648] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.144s) [392.728737] [136/156] (628s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [392.824225] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [392.825027] Starting dynamic subtest: pipe-A-HDMI-A-1 [392.832357] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [392.841935] Starting dynamic subtest: pipe-B-HDMI-A-1 [392.849365] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [392.858704] Starting dynamic subtest: pipe-C-HDMI-A-1 [392.866024] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [392.875285] Starting dynamic subtest: pipe-D-HDMI-A-1 [392.882207] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [392.883553] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.007s) [393.079167] [137/156] (627s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [393.189176] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [393.190608] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [393.283575] [138/156] (627s left) kms_flip (modeset-vs-vblank-race-interruptible) [393.379369] Starting subtest: modeset-vs-vblank-race-interruptible [393.382413] Starting dynamic subtest: A-HDMI-A1 [396.321724] Dynamic subtest A-HDMI-A1: SUCCESS (2.887s) [396.335681] Starting dynamic subtest: B-HDMI-A1 [399.195468] Dynamic subtest B-HDMI-A1: SUCCESS (2.837s) [399.209913] Starting dynamic subtest: C-HDMI-A1 [402.066430] Dynamic subtest C-HDMI-A1: SUCCESS (2.845s) [402.078796] Starting dynamic subtest: D-HDMI-A1 [404.920439] Dynamic subtest D-HDMI-A1: SUCCESS (2.834s) [404.922773] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.415s) [405.119767] [139/156] (615s left) gem_ctx_isolation (clean) [405.171956] Starting subtest: clean [405.172838] Starting dynamic subtest: rcs0 [405.194560] Dynamic subtest rcs0: SUCCESS (0.023s) [405.204865] Starting dynamic subtest: bcs0 [405.263963] Dynamic subtest bcs0: SUCCESS (0.068s) [405.274535] Starting dynamic subtest: vcs0 [405.323743] Dynamic subtest vcs0: SUCCESS (0.058s) [405.334211] Starting dynamic subtest: vcs1 [405.394170] Dynamic subtest vcs1: SUCCESS (0.069s) [405.405100] Starting dynamic subtest: vecs0 [405.460618] Dynamic subtest vecs0: SUCCESS (0.065s) [405.461364] Subtest clean: SUCCESS (0.289s) [405.641351] [140/156] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [405.736544] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [405.737982] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [405.831899] [141/156] (615s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [405.924573] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [405.925995] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [406.033119] [142/156] (615s left) sysfs_timeslice_duration (idempotent) [406.070747] Starting subtest: idempotent [406.072653] Starting dynamic subtest: vecs0 [406.073326] Dynamic subtest vecs0: SUCCESS (0.001s) [406.082776] Starting dynamic subtest: vcs0 [406.083471] Dynamic subtest vcs0: SUCCESS (0.000s) [406.092618] Starting dynamic subtest: bcs0 [406.093347] Dynamic subtest bcs0: SUCCESS (0.000s) [406.102054] Starting dynamic subtest: rcs0 [406.102787] Dynamic subtest rcs0: SUCCESS (0.000s) [406.111394] Starting dynamic subtest: vcs1 [406.112081] Dynamic subtest vcs1: SUCCESS (0.000s) [406.112764] Subtest idempotent: SUCCESS (0.008s) [406.145899] [143/156] (615s left) gem_lmem_swapping (heavy-verify-random) [406.185372] Subtest heavy-verify-random: SKIP (0.000s) [406.226709] [144/156] (615s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [406.316208] Starting subtest: drrs-dirtyfb-ioctl [406.320305] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [406.417738] [145/156] (614s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [406.507053] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [406.507775] Starting dynamic subtest: pipe-A-valid-mode [407.348829] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.837s) [407.349531] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.839s) [407.491657] [146/156] (613s left) gem_mmap_gtt (flink-race) [407.529561] Starting subtest: flink-race [427.651390] Subtest flink-race: SUCCESS (20.059s) [427.737938] [147/156] (593s left) kms_explicit_fence (multiplane-atomic-fence-wait) [427.839887] Starting subtest: multiplane-atomic-fence-wait [428.059547] Subtest multiplane-atomic-fence-wait: SUCCESS (0.211s) [428.292806] [148/156] (593s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [428.388073] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [428.389484] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [428.502565] [149/156] (593s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [428.593040] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [431.018533] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.425s) [431.165635] [150/156] (590s left) gem_userptr_blits (readonly-unsync) [431.212144] Subtest readonly-unsync: SKIP (0.000s) [431.341996] [151/156] (590s left) kms_cursor_crc (cursor-random-256x256) [431.438429] Starting subtest: cursor-random-256x256 [431.442860] Starting dynamic subtest: pipe-A-HDMI-A-1 [433.361187] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.918s) [433.404689] Starting dynamic subtest: pipe-D-HDMI-A-1 [435.280998] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.887s) [435.281761] Subtest cursor-random-256x256: SUCCESS (3.844s) [435.480107] [152/156] (586s left) kms_big_fb (4-tiled-32bpp-rotate-90) [435.581704] Starting subtest: 4-tiled-32bpp-rotate-90 [435.583096] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s) [435.681453] [153/156] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [435.774464] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [435.775971] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [435.870707] [154/156] (585s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [435.960345] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [436.008309] [155/156] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [436.104128] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [436.105695] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [436.197376] [156/156] (585s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [436.289361] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [436.290906] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [436.395366] 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.