[61.881138] Initializing watchdogs
[61.881186]   /dev/watchdog0
[61.897628] [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]
[61.902573] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.904887] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.906908] [001/156] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[62.013441] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[62.015730] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[62.108952] [002/156] (960s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[62.208679] Starting subtest: y-tiled-32bpp-rotate-90
[62.210512] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[62.293710] [003/156] (960s left) gem_mmap_gtt (medium-copy)
[62.337127] Subtest medium-copy: SKIP (0.000s)
[62.390928] [004/156] (960s left) kms_psr (fbc-pr-primary-render)
[62.471656] Starting subtest: fbc-pr-primary-render
[62.473385] Subtest fbc-pr-primary-render: SKIP (0.000s)
[62.549031] [005/156] (959s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[62.650568] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[62.651666] Starting dynamic subtest: pipe-A-eDP-1
[62.655588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.662432] Starting dynamic subtest: pipe-B-eDP-1
[62.666263] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.672301] Starting dynamic subtest: pipe-C-eDP-1
[62.676883] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.683052] Starting dynamic subtest: pipe-D-eDP-1
[62.686863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.688598] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[65.342022] [006/156] (957s left) kms_vblank (query-forked-hang)
[65.439452] Starting subtest: query-forked-hang
[65.440468] Starting dynamic subtest: pipe-A-eDP-1
[92.080770] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.618s)
[92.089412] Starting dynamic subtest: pipe-D-eDP-1
[107.176737] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.091s)
[107.177638] Subtest query-forked-hang: SUCCESS (41.713s)
[108.026543] [007/156] (914s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[108.133607] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[108.135659] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.218134] [008/156] (914s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[108.311652] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[108.313412] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[108.405078] [009/156] (914s left) kms_psr (psr2-sprite-render)
[108.495529] Starting subtest: psr2-sprite-render
[108.496406] Starting dynamic subtest: eDP-1
[110.233702] Dynamic subtest eDP-1: SUCCESS (1.737s)
[110.234985] Subtest psr2-sprite-render: SUCCESS (1.738s)
[111.098783] [010/156] (911s left) kms_flip (dpms-vs-vblank-race)
[111.194961] Starting subtest: dpms-vs-vblank-race
[111.196904] Starting dynamic subtest: A-eDP1
[115.179459] Dynamic subtest A-eDP1: SUCCESS (3.982s)
[115.188782] Starting dynamic subtest: B-eDP1
[118.769530] Dynamic subtest B-eDP1: SUCCESS (3.589s)
[118.775962] Starting dynamic subtest: C-eDP1
[122.375055] Dynamic subtest C-eDP1: SUCCESS (3.604s)
[122.382816] Starting dynamic subtest: D-eDP1
[125.900546] Dynamic subtest D-eDP1: SUCCESS (3.525s)
[125.903541] Subtest dpms-vs-vblank-race: SUCCESS (14.708s)
[126.774609] [011/156] (895s left) kms_lease (master-vs-lease)
[126.864385] Starting subtest: master-vs-lease
[126.865524] Subtest master-vs-lease: SUCCESS (0.001s)
[126.966384] [012/156] (895s left) gem_create (busy-create)
[127.025026] Starting subtest: busy-create
[127.026295] Starting dynamic subtest: smem0
[160.360707] Dynamic subtest smem0: SUCCESS (33.324s)
[160.361935] Subtest busy-create: SUCCESS (33.325s)
[160.541748] [013/156] (862s left) gem_exec_params (cliprects_ptr-dirt)
[160.589374] Starting subtest: cliprects_ptr-dirt
[160.590543] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[160.675108] [014/156] (862s left) syncobj_timeline (single-wait-available-submitted)
[160.717198] Starting subtest: single-wait-available-submitted
[160.718246] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[160.807995] [015/156] (862s left) kms_rotation_crc (exhaust-fences)
[160.898338] Starting subtest: exhaust-fences
[160.900261] Subtest exhaust-fences: SKIP (0.000s)
[160.968927] [016/156] (861s left) kms_properties (plane-properties-atomic)
[161.055132] Starting subtest: plane-properties-atomic
[161.056028] Starting dynamic subtest: pipe-A-eDP-1
[161.602997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[161.610293] Starting dynamic subtest: pipe-B-eDP-1
[162.842579] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[162.849851] Starting dynamic subtest: pipe-C-eDP-1
[164.081465] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[164.090269] Starting dynamic subtest: pipe-D-eDP-1
[165.320690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s)
[165.321561] Subtest plane-properties-atomic: SUCCESS (4.266s)
[166.130005] [017/156] (856s left) i915_drm_fdinfo (busy-idle-check-all)
[166.165157] Starting subtest: busy-idle-check-all
[166.166532] Starting dynamic subtest: rcs0
[166.177261] Dynamic subtest rcs0: SKIP (0.003s)
[166.185883] Starting dynamic subtest: bcs0
[166.187785] Dynamic subtest bcs0: SKIP (0.000s)
[166.194317] Starting dynamic subtest: vcs0
[166.196367] Dynamic subtest vcs0: SKIP (0.000s)
[166.205663] Starting dynamic subtest: vcs1
[166.207574] Dynamic subtest vcs1: SKIP (0.000s)
[166.214099] Starting dynamic subtest: vecs0
[166.216037] Dynamic subtest vecs0: SKIP (0.001s)
[166.222883] Starting dynamic subtest: ccs0
[166.224826] Dynamic subtest ccs0: SKIP (0.000s)
[166.226751] Subtest busy-idle-check-all: SKIP (0.007s)
[166.252978] [018/156] (856s left) prime_vgem (basic-write)
[166.403643] Starting subtest: basic-write
[166.410712] Subtest basic-write: SKIP (0.006s)
[166.503615] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[166.505977] [019/156] (856s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[166.600383] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[166.602232] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[167.741612] [020/156] (855s left) kms_busy (extended-pageflip-hang-newfb)
[167.832977] Starting subtest: extended-pageflip-hang-newfb
[167.833842] Starting dynamic subtest: pipe-A
[194.099419] Dynamic subtest pipe-A: SUCCESS (26.262s)
[194.108717] Starting dynamic subtest: pipe-D
[218.177652] Dynamic subtest pipe-D: SUCCESS (24.076s)
[218.178563] Subtest extended-pageflip-hang-newfb: SUCCESS (50.342s)
[219.014178] [021/156] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[219.112834] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[226.112100] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.000s)
[226.239794] [022/156] (796s left) kms_cursor_crc (cursor-sliding-512x170)
[226.544750] Starting subtest: cursor-sliding-512x170
[226.546794] Subtest cursor-sliding-512x170: SKIP (0.001s)
[226.696919] [023/156] (796s left) gem_basic (multigpu-create-close)
[226.736504] Starting subtest: multigpu-create-close
[226.738418] Subtest multigpu-create-close: SKIP (0.000s)
[226.831829] [024/156] (796s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[226.927628] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[226.929406] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[227.020494] [025/156] (796s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[227.104679] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[227.106508] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[227.194082] [026/156] (796s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[227.291690] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[227.294054] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[227.389711] [027/156] (795s left) kms_cursor_crc (cursor-random-128x128)
[227.603980] Starting subtest: cursor-random-128x128
[227.606257] Starting dynamic subtest: pipe-A-eDP-1
[230.948943] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.343s)
[230.977863] Starting dynamic subtest: pipe-D-eDP-1
[235.001577] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.029s)
[235.002624] Subtest cursor-random-128x128: SUCCESS (7.397s)
[235.831733] [028/156] (787s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[235.918631] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[235.920526] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[236.024245] [029/156] (787s left) gem_exec_balancer (indices)
[236.075663] Starting subtest: indices
[238.282529] Subtest indices: SUCCESS (2.196s)
[238.589938] [030/156] (784s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[238.683382] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[242.887279] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.205s)
[244.046419] [031/156] (779s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[244.135896] Starting subtest: psr-rgb565-draw-blt
[251.316854] Subtest psr-rgb565-draw-blt: SUCCESS (7.182s)
[251.435773] [032/156] (771s left) gem_lmem_swapping (parallel-random-engines)
[251.472401] Subtest parallel-random-engines: SKIP (0.000s)
[251.508550] [033/156] (771s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[251.605621] Starting subtest: x-tiled-32bpp-rotate-90
[251.625164] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[251.724397] [034/156] (771s left) prime_vgem (sync)
[251.784264] Starting subtest: sync
[251.785260] Starting dynamic subtest: rcs0
[251.837351] Dynamic subtest rcs0: SUCCESS (0.053s)
[251.844383] Starting dynamic subtest: bcs0
[251.889814] Dynamic subtest bcs0: SUCCESS (0.052s)
[251.898184] Starting dynamic subtest: vcs0
[251.939611] Dynamic subtest vcs0: SUCCESS (0.048s)
[251.946908] Starting dynamic subtest: vcs1
[251.985915] Dynamic subtest vcs1: SUCCESS (0.046s)
[251.993098] Starting dynamic subtest: vecs0
[252.032870] Dynamic subtest vecs0: SUCCESS (0.046s)
[252.039666] Starting dynamic subtest: ccs0
[252.079195] Dynamic subtest ccs0: SUCCESS (0.046s)
[252.080175] Subtest sync: SUCCESS (0.295s)
[252.201833] [035/156] (771s left) kms_prop_blob (blob-prop-core)
[252.244374] Starting subtest: blob-prop-core
[252.245289] Subtest blob-prop-core: SUCCESS (0.000s)
[252.333721] [036/156] (771s left) perf_pmu (semaphore-busy)
[252.367108] Starting subtest: semaphore-busy
[252.367984] Starting dynamic subtest: rcs0
[254.019894] Dynamic subtest rcs0: SUCCESS (1.643s)
[254.028200] Starting dynamic subtest: bcs0
[255.654569] Dynamic subtest bcs0: SUCCESS (1.633s)
[255.662227] Starting dynamic subtest: vcs0
[259.874944] Dynamic subtest vcs0: SUCCESS (4.218s)
[259.883844] Starting dynamic subtest: vcs1
[265.827558] Dynamic subtest vcs1: SUCCESS (5.950s)
[265.836984] Starting dynamic subtest: vecs0
[271.844204] Dynamic subtest vecs0: SUCCESS (6.013s)
[271.854205] Starting dynamic subtest: ccs0
[274.919234] Dynamic subtest ccs0: SUCCESS (3.074s)
[274.920298] Subtest semaphore-busy: SUCCESS (22.542s)
[275.033278] [037/156] (748s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[275.119160] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[275.214908] [038/156] (748s left) gem_exec_balancer (parallel-ordering)
[275.484146] Starting subtest: parallel-ordering
[276.554502] Subtest parallel-ordering: SUCCESS (1.070s)
[276.654960] [039/156] (746s left) kms_addfb_basic (bad-pitch-1024)
[276.697543] Starting subtest: bad-pitch-1024
[276.698497] Subtest bad-pitch-1024: SUCCESS (0.000s)
[276.818440] [040/156] (746s left) gem_ctx_shared (exec-shared-gtt)
[276.874548] Starting subtest: exec-shared-gtt
[276.875552] Starting dynamic subtest: rcs0
[276.885643] Dynamic subtest rcs0: SUCCESS (0.011s)
[276.896446] Starting dynamic subtest: bcs0
[276.898513] Dynamic subtest bcs0: SUCCESS (0.006s)
[276.907432] Starting dynamic subtest: vcs0
[276.908245] Dynamic subtest vcs0: SUCCESS (0.010s)
[276.915476] Starting dynamic subtest: vcs1
[276.916397] Dynamic subtest vcs1: SUCCESS (0.006s)
[276.923906] Starting dynamic subtest: vecs0
[276.924983] Dynamic subtest vecs0: SUCCESS (0.005s)
[276.932202] Starting dynamic subtest: ccs0
[276.933060] Dynamic subtest ccs0: SUCCESS (0.005s)
[276.933922] Subtest exec-shared-gtt: SUCCESS (0.046s)
[277.097549] [041/156] (746s left) device_reset (unbind-cold-reset-rebind)
[277.141595] Starting subtest: unbind-cold-reset-rebind
[277.143511] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[277.196845] [042/156] (746s left) prime_vgem (basic-gtt)
[277.266687] Starting subtest: basic-gtt
[277.268663] Subtest basic-gtt: SKIP (0.000s)
[277.365476] [043/156] (746s left) gem_pwrite_snooped
[277.487669] [044/156] (746s left) gem_userptr_blits (invalid-null-pointer)
[277.543044] Starting subtest: invalid-null-pointer
[277.543948] Subtest invalid-null-pointer: SUCCESS (0.001s)
[277.670161] [045/156] (746s left) perf (invalid-oa-metric-set-id)
[277.781386] Starting subtest: invalid-oa-metric-set-id
[277.795649] Subtest invalid-oa-metric-set-id: SUCCESS (0.015s)
[277.831828] [046/156] (746s left) gem_ctx_persistence (userptr)
[277.893105] Starting subtest: userptr
[278.123589] Subtest userptr: SUCCESS (0.231s)
[278.198801] [047/156] (745s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[278.291459] Starting subtest: primary-yf-tiled-reflect-x-180
[278.351150] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[278.448993] [048/156] (745s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[278.536411] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[278.537325] Starting dynamic subtest: pipe-A
[278.875166] Dynamic subtest pipe-A: SUCCESS (0.340s)
[278.882776] Starting dynamic subtest: pipe-B
[280.282703] Dynamic subtest pipe-B: SUCCESS (1.407s)
[280.290729] Starting dynamic subtest: pipe-C
[281.718912] Dynamic subtest pipe-C: SUCCESS (1.436s)
[281.727857] Starting dynamic subtest: pipe-D
[283.176786] Dynamic subtest pipe-D: SUCCESS (1.457s)
[283.177658] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.642s)
[284.332343] [049/156] (739s left) api_intel_bb (delta-check)
[284.379940] Starting subtest: delta-check
[284.385775] Subtest delta-check: SUCCESS (0.006s)
[284.510359] [050/156] (739s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[284.595455] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[284.597156] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[284.690308] [051/156] (739s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[284.780865] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[284.782848] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[284.892591] [052/156] (739s left) gem_userptr_blits (create-destroy-unsync)
[284.953381] Subtest create-destroy-unsync: SKIP (0.000s)
[285.064611] [053/156] (739s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[285.155673] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[285.157468] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[285.242110] [054/156] (738s left) kms_async_flips (test-cursor)
[285.326373] Starting subtest: test-cursor
[285.704871] Starting dynamic subtest: pipe-A-eDP-1
[286.523632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[286.904237] Starting dynamic subtest: pipe-B-eDP-1
[287.653982] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[288.032585] Starting dynamic subtest: pipe-C-eDP-1
[288.790045] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[289.159266] Starting dynamic subtest: pipe-D-eDP-1
[289.920683] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[289.921713] Subtest test-cursor: SUCCESS (4.595s)
[291.090386] [055/156] (733s left) kms_chamelium_audio (dp-audio-edid)
[291.465705] Subtest dp-audio-edid: SKIP (0.000s)
[292.294238] [056/156] (731s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[292.349548] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[292.350504] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[292.438126] [057/156] (731s left) kms_psr (pr-primary-mmap-gtt)
[292.524396] Starting subtest: pr-primary-mmap-gtt
[292.526077] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[292.595664] [058/156] (731s left) syncobj_wait (multi-wait-signaled)
[292.645800] Starting subtest: multi-wait-signaled
[292.646871] Subtest multi-wait-signaled: SUCCESS (0.000s)
[292.738992] [059/156] (731s left) syncobj_timeline (invalid-wait-bad-flags)
[292.793168] Starting subtest: invalid-wait-bad-flags
[292.794405] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[292.873249] [060/156] (731s left) api_intel_bb (lot-of-buffers)
[292.922434] Starting subtest: lot-of-buffers
[294.094572] Subtest lot-of-buffers: SUCCESS (1.164s)
[294.417018] [061/156] (729s left) gem_ctx_persistence (engines-mixed)
[294.483375] Starting subtest: engines-mixed
[294.484349] Starting dynamic subtest: rcs0
[294.560882] Dynamic subtest rcs0: SUCCESS (0.076s)
[294.571937] Starting dynamic subtest: bcs0
[294.611768] Dynamic subtest bcs0: SUCCESS (0.049s)
[294.623527] Starting dynamic subtest: vcs0
[294.656633] Dynamic subtest vcs0: SUCCESS (0.043s)
[294.665747] Starting dynamic subtest: vcs1
[294.700360] Dynamic subtest vcs1: SUCCESS (0.043s)
[294.715421] Starting dynamic subtest: vecs0
[294.748513] Dynamic subtest vecs0: SUCCESS (0.046s)
[294.759434] Starting dynamic subtest: ccs0
[294.814731] Dynamic subtest ccs0: SUCCESS (0.064s)
[294.816230] Subtest engines-mixed: SUCCESS (0.332s)
[294.903161] [062/156] (729s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[295.022712] Starting subtest: flip-vs-cursor-varying-size
[304.349231] Subtest flip-vs-cursor-varying-size: SUCCESS (9.325s)
[305.153870] [063/156] (719s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[305.251418] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[305.253121] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[305.340615] [064/156] (719s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[305.427853] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[305.429656] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[305.539502] [065/156] (718s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[305.627072] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[305.628140] Starting dynamic subtest: pipe-A-eDP-1
[306.081334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[306.092592] Starting dynamic subtest: pipe-B-eDP-1
[306.103374] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[306.113816] Starting dynamic subtest: pipe-C-eDP-1
[306.122612] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[306.130382] Starting dynamic subtest: pipe-D-eDP-1
[306.137975] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[306.139273] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.470s)
[308.414890] [066/156] (716s left) gem_exec_schedule (preempt-queue-chain)
[308.481769] Subtest preempt-queue-chain: SKIP (0.000s)
[308.790253] [067/156] (715s left) kms_psr (fbc-psr-cursor-render)
[308.882358] Starting subtest: fbc-psr-cursor-render
[308.883257] Starting dynamic subtest: eDP-1
[308.885027] Dynamic subtest eDP-1: SKIP (0.000s)
[308.886720] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[308.962128] [068/156] (715s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[309.052064] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[309.053649] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[309.153656] [069/156] (715s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[309.252609] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[309.262536] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[309.359094] [070/156] (715s left) kms_big_fb (linear-8bpp-rotate-180)
[309.451893] Starting subtest: linear-8bpp-rotate-180
[310.722324] Subtest linear-8bpp-rotate-180: SUCCESS (1.271s)
[310.835666] [071/156] (713s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[310.889771] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[310.890977] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[311.010250] [072/156] (713s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[311.071544] Starting subtest: x-tiled-to-vebox-yf-tiled
[311.073520] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[311.250407] [073/156] (713s left) gen9_exec_parse (batch-zero-length)
[311.304359] Subtest batch-zero-length: SKIP (0.000s)
[311.385445] [074/156] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[311.478924] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[311.480617] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.576937] [075/156] (713s left) kms_chamelium_edid (dp-mode-timings)
[311.955276] Subtest dp-mode-timings: SKIP (0.000s)
[312.821926] [076/156] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[312.917147] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[312.919020] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[312.995973] [077/156] (711s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[313.092068] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[320.229658] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.139s)
[320.324350] [078/156] (704s left) gem_softpin (32b-excludes-last-page)
[320.386990] Starting subtest: 32b-excludes-last-page
[320.393193] Subtest 32b-excludes-last-page: SUCCESS (0.006s)
[320.500767] [079/156] (704s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[320.540910] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[320.646248] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[320.717626] [080/156] (704s left) gem_exec_fence (submit67)
[320.887053] Starting subtest: submit67
[320.889192] Subtest submit67: SKIP (0.000s)
[322.392102] [081/156] (702s left) gem_exec_params (invalid-bsd1-flag-on-render)
[322.447028] Starting subtest: invalid-bsd1-flag-on-render
[322.447938] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[322.567307] [082/156] (702s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[322.674616] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[322.676469] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[322.798106] [083/156] (702s left) i915_pm_rpm (gem-evict-pwrite)
[324.519222] Starting subtest: gem-evict-pwrite
[324.522288] Subtest gem-evict-pwrite: SKIP (0.000s)
[325.043153] [084/156] (700s left) gem_exec_create (forked)
[325.094773] Starting subtest: forked
[325.095809] Starting dynamic subtest: smem
[346.283940] Dynamic subtest smem: SUCCESS (21.178s)
[346.285744] Subtest forked: SUCCESS (21.180s)
[346.473448] [085/156] (678s left) gem_mmap_offset (ptrace)
[346.524684] Starting subtest: ptrace
[346.527452] Starting dynamic subtest: smem0-wb
[346.545173] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[346.555565] Starting dynamic subtest: smem0-wc
[346.562073] Dynamic subtest smem0-wc: SUCCESS (0.016s)
[346.571236] Starting dynamic subtest: smem0-uc
[346.579362] Dynamic subtest smem0-uc: SUCCESS (0.017s)
[346.580341] Subtest ptrace: SUCCESS (0.057s)
[346.691359] [086/156] (678s left) perf (oa-exponents)
[346.797448] Starting subtest: oa-exponents
[346.798537] Starting dynamic subtest: 0-rcs0
[348.604549] Dynamic subtest 0-rcs0: SUCCESS (1.797s)
[348.613651] Starting dynamic subtest: 1-vcs0
[350.434570] Dynamic subtest 1-vcs0: SUCCESS (1.829s)
[350.435740] Subtest oa-exponents: SUCCESS (3.628s)
[350.472579] [087/156] (674s left) kms_lease (implicit-plane-lease)
[350.567954] Starting subtest: implicit-plane-lease
[350.570391] Subtest implicit-plane-lease: SUCCESS (0.002s)
[350.671982] [088/156] (674s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[350.770186] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[350.771026] Starting dynamic subtest: pipe-A-default-mode
[351.985695] Dynamic subtest pipe-A-default-mode: SKIP (1.212s)
[351.987519] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.214s)
[352.149856] [089/156] (673s left) perf (create-destroy-userspace-config)
[352.243054] Starting subtest: create-destroy-userspace-config
[352.262300] Subtest create-destroy-userspace-config: SUCCESS (0.021s)
[352.304032] [090/156] (673s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[352.396151] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[352.397198] Starting dynamic subtest: pipe-A-default-mode
[355.118037] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[355.119112] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.724s)
[355.948164] [091/156] (669s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[356.038769] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[356.039716] Starting dynamic subtest: pipe-A
[356.101879] Dynamic subtest pipe-A: SUCCESS (0.065s)
[356.109920] Starting dynamic subtest: pipe-B
[357.277976] Dynamic subtest pipe-B: SUCCESS (1.175s)
[357.289071] Starting dynamic subtest: pipe-C
[358.398452] Dynamic subtest pipe-C: SUCCESS (1.119s)
[358.407769] Starting dynamic subtest: pipe-D
[359.542373] Dynamic subtest pipe-D: SUCCESS (1.143s)
[359.543263] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.506s)
[360.691337] [092/156] (664s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[360.779689] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[360.781328] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.869538] [093/156] (664s left) gem_exec_reloc (basic-write-cpu-active)
[360.915345] Subtest basic-write-cpu-active: SKIP (0.000s)
[360.981144] [094/156] (664s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[361.352409] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[362.191523] [095/156] (663s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[362.281098] Starting subtest: stress-xrgb8888-ytiled
[362.282913] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[362.346073] [096/156] (663s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[362.435409] Starting subtest: 4-tiled-64bpp-rotate-270
[362.455107] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[362.573201] [097/156] (663s left) kms_cursor_crc (cursor-random-128x42)
[362.795672] Starting subtest: cursor-random-128x42
[362.840699] Subtest cursor-random-128x42: SKIP (0.043s)
[363.024694] [098/156] (662s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-render)
[363.108956] Starting subtest: hdr-rgb101010-draw-render
[363.110641] Subtest hdr-rgb101010-draw-render: SKIP (0.000s)
[363.200893] [099/156] (662s left) gem_exec_schedule (smoketest)
[363.375101] Starting subtest: smoketest
[363.376084] Starting dynamic subtest: rcs0
[368.919046] Dynamic subtest rcs0: SUCCESS (5.484s)
[368.931672] Starting dynamic subtest: bcs0
[374.429911] Dynamic subtest bcs0: SUCCESS (5.507s)
[374.440845] Starting dynamic subtest: vcs0
[379.919148] Dynamic subtest vcs0: SUCCESS (5.489s)
[379.934599] Starting dynamic subtest: vcs1
[385.423169] Dynamic subtest vcs1: SUCCESS (5.503s)
[385.433085] Starting dynamic subtest: vecs0
[390.915753] Dynamic subtest vecs0: SUCCESS (5.494s)
[390.928374] Starting dynamic subtest: ccs0
[396.378605] Dynamic subtest ccs0: SUCCESS (5.502s)
[396.379453] Subtest smoketest: SUCCESS (32.986s)
[396.550712] [100/156] (629s left) gem_exec_gttfill (engines)
[396.613589] Starting subtest: engines
[396.614701] Starting dynamic subtest: rcs0
[420.348993] Dynamic subtest rcs0: SUCCESS (23.733s)
[420.361891] Starting dynamic subtest: bcs0
[443.664873] Dynamic subtest bcs0: SUCCESS (23.313s)
[443.674013] Starting dynamic subtest: vcs0
[467.061385] Dynamic subtest vcs0: SUCCESS (23.394s)
[467.071047] Starting dynamic subtest: vcs1
[490.391720] Dynamic subtest vcs1: SUCCESS (23.328s)
[490.405263] Starting dynamic subtest: vecs0
[513.765061] Dynamic subtest vecs0: SUCCESS (23.370s)
[513.774868] Starting dynamic subtest: ccs0
[537.116387] Dynamic subtest ccs0: SUCCESS (23.349s)
[537.118081] Subtest engines: SUCCESS (140.497s)
[537.305633] [101/156] (488s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[537.450512] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[537.452332] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[537.553314] [102/156] (488s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[537.639631] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[537.641340] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[537.710761] [103/156] (488s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[537.804369] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[537.805976] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[537.917756] [104/156] (488s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[538.019915] Starting subtest: fbcpsrhdr-suspend
[538.021606] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[538.123701] [105/156] (487s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[538.217689] Starting subtest: 2x-plain-flip-ts-check-interruptible
[538.232493] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.013s)
[538.319909] [106/156] (487s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[538.439890] Starting subtest: cursorB-vs-flipA-legacy
[538.443328] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[538.581257] [107/156] (487s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[538.674252] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[538.675250] Starting dynamic subtest: pipe-A-eDP-1
[538.988678] Dynamic subtest pipe-A-eDP-1: SKIP (0.126s)
[539.048977] Starting dynamic subtest: pipe-B-eDP-1
[539.974421] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s)
[539.976286] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.302s)
[541.265628] [108/156] (484s left) gem_exec_suspend (basic-s4-devices)
[541.318062] Starting subtest: basic-S4-devices
[541.319360] Starting dynamic subtest: smem
[554.347640] Dynamic subtest smem: SUCCESS (13.018s)
[554.350214] Subtest basic-S4-devices: SUCCESS (13.021s)
[559.604551] [109/156] (471s left) kms_content_protection (atomic-dpms)
[559.773641] Starting subtest: atomic-dpms
[559.775567] Subtest atomic-dpms: SKIP (0.000s)
[559.904997] [110/156] (471s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[559.998710] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[560.000791] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.099261] [111/156] (471s left) kms_feature_discovery (dp-mst)
[560.206242] Starting subtest: dp-mst
[560.208072] Subtest dp-mst: SKIP (0.000s)
[560.292165] [112/156] (470s left) gem_mmap_gtt (big-copy-xy)
[560.339857] Subtest big-copy-XY: SKIP (0.000s)
[560.406762] [113/156] (470s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[560.506022] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[560.507958] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[560.637503] [114/156] (470s left) gem_eio (in-flight-immediate)
[560.890063] Starting subtest: in-flight-immediate
[569.402022] Subtest in-flight-immediate: SUCCESS (8.511s)
[569.602458] [115/156] (461s left) kms_vrr (flipline)
[569.689240] Starting subtest: flipline
[569.691950] Subtest flipline: SKIP (0.000s)
[569.760877] [116/156] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[569.854659] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[569.856443] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[569.954689] [117/156] (461s left) perf (gen12-oa-tlb-invalidate)
[570.095061] Starting subtest: gen12-oa-tlb-invalidate
[570.096161] Starting dynamic subtest: 0-rcs0
[580.177029] Dynamic subtest 0-rcs0: SUCCESS (10.037s)
[580.190013] Starting dynamic subtest: 1-vcs1
[590.182386] Dynamic subtest 1-vcs1: SUCCESS (10.048s)
[590.183776] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s)
[590.233385] [118/156] (441s left) syncobj_wait (reset-multiple-signaled)
[590.321100] Starting subtest: reset-multiple-signaled
[590.322079] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[590.433106] [119/156] (441s left) gem_userptr_blits (stress-purge)
[590.509574] Starting subtest: stress-purge
[595.962061] Subtest stress-purge: SUCCESS (5.452s)
[596.113744] [120/156] (435s left) i915_query (engine-info)
[596.204761] Starting subtest: engine-info
[596.209516] Subtest engine-info: SUCCESS (0.006s)
[596.343598] [121/156] (435s left) gem_close (many-handles-one-vma)
[596.399425] Starting subtest: many-handles-one-vma
[596.446953] Subtest many-handles-one-vma: SUCCESS (0.047s)
[596.553761] [122/156] (435s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[596.661498] Starting subtest: yf-tiled-32bpp-rotate-270
[596.663810] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[596.753827] [123/156] (434s left) gem_mmap_gtt (hang-user)
[596.814536] Subtest hang-user: SKIP (0.000s)
[596.887171] [124/156] (434s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[596.985888] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[596.987033] Starting dynamic subtest: pipe-A-eDP-1
[596.995948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[597.006655] Starting dynamic subtest: pipe-B-eDP-1
[597.014314] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[597.024288] Starting dynamic subtest: pipe-C-eDP-1
[597.031618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[597.041561] Starting dynamic subtest: pipe-D-eDP-1
[597.048927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[597.049787] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[599.274972] [125/156] (432s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[599.369881] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[599.372040] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[599.479882] [126/156] (432s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[599.578400] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[599.579227] Starting dynamic subtest: pipe-A-eDP-1
[605.456122] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.877s)
[605.466449] Starting dynamic subtest: pipe-B-eDP-1
[612.091049] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s)
[612.092188] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.513s)
[612.981304] [127/156] (418s left) sw_sync (sync_expired_merge)
[613.025618] Starting subtest: sync_expired_merge
[614.108915] Subtest sync_expired_merge: SUCCESS (1.074s)
[614.160251] [128/156] (417s left) sysfs_defaults (readonly)
[614.213243] Starting subtest: readonly
[614.214040] Starting dynamic subtest: vecs0
[614.214923] Dynamic subtest vecs0: SUCCESS (0.000s)
[614.225482] Starting dynamic subtest: ccs0
[614.226384] Dynamic subtest ccs0: SUCCESS (0.000s)
[614.236630] Starting dynamic subtest: vcs0
[614.237510] Dynamic subtest vcs0: SUCCESS (0.000s)
[614.247626] Starting dynamic subtest: bcs0
[614.248527] Dynamic subtest bcs0: SUCCESS (0.000s)
[614.258305] Starting dynamic subtest: rcs0
[614.259220] Dynamic subtest rcs0: SUCCESS (0.000s)
[614.268960] Starting dynamic subtest: vcs1
[614.270078] Dynamic subtest vcs1: SUCCESS (0.000s)
[614.271269] Subtest readonly: SUCCESS (0.006s)
[614.307283] [129/156] (417s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[614.400857] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[614.402438] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[614.498861] [130/156] (417s left) kms_psr (fbc-psr2-cursor-plane-move)
[614.582662] Starting subtest: fbc-psr2-cursor-plane-move
[614.583717] Starting dynamic subtest: eDP-1
[614.585672] Dynamic subtest eDP-1: SKIP (0.000s)
[614.587504] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[614.655502] [131/156] (417s left) gem_softpin (allocator-nopin-reserve)
[614.705398] Starting subtest: allocator-nopin-reserve
[614.804116] Subtest allocator-nopin-reserve: SUCCESS (0.098s)
[614.939432] [132/156] (417s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[615.026959] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[617.548311] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.521s)
[618.676888] [133/156] (413s left) kms_color (gamma)
[618.771420] Starting subtest: gamma
[618.772437] Starting dynamic subtest: pipe-A-eDP-1
[619.493403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[619.504838] Starting dynamic subtest: pipe-B-eDP-1
[620.893456] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[620.903893] Starting dynamic subtest: pipe-C-eDP-1
[622.263246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[622.273352] Starting dynamic subtest: pipe-D-eDP-1
[623.625562] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s)
[623.626432] Subtest gamma: SUCCESS (4.854s)
[624.496590] [134/156] (407s left) gem_exec_whisper (basic-fds)
[624.559078] Starting subtest: basic-fds
[632.224933] Subtest basic-fds: SUCCESS (7.664s)
[632.407686] [135/156] (399s left) i915_hangman (gt-engine-hang)
[632.464850] Starting subtest: gt-engine-hang
[632.465675] Starting dynamic subtest: rcs0
[634.315645] Dynamic subtest rcs0: SUCCESS (1.839s)
[634.327293] Starting dynamic subtest: bcs0
[636.298242] Dynamic subtest bcs0: SUCCESS (1.980s)
[636.312128] Starting dynamic subtest: vcs0
[638.280895] Dynamic subtest vcs0: SUCCESS (1.980s)
[638.294503] Starting dynamic subtest: vcs1
[640.329302] Dynamic subtest vcs1: SUCCESS (2.045s)
[640.339919] Starting dynamic subtest: vecs0
[642.314198] Dynamic subtest vecs0: SUCCESS (1.982s)
[642.327685] Starting dynamic subtest: ccs0
[644.233085] Dynamic subtest ccs0: SUCCESS (1.916s)
[644.234699] Subtest gt-engine-hang: SUCCESS (11.760s)
[644.367792] [136/156] (387s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[644.489955] Starting subtest: 2x-long-flip-vs-cursor-atomic
[644.492397] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[644.630869] [137/156] (387s left) prime_vgem (basic-fence-flip)
[644.698131] Starting subtest: basic-fence-flip
[645.014013] Subtest basic-fence-flip: SUCCESS (0.316s)
[645.118222] [138/156] (387s left) prime_mmap (test_refcounting)
[645.173437] Starting subtest: test_refcounting
[645.174430] Starting dynamic subtest: test_refcounting-smem
[645.208209] Dynamic subtest test_refcounting-smem: SUCCESS (0.036s)
[645.209455] Subtest test_refcounting: SUCCESS (0.037s)
[645.308287] [139/156] (387s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[645.397322] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[645.398945] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[645.495430] [140/156] (386s left) prime_mmap (test_forked)
[645.541411] Starting subtest: test_forked
[645.542326] Starting dynamic subtest: test_forked-smem
[645.591297] Dynamic subtest test_forked-smem: SUCCESS (0.049s)
[645.592486] Subtest test_forked: SUCCESS (0.051s)
[645.699959] [141/156] (386s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[645.792203] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[645.793971] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[645.878536] [142/156] (386s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[645.964700] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[645.966583] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[646.051933] [143/156] (386s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[646.141506] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[646.143396] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[646.261673] [144/156] (386s left) kms_pm_rpm (i2c)
[648.505891] Starting subtest: i2c
[653.878777] Subtest i2c: SUCCESS (5.372s)
[653.963185] [145/156] (378s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[654.057585] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[654.059185] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[654.151642] [146/156] (378s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[654.253534] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[654.255338] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[654.350865] [147/156] (378s left) gem_readwrite (read-bad-handle)
[654.406402] Subtest read-bad-handle: SKIP (0.000s)
[654.472902] [148/156] (378s left) gem_mmap_gtt (basic-write-gtt)
[654.515649] Subtest basic-write-gtt: SKIP (0.000s)
[654.574075] [149/156] (378s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[654.675254] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[654.676882] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[654.761752] [150/156] (378s left) gem_mmap_gtt (cpuset-big-copy)
[654.810865] Subtest cpuset-big-copy: SKIP (0.000s)
[654.872345] [151/156] (377s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[654.961804] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[658.557380] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.596s)
[659.755435] [152/156] (373s left) kms_cursor_legacy (torture-move)
[659.881630] Starting subtest: torture-move
[659.882563] Starting dynamic subtest: pipe-A
[665.880963] Dynamic subtest pipe-A: SUCCESS (5.952s)
[665.896226] Starting dynamic subtest: pipe-B
[672.661079] Dynamic subtest pipe-B: SUCCESS (6.815s)
[672.682679] Starting dynamic subtest: pipe-C
[679.097454] Dynamic subtest pipe-C: SUCCESS (6.434s)
[679.120729] Starting dynamic subtest: pipe-D
[686.560901] Dynamic subtest pipe-D: SUCCESS (7.461s)
[686.579639] Starting dynamic subtest: all-pipes
[693.006056] Dynamic subtest all-pipes: SUCCESS (6.448s)
[693.006846] Subtest torture-move: SUCCESS (33.119s)
[693.161744] [153/156] (339s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[693.212264] Starting subtest: wait-all-for-submit-delayed-submit
[693.314211] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[693.394458] [154/156] (339s left) kms_getfb (getfb-reject-nv12)
[693.493218] Starting subtest: getfb-reject-nv12
[693.495076] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[693.619457] [155/156] (339s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[693.713206] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[693.715872] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[693.787046] [156/156] (339s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[693.880444] Starting subtest: primary-4-tiled-reflect-x-0
[701.189366] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.308s)
[702.414839] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: gem_create
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: gem_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: kms_prop_blob
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_ctx_shared
results: parsing output: 40/ for test: device_reset
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_pwrite_snooped
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: api_intel_bb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: kms_chamelium_audio
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_chamelium_edid
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_pm_rpm
results: parsing output: 83/ for test: gem_exec_create
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_pipe_stress
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: gem_exec_gttfill
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: gem_exec_suspend
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_feature_discovery
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: gem_close
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: sw_sync
results: parsing output: 127/ for test: sysfs_defaults
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_color
results: parsing output: 133/ for test: gem_exec_whisper
results: parsing output: 134/ for test: i915_hangman
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: prime_vgem
results: parsing output: 137/ for test: prime_mmap
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: prime_mmap
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_pm_rpm
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_readwrite
results: parsing output: 147/ for test: gem_mmap_gtt
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_mmap_gtt
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: syncobj_wait
results: parsing output: 153/ for test: kms_getfb
results: parsing output: 154/ for test: kms_plane
results: parsing output: 155/ for test: kms_rotation_crc
Done.