[60.278385] Initializing watchdogs
[60.278430]   /dev/watchdog0
[60.291540] [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]
[60.295817] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.298051] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.301234] [001/131] (960s left) kms_psr (psr2-sprite-mmap-gtt)
[60.425781] Starting subtest: psr2-sprite-mmap-gtt
[60.428108] Starting dynamic subtest: eDP-1
[61.844929] Dynamic subtest eDP-1: SKIP (1.424s)
[61.849520] Subtest psr2-sprite-mmap-gtt: SKIP (1.425s)
[62.040308] [002/131] (958s left) kms_plane_cursor (viewport)
[62.139121] Starting subtest: viewport
[62.143661] Starting dynamic subtest: pipe-A-eDP-1-size-64
[64.526305] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.397s)
[64.584568] Starting dynamic subtest: pipe-A-eDP-1-size-128
[66.975518] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.405s)
[67.034161] Starting dynamic subtest: pipe-A-eDP-1-size-256
[69.493623] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[69.839671] Starting dynamic subtest: pipe-B-eDP-1-size-64
[73.016782] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.190s)
[73.076761] Starting dynamic subtest: pipe-B-eDP-1-size-128
[75.582659] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[75.640509] Starting dynamic subtest: pipe-B-eDP-1-size-256
[78.115040] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.481s)
[78.468805] Starting dynamic subtest: pipe-C-eDP-1-size-64
[81.226350] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.765s)
[81.266984] Starting dynamic subtest: pipe-C-eDP-1-size-128
[83.327135] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.068s)
[83.362484] Starting dynamic subtest: pipe-C-eDP-1-size-256
[85.416699] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.057s)
[85.743699] Starting dynamic subtest: pipe-D-eDP-1-size-64
[88.469291] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.735s)
[88.506119] Starting dynamic subtest: pipe-D-eDP-1-size-128
[90.581506] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.079s)
[90.616886] Starting dynamic subtest: pipe-D-eDP-1-size-256
[92.692857] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[93.013197] Subtest viewport: SUCCESS (30.901s)
[93.878518] [003/131] (926s left) sysfs_timeslice_duration (duration)
[93.944077] Starting subtest: duration
[93.946289] Starting dynamic subtest: vecs0
[107.832878] Dynamic subtest vecs0: SUCCESS (13.879s)
[107.841689] Starting dynamic subtest: ccs0
[121.002072] Dynamic subtest ccs0: SUCCESS (13.172s)
[121.014096] Starting dynamic subtest: vcs0
[135.861206] Dynamic subtest vcs0: SUCCESS (14.853s)
[135.871378] Starting dynamic subtest: bcs0
[149.022322] Dynamic subtest bcs0: SUCCESS (13.160s)
[149.033830] Starting dynamic subtest: rcs0
[162.166906] Dynamic subtest rcs0: SUCCESS (13.142s)
[162.176965] Starting dynamic subtest: vcs1
[175.799610] Dynamic subtest vcs1: SUCCESS (13.627s)
[175.802250] Subtest duration: SUCCESS (81.849s)
[175.895831] [004/131] (845s left) kms_psr (psr-dpms)
[175.993032] Starting subtest: psr-dpms
[175.995277] Starting dynamic subtest: eDP-1
[178.978268] Dynamic subtest eDP-1: SUCCESS (2.984s)
[178.980175] Subtest psr-dpms: SUCCESS (2.985s)
[179.868563] [005/131] (841s left) kms_cursor_crc (cursor-sliding-64x21)
[180.061751] Starting subtest: cursor-sliding-64x21
[180.107596] Subtest cursor-sliding-64x21: SKIP (0.038s)
[180.373454] [006/131] (840s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[180.476904] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[180.479195] Starting dynamic subtest: pipe-A-default-mode
[180.798177] Dynamic subtest pipe-A-default-mode: SKIP (0.319s)
[180.802707] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.321s)
[181.606148] [007/131] (839s left) kms_joiner (basic-max-non-joiner)
[181.712614] Starting subtest: basic-max-non-joiner
[181.716776] Subtest basic-max-non-joiner: SKIP (0.000s)
[181.803752] [008/131] (839s left) kms_flip (2x-flip-vs-dpms)
[181.909150] Starting subtest: 2x-flip-vs-dpms
[181.921213] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[182.022245] [009/131] (839s left) syncobj_wait (invalid-reset-zero-handles)
[182.074459] Starting subtest: invalid-reset-zero-handles
[182.076419] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[182.207236] [010/131] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[182.301692] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[182.305718] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[182.408780] [011/131] (838s left) gem_exec_params (batch-first)
[182.465770] Starting subtest: batch-first
[182.470667] Subtest batch-first: SUCCESS (0.004s)
[182.620634] [012/131] (838s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[182.732447] Starting subtest: 4-tiled-64bpp-rotate-180
[184.245243] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.511s)
[184.423119] [013/131] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[184.535586] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[184.539937] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[184.665653] [014/131] (836s left) kms_frontbuffer_tracking (psr-1p-rte)
[184.769391] Starting subtest: psr-1p-rte
[190.164662] Subtest psr-1p-rte: SUCCESS (5.397s)
[190.334152] [015/131] (830s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[190.395341] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[190.397595] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[190.511976] [016/131] (830s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[190.604784] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[190.609308] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[190.730875] [017/131] (830s left) kms_atomic_transition (plane-all-transition)
[190.831288] Starting subtest: plane-all-transition
[190.833612] Starting dynamic subtest: pipe-A-eDP-1
[193.322317] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.493s)
[193.628763] Starting dynamic subtest: pipe-B-eDP-1
[196.823632] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.202s)
[197.123639] Subtest plane-all-transition: SUCCESS (6.294s)
[197.974705] [018/131] (823s left) gem_eio (in-flight-suspend)
[198.175652] Starting subtest: in-flight-suspend
[244.354576] Subtest in-flight-suspend: SUCCESS (16.757s)
[244.519169] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[244.522206] [019/131] (776s left) gem_mmap_gtt (basic-wc)
[244.594594] Subtest basic-wc: SKIP (0.000s)
[244.653601] [020/131] (776s left) kms_universal_plane (universal-plane-sanity)
[244.733138] Starting subtest: universal-plane-sanity
[244.735391] Starting dynamic subtest: pipe-A-eDP-1
[245.314237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[245.323227] Starting dynamic subtest: pipe-B-eDP-1
[246.483533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[246.493349] Starting dynamic subtest: pipe-C-eDP-1
[247.676490] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.228s)
[247.685549] Starting dynamic subtest: pipe-D-eDP-1
[248.876374] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[248.878692] Subtest universal-plane-sanity: SUCCESS (4.289s)
[249.725967] [021/131] (771s left) gen7_exec_parse (bitmasks)
[249.782723] Subtest bitmasks: SKIP (0.000s)
[249.878220] [022/131] (771s left) kms_plane_multiple (tiling-y)
[249.962864] Starting subtest: tiling-y
[249.967173] Subtest tiling-y: SKIP (0.000s)
[250.091270] [023/131] (771s left) sw_sync (sync_merge_same)
[250.138405] Starting subtest: sync_merge_same
[250.140215] Subtest sync_merge_same: SUCCESS (0.000s)
[250.222187] [024/131] (771s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[250.321034] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[250.323228] Starting dynamic subtest: pipe-A-default-mode
[252.970014] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[252.972366] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.698s)
[253.829540] [025/131] (767s left) gem_reg_read (timestamp-monotonic)
[253.877470] Starting subtest: timestamp-monotonic
[258.514462] Subtest timestamp-monotonic: SUCCESS (4.684s)
[258.613305] [026/131] (763s left) gem_exec_schedule (out-order)
[258.682589] Starting subtest: out-order
[258.684738] Starting dynamic subtest: rcs0
[258.869229] Dynamic subtest rcs0: SUCCESS (0.186s)
[258.880314] Starting dynamic subtest: vcs0
[258.980769] Dynamic subtest vcs0: SUCCESS (0.111s)
[258.990995] Starting dynamic subtest: vcs1
[259.091411] Dynamic subtest vcs1: SUCCESS (0.112s)
[259.102100] Starting dynamic subtest: vecs0
[259.210761] Dynamic subtest vecs0: SUCCESS (0.119s)
[259.220747] Starting dynamic subtest: ccs0
[259.347203] Dynamic subtest ccs0: SUCCESS (0.137s)
[259.349654] Subtest out-order: SUCCESS (0.670s)
[260.497350] [027/131] (761s left) gem_close_race (basic-process)
[260.566523] Starting subtest: basic-process
[260.643809] Subtest basic-process: SUCCESS (0.078s)
[260.856575] [028/131] (761s left) api_intel_bb (simple-bb-ctx)
[260.910668] Starting subtest: simple-bb-ctx
[260.919264] Subtest simple-bb-ctx: SUCCESS (0.012s)
[261.084568] [029/131] (760s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[261.144654] Starting subtest: invalid-multi-wait-all-unsubmitted
[261.146905] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[261.263051] [030/131] (760s left) gem_ctx_isolation (nonpriv-switch)
[261.341077] Starting subtest: nonpriv-switch
[261.343430] Starting dynamic subtest: rcs0
[261.703276] Dynamic subtest rcs0: SUCCESS (0.364s)
[261.711611] Starting dynamic subtest: bcs0
[262.080811] Dynamic subtest bcs0: SUCCESS (0.379s)
[262.090803] Starting dynamic subtest: vcs0
[262.440980] Dynamic subtest vcs0: SUCCESS (0.361s)
[262.451084] Starting dynamic subtest: vcs1
[263.650903] Dynamic subtest vcs1: SUCCESS (1.214s)
[263.661175] Starting dynamic subtest: vecs0
[265.650054] Dynamic subtest vecs0: SUCCESS (2.005s)
[265.661474] Starting dynamic subtest: ccs0
[267.658404] Dynamic subtest ccs0: SUCCESS (2.014s)
[267.660794] Subtest nonpriv-switch: SUCCESS (6.341s)
[267.919722] [031/131] (754s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[268.026820] Starting subtest: yf-tiled-64bpp-rotate-180
[268.031038] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[268.148044] [032/131] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[268.253289] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[268.257161] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[268.394564] [033/131] (753s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[268.491136] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[268.493025] Starting dynamic subtest: pipe-A-eDP-1
[268.551405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[268.559828] Starting dynamic subtest: pipe-B-eDP-1
[268.612377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[268.620850] Starting dynamic subtest: pipe-C-eDP-1
[268.671427] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[268.679731] Starting dynamic subtest: pipe-D-eDP-1
[268.734079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[268.736386] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.245s)
[270.993443] [034/131] (751s left) gem_mmap_wc (bad-object)
[271.059103] Subtest bad-object: SKIP (0.000s)
[271.121356] [035/131] (751s left) gem_ctx_shared (exec-single-timeline)
[271.183408] Starting subtest: exec-single-timeline
[271.185596] Starting dynamic subtest: rcs0
[272.221964] Dynamic subtest rcs0: SUCCESS (1.038s)
[272.234134] Starting dynamic subtest: bcs0
[273.310398] Dynamic subtest bcs0: SUCCESS (1.087s)
[273.321517] Starting dynamic subtest: vcs0
[274.399165] Dynamic subtest vcs0: SUCCESS (1.087s)
[274.410266] Starting dynamic subtest: vcs1
[275.487188] Dynamic subtest vcs1: SUCCESS (1.084s)
[275.497899] Starting dynamic subtest: vecs0
[276.576459] Dynamic subtest vecs0: SUCCESS (1.083s)
[276.588191] Starting dynamic subtest: ccs0
[277.663784] Dynamic subtest ccs0: SUCCESS (1.084s)
[277.666645] Subtest exec-single-timeline: SUCCESS (6.483s)
[278.378715] [036/131] (743s left) gem_exec_store (dword)
[278.447897] Starting subtest: dword
[278.450197] Starting dynamic subtest: rcs0
[278.542363] Dynamic subtest rcs0: SUCCESS (0.095s)
[278.553425] Starting dynamic subtest: bcs0
[278.588281] Dynamic subtest bcs0: SUCCESS (0.044s)
[278.598557] Starting dynamic subtest: vcs0
[278.631181] Dynamic subtest vcs0: SUCCESS (0.041s)
[278.641499] Starting dynamic subtest: vcs1
[278.676408] Dynamic subtest vcs1: SUCCESS (0.043s)
[278.686288] Starting dynamic subtest: vecs0
[278.718282] Dynamic subtest vecs0: SUCCESS (0.041s)
[278.726562] Starting dynamic subtest: ccs0
[278.765972] Dynamic subtest ccs0: SUCCESS (0.045s)
[278.768626] Subtest dword: SUCCESS (0.320s)
[278.975430] [037/131] (743s left) kms_flip (modeset-vs-vblank-race)
[279.077552] Starting subtest: modeset-vs-vblank-race
[279.079842] Starting dynamic subtest: A-eDP1
[283.798888] Dynamic subtest A-eDP1: SUCCESS (4.721s)
[283.811860] Starting dynamic subtest: B-eDP1
[288.534495] Dynamic subtest B-eDP1: SUCCESS (4.732s)
[288.548296] Starting dynamic subtest: C-eDP1
[293.130699] Dynamic subtest C-eDP1: SUCCESS (4.593s)
[293.141961] Starting dynamic subtest: D-eDP1
[297.686375] Dynamic subtest D-eDP1: SUCCESS (4.555s)
[297.688596] Subtest modeset-vs-vblank-race: SUCCESS (18.612s)
[298.894186] [038/131] (723s left) gem_ctx_exec (basic)
[298.965271] Starting subtest: basic
[298.969620] Subtest basic: SUCCESS (0.004s)
[299.125422] [039/131] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[299.241562] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[299.246195] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[299.383833] [040/131] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[299.493309] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[306.011412] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.523s)
[306.190281] [041/131] (716s left) gem_exec_reloc (basic-write-wc-active)
[306.267457] Subtest basic-write-wc-active: SKIP (0.000s)
[306.354873] [042/131] (716s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[306.456335] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[306.458595] Starting dynamic subtest: pipe-A-eDP-1
[306.479474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[306.489552] Starting dynamic subtest: pipe-B-eDP-1
[306.509041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[306.517179] Starting dynamic subtest: pipe-C-eDP-1
[306.537444] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[306.545920] Starting dynamic subtest: pipe-D-eDP-1
[306.565408] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[306.567264] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[308.751098] [043/131] (713s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[308.884749] Starting subtest: basic-busy-flip-before-cursor-atomic
[308.889365] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[309.056595] [044/131] (713s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[309.161598] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[309.166046] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[309.288687] [045/131] (713s left) gem_gpgpu_fill (offset-16x16)
[309.351210] Starting subtest: offset-16x16
[309.356150] Subtest offset-16x16: SUCCESS (0.006s)
[309.526041] [046/131] (713s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[309.597653] Subtest writes-after-reads-uncached: SKIP (0.000s)
[309.679631] [047/131] (712s left) gem_spin_batch (resubmit-all)
[309.747305] Starting subtest: resubmit-all
[309.749257] Starting dynamic subtest: rcs0
[309.758376] Dynamic subtest rcs0: SUCCESS (0.011s)
[309.768945] Starting dynamic subtest: bcs0
[309.770927] Dynamic subtest bcs0: SUCCESS (0.003s)
[309.778636] Starting dynamic subtest: vcs0
[309.780454] Dynamic subtest vcs0: SUCCESS (0.002s)
[309.787872] Starting dynamic subtest: vcs1
[309.789799] Dynamic subtest vcs1: SUCCESS (0.003s)
[309.797169] Starting dynamic subtest: vecs0
[309.798927] Dynamic subtest vecs0: SUCCESS (0.002s)
[309.806187] Starting dynamic subtest: ccs0
[309.808173] Dynamic subtest ccs0: SUCCESS (0.001s)
[309.809977] Subtest resubmit-all: SUCCESS (0.026s)
[311.358887] [048/131] (711s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[311.486494] Starting subtest: basic-flip-before-cursor-atomic
[312.410432] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.925s)
[313.276554] [049/131] (709s left) kms_getfb (getfb2-into-addfb2)
[313.374203] Starting subtest: getfb2-into-addfb2
[313.376543] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[313.512859] [050/131] (709s left) perf_pmu (busy-no-semaphores)
[313.551579] Starting subtest: busy-no-semaphores
[313.553920] Starting dynamic subtest: rcs0
[314.130203] Dynamic subtest rcs0: SUCCESS (0.580s)
[314.142056] Starting dynamic subtest: bcs0
[314.685183] Dynamic subtest bcs0: SUCCESS (0.551s)
[314.696830] Starting dynamic subtest: vcs0
[315.236485] Dynamic subtest vcs0: SUCCESS (0.549s)
[315.248693] Starting dynamic subtest: vcs1
[316.869392] Dynamic subtest vcs1: SUCCESS (1.630s)
[316.881243] Starting dynamic subtest: vecs0
[318.852342] Dynamic subtest vecs0: SUCCESS (1.980s)
[318.864292] Starting dynamic subtest: ccs0
[320.836535] Dynamic subtest ccs0: SUCCESS (1.982s)
[320.839241] Subtest busy-no-semaphores: SUCCESS (7.291s)
[320.998163] [051/131] (701s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[321.100015] Starting subtest: primary-y-tiled-reflect-x-90
[321.104329] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[321.195697] [052/131] (701s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[321.283391] Starting subtest: fbc-psr-sprite-mmap-cpu
[321.285567] Starting dynamic subtest: eDP-1
[321.289920] Dynamic subtest eDP-1: SKIP (0.000s)
[321.294319] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[321.379364] [053/131] (701s left) gem_mmap_gtt (cpuset-big-copy)
[321.440594] Subtest cpuset-big-copy: SKIP (0.000s)
[321.504956] [054/131] (701s left) kms_vblank (crtc-id)
[321.597053] Starting subtest: crtc-id
[321.599408] Starting dynamic subtest: pipe-A-eDP-1
[322.052174] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[322.066748] Starting dynamic subtest: pipe-D-eDP-1
[323.183165] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[323.185536] Subtest crtc-id: SUCCESS (1.588s)
[324.033654] [055/131] (698s left) i915_pm_freq_api (freq-reset-multiple)
[324.097632] Starting subtest: freq-reset-multiple
[324.099807] Starting dynamic subtest: gt0
[333.171232] Dynamic subtest gt0: SUCCESS (9.077s)
[333.180544] Starting dynamic subtest: gt1
[341.083951] Dynamic subtest gt1: SUCCESS (7.914s)
[341.086988] Subtest freq-reset-multiple: SUCCESS (16.993s)
[341.188304] [056/131] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[341.304689] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[348.124414] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.819s)
[348.296160] [057/131] (674s left) dmabuf_sync_file (export-wait-after-attach)
[348.347429] Starting subtest: export-wait-after-attach
[348.349703] Subtest export-wait-after-attach: SUCCESS (0.001s)
[348.432286] [058/131] (674s left) syncobj_basic (bad-fd-to-handle)
[348.490933] Starting subtest: bad-fd-to-handle
[348.492836] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[348.626874] [059/131] (674s left) gem_busy (extended)
[348.805186] Starting subtest: extended
[348.807575] Starting dynamic subtest: rcs0
[348.899979] Dynamic subtest rcs0: SUCCESS (0.094s)
[348.911473] Starting dynamic subtest: bcs0
[348.941585] Dynamic subtest bcs0: SUCCESS (0.040s)
[348.951927] Starting dynamic subtest: vcs0
[350.338219] Dynamic subtest vcs0: SUCCESS (1.392s)
[350.351169] Starting dynamic subtest: vcs1
[352.322482] Dynamic subtest vcs1: SUCCESS (1.980s)
[352.334783] Starting dynamic subtest: vecs0
[354.307715] Dynamic subtest vecs0: SUCCESS (1.982s)
[354.320417] Starting dynamic subtest: ccs0
[354.352076] Dynamic subtest ccs0: SUCCESS (0.044s)
[354.354530] Subtest extended: SUCCESS (5.547s)
[354.625259] [060/131] (668s left) kms_psr (fbc-psr-primary-mmap-cpu)
[354.715351] Starting subtest: fbc-psr-primary-mmap-cpu
[354.717544] Starting dynamic subtest: eDP-1
[354.721641] Dynamic subtest eDP-1: SKIP (0.000s)
[354.725733] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[354.812156] [061/131] (668s left) kms_vblank (wait-forked-busy)
[354.905295] Starting subtest: wait-forked-busy
[354.907189] Starting dynamic subtest: pipe-A-eDP-1
[356.783346] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[356.797987] Starting dynamic subtest: pipe-D-eDP-1
[359.320638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[359.323078] Subtest wait-forked-busy: SUCCESS (4.416s)
[360.143474] [062/131] (663s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[360.238670] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[360.242799] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[360.373674] [063/131] (662s left) kms_pm_rpm (system-suspend-idle)
[362.506023] Starting subtest: system-suspend-idle
[382.561454] Subtest system-suspend-idle: SUCCESS (4.636s)
[382.942588] [064/131] (640s left) gem_ctx_param (non-root-set)
[382.998871] Starting subtest: non-root-set
[383.029653] Subtest non-root-set: SUCCESS (0.032s)
[383.146023] [065/131] (640s left) syncobj_wait (multi-wait-submitted)
[383.208161] Starting subtest: multi-wait-submitted
[383.311613] Subtest multi-wait-submitted: SUCCESS (0.107s)
[383.404760] [066/131] (640s left) gem_userptr_blits (sync-unmap-after-close)
[383.461679] Starting subtest: sync-unmap-after-close
[383.473725] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[383.630717] [067/131] (639s left) kms_cursor_crc (cursor-size-change)
[383.718464] Starting subtest: cursor-size-change
[383.720623] Starting dynamic subtest: pipe-A-eDP-1
[384.504151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[384.513252] Starting dynamic subtest: pipe-D-eDP-1
[385.910459] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.439s)
[385.912641] Subtest cursor-size-change: SUCCESS (2.250s)
[386.724615] [068/131] (636s left) gem_exec_flush (basic-uc-prw-default)
[386.795516] Starting subtest: basic-uc-prw-default
[392.172262] Subtest basic-uc-prw-default: SUCCESS (5.453s)
[392.381467] [069/131] (631s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[392.445795] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[392.450527] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[392.659556] [070/131] (630s left) gem_ctx_engines (invalid-engines)
[392.718909] Starting subtest: invalid-engines
[392.731653] Subtest invalid-engines: SUCCESS (0.013s)
[392.981147] [071/131] (630s left) kms_flip (flip-vs-rmfb-interruptible)
[393.081801] Starting subtest: flip-vs-rmfb-interruptible
[393.084180] Starting dynamic subtest: A-eDP1
[401.703357] Dynamic subtest A-eDP1: SUCCESS (8.667s)
[401.715768] Starting dynamic subtest: B-eDP1
[410.315010] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[410.326405] Starting dynamic subtest: C-eDP1
[418.912067] Dynamic subtest C-eDP1: SUCCESS (8.594s)
[418.923278] Starting dynamic subtest: D-eDP1
[427.540067] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[427.544914] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.523s)
[428.743283] [072/131] (594s left) gem_exec_params (no-blt)
[428.819480] Starting subtest: no-blt
[428.821874] Subtest no-blt: SUCCESS (0.002s)
[429.004458] [073/131] (594s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[429.383740] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[430.227023] [074/131] (593s left) gem_render_copy (linear)
[430.299704] Starting subtest: linear
[430.301737] Starting dynamic subtest: smem
[430.340919] Dynamic subtest smem: SUCCESS (0.044s)
[430.343550] Subtest linear: SUCCESS (0.045s)
[430.555768] [075/131] (593s left) kms_lease (page-flip-implicit-plane)
[430.653172] Starting subtest: page-flip-implicit-plane
[430.655152] Starting dynamic subtest: pipe-A-eDP-1
[431.132386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[431.144822] Starting dynamic subtest: pipe-B-eDP-1
[432.284708] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[432.297562] Starting dynamic subtest: pipe-C-eDP-1
[433.404092] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[433.414393] Starting dynamic subtest: pipe-D-eDP-1
[434.535203] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[434.537588] Subtest page-flip-implicit-plane: SUCCESS (3.885s)
[435.396948] [076/131] (588s left) perf_pmu (interrupts-sync)
[435.433794] Starting subtest: interrupts-sync
[436.550719] Subtest interrupts-sync: SUCCESS (1.116s)
[436.693624] [077/131] (587s left) kms_atomic_transition (modeset-transition)
[436.781324] Starting subtest: modeset-transition
[436.783573] Starting dynamic subtest: 1x-outputs
[447.639586] Dynamic subtest 1x-outputs: SUCCESS (10.862s)
[447.642100] Subtest modeset-transition: SUCCESS (10.863s)
[448.523227] [078/131] (575s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[448.616309] Starting subtest: plane-lut1d-post-ctm3x4
[448.628516] Starting dynamic subtest: pipe-A-eDP-1
[449.365079] Dynamic subtest pipe-A-eDP-1: FAIL (0.336s)
[449.996725] Starting dynamic subtest: pipe-B-eDP-1
[450.852609] Dynamic subtest pipe-B-eDP-1: FAIL (0.325s)
[451.427760] Starting dynamic subtest: pipe-C-eDP-1
[452.253916] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[452.756022] Starting dynamic subtest: pipe-D-eDP-1
[453.587881] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[453.590085] Subtest plane-lut1d-post-ctm3x4: FAIL (4.684s)
[454.158513] [079/131] (569s left) perf (gen12-group-exclusive-stream-ctx-handle)
[454.296201] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[454.322354] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[454.365831] [080/131] (569s left) gem_exec_reloc (basic-gtt-read-noreloc)
[455.805449] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[455.902591] [081/131] (568s left) prime_vgem (busy)
[456.018286] Starting subtest: busy
[456.020661] Starting dynamic subtest: rcs0
[456.090736] Dynamic subtest rcs0: SUCCESS (0.072s)
[456.099237] Starting dynamic subtest: bcs0
[456.175363] Dynamic subtest bcs0: SUCCESS (0.084s)
[456.184600] Starting dynamic subtest: vcs0
[456.226105] Dynamic subtest vcs0: SUCCESS (0.050s)
[456.234659] Starting dynamic subtest: vcs1
[456.267816] Dynamic subtest vcs1: SUCCESS (0.041s)
[456.276448] Starting dynamic subtest: vecs0
[456.315121] Dynamic subtest vecs0: SUCCESS (0.046s)
[456.323880] Starting dynamic subtest: ccs0
[456.359738] Dynamic subtest ccs0: SUCCESS (0.044s)
[456.361866] Subtest busy: SUCCESS (0.342s)
[456.506648] [082/131] (567s left) api_intel_bb (add-remove-objects)
[456.555291] Starting subtest: add-remove-objects
[456.559967] Subtest add-remove-objects: SUCCESS (0.007s)
[456.722260] [083/131] (567s left) kms_content_protection (lic-type-1)
[456.870667] Starting subtest: lic-type-1
[456.874774] Subtest lic-type-1: SKIP (0.000s)
[457.038093] [084/131] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[457.131243] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[457.134523] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[457.267677] [085/131] (566s left) gem_render_copy (yf-tiled-ccs-to-linear)
[457.323079] Starting subtest: yf-tiled-ccs-to-linear
[457.327243] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[457.529351] [086/131] (566s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[457.623323] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[457.625613] Starting dynamic subtest: pipe-A-eDP-1
[457.685929] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[457.696888] Starting dynamic subtest: pipe-B-eDP-1
[457.754851] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[457.765436] Starting dynamic subtest: pipe-C-eDP-1
[457.822384] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[457.832313] Starting dynamic subtest: pipe-D-eDP-1
[457.890524] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[457.895124] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[459.831227] [087/131] (564s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[459.934251] Starting subtest: fbc-rgb565-draw-mmap-gtt
[459.938297] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[460.069920] [088/131] (564s left) gem_exec_schedule (semaphore-noskip)
[460.144530] Starting subtest: semaphore-noskip
[460.549671] Subtest semaphore-noskip: SUCCESS (0.411s)
[460.923275] [089/131] (563s left) gem_mmap_offset (close-race)
[460.998066] Starting subtest: close-race
[481.106807] Subtest close-race: SUCCESS (20.111s)
[481.271185] [090/131] (543s left) syncobj_wait (wait-all-for-submit-complex)
[481.336864] Starting subtest: wait-all-for-submit-complex
[481.549829] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[481.659188] [091/131] (542s left) gem_spin_batch (user-each)
[481.728390] Starting subtest: user-each
[485.094464] Subtest user-each: SUCCESS (3.363s)
[486.933737] [092/131] (537s left) syncobj_eventfd (timeline-wait-signaled)
[486.991507] Starting subtest: timeline-wait-signaled
[486.993852] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[487.129692] [093/131] (537s left) i915_drm_fdinfo (memory-info-purgeable)
[487.171609] Starting subtest: memory-info-purgeable
[487.173932] Starting dynamic subtest: smem0
[490.204664] Dynamic subtest smem0: SUCCESS (3.033s)
[490.206759] Subtest memory-info-purgeable: SUCCESS (3.033s)
[490.299219] [094/131] (534s left) kms_chamelium_color (ctm-0-75)
[490.402165] Subtest ctm-0-75: SKIP (0.000s)
[490.454282] [095/131] (534s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[490.562017] Starting subtest: modeset-atomic-cursor-hotspot
[490.565770] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[490.734090] [096/131] (533s left) kms_flip (dpms-vs-vblank-race-interruptible)
[490.834531] Starting subtest: dpms-vs-vblank-race-interruptible
[490.836520] Starting dynamic subtest: A-eDP1
[495.780164] Dynamic subtest A-eDP1: SUCCESS (4.941s)
[495.789382] Starting dynamic subtest: B-eDP1
[500.394921] Dynamic subtest B-eDP1: SUCCESS (4.611s)
[500.404527] Starting dynamic subtest: C-eDP1
[505.026827] Dynamic subtest C-eDP1: SUCCESS (4.631s)
[505.035774] Starting dynamic subtest: D-eDP1
[509.626124] Dynamic subtest D-eDP1: SUCCESS (4.595s)
[509.628045] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.787s)
[510.525134] [097/131] (514s left) gem_mmap_gtt (basic-write)
[510.593262] Subtest basic-write: SKIP (0.000s)
[510.670609] [098/131] (514s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[510.770067] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[517.819732] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.051s)
[517.958559] [099/131] (506s left) kms_pm_backlight (fade)
[518.043998] Starting subtest: fade
[518.091114] Starting dynamic subtest: eDP-1
[520.754417] Dynamic subtest eDP-1: SUCCESS (2.662s)
[520.756768] Subtest fade: SUCCESS (2.711s)
[521.578995] [100/131] (503s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[526.599715] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[526.604211] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[527.487764] [101/131] (497s left) kms_cursor_crc (cursor-onscreen-256x256)
[527.732119] Starting subtest: cursor-onscreen-256x256
[527.741856] Starting dynamic subtest: pipe-A-eDP-1
[529.835473] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[529.860806] Starting dynamic subtest: pipe-D-eDP-1
[532.682334] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.828s)
[532.684733] Subtest cursor-onscreen-256x256: SUCCESS (4.949s)
[533.551423] [102/131] (491s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[533.648148] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[533.650354] Starting dynamic subtest: pipe-A-eDP-1
[533.659024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[533.668206] Starting dynamic subtest: pipe-B-eDP-1
[533.676971] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[533.685766] Starting dynamic subtest: pipe-C-eDP-1
[533.693994] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[533.702517] Starting dynamic subtest: pipe-D-eDP-1
[533.710754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[533.714827] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[535.896515] [103/131] (489s left) kms_plane_scaling (planes-downscale-factor-0-75)
[535.990966] Starting subtest: planes-downscale-factor-0-75
[535.993090] Starting dynamic subtest: pipe-A
[536.009983] Dynamic subtest pipe-A: SKIP (0.017s)
[536.019674] Starting dynamic subtest: pipe-B
[536.042108] Dynamic subtest pipe-B: SKIP (0.030s)
[536.051535] Starting dynamic subtest: pipe-C
[536.070263] Dynamic subtest pipe-C: SKIP (0.030s)
[536.079114] Starting dynamic subtest: pipe-D
[536.099145] Dynamic subtest pipe-D: SKIP (0.028s)
[536.102716] Subtest planes-downscale-factor-0-75: SKIP (0.107s)
[536.232281] [104/131] (488s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[536.294782] Starting subtest: etime-single-wait-all-for-submit-submitted
[536.400430] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[536.500457] [105/131] (488s left) gem_exec_balancer (sliced)
[536.578973] Starting subtest: sliced
[536.583609] Subtest sliced: SKIP (0.000s)
[536.911994] [106/131] (488s left) kms_chamelium_edid (dp-mode-timings)
[537.307797] Subtest dp-mode-timings: SKIP (0.000s)
[538.082201] [107/131] (487s left) kms_prop_blob (blob-prop-validate)
[538.146702] Starting subtest: blob-prop-validate
[538.149093] Subtest blob-prop-validate: SUCCESS (0.000s)
[538.291953] [108/131] (486s left) prime_mmap (test_userptr)
[538.353659] Starting subtest: test_userptr
[538.355852] Starting dynamic subtest: test_userptr-smem
[538.358086] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[538.360297] Subtest test_userptr: SUCCESS (0.001s)
[538.486689] [109/131] (486s left) gem_ctx_create (basic)
[538.566376] Starting subtest: basic
[538.568336] Subtest basic: SUCCESS (0.000s)
[538.771792] [110/131] (486s left) syncobj_timeline (single-wait-available-signaled)
[538.834260] Starting subtest: single-wait-available-signaled
[538.836731] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[538.969394] [111/131] (486s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[543.958139] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[543.960418] Starting dynamic subtest: pipe-A-eDP-1
[544.767921] Dynamic subtest pipe-A-eDP-1: SKIP (0.806s)
[544.777122] Starting dynamic subtest: pipe-B-eDP-1
[545.890355] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[545.894669] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.929s)
[547.097180] [112/131] (478s left) gem_tiled_swapping (non-threaded)
[547.166893] Subtest non-threaded: SKIP (0.000s)
[547.237670] [113/131] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[547.331339] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[547.335278] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[547.460008] [114/131] (477s left) i915_pm_rpm (system-suspend-execbuf)
[548.983873] Starting subtest: system-suspend-execbuf
[608.039314] Subtest system-suspend-execbuf: SUCCESS (43.382s)
[608.439498] [115/131] (416s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[608.521340] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[608.523590] Starting dynamic subtest: pipe-A-default-mode
[608.823126] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[608.827451] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.302s)
[609.655097] [116/131] (415s left) kms_big_fb (linear-addfb)
[609.753540] Starting subtest: linear-addfb
[609.755750] Subtest linear-addfb: SUCCESS (0.000s)
[609.879611] [117/131] (415s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[609.991963] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[609.996337] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[610.127544] [118/131] (415s left) i915_query (query-regions-unallocated)
[610.184070] Starting subtest: query-regions-unallocated
[610.186334] Subtest query-regions-unallocated: SUCCESS (0.000s)
[610.303558] [119/131] (415s left) gem_ctx_persistence (idempotent)
[610.365419] Starting subtest: idempotent
[610.368512] Subtest idempotent: SUCCESS (0.000s)
[610.486294] [120/131] (415s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[610.587968] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[610.591331] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[610.728253] [121/131] (414s left) gem_exec_fence (nb-await)
[610.913525] Starting subtest: nb-await
[610.915888] Starting dynamic subtest: rcs0
[610.980340] Dynamic subtest rcs0: SUCCESS (0.066s)
[610.992044] Starting dynamic subtest: bcs0
[611.038162] Dynamic subtest bcs0: SUCCESS (0.057s)
[611.048339] Starting dynamic subtest: vcs0
[611.097841] Dynamic subtest vcs0: SUCCESS (0.057s)
[611.112387] Starting dynamic subtest: vcs1
[611.157411] Dynamic subtest vcs1: SUCCESS (0.057s)
[611.169428] Starting dynamic subtest: vecs0
[611.216985] Dynamic subtest vecs0: SUCCESS (0.057s)
[611.229426] Starting dynamic subtest: ccs0
[611.274867] Dynamic subtest ccs0: SUCCESS (0.056s)
[611.277587] Subtest nb-await: SUCCESS (0.362s)
[612.956762] [122/131] (412s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[613.066364] Starting subtest: basic-modeset-with-all-modifiers-formats
[613.455653] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[614.221606] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.766s)
[614.230996] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[614.242967] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[614.251423] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[614.265188] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[614.276227] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[614.421039] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[614.435674] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[614.443090] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[614.453810] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[614.466078] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[614.486907] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[614.489759] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[614.509246] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[614.511579] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[614.522650] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[614.531752] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[614.540726] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[614.553736] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[614.562739] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[614.576287] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[614.585525] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[614.598077] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[614.607033] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[614.742957] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.143s)
[614.753126] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[614.765187] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[614.774117] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[614.787237] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[614.796129] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[614.809511] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[614.820830] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[614.831789] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[614.842509] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[614.854095] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[614.863069] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[614.876071] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[614.884672] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[614.898358] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[614.909362] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[614.920666] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[614.929786] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[615.076587] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[615.087965] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[615.099003] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[615.108092] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[615.121398] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[615.131704] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[615.143285] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[615.151994] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[615.165617] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[615.174128] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[615.187861] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[615.199036] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[615.209644] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[615.218492] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[615.231571] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[615.239851] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[615.253999] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[615.636741] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.571s)
[616.460886] [123/131] (409s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[616.575044] Starting subtest: crc-primary-basic-yf-tiled-ccs
[616.577223] Starting dynamic subtest: pipe-A-eDP-1
[616.600758] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[616.611718] Starting dynamic subtest: pipe-B-eDP-1
[616.633043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[616.641502] Starting dynamic subtest: pipe-C-eDP-1
[616.662883] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[616.674778] Starting dynamic subtest: pipe-D-eDP-1
[616.698261] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[616.702518] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[618.794519] [124/131] (407s left) kms_psr (fbc-pr-primary-mmap-cpu)
[618.899000] Starting subtest: fbc-pr-primary-mmap-cpu
[618.903245] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[618.999332] [125/131] (406s left) kms_draw_crc (draw-method-mmap-gtt)
[619.104781] Starting subtest: draw-method-mmap-gtt
[619.109276] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[619.230044] [126/131] (406s left) gem_exec_balancer (busy)
[619.295618] Starting subtest: busy
[620.816577] Subtest busy: SUCCESS (1.522s)
[621.164476] [127/131] (404s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[621.285865] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[632.461551] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.179s)
[633.333397] [128/131] (392s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[633.447665] Starting subtest: x-tiled-64bpp-rotate-0
[634.902436] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.456s)
[635.298339] [129/131] (390s left) gem_softpin (noreloc-interruptible)
[635.356001] Starting subtest: noreloc-interruptible
[640.777996] Subtest noreloc-interruptible: SUCCESS (5.422s)
[640.931691] [130/131] (385s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[641.046813] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[641.051204] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[641.183960] [131/131] (384s left) gem_exec_schedule (deep)
[641.353693] Starting subtest: deep
[641.356155] Starting dynamic subtest: rcs0
[646.197973] Dynamic subtest rcs0: SKIP (4.842s)
[646.210639] Starting dynamic subtest: vcs0
[656.316270] Dynamic subtest vcs0: SUCCESS (10.124s)
[656.328195] Starting dynamic subtest: vcs1
[667.781175] Dynamic subtest vcs1: SUCCESS (11.463s)
[667.794487] Starting dynamic subtest: vecs0
[678.509871] Dynamic subtest vecs0: SUCCESS (10.724s)
[678.521163] Starting dynamic subtest: ccs0
[690.263716] Dynamic subtest ccs0: SUCCESS (11.750s)
[690.266480] Subtest deep: SUCCESS (48.908s)
[691.598638] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_plane_cursor
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_joiner
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: kms_universal_plane
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: kms_plane_multiple
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_reg_read
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: gem_close_race
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_ctx_isolation
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: gem_ctx_shared
results: parsing output: 35/ for test: gem_exec_store
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_ctx_exec
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_gpgpu_fill
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_getfb
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: i915_pm_freq_api
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: syncobj_basic
results: parsing output: 58/ for test: gem_busy
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_vblank
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_exec_flush
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_ctx_engines
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: prime_vgem
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: syncobj_eventfd
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pm_backlight
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_chamelium_edid
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: gem_ctx_create
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: gem_tiled_swapping
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_pm_rpm
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: i915_query
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_draw_crc
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_exec_schedule
Done.