[56.735860] Initializing watchdogs [56.735906] /dev/watchdog0 [56.750007] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.754301] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.756278] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.758602] [001/131] (960s left) gem_tiled_blits (basic) [56.908697] Subtest basic: SKIP (0.000s) [56.979920] [002/131] (960s left) sysfs_heartbeat_interval (nopreempt) [57.041536] Starting subtest: nopreempt [57.042628] Starting dynamic subtest: vecs0 [66.929170] Dynamic subtest vecs0: SUCCESS (9.884s) [66.936933] Starting dynamic subtest: ccs0 [70.763429] Dynamic subtest ccs0: SUCCESS (3.835s) [70.771089] Starting dynamic subtest: vcs0 [79.942520] Dynamic subtest vcs0: SUCCESS (9.177s) [79.950820] Starting dynamic subtest: bcs0 [83.776896] Dynamic subtest bcs0: SUCCESS (3.835s) [83.785318] Starting dynamic subtest: rcs0 [87.735546] Dynamic subtest rcs0: SUCCESS (3.959s) [87.743649] Starting dynamic subtest: vcs1 [96.939089] Dynamic subtest vcs1: SUCCESS (9.203s) [96.940219] Subtest nopreempt: SUCCESS (39.897s) [97.009757] [003/131] (920s left) gem_mmap_offset (partial-remap) [97.060246] Starting subtest: partial-remap [97.061322] Starting dynamic subtest: smem0 [97.068828] Dynamic subtest smem0: SUCCESS (0.007s) [97.069839] Subtest partial-remap: SUCCESS (0.007s) [97.171833] [004/131] (920s left) kms_addfb_basic (legacy-format) [97.223381] Starting subtest: legacy-format [97.243595] Subtest legacy-format: SUCCESS (0.020s) [97.374948] [005/131] (920s left) prime_self_import (basic-llseek-size) [97.408263] Starting subtest: basic-llseek-size [97.423921] Subtest basic-llseek-size: SUCCESS (0.016s) [97.529239] [006/131] (919s left) kms_chamelium_hpd (dp-hpd-after-suspend) [97.912070] Subtest dp-hpd-after-suspend: SKIP (0.000s) [98.711118] [007/131] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [98.811811] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [98.813733] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [98.912844] [008/131] (918s left) gem_eio (in-flight-internal-immediate) [99.068789] Starting subtest: in-flight-internal-immediate [100.948585] Subtest in-flight-internal-immediate: SUCCESS (1.880s) [101.089136] [009/131] (916s left) perf_pmu (busy-idle) [101.122503] Starting subtest: busy-idle [101.123736] Starting dynamic subtest: rcs0 [101.843300] Dynamic subtest rcs0: SUCCESS (0.720s) [101.851785] Starting dynamic subtest: bcs0 [102.520928] Dynamic subtest bcs0: SUCCESS (0.677s) [102.529304] Starting dynamic subtest: vcs0 [103.916197] Dynamic subtest vcs0: SUCCESS (1.392s) [103.924893] Starting dynamic subtest: vcs1 [105.963511] Dynamic subtest vcs1: SUCCESS (2.046s) [105.972045] Starting dynamic subtest: vecs0 [107.947940] Dynamic subtest vecs0: SUCCESS (1.983s) [107.957185] Starting dynamic subtest: ccs0 [108.626302] Dynamic subtest ccs0: SUCCESS (0.680s) [108.627759] Subtest busy-idle: SUCCESS (7.504s) [108.729036] [010/131] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [108.831470] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [113.222126] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.392s) [113.337065] [011/131] (904s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [113.459258] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [113.460974] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [113.551669] [012/131] (904s left) kms_vblank (wait-idle) [113.656822] Starting subtest: wait-idle [113.657846] Starting dynamic subtest: pipe-A-eDP-1 [115.418140] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.759s) [115.428231] Starting dynamic subtest: pipe-D-eDP-1 [117.829420] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.409s) [117.830718] Subtest wait-idle: SUCCESS (4.171s) [118.645395] [013/131] (898s left) kms_vblank (query-busy) [118.749624] Starting subtest: query-busy [118.750608] Starting dynamic subtest: pipe-A-eDP-1 [120.648433] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.897s) [120.658954] Starting dynamic subtest: pipe-D-eDP-1 [123.213085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s) [123.214216] Subtest query-busy: SUCCESS (4.463s) [124.000444] [014/131] (893s left) kms_joiner (invalid-modeset-big-joiner) [124.105055] Starting subtest: invalid-modeset-big-joiner [124.106737] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [124.168240] [015/131] (893s left) gem_gtt_cpu_tlb [124.281451] [016/131] (893s left) gem_exec_whisper (basic-forked) [124.344224] Starting subtest: basic-forked [131.887694] Subtest basic-forked: SUCCESS (7.542s) [132.062594] [017/131] (885s left) gem_vm_create (invalid-create) [132.128473] Starting subtest: invalid-create [132.131122] Subtest invalid-create: SUCCESS (0.002s) [132.236652] [018/131] (885s left) syncobj_timeline (invalid-signal-zero-handles) [132.291189] Starting subtest: invalid-signal-zero-handles [132.292335] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [132.407597] [019/131] (885s left) i915_pm_rps (waitboost) [132.467715] Starting subtest: waitboost [132.496147] Subtest waitboost: FAIL (0.008s) [132.534331] [020/131] (885s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [137.545633] Starting subtest: pr-cursor-plane-move-continuous-sf [137.551014] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.004s) [138.404953] [021/131] (879s left) gem_userptr_blits (huge-split) [138.483493] Starting subtest: huge-split [138.489962] Subtest huge-split: SUCCESS (0.006s) [138.616884] [022/131] (879s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [138.706399] Starting subtest: yf-tiled-addfb-size-offset-overflow [138.708146] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [138.797820] [023/131] (879s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [138.905468] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [139.040445] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s) [139.180831] [024/131] (878s left) perf_pmu (gt-awake) [139.214259] Starting subtest: gt-awake [147.949091] Subtest gt-awake: SUCCESS (8.731s) [148.050077] [025/131] (869s left) kms_pipe_crc_basic (read-crc) [148.153859] Starting subtest: read-crc [148.154983] Starting dynamic subtest: pipe-A-eDP-1 [148.843904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s) [148.850451] Starting dynamic subtest: pipe-B-eDP-1 [150.155592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s) [150.164084] Starting dynamic subtest: pipe-C-eDP-1 [151.449140] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.294s) [151.455753] Starting dynamic subtest: pipe-D-eDP-1 [152.761996] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s) [152.763071] Subtest read-crc: SUCCESS (4.604s) [153.608516] [026/131] (864s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [153.709149] Starting subtest: fbc-psr2-sprite-mmap-cpu [153.710111] Starting dynamic subtest: eDP-1 [153.711863] Dynamic subtest eDP-1: SKIP (0.000s) [153.713565] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [153.773440] [027/131] (864s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [153.830190] Starting subtest: multi-wait-all-for-submit-submitted-signaled [153.935377] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s) [154.003095] [028/131] (864s left) drm_read (invalid-buffer) [154.182335] Starting subtest: invalid-buffer [154.183502] Subtest invalid-buffer: SUCCESS (0.000s) [154.296913] [029/131] (863s left) kms_cursor_crc (cursor-random-32x32) [154.422166] Starting subtest: cursor-random-32x32 [154.459060] Subtest cursor-random-32x32: SKIP (0.034s) [154.740799] [030/131] (863s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [154.840319] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [157.535357] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.696s) [157.664603] [031/131] (860s left) gem_lmem_swapping (parallel-random-verify-ccs) [157.698822] Subtest parallel-random-verify-ccs: SKIP (0.000s) [157.736201] [032/131] (860s left) kms_draw_crc (draw-method-mmap-cpu) [157.829025] Starting subtest: draw-method-mmap-cpu [157.829907] Starting dynamic subtest: xrgb8888-untiled [158.058275] Dynamic subtest xrgb8888-untiled: SUCCESS (0.230s) [158.065029] Starting dynamic subtest: rgb565-untiled [158.258348] Dynamic subtest rgb565-untiled: SUCCESS (0.200s) [158.265217] Starting dynamic subtest: xrgb2101010-untiled [158.458492] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.200s) [158.465936] Starting dynamic subtest: xbgr16161616f-untiled [158.703167] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s) [158.711512] Starting dynamic subtest: xrgb8888-xtiled [158.847424] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [158.854219] Starting dynamic subtest: rgb565-xtiled [158.980639] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [158.987492] Starting dynamic subtest: xrgb2101010-xtiled [159.091953] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [159.098780] Starting dynamic subtest: xbgr16161616f-xtiled [159.214249] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [159.223415] Starting dynamic subtest: xrgb8888-4tiled [159.347243] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s) [159.355041] Starting dynamic subtest: rgb565-4tiled [159.469635] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s) [159.475955] Starting dynamic subtest: xrgb2101010-4tiled [159.591811] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s) [159.599592] Starting dynamic subtest: xbgr16161616f-4tiled [159.747499] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s) [159.748401] Subtest draw-method-mmap-cpu: SUCCESS (1.919s) [159.857483] [033/131] (858s left) gem_softpin (evict-active) [159.909945] Starting subtest: evict-active [159.915735] Subtest evict-active: SUCCESS (0.006s) [160.041457] [034/131] (858s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [160.137955] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [164.939226] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.799s) [165.053235] [035/131] (853s left) kms_lease (lessee-list) [165.155873] Starting subtest: lessee-list [165.156944] Starting dynamic subtest: pipe-A-eDP-1 [165.159419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [165.166649] Starting dynamic subtest: pipe-B-eDP-1 [165.167798] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [165.173905] Starting dynamic subtest: pipe-C-eDP-1 [165.174849] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [165.181112] Starting dynamic subtest: pipe-D-eDP-1 [165.182103] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [165.183065] Subtest lessee-list: SUCCESS (0.008s) [165.274169] [036/131] (853s left) prime_vgem (basic-read) [165.371148] Starting subtest: basic-read [165.377759] Subtest basic-read: SKIP (0.006s) [165.463489] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true [165.465719] [037/131] (852s left) i915_query (query-regions-garbage-items) [165.514178] Starting subtest: query-regions-garbage-items [165.515236] Subtest query-regions-garbage-items: SUCCESS (0.000s) [165.595989] [038/131] (852s left) kms_flip (2x-flip-vs-suspend-interruptible) [165.689901] Starting subtest: 2x-flip-vs-suspend-interruptible [165.701851] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s) [165.809212] [039/131] (852s left) kms_getfb (getfb-handle-valid) [165.868254] Starting subtest: getfb-handle-valid [165.869222] Subtest getfb-handle-valid: SUCCESS (0.000s) [165.974286] [040/131] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [166.072392] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [170.685307] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.614s) [170.817884] [041/131] (847s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [170.923880] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [174.030943] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (3.107s) [174.148575] [042/131] (844s left) gem_exec_reloc (basic-concurrent0) [174.208774] Subtest basic-concurrent0: SKIP (0.000s) [174.286836] [043/131] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [174.380652] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [177.035747] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.656s) [177.180688] [044/131] (841s left) gem_exec_reloc (basic-cpu-noreloc) [177.238508] Subtest basic-cpu-noreloc: SKIP (0.000s) [177.297156] [045/131] (841s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [177.398078] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [178.668054] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.270s) [178.909179] [046/131] (839s left) gem_basic (bad-close) [178.955930] Starting subtest: bad-close [178.957920] Subtest bad-close: SUCCESS (0.000s) [179.060182] [047/131] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [179.164607] Starting subtest: fbcpsr-rgb101010-draw-blt [183.811264] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.647s) [183.926982] [048/131] (834s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [184.014987] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [184.016060] Starting dynamic subtest: pipe-A-eDP-1 [184.025163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [184.032326] Starting dynamic subtest: pipe-B-eDP-1 [184.042938] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [184.049836] Starting dynamic subtest: pipe-C-eDP-1 [184.058963] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [184.065143] Starting dynamic subtest: pipe-D-eDP-1 [184.074237] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [184.075864] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [186.206298] [049/131] (832s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [186.288969] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [186.290076] Starting dynamic subtest: pipe-A-default-mode [187.459039] Dynamic subtest pipe-A-default-mode: SKIP (1.166s) [187.460728] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.168s) [187.594262] [050/131] (831s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [187.728033] Starting subtest: modeset-atomic-cursor-hotspot [187.729608] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [187.881724] [051/131] (830s left) gem_busy (busy) [187.944695] Starting subtest: busy [187.945873] Starting dynamic subtest: all-engines [188.010560] Dynamic subtest all-engines: SUCCESS (0.066s) [188.017515] Starting dynamic subtest: rcs0 [189.939837] Dynamic subtest rcs0: SUCCESS (1.927s) [189.948443] Starting dynamic subtest: bcs0 [189.985257] Dynamic subtest bcs0: SUCCESS (0.045s) [189.993728] Starting dynamic subtest: vcs0 [190.026839] Dynamic subtest vcs0: SUCCESS (0.039s) [190.034015] Starting dynamic subtest: vcs1 [191.919910] Dynamic subtest vcs1: SUCCESS (1.888s) [191.928696] Starting dynamic subtest: vecs0 [193.904224] Dynamic subtest vecs0: SUCCESS (1.984s) [193.912604] Starting dynamic subtest: ccs0 [195.951537] Dynamic subtest ccs0: SUCCESS (2.047s) [195.952614] Subtest busy: SUCCESS (8.005s) [196.290296] [052/131] (822s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [196.391068] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [201.520979] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.130s) [201.650244] [053/131] (817s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [201.766070] Starting subtest: psr-rgb565-draw-mmap-gtt [201.767732] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [201.869949] [054/131] (816s left) kms_chamelium_edid (dp-mode-timings) [202.250537] Subtest dp-mode-timings: SKIP (0.000s) [203.076228] [055/131] (815s left) gem_ctx_isolation (nonpriv) [203.138388] Starting subtest: nonpriv [203.139507] Starting dynamic subtest: rcs0 [203.681457] Dynamic subtest rcs0: SUCCESS (0.542s) [203.690197] Starting dynamic subtest: bcs0 [204.253450] Dynamic subtest bcs0: SUCCESS (0.572s) [204.262556] Starting dynamic subtest: vcs0 [204.803474] Dynamic subtest vcs0: SUCCESS (0.549s) [204.812667] Starting dynamic subtest: vcs1 [206.493269] Dynamic subtest vcs1: SUCCESS (1.689s) [206.500965] Starting dynamic subtest: vecs0 [208.446344] Dynamic subtest vecs0: SUCCESS (1.952s) [208.455621] Starting dynamic subtest: ccs0 [210.559075] Dynamic subtest ccs0: SUCCESS (2.113s) [210.560190] Subtest nonpriv: SUCCESS (7.421s) [210.814129] [056/131] (808s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [210.920680] Starting subtest: flip-primary-invalidate-overlay [223.346414] Subtest flip-primary-invalidate-overlay: SUCCESS (12.427s) [223.655407] [057/131] (795s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [225.193637] Starting subtest: modeset-lpsp-stress-no-wait [235.104346] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.912s) [235.177885] [058/131] (783s left) dumb_buffer (create-valid-dumb) [235.235779] Starting subtest: create-valid-dumb [235.236738] Subtest create-valid-dumb: SUCCESS (0.000s) [235.344348] [059/131] (783s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [235.443377] Starting subtest: modeset-transition-nonblocking-fencing [235.444299] Starting dynamic subtest: 1x-outputs [245.979373] Dynamic subtest 1x-outputs: SUCCESS (10.534s) [246.253797] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.810s) [247.096431] [060/131] (771s left) gem_mmap_gtt (cpuset-medium-copy-odd) [247.157929] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [247.216531] [061/131] (771s left) kms_cursor_crc (cursor-rapid-movement-256x85) [247.444804] Starting subtest: cursor-rapid-movement-256x85 [247.482484] Subtest cursor-rapid-movement-256x85: SKIP (0.036s) [247.661750] [062/131] (771s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [247.753868] Starting subtest: plane-upscale-20x20-with-pixel-format [247.754944] Starting dynamic subtest: pipe-A [248.803615] Dynamic subtest pipe-A: SUCCESS (1.049s) [248.810606] Starting dynamic subtest: pipe-B [250.904643] Dynamic subtest pipe-B: SUCCESS (2.100s) [250.912412] Starting dynamic subtest: pipe-C [252.096963] Dynamic subtest pipe-C: SUCCESS (1.192s) [252.104143] Starting dynamic subtest: pipe-D [253.219135] Dynamic subtest pipe-D: SUCCESS (1.122s) [253.220097] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.466s) [254.398667] [063/131] (764s left) gem_ctx_persistence (smoketest) [254.464317] Starting subtest: smoketest [294.921980] Subtest smoketest: SUCCESS (40.454s) [294.995112] [064/131] (724s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [300.060506] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [300.065234] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [300.897883] [065/131] (718s left) gem_exec_suspend (basic-s3) [300.959668] Starting subtest: basic-S3 [300.960770] Starting dynamic subtest: smem [323.930383] Dynamic subtest smem: SUCCESS (8.968s) [323.932231] Subtest basic-S3: SUCCESS (8.970s) [332.126907] [066/131] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [332.252871] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [332.254681] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [332.356863] [067/131] (708s left) gem_reg_read (bad-register) [332.405800] Starting subtest: bad-register [332.406787] Subtest bad-register: SUCCESS (0.000s) [332.504359] [068/131] (708s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [332.599699] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [339.928479] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.313s) [340.031825] [069/131] (701s left) gem_exec_fence (syncobj-unused-fence) [340.489525] Starting subtest: syncobj-unused-fence [340.493900] Subtest syncobj-unused-fence: SUCCESS (0.005s) [342.003880] [070/131] (699s left) syncobj_eventfd (invalid-bad-pad) [342.064754] Starting subtest: invalid-bad-pad [342.065774] Subtest invalid-bad-pad: SUCCESS (0.000s) [342.176342] [071/131] (699s left) gem_exec_reloc (basic-wc) [342.236847] Subtest basic-wc: SKIP (0.000s) [342.315920] [072/131] (699s left) kms_flip (2x-plain-flip-ts-check) [342.416377] Starting subtest: 2x-plain-flip-ts-check [342.427802] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [342.504119] [073/131] (698s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [342.598906] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [342.600176] Starting dynamic subtest: pipe-A-eDP-1 [342.624042] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [342.633857] Starting dynamic subtest: pipe-B-eDP-1 [342.659809] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [342.666987] Starting dynamic subtest: pipe-C-eDP-1 [342.688019] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [342.695156] Starting dynamic subtest: pipe-D-eDP-1 [342.717708] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [342.719419] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [344.737645] [074/131] (696s left) kms_psr2_su (page_flip-nv12) [344.793194] Subtest page_flip-NV12: SKIP (0.000s) [344.849924] [075/131] (696s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [344.942870] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [344.943978] Starting dynamic subtest: pipe-A [345.017888] Dynamic subtest pipe-A: SUCCESS (0.075s) [345.027707] Starting dynamic subtest: pipe-B [346.163404] Dynamic subtest pipe-B: SUCCESS (1.143s) [346.173241] Starting dynamic subtest: pipe-C [347.267932] Dynamic subtest pipe-C: SUCCESS (1.103s) [347.276027] Starting dynamic subtest: pipe-D [348.396157] Dynamic subtest pipe-D: SUCCESS (1.127s) [348.397151] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.451s) [349.541970] [076/131] (692s left) gem_userptr_blits (stress-mm) [349.612690] Starting subtest: stress-mm [354.985852] Subtest stress-mm: SUCCESS (5.369s) [355.128231] [077/131] (686s left) i915_hangman (gt-error-state-capture) [355.201640] Starting subtest: gt-error-state-capture [355.202755] Starting dynamic subtest: rcs0 [364.921927] Dynamic subtest rcs0: SUCCESS (9.714s) [364.932020] Starting dynamic subtest: bcs0 [376.888421] Dynamic subtest bcs0: SUCCESS (11.961s) [376.898811] Starting dynamic subtest: vcs0 [388.856837] Dynamic subtest vcs0: SUCCESS (11.962s) [388.867612] Starting dynamic subtest: vcs1 [399.865315] Dynamic subtest vcs1: SUCCESS (11.003s) [399.875654] Starting dynamic subtest: vecs0 [411.832230] Dynamic subtest vecs0: SUCCESS (11.961s) [411.842106] Starting dynamic subtest: ccs0 [422.905144] Dynamic subtest ccs0: SUCCESS (11.067s) [422.906682] Subtest gt-error-state-capture: SUCCESS (67.680s) [422.978769] [078/131] (618s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [423.072782] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [423.074176] Starting dynamic subtest: pipe-A-eDP-1 [457.575817] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.169s) [457.584808] Starting dynamic subtest: pipe-B-eDP-1 [491.134386] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.571s) [491.144567] Starting dynamic subtest: pipe-C-eDP-1 [524.097154] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.433s) [524.105988] Starting dynamic subtest: pipe-D-eDP-1 [562.437623] Dynamic subtest pipe-D-eDP-1: SUCCESS (8.778s) [562.438554] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (20.956s) [571.610945] [079/131] (596s left) gem_eio (in-flight-immediate) [571.795662] Starting subtest: in-flight-immediate [579.644428] Subtest in-flight-immediate: SUCCESS (7.847s) [579.813529] [080/131] (588s left) gem_userptr_blits (dmabuf-sync) [579.882961] Starting subtest: dmabuf-sync [579.886697] Subtest dmabuf-sync: SKIP (0.002s) [580.020274] [081/131] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [580.122249] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [580.124113] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [580.229907] [082/131] (588s left) kms_atomic_interruptible (atomic-setmode) [580.334258] Starting subtest: atomic-setmode [580.363262] Starting dynamic subtest: pipe-A-eDP-1 [587.220452] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.883s) [587.221451] Subtest atomic-setmode: SUCCESS (6.885s) [588.075602] [083/131] (580s left) gem_exec_schedule (u-lateslice) [588.143850] Starting subtest: u-lateslice [588.144897] Starting dynamic subtest: rcs0 [588.162806] Dynamic subtest rcs0: SUCCESS (0.019s) [588.171483] Starting dynamic subtest: bcs0 [588.180048] Dynamic subtest bcs0: SUCCESS (0.017s) [588.188141] Starting dynamic subtest: vcs0 [588.197770] Dynamic subtest vcs0: SUCCESS (0.017s) [588.205462] Starting dynamic subtest: vcs1 [588.215240] Dynamic subtest vcs1: SUCCESS (0.017s) [588.224111] Starting dynamic subtest: vecs0 [588.233351] Dynamic subtest vecs0: SUCCESS (0.017s) [588.249024] Starting dynamic subtest: ccs0 [588.252811] Dynamic subtest ccs0: SUCCESS (0.020s) [588.253702] Subtest u-lateslice: SUCCESS (0.109s) [589.413218] [084/131] (578s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [589.466512] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [589.526933] [085/131] (578s left) kms_psr (psr2-sprite-plane-move) [589.629889] Starting subtest: psr2-sprite-plane-move [589.630848] Starting dynamic subtest: eDP-1 [591.397927] Dynamic subtest eDP-1: SUCCESS (1.768s) [591.398798] Subtest psr2-sprite-plane-move: SUCCESS (1.769s) [592.235791] [086/131] (576s left) syncobj_wait (single-wait-all-for-submit-signaled) [592.295835] Starting subtest: single-wait-all-for-submit-signaled [592.296900] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [592.409168] [087/131] (576s left) kms_psr (fbc-psr-primary-mmap-gtt) [592.502728] Starting subtest: fbc-psr-primary-mmap-gtt [592.503719] Starting dynamic subtest: eDP-1 [592.505448] Dynamic subtest eDP-1: SKIP (0.000s) [592.507187] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [592.568712] [088/131] (575s left) gem_mmap (big-bo) [592.627549] Subtest big-bo: SKIP (0.000s) [592.689006] [089/131] (575s left) kms_flip (flip-vs-fences) [592.787456] Starting subtest: flip-vs-fences [592.789250] Subtest flip-vs-fences: SKIP (0.000s) [592.907783] [090/131] (575s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [592.962690] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [592.964712] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [593.138388] [091/131] (575s left) gem_exec_balancer (waits) [593.194488] Starting subtest: waits [599.577493] Subtest waits: SUCCESS (6.378s) [599.876627] [092/131] (568s left) gen9_exec_parse (shadow-peek) [599.947641] Subtest shadow-peek: SKIP (0.000s) [600.023366] [093/131] (568s left) gem_fence_thrash (bo-copy) [600.053601] Starting subtest: bo-copy [600.080416] Subtest bo-copy: SKIP (0.026s) [600.136220] [094/131] (568s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [600.239109] Starting subtest: psr-farfromfence-mmap-gtt [600.240721] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [600.348839] [095/131] (568s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [600.451165] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [601.732361] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.281s) [601.933897] [096/131] (566s left) kms_content_protection (mei-interface) [602.112621] Starting subtest: mei-interface [602.114782] Subtest mei-interface: SKIP (0.001s) [602.265796] [097/131] (566s left) gem_mmap_gtt (fault-concurrent) [602.323804] Subtest fault-concurrent: SKIP (0.000s) [602.386661] [098/131] (566s left) api_intel_allocator (open-vm) [602.445836] Starting subtest: open-vm [602.447482] Subtest open-vm: SUCCESS (0.003s) [602.562937] [099/131] (566s left) dmabuf_sync_file (import-multiple-read-write) [602.608129] Starting subtest: import-multiple-read-write [602.611025] Subtest import-multiple-read-write: SUCCESS (0.003s) [602.660238] [100/131] (566s left) syncobj_basic (bad-handle-to-fd) [602.715141] Starting subtest: bad-handle-to-fd [602.716255] Subtest bad-handle-to-fd: SUCCESS (0.000s) [602.822869] [101/131] (566s left) gem_exec_create (basic) [602.898054] Starting subtest: basic [602.899312] Starting dynamic subtest: smem [606.289312] Dynamic subtest smem: SUCCESS (3.387s) [606.290681] Subtest basic: SUCCESS (3.389s) [606.468935] [102/131] (562s left) gem_exec_await (wide-contexts) [606.694970] Starting subtest: wide-contexts [632.304792] Subtest wide-contexts: SUCCESS (25.613s) [632.493246] [103/131] (536s left) kms_psr (fbc-pr-cursor-plane-move) [632.615551] Starting subtest: fbc-pr-cursor-plane-move [632.617327] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [632.683811] [104/131] (536s left) kms_psr (pr-sprite-render) [632.783684] Starting subtest: pr-sprite-render [632.785405] Subtest pr-sprite-render: SKIP (0.000s) [632.850602] [105/131] (536s left) kms_big_fb (y-tiled-16bpp-rotate-180) [632.956152] Starting subtest: y-tiled-16bpp-rotate-180 [632.958113] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [633.070789] [106/131] (535s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [633.179351] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [633.181331] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [633.282875] [107/131] (535s left) gem_ringfill (basic-all) [639.317151] Starting subtest: basic-all [640.498161] Subtest basic-all: SUCCESS (1.178s) [640.650217] [108/131] (528s left) kms_flip (2x-flip-vs-dpms) [640.746621] Starting subtest: 2x-flip-vs-dpms [640.757972] Subtest 2x-flip-vs-dpms: SKIP (0.011s) [640.848366] [109/131] (528s left) syncobj_timeline (wait-all-interrupted) [640.912169] Starting subtest: wait-all-interrupted [641.017282] Subtest wait-all-interrupted: SUCCESS (0.102s) [641.088778] [110/131] (528s left) kms_big_fb (x-tiled-16bpp-rotate-0) [641.184162] Starting subtest: x-tiled-16bpp-rotate-0 [642.616933] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.433s) [642.836072] [111/131] (526s left) kms_plane (plane-position-hole-dpms) [642.944190] Starting subtest: plane-position-hole-dpms [643.470195] Starting dynamic subtest: pipe-A-plane-1 [645.701242] Dynamic subtest pipe-A-plane-1: SUCCESS (2.230s) [645.709844] Starting dynamic subtest: pipe-A-plane-2 [647.956151] Dynamic subtest pipe-A-plane-2: SUCCESS (2.253s) [647.965904] Starting dynamic subtest: pipe-A-plane-3 [650.211510] Dynamic subtest pipe-A-plane-3: SUCCESS (2.255s) [650.227774] Starting dynamic subtest: pipe-A-plane-4 [652.477150] Dynamic subtest pipe-A-plane-4: SUCCESS (2.265s) [652.485724] Starting dynamic subtest: pipe-A-plane-5 [652.516224] Dynamic subtest pipe-A-plane-5: SUCCESS (0.038s) [653.639518] Starting dynamic subtest: pipe-B-plane-1 [655.892215] Dynamic subtest pipe-B-plane-1: SUCCESS (2.259s) [655.900775] Starting dynamic subtest: pipe-B-plane-2 [658.122004] Dynamic subtest pipe-B-plane-2: SUCCESS (2.230s) [658.131717] Starting dynamic subtest: pipe-B-plane-3 [660.375800] Dynamic subtest pipe-B-plane-3: SUCCESS (2.253s) [660.385739] Starting dynamic subtest: pipe-B-plane-4 [662.610142] Dynamic subtest pipe-B-plane-4: SUCCESS (2.232s) [662.619045] Starting dynamic subtest: pipe-B-plane-5 [662.650061] Dynamic subtest pipe-B-plane-5: SUCCESS (0.039s) [662.651066] Subtest plane-position-hole-dpms: SUCCESS (19.701s) [663.433139] [112/131] (505s left) syncobj_timeline (invalid-signal-bad-pad) [663.485412] Starting subtest: invalid-signal-bad-pad [663.486510] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [663.578494] [113/131] (505s left) gem_exec_params (no-bsd) [663.632277] Starting subtest: no-bsd [663.634309] Subtest no-bsd: SUCCESS (0.002s) [665.344841] [114/131] (504s left) kms_color (ctm-0-75) [665.438299] Starting subtest: ctm-0-75 [665.439442] Starting dynamic subtest: pipe-A-eDP-1 [670.119887] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.680s) [670.136344] Starting dynamic subtest: pipe-B-eDP-1 [675.459030] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.336s) [675.468646] Starting dynamic subtest: pipe-C-eDP-1 [680.688743] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.231s) [680.698101] Starting dynamic subtest: pipe-D-eDP-1 [685.996148] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.308s) [685.997112] Subtest ctm-0-75: SUCCESS (20.557s) [686.845748] [115/131] (482s left) gem_mmap_gtt (big-copy-odd) [686.903962] Subtest big-copy-odd: SKIP (0.000s) [686.963131] [116/131] (482s left) gem_ctx_persistence (engines-hostile-preempt) [687.020437] Starting subtest: engines-hostile-preempt [687.021435] Starting dynamic subtest: rcs0 [687.130210] Dynamic subtest rcs0: SUCCESS (0.109s) [687.141694] Starting dynamic subtest: bcs0 [687.206340] Dynamic subtest bcs0: SUCCESS (0.074s) [687.217275] Starting dynamic subtest: vcs0 [688.323408] Dynamic subtest vcs0: SUCCESS (1.113s) [688.333147] Starting dynamic subtest: vcs1 [690.303444] Dynamic subtest vcs1: SUCCESS (1.978s) [690.314724] Starting dynamic subtest: vecs0 [692.287280] Dynamic subtest vecs0: SUCCESS (1.982s) [692.297936] Starting dynamic subtest: ccs0 [692.341810] Dynamic subtest ccs0: SUCCESS (0.055s) [692.343134] Subtest engines-hostile-preempt: SUCCESS (5.322s) [692.475358] [117/131] (476s left) gem_exec_balancer (full-late-pulse) [692.543673] Starting subtest: full-late-pulse [697.100913] Subtest full-late-pulse: SUCCESS (4.557s) [697.413747] [118/131] (472s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [697.472638] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [697.581182] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [697.651620] [119/131] (471s left) gem_exec_schedule (preempt-other-chain) [697.723788] Starting subtest: preempt-other-chain [697.725014] Starting dynamic subtest: rcs0 [697.866306] Dynamic subtest rcs0: SUCCESS (0.140s) [697.877793] Starting dynamic subtest: bcs0 [697.997029] Dynamic subtest bcs0: SUCCESS (0.131s) [698.011181] Starting dynamic subtest: vcs0 [698.125427] Dynamic subtest vcs0: SUCCESS (0.127s) [698.136465] Starting dynamic subtest: vcs1 [698.254767] Dynamic subtest vcs1: SUCCESS (0.128s) [698.266055] Starting dynamic subtest: vecs0 [698.382377] Dynamic subtest vecs0: SUCCESS (0.127s) [698.393091] Starting dynamic subtest: ccs0 [698.511943] Dynamic subtest ccs0: SUCCESS (0.129s) [698.513310] Subtest preempt-other-chain: SUCCESS (0.786s) [699.386660] [120/131] (470s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [699.486255] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [699.487124] Starting dynamic subtest: pipe-A-default-mode [699.774546] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [699.776515] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.287s) [700.569888] [121/131] (469s left) gem_exec_params (sol-reset-invalid) [700.629363] Starting subtest: sol-reset-invalid [700.631951] Subtest sol-reset-invalid: SUCCESS (0.002s) [702.373893] [122/131] (467s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [702.467261] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [702.468305] Starting dynamic subtest: pipe-A-eDP-1 [702.477215] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [702.485992] Starting dynamic subtest: pipe-B-eDP-1 [702.494791] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [702.503461] Starting dynamic subtest: pipe-C-eDP-1 [702.511822] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [702.519781] Starting dynamic subtest: pipe-D-eDP-1 [702.528441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [702.530183] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s) [704.622182] [123/131] (465s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [704.668738] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [704.720329] [124/131] (464s left) core_getversion (basic) [704.753286] Starting subtest: basic [704.755003] Subtest basic: SUCCESS (0.000s) [704.813262] [125/131] (464s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [704.904202] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [704.906206] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [705.008710] [126/131] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [705.101911] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [705.103667] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [705.199899] [127/131] (464s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [705.303322] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [705.305422] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [706.456561] [128/131] (463s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [706.553251] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [709.564857] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.012s) [709.706931] [129/131] (460s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [709.760122] Starting subtest: invalid-bsd1-flag-on-vebox [709.761289] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [709.858827] [130/131] (460s left) gem_eio (create-ext) [710.078711] Starting subtest: create-ext [710.407314] Subtest create-ext: SUCCESS (0.330s) [710.560446] [131/131] (459s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [710.604248] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [710.605358] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [710.688035] Closing watchdogs Done.