[63.454194] Initializing watchdogs
[63.454245]   /dev/watchdog0
[63.470227] [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]
[63.474779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.477243] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.479576] [001/133] (960s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[63.584981] Starting subtest: pipe-fbc-rte
[63.587861] Starting dynamic subtest: pipe-B-eDP-1
[69.062771] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.473s)
[69.067349] Subtest pipe-fbc-rte: SUCCESS (5.475s)
[71.322709] [002/133] (952s left) gem_exec_schedule (timeslicing)
[71.384174] Starting subtest: timeslicing
[71.385184] Starting dynamic subtest: rcs0
[71.405624] Dynamic subtest rcs0: SUCCESS (0.022s)
[71.414698] Starting dynamic subtest: bcs0
[71.427061] Dynamic subtest bcs0: SUCCESS (0.021s)
[71.433839] Starting dynamic subtest: vcs0
[71.446882] Dynamic subtest vcs0: SUCCESS (0.020s)
[71.453494] Starting dynamic subtest: vcs1
[71.467609] Dynamic subtest vcs1: SUCCESS (0.020s)
[71.474428] Starting dynamic subtest: vecs0
[71.487212] Dynamic subtest vecs0: SUCCESS (0.020s)
[71.493221] Starting dynamic subtest: ccs0
[71.508240] Dynamic subtest ccs0: SUCCESS (0.021s)
[71.509374] Subtest timeslicing: SUCCESS (0.125s)
[73.356187] [003/133] (950s left) kms_cursor_edge_walk (256x256-top-bottom)
[73.578438] Starting subtest: 256x256-top-bottom
[73.579322] Starting dynamic subtest: pipe-A-eDP-1
[76.997880] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[77.010230] Starting dynamic subtest: pipe-D-eDP-1
[80.122161] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[80.123040] Subtest 256x256-top-bottom: SUCCESS (6.551s)
[80.925169] [004/133] (943s left) kms_cursor_crc (cursor-dpms)
[81.060420] Starting subtest: cursor-dpms
[81.061655] Starting dynamic subtest: pipe-A-eDP-1
[84.096906] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.035s)
[84.104944] Starting dynamic subtest: pipe-D-eDP-1
[87.821198] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.722s)
[87.822381] Subtest cursor-dpms: SUCCESS (6.759s)
[88.640569] [005/133] (935s left) kms_psr (fbc-pr-dpms)
[88.727382] Starting subtest: fbc-pr-dpms
[88.729219] Subtest fbc-pr-dpms: SKIP (0.000s)
[88.790562] [006/133] (935s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[88.871486] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[88.872519] Starting dynamic subtest: pipe-A-eDP-1
[88.881590] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[88.888348] Starting dynamic subtest: pipe-B-eDP-1
[88.897579] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[88.904267] Starting dynamic subtest: pipe-C-eDP-1
[88.913458] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[88.919983] Starting dynamic subtest: pipe-D-eDP-1
[88.928032] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[88.929536] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[91.178964] [007/133] (932s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[91.268879] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[91.280350] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[91.353436] [008/133] (932s left) syncobj_timeline (signal-point-0)
[91.414415] Starting subtest: signal-point-0
[91.415668] Subtest signal-point-0: SUCCESS (0.000s)
[91.498214] [009/133] (932s left) gem_exec_params (invalid-flag)
[91.546218] Starting subtest: invalid-flag
[91.547249] Subtest invalid-flag: SUCCESS (0.000s)
[91.628792] [010/133] (932s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[91.711947] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[91.713587] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[91.779667] [011/133] (932s left) gem_close_race (multigpu-basic-process)
[91.829718] Starting subtest: multigpu-basic-process
[91.831683] Subtest multigpu-basic-process: SKIP (0.000s)
[92.054310] [012/133] (932s left) kms_universal_plane (universal-plane-functional)
[92.132046] Starting subtest: universal-plane-functional
[92.133340] Starting dynamic subtest: pipe-A-eDP-1
[96.046018] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.911s)
[96.055453] Starting dynamic subtest: pipe-B-eDP-1
[100.567339] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.521s)
[100.576543] Starting dynamic subtest: pipe-C-eDP-1
[104.787833] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.219s)
[104.794720] Starting dynamic subtest: pipe-D-eDP-1
[108.972227] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.182s)
[108.973105] Subtest universal-plane-functional: SUCCESS (16.837s)
[109.763702] [013/133] (914s left) perf (per-context-mode-unprivileged)
[109.886945] Starting subtest: per-context-mode-unprivileged
[109.888639] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[109.920493] [014/133] (914s left) gem_set_tiling_vs_gtt
[110.021631] [015/133] (914s left) api_intel_allocator (simple-allocator)
[110.074463] Starting subtest: simple-allocator
[110.075412] Starting dynamic subtest: basic
[110.077860] Dynamic subtest basic: SUCCESS (0.003s)
[110.087337] Starting dynamic subtest: parallel-one
[110.257759] Dynamic subtest parallel-one: SUCCESS (0.171s)
[110.265910] Starting dynamic subtest: print
[110.267060] Dynamic subtest print: SUCCESS (0.000s)
[110.273681] Starting dynamic subtest: reuse
[110.274510] Dynamic subtest reuse: SUCCESS (0.000s)
[110.280969] Starting dynamic subtest: reserve
[110.281849] Dynamic subtest reserve: SUCCESS (0.000s)
[110.288609] Starting dynamic subtest: fork-reopen-allocator
[110.289504] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[110.290383] Subtest simple-allocator: SUCCESS (0.194s)
[110.376748] [016/133] (914s left) gem_exec_parallel (contexts)
[110.432094] Starting subtest: contexts
[110.433132] Starting dynamic subtest: rcs0
[113.818064] Dynamic subtest rcs0: SUCCESS (3.376s)
[113.828250] Starting dynamic subtest: bcs0
[117.217430] Dynamic subtest bcs0: SUCCESS (3.398s)
[117.227501] Starting dynamic subtest: vcs0
[121.660569] Dynamic subtest vcs0: SUCCESS (4.441s)
[121.669737] Starting dynamic subtest: vcs1
[125.729701] Dynamic subtest vcs1: SUCCESS (4.067s)
[125.740958] Starting dynamic subtest: vecs0
[129.707254] Dynamic subtest vecs0: SUCCESS (3.975s)
[129.715246] Starting dynamic subtest: ccs0
[133.205627] Dynamic subtest ccs0: SUCCESS (3.498s)
[133.206617] Subtest contexts: SUCCESS (22.764s)
[133.384147] [017/133] (891s left) gem_tiled_swapping (non-threaded)
[133.430392] Subtest non-threaded: SKIP (0.000s)
[133.477480] [018/133] (891s left) gen9_exec_parse (allowed-all)
[133.538037] Subtest allowed-all: SKIP (0.000s)
[133.608634] [019/133] (890s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[133.702121] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[133.703913] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[134.795810] [020/133] (889s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[134.895048] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[135.941441] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.046s)
[136.080595] [021/133] (888s left) gem_vm_create (execbuf)
[136.131882] Starting subtest: execbuf
[136.137739] Subtest execbuf: SUCCESS (0.006s)
[136.274615] [022/133] (888s left) gem_mmap_wc (read)
[136.314563] Subtest read: SKIP (0.000s)
[136.370382] [023/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[136.463195] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[136.465761] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[136.562553] [024/133] (888s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[136.825031] Starting subtest: parallel-dmabuf-import-out-fence
[138.051232] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.227s)
[138.139048] [025/133] (886s left) i915_power (sanity)
[138.189912] Starting subtest: sanity
[138.192066] Subtest sanity: SKIP (0.000s)
[138.281888] [026/133] (886s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[138.369197] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[138.370469] Starting dynamic subtest: pipe-A-eDP-1
[138.380368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[138.395619] Starting dynamic subtest: pipe-B-eDP-1
[138.404866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[138.412114] Starting dynamic subtest: pipe-C-eDP-1
[138.422277] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[138.430903] Starting dynamic subtest: pipe-D-eDP-1
[138.440111] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[138.441799] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[140.642150] [027/133] (884s left) kms_psr (pr-primary-page-flip)
[140.730361] Starting subtest: pr-primary-page-flip
[140.731964] Subtest pr-primary-page-flip: SKIP (0.000s)
[140.801034] [028/133] (884s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[140.847992] Starting subtest: etime-single-wait-available-unsubmitted
[140.951805] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[141.032188] [029/133] (883s left) i915_drm_fdinfo (busy-hang)
[141.066537] Starting subtest: busy-hang
[141.067493] Starting dynamic subtest: rcs0
[141.088013] Dynamic subtest rcs0: SKIP (0.022s)
[141.097673] Starting dynamic subtest: bcs0
[141.099318] Dynamic subtest bcs0: SKIP (0.001s)
[141.106464] Starting dynamic subtest: vcs0
[141.107968] Dynamic subtest vcs0: SKIP (0.000s)
[141.115091] Starting dynamic subtest: vcs1
[141.116573] Dynamic subtest vcs1: SKIP (0.000s)
[141.123553] Starting dynamic subtest: vecs0
[141.125122] Dynamic subtest vecs0: SKIP (0.000s)
[141.131966] Starting dynamic subtest: ccs0
[141.133455] Dynamic subtest ccs0: SKIP (0.000s)
[141.134878] Subtest busy-hang: SKIP (0.027s)
[141.160609] [030/133] (883s left) gem_ctx_sseu (engines)
[141.213871] Subtest engines: SKIP (0.000s)
[141.275469] [031/133] (883s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[141.360732] Starting subtest: fbc-rgb565-draw-blt
[145.598110] Subtest fbc-rgb565-draw-blt: SUCCESS (4.238s)
[146.751681] [032/133] (878s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[146.844415] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[146.845961] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[146.913221] [033/133] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[147.003999] Starting subtest: psr-1p-primscrn-cur-indfb-move
[154.405575] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.403s)
[154.544681] [034/133] (870s left) prime_busy (hang-wait)
[154.608790] Starting subtest: hang-wait
[154.609898] Starting dynamic subtest: rcs0
[180.799877] Dynamic subtest rcs0: SUCCESS (26.186s)
[180.809033] Starting dynamic subtest: bcs0
[187.954912] Dynamic subtest bcs0: SUCCESS (7.152s)
[187.963446] Starting dynamic subtest: vcs0
[194.990469] Dynamic subtest vcs0: SUCCESS (7.033s)
[195.000353] Starting dynamic subtest: vcs1
[201.896749] Dynamic subtest vcs1: SUCCESS (6.907s)
[201.908208] Starting dynamic subtest: vecs0
[208.937815] Dynamic subtest vecs0: SUCCESS (7.037s)
[208.949760] Starting dynamic subtest: ccs0
[222.841027] Dynamic subtest ccs0: SUCCESS (13.903s)
[222.842746] Subtest hang-wait: SUCCESS (68.229s)
[222.955539] [035/133] (802s left) syncobj_wait (invalid-reset-zero-handles)
[223.000199] Starting subtest: invalid-reset-zero-handles
[223.001236] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[223.093880] [036/133] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[223.183257] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[230.327444] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.145s)
[230.456926] [037/133] (794s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[230.560235] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[230.561699] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[230.651656] [038/133] (794s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[230.705813] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[230.707695] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[230.877889] [039/133] (794s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[230.940412] Starting subtest: invalid-bsd2-flag-on-blt
[230.941468] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[231.044245] [040/133] (794s left) gem_userptr_blits (readonly-unsync)
[231.093722] Subtest readonly-unsync: SKIP (0.000s)
[231.211601] [041/133] (794s left) drm_read (empty-nonblock)
[231.363174] Starting subtest: empty-nonblock
[231.364235] Subtest empty-nonblock: SUCCESS (0.000s)
[231.478836] [042/133] (793s left) kms_chamelium_frames (hdmi-aspect-ratio)
[231.872279] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[232.649509] [043/133] (792s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[232.745583] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[232.746461] Starting dynamic subtest: pipe-A
[233.095943] Dynamic subtest pipe-A: SUCCESS (0.350s)
[233.106114] Starting dynamic subtest: pipe-B
[234.505204] Dynamic subtest pipe-B: SUCCESS (1.408s)
[234.513861] Starting dynamic subtest: pipe-C
[235.944485] Dynamic subtest pipe-C: SUCCESS (1.438s)
[235.953852] Starting dynamic subtest: pipe-D
[237.362793] Dynamic subtest pipe-D: SUCCESS (1.417s)
[237.363792] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.618s)
[238.525346] [044/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[238.619464] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[238.621203] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.710115] [045/133] (786s left) kms_getfb (getfb-handle-not-fb)
[238.793930] Starting subtest: getfb-handle-not-fb
[238.794920] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[238.874922] [046/133] (786s left) gem_exec_balancer (bonded-true-hang)
[239.134856] Starting subtest: bonded-true-hang
[239.136700] Subtest bonded-true-hang: SKIP (0.000s)
[239.231883] [047/133] (786s left) gem_mmap_wc (bad-object)
[239.284239] Subtest bad-object: SKIP (0.000s)
[239.333256] [048/133] (786s left) gem_partial_pwrite_pread (reads-display)
[239.382037] Subtest reads-display: SKIP (0.000s)
[239.434467] [049/133] (786s left) kms_tv_load_detect (load-detect)
[239.490074] Subtest load-detect: SKIP (0.000s)
[239.540900] [050/133] (786s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[239.632569] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[239.634444] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[239.700280] [051/133] (785s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[239.789815] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[244.057561] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.268s)
[245.252160] [052/133] (780s left) gem_softpin (allocator-nopin-reserve)
[245.310746] Starting subtest: allocator-nopin-reserve
[245.403025] Subtest allocator-nopin-reserve: SUCCESS (0.093s)
[245.524076] [053/133] (780s left) kms_lease (lease-invalid-connector)
[245.609361] Starting subtest: lease-invalid-connector
[245.610197] Starting dynamic subtest: pipe-A-eDP-1
[245.610966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[245.619378] Starting dynamic subtest: pipe-B-eDP-1
[245.620217] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[245.627360] Starting dynamic subtest: pipe-C-eDP-1
[245.628236] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[245.635450] Starting dynamic subtest: pipe-D-eDP-1
[245.636364] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[245.637300] Subtest lease-invalid-connector: SUCCESS (0.004s)
[245.677583] [054/133] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[245.761877] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[245.763475] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[245.844349] [055/133] (779s left) gem_exec_params (no-vebox)
[245.895314] Starting subtest: no-vebox
[245.897614] Subtest no-vebox: SUCCESS (0.002s)
[247.370741] [056/133] (778s left) gem_eio (in-flight-contexts-10ms)
[247.549368] Starting subtest: in-flight-contexts-10ms
[261.351556] Subtest in-flight-contexts-10ms: SUCCESS (13.801s)
[261.479246] [057/133] (764s left) kms_vblank (ts-continuation-dpms-suspend)
[261.573248] Starting subtest: ts-continuation-dpms-suspend
[261.574111] Starting dynamic subtest: pipe-A-eDP-1
[279.126551] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.440s)
[279.137308] Starting dynamic subtest: pipe-D-eDP-1
[297.107372] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.825s)
[297.108527] Subtest ts-continuation-dpms-suspend: SUCCESS (5.269s)
[302.958986] [058/133] (727s left) kms_rmfb (close-fd)
[303.051028] Starting subtest: close-fd
[303.052201] Starting dynamic subtest: pipe-A-eDP-1
[303.158330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[303.167502] Starting dynamic subtest: pipe-B-eDP-1
[304.387808] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s)
[304.396588] Starting dynamic subtest: pipe-C-eDP-1
[305.512195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[305.521474] Starting dynamic subtest: pipe-D-eDP-1
[306.648817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[306.650121] Subtest close-fd: SUCCESS (3.573s)
[307.871311] [059/133] (723s left) gem_mmap_gtt (basic-short)
[307.922195] Subtest basic-short: SKIP (0.000s)
[307.971791] [060/133] (722s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[308.054475] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[308.055604] Starting dynamic subtest: pipe-A-eDP-1
[308.064084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[308.072811] Starting dynamic subtest: pipe-B-eDP-1
[308.081158] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[308.090028] Starting dynamic subtest: pipe-C-eDP-1
[308.097903] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[308.106053] Starting dynamic subtest: pipe-D-eDP-1
[308.113277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[308.114213] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[310.356125] [061/133] (720s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[310.455082] Starting subtest: yf-tiled-64bpp-rotate-180
[310.457059] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[310.557299] [062/133] (720s left) perf (enable-disable)
[310.657237] Starting subtest: enable-disable
[310.658489] Starting dynamic subtest: 0-rcs0
[312.933362] Dynamic subtest 0-rcs0: SUCCESS (2.261s)
[312.943839] Starting dynamic subtest: 1-vecs0
[317.419094] Dynamic subtest 1-vecs0: SUCCESS (4.473s)
[317.420254] Subtest enable-disable: SUCCESS (6.736s)
[317.456872] [063/133] (713s left) kms_plane_scaling (planes-scaler-unity-scaling)
[317.547312] Starting subtest: planes-scaler-unity-scaling
[317.548346] Starting dynamic subtest: pipe-A
[317.610368] Dynamic subtest pipe-A: SUCCESS (0.064s)
[317.618951] Starting dynamic subtest: pipe-B
[318.727021] Dynamic subtest pipe-B: SUCCESS (1.113s)
[318.737074] Starting dynamic subtest: pipe-C
[319.834547] Dynamic subtest pipe-C: SUCCESS (1.105s)
[319.844796] Starting dynamic subtest: pipe-D
[320.973010] Dynamic subtest pipe-D: SUCCESS (1.136s)
[320.973955] Subtest planes-scaler-unity-scaling: SUCCESS (3.422s)
[322.123437] [064/133] (708s left) kms_cursor_legacy (torture-bo)
[322.248734] Starting subtest: torture-bo
[322.250110] Starting dynamic subtest: pipe-A
[327.929530] Dynamic subtest pipe-A: SUCCESS (5.628s)
[327.939847] Starting dynamic subtest: pipe-B
[334.283838] Dynamic subtest pipe-B: SUCCESS (6.388s)
[334.299039] Starting dynamic subtest: pipe-C
[340.752420] Dynamic subtest pipe-C: SUCCESS (6.467s)
[340.761075] Starting dynamic subtest: pipe-D
[348.060516] Dynamic subtest pipe-D: SUCCESS (7.298s)
[348.071392] Starting dynamic subtest: all-pipes
[354.897272] Dynamic subtest all-pipes: SUCCESS (6.826s)
[354.898507] Subtest torture-bo: SUCCESS (32.618s)
[355.045562] [065/133] (676s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[355.140075] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[355.152363] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.012s)
[355.222499] [066/133] (675s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[355.303253] Starting subtest: fbc-psr2-sprite-mmap-gtt
[355.304325] Starting dynamic subtest: eDP-1
[355.306181] Dynamic subtest eDP-1: SKIP (0.000s)
[355.307942] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[355.371717] [067/133] (675s left) i915_pm_freq_api (freq-reset)
[355.428482] Starting subtest: freq-reset
[355.429768] Starting dynamic subtest: gt0
[355.617347] Dynamic subtest gt0: SUCCESS (0.186s)
[355.629088] Starting dynamic subtest: gt1
[355.778562] Dynamic subtest gt1: SUCCESS (0.163s)
[355.779973] Subtest freq-reset: SUCCESS (0.351s)
[355.851407] [068/133] (675s left) gem_exec_fence (syncobj-unused-fence)
[356.341964] Starting subtest: syncobj-unused-fence
[356.346762] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[357.640720] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[357.643908] [069/133] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[357.737394] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[357.739635] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[357.832564] [070/133] (673s left) kms_psr (fbc-pr-primary-render)
[357.919801] Starting subtest: fbc-pr-primary-render
[357.922461] Subtest fbc-pr-primary-render: SKIP (0.000s)
[358.002751] [071/133] (673s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[358.100615] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[359.258113] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.158s)
[359.379435] [072/133] (671s left) syncobj_timeline (wait-any-snapshot)
[359.431604] Starting subtest: wait-any-snapshot
[359.516086] Subtest wait-any-snapshot: SUCCESS (0.084s)
[359.589453] [073/133] (671s left) gem_exec_flush (basic-wb-prw-default)
[359.651690] Starting subtest: basic-wb-prw-default
[365.129457] Subtest basic-wb-prw-default: SUCCESS (5.471s)
[365.311307] [074/133] (666s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[365.404209] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[365.405138] Starting dynamic subtest: pipe-A-eDP-1
[365.415240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[365.424683] Starting dynamic subtest: pipe-B-eDP-1
[365.435568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[365.445038] Starting dynamic subtest: pipe-C-eDP-1
[365.455104] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[365.464342] Starting dynamic subtest: pipe-D-eDP-1
[365.474677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[365.476477] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[367.714520] [075/133] (663s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[367.816765] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[367.819212] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[367.909445] [076/133] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[367.998493] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[368.000138] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[368.094533] [077/133] (663s left) kms_color (invalid-gamma-lut-sizes)
[368.175284] Starting subtest: invalid-gamma-lut-sizes
[368.176546] Starting dynamic subtest: pipe-A
[368.463781] Dynamic subtest pipe-A: SUCCESS (0.288s)
[368.473496] Starting dynamic subtest: pipe-B
[368.474813] Dynamic subtest pipe-B: SUCCESS (0.000s)
[368.483493] Starting dynamic subtest: pipe-C
[368.484734] Dynamic subtest pipe-C: SUCCESS (0.000s)
[368.493945] Starting dynamic subtest: pipe-D
[368.495209] Dynamic subtest pipe-D: SUCCESS (0.000s)
[368.496346] Subtest invalid-gamma-lut-sizes: SUCCESS (0.293s)
[369.257798] [078/133] (662s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[369.357960] Starting subtest: x-tiled-8bpp-rotate-90
[369.382581] Subtest x-tiled-8bpp-rotate-90: SKIP (0.023s)
[369.494660] [079/133] (662s left) syncobj_timeline (reset-during-wait-for-submit)
[369.551015] Starting subtest: reset-during-wait-for-submit
[369.654644] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[369.740815] [080/133] (661s left) vgem_basic (setversion)
[369.783762] Starting subtest: setversion
[369.785866] Subtest setversion: SUCCESS (0.000s)
[369.838143] [081/133] (661s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[369.951014] Starting subtest: cursorA-vs-flipB-legacy
[369.953055] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[370.114803] [082/133] (661s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[370.257530] Starting subtest: cursor-rapid-movement-32x32
[370.304766] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[370.611412] [083/133] (661s left) template (a)
[370.660622] Starting subtest: A
[370.662022] Subtest A: SUCCESS (0.000s)
[370.741670] [084/133] (661s left) syncobj_eventfd (invalid-illegal-eventfd)
[370.796319] Starting subtest: invalid-illegal-eventfd
[370.797506] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[370.891110] [085/133] (660s left) gem_mmap_offset (partial-remap)
[370.929069] Starting subtest: partial-remap
[370.930167] Starting dynamic subtest: smem0
[370.935704] Dynamic subtest smem0: SUCCESS (0.005s)
[370.937059] Subtest partial-remap: SUCCESS (0.006s)
[371.018650] [086/133] (660s left) gem_ctx_param (invalid-get-engines)
[371.069034] Starting subtest: invalid-get-engines
[371.070414] Subtest invalid-get-engines: SUCCESS (0.001s)
[371.160316] [087/133] (660s left) gem_exec_fence (syncobj-timeline-signal)
[371.702562] Starting subtest: syncobj-timeline-signal
[371.704215] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[372.641067] [088/133] (659s left) gem_ctx_persistence (legacy-engines-mixed)
[372.689196] Starting subtest: legacy-engines-mixed
[372.690181] Starting dynamic subtest: render
[372.778768] Dynamic subtest render: SUCCESS (0.089s)
[372.795350] Starting dynamic subtest: bsd1
[372.847831] Dynamic subtest bsd1: SUCCESS (0.066s)
[372.860681] Starting dynamic subtest: bsd2
[372.917774] Dynamic subtest bsd2: SUCCESS (0.066s)
[372.931200] Starting dynamic subtest: blt
[372.980589] Dynamic subtest blt: SUCCESS (0.060s)
[372.993155] Starting dynamic subtest: vebox
[373.026390] Dynamic subtest vebox: SUCCESS (0.043s)
[373.027568] Subtest legacy-engines-mixed: SUCCESS (0.338s)
[373.102153] [089/133] (658s left) kms_force_connector_basic (prune-stale-modes)
[373.181334] Starting subtest: prune-stale-modes
[373.634445] Subtest prune-stale-modes: SUCCESS (0.455s)
[373.773151] [090/133] (658s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[373.854820] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[373.857058] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[373.924114] [091/133] (658s left) kms_cursor_crc (cursor-alpha-opaque)
[374.012064] Starting subtest: cursor-alpha-opaque
[374.013019] Starting dynamic subtest: pipe-A-eDP-1
[374.643426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[374.653103] Starting dynamic subtest: pipe-D-eDP-1
[375.943662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[375.945170] Subtest cursor-alpha-opaque: SUCCESS (1.932s)
[376.787448] [092/133] (655s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[376.888118] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[376.890414] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[376.971432] [093/133] (655s left) gem_exec_schedule (manyslice)
[377.029277] Starting subtest: manyslice
[377.030256] Starting dynamic subtest: rcs0
[382.221967] Dynamic subtest rcs0: SUCCESS (5.145s)
[382.236348] Starting dynamic subtest: bcs0
[388.875775] Dynamic subtest bcs0: SUCCESS (6.649s)
[388.888561] Starting dynamic subtest: vcs0
[395.500666] Dynamic subtest vcs0: SUCCESS (6.620s)
[395.512102] Starting dynamic subtest: vcs1
[402.100358] Dynamic subtest vcs1: SUCCESS (6.603s)
[402.114565] Starting dynamic subtest: vecs0
[408.643644] Dynamic subtest vecs0: SUCCESS (6.592s)
[408.654322] Starting dynamic subtest: ccs0
[415.902276] Dynamic subtest ccs0: SUCCESS (7.214s)
[415.904731] Subtest manyslice: SUCCESS (38.835s)
[416.174093] [094/133] (615s left) syncobj_timeline (invalid-wait-illegal-handle)
[416.230227] Starting subtest: invalid-wait-illegal-handle
[416.231312] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[416.338963] [095/133] (615s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[416.428621] Starting subtest: basic-modeset-with-all-modifiers-formats
[416.819406] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[417.625238] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.806s)
[417.635090] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[417.646202] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[417.655499] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[417.668487] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[417.677819] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[417.824242] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[417.833501] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[417.846144] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[417.855381] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[417.868554] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[417.878179] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[417.891012] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[417.900548] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[417.913176] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[417.922588] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[417.935080] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[417.944500] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[417.957435] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[417.966851] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[417.979462] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[417.988811] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[418.002101] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[418.011627] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[418.157789] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[418.167447] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[418.179732] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[418.189330] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[418.201943] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[418.211563] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[418.224218] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[418.235612] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[418.245832] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[418.255580] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[418.268514] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[418.283181] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[418.290788] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[418.300427] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[418.313004] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[418.322305] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[418.334967] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[418.346340] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[418.490808] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[418.500804] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[418.513260] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[418.523128] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[418.535546] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[418.545196] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[418.557472] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[418.566773] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[418.579602] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[418.589506] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[418.602033] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[418.611927] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[418.624536] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[418.634961] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[418.646493] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[418.655554] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[418.668511] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[419.054171] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.627s)
[419.879122] [096/133] (612s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[419.973858] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[419.976361] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[420.081963] [097/133] (612s left) gem_sync (basic-all)
[420.133173] Starting subtest: basic-all
[423.517234] Subtest basic-all: SUCCESS (3.377s)
[423.689980] [098/133] (608s left) kms_prop_blob (blob-prop-core)
[423.744434] Starting subtest: blob-prop-core
[423.745305] Subtest blob-prop-core: SUCCESS (0.000s)
[423.846181] [099/133] (608s left) kms_pm_rpm (cursor-dpms)
[425.671496] Starting subtest: cursor-dpms
[425.674279] Subtest cursor-dpms: SKIP (0.000s)
[426.085979] [100/133] (606s left) kms_dsc (dsc-fractional-bpp)
[426.175147] Starting subtest: dsc-fractional-bpp
[426.180669] Subtest dsc-fractional-bpp: SKIP (0.000s)
[426.257073] [101/133] (606s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[426.353403] Starting subtest: flip-vs-dpms-on-nop-interruptible
[426.354588] Starting dynamic subtest: A-eDP1
[428.234010] Dynamic subtest A-eDP1: SUCCESS (1.886s)
[428.246390] Starting dynamic subtest: B-eDP1
[430.041163] Dynamic subtest B-eDP1: SUCCESS (1.805s)
[430.055432] Starting dynamic subtest: C-eDP1
[431.842190] Dynamic subtest C-eDP1: SUCCESS (1.798s)
[431.854652] Starting dynamic subtest: D-eDP1
[433.728537] Dynamic subtest D-eDP1: SUCCESS (1.883s)
[433.730219] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.385s)
[434.882413] [102/133] (597s left) core_debugfs (read-all-entries)
[434.930072] Starting subtest: read-all-entries
[435.024719] Subtest read-all-entries: SUCCESS (0.096s)
[435.087450] [103/133] (597s left) gem_mmap_wc (set-cache-level)
[435.139414] Subtest set-cache-level: SKIP (0.000s)
[435.199572] [104/133] (597s left) kms_atomic (plane-invalid-params-fence)
[435.286548] Starting subtest: plane-invalid-params-fence
[435.287700] Starting dynamic subtest: pipe-A-eDP-1
[435.648337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[435.649470] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[436.472539] [105/133] (596s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[436.873467] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[437.643952] [106/133] (594s left) kms_big_fb (linear-64bpp-rotate-270)
[437.746062] Starting subtest: linear-64bpp-rotate-270
[437.769067] Subtest linear-64bpp-rotate-270: SKIP (0.022s)
[437.879743] [107/133] (594s left) kms_properties (get_properties-sanity-non-atomic)
[437.958336] Starting subtest: get_properties-sanity-non-atomic
[437.959310] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[438.028917] [108/133] (594s left) syncobj_basic (bad-fd-to-handle)
[438.078803] Starting subtest: bad-fd-to-handle
[438.080321] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[438.175648] [109/133] (594s left) kms_flip (2x-flip-vs-panning-interruptible)
[438.263365] Starting subtest: 2x-flip-vs-panning-interruptible
[438.274627] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[438.347348] [110/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[438.442474] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[438.444369] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[438.538599] [111/133] (594s left) kms_pm_rpm (modeset-non-lpsp-stress)
[440.762935] Starting subtest: modeset-non-lpsp-stress
[441.920397] Subtest modeset-non-lpsp-stress: SKIP (1.156s)
[442.293262] [112/133] (590s left) gem_mmap_gtt (bad-object)
[442.353333] Subtest bad-object: SKIP (0.000s)
[442.406610] [113/133] (590s left) gem_exec_whisper (basic-sync-all)
[442.468918] Starting subtest: basic-sync-all
[450.441097] Subtest basic-sync-all: SUCCESS (7.971s)
[450.624215] [114/133] (582s left) gem_partial_pwrite_pread (writes-after-reads)
[450.674150] Subtest writes-after-reads: SKIP (0.000s)
[450.742094] [115/133] (582s left) gem_exec_whisper (basic-fds-priority-all)
[450.796393] Starting subtest: basic-fds-priority-all
[475.163561] Subtest basic-fds-priority-all: SUCCESS (24.362s)
[475.348890] [116/133] (557s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[475.445922] Starting subtest: multiplane-rotation-cropping-top
[493.131723] Subtest multiplane-rotation-cropping-top: SUCCESS (17.682s)
[493.250702] [117/133] (539s left) core_setmaster (master-drop-set-user)
[493.345368] Starting subtest: master-drop-set-user
[493.356465] Subtest master-drop-set-user: SUCCESS (0.012s)
[493.391073] [118/133] (539s left) gem_userptr_blits (sync-unmap-after-close)
[493.446633] Starting subtest: sync-unmap-after-close
[493.456087] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[493.567485] [119/133] (539s left) perf (blocking-parameterized)
[493.655298] Starting subtest: blocking-parameterized
[513.674330] Subtest blocking-parameterized: SUCCESS (20.015s)
[513.724017] [120/133] (519s left) perf_pmu (most-busy-check-all)
[513.761603] Starting subtest: most-busy-check-all
[513.762955] Starting dynamic subtest: rcs0
[515.612324] Dynamic subtest rcs0: SUCCESS (1.841s)
[515.624420] Starting dynamic subtest: bcs0
[517.597835] Dynamic subtest bcs0: SUCCESS (1.982s)
[517.609047] Starting dynamic subtest: vcs0
[519.579653] Dynamic subtest vcs0: SUCCESS (1.978s)
[519.592452] Starting dynamic subtest: vcs1
[521.563648] Dynamic subtest vcs1: SUCCESS (1.981s)
[521.577192] Starting dynamic subtest: vecs0
[523.548314] Dynamic subtest vecs0: SUCCESS (1.982s)
[523.561633] Starting dynamic subtest: ccs0
[525.596102] Dynamic subtest ccs0: SUCCESS (2.045s)
[525.597855] Subtest most-busy-check-all: SUCCESS (11.826s)
[525.693559] [121/133] (507s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[525.807177] Starting subtest: short-flip-before-cursor-atomic-transitions
[527.509505] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.692s)
[527.866147] [122/133] (505s left) perf (gen8-unprivileged-single-ctx-counters)
[527.954331] Starting subtest: gen8-unprivileged-single-ctx-counters
[527.957130] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[527.996790] [123/133] (505s left) kms_plane_alpha_blend (constant-alpha-mid)
[528.092521] Starting subtest: constant-alpha-mid
[528.396358] Starting dynamic subtest: pipe-A-eDP-1
[529.365350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.969s)
[529.375528] Starting dynamic subtest: pipe-D-eDP-1
[530.933723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.566s)
[530.935209] Subtest constant-alpha-mid: SUCCESS (2.842s)
[531.796041] [124/133] (501s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[531.895361] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[531.897525] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[531.991911] [125/133] (501s left) kms_joiner (invalid-modeset-force-big-joiner)
[532.095157] Starting subtest: invalid-modeset-force-big-joiner
[532.096970] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[532.176079] [126/133] (501s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[532.265353] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[539.313153] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.050s)
[539.439459] [127/133] (493s left) i915_pm_rps (thresholds)
[539.493509] Starting subtest: thresholds
[539.496608] Subtest thresholds: SKIP (0.001s)
[539.595305] [128/133] (493s left) kms_flip (basic-plain-flip)
[539.681527] Starting subtest: basic-plain-flip
[539.684589] Starting dynamic subtest: A-eDP1
[541.352206] Dynamic subtest A-eDP1: SUCCESS (1.669s)
[541.366121] Starting dynamic subtest: B-eDP1
[543.044352] Dynamic subtest B-eDP1: SUCCESS (1.689s)
[543.058689] Starting dynamic subtest: C-eDP1
[544.745045] Dynamic subtest C-eDP1: SUCCESS (1.697s)
[544.756473] Starting dynamic subtest: D-eDP1
[546.430055] Dynamic subtest D-eDP1: SUCCESS (1.682s)
[546.431486] Subtest basic-plain-flip: SUCCESS (6.749s)
[547.580005] [129/133] (485s left) gem_exec_flush (basic-batch-kernel-default-uc)
[547.635559] Starting subtest: basic-batch-kernel-default-uc
[554.214283] Subtest basic-batch-kernel-default-uc: SUCCESS (6.579s)
[554.400818] [130/133] (479s left) kms_psr (psr2-sprite-render)
[554.495046] Starting subtest: psr2-sprite-render
[554.496366] Starting dynamic subtest: eDP-1
[556.228477] Dynamic subtest eDP-1: SUCCESS (1.733s)
[556.229575] Subtest psr2-sprite-render: SUCCESS (1.734s)
[557.069442] [131/133] (476s left) gem_pxp (regular-baseline-src-copy-readible)
[557.186481] Starting subtest: regular-baseline-src-copy-readible
[557.244782] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[557.365676] [132/133] (476s left) fbdev (read)
[557.398465] Starting subtest: read
[557.940530] Subtest read: SUCCESS (0.533s)
[558.019288] [133/133] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[558.108467] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[558.111080] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[558.203516] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_close_race
results: parsing output: 11/ for test: kms_universal_plane
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_set_tiling_vs_gtt
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: gem_exec_parallel
results: parsing output: 16/ for test: gem_tiled_swapping
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: i915_power
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: gem_ctx_sseu
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: prime_busy
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: drm_read
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: gem_partial_pwrite_pread
results: parsing output: 48/ for test: kms_tv_load_detect
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_rmfb
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: i915_pm_freq_api
results: parsing output: 67/ for test: gem_exec_fence
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_color
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: vgem_basic
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: template
results: parsing output: 83/ for test: syncobj_eventfd
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_force_connector_basic
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_sync
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_dsc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: core_debugfs
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_atomic
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: core_setmaster
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_plane_alpha_blend
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_joiner
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_pm_rps
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: fbdev
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.