[48.859866] Initializing watchdogs [48.859927] /dev/watchdog0 [48.876427] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [48.882169] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [48.885229] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [48.887093] [001/156] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [48.926144] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [48.926876] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s) [48.989383] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [49.084511] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [49.086013] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [49.177470] [003/156] (960s left) kms_chamelium_color (ctm-negative) [49.266368] Subtest ctm-negative: SKIP (0.000s) [49.305928] [004/156] (960s left) api_intel_bb (object-reloc-keep-cache) [49.339528] Starting subtest: object-reloc-keep-cache [49.344847] Subtest object-reloc-keep-cache: SUCCESS (0.006s) [49.466452] [005/156] (960s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render) [49.562179] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render [49.563537] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [49.655367] [006/156] (959s left) gem_pread (display) [49.690343] Starting subtest: display [50.519068] Subtest display: SUCCESS (0.819s) [50.585385] [007/156] (959s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [50.733165] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [50.828723] [008/156] (958s left) syncobj_eventfd (timeline-wait) [50.868226] Starting subtest: timeline-wait [50.878646] Subtest timeline-wait: SUCCESS (0.011s) [50.937543] [009/156] (958s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc) [51.039431] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc [51.040890] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [51.133578] [010/156] (958s left) prime_self_import (basic-with_fd_dup) [51.166356] Starting subtest: basic-with_fd_dup [51.169529] Subtest basic-with_fd_dup: SUCCESS (0.003s) [51.274541] [011/156] (958s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [51.374723] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [51.965423] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.590s) [52.083513] [012/156] (957s left) kms_content_protection (dp-mst-type-0-hdcp14) [52.175285] Starting subtest: dp-mst-type-0-hdcp14 [52.176757] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [52.266324] [013/156] (957s left) kms_pipe_crc_basic (disable-crc-after-crtc) [52.354638] Starting subtest: disable-crc-after-crtc [52.355338] Starting dynamic subtest: pipe-A-HDMI-A-1 [52.717111] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.361s) [52.727073] Starting dynamic subtest: pipe-B-HDMI-A-1 [53.041737] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.322s) [53.047870] Starting dynamic subtest: pipe-C-HDMI-A-1 [53.378142] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.335s) [53.387261] Starting dynamic subtest: pipe-D-HDMI-A-1 [53.734127] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.354s) [53.735056] Subtest disable-crc-after-crtc: SUCCESS (1.378s) [53.872783] [014/156] (955s left) api_intel_allocator (two-level-inception-interruptible) [53.913855] Starting subtest: two-level-inception-interruptible [59.379422] Subtest two-level-inception-interruptible: SUCCESS (5.426s) [59.465512] [015/156] (950s left) kms_big_fb (y-tiled-addfb-size-overflow) [59.567332] Starting subtest: y-tiled-addfb-size-overflow [59.568035] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s) [59.663152] [016/156] (950s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [59.756533] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [59.757927] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [59.854732] [017/156] (950s left) kms_rotation_crc (cursor-rotation-180) [59.942624] Starting subtest: cursor-rotation-180 [60.299285] Subtest cursor-rotation-180: SUCCESS (0.356s) [60.484528] [018/156] (949s left) kms_big_fb (x-tiled-32bpp-rotate-270) [60.583451] Starting subtest: x-tiled-32bpp-rotate-270 [60.665439] Subtest x-tiled-32bpp-rotate-270: SKIP (0.081s) [60.774091] [019/156] (949s left) i915_pm_rps (min-max-config-loaded) [60.816183] Starting subtest: min-max-config-loaded [61.146315] Subtest min-max-config-loaded: SUCCESS (0.324s) [61.259804] [020/156] (948s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [61.293490] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [61.294210] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [61.366590] [021/156] (948s left) gem_exec_params (sol-reset-not-gen7) [61.402088] Starting subtest: sol-reset-not-gen7 [61.403643] Subtest sol-reset-not-gen7: SUCCESS (0.001s) [61.509914] [022/156] (948s left) gem_exec_reloc (basic-write-wc-active) [61.548204] Starting subtest: basic-write-wc-active [61.666761] Subtest basic-write-wc-active: SUCCESS (0.118s) [61.801655] [023/156] (948s left) kms_psr (fbc-psr2-dpms) [61.891428] Subtest fbc-psr2-dpms: SKIP (0.000s) [61.925746] [024/156] (948s left) gem_exec_fence (syncobj-timeline-repeat) [62.402120] Starting subtest: syncobj-timeline-repeat [62.761528] Subtest syncobj-timeline-repeat: SUCCESS (0.359s) [62.924510] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true [62.926603] [025/156] (947s left) kms_cursor_edge_walk (64x64-left-edge) [63.018655] Starting subtest: 64x64-left-edge [63.019405] Starting dynamic subtest: pipe-A-HDMI-A-1 [64.788749] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.769s) [64.796634] Starting dynamic subtest: pipe-D-HDMI-A-1 [66.482283] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.690s) [66.483101] Subtest 64x64-left-edge: SUCCESS (3.462s) [66.606198] [026/156] (943s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [66.711293] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [66.712737] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [66.831460] [027/156] (943s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt) [66.929173] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt [66.930796] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [67.349016] [028/156] (943s left) gen9_exec_parse (bb-large) [67.448075] Subtest bb-large: SKIP (0.000s) [67.531054] [029/156] (942s left) kms_atomic (atomic-plane-damage) [67.796038] Starting subtest: atomic-plane-damage [67.853968] Starting dynamic subtest: pipe-A-HDMI-A-1 [68.050780] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.199s) [68.051617] Subtest atomic-plane-damage: SUCCESS (0.255s) [68.275776] [030/156] (942s left) sw_sync (sync_busy_fork_unixsocket) [68.312321] Starting subtest: sync_busy_fork_unixsocket [68.320931] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [68.380169] [031/156] (942s left) prime_busy (after-wait) [68.417719] Starting subtest: after-wait [68.422289] Starting dynamic subtest: rcs0 [68.448020] Dynamic subtest rcs0: SUCCESS (0.025s) [68.458151] Starting dynamic subtest: bcs0 [68.466989] Dynamic subtest bcs0: SUCCESS (0.018s) [68.478138] Starting dynamic subtest: vcs0 [68.482464] Dynamic subtest vcs0: SUCCESS (0.015s) [68.490407] Starting dynamic subtest: vcs1 [68.499396] Dynamic subtest vcs1: SUCCESS (0.016s) [68.506989] Starting dynamic subtest: vecs0 [68.515372] Dynamic subtest vecs0: SUCCESS (0.016s) [68.623115] Subtest after-wait: SUCCESS (0.204s) [68.691604] [032/156] (941s left) kms_plane_scaling (planes-upscale-factor-0-25) [68.777427] Starting subtest: planes-upscale-factor-0-25 [68.778136] Starting dynamic subtest: pipe-A [68.837619] Dynamic subtest pipe-A: SUCCESS (0.061s) [68.848384] Starting dynamic subtest: pipe-B [68.998399] Dynamic subtest pipe-B: SUCCESS (0.160s) [69.005011] Starting dynamic subtest: pipe-C [69.140481] Dynamic subtest pipe-C: SUCCESS (0.142s) [69.153928] Starting dynamic subtest: pipe-D [69.274738] Dynamic subtest pipe-D: SUCCESS (0.134s) [69.276175] Subtest planes-upscale-factor-0-25: SUCCESS (0.498s) [69.462367] [033/156] (941s left) gem_pwrite (basic-self) [69.497059] Starting subtest: basic-self [69.536440] Subtest basic-self: SUCCESS (0.040s) [69.648592] [034/156] (941s left) sysfs_heartbeat_interval (idempotent) [69.685636] Starting subtest: idempotent [69.686357] Starting dynamic subtest: vecs0 [69.687912] Dynamic subtest vecs0: SUCCESS (0.001s) [69.694763] Starting dynamic subtest: vcs0 [69.695458] Dynamic subtest vcs0: SUCCESS (0.001s) [69.702400] Starting dynamic subtest: bcs0 [69.703113] Dynamic subtest bcs0: SUCCESS (0.001s) [69.709419] Starting dynamic subtest: rcs0 [69.710120] Dynamic subtest rcs0: SUCCESS (0.001s) [69.716415] Starting dynamic subtest: vcs1 [69.717101] Dynamic subtest vcs1: SUCCESS (0.001s) [69.717800] Subtest idempotent: SUCCESS (0.007s) [69.752807] [035/156] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [69.847356] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [69.848722] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [69.936984] [036/156] (940s left) kms_chamelium_frames (dp-frame-dump) [70.078804] Subtest dp-frame-dump: SKIP (0.000s) [70.181433] [037/156] (940s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [70.285359] Starting subtest: fbcpsr-modesetfrombusy [70.286799] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s) [70.383627] [038/156] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-pwrite) [70.475067] Starting subtest: fbcpsrhdr-rgb565-draw-pwrite [70.476437] Subtest fbcpsrhdr-rgb565-draw-pwrite: SKIP (0.000s) [70.556508] [039/156] (940s left) kms_flip (2x-blocking-absolute-wf_vblank) [70.644306] Starting subtest: 2x-blocking-absolute-wf_vblank [70.654121] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s) [70.739110] [040/156] (940s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [70.780142] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [70.780909] Starting dynamic subtest: smem [70.899528] Dynamic subtest smem: SUCCESS (0.114s) [70.900293] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.114s) [71.085980] [041/156] (939s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [71.120825] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [71.159896] [042/156] (939s left) kms_pipe_crc_basic (suspend-read-crc) [71.249876] Starting subtest: suspend-read-crc [71.250620] Starting dynamic subtest: pipe-A-HDMI-A-1 [87.853403] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.928s) [87.861015] Starting dynamic subtest: pipe-B-HDMI-A-1 [104.774109] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.683s) [104.785377] Starting dynamic subtest: pipe-C-HDMI-A-1 [121.786296] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.698s) [121.794757] Starting dynamic subtest: pipe-D-HDMI-A-1 [138.775510] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.675s) [138.776216] Subtest suspend-read-crc: SUCCESS (6.991s) [146.976764] [043/156] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [147.081129] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [147.082573] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [147.172541] [044/156] (871s left) gem_exec_reloc (basic-cpu-active) [147.210999] Starting subtest: basic-cpu-active [147.341301] Subtest basic-cpu-active: SUCCESS (0.121s) [147.453451] [045/156] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [147.547195] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [147.548593] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [147.645175] [046/156] (871s left) kms_psr (fbc-pr-cursor-blt) [147.734367] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [147.779307] [047/156] (871s left) gem_exec_params (readonly) [147.817196] Starting subtest: readonly [147.819093] Subtest readonly: SUCCESS (0.001s) [147.923305] [048/156] (871s left) kms_vblank (query-idle) [148.013463] Starting subtest: query-idle [148.014212] Starting dynamic subtest: pipe-A-HDMI-A-1 [149.182689] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.163s) [149.191891] Starting dynamic subtest: pipe-D-HDMI-A-1 [150.343708] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.156s) [150.344414] Subtest query-idle: SUCCESS (2.324s) [150.509925] [049/156] (868s left) gem_exec_create (forked) [150.556581] Starting subtest: forked [150.557346] Starting dynamic subtest: smem [170.644854] Dynamic subtest smem: SUCCESS (20.063s) [170.645582] Subtest forked: SUCCESS (20.064s) [170.823289] [050/156] (848s left) kms_big_fb (4-tiled-32bpp-rotate-90) [170.921727] Starting subtest: 4-tiled-32bpp-rotate-90 [170.923061] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s) [171.012742] [051/156] (848s left) kms_vrr (flip-basic-fastset) [171.100532] Starting subtest: flip-basic-fastset [171.102767] Subtest flip-basic-fastset: SKIP (0.000s) [171.188328] [052/156] (848s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc) [171.282718] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc [171.284239] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [171.380247] [053/156] (848s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [171.481081] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [171.482558] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [171.566036] [054/156] (848s left) gem_ctx_shared (q-promotion) [171.609470] Starting subtest: Q-promotion [171.610286] Starting dynamic subtest: rcs0 [171.663510] Dynamic subtest rcs0: SUCCESS (0.053s) [171.674783] Starting dynamic subtest: bcs0 [171.719338] Dynamic subtest bcs0: SUCCESS (0.055s) [171.733274] Starting dynamic subtest: vcs0 [171.776877] Dynamic subtest vcs0: SUCCESS (0.056s) [171.788241] Starting dynamic subtest: vcs1 [171.832191] Dynamic subtest vcs1: SUCCESS (0.054s) [171.840384] Starting dynamic subtest: vecs0 [171.884765] Dynamic subtest vecs0: SUCCESS (0.051s) [171.885986] Subtest Q-promotion: SUCCESS (0.276s) [172.074446] [055/156] (847s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [172.161707] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [172.163660] Starting dynamic subtest: pipe-A-valid-mode [173.211416] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.048s) [173.212199] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.049s) [173.392310] [056/156] (846s left) gem_exec_reloc (basic-write-gtt-noreloc) [173.435832] Starting subtest: basic-write-gtt-noreloc [173.438503] Subtest basic-write-gtt-noreloc: SUCCESS (0.002s) [173.563214] [057/156] (846s left) kms_pm_rpm (pm-tiling) [174.962953] Starting subtest: pm-tiling [178.777488] Subtest pm-tiling: SUCCESS (3.814s) [178.886211] [058/156] (840s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [178.976483] Starting subtest: sprite-rotation-90-pos-100-0 [183.403774] Subtest sprite-rotation-90-pos-100-0: SUCCESS (4.428s) [183.605204] [059/156] (836s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render) [183.706329] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render [183.707687] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [183.783996] [060/156] (836s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render) [183.877381] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render [183.878753] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [183.974346] [061/156] (835s left) i915_pm_freq_api (freq-suspend) [184.011832] Subtest freq-suspend: SKIP (0.000s) [184.061184] [062/156] (835s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [184.154250] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [184.155689] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [184.264581] [063/156] (835s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [184.352881] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [184.399919] [064/156] (835s left) kms_psr (psr-no-drrs) [184.500659] Subtest psr-no-drrs: SKIP (0.000s) [184.543781] [065/156] (835s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [184.632596] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [184.634036] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s) [184.697935] [066/156] (835s left) gem_close_race (basic-process) [184.743223] Starting subtest: basic-process [184.800405] Subtest basic-process: SUCCESS (0.057s) [184.982460] [067/156] (835s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [185.075054] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [185.076458] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [185.162187] [068/156] (834s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [185.255075] Starting subtest: fbc-1p-primscrn-cur-indfb-move [186.752140] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (1.497s) [186.893316] [069/156] (833s left) gem_exec_balancer (individual) [186.936064] Starting subtest: individual [188.522534] Subtest individual: SUCCESS (1.578s) [188.699418] [070/156] (831s left) kms_flip (2x-flip-vs-expired-vblank) [188.789179] Starting subtest: 2x-flip-vs-expired-vblank [188.798215] Subtest 2x-flip-vs-expired-vblank: SKIP (0.009s) [188.865805] [071/156] (831s left) gem_pxp (reject-modify-context-protection-off-1) [188.968738] Starting subtest: reject-modify-context-protection-off-1 [188.969832] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s) [189.050719] [072/156] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [189.144106] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [189.145460] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [189.251563] [073/156] (831s left) gem_exec_schedule (pi-userfault) [189.419141] Starting subtest: pi-userfault [189.419963] Starting dynamic subtest: rcs0 [189.427080] Dynamic subtest rcs0: SUCCESS (0.009s) [189.440854] Starting dynamic subtest: bcs0 [189.441571] Dynamic subtest bcs0: SUCCESS (0.005s) [189.450584] Starting dynamic subtest: vcs0 [189.451288] Dynamic subtest vcs0: SUCCESS (0.004s) [189.459562] Starting dynamic subtest: vcs1 [189.460259] Dynamic subtest vcs1: SUCCESS (0.004s) [189.467811] Starting dynamic subtest: vecs0 [189.468488] Dynamic subtest vecs0: SUCCESS (0.003s) [189.469144] Subtest pi-userfault: SUCCESS (0.032s) [189.632057] [074/156] (830s left) gem_exec_schedule (smoketest) [189.796146] Starting subtest: smoketest [189.797211] Starting dynamic subtest: rcs0 [195.259855] Dynamic subtest rcs0: SUCCESS (5.424s) [195.269310] Starting dynamic subtest: bcs0 [200.686118] Dynamic subtest bcs0: SUCCESS (5.423s) [200.696022] Starting dynamic subtest: vcs0 [206.111168] Dynamic subtest vcs0: SUCCESS (5.422s) [206.121619] Starting dynamic subtest: vcs1 [211.532327] Dynamic subtest vcs1: SUCCESS (5.417s) [211.541538] Starting dynamic subtest: vecs0 [216.955709] Dynamic subtest vecs0: SUCCESS (5.420s) [216.956610] Subtest smoketest: SUCCESS (27.115s) [217.094843] [075/156] (803s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [217.190034] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [217.191410] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [217.294789] [076/156] (803s left) gem_ctx_param (vm) [217.330103] Starting subtest: vm [217.349493] Subtest vm: SUCCESS (0.020s) [217.444802] [077/156] (803s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [217.533580] Starting subtest: plane-primary-toggle-with-vblank-wait [217.534308] Starting dynamic subtest: pipe-A-HDMI-A-1 [217.647139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.112s) [217.731536] Starting dynamic subtest: pipe-B-HDMI-A-1 [217.908671] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.186s) [217.958674] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.425s) [218.128450] [078/156] (802s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [218.223982] Starting subtest: psrhdr-slowdraw [218.225406] Subtest psrhdr-slowdraw: SKIP (0.000s) [218.315940] [079/156] (802s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [218.407874] Starting subtest: fbc-rgb565-draw-pwrite [219.738152] Subtest fbc-rgb565-draw-pwrite: SUCCESS (1.329s) [219.844299] [080/156] (800s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff) [219.942017] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff [219.943401] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [220.042456] [081/156] (800s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [220.132617] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [220.133747] Starting dynamic subtest: pipe-A-HDMI-A-1 [220.140517] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [220.148844] Starting dynamic subtest: pipe-B-HDMI-A-1 [220.155958] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [220.167289] Starting dynamic subtest: pipe-C-HDMI-A-1 [220.174297] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [220.182536] Starting dynamic subtest: pipe-D-HDMI-A-1 [220.189644] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [220.191031] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s) [220.387582] [082/156] (800s left) kms_atomic_interruptible (legacy-dpms) [220.478979] Starting subtest: legacy-dpms [220.479735] Starting dynamic subtest: pipe-A-HDMI-A-1 [226.721986] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.239s) [226.722772] Subtest legacy-dpms: SUCCESS (6.242s) [226.874120] [083/156] (793s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [226.970740] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [226.972203] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [227.030479] [084/156] (793s left) gem_madvise (dontneed-before-exec) [227.063490] Starting subtest: dontneed-before-exec [227.066102] Subtest dontneed-before-exec: SUCCESS (0.003s) [227.173467] [085/156] (793s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt) [227.266904] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt [227.268400] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [227.364699] [086/156] (793s left) kms_rmfb (rmfb-ioctl) [227.453706] Starting subtest: rmfb-ioctl [227.455553] Starting dynamic subtest: pipe-A-HDMI-A-1 [227.550891] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.096s) [227.560373] Starting dynamic subtest: pipe-B-HDMI-A-1 [227.718412] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.166s) [227.727994] Starting dynamic subtest: pipe-C-HDMI-A-1 [227.903945] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.184s) [227.913477] Starting dynamic subtest: pipe-D-HDMI-A-1 [228.080405] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.175s) [228.081091] Subtest rmfb-ioctl: SUCCESS (0.627s) [228.267328] [087/156] (792s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [228.356081] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [228.358348] Starting dynamic subtest: pipe-A-HDMI-A-1 [228.365443] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [228.375845] Starting dynamic subtest: pipe-B-HDMI-A-1 [228.382886] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [228.393147] Starting dynamic subtest: pipe-C-HDMI-A-1 [228.400053] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [228.409994] Starting dynamic subtest: pipe-D-HDMI-A-1 [228.418416] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [228.419857] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [228.622452] [088/156] (792s left) syncobj_timeline (invalid-transfer-illegal-handle) [228.657527] Starting subtest: invalid-transfer-illegal-handle [228.658231] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [228.725722] [089/156] (792s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt) [228.818340] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt [228.819793] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [228.914914] [090/156] (792s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [229.003706] Starting subtest: plane-downscale-factor-0-5-with-modifiers [229.004533] Starting dynamic subtest: pipe-A [229.469485] Dynamic subtest pipe-A: SUCCESS (0.466s) [229.481539] Starting dynamic subtest: pipe-B [229.912512] Dynamic subtest pipe-B: SUCCESS (0.442s) [229.931878] Starting dynamic subtest: pipe-C [230.364765] Dynamic subtest pipe-C: SUCCESS (0.451s) [230.377293] Starting dynamic subtest: pipe-D [230.826771] Dynamic subtest pipe-D: SUCCESS (0.461s) [230.827475] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (1.824s) [231.015614] [091/156] (790s left) gem_lmem_swapping (massive) [231.055861] Subtest massive: SKIP (0.000s) [231.102521] [092/156] (790s left) kms_psr (pr-cursor-mmap-cpu) [231.194433] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [231.235957] [093/156] (789s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move) [231.328033] Starting subtest: hdr-2p-scndscrn-spr-indfb-move [231.329533] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [231.428321] [094/156] (789s left) kms_properties (get_properties-sanity-non-atomic) [231.519615] Starting subtest: get_properties-sanity-non-atomic [231.522318] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s) [231.582090] [095/156] (789s left) gen7_exec_parse (basic-allocation) [231.620679] Subtest basic-allocation: SKIP (0.000s) [231.669290] [096/156] (789s left) i915_drm_fdinfo (all-busy-idle-check-all) [231.705242] Starting subtest: all-busy-idle-check-all [232.324139] Subtest all-busy-idle-check-all: SUCCESS (0.617s) [232.419476] [097/156] (788s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [232.507616] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [232.509438] Starting dynamic subtest: pipe-A-HDMI-A-1 [232.515972] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [232.524468] Starting dynamic subtest: pipe-B-HDMI-A-1 [232.531608] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [232.540022] Starting dynamic subtest: pipe-C-HDMI-A-1 [232.547047] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [232.555141] Starting dynamic subtest: pipe-D-HDMI-A-1 [232.562037] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [232.563383] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.007s) [232.781814] [098/156] (788s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt) [232.877320] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt [232.878730] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [232.973694] [099/156] (788s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [233.064060] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [233.110492] [100/156] (788s left) gem_eio (suspend) [233.155666] Starting subtest: suspend [244.241424] Subtest suspend: SUCCESS (11.082s) [253.408145] [101/156] (777s left) kms_flip (nonexisting-fb-interruptible) [253.508197] Starting subtest: nonexisting-fb-interruptible [253.511113] Starting dynamic subtest: A-HDMI-A1 [253.671835] Dynamic subtest A-HDMI-A1: SUCCESS (0.160s) [253.682032] Starting dynamic subtest: B-HDMI-A1 [253.811048] Dynamic subtest B-HDMI-A1: SUCCESS (0.138s) [253.823835] Starting dynamic subtest: C-HDMI-A1 [253.951847] Dynamic subtest C-HDMI-A1: SUCCESS (0.139s) [253.962193] Starting dynamic subtest: D-HDMI-A1 [254.089659] Dynamic subtest D-HDMI-A1: SUCCESS (0.136s) [254.091974] Subtest nonexisting-fb-interruptible: SUCCESS (0.584s) [254.261902] [102/156] (776s left) kms_flip (modeset-vs-vblank-race) [254.350205] Starting subtest: modeset-vs-vblank-race [254.352752] Starting dynamic subtest: A-HDMI-A1 [257.183664] Dynamic subtest A-HDMI-A1: SUCCESS (2.830s) [257.193873] Starting dynamic subtest: B-HDMI-A1 [260.095573] Dynamic subtest B-HDMI-A1: SUCCESS (2.911s) [260.108918] Starting dynamic subtest: C-HDMI-A1 [262.939169] Dynamic subtest C-HDMI-A1: SUCCESS (2.843s) [262.950814] Starting dynamic subtest: D-HDMI-A1 [265.851822] Dynamic subtest D-HDMI-A1: SUCCESS (2.912s) [265.854132] Subtest modeset-vs-vblank-race: SUCCESS (11.505s) [266.051468] [103/156] (764s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [266.154960] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [266.156449] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [266.268132] [104/156] (764s left) kms_draw_crc (draw-method-mmap-cpu) [266.356987] Starting subtest: draw-method-mmap-cpu [266.357728] Starting dynamic subtest: xrgb8888-untiled [266.502750] Dynamic subtest xrgb8888-untiled: SUCCESS (0.145s) [266.521024] Starting dynamic subtest: rgb565-untiled [266.669521] Dynamic subtest rgb565-untiled: SUCCESS (0.165s) [266.686298] Starting dynamic subtest: xrgb2101010-untiled [266.802757] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.131s) [266.818675] Starting dynamic subtest: xbgr16161616f-untiled [266.953232] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.149s) [266.971069] Starting dynamic subtest: xrgb8888-xtiled [267.044503] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s) [267.061673] Starting dynamic subtest: rgb565-xtiled [267.127792] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s) [267.145256] Starting dynamic subtest: xrgb2101010-xtiled [267.210997] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s) [267.228481] Starting dynamic subtest: xbgr16161616f-xtiled [267.294311] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s) [267.312026] Starting dynamic subtest: xrgb8888-ytiled [267.386254] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.090s) [267.403878] Starting dynamic subtest: rgb565-ytiled [267.477821] Dynamic subtest rgb565-ytiled: SUCCESS (0.089s) [267.495176] Starting dynamic subtest: xrgb2101010-ytiled [267.560956] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s) [267.578600] Starting dynamic subtest: xbgr16161616f-ytiled [267.652680] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.090s) [267.655582] Subtest draw-method-mmap-cpu: SUCCESS (1.297s) [267.758762] [105/156] (762s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [267.793997] Starting subtest: wait-all-for-submit-delayed-submit [267.896128] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [267.976927] [106/156] (762s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [268.067663] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [268.188276] Starting dynamic subtest: pipe-A-HDMI-A-1-y-rc-ccs [270.375013] Dynamic subtest pipe-A-HDMI-A-1-y-rc-ccs: SUCCESS (2.178s) [270.386510] Starting dynamic subtest: pipe-A-HDMI-A-1-y [272.455540] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.079s) [272.466644] Starting dynamic subtest: pipe-A-HDMI-A-1-y [274.464522] Dynamic subtest pipe-A-HDMI-A-1-y: SUCCESS (2.008s) [274.474701] Starting dynamic subtest: pipe-A-HDMI-A-1-x [276.505365] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.040s) [276.631260] Starting dynamic subtest: pipe-B-HDMI-A-1-y-rc-ccs [278.832421] Dynamic subtest pipe-B-HDMI-A-1-y-rc-ccs: SUCCESS (2.202s) [278.845583] Starting dynamic subtest: pipe-B-HDMI-A-1-y [280.905334] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.071s) [280.915280] Starting dynamic subtest: pipe-B-HDMI-A-1-y [282.913638] Dynamic subtest pipe-B-HDMI-A-1-y: SUCCESS (2.007s) [282.922587] Starting dynamic subtest: pipe-B-HDMI-A-1-x [284.947159] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.032s) [285.060383] Starting dynamic subtest: pipe-C-HDMI-A-1-y-rc-ccs [287.234392] Dynamic subtest pipe-C-HDMI-A-1-y-rc-ccs: SUCCESS (2.174s) [287.243672] Starting dynamic subtest: pipe-C-HDMI-A-1-y [289.307391] Dynamic subtest pipe-C-HDMI-A-1-y: SUCCESS (2.072s) [289.317534] Starting dynamic subtest: pipe-C-HDMI-A-1-y [291.315843] Dynamic subtest pipe-C-HDMI-A-1-y: SUCCESS (2.007s) [291.325437] Starting dynamic subtest: pipe-C-HDMI-A-1-x [293.349383] Dynamic subtest pipe-C-HDMI-A-1-x: SUCCESS (2.032s) [293.466623] Starting dynamic subtest: pipe-D-HDMI-A-1-y-rc-ccs [295.630280] Dynamic subtest pipe-D-HDMI-A-1-y-rc-ccs: SUCCESS (2.164s) [295.641176] Starting dynamic subtest: pipe-D-HDMI-A-1-y [297.703294] Dynamic subtest pipe-D-HDMI-A-1-y: SUCCESS (2.071s) [297.714223] Starting dynamic subtest: pipe-D-HDMI-A-1-y [299.712729] Dynamic subtest pipe-D-HDMI-A-1-y: SUCCESS (2.007s) [299.721647] Starting dynamic subtest: pipe-D-HDMI-A-1-x [301.745574] Dynamic subtest pipe-D-HDMI-A-1-x: SUCCESS (2.032s) [301.746328] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (33.672s) [301.957965] [107/156] (728s left) kms_flip (plain-flip-fb-recreate) [302.053368] Starting subtest: plain-flip-fb-recreate [302.055232] Starting dynamic subtest: A-HDMI-A1 [309.878552] Dynamic subtest A-HDMI-A1: SUCCESS (7.822s) [309.895967] Starting dynamic subtest: B-HDMI-A1 [317.685619] Dynamic subtest B-HDMI-A1: SUCCESS (7.804s) [317.697282] Starting dynamic subtest: C-HDMI-A1 [325.497383] Dynamic subtest C-HDMI-A1: SUCCESS (7.808s) [325.512425] Starting dynamic subtest: D-HDMI-A1 [333.325279] Dynamic subtest D-HDMI-A1: SUCCESS (7.824s) [333.328882] Subtest plain-flip-fb-recreate: SUCCESS (31.273s) [333.484381] [108/156] (697s left) dumb_buffer (map-uaf) [333.519829] Starting subtest: map-uaf [333.523700] Subtest map-uaf: SUCCESS (0.005s) [333.615728] [109/156] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [333.712617] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [333.714067] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [333.805846] [110/156] (697s left) kms_psr (pr-primary-mmap-cpu) [333.894347] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [333.943128] [111/156] (697s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [334.035107] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [335.318122] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.284s) [335.447981] [112/156] (695s left) kms_plane_multiple (tiling-x) [335.538617] Starting subtest: tiling-x [335.539355] Starting dynamic subtest: pipe-A-HDMI-A-1 [336.164015] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.625s) [336.176436] Starting dynamic subtest: pipe-B-HDMI-A-1 [336.819387] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.652s) [336.830450] Starting dynamic subtest: pipe-C-HDMI-A-1 [337.474895] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.654s) [337.488084] Starting dynamic subtest: pipe-D-HDMI-A-1 [338.111075] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.634s) [338.111841] Subtest tiling-x: SUCCESS (2.573s) [338.278579] [113/156] (692s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [338.377128] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [338.378536] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [338.485414] [114/156] (692s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [338.578167] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [338.579590] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [338.678007] [115/156] (692s left) gem_exec_reloc (basic-wc-read-active) [338.716821] Starting subtest: basic-wc-read-active [338.840988] Subtest basic-wc-read-active: SUCCESS (0.118s) [338.957908] [116/156] (692s left) gem_exec_reloc (basic-gtt) [338.996058] Starting subtest: basic-gtt [339.003812] Subtest basic-gtt: SUCCESS (0.008s) [339.117004] [117/156] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [339.210126] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [339.211519] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [339.310661] [118/156] (691s left) gem_ctx_persistence (legacy-engines-hang) [339.348669] Starting subtest: legacy-engines-hang [339.349420] Starting dynamic subtest: render [339.389265] Dynamic subtest render: SUCCESS (0.039s) [339.409644] Starting dynamic subtest: bsd1 [339.440138] Dynamic subtest bsd1: SUCCESS (0.048s) [339.458323] Starting dynamic subtest: bsd2 [339.481170] Dynamic subtest bsd2: SUCCESS (0.039s) [339.499959] Starting dynamic subtest: blt [339.529219] Dynamic subtest blt: SUCCESS (0.046s) [339.547669] Starting dynamic subtest: vebox [339.572298] Dynamic subtest vebox: SUCCESS (0.040s) [339.573348] Subtest legacy-engines-hang: SUCCESS (0.224s) [339.660906] [119/156] (691s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [339.752966] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt [339.754464] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [339.850618] [120/156] (691s left) kms_cursor_legacy (torture-bo) [339.939037] Starting subtest: torture-bo [339.939803] Starting dynamic subtest: pipe-A [345.442706] Dynamic subtest pipe-A: SUCCESS (5.468s) [345.455270] Starting dynamic subtest: pipe-B [350.902044] Dynamic subtest pipe-B: SUCCESS (5.457s) [350.912535] Starting dynamic subtest: pipe-C [356.367387] Dynamic subtest pipe-C: SUCCESS (5.463s) [356.377517] Starting dynamic subtest: pipe-D [361.831098] Dynamic subtest pipe-D: SUCCESS (5.461s) [361.851910] Starting dynamic subtest: all-pipes [367.288893] Dynamic subtest all-pipes: SUCCESS (5.481s) [367.289669] Subtest torture-bo: SUCCESS (27.336s) [367.382113] [121/156] (664s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [367.476568] Starting subtest: missing-ccs-buffer-y-tiled-ccs [367.479525] Starting dynamic subtest: pipe-A-HDMI-A-1 [367.486375] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [367.495285] Starting dynamic subtest: pipe-B-HDMI-A-1 [367.502265] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [367.511151] Starting dynamic subtest: pipe-C-HDMI-A-1 [367.518108] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [367.526728] Starting dynamic subtest: pipe-D-HDMI-A-1 [367.533731] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [367.535064] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.012s) [367.754423] [122/156] (663s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [367.846687] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [378.704694] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.855s) [378.840576] [123/156] (652s left) drm_read (short-buffer-nonblock) [378.960767] Starting subtest: short-buffer-nonblock [378.961491] Subtest short-buffer-nonblock: SUCCESS (0.000s) [379.082143] [124/156] (652s left) gem_exec_whisper (basic-contexts-all) [379.125911] Starting subtest: basic-contexts-all [380.852490] Subtest basic-contexts-all: SUCCESS (1.725s) [381.033496] [125/156] (650s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt) [381.128057] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt [381.129417] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [381.260101] [126/156] (650s left) i915_query (query-regions-garbage-items) [381.294601] Starting subtest: query-regions-garbage-items [381.295364] Subtest query-regions-garbage-items: SUCCESS (0.000s) [381.356920] [127/156] (650s left) gem_wait (invalid-buf) [381.394356] Starting subtest: invalid-buf [381.395060] Subtest invalid-buf: SUCCESS (0.000s) [381.598744] [128/156] (650s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt) [381.690580] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt [381.691997] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [381.792459] [129/156] (649s left) perf_pmu (busy-idle) [381.829979] Starting subtest: busy-idle [381.830705] Starting dynamic subtest: rcs0 [382.481364] Dynamic subtest rcs0: SUCCESS (0.646s) [382.493343] Starting dynamic subtest: bcs0 [383.108275] Dynamic subtest bcs0: SUCCESS (0.627s) [383.119921] Starting dynamic subtest: vcs0 [383.739341] Dynamic subtest vcs0: SUCCESS (0.630s) [383.751232] Starting dynamic subtest: vcs1 [384.371438] Dynamic subtest vcs1: SUCCESS (0.629s) [384.383417] Starting dynamic subtest: vecs0 [385.007868] Dynamic subtest vecs0: SUCCESS (0.636s) [385.008781] Subtest busy-idle: SUCCESS (3.177s) [385.080507] [130/156] (646s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [385.170719] Starting subtest: 2x-cursor-vs-flip-legacy [385.173191] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s) [385.232818] [131/156] (646s left) gem_exec_balancer (semaphore) [385.274766] Starting subtest: semaphore [386.602215] Subtest semaphore: SUCCESS (1.327s) [386.805562] [132/156] (645s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite) [386.903741] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite [386.905191] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [386.984908] [133/156] (644s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [387.078116] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [387.079524] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [387.165842] [134/156] (644s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt) [387.260156] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt [387.261548] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [387.347457] [135/156] (644s left) kms_pm_rpm (i2c) [388.742096] Starting subtest: i2c [391.348728] Subtest i2c: SUCCESS (2.607s) [391.464998] [136/156] (640s left) kms_lease (cursor-implicit-plane) [391.553597] Starting subtest: cursor-implicit-plane [391.555468] Starting dynamic subtest: pipe-A-HDMI-A-1 [391.720618] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.165s) [391.729914] Starting dynamic subtest: pipe-B-HDMI-A-1 [391.876790] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.155s) [391.888260] Starting dynamic subtest: pipe-C-HDMI-A-1 [392.050569] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.171s) [392.061126] Starting dynamic subtest: pipe-D-HDMI-A-1 [392.212247] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.159s) [392.213000] Subtest cursor-implicit-plane: SUCCESS (0.659s) [392.335757] [137/156] (639s left) kms_color_pipeline (plane-lut1d-lut1d) [392.425779] Starting subtest: plane-lut1d-lut1d [392.507601] Starting dynamic subtest: pipe-A-plane-0 [392.615108] Dynamic subtest pipe-A-plane-0: SUCCESS (0.108s) [392.631586] Starting dynamic subtest: pipe-A-plane-1 [392.706787] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s) [392.725834] Starting dynamic subtest: pipe-A-plane-2 [392.806869] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s) [393.015803] Starting dynamic subtest: pipe-B-plane-0 [393.089951] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s) [393.103804] Starting dynamic subtest: pipe-B-plane-1 [393.181845] Dynamic subtest pipe-B-plane-1: SUCCESS (0.088s) [393.196570] Starting dynamic subtest: pipe-B-plane-2 [393.274140] Dynamic subtest pipe-B-plane-2: SUCCESS (0.088s) [393.500315] Starting dynamic subtest: pipe-C-plane-0 [393.574132] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s) [393.588806] Starting dynamic subtest: pipe-C-plane-1 [393.674002] Dynamic subtest pipe-C-plane-1: SUCCESS (0.097s) [393.689453] Starting dynamic subtest: pipe-C-plane-2 [393.774029] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s) [393.980443] Starting dynamic subtest: pipe-D-plane-0 [394.071416] Dynamic subtest pipe-D-plane-0: SUCCESS (0.100s) [394.085313] Starting dynamic subtest: pipe-D-plane-1 [394.172055] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s) [394.187997] Starting dynamic subtest: pipe-D-plane-2 [394.271829] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s) [394.320530] Subtest plane-lut1d-lut1d: SUCCESS (1.894s) [394.436757] [138/156] (637s left) gem_ctx_engines (none) [394.483954] Starting subtest: none [394.486010] Subtest none: SUCCESS (0.001s) [394.663292] [139/156] (637s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [394.698939] Starting subtest: multi-wait-for-submit-available-submitted [394.699672] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [394.776533] [140/156] (637s left) gem_lmem_swapping (random) [394.814674] Subtest random: SKIP (0.000s) [394.855810] [141/156] (637s left) kms_frontbuffer_tracking (fbcpsr-suspend) [394.953746] Starting subtest: fbcpsr-suspend [394.955115] Subtest fbcpsr-suspend: SKIP (0.000s) [395.037914] [142/156] (637s left) prime_self_import (basic-llseek-bad) [395.070784] Starting subtest: basic-llseek-bad [395.072191] Subtest basic-llseek-bad: SUCCESS (0.002s) [395.167252] [143/156] (637s left) gem_bad_reloc (negative-reloc-lut) [395.206008] Starting subtest: negative-reloc-lut [395.208198] Subtest negative-reloc-lut: SUCCESS (0.001s) [395.303524] [144/156] (637s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [395.401916] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [395.714280] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.313s) [395.846271] [145/156] (636s left) kms_fence_pin_leak [397.402490] [146/156] (635s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [397.499111] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [397.500518] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [397.591924] [147/156] (634s left) gem_softpin (allocator-fork) [397.631478] Starting subtest: allocator-fork [399.869868] Subtest allocator-fork: SUCCESS (2.230s) [399.990218] [148/156] (632s left) kms_cursor_crc (cursor-random-64x21) [400.087961] Starting subtest: cursor-random-64x21 [400.092773] Starting dynamic subtest: pipe-A-HDMI-A-1 [401.990335] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.897s) [402.034090] Starting dynamic subtest: pipe-D-HDMI-A-1 [403.905569] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.880s) [403.906384] Subtest cursor-random-64x21: SUCCESS (3.817s) [404.089680] [149/156] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [404.188776] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [404.197398] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [404.277733] [150/156] (628s left) kms_cursor_crc (cursor-dpms) [404.368220] Starting subtest: cursor-dpms [404.368988] Starting dynamic subtest: pipe-A-HDMI-A-1 [404.993080] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.623s) [405.003158] Starting dynamic subtest: pipe-D-HDMI-A-1 [405.596097] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.602s) [405.596907] Subtest cursor-dpms: SUCCESS (1.229s) [405.749723] [151/156] (626s left) kms_psr (psr-sprite-plane-onoff) [405.842385] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [405.885379] [152/156] (626s left) syncobj_wait (multi-wait-all-for-submit-submitted) [405.920110] Starting subtest: multi-wait-all-for-submit-submitted [406.027542] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [406.099146] [153/156] (626s left) gem_mmap_offset (oob-read) [406.132869] Starting subtest: oob-read [406.133618] Subtest oob-read: SUCCESS (0.001s) [406.218050] [154/156] (626s left) perf_pmu (init-wait) [406.255183] Starting subtest: init-wait [406.255948] Starting dynamic subtest: rcs0 [406.257760] Dynamic subtest rcs0: SUCCESS (0.001s) [406.267223] Starting dynamic subtest: bcs0 [406.267935] Dynamic subtest bcs0: SUCCESS (0.000s) [406.276611] Starting dynamic subtest: vcs0 [406.277363] Dynamic subtest vcs0: SUCCESS (0.000s) [406.285944] Starting dynamic subtest: vcs1 [406.286670] Dynamic subtest vcs1: SUCCESS (0.000s) [406.295400] Starting dynamic subtest: vecs0 [406.296094] Dynamic subtest vecs0: SUCCESS (0.000s) [406.296773] Subtest init-wait: SUCCESS (0.008s) [406.347572] [155/156] (626s left) gem_userptr_blits (unsync-unmap) [406.386985] Subtest unsync-unmap: SKIP (0.000s) [406.517365] [156/156] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [406.609045] Starting subtest: fbc-2p-primscrn-spr-indfb-move [406.610430] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [406.724517] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_chamelium_color results: parsing output: 3/ for test: api_intel_bb results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_pread results: parsing output: 6/ for test: kms_chamelium_hpd results: parsing output: 7/ for test: syncobj_eventfd results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: prime_self_import results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_content_protection results: parsing output: 12/ for test: kms_pipe_crc_basic results: parsing output: 13/ for test: api_intel_allocator results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_rotation_crc results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: i915_pm_rps results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: gem_exec_params results: parsing output: 21/ for test: gem_exec_reloc results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: kms_cursor_edge_walk results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gen9_exec_parse results: parsing output: 28/ for test: kms_atomic results: parsing output: 29/ for test: sw_sync results: parsing output: 30/ for test: prime_busy results: parsing output: 31/ for test: kms_plane_scaling results: parsing output: 32/ for test: gem_pwrite results: parsing output: 33/ for test: sysfs_heartbeat_interval results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_chamelium_frames 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_flip results: parsing output: 39/ for test: gem_render_copy results: parsing output: 40/ for test: kms_pipe_b_c_ivb results: parsing output: 41/ for test: kms_pipe_crc_basic results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: gem_exec_params results: parsing output: 47/ for test: kms_vblank results: parsing output: 48/ for test: gem_exec_create results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_vrr results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_ctx_shared results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: gem_exec_reloc results: parsing output: 56/ for test: kms_pm_rpm results: parsing output: 57/ for test: kms_rotation_crc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: i915_pm_freq_api results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_psr2_sf results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: kms_plane results: parsing output: 65/ for test: gem_close_race results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_exec_balancer results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: gem_pxp results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_ctx_param results: parsing output: 76/ for test: kms_atomic_transition results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_atomic_interruptible results: parsing output: 82/ for test: kms_flip_scaled_crc results: parsing output: 83/ for test: gem_madvise results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_rmfb results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_plane_scaling results: parsing output: 90/ for test: gem_lmem_swapping results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_properties results: parsing output: 94/ for test: gen7_exec_parse results: parsing output: 95/ for test: i915_drm_fdinfo results: parsing output: 96/ for test: kms_ccs results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_psr2_sf results: parsing output: 99/ for test: gem_eio results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_draw_crc results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_async_flips results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: dumb_buffer results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_plane_multiple results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: gem_exec_reloc results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_ctx_persistence results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: drm_read results: parsing output: 123/ for test: gem_exec_whisper results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: i915_query results: parsing output: 126/ for test: gem_wait results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: perf_pmu results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: gem_exec_balancer results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_pm_rpm results: parsing output: 135/ for test: kms_lease results: parsing output: 136/ for test: kms_color_pipeline results: parsing output: 137/ for test: gem_ctx_engines results: parsing output: 138/ for test: syncobj_timeline results: parsing output: 139/ for test: gem_lmem_swapping results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: prime_self_import results: parsing output: 142/ for test: gem_bad_reloc results: parsing output: 143/ for test: kms_big_fb results: parsing output: 144/ for test: kms_fence_pin_leak results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: gem_softpin results: parsing output: 147/ for test: kms_cursor_crc results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_cursor_crc results: parsing output: 150/ for test: kms_psr results: parsing output: 151/ for test: syncobj_wait results: parsing output: 152/ for test: gem_mmap_offset results: parsing output: 153/ for test: perf_pmu results: parsing output: 154/ for test: gem_userptr_blits results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.