[57.649842] Initializing watchdogs [57.649890] /dev/watchdog0 [57.665780] [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] [57.670857] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.673324] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.676947] [001/155] (960s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [57.768847] Subtest no-spare-fences-interruptible: SKIP (0.000s) [57.837275] [002/155] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [57.943422] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [57.947953] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [58.055496] [003/155] (960s left) kms_dp_link_training (uhbr-sst) [58.151633] Starting subtest: uhbr-sst [58.159848] Subtest uhbr-sst: SKIP (0.000s) [58.224601] [004/155] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [58.321825] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [65.769191] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.413s) [66.975209] [005/155] (951s left) gem_userptr_blits (process-exit-busy) [67.033759] Starting subtest: process-exit-busy [67.048058] Subtest process-exit-busy: SUCCESS (0.014s) [67.170799] [006/155] (951s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [67.256208] Starting subtest: random-ccs-data-yf-tiled-ccs [67.258613] Starting dynamic subtest: pipe-A-eDP-1 [67.283883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [67.294445] Starting dynamic subtest: pipe-B-eDP-1 [67.317128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [67.324751] Starting dynamic subtest: pipe-C-eDP-1 [67.347413] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [67.354890] Starting dynamic subtest: pipe-D-eDP-1 [67.378233] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [67.382151] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s) [69.527929] [007/155] (948s left) syncobj_timeline (invalid-signal-one-illegal-handle) [69.580939] Starting subtest: invalid-signal-one-illegal-handle [69.583311] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [69.673480] [008/155] (948s left) gem_exec_whisper (basic-sync-all) [69.736942] Starting subtest: basic-sync-all [76.559253] Subtest basic-sync-all: SUCCESS (6.814s) [76.753033] [009/155] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [76.862903] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [76.867496] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [76.971144] [010/155] (941s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [77.075702] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [80.940309] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.869s) [82.159610] [011/155] (936s left) kms_getfb (getfb-handle-closed) [82.255468] Starting subtest: getfb-handle-closed [82.257863] Subtest getfb-handle-closed: SUCCESS (0.000s) [82.351762] [012/155] (936s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [82.450950] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [82.455264] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [82.561877] [013/155] (936s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [83.111665] Starting subtest: syncobj-backward-timeline-chain-engines [83.222639] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.114s) [84.413529] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [84.416823] [014/155] (934s left) gem_create (create-ext-set-pat) [84.590613] Starting subtest: create-ext-set-pat [84.593213] Subtest create-ext-set-pat: SUCCESS (0.001s) [84.697887] [015/155] (934s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc) [84.794304] Starting subtest: hdr-rgb101010-draw-mmap-wc [84.798229] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [84.894966] [016/155] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [84.999447] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [85.003835] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [85.099469] [017/155] (933s left) kms_frontbuffer_tracking (fbc-tiling-4) [85.194253] Starting subtest: fbc-tiling-4 [89.536962] Subtest fbc-tiling-4: SUCCESS (4.346s) [90.754193] [018/155] (928s left) kms_cursor_crc (cursor-onscreen-512x170) [91.052965] Starting subtest: cursor-onscreen-512x170 [91.057421] Subtest cursor-onscreen-512x170: SKIP (0.001s) [91.215867] [019/155] (927s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [91.319822] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [92.476479] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.157s) [92.599881] [020/155] (926s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [92.688211] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [92.691612] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s) [92.759804] [021/155] (926s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [92.858017] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [99.612069] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.755s) [99.739658] [022/155] (919s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [99.807921] Starting subtest: yf-tiled-ccs-to-x-tiled [99.812506] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [100.004185] [023/155] (919s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite) [100.113590] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite [100.117950] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [100.213573] [024/155] (918s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [100.302088] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [100.304400] Starting dynamic subtest: pipe-A-default-mode [103.021055] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s) [103.023019] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.718s) [103.857943] [025/155] (915s left) kms_lease (page-flip-implicit-plane) [103.948575] Starting subtest: page-flip-implicit-plane [103.950990] Starting dynamic subtest: pipe-A-eDP-1 [104.431397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s) [104.441415] Starting dynamic subtest: pipe-B-eDP-1 [105.598406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s) [105.608399] Starting dynamic subtest: pipe-C-eDP-1 [106.711440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s) [106.721556] Starting dynamic subtest: pipe-D-eDP-1 [107.834086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s) [107.836037] Subtest page-flip-implicit-plane: SUCCESS (3.885s) [108.675264] [026/155] (910s left) gem_softpin (full) [108.727049] Starting subtest: full [108.734630] Subtest full: SUCCESS (0.008s) [108.857896] [027/155] (910s left) kms_plane_alpha_blend (alpha-7efc) [108.958994] Starting subtest: alpha-7efc [109.247432] Starting dynamic subtest: pipe-A-eDP-1 [109.833712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s) [109.859842] Starting dynamic subtest: pipe-D-eDP-1 [111.181837] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [111.184220] Subtest alpha-7efc: SUCCESS (2.222s) [112.029738] [028/155] (907s left) kms_getfb (getfb2-handle-protection) [112.124459] Starting subtest: getfb2-handle-protection [112.153389] Subtest getfb2-handle-protection: SUCCESS (0.030s) [112.260608] [029/155] (907s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [112.351994] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [112.354316] Starting dynamic subtest: pipe-A-eDP-1 [112.451257] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [112.464832] Starting dynamic subtest: pipe-B-eDP-1 [113.605601] Dynamic subtest pipe-B-eDP-1: SKIP (1.153s) [113.610498] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.255s) [114.798583] [030/155] (904s left) fbdev (unaligned-write) [114.847713] Starting subtest: unaligned-write [115.027624] Subtest unaligned-write: SUCCESS (0.178s) [115.089068] [031/155] (904s left) gem_exec_balancer (fairslice) [115.155778] Starting subtest: fairslice [118.083750] Subtest fairslice: SUCCESS (2.925s) [118.396815] [032/155] (901s left) kms_addfb_basic (too-high) [118.494273] Starting subtest: too-high [118.496652] Subtest too-high: SUCCESS (0.001s) [118.601968] [033/155] (900s left) kms_addfb_basic (basic-y-tiled-legacy) [118.651870] Starting subtest: basic-y-tiled-legacy [118.656202] Subtest basic-y-tiled-legacy: SKIP (0.000s) [118.794472] [034/155] (900s left) kms_prime (basic-crc-hybrid) [118.878847] Subtest basic-crc-hybrid: SKIP (0.000s) [118.996537] [035/155] (900s left) kms_big_fb (4-tiled-16bpp-rotate-180) [119.100619] Starting subtest: 4-tiled-16bpp-rotate-180 [120.357797] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.257s) [120.481488] [036/155] (899s left) api_intel_allocator (reloc-allocator) [120.538446] Starting subtest: reloc-allocator [120.540320] Starting dynamic subtest: basic [120.542379] Dynamic subtest basic: SUCCESS (0.004s) [120.551615] Starting dynamic subtest: parallel-one [120.553565] Dynamic subtest parallel-one: SUCCESS (0.008s) [120.563073] Starting dynamic subtest: print [120.565707] Dynamic subtest print: SUCCESS (0.000s) [120.574064] Starting dynamic subtest: reuse [120.575724] Dynamic subtest reuse: SUCCESS (0.000s) [120.583596] Starting dynamic subtest: fork-reopen-allocator [120.585240] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [120.586819] Subtest reloc-allocator: SUCCESS (0.028s) [120.704012] [037/155] (898s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [120.808415] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu [120.811667] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [120.921098] [038/155] (898s left) i915_pm_rpm (reg-read-ioctl) [122.543576] Starting subtest: reg-read-ioctl [124.846742] Subtest reg-read-ioctl: SUCCESS (2.306s) [125.247716] [039/155] (894s left) gem_exec_suspend (basic-s0) [125.302695] Starting subtest: basic-S0 [125.304856] Starting dynamic subtest: smem [146.557627] Dynamic subtest smem: SUCCESS (8.037s) [146.560931] Subtest basic-S0: SUCCESS (8.039s) [150.805540] [040/155] (873s left) gem_render_linear_blits (basic) [150.883690] Starting subtest: basic [150.916161] Subtest basic: SUCCESS (0.031s) [151.004331] [041/155] (872s left) syncobj_timeline (multi-wait-submitted-signaled) [151.059795] Starting subtest: multi-wait-submitted-signaled [151.062287] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [151.162358] [042/155] (872s left) i915_query (query-topology-kernel-writes) [151.215883] Starting subtest: query-topology-kernel-writes [151.218236] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [151.331996] [043/155] (872s left) gem_pread (self) [151.385650] Subtest self: SKIP (0.000s) [151.472768] [044/155] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [151.588152] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [158.424949] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.764s) [158.563483] [045/155] (865s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt) [158.660768] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt [158.665232] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [158.753917] [046/155] (865s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [158.851650] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [159.971849] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.113s) [160.108731] [047/155] (864s left) kms_invalid_mode (zero-clock) [160.203097] Starting subtest: zero-clock [160.204890] Starting dynamic subtest: pipe-A-eDP-1 [160.487271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [160.498993] Starting dynamic subtest: pipe-B-eDP-1 [160.501040] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [160.510580] Starting dynamic subtest: pipe-C-eDP-1 [160.512895] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [160.522478] Starting dynamic subtest: pipe-D-eDP-1 [160.524813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [160.527178] Subtest zero-clock: SUCCESS (0.288s) [161.355208] [048/155] (862s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move) [161.459152] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move [161.463400] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [161.547085] [049/155] (862s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite) [161.654903] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite [161.659111] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [161.779874] [050/155] (862s left) perf (invalid-oa-format-id) [161.904017] Starting subtest: invalid-oa-format-id [161.916229] Subtest invalid-oa-format-id: SUCCESS (0.010s) [161.964332] [051/155] (862s left) kms_psr (fbc-pr-cursor-plane-move) [162.053515] Starting subtest: fbc-pr-cursor-plane-move [162.057714] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [162.128762] [052/155] (862s left) gem_flink_race (flink_close) [162.162312] Starting subtest: flink_close [167.263510] Subtest flink_close: SUCCESS (5.080s) [167.355886] [053/155] (857s left) kms_pm_rpm (modeset-lpsp-stress) [168.905156] Starting subtest: modeset-lpsp-stress [184.831189] Subtest modeset-lpsp-stress: SUCCESS (15.914s) [184.940607] [054/155] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [185.039489] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [189.796159] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.760s) [189.937742] [055/155] (834s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [190.032548] Starting subtest: psr2-cursor-plane-update-sf [190.034751] Starting dynamic subtest: pipe-A-eDP-1 [190.598682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s) [190.610004] Starting dynamic subtest: pipe-B-eDP-1 [191.888472] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s) [191.890348] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.860s) [192.765019] [056/155] (831s left) template (a) [192.815594] Starting subtest: A [192.817566] Subtest A: SUCCESS (0.000s) [192.911287] [057/155] (831s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt) [193.014815] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt [193.019248] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s) [193.113139] [058/155] (831s left) kms_psr (psr2-cursor-plane-move) [193.199454] Starting subtest: psr2-cursor-plane-move [193.201692] Starting dynamic subtest: eDP-1 [194.924212] Dynamic subtest eDP-1: SUCCESS (1.724s) [194.926764] Subtest psr2-cursor-plane-move: SUCCESS (1.725s) [195.813817] [059/155] (828s left) gem_exec_big (single) [195.878251] Starting subtest: single [200.703642] Subtest single: SUCCESS (4.821s) [200.948409] [060/155] (823s left) kms_plane (planar-pixel-format-settings) [201.086227] Starting subtest: planar-pixel-format-settings [201.158578] Subtest planar-pixel-format-settings: SUCCESS (0.074s) [201.259001] [061/155] (823s left) kms_fbcon_fbt (fbc-suspend) [201.317691] Starting subtest: fbc-suspend [250.908074] Subtest fbc-suspend: SUCCESS (19.710s) [256.333105] [062/155] (772s left) kms_psr (psr-suspend) [256.447862] Starting subtest: psr-suspend [256.450316] Starting dynamic subtest: eDP-1 [274.255841] Dynamic subtest eDP-1: SUCCESS (3.304s) [274.258299] Subtest psr-suspend: SUCCESS (3.305s) [281.137966] [063/155] (753s left) i915_selftest (live) [284.577089] Starting subtest: live [284.580034] Starting dynamic subtest: sanitycheck [289.056565] Dynamic subtest sanitycheck: SUCCESS (4.444s) [289.066637] Starting dynamic subtest: uncore [291.897943] Dynamic subtest uncore: SUCCESS (2.824s) [291.908332] Starting dynamic subtest: workarounds [295.138063] Dynamic subtest workarounds: SUCCESS (3.228s) [295.148803] Starting dynamic subtest: gt_engines [299.808202] Dynamic subtest gt_engines: SUCCESS (4.657s) [299.818091] Starting dynamic subtest: gt_timelines [315.577610] Dynamic subtest gt_timelines: SUCCESS (15.759s) [315.594489] Starting dynamic subtest: gt_contexts [320.047939] Dynamic subtest gt_contexts: SUCCESS (4.469s) [320.062132] Starting dynamic subtest: gt_lrc [326.334388] Dynamic subtest gt_lrc: SUCCESS (6.284s) [326.345427] Starting dynamic subtest: gt_mocs [330.859787] Dynamic subtest gt_mocs: SUCCESS (4.522s) [330.870959] Starting dynamic subtest: gt_pm [337.863481] Dynamic subtest gt_pm: SUCCESS (6.985s) [337.873781] Starting dynamic subtest: gt_heartbeat [342.313776] Dynamic subtest gt_heartbeat: SUCCESS (4.463s) [342.324660] Starting dynamic subtest: gt_tlb [351.757009] Dynamic subtest gt_tlb: SUCCESS (9.439s) [351.768037] Starting dynamic subtest: requests [365.309740] Dynamic subtest requests: SUCCESS (13.546s) [365.318165] Starting dynamic subtest: migrate [371.275035] Dynamic subtest migrate: SUCCESS (5.960s) [371.285935] Starting dynamic subtest: active [375.727288] Dynamic subtest active: SUCCESS (4.453s) [375.743150] Starting dynamic subtest: objects [380.591539] Dynamic subtest objects: SUCCESS (4.864s) [380.601906] Starting dynamic subtest: mman [385.483288] Dynamic subtest mman: SUCCESS (4.890s) [385.500641] Starting dynamic subtest: dmabuf [388.335752] Dynamic subtest dmabuf: SUCCESS (2.851s) [388.346670] Starting dynamic subtest: vma [392.840813] Dynamic subtest vma: SUCCESS (4.504s) [392.851770] Starting dynamic subtest: coherency [398.417895] Dynamic subtest coherency: SUCCESS (5.575s) [398.428601] Starting dynamic subtest: gtt [408.550335] Dynamic subtest gtt: SUCCESS (10.131s) [408.560560] Starting dynamic subtest: gem [416.588925] Dynamic subtest gem: SUCCESS (8.035s) [416.600576] Starting dynamic subtest: evict [422.208379] Dynamic subtest evict: SUCCESS (5.619s) [422.217341] Starting dynamic subtest: hugepages [433.166356] Dynamic subtest hugepages: SUCCESS (10.954s) [433.182668] Starting dynamic subtest: gem_contexts [456.186952] Dynamic subtest gem_contexts: FAIL (22.630s) [456.197812] Starting dynamic subtest: client [460.296345] Dynamic subtest client: SUCCESS (4.490s) [460.314787] Starting dynamic subtest: gem_migrate [464.706004] Dynamic subtest gem_migrate: SUCCESS (4.405s) [464.716472] Starting dynamic subtest: reset [467.554692] Dynamic subtest reset: SUCCESS (2.847s) [467.573657] Starting dynamic subtest: memory_region [472.010351] Dynamic subtest memory_region: SUCCESS (4.453s) [472.021615] Starting dynamic subtest: hangcheck [485.404338] Dynamic subtest hangcheck: SUCCESS (13.388s) [485.415806] Starting dynamic subtest: execlists [489.841969] Dynamic subtest execlists: SUCCESS (4.435s) [489.855742] Starting dynamic subtest: ring_submission [494.319429] Dynamic subtest ring_submission: SUCCESS (4.473s) [494.330619] Starting dynamic subtest: perf [498.761730] Dynamic subtest perf: SUCCESS (4.439s) [498.771712] Starting dynamic subtest: slpc [512.943017] Dynamic subtest slpc: SUCCESS (14.184s) [512.953862] Starting dynamic subtest: guc [516.987054] Dynamic subtest guc: SUCCESS (4.044s) [516.998525] Starting dynamic subtest: guc_multi_lrc [521.421307] Dynamic subtest guc_multi_lrc: SUCCESS (4.434s) [521.432594] Starting dynamic subtest: guc_hang [526.478020] Dynamic subtest guc_hang: SUCCESS (5.055s) [526.488452] Starting dynamic subtest: late_gt_pm [530.925224] Dynamic subtest late_gt_pm: SUCCESS (4.446s) [530.927838] Subtest live: FAIL (246.241s) [530.958305] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [530.959043] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [530.962330] [064/155] (504s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [532.771317] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [533.626588] [FACT kms_chamelium_edid (dp-edid-stress-resolution-non-4k)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [533.627856] [FACT kms_chamelium_edid (dp-edid-stress-resolution-non-4k)] new: kernel.kmod_is_loaded.i915: true [533.632218] [065/155] (501s left) kms_vblank (invalid) [533.741243] Starting subtest: invalid [533.743137] Starting dynamic subtest: pipe-A-eDP-1 [534.153211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s) [534.155687] Subtest invalid: SUCCESS (0.413s) [534.975469] [066/155] (500s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt) [535.071427] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt [535.075670] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [535.165916] [067/155] (499s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [535.219682] Starting subtest: invalid-multi-wait-unsubmitted-submitted [535.221879] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [535.318489] [068/155] (499s left) gem_ctx_persistence (engines-cleanup) [535.376422] Starting subtest: engines-cleanup [535.378902] Starting dynamic subtest: rcs0 [535.465484] Dynamic subtest rcs0: SUCCESS (0.089s) [535.480158] Starting dynamic subtest: bcs0 [535.490694] Dynamic subtest bcs0: SUCCESS (0.023s) [535.500862] Starting dynamic subtest: vcs0 [535.562444] Dynamic subtest vcs0: SUCCESS (0.071s) [535.575561] Starting dynamic subtest: vcs1 [535.606428] Dynamic subtest vcs1: SUCCESS (0.042s) [535.618012] Starting dynamic subtest: vecs0 [535.663053] Dynamic subtest vecs0: SUCCESS (0.054s) [535.675619] Starting dynamic subtest: ccs0 [535.702410] Dynamic subtest ccs0: SUCCESS (0.038s) [535.704830] Subtest engines-cleanup: SUCCESS (0.327s) [535.783848] [069/155] (499s left) sysfs_timeslice_duration (duration) [535.856025] Starting subtest: duration [535.857955] Starting dynamic subtest: vecs0 [549.741321] Dynamic subtest vecs0: SUCCESS (13.886s) [549.754308] Starting dynamic subtest: ccs0 [562.882040] Dynamic subtest ccs0: SUCCESS (13.141s) [562.894489] Starting dynamic subtest: vcs0 [576.685885] Dynamic subtest vcs0: SUCCESS (13.799s) [576.698938] Starting dynamic subtest: bcs0 [589.844345] Dynamic subtest bcs0: SUCCESS (13.144s) [589.855509] Starting dynamic subtest: rcs0 [602.996752] Dynamic subtest rcs0: SUCCESS (13.161s) [603.008970] Starting dynamic subtest: vcs1 [616.686240] Dynamic subtest vcs1: SUCCESS (13.683s) [616.688790] Subtest duration: SUCCESS (80.827s) [616.763738] [070/155] (418s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [616.865984] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [616.868324] Starting dynamic subtest: pipe-A-eDP-1 [617.379445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.484s) [617.399868] Starting dynamic subtest: pipe-B-eDP-1 [618.809992] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s) [618.822637] Starting dynamic subtest: pipe-C-eDP-1 [620.188689] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s) [620.201074] Starting dynamic subtest: pipe-D-eDP-1 [621.537664] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s) [621.539603] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.645s) [622.730872] [071/155] (412s left) kms_cursor_crc (cursor-random-512x170) [623.045461] Starting subtest: cursor-random-512x170 [623.050043] Subtest cursor-random-512x170: SKIP (0.001s) [623.192957] [072/155] (412s left) gem_eio (create) [623.386789] Starting subtest: create [623.657285] Subtest create: SUCCESS (0.269s) [623.812814] [073/155] (411s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw) [623.917632] Starting subtest: hdr-2p-pri-indfb-multidraw [623.920924] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s) [624.015437] [074/155] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [624.111221] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [631.620485] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.511s) [631.736659] [075/155] (403s left) kms_content_protection (dp-mst-lic-type-1) [631.888816] Starting subtest: dp-mst-lic-type-1 [631.893028] Subtest dp-mst-lic-type-1: SKIP (0.000s) [632.017381] [076/155] (403s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [632.120148] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [632.124093] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [632.216378] [077/155] (403s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [632.604912] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [633.399408] [078/155] (402s left) gem_exec_schedule (smoketest) [633.589999] Starting subtest: smoketest [633.593069] Starting dynamic subtest: rcs0 [639.187663] Dynamic subtest rcs0: SUCCESS (5.494s) [639.201611] Starting dynamic subtest: bcs0 [644.703526] Dynamic subtest bcs0: SUCCESS (5.515s) [644.720600] Starting dynamic subtest: vcs0 [650.209578] Dynamic subtest vcs0: SUCCESS (5.502s) [650.225828] Starting dynamic subtest: vcs1 [655.714766] Dynamic subtest vcs1: SUCCESS (5.504s) [655.728698] Starting dynamic subtest: vecs0 [661.212670] Dynamic subtest vecs0: SUCCESS (5.501s) [661.224938] Starting dynamic subtest: ccs0 [666.747870] Dynamic subtest ccs0: SUCCESS (5.528s) [666.750424] Subtest smoketest: SUCCESS (33.050s) [666.890153] [079/155] (368s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [666.992088] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [674.430427] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.442s) [674.599716] [080/155] (361s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [674.662482] Starting subtest: invalid-bsd1-flag-on-vebox [674.664436] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [674.784253] [081/155] (360s left) kms_cursor_edge_walk (64x64-top-edge) [674.874938] Starting subtest: 64x64-top-edge [674.877286] Starting dynamic subtest: pipe-A-eDP-1 [678.312547] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s) [678.324521] Starting dynamic subtest: pipe-D-eDP-1 [681.543490] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.231s) [681.545738] Subtest 64x64-top-edge: SUCCESS (6.669s) [682.354950] [082/155] (353s left) kms_psr (psr2-sprite-render) [682.461053] Starting subtest: psr2-sprite-render [682.463341] Starting dynamic subtest: eDP-1 [684.179341] Dynamic subtest eDP-1: SUCCESS (1.717s) [684.181677] Subtest psr2-sprite-render: SUCCESS (1.718s) [685.055832] [083/155] (350s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [685.147708] Starting subtest: bad-pixel-format-y-tiled-ccs [685.149994] Starting dynamic subtest: pipe-A-eDP-1 [685.172056] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [685.183786] Starting dynamic subtest: pipe-B-eDP-1 [685.205282] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [685.215743] Starting dynamic subtest: pipe-C-eDP-1 [685.236696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [685.246652] Starting dynamic subtest: pipe-D-eDP-1 [685.267536] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [685.271814] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [687.402572] [084/155] (348s left) gem_unfence_active_buffers [687.553222] [085/155] (348s left) vgem_basic (unload) [687.589858] Starting subtest: unload [716.667700] Subtest unload: SUCCESS (29.022s) [716.716623] [086/155] (319s left) gem_mmap_wc (set-cache-level) [716.769288] Subtest set-cache-level: SKIP (0.000s) [716.827035] [087/155] (319s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render) [716.923527] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render [716.927933] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [717.021434] [088/155] (319s left) gem_reg_read (bad-register) [717.089645] Starting subtest: bad-register [717.091522] Subtest bad-register: SUCCESS (0.000s) [717.197288] [089/155] (318s left) kms_feature_discovery (chamelium) [717.285566] Starting subtest: chamelium [717.289703] Subtest chamelium: SKIP (0.000s) [717.363646] [090/155] (318s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt) [717.456547] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt [717.460618] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [717.554738] [091/155] (318s left) gem_mmap_gtt (ptrace) [717.610198] Subtest ptrace: SKIP (0.000s) [717.666734] [092/155] (318s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [717.763673] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [717.767199] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [717.866569] [093/155] (318s left) gen9_exec_parse (bb-start-far) [717.918035] Subtest bb-start-far: SKIP (0.000s) [717.989008] [094/155] (318s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [718.080032] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [718.083418] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [718.171061] [095/155] (318s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [718.293660] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [718.297520] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s) [718.463052] [096/155] (317s left) perf (i915-ref-count) [718.534352] Starting subtest: i915-ref-count [718.601045] Subtest i915-ref-count: SUCCESS (0.065s) [718.670687] [097/155] (317s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc) [718.765029] Starting subtest: fbchdr-rgb565-draw-mmap-wc [718.768429] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s) [718.860151] [098/155] (317s left) syncobj_timeline (device-signal-unordered) [718.906321] Starting subtest: device-signal-unordered [718.908275] Subtest device-signal-unordered: SUCCESS (0.000s) [718.999739] [099/155] (317s left) kms_frontbuffer_tracking (fbc-1p-rte) [719.097107] Starting subtest: fbc-1p-rte [724.569704] Subtest fbc-1p-rte: SUCCESS (5.476s) [725.733057] [100/155] (310s left) dmabuf_sync_file (import-multiple-read-only) [725.786287] Starting subtest: import-multiple-read-only [725.788534] Subtest import-multiple-read-only: SUCCESS (0.004s) [725.860083] [101/155] (310s left) gem_ctx_bad_destroy (invalid-default-ctx) [725.910307] Starting subtest: invalid-default-ctx [725.912805] Subtest invalid-default-ctx: SUCCESS (0.000s) [725.987498] [102/155] (310s left) kms_color (legacy-gamma-reset) [726.080077] Starting subtest: legacy-gamma-reset [726.082323] Starting dynamic subtest: pipe-A-eDP-1 [726.452069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s) [726.463821] Starting dynamic subtest: pipe-B-eDP-1 [726.466617] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [726.479565] Starting dynamic subtest: pipe-C-eDP-1 [726.481704] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [726.493057] Starting dynamic subtest: pipe-D-eDP-1 [726.495393] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [726.497816] Subtest legacy-gamma-reset: SUCCESS (0.409s) [727.268831] [103/155] (309s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [727.380357] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [727.384583] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [727.480356] [104/155] (309s left) api_intel_bb (simple-bb) [727.530508] Starting subtest: simple-bb [727.533869] Subtest simple-bb: SUCCESS (0.006s) [727.659738] [105/155] (309s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt) [727.757698] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt [727.762134] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [727.860647] [106/155] (308s left) gem_softpin (evict-active) [727.928732] Starting subtest: evict-active [727.935626] Subtest evict-active: SUCCESS (0.007s) [728.065891] [107/155] (308s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [728.161428] Starting subtest: extended-pageflip-modeset-hang-oldfb [728.163199] Starting dynamic subtest: pipe-A [736.074110] Dynamic subtest pipe-A: SUCCESS (7.911s) [736.086204] Starting dynamic subtest: pipe-D [745.435730] Dynamic subtest pipe-D: SUCCESS (9.353s) [745.438499] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (17.270s) [745.824326] [108/155] (291s left) perf_pmu (busy-no-semaphores) [745.871233] Starting subtest: busy-no-semaphores [745.873528] Starting dynamic subtest: rcs0 [746.434443] Dynamic subtest rcs0: SUCCESS (0.562s) [746.449635] Starting dynamic subtest: bcs0 [746.985426] Dynamic subtest bcs0: SUCCESS (0.548s) [746.999525] Starting dynamic subtest: vcs0 [747.537616] Dynamic subtest vcs0: SUCCESS (0.549s) [747.551852] Starting dynamic subtest: vcs1 [749.267185] Dynamic subtest vcs1: SUCCESS (1.726s) [749.281042] Starting dynamic subtest: vecs0 [751.315420] Dynamic subtest vecs0: SUCCESS (2.044s) [751.329871] Starting dynamic subtest: ccs0 [753.302423] Dynamic subtest ccs0: SUCCESS (1.984s) [753.304844] Subtest busy-no-semaphores: SUCCESS (7.431s) [753.526989] [109/155] (283s left) kms_atomic_interruptible (legacy-pageflip) [753.656480] Starting subtest: legacy-pageflip [753.658864] Starting dynamic subtest: pipe-A-eDP-1 [761.058630] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.402s) [761.060622] Subtest legacy-pageflip: SUCCESS (7.405s) [761.889876] [110/155] (275s left) syncobj_timeline (single-wait-all-for-submit-signaled) [761.952636] Starting subtest: single-wait-all-for-submit-signaled [761.954920] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [762.083107] [111/155] (274s left) kms_setmode (invalid-clone-exclusive-crtc) [762.141605] Starting subtest: invalid-clone-exclusive-crtc [762.148402] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [762.241435] [112/155] (274s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [762.328454] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [762.330800] Starting dynamic subtest: pipe-A [762.348333] Dynamic subtest pipe-A: SKIP (0.017s) [762.360156] Starting dynamic subtest: pipe-B [762.380555] Dynamic subtest pipe-B: SKIP (0.031s) [762.391998] Starting dynamic subtest: pipe-C [762.412326] Dynamic subtest pipe-C: SKIP (0.031s) [762.423098] Starting dynamic subtest: pipe-D [762.443044] Dynamic subtest pipe-D: SKIP (0.030s) [762.446685] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.112s) [762.540492] [113/155] (274s left) kms_plane_scaling (planes-downscale-factor-0-75) [762.631894] Starting subtest: planes-downscale-factor-0-75 [762.634206] Starting dynamic subtest: pipe-A [762.654138] Dynamic subtest pipe-A: SKIP (0.018s) [762.667303] Starting dynamic subtest: pipe-B [762.687253] Dynamic subtest pipe-B: SKIP (0.031s) [762.698490] Starting dynamic subtest: pipe-C [762.718539] Dynamic subtest pipe-C: SKIP (0.032s) [762.729743] Starting dynamic subtest: pipe-D [762.753432] Dynamic subtest pipe-D: SKIP (0.035s) [762.757074] Subtest planes-downscale-factor-0-75: SKIP (0.119s) [762.851478] [114/155] (274s left) kms_big_fb (4-tiled-16bpp-rotate-90) [762.951344] Starting subtest: 4-tiled-16bpp-rotate-90 [762.971307] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [763.090095] [115/155] (274s left) gem_readwrite (read-bad-handle) [763.137234] Subtest read-bad-handle: SKIP (0.000s) [763.198264] [116/155] (274s left) gem_lmem_swapping (verify-random) [763.240199] Subtest verify-random: SKIP (0.000s) [763.286252] [117/155] (274s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [763.405453] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [774.583459] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.183s) [775.437393] [118/155] (261s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [775.548286] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [775.552563] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [775.656194] [119/155] (261s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite) [775.754842] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite [775.759243] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [775.854502] [120/155] (261s left) syncobj_basic (bad-pad-fd-to-handle) [775.918092] Starting subtest: bad-pad-fd-to-handle [775.920407] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [776.014276] [121/155] (261s left) gem_exec_flush (basic-wb-ro-before-default) [776.075659] Starting subtest: basic-wb-ro-before-default [781.565443] Subtest basic-wb-ro-before-default: SUCCESS (5.456s) [781.725510] [122/155] (255s left) gem_exec_schedule (noreorder-priority) [781.908533] Starting subtest: noreorder-priority [781.912045] Starting dynamic subtest: rcs0 [783.026545] Dynamic subtest rcs0: SUCCESS (1.120s) [783.043547] Starting dynamic subtest: vcs0 [784.758330] Dynamic subtest vcs0: SUCCESS (1.729s) [784.771995] Starting dynamic subtest: vcs1 [786.740824] Dynamic subtest vcs1: SUCCESS (1.980s) [786.754864] Starting dynamic subtest: vecs0 [788.789264] Dynamic subtest vecs0: SUCCESS (2.046s) [788.802676] Starting dynamic subtest: ccs0 [789.945926] Dynamic subtest ccs0: SUCCESS (1.156s) [789.948509] Subtest noreorder-priority: SUCCESS (8.043s) [790.141524] [123/155] (247s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [790.262723] Starting subtest: cursorA-vs-flipA-legacy [801.384747] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.126s) [802.247426] [124/155] (235s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [802.353737] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [803.211383] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s) [803.373565] [125/155] (234s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [803.476327] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [803.480328] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [803.571172] [126/155] (234s left) kms_addfb_basic (clobberred-modifier) [803.625017] Starting subtest: clobberred-modifier [803.629301] Subtest clobberred-modifier: SKIP (0.000s) [803.766549] [127/155] (233s left) gem_exec_params (invalid-fence-in-submit) [803.832509] Starting subtest: invalid-fence-in-submit [803.834724] Subtest invalid-fence-in-submit: SUCCESS (0.003s) [803.962906] [128/155] (233s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt) [804.061583] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt [804.065703] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [804.153246] [129/155] (233s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [804.252815] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [804.256404] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [804.350020] [130/155] (233s left) sriov_basic (bind-unbind-vf) [804.407158] Starting subtest: bind-unbind-vf [804.409338] Starting dynamic subtest: vf-1 [804.469806] Dynamic subtest vf-1: FAIL (0.006s) [804.482841] Starting dynamic subtest: vf-2 [804.543935] Dynamic subtest vf-2: FAIL (0.004s) [804.556257] Starting dynamic subtest: vf-3 [804.616314] Dynamic subtest vf-3: FAIL (0.004s) [804.628187] Starting dynamic subtest: vf-4 [804.687271] Dynamic subtest vf-4: FAIL (0.004s) [804.700536] Starting dynamic subtest: vf-5 [804.764682] Dynamic subtest vf-5: FAIL (0.004s) [804.778479] Starting dynamic subtest: vf-6 [804.839417] Dynamic subtest vf-6: FAIL (0.004s) [804.851457] Starting dynamic subtest: vf-7 [804.912056] Dynamic subtest vf-7: FAIL (0.004s) [804.922904] Starting dynamic subtest: vf-random [804.981244] Dynamic subtest vf-random: FAIL (0.004s) [804.992099] Starting dynamic subtest: vf-last [805.047946] Dynamic subtest vf-last: FAIL (0.454s) [805.049732] Subtest bind-unbind-vf: FAIL (0.493s) [805.088404] [131/155] (232s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [805.191546] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [805.195175] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [805.300074] [132/155] (232s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [805.415824] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [837.466230] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.053s) [838.283317] [133/155] (199s left) i915_hangman (engine-error-state-capture) [838.343120] Starting subtest: engine-error-state-capture [838.345459] Starting dynamic subtest: rcs0 [843.757050] Dynamic subtest rcs0: SUCCESS (5.415s) [843.771709] Starting dynamic subtest: bcs0 [849.773310] Dynamic subtest bcs0: SUCCESS (6.013s) [849.786332] Starting dynamic subtest: vcs0 [854.766177] Dynamic subtest vcs0: SUCCESS (4.989s) [854.779564] Starting dynamic subtest: vcs1 [859.755511] Dynamic subtest vcs1: SUCCESS (4.989s) [859.767166] Starting dynamic subtest: vecs0 [865.709909] Dynamic subtest vecs0: SUCCESS (5.952s) [865.723741] Starting dynamic subtest: ccs0 [871.725475] Dynamic subtest ccs0: SUCCESS (6.012s) [871.728489] Subtest engine-error-state-capture: SUCCESS (33.386s) [871.860640] [134/155] (166s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [871.914320] Starting subtest: y-tiled-to-vebox-x-tiled [871.919008] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [872.105361] [135/155] (165s left) i915_drm_fdinfo (most-busy-check-all) [872.148053] Starting subtest: most-busy-check-all [872.150437] Starting dynamic subtest: rcs0 [872.157703] Dynamic subtest rcs0: SKIP (0.006s) [872.169626] Starting dynamic subtest: bcs0 [872.173891] Dynamic subtest bcs0: SKIP (0.000s) [872.184970] Starting dynamic subtest: vcs0 [872.189449] Dynamic subtest vcs0: SKIP (0.000s) [872.200265] Starting dynamic subtest: vcs1 [872.204587] Dynamic subtest vcs1: SKIP (0.000s) [872.217079] Starting dynamic subtest: vecs0 [872.221475] Dynamic subtest vecs0: SKIP (0.000s) [872.232023] Starting dynamic subtest: ccs0 [872.236136] Dynamic subtest ccs0: SKIP (0.000s) [872.240193] Subtest most-busy-check-all: SKIP (0.012s) [872.280595] [136/155] (165s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [872.421563] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu [872.425758] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [872.518553] [137/155] (165s left) kms_atomic_interruptible (legacy-setmode) [872.621218] Starting subtest: legacy-setmode [872.623343] Starting dynamic subtest: pipe-A-eDP-1 [879.504202] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.882s) [879.506593] Subtest legacy-setmode: SUCCESS (6.883s) [880.317325] [138/155] (157s left) kms_psr (fbc-psr2-cursor-plane-move) [880.406276] Starting subtest: fbc-psr2-cursor-plane-move [880.408643] Starting dynamic subtest: eDP-1 [880.412898] Dynamic subtest eDP-1: SKIP (0.000s) [880.417216] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [880.489920] [139/155] (157s left) gem_wait (write-wait) [880.551176] Starting subtest: write-wait [880.553037] Starting dynamic subtest: all-engines [881.672593] Dynamic subtest all-engines: SUCCESS (1.124s) [881.692729] Starting dynamic subtest: rcs0 [882.730581] Dynamic subtest rcs0: SUCCESS (1.056s) [882.751362] Starting dynamic subtest: bcs0 [883.788818] Dynamic subtest bcs0: SUCCESS (1.055s) [883.807934] Starting dynamic subtest: vcs0 [884.843698] Dynamic subtest vcs0: SUCCESS (1.052s) [884.864749] Starting dynamic subtest: vcs1 [885.897641] Dynamic subtest vcs1: SUCCESS (1.051s) [885.916740] Starting dynamic subtest: vecs0 [886.950860] Dynamic subtest vecs0: SUCCESS (1.051s) [886.971842] Starting dynamic subtest: ccs0 [888.008017] Dynamic subtest ccs0: SUCCESS (1.055s) [888.010536] Subtest write-wait: SUCCESS (7.461s) [888.214249] [140/155] (150s left) kms_vblank (wait-forked-hang) [888.312774] Starting subtest: wait-forked-hang [888.315039] Starting dynamic subtest: pipe-A-eDP-1 [914.508372] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.192s) [914.524832] Starting dynamic subtest: pipe-D-eDP-1 [939.547858] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.037s) [939.550351] Subtest wait-forked-hang: SUCCESS (51.233s) [940.382253] [141/155] ( 97s left) perf_pmu (most-busy-idle-check-all) [940.424145] Starting subtest: most-busy-idle-check-all [940.426324] Starting dynamic subtest: rcs0 [941.775356] Dynamic subtest rcs0: SUCCESS (1.351s) [941.789272] Starting dynamic subtest: bcs0 [943.759338] Dynamic subtest bcs0: SUCCESS (1.981s) [943.773906] Starting dynamic subtest: vcs0 [945.744417] Dynamic subtest vcs0: SUCCESS (1.981s) [945.757216] Starting dynamic subtest: vcs1 [947.791633] Dynamic subtest vcs1: SUCCESS (2.045s) [947.807722] Starting dynamic subtest: vecs0 [949.775252] Dynamic subtest vecs0: SUCCESS (1.979s) [949.790041] Starting dynamic subtest: ccs0 [951.759240] Dynamic subtest ccs0: SUCCESS (1.981s) [951.762078] Subtest most-busy-idle-check-all: SUCCESS (11.336s) [951.883898] [142/155] ( 86s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [951.992026] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc [951.996493] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [952.117509] [143/155] ( 86s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [952.178907] Subtest writes-after-reads-uncached: SKIP (0.000s) [952.238101] [144/155] ( 86s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [952.338225] Starting subtest: psr-shrfb-scaledprimary [958.149751] Subtest psr-shrfb-scaledprimary: SUCCESS (5.817s) [958.277912] [145/155] ( 80s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [958.380200] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite [958.384711] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [958.479830] [146/155] ( 80s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [958.582214] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [958.586096] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [958.655285] [147/155] ( 79s left) gem_ctx_shared (create-shared-gtt) [958.712515] Starting subtest: create-shared-gtt [960.864907] Subtest create-shared-gtt: SUCCESS (2.150s) [961.244252] [148/155] ( 77s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [961.336407] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [961.338759] Starting dynamic subtest: pipe-A-eDP-1 [961.362693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [961.375472] Starting dynamic subtest: pipe-B-eDP-1 [961.397197] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [961.408559] Starting dynamic subtest: pipe-C-eDP-1 [961.429687] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [961.443627] Starting dynamic subtest: pipe-D-eDP-1 [961.465842] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [961.470012] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [963.585807] [149/155] ( 75s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt) [963.678990] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt [963.683257] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [963.778353] [150/155] ( 74s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [963.885075] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [971.266742] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.386s) [971.429146] [151/155] ( 67s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [971.544867] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [971.549245] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [971.651055] [152/155] ( 67s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [971.740261] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [971.742479] Starting dynamic subtest: pipe-A-eDP-1 [971.765284] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [971.780227] Starting dynamic subtest: pipe-B-eDP-1 [971.801970] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [971.815027] Starting dynamic subtest: pipe-C-eDP-1 [971.836154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [971.847775] Starting dynamic subtest: pipe-D-eDP-1 [971.869890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [971.873987] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s) [974.073886] [153/155] ( 64s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [974.173940] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [974.178516] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [974.287902] [154/155] ( 64s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [974.389466] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [974.393467] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [974.488332] [155/155] ( 64s left) kms_psr (fbc-psr-primary-mmap-cpu) [974.588160] Starting subtest: fbc-psr-primary-mmap-cpu [974.590391] Starting dynamic subtest: eDP-1 [974.594504] Dynamic subtest eDP-1: SKIP (0.000s) [974.598560] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [974.660545] Closing watchdogs results: parsing output: 0/ for test: gem_fenced_exec_thrash results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_dp_link_training results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_userptr_blits results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: gem_exec_whisper results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_getfb results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: gem_create results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_flip_scaled_crc results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_render_copy results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: kms_lease results: parsing output: 25/ for test: gem_softpin results: parsing output: 26/ for test: kms_plane_alpha_blend results: parsing output: 27/ for test: kms_getfb results: parsing output: 28/ for test: kms_psr2_sf results: parsing output: 29/ for test: fbdev results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: kms_addfb_basic results: parsing output: 33/ for test: kms_prime results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: api_intel_allocator results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: i915_pm_rpm results: parsing output: 38/ for test: gem_exec_suspend results: parsing output: 39/ for test: gem_render_linear_blits results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: i915_query results: parsing output: 42/ for test: gem_pread results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_invalid_mode results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: perf results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_flink_race results: parsing output: 52/ for test: kms_pm_rpm results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_psr2_sf results: parsing output: 55/ for test: template results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: gem_exec_big results: parsing output: 59/ for test: kms_plane results: parsing output: 60/ for test: kms_fbcon_fbt results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: i915_selftest results: parsing output: 63/ for test: kms_chamelium_edid results: parsing output: 64/ for test: kms_vblank results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: gem_ctx_persistence results: parsing output: 68/ for test: sysfs_timeslice_duration results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_cursor_crc results: parsing output: 71/ for test: gem_eio results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_content_protection results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_chamelium_hpd results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_params results: parsing output: 80/ for test: kms_cursor_edge_walk results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: gem_unfence_active_buffers results: parsing output: 84/ for test: vgem_basic results: parsing output: 85/ for test: gem_mmap_wc results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_reg_read results: parsing output: 88/ for test: kms_feature_discovery results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_mmap_gtt results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gen9_exec_parse results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: perf results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: dmabuf_sync_file results: parsing output: 100/ for test: gem_ctx_bad_destroy results: parsing output: 101/ for test: kms_color results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: api_intel_bb results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_softpin results: parsing output: 106/ for test: kms_busy results: parsing output: 107/ for test: perf_pmu results: parsing output: 108/ for test: kms_atomic_interruptible results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_setmode results: parsing output: 111/ for test: kms_plane_scaling results: parsing output: 112/ for test: kms_plane_scaling results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: gem_readwrite results: parsing output: 115/ for test: gem_lmem_swapping results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: syncobj_basic results: parsing output: 120/ for test: gem_exec_flush results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_addfb_basic results: parsing output: 126/ for test: gem_exec_params results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: sriov_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_cursor_legacy results: parsing output: 132/ for test: i915_hangman results: parsing output: 133/ for test: gem_render_copy results: parsing output: 134/ for test: i915_drm_fdinfo results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_atomic_interruptible results: parsing output: 137/ for test: kms_psr results: parsing output: 138/ for test: gem_wait results: parsing output: 139/ for test: kms_vblank results: parsing output: 140/ for test: perf_pmu results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_partial_pwrite_pread results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_plane results: parsing output: 146/ for test: gem_ctx_shared results: parsing output: 147/ for test: kms_ccs results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_ccs results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_psr Done.