[43.758636] Initializing watchdogs [43.758701] /dev/watchdog0 [43.773948] [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] [43.779495] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [43.781979] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [43.783848] [001/133] (960s left) kms_color (ctm-blue-to-red) [43.874578] Starting subtest: ctm-blue-to-red [43.875311] Starting dynamic subtest: pipe-A-HDMI-A-1 [44.202559] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.328s) [44.208080] Starting dynamic subtest: pipe-B-HDMI-A-1 [44.495486] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.292s) [44.500970] Starting dynamic subtest: pipe-C-HDMI-A-1 [44.802176] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.306s) [44.807848] Starting dynamic subtest: pipe-D-HDMI-A-1 [45.096129] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.294s) [45.096812] Subtest ctm-blue-to-red: SUCCESS (1.222s) [45.233306] [002/133] (959s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [45.274054] Starting subtest: yf-tiled-to-vebox-y-tiled [45.274748] Starting dynamic subtest: smem [45.372827] Dynamic subtest smem: SUCCESS (0.098s) [45.373540] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.099s) [45.552352] [003/133] (958s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [45.639343] Starting subtest: crc-primary-basic-y-tiled-ccs [45.640059] Starting dynamic subtest: pipe-A-HDMI-A-1 [45.646844] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [45.652332] Starting dynamic subtest: pipe-B-HDMI-A-1 [45.659210] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [45.664644] Starting dynamic subtest: pipe-C-HDMI-A-1 [45.671481] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [45.676887] Starting dynamic subtest: pipe-D-HDMI-A-1 [45.683783] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [45.685115] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.007s) [45.873802] [004/133] (958s left) gem_mmap_gtt (basic-small-copy-odd) [45.907300] Starting subtest: basic-small-copy-odd [47.794081] Subtest basic-small-copy-odd: SUCCESS (1.881s) [47.874377] [005/133] (956s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [48.023725] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [48.670916] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.620s) [48.785333] [006/133] (955s left) kms_chamelium_frames (vga-frame-dump) [48.929963] Subtest vga-frame-dump: SKIP (0.000s) [49.018359] [007/133] (955s left) gem_eio (wait-wedge-10ms) [49.068752] Starting subtest: wait-wedge-10ms [49.341203] Subtest wait-wedge-10ms: SUCCESS (0.262s) [49.462318] [008/133] (955s left) gem_tiled_blits (normal) [49.549515] Starting subtest: normal [60.704383] Subtest normal: SUCCESS (10.947s) [60.806794] [009/133] (943s left) kms_plane_alpha_blend (alpha-transparent-fb) [60.935222] Starting subtest: alpha-transparent-fb [61.006039] Starting dynamic subtest: pipe-A-HDMI-A-1 [61.301500] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.293s) [61.310595] Starting dynamic subtest: pipe-D-HDMI-A-1 [61.626252] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.321s) [61.626997] Subtest alpha-transparent-fb: SUCCESS (0.686s) [61.771750] [010/133] (942s left) gem_exec_fence (syncobj-import) [62.137351] Starting subtest: syncobj-import [62.140111] Subtest syncobj-import: SUCCESS (0.003s) [62.433305] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true [62.435141] [011/133] (942s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [62.469624] Starting subtest: etime-multi-wait-for-submit-submitted [62.575754] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s) [62.646325] [012/133] (942s left) kms_big_fb (y-tiled-addfb-size-overflow) [62.743094] Starting subtest: y-tiled-addfb-size-overflow [62.743789] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.001s) [62.841279] [013/133] (941s left) gem_create (create-ext-cpu-access-sanity-check) [62.997997] Starting subtest: create-ext-cpu-access-sanity-check [62.999859] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [63.076107] [014/133] (941s left) gem_lmem_swapping (heavy-multi) [63.113731] Subtest heavy-multi: SKIP (0.000s) [63.153632] [015/133] (941s left) kms_psr (fbc-pr-cursor-render) [63.238393] Subtest fbc-pr-cursor-render: SKIP (0.000s) [63.278827] [016/133] (941s left) gem_ctx_persistence (engines-mixed) [63.317222] Starting subtest: engines-mixed [63.317967] Starting dynamic subtest: rcs0 [63.371142] Dynamic subtest rcs0: SUCCESS (0.053s) [63.380590] Starting dynamic subtest: bcs0 [63.424503] Dynamic subtest bcs0: SUCCESS (0.052s) [63.440253] Starting dynamic subtest: vcs0 [63.476597] Dynamic subtest vcs0: SUCCESS (0.051s) [63.493205] Starting dynamic subtest: vcs1 [63.536624] Dynamic subtest vcs1: SUCCESS (0.059s) [63.552295] Starting dynamic subtest: vecs0 [63.584662] Dynamic subtest vecs0: SUCCESS (0.047s) [63.585903] Subtest engines-mixed: SUCCESS (0.266s) [63.664310] [017/133] (941s left) syncobj_wait (multi-wait-all-submitted) [63.697443] Starting subtest: multi-wait-all-submitted [63.799897] Subtest multi-wait-all-submitted: SUCCESS (0.101s) [63.876132] [018/133] (941s left) dumb_buffer (map-valid) [63.908034] Starting subtest: map-valid [63.908739] Subtest map-valid: SUCCESS (0.000s) [63.996734] [019/133] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [64.085482] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [64.086852] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [64.169333] [020/133] (940s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [64.253696] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [64.254397] Starting dynamic subtest: pipe-A-valid-mode [65.291984] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.032s) [65.292736] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (1.033s) [65.446745] [021/133] (939s left) kms_pm_rpm (modeset-non-lpsp-stress) [66.864021] Starting subtest: modeset-non-lpsp-stress [68.070245] Subtest modeset-non-lpsp-stress: SKIP (1.202s) [68.250694] [022/133] (936s left) gem_exec_alignment (many) [68.290341] Starting subtest: many [101.416408] Subtest many: SUCCESS (33.085s) [102.164308] [023/133] (902s left) kms_psr (fbc-psr2-primary-blt) [102.293026] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [102.335749] [024/133] (902s left) kms_chamelium_audio (hdmi-audio-edid) [102.473397] Subtest hdmi-audio-edid: SKIP (0.000s) [102.561897] [025/133] (902s left) kms_psr (pr-primary-mmap-cpu) [102.650205] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [102.693429] [026/133] (902s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [102.732599] Starting subtest: multi-wait-available-unsubmitted-submitted [102.733345] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [102.811573] [027/133] (902s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [102.896947] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [102.938692] [028/133] (902s left) sysfs_heartbeat_interval (invalid) [102.977037] Starting subtest: invalid [102.977787] Starting dynamic subtest: vecs0 [102.978479] Dynamic subtest vecs0: SUCCESS (0.000s) [102.987405] Starting dynamic subtest: vcs0 [102.988127] Dynamic subtest vcs0: SUCCESS (0.000s) [102.995662] Starting dynamic subtest: bcs0 [102.996342] Dynamic subtest bcs0: SUCCESS (0.000s) [103.003154] Starting dynamic subtest: rcs0 [103.003843] Dynamic subtest rcs0: SUCCESS (0.000s) [103.010230] Starting dynamic subtest: vcs1 [103.010909] Dynamic subtest vcs1: SUCCESS (0.001s) [103.011584] Subtest invalid: SUCCESS (0.003s) [103.041006] [029/133] (902s left) kms_sequence (queue-busy) [103.125764] Starting subtest: queue-busy [103.127304] Starting dynamic subtest: pipe-A-HDMI-A-1 [104.434286] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.307s) [104.442136] Starting dynamic subtest: pipe-B-HDMI-A-1 [105.700393] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.264s) [105.708168] Starting dynamic subtest: pipe-C-HDMI-A-1 [106.992926] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.290s) [107.002215] Starting dynamic subtest: pipe-D-HDMI-A-1 [108.272942] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.279s) [108.273839] Subtest queue-busy: SUCCESS (5.146s) [108.389307] [030/133] (897s left) kms_vrr (flip-basic-fastset) [108.480396] Starting subtest: flip-basic-fastset [108.482368] Subtest flip-basic-fastset: SKIP (0.000s) [108.534446] [031/133] (896s left) gem_userptr_blits (stress-mm-invalidate-close) [108.578608] Starting subtest: stress-mm-invalidate-close [110.736042] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [110.836773] [032/133] (894s left) kms_big_fb (4-tiled-32bpp-rotate-0) [110.934839] Starting subtest: 4-tiled-32bpp-rotate-0 [110.936242] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s) [111.029661] [033/133] (894s left) gem_userptr_blits (set-cache-level) [111.068071] Starting subtest: set-cache-level [111.068756] Subtest set-cache-level: SUCCESS (0.000s) [111.199999] [034/133] (894s left) kms_async_flips (async-flip-dpms) [111.283813] Starting subtest: async-flip-dpms [111.415105] Starting dynamic subtest: pipe-A-HDMI-A-1 [113.847494] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.431s) [114.008450] Starting dynamic subtest: pipe-B-HDMI-A-1 [116.404641] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.404s) [116.550556] Starting dynamic subtest: pipe-C-HDMI-A-1 [118.969936] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.422s) [119.126477] Starting dynamic subtest: pipe-D-HDMI-A-1 [121.543468] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.425s) [121.547939] Subtest async-flip-dpms: SUCCESS (10.262s) [121.788115] [035/133] (883s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [121.878823] Starting subtest: fbc-rgb101010-draw-mmap-cpu [124.345739] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.467s) [124.448414] [036/133] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [124.540700] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [124.542067] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [124.641439] [037/133] (881s left) gem_mmap_gtt (hang) [124.674472] Starting subtest: hang [130.108896] Subtest hang: SUCCESS (5.433s) [130.209169] [038/133] (875s left) gem_media_fill (media-fill) [130.252409] Starting subtest: media-fill [130.253203] Starting dynamic subtest: smem [130.257950] Dynamic subtest smem: SUCCESS (0.006s) [130.258705] Subtest media-fill: SUCCESS (0.006s) [130.460443] [039/133] (875s left) perf_pmu (semaphore-busy) [130.502793] Starting subtest: semaphore-busy [130.503504] Starting dynamic subtest: rcs0 [132.076118] Dynamic subtest rcs0: SUCCESS (1.564s) [132.094569] Starting dynamic subtest: bcs0 [133.625152] Dynamic subtest bcs0: SUCCESS (1.547s) [133.636018] Starting dynamic subtest: vcs0 [135.172155] Dynamic subtest vcs0: SUCCESS (1.545s) [135.183123] Starting dynamic subtest: vcs1 [136.722125] Dynamic subtest vcs1: SUCCESS (1.548s) [136.732845] Starting dynamic subtest: vecs0 [138.269643] Dynamic subtest vecs0: SUCCESS (1.546s) [138.270787] Subtest semaphore-busy: SUCCESS (7.758s) [138.362283] [040/133] (867s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [138.450734] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [138.452095] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [138.518114] [041/133] (867s left) i915_query (query-topology-kernel-writes) [138.551637] Starting subtest: query-topology-kernel-writes [138.552339] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [138.611808] [042/133] (867s left) i915_query (query-garbage) [138.644045] Starting subtest: query-garbage [138.644733] Subtest query-garbage: SUCCESS (0.000s) [138.702766] [043/133] (867s left) kms_dsc (dsc-with-output-formats) [138.785762] Starting subtest: dsc-with-output-formats [138.792280] Subtest dsc-with-output-formats: SKIP (0.001s) [138.842891] [044/133] (867s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [138.926863] Starting subtest: bad-aux-stride-y-tiled-ccs [138.928460] Starting dynamic subtest: pipe-A-HDMI-A-1 [138.935195] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [138.942821] Starting dynamic subtest: pipe-B-HDMI-A-1 [138.949687] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [138.956860] Starting dynamic subtest: pipe-C-HDMI-A-1 [138.963557] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [138.970761] Starting dynamic subtest: pipe-D-HDMI-A-1 [138.977432] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [138.978763] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s) [139.189264] [045/133] (866s left) gem_mmap_gtt (hang-user) [139.222900] Starting subtest: hang-user [175.232349] Subtest hang-user: SUCCESS (36.011s) [175.333694] [046/133] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [175.426711] Starting subtest: psr-2p-scndscrn-cur-indfb-move [175.428085] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [175.520563] [047/133] (830s left) kms_atomic_transition (modeset-transition-nonblocking) [175.605659] Starting subtest: modeset-transition-nonblocking [175.606328] Starting dynamic subtest: 1x-outputs [176.811932] Dynamic subtest 1x-outputs: SUCCESS (1.206s) [176.812695] Subtest modeset-transition-nonblocking: SUCCESS (1.207s) [176.951299] [048/133] (829s left) kms_rotation_crc (primary-rotation-90) [177.040869] Starting subtest: primary-rotation-90 [182.058968] Subtest primary-rotation-90: SUCCESS (5.018s) [182.258805] [049/133] (823s left) kms_addfb_basic (bad-pitch-1024) [182.292891] Starting subtest: bad-pitch-1024 [182.293613] Subtest bad-pitch-1024: SUCCESS (0.000s) [182.445845] [050/133] (823s left) sw_sync (sync_multi_consumer) [182.478922] Starting subtest: sync_multi_consumer [183.010110] Subtest sync_multi_consumer: SUCCESS (0.523s) [183.062134] [051/133] (823s left) syncobj_wait (invalid-reset-zero-handles) [183.096152] Starting subtest: invalid-reset-zero-handles [183.096896] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [183.157008] [052/133] (823s left) kms_hdr (static-toggle-suspend) [183.241752] Starting subtest: static-toggle-suspend [183.243782] Subtest static-toggle-suspend: SKIP (0.000s) [183.300289] [053/133] (823s left) gem_softpin (allocator-fork) [183.338674] Starting subtest: allocator-fork [185.573227] Subtest allocator-fork: SUCCESS (2.227s) [185.672493] [054/133] (820s left) gem_exec_params (no-bsd) [185.708955] Starting subtest: no-bsd [185.709684] Subtest no-bsd: SUCCESS (0.001s) [185.835184] [055/133] (820s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [185.924588] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [185.926008] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [186.023382] [056/133] (820s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [186.109826] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [186.111251] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s) [186.167096] [057/133] (820s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [186.251905] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [186.253415] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [186.307586] [058/133] (820s left) i915_hangman (engine-error-state-capture) [186.349359] Starting subtest: engine-error-state-capture [186.350044] Starting dynamic subtest: rcs0 [190.405943] Dynamic subtest rcs0: SUCCESS (4.056s) [190.421170] Starting dynamic subtest: bcs0 [194.369833] Dynamic subtest bcs0: SUCCESS (3.962s) [194.382941] Starting dynamic subtest: vcs0 [198.396635] Dynamic subtest vcs0: SUCCESS (4.025s) [198.407080] Starting dynamic subtest: vcs1 [202.361900] Dynamic subtest vcs1: SUCCESS (3.964s) [202.377731] Starting dynamic subtest: vecs0 [206.401745] Dynamic subtest vecs0: SUCCESS (4.038s) [206.402853] Subtest engine-error-state-capture: SUCCESS (20.052s) [206.478643] [059/133] (800s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [206.568638] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [206.569980] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [206.667775] [060/133] (799s left) gem_exec_schedule (manyslice) [206.711042] Starting subtest: manyslice [206.711825] Starting dynamic subtest: rcs0 [207.215782] Dynamic subtest rcs0: SUCCESS (0.496s) [207.223213] Starting dynamic subtest: bcs0 [207.520852] Dynamic subtest bcs0: SUCCESS (0.304s) [207.528989] Starting dynamic subtest: vcs0 [207.910664] Dynamic subtest vcs0: SUCCESS (0.389s) [207.918455] Starting dynamic subtest: vcs1 [208.247879] Dynamic subtest vcs1: SUCCESS (0.336s) [208.255413] Starting dynamic subtest: vecs0 [208.576140] Dynamic subtest vecs0: SUCCESS (0.326s) [208.576887] Subtest manyslice: SUCCESS (1.855s) [208.862468] [061/133] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [208.954098] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [208.955540] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [209.059712] [062/133] (797s left) kms_big_fb (x-tiled-64bpp-rotate-180) [209.152082] Starting subtest: x-tiled-64bpp-rotate-180 [210.619944] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.467s) [210.754974] [063/133] (795s left) kms_atomic_interruptible (legacy-setmode) [210.843602] Starting subtest: legacy-setmode [210.844279] Starting dynamic subtest: pipe-A-HDMI-A-1 [217.044396] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.200s) [217.045174] Subtest legacy-setmode: SUCCESS (6.201s) [217.183290] [064/133] (789s left) kms_cursor_legacy (cursor-vs-flip-legacy) [217.274293] Starting subtest: cursor-vs-flip-legacy [246.917241] Subtest cursor-vs-flip-legacy: SUCCESS (29.642s) [247.048650] [065/133] (759s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [247.145068] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [247.146482] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [247.249756] [066/133] (759s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [247.282955] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [247.283665] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [247.350530] [067/133] (759s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [247.435907] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [247.452243] Starting dynamic subtest: pipe-A-plane-0 [247.960765] Dynamic subtest pipe-A-plane-0: SUCCESS (0.508s) [247.974200] Starting dynamic subtest: pipe-A-plane-3 [248.377452] Dynamic subtest pipe-A-plane-3: SUCCESS (0.415s) [248.395937] Starting dynamic subtest: pipe-A-plane-5 [248.702492] Dynamic subtest pipe-A-plane-5: SUCCESS (0.323s) [248.852127] Starting dynamic subtest: pipe-B-plane-0 [249.303431] Dynamic subtest pipe-B-plane-0: SUCCESS (0.458s) [249.318178] Starting dynamic subtest: pipe-B-plane-3 [249.737172] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s) [249.751416] Starting dynamic subtest: pipe-B-plane-5 [250.053649] Dynamic subtest pipe-B-plane-5: SUCCESS (0.315s) [250.111091] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (2.675s) [250.254593] [068/133] (756s left) kms_psr (fbc-psr-cursor-mmap-gtt) [250.346600] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [250.391577] [069/133] (756s left) kms_cursor_crc (cursor-offscreen-32x10) [250.478990] Starting subtest: cursor-offscreen-32x10 [250.531877] Subtest cursor-offscreen-32x10: SKIP (0.051s) [250.620570] [070/133] (756s left) drm_read (short-buffer-nonblock) [250.743940] Starting subtest: short-buffer-nonblock [250.744625] Subtest short-buffer-nonblock: SUCCESS (0.000s) [250.856337] [071/133] (756s left) kms_flip (dpms-vs-vblank-race-interruptible) [250.947663] Starting subtest: dpms-vs-vblank-race-interruptible [250.949412] Starting dynamic subtest: A-HDMI-A1 [253.852211] Dynamic subtest A-HDMI-A1: SUCCESS (2.902s) [253.860133] Starting dynamic subtest: B-HDMI-A1 [256.630899] Dynamic subtest B-HDMI-A1: SUCCESS (2.777s) [256.639173] Starting dynamic subtest: C-HDMI-A1 [259.382174] Dynamic subtest C-HDMI-A1: SUCCESS (2.749s) [259.389954] Starting dynamic subtest: D-HDMI-A1 [262.118956] Dynamic subtest D-HDMI-A1: SUCCESS (2.736s) [262.121178] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.173s) [262.265978] [072/133] (744s left) kms_chamelium_edid (hdmi-edid-read) [262.416683] Subtest hdmi-edid-read: SKIP (0.000s) [262.504164] [073/133] (744s left) syncobj_timeline (invalid-signal-illegal-handle) [262.541649] Starting subtest: invalid-signal-illegal-handle [262.542401] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [262.605284] [074/133] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [262.695511] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [262.696983] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [262.792700] [075/133] (744s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [262.883279] Starting subtest: psr-2p-pri-indfb-multidraw [262.884760] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [262.964912] [076/133] (744s left) syncobj_timeline (wait-any-interrupted) [262.999273] Starting subtest: wait-any-interrupted [263.100867] Subtest wait-any-interrupted: SUCCESS (0.101s) [263.165744] [077/133] (744s left) kms_psr (psr-sprite-plane-move) [263.251686] Subtest psr-sprite-plane-move: SKIP (0.000s) [263.292559] [078/133] (744s left) gem_exec_balancer (parallel-bb-first) [263.450929] Subtest parallel-bb-first: SKIP (0.000s) [263.534019] [079/133] (743s left) sw_sync (sync_multi_producer_single_consumer) [263.566724] Starting subtest: sync_multi_producer_single_consumer [264.651879] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [264.705857] [080/133] (742s left) syncobj_timeline (device-signal-unordered) [264.740040] Starting subtest: device-signal-unordered [264.740744] Subtest device-signal-unordered: SUCCESS (0.001s) [264.816645] [081/133] (742s left) core_auth (getclient-master-drop) [264.849209] Starting subtest: getclient-master-drop [264.851760] Subtest getclient-master-drop: SUCCESS (0.002s) [264.917465] [082/133] (742s left) gem_mmap_gtt (basic-copy) [264.949746] Starting subtest: basic-copy [265.422098] Subtest basic-copy: SUCCESS (0.464s) [265.492533] [083/133] (742s left) kms_addfb_basic (bad-pitch-65536) [265.526072] Starting subtest: bad-pitch-65536 [265.526781] Subtest bad-pitch-65536: SUCCESS (0.000s) [265.672097] [084/133] (741s left) gem_exec_whisper (basic-fds) [265.714578] Starting subtest: basic-fds [268.679687] Subtest basic-fds: SUCCESS (2.964s) [268.857530] [085/133] (738s left) gem_exec_reloc (basic-concurrent0) [268.894753] Starting subtest: basic-concurrent0 [274.340321] Subtest basic-concurrent0: SUCCESS (5.401s) [274.415008] [086/133] (733s left) gen7_exec_parse (chained-batch) [274.452106] Subtest chained-batch: SKIP (0.000s) [274.494774] [087/133] (733s left) gem_exec_fence (basic-busy-all) [274.536326] Starting subtest: basic-busy-all [274.571641] Subtest basic-busy-all: SUCCESS (0.035s) [275.185844] [088/133] (732s left) kms_cursor_crc (cursor-random-128x128) [275.275043] Starting subtest: cursor-random-128x128 [275.279705] Starting dynamic subtest: pipe-A-HDMI-A-1 [277.196545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.916s) [277.237835] Starting dynamic subtest: pipe-D-HDMI-A-1 [279.109196] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.879s) [279.109951] Subtest cursor-random-128x128: SUCCESS (3.836s) [279.268716] [089/133] (728s left) vgem_basic (dmabuf-export) [279.315535] Starting subtest: dmabuf-export [279.340502] Subtest dmabuf-export: SUCCESS (0.026s) [279.436917] [090/133] (728s left) i915_pm_rpm (gem-evict-pwrite) [280.837253] Starting subtest: gem-evict-pwrite [282.125679] Subtest gem-evict-pwrite: SUCCESS (1.289s) [282.304303] [091/133] (725s left) syncobj_wait (wait-all-complex) [282.340337] Starting subtest: wait-all-complex [282.563774] Subtest wait-all-complex: SUCCESS (0.215s) [282.632183] [092/133] (725s left) kms_busy (extended-pageflip-hang-oldfb) [282.722162] Starting subtest: extended-pageflip-hang-oldfb [282.722881] Starting dynamic subtest: pipe-A [282.847446] Dynamic subtest pipe-A: SUCCESS (0.124s) [282.861130] Starting dynamic subtest: pipe-D [282.992584] Dynamic subtest pipe-D: SUCCESS (0.141s) [282.993300] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.272s) [283.118007] [093/133] (724s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [283.213817] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [283.215272] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [283.317372] [094/133] (724s left) kms_big_fb (yf-tiled-addfb-size-overflow) [283.411732] Starting subtest: yf-tiled-addfb-size-overflow [283.413083] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [283.519613] [095/133] (724s left) gem_ctx_create (basic) [283.561195] Starting subtest: basic [283.561921] Subtest basic: SUCCESS (0.000s) [283.743657] [096/133] (724s left) gem_exec_reloc (basic-write-read) [283.780696] Starting subtest: basic-write-read [283.785280] Subtest basic-write-read: SUCCESS (0.005s) [283.897103] [097/133] (724s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [283.984447] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [284.026689] [098/133] (724s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [284.116916] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [284.118392] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [284.202348] [099/133] (723s left) kms_cursor_crc (cursor-tearing-position-change) [284.289225] Starting subtest: cursor-tearing-position-change [284.291037] Starting dynamic subtest: pipe-A-HDMI-A-1 [284.554398] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s) [284.564560] Starting dynamic subtest: pipe-D-HDMI-A-1 [284.798585] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.241s) [284.799338] Subtest cursor-tearing-position-change: SUCCESS (0.510s) [284.963494] [100/133] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [285.057192] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [285.058623] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [285.137129] [101/133] (723s left) kms_big_fb (linear-64bpp-rotate-270) [285.233079] Starting subtest: linear-64bpp-rotate-270 [285.281953] Subtest linear-64bpp-rotate-270: SKIP (0.048s) [285.383963] [102/133] (722s left) gem_ctx_persistence (smoketest) [285.423230] Starting subtest: smoketest [323.706145] Subtest smoketest: SUCCESS (38.284s) [323.781527] [103/133] (684s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [323.875754] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [323.877130] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [323.973967] [104/133] (684s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [324.063764] Starting subtest: psr-rgb565-draw-pwrite [324.065138] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s) [324.157829] [105/133] (684s left) template (b) [324.191882] Starting subtest: B [324.192570] Subtest B: SUCCESS (0.000s) [324.248431] [106/133] (684s left) kms_lease (simple-lease) [324.333415] Starting subtest: simple-lease [324.335627] Starting dynamic subtest: pipe-A-HDMI-A-1 [324.560174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.224s) [324.569329] Starting dynamic subtest: pipe-B-HDMI-A-1 [324.747926] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.186s) [324.787096] Starting dynamic subtest: pipe-C-HDMI-A-1 [324.959478] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.209s) [324.994027] Starting dynamic subtest: pipe-D-HDMI-A-1 [325.171862] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.210s) [325.172664] Subtest simple-lease: SUCCESS (0.839s) [325.287727] [107/133] (683s left) gem_exec_params (sol-reset-invalid) [325.328145] Starting subtest: sol-reset-invalid [325.329986] Subtest sol-reset-invalid: SUCCESS (0.001s) [325.431663] [108/133] (683s left) gem_pxp (create-regular-context-2) [325.534464] Starting subtest: create-regular-context-2 [325.535521] Subtest create-regular-context-2: SUCCESS (0.001s) [325.604231] [109/133] (682s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [325.694846] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [325.696236] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [325.797634] [110/133] (682s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [325.883165] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [325.883885] Starting dynamic subtest: pipe-A-valid-mode [327.064403] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.179s) [327.065181] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.181s) [327.209296] [111/133] (681s left) gem_reg_read (timestamp-moving) [327.247262] Starting subtest: timestamp-moving [328.256992] Subtest timestamp-moving: SUCCESS (1.001s) [328.317097] [112/133] (680s left) kms_flip (absolute-wf_vblank) [328.405762] Starting subtest: absolute-wf_vblank [328.408556] Starting dynamic subtest: A-HDMI-A1 [336.097453] Dynamic subtest A-HDMI-A1: SUCCESS (7.667s) [336.105152] Starting dynamic subtest: B-HDMI-A1 [343.763716] Dynamic subtest B-HDMI-A1: SUCCESS (7.653s) [343.773186] Starting dynamic subtest: C-HDMI-A1 [351.410942] Dynamic subtest C-HDMI-A1: SUCCESS (7.649s) [351.418480] Starting dynamic subtest: D-HDMI-A1 [359.037603] Dynamic subtest D-HDMI-A1: SUCCESS (7.652s) [359.039808] Subtest absolute-wf_vblank: SUCCESS (30.634s) [359.185753] [113/133] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [359.278733] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [360.555069] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.277s) [360.667844] [114/133] (648s left) perf_pmu (faulting-read) [360.704054] Starting subtest: faulting-read [360.704751] Starting dynamic subtest: gtt [360.706457] Dynamic subtest gtt: SUCCESS (0.001s) [360.714281] Starting dynamic subtest: wb [360.714955] Dynamic subtest wb: SUCCESS (0.001s) [360.722428] Starting dynamic subtest: wc [360.723098] Dynamic subtest wc: SUCCESS (0.000s) [360.730241] Starting dynamic subtest: uc [360.730897] Dynamic subtest uc: SUCCESS (0.000s) [360.731559] Subtest faulting-read: SUCCESS (0.006s) [360.807450] [115/133] (648s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [360.895987] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [360.896709] Starting dynamic subtest: pipe-A [361.029780] Dynamic subtest pipe-A: SUCCESS (0.134s) [361.039205] Starting dynamic subtest: pipe-B [361.181378] Dynamic subtest pipe-B: SUCCESS (0.151s) [361.190313] Starting dynamic subtest: pipe-C [361.314948] Dynamic subtest pipe-C: SUCCESS (0.132s) [361.323937] Starting dynamic subtest: pipe-D [361.440294] Dynamic subtest pipe-D: SUCCESS (0.124s) [361.442104] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.546s) [361.637671] [116/133] (647s left) gem_exec_balancer (parallel-out-fence) [361.800320] Subtest parallel-out-fence: SKIP (0.000s) [361.871501] [117/133] (647s left) perf_pmu (busy-double-start) [361.907616] Starting subtest: busy-double-start [361.908380] Starting dynamic subtest: rcs0 [365.451759] Dynamic subtest rcs0: SUCCESS (3.543s) [365.464557] Starting dynamic subtest: bcs0 [368.996649] Dynamic subtest bcs0: SUCCESS (3.542s) [369.008734] Starting dynamic subtest: vcs0 [372.544821] Dynamic subtest vcs0: SUCCESS (3.544s) [372.557019] Starting dynamic subtest: vcs1 [376.092665] Dynamic subtest vcs1: SUCCESS (3.544s) [376.105013] Starting dynamic subtest: vecs0 [379.636711] Dynamic subtest vecs0: SUCCESS (3.541s) [379.637886] Subtest busy-double-start: SUCCESS (17.729s) [379.709186] [118/133] (629s left) i915_suspend (basic-s3-without-i915) [379.741055] Starting subtest: basic-s3-without-i915