[58.728059] Initializing watchdogs [58.728107] /dev/watchdog0 [58.742890] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.747490] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.749810] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.753174] [001/134] (960s left) kms_getfb (getfb-handle-closed) [58.886590] Starting subtest: getfb-handle-closed [58.888900] Subtest getfb-handle-closed: SUCCESS (0.001s) [59.007088] [002/134] (960s left) gem_close_race (multigpu-basic-threads) [59.072986] Starting subtest: multigpu-basic-threads [59.077459] Subtest multigpu-basic-threads: SKIP (0.000s) [59.310357] [003/134] (960s left) gem_pxp (hw-rejects-pxp-buffer) [59.432200] Starting subtest: hw-rejects-pxp-buffer [59.437029] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [59.558834] [004/134] (959s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [64.590890] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [64.593385] Starting dynamic subtest: pipe-A-eDP-1 [65.381357] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s) [65.389406] Starting dynamic subtest: pipe-B-eDP-1 [66.511761] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s) [66.518520] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.920s) [67.751745] [005/134] (951s left) gem_exec_flush (basic-batch-kernel-default-wb) [67.852437] Starting subtest: basic-batch-kernel-default-wb [75.173634] Subtest basic-batch-kernel-default-wb: SUCCESS (7.321s) [75.372301] [006/134] (944s left) kms_frontbuffer_tracking (pipe-fbc-rte) [75.494047] Starting subtest: pipe-fbc-rte [75.500916] Starting dynamic subtest: pipe-B-eDP-1 [81.039259] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.550s) [81.046418] Subtest pipe-fbc-rte: SUCCESS (5.552s) [83.359944] [007/134] (936s left) sw_sync (alloc_timeline) [83.394522] Starting subtest: alloc_timeline [83.397025] Subtest alloc_timeline: SUCCESS (0.000s) [83.470913] [008/134] (936s left) gem_exec_params (batch-first) [83.533590] Starting subtest: batch-first [83.538061] Subtest batch-first: SUCCESS (0.005s) [83.697321] [009/134] (935s left) gem_mmap_gtt (basic-small-copy) [83.764826] Subtest basic-small-copy: SKIP (0.000s) [83.834873] [010/134] (935s left) kms_universal_plane (universal-plane-pageflip-windowed) [83.933133] Starting subtest: universal-plane-pageflip-windowed [83.935515] Starting dynamic subtest: pipe-A-eDP-1 [84.522631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s) [84.531150] Starting dynamic subtest: pipe-B-eDP-1 [85.790761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s) [85.799661] Starting dynamic subtest: pipe-C-eDP-1 [87.006519] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s) [87.016223] Starting dynamic subtest: pipe-D-eDP-1 [88.239140] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [88.241509] Subtest universal-plane-pageflip-windowed: SUCCESS (4.307s) [89.086045] [011/134] (930s left) syncobj_eventfd (invalid-illegal-handle) [89.149617] Starting subtest: invalid-illegal-handle [89.151866] Subtest invalid-illegal-handle: SUCCESS (0.000s) [89.273389] [012/134] (930s left) gen9_exec_parse (cmd-crossing-page) [89.340542] Subtest cmd-crossing-page: SKIP (0.000s) [89.401581] [013/134] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [89.502372] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [98.084517] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.583s) [98.203724] [014/134] (921s left) kms_cursor_crc (cursor-sliding-64x21) [98.390497] Starting subtest: cursor-sliding-64x21 [98.447715] Subtest cursor-sliding-64x21: SKIP (0.053s) [98.720190] [015/134] (921s left) kms_psr (pr-cursor-render) [98.809234] Starting subtest: pr-cursor-render [98.813140] Subtest pr-cursor-render: SKIP (0.000s) [98.886093] [016/134] (920s left) kms_flip (nonexisting-fb) [98.986869] Starting subtest: nonexisting-fb [98.988885] Starting dynamic subtest: A-eDP1 [100.127257] Dynamic subtest A-eDP1: SUCCESS (1.142s) [100.136209] Starting dynamic subtest: B-eDP1 [101.261384] Dynamic subtest B-eDP1: SUCCESS (1.134s) [101.270465] Starting dynamic subtest: C-eDP1 [102.393475] Dynamic subtest C-eDP1: SUCCESS (1.132s) [102.400722] Starting dynamic subtest: D-eDP1 [103.530746] Dynamic subtest D-eDP1: SUCCESS (1.136s) [103.533021] Subtest nonexisting-fb: SUCCESS (4.549s) [104.707015] [017/134] (915s left) kms_flip (basic-flip-vs-wf_vblank) [104.805945] Starting subtest: basic-flip-vs-wf_vblank [104.808228] Starting dynamic subtest: A-eDP1 [106.755674] Dynamic subtest A-eDP1: SUCCESS (1.951s) [106.764940] Starting dynamic subtest: B-eDP1 [108.678877] Dynamic subtest B-eDP1: SUCCESS (1.922s) [108.688120] Starting dynamic subtest: C-eDP1 [110.608633] Dynamic subtest C-eDP1: SUCCESS (1.929s) [110.617370] Starting dynamic subtest: D-eDP1 [112.532343] Dynamic subtest D-eDP1: SUCCESS (1.923s) [112.534782] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.731s) [113.785117] [018/134] (906s left) kms_force_connector_basic (prune-stale-modes) [113.881911] Starting subtest: prune-stale-modes [114.195726] Subtest prune-stale-modes: SUCCESS (0.314s) [114.342032] [019/134] (905s left) kms_dirtyfb (default-dirtyfb-ioctl) [114.448188] Starting subtest: default-dirtyfb-ioctl [114.450111] Starting dynamic subtest: A-eDP-1 [116.042680] Dynamic subtest A-eDP-1: SUCCESS (1.595s) [116.045101] Subtest default-dirtyfb-ioctl: SUCCESS (1.596s) [116.884966] [020/134] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [116.994154] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [116.998575] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [117.114430] [021/134] (902s left) gem_ctx_exec (basic-nohangcheck) [117.182697] Starting subtest: basic-nohangcheck [117.459062] Subtest basic-nohangcheck: SUCCESS (0.276s) [117.608807] [022/134] (902s left) syncobj_timeline (wait-zero-handles) [117.664800] Starting subtest: wait-zero-handles [117.666737] Subtest wait-zero-handles: SUCCESS (0.000s) [117.794295] [023/134] (902s left) gem_tiled_pread_basic [117.911059] [024/134] (902s left) kms_atomic_transition (modeset-transition-fencing) [118.000710] Starting subtest: modeset-transition-fencing [118.002967] Starting dynamic subtest: 1x-outputs [128.846948] Dynamic subtest 1x-outputs: SUCCESS (10.847s) [128.849922] Subtest modeset-transition-fencing: SUCCESS (10.847s) [129.723979] [025/134] (890s left) kms_big_fb (y-tiled-16bpp-rotate-180) [129.836263] Starting subtest: y-tiled-16bpp-rotate-180 [129.840514] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [129.962287] [026/134] (890s left) vgem_basic (sysfs) [130.039227] Starting subtest: sysfs [130.041079] Subtest sysfs: SUCCESS (0.000s) [130.103598] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true [130.106720] [027/134] (890s left) gem_close_race (basic-process) [130.200301] Starting subtest: basic-process [130.284403] Subtest basic-process: SUCCESS (0.083s) [130.492019] [028/134] (889s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [130.600274] Starting subtest: fbc-rgb101010-draw-pwrite [135.903658] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.306s) [137.116114] [029/134] (883s left) gem_userptr_blits (unsync-unmap-cycles) [137.190110] Subtest unsync-unmap-cycles: SKIP (0.000s) [137.345593] [030/134] (883s left) gem_exec_schedule (manyslice) [137.422165] Starting subtest: manyslice [137.424441] Starting dynamic subtest: rcs0 [142.017075] Dynamic subtest rcs0: SUCCESS (4.603s) [142.025916] Starting dynamic subtest: bcs0 [148.137683] Dynamic subtest bcs0: SUCCESS (6.120s) [148.147767] Starting dynamic subtest: vcs0 [153.707940] Dynamic subtest vcs0: SUCCESS (5.569s) [153.718937] Starting dynamic subtest: vcs1 [159.277049] Dynamic subtest vcs1: SUCCESS (5.568s) [159.288884] Starting dynamic subtest: vecs0 [164.848596] Dynamic subtest vecs0: SUCCESS (5.570s) [164.856316] Starting dynamic subtest: ccs0 [171.538434] Dynamic subtest ccs0: SUCCESS (6.687s) [171.541587] Subtest manyslice: SUCCESS (34.124s) [171.851648] [031/134] (848s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [171.962904] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [171.965272] Starting dynamic subtest: pipe-A-eDP-1 [171.988705] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [171.997819] Starting dynamic subtest: pipe-B-eDP-1 [172.021778] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [172.029329] Starting dynamic subtest: pipe-C-eDP-1 [172.050658] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [172.057435] Starting dynamic subtest: pipe-D-eDP-1 [172.079327] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [172.083795] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.013s) [174.284549] [032/134] (846s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [174.407310] Starting subtest: cursorB-vs-flipB-legacy [174.411811] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [174.574964] [033/134] (845s left) gem_exec_params (invalid-bsd2-flag-on-render) [174.641378] Starting subtest: invalid-bsd2-flag-on-render [174.643714] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [174.773823] [034/134] (845s left) kms_chamelium_edid (dp-edid-resolution-list) [175.165117] Subtest dp-edid-resolution-list: SKIP (0.000s) [175.961087] [035/134] (844s left) gem_spin_batch (spin-all-new) [176.035051] Starting subtest: spin-all-new [176.052189] Subtest spin-all-new: SUCCESS (0.018s) [178.001235] [036/134] (842s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [178.110091] Starting subtest: flip-primary-invalidate-overlay [189.728042] Subtest flip-primary-invalidate-overlay: SUCCESS (11.620s) [189.921161] [037/134] (830s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [190.020331] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [190.047278] Starting dynamic subtest: pipe-A-plane-0 [190.051182] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [190.059283] Starting dynamic subtest: pipe-A-plane-3 [190.063056] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [190.069580] Starting dynamic subtest: pipe-A-plane-5 [190.073428] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [191.127406] Starting dynamic subtest: pipe-B-plane-0 [191.131464] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [191.138696] Starting dynamic subtest: pipe-B-plane-3 [191.143300] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [191.150482] Starting dynamic subtest: pipe-B-plane-5 [191.154630] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [191.432320] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (1.409s) [192.295186] [038/134] (828s left) kms_dsc (dsc-fractional-bpp-with-bpc) [192.397015] Starting subtest: dsc-fractional-bpp-with-bpc [192.428338] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [192.480759] [039/134] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [192.590268] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [192.594481] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [192.716031] [040/134] (828s left) i915_hangman (gt-engine-error) [192.794646] Starting subtest: gt-engine-error [192.796854] Starting dynamic subtest: rcs0 [193.910036] Dynamic subtest rcs0: SUCCESS (1.115s) [193.919938] Starting dynamic subtest: bcs0 [195.827469] Dynamic subtest bcs0: SUCCESS (1.915s) [195.841729] Starting dynamic subtest: vcs0 [197.874433] Dynamic subtest vcs0: SUCCESS (2.045s) [197.885066] Starting dynamic subtest: vcs1 [199.859475] Dynamic subtest vcs1: SUCCESS (1.983s) [199.869997] Starting dynamic subtest: vecs0 [201.844031] Dynamic subtest vecs0: SUCCESS (1.983s) [201.854949] Starting dynamic subtest: ccs0 [203.890486] Dynamic subtest ccs0: SUCCESS (2.044s) [203.893684] Subtest gt-engine-error: SUCCESS (11.096s) [203.985237] [041/134] (816s left) gem_exec_fence (submit3) [204.175879] Starting subtest: submit3 [204.181054] Subtest submit3: SKIP (0.000s) [205.985603] [042/134] (814s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [206.104184] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [206.108263] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [206.231317] [043/134] (814s left) kms_plane_cursor (overlay) [206.325794] Starting subtest: overlay [206.330124] Starting dynamic subtest: pipe-A-eDP-1-size-64 [208.946514] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.620s) [209.005242] Starting dynamic subtest: pipe-A-eDP-1-size-128 [211.614866] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.615s) [211.672737] Starting dynamic subtest: pipe-A-eDP-1-size-256 [214.249073] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s) [214.609239] Starting dynamic subtest: pipe-B-eDP-1-size-64 [217.915344] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.314s) [217.973520] Starting dynamic subtest: pipe-B-eDP-1-size-128 [220.571545] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s) [220.629929] Starting dynamic subtest: pipe-B-eDP-1-size-256 [223.183968] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s) [223.533944] Starting dynamic subtest: pipe-C-eDP-1-size-64 [226.610053] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.085s) [226.645885] Starting dynamic subtest: pipe-C-eDP-1-size-128 [228.876206] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s) [228.913316] Starting dynamic subtest: pipe-C-eDP-1-size-256 [231.098604] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s) [231.437454] Starting dynamic subtest: pipe-D-eDP-1-size-64 [234.367041] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.940s) [234.404076] Starting dynamic subtest: pipe-D-eDP-1-size-128 [236.612583] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [236.647869] Starting dynamic subtest: pipe-D-eDP-1-size-256 [238.867251] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s) [239.188724] Subtest overlay: SUCCESS (32.860s) [239.979279] [044/134] (781s left) kms_cursor_crc (cursor-rapid-movement-256x85) [240.244047] Starting subtest: cursor-rapid-movement-256x85 [240.291546] Subtest cursor-rapid-movement-256x85: SKIP (0.044s) [240.481519] [045/134] (780s left) syncobj_timeline (invalid-transfer-bad-pad) [240.543532] Starting subtest: invalid-transfer-bad-pad [240.545765] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [240.652211] [046/134] (780s left) syncobj_timeline (wait-all-for-submit-complex) [240.702418] Starting subtest: wait-all-for-submit-complex [240.916919] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [241.001505] [047/134] (780s left) gem_partial_pwrite_pread (writes-after-reads) [241.067892] Subtest writes-after-reads: SKIP (0.000s) [241.149430] [048/134] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [241.255472] Starting subtest: fbcpsr-rgb565-draw-blt [248.185115] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.932s) [248.357282] [049/134] (772s left) gem_blits (basic) [248.424285] Starting subtest: basic [249.780996] Subtest basic: SUCCESS (1.354s) [249.926364] [050/134] (771s left) kms_psr (fbc-psr-primary-mmap-gtt) [250.020203] Starting subtest: fbc-psr-primary-mmap-gtt [250.022547] Starting dynamic subtest: eDP-1 [250.027071] Dynamic subtest eDP-1: SKIP (0.000s) [250.031512] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [250.102256] [051/134] (771s left) gem_madvise (dontneed-after-mmap) [250.146433] Starting subtest: dontneed-after-mmap [250.167845] Subtest dontneed-after-mmap: SUCCESS (0.024s) [250.279969] [052/134] (771s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [250.352777] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [250.356961] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [250.546649] [053/134] (770s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [250.634835] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [257.785631] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.153s) [259.005429] [054/134] (762s left) api_intel_bb (object-noreloc-keep-cache-simple) [259.067779] Starting subtest: object-noreloc-keep-cache-simple [259.070174] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.004s) [259.228469] [055/134] (762s left) kms_pm_rpm (modeset-non-lpsp-stress) [261.075983] Starting subtest: modeset-non-lpsp-stress [262.241040] Subtest modeset-non-lpsp-stress: SKIP (1.167s) [262.628652] [056/134] (758s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [262.731134] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [262.733379] Starting dynamic subtest: pipe-A-eDP-1 [262.755709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [262.765077] Starting dynamic subtest: pipe-B-eDP-1 [262.786226] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [262.793946] Starting dynamic subtest: pipe-C-eDP-1 [262.814688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [262.821632] Starting dynamic subtest: pipe-D-eDP-1 [262.842639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [262.846961] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s) [264.993962] [057/134] (756s left) gem_mmap_gtt (cpuset-medium-copy) [265.060301] Subtest cpuset-medium-copy: SKIP (0.000s) [265.122821] [058/134] (756s left) dmabuf_sync_file (export-basic) [265.168405] Starting subtest: export-basic [265.170595] Subtest export-basic: SUCCESS (0.001s) [265.232821] [059/134] (756s left) gem_eio (context-create) [265.467343] Starting subtest: context-create [265.828399] Subtest context-create: SUCCESS (0.359s) [265.983417] [060/134] (755s left) kms_psr (psr2-sprite-mmap-gtt) [266.078201] Starting subtest: psr2-sprite-mmap-gtt [266.080039] Starting dynamic subtest: eDP-1 [267.547884] Dynamic subtest eDP-1: SKIP (1.466s) [267.552594] Subtest psr2-sprite-mmap-gtt: SKIP (1.468s) [267.743288] [061/134] (753s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [267.844464] Starting subtest: yf-tiled-32bpp-rotate-90 [267.848518] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [267.974072] [062/134] (753s left) kms_3d (basic) [268.031063] Starting subtest: basic [270.044987] Subtest basic: SUCCESS (2.016s) [270.576198] [063/134] (751s left) gem_exec_schedule (promotion) [270.654135] Starting subtest: promotion [270.656438] Starting dynamic subtest: rcs0 [270.739870] Dynamic subtest rcs0: SUCCESS (0.095s) [270.749828] Starting dynamic subtest: vcs0 [270.826232] Dynamic subtest vcs0: SUCCESS (0.086s) [270.835865] Starting dynamic subtest: vcs1 [270.909641] Dynamic subtest vcs1: SUCCESS (0.083s) [270.917623] Starting dynamic subtest: vecs0 [270.992089] Dynamic subtest vecs0: SUCCESS (0.081s) [271.005669] Starting dynamic subtest: ccs0 [271.073839] Dynamic subtest ccs0: SUCCESS (0.082s) [271.076335] Subtest promotion: SUCCESS (0.430s) [272.024804] [064/134] (749s left) perf (gen8-unprivileged-single-ctx-counters) [272.156783] Starting subtest: gen8-unprivileged-single-ctx-counters [272.161223] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [272.208161] [065/134] (749s left) kms_cursor_crc (cursor-onscreen-64x64) [272.390306] Starting subtest: cursor-onscreen-64x64 [272.395304] Starting dynamic subtest: pipe-A-eDP-1 [274.493543] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s) [274.528448] Starting dynamic subtest: pipe-D-eDP-1 [277.283336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s) [277.285643] Subtest cursor-onscreen-64x64: SUCCESS (4.892s) [278.094317] [066/134] (743s left) gem_exec_reloc (basic-gtt-read-noreloc) [278.157639] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [278.222554] [067/134] (743s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [278.317988] Starting subtest: primary-y-tiled-reflect-x-90 [278.322403] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [278.407537] [068/134] (743s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [278.510523] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [278.512635] Starting dynamic subtest: pipe-A-eDP-1 [279.257239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s) [279.266512] Starting dynamic subtest: pipe-B-eDP-1 [281.028244] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.770s) [281.037502] Starting dynamic subtest: pipe-C-eDP-1 [282.877277] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.847s) [282.890956] Starting dynamic subtest: pipe-D-eDP-1 [284.702817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.824s) [284.705136] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.186s) [285.857407] [069/134] (736s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [290.963515] Starting subtest: pr-overlay-plane-move-continuous-sf [290.968090] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s) [291.800945] [070/134] (730s left) kms_rotation_crc (primary-rotation-270) [291.909119] Starting subtest: primary-rotation-270 [291.913493] Subtest primary-rotation-270: SKIP (0.001s) [292.007891] [071/134] (730s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [296.964533] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [296.966852] Starting dynamic subtest: pipe-A-eDP-1 [303.583087] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.615s) [303.592116] Starting dynamic subtest: pipe-B-eDP-1 [310.242082] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s) [310.244424] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.279s) [311.132141] [072/134] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [311.244240] Starting subtest: psr-1p-primscrn-cur-indfb-move [318.641091] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.401s) [318.812074] [073/134] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [318.915906] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [318.920421] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [319.072844] [074/134] (703s left) kms_invalid_mode (bad-vsync-end) [319.178195] Starting subtest: bad-vsync-end [319.180501] Starting dynamic subtest: pipe-A-eDP-1 [319.466937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [319.475360] Starting dynamic subtest: pipe-B-eDP-1 [319.477353] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [319.484933] Starting dynamic subtest: pipe-C-eDP-1 [319.486900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [319.495047] Starting dynamic subtest: pipe-D-eDP-1 [319.497323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [319.499605] Subtest bad-vsync-end: SUCCESS (0.296s) [320.290858] [075/134] (701s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [320.357581] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [320.359958] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [320.478362] [076/134] (701s left) gem_mmap_offset (pf-nonblock) [320.535375] Starting subtest: pf-nonblock [320.539489] Subtest pf-nonblock: SUCCESS (0.006s) [320.685519] [077/134] (701s left) gem_wait (write-wait) [320.754294] Starting subtest: write-wait [320.756609] Starting dynamic subtest: all-engines [321.899861] Dynamic subtest all-engines: SUCCESS (1.145s) [321.915320] Starting dynamic subtest: rcs0 [322.959810] Dynamic subtest rcs0: SUCCESS (1.058s) [322.975113] Starting dynamic subtest: bcs0 [324.020343] Dynamic subtest bcs0: SUCCESS (1.058s) [324.035642] Starting dynamic subtest: vcs0 [325.073600] Dynamic subtest vcs0: SUCCESS (1.051s) [325.089328] Starting dynamic subtest: vcs1 [326.126043] Dynamic subtest vcs1: SUCCESS (1.051s) [326.141189] Starting dynamic subtest: vecs0 [327.179461] Dynamic subtest vecs0: SUCCESS (1.051s) [327.194817] Starting dynamic subtest: ccs0 [328.236901] Dynamic subtest ccs0: SUCCESS (1.055s) [328.239396] Subtest write-wait: SUCCESS (7.484s) [328.447565] [078/134] (693s left) perf_pmu (gt-awake) [328.493827] Starting subtest: gt-awake [336.918927] Subtest gt-awake: SUCCESS (8.424s) [337.038800] [079/134] (685s left) kms_content_protection (suspend-resume) [337.197757] Starting subtest: suspend-resume [337.202345] Subtest suspend-resume: SKIP (0.000s) [337.353600] [080/134] (685s left) api_intel_allocator (simple-allocator) [337.414821] Starting subtest: simple-allocator [337.417116] Starting dynamic subtest: basic [337.419046] Dynamic subtest basic: SUCCESS (0.004s) [337.430479] Starting dynamic subtest: parallel-one [337.610239] Dynamic subtest parallel-one: SUCCESS (0.193s) [337.621114] Starting dynamic subtest: print [337.622921] Dynamic subtest print: SUCCESS (0.000s) [337.631299] Starting dynamic subtest: reuse [337.633441] Dynamic subtest reuse: SUCCESS (0.000s) [337.641388] Starting dynamic subtest: reserve [337.643572] Dynamic subtest reserve: SUCCESS (0.000s) [337.651291] Starting dynamic subtest: fork-reopen-allocator [337.653426] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [337.655646] Subtest simple-allocator: SUCCESS (0.212s) [337.778146] [081/134] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [337.891267] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [337.895497] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [338.009956] [082/134] (684s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [338.119303] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [338.123620] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [338.240595] [083/134] (684s left) prime_mmap (test_correct) [338.308640] Starting subtest: test_correct [338.310586] Starting dynamic subtest: test_correct-smem [338.341035] Dynamic subtest test_correct-smem: SUCCESS (0.034s) [338.343719] Subtest test_correct: SUCCESS (0.035s) [338.452467] [084/134] (684s left) syncobj_wait (multi-wait-all-for-submit-signaled) [338.510613] Starting subtest: multi-wait-all-for-submit-signaled [338.512833] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [338.632889] [085/134] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [338.736081] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [343.236154] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.505s) [344.421446] [086/134] (678s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [344.521265] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [344.525357] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [344.607373] [087/134] (678s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [344.709131] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [344.713621] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [344.792553] [088/134] (678s left) kms_flip (plain-flip-ts-check-interruptible) [344.892630] Starting subtest: plain-flip-ts-check-interruptible [344.894775] Starting dynamic subtest: A-eDP1 [353.766290] Dynamic subtest A-eDP1: SUCCESS (8.871s) [353.775179] Starting dynamic subtest: B-eDP1 [362.598446] Dynamic subtest B-eDP1: SUCCESS (8.830s) [362.608189] Starting dynamic subtest: C-eDP1 [371.417295] Dynamic subtest C-eDP1: SUCCESS (8.817s) [371.426648] Starting dynamic subtest: D-eDP1 [380.249584] Dynamic subtest D-eDP1: SUCCESS (8.831s) [380.254079] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.361s) [381.445815] [089/134] (641s left) gem_mmap_offset (partial-remap) [381.514896] Starting subtest: partial-remap [381.516907] Starting dynamic subtest: smem0 [381.525719] Dynamic subtest smem0: SUCCESS (0.007s) [381.527688] Subtest partial-remap: SUCCESS (0.008s) [381.662838] [090/134] (641s left) perf (sysctl-defaults) [381.755605] Starting subtest: sysctl-defaults [381.757602] Subtest sysctl-defaults: SUCCESS (0.000s) [381.816421] [091/134] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [381.912683] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [386.477291] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.568s) [387.668150] [092/134] (635s left) kms_pm_rpm (basic-rte) [387.704662] Starting subtest: basic-rte [390.648324] Subtest basic-rte: SUCCESS (2.943s) [392.470132] [093/134] (630s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [392.577730] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [392.579965] Starting dynamic subtest: pipe-A-eDP-1 [392.639401] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [392.649321] Starting dynamic subtest: pipe-B-eDP-1 [392.705467] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [392.715177] Starting dynamic subtest: pipe-C-eDP-1 [392.771739] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [392.781375] Starting dynamic subtest: pipe-D-eDP-1 [392.838802] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [392.842975] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.010s) [394.822171] [094/134] (628s left) kms_lease (implicit-plane-lease) [394.922442] Starting subtest: implicit-plane-lease [394.924438] Subtest implicit-plane-lease: SUCCESS (0.003s) [395.054370] [095/134] (628s left) gem_exec_gttfill (engines) [395.128607] Starting subtest: engines [395.130850] Starting dynamic subtest: rcs0 [418.234718] Dynamic subtest rcs0: SUCCESS (23.108s) [418.246527] Starting dynamic subtest: bcs0 [441.576547] Dynamic subtest bcs0: SUCCESS (23.340s) [441.587996] Starting dynamic subtest: vcs0 [464.946048] Dynamic subtest vcs0: SUCCESS (23.366s) [464.957430] Starting dynamic subtest: vcs1 [488.283894] Dynamic subtest vcs1: SUCCESS (23.335s) [488.293830] Starting dynamic subtest: vecs0 [511.607289] Dynamic subtest vecs0: SUCCESS (23.319s) [511.618202] Starting dynamic subtest: ccs0 [534.899274] Dynamic subtest ccs0: SUCCESS (23.288s) [534.901572] Subtest engines: SUCCESS (139.769s) [535.099898] [096/134] (488s left) gem_exec_store (cachelines) [535.203966] Starting subtest: cachelines [535.206363] Starting dynamic subtest: rcs0 [535.312921] Dynamic subtest rcs0: SUCCESS (0.109s) [535.324663] Starting dynamic subtest: bcs0 [535.378216] Dynamic subtest bcs0: SUCCESS (0.063s) [535.389044] Starting dynamic subtest: vcs0 [535.448683] Dynamic subtest vcs0: SUCCESS (0.067s) [535.459747] Starting dynamic subtest: vcs1 [535.510559] Dynamic subtest vcs1: SUCCESS (0.059s) [535.521031] Starting dynamic subtest: vecs0 [535.576817] Dynamic subtest vecs0: SUCCESS (0.067s) [535.587527] Starting dynamic subtest: ccs0 [535.644602] Dynamic subtest ccs0: SUCCESS (0.064s) [535.646969] Subtest cachelines: SUCCESS (0.440s) [535.843290] [097/134] (487s left) kms_big_fb (x-tiled-addfb-size-overflow) [535.960078] Starting subtest: x-tiled-addfb-size-overflow [535.962411] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s) [536.073756] [098/134] (487s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [536.137943] Starting subtest: etime-single-wait-available-unsubmitted [536.241068] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s) [536.341584] [099/134] (486s left) gem_exec_reloc (basic-softpin) [536.399674] Subtest basic-softpin: SKIP (0.000s) [536.461967] [100/134] (486s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [536.569040] Starting subtest: plane-scaler-with-clipping-clamping-rotation [536.571391] Starting dynamic subtest: pipe-A [536.795405] Dynamic subtest pipe-A: SUCCESS (0.229s) [536.804169] Starting dynamic subtest: pipe-B [538.083407] Dynamic subtest pipe-B: SUCCESS (1.287s) [538.092381] Starting dynamic subtest: pipe-C [539.416782] Dynamic subtest pipe-C: SUCCESS (1.333s) [539.426063] Starting dynamic subtest: pipe-D [540.739699] Dynamic subtest pipe-D: SUCCESS (1.322s) [540.742081] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.173s) [541.935874] [101/134] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [542.052417] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [549.548263] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.498s) [549.711519] [102/134] (473s left) gem_ctx_persistence (heartbeat-many) [549.772151] Starting subtest: heartbeat-many [549.776648] Subtest heartbeat-many: SKIP (0.000s) [549.908604] [103/134] (473s left) i915_query (query-topology-garbage-items) [549.962088] Starting subtest: query-topology-garbage-items [549.963969] Subtest query-topology-garbage-items: SUCCESS (0.000s) [550.092300] [104/134] (473s left) prime_vgem (sync) [550.181075] Starting subtest: sync [550.183336] Starting dynamic subtest: rcs0 [550.241841] Dynamic subtest rcs0: SUCCESS (0.061s) [550.250436] Starting dynamic subtest: bcs0 [550.324800] Dynamic subtest bcs0: SUCCESS (0.082s) [550.333310] Starting dynamic subtest: vcs0 [550.372247] Dynamic subtest vcs0: SUCCESS (0.046s) [550.380837] Starting dynamic subtest: vcs1 [550.416631] Dynamic subtest vcs1: SUCCESS (0.043s) [550.424956] Starting dynamic subtest: vecs0 [550.461084] Dynamic subtest vecs0: SUCCESS (0.044s) [550.469390] Starting dynamic subtest: ccs0 [550.504610] Dynamic subtest ccs0: SUCCESS (0.043s) [550.506396] Subtest sync: SUCCESS (0.325s) [550.674627] [105/134] (472s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [550.766017] Starting subtest: plane-upscale-factor-0-25-with-modifiers [550.767803] Starting dynamic subtest: pipe-A [551.102809] Dynamic subtest pipe-A: SUCCESS (0.338s) [551.111190] Starting dynamic subtest: pipe-B [552.547135] Dynamic subtest pipe-B: SUCCESS (1.443s) [552.555557] Starting dynamic subtest: pipe-C [553.980416] Dynamic subtest pipe-C: SUCCESS (1.432s) [553.989310] Starting dynamic subtest: pipe-D [555.400635] Dynamic subtest pipe-D: SUCCESS (1.420s) [555.402941] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.636s) [556.588212] [106/134] (467s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-cpu) [556.692680] Starting subtest: fbc-abgr161616f-draw-mmap-cpu [556.697238] Subtest fbc-abgr161616f-draw-mmap-cpu: SKIP (0.000s) [556.824236] [107/134] (466s left) gem_exec_balancer (persistence) [557.093737] Starting subtest: persistence [557.988120] Subtest persistence: SUCCESS (0.893s) [558.134393] [108/134] (465s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [558.240500] Starting subtest: fbc-2p-pri-indfb-multidraw [558.244863] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [558.356897] [109/134] (465s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [558.453251] Starting subtest: psr-2p-primscrn-cur-indfb-move [558.457660] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [558.563313] [110/134] (465s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [558.664619] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [558.668759] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [558.795768] [111/134] (464s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [558.902661] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [559.771351] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.870s) [559.957054] [112/134] (463s left) gem_create (create-valid-nonaligned) [560.009029] Starting subtest: create-valid-nonaligned [560.011306] Subtest create-valid-nonaligned: SUCCESS (0.000s) [560.202673] [113/134] (463s left) i915_drm_fdinfo (busy-idle) [560.249819] Starting subtest: busy-idle [560.252220] Starting dynamic subtest: rcs0 [560.286068] Dynamic subtest rcs0: SKIP (0.034s) [560.297057] Starting dynamic subtest: bcs0 [560.301347] Dynamic subtest bcs0: SKIP (0.001s) [560.309666] Starting dynamic subtest: vcs0 [560.313761] Dynamic subtest vcs0: SKIP (0.000s) [560.322101] Starting dynamic subtest: vcs1 [560.326405] Dynamic subtest vcs1: SKIP (0.000s) [560.334808] Starting dynamic subtest: vecs0 [560.339178] Dynamic subtest vecs0: SKIP (0.000s) [560.347351] Starting dynamic subtest: ccs0 [560.351837] Dynamic subtest ccs0: SKIP (0.000s) [560.356244] Subtest busy-idle: SKIP (0.042s) [560.392273] [114/134] (463s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [560.523595] Starting subtest: cursorB-vs-flipA-atomic [560.528260] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [560.680347] [115/134] (463s left) gem_softpin (softpin) [560.753824] Starting subtest: softpin [593.150857] Subtest softpin: SUCCESS (32.390s) [593.273880] [116/134] (430s left) gem_set_tiling_vs_blt (tiled-to-untiled) [593.331271] Subtest tiled-to-untiled: SKIP (0.000s) [593.404442] [117/134] (430s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [593.497722] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [593.524159] Starting dynamic subtest: pipe-A-plane-0 [593.528558] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [593.538599] Starting dynamic subtest: pipe-A-plane-3 [593.542908] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [593.551299] Starting dynamic subtest: pipe-A-plane-5 [593.555765] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [594.655564] Starting dynamic subtest: pipe-B-plane-0 [594.659982] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [594.668680] Starting dynamic subtest: pipe-B-plane-3 [594.673247] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [594.681590] Starting dynamic subtest: pipe-B-plane-5 [594.685702] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [594.985856] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (1.487s) [595.852875] [118/134] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [595.965020] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [595.969382] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [596.096480] [119/134] (428s left) kms_big_fb (4-tiled-8bpp-rotate-90) [596.198401] Starting subtest: 4-tiled-8bpp-rotate-90 [596.220033] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s) [596.364479] [120/134] (427s left) kms_color (invalid-ctm-matrix-sizes) [596.469186] Starting subtest: invalid-ctm-matrix-sizes [596.471323] Starting dynamic subtest: pipe-A [596.473237] Dynamic subtest pipe-A: SUCCESS (0.002s) [596.482493] Starting dynamic subtest: pipe-B [596.484752] Dynamic subtest pipe-B: SUCCESS (0.003s) [596.493198] Starting dynamic subtest: pipe-C [596.495455] Dynamic subtest pipe-C: SUCCESS (0.004s) [596.503930] Starting dynamic subtest: pipe-D [596.506185] Dynamic subtest pipe-D: SUCCESS (0.004s) [596.508032] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s) [596.564559] [121/134] (427s left) kms_chamelium_hpd (dp-hpd-after-suspend) [596.961552] Subtest dp-hpd-after-suspend: SKIP (0.000s) [597.741650] [122/134] (426s left) kms_rmfb (close-fd) [597.851767] Starting subtest: close-fd [597.854448] Starting dynamic subtest: pipe-A-eDP-1 [597.957495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [597.967440] Starting dynamic subtest: pipe-B-eDP-1 [599.124437] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s) [599.134091] Starting dynamic subtest: pipe-C-eDP-1 [600.249059] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [600.258127] Starting dynamic subtest: pipe-D-eDP-1 [601.367306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s) [601.369581] Subtest close-fd: SUCCESS (3.520s) [602.585065] [123/134] (421s left) kms_busy (extended-modeset-hang-newfb-with-reset) [602.689594] Starting subtest: extended-modeset-hang-newfb-with-reset [602.691952] Starting dynamic subtest: pipe-A [618.009188] Dynamic subtest pipe-A: SUCCESS (15.315s) [618.017862] Starting dynamic subtest: pipe-D [633.508056] Dynamic subtest pipe-D: SUCCESS (15.497s) [633.510206] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.816s) [634.323172] [124/134] (389s left) perf_pmu (busy-accuracy-50) [634.371545] Starting subtest: busy-accuracy-50 [634.373799] Starting dynamic subtest: rcs0 [635.904379] Dynamic subtest rcs0: SUCCESS (1.530s) [635.916134] Starting dynamic subtest: bcs0 [637.446902] Dynamic subtest bcs0: SUCCESS (1.539s) [637.458017] Starting dynamic subtest: vcs0 [638.989480] Dynamic subtest vcs0: SUCCESS (1.540s) [639.000662] Starting dynamic subtest: vcs1 [640.533070] Dynamic subtest vcs1: SUCCESS (1.541s) [640.542958] Starting dynamic subtest: vecs0 [642.075554] Dynamic subtest vecs0: SUCCESS (1.540s) [642.086038] Starting dynamic subtest: ccs0 [643.626517] Dynamic subtest ccs0: SUCCESS (1.548s) [643.628823] Subtest busy-accuracy-50: SUCCESS (9.254s) [643.951931] [125/134] (380s left) gem_lmem_evict (dontneed-evict-race) [643.998257] Subtest dontneed-evict-race: SKIP (0.000s) [644.047676] [126/134] (380s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [644.146302] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [644.148693] Starting dynamic subtest: pipe-A-eDP-1 [644.158918] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [644.174314] Starting dynamic subtest: pipe-B-eDP-1 [644.183284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [644.191845] Starting dynamic subtest: pipe-C-eDP-1 [644.200397] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [644.209083] Starting dynamic subtest: pipe-D-eDP-1 [644.218175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [644.222918] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.007s) [646.387360] [127/134] (378s left) i915_pm_rpm (system-suspend-devices) [648.025141] Starting subtest: system-suspend-devices [655.801884] Subtest system-suspend-devices: SUCCESS (7.776s) [656.187693] [128/134] (368s left) syncobj_wait (wait-any-complex) [656.256266] Starting subtest: wait-any-complex [656.317061] Subtest wait-any-complex: SUCCESS (0.061s) [656.407245] [129/134] (368s left) kms_vblank (wait-forked) [656.505486] Starting subtest: wait-forked [656.507580] Starting dynamic subtest: pipe-A-eDP-1 [658.315710] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s) [658.331462] Starting dynamic subtest: pipe-D-eDP-1 [660.849968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.531s) [660.852644] Subtest wait-forked: SUCCESS (4.344s) [661.720106] [130/134] (362s left) gem_exec_balancer (noheartbeat) [661.987876] Starting subtest: noheartbeat [661.992619] Subtest noheartbeat: SKIP (0.000s) [662.133250] [131/134] (362s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [662.233207] Starting subtest: fbc-psr2-cursor-mmap-cpu [662.235447] Starting dynamic subtest: eDP-1 [662.239999] Dynamic subtest eDP-1: SKIP (0.000s) [662.244254] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [662.316552] [132/134] (362s left) kms_getfb (getfb2-handle-not-fb) [662.402250] Starting subtest: getfb2-handle-not-fb [662.404519] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [662.519828] [133/134] (362s left) syncobj_wait (wait-for-submit-snapshot) [662.578482] Starting subtest: wait-for-submit-snapshot [662.658594] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [662.744151] [134/134] (361s left) kms_addfb_basic (size-max) [662.843059] Starting subtest: size-max [662.845328] Subtest size-max: SUCCESS (0.000s) [662.973364] Closing watchdogs results: parsing output: 0/ for test: kms_getfb results: parsing output: 1/ for test: gem_close_race results: parsing output: 2/ for test: gem_pxp results: parsing output: 3/ for test: kms_psr2_sf results: parsing output: 4/ for test: gem_exec_flush results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: sw_sync results: parsing output: 7/ for test: gem_exec_params results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: kms_universal_plane results: parsing output: 10/ for test: syncobj_eventfd results: parsing output: 11/ for test: gen9_exec_parse results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: kms_flip results: parsing output: 16/ for test: kms_flip results: parsing output: 17/ for test: kms_force_connector_basic results: parsing output: 18/ for test: kms_dirtyfb results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: gem_ctx_exec results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: gem_tiled_pread_basic results: parsing output: 23/ for test: kms_atomic_transition results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: vgem_basic results: parsing output: 26/ for test: gem_close_race results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_cursor_legacy results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: kms_chamelium_edid results: parsing output: 34/ for test: gem_spin_batch results: parsing output: 35/ for test: kms_psr_stress_test results: parsing output: 36/ for test: kms_plane results: parsing output: 37/ for test: kms_dsc results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: i915_hangman results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_plane_cursor results: parsing output: 43/ for test: kms_cursor_crc results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: gem_partial_pwrite_pread results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_blits results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: gem_madvise results: parsing output: 51/ for test: gem_render_copy results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: api_intel_bb results: parsing output: 54/ for test: kms_pm_rpm results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: dmabuf_sync_file results: parsing output: 58/ for test: gem_eio results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_3d results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: perf results: parsing output: 64/ for test: kms_cursor_crc results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: kms_rotation_crc results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: kms_rotation_crc results: parsing output: 70/ for test: kms_psr2_sf results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_invalid_mode results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: gem_mmap_offset results: parsing output: 76/ for test: gem_wait results: parsing output: 77/ for test: perf_pmu results: parsing output: 78/ for test: kms_content_protection results: parsing output: 79/ for test: api_intel_allocator results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: prime_mmap results: parsing output: 83/ for test: syncobj_wait results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: kms_flip_scaled_crc results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: gem_mmap_offset results: parsing output: 89/ for test: perf results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_pm_rpm results: parsing output: 92/ for test: kms_ccs results: parsing output: 93/ for test: kms_lease results: parsing output: 94/ for test: gem_exec_gttfill results: parsing output: 95/ for test: gem_exec_store results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: kms_plane_scaling results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_ctx_persistence results: parsing output: 102/ for test: i915_query results: parsing output: 103/ for test: prime_vgem results: parsing output: 104/ for test: kms_plane_scaling results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_exec_balancer results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_create results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: gem_set_tiling_vs_blt results: parsing output: 116/ for test: kms_plane results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_color results: parsing output: 120/ for test: kms_chamelium_hpd results: parsing output: 121/ for test: kms_rmfb results: parsing output: 122/ for test: kms_busy results: parsing output: 123/ for test: perf_pmu results: parsing output: 124/ for test: gem_lmem_evict results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: i915_pm_rpm results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: kms_vblank results: parsing output: 129/ for test: gem_exec_balancer results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: kms_getfb results: parsing output: 132/ for test: syncobj_wait results: parsing output: 133/ for test: kms_addfb_basic Done.