[46.940978] Initializing watchdogs [46.941063] /dev/watchdog0 [46.956918] [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] [46.962817] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [46.965511] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [46.967462] [001/133] (960s left) kms_color (ctm-blue-to-red) [47.059632] Starting subtest: ctm-blue-to-red [47.060378] Starting dynamic subtest: pipe-A-HDMI-A-1 [47.387187] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.320s) [47.393472] Starting dynamic subtest: pipe-B-HDMI-A-1 [47.683817] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.290s) [47.689320] Starting dynamic subtest: pipe-C-HDMI-A-1 [47.984923] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.288s) [47.991939] Starting dynamic subtest: pipe-D-HDMI-A-1 [48.281746] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.297s) [48.282458] Subtest ctm-blue-to-red: SUCCESS (1.197s) [48.415696] [002/133] (959s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [48.459299] Starting subtest: yf-tiled-to-vebox-y-tiled [48.460058] Starting dynamic subtest: smem [48.560073] Dynamic subtest smem: SUCCESS (0.099s) [48.560801] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.099s) [48.739310] [003/133] (958s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [48.827321] Starting subtest: crc-primary-basic-y-tiled-ccs [48.828076] Starting dynamic subtest: pipe-A-HDMI-A-1 [48.834983] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [48.840582] Starting dynamic subtest: pipe-B-HDMI-A-1 [48.847446] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [48.852983] Starting dynamic subtest: pipe-C-HDMI-A-1 [48.859952] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [48.865345] Starting dynamic subtest: pipe-D-HDMI-A-1 [48.872328] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [48.873734] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [49.061633] [004/133] (958s left) gem_mmap_gtt (basic-small-copy-odd) [49.097000] Starting subtest: basic-small-copy-odd [51.082293] Subtest basic-small-copy-odd: SUCCESS (1.956s) [51.159767] [005/133] (956s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [51.300753] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [51.937170] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.628s) [52.065660] [006/133] (955s left) kms_chamelium_frames (vga-frame-dump) [52.207211] Subtest vga-frame-dump: SKIP (0.000s) [52.291637] [007/133] (955s left) gem_eio (wait-wedge-10ms) [52.343993] Starting subtest: wait-wedge-10ms [52.609332] Subtest wait-wedge-10ms: SUCCESS (0.262s) [52.770662] [008/133] (954s left) gem_tiled_blits (normal) [52.862685] Starting subtest: normal [62.680437] Subtest normal: SUCCESS (9.761s) [62.791254] [009/133] (944s left) kms_plane_alpha_blend (alpha-transparent-fb) [62.914532] Starting subtest: alpha-transparent-fb [62.985361] Starting dynamic subtest: pipe-A-HDMI-A-1 [63.275212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.289s) [63.283578] Starting dynamic subtest: pipe-D-HDMI-A-1 [63.606878] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.330s) [63.607673] Subtest alpha-transparent-fb: SUCCESS (0.691s) [63.763651] [010/133] (944s left) gem_exec_fence (syncobj-import) [64.123746] Starting subtest: syncobj-import [64.125720] Subtest syncobj-import: SUCCESS (0.003s) [64.425156] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true [64.429315] [011/133] (943s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [64.463496] Starting subtest: etime-multi-wait-for-submit-submitted [64.567621] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s) [64.638531] [012/133] (943s left) kms_big_fb (y-tiled-addfb-size-overflow) [64.736193] Starting subtest: y-tiled-addfb-size-overflow [64.736952] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s) [64.827545] [013/133] (943s left) gem_create (create-ext-cpu-access-sanity-check) [64.971484] Starting subtest: create-ext-cpu-access-sanity-check [64.973356] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [65.046608] [014/133] (942s left) gem_lmem_swapping (heavy-multi) [65.083456] Subtest heavy-multi: SKIP (0.000s) [65.120765] [015/133] (942s left) kms_psr (fbc-pr-cursor-render) [65.204579] Subtest fbc-pr-cursor-render: SKIP (0.000s) [65.247501] [016/133] (942s left) gem_ctx_persistence (engines-mixed) [65.284419] Starting subtest: engines-mixed [65.285149] Starting dynamic subtest: rcs0 [65.334753] Dynamic subtest rcs0: SUCCESS (0.049s) [65.350437] Starting dynamic subtest: bcs0 [65.384855] Dynamic subtest bcs0: SUCCESS (0.049s) [65.403081] Starting dynamic subtest: vcs0 [65.437609] Dynamic subtest vcs0: SUCCESS (0.052s) [65.454632] Starting dynamic subtest: vcs1 [65.498666] Dynamic subtest vcs1: SUCCESS (0.060s) [65.516038] Starting dynamic subtest: vecs0 [65.548603] Dynamic subtest vecs0: SUCCESS (0.049s) [65.549791] Subtest engines-mixed: SUCCESS (0.263s) [65.622478] [017/133] (942s left) syncobj_wait (multi-wait-all-submitted) [65.655589] Starting subtest: multi-wait-all-submitted [65.759790] Subtest multi-wait-all-submitted: SUCCESS (0.103s) [65.841569] [018/133] (942s left) dumb_buffer (map-valid) [65.874796] Starting subtest: map-valid [65.875475] Subtest map-valid: SUCCESS (0.000s) [65.953012] [019/133] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [66.042405] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [66.043768] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [66.126077] [020/133] (942s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [66.209767] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [66.210471] Starting dynamic subtest: pipe-A-valid-mode [67.252347] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.040s) [67.253389] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (1.041s) [67.775895] [021/133] (940s left) kms_pm_rpm (modeset-non-lpsp-stress) [69.195044] Starting subtest: modeset-non-lpsp-stress [70.390644] Subtest modeset-non-lpsp-stress: SKIP (1.193s) [70.577948] [022/133] (937s left) gem_exec_alignment (many) [70.616446] Starting subtest: many [103.273192] Subtest many: SUCCESS (32.638s) [103.846470] [023/133] (904s left) kms_psr (fbc-psr2-primary-blt) [103.986862] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [104.035215] [024/133] (904s left) kms_chamelium_audio (hdmi-audio-edid) [104.172155] Subtest hdmi-audio-edid: SKIP (0.000s) [104.263315] [025/133] (904s left) kms_psr (pr-primary-mmap-cpu) [104.350483] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [104.392866] [026/133] (904s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [104.433584] Starting subtest: multi-wait-available-unsubmitted-submitted [104.434345] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [104.489845] [027/133] (903s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [104.575282] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [104.627081] [028/133] (903s left) sysfs_heartbeat_interval (invalid) [104.667344] Starting subtest: invalid [104.668067] Starting dynamic subtest: vecs0 [104.668756] Dynamic subtest vecs0: SUCCESS (0.000s) [104.675771] Starting dynamic subtest: vcs0 [104.676456] Dynamic subtest vcs0: SUCCESS (0.000s) [104.683225] Starting dynamic subtest: bcs0 [104.683912] Dynamic subtest bcs0: SUCCESS (0.000s) [104.690639] Starting dynamic subtest: rcs0 [104.691321] Dynamic subtest rcs0: SUCCESS (0.000s) [104.698034] Starting dynamic subtest: vcs1 [104.698722] Dynamic subtest vcs1: SUCCESS (0.000s) [104.699389] Subtest invalid: SUCCESS (0.006s) [104.729776] [029/133] (903s left) kms_sequence (queue-busy) [104.820531] Starting subtest: queue-busy [104.821460] Starting dynamic subtest: pipe-A-HDMI-A-1 [106.119700] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.298s) [106.130178] Starting dynamic subtest: pipe-B-HDMI-A-1 [107.398713] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.277s) [107.408914] Starting dynamic subtest: pipe-C-HDMI-A-1 [108.664676] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.265s) [108.672519] Starting dynamic subtest: pipe-D-HDMI-A-1 [109.951056] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.284s) [109.951811] Subtest queue-busy: SUCCESS (5.130s) [110.064313] [030/133] (898s left) kms_vrr (flip-basic-fastset) [110.154858] Starting subtest: flip-basic-fastset [110.156959] Subtest flip-basic-fastset: SKIP (0.000s) [110.220870] [031/133] (898s left) gem_userptr_blits (stress-mm-invalidate-close) [110.266991] Starting subtest: stress-mm-invalidate-close [112.423750] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [112.534083] [032/133] (896s left) kms_big_fb (4-tiled-32bpp-rotate-0) [112.631261] Starting subtest: 4-tiled-32bpp-rotate-0 [112.632668] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s) [112.723553] [033/133] (895s left) gem_userptr_blits (set-cache-level) [112.761220] Starting subtest: set-cache-level [112.761904] Subtest set-cache-level: SUCCESS (0.000s) [112.874479] [034/133] (895s left) kms_async_flips (async-flip-dpms) [112.958657] Starting subtest: async-flip-dpms [113.089137] Starting dynamic subtest: pipe-A-HDMI-A-1 [115.512585] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.421s) [115.660598] Starting dynamic subtest: pipe-B-HDMI-A-1 [118.051590] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.398s) [118.213788] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.613169] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.408s) [120.764049] Starting dynamic subtest: pipe-D-HDMI-A-1 [123.156885] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.399s) [123.160391] Subtest async-flip-dpms: SUCCESS (10.201s) [123.400324] [035/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [123.492459] Starting subtest: fbc-rgb101010-draw-mmap-cpu [125.974700] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.482s) [126.072424] [036/133] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [126.163704] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [126.165087] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [126.251825] [037/133] (882s left) gem_mmap_gtt (hang) [126.284543] Starting subtest: hang [131.716301] Subtest hang: SUCCESS (5.432s) [131.796606] [038/133] (877s left) gem_media_fill (media-fill) [131.840125] Starting subtest: media-fill [131.840881] Starting dynamic subtest: smem [131.844716] Dynamic subtest smem: SUCCESS (0.004s) [131.845474] Subtest media-fill: SUCCESS (0.005s) [132.038646] [039/133] (876s left) perf_pmu (semaphore-busy) [132.078709] Starting subtest: semaphore-busy [132.079393] Starting dynamic subtest: rcs0 [133.631594] Dynamic subtest rcs0: SUCCESS (1.544s) [133.648382] Starting dynamic subtest: bcs0 [135.190056] Dynamic subtest bcs0: SUCCESS (1.557s) [135.200750] Starting dynamic subtest: vcs0 [136.751615] Dynamic subtest vcs0: SUCCESS (1.560s) [136.768809] Starting dynamic subtest: vcs1 [138.300191] Dynamic subtest vcs1: SUCCESS (1.547s) [138.311429] Starting dynamic subtest: vecs0 [139.854857] Dynamic subtest vecs0: SUCCESS (1.554s) [139.855814] Subtest semaphore-busy: SUCCESS (7.768s) [139.914968] [040/133] (869s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [140.005584] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [140.007023] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [140.062498] [041/133] (868s left) i915_query (query-topology-kernel-writes) [140.095451] Starting subtest: query-topology-kernel-writes [140.096166] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [140.155786] [042/133] (868s left) i915_query (query-garbage) [140.187533] Starting subtest: query-garbage [140.188380] Subtest query-garbage: SUCCESS (0.000s) [140.263885] [043/133] (868s left) kms_dsc (dsc-with-output-formats) [140.350702] Starting subtest: dsc-with-output-formats [140.357314] Subtest dsc-with-output-formats: SKIP (0.001s) [140.413909] [044/133] (868s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [140.497787] Starting subtest: bad-aux-stride-y-tiled-ccs [140.498482] Starting dynamic subtest: pipe-A-HDMI-A-1 [140.505032] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [140.512567] Starting dynamic subtest: pipe-B-HDMI-A-1 [140.519185] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [140.526617] Starting dynamic subtest: pipe-C-HDMI-A-1 [140.533124] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [140.540389] Starting dynamic subtest: pipe-D-HDMI-A-1 [140.547038] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [140.548325] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s) [140.743849] [045/133] (868s left) gem_mmap_gtt (hang-user) [140.779838] Starting subtest: hang-user [176.252698] Subtest hang-user: SUCCESS (35.460s) [176.347659] [046/133] (832s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [176.439811] Starting subtest: psr-2p-scndscrn-cur-indfb-move [176.441206] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [176.517535] [047/133] (832s left) kms_atomic_transition (modeset-transition-nonblocking) [176.602878] Starting subtest: modeset-transition-nonblocking [176.603667] Starting dynamic subtest: 1x-outputs [177.804982] Dynamic subtest 1x-outputs: SUCCESS (1.202s) [177.805793] Subtest modeset-transition-nonblocking: SUCCESS (1.203s) [177.946128] [048/133] (831s left) kms_rotation_crc (primary-rotation-90) [178.034784] Starting subtest: primary-rotation-90 [182.898557] Subtest primary-rotation-90: SUCCESS (4.863s) [183.098979] [049/133] (826s left) kms_addfb_basic (bad-pitch-1024) [183.131626] Starting subtest: bad-pitch-1024 [183.132346] Subtest bad-pitch-1024: SUCCESS (0.000s) [183.261681] [050/133] (826s left) sw_sync (sync_multi_consumer) [183.293020] Starting subtest: sync_multi_consumer [183.835627] Subtest sync_multi_consumer: SUCCESS (0.534s) [183.892810] [051/133] (825s left) syncobj_wait (invalid-reset-zero-handles) [183.925656] Starting subtest: invalid-reset-zero-handles [183.926331] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [183.981235] [052/133] (825s left) kms_hdr (static-toggle-suspend) [184.065182] Starting subtest: static-toggle-suspend [184.067396] Subtest static-toggle-suspend: SKIP (0.001s) [184.121891] [053/133] (825s left) gem_softpin (allocator-fork) [184.160408] Starting subtest: allocator-fork [186.390832] Subtest allocator-fork: SUCCESS (2.222s) [186.496052] [054/133] (822s left) gem_exec_params (no-bsd) [186.532671] Starting subtest: no-bsd [186.534269] Subtest no-bsd: SUCCESS (0.001s) [186.637442] [055/133] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [186.726590] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [186.727946] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [186.805756] [056/133] (822s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [186.889829] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [186.891191] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s) [186.947322] [057/133] (822s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [187.030817] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [187.032203] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [187.091104] [058/133] (822s left) i915_hangman (engine-error-state-capture) [187.134167] Starting subtest: engine-error-state-capture [187.134872] Starting dynamic subtest: rcs0 [191.356619] Dynamic subtest rcs0: SUCCESS (4.222s) [191.368872] Starting dynamic subtest: bcs0 [195.385700] Dynamic subtest bcs0: SUCCESS (4.027s) [195.403543] Starting dynamic subtest: vcs0 [199.431971] Dynamic subtest vcs0: SUCCESS (4.044s) [199.446083] Starting dynamic subtest: vcs1 [203.392914] Dynamic subtest vcs1: SUCCESS (3.958s) [203.410266] Starting dynamic subtest: vecs0 [207.360796] Dynamic subtest vecs0: SUCCESS (3.965s) [207.361980] Subtest engine-error-state-capture: SUCCESS (20.226s) [207.455825] [059/133] (802s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [207.545538] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [207.546968] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [207.636944] [060/133] (802s left) gem_exec_schedule (manyslice) [207.679079] Starting subtest: manyslice [207.679833] Starting dynamic subtest: rcs0 [208.210710] Dynamic subtest rcs0: SUCCESS (0.523s) [208.218505] Starting dynamic subtest: bcs0 [208.581148] Dynamic subtest bcs0: SUCCESS (0.369s) [208.589168] Starting dynamic subtest: vcs0 [208.939987] Dynamic subtest vcs0: SUCCESS (0.358s) [208.947673] Starting dynamic subtest: vcs1 [209.282336] Dynamic subtest vcs1: SUCCESS (0.341s) [209.290127] Starting dynamic subtest: vecs0 [209.619025] Dynamic subtest vecs0: SUCCESS (0.336s) [209.619818] Subtest manyslice: SUCCESS (1.932s) [209.905401] [061/133] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [209.996674] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [209.998029] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [210.090711] [062/133] (799s left) kms_big_fb (x-tiled-64bpp-rotate-180) [210.185051] Starting subtest: x-tiled-64bpp-rotate-180 [211.611674] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.426s) [211.741589] [063/133] (798s left) kms_atomic_interruptible (legacy-setmode) [211.830606] Starting subtest: legacy-setmode [211.832520] Starting dynamic subtest: pipe-A-HDMI-A-1 [218.024072] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.191s) [218.024788] Subtest legacy-setmode: SUCCESS (6.193s) [218.168877] [064/133] (791s left) kms_cursor_legacy (cursor-vs-flip-legacy) [218.260931] Starting subtest: cursor-vs-flip-legacy [247.880486] Subtest cursor-vs-flip-legacy: SUCCESS (29.616s) [248.019129] [065/133] (761s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [248.119036] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [248.120418] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [248.212332] [066/133] (761s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [248.245745] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [248.246437] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [248.313917] [067/133] (761s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [248.399757] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [248.414919] Starting dynamic subtest: pipe-A-plane-0 [248.923446] Dynamic subtest pipe-A-plane-0: SUCCESS (0.508s) [248.940674] Starting dynamic subtest: pipe-A-plane-3 [249.356990] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s) [249.373908] Starting dynamic subtest: pipe-A-plane-5 [249.682079] Dynamic subtest pipe-A-plane-5: SUCCESS (0.322s) [249.815251] Starting dynamic subtest: pipe-B-plane-0 [250.266657] Dynamic subtest pipe-B-plane-0: SUCCESS (0.458s) [250.280135] Starting dynamic subtest: pipe-B-plane-3 [250.708457] Dynamic subtest pipe-B-plane-3: SUCCESS (0.440s) [250.724241] Starting dynamic subtest: pipe-B-plane-5 [251.024913] Dynamic subtest pipe-B-plane-5: SUCCESS (0.315s) [251.098572] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (2.698s) [251.237913] [068/133] (758s left) kms_psr (fbc-psr-cursor-mmap-gtt) [251.331033] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [251.371353] [069/133] (758s left) kms_cursor_crc (cursor-offscreen-32x10) [251.459927] Starting subtest: cursor-offscreen-32x10 [251.512187] Subtest cursor-offscreen-32x10: SKIP (0.051s) [251.599026] [070/133] (758s left) drm_read (short-buffer-nonblock) [251.706672] Starting subtest: short-buffer-nonblock [251.707393] Subtest short-buffer-nonblock: SUCCESS (0.000s) [251.807915] [071/133] (758s left) kms_flip (dpms-vs-vblank-race-interruptible) [251.898145] Starting subtest: dpms-vs-vblank-race-interruptible [251.900865] Starting dynamic subtest: A-HDMI-A1 [254.803106] Dynamic subtest A-HDMI-A1: SUCCESS (2.901s) [254.811117] Starting dynamic subtest: B-HDMI-A1 [257.579284] Dynamic subtest B-HDMI-A1: SUCCESS (2.775s) [257.589025] Starting dynamic subtest: C-HDMI-A1 [260.329288] Dynamic subtest C-HDMI-A1: SUCCESS (2.748s) [260.338678] Starting dynamic subtest: D-HDMI-A1 [263.142185] Dynamic subtest D-HDMI-A1: SUCCESS (2.811s) [263.144299] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.245s) [263.320852] [072/133] (746s left) kms_chamelium_edid (hdmi-edid-read) [263.469226] Subtest hdmi-edid-read: SKIP (0.000s) [263.574235] [073/133] (746s left) syncobj_timeline (invalid-signal-illegal-handle) [263.610577] Starting subtest: invalid-signal-illegal-handle [263.611337] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [263.669882] [074/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [263.760862] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [263.762264] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [263.858572] [075/133] (746s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [263.948867] Starting subtest: psr-2p-pri-indfb-multidraw [263.950233] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [264.046524] [076/133] (746s left) syncobj_timeline (wait-any-interrupted) [264.087018] Starting subtest: wait-any-interrupted [264.182814] Subtest wait-any-interrupted: SUCCESS (0.102s) [264.266658] [077/133] (746s left) kms_psr (psr-sprite-plane-move) [264.353749] Subtest psr-sprite-plane-move: SKIP (0.000s) [264.399770] [078/133] (746s left) gem_exec_balancer (parallel-bb-first) [264.555021] Subtest parallel-bb-first: SKIP (0.000s) [264.630248] [079/133] (745s left) sw_sync (sync_multi_producer_single_consumer) [264.662016] Starting subtest: sync_multi_producer_single_consumer [265.745487] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [265.788365] [080/133] (744s left) syncobj_timeline (device-signal-unordered) [265.821778] Starting subtest: device-signal-unordered [265.823550] Subtest device-signal-unordered: SUCCESS (0.001s) [265.879236] [081/133] (744s left) core_auth (getclient-master-drop) [265.911390] Starting subtest: getclient-master-drop [265.912773] Subtest getclient-master-drop: SUCCESS (0.002s) [265.970657] [082/133] (744s left) gem_mmap_gtt (basic-copy) [266.003931] Starting subtest: basic-copy [266.477961] Subtest basic-copy: SUCCESS (0.466s) [266.552562] [083/133] (744s left) kms_addfb_basic (bad-pitch-65536) [266.584740] Starting subtest: bad-pitch-65536 [266.585469] Subtest bad-pitch-65536: SUCCESS (0.000s) [266.749266] [084/133] (743s left) gem_exec_whisper (basic-fds) [266.792810] Starting subtest: basic-fds [269.674254] Subtest basic-fds: SUCCESS (2.881s) [269.859948] [085/133] (740s left) gem_exec_reloc (basic-concurrent0) [269.897608] Starting subtest: basic-concurrent0 [275.332253] Subtest basic-concurrent0: SUCCESS (5.398s) [275.416165] [086/133] (735s left) gen7_exec_parse (chained-batch) [275.453068] Subtest chained-batch: SKIP (0.000s) [275.492517] [087/133] (735s left) gem_exec_fence (basic-busy-all) [275.534145] Starting subtest: basic-busy-all [275.594580] Subtest basic-busy-all: SUCCESS (0.060s) [276.203411] [088/133] (734s left) kms_cursor_crc (cursor-random-128x128) [276.293303] Starting subtest: cursor-random-128x128 [276.298041] Starting dynamic subtest: pipe-A-HDMI-A-1 [278.219742] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.921s) [278.254099] Starting dynamic subtest: pipe-D-HDMI-A-1 [280.121376] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.874s) [280.122271] Subtest cursor-random-128x128: SUCCESS (3.828s) [280.265246] [089/133] (730s left) vgem_basic (dmabuf-export) [280.306874] Starting subtest: dmabuf-export [280.309527] Subtest dmabuf-export: SUCCESS (0.003s) [280.401996] [090/133] (730s left) i915_pm_rpm (gem-evict-pwrite) [281.804326] Starting subtest: gem-evict-pwrite [283.100842] Subtest gem-evict-pwrite: SUCCESS (1.295s) [283.277385] [091/133] (727s left) syncobj_wait (wait-all-complex) [283.312701] Starting subtest: wait-all-complex [283.536166] Subtest wait-all-complex: SUCCESS (0.215s) [283.608749] [092/133] (727s left) kms_busy (extended-pageflip-hang-oldfb) [283.698999] Starting subtest: extended-pageflip-hang-oldfb [283.699726] Starting dynamic subtest: pipe-A [283.828065] Dynamic subtest pipe-A: SUCCESS (0.127s) [283.840929] Starting dynamic subtest: pipe-D [283.981503] Dynamic subtest pipe-D: SUCCESS (0.150s) [283.983390] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.285s) [284.118098] [093/133] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [284.211332] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [284.212774] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [284.306380] [094/133] (726s left) kms_big_fb (yf-tiled-addfb-size-overflow) [284.401208] Starting subtest: yf-tiled-addfb-size-overflow [284.402619] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [284.488692] [095/133] (726s left) gem_ctx_create (basic) [284.529881] Starting subtest: basic [284.530642] Subtest basic: SUCCESS (0.000s) [284.709507] [096/133] (726s left) gem_exec_reloc (basic-write-read) [284.747262] Starting subtest: basic-write-read [284.751930] Subtest basic-write-read: SUCCESS (0.005s) [284.870265] [097/133] (726s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [284.962735] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [285.010539] [098/133] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [285.101346] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [285.102797] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [285.170935] [099/133] (726s left) kms_cursor_crc (cursor-tearing-position-change) [285.257878] Starting subtest: cursor-tearing-position-change [285.258746] Starting dynamic subtest: pipe-A-HDMI-A-1 [285.511862] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.253s) [285.521530] Starting dynamic subtest: pipe-D-HDMI-A-1 [285.744028] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.228s) [285.744802] Subtest cursor-tearing-position-change: SUCCESS (0.486s) [285.885201] [100/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [285.983724] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [285.985050] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [286.058480] [101/133] (725s left) kms_big_fb (linear-64bpp-rotate-270) [286.164444] Starting subtest: linear-64bpp-rotate-270 [286.208356] Subtest linear-64bpp-rotate-270: SKIP (0.043s) [286.321409] [102/133] (725s left) gem_ctx_persistence (smoketest) [286.360029] Starting subtest: smoketest [324.720712] Subtest smoketest: SUCCESS (38.358s) [324.796412] [103/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [324.888743] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [324.890101] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [324.976278] [104/133] (686s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [325.066911] Starting subtest: psr-rgb565-draw-pwrite [325.068364] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s) [325.163289] [105/133] (686s left) template (b) [325.196762] Starting subtest: B [325.197452] Subtest B: SUCCESS (0.000s) [325.260941] [106/133] (686s left) kms_lease (simple-lease) [325.348201] Starting subtest: simple-lease [325.348949] Starting dynamic subtest: pipe-A-HDMI-A-1 [325.582481] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.233s) [325.592542] Starting dynamic subtest: pipe-B-HDMI-A-1 [325.778947] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.192s) [325.787662] Starting dynamic subtest: pipe-C-HDMI-A-1 [325.980036] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.198s) [325.990372] Starting dynamic subtest: pipe-D-HDMI-A-1 [326.176695] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.196s) [326.177463] Subtest simple-lease: SUCCESS (0.830s) [326.297759] [107/133] (685s left) gem_exec_params (sol-reset-invalid) [326.337823] Starting subtest: sol-reset-invalid [326.339863] Subtest sol-reset-invalid: SUCCESS (0.001s) [326.443410] [108/133] (685s left) gem_pxp (create-regular-context-2) [326.545378] Starting subtest: create-regular-context-2 [326.546419] Subtest create-regular-context-2: SUCCESS (0.001s) [326.620258] [109/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [326.710907] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [326.712389] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [326.813658] [110/133] (684s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [326.898962] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [326.900803] Starting dynamic subtest: pipe-A-valid-mode [328.105330] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.205s) [328.106113] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.207s) [328.248651] [111/133] (683s left) gem_reg_read (timestamp-moving) [328.284679] Starting subtest: timestamp-moving [329.294673] Subtest timestamp-moving: SUCCESS (1.001s) [329.351255] [112/133] (682s left) kms_flip (absolute-wf_vblank) [329.438689] Starting subtest: absolute-wf_vblank [329.441282] Starting dynamic subtest: A-HDMI-A1 [337.142959] Dynamic subtest A-HDMI-A1: SUCCESS (7.682s) [337.150722] Starting dynamic subtest: B-HDMI-A1 [344.812801] Dynamic subtest B-HDMI-A1: SUCCESS (7.655s) [344.820071] Starting dynamic subtest: C-HDMI-A1 [352.469615] Dynamic subtest C-HDMI-A1: SUCCESS (7.657s) [352.476996] Starting dynamic subtest: D-HDMI-A1 [360.096840] Dynamic subtest D-HDMI-A1: SUCCESS (7.654s) [360.098996] Subtest absolute-wf_vblank: SUCCESS (30.659s) [360.270978] [113/133] (651s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [360.364313] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [361.616328] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.251s) [361.728674] [114/133] (650s left) perf_pmu (faulting-read) [361.764528] Starting subtest: faulting-read [361.765320] Starting dynamic subtest: gtt [361.767149] Dynamic subtest gtt: SUCCESS (0.001s) [361.776779] Starting dynamic subtest: wb [361.777468] Dynamic subtest wb: SUCCESS (0.001s) [361.785111] Starting dynamic subtest: wc [361.785801] Dynamic subtest wc: SUCCESS (0.000s) [361.793375] Starting dynamic subtest: uc [361.794069] Dynamic subtest uc: SUCCESS (0.000s) [361.794748] Subtest faulting-read: SUCCESS (0.006s) [361.880815] [115/133] (650s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [361.974226] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [361.975269] Starting dynamic subtest: pipe-A [362.120701] Dynamic subtest pipe-A: SUCCESS (0.147s) [362.129817] Starting dynamic subtest: pipe-B [362.264422] Dynamic subtest pipe-B: SUCCESS (0.143s) [362.273894] Starting dynamic subtest: pipe-C [362.398284] Dynamic subtest pipe-C: SUCCESS (0.133s) [362.407808] Starting dynamic subtest: pipe-D [362.533819] Dynamic subtest pipe-D: SUCCESS (0.135s) [362.534582] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.561s) [362.724075] [116/133] (649s left) gem_exec_balancer (parallel-out-fence) [362.885590] Subtest parallel-out-fence: SKIP (0.000s) [362.961791] [117/133] (649s left) perf_pmu (busy-double-start) [362.997221] Starting subtest: busy-double-start [362.997995] Starting dynamic subtest: rcs0 [366.544698] Dynamic subtest rcs0: SUCCESS (3.546s) [366.557107] Starting dynamic subtest: bcs0 [370.093581] Dynamic subtest bcs0: SUCCESS (3.546s) [370.106036] Starting dynamic subtest: vcs0 [373.640683] Dynamic subtest vcs0: SUCCESS (3.544s) [373.652607] Starting dynamic subtest: vcs1 [377.187602] Dynamic subtest vcs1: SUCCESS (3.544s) [377.199410] Starting dynamic subtest: vecs0 [380.743625] Dynamic subtest vecs0: SUCCESS (3.553s) [380.744730] Subtest busy-double-start: SUCCESS (17.746s) [380.819865] [118/133] (631s left) i915_suspend (basic-s3-without-i915) [380.852693] Starting subtest: basic-s3-without-i915