[61.082142] Initializing watchdogs [61.082215] /dev/watchdog0 [61.096726] [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] [61.101539] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.103923] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.107348] [001/131] (960s left) syncobj_timeline (wait-any-complex) [61.182081] Starting subtest: wait-any-complex [61.242722] Subtest wait-any-complex: SUCCESS (0.062s) [61.339120] [002/131] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [61.454829] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [61.457248] Starting dynamic subtest: pipe-A-default-mode [61.757511] Dynamic subtest pipe-A-default-mode: SKIP (0.301s) [61.761843] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.303s) [62.598605] [003/131] (959s left) sw_sync (sync_busy_fork_unixsocket) [62.638970] Starting subtest: sync_busy_fork_unixsocket [62.645509] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s) [62.718232] [004/131] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [62.813684] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [69.819906] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.035s) [69.944789] [005/131] (951s left) api_intel_bb (full-batch) [70.003673] Starting subtest: full-batch [70.008195] Subtest full-batch: SUCCESS (0.006s) [70.126605] [006/131] (951s left) kms_plane_cursor (primary) [70.223935] Starting subtest: primary [70.228077] Starting dynamic subtest: pipe-A-eDP-1-size-64 [72.797438] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.579s) [72.824413] Starting dynamic subtest: pipe-A-eDP-1-size-128 [75.395658] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.582s) [75.419038] Starting dynamic subtest: pipe-A-eDP-1-size-256 [77.961387] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s) [78.273261] Starting dynamic subtest: pipe-B-eDP-1-size-64 [81.521966] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.257s) [81.545584] Starting dynamic subtest: pipe-B-eDP-1-size-128 [84.078182] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s) [84.101993] Starting dynamic subtest: pipe-B-eDP-1-size-256 [86.656610] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s) [86.969413] Starting dynamic subtest: pipe-C-eDP-1-size-64 [89.907190] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.946s) [89.932050] Starting dynamic subtest: pipe-C-eDP-1-size-128 [92.163450] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.235s) [92.190715] Starting dynamic subtest: pipe-C-eDP-1-size-256 [94.308569] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.124s) [94.621846] Starting dynamic subtest: pipe-D-eDP-1-size-64 [97.564578] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.950s) [97.590206] Starting dynamic subtest: pipe-D-eDP-1-size-128 [99.709369] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.124s) [99.735021] Starting dynamic subtest: pipe-D-eDP-1-size-256 [101.865577] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s) [102.173805] Subtest primary: SUCCESS (31.956s) [102.992624] [007/131] (918s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [103.072109] Starting subtest: invalid-multi-wait-unsubmitted-signaled [103.074614] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [103.207087] [008/131] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [103.307292] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [110.072488] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.767s) [110.242331] [009/131] (911s left) perf_pmu (faulting-read) [110.282726] Starting subtest: faulting-read [110.285048] Starting dynamic subtest: wb [110.287291] Dynamic subtest wb: SUCCESS (0.001s) [110.295661] Starting dynamic subtest: wc [110.297985] Dynamic subtest wc: SUCCESS (0.000s) [110.306501] Starting dynamic subtest: uc [110.308726] Dynamic subtest uc: SUCCESS (0.000s) [110.310933] Subtest faulting-read: SUCCESS (0.003s) [110.416923] [010/131] (911s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [110.522639] Starting subtest: fbcpsr-rgb101010-draw-render [117.235385] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.714s) [117.369089] [011/131] (904s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [117.471206] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [117.473473] Starting dynamic subtest: pipe-A-eDP-1 [117.482338] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [117.490816] Starting dynamic subtest: pipe-B-eDP-1 [117.499565] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [117.507247] Starting dynamic subtest: pipe-C-eDP-1 [117.515635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [117.523062] Starting dynamic subtest: pipe-D-eDP-1 [117.531379] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [117.535589] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s) [119.747610] [012/131] (902s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [120.149864] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [120.939620] [013/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [121.057563] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [121.061803] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [121.191472] [014/131] (900s left) prime_udl [121.273960] [015/131] (900s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [121.388483] Starting subtest: psr-farfromfence-mmap-gtt [121.392595] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [121.527898] [016/131] (900s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [121.620126] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [121.622372] Starting dynamic subtest: pipe-A-eDP-1 [121.644614] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [121.653577] Starting dynamic subtest: pipe-B-eDP-1 [121.674762] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [121.681838] Starting dynamic subtest: pipe-C-eDP-1 [121.702984] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [121.710041] Starting dynamic subtest: pipe-D-eDP-1 [121.731235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [121.735497] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [123.852126] [017/131] (898s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [123.962461] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [123.964945] Starting dynamic subtest: pipe-A-eDP-1 [123.988121] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [123.998614] Starting dynamic subtest: pipe-B-eDP-1 [124.021134] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [124.029186] Starting dynamic subtest: pipe-C-eDP-1 [124.051052] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [124.059244] Starting dynamic subtest: pipe-D-eDP-1 [124.082464] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [124.086764] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.009s) [126.222933] [018/131] (896s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [126.318642] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [126.323346] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [126.447706] [019/131] (895s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [126.500678] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [126.558012] [020/131] (895s left) gem_exec_schedule (noreorder) [126.728772] Starting subtest: noreorder [126.731660] Starting dynamic subtest: rcs0 [126.807512] Dynamic subtest rcs0: SUCCESS (0.079s) [126.818857] Starting dynamic subtest: vcs0 [127.877687] Dynamic subtest vcs0: SUCCESS (1.067s) [127.888276] Starting dynamic subtest: vcs1 [129.967316] Dynamic subtest vcs1: SUCCESS (2.087s) [129.978691] Starting dynamic subtest: vecs0 [131.905220] Dynamic subtest vecs0: SUCCESS (1.935s) [131.916022] Starting dynamic subtest: ccs0 [131.984942] Dynamic subtest ccs0: SUCCESS (0.079s) [131.987765] Subtest noreorder: SUCCESS (5.258s) [132.196072] [021/131] (890s left) gen7_exec_parse (cmd-crossing-page) [132.264091] Subtest cmd-crossing-page: SKIP (0.000s) [132.335394] [022/131] (890s left) gem_exec_reloc (basic-wc-read-noreloc) [132.388979] Subtest basic-wc-read-noreloc: SKIP (0.000s) [132.464345] [023/131] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [132.561422] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [132.565522] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [132.686870] [024/131] (889s left) syncobj_basic (bad-flags-fd-to-handle) [132.737998] Starting subtest: bad-flags-fd-to-handle [132.740252] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [132.867444] [025/131] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [132.935650] Starting subtest: framebuffer-vs-set-tiling [132.939742] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [133.109525] [026/131] (889s left) kms_sequence (get-busy) [133.198763] Starting subtest: get-busy [133.200509] Starting dynamic subtest: pipe-A-eDP-1 [135.130907] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [135.140705] Starting dynamic subtest: pipe-B-eDP-1 [137.685821] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.554s) [137.695266] Starting dynamic subtest: pipe-C-eDP-1 [140.291441] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s) [140.300535] Starting dynamic subtest: pipe-D-eDP-1 [142.838248] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s) [142.840486] Subtest get-busy: SUCCESS (9.638s) [143.646456] [027/131] (878s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [143.753739] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [143.758171] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [143.877377] [028/131] (878s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [143.930145] Starting subtest: multi-wait-for-submit-available-submitted [143.932721] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [144.062861] [029/131] (878s left) i915_selftest (live) [147.505942] Starting subtest: live [147.508894] Starting dynamic subtest: sanitycheck [152.022491] Dynamic subtest sanitycheck: SUCCESS (4.516s) [152.031944] Starting dynamic subtest: uncore [154.808256] Dynamic subtest uncore: SUCCESS (2.783s) [154.817240] Starting dynamic subtest: workarounds [173.076499] Dynamic subtest workarounds: FAIL (17.689s) [173.087047] Starting dynamic subtest: gt_engines [177.184353] Dynamic subtest gt_engines: SUCCESS (4.682s) [177.193893] Starting dynamic subtest: gt_timelines [195.090320] Dynamic subtest gt_timelines: SUCCESS (17.903s) [195.099357] Starting dynamic subtest: gt_contexts [199.574763] Dynamic subtest gt_contexts: SUCCESS (4.482s) [199.589252] Starting dynamic subtest: gt_lrc [205.833794] Dynamic subtest gt_lrc: SUCCESS (6.257s) [205.847947] Starting dynamic subtest: gt_mocs [210.365207] Dynamic subtest gt_mocs: SUCCESS (4.529s) [210.374678] Starting dynamic subtest: gt_pm [217.211670] Dynamic subtest gt_pm: SUCCESS (6.845s) [217.220711] Starting dynamic subtest: gt_heartbeat [221.634295] Dynamic subtest gt_heartbeat: SUCCESS (4.420s) [221.643187] Starting dynamic subtest: gt_tlb [231.175245] Dynamic subtest gt_tlb: SUCCESS (9.538s) [231.183516] Starting dynamic subtest: requests [245.158572] Dynamic subtest requests: SUCCESS (13.981s) [245.167894] Starting dynamic subtest: migrate [253.255242] Dynamic subtest migrate: SUCCESS (8.094s) [253.264270] Starting dynamic subtest: active [257.749061] Dynamic subtest active: SUCCESS (4.491s) [257.758198] Starting dynamic subtest: objects [262.596386] Dynamic subtest objects: SUCCESS (4.846s) [262.603519] Starting dynamic subtest: mman [267.509344] Dynamic subtest mman: SUCCESS (4.910s) [267.519197] Starting dynamic subtest: dmabuf [271.915071] Dynamic subtest dmabuf: SUCCESS (4.404s) [271.928701] Starting dynamic subtest: vma [276.385335] Dynamic subtest vma: SUCCESS (4.468s) [276.394434] Starting dynamic subtest: coherency [280.184350] Dynamic subtest coherency: SUCCESS (3.796s) [280.193676] Starting dynamic subtest: gtt [292.247756] Dynamic subtest gtt: SUCCESS (12.061s) [292.256746] Starting dynamic subtest: gem [300.726756] Dynamic subtest gem: SUCCESS (8.477s) [300.735959] Starting dynamic subtest: evict [306.348263] Dynamic subtest evict: SUCCESS (5.620s) [306.355971] Starting dynamic subtest: hugepages [317.473639] Dynamic subtest hugepages: SUCCESS (11.122s) [317.482994] Starting dynamic subtest: gem_contexts [346.753325] Dynamic subtest gem_contexts: SUCCESS (29.277s) [346.768868] Starting dynamic subtest: client [351.240387] Dynamic subtest client: SUCCESS (4.484s) [351.249369] Starting dynamic subtest: gem_migrate [355.735151] Dynamic subtest gem_migrate: SUCCESS (4.493s) [355.749567] Starting dynamic subtest: reset [358.647974] Dynamic subtest reset: SUCCESS (2.911s) [358.662299] Starting dynamic subtest: memory_region [363.165436] Dynamic subtest memory_region: SUCCESS (4.515s) [363.175394] Starting dynamic subtest: hangcheck [376.542616] Dynamic subtest hangcheck: SUCCESS (13.375s) [376.551690] Starting dynamic subtest: execlists [381.018417] Dynamic subtest execlists: SUCCESS (4.474s) [381.027403] Starting dynamic subtest: ring_submission [385.529976] Dynamic subtest ring_submission: SUCCESS (4.509s) [385.539027] Starting dynamic subtest: perf [390.011253] Dynamic subtest perf: SUCCESS (4.479s) [390.025657] Starting dynamic subtest: slpc [404.232679] Dynamic subtest slpc: SUCCESS (14.218s) [404.241916] Starting dynamic subtest: guc [408.282251] Dynamic subtest guc: SUCCESS (4.048s) [408.291295] Starting dynamic subtest: guc_multi_lrc [412.730952] Dynamic subtest guc_multi_lrc: SUCCESS (4.447s) [412.739679] Starting dynamic subtest: guc_hang [417.764846] Dynamic subtest guc_hang: SUCCESS (5.031s) [417.773850] Starting dynamic subtest: late_gt_pm [422.183966] Dynamic subtest late_gt_pm: SUCCESS (4.417s) [422.186655] Subtest live: FAIL (274.667s) [422.214835] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [422.218142] [030/131] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [423.841967] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [423.846700] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [423.958148] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true [423.961868] [031/131] (598s left) kms_cursor_crc (cursor-offscreen-32x10) [424.133431] Starting subtest: cursor-offscreen-32x10 [424.185561] Subtest cursor-offscreen-32x10: SKIP (0.048s) [424.445592] [032/131] (598s left) i915_pm_freq_api (freq-suspend) [424.517532] Starting subtest: freq-suspend [424.519823] Starting dynamic subtest: gt0 [441.399435] Dynamic subtest gt0: SUCCESS (5.026s) [441.410115] Starting dynamic subtest: gt1 [457.413524] Dynamic subtest gt1: SUCCESS (1.269s) [457.415738] Subtest freq-suspend: SUCCESS (6.300s) [458.513810] [033/131] (565s left) api_intel_allocator (reopen) [458.571725] Starting subtest: reopen [458.574469] Subtest reopen: SUCCESS (0.005s) [458.739165] [034/131] (565s left) gem_ctx_persistence (engines-mixed) [458.811836] Starting subtest: engines-mixed [458.814734] Starting dynamic subtest: rcs0 [458.933116] Dynamic subtest rcs0: SUCCESS (0.125s) [458.944201] Starting dynamic subtest: bcs0 [459.018096] Dynamic subtest bcs0: SUCCESS (0.086s) [459.028930] Starting dynamic subtest: vcs0 [459.104012] Dynamic subtest vcs0: SUCCESS (0.087s) [459.115044] Starting dynamic subtest: vcs1 [459.169443] Dynamic subtest vcs1: SUCCESS (0.065s) [459.180300] Starting dynamic subtest: vecs0 [459.250756] Dynamic subtest vecs0: SUCCESS (0.082s) [459.261962] Starting dynamic subtest: ccs0 [459.326072] Dynamic subtest ccs0: SUCCESS (0.075s) [459.328761] Subtest engines-mixed: SUCCESS (0.533s) [459.423839] [035/131] (564s left) gem_eio (in-flight-internal-1us) [459.589846] Starting subtest: in-flight-internal-1us [461.542922] Subtest in-flight-internal-1us: SUCCESS (2.010s) [461.723234] [036/131] (562s left) i915_pm_freq_mult (media-freq) [461.781786] Starting subtest: media-freq [461.784651] Starting dynamic subtest: gt0 [461.789571] Dynamic subtest gt0: SKIP (0.000s) [461.798703] Starting dynamic subtest: gt1 [461.803464] Dynamic subtest gt1: SKIP (0.000s) [461.808201] Subtest media-freq: SKIP (0.001s) [461.926186] [037/131] (562s left) gem_fenced_exec_thrash (too-many-fences) [461.983701] Subtest too-many-fences: SKIP (0.000s) [462.054051] [038/131] (561s left) gem_exec_balancer (invalid-balancer) [462.108247] Starting subtest: invalid-balancer [462.983145] Subtest invalid-balancer: SUCCESS (0.893s) [463.319676] [039/131] (560s left) gem_ccs (block-multicopy-compressed) [463.374199] Starting subtest: block-multicopy-compressed [463.378626] Subtest block-multicopy-compressed: SKIP (0.000s) [463.510038] [040/131] (560s left) kms_lease (setcrtc-implicit-plane) [463.605290] Starting subtest: setcrtc-implicit-plane [463.607643] Starting dynamic subtest: pipe-A-eDP-1 [464.095236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s) [464.107661] Starting dynamic subtest: pipe-B-eDP-1 [465.205183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s) [465.217507] Starting dynamic subtest: pipe-C-eDP-1 [466.295400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s) [466.305481] Starting dynamic subtest: pipe-D-eDP-1 [467.417957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [467.420465] Subtest setcrtc-implicit-plane: SUCCESS (3.873s) [468.278518] [041/131] (555s left) kms_pm_rpm (basic-rte) [468.320334] Starting subtest: basic-rte [471.323642] Subtest basic-rte: SUCCESS (3.032s) [472.836316] [042/131] (551s left) gem_exec_whisper (basic-fds-priority-all) [472.900755] Starting subtest: basic-fds-priority-all [496.967935] Subtest basic-fds-priority-all: SUCCESS (24.105s) [497.178180] [043/131] (527s left) syncobj_wait (wait-for-submit-delayed-submit) [497.248695] Starting subtest: wait-for-submit-delayed-submit [497.349200] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [497.458755] [044/131] (526s left) kms_flip (2x-flip-vs-rmfb) [497.565841] Starting subtest: 2x-flip-vs-rmfb [497.577622] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [497.718944] [045/131] (526s left) gem_exec_alignment (single) [497.801520] Starting subtest: single [497.807364] Subtest single: SUCCESS (0.004s) [497.977590] [046/131] (526s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [498.083763] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [498.088733] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [498.229296] [047/131] (526s left) kms_psr (psr-dpms) [498.327513] Starting subtest: psr-dpms [498.329607] Starting dynamic subtest: eDP-1 [501.307201] Dynamic subtest eDP-1: SUCCESS (2.978s) [501.309924] Subtest psr-dpms: SUCCESS (2.979s) [502.184059] [048/131] (522s left) dumb_buffer (invalid-bpp) [502.235531] Starting subtest: invalid-bpp [502.238153] Subtest invalid-bpp: SUCCESS (0.000s) [502.367061] [049/131] (522s left) gem_ctx_param (basic-default) [502.428679] Starting subtest: basic-default [502.431610] Subtest basic-default: SUCCESS (0.000s) [502.535914] [050/131] (522s left) syncobj_timeline (invalid-signal-zero-handles) [502.598920] Starting subtest: invalid-signal-zero-handles [502.601353] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [502.731531] [051/131] (521s left) gem_pxp (hw-rejects-pxp-context) [502.855697] Starting subtest: hw-rejects-pxp-context [502.860906] Subtest hw-rejects-pxp-context: SKIP (0.000s) [502.995273] [052/131] (521s left) sw_sync (sync_random_merge) [503.037648] Starting subtest: sync_random_merge [503.073213] Subtest sync_random_merge: SUCCESS (0.038s) [503.159140] [053/131] (521s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [508.176925] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [508.181922] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [509.042353] [054/131] (515s left) gem_userptr_blits (invalid-mmap-offset-unsync) [509.114883] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [509.262847] [055/131] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [509.375942] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [509.380951] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [509.504753] [056/131] (515s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [509.608070] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [509.613625] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [509.733136] [057/131] (515s left) perf_pmu (all-busy-check-all) [509.771667] Starting subtest: all-busy-check-all [511.533705] Subtest all-busy-check-all: SUCCESS (1.762s) [511.674190] [058/131] (513s left) gem_exec_params (no-bsd) [511.739653] Starting subtest: no-bsd [511.742572] Subtest no-bsd: SUCCESS (0.003s) [513.632305] [059/131] (511s left) kms_cursor_crc (cursor-rapid-movement-256x256) [513.859928] Starting subtest: cursor-rapid-movement-256x256 [513.865669] Starting dynamic subtest: pipe-A-eDP-1 [514.442569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s) [514.473588] Starting dynamic subtest: pipe-D-eDP-1 [515.634767] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.173s) [515.637674] Subtest cursor-rapid-movement-256x256: SUCCESS (1.775s) [516.504379] [060/131] (508s left) kms_psr (psr-sprite-plane-move) [516.601694] Starting subtest: psr-sprite-plane-move [516.604483] Starting dynamic subtest: eDP-1 [518.425766] Dynamic subtest eDP-1: SUCCESS (1.824s) [518.428629] Subtest psr-sprite-plane-move: SUCCESS (1.824s) [519.268599] [061/131] (505s left) kms_big_fb (4-tiled-8bpp-rotate-90) [519.388211] Starting subtest: 4-tiled-8bpp-rotate-90 [519.410756] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s) [519.553649] [062/131] (505s left) kms_cursor_crc (cursor-sliding-256x256) [519.808485] Starting subtest: cursor-sliding-256x256 [519.811052] Starting dynamic subtest: pipe-A-eDP-1 [523.067596] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.255s) [523.099485] Starting dynamic subtest: pipe-D-eDP-1 [527.001666] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.914s) [527.003931] Subtest cursor-sliding-256x256: SUCCESS (7.197s) [527.840472] [063/131] (497s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [527.949746] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [527.954758] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [528.054370] [064/131] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [528.148179] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [528.152794] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [528.307593] [065/131] (496s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [528.422348] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [528.427162] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [528.534327] [066/131] (496s left) gem_sync (basic-each) [528.609824] Starting subtest: basic-each [531.052927] Subtest basic-each: SUCCESS (2.456s) [531.273215] [067/131] (494s left) gem_spin_batch (resubmit-all) [531.345475] Starting subtest: resubmit-all [531.348274] Starting dynamic subtest: rcs0 [531.368117] Dynamic subtest rcs0: SUCCESS (0.022s) [531.380959] Starting dynamic subtest: bcs0 [531.384319] Dynamic subtest bcs0: SUCCESS (0.003s) [531.393784] Starting dynamic subtest: vcs0 [531.396749] Dynamic subtest vcs0: SUCCESS (0.003s) [531.406743] Starting dynamic subtest: vcs1 [531.409756] Dynamic subtest vcs1: SUCCESS (0.003s) [531.419371] Starting dynamic subtest: vecs0 [531.421831] Dynamic subtest vecs0: SUCCESS (0.003s) [531.431024] Starting dynamic subtest: ccs0 [531.433705] Dynamic subtest ccs0: SUCCESS (0.003s) [531.436533] Subtest resubmit-all: SUCCESS (0.041s) [532.590296] [068/131] (492s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [532.652843] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [532.655777] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [532.789193] [069/131] (492s left) gem_mmap_gtt (hang) [532.860770] Subtest hang: SKIP (0.000s) [532.922206] [070/131] (492s left) gem_mmap_gtt (fault-concurrent-x) [532.981194] Subtest fault-concurrent-X: SKIP (0.000s) [533.047244] [071/131] (492s left) gem_exec_alignment (forked) [533.115083] Starting subtest: forked [572.043700] Subtest forked: SUCCESS (38.924s) [572.189715] [072/131] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [572.346351] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [572.352838] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [572.492809] [073/131] (453s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [572.596704] Starting subtest: drrs-dirtyfb-ioctl [572.613745] Subtest drrs-dirtyfb-ioctl: SKIP (0.002s) [572.735125] [074/131] (452s left) gem_exec_fence (concurrent) [572.924703] Starting subtest: concurrent [572.930834] Subtest concurrent: SKIP (0.000s) [574.658639] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [574.662871] [075/131] (451s left) kms_hdr (bpc-switch-suspend) [574.761279] Starting subtest: bpc-switch-suspend [575.797901] Starting dynamic subtest: pipe-A-eDP-1 [595.509021] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.680s) [595.511318] Subtest bpc-switch-suspend: SUCCESS (5.719s) [595.671218] [076/131] (430s left) sysfs_preempt_timeout (timeout) [595.744081] Starting subtest: timeout [595.746489] Starting dynamic subtest: vecs0 [605.583255] Dynamic subtest vecs0: SUCCESS (10.039s) [605.595258] Starting dynamic subtest: ccs0 [606.974458] Dynamic subtest ccs0: SUCCESS (1.403s) [606.985755] Starting dynamic subtest: vcs0 [616.590517] Dynamic subtest vcs0: SUCCESS (9.661s) [616.603386] Starting dynamic subtest: bcs0 [617.906838] Dynamic subtest bcs0: SUCCESS (1.318s) [617.920260] Starting dynamic subtest: rcs0 [619.290057] Dynamic subtest rcs0: SUCCESS (1.384s) [619.308764] Starting dynamic subtest: vcs1 [628.555539] Dynamic subtest vcs1: SUCCESS (9.272s) [628.558293] Subtest timeout: SUCCESS (33.090s) [628.655493] [077/131] (397s left) kms_psr (fbc-psr2-sprite-plane-move) [628.782777] Starting subtest: fbc-psr2-sprite-plane-move [628.785096] Starting dynamic subtest: eDP-1 [628.789611] Dynamic subtest eDP-1: SKIP (0.000s) [628.794025] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [628.877729] [078/131] (396s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [633.852817] Starting subtest: pr-overlay-plane-move-continuous-sf [633.857352] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [634.730042] [079/131] (391s left) kms_psr (pr-cursor-mmap-gtt) [634.827607] Starting subtest: pr-cursor-mmap-gtt [634.832031] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [634.929657] [080/131] (390s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [635.017126] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [635.019542] Starting dynamic subtest: pipe-A-default-mode [635.305340] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [635.310444] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.286s) [636.159857] [081/131] (389s left) kms_busy (extended-modeset-hang-newfb-with-reset) [636.276617] Starting subtest: extended-modeset-hang-newfb-with-reset [636.278988] Starting dynamic subtest: pipe-A [651.899536] Dynamic subtest pipe-A: SUCCESS (15.618s) [651.910315] Starting dynamic subtest: pipe-D [667.460833] Dynamic subtest pipe-D: SUCCESS (15.562s) [667.463335] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.184s) [668.293539] [082/131] (357s left) gem_pwrite (basic-exhaustion) [668.357361] Subtest basic-exhaustion: SKIP (0.000s) [668.430344] [083/131] (357s left) gem_caching (writes) [668.496106] Subtest writes: SKIP (0.000s) [668.575621] [084/131] (357s left) perf_pmu (busy-idle-check-all) [668.611107] Starting subtest: busy-idle-check-all [668.613319] Starting dynamic subtest: rcs0 [669.287409] Dynamic subtest rcs0: SUCCESS (0.677s) [669.300177] Starting dynamic subtest: bcs0 [669.938989] Dynamic subtest bcs0: SUCCESS (0.649s) [669.952241] Starting dynamic subtest: vcs0 [671.550458] Dynamic subtest vcs0: SUCCESS (1.608s) [671.563484] Starting dynamic subtest: vcs1 [673.534475] Dynamic subtest vcs1: SUCCESS (1.982s) [673.547486] Starting dynamic subtest: vecs0 [675.581702] Dynamic subtest vecs0: SUCCESS (2.045s) [675.594713] Starting dynamic subtest: ccs0 [676.238658] Dynamic subtest ccs0: SUCCESS (0.656s) [676.241134] Subtest busy-idle-check-all: SUCCESS (7.632s) [676.377359] [085/131] (349s left) gen9_exec_parse (unaligned-jump) [676.437469] Subtest unaligned-jump: SKIP (0.000s) [676.518157] [086/131] (349s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [676.626025] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [676.630082] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [676.760665] [087/131] (349s left) gem_lmem_swapping (parallel-random) [676.810453] Subtest parallel-random: SKIP (0.000s) [676.856979] [088/131] (349s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [676.956084] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [677.791301] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s) [678.002755] [089/131] (348s left) gem_ctx_bad_destroy (invalid-default-ctx) [678.072893] Starting subtest: invalid-default-ctx [678.075104] Subtest invalid-default-ctx: SUCCESS (0.000s) [678.169793] [090/131] (348s left) syncobj_eventfd (invalid-illegal-handle) [678.228463] Starting subtest: invalid-illegal-handle [678.230395] Subtest invalid-illegal-handle: SUCCESS (0.000s) [678.365716] [091/131] (348s left) kms_async_flips (async-flip-suspend-resume) [678.468642] Starting subtest: async-flip-suspend-resume [678.849091] Starting dynamic subtest: pipe-A-eDP-1 [697.407912] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.941s) [697.800590] Starting dynamic subtest: pipe-B-eDP-1 [715.450912] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.017s) [715.832441] Starting dynamic subtest: pipe-C-eDP-1 [733.398283] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.977s) [733.769756] Starting dynamic subtest: pipe-D-eDP-1 [751.404682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.990s) [751.407015] Subtest async-flip-suspend-resume: SUCCESS (13.463s) [752.563472] [092/131] (273s left) gem_ctx_persistence (hang) [752.636973] Starting subtest: hang [752.642715] Subtest hang: SKIP (0.000s) [752.780992] [093/131] (273s left) gem_exec_parallel (userptr) [752.843161] Starting subtest: userptr [752.846017] Starting dynamic subtest: rcs0 [754.564168] Dynamic subtest rcs0: SUCCESS (1.768s) [754.576017] Starting dynamic subtest: bcs0 [756.215662] Dynamic subtest bcs0: SUCCESS (1.684s) [756.228077] Starting dynamic subtest: vcs0 [758.256900] Dynamic subtest vcs0: SUCCESS (2.071s) [758.269971] Starting dynamic subtest: vcs1 [760.304141] Dynamic subtest vcs1: SUCCESS (2.071s) [760.318534] Starting dynamic subtest: vecs0 [762.288682] Dynamic subtest vecs0: SUCCESS (1.999s) [762.300411] Starting dynamic subtest: ccs0 [764.127216] Dynamic subtest ccs0: SUCCESS (1.850s) [764.130070] Subtest userptr: SUCCESS (11.454s) [764.337963] [094/131] (262s left) kms_cdclk (mode-transition-all-outputs) [764.447781] Starting subtest: mode-transition-all-outputs [764.737877] Subtest mode-transition-all-outputs: SKIP (0.289s) [765.605952] [095/131] (260s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [765.704547] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [765.706997] Starting dynamic subtest: pipe-A-eDP-1 [765.733406] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [765.745271] Starting dynamic subtest: pipe-B-eDP-1 [765.772753] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [765.784160] Starting dynamic subtest: pipe-C-eDP-1 [765.812904] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [765.824584] Starting dynamic subtest: pipe-D-eDP-1 [765.852824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [765.857690] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [767.947371] [096/131] (258s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [768.075522] Starting subtest: 2x-long-flip-vs-cursor-legacy [768.080666] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [768.244448] [097/131] (258s left) gem_close_race (multigpu-basic-threads) [768.309956] Starting subtest: multigpu-basic-threads [768.315039] Subtest multigpu-basic-threads: SKIP (0.000s) [768.577070] [098/131] (258s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [768.648061] Starting subtest: y-tiled-to-vebox-yf-tiled [768.652982] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [768.853181] [099/131] (257s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [768.960084] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [768.965010] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [769.075578] [100/131] (257s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [769.180901] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [769.185389] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [769.288382] [101/131] (257s left) gem_exec_fence (invalid-timeline-fence-array) [769.860682] Starting subtest: invalid-timeline-fence-array [769.867127] Subtest invalid-timeline-fence-array: SUCCESS (0.007s) [771.377034] [102/131] (255s left) kms_flip (2x-blocking-wf_vblank) [771.480745] Starting subtest: 2x-blocking-wf_vblank [771.488609] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [771.645313] [103/131] (255s left) kms_flip (absolute-wf_vblank-interruptible) [771.754851] Starting subtest: absolute-wf_vblank-interruptible [771.759808] Starting dynamic subtest: A-eDP1 [780.458043] Dynamic subtest A-eDP1: SUCCESS (8.715s) [780.471489] Starting dynamic subtest: B-eDP1 [789.195772] Dynamic subtest B-eDP1: SUCCESS (8.731s) [789.206943] Starting dynamic subtest: C-eDP1 [797.919001] Dynamic subtest C-eDP1: SUCCESS (8.719s) [797.933740] Starting dynamic subtest: D-eDP1 [806.646087] Dynamic subtest D-eDP1: SUCCESS (8.724s) [806.648844] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.903s) [807.884495] [104/131] (219s left) gem_exec_schedule (u-fairslice) [807.979021] Starting subtest: u-fairslice [807.982068] Starting dynamic subtest: rcs0 [809.992902] Dynamic subtest rcs0: SUCCESS (2.023s) [810.015774] Starting dynamic subtest: bcs0 [812.018168] Dynamic subtest bcs0: SUCCESS (2.021s) [812.040945] Starting dynamic subtest: vcs0 [814.037427] Dynamic subtest vcs0: SUCCESS (2.020s) [814.049688] Starting dynamic subtest: vcs1 [816.056775] Dynamic subtest vcs1: SUCCESS (2.018s) [816.069155] Starting dynamic subtest: vecs0 [818.071840] Dynamic subtest vecs0: SUCCESS (2.018s) [818.084675] Starting dynamic subtest: ccs0 [820.096875] Dynamic subtest ccs0: SUCCESS (2.022s) [820.099780] Subtest u-fairslice: SUCCESS (12.129s) [820.423314] [105/131] (206s left) kms_psr (fbc-pr-primary-page-flip) [820.515765] Starting subtest: fbc-pr-primary-page-flip [820.521062] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [820.615367] [106/131] (206s left) kms_big_fb (x-tiled-64bpp-rotate-270) [820.721400] Starting subtest: x-tiled-64bpp-rotate-270 [820.742018] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [820.904560] [107/131] (206s left) kms_draw_crc (draw-method-mmap-cpu) [820.993838] Starting subtest: draw-method-mmap-cpu [820.996158] Starting dynamic subtest: xrgb8888-untiled [821.236074] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [821.246774] Starting dynamic subtest: rgb565-untiled [821.458442] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [821.468990] Starting dynamic subtest: xrgb2101010-untiled [821.669709] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s) [821.690321] Starting dynamic subtest: xbgr16161616f-untiled [821.902569] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.230s) [821.913421] Starting dynamic subtest: xrgb8888-xtiled [822.035701] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [822.046137] Starting dynamic subtest: rgb565-xtiled [822.169417] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [822.180582] Starting dynamic subtest: xrgb2101010-xtiled [822.291653] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [822.302641] Starting dynamic subtest: xbgr16161616f-xtiled [822.414546] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [822.432889] Starting dynamic subtest: xrgb8888-4tiled [822.569208] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s) [822.580794] Starting dynamic subtest: rgb565-4tiled [822.702336] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s) [822.713011] Starting dynamic subtest: xrgb2101010-4tiled [822.846731] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [822.857195] Starting dynamic subtest: xbgr16161616f-4tiled [822.991030] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [822.993634] Subtest draw-method-mmap-cpu: SUCCESS (2.000s) [823.121544] [108/131] (204s left) gem_exec_reloc (basic-wc-cpu) [823.184486] Subtest basic-wc-cpu: SKIP (0.000s) [823.266550] [109/131] (203s left) kms_plane (plane-position-hole-dpms) [823.362970] Starting subtest: plane-position-hole-dpms [823.878300] Starting dynamic subtest: pipe-A-plane-1 [826.197030] Dynamic subtest pipe-A-plane-1: SUCCESS (2.317s) [826.208470] Starting dynamic subtest: pipe-A-plane-2 [828.558559] Dynamic subtest pipe-A-plane-2: SUCCESS (2.362s) [828.569998] Starting dynamic subtest: pipe-A-plane-3 [830.912678] Dynamic subtest pipe-A-plane-3: SUCCESS (2.352s) [830.924634] Starting dynamic subtest: pipe-A-plane-4 [833.270982] Dynamic subtest pipe-A-plane-4: SUCCESS (2.359s) [833.281884] Starting dynamic subtest: pipe-A-plane-5 [833.298218] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [834.429287] Starting dynamic subtest: pipe-B-plane-1 [836.688023] Dynamic subtest pipe-B-plane-1: SUCCESS (2.268s) [836.700830] Starting dynamic subtest: pipe-B-plane-2 [839.034896] Dynamic subtest pipe-B-plane-2: SUCCESS (2.344s) [839.046787] Starting dynamic subtest: pipe-B-plane-3 [841.309143] Dynamic subtest pipe-B-plane-3: SUCCESS (2.277s) [841.321453] Starting dynamic subtest: pipe-B-plane-4 [843.714129] Dynamic subtest pipe-B-plane-4: SUCCESS (2.403s) [843.726250] Starting dynamic subtest: pipe-B-plane-5 [843.739148] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [843.742140] Subtest plane-position-hole-dpms: SUCCESS (20.379s) [844.614907] [110/131] (182s left) kms_chamelium_frames (dp-crc-single) [845.002713] Subtest dp-crc-single: SKIP (0.000s) [845.798101] [111/131] (181s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [845.912381] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [853.476163] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.565s) [853.607280] [112/131] (173s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [853.708986] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [853.713940] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [853.841867] [113/131] (173s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [853.910150] Starting subtest: invalid-multi-wait-unsubmitted-submitted [853.912920] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [854.051468] [114/131] (173s left) kms_properties (invalid-properties-atomic) [854.145929] Starting subtest: invalid-properties-atomic [854.449135] Subtest invalid-properties-atomic: SUCCESS (0.303s) [854.548065] [115/131] (172s left) gem_exec_suspend (basic-s3) [854.618053] Starting subtest: basic-S3 [854.620924] Starting dynamic subtest: smem [875.332143] Dynamic subtest smem: SUCCESS (6.722s) [875.335214] Subtest basic-S3: SUCCESS (6.724s) [875.547793] [116/131] (151s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [875.662210] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [875.664445] Starting dynamic subtest: pipe-A-default-mode [876.847088] Dynamic subtest pipe-A-default-mode: SKIP (1.213s) [876.852050] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.216s) [877.038077] [117/131] (150s left) kms_psr (fbc-psr-primary-page-flip) [877.138407] Starting subtest: fbc-psr-primary-page-flip [877.141038] Starting dynamic subtest: eDP-1 [877.146345] Dynamic subtest eDP-1: SKIP (0.000s) [877.151462] Subtest fbc-psr-primary-page-flip: SKIP (0.003s) [877.242571] [118/131] (150s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [877.345613] Starting subtest: fbc-2p-primscrn-spr-indfb-move [877.350975] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [877.474179] [119/131] (150s left) kms_joiner (invalid-modeset-force-ultra-joiner) [877.569514] Starting subtest: invalid-modeset-force-ultra-joiner [877.574683] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [877.654220] [120/131] (150s left) kms_prop_blob (blob-multiple) [877.717910] Starting subtest: blob-multiple [877.720460] Subtest blob-multiple: SUCCESS (0.002s) [877.861325] [121/131] (149s left) kms_vblank (wait-forked-busy) [877.950992] Starting subtest: wait-forked-busy [877.953466] Starting dynamic subtest: pipe-A-eDP-1 [879.813502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s) [879.829585] Starting dynamic subtest: pipe-D-eDP-1 [882.323841] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s) [882.326563] Subtest wait-forked-busy: SUCCESS (4.435s) [883.140702] [122/131] (144s left) kms_content_protection (legacy) [883.292901] Starting subtest: legacy [883.298452] Subtest legacy: SKIP (0.000s) [883.458272] [123/131] (144s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [883.555641] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [884.328424] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s) [884.507925] [124/131] (143s left) gem_mmap_gtt (cpuset-medium-copy) [884.576478] Subtest cpuset-medium-copy: SKIP (0.000s) [884.643060] [125/131] (143s left) prime_vgem (fence-wait) [884.720732] Starting subtest: fence-wait [884.723034] Starting dynamic subtest: rcs0 [885.768748] Dynamic subtest rcs0: SUCCESS (1.055s) [885.780407] Starting dynamic subtest: bcs0 [886.825051] Dynamic subtest bcs0: SUCCESS (1.062s) [886.836427] Starting dynamic subtest: vcs0 [887.865703] Dynamic subtest vcs0: SUCCESS (1.046s) [887.877440] Starting dynamic subtest: vcs1 [888.906708] Dynamic subtest vcs1: SUCCESS (1.042s) [888.925443] Starting dynamic subtest: vecs0 [889.952976] Dynamic subtest vecs0: SUCCESS (1.050s) [889.966143] Starting dynamic subtest: ccs0 [891.322107] Dynamic subtest ccs0: SUCCESS (1.373s) [891.324899] Subtest fence-wait: SUCCESS (6.640s) [891.492634] [126/131] (136s left) kms_addfb_basic (bo-too-small) [891.592866] Starting subtest: bo-too-small [891.595456] Subtest bo-too-small: SUCCESS (0.000s) [891.722709] [127/131] (136s left) kms_plane_scaling (planes-scaler-unity-scaling) [891.824302] Starting subtest: planes-scaler-unity-scaling [891.826818] Starting dynamic subtest: pipe-A [891.886575] Dynamic subtest pipe-A: SUCCESS (0.064s) [891.904821] Starting dynamic subtest: pipe-B [893.088517] Dynamic subtest pipe-B: SUCCESS (1.203s) [893.099755] Starting dynamic subtest: pipe-C [894.193711] Dynamic subtest pipe-C: SUCCESS (1.106s) [894.205283] Starting dynamic subtest: pipe-D [895.332683] Dynamic subtest pipe-D: SUCCESS (1.140s) [895.335695] Subtest planes-scaler-unity-scaling: SUCCESS (3.521s) [896.498152] [128/131] (131s left) gem_exec_params (invalid-flag) [896.564450] Starting subtest: invalid-flag [896.566761] Subtest invalid-flag: SUCCESS (0.000s) [896.702431] [129/131] (131s left) kms_async_flips (crc-atomic) [896.798384] Starting subtest: crc-atomic [897.182273] Starting dynamic subtest: pipe-A-eDP-1 [900.111739] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.933s) [900.488716] Starting dynamic subtest: pipe-B-eDP-1 [903.409468] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.936s) [903.785549] Starting dynamic subtest: pipe-C-eDP-1 [906.711709] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s) [907.076187] Starting dynamic subtest: pipe-D-eDP-1 [909.929009] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.859s) [909.931803] Subtest crc-atomic: SUCCESS (13.142s) [911.130173] [130/131] (116s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [911.228632] Starting subtest: sprite-rotation-90-pos-100-0 [911.233923] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [911.325898] [131/131] (116s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [911.424972] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [911.430197] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [911.541153] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_flip_scaled_crc results: parsing output: 2/ for test: sw_sync results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: api_intel_bb results: parsing output: 5/ for test: kms_plane_cursor results: parsing output: 6/ for test: syncobj_wait results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: kms_chamelium_hpd results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: prime_udl results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: gem_mmap_gtt results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: gen7_exec_parse results: parsing output: 21/ for test: gem_exec_reloc results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: syncobj_basic results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: kms_sequence results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: i915_selftest results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: i915_pm_freq_api results: parsing output: 32/ for test: api_intel_allocator results: parsing output: 33/ for test: gem_ctx_persistence results: parsing output: 34/ for test: gem_eio results: parsing output: 35/ for test: i915_pm_freq_mult results: parsing output: 36/ for test: gem_fenced_exec_thrash results: parsing output: 37/ for test: gem_exec_balancer results: parsing output: 38/ for test: gem_ccs results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: kms_pm_rpm results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: syncobj_wait results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: gem_exec_alignment results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: dumb_buffer results: parsing output: 48/ for test: gem_ctx_param results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: gem_pxp results: parsing output: 51/ for test: sw_sync results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: gem_exec_params results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_cursor_crc results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_sync results: parsing output: 66/ for test: gem_spin_batch results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: gem_mmap_gtt results: parsing output: 69/ for test: gem_mmap_gtt results: parsing output: 70/ for test: gem_exec_alignment results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_dirtyfb results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_hdr results: parsing output: 75/ for test: sysfs_preempt_timeout results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: kms_psr2_sf results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_flip_scaled_crc results: parsing output: 80/ for test: kms_busy results: parsing output: 81/ for test: gem_pwrite results: parsing output: 82/ for test: gem_caching results: parsing output: 83/ for test: perf_pmu results: parsing output: 84/ for test: gen9_exec_parse results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_lmem_swapping results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: gem_ctx_bad_destroy results: parsing output: 89/ for test: syncobj_eventfd results: parsing output: 90/ for test: kms_async_flips results: parsing output: 91/ for test: gem_ctx_persistence results: parsing output: 92/ for test: gem_exec_parallel results: parsing output: 93/ for test: kms_cdclk results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: gem_close_race results: parsing output: 97/ for test: gem_render_copy results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_exec_fence results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: gem_exec_schedule results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_draw_crc results: parsing output: 107/ for test: gem_exec_reloc results: parsing output: 108/ for test: kms_plane results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_properties results: parsing output: 114/ for test: gem_exec_suspend results: parsing output: 115/ for test: kms_flip_scaled_crc results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_joiner results: parsing output: 119/ for test: kms_prop_blob results: parsing output: 120/ for test: kms_vblank results: parsing output: 121/ for test: kms_content_protection results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: prime_vgem results: parsing output: 125/ for test: kms_addfb_basic results: parsing output: 126/ for test: kms_plane_scaling results: parsing output: 127/ for test: gem_exec_params results: parsing output: 128/ for test: kms_async_flips results: parsing output: 129/ for test: kms_rotation_crc results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.