[57.849165] Initializing watchdogs [57.849211] /dev/watchdog0 [57.864036] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.867965] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.870075] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.873356] [001/133] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [57.970245] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [57.972596] Starting dynamic subtest: pipe-A [58.056281] Dynamic subtest pipe-A: SUCCESS (0.087s) [58.066454] Starting dynamic subtest: pipe-B [59.223355] Dynamic subtest pipe-B: SUCCESS (1.166s) [59.233338] Starting dynamic subtest: pipe-C [60.332284] Dynamic subtest pipe-C: SUCCESS (1.108s) [60.343518] Starting dynamic subtest: pipe-D [61.461586] Dynamic subtest pipe-D: SUCCESS (1.129s) [61.464063] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.493s) [62.628715] [002/133] (955s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [62.736938] Starting subtest: basic-flip-after-cursor-legacy [63.689723] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.950s) [64.559019] [003/133] (953s left) kms_pipe_crc_basic (hang-read-crc) [64.651077] Starting subtest: hang-read-crc [64.653436] Starting dynamic subtest: pipe-A-eDP-1 [66.723435] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s) [66.731528] Starting dynamic subtest: pipe-B-eDP-1 [69.490698] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s) [69.499361] Starting dynamic subtest: pipe-C-eDP-1 [72.117610] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.627s) [72.127187] Starting dynamic subtest: pipe-D-eDP-1 [74.775056] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s) [74.777584] Subtest hang-read-crc: SUCCESS (10.121s) [75.644499] [004/133] (942s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [75.766347] Starting subtest: yf-tiled-16bpp-rotate-270 [75.771308] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [75.868626] [005/133] (942s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [75.959367] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [75.963681] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [76.058132] [006/133] (942s left) kms_legacy_colorkey (basic) [76.131772] Starting subtest: basic [76.134129] Starting dynamic subtest: pipe-A [76.175833] Dynamic subtest pipe-A: SUCCESS (0.045s) [76.186434] Starting dynamic subtest: pipe-B [76.188703] Dynamic subtest pipe-B: SUCCESS (0.001s) [76.195821] Starting dynamic subtest: pipe-C [76.197741] Dynamic subtest pipe-C: SUCCESS (0.001s) [76.205079] Starting dynamic subtest: pipe-D [76.207198] Dynamic subtest pipe-D: SUCCESS (0.001s) [76.209348] Subtest basic: SUCCESS (0.050s) [76.244250] [007/133] (942s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [76.336229] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [76.340240] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [76.401710] [008/133] (942s left) kms_pm_dc (dc6-psr) [77.474745] Starting subtest: dc6-psr [80.453498] Subtest dc6-psr: SUCCESS (2.980s) [81.266988] [009/133] (937s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [81.332409] Starting subtest: legacy-engines-hostile-preempt [81.334657] Starting dynamic subtest: render [81.413238] Dynamic subtest render: SUCCESS (0.081s) [81.423193] Starting dynamic subtest: bsd1 [82.839271] Dynamic subtest bsd1: SUCCESS (1.422s) [82.851635] Starting dynamic subtest: bsd2 [84.886120] Dynamic subtest bsd2: SUCCESS (2.045s) [84.897144] Starting dynamic subtest: blt [84.913486] Dynamic subtest blt: SUCCESS (0.027s) [84.921232] Starting dynamic subtest: vebox [86.871081] Dynamic subtest vebox: SUCCESS (1.954s) [86.873674] Subtest legacy-engines-hostile-preempt: SUCCESS (5.538s) [86.950740] [010/133] (931s left) kms_cursor_crc (cursor-onscreen-512x170) [87.277131] Starting subtest: cursor-onscreen-512x170 [87.281275] Subtest cursor-onscreen-512x170: SKIP (0.001s) [87.424997] [011/133] (931s left) gem_exec_params (dr4-dirt) [87.499767] Starting subtest: DR4-dirt [87.502255] Subtest DR4-dirt: SUCCESS (0.000s) [87.610937] [012/133] (931s left) core_auth (many-magics) [87.673968] Starting subtest: many-magics [88.594824] Subtest many-magics: SUCCESS (0.921s) [88.735582] [013/133] (930s left) gem_ctx_sseu (mmap-args) [88.800997] Subtest mmap-args: SKIP (0.000s) [88.873213] [014/133] (930s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [88.917972] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [89.022294] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s) [89.092048] [015/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [89.177945] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [93.086082] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.911s) [94.252340] [016/133] (924s left) kms_atomic_transition (modeset-transition-nonblocking) [94.330823] Starting subtest: modeset-transition-nonblocking [94.333302] Starting dynamic subtest: 1x-outputs [105.080069] Dynamic subtest 1x-outputs: SUCCESS (10.748s) [105.082612] Subtest modeset-transition-nonblocking: SUCCESS (10.749s) [105.944497] [017/133] (913s left) gem_ccs (block-copy-compressed) [106.012049] Starting subtest: block-copy-compressed [106.016738] Subtest block-copy-compressed: SKIP (0.000s) [106.111969] [018/133] (912s left) kms_plane (plane-position-hole-dpms) [106.185065] Starting subtest: plane-position-hole-dpms [106.709879] Starting dynamic subtest: pipe-A-plane-1 [109.146658] Dynamic subtest pipe-A-plane-1: SUCCESS (2.437s) [109.156085] Starting dynamic subtest: pipe-A-plane-2 [111.490293] Dynamic subtest pipe-A-plane-2: SUCCESS (2.343s) [111.499584] Starting dynamic subtest: pipe-A-plane-3 [113.846117] Dynamic subtest pipe-A-plane-3: SUCCESS (2.355s) [113.855059] Starting dynamic subtest: pipe-A-plane-4 [116.211423] Dynamic subtest pipe-A-plane-4: SUCCESS (2.366s) [116.220630] Starting dynamic subtest: pipe-A-plane-5 [116.243031] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s) [117.385285] Starting dynamic subtest: pipe-B-plane-1 [119.818052] Dynamic subtest pipe-B-plane-1: SUCCESS (2.439s) [119.827265] Starting dynamic subtest: pipe-B-plane-2 [122.110195] Dynamic subtest pipe-B-plane-2: SUCCESS (2.292s) [122.117818] Starting dynamic subtest: pipe-B-plane-3 [124.519994] Dynamic subtest pipe-B-plane-3: SUCCESS (2.409s) [124.528198] Starting dynamic subtest: pipe-B-plane-4 [126.894488] Dynamic subtest pipe-B-plane-4: SUCCESS (2.372s) [126.910596] Starting dynamic subtest: pipe-B-plane-5 [126.918903] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [126.921232] Subtest plane-position-hole-dpms: SUCCESS (20.732s) [127.697497] [019/133] (891s left) gem_reg_read (timestamp-monotonic) [127.754821] Starting subtest: timestamp-monotonic [131.986471] Subtest timestamp-monotonic: SUCCESS (4.231s) [132.057424] [020/133] (887s left) kms_cursor_crc (cursor-random-512x170) [132.368309] Starting subtest: cursor-random-512x170 [132.372727] Subtest cursor-random-512x170: SKIP (0.001s) [132.535355] [021/133] (886s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [132.610511] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [132.612831] Starting dynamic subtest: pipe-A-eDP-1 [133.029554] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s) [133.039430] Starting dynamic subtest: pipe-B-eDP-1 [134.424777] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [134.432597] Starting dynamic subtest: pipe-C-eDP-1 [135.813051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s) [135.823256] Starting dynamic subtest: pipe-D-eDP-1 [137.131446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s) [137.133625] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.496s) [138.333909] [022/133] (880s left) kms_setmode (basic) [138.394735] Starting subtest: basic [138.717805] Starting dynamic subtest: pipe-A-eDP-1 [140.836794] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s) [141.180017] Starting dynamic subtest: pipe-B-eDP-1 [143.270720] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.093s) [143.578281] Subtest basic: SUCCESS (5.180s) [144.420461] [023/133] (874s left) kms_pm_rpm (universal-planes-dpms) [145.927591] Starting subtest: universal-planes-dpms [145.929865] Starting dynamic subtest: plane-35 [154.238044] Dynamic subtest plane-35: SUCCESS (8.311s) [154.249672] Starting dynamic subtest: plane-65 [162.534921] Dynamic subtest plane-65: SUCCESS (8.294s) [162.545512] Starting dynamic subtest: plane-95 [170.814799] Dynamic subtest plane-95: SUCCESS (8.277s) [170.825234] Starting dynamic subtest: plane-125 [179.102040] Dynamic subtest plane-125: SUCCESS (8.285s) [179.112950] Starting dynamic subtest: plane-135 [187.365644] Dynamic subtest plane-135: SUCCESS (8.261s) [187.375981] Starting dynamic subtest: plane-145 [195.693541] Dynamic subtest plane-145: SUCCESS (8.325s) [195.696081] Subtest universal-planes-dpms: SUCCESS (49.767s) [196.070553] [024/133] (823s left) gem_sync (basic-store-each) [196.148850] Starting subtest: basic-store-each [198.561256] Subtest basic-store-each: SUCCESS (2.422s) [198.745882] [025/133] (820s left) kms_psr (psr-cursor-blt) [198.822713] Starting subtest: psr-cursor-blt [198.824820] Starting dynamic subtest: eDP-1 [200.568137] Dynamic subtest eDP-1: SUCCESS (1.745s) [200.570322] Subtest psr-cursor-blt: SUCCESS (1.746s) [201.420604] [026/133] (817s left) perf (invalid-remove-userspace-config) [201.548494] Starting subtest: invalid-remove-userspace-config [201.555480] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [201.593112] [027/133] (817s left) gem_mmap_gtt (close-race) [201.661495] Subtest close-race: SKIP (0.000s) [201.719882] [028/133] (817s left) kms_color_pipeline (plane-ctm3x4-lut1d) [201.808412] Starting subtest: plane-ctm3x4-lut1d [201.932873] Starting dynamic subtest: pipe-A-plane-0 [202.120772] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [202.129495] Starting dynamic subtest: pipe-A-plane-1 [202.253934] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [202.261965] Starting dynamic subtest: pipe-A-plane-2 [202.386705] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s) [203.654166] Starting dynamic subtest: pipe-B-plane-0 [203.836737] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s) [203.848035] Starting dynamic subtest: pipe-B-plane-1 [204.036906] Dynamic subtest pipe-B-plane-1: SUCCESS (0.198s) [204.045307] Starting dynamic subtest: pipe-B-plane-2 [204.227605] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s) [205.453285] Starting dynamic subtest: pipe-C-plane-0 [205.580069] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [205.588478] Starting dynamic subtest: pipe-C-plane-1 [205.713045] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s) [205.723679] Starting dynamic subtest: pipe-C-plane-2 [205.857705] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [207.068377] Starting dynamic subtest: pipe-D-plane-0 [207.206759] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [207.214691] Starting dynamic subtest: pipe-D-plane-1 [207.340165] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [207.348320] Starting dynamic subtest: pipe-D-plane-2 [207.473414] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s) [207.761809] Subtest plane-ctm3x4-lut1d: SUCCESS (5.953s) [208.640914] [029/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [208.722571] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [208.726661] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [208.819937] [030/133] (810s left) sw_sync (sync_multi_timeline_wait) [208.856237] Starting subtest: sync_multi_timeline_wait [208.858632] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [208.905479] [031/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [208.985274] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [208.989149] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [209.073780] [032/133] (810s left) kms_invalid_mode (bad-htotal) [209.139895] Starting subtest: bad-htotal [209.142198] Starting dynamic subtest: pipe-A-eDP-1 [209.435482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [209.444044] Starting dynamic subtest: pipe-B-eDP-1 [209.446536] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [209.454176] Starting dynamic subtest: pipe-C-eDP-1 [209.456501] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [209.464267] Starting dynamic subtest: pipe-D-eDP-1 [209.466582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [209.468970] Subtest bad-htotal: SUCCESS (0.303s) [210.264985] [033/133] (809s left) gem_spin_batch (engines) [210.343876] Starting subtest: engines [210.346233] Starting dynamic subtest: rcs0 [213.589127] Dynamic subtest rcs0: SUCCESS (3.242s) [213.599956] Starting dynamic subtest: bcs0 [216.828565] Dynamic subtest bcs0: SUCCESS (3.237s) [216.837333] Starting dynamic subtest: vcs0 [220.065247] Dynamic subtest vcs0: SUCCESS (3.234s) [220.076609] Starting dynamic subtest: vcs1 [223.301300] Dynamic subtest vcs1: SUCCESS (3.233s) [223.311653] Starting dynamic subtest: vecs0 [226.537207] Dynamic subtest vecs0: SUCCESS (3.233s) [226.548199] Starting dynamic subtest: ccs0 [229.774208] Dynamic subtest ccs0: SUCCESS (3.234s) [229.776650] Subtest engines: SUCCESS (19.430s) [229.954670] [034/133] (789s left) gem_exec_reloc (basic-write-wc-active) [230.018031] Subtest basic-write-wc-active: SKIP (0.000s) [230.082651] [035/133] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [230.163373] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [237.463180] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.302s) [237.578526] [036/133] (782s left) gem_exec_fence (syncobj-timeline-unused-fence) [238.164348] Starting subtest: syncobj-timeline-unused-fence [238.170566] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s) [239.908621] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [239.911808] [037/133] (779s left) gem_pxp (create-regular-context-1) [240.036025] Starting subtest: create-regular-context-1 [240.038675] Subtest create-regular-context-1: SUCCESS (0.002s) [240.154416] [038/133] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [240.233873] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [240.238174] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [240.337244] [039/133] (779s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [240.441336] Starting subtest: cursorA-vs-flipB-atomic-transitions [240.445646] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [240.591096] [040/133] (779s left) kms_flip (wf_vblank-ts-check-interruptible) [240.664253] Starting subtest: wf_vblank-ts-check-interruptible [240.666589] Starting dynamic subtest: A-eDP1 [249.527303] Dynamic subtest A-eDP1: SUCCESS (8.862s) [249.540747] Starting dynamic subtest: B-eDP1 [258.464853] Dynamic subtest B-eDP1: SUCCESS (8.935s) [258.474763] Starting dynamic subtest: C-eDP1 [267.391145] Dynamic subtest C-eDP1: SUCCESS (8.922s) [267.400891] Starting dynamic subtest: D-eDP1 [276.324882] Dynamic subtest D-eDP1: SUCCESS (8.934s) [276.331118] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.664s) [277.548289] [041/133] (742s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [277.630525] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [277.635057] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [277.731787] [042/133] (742s left) kms_chamelium_frames (dp-crc-single) [278.097896] Subtest dp-crc-single: SKIP (0.000s) [278.871899] [043/133] (741s left) kms_atomic_transition (plane-all-transition) [278.944817] Starting subtest: plane-all-transition [278.946991] Starting dynamic subtest: pipe-A-eDP-1 [281.437896] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [281.743943] Starting dynamic subtest: pipe-B-eDP-1 [285.020162] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.283s) [285.336927] Subtest plane-all-transition: SUCCESS (6.391s) [286.149408] [044/133] (733s left) kms_debugfs (display-off-read-all) [286.233725] Starting subtest: display-off-read-all [286.537971] Subtest display-off-read-all: SUCCESS (0.307s) [287.390210] [045/133] (732s left) gem_ctx_param (invalid-get-ringsize) [287.459036] Starting subtest: invalid-get-ringsize [287.461280] Subtest invalid-get-ringsize: SUCCESS (0.001s) [287.575414] [046/133] (732s left) sysfs_heartbeat_interval (invalid) [287.633076] Starting subtest: invalid [287.635327] Starting dynamic subtest: vecs0 [287.637601] Dynamic subtest vecs0: SUCCESS (0.000s) [287.646515] Starting dynamic subtest: ccs0 [287.648635] Dynamic subtest ccs0: SUCCESS (0.000s) [287.656278] Starting dynamic subtest: vcs0 [287.658404] Dynamic subtest vcs0: SUCCESS (0.000s) [287.666077] Starting dynamic subtest: bcs0 [287.668092] Dynamic subtest bcs0: SUCCESS (0.000s) [287.678481] Starting dynamic subtest: rcs0 [287.680635] Dynamic subtest rcs0: SUCCESS (0.000s) [287.688496] Starting dynamic subtest: vcs1 [287.690365] Dynamic subtest vcs1: SUCCESS (0.000s) [287.692261] Subtest invalid: SUCCESS (0.005s) [287.736246] [047/133] (732s left) gem_madvise (dontneed-before-exec) [287.770092] Starting subtest: dontneed-before-exec [287.794850] Subtest dontneed-before-exec: SKIP (0.022s) [287.859164] [048/133] (732s left) kms_atomic_interruptible (atomic-setmode) [287.942365] Starting subtest: atomic-setmode [287.944678] Starting dynamic subtest: pipe-A-eDP-1 [294.833064] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.888s) [294.835527] Subtest atomic-setmode: SUCCESS (6.891s) [295.626965] [049/133] (724s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [295.699079] Starting subtest: yf-tiled-to-vebox-y-tiled [295.704188] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [295.899429] [050/133] (724s left) prime_vgem (fence-read-hang) [295.976049] Subtest fence-read-hang: SKIP (0.000s) [296.071273] [051/133] (724s left) gem_exec_fence (syncobj-timeline-chain-engines) [296.592317] Starting subtest: syncobj-timeline-chain-engines [296.714797] Subtest syncobj-timeline-chain-engines: SUCCESS (0.122s) [297.906116] [052/133] (722s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [297.987225] Starting subtest: 2x-flip-vs-absolute-wf_vblank [297.994414] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.007s) [298.071101] [053/133] (722s left) gem_userptr_blits (huge-split) [298.150160] Starting subtest: huge-split [298.157370] Subtest huge-split: SUCCESS (0.007s) [298.265652] [054/133] (722s left) gem_tiled_partial_pwrite_pread (reads) [298.326412] Subtest reads: SKIP (0.000s) [298.385958] [055/133] (722s left) gem_exec_create (madvise) [298.454493] Starting subtest: madvise [298.456868] Starting dynamic subtest: smem [318.936117] Dynamic subtest smem: SUCCESS (20.478s) [318.938733] Subtest madvise: SUCCESS (20.479s) [320.033242] [056/133] (700s left) prime_vgem (sync) [320.115480] Starting subtest: sync [320.117421] Starting dynamic subtest: rcs0 [320.163967] Dynamic subtest rcs0: SUCCESS (0.051s) [320.172853] Starting dynamic subtest: bcs0 [320.225700] Dynamic subtest bcs0: SUCCESS (0.061s) [320.234130] Starting dynamic subtest: vcs0 [320.276118] Dynamic subtest vcs0: SUCCESS (0.049s) [320.287618] Starting dynamic subtest: vcs1 [320.324747] Dynamic subtest vcs1: SUCCESS (0.048s) [320.333535] Starting dynamic subtest: vecs0 [320.372830] Dynamic subtest vecs0: SUCCESS (0.047s) [320.381320] Starting dynamic subtest: ccs0 [320.422549] Dynamic subtest ccs0: SUCCESS (0.048s) [320.424884] Subtest sync: SUCCESS (0.311s) [320.538233] [057/133] (700s left) kms_psr (fbc-pr-sprite-render) [320.613932] Starting subtest: fbc-pr-sprite-render [320.618431] Subtest fbc-pr-sprite-render: SKIP (0.000s) [320.688481] [058/133] (699s left) i915_drm_fdinfo (all-busy-check-all) [320.729838] Starting subtest: all-busy-check-all [320.736648] Subtest all-busy-check-all: SKIP (0.005s) [320.796707] [059/133] (699s left) i915_pm_rpm (debugfs-forcewake-user) [322.296436] Starting subtest: debugfs-forcewake-user [333.685360] Subtest debugfs-forcewake-user: SUCCESS (11.387s) [334.083908] [060/133] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [334.161497] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [334.165623] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [334.259345] [061/133] (686s left) gem_exec_fence (expired-history) [334.669583] Starting subtest: expired-history [341.545413] Subtest expired-history: SUCCESS (6.876s) [342.199419] [062/133] (678s left) kms_big_fb (4-tiled-16bpp-rotate-90) [342.273461] Starting subtest: 4-tiled-16bpp-rotate-90 [342.293765] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [342.409908] [063/133] (678s left) gem_ccs (large-ctrl-surf-copy) [342.473511] Starting subtest: large-ctrl-surf-copy [342.477956] Subtest large-ctrl-surf-copy: SKIP (0.000s) [342.573418] [064/133] (678s left) core_auth (getclient-master-drop) [342.612457] Starting subtest: getclient-master-drop [342.628169] Subtest getclient-master-drop: SUCCESS (0.020s) [342.743676] [065/133] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [342.831961] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [342.836063] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [342.923886] [066/133] (678s left) gem_pxp (reject-modify-context-protection-off-3) [343.032724] Starting subtest: reject-modify-context-protection-off-3 [343.035035] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [343.140504] [067/133] (677s left) gem_flink_basic (bad-open) [343.195864] Starting subtest: bad-open [343.197752] Subtest bad-open: SUCCESS (0.000s) [343.288742] [068/133] (677s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [343.373042] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [343.376303] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [343.455804] [069/133] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [343.533063] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [343.536772] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [343.627383] [070/133] (677s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [343.700285] Starting subtest: bad-aux-stride-y-tiled-ccs [343.702119] Starting dynamic subtest: pipe-A-eDP-1 [343.720978] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [343.730357] Starting dynamic subtest: pipe-B-eDP-1 [343.746899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [343.754305] Starting dynamic subtest: pipe-C-eDP-1 [343.771981] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [343.779320] Starting dynamic subtest: pipe-D-eDP-1 [343.797431] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [343.800931] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s) [345.939841] [071/133] (675s left) gem_mmap_offset (oob-read) [345.997302] Starting subtest: oob-read [345.999569] Subtest oob-read: SUCCESS (0.001s) [346.107974] [072/133] (675s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [346.184227] Starting subtest: fbc-2p-pri-indfb-multidraw [346.188144] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [346.281982] [073/133] (674s left) kms_addfb_basic (basic-y-tiled-legacy) [346.338231] Starting subtest: basic-y-tiled-legacy [346.342766] Subtest basic-y-tiled-legacy: SKIP (0.000s) [346.481369] [074/133] (674s left) syncobj_timeline (etime-single-wait-submitted) [346.538901] Starting subtest: etime-single-wait-submitted [346.645919] Subtest etime-single-wait-submitted: SUCCESS (0.105s) [346.733447] [075/133] (674s left) gem_basic (bad-close) [346.790714] Starting subtest: bad-close [346.795405] Subtest bad-close: SUCCESS (0.000s) [346.899503] [076/133] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [346.983056] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [346.987094] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [347.080480] [077/133] (674s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [347.153754] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [347.158210] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [347.257666] [078/133] (674s left) kms_big_fb (linear-16bpp-rotate-180) [347.373324] Starting subtest: linear-16bpp-rotate-180 [348.667801] Subtest linear-16bpp-rotate-180: SUCCESS (1.293s) [348.792515] [079/133] (672s left) perf_pmu (busy-double-start) [348.841754] Starting subtest: busy-double-start [348.843655] Starting dynamic subtest: rcs0 [352.415751] Dynamic subtest rcs0: SUCCESS (3.575s) [352.426575] Starting dynamic subtest: bcs0 [355.985645] Dynamic subtest bcs0: SUCCESS (3.568s) [355.996346] Starting dynamic subtest: vcs0 [360.371212] Dynamic subtest vcs0: SUCCESS (4.381s) [360.383123] Starting dynamic subtest: vcs1 [364.378037] Dynamic subtest vcs1: SUCCESS (4.005s) [364.389463] Starting dynamic subtest: vecs0 [368.348751] Dynamic subtest vecs0: SUCCESS (3.969s) [368.360193] Starting dynamic subtest: ccs0 [371.988345] Dynamic subtest ccs0: FAIL (3.578s) [371.990591] Subtest busy-double-start: FAIL (23.088s) [372.041776] [080/133] (649s left) gem_lmem_swapping (heavy-multi) [372.086310] Subtest heavy-multi: SKIP (0.000s) [372.132067] [081/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [372.213428] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [372.217677] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [372.317142] [082/133] (649s left) kms_vblank (wait-forked) [372.387260] Starting subtest: wait-forked [372.389520] Starting dynamic subtest: pipe-A-eDP-1 [374.211289] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s) [374.225660] Starting dynamic subtest: pipe-D-eDP-1 [376.724050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.511s) [376.726321] Subtest wait-forked: SUCCESS (4.336s) [377.599389] [083/133] (644s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [377.660510] Starting subtest: multi-wait-all-for-submit-unsubmitted [377.765765] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [377.848629] [084/133] (643s left) gem_exec_reloc (basic-write-cpu) [377.902660] Subtest basic-write-cpu: SKIP (0.000s) [377.976304] [085/133] (643s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [378.050584] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [378.052599] Starting dynamic subtest: pipe-A-default-mode [380.731419] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s) [380.733730] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.680s) [381.599585] [086/133] (640s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [381.670383] Starting subtest: plane-use-after-nonblocking-unbind-fencing [381.672765] Starting dynamic subtest: pipe-A-eDP-1 [381.730991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [382.049943] Starting dynamic subtest: pipe-B-eDP-1 [382.813590] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s) [383.108206] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.439s) [383.977298] [087/133] (637s left) kms_cdclk (mode-transition-all-outputs) [384.055603] Starting subtest: mode-transition-all-outputs [384.347725] Subtest mode-transition-all-outputs: SKIP (0.291s) [385.212286] [088/133] (636s left) syncobj_wait (invalid-reset-zero-handles) [385.261172] Starting subtest: invalid-reset-zero-handles [385.263418] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [385.358374] [089/133] (636s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [385.443789] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [385.448197] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [385.540328] [090/133] (636s left) gen9_exec_parse (batch-without-end) [385.606601] Subtest batch-without-end: SKIP (0.000s) [385.682019] [091/133] (636s left) syncobj_timeline (invalid-transfer-bad-pad) [385.745817] Starting subtest: invalid-transfer-bad-pad [385.748199] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [385.838155] [092/133] (636s left) kms_hdmi_inject (inject-audio) [385.905236] Subtest inject-audio: SKIP (0.000s) [385.965100] [093/133] (636s left) gem_softpin (evict-snoop) [386.029577] Starting subtest: evict-snoop [386.034206] Subtest evict-snoop: SKIP (0.000s) [386.166728] [094/133] (635s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [386.248682] Starting subtest: fbc-rgb101010-draw-pwrite [391.542943] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.303s) [392.703456] [095/133] (629s left) gem_wait (invalid-buf) [392.765735] Starting subtest: invalid-buf [392.767820] Subtest invalid-buf: SUCCESS (0.000s) [392.965666] [096/133] (629s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [393.021086] Starting subtest: multi-wait-for-submit-available-submitted [393.023433] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [393.134975] [097/133] (629s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [393.201460] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [393.273081] [098/133] (628s left) i915_suspend (sysfs-reader) [393.340155] Starting subtest: sysfs-reader [411.569881] Subtest sysfs-reader: SUCCESS (3.309s) [411.668055] [099/133] (610s left) kms_plane_lowres (tiling-yf) [411.753165] Starting subtest: tiling-yf [411.756925] Subtest tiling-yf: SKIP (0.000s) [411.826670] [100/133] (610s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [411.906939] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [411.908787] Starting dynamic subtest: pipe-A-eDP-1 [414.002513] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s) [414.012583] Starting dynamic subtest: pipe-B-eDP-1 [416.352514] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.346s) [416.361745] Starting dynamic subtest: pipe-C-eDP-1 [418.385628] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.029s) [418.395664] Starting dynamic subtest: pipe-D-eDP-1 [420.438074] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.048s) [420.440242] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.521s) [421.574685] [101/133] (600s left) gem_exec_whisper (basic-fds-forked) [421.638325] Starting subtest: basic-fds-forked [446.316006] Subtest basic-fds-forked: SUCCESS (24.642s) [446.475989] [102/133] (575s left) kms_selftest (drm_format_helper) [446.515265] Starting subtest: drm_format_helper [446.559558] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [446.644114] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.085s) [446.654459] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [446.738242] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.093s) [446.749358] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [446.849029] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.109s) [446.859390] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [446.950103] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.100s) [446.959636] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [447.055839] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.105s) [447.065413] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [447.152940] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.097s) [447.162770] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [447.261051] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.105s) [447.270506] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [447.354347] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.093s) [447.365770] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [447.461323] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.104s) [447.471747] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [447.557459] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.096s) [447.568572] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [447.644523] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.084s) [447.655320] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [447.729292] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.086s) [447.739809] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [447.826425] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.093s) [447.838725] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [447.915746] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.091s) [447.926750] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [448.043807] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.126s) [448.055433] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [448.154070] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.109s) [448.165389] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [448.271101] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.117s) [448.273404] Subtest drm_format_helper: SUCCESS (1.758s) [448.413763] [103/133] (574s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [448.792690] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [449.587024] [104/133] (572s left) kms_plane (pixel-format-4-tiled-modifier) [449.662509] Starting subtest: pixel-format-4-tiled-modifier [449.694580] Starting dynamic subtest: pipe-A-plane-0 [450.297364] Dynamic subtest pipe-A-plane-0: SUCCESS (0.600s) [450.308519] Starting dynamic subtest: pipe-A-plane-3 [450.716124] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s) [450.728294] Starting dynamic subtest: pipe-A-plane-5 [450.732750] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [451.808413] Starting dynamic subtest: pipe-B-plane-0 [452.433119] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [452.443315] Starting dynamic subtest: pipe-B-plane-3 [452.832744] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s) [452.845119] Starting dynamic subtest: pipe-B-plane-5 [452.848877] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [453.142666] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.480s) [454.004256] [105/133] (568s left) gem_tiled_blits (basic) [454.059803] Subtest basic: SKIP (0.000s) [454.132523] [106/133] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [454.210856] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [458.651234] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.443s) [459.796614] [107/133] (562s left) kms_big_fb (x-tiled-addfb) [459.875964] Starting subtest: x-tiled-addfb [459.878175] Subtest x-tiled-addfb: SUCCESS (0.000s) [459.973981] [108/133] (562s left) gem_softpin (evict-active) [460.027978] Starting subtest: evict-active [460.034640] Subtest evict-active: SUCCESS (0.007s) [460.149027] [109/133] (562s left) perf_pmu (multi-client) [460.188596] Starting subtest: multi-client [460.190533] Starting dynamic subtest: rcs0 [461.270167] Dynamic subtest rcs0: SUCCESS (1.058s) [461.282473] Starting dynamic subtest: bcs0 [462.294722] Dynamic subtest bcs0: SUCCESS (1.046s) [462.308123] Starting dynamic subtest: vcs0 [463.347097] Dynamic subtest vcs0: SUCCESS (1.049s) [463.360637] Starting dynamic subtest: vcs1 [464.803005] Dynamic subtest vcs1: SUCCESS (1.453s) [464.816308] Starting dynamic subtest: vecs0 [466.782279] Dynamic subtest vecs0: SUCCESS (1.976s) [466.795844] Starting dynamic subtest: ccs0 [468.767736] Dynamic subtest ccs0: SUCCESS (1.982s) [468.771142] Subtest multi-client: SUCCESS (8.580s) [468.897893] [110/133] (553s left) gem_exec_balancer (hog) [468.960026] Starting subtest: hog [468.964424] Subtest hog: SKIP (0.000s) [469.278269] [111/133] (553s left) kms_content_protection (srm) [469.404610] Starting subtest: srm [469.412184] Subtest srm: SKIP (0.003s) [469.535572] [112/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [469.620983] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [469.625395] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [469.710280] [113/133] (553s left) kms_psr (psr-sprite-blt) [469.795621] Starting subtest: psr-sprite-blt [469.797828] Starting dynamic subtest: eDP-1 [471.537667] Dynamic subtest eDP-1: SUCCESS (1.741s) [471.539974] Subtest psr-sprite-blt: SUCCESS (1.742s) [472.375814] [114/133] (550s left) kms_feature_discovery (display-4x) [472.449383] Starting subtest: display-4x [472.453723] Subtest display-4x: SKIP (0.000s) [472.528220] [115/133] (550s left) kms_addfb_basic (unused-handle) [472.583617] Starting subtest: unused-handle [472.585983] Subtest unused-handle: SUCCESS (0.000s) [472.700197] [116/133] (550s left) kms_psr (fbc-pr-cursor-render) [472.767142] Starting subtest: fbc-pr-cursor-render [472.771345] Subtest fbc-pr-cursor-render: SKIP (0.000s) [472.845664] [117/133] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [472.925491] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [476.786258] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.865s) [477.995958] [118/133] (545s left) kms_cursor_crc (cursor-tearing-position-change) [478.090730] Starting subtest: cursor-tearing-position-change [478.092962] Starting dynamic subtest: pipe-A-eDP-1 [478.644063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [478.656791] Starting dynamic subtest: pipe-D-eDP-1 [479.902660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s) [479.905283] Subtest cursor-tearing-position-change: SUCCESS (1.812s) [480.733101] [119/133] (542s left) kms_psr (pr-basic) [480.799566] Starting subtest: pr-basic [480.804035] Subtest pr-basic: SKIP (0.000s) [480.878014] [120/133] (542s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [480.945416] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [480.947659] Starting dynamic subtest: pipe-A-eDP-1 [480.957784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [480.970439] Starting dynamic subtest: pipe-B-eDP-1 [480.979193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [480.989093] Starting dynamic subtest: pipe-C-eDP-1 [480.997418] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [481.006942] Starting dynamic subtest: pipe-D-eDP-1 [481.015498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [481.020371] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [483.174720] [121/133] (540s left) dumb_buffer (create-valid-dumb) [483.234274] Starting subtest: create-valid-dumb [483.236458] Subtest create-valid-dumb: SUCCESS (0.000s) [483.340637] [122/133] (539s left) i915_module_load (reload) [483.372756] Starting subtest: reload [488.121733] Subtest reload: SUCCESS (4.749s) [488.167217] [123/133] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [489.768959] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [489.773029] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [489.856825] [124/133] (533s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [489.933223] Starting subtest: psr-rgb565-draw-blt [496.834471] Subtest psr-rgb565-draw-blt: SUCCESS (6.903s) [496.947579] [125/133] (526s left) gem_flink_race (flink_close) [496.988800] Starting subtest: flink_close [502.071117] Subtest flink_close: SUCCESS (5.086s) [502.166402] [126/133] (521s left) kms_psr (fbc-psr-no-drrs) [502.249853] Starting subtest: fbc-psr-no-drrs [502.251998] Starting dynamic subtest: eDP-1 [502.255876] Dynamic subtest eDP-1: SKIP (0.000s) [502.259830] Subtest fbc-psr-no-drrs: SKIP (0.001s) [502.325927] [127/133] (521s left) syncobj_wait (multi-wait-all-submitted-signaled) [502.388732] Starting subtest: multi-wait-all-submitted-signaled [502.496592] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s) [502.573337] [128/133] (520s left) gem_exec_schedule (timeslicing) [502.648169] Starting subtest: timeslicing [502.650352] Starting dynamic subtest: rcs0 [502.665451] Dynamic subtest rcs0: SUCCESS (0.023s) [502.676289] Starting dynamic subtest: bcs0 [502.685919] Dynamic subtest bcs0: SUCCESS (0.020s) [502.695069] Starting dynamic subtest: vcs0 [502.704922] Dynamic subtest vcs0: SUCCESS (0.018s) [502.714395] Starting dynamic subtest: vcs1 [502.725632] Dynamic subtest vcs1: SUCCESS (0.020s) [502.737942] Starting dynamic subtest: vecs0 [502.745824] Dynamic subtest vecs0: SUCCESS (0.020s) [502.755051] Starting dynamic subtest: ccs0 [502.767554] Dynamic subtest ccs0: SUCCESS (0.021s) [502.769870] Subtest timeslicing: SUCCESS (0.126s) [503.838962] [129/133] (519s left) syncobj_wait (multi-wait-submitted) [503.893608] Starting subtest: multi-wait-submitted [504.001076] Subtest multi-wait-submitted: SUCCESS (0.106s) [504.074205] [130/133] (519s left) syncobj_timeline (wait-all-for-submit-snapshot) [504.124254] Starting subtest: wait-all-for-submit-snapshot [504.204158] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [504.288239] [131/133] (519s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [504.360726] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [504.362945] Starting dynamic subtest: pipe-A-default-mode [507.091789] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s) [507.094117] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.732s) [507.926048] [132/133] (515s left) gem_exec_schedule (pi-userfault) [508.104311] Starting subtest: pi-userfault [508.106915] Starting dynamic subtest: rcs0 [508.113901] Dynamic subtest rcs0: SUCCESS (0.011s) [508.127125] Starting dynamic subtest: bcs0 [508.129095] Dynamic subtest bcs0: SUCCESS (0.009s) [508.144343] Starting dynamic subtest: vcs0 [508.146652] Dynamic subtest vcs0: SUCCESS (0.008s) [508.159589] Starting dynamic subtest: vcs1 [508.162218] Dynamic subtest vcs1: SUCCESS (0.009s) [508.170748] Starting dynamic subtest: vecs0 [508.172981] Dynamic subtest vecs0: SUCCESS (0.008s) [508.182206] Starting dynamic subtest: ccs0 [508.184387] Dynamic subtest ccs0: SUCCESS (0.007s) [508.186585] Subtest pi-userfault: SUCCESS (0.057s) [508.339400] [133/133] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [508.416731] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [515.421420] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.007s) [515.529046] Closing watchdogs results: parsing output: 0/ for test: kms_plane_scaling results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: kms_pipe_crc_basic results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_legacy_colorkey results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: kms_pm_dc results: parsing output: 8/ for test: gem_ctx_persistence results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: gem_exec_params results: parsing output: 11/ for test: core_auth results: parsing output: 12/ for test: gem_ctx_sseu results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_atomic_transition results: parsing output: 16/ for test: gem_ccs results: parsing output: 17/ for test: kms_plane results: parsing output: 18/ for test: gem_reg_read results: parsing output: 19/ for test: kms_cursor_crc results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_setmode results: parsing output: 22/ for test: kms_pm_rpm results: parsing output: 23/ for test: gem_sync results: parsing output: 24/ for test: kms_psr results: parsing output: 25/ for test: perf results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: kms_color_pipeline results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: sw_sync results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_invalid_mode results: parsing output: 32/ for test: gem_spin_batch results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_exec_fence results: parsing output: 36/ for test: gem_pxp results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_chamelium_frames results: parsing output: 42/ for test: kms_atomic_transition results: parsing output: 43/ for test: kms_debugfs results: parsing output: 44/ for test: gem_ctx_param results: parsing output: 45/ for test: sysfs_heartbeat_interval results: parsing output: 46/ for test: gem_madvise results: parsing output: 47/ for test: kms_atomic_interruptible results: parsing output: 48/ for test: gem_render_copy results: parsing output: 49/ for test: prime_vgem results: parsing output: 50/ for test: gem_exec_fence results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 54/ for test: gem_exec_create results: parsing output: 55/ for test: prime_vgem results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: i915_drm_fdinfo results: parsing output: 58/ for test: i915_pm_rpm results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_exec_fence results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: gem_ccs results: parsing output: 63/ for test: core_auth results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_pxp results: parsing output: 66/ for test: gem_flink_basic results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: gem_mmap_offset results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: gem_basic results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: perf_pmu results: parsing output: 79/ for test: gem_lmem_swapping results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_vblank results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: kms_atomic_transition results: parsing output: 86/ for test: kms_cdclk results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gen9_exec_parse results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_hdmi_inject results: parsing output: 92/ for test: gem_softpin results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_wait results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: kms_pipe_b_c_ivb results: parsing output: 97/ for test: i915_suspend results: parsing output: 98/ for test: kms_plane_lowres results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: gem_exec_whisper results: parsing output: 101/ for test: kms_selftest results: parsing output: 102/ for test: kms_chamelium_hpd results: parsing output: 103/ for test: kms_plane results: parsing output: 104/ for test: gem_tiled_blits results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_softpin results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: gem_exec_balancer results: parsing output: 110/ for test: kms_content_protection results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_feature_discovery results: parsing output: 114/ for test: kms_addfb_basic results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: dumb_buffer results: parsing output: 121/ for test: i915_module_load results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_flink_race results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_flip_scaled_crc results: parsing output: 131/ for test: gem_exec_schedule results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.