[59.699338] Initializing watchdogs [59.699382] /dev/watchdog0 [59.713163] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.717321] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.720158] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.723590] [001/132] (960s left) syncobj_timeline (invalid-signal-illegal-handle) [59.795859] Starting subtest: invalid-signal-illegal-handle [59.798275] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [59.901195] [002/132] (960s left) fbdev (write) [59.946111] Starting subtest: write [60.336370] Subtest write: SUCCESS (0.388s) [60.395947] [003/132] (959s left) gem_mmap (big-bo) [60.454034] Subtest big-bo: SKIP (0.000s) [60.514249] [004/132] (959s left) kms_chamelium_edid (dp-mode-timings) [60.904067] Subtest dp-mode-timings: SKIP (0.000s) [61.700584] [005/132] (958s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [61.751292] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [61.808585] [006/132] (958s left) gem_ctx_persistence (idempotent) [61.860714] Starting subtest: idempotent [61.863260] Subtest idempotent: SUCCESS (0.000s) [61.954697] [007/132] (958s left) kms_psr (fbc-psr-cursor-render) [62.057313] Starting subtest: fbc-psr-cursor-render [62.059656] Starting dynamic subtest: eDP-1 [62.064639] Dynamic subtest eDP-1: SKIP (0.000s) [62.069068] Subtest fbc-psr-cursor-render: SKIP (0.000s) [62.139861] [008/132] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [62.254079] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [62.258059] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [62.375546] [009/132] (958s left) gem_ringfill (basic-all) [67.927883] Starting subtest: basic-all [69.102751] Subtest basic-all: SUCCESS (1.173s) [69.233111] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true [69.236511] [010/132] (951s left) kms_psr (pr-basic) [69.336971] Starting subtest: pr-basic [69.341437] Subtest pr-basic: SKIP (0.000s) [69.411830] [011/132] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [69.497656] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [69.501804] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [69.590520] [012/132] (951s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [69.678360] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [69.680351] Starting dynamic subtest: pipe-A-eDP-1 [86.506908] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.534s) [86.515425] Starting dynamic subtest: pipe-B-eDP-1 [103.472844] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.428s) [103.482297] Starting dynamic subtest: pipe-C-eDP-1 [120.453862] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.457s) [120.470049] Starting dynamic subtest: pipe-D-eDP-1 [137.440724] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.322s) [137.443122] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.744s) [138.667833] [013/132] (882s left) i915_hangman (hangcheck-unterminated) [138.732428] Starting subtest: hangcheck-unterminated [149.852040] Subtest hangcheck-unterminated: SUCCESS (11.088s) [149.969652] [014/132] (870s left) gem_lmem_swapping (massive) [150.022171] Subtest massive: SKIP (0.000s) [150.067280] [015/132] (870s left) kms_psr (fbc-psr2-primary-mmap-gtt) [150.153845] Starting subtest: fbc-psr2-primary-mmap-gtt [150.156201] Starting dynamic subtest: eDP-1 [150.160535] Dynamic subtest eDP-1: SKIP (0.000s) [150.164920] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s) [150.226620] [016/132] (870s left) syncobj_wait (wait-any-complex) [150.280844] Starting subtest: wait-any-complex [150.341776] Subtest wait-any-complex: SUCCESS (0.062s) [150.427269] [017/132] (870s left) kms_cursor_crc (cursor-rapid-movement-max-size) [150.716516] Starting subtest: cursor-rapid-movement-max-size [150.723085] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [150.839885] [018/132] (870s left) perf_pmu (busy-double-start) [150.884739] Starting subtest: busy-double-start [150.886634] Starting dynamic subtest: rcs0 [154.454249] Dynamic subtest rcs0: SUCCESS (3.564s) [154.464824] Starting dynamic subtest: bcs0 [158.020305] Dynamic subtest bcs0: SUCCESS (3.562s) [158.030917] Starting dynamic subtest: vcs0 [162.360139] Dynamic subtest vcs0: SUCCESS (4.336s) [162.370158] Starting dynamic subtest: vcs1 [166.409790] Dynamic subtest vcs1: SUCCESS (4.046s) [166.420792] Starting dynamic subtest: vecs0 [170.426260] Dynamic subtest vecs0: SUCCESS (4.014s) [170.437023] Starting dynamic subtest: ccs0 [174.064782] Dynamic subtest ccs0: FAIL (3.579s) [174.067135] Subtest busy-double-start: FAIL (23.107s) [174.107784] [019/132] (846s left) gen9_exec_parse (valid-registers) [174.176302] Subtest valid-registers: SKIP (0.000s) [174.256690] [020/132] (846s left) gem_exec_fence (basic-await) [174.438076] Starting subtest: basic-await [174.440694] Starting dynamic subtest: rcs0 [174.517841] Dynamic subtest rcs0: SUCCESS (0.079s) [174.532121] Starting dynamic subtest: bcs0 [174.593861] Dynamic subtest bcs0: SUCCESS (0.076s) [174.605000] Starting dynamic subtest: vcs0 [174.667405] Dynamic subtest vcs0: SUCCESS (0.072s) [174.678997] Starting dynamic subtest: vcs1 [174.741815] Dynamic subtest vcs1: SUCCESS (0.074s) [174.752948] Starting dynamic subtest: vecs0 [174.815824] Dynamic subtest vecs0: SUCCESS (0.073s) [174.827036] Starting dynamic subtest: ccs0 [174.892317] Dynamic subtest ccs0: SUCCESS (0.076s) [174.895067] Subtest basic-await: SUCCESS (0.455s) [176.973998] [021/132] (844s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [177.080745] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [177.085004] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [177.170278] [022/132] (843s left) kms_content_protection (atomic) [177.310884] Starting subtest: atomic [177.315488] Subtest atomic: SKIP (0.000s) [177.446291] [023/132] (843s left) syncobj_eventfd (timeline-wait) [177.503548] Starting subtest: timeline-wait [177.512847] Subtest timeline-wait: SUCCESS (0.011s) [177.597938] [024/132] (843s left) gem_exec_await (wide-all) [177.771784] Starting subtest: wide-all [200.747116] Subtest wide-all: SUCCESS (22.968s) [200.957260] [025/132] (820s left) kms_chamelium_hpd (vga-hpd-after-suspend) [201.398704] Subtest vga-hpd-after-suspend: SKIP (0.000s) [202.229612] [026/132] (818s left) gem_exec_params (invalid-fence-in) [202.287647] Starting subtest: invalid-fence-in [202.290013] Subtest invalid-fence-in: SUCCESS (0.000s) [202.377282] [027/132] (818s left) gem_exec_balancer (nop) [202.447975] Starting subtest: nop [249.012955] Subtest nop: SUCCESS (46.558s) [249.318540] [028/132] (771s left) gem_mmap_gtt (fault-concurrent-y) [249.382414] Subtest fault-concurrent-Y: SKIP (0.000s) [249.442344] [029/132] (771s left) gem_fenced_exec_thrash (2-spare-fences) [249.506190] Subtest 2-spare-fences: SKIP (0.000s) [249.584180] [030/132] (771s left) gen7_exec_parse (batch-without-end) [249.657125] Subtest batch-without-end: SKIP (0.000s) [249.716198] [031/132] (771s left) sw_sync (sync_busy_fork) [249.768913] Starting subtest: sync_busy_fork [250.783072] Subtest sync_busy_fork: SUCCESS (1.012s) [250.846944] [032/132] (770s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [250.945029] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [250.947430] Starting dynamic subtest: pipe-A-default-mode [252.116886] Dynamic subtest pipe-A-default-mode: SKIP (1.170s) [252.120795] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.171s) [252.259567] [033/132] (769s left) kms_big_fb (linear-32bpp-rotate-90) [252.373100] Starting subtest: linear-32bpp-rotate-90 [252.392975] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [252.514864] [034/132] (769s left) gem_pxp (create-regular-context-2) [252.639206] Starting subtest: create-regular-context-2 [252.641679] Subtest create-regular-context-2: SUCCESS (0.002s) [252.756366] [035/132] (768s left) kms_pm_backlight (bad-brightness) [252.854209] Starting subtest: bad-brightness [252.927112] Starting dynamic subtest: eDP-1 [253.235923] Dynamic subtest eDP-1: SUCCESS (0.307s) [253.238469] Subtest bad-brightness: SUCCESS (0.383s) [254.120942] [036/132] (767s left) kms_flip (2x-nonexisting-fb-interruptible) [254.226963] Starting subtest: 2x-nonexisting-fb-interruptible [254.236599] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s) [254.312926] [037/132] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [254.401295] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [261.026238] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.628s) [261.168312] [038/132] (760s left) gem_create (create-clear) [261.232908] Starting subtest: create-clear [261.235337] Starting dynamic subtest: smem0 [293.967859] Dynamic subtest smem0: SUCCESS (32.729s) [293.969905] Subtest create-clear: SUCCESS (32.730s) [294.158463] [039/132] (727s left) kms_draw_crc (draw-method-pwrite) [294.260981] Starting subtest: draw-method-pwrite [294.263026] Starting dynamic subtest: xrgb8888-untiled [294.892464] Dynamic subtest xrgb8888-untiled: SUCCESS (0.633s) [294.901744] Starting dynamic subtest: rgb565-untiled [295.392708] Dynamic subtest rgb565-untiled: SUCCESS (0.499s) [295.403339] Starting dynamic subtest: xrgb2101010-untiled [295.993688] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.600s) [296.003936] Starting dynamic subtest: xbgr16161616f-untiled [296.804361] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.811s) [296.813377] Starting dynamic subtest: xrgb8888-xtiled [298.915852] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.110s) [298.925687] Starting dynamic subtest: rgb565-xtiled [300.249565] Dynamic subtest rgb565-xtiled: SUCCESS (1.333s) [300.259451] Starting dynamic subtest: xrgb2101010-xtiled [302.294271] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.043s) [302.303689] Starting dynamic subtest: xbgr16161616f-xtiled [305.884323] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.588s) [305.896886] Starting dynamic subtest: xrgb8888-4tiled [307.173406] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.288s) [307.184321] Starting dynamic subtest: rgb565-4tiled [307.829180] Dynamic subtest rgb565-4tiled: SUCCESS (0.655s) [307.838392] Starting dynamic subtest: xrgb2101010-4tiled [309.086030] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.254s) [309.096539] Starting dynamic subtest: xbgr16161616f-4tiled [312.352465] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.265s) [312.354804] Subtest draw-method-pwrite: SUCCESS (18.089s) [312.444703] [040/132] (709s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [312.545671] Starting subtest: compare-crc-sanitycheck-nv12 [312.548003] Starting dynamic subtest: pipe-A-eDP-1 [313.287616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [313.297015] Starting dynamic subtest: pipe-B-eDP-1 [314.523449] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s) [314.533827] Starting dynamic subtest: pipe-C-eDP-1 [315.702903] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.178s) [315.713385] Starting dynamic subtest: pipe-D-eDP-1 [316.962124] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s) [316.964619] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.416s) [317.784461] [041/132] (704s left) gem_ctx_shared (exec-shared-gtt) [317.840682] Starting subtest: exec-shared-gtt [317.843059] Starting dynamic subtest: rcs0 [317.849468] Dynamic subtest rcs0: SUCCESS (0.008s) [317.859293] Starting dynamic subtest: bcs0 [317.861492] Dynamic subtest bcs0: SUCCESS (0.005s) [317.870262] Starting dynamic subtest: vcs0 [317.872612] Dynamic subtest vcs0: SUCCESS (0.007s) [317.881735] Starting dynamic subtest: vcs1 [317.884177] Dynamic subtest vcs1: SUCCESS (0.007s) [317.892689] Starting dynamic subtest: vecs0 [317.894919] Dynamic subtest vecs0: SUCCESS (0.005s) [317.903721] Starting dynamic subtest: ccs0 [317.905983] Dynamic subtest ccs0: SUCCESS (0.006s) [317.908290] Subtest exec-shared-gtt: SUCCESS (0.042s) [318.068165] [042/132] (703s left) syncobj_timeline (single-wait-all-signaled) [318.131643] Starting subtest: single-wait-all-signaled [318.133666] Subtest single-wait-all-signaled: SUCCESS (0.001s) [318.235147] [043/132] (703s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [318.327756] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [318.331896] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [318.432786] [044/132] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [318.528432] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [319.484774] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s) [319.611414] [045/132] (702s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [319.728513] Starting subtest: short-busy-flip-before-cursor-toggle [319.732995] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [319.885924] [046/132] (702s left) gem_exec_reloc (basic-range-active) [319.945164] Subtest basic-range-active: SKIP (0.000s) [320.015753] [047/132] (702s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs) [320.104649] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs [320.106989] Starting dynamic subtest: pipe-A-eDP-1 [320.128553] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [320.138445] Starting dynamic subtest: pipe-B-eDP-1 [320.159294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [320.167329] Starting dynamic subtest: pipe-C-eDP-1 [320.187161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [320.195559] Starting dynamic subtest: pipe-D-eDP-1 [320.215456] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [320.218936] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s) [322.272927] [048/132] (699s left) kms_atomic_interruptible (universal-setplane-cursor) [322.359080] Starting subtest: universal-setplane-cursor [322.361312] Starting dynamic subtest: pipe-A-eDP-1 [329.780535] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s) [329.782969] Subtest universal-setplane-cursor: SUCCESS (7.421s) [330.641274] [049/132] (691s left) perf_pmu (render-node-busy-idle) [330.708790] Starting subtest: render-node-busy-idle [330.711136] Starting dynamic subtest: rcs0 [331.391527] Dynamic subtest rcs0: SUCCESS (0.682s) [331.406141] Starting dynamic subtest: bcs0 [332.055135] Dynamic subtest bcs0: SUCCESS (0.661s) [332.066635] Starting dynamic subtest: vcs0 [333.883864] Dynamic subtest vcs0: SUCCESS (1.825s) [333.894686] Starting dynamic subtest: vcs1 [335.867434] Dynamic subtest vcs1: SUCCESS (1.981s) [335.877919] Starting dynamic subtest: vecs0 [337.916504] Dynamic subtest vecs0: SUCCESS (2.046s) [337.928136] Starting dynamic subtest: ccs0 [338.593721] Dynamic subtest ccs0: SUCCESS (0.676s) [338.596434] Subtest render-node-busy-idle: SUCCESS (7.883s) [338.670605] [050/132] (683s left) kms_vblank (query-busy) [338.775132] Starting subtest: query-busy [338.777401] Starting dynamic subtest: pipe-A-eDP-1 [340.660909] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [340.676404] Starting dynamic subtest: pipe-D-eDP-1 [343.209586] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s) [343.211845] Subtest query-busy: SUCCESS (4.434s) [344.014309] [051/132] (678s left) core_getversion (basic) [344.058469] Starting subtest: basic [344.062911] Subtest basic: SUCCESS (0.000s) [344.138654] [052/132] (678s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [344.250440] Starting subtest: basic-busy-flip-before-cursor-varying-size [344.254856] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [344.391046] [053/132] (677s left) kms_properties (crtc-properties-legacy) [344.481364] Starting subtest: crtc-properties-legacy [344.483197] Starting dynamic subtest: pipe-A-eDP-1 [344.926067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s) [344.938661] Starting dynamic subtest: pipe-B-eDP-1 [346.082798] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s) [346.092933] Starting dynamic subtest: pipe-C-eDP-1 [347.199729] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s) [347.210894] Starting dynamic subtest: pipe-D-eDP-1 [348.340791] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s) [348.342917] Subtest crtc-properties-legacy: SUCCESS (3.858s) [349.156803] [054/132] (673s left) kms_frontbuffer_tracking (fbc-stridechange) [349.256953] Starting subtest: fbc-stridechange [352.539193] Subtest fbc-stridechange: SUCCESS (3.285s) [353.671446] [055/132] (668s left) prime_vgem (basic-fence-read) [353.742997] Starting subtest: basic-fence-read [353.760156] Subtest basic-fence-read: SKIP (0.017s) [353.879351] [056/132] (668s left) kms_psr (fbc-pr-cursor-mmap-gtt) [353.980139] Starting subtest: fbc-pr-cursor-mmap-gtt [353.984589] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [354.063006] [057/132] (668s left) syncobj_wait (wait-for-submit-delayed-submit) [354.124523] Starting subtest: wait-for-submit-delayed-submit [354.228856] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [354.305788] [058/132] (668s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [354.426275] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [354.428575] Starting dynamic subtest: pipe-A-default-mode [357.208197] Dynamic subtest pipe-A-default-mode: SUCCESS (2.779s) [357.210358] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.781s) [358.073839] [059/132] (664s left) gem_exec_flush (basic-uc-rw-default) [358.138767] Starting subtest: basic-uc-rw-default [363.591461] Subtest basic-uc-rw-default: SUCCESS (5.453s) [363.789929] [060/132] (658s left) kms_flip (2x-blocking-absolute-wf_vblank) [363.898175] Starting subtest: 2x-blocking-absolute-wf_vblank [363.907312] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [363.984671] [061/132] (658s left) kms_cursor_crc (cursor-onscreen-128x128) [364.182894] Starting subtest: cursor-onscreen-128x128 [364.187804] Starting dynamic subtest: pipe-A-eDP-1 [366.311471] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s) [366.340681] Starting dynamic subtest: pipe-D-eDP-1 [369.052458] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.721s) [369.054768] Subtest cursor-onscreen-128x128: SUCCESS (4.870s) [369.860952] [062/132] (652s left) kms_pm_rpm (dpms-mode-unset-lpsp) [372.095667] Starting subtest: dpms-mode-unset-lpsp [376.133427] Subtest dpms-mode-unset-lpsp: SUCCESS (4.042s) [376.509117] [063/132] (646s left) i915_pm_rps (thresholds-idle-park) [376.570021] Starting subtest: thresholds-idle-park [376.574366] Subtest thresholds-idle-park: SKIP (0.001s) [376.672246] [064/132] (646s left) gem_exec_reloc (basic-active) [376.727248] Subtest basic-active: SKIP (0.000s) [376.792424] [065/132] (646s left) api_intel_bb (reset-flags) [376.853223] Starting subtest: reset-flags [376.857706] Subtest reset-flags: SUCCESS (0.006s) [376.981345] [066/132] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [377.074316] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [377.078912] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [377.158474] [067/132] (645s left) kms_color_pipeline (plane-lut1d-lut1d) [377.255423] Starting subtest: plane-lut1d-lut1d [377.379162] Starting dynamic subtest: pipe-A-plane-0 [377.533745] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [377.542993] Starting dynamic subtest: pipe-A-plane-1 [377.667048] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [377.676682] Starting dynamic subtest: pipe-A-plane-2 [377.800641] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [378.988350] Starting dynamic subtest: pipe-B-plane-0 [379.125265] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [379.134721] Starting dynamic subtest: pipe-B-plane-1 [379.280449] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [379.290887] Starting dynamic subtest: pipe-B-plane-2 [379.414007] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [380.627892] Starting dynamic subtest: pipe-C-plane-0 [380.751219] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [380.761217] Starting dynamic subtest: pipe-C-plane-1 [380.884864] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s) [380.894884] Starting dynamic subtest: pipe-C-plane-2 [381.020961] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [382.156594] Starting dynamic subtest: pipe-D-plane-0 [382.282201] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [382.292056] Starting dynamic subtest: pipe-D-plane-1 [382.415269] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s) [382.424855] Starting dynamic subtest: pipe-D-plane-2 [382.548729] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [382.837647] Subtest plane-lut1d-lut1d: SUCCESS (5.585s) [383.649385] [068/132] (639s left) gem_softpin (noreloc-interruptible) [383.720857] Starting subtest: noreloc-interruptible [389.140942] Subtest noreloc-interruptible: SUCCESS (5.419s) [389.290469] [069/132] (633s left) gem_exec_fence (long-history) [389.758588] Starting subtest: long-history [396.617820] Subtest long-history: SUCCESS (6.861s) [397.283122] [070/132] (625s left) kms_addfb_basic (size-max) [397.387809] Starting subtest: size-max [397.389858] Subtest size-max: SUCCESS (0.000s) [397.476520] [071/132] (625s left) prime_vgem (basic-write) [397.555505] Starting subtest: basic-write [397.567376] Subtest basic-write: SKIP (0.009s) [397.666427] [072/132] (625s left) kms_getfb (getfb-handle-protection) [397.755006] Starting subtest: getfb-handle-protection [397.774210] Subtest getfb-handle-protection: SUCCESS (0.020s) [397.882293] [073/132] (625s left) gem_exec_params (invalid-ring) [397.939793] Starting subtest: invalid-ring [397.942205] Subtest invalid-ring: SUCCESS (0.000s) [398.045964] [074/132] (625s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [398.096846] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [398.156173] [075/132] (625s left) kms_big_fb (x-tiled-32bpp-rotate-0) [398.243014] Starting subtest: x-tiled-32bpp-rotate-0 [399.733700] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.490s) [399.865585] [076/132] (623s left) kms_psr (psr-primary-mmap-cpu) [399.986381] Starting subtest: psr-primary-mmap-cpu [399.988308] Starting dynamic subtest: eDP-1 [401.719539] Dynamic subtest eDP-1: SUCCESS (1.730s) [401.721861] Subtest psr-primary-mmap-cpu: SUCCESS (1.731s) [402.578927] [077/132] (620s left) gem_exec_params (rel-constants-invalid) [402.637946] Starting subtest: rel-constants-invalid [402.640831] Subtest rel-constants-invalid: SUCCESS (0.000s) [402.754725] [078/132] (620s left) kms_plane_multiple (2x-tiling-x) [402.844517] Starting subtest: 2x-tiling-x [402.848681] Subtest 2x-tiling-x: SKIP (0.000s) [402.917735] [079/132] (620s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [403.027252] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [403.031647] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [403.156512] [080/132] (620s left) kms_async_flips (test-time-stamp-atomic) [403.258213] Starting subtest: test-time-stamp-atomic [403.638797] Starting dynamic subtest: pipe-A-eDP-1 [404.396411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s) [404.789517] Starting dynamic subtest: pipe-B-eDP-1 [405.535009] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.751s) [405.937474] Starting dynamic subtest: pipe-C-eDP-1 [406.672788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.747s) [407.051520] Starting dynamic subtest: pipe-D-eDP-1 [407.806594] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.761s) [407.809023] Subtest test-time-stamp-atomic: SUCCESS (4.549s) [408.965127] [081/132] (614s left) kms_flip (flip-vs-modeset-vs-hang) [409.061066] Starting subtest: flip-vs-modeset-vs-hang [409.063641] Starting dynamic subtest: A-eDP1 [460.373357] Dynamic subtest A-eDP1: SUCCESS (51.308s) [460.386914] Starting dynamic subtest: D-eDP1 [510.357340] Dynamic subtest D-eDP1: SUCCESS (49.971s) [510.360026] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.285s) [510.732892] [082/132] (512s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [510.841800] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [510.845948] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [510.951788] [083/132] (512s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [511.013078] Starting subtest: yf-tiled-ccs-to-x-tiled [511.017542] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [511.209579] [084/132] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [511.311870] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [511.316356] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [511.409257] [085/132] (512s left) kms_psr (psr2-primary-blt) [511.499134] Starting subtest: psr2-primary-blt [511.501407] Starting dynamic subtest: eDP-1 [513.215621] Dynamic subtest eDP-1: SUCCESS (1.715s) [513.217901] Subtest psr2-primary-blt: SUCCESS (1.716s) [514.086008] [086/132] (509s left) gem_exec_schedule (submit-golden-slice) [514.162300] Starting subtest: submit-golden-slice [514.164657] Starting dynamic subtest: rcs0 [514.188265] Dynamic subtest rcs0: SUCCESS (0.036s) [514.204599] Starting dynamic subtest: bcs0 [514.228665] Dynamic subtest bcs0: SUCCESS (0.039s) [514.241341] Starting dynamic subtest: vcs0 [514.261397] Dynamic subtest vcs0: SUCCESS (0.033s) [514.270873] Starting dynamic subtest: vcs1 [514.297727] Dynamic subtest vcs1: SUCCESS (0.035s) [514.308011] Starting dynamic subtest: vecs0 [514.336872] Dynamic subtest vecs0: SUCCESS (0.038s) [514.353407] Starting dynamic subtest: ccs0 [514.371493] Dynamic subtest ccs0: SUCCESS (0.033s) [514.373756] Subtest submit-golden-slice: SUCCESS (0.220s) [515.979414] [087/132] (507s left) kms_prop_blob (blob-prop-core) [516.042527] Starting subtest: blob-prop-core [516.044372] Subtest blob-prop-core: SUCCESS (0.000s) [516.158375] [088/132] (507s left) kms_big_fb (y-tiled-8bpp-rotate-180) [516.254283] Starting subtest: y-tiled-8bpp-rotate-180 [516.258794] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [516.396175] [089/132] (507s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [516.455662] Starting subtest: multi-wait-all-for-submit-unsubmitted [516.559986] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [516.635312] [090/132] (507s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [516.736255] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [516.738279] Starting dynamic subtest: pipe-A-eDP-1 [517.546211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s) [517.557717] Starting dynamic subtest: pipe-B-eDP-1 [519.174405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.627s) [519.184450] Starting dynamic subtest: pipe-C-eDP-1 [520.710004] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.534s) [520.720673] Starting dynamic subtest: pipe-D-eDP-1 [522.235949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s) [522.238250] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.494s) [523.399683] [091/132] (500s left) kms_invalid_mode (int-max-clock) [523.499605] Starting subtest: int-max-clock [523.501971] Starting dynamic subtest: pipe-A-eDP-1 [523.785812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [523.796044] Starting dynamic subtest: pipe-B-eDP-1 [523.798265] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [523.807144] Starting dynamic subtest: pipe-C-eDP-1 [523.809365] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [523.817972] Starting dynamic subtest: pipe-D-eDP-1 [523.820218] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [523.822312] Subtest int-max-clock: SUCCESS (0.294s) [524.626467] [092/132] (499s left) kms_vblank (wait-forked-busy) [524.720930] Starting subtest: wait-forked-busy [524.722749] Starting dynamic subtest: pipe-A-eDP-1 [526.600987] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s) [526.617345] Starting dynamic subtest: pipe-D-eDP-1 [529.196810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s) [529.199036] Subtest wait-forked-busy: SUCCESS (4.474s) [529.989517] [093/132] (494s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [530.092160] Starting subtest: pr-primary-plane-update-sf-dmg-area [530.096331] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [530.161472] [094/132] (493s left) gem_softpin (allocator-nopin-reserve) [530.218186] Starting subtest: allocator-nopin-reserve [530.301302] Subtest allocator-nopin-reserve: SUCCESS (0.083s) [530.407099] [095/132] (493s left) syncobj_timeline (etime-multi-wait-all-submitted) [530.459553] Starting subtest: etime-multi-wait-all-submitted [530.558944] Subtest etime-multi-wait-all-submitted: SUCCESS (0.101s) [530.639039] [096/132] (493s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [530.739386] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [530.743847] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [530.834537] [097/132] (493s left) prime_vgem (fence-wait) [530.918307] Starting subtest: fence-wait [530.920591] Starting dynamic subtest: rcs0 [531.976851] Dynamic subtest rcs0: SUCCESS (1.057s) [531.998839] Starting dynamic subtest: bcs0 [533.044433] Dynamic subtest bcs0: SUCCESS (1.065s) [533.056346] Starting dynamic subtest: vcs0 [534.086326] Dynamic subtest vcs0: SUCCESS (1.041s) [534.098525] Starting dynamic subtest: vcs1 [535.128442] Dynamic subtest vcs1: SUCCESS (1.040s) [535.140814] Starting dynamic subtest: vecs0 [536.172629] Dynamic subtest vecs0: SUCCESS (1.042s) [536.184926] Starting dynamic subtest: ccs0 [537.215500] Dynamic subtest ccs0: SUCCESS (1.041s) [537.218421] Subtest fence-wait: SUCCESS (6.297s) [537.348851] [098/132] (486s left) kms_busy (basic-hang) [537.449153] Starting subtest: basic-hang [537.451545] Starting dynamic subtest: flip-pipe-A [538.054050] Dynamic subtest flip-pipe-A: SUCCESS (0.605s) [538.065125] Starting dynamic subtest: modeset-pipe-A [541.516878] Dynamic subtest modeset-pipe-A: SUCCESS (3.460s) [541.526658] Starting dynamic subtest: flip-pipe-D [542.717245] Dynamic subtest flip-pipe-D: SUCCESS (1.197s) [542.728186] Starting dynamic subtest: modeset-pipe-D [546.147718] Dynamic subtest modeset-pipe-D: SUCCESS (3.429s) [546.149884] Subtest basic-hang: SUCCESS (8.697s) [546.947475] [099/132] (477s left) syncobj_timeline (multi-wait-available-signaled) [547.008262] Starting subtest: multi-wait-available-signaled [547.010697] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [547.097008] [100/132] (477s left) kms_fbcon_fbt (fbc-suspend) [547.151330] Starting subtest: fbc-suspend [596.544366] Subtest fbc-suspend: SUCCESS (19.197s) [597.913369] [101/132] (426s left) prime_mmap (test_correct_cpu_write) [597.976266] Starting subtest: test_correct_cpu_write [597.979184] Starting dynamic subtest: test_correct_cpu_write-smem [597.981743] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [597.984029] Subtest test_correct_cpu_write: SUCCESS (0.001s) [598.077600] [102/132] (426s left) gem_exec_suspend (basic-s0) [598.141180] Starting subtest: basic-S0 [598.143465] Starting dynamic subtest: smem [619.214409] Dynamic subtest smem: SUCCESS (6.870s) [619.217495] Subtest basic-S0: SUCCESS (6.873s) [619.414951] [103/132] (405s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [619.526412] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [619.531116] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [619.633759] [104/132] (404s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [619.731285] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [626.587092] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.833s) [626.695492] [105/132] (397s left) gen3_mixed_blits [626.809445] [106/132] (397s left) gem_exec_schedule (implicit-write-read) [626.881316] Starting subtest: implicit-write-read [626.883500] Starting dynamic subtest: rcs0 [626.991612] Dynamic subtest rcs0: SUCCESS (0.122s) [627.004614] Starting dynamic subtest: vcs0 [627.072229] Dynamic subtest vcs0: SUCCESS (0.080s) [627.083538] Starting dynamic subtest: vcs1 [627.155092] Dynamic subtest vcs1: SUCCESS (0.081s) [627.166417] Starting dynamic subtest: vecs0 [627.241717] Dynamic subtest vecs0: SUCCESS (0.084s) [627.251664] Starting dynamic subtest: ccs0 [627.329995] Dynamic subtest ccs0: SUCCESS (0.086s) [627.332532] Subtest implicit-write-read: SUCCESS (0.461s) [628.260737] [107/132] (396s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [628.372659] Starting subtest: cursorA-vs-flipA-atomic-transitions [639.584529] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.193s) [640.471815] [108/132] (384s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [640.574501] Starting subtest: async-flip-with-page-flip-events-tiled [640.958976] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [643.751101] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.789s) [643.764270] Starting dynamic subtest: pipe-A-eDP-1-4 [645.950503] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s) [645.963566] Starting dynamic subtest: pipe-A-eDP-1-4 [647.961242] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [647.974167] Starting dynamic subtest: pipe-A-eDP-1-x [650.152295] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s) [650.520697] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [653.287230] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.773s) [653.299711] Starting dynamic subtest: pipe-B-eDP-1-4 [655.483714] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s) [655.496886] Starting dynamic subtest: pipe-B-eDP-1-4 [657.492407] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [657.503112] Starting dynamic subtest: pipe-B-eDP-1-x [659.692658] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s) [660.059973] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [662.813467] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.761s) [662.825691] Starting dynamic subtest: pipe-C-eDP-1-4 [664.988480] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s) [665.000996] Starting dynamic subtest: pipe-C-eDP-1-4 [666.999137] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [667.012034] Starting dynamic subtest: pipe-C-eDP-1-x [669.178473] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [669.542694] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [672.349046] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s) [672.359595] Starting dynamic subtest: pipe-D-eDP-1-4 [674.524336] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [674.537661] Starting dynamic subtest: pipe-D-eDP-1-4 [676.535145] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [676.545687] Starting dynamic subtest: pipe-D-eDP-1-x [678.714559] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [678.717669] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.136s) [679.954145] [109/132] (344s left) gem_ctx_param (invalid-set-ringsize) [680.015495] Starting subtest: invalid-set-ringsize [680.018529] Subtest invalid-set-ringsize: SUCCESS (0.000s) [680.092243] [110/132] (344s left) api_intel_allocator (reloc-allocator) [680.154428] Starting subtest: reloc-allocator [680.157204] Starting dynamic subtest: basic [680.159456] Dynamic subtest basic: SUCCESS (0.003s) [680.171251] Starting dynamic subtest: parallel-one [680.173688] Dynamic subtest parallel-one: SUCCESS (0.009s) [680.183661] Starting dynamic subtest: print [680.186409] Dynamic subtest print: SUCCESS (0.000s) [680.196374] Starting dynamic subtest: reuse [680.198748] Dynamic subtest reuse: SUCCESS (0.000s) [680.208513] Starting dynamic subtest: fork-reopen-allocator [680.211395] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s) [680.214068] Subtest reloc-allocator: SUCCESS (0.030s) [680.296724] [111/132] (344s left) gem_close_race (basic-process) [680.361963] Starting subtest: basic-process [680.403156] Subtest basic-process: SUCCESS (0.041s) [680.588654] [112/132] (344s left) kms_chamelium_audio (dp-audio-edid) [680.974311] Subtest dp-audio-edid: SKIP (0.000s) [681.760997] [113/132] (343s left) gem_mmap_gtt (fault-concurrent-x) [681.820990] Subtest fault-concurrent-X: SKIP (0.000s) [681.895789] [114/132] (343s left) kms_big_fb (4-tiled-32bpp-rotate-180) [681.995370] Starting subtest: 4-tiled-32bpp-rotate-180 [683.441904] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.448s) [683.584439] [115/132] (341s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [683.654223] Starting subtest: map-fixed-invalidate-overlap-busy [683.658294] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [683.778484] [116/132] (341s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [683.872509] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [683.877117] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [683.979958] [117/132] (341s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [684.072706] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [684.098415] Starting dynamic subtest: pipe-A-plane-0 [684.386981] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [684.396570] Starting dynamic subtest: pipe-A-plane-3 [684.645100] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [684.655400] Starting dynamic subtest: pipe-A-plane-5 [684.659466] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [685.768045] Starting dynamic subtest: pipe-B-plane-0 [686.059562] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [686.069655] Starting dynamic subtest: pipe-B-plane-3 [686.304412] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s) [686.314581] Starting dynamic subtest: pipe-B-plane-5 [686.320689] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [686.613955] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.542s) [687.442998] [118/132] (337s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [687.536960] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [687.539253] Starting dynamic subtest: pipe-A-eDP-1 [687.563397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [687.575821] Starting dynamic subtest: pipe-B-eDP-1 [687.601211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [687.610678] Starting dynamic subtest: pipe-C-eDP-1 [687.636044] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [687.645287] Starting dynamic subtest: pipe-D-eDP-1 [687.671310] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [687.676389] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s) [689.811746] [119/132] (335s left) gen7_exec_parse (basic-allowed) [689.878811] Subtest basic-allowed: SKIP (0.000s) [689.952522] [120/132] (335s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [690.062662] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [690.067347] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [690.161107] [121/132] (335s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [690.255181] Starting subtest: fbcpsr-2p-rte [690.260228] Subtest fbcpsr-2p-rte: SKIP (0.000s) [690.350107] [122/132] (334s left) kms_flip (plain-flip-interruptible) [690.446670] Starting subtest: plain-flip-interruptible [690.449344] Starting dynamic subtest: A-eDP1 [692.105464] Dynamic subtest A-eDP1: SUCCESS (1.657s) [692.116709] Starting dynamic subtest: B-eDP1 [693.741503] Dynamic subtest B-eDP1: SUCCESS (1.633s) [693.752435] Starting dynamic subtest: C-eDP1 [695.362790] Dynamic subtest C-eDP1: SUCCESS (1.619s) [695.373504] Starting dynamic subtest: D-eDP1 [696.995345] Dynamic subtest D-eDP1: SUCCESS (1.629s) [696.998221] Subtest plain-flip-interruptible: SUCCESS (6.550s) [698.173453] [123/132] (327s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [698.239586] Starting subtest: invalid-bsd2-flag-on-vebox [698.242166] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [698.338516] [124/132] (327s left) kms_plane_scaling (intel-max-src-size) [698.425653] Starting subtest: intel-max-src-size [698.433462] Subtest intel-max-src-size: SKIP (0.000s) [698.527044] [125/132] (326s left) syncobj_timeline (wait-zero-handles) [698.583054] Starting subtest: wait-zero-handles [698.585535] Subtest wait-zero-handles: SUCCESS (0.000s) [698.676551] [126/132] (326s left) perf_pmu (rc6) [698.719734] Starting subtest: rc6 [698.722507] Starting dynamic subtest: gt0 [705.072042] Dynamic subtest gt0: SUCCESS (6.350s) [705.085841] Starting dynamic subtest: runtime-pm-gt0 [712.792500] Dynamic subtest runtime-pm-gt0: SUCCESS (7.716s) [712.805704] Starting dynamic subtest: runtime-pm-long-gt0 [725.218976] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.426s) [725.232425] Starting dynamic subtest: other-idle-gt0 [731.563050] Dynamic subtest other-idle-gt0: SUCCESS (6.342s) [731.576413] Starting dynamic subtest: gt1 [737.905531] Dynamic subtest gt1: SUCCESS (6.341s) [737.916497] Starting dynamic subtest: runtime-pm-gt1 [745.375580] Dynamic subtest runtime-pm-gt1: SUCCESS (7.468s) [745.388526] Starting dynamic subtest: runtime-pm-long-gt1 [757.871099] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.492s) [757.884449] Starting dynamic subtest: other-idle-gt1 [764.215155] Dynamic subtest other-idle-gt1: SUCCESS (6.341s) [764.218252] Subtest rc6: SUCCESS (65.495s) [765.460568] [127/132] (260s left) kms_flip (bo-too-big) [765.556088] Starting subtest: bo-too-big [765.558193] Starting dynamic subtest: A-eDP1 [766.908457] Dynamic subtest A-eDP1: SUCCESS (1.351s) [766.920339] Starting dynamic subtest: B-eDP1 [768.241499] Dynamic subtest B-eDP1: SUCCESS (1.330s) [768.253139] Starting dynamic subtest: C-eDP1 [769.576961] Dynamic subtest C-eDP1: SUCCESS (1.333s) [769.589094] Starting dynamic subtest: D-eDP1 [770.899990] Dynamic subtest D-eDP1: SUCCESS (1.322s) [770.902329] Subtest bo-too-big: SUCCESS (5.346s) [772.107296] [128/132] (253s left) i915_pm_rpm (gem-mmap-type) [774.341961] Starting subtest: gem-mmap-type [774.344833] Starting dynamic subtest: wb-smem0 [777.796525] Dynamic subtest wb-smem0: SUCCESS (3.455s) [777.806938] Starting dynamic subtest: wc-smem0 [780.962668] Dynamic subtest wc-smem0: SUCCESS (3.165s) [780.972339] Starting dynamic subtest: uc-smem0 [784.143889] Dynamic subtest uc-smem0: SUCCESS (3.181s) [784.146485] Subtest gem-mmap-type: SUCCESS (9.804s) [784.213196] [129/132] (241s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [784.314202] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [784.319022] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [784.389555] [130/132] (241s left) syncobj_wait (invalid-reset-bad-pad) [784.435548] Starting subtest: invalid-reset-bad-pad [784.437968] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [784.528832] [131/132] (241s left) kms_lease (lease-unleased-crtc) [784.611687] Starting subtest: lease-unleased-crtc [784.613964] Starting dynamic subtest: pipe-A-eDP-1 [784.901195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [784.911589] Starting dynamic subtest: pipe-B-eDP-1 [785.647580] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.744s) [785.662228] Starting dynamic subtest: pipe-C-eDP-1 [785.665109] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [785.675212] Starting dynamic subtest: pipe-D-eDP-1 [785.677712] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [785.680304] Subtest lease-unleased-crtc: SUCCESS (1.051s) [786.020924] [132/132] (239s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [786.122165] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [792.917509] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.797s) [793.018296] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: fbdev results: parsing output: 2/ for test: gem_mmap results: parsing output: 3/ for test: kms_chamelium_edid results: parsing output: 4/ for test: gem_mmap_gtt results: parsing output: 5/ for test: gem_ctx_persistence results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_ringfill results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: i915_hangman results: parsing output: 13/ for test: gem_lmem_swapping results: parsing output: 14/ for test: kms_psr results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: kms_cursor_crc results: parsing output: 17/ for test: perf_pmu results: parsing output: 18/ for test: gen9_exec_parse results: parsing output: 19/ for test: gem_exec_fence results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_content_protection results: parsing output: 22/ for test: syncobj_eventfd results: parsing output: 23/ for test: gem_exec_await results: parsing output: 24/ for test: kms_chamelium_hpd results: parsing output: 25/ for test: gem_exec_params results: parsing output: 26/ for test: gem_exec_balancer results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: gem_fenced_exec_thrash results: parsing output: 29/ for test: gen7_exec_parse results: parsing output: 30/ for test: sw_sync results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: gem_pxp results: parsing output: 34/ for test: kms_pm_backlight results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_create results: parsing output: 38/ for test: kms_draw_crc results: parsing output: 39/ for test: kms_pipe_crc_basic results: parsing output: 40/ for test: gem_ctx_shared results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: gem_exec_reloc results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_atomic_interruptible results: parsing output: 48/ for test: perf_pmu results: parsing output: 49/ for test: kms_vblank results: parsing output: 50/ for test: core_getversion results: parsing output: 51/ for test: kms_cursor_legacy results: parsing output: 52/ for test: kms_properties results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: prime_vgem results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: syncobj_wait results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: gem_exec_flush results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: kms_cursor_crc results: parsing output: 61/ for test: kms_pm_rpm results: parsing output: 62/ for test: i915_pm_rps results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_bb results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_color_pipeline results: parsing output: 67/ for test: gem_softpin results: parsing output: 68/ for test: gem_exec_fence results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: prime_vgem results: parsing output: 71/ for test: kms_getfb results: parsing output: 72/ for test: gem_exec_params results: parsing output: 73/ for test: kms_pipe_b_c_ivb results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: gem_exec_params results: parsing output: 77/ for test: kms_plane_multiple results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_async_flips results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_render_copy results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_psr results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: kms_prop_blob results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: syncobj_wait results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: kms_invalid_mode results: parsing output: 91/ for test: kms_vblank results: parsing output: 92/ for test: kms_psr2_sf results: parsing output: 93/ for test: gem_softpin results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: prime_vgem results: parsing output: 97/ for test: kms_busy results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: kms_fbcon_fbt results: parsing output: 100/ for test: prime_mmap results: parsing output: 101/ for test: gem_exec_suspend results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gen3_mixed_blits results: parsing output: 105/ for test: gem_exec_schedule results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: kms_async_flips results: parsing output: 108/ for test: gem_ctx_param results: parsing output: 109/ for test: api_intel_allocator results: parsing output: 110/ for test: gem_close_race results: parsing output: 111/ for test: kms_chamelium_audio results: parsing output: 112/ for test: gem_mmap_gtt results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_plane results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: gen7_exec_parse results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: gem_exec_params results: parsing output: 123/ for test: kms_plane_scaling results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: perf_pmu results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: i915_pm_rpm results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: syncobj_wait results: parsing output: 130/ for test: kms_lease results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.