[70.528991] Initializing watchdogs [70.529060] /dev/watchdog0 [70.542284] [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] [70.546539] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [70.548770] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [70.552244] [001/134] (960s left) kms_psr (fbc-pr-sprite-render) [70.678461] Starting subtest: fbc-pr-sprite-render [70.683670] Subtest fbc-pr-sprite-render: SKIP (0.000s) [70.747558] [002/134] (960s left) kms_pm_backlight (bad-brightness) [70.847366] Starting subtest: bad-brightness [70.940083] Starting dynamic subtest: eDP-1 [71.235732] Dynamic subtest eDP-1: SUCCESS (0.293s) [71.238089] Subtest bad-brightness: SUCCESS (0.389s) [72.026071] [003/134] (959s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [72.082315] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [72.134144] [004/134] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [72.288861] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [72.293466] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [72.419262] [005/134] (958s left) kms_prop_blob (invalid-set-prop-any) [72.631902] Starting subtest: invalid-set-prop-any [72.634652] Subtest invalid-set-prop-any: SUCCESS (0.000s) [72.812982] [006/134] (958s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [73.017144] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [73.030881] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [73.201011] [007/134] (958s left) intel_hwmon (hwmon-write) [73.266384] Subtest hwmon-write: SKIP (0.000s) [73.398135] [008/134] (957s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [73.523270] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [73.525674] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [73.626782] [009/134] (957s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [73.728204] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [73.730707] Starting dynamic subtest: pipe-A [73.793124] Dynamic subtest pipe-A: SUCCESS (0.065s) [73.800631] Starting dynamic subtest: pipe-B [75.010975] Dynamic subtest pipe-B: SUCCESS (1.175s) [75.021261] Starting dynamic subtest: pipe-C [76.154239] Dynamic subtest pipe-C: SUCCESS (1.109s) [76.163509] Starting dynamic subtest: pipe-D [77.322069] Dynamic subtest pipe-D: SUCCESS (1.138s) [77.324474] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.489s) [78.482186] [010/134] (952s left) gem_exec_params (cliprects-invalid) [78.545100] Starting subtest: cliprects-invalid [78.547461] Subtest cliprects-invalid: SUCCESS (0.000s) [78.663975] [011/134] (952s left) kms_plane (plane-panning-bottom-right-suspend) [78.754801] Starting subtest: plane-panning-bottom-right-suspend [78.756711] Starting dynamic subtest: pipe-A [96.528957] Dynamic subtest pipe-A: SUCCESS (3.012s) [96.538986] Starting dynamic subtest: pipe-B [114.517100] Dynamic subtest pipe-B: SUCCESS (3.385s) [114.519603] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.400s) [115.346299] [012/134] (916s left) gem_ctx_persistence (process) [115.404850] Starting subtest: process [115.566359] Subtest process: SUCCESS (0.161s) [115.670208] [013/134] (915s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [115.786368] Starting subtest: cursorB-vs-flipB-atomic [115.791025] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [115.930058] [014/134] (915s left) kms_flip (flip-vs-panning-vs-hang) [116.049611] Starting subtest: flip-vs-panning-vs-hang [116.051985] Starting dynamic subtest: A-eDP1 [166.990251] Dynamic subtest A-eDP1: SUCCESS (50.705s) [167.004611] Starting dynamic subtest: D-eDP1 [216.970428] Dynamic subtest D-eDP1: SUCCESS (49.966s) [216.972802] Subtest flip-vs-panning-vs-hang: SUCCESS (100.674s) [218.110298] [015/134] (813s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [218.203418] Starting subtest: psr-rgb101010-draw-mmap-gtt [218.207390] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [218.313819] [016/134] (813s left) kms_color_pipeline (plane-ctm3x4) [218.403384] Starting subtest: plane-ctm3x4 [218.540645] Starting dynamic subtest: pipe-A-plane-0 [218.685469] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [218.697065] Starting dynamic subtest: pipe-A-plane-1 [218.796035] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s) [218.806044] Starting dynamic subtest: pipe-A-plane-2 [218.906889] Dynamic subtest pipe-A-plane-2: SUCCESS (0.111s) [220.095603] Starting dynamic subtest: pipe-B-plane-0 [220.208628] Dynamic subtest pipe-B-plane-0: SUCCESS (0.122s) [220.217223] Starting dynamic subtest: pipe-B-plane-1 [220.319576] Dynamic subtest pipe-B-plane-1: SUCCESS (0.111s) [220.328407] Starting dynamic subtest: pipe-B-plane-2 [220.453072] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [221.641093] Starting dynamic subtest: pipe-C-plane-0 [221.745420] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [221.754203] Starting dynamic subtest: pipe-C-plane-1 [221.867666] Dynamic subtest pipe-C-plane-1: SUCCESS (0.122s) [221.878136] Starting dynamic subtest: pipe-C-plane-2 [221.989936] Dynamic subtest pipe-C-plane-2: SUCCESS (0.122s) [223.189581] Starting dynamic subtest: pipe-D-plane-0 [223.315299] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [223.324470] Starting dynamic subtest: pipe-D-plane-1 [223.425932] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s) [223.436933] Starting dynamic subtest: pipe-D-plane-2 [223.536927] Dynamic subtest pipe-D-plane-2: SUCCESS (0.111s) [223.824328] Subtest plane-ctm3x4: SUCCESS (5.421s) [224.653261] [017/134] (807s left) gem_userptr_blits (vma-merge) [224.728972] Starting subtest: vma-merge [224.775868] Subtest vma-merge: SUCCESS (0.047s) [224.893664] [018/134] (806s left) kms_chamelium_frames (hdmi-crc-fast) [225.276017] Subtest hdmi-crc-fast: SKIP (0.000s) [226.052227] [019/134] (805s left) kms_addfb_basic (framebuffer-vs-set-tiling) [226.114935] Starting subtest: framebuffer-vs-set-tiling [226.119526] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [226.249962] [020/134] (805s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [226.351158] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [226.355543] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [226.440952] [021/134] (805s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [226.548775] Starting subtest: flip-vs-cursor-atomic-transitions [234.398496] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.850s) [235.213885] [022/134] (796s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [235.265188] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [235.267514] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [235.355926] [023/134] (796s left) prime_self_import (basic-with_fd_dup) [235.390749] Starting subtest: basic-with_fd_dup [235.403943] Subtest basic-with_fd_dup: SUCCESS (0.015s) [235.506317] [024/134] (796s left) gem_pipe_control_store_loop (fresh-buffer) [235.567192] Starting subtest: fresh-buffer [237.718906] Subtest fresh-buffer: SUCCESS (2.152s) [237.847535] [025/134] (794s left) gen9_exec_parse (bb-start-out) [237.911625] Subtest bb-start-out: SKIP (0.000s) [237.984565] [026/134] (794s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [238.084488] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [238.086785] Starting dynamic subtest: pipe-A-eDP-1 [243.992844] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.911s) [244.003034] Starting dynamic subtest: pipe-B-eDP-1 [250.655172] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s) [250.657468] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.576s) [251.521031] [027/134] (780s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [251.614393] Starting subtest: 2x-flip-vs-blocking-wf-vblank [251.625546] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s) [251.727402] [028/134] (780s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [251.784815] Starting subtest: y-tiled-ccs-to-y-tiled [251.789309] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [251.964729] [029/134] (780s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [252.060227] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [252.071925] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s) [252.144919] [030/134] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [252.242749] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [259.536199] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.296s) [259.661751] [031/134] (772s left) kms_cursor_legacy (single-bo) [259.781669] Starting subtest: single-bo [259.783985] Starting dynamic subtest: pipe-A [265.165964] Dynamic subtest pipe-A: SUCCESS (5.379s) [265.177892] Starting dynamic subtest: pipe-B [270.547883] Dynamic subtest pipe-B: SUCCESS (5.379s) [270.558862] Starting dynamic subtest: pipe-C [275.929677] Dynamic subtest pipe-C: SUCCESS (5.379s) [275.940485] Starting dynamic subtest: pipe-D [281.312152] Dynamic subtest pipe-D: SUCCESS (5.379s) [281.324902] Starting dynamic subtest: all-pipes [286.700332] Dynamic subtest all-pipes: SUCCESS (5.385s) [286.702903] Subtest single-bo: SUCCESS (26.912s) [286.843316] [032/134] (745s left) gem_exec_params (secure-non-root) [286.899378] Starting subtest: secure-non-root [286.903862] Subtest secure-non-root: SKIP (0.000s) [287.026201] [033/134] (745s left) perf (global-sseu-config-invalid) [287.159785] Starting subtest: global-sseu-config-invalid [287.164098] Subtest global-sseu-config-invalid: SKIP (0.000s) [287.198464] [034/134] (745s left) kms_lease (lease-unleased-connector) [287.292307] Starting subtest: lease-unleased-connector [287.294630] Starting dynamic subtest: pipe-A-eDP-1 [287.296858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [287.307343] Starting dynamic subtest: pipe-B-eDP-1 [287.309545] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [287.319091] Starting dynamic subtest: pipe-C-eDP-1 [287.321394] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [287.329571] Starting dynamic subtest: pipe-D-eDP-1 [287.331456] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [287.333221] Subtest lease-unleased-connector: SUCCESS (0.031s) [287.426636] [035/134] (744s left) gem_exec_fence (basic-busy) [287.605082] Starting subtest: basic-busy [287.607846] Starting dynamic subtest: rcs0 [287.687849] Dynamic subtest rcs0: SUCCESS (0.083s) [287.699968] Starting dynamic subtest: bcs0 [287.748689] Dynamic subtest bcs0: SUCCESS (0.059s) [287.759751] Starting dynamic subtest: vcs0 [287.810351] Dynamic subtest vcs0: SUCCESS (0.060s) [287.819800] Starting dynamic subtest: vcs1 [287.872674] Dynamic subtest vcs1: SUCCESS (0.061s) [287.883796] Starting dynamic subtest: vecs0 [287.928704] Dynamic subtest vecs0: SUCCESS (0.053s) [287.939327] Starting dynamic subtest: ccs0 [287.991740] Dynamic subtest ccs0: SUCCESS (0.061s) [287.994194] Subtest basic-busy: SUCCESS (0.388s) [289.563842] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [289.567172] [036/134] (742s left) gem_exec_whisper (basic-normal) [289.635036] Starting subtest: basic-normal [294.890471] Subtest basic-normal: SUCCESS (5.252s) [295.076611] [037/134] (737s left) kms_cursor_crc (cursor-rapid-movement-128x42) [295.326183] Starting subtest: cursor-rapid-movement-128x42 [295.370466] Subtest cursor-rapid-movement-128x42: SKIP (0.042s) [295.572278] [038/134] (736s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [296.101004] Starting subtest: syncobj-timeline-multiple-ext-nodes [296.103988] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [297.558433] [039/134] (734s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [297.658216] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [297.662722] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [298.808943] [040/134] (733s left) gem_exec_params (rel-constants-invalid-ring) [298.864524] Starting subtest: rel-constants-invalid-ring [298.866902] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [298.960389] [041/134] (733s left) kms_atomic (atomic-plane-damage) [299.049068] Starting subtest: atomic-plane-damage [299.098191] Starting dynamic subtest: pipe-A-eDP-1 [299.625221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.524s) [299.627175] Subtest atomic-plane-damage: SUCCESS (0.576s) [300.435401] [042/134] (732s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [300.540836] Starting subtest: yf-tiled-64bpp-rotate-0 [300.545184] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [300.632417] [043/134] (732s left) gem_ctx_param (root-set) [300.676855] Starting subtest: root-set [300.679191] Subtest root-set: SUCCESS (0.001s) [300.790682] [044/134] (731s left) gem_exec_reloc (basic-write-gtt) [300.848096] Subtest basic-write-gtt: SKIP (0.000s) [300.915418] [045/134] (731s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [300.977583] Starting subtest: multi-wait-for-submit-available-submitted [300.979940] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [301.082555] [046/134] (731s left) gem_exec_params (batch-first) [301.130898] Starting subtest: batch-first [301.136456] Subtest batch-first: SUCCESS (0.006s) [301.279248] [047/134] (731s left) i915_drm_fdinfo (idle) [301.317905] Starting subtest: idle [301.320146] Starting dynamic subtest: rcs0 [301.884753] Dynamic subtest rcs0: SUCCESS (0.566s) [301.895011] Starting dynamic subtest: bcs0 [302.391051] Dynamic subtest bcs0: SUCCESS (0.503s) [302.402342] Starting dynamic subtest: vcs0 [302.895181] Dynamic subtest vcs0: SUCCESS (0.503s) [302.907776] Starting dynamic subtest: vcs1 [303.402054] Dynamic subtest vcs1: SUCCESS (0.504s) [303.414995] Starting dynamic subtest: vecs0 [303.907966] Dynamic subtest vecs0: SUCCESS (0.503s) [303.920488] Starting dynamic subtest: ccs0 [304.413440] Dynamic subtest ccs0: SUCCESS (0.503s) [304.416031] Subtest idle: SUCCESS (3.096s) [304.488792] [048/134] (728s left) prime_busy (before) [304.556167] Starting subtest: before [304.560997] Starting dynamic subtest: rcs0 [304.597822] Dynamic subtest rcs0: SUCCESS (0.038s) [304.609853] Starting dynamic subtest: bcs0 [304.654184] Dynamic subtest bcs0: SUCCESS (0.054s) [304.665172] Starting dynamic subtest: vcs0 [304.696585] Dynamic subtest vcs0: SUCCESS (0.041s) [304.706131] Starting dynamic subtest: vcs1 [304.739456] Dynamic subtest vcs1: SUCCESS (0.042s) [304.749327] Starting dynamic subtest: vecs0 [304.782654] Dynamic subtest vecs0: SUCCESS (0.043s) [304.792754] Starting dynamic subtest: ccs0 [304.826141] Dynamic subtest ccs0: SUCCESS (0.043s) [304.934406] Subtest before: SUCCESS (0.376s) [305.008408] [049/134] (727s left) gem_exec_schedule (implicit-boths) [305.082489] Starting subtest: implicit-boths [305.084882] Starting dynamic subtest: rcs0 [305.247989] Dynamic subtest rcs0: SUCCESS (0.175s) [305.262803] Starting dynamic subtest: vcs0 [305.372827] Dynamic subtest vcs0: SUCCESS (0.124s) [305.385279] Starting dynamic subtest: vcs1 [305.488929] Dynamic subtest vcs1: SUCCESS (0.115s) [305.502553] Starting dynamic subtest: vecs0 [305.599486] Dynamic subtest vecs0: SUCCESS (0.110s) [305.611723] Starting dynamic subtest: ccs0 [305.720615] Dynamic subtest ccs0: SUCCESS (0.119s) [305.723360] Subtest implicit-boths: SUCCESS (0.647s) [306.649103] [050/134] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [306.747861] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [310.450998] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.708s) [311.647172] [051/134] (721s left) core_auth (basic-auth) [311.712243] Starting subtest: basic-auth [311.714544] Subtest basic-auth: SUCCESS (0.001s) [311.825583] [052/134] (721s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [311.930404] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [311.934429] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [312.024415] [053/134] (721s left) gem_spin_batch (spin-all) [312.086629] Starting subtest: spin-all [312.102329] Subtest spin-all: SUCCESS (0.015s) [313.542372] [054/134] (719s left) kms_vrr (max-min) [313.635027] Starting subtest: max-min [313.641645] Subtest max-min: SKIP (0.000s) [313.726545] [055/134] (719s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [313.825925] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [320.715233] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.890s) [320.855559] [056/134] (712s left) kms_big_fb (linear-64bpp-rotate-270) [320.966553] Starting subtest: linear-64bpp-rotate-270 [320.988319] Subtest linear-64bpp-rotate-270: SKIP (0.021s) [321.099940] [057/134] (712s left) device_reset (unbind-reset-rebind) [321.145989] Starting subtest: unbind-reset-rebind [327.335494] Subtest unbind-reset-rebind: SUCCESS (6.185s) [327.383000] [058/134] (705s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [327.483878] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [327.486105] Starting dynamic subtest: pipe-A-eDP-1 [327.514561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [327.527324] Starting dynamic subtest: pipe-B-eDP-1 [327.548246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [327.558315] Starting dynamic subtest: pipe-C-eDP-1 [327.579752] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [327.589049] Starting dynamic subtest: pipe-D-eDP-1 [327.611474] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [327.615894] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [329.746001] [059/134] (703s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [329.838959] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [329.841467] Starting dynamic subtest: pipe-A-eDP-1 [329.864903] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [329.877246] Starting dynamic subtest: pipe-B-eDP-1 [329.899436] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [329.909736] Starting dynamic subtest: pipe-C-eDP-1 [329.931852] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [329.942213] Starting dynamic subtest: pipe-D-eDP-1 [329.964848] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [329.968980] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s) [332.123052] [060/134] (701s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [332.249938] Starting subtest: basic-busy-flip-before-cursor-varying-size [332.254646] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [332.397564] [061/134] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [332.491362] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [332.495594] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [332.585887] [062/134] (700s left) i915_hangman (gt-engine-error) [332.656470] Starting subtest: gt-engine-error [332.658880] Starting dynamic subtest: rcs0 [334.465383] Dynamic subtest rcs0: SUCCESS (1.806s) [334.476639] Starting dynamic subtest: bcs0 [336.512197] Dynamic subtest bcs0: SUCCESS (2.043s) [336.530159] Starting dynamic subtest: vcs0 [338.432107] Dynamic subtest vcs0: SUCCESS (1.916s) [338.445594] Starting dynamic subtest: vcs1 [340.478700] Dynamic subtest vcs1: SUCCESS (2.043s) [340.492492] Starting dynamic subtest: vecs0 [342.462202] Dynamic subtest vecs0: SUCCESS (1.979s) [342.477923] Starting dynamic subtest: ccs0 [344.447472] Dynamic subtest ccs0: SUCCESS (1.983s) [344.450210] Subtest gt-engine-error: SUCCESS (11.789s) [344.621688] [063/134] (688s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [344.722540] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [351.534562] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.817s) [351.694796] [064/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [351.745157] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [351.747568] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [351.843417] [065/134] (681s left) gem_exec_reloc (basic-cpu-gtt-active) [351.894751] Subtest basic-cpu-gtt-active: SKIP (0.000s) [351.957707] [066/134] (681s left) gem_exec_params (dr1-dirt) [352.018093] Starting subtest: DR1-dirt [352.020560] Subtest DR1-dirt: SUCCESS (0.000s) [352.122429] [067/134] (681s left) kms_psr (fbc-psr2-sprite-blt) [352.206936] Starting subtest: fbc-psr2-sprite-blt [352.209248] Starting dynamic subtest: eDP-1 [352.213439] Dynamic subtest eDP-1: SKIP (0.000s) [352.217719] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [352.292089] [068/134] (681s left) prime_self_import (reimport-vs-gem_close-race) [352.325887] Starting subtest: reimport-vs-gem_close-race [357.385285] Subtest reimport-vs-gem_close-race: SUCCESS (5.062s) [357.476471] [069/134] (676s left) gem_ctx_persistence (engines-hostile-preempt) [357.529179] Starting subtest: engines-hostile-preempt [357.531669] Starting dynamic subtest: rcs0 [357.587627] Dynamic subtest rcs0: SUCCESS (0.059s) [357.599904] Starting dynamic subtest: bcs0 [357.650969] Dynamic subtest bcs0: SUCCESS (0.062s) [357.663576] Starting dynamic subtest: vcs0 [359.518173] Dynamic subtest vcs0: SUCCESS (1.864s) [359.530922] Starting dynamic subtest: vcs1 [361.477934] Dynamic subtest vcs1: SUCCESS (1.957s) [361.490646] Starting dynamic subtest: vecs0 [363.481860] Dynamic subtest vecs0: SUCCESS (2.002s) [363.497989] Starting dynamic subtest: ccs0 [363.563509] Dynamic subtest ccs0: SUCCESS (0.080s) [363.566367] Subtest engines-hostile-preempt: SUCCESS (6.036s) [363.645429] [070/134] (670s left) kms_big_fb (y-tiled-8bpp-rotate-0) [363.748828] Starting subtest: y-tiled-8bpp-rotate-0 [363.752990] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [363.845929] [071/134] (670s left) gem_exec_suspend (basic-s4-devices) [363.903140] Starting subtest: basic-S4-devices [363.905421] Starting dynamic subtest: smem [375.455522] Dynamic subtest smem: SUCCESS (11.552s) [375.458734] Subtest basic-S4-devices: SUCCESS (11.554s) [375.640231] [072/134] (658s left) kms_psr (psr2-primary-page-flip) [375.733532] Starting subtest: psr2-primary-page-flip [375.735902] Starting dynamic subtest: eDP-1 [377.434205] Dynamic subtest eDP-1: SUCCESS (1.700s) [377.436637] Subtest psr2-primary-page-flip: SUCCESS (1.701s) [378.321383] [073/134] (655s left) kms_chamelium_color (ctm-0-50) [378.418358] Subtest ctm-0-50: SKIP (0.000s) [378.465052] [074/134] (655s left) kms_content_protection (dp-mst-type-0-suspend-resume) [378.611995] Starting subtest: dp-mst-type-0-suspend-resume [378.616633] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s) [378.749304] [075/134] (655s left) kms_plane_lowres (tiling-yf) [378.834225] Starting subtest: tiling-yf [378.838271] Subtest tiling-yf: SKIP (0.000s) [378.922516] [076/134] (655s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [378.972209] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [379.076405] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [379.157081] [077/134] (654s left) kms_psr (psr2-primary-mmap-cpu) [379.237319] Starting subtest: psr2-primary-mmap-cpu [379.239651] Starting dynamic subtest: eDP-1 [380.998474] Dynamic subtest eDP-1: SUCCESS (1.760s) [381.000430] Subtest psr2-primary-mmap-cpu: SUCCESS (1.761s) [381.883426] [078/134] (652s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [381.984817] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [381.989287] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [382.085946] [079/134] (652s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [382.181949] Starting subtest: fbcpsr-tiling-linear [388.780396] Subtest fbcpsr-tiling-linear: SUCCESS (6.601s) [388.921624] [080/134] (645s left) syncobj_timeline (transfer-timeline-point) [388.980304] Starting subtest: transfer-timeline-point [388.982631] Subtest transfer-timeline-point: SUCCESS (0.000s) [389.100344] [081/134] (645s left) gem_mmap_gtt (ptrace) [389.163025] Subtest ptrace: SKIP (0.000s) [389.226198] [082/134] (645s left) gem_exec_balancer (noheartbeat) [389.481192] Starting subtest: noheartbeat [389.486178] Subtest noheartbeat: SKIP (0.000s) [389.581529] [083/134] (644s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [389.685614] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [390.487728] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.804s) [390.660653] [084/134] (643s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [390.783821] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [390.942097] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.161s) [391.067155] [085/134] (643s left) gem_mmap (bad-size) [391.124775] Subtest bad-size: SKIP (0.000s) [391.196222] [086/134] (643s left) syncobj_eventfd (invalid-illegal-eventfd) [391.252639] Starting subtest: invalid-illegal-eventfd [391.254632] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [391.353694] [087/134] (643s left) gem_exec_schedule (u-semaphore-noskip) [391.426388] Starting subtest: u-semaphore-noskip [391.841401] Subtest u-semaphore-noskip: SUCCESS (0.419s) [392.162403] [088/134] (642s left) gem_exec_schedule (preempt-queue-contexts-chain) [392.232112] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [392.520979] [089/134] (642s left) gem_eio (create-ext) [392.749401] Starting subtest: create-ext [393.069557] Subtest create-ext: SUCCESS (0.320s) [393.210796] [090/134] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [393.307016] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [400.104572] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.801s) [400.256829] [091/134] (634s left) gem_eio (hibernate) [400.492527] Starting subtest: hibernate [415.155137] Subtest hibernate: SUCCESS (14.660s) [415.280584] [092/134] (619s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [415.369939] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [415.374356] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [415.468529] [093/134] (619s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [415.573286] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [415.575552] Starting dynamic subtest: pipe-A-eDP-1 [415.673904] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [415.686826] Starting dynamic subtest: pipe-B-eDP-1 [416.797062] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [416.801591] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.226s) [417.988384] [094/134] (616s left) kms_explicit_fence (multiplane-atomic-fence-wait) [418.130177] Starting subtest: multiplane-atomic-fence-wait [418.446574] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s) [419.624400] [095/134] (615s left) gem_mmap_wc (copy) [419.683271] Subtest copy: SKIP (0.000s) [419.737027] [096/134] (615s left) kms_dsc (dsc-fractional-bpp-with-bpc-ultrajoiner) [419.838740] Starting subtest: dsc-fractional-bpp-with-bpc-ultrajoiner [419.849542] Subtest dsc-fractional-bpp-with-bpc-ultrajoiner: SKIP (0.000s) [419.914453] [097/134] (615s left) gem_userptr_blits (unsync-overlap) [419.979034] Subtest unsync-overlap: SKIP (0.000s) [420.106716] [098/134] (614s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [420.204883] Starting subtest: verify-pxp-key-change-after-suspend-resume [427.410942] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.207s) [427.539235] [099/134] (607s left) kms_big_fb (x-tiled-64bpp-rotate-270) [427.640587] Starting subtest: x-tiled-64bpp-rotate-270 [427.660513] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [427.773508] [100/134] (607s left) gem_ringfill (legacy-basic) [433.511207] Starting subtest: legacy-basic [433.513613] Starting dynamic subtest: default [433.564757] Dynamic subtest default: SUCCESS (0.053s) [433.579918] Starting dynamic subtest: render [433.606292] Dynamic subtest render: SUCCESS (0.040s) [433.621889] Starting dynamic subtest: bsd [433.651488] Dynamic subtest bsd: SUCCESS (0.042s) [433.663179] Starting dynamic subtest: bsd1 [433.692492] Dynamic subtest bsd1: SUCCESS (0.039s) [433.704206] Starting dynamic subtest: bsd2 [433.734294] Dynamic subtest bsd2: SUCCESS (0.040s) [433.746395] Starting dynamic subtest: blt [433.780712] Dynamic subtest blt: SUCCESS (0.044s) [433.793277] Starting dynamic subtest: vebox [433.823585] Dynamic subtest vebox: SUCCESS (0.040s) [433.826503] Subtest legacy-basic: SUCCESS (0.314s) [433.916547] [101/134] (601s left) i915_pm_rpm (gem-mmap-type) [435.651000] Starting subtest: gem-mmap-type [435.653992] Starting dynamic subtest: wb-smem0 [439.602477] Dynamic subtest wb-smem0: SUCCESS (3.948s) [439.615029] Starting dynamic subtest: wc-smem0 [442.786273] Dynamic subtest wc-smem0: SUCCESS (3.183s) [442.802674] Starting dynamic subtest: uc-smem0 [445.991216] Dynamic subtest uc-smem0: SUCCESS (3.203s) [445.993572] Subtest gem-mmap-type: SUCCESS (10.339s) [446.124816] [102/134] (589s left) kms_selftest (drm_cmdline_parser) [446.162944] Starting subtest: drm_cmdline_parser [446.177423] Starting dynamic subtest: drm_test_cmdline_force_d_only [446.308996] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.131s) [446.321048] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [446.409971] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.100s) [446.423211] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [446.529190] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.119s) [446.540805] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [446.610739] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.081s) [446.623690] Starting dynamic subtest: drm_test_cmdline_force_e_only [446.694421] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.084s) [446.707778] Starting dynamic subtest: drm_test_cmdline_res [446.774564] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.079s) [446.786702] Starting dynamic subtest: drm_test_cmdline_res_vesa [446.870758] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.094s) [446.883260] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [446.955581] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.084s) [446.967914] Starting dynamic subtest: drm_test_cmdline_res_rblank [447.069202] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.112s) [447.081609] Starting dynamic subtest: drm_test_cmdline_res_bpp [447.164773] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.095s) [447.175414] Starting dynamic subtest: drm_test_cmdline_res_refresh [447.260428] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.093s) [447.273529] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [447.380473] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.119s) [447.391425] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [447.495271] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.113s) [447.509938] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [447.601608] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.105s) [447.615033] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [447.693594] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.091s) [447.704293] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [447.792526] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.098s) [447.803085] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [447.901737] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.108s) [447.912295] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [448.013387] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.111s) [448.026411] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [448.114173] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.098s) [448.124950] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [448.217782] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.103s) [448.228478] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [448.320847] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.102s) [448.334499] Starting dynamic subtest: drm_test_cmdline_name [448.415641] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.094s) [448.426187] Starting dynamic subtest: drm_test_cmdline_name_bpp [448.522731] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.107s) [448.533666] Starting dynamic subtest: drm_test_cmdline_name_option [448.627092] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.103s) [448.637305] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [448.735089] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.108s) [448.745723] Starting dynamic subtest: drm_test_cmdline_rotate_0 [448.843008] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.106s) [448.853369] Starting dynamic subtest: drm_test_cmdline_rotate_90 [448.939326] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.096s) [448.949834] Starting dynamic subtest: drm_test_cmdline_rotate_180 [449.040250] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.100s) [449.054102] Starting dynamic subtest: drm_test_cmdline_rotate_270 [449.151769] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.109s) [449.162353] Starting dynamic subtest: drm_test_cmdline_hmirror [449.254251] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.100s) [449.264907] Starting dynamic subtest: drm_test_cmdline_vmirror [449.356098] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.102s) [449.367095] Starting dynamic subtest: drm_test_cmdline_margin_options [449.464446] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.106s) [449.475595] Starting dynamic subtest: drm_test_cmdline_multiple_options [449.598950] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.130s) [449.613514] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [449.724019] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.123s) [449.735309] Starting dynamic subtest: drm_test_cmdline_extra_and_option [449.816941] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.093s) [449.828055] Starting dynamic subtest: drm_test_cmdline_freestanding_options [449.922506] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.104s) [449.933235] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [450.061604] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.137s) [450.072909] Starting dynamic subtest: drm_test_cmdline_panel_orientation [450.164600] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.103s) [450.177507] Starting dynamic subtest: drm_test_cmdline_invalid [450.281689] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.115s) [450.293067] Starting dynamic subtest: drm_test_cmdline_tv_options [450.406069] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.121s) [450.408270] Subtest drm_cmdline_parser: SUCCESS (4.240s) [450.552325] [103/134] (584s left) kms_invalid_mode (bad-vsync-start) [450.648622] Starting subtest: bad-vsync-start [450.650887] Starting dynamic subtest: pipe-A-eDP-1 [450.933994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [450.945984] Starting dynamic subtest: pipe-B-eDP-1 [450.948150] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [450.959160] Starting dynamic subtest: pipe-C-eDP-1 [450.961471] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [450.972575] Starting dynamic subtest: pipe-D-eDP-1 [450.974906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [450.977278] Subtest bad-vsync-start: SUCCESS (0.294s) [451.797710] [104/134] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [451.900348] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [451.904394] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [451.993549] [105/134] (583s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [452.080080] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [452.084691] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [453.209810] [106/134] (582s left) gem_exec_reloc (basic-wc-noreloc) [453.270842] Subtest basic-wc-noreloc: SKIP (0.000s) [453.342479] [107/134] (582s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [453.430181] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [453.434327] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [453.509342] [108/134] (581s left) prime_self_import (basic-llseek-bad) [453.543823] Starting subtest: basic-llseek-bad [453.559368] Subtest basic-llseek-bad: SUCCESS (0.016s) [453.650462] [109/134] (581s left) kms_big_fb (4-tiled-64bpp-rotate-270) [453.745448] Starting subtest: 4-tiled-64bpp-rotate-270 [453.767506] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s) [453.893957] [110/134] (581s left) kms_chamelium_hpd (hdmi-hpd-fast) [454.301159] Subtest hdmi-hpd-fast: SKIP (0.000s) [455.125065] [111/134] (580s left) gem_ccs (ctrl-surf-copy-new-ctx) [455.180809] Starting subtest: ctrl-surf-copy-new-ctx [455.185364] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [455.292808] [112/134] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [455.386753] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [455.390854] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [455.503747] [113/134] (580s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [455.608929] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [463.360472] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.753s) [463.474787] [114/134] (572s left) gem_tiled_fence_blits (basic) [463.539876] Subtest basic: SKIP (0.000s) [463.623517] [115/134] (572s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [463.723232] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [463.727494] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [463.822957] [116/134] (571s left) gem_ctx_engines (execute-allforone) [463.882472] Starting subtest: execute-allforone [463.899873] Subtest execute-allforone: SUCCESS (0.017s) [465.565321] [117/134] (570s left) kms_psr (pr-cursor-render) [465.660239] Starting subtest: pr-cursor-render [465.664706] Subtest pr-cursor-render: SKIP (0.000s) [465.736444] [118/134] (570s left) gem_exec_reloc (basic-write-read-active) [465.793255] Subtest basic-write-read-active: SKIP (0.000s) [465.858897] [119/134] (570s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [465.945865] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [465.950239] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [466.038898] [120/134] (569s left) api_intel_bb (intel-bb-blit-y) [466.088089] Starting subtest: intel-bb-blit-y [469.470901] Subtest intel-bb-blit-y: SUCCESS (3.382s) [469.606839] [121/134] (566s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [471.636967] Starting subtest: dpms-mode-unset-non-lpsp [472.803847] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s) [473.179287] [122/134] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [473.275771] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [473.280192] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [473.376864] [123/134] (562s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [473.476741] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [473.481181] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [473.593752] [124/134] (562s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [473.651064] Starting subtest: multi-wait-available-unsubmitted-signaled [473.653352] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [473.738002] [125/134] (562s left) i915_query (engine-info-invalid) [473.788076] Starting subtest: engine-info-invalid [473.790373] Subtest engine-info-invalid: SUCCESS (0.000s) [473.904989] [126/134] (562s left) kms_vblank (query-busy-hang) [473.997521] Starting subtest: query-busy-hang [473.999410] Starting dynamic subtest: pipe-A-eDP-1 [500.266860] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.266s) [500.284531] Starting dynamic subtest: pipe-D-eDP-1 [525.289465] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s) [525.291960] Subtest query-busy-hang: SUCCESS (51.284s) [526.149747] [127/134] (510s left) api_intel_allocator (fork-simple-once) [526.214720] Starting subtest: fork-simple-once [526.228196] Subtest fork-simple-once: SUCCESS (0.015s) [526.363223] [128/134] (509s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [526.459872] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [526.484102] Starting dynamic subtest: pipe-A-plane-0 [526.872752] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s) [526.884459] Starting dynamic subtest: pipe-A-plane-3 [527.217008] Dynamic subtest pipe-A-plane-3: SUCCESS (0.344s) [528.344627] Starting dynamic subtest: pipe-B-plane-0 [528.745937] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s) [528.757290] Starting dynamic subtest: pipe-B-plane-3 [529.047152] Dynamic subtest pipe-B-plane-3: SUCCESS (0.299s) [529.367923] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.909s) [530.223967] [129/134] (506s left) gem_partial_pwrite_pread (reads-snoop) [530.289318] Subtest reads-snoop: SKIP (0.000s) [530.362513] [130/134] (506s left) kms_flip_tiling (flip-change-tiling) [530.455923] Starting subtest: flip-change-tiling [530.458182] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [530.631324] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.177s) [530.645806] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [530.777519] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s) [530.790292] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [530.910601] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [530.924820] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [531.054757] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s) [531.069341] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [531.198689] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [531.212823] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [531.342826] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [531.358143] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [531.487425] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [531.502027] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [531.609929] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s) [531.623240] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [531.744493] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [531.757100] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [531.887780] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [531.901308] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [532.031998] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [532.046296] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [532.176430] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [532.192203] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [532.309741] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [532.324569] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [532.456224] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [532.473208] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [532.576951] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.119s) [532.591779] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [532.721314] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [532.736045] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [532.865187] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [532.879331] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [533.009665] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [533.023176] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [533.143331] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s) [533.158151] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [533.287962] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [533.302019] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [533.432365] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [533.446169] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [533.565737] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.131s) [533.580181] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [533.709866] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [533.725086] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [533.853932] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [533.867859] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [533.998435] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [534.013624] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [534.142869] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [534.159861] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [534.287174] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [534.305398] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [534.432959] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [534.446112] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [534.565352] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.131s) [534.579650] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [534.721013] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.153s) [534.735834] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [534.865023] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [534.881753] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [535.009403] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [535.026631] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [535.154893] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [535.169433] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [535.298591] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [535.315776] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [535.454755] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s) [535.468665] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [535.576768] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [535.634180] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [536.885585] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.263s) [536.903187] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [537.020641] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [537.033840] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [537.154325] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [537.168150] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [537.297379] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [537.311500] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [537.441153] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [537.458210] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [537.585466] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.141s) [537.599974] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [537.719379] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [537.734699] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [537.830806] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [537.843636] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [537.965912] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [537.981197] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [538.110104] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [538.123559] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [538.263559] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.153s) [538.277059] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [538.407591] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [538.421085] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [538.542073] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [538.557187] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [538.686992] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [538.701533] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [538.808212] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s) [538.824974] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [538.981554] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s) [538.995189] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [539.125189] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [539.138422] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [539.268508] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [539.283027] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [539.413894] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [539.428417] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [539.558412] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [539.572943] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [539.702824] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s) [539.716686] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [539.825205] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [539.840540] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [539.980549] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.154s) [540.000485] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [540.123923] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.141s) [540.139963] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [540.268944] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [540.283385] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [540.413146] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [540.427639] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [540.558436] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [540.574497] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [540.702178] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [540.718078] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [540.824924] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [540.841061] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [540.969366] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s) [540.982554] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [541.113611] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [541.128565] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [541.257761] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [541.275925] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [541.402623] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [541.419657] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [541.558301] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s) [541.572110] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [541.702944] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [541.717330] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [541.824835] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [541.879041] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [543.115831] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.245s) [543.131025] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [543.215812] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [543.228219] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [543.315724] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [543.328194] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [543.426753] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [543.440136] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [543.537062] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [543.550077] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [543.648184] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s) [543.663739] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [543.748751] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [543.764362] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [543.861465] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [543.876410] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [543.970946] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.108s) [543.983328] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [544.081979] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [544.094563] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [544.192659] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [544.206527] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [544.303851] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [544.316682] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [544.403960] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [544.417715] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [544.504560] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [544.518443] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [544.604619] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [544.618698] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [544.715381] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [544.729146] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [544.826195] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [544.839865] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [544.937040] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [544.950724] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [545.037812] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [545.051678] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [545.148926] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [545.163875] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [545.260030] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [545.273529] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [545.371164] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [545.386540] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [545.481736] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [545.495235] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [545.593602] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [545.606729] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [545.704158] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [545.718316] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [545.815255] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [545.829399] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [545.915594] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s) [545.929757] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [546.026371] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s) [546.041040] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [546.138046] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [546.153227] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [546.249034] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [546.261935] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [546.359495] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [546.375109] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [546.470995] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [546.485096] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [546.581992] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [546.596089] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [546.693267] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [546.706839] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [546.804457] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [546.818070] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [546.915707] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [546.961072] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [548.144401] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.194s) [548.158858] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [548.244793] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [548.259164] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [548.343905] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [548.358187] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [548.455195] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s) [548.470710] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [548.566299] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s) [548.578595] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [548.677502] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s) [548.691105] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [548.778069] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [548.797544] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [548.889486] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [548.906576] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [549.000516] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [549.015980] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [549.110921] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [549.123903] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [549.232670] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.120s) [549.246616] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [549.343612] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [549.362508] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [549.455078] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.109s) [549.468611] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [549.555706] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [549.568979] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [549.656161] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [549.669720] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [549.766691] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [549.780566] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [549.877081] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [549.889510] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [549.988462] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [550.001450] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [550.099979] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [550.112330] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [550.211395] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [550.225849] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [550.322181] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [550.336858] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [550.433579] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [550.450551] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [550.544239] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [550.557595] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [550.655977] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s) [550.670290] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [550.755406] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s) [550.767769] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [550.866186] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [550.881208] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [550.977967] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [550.995761] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [551.088674] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [551.104379] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [551.200202] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s) [551.213516] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [551.311280] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [551.322726] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [551.422043] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [551.435533] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [551.533269] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [551.546220] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [551.644569] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [551.659067] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [551.755581] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s) [551.771745] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [551.877994] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.120s) [551.892938] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [551.989330] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [552.022429] Subtest flip-change-tiling: SUCCESS (21.565s) [553.250885] [131/134] (483s left) kms_cursor_crc (cursor-onscreen-512x512) [553.550130] Starting subtest: cursor-onscreen-512x512 [553.554732] Subtest cursor-onscreen-512x512: SKIP (0.001s) [553.721852] [132/134] (482s left) sysfs_heartbeat_interval (mixed) [553.779940] Starting subtest: mixed [553.782242] Starting dynamic subtest: vecs0 [559.058386] Dynamic subtest vecs0: SUCCESS (5.277s) [559.071512] Starting dynamic subtest: ccs0 [564.231489] Dynamic subtest ccs0: SUCCESS (5.170s) [564.244075] Starting dynamic subtest: vcs0 [569.460570] Dynamic subtest vcs0: SUCCESS (5.225s) [569.473230] Starting dynamic subtest: bcs0 [574.683996] Dynamic subtest bcs0: SUCCESS (5.220s) [574.698292] Starting dynamic subtest: rcs0 [579.872091] Dynamic subtest rcs0: SUCCESS (5.186s) [579.885454] Starting dynamic subtest: vcs1 [585.101161] Dynamic subtest vcs1: SUCCESS (5.227s) [585.103762] Subtest mixed: SUCCESS (31.317s) [585.205964] [133/134] (451s left) kms_invalid_mode (zero-clock) [585.317701] Starting subtest: zero-clock [585.319867] Starting dynamic subtest: pipe-A-eDP-1 [585.602873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [585.617341] Starting dynamic subtest: pipe-B-eDP-1 [585.619419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [585.631137] Starting dynamic subtest: pipe-C-eDP-1 [585.633505] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [585.645103] Starting dynamic subtest: pipe-D-eDP-1 [585.647492] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [585.649877] Subtest zero-clock: SUCCESS (0.291s) [586.459431] [134/134] (450s left) gem_exec_whisper (basic-queues-forked) [586.512033] Starting subtest: basic-queues-forked [609.644291] Subtest basic-queues-forked: SUCCESS (23.123s) [609.827857] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_pm_backlight results: parsing output: 2/ for test: kms_pipe_b_c_ivb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_prop_blob results: parsing output: 5/ for test: kms_flip results: parsing output: 6/ for test: intel_hwmon results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: kms_plane_scaling results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: kms_plane results: parsing output: 11/ for test: gem_ctx_persistence results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_color_pipeline results: parsing output: 16/ for test: gem_userptr_blits results: parsing output: 17/ for test: kms_chamelium_frames results: parsing output: 18/ for test: kms_addfb_basic results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: syncobj_wait results: parsing output: 22/ for test: prime_self_import results: parsing output: 23/ for test: gem_pipe_control_store_loop results: parsing output: 24/ for test: gen9_exec_parse results: parsing output: 25/ for test: kms_psr2_sf results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: gem_render_copy results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: gem_exec_params results: parsing output: 32/ for test: perf results: parsing output: 33/ for test: kms_lease results: parsing output: 34/ for test: gem_exec_fence results: parsing output: 35/ for test: gem_exec_whisper results: parsing output: 36/ for test: kms_cursor_crc results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: gem_exec_params results: parsing output: 40/ for test: kms_atomic results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: gem_ctx_param results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: gem_exec_params results: parsing output: 46/ for test: i915_drm_fdinfo results: parsing output: 47/ for test: prime_busy results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: core_auth results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_spin_batch results: parsing output: 53/ for test: kms_vrr results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: device_reset results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_cursor_legacy results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: i915_hangman results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: gem_exec_params results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: prime_self_import results: parsing output: 68/ for test: gem_ctx_persistence results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: gem_exec_suspend results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_chamelium_color results: parsing output: 73/ for test: kms_content_protection results: parsing output: 74/ for test: kms_plane_lowres results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: kms_psr results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: gem_mmap_gtt results: parsing output: 81/ for test: gem_exec_balancer results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: gem_pxp results: parsing output: 84/ for test: gem_mmap results: parsing output: 85/ for test: syncobj_eventfd results: parsing output: 86/ for test: gem_exec_schedule results: parsing output: 87/ for test: gem_exec_schedule results: parsing output: 88/ for test: gem_eio results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_eio results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr2_sf results: parsing output: 93/ for test: kms_explicit_fence results: parsing output: 94/ for test: gem_mmap_wc results: parsing output: 95/ for test: kms_dsc results: parsing output: 96/ for test: gem_userptr_blits results: parsing output: 97/ for test: gem_pxp results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: gem_ringfill results: parsing output: 100/ for test: i915_pm_rpm results: parsing output: 101/ for test: kms_selftest results: parsing output: 102/ for test: kms_invalid_mode results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_flip_scaled_crc results: parsing output: 107/ for test: prime_self_import results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_chamelium_hpd results: parsing output: 110/ for test: gem_ccs results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_tiled_fence_blits results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_ctx_engines results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: gem_exec_reloc results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: api_intel_bb results: parsing output: 120/ for test: kms_pm_rpm results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: i915_query results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: api_intel_allocator results: parsing output: 127/ for test: kms_plane results: parsing output: 128/ for test: gem_partial_pwrite_pread results: parsing output: 129/ for test: kms_flip_tiling results: parsing output: 130/ for test: kms_cursor_crc results: parsing output: 131/ for test: sysfs_heartbeat_interval results: parsing output: 132/ for test: kms_invalid_mode results: parsing output: 133/ for test: gem_exec_whisper Done.