[69.547782] Initializing watchdogs
[69.547824]   /dev/watchdog0
[69.560993] [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]
[69.565344] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.567634] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.571834] [001/133] (960s left) api_intel_bb (full-batch)
[69.656092] Starting subtest: full-batch
[69.666014] Subtest full-batch: SUCCESS (0.012s)
[69.757160] [002/133] (960s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[69.867828] Starting subtest: x-tiled-64bpp-rotate-90
[69.902975] Subtest x-tiled-64bpp-rotate-90: SKIP (0.034s)
[70.001382] [003/133] (960s left) vgem_basic (second-client)
[70.065975] Starting subtest: second-client
[70.088061] Subtest second-client: SUCCESS (0.022s)
[70.138132] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[70.141280] [004/133] (960s left) i915_drm_fdinfo (context-close-stress)
[70.183937] Starting subtest: context-close-stress
[80.930249] Subtest context-close-stress: SUCCESS (10.745s)
[81.006407] [005/133] (949s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[81.254953] Starting subtest: primary-yf-tiled-reflect-x-90
[81.259477] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[81.325876] [006/133] (948s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[81.412754] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[81.514938] [007/133] (948s left) gen9_exec_parse (basic-rejected-ctx-param)
[81.571062] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[81.646251] [008/133] (948s left) kms_flip (flip-vs-panning-interruptible)
[81.741150] Starting subtest: flip-vs-panning-interruptible
[81.743455] Starting dynamic subtest: A-eDP1
[90.493747] Dynamic subtest A-eDP1: SUCCESS (8.752s)
[90.503718] Starting dynamic subtest: B-eDP1
[99.217220] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[99.226042] Starting dynamic subtest: C-eDP1
[107.929777] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[107.938570] Starting dynamic subtest: D-eDP1
[116.665127] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[116.669447] Subtest flip-vs-panning-interruptible: SUCCESS (34.930s)
[117.828235] [009/133] (912s left) gem_exec_schedule (manyslice)
[117.897078] Starting subtest: manyslice
[117.899448] Starting dynamic subtest: rcs0
[122.508575] Dynamic subtest rcs0: SUCCESS (4.621s)
[122.520563] Starting dynamic subtest: bcs0
[129.136244] Dynamic subtest bcs0: SUCCESS (6.625s)
[129.147146] Starting dynamic subtest: vcs0
[135.223430] Dynamic subtest vcs0: SUCCESS (6.088s)
[135.235659] Starting dynamic subtest: vcs1
[140.822533] Dynamic subtest vcs1: SUCCESS (5.597s)
[140.834933] Starting dynamic subtest: vecs0
[146.406990] Dynamic subtest vecs0: SUCCESS (5.584s)
[146.419746] Starting dynamic subtest: ccs0
[152.576095] Dynamic subtest ccs0: SUCCESS (6.168s)
[152.578873] Subtest manyslice: SUCCESS (34.689s)
[152.878990] [010/133] (877s left) kms_joiner (basic-max-non-joiner)
[152.979246] Starting subtest: basic-max-non-joiner
[152.983295] Subtest basic-max-non-joiner: SKIP (0.000s)
[153.048274] [011/133] (877s left) syncobj_timeline (host-signal-points)
[153.113984] Starting subtest: host-signal-points
[153.118822] Subtest host-signal-points: SUCCESS (0.005s)
[153.209986] [012/133] (877s left) kms_cursor_legacy (single-move)
[153.327362] Starting subtest: single-move
[153.329547] Starting dynamic subtest: pipe-A
[158.711059] Dynamic subtest pipe-A: SUCCESS (5.379s)
[158.720961] Starting dynamic subtest: pipe-B
[164.092511] Dynamic subtest pipe-B: SUCCESS (5.380s)
[164.101655] Starting dynamic subtest: pipe-C
[169.474933] Dynamic subtest pipe-C: SUCCESS (5.379s)
[169.483727] Starting dynamic subtest: pipe-D
[174.854329] Dynamic subtest pipe-D: SUCCESS (5.379s)
[174.863715] Starting dynamic subtest: all-pipes
[180.241813] Dynamic subtest all-pipes: SUCCESS (5.385s)
[180.244297] Subtest single-move: SUCCESS (26.910s)
[180.398494] [013/133] (850s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[180.500361] Starting subtest: pipe-fbc-rte
[180.506976] Starting dynamic subtest: pipe-B-eDP-1
[185.968766] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.472s)
[185.976301] Subtest pipe-fbc-rte: SUCCESS (5.474s)
[188.226294] [014/133] (842s left) gem_exec_params (no-bsd)
[188.284361] Starting subtest: no-bsd
[188.286620] Subtest no-bsd: SUCCESS (0.002s)
[189.990570] [015/133] (840s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[190.077907] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[193.679936] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.606s)
[194.853480] [016/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[194.950384] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[194.954736] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[195.045850] [017/133] (835s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[195.166062] Starting subtest: 2x-cursor-vs-flip-atomic
[195.171032] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[195.317043] [018/133] (835s left) gem_render_copy_redux (flink-interruptible)
[195.372437] Starting subtest: flink-interruptible
[196.146983] Subtest flink-interruptible: SUCCESS (0.775s)
[196.282853] [019/133] (834s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[196.377365] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[196.381208] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[197.468406] [020/133] (833s left) vgem_basic (sysfs)
[197.514918] Starting subtest: sysfs
[197.516863] Subtest sysfs: SUCCESS (0.000s)
[197.568998] [021/133] (833s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[197.614910] Starting subtest: multi-wait-all-for-submit-available-submitted
[197.617306] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[197.708694] [022/133] (833s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[197.793915] Starting subtest: fbc-pr-cursor-mmap-cpu
[197.798244] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[197.862870] [023/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[197.963060] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[197.967307] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[198.039834] [024/133] (832s left) syncobj_basic (test-valid-cycle)
[198.086732] Starting subtest: test-valid-cycle
[198.089055] Subtest test-valid-cycle: SUCCESS (0.000s)
[198.180898] [025/133] (832s left) kms_cursor_crc (cursor-random-128x128)
[198.370535] Starting subtest: cursor-random-128x128
[198.375264] Starting dynamic subtest: pipe-A-eDP-1
[201.695719] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.319s)
[201.722523] Starting dynamic subtest: pipe-D-eDP-1
[205.668677] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.953s)
[205.670988] Subtest cursor-random-128x128: SUCCESS (7.297s)
[206.554238] [026/133] (824s left) vgem_basic (mmap)
[206.609241] Starting subtest: mmap
[206.627807] Subtest mmap: SUCCESS (0.023s)
[206.687274] [027/133] (824s left) kms_content_protection (uevent)
[206.823966] Starting subtest: uevent
[206.828660] Subtest uevent: SKIP (0.000s)
[206.928114] [028/133] (824s left) kms_plane (plane-position-covered)
[207.030762] Starting subtest: plane-position-covered
[207.569584] Starting dynamic subtest: pipe-A-plane-1
[208.851769] Dynamic subtest pipe-A-plane-1: SUCCESS (1.282s)
[208.860844] Starting dynamic subtest: pipe-A-plane-2
[210.192429] Dynamic subtest pipe-A-plane-2: SUCCESS (1.338s)
[210.200280] Starting dynamic subtest: pipe-A-plane-3
[211.484964] Dynamic subtest pipe-A-plane-3: SUCCESS (1.291s)
[211.493116] Starting dynamic subtest: pipe-A-plane-4
[212.742432] Dynamic subtest pipe-A-plane-4: SUCCESS (1.256s)
[212.750503] Starting dynamic subtest: pipe-A-plane-5
[212.766042] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[213.970918] Starting dynamic subtest: pipe-B-plane-1
[215.229168] Dynamic subtest pipe-B-plane-1: SUCCESS (1.268s)
[215.242159] Starting dynamic subtest: pipe-B-plane-2
[216.517319] Dynamic subtest pipe-B-plane-2: SUCCESS (1.289s)
[216.526517] Starting dynamic subtest: pipe-B-plane-3
[217.754782] Dynamic subtest pipe-B-plane-3: SUCCESS (1.237s)
[217.763763] Starting dynamic subtest: pipe-B-plane-4
[218.993569] Dynamic subtest pipe-B-plane-4: SUCCESS (1.235s)
[219.001889] Starting dynamic subtest: pipe-B-plane-5
[219.017264] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[219.019367] Subtest plane-position-covered: SUCCESS (11.986s)
[219.788778] [029/133] (811s left) perf_pmu (init-sema)
[219.840434] Starting subtest: init-sema
[219.842261] Starting dynamic subtest: rcs0
[219.844478] Dynamic subtest rcs0: SUCCESS (0.004s)
[219.852353] Starting dynamic subtest: bcs0
[219.854630] Dynamic subtest bcs0: SUCCESS (0.001s)
[219.861517] Starting dynamic subtest: vcs0
[219.863634] Dynamic subtest vcs0: SUCCESS (0.001s)
[219.870342] Starting dynamic subtest: vcs1
[219.872148] Dynamic subtest vcs1: SUCCESS (0.001s)
[219.878739] Starting dynamic subtest: vecs0
[219.880567] Dynamic subtest vecs0: SUCCESS (0.001s)
[219.887456] Starting dynamic subtest: ccs0
[219.889643] Dynamic subtest ccs0: SUCCESS (0.000s)
[219.891520] Subtest init-sema: SUCCESS (0.011s)
[219.949599] [030/133] (811s left) gem_mmap_gtt (basic)
[220.002614] Subtest basic: SKIP (0.000s)
[220.063151] [031/133] (811s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[220.163572] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[220.168100] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[220.262068] [032/133] (811s left) kms_plane_cursor (primary)
[220.354351] Starting subtest: primary
[220.358843] Starting dynamic subtest: pipe-A-eDP-1-size-64
[222.918060] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.563s)
[222.939908] Starting dynamic subtest: pipe-A-eDP-1-size-128
[225.496021] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[225.519739] Starting dynamic subtest: pipe-A-eDP-1-size-256
[228.131687] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.616s)
[228.444892] Starting dynamic subtest: pipe-B-eDP-1-size-64
[231.690527] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.254s)
[231.716485] Starting dynamic subtest: pipe-B-eDP-1-size-128
[234.258441] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[234.281335] Starting dynamic subtest: pipe-B-eDP-1-size-256
[236.892307] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.616s)
[237.216188] Starting dynamic subtest: pipe-C-eDP-1-size-64
[240.172259] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.965s)
[240.196683] Starting dynamic subtest: pipe-C-eDP-1-size-128
[242.362322] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[242.386921] Starting dynamic subtest: pipe-C-eDP-1-size-256
[244.550113] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[244.867081] Starting dynamic subtest: pipe-D-eDP-1-size-64
[247.795231] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.938s)
[247.819471] Starting dynamic subtest: pipe-D-eDP-1-size-128
[250.005646] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[250.030302] Starting dynamic subtest: pipe-D-eDP-1-size-256
[252.206563] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[252.514065] Subtest primary: SUCCESS (32.158s)
[253.332885] [033/133] (777s left) gem_exec_params (invalid-ring2)
[253.392676] Starting subtest: invalid-ring2
[253.395139] Subtest invalid-ring2: SUCCESS (0.000s)
[253.491792] [034/133] (777s left) gem_madvise (dontneed-after-mmap)
[253.536687] Starting subtest: dontneed-after-mmap
[253.552050] Subtest dontneed-after-mmap: SUCCESS (0.017s)
[253.640028] [035/133] (777s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[253.709576] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[253.790849] [036/133] (777s left) gem_pxp (create-valid-protected-context)
[253.909501] Starting subtest: create-valid-protected-context
[253.912066] Subtest create-valid-protected-context: SUCCESS (0.002s)
[254.015613] [037/133] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[254.108207] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[254.112565] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[254.197891] [038/133] (777s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[254.256648] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[254.261541] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[254.434978] [039/133] (777s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[254.558964] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[254.563630] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[254.699308] [040/133] (776s left) prime_self_import (basic-with_one_bo)
[254.733477] Starting subtest: basic-with_one_bo
[254.749869] Subtest basic-with_one_bo: SUCCESS (0.020s)
[254.869894] [041/133] (776s left) perf (gen12-unprivileged-single-ctx-counters)
[254.989596] Starting subtest: gen12-unprivileged-single-ctx-counters
[254.991777] Starting dynamic subtest: rcs0
[255.098961] Dynamic subtest rcs0: SUCCESS (0.110s)
[255.101256] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.111s)
[255.147827] [042/133] (776s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[255.217407] Starting subtest: single-wait-for-submit-unsubmitted
[255.324214] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[255.411355] [043/133] (776s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[255.520744] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[259.520394] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.005s)
[260.649354] [044/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[260.744884] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[260.748854] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[260.817338] [045/133] (770s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[260.921227] Starting subtest: extended-modeset-hang-newfb-with-reset
[260.923116] Starting dynamic subtest: pipe-A
[275.211876] Dynamic subtest pipe-A: SUCCESS (14.291s)
[275.222419] Starting dynamic subtest: pipe-D
[291.080778] Dynamic subtest pipe-D: SUCCESS (15.863s)
[291.083121] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.161s)
[291.879629] [046/133] (739s left) i915_pm_rpm (system-suspend-devices)
[294.109899] Starting subtest: system-suspend-devices
[301.874565] Subtest system-suspend-devices: SUCCESS (7.767s)
[302.250242] [047/133] (729s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[302.347329] Starting subtest: addfb25-y-tiled-legacy
[302.349192] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[302.445028] [048/133] (729s left) gem_mmap_gtt (flink-race)
[302.509293] Subtest flink-race: SKIP (0.000s)
[302.564682] [049/133] (729s left) kms_cursor_crc (cursor-offscreen-max-size)
[302.876190] Starting subtest: cursor-offscreen-max-size
[302.882746] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[302.987809] [050/133] (728s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[303.045932] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[303.146845] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[303.222079] [051/133] (728s left) kms_lease (multimaster-lease)
[303.312697] Starting subtest: multimaster-lease
[303.316968] Subtest multimaster-lease: SUCCESS (0.003s)
[303.422699] [052/133] (728s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[303.507661] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[303.511092] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[303.579425] [053/133] (728s left) gem_eio (wait-10ms)
[303.783479] Starting subtest: wait-10ms
[304.102551] Subtest wait-10ms: SUCCESS (0.319s)
[304.227191] [054/133] (727s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[304.287842] Starting subtest: multi-wait-for-submit-available-signaled
[304.289737] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[304.402588] [055/133] (727s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[304.489290] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[304.492984] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[304.604485] [056/133] (727s left) kms_rotation_crc (cursor-rotation-180)
[304.699465] Starting subtest: cursor-rotation-180
[306.216556] Subtest cursor-rotation-180: SUCCESS (1.517s)
[307.407972] [057/133] (724s left) gem_exec_fence (syncobj-signal)
[307.861885] Starting subtest: syncobj-signal
[307.866582] Subtest syncobj-signal: SUCCESS (0.006s)
[308.962496] [058/133] (723s left) kms_vblank (query-busy-hang)
[309.063945] Starting subtest: query-busy-hang
[309.066278] Starting dynamic subtest: pipe-A-eDP-1
[335.636780] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.571s)
[335.650757] Starting dynamic subtest: pipe-D-eDP-1
[360.671061] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s)
[360.673466] Subtest query-busy-hang: SUCCESS (51.606s)
[361.484865] [059/133] (670s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[361.597186] Starting subtest: verify-pxp-key-change-after-suspend-resume
[368.774057] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.178s)
[369.901520] [060/133] (663s left) syncobj_timeline (single-wait-available-signaled)
[369.966503] Starting subtest: single-wait-available-signaled
[369.968507] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[370.064170] [061/133] (663s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[370.163656] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[370.167863] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[370.234583] [062/133] (663s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[370.341291] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[370.976446] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[371.136856] [063/133] (662s left) kms_pm_rpm (pm-tiling)
[373.062511] Starting subtest: pm-tiling
[373.067580] Subtest pm-tiling: SKIP (0.000s)
[373.427351] [064/133] (660s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[373.508060] Starting subtest: plane-upscale-factor-0-25-with-rotation
[373.510302] Starting dynamic subtest: pipe-A
[373.732094] Dynamic subtest pipe-A: SUCCESS (0.226s)
[373.740567] Starting dynamic subtest: pipe-B
[374.996855] Dynamic subtest pipe-B: SUCCESS (1.263s)
[375.005305] Starting dynamic subtest: pipe-C
[376.325561] Dynamic subtest pipe-C: SUCCESS (1.327s)
[376.334489] Starting dynamic subtest: pipe-D
[377.657710] Dynamic subtest pipe-D: SUCCESS (1.331s)
[377.659910] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.152s)
[378.838954] [065/133] (654s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[378.898280] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[379.003101] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[379.072526] [066/133] (654s left) gem_exec_parallel (contexts)
[379.137848] Starting subtest: contexts
[379.140196] Starting dynamic subtest: rcs0
[381.969676] Dynamic subtest rcs0: SUCCESS (2.830s)
[381.980678] Starting dynamic subtest: bcs0
[385.555791] Dynamic subtest bcs0: SUCCESS (3.584s)
[385.567678] Starting dynamic subtest: vcs0
[389.420618] Dynamic subtest vcs0: SUCCESS (3.862s)
[389.434262] Starting dynamic subtest: vcs1
[393.426686] Dynamic subtest vcs1: SUCCESS (4.004s)
[393.435258] Starting dynamic subtest: vecs0
[397.336309] Dynamic subtest vecs0: SUCCESS (3.906s)
[397.345117] Starting dynamic subtest: ccs0
[400.981093] Dynamic subtest ccs0: SUCCESS (3.644s)
[400.984349] Subtest contexts: SUCCESS (21.843s)
[401.167668] [067/133] (632s left) kms_plane_alpha_blend (alpha-7efc)
[401.266720] Starting subtest: alpha-7efc
[401.554562] Starting dynamic subtest: pipe-A-eDP-1
[402.160402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[402.186178] Starting dynamic subtest: pipe-D-eDP-1
[403.446993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.265s)
[403.449216] Subtest alpha-7efc: SUCCESS (2.181s)
[404.303648] [068/133] (629s left) i915_suspend (fence-restore-tiled2untiled)
[404.369242] Starting subtest: fence-restore-tiled2untiled
[404.374060] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[404.462878] [069/133] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[404.555589] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[411.275905] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.723s)
[411.400871] [070/133] (622s left) kms_psr (psr2-sprite-mmap-gtt)
[411.495920] Starting subtest: psr2-sprite-mmap-gtt
[411.498218] Starting dynamic subtest: eDP-1
[412.934582] Dynamic subtest eDP-1: SKIP (1.435s)
[412.939462] Subtest psr2-sprite-mmap-gtt: SKIP (1.437s)
[413.079375] [071/133] (620s left) gem_ctx_isolation (nonpriv-switch)
[413.147169] Starting subtest: nonpriv-switch
[413.149825] Starting dynamic subtest: rcs0
[413.432520] Dynamic subtest rcs0: SUCCESS (0.285s)
[413.443347] Starting dynamic subtest: bcs0
[413.737726] Dynamic subtest bcs0: SUCCESS (0.304s)
[413.748929] Starting dynamic subtest: vcs0
[414.026408] Dynamic subtest vcs0: SUCCESS (0.287s)
[414.036945] Starting dynamic subtest: vcs1
[415.183941] Dynamic subtest vcs1: SUCCESS (1.156s)
[415.194518] Starting dynamic subtest: vecs0
[417.208772] Dynamic subtest vecs0: SUCCESS (2.023s)
[417.218357] Starting dynamic subtest: ccs0
[419.230648] Dynamic subtest ccs0: SUCCESS (2.021s)
[419.232994] Subtest nonpriv-switch: SUCCESS (6.085s)
[419.480052] [072/133] (614s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[419.575790] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[419.578069] Starting dynamic subtest: pipe-A-eDP-1
[419.601288] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[419.610838] Starting dynamic subtest: pipe-B-eDP-1
[419.632314] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[419.641200] Starting dynamic subtest: pipe-C-eDP-1
[419.662575] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[419.671121] Starting dynamic subtest: pipe-D-eDP-1
[419.693223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[419.697161] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[421.739188] [073/133] (612s left) gem_softpin (softpin)
[421.803709] Starting subtest: softpin
[454.176318] Subtest softpin: SUCCESS (32.369s)
[454.284656] [074/133] (579s left) gem_blits (basic)
[454.348633] Starting subtest: basic
[456.454296] Subtest basic: SUCCESS (2.103s)
[456.594592] [075/133] (577s left) kms_draw_crc (draw-method-mmap-gtt)
[456.699858] Starting subtest: draw-method-mmap-gtt
[456.704226] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[456.801772] [076/133] (577s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[456.895019] Starting subtest: fbc-psr2-primary-mmap-gtt
[456.897321] Starting dynamic subtest: eDP-1
[456.901680] Dynamic subtest eDP-1: SKIP (0.000s)
[456.906119] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[456.968856] [077/133] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[457.065489] Starting subtest: psr-1p-primscrn-spr-indfb-move
[464.570099] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.509s)
[464.691879] [078/133] (569s left) gem_exercise_blt (fast-copy-emit)
[464.760786] Starting subtest: fast-copy-emit
[464.763028] Starting dynamic subtest: linear-smem-smem-emit
[464.781086] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[464.790775] Starting dynamic subtest: xmajor-smem-smem-emit
[464.797978] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[464.806237] Starting dynamic subtest: tile4-smem-smem-emit
[464.814182] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[464.822597] Starting dynamic subtest: tile64-smem-smem-emit
[464.830796] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[464.833176] Subtest fast-copy-emit: SUCCESS (0.072s)
[464.957039] [079/133] (569s left) sysfs_heartbeat_interval (nopreempt)
[465.015947] Starting subtest: nopreempt
[465.018255] Starting dynamic subtest: vecs0
[474.899713] Dynamic subtest vecs0: SUCCESS (9.880s)
[474.911058] Starting dynamic subtest: ccs0
[478.859848] Dynamic subtest ccs0: SUCCESS (3.959s)
[478.872910] Starting dynamic subtest: vcs0
[488.926325] Dynamic subtest vcs0: SUCCESS (10.066s)
[488.938058] Starting dynamic subtest: bcs0
[492.881098] Dynamic subtest bcs0: SUCCESS (3.951s)
[492.894222] Starting dynamic subtest: rcs0
[496.972642] Dynamic subtest rcs0: SUCCESS (4.091s)
[496.984057] Starting dynamic subtest: vcs1
[506.905572] Dynamic subtest vcs1: SUCCESS (9.932s)
[506.908074] Subtest nopreempt: SUCCESS (41.890s)
[506.983901] [080/133] (527s left) gem_ctx_shared (q-in-order)
[507.034478] Starting subtest: Q-in-order
[507.036889] Starting dynamic subtest: rcs0
[507.212059] Dynamic subtest rcs0: SUCCESS (0.175s)
[507.223842] Starting dynamic subtest: vcs0
[507.340813] Dynamic subtest vcs0: SUCCESS (0.128s)
[507.356102] Starting dynamic subtest: vcs1
[507.449048] Dynamic subtest vcs1: SUCCESS (0.107s)
[507.466595] Starting dynamic subtest: vecs0
[507.569436] Dynamic subtest vecs0: SUCCESS (0.120s)
[507.585903] Starting dynamic subtest: ccs0
[507.716211] Dynamic subtest ccs0: SUCCESS (0.143s)
[507.719047] Subtest Q-in-order: SUCCESS (0.680s)
[508.981287] [081/133] (525s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[509.078864] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[509.083306] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[509.187253] [082/133] (525s left) gem_readwrite (read-bad-handle)
[509.250944] Subtest read-bad-handle: SKIP (0.000s)
[509.306264] [083/133] (524s left) gem_ctx_persistence (processes)
[509.363098] Starting subtest: processes
[510.944544] Subtest processes: SUCCESS (1.581s)
[511.024194] [084/133] (523s left) kms_hdr (static-swap)
[511.110048] Starting subtest: static-swap
[511.116641] Subtest static-swap: SKIP (0.000s)
[511.203283] [085/133] (523s left) kms_chamelium_hpd (vga-hpd)
[511.575156] Subtest vga-hpd: SKIP (0.000s)
[512.347284] [086/133] (522s left) kms_big_fb (linear-32bpp-rotate-0)
[512.443130] Starting subtest: linear-32bpp-rotate-0
[514.022305] Subtest linear-32bpp-rotate-0: SUCCESS (1.578s)
[514.166943] [087/133] (520s left) kms_psr (psr2-cursor-blt)
[514.274943] Starting subtest: psr2-cursor-blt
[514.276989] Starting dynamic subtest: eDP-1
[516.039152] Dynamic subtest eDP-1: SUCCESS (1.761s)
[516.041289] Subtest psr2-cursor-blt: SUCCESS (1.763s)
[516.831674] [088/133] (517s left) gem_exec_capture (pi)
[516.889270] Starting subtest: pi
[516.891630] Starting dynamic subtest: rcs0
[521.124318] Dynamic subtest rcs0: SUCCESS (4.237s)
[521.133397] Starting dynamic subtest: bcs0
[525.033164] Dynamic subtest bcs0: SUCCESS (3.907s)
[525.042730] Starting dynamic subtest: vcs0
[528.907889] Dynamic subtest vcs0: SUCCESS (3.872s)
[528.918340] Starting dynamic subtest: vcs1
[532.881735] Dynamic subtest vcs1: SUCCESS (3.973s)
[532.892044] Starting dynamic subtest: vecs0
[536.798953] Dynamic subtest vecs0: SUCCESS (3.915s)
[536.811081] Starting dynamic subtest: ccs0
[540.783464] Dynamic subtest ccs0: SUCCESS (3.983s)
[540.785826] Subtest pi: SUCCESS (23.897s)
[540.861996] [089/133] (493s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[541.011294] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[541.013610] Starting dynamic subtest: pipe-A-eDP-1
[541.034152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[541.044772] Starting dynamic subtest: pipe-B-eDP-1
[541.064556] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[541.073185] Starting dynamic subtest: pipe-C-eDP-1
[541.092785] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[541.101167] Starting dynamic subtest: pipe-D-eDP-1
[541.121663] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[541.123752] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[543.276604] [090/133] (491s left) gem_eio (in-flight-contexts-1us)
[543.474477] Starting subtest: in-flight-contexts-1us
[554.918072] Subtest in-flight-contexts-1us: SUCCESS (11.443s)
[555.098836] [091/133] (479s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[555.185311] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[555.189843] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[556.303471] [092/133] (478s left) kms_pm_backlight (fade)
[556.392797] Starting subtest: fade
[556.473042] Starting dynamic subtest: eDP-1
[558.951078] Dynamic subtest eDP-1: SUCCESS (2.477s)
[558.953572] Subtest fade: SUCCESS (2.560s)
[559.832146] [093/133] (474s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[559.940509] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[559.944696] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[560.040218] [094/133] (474s left) gem_partial_pwrite_pread (write-uncached)
[560.095890] Subtest write-uncached: SKIP (0.000s)
[560.172719] [095/133] (474s left) gem_exec_schedule (reorder-wide)
[560.365950] Subtest reorder-wide: SKIP (0.000s)
[560.557361] [096/133] (474s left) gem_exec_params (sol-reset-invalid)
[560.609337] Starting subtest: sol-reset-invalid
[560.613972] Subtest sol-reset-invalid: SUCCESS (0.002s)
[562.044549] [097/133] (472s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[562.427834] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[563.244123] [098/133] (471s left) i915_pm_freq_api (freq-suspend)
[563.305682] Starting subtest: freq-suspend
[563.307883] Starting dynamic subtest: gt0
[579.840918] Dynamic subtest gt0: SUCCESS (1.252s)
[579.853211] Starting dynamic subtest: gt1
[595.873383] Dynamic subtest gt1: SUCCESS (1.199s)
[595.875639] Subtest freq-suspend: SUCCESS (2.455s)
[596.952532] [099/133] (439s left) syncobj_wait (wait-for-submit-delayed-submit)
[597.035005] Starting subtest: wait-for-submit-delayed-submit
[597.139559] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[597.230880] [100/133] (438s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[597.333867] Starting subtest: 4-tiled-8bpp-rotate-270
[597.356684] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[597.469534] [101/133] (438s left) kms_fbcon_fbt (psr-suspend)
[597.546392] Starting subtest: psr-suspend
[646.876575] Subtest psr-suspend: SUCCESS (19.590s)
[646.981843] [102/133] (389s left) gem_softpin (overlap)
[647.051315] Starting subtest: overlap
[647.896922] Subtest overlap: SUCCESS (0.844s)
[648.023743] [103/133] (388s left) kms_frontbuffer_tracking (fbc-stridechange)
[648.118809] Starting subtest: fbc-stridechange
[651.442425] Subtest fbc-stridechange: SUCCESS (3.325s)
[652.649788] [104/133] (383s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[652.758117] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[652.763098] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[652.857198] [105/133] (383s left) kms_atomic_interruptible (legacy-cursor)
[652.958186] Starting subtest: legacy-cursor
[652.960745] Starting dynamic subtest: pipe-A-eDP-1
[660.360235] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.397s)
[660.363229] Subtest legacy-cursor: SUCCESS (7.398s)
[661.210653] [106/133] (375s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[661.303281] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[661.308211] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[661.371408] [107/133] (374s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[661.479497] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[661.481817] Starting dynamic subtest: pipe-A-eDP-1
[662.290734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[662.303954] Starting dynamic subtest: pipe-B-eDP-1
[663.919437] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.620s)
[663.930339] Starting dynamic subtest: pipe-C-eDP-1
[665.444447] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.524s)
[665.455472] Starting dynamic subtest: pipe-D-eDP-1
[667.024364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.577s)
[667.027236] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.533s)
[668.145094] [108/133] (368s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[668.246032] Starting subtest: psr2-cursor-plane-update-sf
[668.248535] Starting dynamic subtest: pipe-A-eDP-1
[668.809531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.571s)
[668.822494] Starting dynamic subtest: pipe-B-eDP-1
[670.138186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[670.140832] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.897s)
[671.013302] [109/133] (365s left) gem_exec_flush (basic-batch-kernel-default-wb)
[671.084818] Starting subtest: basic-batch-kernel-default-wb
[678.737762] Subtest basic-batch-kernel-default-wb: SUCCESS (7.654s)
[678.933511] [110/133] (357s left) gem_mmap (bad-size)
[679.005206] Subtest bad-size: SKIP (0.000s)
[679.075564] [111/133] (357s left) gem_softpin (allocator-evict)
[679.128869] Starting subtest: allocator-evict
[679.131342] Starting dynamic subtest: rcs0
[702.846443] Dynamic subtest rcs0: SUCCESS (23.717s)
[702.858556] Starting dynamic subtest: bcs0
[726.295481] Dynamic subtest bcs0: SUCCESS (23.441s)
[726.307811] Starting dynamic subtest: vcs0
[749.912689] Dynamic subtest vcs0: SUCCESS (23.615s)
[749.924585] Starting dynamic subtest: vcs1
[773.907841] Dynamic subtest vcs1: SUCCESS (23.996s)
[773.917570] Starting dynamic subtest: vecs0
[797.587132] Dynamic subtest vecs0: SUCCESS (23.675s)
[797.598531] Starting dynamic subtest: ccs0
[821.403753] Dynamic subtest ccs0: SUCCESS (23.810s)
[821.406267] Subtest allocator-evict: SUCCESS (142.262s)
[821.490686] [112/133] (215s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[821.638241] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[821.661408] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.022s)
[821.743532] [113/133] (214s left) gem_exec_schedule (deep)
[821.937339] Starting subtest: deep
[821.940446] Starting dynamic subtest: rcs0
[827.435478] Dynamic subtest rcs0: SKIP (5.492s)
[827.448476] Starting dynamic subtest: vcs0
[838.069616] Dynamic subtest vcs0: SUCCESS (10.634s)
[838.080785] Starting dynamic subtest: vcs1
[849.499606] Dynamic subtest vcs1: SUCCESS (11.423s)
[849.510731] Starting dynamic subtest: vecs0
[860.591115] Dynamic subtest vecs0: SUCCESS (11.088s)
[860.608565] Starting dynamic subtest: ccs0
[873.553311] Dynamic subtest ccs0: SUCCESS (12.960s)
[873.556426] Subtest deep: SUCCESS (51.605s)
[874.563924] [114/133] (162s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[874.680480] Starting subtest: basic-busy-flip-before-cursor-varying-size
[874.686308] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[874.830909] [115/133] (161s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[874.935175] Starting subtest: basic-flip-after-cursor-varying-size
[875.907854] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.974s)
[876.756226] [116/133] (160s left) kms_vblank (ts-continuation-idle-hang)
[876.844284] Starting subtest: ts-continuation-idle-hang
[876.846436] Starting dynamic subtest: pipe-A-eDP-1
[903.482730] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.641s)
[903.496924] Starting dynamic subtest: pipe-D-eDP-1
[928.498187] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[928.501105] Subtest ts-continuation-idle-hang: SUCCESS (51.658s)
[929.321252] [117/133] (107s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[929.390511] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[929.510417] [118/133] (107s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[929.603193] Starting subtest: psr-rgb101010-draw-blt
[936.937941] Subtest psr-rgb101010-draw-blt: SUCCESS (7.336s)
[937.057066] [119/133] ( 99s left) gem_close_race (multigpu-basic-threads)
[937.133855] Starting subtest: multigpu-basic-threads
[937.139570] Subtest multigpu-basic-threads: SKIP (0.000s)
[937.364874] [120/133] ( 99s left) dmabuf_sync_file (import-basic)
[937.416495] Starting subtest: import-basic
[937.419259] Subtest import-basic: SUCCESS (0.002s)
[937.469545] [121/133] ( 99s left) prime_busy (before-wait)
[937.525450] Starting subtest: before-wait
[937.528509] Starting dynamic subtest: rcs0
[937.560725] Dynamic subtest rcs0: SUCCESS (0.034s)
[937.571898] Starting dynamic subtest: bcs0
[937.602816] Dynamic subtest bcs0: SUCCESS (0.041s)
[937.613141] Starting dynamic subtest: vcs0
[937.642944] Dynamic subtest vcs0: SUCCESS (0.039s)
[937.653600] Starting dynamic subtest: vcs1
[937.685079] Dynamic subtest vcs1: SUCCESS (0.041s)
[937.700704] Starting dynamic subtest: vecs0
[937.726368] Dynamic subtest vecs0: SUCCESS (0.041s)
[937.736658] Starting dynamic subtest: ccs0
[937.770211] Dynamic subtest ccs0: SUCCESS (0.043s)
[937.878024] Subtest before-wait: SUCCESS (0.354s)
[937.959519] [122/133] ( 99s left) gem_fence_thrash (bo-write-verify-threaded-none)
[938.005397] Starting subtest: bo-write-verify-threaded-none
[938.032878] Subtest bo-write-verify-threaded-none: SKIP (0.023s)
[938.097021] [123/133] ( 98s left) kms_psr (psr-suspend)
[938.188771] Starting subtest: psr-suspend
[938.191183] Starting dynamic subtest: eDP-1
[956.294717] Dynamic subtest eDP-1: SUCCESS (2.944s)
[956.297112] Subtest psr-suspend: SUCCESS (2.945s)
[957.172035] [124/133] ( 79s left) gem_readwrite (new-obj)
[957.241676] Subtest new-obj: SKIP (0.000s)
[957.306190] [125/133] ( 79s left) kms_frontbuffer_tracking (fbc-suspend)
[957.404529] Starting subtest: fbc-suspend
[995.341051] Subtest fbc-suspend: SUCCESS (7.423s)
[996.554665] [126/133] ( 40s left) gem_exec_whisper (basic-forked)
[996.623744] Starting subtest: basic-forked
[1003.959203] Subtest basic-forked: SUCCESS (7.336s)
[1004.163595] [127/133] ( 33s left) kms_atomic_transition (modeset-transition)
[1004.264640] Starting subtest: modeset-transition
[1004.266858] Starting dynamic subtest: 1x-outputs
[1015.067676] Dynamic subtest 1x-outputs: SUCCESS (10.804s)
[1015.070464] Subtest modeset-transition: SUCCESS (10.806s)
[1015.949964] [128/133] ( 21s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[1016.060928] Starting subtest: plane-lut1d-pre-ctm3x4
[1016.194955] Starting dynamic subtest: pipe-A-plane-0
[1016.624585] Dynamic subtest pipe-A-plane-0: FAIL (0.215s)
[1016.636237] Starting dynamic subtest: pipe-A-plane-1
[1016.885824] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[1016.896552] Starting dynamic subtest: pipe-A-plane-2
[1017.137236] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[1017.918941] Starting dynamic subtest: pipe-B-plane-0
[1018.388796] Dynamic subtest pipe-B-plane-0: FAIL (0.176s)
[1018.400875] Starting dynamic subtest: pipe-B-plane-1
[1018.768532] Dynamic subtest pipe-B-plane-1: FAIL (0.154s)
[1018.779503] Starting dynamic subtest: pipe-B-plane-2
[1019.115776] Dynamic subtest pipe-B-plane-2: FAIL (0.687s)
[1020.152926] Starting dynamic subtest: pipe-C-plane-0
[1020.710863] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[1020.721756] Starting dynamic subtest: pipe-C-plane-1
[1021.150491] Dynamic subtest pipe-C-plane-1: FAIL (0.691s)
[1021.163828] Starting dynamic subtest: pipe-C-plane-2
[1021.590671] Dynamic subtest pipe-C-plane-2: FAIL (0.150s)
[1022.382493] Starting dynamic subtest: pipe-D-plane-0
[1023.012407] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[1023.022203] Starting dynamic subtest: pipe-D-plane-1
[1023.541809] Dynamic subtest pipe-D-plane-1: FAIL (0.641s)
[1023.552243] Starting dynamic subtest: pipe-D-plane-2
[1024.098266] Dynamic subtest pipe-D-plane-2: FAIL (0.654s)
[1024.115570] Subtest plane-lut1d-pre-ctm3x4: FAIL (8.055s)
[1024.947977] [129/133] ( 12s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[1025.048766] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[1025.054075] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[1025.143714] [130/133] ( 12s left) gem_exec_balancer (bonded-true-hang)
[1025.403314] Starting subtest: bonded-true-hang
[1025.408508] Subtest bonded-true-hang: SKIP (0.000s)
[1025.491778] [131/133] ( 11s left) api_intel_bb (blit-noreloc-keep-cache)
[1025.549850] Starting subtest: blit-noreloc-keep-cache
[1025.559967] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s)
[1025.678185] [132/133] ( 11s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[1025.770604] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[1025.775809] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[1025.854655] [133/133] ( 11s left) kms_psr (fbc-psr-cursor-plane-move)
[1025.941298] Starting subtest: fbc-psr-cursor-plane-move
[1025.943263] Starting dynamic subtest: eDP-1
[1025.947375] Dynamic subtest eDP-1: SKIP (0.000s)
[1025.952072] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[1026.012584] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_render_copy_redux
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_basic
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: perf_pmu
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane_cursor
results: parsing output: 32/ for test: gem_exec_params
results: parsing output: 33/ for test: gem_madvise
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_pxp
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_lease
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_parallel
results: parsing output: 66/ for test: kms_plane_alpha_blend
results: parsing output: 67/ for test: i915_suspend
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_ctx_isolation
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: gem_blits
results: parsing output: 74/ for test: kms_draw_crc
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exercise_blt
results: parsing output: 78/ for test: sysfs_heartbeat_interval
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_readwrite
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_exec_capture
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_pm_backlight
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_chamelium_edid
results: parsing output: 97/ for test: i915_pm_freq_api
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_fbcon_fbt
results: parsing output: 101/ for test: gem_softpin
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_atomic_interruptible
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: gem_mmap
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_close_race
results: parsing output: 119/ for test: dmabuf_sync_file
results: parsing output: 120/ for test: prime_busy
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_readwrite
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr
Done.