[59.389020] Initializing watchdogs [59.389083] /dev/watchdog0 [59.402967] [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] [59.407417] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.409737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.412912] [001/155] (960s left) perf (i915-ref-count) [59.506463] Starting subtest: i915-ref-count [59.569709] Subtest i915-ref-count: SUCCESS (0.061s) [59.637128] [002/155] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [59.745771] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [59.750291] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [59.861432] [003/155] (960s left) gem_exec_fence (syncobj-timeline-chain-engines) [60.408006] Starting subtest: syncobj-timeline-chain-engines [60.504151] Subtest syncobj-timeline-chain-engines: SUCCESS (0.099s) [61.402042] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [61.405124] [004/155] (958s left) gem_exec_schedule (preemptive-hang) [61.587581] Starting subtest: preemptive-hang [61.590129] Starting dynamic subtest: rcs0 [70.441383] Dynamic subtest rcs0: SUCCESS (8.821s) [70.451418] Starting dynamic subtest: bcs0 [79.397208] Dynamic subtest bcs0: SUCCESS (8.945s) [79.408762] Starting dynamic subtest: vcs0 [88.422433] Dynamic subtest vcs0: SUCCESS (9.023s) [88.429932] Starting dynamic subtest: vcs1 [97.381640] Dynamic subtest vcs1: SUCCESS (8.955s) [97.388989] Starting dynamic subtest: vecs0 [106.402776] Dynamic subtest vecs0: SUCCESS (9.017s) [106.412884] Starting dynamic subtest: ccs0 [115.430818] Dynamic subtest ccs0: SUCCESS (9.029s) [115.433458] Subtest preemptive-hang: SUCCESS (53.794s) [115.666986] [005/155] (904s left) kms_flip (2x-busy-flip) [115.758471] Starting subtest: 2x-busy-flip [115.768745] Subtest 2x-busy-flip: SKIP (0.010s) [115.845123] [006/155] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [115.934760] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [122.941061] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.010s) [123.065938] [007/155] (897s left) core_setmaster (master-drop-set-shared-fd) [123.147080] Starting subtest: master-drop-set-shared-fd [123.157859] Subtest master-drop-set-shared-fd: SUCCESS (0.011s) [123.191952] [008/155] (896s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [123.291605] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [123.295730] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [123.389780] [009/155] (896s left) prime_mmap (test_userptr) [123.443776] Starting subtest: test_userptr [123.446165] Starting dynamic subtest: test_userptr-smem [123.448468] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [123.450454] Subtest test_userptr: SUCCESS (0.001s) [123.542265] [010/155] (896s left) kms_rmfb (rmfb-ioctl) [123.631018] Starting subtest: rmfb-ioctl [123.633317] Starting dynamic subtest: pipe-A-eDP-1 [123.737026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [123.746618] Starting dynamic subtest: pipe-B-eDP-1 [124.917302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s) [124.926797] Starting dynamic subtest: pipe-C-eDP-1 [126.131758] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s) [126.141483] Starting dynamic subtest: pipe-D-eDP-1 [127.272755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [127.275150] Subtest rmfb-ioctl: SUCCESS (3.642s) [128.416428] [011/155] (891s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [128.518557] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [128.521073] Starting dynamic subtest: pipe-A-default-mode [129.675165] Dynamic subtest pipe-A-default-mode: SKIP (1.152s) [129.679488] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.154s) [129.816397] [012/155] (890s left) gem_mmap_gtt (fault-concurrent-x) [129.880483] Subtest fault-concurrent-X: SKIP (0.000s) [129.937016] [013/155] (890s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [130.066117] Starting subtest: cursorA-vs-flipA-atomic [141.241665] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.175s) [142.071164] [014/155] (878s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [142.164917] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [142.167209] Starting dynamic subtest: pipe-A-default-mode [144.897220] Dynamic subtest pipe-A-default-mode: SUCCESS (2.731s) [144.899716] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.732s) [145.758151] [015/155] (874s left) gem_workarounds (basic-read) [145.833620] Starting subtest: basic-read [145.843744] Subtest basic-read: SUCCESS (0.010s) [145.963231] [016/155] (874s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff) [146.059152] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff [146.063563] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [146.190831] [017/155] (874s left) gem_set_tiling_vs_pwrite [146.321459] [018/155] (874s left) kms_atomic_transition (plane-all-modeset-transition) [146.424178] Starting subtest: plane-all-modeset-transition [146.428637] Subtest plane-all-modeset-transition: SKIP (0.000s) [146.493465] [019/155] (874s left) gem_tiled_fence_blits (basic) [146.550753] Subtest basic: SKIP (0.000s) [146.608735] [020/155] (874s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-blt) [146.703556] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-blt [146.707134] Subtest fbchdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [146.797173] [021/155] (873s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move) [146.904922] Starting subtest: hdr-2p-primscrn-cur-indfb-move [146.908767] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [147.007429] [022/155] (873s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt) [147.099585] Starting subtest: hdr-rgb101010-draw-mmap-gtt [147.102889] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [147.181651] [023/155] (873s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [147.275118] Starting subtest: psr-rgb101010-draw-render [154.509264] Subtest psr-rgb101010-draw-render: SUCCESS (7.238s) [154.618558] [024/155] (866s left) kms_psr (psr2-cursor-blt) [154.711965] Starting subtest: psr2-cursor-blt [154.714478] Starting dynamic subtest: eDP-1 [156.392768] Dynamic subtest eDP-1: SUCCESS (1.681s) [156.394788] Subtest psr2-cursor-blt: SUCCESS (1.681s) [157.197118] [025/155] (863s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [157.252167] Starting subtest: etime-multi-wait-available-unsubmitted [157.354456] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s) [157.458984] [026/155] (863s left) kms_psr (psr-sprite-plane-onoff) [157.556528] Starting subtest: psr-sprite-plane-onoff [157.558790] Starting dynamic subtest: eDP-1 [159.337558] Dynamic subtest eDP-1: SUCCESS (1.781s) [159.339933] Subtest psr-sprite-plane-onoff: SUCCESS (1.782s) [160.173384] [027/155] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [160.275844] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc [160.279906] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [160.385059] [028/155] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu) [160.487552] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu [160.491611] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [160.578401] [029/155] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt) [160.677559] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt [160.681956] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [160.770326] [030/155] (860s left) syncobj_wait (wait-for-submit-delayed-submit) [160.822523] Starting subtest: wait-for-submit-delayed-submit [160.924212] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [161.004704] [031/155] (860s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [161.061187] Starting subtest: invalid-multi-wait-unsubmitted-signaled [161.063551] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [161.147832] [032/155] (860s left) kms_lease (page-flip-implicit-plane) [161.242105] Starting subtest: page-flip-implicit-plane [161.244324] Starting dynamic subtest: pipe-A-eDP-1 [161.726375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s) [161.735884] Starting dynamic subtest: pipe-B-eDP-1 [162.927578] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s) [162.937278] Starting dynamic subtest: pipe-C-eDP-1 [164.034683] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s) [164.045747] Starting dynamic subtest: pipe-D-eDP-1 [165.153686] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s) [165.155591] Subtest page-flip-implicit-plane: SUCCESS (3.909s) [165.984881] [033/155] (855s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt) [166.089499] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt [166.093762] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [166.169218] [034/155] (855s left) kms_draw_crc (fill-fb) [166.262699] Starting subtest: fill-fb [166.704125] Subtest fill-fb: SUCCESS (0.442s) [166.807212] [035/155] (854s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [166.896990] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [166.899336] Starting dynamic subtest: pipe-A-eDP-1 [166.922587] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [166.932572] Starting dynamic subtest: pipe-B-eDP-1 [166.951226] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [166.958222] Starting dynamic subtest: pipe-C-eDP-1 [166.976907] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [166.984204] Starting dynamic subtest: pipe-D-eDP-1 [167.003968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [167.007419] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s) [169.060319] [036/155] (852s left) gem_pwrite (basic-self) [169.127216] Subtest basic-self: SKIP (0.000s) [169.179945] [037/155] (852s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [169.282153] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [169.287639] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [169.381064] [038/155] (852s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-render) [169.487459] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-render [169.491686] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [169.585185] [039/155] (851s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [169.680068] Starting subtest: switch-modeset-ultra-joiner-big-joiner [169.684378] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [169.746596] [040/155] (851s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [169.844625] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [169.848665] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [169.923144] [041/155] (851s left) perf_pmu (busy-hang) [169.970548] Starting subtest: busy-hang [169.972728] Starting dynamic subtest: rcs0 [171.227766] Dynamic subtest rcs0: SUCCESS (1.254s) [171.238806] Starting dynamic subtest: bcs0 [172.443699] Dynamic subtest bcs0: SUCCESS (1.215s) [172.455764] Starting dynamic subtest: vcs0 [174.784830] Dynamic subtest vcs0: SUCCESS (2.340s) [174.797655] Starting dynamic subtest: vcs1 [176.833226] Dynamic subtest vcs1: SUCCESS (2.047s) [176.844171] Starting dynamic subtest: vecs0 [178.816577] Dynamic subtest vecs0: SUCCESS (1.983s) [178.827174] Starting dynamic subtest: ccs0 [180.033655] Dynamic subtest ccs0: SUCCESS (1.216s) [180.035804] Subtest busy-hang: SUCCESS (10.061s) [180.120634] [042/155] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [180.228065] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [180.232719] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [180.312346] [043/155] (841s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [180.417903] Starting subtest: crc-primary-basic-y-tiled-ccs [180.420247] Starting dynamic subtest: pipe-A-eDP-1 [180.448060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [180.459621] Starting dynamic subtest: pipe-B-eDP-1 [180.480635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [180.488683] Starting dynamic subtest: pipe-C-eDP-1 [180.510172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [180.518107] Starting dynamic subtest: pipe-D-eDP-1 [180.541175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [180.545598] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s) [182.648338] [044/155] (838s left) kms_vblank (query-forked-busy) [182.744089] Starting subtest: query-forked-busy [182.745991] Starting dynamic subtest: pipe-A-eDP-1 [184.631680] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s) [184.646146] Starting dynamic subtest: pipe-D-eDP-1 [187.224926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s) [187.227114] Subtest query-forked-busy: SUCCESS (4.481s) [188.015534] [045/155] (833s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [188.118697] Starting subtest: plane-downscale-factor-0-75-with-rotation [188.120856] Starting dynamic subtest: pipe-A [188.369553] Dynamic subtest pipe-A: SUCCESS (0.253s) [188.377839] Starting dynamic subtest: pipe-B [189.718534] Dynamic subtest pipe-B: SUCCESS (1.348s) [189.728600] Starting dynamic subtest: pipe-C [191.042237] Dynamic subtest pipe-C: SUCCESS (1.322s) [191.052582] Starting dynamic subtest: pipe-D [192.379656] Dynamic subtest pipe-D: SUCCESS (1.336s) [192.381966] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.263s) [193.537461] [046/155] (828s left) kms_cursor_crc (cursor-rapid-movement-32x32) [193.689035] Starting subtest: cursor-rapid-movement-32x32 [193.734309] Subtest cursor-rapid-movement-32x32: SKIP (0.041s) [194.031859] [047/155] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [194.128309] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [194.132484] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [194.227151] [048/155] (827s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [194.316786] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [194.320678] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [194.396607] [049/155] (827s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [194.493701] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [194.497524] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [194.598301] [050/155] (827s left) kms_content_protection (type1) [194.739742] Starting subtest: type1 [194.743477] Subtest type1: SKIP (0.000s) [194.849805] [051/155] (827s left) syncobj_wait (multi-wait-submitted) [194.894132] Starting subtest: multi-wait-submitted [195.002782] Subtest multi-wait-submitted: SUCCESS (0.107s) [195.094477] [052/155] (826s left) kms_cursor_edge_walk (256x256-left-edge) [195.189589] Starting subtest: 256x256-left-edge [195.191765] Starting dynamic subtest: pipe-A-eDP-1 [198.611311] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s) [198.620969] Starting dynamic subtest: pipe-D-eDP-1 [201.736228] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s) [201.738596] Subtest 256x256-left-edge: SUCCESS (6.548s) [202.530326] [053/155] (819s left) kms_atomic (plane-overlay-legacy) [202.615856] Starting subtest: plane-overlay-legacy [202.618155] Starting dynamic subtest: pipe-A-eDP-1 [203.025882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s) [203.027859] Subtest plane-overlay-legacy: SUCCESS (0.410s) [203.874373] [054/155] (818s left) sysfs_heartbeat_interval (idempotent) [203.941758] Starting subtest: idempotent [203.944129] Starting dynamic subtest: vecs0 [203.946473] Dynamic subtest vecs0: SUCCESS (0.001s) [203.955433] Starting dynamic subtest: ccs0 [203.957696] Dynamic subtest ccs0: SUCCESS (0.001s) [203.966059] Starting dynamic subtest: vcs0 [203.968291] Dynamic subtest vcs0: SUCCESS (0.000s) [203.976476] Starting dynamic subtest: bcs0 [203.978775] Dynamic subtest bcs0: SUCCESS (0.001s) [203.987070] Starting dynamic subtest: rcs0 [203.989269] Dynamic subtest rcs0: SUCCESS (0.000s) [203.997645] Starting dynamic subtest: vcs1 [203.999554] Dynamic subtest vcs1: SUCCESS (0.000s) [204.001843] Subtest idempotent: SUCCESS (0.008s) [204.046520] [055/155] (818s left) gem_mmap_gtt (big-copy-xy) [204.119752] Subtest big-copy-XY: SKIP (0.000s) [204.176722] [056/155] (817s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [204.269312] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [204.281225] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [204.368322] [057/155] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [204.470507] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [204.474776] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [204.588188] [058/155] (817s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt) [204.688197] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt [204.692321] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [204.786106] [059/155] (817s left) kms_frontbuffer_tracking (fbc-tiling-4) [204.887608] Starting subtest: fbc-tiling-4 [209.079428] Subtest fbc-tiling-4: SUCCESS (4.196s) [210.277817] [060/155] (812s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [210.344974] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [210.410260] [061/155] (811s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [210.508868] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [210.511163] Starting dynamic subtest: pipe-A-eDP-1 [210.571335] Dynamic subtest pipe-A-eDP-1: SKIP (0.065s) [210.584940] Starting dynamic subtest: pipe-B-eDP-1 [211.733960] Dynamic subtest pipe-B-eDP-1: SKIP (1.162s) [211.738537] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.230s) [212.912754] [062/155] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [213.022763] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [213.027233] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [213.109356] [063/155] (809s left) gem_exec_whisper (basic-fds-priority-all) [213.171054] Starting subtest: basic-fds-priority-all [236.210035] Subtest basic-fds-priority-all: SUCCESS (23.035s) [236.385364] [064/155] (786s left) api_intel_bb (object-reloc-purge-cache) [236.443208] Starting subtest: object-reloc-purge-cache [236.448660] Subtest object-reloc-purge-cache: SKIP (0.006s) [236.568815] [065/155] (785s left) gem_exec_balancer (hog) [236.623051] Starting subtest: hog [236.627577] Subtest hog: SKIP (0.000s) [236.942371] [066/155] (785s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [237.040935] Starting subtest: plane-upscale-factor-0-25-with-modifiers [237.043454] Starting dynamic subtest: pipe-A [237.377483] Dynamic subtest pipe-A: SUCCESS (0.338s) [237.387396] Starting dynamic subtest: pipe-B [238.810352] Dynamic subtest pipe-B: SUCCESS (1.432s) [238.820133] Starting dynamic subtest: pipe-C [240.228411] Dynamic subtest pipe-C: SUCCESS (1.417s) [240.238371] Starting dynamic subtest: pipe-D [241.660458] Dynamic subtest pipe-D: SUCCESS (1.431s) [241.662781] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.622s) [242.819658] [067/155] (779s left) kms_prop_blob (blob-prop-lifetime) [242.880234] Starting subtest: blob-prop-lifetime [242.882510] Subtest blob-prop-lifetime: SUCCESS (0.001s) [242.991673] [068/155] (779s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [243.098519] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [243.102914] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [243.203786] [069/155] (779s left) gem_ctx_isolation (nonpriv-switch) [243.276939] Starting subtest: nonpriv-switch [243.279243] Starting dynamic subtest: rcs0 [243.573854] Dynamic subtest rcs0: SUCCESS (0.300s) [243.585737] Starting dynamic subtest: bcs0 [243.934216] Dynamic subtest bcs0: SUCCESS (0.360s) [243.944748] Starting dynamic subtest: vcs0 [244.246122] Dynamic subtest vcs0: SUCCESS (0.311s) [244.257659] Starting dynamic subtest: vcs1 [245.579685] Dynamic subtest vcs1: SUCCESS (1.332s) [245.588578] Starting dynamic subtest: vecs0 [247.668204] Dynamic subtest vecs0: SUCCESS (2.087s) [247.677153] Starting dynamic subtest: ccs0 [249.647784] Dynamic subtest ccs0: SUCCESS (1.978s) [249.650313] Subtest nonpriv-switch: SUCCESS (6.374s) [249.884164] [070/155] (772s left) kms_flip (absolute-wf_vblank-interruptible) [249.977906] Starting subtest: absolute-wf_vblank-interruptible [249.980204] Starting dynamic subtest: A-eDP1 [258.682476] Dynamic subtest A-eDP1: SUCCESS (8.703s) [258.692396] Starting dynamic subtest: B-eDP1 [267.410926] Dynamic subtest B-eDP1: SUCCESS (8.727s) [267.420449] Starting dynamic subtest: C-eDP1 [276.138871] Dynamic subtest C-eDP1: SUCCESS (8.726s) [276.149630] Starting dynamic subtest: D-eDP1 [284.864205] Dynamic subtest D-eDP1: SUCCESS (8.724s) [284.869398] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.891s) [286.077904] [071/155] (736s left) gem_ctx_persistence (idempotent) [286.142462] Starting subtest: idempotent [286.144936] Subtest idempotent: SUCCESS (0.000s) [286.280224] [072/155] (736s left) kms_vblank (wait-busy) [286.369605] Starting subtest: wait-busy [286.371782] Starting dynamic subtest: pipe-A-eDP-1 [288.264076] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s) [288.280020] Starting dynamic subtest: pipe-D-eDP-1 [290.840530] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s) [290.842585] Subtest wait-busy: SUCCESS (4.470s) [291.657617] [073/155] (731s left) kms_big_fb (x-tiled-8bpp-rotate-270) [291.766840] Starting subtest: x-tiled-8bpp-rotate-270 [291.789459] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s) [291.924825] [074/155] (730s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [292.021541] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [292.023949] Starting dynamic subtest: pipe-A-eDP-1 [292.033151] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [292.044681] Starting dynamic subtest: pipe-B-eDP-1 [292.052871] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [292.061637] Starting dynamic subtest: pipe-C-eDP-1 [292.070159] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.078637] Starting dynamic subtest: pipe-D-eDP-1 [292.086803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.090735] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s) [294.203223] [075/155] (728s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [294.311314] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [294.315249] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [294.415463] [076/155] (728s left) gem_softpin (evict-active) [294.475446] Starting subtest: evict-active [294.481802] Subtest evict-active: SUCCESS (0.006s) [294.630276] [077/155] (728s left) gem_ctx_param (invalid-ctx-set) [294.688575] Starting subtest: invalid-ctx-set [294.690971] Subtest invalid-ctx-set: SUCCESS (0.001s) [294.779883] [078/155] (728s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [294.880974] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [294.885137] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [294.979578] [079/155] (728s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [295.082402] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [295.086671] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [295.179846] [080/155] (727s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [295.239684] Starting subtest: y-tiled-to-vebox-x-tiled [295.243042] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [295.421492] [081/155] (727s left) gem_ccs (large-ctrl-surf-copy) [295.481386] Starting subtest: large-ctrl-surf-copy [295.485427] Subtest large-ctrl-surf-copy: SKIP (0.000s) [295.600643] [082/155] (727s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [295.711981] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [295.713884] Starting dynamic subtest: pipe-A-eDP-1 [296.426764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [296.436548] Starting dynamic subtest: pipe-B-eDP-1 [298.225644] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.797s) [298.234500] Starting dynamic subtest: pipe-C-eDP-1 [299.972701] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.744s) [299.983414] Starting dynamic subtest: pipe-D-eDP-1 [301.813910] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.840s) [301.815922] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.095s) [302.945766] [083/155] (720s left) gem_watchdog (default-virtual) [303.008891] Starting subtest: default-virtual [309.285023] Subtest default-virtual: SUCCESS (6.284s) [309.379853] [084/155] (713s left) kms_big_fb (4-tiled-64bpp-rotate-180) [309.489938] Starting subtest: 4-tiled-64bpp-rotate-180 [310.990841] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.500s) [311.178500] [085/155] (712s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [311.273074] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [311.275396] Starting dynamic subtest: A-eDP1 [314.876616] Dynamic subtest A-eDP1: SUCCESS (3.601s) [314.887135] Starting dynamic subtest: B-eDP1 [318.085108] Dynamic subtest B-eDP1: SUCCESS (3.208s) [318.095627] Starting dynamic subtest: C-eDP1 [321.191507] Dynamic subtest C-eDP1: SUCCESS (3.106s) [321.202123] Starting dynamic subtest: D-eDP1 [324.306210] Dynamic subtest D-eDP1: SUCCESS (3.112s) [324.311508] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.038s) [325.123636] [086/155] (698s left) kms_atomic_interruptible (legacy-cursor) [325.233518] Starting subtest: legacy-cursor [325.236554] Starting dynamic subtest: pipe-A-eDP-1 [332.601467] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.366s) [332.603765] Subtest legacy-cursor: SUCCESS (7.367s) [333.459880] [087/155] (689s left) gem_spin_batch (spin-all-new) [333.527426] Starting subtest: spin-all-new [333.538546] Subtest spin-all-new: SUCCESS (0.013s) [335.350329] [088/155] (688s left) kms_cursor_legacy (cursor-vs-flip-atomic) [335.467437] Starting subtest: cursor-vs-flip-atomic [365.142868] Subtest cursor-vs-flip-atomic: SUCCESS (29.672s) [365.986924] [089/155] (657s left) syncobj_timeline (multi-wait-all-available-signaled) [366.048162] Starting subtest: multi-wait-all-available-signaled [366.050407] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [366.141178] [090/155] (657s left) gem_workarounds (suspend-resume-context) [366.200206] Starting subtest: suspend-resume-context [382.071441] Subtest suspend-resume-context: SUCCESS (1.275s) [382.213335] [091/155] (641s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [382.325481] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [391.676869] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.225s) [391.794213] [092/155] (631s left) i915_drm_fdinfo (isolation) [391.842560] Starting subtest: isolation [391.844523] Starting dynamic subtest: rcs0 [391.862308] Dynamic subtest rcs0: SKIP (0.021s) [391.874008] Starting dynamic subtest: bcs0 [391.878274] Dynamic subtest bcs0: SKIP (0.000s) [391.888119] Starting dynamic subtest: vcs0 [391.892742] Dynamic subtest vcs0: SKIP (0.000s) [391.902121] Starting dynamic subtest: vcs1 [391.906462] Dynamic subtest vcs1: SKIP (0.000s) [391.916055] Starting dynamic subtest: vecs0 [391.920305] Dynamic subtest vecs0: SKIP (0.000s) [391.929904] Starting dynamic subtest: ccs0 [391.934069] Dynamic subtest ccs0: SKIP (0.000s) [391.938207] Subtest isolation: SKIP (0.026s) [391.975424] [093/155] (631s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [392.083029] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [392.087171] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [392.183309] [094/155] (631s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move) [392.284183] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move [392.288247] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [392.387450] [095/155] (631s left) kms_psr (fbc-psr2-basic) [392.492206] Starting subtest: fbc-psr2-basic [392.494478] Starting dynamic subtest: eDP-1 [392.498640] Dynamic subtest eDP-1: SKIP (0.000s) [392.502965] Subtest fbc-psr2-basic: SKIP (0.001s) [392.566865] [096/155] (631s left) api_intel_allocator (open-vm) [392.630602] Starting subtest: open-vm [392.632903] Subtest open-vm: SUCCESS (0.003s) [392.750155] [097/155] (631s left) kms_setmode (invalid-clone-exclusive-crtc) [392.813704] Starting subtest: invalid-clone-exclusive-crtc [392.819247] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [392.919645] [098/155] (630s left) gem_workarounds (reset-fd) [392.978984] Starting subtest: reset-fd [393.137062] Subtest reset-fd: SUCCESS (0.158s) [393.256130] [099/155] (630s left) kms_properties (connector-properties-atomic) [393.336854] Starting subtest: connector-properties-atomic [393.338472] Starting dynamic subtest: pipe-A-eDP-1 [401.216172] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.848s) [401.227751] Starting dynamic subtest: pipe-None-DP-1 [401.232352] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [401.242023] Starting dynamic subtest: pipe-None-HDMI-A-1 [401.246435] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [401.256446] Starting dynamic subtest: pipe-None-DP-2 [401.261029] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [401.272360] Starting dynamic subtest: pipe-None-HDMI-A-2 [401.277137] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [401.286666] Starting dynamic subtest: pipe-None-DP-3 [401.292025] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [401.304261] Starting dynamic subtest: pipe-None-DP-4 [401.308708] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [401.310981] Subtest connector-properties-atomic: SUCCESS (7.860s) [402.106348] [100/155] (621s left) i915_query (query-topology-known-pci-ids) [402.174315] Starting subtest: query-topology-known-pci-ids [402.178602] Subtest query-topology-known-pci-ids: SKIP (0.000s) [402.287692] [101/155] (621s left) kms_addfb_basic (addfb25-4-tiled) [402.379907] Starting subtest: addfb25-4-tiled [402.382105] Subtest addfb25-4-tiled: SUCCESS (0.000s) [402.477258] [102/155] (621s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [402.578275] Starting subtest: fbc-farfromfence-mmap-gtt [402.583211] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [402.683441] [103/155] (621s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [402.818890] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [403.627078] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.807s) [403.826943] [104/155] (620s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [403.921684] Starting subtest: plane-lut1d-ctm3x4-lut1d [404.046482] Starting dynamic subtest: pipe-A-plane-0 [404.235187] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [404.246240] Starting dynamic subtest: pipe-A-plane-1 [404.380215] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [404.390168] Starting dynamic subtest: pipe-A-plane-2 [404.535590] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [405.690526] Starting dynamic subtest: pipe-B-plane-0 [405.822588] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [405.832542] Starting dynamic subtest: pipe-B-plane-1 [405.968285] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s) [405.978797] Starting dynamic subtest: pipe-B-plane-2 [406.100836] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [407.324078] Starting dynamic subtest: pipe-C-plane-0 [407.448804] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [407.459175] Starting dynamic subtest: pipe-C-plane-1 [407.593159] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [407.605882] Starting dynamic subtest: pipe-C-plane-2 [407.738181] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [408.971813] Starting dynamic subtest: pipe-D-plane-0 [409.096616] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [409.109212] Starting dynamic subtest: pipe-D-plane-1 [409.241061] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [409.251378] Starting dynamic subtest: pipe-D-plane-2 [409.374721] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [409.676481] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.746s) [410.532291] [105/155] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [410.636289] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [417.896676] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.263s) [418.012382] [106/155] (606s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [418.075451] Starting subtest: invalid-multi-wait-unsubmitted [418.077554] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [418.193009] [107/155] (606s left) i915_pm_rps (thresholds-idle) [418.250180] Starting subtest: thresholds-idle [418.254646] Subtest thresholds-idle: SKIP (0.001s) [418.357482] [108/155] (605s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [420.076319] Starting subtest: dpms-mode-unset-non-lpsp [421.226503] Subtest dpms-mode-unset-non-lpsp: SKIP (1.147s) [421.608564] [109/155] (602s left) perf (sysctl-defaults) [421.689013] Starting subtest: sysctl-defaults [421.691459] Subtest sysctl-defaults: SUCCESS (0.000s) [421.756674] [110/155] (602s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [421.850405] Starting subtest: extended-pageflip-modeset-hang-oldfb [421.852365] Starting dynamic subtest: pipe-A [429.755869] Dynamic subtest pipe-A: SUCCESS (7.902s) [429.767988] Starting dynamic subtest: pipe-D [438.397079] Dynamic subtest pipe-D: SUCCESS (8.636s) [438.399206] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.542s) [439.258760] [111/155] (585s left) perf_pmu (most-busy-check-all) [439.302105] Starting subtest: most-busy-check-all [439.304024] Starting dynamic subtest: rcs0 [440.898756] Dynamic subtest rcs0: SUCCESS (1.596s) [440.911180] Starting dynamic subtest: bcs0 [442.883011] Dynamic subtest bcs0: SUCCESS (1.980s) [442.896205] Starting dynamic subtest: vcs0 [444.866873] Dynamic subtest vcs0: SUCCESS (1.980s) [444.880467] Starting dynamic subtest: vcs1 [446.914943] Dynamic subtest vcs1: SUCCESS (2.044s) [446.928426] Starting dynamic subtest: vecs0 [448.898931] Dynamic subtest vecs0: SUCCESS (1.980s) [448.912291] Starting dynamic subtest: ccs0 [450.883172] Dynamic subtest ccs0: SUCCESS (1.980s) [450.886438] Subtest most-busy-check-all: SUCCESS (11.579s) [450.982164] [112/155] (573s left) kms_psr (psr-cursor-render) [451.078357] Starting subtest: psr-cursor-render [451.080650] Starting dynamic subtest: eDP-1 [452.761904] Dynamic subtest eDP-1: SUCCESS (1.683s) [452.764280] Subtest psr-cursor-render: SUCCESS (1.684s) [453.620141] [113/155] (570s left) i915_pm_rc6_residency (rc6-accuracy) [453.677490] Starting subtest: rc6-accuracy [453.679330] Starting dynamic subtest: gt0 [456.849865] Dynamic subtest gt0: SUCCESS (3.168s) [456.860639] Starting dynamic subtest: gt1 [460.023141] Dynamic subtest gt1: SUCCESS (3.167s) [460.025543] Subtest rc6-accuracy: SUCCESS (6.341s) [460.097636] [114/155] (564s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [460.201082] Starting subtest: bad-aux-stride-yf-tiled-ccs [460.203188] Starting dynamic subtest: pipe-A-eDP-1 [460.224946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [460.236601] Starting dynamic subtest: pipe-B-eDP-1 [460.257542] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [460.267346] Starting dynamic subtest: pipe-C-eDP-1 [460.288997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [460.298454] Starting dynamic subtest: pipe-D-eDP-1 [460.320553] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [460.324524] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s) [462.399330] [115/155] (562s left) kms_pipe_stress (stress-xrgb8888-yftiled) [462.495698] Starting subtest: stress-xrgb8888-yftiled [462.500131] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [462.575176] [116/155] (562s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite) [462.685246] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite [462.689379] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [462.781580] [117/155] (561s left) syncobj_timeline (signal) [462.849206] Starting subtest: signal [462.851476] Subtest signal: SUCCESS (0.001s) [462.973628] [118/155] (561s left) gem_exec_big (single) [463.040154] Starting subtest: single [467.933856] Subtest single: SUCCESS (4.889s) [468.285352] [119/155] (556s left) kms_rotation_crc (exhaust-fences) [468.431342] Starting subtest: exhaust-fences [468.435762] Subtest exhaust-fences: SKIP (0.000s) [468.504066] [120/155] (556s left) fbdev (eof) [468.555097] Starting subtest: eof [468.557411] Subtest eof: SUCCESS (0.000s) [468.654443] [121/155] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [468.751196] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [472.266715] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.519s) [473.407776] [122/155] (551s left) i915_hangman (gt-engine-error) [473.471108] Starting subtest: gt-engine-error [473.473559] Starting dynamic subtest: rcs0 [474.850812] Dynamic subtest rcs0: SUCCESS (1.377s) [474.864823] Starting dynamic subtest: bcs0 [476.833301] Dynamic subtest bcs0: SUCCESS (1.978s) [476.847863] Starting dynamic subtest: vcs0 [478.880430] Dynamic subtest vcs0: SUCCESS (2.045s) [478.900982] Starting dynamic subtest: vcs1 [480.865227] Dynamic subtest vcs1: SUCCESS (1.983s) [480.878409] Starting dynamic subtest: vecs0 [482.848734] Dynamic subtest vecs0: SUCCESS (1.981s) [482.862120] Starting dynamic subtest: ccs0 [484.832732] Dynamic subtest ccs0: SUCCESS (1.982s) [484.835335] Subtest gt-engine-error: SUCCESS (11.363s) [484.981517] [123/155] (539s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [485.083507] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu [485.087946] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [485.181640] [124/155] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [485.289966] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [485.294122] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [485.393910] [125/155] (539s left) prime_vgem (sync) [485.459038] Starting subtest: sync [485.461426] Starting dynamic subtest: rcs0 [485.503149] Dynamic subtest rcs0: SUCCESS (0.043s) [485.514687] Starting dynamic subtest: bcs0 [485.576845] Dynamic subtest bcs0: SUCCESS (0.073s) [485.587408] Starting dynamic subtest: vcs0 [485.625110] Dynamic subtest vcs0: SUCCESS (0.047s) [485.636210] Starting dynamic subtest: vcs1 [485.670964] Dynamic subtest vcs1: SUCCESS (0.045s) [485.681723] Starting dynamic subtest: vecs0 [485.716955] Dynamic subtest vecs0: SUCCESS (0.045s) [485.727779] Starting dynamic subtest: ccs0 [485.762872] Dynamic subtest ccs0: SUCCESS (0.045s) [485.765170] Subtest sync: SUCCESS (0.305s) [485.896597] [126/155] (539s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render) [485.991638] Starting subtest: psrhdr-rgb565-draw-render [485.995115] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s) [486.095261] [127/155] (539s left) kms_dp_aux_dev (basic) [486.147267] Starting subtest: basic [486.371196] Subtest basic: SUCCESS (0.222s) [486.445764] [128/155] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [486.550745] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [486.554928] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [486.648913] [129/155] (538s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [486.750991] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [486.755354] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [486.829378] [130/155] (538s left) syncobj_timeline (single-wait-available-submitted) [486.891922] Starting subtest: single-wait-available-submitted [486.894257] Subtest single-wait-available-submitted: SUCCESS (0.000s) [487.013793] [131/155] (538s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu) [487.133966] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu [487.138091] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [487.231062] [132/155] (538s left) gem_mmap_gtt (hang-user) [487.292738] Subtest hang-user: SKIP (0.000s) [487.355278] [133/155] (538s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc) [487.445112] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc [487.448671] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [487.540348] [134/155] (537s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [487.928476] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [488.747448] [135/155] (536s left) i915_query (query-topology-unsupported) [488.814069] Starting subtest: query-topology-unsupported [488.817912] Subtest query-topology-unsupported: SKIP (0.000s) [488.901289] [136/155] (536s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [489.286025] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [490.147384] [137/155] (535s left) kms_cursor_crc (cursor-onscreen-128x128) [490.387074] Starting subtest: cursor-onscreen-128x128 [490.389187] Starting dynamic subtest: pipe-A-eDP-1 [492.522761] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s) [492.551152] Starting dynamic subtest: pipe-D-eDP-1 [495.331469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.788s) [495.333605] Subtest cursor-onscreen-128x128: SUCCESS (4.946s) [496.135933] [138/155] (529s left) gem_exec_params (invalid-fence-in-submit) [496.211600] Starting subtest: invalid-fence-in-submit [496.216826] Subtest invalid-fence-in-submit: SUCCESS (0.004s) [496.332877] [139/155] (529s left) kms_psr (fbc-psr-basic) [496.430074] Starting subtest: fbc-psr-basic [496.432204] Starting dynamic subtest: eDP-1 [496.436099] Dynamic subtest eDP-1: SKIP (0.000s) [496.440180] Subtest fbc-psr-basic: SKIP (0.001s) [496.507609] [140/155] (529s left) gem_exec_schedule (semaphore-resolve) [496.585347] Starting subtest: semaphore-resolve [496.617436] Subtest semaphore-resolve: SUCCESS (0.040s) [496.962370] [141/155] (528s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [497.062342] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [497.066714] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [497.165070] [142/155] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [497.262596] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [497.266797] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [497.392139] [143/155] (528s left) gem_lmem_swapping (heavy-verify-multi-ccs) [497.448053] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [497.493302] [144/155] (528s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [497.588737] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [498.599776] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s) [498.724861] [145/155] (527s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [498.853990] Starting subtest: verify-pxp-key-change-after-suspend-resume [506.029975] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.178s) [506.138447] [146/155] (519s left) kms_psr (fbc-pr-primary-blt) [506.234265] Starting subtest: fbc-pr-primary-blt [506.238666] Subtest fbc-pr-primary-blt: SKIP (0.000s) [506.320695] [147/155] (519s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [506.419116] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [506.423574] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [506.505542] [148/155] (519s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [506.611501] Starting subtest: fbcpsr-modesetfrombusy [512.813588] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.207s) [512.943260] [149/155] (513s left) kms_big_fb (y-tiled-8bpp-rotate-180) [513.039377] Starting subtest: y-tiled-8bpp-rotate-180 [513.043163] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [513.150033] [150/155] (513s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [513.240923] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [513.266453] Starting dynamic subtest: pipe-A-plane-0 [513.877574] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s) [513.890478] Starting dynamic subtest: pipe-A-plane-3 [514.288372] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s) [515.380664] Starting dynamic subtest: pipe-B-plane-0 [516.027141] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s) [516.040350] Starting dynamic subtest: pipe-B-plane-3 [516.460335] Dynamic subtest pipe-B-plane-3: SUCCESS (0.431s) [516.769985] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.528s) [517.663543] [151/155] (508s left) gen9_exec_parse (batch-invalid-length) [517.730996] Subtest batch-invalid-length: SKIP (0.000s) [517.803622] [152/155] (508s left) prime_mmap (test_errors) [517.861776] Starting subtest: test_errors [517.864112] Starting dynamic subtest: test_errors-smem [517.956682] Dynamic subtest test_errors-smem: SUCCESS (0.096s) [517.959227] Subtest test_errors: SUCCESS (0.097s) [518.054011] [153/155] (508s left) kms_dsc (dsc-fractional-bpp-with-bpc) [518.139775] Starting subtest: dsc-fractional-bpp-with-bpc [518.170062] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [518.228051] [154/155] (508s left) gem_mmap_gtt (basic-small-bo-tiledy) [518.297147] Subtest basic-small-bo-tiledY: SKIP (0.000s) [518.360919] [155/155] (508s left) gem_mmap_gtt (basic-small-bo) [518.412880] Subtest basic-small-bo: SKIP (0.000s) [518.471005] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_exec_fence results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: core_setmaster results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: prime_mmap results: parsing output: 9/ for test: kms_rmfb results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: kms_flip_scaled_crc results: parsing output: 14/ for test: gem_workarounds results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_set_tiling_vs_pwrite results: parsing output: 17/ for test: kms_atomic_transition results: parsing output: 18/ for test: gem_tiled_fence_blits results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_draw_crc results: parsing output: 34/ for test: kms_ccs results: parsing output: 35/ for test: gem_pwrite results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_joiner results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: perf_pmu results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_vblank results: parsing output: 44/ for test: kms_plane_scaling results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_plane results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: syncobj_wait results: parsing output: 51/ for test: kms_cursor_edge_walk results: parsing output: 52/ for test: kms_atomic results: parsing output: 53/ for test: sysfs_heartbeat_interval results: parsing output: 54/ for test: gem_mmap_gtt results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_pipe_b_c_ivb results: parsing output: 60/ for test: kms_psr2_sf results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_exec_whisper results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: gem_exec_balancer results: parsing output: 65/ for test: kms_plane_scaling results: parsing output: 66/ for test: kms_prop_blob results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_ctx_isolation results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: gem_ctx_persistence results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_ccs results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_softpin results: parsing output: 76/ for test: gem_ctx_param results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_render_copy results: parsing output: 80/ for test: gem_ccs results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: gem_watchdog results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_flip results: parsing output: 85/ for test: kms_atomic_interruptible results: parsing output: 86/ for test: gem_spin_batch results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: gem_workarounds results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: i915_drm_fdinfo 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_psr results: parsing output: 95/ for test: api_intel_allocator results: parsing output: 96/ for test: kms_setmode results: parsing output: 97/ for test: gem_workarounds results: parsing output: 98/ for test: kms_properties results: parsing output: 99/ for test: i915_query results: parsing output: 100/ for test: kms_addfb_basic results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_color_pipeline results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: i915_pm_rps results: parsing output: 107/ for test: kms_pm_rpm results: parsing output: 108/ for test: perf results: parsing output: 109/ for test: kms_busy results: parsing output: 110/ for test: perf_pmu results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: i915_pm_rc6_residency results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: kms_pipe_stress results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: gem_exec_big results: parsing output: 118/ for test: kms_rotation_crc results: parsing output: 119/ for test: fbdev results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: i915_hangman results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: prime_vgem results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_dp_aux_dev results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_mmap_gtt results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_chamelium_frames results: parsing output: 134/ for test: i915_query results: parsing output: 135/ for test: kms_chamelium_hpd results: parsing output: 136/ for test: kms_cursor_crc results: parsing output: 137/ for test: gem_exec_params results: parsing output: 138/ for test: kms_psr results: parsing output: 139/ for test: gem_exec_schedule results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_lmem_swapping results: parsing output: 143/ for test: kms_big_fb results: parsing output: 144/ for test: gem_pxp results: parsing output: 145/ for test: kms_psr results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_big_fb results: parsing output: 149/ for test: kms_plane results: parsing output: 150/ for test: gen9_exec_parse results: parsing output: 151/ for test: prime_mmap results: parsing output: 152/ for test: kms_dsc results: parsing output: 153/ for test: gem_mmap_gtt results: parsing output: 154/ for test: gem_mmap_gtt Done.