[55.789359] Initializing watchdogs [55.789407] /dev/watchdog0 [55.804358] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [55.808215] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.810751] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.814191] [001/156] (960s left) kms_addfb_basic (bad-pitch-0) [55.897836] Starting subtest: bad-pitch-0 [55.900160] Subtest bad-pitch-0: SUCCESS (0.000s) [56.014809] [002/156] (960s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [56.109119] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [56.111241] Starting dynamic subtest: pipe-A-eDP-1 [56.243675] Dynamic subtest pipe-A-eDP-1: SKIP (0.137s) [56.253448] Starting dynamic subtest: pipe-B-eDP-1 [57.443957] Dynamic subtest pipe-B-eDP-1: SKIP (1.200s) [57.449111] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.338s) [58.621422] [003/156] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [58.703899] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [58.708172] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [58.800883] [004/156] (957s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [58.863876] Starting subtest: multi-wait-for-submit-submitted-signaled [58.866225] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [58.979339] [005/156] (957s left) kms_vblank (wait-forked-busy-hang) [59.053632] Starting subtest: wait-forked-busy-hang [59.055941] Starting dynamic subtest: pipe-A-eDP-1 [87.020512] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.965s) [87.033707] Starting dynamic subtest: pipe-D-eDP-1 [112.015319] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.993s) [112.017653] Subtest wait-forked-busy-hang: SUCCESS (52.961s) [112.892216] [006/156] (903s left) gem_readwrite (read-write) [112.950139] Subtest read-write: SKIP (0.000s) [113.013777] [007/156] (903s left) gem_fenced_exec_thrash (no-spare-fences) [113.075406] Subtest no-spare-fences: SKIP (0.000s) [113.130341] [008/156] (903s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite) [113.208230] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite [113.212239] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [113.308172] [009/156] (903s left) kms_universal_plane (disable-primary-vs-flip) [113.388778] Starting subtest: disable-primary-vs-flip [113.391082] Starting dynamic subtest: pipe-A-eDP-1 [114.995649] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.606s) [115.004168] Starting dynamic subtest: pipe-B-eDP-1 [117.258704] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.261s) [117.267104] Starting dynamic subtest: pipe-C-eDP-1 [119.499959] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s) [119.507787] Starting dynamic subtest: pipe-D-eDP-1 [121.762963] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.260s) [121.765392] Subtest disable-primary-vs-flip: SUCCESS (8.374s) [122.636362] [010/156] (894s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy) [122.720668] Starting subtest: fbcpsrhdr-modesetfrombusy [122.724791] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s) [122.822473] [011/156] (893s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [122.912074] Starting subtest: yf-tiled-64bpp-rotate-90 [122.916640] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [123.002367] [012/156] (893s left) prime_vgem (sync) [123.103826] Starting subtest: sync [123.106279] Starting dynamic subtest: rcs0 [123.158564] Dynamic subtest rcs0: SUCCESS (0.055s) [123.166269] Starting dynamic subtest: bcs0 [123.215835] Dynamic subtest bcs0: SUCCESS (0.057s) [123.223390] Starting dynamic subtest: vcs0 [123.263503] Dynamic subtest vcs0: SUCCESS (0.047s) [123.271067] Starting dynamic subtest: vcs1 [123.307493] Dynamic subtest vcs1: SUCCESS (0.044s) [123.315091] Starting dynamic subtest: vecs0 [123.352727] Dynamic subtest vecs0: SUCCESS (0.045s) [123.360198] Starting dynamic subtest: ccs0 [123.400019] Dynamic subtest ccs0: SUCCESS (0.047s) [123.402349] Subtest sync: SUCCESS (0.296s) [123.527256] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [123.530306] [013/156] (893s left) kms_flip (2x-flip-vs-panning-vs-hang) [123.601595] Starting subtest: 2x-flip-vs-panning-vs-hang [123.604924] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.001s) [123.705343] [014/156] (893s left) gem_softpin (32b-excludes-last-page) [123.759097] Starting subtest: 32b-excludes-last-page [123.762876] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [123.881659] [015/156] (892s left) gem_ctx_engines (execute-one) [123.936121] Starting subtest: execute-one [125.867263] Subtest execute-one: SUCCESS (1.931s) [126.053221] [016/156] (890s left) gem_mmap_gtt (medium-copy) [126.107319] Subtest medium-copy: SKIP (0.000s) [126.181449] [017/156] (890s left) perf_pmu (render-node-busy) [126.238648] Starting subtest: render-node-busy [126.241046] Starting dynamic subtest: rcs0 [126.837223] Dynamic subtest rcs0: SUCCESS (0.597s) [126.848923] Starting dynamic subtest: bcs0 [127.401588] Dynamic subtest bcs0: SUCCESS (0.564s) [127.410786] Starting dynamic subtest: vcs0 [129.213761] Dynamic subtest vcs0: SUCCESS (1.810s) [129.226046] Starting dynamic subtest: vcs1 [131.197743] Dynamic subtest vcs1: SUCCESS (1.983s) [131.210320] Starting dynamic subtest: vecs0 [133.246066] Dynamic subtest vecs0: SUCCESS (2.047s) [133.258104] Starting dynamic subtest: ccs0 [133.808464] Dynamic subtest ccs0: SUCCESS (0.563s) [133.811251] Subtest render-node-busy: SUCCESS (7.570s) [133.881201] [018/156] (883s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [133.976196] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [133.980715] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [134.067745] [019/156] (882s left) perf (non-zero-reason) [134.191247] Starting subtest: non-zero-reason [134.193511] Starting dynamic subtest: 0-rcs0 [139.526821] Dynamic subtest 0-rcs0: SUCCESS (5.334s) [139.538830] Starting dynamic subtest: 1-vcs0 [143.415783] Dynamic subtest 1-vcs0: SUCCESS (3.888s) [143.418915] Subtest non-zero-reason: SUCCESS (9.223s) [143.465311] [020/156] (873s left) gem_mmap_wc (write-wc-read-gtt) [143.525612] Subtest write-wc-read-gtt: SKIP (0.000s) [143.584306] [021/156] (873s left) gem_set_tiling_vs_gtt [143.707990] [022/156] (873s left) perf (per-context-mode-unprivileged) [143.801773] Starting subtest: per-context-mode-unprivileged [143.806251] Subtest per-context-mode-unprivileged: SKIP (0.000s) [143.844253] [023/156] (873s left) i915_pm_rpm (system-suspend-execbuf) [145.361839] Starting subtest: system-suspend-execbuf [204.599262] Subtest system-suspend-execbuf: SUCCESS (44.040s) [204.992688] [024/156] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [205.074561] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [205.080048] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [205.177525] [025/156] (812s left) prime_mmap_coherency (write) [205.227420] Starting subtest: write [210.608429] Subtest write: SUCCESS (5.380s) [210.748611] [026/156] (806s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [210.834176] Starting subtest: fbcpsr-modesetfrombusy [217.171949] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.346s) [217.297553] [027/156] (800s left) gem_exec_schedule (pi-shared-iova) [217.472140] Starting subtest: pi-shared-iova [217.474397] Starting dynamic subtest: rcs0 [217.547314] Dynamic subtest rcs0: SUCCESS (0.077s) [217.559063] Starting dynamic subtest: vcs0 [217.606282] Dynamic subtest vcs0: SUCCESS (0.057s) [217.617330] Starting dynamic subtest: vcs1 [217.661017] Dynamic subtest vcs1: SUCCESS (0.055s) [217.671972] Starting dynamic subtest: vecs0 [217.714857] Dynamic subtest vecs0: SUCCESS (0.052s) [217.724581] Starting dynamic subtest: ccs0 [217.770893] Dynamic subtest ccs0: SUCCESS (0.056s) [217.773734] Subtest pi-shared-iova: SUCCESS (0.302s) [219.510544] [028/156] (797s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw) [219.600245] Starting subtest: hdr-2p-pri-indfb-multidraw [219.605378] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s) [219.686393] [029/156] (797s left) kms_psr (fbc-pr-primary-blt) [219.767376] Starting subtest: fbc-pr-primary-blt [219.772837] Subtest fbc-pr-primary-blt: SKIP (0.000s) [219.841205] [030/156] (797s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [219.920384] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [219.925080] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [220.016913] [031/156] (797s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [220.102625] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [229.648723] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.552s) [229.779292] [032/156] (787s left) kms_rotation_crc (sprite-rotation-90) [229.853030] Starting subtest: sprite-rotation-90 [229.858205] Subtest sprite-rotation-90: SKIP (0.001s) [229.926840] [033/156] (787s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [229.975204] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [230.080792] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s) [230.156189] [034/156] (787s left) kms_cursor_crc (cursor-offscreen-32x32) [230.276375] Starting subtest: cursor-offscreen-32x32 [230.324376] Subtest cursor-offscreen-32x32: SKIP (0.042s) [230.589609] [035/156] (787s left) kms_addfb_basic (too-wide) [230.664292] Starting subtest: too-wide [230.666875] Subtest too-wide: SUCCESS (0.000s) [230.769164] [036/156] (786s left) syncobj_wait (single-wait-all-signaled) [230.816185] Starting subtest: single-wait-all-signaled [230.818640] Subtest single-wait-all-signaled: SUCCESS (0.000s) [230.920441] [037/156] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [231.001169] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [231.006243] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [231.103158] [038/156] (786s left) i915_drm_fdinfo (busy-idle-check-all) [231.140950] Starting subtest: busy-idle-check-all [231.142969] Starting dynamic subtest: rcs0 [231.147023] Dynamic subtest rcs0: SKIP (0.004s) [231.157512] Starting dynamic subtest: bcs0 [231.161268] Dynamic subtest bcs0: SKIP (0.000s) [231.170330] Starting dynamic subtest: vcs0 [231.174912] Dynamic subtest vcs0: SKIP (0.000s) [231.184156] Starting dynamic subtest: vcs1 [231.188307] Dynamic subtest vcs1: SKIP (0.000s) [231.197909] Starting dynamic subtest: vecs0 [231.202602] Dynamic subtest vecs0: SKIP (0.000s) [231.211519] Starting dynamic subtest: ccs0 [231.216187] Dynamic subtest ccs0: SKIP (0.000s) [231.220785] Subtest busy-idle-check-all: SKIP (0.007s) [231.257588] [039/156] (786s left) syncobj_timeline (single-wait-available-submitted) [231.305675] Starting subtest: single-wait-available-submitted [231.308264] Subtest single-wait-available-submitted: SUCCESS (0.000s) [231.402259] [040/156] (786s left) api_intel_bb (crc32) [231.453553] Starting subtest: crc32 [231.455857] Starting dynamic subtest: rcs0-smem0 [231.741372] Dynamic subtest rcs0-smem0: SUCCESS (0.287s) [231.756670] Starting dynamic subtest: bcs0-smem0 [232.043878] Dynamic subtest bcs0-smem0: SUCCESS (0.301s) [232.057639] Starting dynamic subtest: vcs0-smem0 [232.375252] Dynamic subtest vcs0-smem0: SUCCESS (0.330s) [232.386929] Starting dynamic subtest: vcs1-smem0 [232.699295] Dynamic subtest vcs1-smem0: SUCCESS (0.322s) [232.712433] Starting dynamic subtest: vecs0-smem0 [232.990224] Dynamic subtest vecs0-smem0: SUCCESS (0.290s) [233.003654] Starting dynamic subtest: ccs0-smem0 [233.324748] Dynamic subtest ccs0-smem0: SUCCESS (0.333s) [233.327646] Subtest crc32: SUCCESS (1.872s) [233.437987] [041/156] (784s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [233.490172] Starting subtest: single-wait-all-for-submit-unsubmitted [233.590747] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [233.687986] [042/156] (784s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [233.763329] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [233.766054] Starting dynamic subtest: pipe-A-default-mode [234.940133] Dynamic subtest pipe-A-default-mode: SKIP (1.172s) [234.945657] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.173s) [235.082762] [043/156] (782s left) kms_dp_link_training (uhbr-mst) [235.159260] Starting subtest: uhbr-mst [235.170631] Subtest uhbr-mst: SKIP (0.000s) [235.233866] [044/156] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [235.312200] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [235.317415] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [235.410106] [045/156] (782s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render) [235.504218] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render [235.509182] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [235.606647] [046/156] (782s left) gem_partial_pwrite_pread (reads-snoop) [235.658004] Subtest reads-snoop: SKIP (0.000s) [235.728707] [047/156] (782s left) gen9_exec_parse (basic-rejected-ctx-param) [235.785949] Subtest basic-rejected-ctx-param: SKIP (0.000s) [235.855321] [048/156] (782s left) kms_psr (psr-primary-render) [235.936872] Starting subtest: psr-primary-render [235.938895] Starting dynamic subtest: eDP-1 [237.704177] Dynamic subtest eDP-1: SUCCESS (1.767s) [237.707285] Subtest psr-primary-render: SUCCESS (1.767s) [238.563492] [049/156] (779s left) gem_ctx_bad_destroy (double-destroy) [238.613143] Starting subtest: double-destroy [238.615868] Subtest double-destroy: SUCCESS (0.000s) [238.687928] [050/156] (779s left) gem_ctx_persistence (hang) [238.738128] Starting subtest: hang [238.743933] Subtest hang: SKIP (0.000s) [238.832924] [051/156] (779s left) kms_psr (psr2-cursor-blt) [238.904334] Starting subtest: psr2-cursor-blt [238.906818] Starting dynamic subtest: eDP-1 [240.656077] Dynamic subtest eDP-1: SUCCESS (1.751s) [240.658605] Subtest psr2-cursor-blt: SUCCESS (1.751s) [241.523774] [052/156] (776s left) kms_cursor_crc (cursor-rapid-movement-256x85) [241.735888] Starting subtest: cursor-rapid-movement-256x85 [241.785135] Subtest cursor-rapid-movement-256x85: SKIP (0.043s) [241.936222] [053/156] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [242.013394] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [242.019151] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [242.111749] [054/156] (776s left) gem_eio (create-ext) [242.317184] Starting subtest: create-ext [242.620069] Subtest create-ext: SUCCESS (0.303s) [242.739037] [055/156] (775s left) kms_big_fb (x-tiled-8bpp-rotate-0) [242.822071] Starting subtest: x-tiled-8bpp-rotate-0 [244.079787] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.259s) [244.194327] [056/156] (774s left) kms_flip (flip-vs-rmfb-interruptible) [244.267697] Starting subtest: flip-vs-rmfb-interruptible [244.269994] Starting dynamic subtest: A-eDP1 [252.916929] Dynamic subtest A-eDP1: SUCCESS (8.648s) [252.928209] Starting dynamic subtest: B-eDP1 [261.538485] Dynamic subtest B-eDP1: SUCCESS (8.620s) [261.549209] Starting dynamic subtest: C-eDP1 [270.161009] Dynamic subtest C-eDP1: SUCCESS (8.621s) [270.174735] Starting dynamic subtest: D-eDP1 [278.804084] Dynamic subtest D-eDP1: SUCCESS (8.640s) [278.806118] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.538s) [279.996189] [057/156] (738s left) kms_pm_backlight (brightness-with-dpms) [280.069075] Starting subtest: brightness-with-dpms [280.117203] Starting dynamic subtest: eDP-1 [282.494133] Dynamic subtest eDP-1: SUCCESS (2.375s) [282.497127] Subtest brightness-with-dpms: SUCCESS (2.425s) [283.362995] [058/156] (735s left) kms_plane_multiple (2x-tiling-4) [283.438308] Starting subtest: 2x-tiling-4 [283.443930] Subtest 2x-tiling-4: SKIP (0.000s) [283.511769] [059/156] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [283.595384] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [283.600715] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [283.686393] [060/156] (735s left) kms_async_flips (alternate-sync-async-flip) [283.757005] Starting subtest: alternate-sync-async-flip [284.140395] Starting dynamic subtest: pipe-A-eDP-1 [286.954408] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.815s) [287.351127] Starting dynamic subtest: pipe-B-eDP-1 [290.098812] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s) [290.471400] Starting dynamic subtest: pipe-C-eDP-1 [293.226950] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s) [293.594813] Starting dynamic subtest: pipe-D-eDP-1 [296.364244] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s) [296.366832] Subtest alternate-sync-async-flip: SUCCESS (12.610s) [297.538038] [061/156] (721s left) gem_exec_store (basic) [297.597643] Starting subtest: basic [297.702390] Subtest basic: SUCCESS (0.109s) [297.903610] [062/156] (720s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [297.985538] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt [297.991065] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [298.084736] [063/156] (720s left) gem_unref_active_buffers [298.266698] [064/156] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [298.343900] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [298.348850] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [298.444745] [065/156] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [298.524781] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [305.914024] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.399s) [306.038141] [066/156] (712s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc) [306.121942] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc [306.126953] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [306.220192] [067/156] (712s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [306.297935] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [310.246553] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.957s) [311.385697] [068/156] (707s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [311.465265] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc [311.470264] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [311.568172] [069/156] (707s left) kms_invalid_mode (bad-vsync-start) [311.653166] Starting subtest: bad-vsync-start [311.655793] Starting dynamic subtest: pipe-A-eDP-1 [311.949944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [311.967155] Starting dynamic subtest: pipe-B-eDP-1 [311.970122] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [311.981997] Starting dynamic subtest: pipe-C-eDP-1 [311.984150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [311.994406] Starting dynamic subtest: pipe-D-eDP-1 [311.997216] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [312.000097] Subtest bad-vsync-start: SUCCESS (0.303s) [312.816039] [070/156] (706s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [312.897995] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [313.945191] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.047s) [314.067043] [071/156] (705s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [314.144369] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [314.149015] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [314.245137] [072/156] (704s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [314.320266] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [314.322829] Starting dynamic subtest: pipe-A-eDP-1 [314.393969] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [314.404864] Starting dynamic subtest: pipe-B-eDP-1 [315.501646] Dynamic subtest pipe-B-eDP-1: SKIP (1.103s) [315.506865] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.184s) [316.694429] [073/156] (702s left) gem_exec_balancer (parallel-bb-first) [316.948802] Starting subtest: parallel-bb-first [317.862567] Subtest parallel-bb-first: SUCCESS (0.914s) [318.459456] [074/156] (700s left) gem_mmap_gtt (fault-concurrent-y) [318.514147] Subtest fault-concurrent-Y: SKIP (0.000s) [318.583224] [075/156] (700s left) kms_chamelium_hpd (vga-hpd-after-suspend) [318.945173] Subtest vga-hpd-after-suspend: SKIP (0.000s) [319.794277] [076/156] (699s left) gem_softpin (allocator-evict) [319.866414] Starting subtest: allocator-evict [319.868742] Starting dynamic subtest: rcs0 [343.130587] Dynamic subtest rcs0: SUCCESS (23.265s) [343.143511] Starting dynamic subtest: bcs0 [367.424274] Dynamic subtest bcs0: SUCCESS (24.291s) [367.435366] Starting dynamic subtest: vcs0 [391.266413] Dynamic subtest vcs0: SUCCESS (23.840s) [391.278433] Starting dynamic subtest: vcs1 [414.882371] Dynamic subtest vcs1: SUCCESS (23.613s) [414.897440] Starting dynamic subtest: vecs0 [438.541306] Dynamic subtest vecs0: SUCCESS (23.657s) [438.553402] Starting dynamic subtest: ccs0 [462.360175] Dynamic subtest ccs0: SUCCESS (23.816s) [462.362727] Subtest allocator-evict: SUCCESS (142.491s) [462.446018] [077/156] (557s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff) [462.589026] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff [462.593828] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [462.679640] [078/156] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [462.762097] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [462.766694] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [462.846154] [079/156] (556s left) kms_big_fb (4-tiled-32bpp-rotate-270) [462.937498] Starting subtest: 4-tiled-32bpp-rotate-270 [462.957077] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s) [463.060513] [080/156] (556s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff) [463.147239] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff [463.152231] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [463.256491] [081/156] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [463.331651] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [469.887259] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.559s) [470.003783] [082/156] (549s left) drm_read (short-buffer-wakeup) [470.149695] Starting subtest: short-buffer-wakeup [502.369418] Subtest short-buffer-wakeup: SUCCESS (32.215s) [502.491777] [083/156] (517s left) kms_pm_dc (dc5-dpms-negative) [503.587081] Starting subtest: dc5-dpms-negative [503.592272] Subtest dc5-dpms-negative: SKIP (0.000s) [503.676040] [084/156] (516s left) kms_fbcon_fbt (psr) [503.741038] Starting subtest: psr [511.167604] Subtest psr: SUCCESS (7.422s) [511.246966] [085/156] (508s left) gem_render_copy (yf-tiled-ccs-to-linear) [511.304134] Starting subtest: yf-tiled-ccs-to-linear [511.309681] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [511.494997] [086/156] (508s left) kms_getfb (getfb-handle-protection) [511.566722] Starting subtest: getfb-handle-protection [511.584223] Subtest getfb-handle-protection: SUCCESS (0.019s) [511.693776] [087/156] (508s left) gem_bad_reloc (negative-reloc-lut) [511.757190] Subtest negative-reloc-lut: SKIP (0.000s) [511.825999] [088/156] (508s left) syncobj_basic (test-valid-cycle) [511.884389] Starting subtest: test-valid-cycle [511.887236] Subtest test-valid-cycle: SUCCESS (0.000s) [511.990773] [089/156] (508s left) kms_prop_blob (invalid-get-prop-any) [512.046402] Starting subtest: invalid-get-prop-any [512.049258] Subtest invalid-get-prop-any: SUCCESS (0.000s) [512.143900] [090/156] (507s left) kms_flip (busy-flip) [512.227621] Starting subtest: busy-flip [512.230222] Starting dynamic subtest: A-eDP1 [513.897379] Dynamic subtest A-eDP1: SUCCESS (1.672s) [513.909657] Starting dynamic subtest: B-eDP1 [515.625431] Dynamic subtest B-eDP1: SUCCESS (1.726s) [515.638558] Starting dynamic subtest: C-eDP1 [517.338388] Dynamic subtest C-eDP1: SUCCESS (1.712s) [517.352270] Starting dynamic subtest: D-eDP1 [518.985999] Dynamic subtest D-eDP1: SUCCESS (1.645s) [518.988702] Subtest busy-flip: SUCCESS (6.765s) [520.149519] [091/156] (499s left) gem_exec_schedule (u-submit-golden-slice) [520.230676] Starting subtest: u-submit-golden-slice [520.233127] Starting dynamic subtest: rcs0 [520.262044] Dynamic subtest rcs0: SUCCESS (0.035s) [520.274387] Starting dynamic subtest: bcs0 [520.293777] Dynamic subtest bcs0: SUCCESS (0.032s) [520.304332] Starting dynamic subtest: vcs0 [520.327786] Dynamic subtest vcs0: SUCCESS (0.033s) [520.338654] Starting dynamic subtest: vcs1 [520.362672] Dynamic subtest vcs1: SUCCESS (0.034s) [520.375168] Starting dynamic subtest: vecs0 [520.397027] Dynamic subtest vecs0: SUCCESS (0.033s) [520.408423] Starting dynamic subtest: ccs0 [520.434287] Dynamic subtest ccs0: SUCCESS (0.037s) [520.437158] Subtest u-submit-golden-slice: SUCCESS (0.208s) [521.513085] [092/156] (498s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [521.637300] Starting subtest: dp-mst-lic-type-0-hdcp14 [521.642274] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [521.777628] [093/156] (498s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [521.859209] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc [521.864433] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [521.947180] [094/156] (498s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [522.029814] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [522.034974] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [522.122768] [095/156] (498s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [522.199120] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [522.204196] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [522.271979] [096/156] (498s left) kms_frontbuffer_tracking (fbc-stridechange) [522.348333] Starting subtest: fbc-stridechange [525.575394] Subtest fbc-stridechange: SUCCESS (3.234s) [526.766238] [097/156] (493s left) kms_chamelium_color (ctm-0-25) [526.838401] Subtest ctm-0-25: SKIP (0.000s) [526.889058] [098/156] (493s left) i915_query (query-topology-known-pci-ids) [526.937992] Starting subtest: query-topology-known-pci-ids [526.943119] Subtest query-topology-known-pci-ids: SKIP (0.000s) [527.046635] [099/156] (493s left) kms_pipe_stress (stress-xrgb8888-yftiled) [527.117052] Starting subtest: stress-xrgb8888-yftiled [527.122409] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [527.194780] [100/156] (493s left) kms_big_fb (y-tiled-64bpp-rotate-90) [527.276196] Starting subtest: y-tiled-64bpp-rotate-90 [527.281453] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [527.381179] [101/156] (493s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [527.458249] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [527.460869] Starting dynamic subtest: pipe-A-eDP-1 [527.486906] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [527.500195] Starting dynamic subtest: pipe-B-eDP-1 [527.525633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [527.535960] Starting dynamic subtest: pipe-C-eDP-1 [527.562175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [527.572996] Starting dynamic subtest: pipe-D-eDP-1 [527.598978] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [527.603452] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s) [529.710821] [102/156] (490s left) gem_exec_flush (basic-wb-set-default) [529.771382] Starting subtest: basic-wb-set-default [535.232302] Subtest basic-wb-set-default: SUCCESS (5.453s) [535.416516] [103/156] (485s left) kms_psr (fbc-psr-sprite-render) [535.493956] Starting subtest: fbc-psr-sprite-render [535.496525] Starting dynamic subtest: eDP-1 [535.501605] Dynamic subtest eDP-1: SKIP (0.000s) [535.506281] Subtest fbc-psr-sprite-render: SKIP (0.001s) [535.574320] [104/156] (485s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [535.650896] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [535.655606] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [536.757269] [105/156] (483s left) gem_flink_basic (double-flink) [536.806325] Starting subtest: double-flink [536.809304] Subtest double-flink: SUCCESS (0.000s) [536.901220] [106/156] (483s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff) [536.980411] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff [536.985014] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [537.072032] [107/156] (483s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt) [537.151585] Starting subtest: psrhdr-farfromfence-mmap-gtt [537.157008] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [537.250929] [108/156] (483s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [537.330732] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc [537.336159] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [537.434108] [109/156] (483s left) gem_exec_reloc (basic-concurrent16) [537.486238] Subtest basic-concurrent16: SKIP (0.000s) [537.549863] [110/156] (483s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [537.630551] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt [537.635335] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [537.723705] [111/156] (483s left) kms_flip (plain-flip-fb-recreate) [537.794722] Starting subtest: plain-flip-fb-recreate [537.796501] Starting dynamic subtest: A-eDP1 [546.652384] Dynamic subtest A-eDP1: SUCCESS (8.858s) [546.663428] Starting dynamic subtest: B-eDP1 [555.485795] Dynamic subtest B-eDP1: SUCCESS (8.832s) [555.496202] Starting dynamic subtest: C-eDP1 [564.303409] Dynamic subtest C-eDP1: SUCCESS (8.816s) [564.313831] Starting dynamic subtest: D-eDP1 [573.136913] Dynamic subtest D-eDP1: SUCCESS (8.832s) [573.141599] Subtest plain-flip-fb-recreate: SUCCESS (35.347s) [574.329712] [112/156] (446s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [574.413227] Starting subtest: extended-pageflip-modeset-hang-oldfb [574.416076] Starting dynamic subtest: pipe-A [582.299379] Dynamic subtest pipe-A: SUCCESS (7.886s) [582.313079] Starting dynamic subtest: pipe-D [590.930179] Dynamic subtest pipe-D: SUCCESS (8.627s) [590.932860] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.518s) [591.778734] [113/156] (429s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [591.857403] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [591.862380] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [591.959626] [114/156] (429s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [592.031081] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [592.035962] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s) [592.104765] [115/156] (429s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu) [592.188831] Starting subtest: hdr-rgb101010-draw-mmap-cpu [592.193580] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [592.280859] [116/156] (428s left) kms_psr (fbc-pr-sprite-plane-move) [592.355430] Starting subtest: fbc-pr-sprite-plane-move [592.360232] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [592.440809] [117/156] (428s left) kms_psr (psr2-suspend) [592.514292] Starting subtest: psr2-suspend [592.517222] Starting dynamic subtest: eDP-1 [610.238796] Dynamic subtest eDP-1: SUCCESS (3.704s) [610.241172] Subtest psr2-suspend: SUCCESS (3.704s) [611.109033] [118/156] (410s left) i915_module_load (resize-bar) [611.155939] Starting subtest: resize-bar [611.162336] Subtest resize-bar: SKIP (0.006s) [611.209195] [119/156] (410s left) syncobj_timeline (etime-single-wait-all-submitted) [611.259506] Starting subtest: etime-single-wait-all-submitted [611.364404] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s) [611.459840] [120/156] (409s left) kms_draw_crc (draw-method-mmap-wc) [611.536460] Starting subtest: draw-method-mmap-wc [611.539571] Starting dynamic subtest: xrgb8888-untiled [611.802878] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [611.814433] Starting dynamic subtest: rgb565-untiled [612.024926] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [612.036010] Starting dynamic subtest: xrgb2101010-untiled [612.247502] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [612.258423] Starting dynamic subtest: xbgr16161616f-untiled [612.470037] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [612.480890] Starting dynamic subtest: xrgb8888-xtiled [612.592176] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [612.602341] Starting dynamic subtest: rgb565-xtiled [612.725672] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [612.736161] Starting dynamic subtest: xrgb2101010-xtiled [612.848384] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [612.860923] Starting dynamic subtest: xbgr16161616f-xtiled [612.970458] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s) [612.981290] Starting dynamic subtest: xrgb8888-4tiled [613.126693] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [613.136780] Starting dynamic subtest: rgb565-4tiled [613.282354] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s) [613.293164] Starting dynamic subtest: xrgb2101010-4tiled [613.426903] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s) [613.437700] Starting dynamic subtest: xbgr16161616f-4tiled [613.604867] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [613.606768] Subtest draw-method-mmap-wc: SUCCESS (2.067s) [613.702017] [121/156] (407s left) syncobj_timeline (invalid-transfer-non-existent-point) [613.753219] Starting subtest: invalid-transfer-non-existent-point [613.755082] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [613.853752] [122/156] (407s left) gem_exec_flush (basic-wb-ro-default) [613.910005] Starting subtest: basic-wb-ro-default [619.375562] Subtest basic-wb-ro-default: SUCCESS (5.459s) [619.571565] [123/156] (401s left) gem_exec_fence (concurrent) [619.736336] Starting subtest: concurrent [619.740974] Subtest concurrent: SKIP (0.000s) [621.518344] [124/156] (400s left) kms_color_pipeline (plane-lut1d-ctm3x4) [621.588477] Starting subtest: plane-lut1d-ctm3x4 [621.735114] Starting dynamic subtest: pipe-A-plane-0 [621.902075] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [621.913844] Starting dynamic subtest: pipe-A-plane-1 [622.068166] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [622.080176] Starting dynamic subtest: pipe-A-plane-2 [622.258163] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [623.458373] Starting dynamic subtest: pipe-B-plane-0 [623.605341] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s) [623.616942] Starting dynamic subtest: pipe-B-plane-1 [623.761279] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [623.772772] Starting dynamic subtest: pipe-B-plane-2 [623.916658] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [625.170145] Starting dynamic subtest: pipe-C-plane-0 [625.294732] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [625.306176] Starting dynamic subtest: pipe-C-plane-1 [625.450160] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [625.461309] Starting dynamic subtest: pipe-C-plane-2 [625.584318] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [626.787230] Starting dynamic subtest: pipe-D-plane-0 [626.921314] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [626.933687] Starting dynamic subtest: pipe-D-plane-1 [627.078496] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [627.093932] Starting dynamic subtest: pipe-D-plane-2 [627.221677] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s) [627.511668] Subtest plane-lut1d-ctm3x4: SUCCESS (5.920s) [628.349929] [125/156] (393s left) gem_exec_params (sol-reset-invalid) [628.415032] Starting subtest: sol-reset-invalid [628.417358] Subtest sol-reset-invalid: SUCCESS (0.002s) [630.474436] [126/156] (391s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [630.548638] Starting subtest: bad-rotation-90-yf-tiled-ccs [630.550954] Starting dynamic subtest: pipe-A-eDP-1 [630.573533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [630.587198] Starting dynamic subtest: pipe-B-eDP-1 [630.609193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [630.622703] Starting dynamic subtest: pipe-C-eDP-1 [630.644441] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [630.654638] Starting dynamic subtest: pipe-D-eDP-1 [630.677405] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [630.681789] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s) [632.805093] [127/156] (388s left) syncobj_basic (bad-destroy) [632.854839] Starting subtest: bad-destroy [632.857009] Subtest bad-destroy: SUCCESS (0.000s) [632.947821] [128/156] (388s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt) [633.030763] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt [633.035140] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [633.119788] [129/156] (388s left) kms_cursor_edge_walk (128x128-top-edge) [633.190319] Starting subtest: 128x128-top-edge [633.192658] Starting dynamic subtest: pipe-A-eDP-1 [636.664791] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s) [636.676371] Starting dynamic subtest: pipe-D-eDP-1 [639.792532] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [639.794768] Subtest 128x128-top-edge: SUCCESS (6.599s) [640.623241] [130/156] (381s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc) [640.710642] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc [640.715036] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [640.806110] [131/156] (381s left) gen7_exec_parse (basic-allocation) [640.864461] Subtest basic-allocation: SKIP (0.000s) [640.928838] [132/156] (380s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [641.004386] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [641.006651] Starting dynamic subtest: pipe-A-eDP-1 [643.226768] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.222s) [643.238018] Starting dynamic subtest: pipe-B-eDP-1 [645.722353] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.493s) [645.735365] Starting dynamic subtest: pipe-C-eDP-1 [647.874048] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.151s) [647.884931] Starting dynamic subtest: pipe-D-eDP-1 [650.020621] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.144s) [650.022678] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.015s) [651.215836] [133/156] (370s left) gem_exec_alignment (single) [651.285918] Starting subtest: single [651.291949] Subtest single: SUCCESS (0.003s) [651.418180] [134/156] (370s left) kms_async_flips (invalid-async-flip-atomic) [651.501073] Starting subtest: invalid-async-flip-atomic [651.879319] Starting dynamic subtest: pipe-A-eDP-1 [652.745487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.866s) [653.106775] Starting dynamic subtest: pipe-B-eDP-1 [653.963921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.868s) [654.326492] Starting dynamic subtest: pipe-C-eDP-1 [655.098951] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.786s) [655.465229] Starting dynamic subtest: pipe-D-eDP-1 [656.248351] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.793s) [656.250838] Subtest invalid-async-flip-atomic: SUCCESS (4.748s) [657.501851] [135/156] (364s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [657.587250] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [657.591748] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [657.682261] [136/156] (364s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [657.780613] Starting subtest: nonblocking-modeset-vs-cursor-atomic [659.171102] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.388s) [660.060418] [137/156] (362s left) gem_exec_fence (syncobj-timeline-invalid-wait) [660.594627] Starting subtest: syncobj-timeline-invalid-wait [660.597466] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [662.506212] [138/156] (359s left) gem_ctx_persistence (engines-persistence) [662.568338] Starting subtest: engines-persistence [662.570873] Starting dynamic subtest: rcs0 [663.384439] Dynamic subtest rcs0: SUCCESS (0.815s) [663.399218] Starting dynamic subtest: bcs0 [664.130535] Dynamic subtest bcs0: SUCCESS (0.744s) [664.144421] Starting dynamic subtest: vcs0 [664.918486] Dynamic subtest vcs0: SUCCESS (0.785s) [664.932437] Starting dynamic subtest: vcs1 [665.687370] Dynamic subtest vcs1: SUCCESS (0.766s) [665.702011] Starting dynamic subtest: vecs0 [666.452688] Dynamic subtest vecs0: SUCCESS (0.762s) [666.466232] Starting dynamic subtest: ccs0 [667.199650] Dynamic subtest ccs0: SUCCESS (0.745s) [667.202221] Subtest engines-persistence: SUCCESS (4.631s) [667.332804] [139/156] (354s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [667.422448] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [671.173932] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.757s) [672.365089] [140/156] (349s left) kms_frontbuffer_tracking (fbchdr-tiling-y) [672.441869] Starting subtest: fbchdr-tiling-y [672.446258] Subtest fbchdr-tiling-y: SKIP (0.000s) [672.536014] [141/156] (349s left) gem_exec_whisper (basic-queues-priority-all) [672.605566] Starting subtest: basic-queues-priority-all [692.801237] Subtest basic-queues-priority-all: SUCCESS (20.185s) [692.984829] [142/156] (329s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [693.057358] Starting subtest: plane-downscale-factor-0-5-with-modifiers [693.059574] Starting dynamic subtest: pipe-A [693.078674] Dynamic subtest pipe-A: SKIP (0.017s) [693.090627] Starting dynamic subtest: pipe-B [693.110025] Dynamic subtest pipe-B: SKIP (0.030s) [693.121115] Starting dynamic subtest: pipe-C [693.140650] Dynamic subtest pipe-C: SKIP (0.030s) [693.151668] Starting dynamic subtest: pipe-D [693.173668] Dynamic subtest pipe-D: SKIP (0.031s) [693.177654] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s) [693.290831] [143/156] (329s left) gem_mmap_gtt (coherency) [693.355892] Subtest coherency: SKIP (0.000s) [693.436125] [144/156] (328s left) kms_chamelium_edid (dp-edid-read) [693.808929] Subtest dp-edid-read: SKIP (0.000s) [694.674917] [145/156] (327s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite) [694.755854] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite [694.760324] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [694.869089] [146/156] (327s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [694.953032] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [699.526327] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.580s) [700.702390] [147/156] (321s left) gem_exec_reloc (basic-cpu) [700.759605] Subtest basic-cpu: SKIP (0.000s) [700.836735] [148/156] (321s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [700.926907] Starting subtest: psr-rgb565-draw-render [708.030882] Subtest psr-rgb565-draw-render: SUCCESS (7.108s) [708.155049] [149/156] (314s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [708.269282] Starting subtest: flip-vs-cursor-atomic-transitions [716.076948] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.811s) [716.949680] [150/156] (305s left) sysfs_timeslice_duration (invalid) [717.012176] Starting subtest: invalid [717.014573] Starting dynamic subtest: vecs0 [717.016948] Dynamic subtest vecs0: SUCCESS (0.000s) [717.029663] Starting dynamic subtest: ccs0 [717.031542] Dynamic subtest ccs0: SUCCESS (0.000s) [717.041886] Starting dynamic subtest: vcs0 [717.043806] Dynamic subtest vcs0: SUCCESS (0.000s) [717.054070] Starting dynamic subtest: bcs0 [717.056022] Dynamic subtest bcs0: SUCCESS (0.000s) [717.066340] Starting dynamic subtest: rcs0 [717.068223] Dynamic subtest rcs0: SUCCESS (0.000s) [717.078648] Starting dynamic subtest: vcs1 [717.080846] Dynamic subtest vcs1: SUCCESS (0.000s) [717.083091] Subtest invalid: SUCCESS (0.005s) [717.130755] [151/156] (305s left) gem_mmap_offset (pf-nonblock) [717.185823] Starting subtest: pf-nonblock [717.193653] Subtest pf-nonblock: SUCCESS (0.007s) [717.280002] [152/156] (305s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [717.360016] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [724.879983] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.527s) [725.075457] [153/156] (297s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [725.152725] Starting subtest: compare-crc-sanitycheck-nv12 [725.155073] Starting dynamic subtest: pipe-A-eDP-1 [725.843968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s) [725.855842] Starting dynamic subtest: pipe-B-eDP-1 [727.158307] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.309s) [727.170728] Starting dynamic subtest: pipe-C-eDP-1 [728.435829] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.279s) [728.447544] Starting dynamic subtest: pipe-D-eDP-1 [729.651900] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s) [729.654220] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.500s) [730.489200] [154/156] (292s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [730.588822] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [731.580273] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.992s) [731.702849] [155/156] (291s left) api_intel_bb (reset-flags) [731.760564] Starting subtest: reset-flags [731.768215] Subtest reset-flags: SUCCESS (0.009s) [731.884206] [156/156] (291s left) i915_query (query-regions-unallocated) [731.942498] Starting subtest: query-regions-unallocated [731.944477] Subtest query-regions-unallocated: SUCCESS (0.000s) [732.039502] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: syncobj_timeline results: parsing output: 4/ for test: kms_vblank results: parsing output: 5/ for test: gem_readwrite results: parsing output: 6/ for test: gem_fenced_exec_thrash results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_universal_plane results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: prime_vgem results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: gem_softpin results: parsing output: 14/ for test: gem_ctx_engines results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: perf results: parsing output: 19/ for test: gem_mmap_wc results: parsing output: 20/ for test: gem_set_tiling_vs_gtt results: parsing output: 21/ for test: perf results: parsing output: 22/ for test: i915_pm_rpm results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: prime_mmap_coherency results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_rotation_crc results: parsing output: 32/ for test: syncobj_timeline results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: kms_addfb_basic results: parsing output: 35/ for test: syncobj_wait results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: i915_drm_fdinfo results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: api_intel_bb results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: kms_flip_scaled_crc results: parsing output: 42/ for test: kms_dp_link_training results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_partial_pwrite_pread results: parsing output: 46/ for test: gen9_exec_parse results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: gem_ctx_bad_destroy results: parsing output: 49/ for test: gem_ctx_persistence results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: kms_cursor_crc results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_eio results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: kms_pm_backlight results: parsing output: 57/ for test: kms_plane_multiple results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_async_flips results: parsing output: 60/ for test: gem_exec_store results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_unref_active_buffers results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_invalid_mode results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_psr2_sf results: parsing output: 72/ for test: gem_exec_balancer results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: kms_chamelium_hpd results: parsing output: 75/ for test: gem_softpin results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: drm_read results: parsing output: 82/ for test: kms_pm_dc results: parsing output: 83/ for test: kms_fbcon_fbt results: parsing output: 84/ for test: gem_render_copy results: parsing output: 85/ for test: kms_getfb results: parsing output: 86/ for test: gem_bad_reloc results: parsing output: 87/ for test: syncobj_basic results: parsing output: 88/ for test: kms_prop_blob results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: gem_exec_schedule results: parsing output: 91/ for test: kms_content_protection results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_plane results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_chamelium_color results: parsing output: 97/ for test: i915_query results: parsing output: 98/ for test: kms_pipe_stress results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: gem_exec_flush results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: gem_flink_basic results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_busy results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_flip_scaled_crc results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: i915_module_load results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: kms_draw_crc results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: gem_exec_flush results: parsing output: 122/ for test: gem_exec_fence results: parsing output: 123/ for test: kms_color_pipeline results: parsing output: 124/ for test: gem_exec_params results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: syncobj_basic results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_edge_walk results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gen7_exec_parse results: parsing output: 131/ for test: kms_ccs results: parsing output: 132/ for test: gem_exec_alignment results: parsing output: 133/ for test: kms_async_flips results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_cursor_legacy results: parsing output: 136/ for test: gem_exec_fence results: parsing output: 137/ for test: gem_ctx_persistence results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: gem_exec_whisper results: parsing output: 141/ for test: kms_plane_scaling results: parsing output: 142/ for test: gem_mmap_gtt results: parsing output: 143/ for test: kms_chamelium_edid results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: gem_exec_reloc results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_cursor_legacy results: parsing output: 149/ for test: sysfs_timeslice_duration results: parsing output: 150/ for test: gem_mmap_offset results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_pipe_crc_basic results: parsing output: 153/ for test: kms_big_fb results: parsing output: 154/ for test: api_intel_bb results: parsing output: 155/ for test: i915_query Done.