[58.787747] Initializing watchdogs [58.787802] /dev/watchdog0 [58.803464] [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.808332] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.810793] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.812869] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [58.915665] Starting subtest: psr-1p-pri-indfb-multidraw [82.565987] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.651s) [82.694981] [002/133] (936s left) kms_psr (psr-sprite-mmap-gtt) [82.787224] Starting subtest: psr-sprite-mmap-gtt [82.788311] Starting dynamic subtest: eDP-1 [84.204622] Dynamic subtest eDP-1: SKIP (1.406s) [84.206470] Subtest psr-sprite-mmap-gtt: SKIP (1.408s) [84.357938] [003/133] (935s left) api_intel_bb (simple-bb) [84.402295] Starting subtest: simple-bb [84.405788] Subtest simple-bb: SUCCESS (0.004s) [84.516242] [004/133] (934s left) kms_cursor_crc (cursor-onscreen-256x85) [84.766345] Starting subtest: cursor-onscreen-256x85 [84.820962] Subtest cursor-onscreen-256x85: SKIP (0.050s) [85.003789] [005/133] (934s left) kms_color_pipeline (plane-lut1d) [85.083090] Starting subtest: plane-lut1d [85.231090] Starting dynamic subtest: pipe-A-plane-0 [85.419899] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [85.426845] Starting dynamic subtest: pipe-A-plane-1 [85.608809] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s) [85.615871] Starting dynamic subtest: pipe-A-plane-2 [85.775331] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [87.028896] Starting dynamic subtest: pipe-B-plane-0 [87.188522] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [87.196551] Starting dynamic subtest: pipe-B-plane-1 [87.355236] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [87.362136] Starting dynamic subtest: pipe-B-plane-2 [87.533168] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s) [88.744285] Starting dynamic subtest: pipe-C-plane-0 [88.880290] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [88.890070] Starting dynamic subtest: pipe-C-plane-1 [89.046735] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [89.053971] Starting dynamic subtest: pipe-C-plane-2 [89.213456] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [90.388468] Starting dynamic subtest: pipe-D-plane-0 [90.548913] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [90.556364] Starting dynamic subtest: pipe-D-plane-1 [90.693358] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [90.700420] Starting dynamic subtest: pipe-D-plane-2 [90.848872] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [91.148240] Subtest plane-lut1d: SUCCESS (6.065s) [91.953871] [006/133] (927s left) gem_exec_endless (dispatch) [92.020540] Starting subtest: dispatch [92.021720] Starting dynamic subtest: rcs0 [92.026193] Dynamic subtest rcs0: SUCCESS (0.005s) [92.034722] Starting dynamic subtest: bcs0 [92.036682] Dynamic subtest bcs0: SUCCESS (0.004s) [92.044356] Starting dynamic subtest: vcs0 [92.046431] Dynamic subtest vcs0: SUCCESS (0.004s) [92.057760] Starting dynamic subtest: vcs1 [92.059554] Dynamic subtest vcs1: SUCCESS (0.005s) [92.066390] Starting dynamic subtest: vecs0 [92.068155] Dynamic subtest vecs0: SUCCESS (0.005s) [92.074614] Starting dynamic subtest: ccs0 [92.076317] Dynamic subtest ccs0: SUCCESS (0.004s) [92.077191] Subtest dispatch: SUCCESS (0.032s) [93.373409] [007/133] (926s left) gem_userptr_blits (stress-purge) [93.439784] Starting subtest: stress-purge [98.840981] Subtest stress-purge: SUCCESS (5.401s) [98.983487] [008/133] (920s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [99.142252] Starting subtest: yf-tiled-64bpp-rotate-90 [99.144049] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [99.238334] [009/133] (920s left) kms_chamelium_color (ctm-blue-to-red) [99.328727] Subtest ctm-blue-to-red: SKIP (0.000s) [99.367867] [010/133] (920s left) gem_exec_schedule (promotion) [99.443704] Starting subtest: promotion [99.444721] Starting dynamic subtest: rcs0 [99.553533] Dynamic subtest rcs0: SUCCESS (0.109s) [99.565340] Starting dynamic subtest: vcs0 [99.645814] Dynamic subtest vcs0: SUCCESS (0.092s) [99.655553] Starting dynamic subtest: vcs1 [99.732793] Dynamic subtest vcs1: SUCCESS (0.085s) [99.745115] Starting dynamic subtest: vecs0 [99.819828] Dynamic subtest vecs0: SUCCESS (0.085s) [99.830891] Starting dynamic subtest: ccs0 [99.909394] Dynamic subtest ccs0: SUCCESS (0.088s) [99.910925] Subtest promotion: SUCCESS (0.466s) [101.434648] [011/133] (918s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [101.532652] Starting subtest: coverage-vs-premult-vs-constant [101.823494] Starting dynamic subtest: pipe-A-eDP-1 [102.444900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s) [102.452655] Starting dynamic subtest: pipe-D-eDP-1 [103.778127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [103.779305] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.247s) [104.624836] [012/133] (915s left) gem_mmap_wc (write-read) [104.672087] Subtest write-read: SKIP (0.000s) [104.734166] [013/133] (914s left) i915_module_load (reload-no-display) [104.769497] Starting subtest: reload-no-display [110.728520] Subtest reload-no-display: SUCCESS (5.950s) [110.749519] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [110.751534] [014/133] (908s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [112.305405] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [112.409347] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s) [112.445994] [FACT syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submitted)] new: kernel.kmod_is_loaded.i915: true [112.448960] [015/133] (907s left) syncobj_wait (wait-delayed-signal) [112.503066] Starting subtest: wait-delayed-signal [112.606776] Subtest wait-delayed-signal: SUCCESS (0.103s) [112.687245] [016/133] (907s left) api_intel_allocator (gem-pool) [112.728266] Starting subtest: gem-pool [112.739895] Subtest gem-pool: SUCCESS (0.012s) [112.844299] [017/133] (906s left) gem_create (hog-create) [112.899157] Starting subtest: hog-create [112.900129] Starting dynamic subtest: smem0 [145.317434] Dynamic subtest smem0: SUCCESS (32.408s) [145.318805] Subtest hog-create: SUCCESS (32.410s) [145.503273] [018/133] (874s left) kms_force_connector_basic (force-connector-state) [145.578662] Starting subtest: force-connector-state [146.197190] Subtest force-connector-state: SUCCESS (0.618s) [147.128302] [019/133] (872s left) kms_dsc (dsc-basic) [147.222416] Starting subtest: dsc-basic [147.227539] Subtest dsc-basic: SKIP (0.000s) [147.288153] [020/133] (872s left) kms_atomic_transition (plane-all-transition) [147.373199] Starting subtest: plane-all-transition [147.374202] Starting dynamic subtest: pipe-A-eDP-1 [149.876231] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [150.181207] Starting dynamic subtest: pipe-B-eDP-1 [153.406772] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.232s) [153.704565] Subtest plane-all-transition: SUCCESS (6.330s) [154.493846] [021/133] (865s left) syncobj_basic (test-valid-cycle) [154.551201] Starting subtest: test-valid-cycle [154.552214] Subtest test-valid-cycle: SUCCESS (0.000s) [154.638863] [022/133] (865s left) gem_render_copy (linear-to-vebox-y-tiled) [154.687459] Starting subtest: linear-to-vebox-y-tiled [154.689311] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [154.876015] [023/133] (865s left) syncobj_timeline (invalid-single-wait-unsubmitted) [154.922893] Starting subtest: invalid-single-wait-unsubmitted [154.923870] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [155.008906] [024/133] (865s left) syncobj_basic (bad-create-flags) [155.057366] Starting subtest: bad-create-flags [155.058533] Subtest bad-create-flags: SUCCESS (0.000s) [155.136034] [025/133] (864s left) gem_softpin (allocator-nopin-reserve) [155.185091] Starting subtest: allocator-nopin-reserve [155.286633] Subtest allocator-nopin-reserve: SUCCESS (0.101s) [155.396807] [026/133] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [155.495263] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [155.497122] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [155.585050] [027/133] (864s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [155.671424] Starting subtest: primary-y-tiled-reflect-x-0 [155.731090] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s) [155.829152] [028/133] (864s left) kms_big_fb (x-tiled-8bpp-rotate-270) [155.926716] Starting subtest: x-tiled-8bpp-rotate-270 [155.948257] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [156.046584] [029/133] (864s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [156.139331] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [156.514049] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [159.253606] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.729s) [159.261204] Starting dynamic subtest: pipe-A-eDP-1-4 [161.450402] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.193s) [161.460685] Starting dynamic subtest: pipe-A-eDP-1-4 [163.459557] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [163.468245] Starting dynamic subtest: pipe-A-eDP-1-x [165.650091] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [166.009325] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [168.744244] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.732s) [168.754746] Starting dynamic subtest: pipe-B-eDP-1-4 [170.930748] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s) [170.941268] Starting dynamic subtest: pipe-B-eDP-1-4 [172.940759] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [172.953563] Starting dynamic subtest: pipe-B-eDP-1-x [175.131217] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [175.497082] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [178.252989] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.753s) [178.261346] Starting dynamic subtest: pipe-C-eDP-1-4 [180.427384] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [180.435934] Starting dynamic subtest: pipe-C-eDP-1-4 [182.437840] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [182.448458] Starting dynamic subtest: pipe-C-eDP-1-x [184.616680] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [184.970916] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [187.738363] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.763s) [187.748453] Starting dynamic subtest: pipe-D-eDP-1-4 [189.913465] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [189.924448] Starting dynamic subtest: pipe-D-eDP-1-4 [191.923297] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [191.933985] Starting dynamic subtest: pipe-D-eDP-1-x [194.092970] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [194.094335] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.952s) [195.290085] [030/133] (824s left) gem_userptr_blits (unsync-unmap) [195.344645] Subtest unsync-unmap: SKIP (0.000s) [195.469990] [031/133] (824s left) gem_eio (in-flight-10ms) [195.703267] Starting subtest: in-flight-10ms [204.308073] Subtest in-flight-10ms: SUCCESS (8.606s) [204.436300] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true [204.438440] [032/133] (815s left) gem_exec_fence (keep-in-fence) [204.617654] Starting subtest: keep-in-fence [204.618947] Starting dynamic subtest: rcs0 [204.677719] Dynamic subtest rcs0: SUCCESS (0.065s) [204.691625] Starting dynamic subtest: bcs0 [204.732435] Dynamic subtest bcs0: SUCCESS (0.052s) [204.748240] Starting dynamic subtest: vcs0 [206.310426] Dynamic subtest vcs0: SUCCESS (1.567s) [206.321341] Starting dynamic subtest: vcs1 [208.358846] Dynamic subtest vcs1: SUCCESS (2.045s) [208.369031] Starting dynamic subtest: vecs0 [210.342475] Dynamic subtest vecs0: SUCCESS (1.981s) [210.352988] Starting dynamic subtest: ccs0 [210.584333] Dynamic subtest ccs0: SUCCESS (0.247s) [210.585917] Subtest keep-in-fence: SUCCESS (5.973s) [212.390807] [033/133] (807s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [212.491915] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [212.493619] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [212.587964] [034/133] (807s left) gem_exec_whisper (basic-forked-all) [212.640649] Starting subtest: basic-forked-all [226.344495] Subtest basic-forked-all: SUCCESS (13.692s) [226.517924] [035/133] (793s left) gem_exec_nop (basic-sequential) [226.577026] Starting subtest: basic-sequential [240.803870] Subtest basic-sequential: SUCCESS (14.226s) [241.011985] [036/133] (779s left) gem_exec_gttfill (multigpu-basic) [241.182867] Starting subtest: multigpu-basic [253.466242] Subtest multigpu-basic: SUCCESS (12.283s) [253.528835] [037/133] (766s left) kms_addfb_basic (bad-pitch-999) [253.629432] Starting subtest: bad-pitch-999 [253.630421] Subtest bad-pitch-999: SUCCESS (0.000s) [253.764380] [038/133] (766s left) kms_universal_plane (disable-primary-vs-flip) [253.850406] Starting subtest: disable-primary-vs-flip [253.851428] Starting dynamic subtest: pipe-A-eDP-1 [255.437059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.587s) [255.446557] Starting dynamic subtest: pipe-B-eDP-1 [257.646510] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.208s) [257.655440] Starting dynamic subtest: pipe-C-eDP-1 [259.832361] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.184s) [259.841367] Starting dynamic subtest: pipe-D-eDP-1 [262.039033] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.206s) [262.040046] Subtest disable-primary-vs-flip: SUCCESS (8.191s) [262.897788] [039/133] (757s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [262.993907] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [262.995064] Starting dynamic subtest: pipe-A-eDP-1 [264.301870] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.297s) [264.582148] Starting dynamic subtest: pipe-B-eDP-1 [265.608147] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.021s) [265.860500] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.865s) [266.679647] [040/133] (753s left) kms_addfb_basic (invalid-set-prop) [266.729904] Starting subtest: invalid-set-prop [266.731251] Subtest invalid-set-prop: SUCCESS (0.000s) [266.866857] [041/133] (753s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [266.956260] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [266.958054] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [267.038437] [042/133] (753s left) sw_sync (alloc_merge_fence) [267.066352] Starting subtest: alloc_merge_fence [267.067299] Subtest alloc_merge_fence: SUCCESS (0.000s) [267.113558] [043/133] (753s left) kms_properties (invalid-properties-atomic) [267.198924] Starting subtest: invalid-properties-atomic [267.528835] Subtest invalid-properties-atomic: SUCCESS (0.321s) [267.592819] [044/133] (753s left) kms_flip (wf_vblank-ts-check) [267.681048] Starting subtest: wf_vblank-ts-check [267.683384] Starting dynamic subtest: A-eDP1 [276.608287] Dynamic subtest A-eDP1: SUCCESS (8.925s) [276.621310] Starting dynamic subtest: B-eDP1 [285.500652] Dynamic subtest B-eDP1: SUCCESS (8.889s) [285.511467] Starting dynamic subtest: C-eDP1 [294.419663] Dynamic subtest C-eDP1: SUCCESS (8.879s) [294.429792] Starting dynamic subtest: D-eDP1 [303.328923] Dynamic subtest D-eDP1: SUCCESS (8.907s) [303.329837] Subtest wf_vblank-ts-check: SUCCESS (35.613s) [304.484080] [045/133] (716s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [304.572695] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [304.574434] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [304.653317] [046/133] (716s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [304.764443] Starting subtest: cursorB-vs-flipB-atomic-transitions [304.766287] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [304.902906] [047/133] (715s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [305.003842] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [305.005513] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [305.093226] [048/133] (715s left) syncobj_wait (wait-for-submit-complex) [305.143282] Starting subtest: wait-for-submit-complex [305.204781] Subtest wait-for-submit-complex: SUCCESS (0.061s) [305.288462] [049/133] (715s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [305.402530] Starting subtest: short-flip-before-cursor-toggle [306.329864] Subtest short-flip-before-cursor-toggle: SUCCESS (0.927s) [307.178065] [050/133] (713s left) gem_eio (kms) [307.441951] Starting subtest: kms [326.943858] Subtest kms: SUCCESS (19.492s) [328.089028] [051/133] (692s left) gem_pxp (fail-invalid-protected-context) [328.216147] Starting subtest: fail-invalid-protected-context [328.217184] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [328.317812] [052/133] (692s left) kms_psr (psr2-cursor-mmap-cpu) [328.404414] Starting subtest: psr2-cursor-mmap-cpu [328.405362] Starting dynamic subtest: eDP-1 [330.134131] Dynamic subtest eDP-1: SUCCESS (1.728s) [330.135177] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.729s) [330.984930] [053/133] (690s left) i915_suspend (debugfs-reader) [331.035647] Starting subtest: debugfs-reader [349.676837] Subtest debugfs-reader: SUCCESS (3.725s) [356.910047] [054/133] (671s left) kms_pm_rpm (cursor-dpms) [358.438999] Starting subtest: cursor-dpms [358.441540] Subtest cursor-dpms: SKIP (0.000s) [359.188490] [055/133] (669s left) gem_mmap_wc (read) [359.236840] Subtest read: SKIP (0.000s) [359.299798] [056/133] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [359.394682] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [366.365547] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.966s) [366.516139] [057/133] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [366.616944] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [366.618592] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [366.696464] [058/133] (661s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [366.738392] Starting subtest: etime-single-wait-all-available-unsubmitted [366.846446] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s) [366.921931] [059/133] (661s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [367.009101] Starting subtest: 2x-flip-vs-absolute-wf_vblank [367.020064] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [367.111766] [060/133] (661s left) gem_exec_balancer (hog) [367.177326] Starting subtest: hog [367.179554] Subtest hog: SKIP (0.000s) [367.475832] [061/133] (661s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [367.540433] Starting subtest: multi-wait-for-submit-available-submitted-signaled [367.541785] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [367.627515] [062/133] (660s left) gem_close (many-handles-one-vma) [367.681419] Starting subtest: many-handles-one-vma [367.705751] Subtest many-handles-one-vma: SUCCESS (0.024s) [367.822830] [063/133] (660s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [367.914132] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [367.915694] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [368.014233] [064/133] (660s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [368.125526] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [368.763450] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s) [368.929499] [065/133] (659s left) kms_flip (2x-flip-vs-suspend-interruptible) [369.024962] Starting subtest: 2x-flip-vs-suspend-interruptible [369.028661] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s) [369.116441] [066/133] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [369.198021] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [369.200035] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [369.288887] [067/133] (659s left) gem_lmem_swapping (heavy-random) [369.325634] Subtest heavy-random: SKIP (0.000s) [369.361913] [068/133] (659s left) kms_invalid_mode (uint-max-clock) [369.457509] Starting subtest: uint-max-clock [369.458435] Starting dynamic subtest: pipe-A-eDP-1 [369.746443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [369.756829] Starting dynamic subtest: pipe-B-eDP-1 [369.757693] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [369.767013] Starting dynamic subtest: pipe-C-eDP-1 [369.767909] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [369.780909] Starting dynamic subtest: pipe-D-eDP-1 [369.781683] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [369.782447] Subtest uint-max-clock: SUCCESS (0.295s) [370.578105] [069/133] (658s left) i915_drm_fdinfo (all-busy-idle-check-all) [370.620755] Starting subtest: all-busy-idle-check-all [370.625476] Subtest all-busy-idle-check-all: SKIP (0.004s) [370.699987] [070/133] (658s left) gem_basic (bad-close) [370.779543] Starting subtest: bad-close [370.781840] Subtest bad-close: SUCCESS (0.000s) [370.893541] [071/133] (658s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [370.990127] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [370.991225] Starting dynamic subtest: pipe-A-eDP-1 [371.440084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s) [371.452831] Starting dynamic subtest: pipe-B-eDP-1 [371.462225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [371.474448] Starting dynamic subtest: pipe-C-eDP-1 [371.482993] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [371.493181] Starting dynamic subtest: pipe-D-eDP-1 [371.500531] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [371.501336] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.465s) [373.686475] [072/133] (655s left) i915_pm_rpm (debugfs-forcewake-user) [375.414099] Starting subtest: debugfs-forcewake-user [386.818955] Subtest debugfs-forcewake-user: SUCCESS (11.404s) [387.205303] [073/133] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [387.301369] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [394.655740] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.355s) [394.790236] [074/133] (634s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [394.886616] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [394.887538] Starting dynamic subtest: pipe-A-eDP-1 [397.219047] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.333s) [397.230687] Starting dynamic subtest: pipe-B-eDP-1 [399.722398] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.502s) [399.733571] Starting dynamic subtest: pipe-C-eDP-1 [401.958365] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s) [401.970236] Starting dynamic subtest: pipe-D-eDP-1 [404.165926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.206s) [404.166880] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.280s) [405.390921] [075/133] (623s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [405.514178] Starting subtest: 2x-cursor-vs-flip-atomic [405.516131] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [405.673968] [076/133] (623s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [405.767673] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [406.415478] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s) [406.572668] [077/133] (622s left) gem_exec_schedule (implicit-write-read) [406.640846] Starting subtest: implicit-write-read [406.641926] Starting dynamic subtest: rcs0 [406.761431] Dynamic subtest rcs0: SUCCESS (0.120s) [406.775662] Starting dynamic subtest: vcs0 [406.855611] Dynamic subtest vcs0: SUCCESS (0.092s) [406.867469] Starting dynamic subtest: vcs1 [406.941178] Dynamic subtest vcs1: SUCCESS (0.084s) [406.951565] Starting dynamic subtest: vecs0 [407.034594] Dynamic subtest vecs0: SUCCESS (0.093s) [407.047342] Starting dynamic subtest: ccs0 [407.126994] Dynamic subtest ccs0: SUCCESS (0.091s) [407.128587] Subtest implicit-write-read: SUCCESS (0.486s) [408.338161] [078/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [408.425419] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [408.427059] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [408.517974] [079/133] (620s left) perf_pmu (busy-no-semaphores) [408.552447] Starting subtest: busy-no-semaphores [408.553456] Starting dynamic subtest: rcs0 [409.105416] Dynamic subtest rcs0: SUCCESS (0.543s) [409.115904] Starting dynamic subtest: bcs0 [409.656468] Dynamic subtest bcs0: SUCCESS (0.548s) [409.667814] Starting dynamic subtest: vcs0 [410.205094] Dynamic subtest vcs0: SUCCESS (0.545s) [410.216957] Starting dynamic subtest: vcs1 [411.758701] Dynamic subtest vcs1: SUCCESS (1.550s) [411.769469] Starting dynamic subtest: vecs0 [413.740651] Dynamic subtest vecs0: SUCCESS (1.979s) [413.751320] Starting dynamic subtest: ccs0 [415.790947] Dynamic subtest ccs0: SUCCESS (2.046s) [415.792234] Subtest busy-no-semaphores: SUCCESS (7.230s) [415.897351] [080/133] (613s left) gem_userptr_blits (sync-unmap-cycles) [415.951195] Starting subtest: sync-unmap-cycles [421.334737] Subtest sync-unmap-cycles: SUCCESS (5.382s) [421.453936] [081/133] (607s left) gem_mmap_gtt (pf-nonblock) [421.515642] Subtest pf-nonblock: SKIP (0.000s) [421.585925] [082/133] (607s left) prime_vgem (busy) [421.649851] Starting subtest: busy [421.650920] Starting dynamic subtest: rcs0 [421.729828] Dynamic subtest rcs0: SUCCESS (0.080s) [421.739683] Starting dynamic subtest: bcs0 [421.759494] Dynamic subtest bcs0: SUCCESS (0.029s) [421.769505] Starting dynamic subtest: vcs0 [421.807692] Dynamic subtest vcs0: SUCCESS (0.046s) [421.817771] Starting dynamic subtest: vcs1 [421.852413] Dynamic subtest vcs1: SUCCESS (0.045s) [421.862320] Starting dynamic subtest: vecs0 [421.901544] Dynamic subtest vecs0: SUCCESS (0.048s) [421.911519] Starting dynamic subtest: ccs0 [421.947990] Dynamic subtest ccs0: SUCCESS (0.046s) [421.948904] Subtest busy: SUCCESS (0.299s) [422.075688] [083/133] (607s left) syncobj_timeline (single-wait-for-submit-available-submitted) [422.128793] Starting subtest: single-wait-for-submit-available-submitted [422.129790] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [422.229834] [084/133] (607s left) kms_rotation_crc (primary-rotation-90) [422.322761] Starting subtest: primary-rotation-90 [422.324468] Subtest primary-rotation-90: SKIP (0.001s) [422.398940] [085/133] (607s left) kms_cursor_crc (cursor-rapid-movement-64x64) [422.575851] Starting subtest: cursor-rapid-movement-64x64 [422.578691] Starting dynamic subtest: pipe-A-eDP-1 [423.144260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [423.177245] Starting dynamic subtest: pipe-D-eDP-1 [424.401716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [424.402753] Subtest cursor-rapid-movement-64x64: SUCCESS (1.826s) [425.206720] [086/133] (604s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [425.307039] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [425.308978] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [425.405724] [087/133] (604s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [425.498834] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [425.501055] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [425.608940] [088/133] (603s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [425.699226] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [425.726650] Starting dynamic subtest: pipe-A-plane-0 [426.015368] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [426.025903] Starting dynamic subtest: pipe-A-plane-3 [426.248616] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [427.340458] Starting dynamic subtest: pipe-B-plane-0 [427.641649] Dynamic subtest pipe-B-plane-0: SUCCESS (0.310s) [427.653106] Starting dynamic subtest: pipe-B-plane-3 [427.886359] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s) [428.194282] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.495s) [429.010141] [089/133] (600s left) sysfs_timeslice_duration (idempotent) [429.061851] Starting subtest: idempotent [429.062729] Starting dynamic subtest: vecs0 [429.063600] Dynamic subtest vecs0: SUCCESS (0.000s) [429.074237] Starting dynamic subtest: ccs0 [429.075131] Dynamic subtest ccs0: SUCCESS (0.000s) [429.084670] Starting dynamic subtest: vcs0 [429.085605] Dynamic subtest vcs0: SUCCESS (0.001s) [429.095167] Starting dynamic subtest: bcs0 [429.096214] Dynamic subtest bcs0: SUCCESS (0.001s) [429.105866] Starting dynamic subtest: rcs0 [429.106829] Dynamic subtest rcs0: SUCCESS (0.000s) [429.116576] Starting dynamic subtest: vcs1 [429.117668] Dynamic subtest vcs1: SUCCESS (0.000s) [429.118675] Subtest idempotent: SUCCESS (0.009s) [429.166635] [090/133] (600s left) dumb_buffer (create-valid-dumb) [429.220569] Starting subtest: create-valid-dumb [429.221814] Subtest create-valid-dumb: SUCCESS (0.000s) [429.330346] [091/133] (600s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [429.419466] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [429.421711] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [429.510550] [092/133] (600s left) kms_addfb_basic (no-handle) [429.562252] Starting subtest: no-handle [429.563271] Subtest no-handle: SUCCESS (0.000s) [429.706953] [093/133] (600s left) kms_vrr (flipline) [429.799842] Starting subtest: flipline [429.802333] Subtest flipline: SKIP (0.000s) [429.883341] [094/133] (599s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [429.936813] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [429.939074] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [430.116036] [095/133] (599s left) kms_psr (psr2-sprite-render) [430.216638] Starting subtest: psr2-sprite-render [430.217884] Starting dynamic subtest: eDP-1 [431.952307] Dynamic subtest eDP-1: SUCCESS (1.736s) [431.953239] Subtest psr2-sprite-render: SUCCESS (1.737s) [432.789995] [096/133] (597s left) gem_exec_params (invalid-ring2) [432.835861] Starting subtest: invalid-ring2 [432.836857] Subtest invalid-ring2: SUCCESS (0.000s) [432.937734] [097/133] (596s left) kms_big_fb (linear-32bpp-rotate-90) [433.030003] Starting subtest: linear-32bpp-rotate-90 [433.049680] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [433.151805] [098/133] (596s left) kms_psr (fbc-psr2-primary-render) [433.237095] Starting subtest: fbc-psr2-primary-render [433.238016] Starting dynamic subtest: eDP-1 [433.239722] Dynamic subtest eDP-1: SKIP (0.000s) [433.241340] Subtest fbc-psr2-primary-render: SKIP (0.001s) [433.312223] [099/133] (596s left) kms_force_connector_basic (prune-stale-modes) [433.385909] Starting subtest: prune-stale-modes [433.853899] Subtest prune-stale-modes: SUCCESS (0.469s) [433.985968] [100/133] (596s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [434.106776] Starting subtest: cursorA-vs-flipA-toggle [445.235821] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.126s) [446.087443] [101/133] (583s left) kms_hdr (bpc-switch-dpms) [446.184126] Starting subtest: bpc-switch-dpms [447.232726] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [451.641149] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.408s) [452.731314] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [457.219099] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.500s) [457.220046] Subtest bpc-switch-dpms: SUCCESS (11.036s) [457.327764] [102/133] (572s left) gem_eio (in-flight-external) [457.547302] Starting subtest: in-flight-external [459.299560] Subtest in-flight-external: SUCCESS (1.753s) [459.433882] [103/133] (570s left) kms_cursor_crc (cursor-sliding-32x32) [459.574278] Starting subtest: cursor-sliding-32x32 [459.622479] Subtest cursor-sliding-32x32: SKIP (0.047s) [459.936587] [104/133] (570s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [460.029541] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [460.030610] Starting dynamic subtest: pipe-A-eDP-1 [466.940265] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.911s) [466.953127] Starting dynamic subtest: pipe-B-eDP-1 [474.029060] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.085s) [474.030171] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.001s) [474.875948] [105/133] (555s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [474.969273] Starting subtest: planes-downscale-factor-0-75-unity-scaling [474.970313] Starting dynamic subtest: pipe-A [475.034025] Dynamic subtest pipe-A: SUCCESS (0.065s) [475.046050] Starting dynamic subtest: pipe-B [476.182006] Dynamic subtest pipe-B: SUCCESS (1.147s) [476.194377] Starting dynamic subtest: pipe-C [477.358678] Dynamic subtest pipe-C: SUCCESS (1.176s) [477.369051] Starting dynamic subtest: pipe-D [478.466821] Dynamic subtest pipe-D: SUCCESS (1.107s) [478.467683] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.499s) [479.672009] [106/133] (550s left) kms_chamelium_hpd (vga-hpd-without-ddc) [480.065820] Subtest vga-hpd-without-ddc: SKIP (0.000s) [480.860170] [107/133] (549s left) kms_lease (lease-uevent) [480.958120] Starting subtest: lease-uevent [481.985041] Subtest lease-uevent: SUCCESS (1.018s) [482.090549] [108/133] (548s left) kms_cursor_legacy (torture-move) [482.202898] Starting subtest: torture-move [482.203960] Starting dynamic subtest: pipe-A [488.260615] Dynamic subtest pipe-A: SUCCESS (6.010s) [488.275838] Starting dynamic subtest: pipe-B [494.739034] Dynamic subtest pipe-B: SUCCESS (6.522s) [494.752930] Starting dynamic subtest: pipe-C [501.213682] Dynamic subtest pipe-C: SUCCESS (6.462s) [501.234320] Starting dynamic subtest: pipe-D [508.611106] Dynamic subtest pipe-D: SUCCESS (7.395s) [508.627611] Starting dynamic subtest: all-pipes [515.083347] Dynamic subtest all-pipes: SUCCESS (6.478s) [515.084587] Subtest torture-move: SUCCESS (32.877s) [515.239322] [109/133] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [515.336635] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [522.349424] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.010s) [522.498805] [110/133] (507s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [522.590678] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [522.592776] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [522.682130] [111/133] (507s left) kms_psr (fbc-pr-sprite-plane-move) [522.772303] Starting subtest: fbc-pr-sprite-plane-move [522.774873] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [522.855855] [112/133] (507s left) perf_pmu (init-sema) [522.894079] Starting subtest: init-sema [522.895552] Starting dynamic subtest: rcs0 [522.896885] Dynamic subtest rcs0: SUCCESS (0.001s) [522.910115] Starting dynamic subtest: bcs0 [522.911007] Dynamic subtest bcs0: SUCCESS (0.000s) [522.920996] Starting dynamic subtest: vcs0 [522.921926] Dynamic subtest vcs0: SUCCESS (0.000s) [522.931526] Starting dynamic subtest: vcs1 [522.932382] Dynamic subtest vcs1: SUCCESS (0.001s) [522.942337] Starting dynamic subtest: vecs0 [522.943227] Dynamic subtest vecs0: SUCCESS (0.000s) [522.952846] Starting dynamic subtest: ccs0 [522.953858] Dynamic subtest ccs0: SUCCESS (0.000s) [522.954740] Subtest init-sema: SUCCESS (0.007s) [523.006608] [113/133] (507s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [523.098078] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [523.099006] Starting dynamic subtest: pipe-A-eDP-1 [523.122140] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [523.134106] Starting dynamic subtest: pipe-B-eDP-1 [523.156579] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [523.166538] Starting dynamic subtest: pipe-C-eDP-1 [523.188943] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [523.199069] Starting dynamic subtest: pipe-D-eDP-1 [523.221679] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [523.223185] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [525.374054] [114/133] (505s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [525.435423] Starting subtest: invalid-single-wait-all-unsubmitted [525.436445] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [525.533251] [115/133] (505s left) gem_lmem_swapping (verify) [525.567777] Subtest verify: SKIP (0.000s) [525.606079] [116/133] (504s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [525.665562] Subtest writes-after-reads: SKIP (0.000s) [525.737112] [117/133] (504s left) kms_plane (pixel-format-yf-tiled-modifier) [525.839968] Starting subtest: pixel-format-yf-tiled-modifier [525.841813] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [525.910298] [118/133] (504s left) gem_bad_reloc (negative-reloc-lut) [525.960706] Subtest negative-reloc-lut: SKIP (0.000s) [526.028422] [119/133] (504s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [526.133198] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [526.135439] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [526.215292] [120/133] (504s left) kms_chamelium_edid (hdmi-mode-timings) [526.595930] Subtest hdmi-mode-timings: SKIP (0.000s) [527.364492] [121/133] (503s left) gen9_exec_parse (basic-rejected) [527.416681] Subtest basic-rejected: SKIP (0.000s) [527.485544] [122/133] (503s left) gem_ctx_isolation (preservation) [527.551234] Starting subtest: preservation [527.552357] Starting dynamic subtest: rcs0 [527.665888] Dynamic subtest rcs0: SUCCESS (0.113s) [527.677433] Starting dynamic subtest: bcs0 [527.832641] Dynamic subtest bcs0: SUCCESS (0.164s) [527.843515] Starting dynamic subtest: vcs0 [527.996306] Dynamic subtest vcs0: SUCCESS (0.164s) [528.007256] Starting dynamic subtest: vcs1 [529.359214] Dynamic subtest vcs1: SUCCESS (1.361s) [529.372971] Starting dynamic subtest: vecs0 [531.360448] Dynamic subtest vecs0: SUCCESS (2.000s) [531.372062] Starting dynamic subtest: ccs0 [533.357145] Dynamic subtest ccs0: SUCCESS (1.995s) [533.358375] Subtest preservation: SUCCESS (5.805s) [533.587653] [123/133] (497s left) gem_ppgtt (flink-and-close-vma-leak) [533.636866] Starting subtest: flink-and-close-vma-leak [533.683368] Subtest flink-and-close-vma-leak: SUCCESS (0.046s) [533.816060] [124/133] (497s left) perf (buffer-fill) [533.950741] Starting subtest: buffer-fill [533.951508] Starting dynamic subtest: 0-rcs0 [536.259456] Dynamic subtest 0-rcs0: SUCCESS (2.299s) [536.272442] Starting dynamic subtest: 1-vcs1 [540.741675] Dynamic subtest 1-vcs1: SUCCESS (4.481s) [540.742701] Subtest buffer-fill: SUCCESS (6.782s) [540.778158] [125/133] (490s left) kms_psr (fbc-psr-cursor-plane-onoff) [540.868050] Starting subtest: fbc-psr-cursor-plane-onoff [540.869073] Starting dynamic subtest: eDP-1 [540.878996] Dynamic subtest eDP-1: SKIP (0.000s) [540.880988] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [540.958358] [126/133] (490s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [541.073597] Starting subtest: cursorA-vs-flipA-legacy [552.201269] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s) [553.075766] [127/133] (477s left) gem_ctx_persistence (legacy-engines-hostile) [553.141595] Starting subtest: legacy-engines-hostile [553.143865] Starting dynamic subtest: render [553.289333] Dynamic subtest render: SUCCESS (0.146s) [553.303700] Starting dynamic subtest: bsd1 [553.361882] Dynamic subtest bsd1: SUCCESS (0.070s) [553.376390] Starting dynamic subtest: bsd2 [553.475332] Dynamic subtest bsd2: SUCCESS (0.110s) [553.489595] Starting dynamic subtest: blt [553.569043] Dynamic subtest blt: SUCCESS (0.091s) [553.583675] Starting dynamic subtest: vebox [553.672521] Dynamic subtest vebox: SUCCESS (0.100s) [553.674332] Subtest legacy-engines-hostile: SUCCESS (0.532s) [553.749360] [128/133] (477s left) kms_cursor_crc (cursor-alpha-opaque) [553.840077] Starting subtest: cursor-alpha-opaque [553.841037] Starting dynamic subtest: pipe-A-eDP-1 [554.464073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s) [554.478088] Starting dynamic subtest: pipe-D-eDP-1 [555.718986] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [555.719861] Subtest cursor-alpha-opaque: SUCCESS (1.879s) [556.581808] [129/133] (474s left) kms_async_flips (invalid-async-flip-atomic) [556.678062] Starting subtest: invalid-async-flip-atomic [557.056536] Starting dynamic subtest: pipe-A-eDP-1 [557.866980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s) [558.227351] Starting dynamic subtest: pipe-B-eDP-1 [559.084953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.867s) [559.446774] Starting dynamic subtest: pipe-C-eDP-1 [560.258550] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.821s) [560.615367] Starting dynamic subtest: pipe-D-eDP-1 [561.464764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.859s) [561.465763] Subtest invalid-async-flip-atomic: SUCCESS (4.788s) [562.672602] [130/133] (468s left) gem_exec_fence (basic-wait-all) [562.734369] Starting subtest: basic-wait-all [562.820649] Subtest basic-wait-all: SUCCESS (0.088s) [564.278059] [131/133] (466s left) kms_pm_dc (dc5-retention-flops) [565.381374] Starting subtest: dc5-retention-flops [565.383208] Subtest dc5-retention-flops: SKIP (0.000s) [565.453927] [132/133] (465s left) kms_setmode (clone-exclusive-crtc) [565.500157] Starting subtest: clone-exclusive-crtc [565.502560] Subtest clone-exclusive-crtc: SKIP (0.000s) [565.615745] [133/133] (465s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [565.699359] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [565.700183] Starting dynamic subtest: pipe-A-eDP-1 [565.703638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [565.714341] Starting dynamic subtest: pipe-B-eDP-1 [565.718192] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [565.728561] Starting dynamic subtest: pipe-C-eDP-1 [565.732427] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [565.742495] Starting dynamic subtest: pipe-D-eDP-1 [565.746035] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [565.747897] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [567.970031] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: api_intel_bb results: parsing output: 3/ for test: kms_cursor_crc results: parsing output: 4/ for test: kms_color_pipeline results: parsing output: 5/ for test: gem_exec_endless results: parsing output: 6/ for test: gem_userptr_blits results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: kms_chamelium_color results: parsing output: 9/ for test: gem_exec_schedule results: parsing output: 10/ for test: kms_plane_alpha_blend results: parsing output: 11/ for test: gem_mmap_wc results: parsing output: 12/ for test: i915_module_load results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: syncobj_wait results: parsing output: 15/ for test: api_intel_allocator results: parsing output: 16/ for test: gem_create results: parsing output: 17/ for test: kms_force_connector_basic results: parsing output: 18/ for test: kms_dsc results: parsing output: 19/ for test: kms_atomic_transition results: parsing output: 20/ for test: syncobj_basic results: parsing output: 21/ for test: gem_render_copy results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: syncobj_basic results: parsing output: 24/ for test: gem_softpin results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_rotation_crc results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: gem_eio results: parsing output: 31/ for test: gem_exec_fence results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_whisper results: parsing output: 34/ for test: gem_exec_nop results: parsing output: 35/ for test: gem_exec_gttfill results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: kms_universal_plane results: parsing output: 38/ for test: kms_atomic_transition results: parsing output: 39/ for test: kms_addfb_basic results: parsing output: 40/ for test: kms_flip_scaled_crc results: parsing output: 41/ for test: sw_sync results: parsing output: 42/ for test: kms_properties results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: kms_cursor_legacy results: parsing output: 49/ for test: gem_eio results: parsing output: 50/ for test: gem_pxp results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: i915_suspend results: parsing output: 53/ for test: kms_pm_rpm results: parsing output: 54/ for test: gem_mmap_wc results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: gem_exec_balancer results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: gem_close results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: kms_invalid_mode results: parsing output: 68/ for test: i915_drm_fdinfo results: parsing output: 69/ for test: gem_basic results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: i915_pm_rpm results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_ccs results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_exec_schedule results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: gem_userptr_blits results: parsing output: 80/ for test: gem_mmap_gtt results: parsing output: 81/ for test: prime_vgem results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_rotation_crc results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_plane results: parsing output: 88/ for test: sysfs_timeslice_duration results: parsing output: 89/ for test: dumb_buffer results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_vrr results: parsing output: 93/ for test: gem_render_copy results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: gem_exec_params results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: kms_force_connector_basic results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_hdr results: parsing output: 101/ for test: gem_eio results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_psr2_sf results: parsing output: 104/ for test: kms_plane_scaling results: parsing output: 105/ for test: kms_chamelium_hpd results: parsing output: 106/ for test: kms_lease results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: perf_pmu results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: syncobj_wait results: parsing output: 114/ for test: gem_lmem_swapping results: parsing output: 115/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 116/ for test: kms_plane results: parsing output: 117/ for test: gem_bad_reloc results: parsing output: 118/ for test: kms_psr2_sf results: parsing output: 119/ for test: kms_chamelium_edid results: parsing output: 120/ for test: gen9_exec_parse results: parsing output: 121/ for test: gem_ctx_isolation results: parsing output: 122/ for test: gem_ppgtt results: parsing output: 123/ for test: perf results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_cursor_crc results: parsing output: 128/ for test: kms_async_flips results: parsing output: 129/ for test: gem_exec_fence results: parsing output: 130/ for test: kms_pm_dc results: parsing output: 131/ for test: kms_setmode results: parsing output: 132/ for test: kms_ccs Done.