[58.646289] Initializing watchdogs [58.646369] /dev/watchdog0 [58.661151] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.665684] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.667920] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.671188] [001/131] (960s left) gem_userptr_blits (unsync-unmap-after-close) [58.777000] Subtest unsync-unmap-after-close: SKIP (0.000s) [58.938276] [002/131] (960s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [58.996582] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [58.998902] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [59.132260] [003/131] (960s left) gem_ccs (ctrl-surf-copy) [59.201660] Starting subtest: ctrl-surf-copy [59.206001] Subtest ctrl-surf-copy: SKIP (0.000s) [59.328889] [004/131] (959s left) i915_hangman (hangcheck-unterminated) [59.400299] Starting subtest: hangcheck-unterminated [69.877197] Subtest hangcheck-unterminated: SUCCESS (10.444s) [70.037371] [005/131] (949s left) gem_exec_schedule (preempt-hang) [70.214076] Starting subtest: preempt-hang [70.216456] Starting dynamic subtest: rcs0 [70.471069] Dynamic subtest rcs0: SUCCESS (0.258s) [70.482335] Starting dynamic subtest: bcs0 [70.706661] Dynamic subtest bcs0: SUCCESS (0.236s) [70.718118] Starting dynamic subtest: vcs0 [70.917336] Dynamic subtest vcs0: SUCCESS (0.212s) [70.925057] Starting dynamic subtest: vcs1 [71.129689] Dynamic subtest vcs1: SUCCESS (0.210s) [71.139313] Starting dynamic subtest: vecs0 [71.348556] Dynamic subtest vecs0: SUCCESS (0.218s) [71.358491] Starting dynamic subtest: ccs0 [71.578229] Dynamic subtest ccs0: SUCCESS (0.229s) [71.580594] Subtest preempt-hang: SUCCESS (1.365s) [72.036562] [006/131] (947s left) gem_exec_reloc (basic-write-gtt-active) [72.099047] Subtest basic-write-gtt-active: SKIP (0.000s) [72.187404] [007/131] (947s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [72.245595] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [72.250263] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [72.458698] [008/131] (946s left) gem_exercise_blt (fast-copy-emit) [72.524853] Starting subtest: fast-copy-emit [72.527166] Starting dynamic subtest: linear-smem-smem-emit [72.554342] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.029s) [72.562478] Starting dynamic subtest: xmajor-smem-smem-emit [72.572877] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s) [72.580512] Starting dynamic subtest: tile4-smem-smem-emit [72.591743] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s) [72.599368] Starting dynamic subtest: tile64-smem-smem-emit [72.610341] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s) [72.612619] Subtest fast-copy-emit: SUCCESS (0.085s) [72.775632] [009/131] (946s left) kms_cursor_crc (cursor-size-hints) [72.906106] Starting subtest: cursor-size-hints [72.908533] Starting dynamic subtest: pipe-A-eDP-1 [73.582146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s) [73.589900] Starting dynamic subtest: pipe-D-eDP-1 [74.798718] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s) [74.801077] Subtest cursor-size-hints: SUCCESS (1.889s) [75.621386] [010/131] (943s left) kms_getfb (getfb2-handle-not-fb) [75.727890] Starting subtest: getfb2-handle-not-fb [75.730177] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [75.853053] [011/131] (943s left) sriov_basic (enable-vfs-bind-unbind-each) [75.919797] Starting subtest: enable-vfs-bind-unbind-each [75.922203] Starting dynamic subtest: numvfs-1 [75.995492] Dynamic subtest numvfs-1: FAIL (0.017s) [76.004451] Starting dynamic subtest: numvfs-2 [76.078077] Dynamic subtest numvfs-2: FAIL (0.004s) [76.087522] Starting dynamic subtest: numvfs-3 [76.161706] Dynamic subtest numvfs-3: FAIL (0.004s) [76.170730] Starting dynamic subtest: numvfs-4 [76.244474] Dynamic subtest numvfs-4: FAIL (0.004s) [76.256529] Starting dynamic subtest: numvfs-5 [76.337281] Dynamic subtest numvfs-5: FAIL (0.003s) [76.346696] Starting dynamic subtest: numvfs-6 [76.419539] Dynamic subtest numvfs-6: FAIL (0.003s) [76.429116] Starting dynamic subtest: numvfs-7 [76.502529] Dynamic subtest numvfs-7: FAIL (0.004s) [76.512294] Starting dynamic subtest: numvfs-random [76.578638] Dynamic subtest numvfs-random: FAIL (0.003s) [76.580332] Subtest enable-vfs-bind-unbind-each: FAIL (0.044s) [76.613310] [012/131] (942s left) kms_psr (psr2-cursor-plane-move) [76.713080] Starting subtest: psr2-cursor-plane-move [76.715074] Starting dynamic subtest: eDP-1 [78.387447] Dynamic subtest eDP-1: SUCCESS (1.673s) [78.389899] Subtest psr2-cursor-plane-move: SUCCESS (1.673s) [79.206969] [013/131] (940s left) prime_mmap (test_correct_cpu_write) [79.263863] Starting subtest: test_correct_cpu_write [79.266066] Starting dynamic subtest: test_correct_cpu_write-smem [79.267974] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [79.269880] Subtest test_correct_cpu_write: SUCCESS (0.001s) [79.396487] [014/131] (940s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [79.501731] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [79.505774] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [79.626214] [015/131] (940s left) kms_universal_plane (disable-primary-vs-flip) [79.724122] Starting subtest: disable-primary-vs-flip [79.726500] Starting dynamic subtest: pipe-A-eDP-1 [81.253438] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.525s) [81.262100] Starting dynamic subtest: pipe-B-eDP-1 [83.463594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.208s) [83.475800] Starting dynamic subtest: pipe-C-eDP-1 [85.708651] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s) [85.718683] Starting dynamic subtest: pipe-D-eDP-1 [87.859390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.148s) [87.861438] Subtest disable-primary-vs-flip: SUCCESS (8.130s) [88.684326] [016/131] (931s left) gem_mmap_gtt (zero-extend) [88.749967] Subtest zero-extend: SKIP (0.000s) [88.805906] [017/131] (930s left) gem_exec_reloc (basic-write-cpu-active) [88.868499] Subtest basic-write-cpu-active: SKIP (0.000s) [88.944923] [018/131] (930s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [89.043217] Starting subtest: plane-scaler-with-clipping-clamping-rotation [89.045542] Starting dynamic subtest: pipe-A [89.282772] Dynamic subtest pipe-A: SUCCESS (0.242s) [89.291462] Starting dynamic subtest: pipe-B [90.572125] Dynamic subtest pipe-B: SUCCESS (1.289s) [90.581377] Starting dynamic subtest: pipe-C [91.879203] Dynamic subtest pipe-C: SUCCESS (1.306s) [91.888758] Starting dynamic subtest: pipe-D [93.233428] Dynamic subtest pipe-D: SUCCESS (1.354s) [93.235644] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.192s) [94.410309] [019/131] (925s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [94.520704] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [94.525295] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [94.647804] [020/131] (925s left) kms_async_flips (test-cursor) [94.740760] Starting subtest: test-cursor [94.745118] Subtest test-cursor: SKIP (0.000s) [95.968653] [021/131] (924s left) sysfs_heartbeat_interval (idempotent) [96.034642] Starting subtest: idempotent [96.037102] Starting dynamic subtest: vecs0 [96.039519] Dynamic subtest vecs0: SUCCESS (0.001s) [96.049287] Starting dynamic subtest: ccs0 [96.051470] Dynamic subtest ccs0: SUCCESS (0.001s) [96.058973] Starting dynamic subtest: vcs0 [96.061187] Dynamic subtest vcs0: SUCCESS (0.001s) [96.068789] Starting dynamic subtest: bcs0 [96.071036] Dynamic subtest bcs0: SUCCESS (0.001s) [96.078486] Starting dynamic subtest: rcs0 [96.080661] Dynamic subtest rcs0: SUCCESS (0.000s) [96.088031] Starting dynamic subtest: vcs1 [96.090297] Dynamic subtest vcs1: SUCCESS (0.000s) [96.092562] Subtest idempotent: SUCCESS (0.005s) [96.224721] [022/131] (923s left) syncobj_wait (single-wait-all-signaled) [96.277685] Starting subtest: single-wait-all-signaled [96.279571] Subtest single-wait-all-signaled: SUCCESS (0.000s) [96.406473] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [96.504522] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [96.514050] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [96.635205] [024/131] (923s left) gem_unfence_active_buffers [96.823435] [025/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [96.928980] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [103.526338] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.599s) [103.699155] [026/131] (916s left) dumb_buffer (create-valid-dumb) [103.750154] Starting subtest: create-valid-dumb [103.752625] Subtest create-valid-dumb: SUCCESS (0.000s) [103.894462] [027/131] (916s left) kms_big_fb (x-tiled-64bpp-rotate-180) [104.010897] Starting subtest: x-tiled-64bpp-rotate-180 [105.575187] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.566s) [105.817212] [028/131] (914s left) kms_big_fb (linear-8bpp-rotate-270) [105.917075] Starting subtest: linear-8bpp-rotate-270 [105.940211] Subtest linear-8bpp-rotate-270: SKIP (0.020s) [106.086257] [029/131] (914s left) gem_ctx_shared (q-in-order) [106.156394] Starting subtest: Q-in-order [106.158263] Starting dynamic subtest: rcs0 [106.298393] Dynamic subtest rcs0: SUCCESS (0.144s) [106.311749] Starting dynamic subtest: vcs0 [106.377619] Dynamic subtest vcs0: SUCCESS (0.079s) [106.393469] Starting dynamic subtest: vcs1 [106.450915] Dynamic subtest vcs1: SUCCESS (0.073s) [106.467366] Starting dynamic subtest: vecs0 [106.522724] Dynamic subtest vecs0: SUCCESS (0.071s) [106.538231] Starting dynamic subtest: ccs0 [106.601734] Dynamic subtest ccs0: SUCCESS (0.078s) [106.604032] Subtest Q-in-order: SUCCESS (0.448s) [108.046124] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [108.049435] [030/131] (912s left) kms_draw_crc (draw-method-blt) [108.147221] Starting subtest: draw-method-blt [108.149090] Starting dynamic subtest: xrgb8888-untiled [108.391018] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s) [108.401571] Starting dynamic subtest: rgb565-untiled [108.624355] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [108.634433] Starting dynamic subtest: xrgb2101010-untiled [108.846514] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [108.856328] Starting dynamic subtest: xbgr16161616f-untiled [109.057539] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s) [109.068115] Starting dynamic subtest: xrgb8888-xtiled [109.179622] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [109.188265] Starting dynamic subtest: rgb565-xtiled [109.290462] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [109.299242] Starting dynamic subtest: xrgb2101010-xtiled [109.401872] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [109.410207] Starting dynamic subtest: xbgr16161616f-xtiled [109.512893] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s) [109.521977] Starting dynamic subtest: xrgb8888-4tiled [109.624067] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s) [109.634573] Starting dynamic subtest: rgb565-4tiled [109.724343] Dynamic subtest rgb565-4tiled: SUCCESS (0.100s) [109.737452] Starting dynamic subtest: xrgb2101010-4tiled [109.835072] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [109.844137] Starting dynamic subtest: xbgr16161616f-4tiled [109.946367] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s) [109.948382] Subtest draw-method-blt: SUCCESS (1.802s) [110.097576] [031/131] (910s left) i915_query (query-topology-unsupported) [110.158337] Starting subtest: query-topology-unsupported [110.161669] Subtest query-topology-unsupported: SKIP (0.000s) [110.297036] [032/131] (910s left) kms_invalid_mode (int-max-clock) [110.393998] Starting subtest: int-max-clock [110.396129] Starting dynamic subtest: pipe-A-eDP-1 [110.677315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [110.686481] Starting dynamic subtest: pipe-B-eDP-1 [110.688635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [110.697059] Starting dynamic subtest: pipe-C-eDP-1 [110.699240] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [110.707198] Starting dynamic subtest: pipe-D-eDP-1 [110.709065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [110.710853] Subtest int-max-clock: SUCCESS (0.290s) [111.491984] [033/131] (908s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [111.595263] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [115.776121] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.184s) [116.997470] [034/131] (903s left) gem_exec_balancer (bonded-pair) [117.065734] Starting subtest: bonded-pair [117.069967] Subtest bonded-pair: SKIP (0.000s) [117.389816] [035/131] (903s left) kms_cursor_crc (cursor-rapid-movement-512x170) [117.687663] Starting subtest: cursor-rapid-movement-512x170 [117.692025] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [117.869598] [036/131] (902s left) gem_exec_whisper (basic-fds-priority-all) [117.938805] Starting subtest: basic-fds-priority-all [141.876672] Subtest basic-fds-priority-all: SUCCESS (23.932s) [142.085499] [037/131] (878s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [142.178067] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [142.182822] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [143.311925] [038/131] (877s left) i915_drm_fdinfo (virtual-busy) [143.353713] Starting subtest: virtual-busy [143.358298] Subtest virtual-busy: SKIP (0.000s) [143.444258] [039/131] (877s left) i915_suspend (forcewake) [143.503732] Starting subtest: forcewake [174.937118] Subtest forcewake: SUCCESS (6.088s) [175.029447] [040/131] (845s left) kms_vblank (wait-forked) [175.123823] Starting subtest: wait-forked [175.125969] Starting dynamic subtest: pipe-A-eDP-1 [176.987777] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s) [177.005008] Starting dynamic subtest: pipe-D-eDP-1 [179.575300] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s) [179.577824] Subtest wait-forked: SUCCESS (4.353s) [180.482538] [041/131] (840s left) perf (gen12-group-concurrent-oa-buffer-read) [180.623491] Starting subtest: gen12-group-concurrent-oa-buffer-read [190.720196] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (9.954s) [190.758063] [042/131] (830s left) kms_chamelium_audio (hdmi-audio-edid) [191.155759] Subtest hdmi-audio-edid: SKIP (0.000s) [191.962065] [043/131] (828s left) gem_close_race (multigpu-basic-threads) [192.030229] Starting subtest: multigpu-basic-threads [192.035106] Subtest multigpu-basic-threads: SKIP (0.000s) [192.309739] [044/131] (828s left) kms_chamelium_edid (hdmi-mode-timings) [192.708161] Subtest hdmi-mode-timings: SKIP (0.000s) [193.498006] [045/131] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [193.603989] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [201.008205] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.389s) [201.138851] [046/131] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [201.249243] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [201.253499] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [201.382564] [047/131] (819s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [201.478659] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [201.480829] Starting dynamic subtest: pipe-A-default-mode [201.783904] Dynamic subtest pipe-A-default-mode: SKIP (0.302s) [201.788306] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.304s) [202.631292] [048/131] (818s left) kms_plane_cursor (overlay) [202.727950] Starting subtest: overlay [202.732248] Starting dynamic subtest: pipe-A-eDP-1-size-64 [205.248315] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.519s) [205.309985] Starting dynamic subtest: pipe-A-eDP-1-size-128 [207.874803] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s) [207.941704] Starting dynamic subtest: pipe-A-eDP-1-size-256 [210.487238] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.559s) [210.842461] Starting dynamic subtest: pipe-B-eDP-1-size-64 [214.079548] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.246s) [214.140593] Starting dynamic subtest: pipe-B-eDP-1-size-128 [216.637548] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s) [216.698255] Starting dynamic subtest: pipe-B-eDP-1-size-256 [219.227737] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.537s) [219.589395] Starting dynamic subtest: pipe-C-eDP-1-size-64 [222.392115] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.813s) [222.432122] Starting dynamic subtest: pipe-C-eDP-1-size-128 [224.647863] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.224s) [224.687213] Starting dynamic subtest: pipe-C-eDP-1-size-256 [226.870903] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s) [227.201733] Starting dynamic subtest: pipe-D-eDP-1-size-64 [230.036493] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.844s) [230.090358] Starting dynamic subtest: pipe-D-eDP-1-size-128 [232.292648] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.224s) [232.337577] Starting dynamic subtest: pipe-D-eDP-1-size-256 [234.472266] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.146s) [234.789917] Subtest overlay: SUCCESS (32.048s) [235.670859] [049/131] (785s left) core_auth (basic-auth) [235.739295] Starting subtest: basic-auth [235.741716] Subtest basic-auth: SUCCESS (0.002s) [235.886304] [050/131] (785s left) gem_userptr_blits (unsync-unmap-cycles) [235.958387] Subtest unsync-unmap-cycles: SKIP (0.000s) [236.128583] [051/131] (785s left) kms_pm_dc (dc9-dpms) [237.237840] Starting subtest: dc9-dpms [238.652422] Subtest dc9-dpms: SUCCESS (1.415s) [238.755521] [052/131] (782s left) gem_ctx_persistence (processes) [238.826670] Starting subtest: processes [240.228507] Subtest processes: SUCCESS (1.401s) [240.335385] [053/131] (781s left) gem_exec_schedule (preempt-user) [240.411284] Starting subtest: preempt-user [240.413561] Starting dynamic subtest: rcs0 [240.426765] Dynamic subtest rcs0: SUCCESS (0.022s) [240.438928] Starting dynamic subtest: bcs0 [240.445016] Dynamic subtest bcs0: SUCCESS (0.018s) [240.454949] Starting dynamic subtest: vcs0 [240.465213] Dynamic subtest vcs0: SUCCESS (0.019s) [240.475075] Starting dynamic subtest: vcs1 [240.485764] Dynamic subtest vcs1: SUCCESS (0.020s) [240.495755] Starting dynamic subtest: vecs0 [240.504641] Dynamic subtest vecs0: SUCCESS (0.018s) [240.514826] Starting dynamic subtest: ccs0 [240.525026] Dynamic subtest ccs0: SUCCESS (0.019s) [240.527269] Subtest preempt-user: SUCCESS (0.121s) [242.369235] [054/131] (779s left) gem_exec_fence (nb-await) [242.554038] Starting subtest: nb-await [242.556040] Starting dynamic subtest: rcs0 [242.629771] Dynamic subtest rcs0: SUCCESS (0.079s) [242.642766] Starting dynamic subtest: bcs0 [242.689289] Dynamic subtest bcs0: SUCCESS (0.058s) [242.703638] Starting dynamic subtest: vcs0 [242.751499] Dynamic subtest vcs0: SUCCESS (0.060s) [242.767903] Starting dynamic subtest: vcs1 [242.813746] Dynamic subtest vcs1: SUCCESS (0.060s) [242.826984] Starting dynamic subtest: vecs0 [242.873992] Dynamic subtest vecs0: SUCCESS (0.057s) [242.886545] Starting dynamic subtest: ccs0 [242.933516] Dynamic subtest ccs0: SUCCESS (0.058s) [242.935986] Subtest nb-await: SUCCESS (0.384s) [244.366150] [055/131] (777s left) kms_psr (pr-basic) [244.475608] Starting subtest: pr-basic [244.479991] Subtest pr-basic: SKIP (0.000s) [244.572823] [056/131] (776s left) gen9_exec_parse (basic-rejected) [244.630716] Subtest basic-rejected: SKIP (0.000s) [244.712771] [057/131] (776s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [244.809876] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [244.812129] Starting dynamic subtest: pipe-A-eDP-1 [244.837388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [244.850001] Starting dynamic subtest: pipe-B-eDP-1 [244.873652] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [244.883111] Starting dynamic subtest: pipe-C-eDP-1 [244.906806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [244.916425] Starting dynamic subtest: pipe-D-eDP-1 [244.940468] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [244.944754] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s) [247.018476] [058/131] (774s left) kms_pm_rpm (system-suspend-idle) [248.540345] Starting subtest: system-suspend-idle [268.470049] Subtest system-suspend-idle: SUCCESS (4.581s) [268.884459] [059/131] (752s left) gem_gtt_cpu_tlb [269.019391] [060/131] (752s left) kms_flip (absolute-wf_vblank) [269.117558] Starting subtest: absolute-wf_vblank [269.120300] Starting dynamic subtest: A-eDP1 [277.850939] Dynamic subtest A-eDP1: SUCCESS (8.584s) [277.864067] Starting dynamic subtest: B-eDP1 [286.635288] Dynamic subtest B-eDP1: SUCCESS (8.743s) [286.646249] Starting dynamic subtest: C-eDP1 [295.377298] Dynamic subtest C-eDP1: SUCCESS (8.711s) [295.387924] Starting dynamic subtest: D-eDP1 [304.109881] Dynamic subtest D-eDP1: SUCCESS (8.724s) [304.112418] Subtest absolute-wf_vblank: SUCCESS (34.780s) [305.296253] [061/131] (716s left) kms_psr (fbc-pr-primary-render) [305.396315] Starting subtest: fbc-pr-primary-render [305.401326] Subtest fbc-pr-primary-render: SKIP (0.000s) [305.494452] [062/131] (716s left) gem_exec_balancer (parallel-out-fence) [305.756578] Starting subtest: parallel-out-fence [307.026032] Subtest parallel-out-fence: SUCCESS (1.269s) [307.164928] [063/131] (714s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [307.267164] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [307.272722] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [307.394762] [064/131] (714s left) kms_chamelium_hpd (hdmi-hpd) [307.785017] Subtest hdmi-hpd: SKIP (0.000s) [308.593837] [065/131] (713s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [308.721942] Starting subtest: cursorA-vs-flipA-legacy [319.866310] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.142s) [320.760307] [066/131] (701s left) syncobj_timeline (signal-point-0) [320.830564] Starting subtest: signal-point-0 [320.833419] Subtest signal-point-0: SUCCESS (0.000s) [320.956604] [067/131] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [321.053138] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [321.058184] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [321.173391] [068/131] (700s left) gem_pxp (verify-pxp-stale-buf-execution) [321.303192] Starting subtest: verify-pxp-stale-buf-execution [322.366110] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s) [322.535646] [069/131] (699s left) gem_ppgtt (blt-vs-render-ctx0) [322.595756] Starting subtest: blt-vs-render-ctx0 [355.837578] Subtest blt-vs-render-ctx0: SUCCESS (33.226s) [356.008582] [070/131] (666s left) gem_mmap_gtt (cpuset-big-copy-xy) [356.113245] Subtest cpuset-big-copy-XY: SKIP (0.000s) [356.182711] [071/131] (665s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [356.288054] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [356.290776] Starting dynamic subtest: pipe-A [357.349044] Dynamic subtest pipe-A: SUCCESS (1.062s) [357.359400] Starting dynamic subtest: pipe-B [359.446593] Dynamic subtest pipe-B: SUCCESS (2.096s) [359.457452] Starting dynamic subtest: pipe-C [360.655255] Dynamic subtest pipe-C: SUCCESS (1.207s) [360.666835] Starting dynamic subtest: pipe-D [361.806879] Dynamic subtest pipe-D: SUCCESS (1.150s) [361.809823] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.519s) [363.026495] [072/131] (659s left) syncobj_basic (bad-pad-handle-to-fd) [363.104434] Starting subtest: bad-pad-handle-to-fd [363.107246] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [363.240053] [073/131] (658s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [363.341114] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [363.343928] Starting dynamic subtest: A-eDP1 [366.931780] Dynamic subtest A-eDP1: SUCCESS (3.594s) [366.944243] Starting dynamic subtest: B-eDP1 [370.130222] Dynamic subtest B-eDP1: SUCCESS (3.200s) [370.141841] Starting dynamic subtest: C-eDP1 [373.230895] Dynamic subtest C-eDP1: SUCCESS (3.098s) [373.242419] Starting dynamic subtest: D-eDP1 [376.315984] Dynamic subtest D-eDP1: SUCCESS (3.086s) [376.318536] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.985s) [377.152432] [074/131] (645s left) syncobj_wait (wait-for-submit-complex) [377.223924] Starting subtest: wait-for-submit-complex [377.286145] Subtest wait-for-submit-complex: SUCCESS (0.062s) [377.391891] [075/131] (644s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [377.491164] Starting subtest: yf-tiled-16bpp-rotate-270 [377.496521] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [377.629997] [076/131] (644s left) sw_sync (sync_multi_timeline_wait) [377.665099] Starting subtest: sync_multi_timeline_wait [377.668099] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [377.748141] [077/131] (644s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [377.842866] Starting subtest: primary-y-tiled-reflect-x-0 [377.902862] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s) [378.030128] [078/131] (644s left) kms_mmap_write_crc (main) [378.119086] Starting subtest: main [378.121583] Starting dynamic subtest: pipe-A-eDP-1 [381.763911] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.645s) [381.766706] Subtest main: SUCCESS (3.647s) [382.589207] [079/131] (639s left) kms_cursor_edge_walk (64x64-left-edge) [382.680120] Starting subtest: 64x64-left-edge [382.682707] Starting dynamic subtest: pipe-A-eDP-1 [386.125939] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s) [386.137901] Starting dynamic subtest: pipe-D-eDP-1 [389.234300] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.105s) [389.236757] Subtest 64x64-left-edge: SUCCESS (6.551s) [390.073612] [080/131] (632s left) kms_flip (wf_vblank-ts-check-interruptible) [390.169020] Starting subtest: wf_vblank-ts-check-interruptible [390.171804] Starting dynamic subtest: A-eDP1 [399.128265] Dynamic subtest A-eDP1: SUCCESS (8.927s) [399.141940] Starting dynamic subtest: B-eDP1 [408.061268] Dynamic subtest B-eDP1: SUCCESS (8.931s) [408.074952] Starting dynamic subtest: C-eDP1 [416.998963] Dynamic subtest C-eDP1: SUCCESS (8.922s) [417.012018] Starting dynamic subtest: D-eDP1 [425.929292] Dynamic subtest D-eDP1: SUCCESS (8.925s) [425.931956] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.714s) [427.128482] [081/131] (595s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [427.192260] Starting subtest: y-tiled-ccs-to-x-tiled [427.197890] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [427.409852] [082/131] (595s left) kms_psr (fbc-psr2-no-drrs) [427.496046] Starting subtest: fbc-psr2-no-drrs [427.498762] Starting dynamic subtest: eDP-1 [427.503662] Dynamic subtest eDP-1: SKIP (0.000s) [427.508790] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [427.598819] [083/131] (595s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [427.700028] Starting subtest: fbc-rgb565-draw-mmap-gtt [427.705183] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [427.828610] [084/131] (594s left) kms_psr (psr-primary-render) [427.926505] Starting subtest: psr-primary-render [427.928994] Starting dynamic subtest: eDP-1 [429.710982] Dynamic subtest eDP-1: SUCCESS (1.786s) [429.713759] Subtest psr-primary-render: SUCCESS (1.787s) [430.593823] [085/131] (592s left) gem_softpin (evict-prime-sanity-check) [430.653302] Starting subtest: evict-prime-sanity-check [430.656127] Starting dynamic subtest: rcs0 [431.840590] Dynamic subtest rcs0: SUCCESS (1.186s) [431.852572] Starting dynamic subtest: bcs0 [432.978785] Dynamic subtest bcs0: SUCCESS (1.136s) [432.992511] Starting dynamic subtest: vcs0 [434.486575] Dynamic subtest vcs0: SUCCESS (1.505s) [434.500501] Starting dynamic subtest: vcs1 [436.558200] Dynamic subtest vcs1: SUCCESS (2.069s) [436.570852] Starting dynamic subtest: vecs0 [438.461165] Dynamic subtest vecs0: SUCCESS (1.900s) [438.474297] Starting dynamic subtest: ccs0 [439.611798] Dynamic subtest ccs0: SUCCESS (1.149s) [439.625290] Starting dynamic subtest: all [440.765898] Dynamic subtest all: SUCCESS (1.151s) [440.768855] Subtest evict-prime-sanity-check: SUCCESS (10.111s) [440.876409] [086/131] (581s left) kms_content_protection (dp-mst-type-0) [441.035987] Starting subtest: dp-mst-type-0 [441.040439] Subtest dp-mst-type-0: SKIP (0.000s) [441.196046] [087/131] (581s left) gem_tiling_max_stride [441.331639] [088/131] (581s left) kms_async_flips (async-flip-suspend-resume) [441.429042] Starting subtest: async-flip-suspend-resume [441.814902] Starting dynamic subtest: pipe-A-eDP-1 [458.913219] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.930s) [459.281532] Starting dynamic subtest: pipe-B-eDP-1 [476.939363] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.886s) [477.323834] Starting dynamic subtest: pipe-C-eDP-1 [494.927096] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.837s) [495.309499] Starting dynamic subtest: pipe-D-eDP-1 [512.943174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.887s) [512.947703] Subtest async-flip-suspend-resume: SUCCESS (13.019s) [514.201988] [089/131] (508s left) gem_exec_flush (basic-wb-ro-default) [514.283154] Starting subtest: basic-wb-ro-default [519.871373] Subtest basic-wb-ro-default: SUCCESS (5.459s) [520.067647] [090/131] (502s left) gem_tiled_swapping (non-threaded) [520.133974] Subtest non-threaded: SKIP (0.000s) [520.200115] [091/131] (502s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [520.306631] Starting subtest: fbc-rgb101010-draw-mmap-cpu [524.926053] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.576s) [526.070219] [092/131] (497s left) kms_lease (multimaster-lease) [526.176316] Starting subtest: multimaster-lease [526.178626] Subtest multimaster-lease: SUCCESS (0.004s) [526.309643] [093/131] (496s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [526.411523] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [526.416092] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [527.587703] [094/131] (495s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [527.691522] Starting subtest: yf-tiled-8bpp-rotate-270 [527.695468] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [527.823431] [095/131] (495s left) kms_frontbuffer_tracking (psr-1p-rte) [527.924591] Starting subtest: psr-1p-rte [533.343609] Subtest psr-1p-rte: SUCCESS (5.402s) [533.513920] [096/131] (489s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [538.536997] Starting subtest: psr2-overlay-plane-move-continuous-sf [538.538986] Starting dynamic subtest: pipe-A-eDP-1 [545.230817] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.684s) [545.242504] Starting dynamic subtest: pipe-B-eDP-1 [551.887349] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s) [551.889525] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.344s) [552.785252] [097/131] (470s left) gem_mmap_gtt (big-bo-tiledy) [552.854721] Subtest big-bo-tiledY: SKIP (0.000s) [552.928028] [098/131] (470s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [553.024678] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [553.026986] Starting dynamic subtest: pipe-A-eDP-1 [553.049467] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [553.063577] Starting dynamic subtest: pipe-B-eDP-1 [553.084128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [553.094004] Starting dynamic subtest: pipe-C-eDP-1 [553.115057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [553.125030] Starting dynamic subtest: pipe-D-eDP-1 [553.147512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [553.152329] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [555.251688] [099/131] (468s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [555.360978] Starting subtest: psr-2p-primscrn-spr-indfb-move [555.364926] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [555.508337] [100/131] (467s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [555.630024] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [556.617588] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.987s) [557.480756] [101/131] (465s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [557.585649] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [557.587936] Starting dynamic subtest: pipe-A-default-mode [558.719973] Dynamic subtest pipe-A-default-mode: SKIP (1.131s) [558.724193] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.133s) [558.923132] [102/131] (464s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [558.979910] Starting subtest: multi-wait-all-for-submit-submitted-signaled [559.087522] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [559.185883] [103/131] (464s left) prime_vgem (fence-write-hang) [559.286856] Subtest fence-write-hang: SKIP (0.000s) [559.427300] [104/131] (464s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [559.532846] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [559.536930] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [559.676672] [105/131] (463s left) kms_psr (psr-cursor-blt) [559.779586] Starting subtest: psr-cursor-blt [559.781768] Starting dynamic subtest: eDP-1 [561.477190] Dynamic subtest eDP-1: SUCCESS (1.697s) [561.479481] Subtest psr-cursor-blt: SUCCESS (1.698s) [562.383392] [106/131] (461s left) gem_exec_schedule (fairslice) [562.458986] Starting subtest: fairslice [562.460894] Starting dynamic subtest: rcs0 [564.522522] Dynamic subtest rcs0: SUCCESS (2.018s) [564.535756] Starting dynamic subtest: bcs0 [566.488010] Dynamic subtest bcs0: SUCCESS (2.015s) [566.499954] Starting dynamic subtest: vcs0 [568.555040] Dynamic subtest vcs0: SUCCESS (2.016s) [568.568015] Starting dynamic subtest: vcs1 [570.520883] Dynamic subtest vcs1: SUCCESS (2.015s) [570.533522] Starting dynamic subtest: vecs0 [572.589118] Dynamic subtest vecs0: SUCCESS (2.016s) [572.601010] Starting dynamic subtest: ccs0 [574.560971] Dynamic subtest ccs0: SUCCESS (2.019s) [574.563359] Subtest fairslice: SUCCESS (12.105s) [574.885591] [107/131] (448s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [574.993819] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [581.755783] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.763s) [581.959046] [108/131] (441s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [582.022755] Starting subtest: etime-multi-wait-available-unsubmitted [582.127554] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s) [582.230624] [109/131] (441s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [587.354915] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [587.359559] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s) [588.220555] [110/131] (435s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [588.323094] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [588.327513] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [588.452305] [111/131] (435s left) api_intel_bb (offset-control) [588.513646] Starting subtest: offset-control [588.520479] Subtest offset-control: SUCCESS (0.008s) [588.683750] [112/131] (435s left) i915_pm_rps (engine-order) [588.745879] Starting subtest: engine-order [593.865236] Subtest engine-order: SUCCESS (5.112s) [594.039122] [113/131] (429s left) gem_ctx_persistence (engines-mixed) [594.112179] Starting subtest: engines-mixed [594.114534] Starting dynamic subtest: rcs0 [594.218036] Dynamic subtest rcs0: SUCCESS (0.105s) [594.233147] Starting dynamic subtest: bcs0 [594.278991] Dynamic subtest bcs0: SUCCESS (0.059s) [594.295520] Starting dynamic subtest: vcs0 [594.340994] Dynamic subtest vcs0: SUCCESS (0.060s) [594.354084] Starting dynamic subtest: vcs1 [594.405318] Dynamic subtest vcs1: SUCCESS (0.062s) [594.419251] Starting dynamic subtest: vecs0 [594.483531] Dynamic subtest vecs0: SUCCESS (0.076s) [594.498120] Starting dynamic subtest: ccs0 [594.575373] Dynamic subtest ccs0: SUCCESS (0.090s) [594.578244] Subtest engines-mixed: SUCCESS (0.464s) [594.683751] [114/131] (429s left) kms_plane_scaling (2x-scaler-multi-pipe) [594.784069] Starting subtest: 2x-scaler-multi-pipe [594.788403] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [594.926416] [115/131] (429s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [595.031843] Starting subtest: fbcpsr-rgb101010-draw-pwrite [601.998410] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.966s) [602.137815] [116/131] (421s left) gem_pread (snoop) [602.197544] Subtest snoop: SKIP (0.000s) [602.261415] [117/131] (421s left) gem_exec_capture (userptr) [602.313015] Starting subtest: userptr [603.128997] Subtest userptr: SUCCESS (0.813s) [603.282017] [118/131] (420s left) kms_big_fb (4-tiled-8bpp-rotate-180) [603.392786] Starting subtest: 4-tiled-8bpp-rotate-180 [604.574025] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.181s) [604.725909] [119/131] (419s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [604.826591] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [612.206991] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s) [612.403914] [120/131] (411s left) kms_big_fb (y-tiled-16bpp-rotate-270) [612.503887] Starting subtest: y-tiled-16bpp-rotate-270 [612.508042] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [612.637535] [121/131] (411s left) kms_frontbuffer_tracking (fbc-stridechange) [612.738142] Starting subtest: fbc-stridechange [616.051823] Subtest fbc-stridechange: SUCCESS (3.317s) [617.256225] [122/131] (407s left) kms_addfb_basic (basic) [617.315158] Starting subtest: basic [617.317505] Subtest basic: SUCCESS (0.000s) [617.483490] [123/131] (406s left) gem_vm_create (create-ext) [617.553954] Starting subtest: create-ext [617.559665] Subtest create-ext: SUCCESS (0.005s) [617.712205] [124/131] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [617.807992] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [617.812120] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [617.933476] [125/131] (406s left) syncobj_timeline (multi-wait-available-submitted) [617.988404] Starting subtest: multi-wait-available-submitted [617.990700] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [618.120933] [126/131] (406s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [618.216860] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [618.220262] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [618.355258] [127/131] (406s left) syncobj_timeline (wait-for-submit-snapshot) [618.409774] Starting subtest: wait-for-submit-snapshot [618.490855] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [618.600253] [128/131] (406s left) kms_cursor_crc (cursor-onscreen-128x128) [618.793667] Starting subtest: cursor-onscreen-128x128 [618.797780] Starting dynamic subtest: pipe-A-eDP-1 [620.897566] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s) [620.928397] Starting dynamic subtest: pipe-D-eDP-1 [623.759696] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.841s) [623.761979] Subtest cursor-onscreen-128x128: SUCCESS (4.966s) [624.614489] [129/131] (400s left) prime_mmap (test_invalid_sync_flags) [624.670977] Starting subtest: test_invalid_sync_flags [624.673270] Starting dynamic subtest: test_invalid_sync_flags-smem [624.675665] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [624.677847] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [624.817992] [130/131] (399s left) gem_mmap_offset (pf-nonblock) [624.880701] Starting subtest: pf-nonblock [624.885901] Subtest pf-nonblock: SUCCESS (0.006s) [625.036651] [131/131] (399s left) perf_pmu (most-busy-idle-check-all) [625.079615] Starting subtest: most-busy-idle-check-all [625.081953] Starting dynamic subtest: rcs0 [626.771583] Dynamic subtest rcs0: SUCCESS (1.695s) [626.785978] Starting dynamic subtest: bcs0 [628.820175] Dynamic subtest bcs0: SUCCESS (2.045s) [628.834245] Starting dynamic subtest: vcs0 [630.803999] Dynamic subtest vcs0: SUCCESS (1.981s) [630.818190] Starting dynamic subtest: vcs1 [632.787320] Dynamic subtest vcs1: SUCCESS (1.981s) [632.801341] Starting dynamic subtest: vecs0 [634.771462] Dynamic subtest vecs0: SUCCESS (1.982s) [634.785505] Starting dynamic subtest: ccs0 [636.820134] Dynamic subtest ccs0: SUCCESS (2.046s) [636.823330] Subtest most-busy-idle-check-all: SUCCESS (11.746s) [636.951594] Closing watchdogs results: parsing output: 0/ for test: gem_userptr_blits results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: gem_ccs results: parsing output: 3/ for test: i915_hangman results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: gem_exec_reloc results: parsing output: 6/ for test: gem_render_copy results: parsing output: 7/ for test: gem_exercise_blt results: parsing output: 8/ for test: kms_cursor_crc results: parsing output: 9/ for test: kms_getfb results: parsing output: 10/ for test: sriov_basic results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: prime_mmap results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_universal_plane results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: gem_exec_reloc results: parsing output: 17/ for test: kms_plane_scaling results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_async_flips results: parsing output: 20/ for test: sysfs_heartbeat_interval results: parsing output: 21/ for test: syncobj_wait results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_unfence_active_buffers results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: dumb_buffer results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: gem_ctx_shared results: parsing output: 29/ for test: kms_draw_crc results: parsing output: 30/ for test: i915_query results: parsing output: 31/ for test: kms_invalid_mode results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_balancer results: parsing output: 34/ for test: kms_cursor_crc results: parsing output: 35/ for test: gem_exec_whisper results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: i915_drm_fdinfo results: parsing output: 38/ for test: i915_suspend results: parsing output: 39/ for test: kms_vblank results: parsing output: 40/ for test: perf results: parsing output: 41/ for test: kms_chamelium_audio results: parsing output: 42/ for test: gem_close_race results: parsing output: 43/ for test: kms_chamelium_edid results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_flip_scaled_crc results: parsing output: 47/ for test: kms_plane_cursor results: parsing output: 48/ for test: core_auth results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: kms_pm_dc results: parsing output: 51/ for test: gem_ctx_persistence results: parsing output: 52/ for test: gem_exec_schedule results: parsing output: 53/ for test: gem_exec_fence results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_pm_rpm results: parsing output: 58/ for test: gem_gtt_cpu_tlb results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_chamelium_hpd results: parsing output: 64/ for test: kms_cursor_legacy results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_pxp results: parsing output: 68/ for test: gem_ppgtt results: parsing output: 69/ for test: gem_mmap_gtt results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: syncobj_basic results: parsing output: 72/ for test: kms_flip results: parsing output: 73/ for test: syncobj_wait results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: sw_sync results: parsing output: 76/ for test: kms_rotation_crc results: parsing output: 77/ for test: kms_mmap_write_crc results: parsing output: 78/ for test: kms_cursor_edge_walk results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: gem_render_copy results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: gem_softpin results: parsing output: 85/ for test: kms_content_protection results: parsing output: 86/ for test: gem_tiling_max_stride results: parsing output: 87/ for test: kms_async_flips results: parsing output: 88/ for test: gem_exec_flush results: parsing output: 89/ for test: gem_tiled_swapping results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_lease results: parsing output: 92/ for test: kms_ccs results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_flip_scaled_crc results: parsing output: 101/ for test: syncobj_wait results: parsing output: 102/ for test: prime_vgem results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: gem_exec_schedule results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_psr2_sf results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: api_intel_bb results: parsing output: 111/ for test: i915_pm_rps results: parsing output: 112/ for test: gem_ctx_persistence results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_pread results: parsing output: 116/ for test: gem_exec_capture results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_addfb_basic results: parsing output: 122/ for test: gem_vm_create results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: kms_cursor_crc results: parsing output: 128/ for test: prime_mmap results: parsing output: 129/ for test: gem_mmap_offset results: parsing output: 130/ for test: perf_pmu Done.