[57.407730] Initializing watchdogs
[57.407777]   /dev/watchdog0
[57.421974] [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]
[57.426178] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.428282] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.431538] [001/133] (960s left) gem_exec_balancer (parallel-bb-first)
[57.717265] Starting subtest: parallel-bb-first
[58.669947] Subtest parallel-bb-first: SUCCESS (0.953s)
[59.318177] [002/133] (958s left) gem_mmap_wc (read-write)
[59.386042] Subtest read-write: SKIP (0.000s)
[59.440810] [003/133] (958s left) gem_ctx_shared (exec-single-timeline)
[59.494729] Starting subtest: exec-single-timeline
[59.497124] Starting dynamic subtest: rcs0
[60.572922] Dynamic subtest rcs0: SUCCESS (1.076s)
[60.585706] Starting dynamic subtest: bcs0
[61.661546] Dynamic subtest bcs0: SUCCESS (1.087s)
[61.673636] Starting dynamic subtest: vcs0
[62.749617] Dynamic subtest vcs0: SUCCESS (1.087s)
[62.761185] Starting dynamic subtest: vcs1
[63.838845] Dynamic subtest vcs1: SUCCESS (1.088s)
[63.849839] Starting dynamic subtest: vecs0
[64.926421] Dynamic subtest vecs0: SUCCESS (1.086s)
[64.937149] Starting dynamic subtest: ccs0
[66.014034] Dynamic subtest ccs0: SUCCESS (1.086s)
[66.016795] Subtest exec-single-timeline: SUCCESS (6.518s)
[66.203853] [004/133] (951s left) gem_close_race (multigpu-basic-process)
[66.264263] Starting subtest: multigpu-basic-process
[66.268259] Subtest multigpu-basic-process: SKIP (0.000s)
[66.505856] [005/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[66.616565] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[66.620622] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.705470] [006/133] (951s left) gem_mmap_gtt (basic-write-read-distinct)
[66.773452] Subtest basic-write-read-distinct: SKIP (0.000s)
[66.833783] [007/133] (951s left) gem_media_fill (media-fill)
[66.902656] Subtest media-fill: SKIP (0.000s)
[67.017644] [008/133] (951s left) gem_lmem_evict (dontneed-evict-race)
[67.063047] Subtest dontneed-evict-race: SKIP (0.000s)
[67.111108] [009/133] (951s left) gen9_exec_parse (cmd-crossing-page)
[67.167810] Subtest cmd-crossing-page: SKIP (0.000s)
[67.234713] [010/133] (951s left) kms_fbcon_fbt (fbc-suspend)
[67.290861] Starting subtest: fbc-suspend
[116.520560] Subtest fbc-suspend: SUCCESS (19.107s)
[117.918796] [011/133] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[118.027831] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[124.544657] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.520s)
[124.644148] [012/133] (893s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[124.744807] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[124.749876] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[124.834879] [013/133] (893s left) kms_psr (pr-cursor-mmap-gtt)
[124.924362] Starting subtest: pr-cursor-mmap-gtt
[124.929496] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[124.994026] [014/133] (893s left) kms_flip (absolute-wf_vblank)
[125.081345] Starting subtest: absolute-wf_vblank
[125.084151] Starting dynamic subtest: A-eDP1
[133.808515] Dynamic subtest A-eDP1: SUCCESS (8.729s)
[133.819661] Starting dynamic subtest: B-eDP1
[142.538624] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[142.549951] Starting dynamic subtest: C-eDP1
[151.254646] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[151.265511] Starting dynamic subtest: D-eDP1
[159.985655] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[159.991508] Subtest absolute-wf_vblank: SUCCESS (34.913s)
[161.194274] [015/133] (857s left) perf (polling)
[161.352527] Starting subtest: polling
[161.355077] Starting dynamic subtest: 0-rcs0
[171.373480] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[171.382656] Starting dynamic subtest: 1-vcs0
[181.398599] Dynamic subtest 1-vcs0: SUCCESS (10.024s)
[181.401656] Subtest polling: SUCCESS (20.046s)
[181.446434] [016/133] (837s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[181.573235] Starting subtest: cursorB-vs-flipA-legacy
[181.577886] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[181.716849] [017/133] (836s left) gem_ctx_param (get-priority-new-ctx)
[181.776822] Starting subtest: get-priority-new-ctx
[181.779509] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[181.898815] [018/133] (836s left) gem_userptr_blits (vma-merge)
[181.978893] Starting subtest: vma-merge
[182.020996] Subtest vma-merge: SUCCESS (0.041s)
[182.138757] [019/133] (836s left) kms_flip (plain-flip-interruptible)
[182.241341] Starting subtest: plain-flip-interruptible
[182.244059] Starting dynamic subtest: A-eDP1
[183.895527] Dynamic subtest A-eDP1: SUCCESS (1.652s)
[183.905022] Starting dynamic subtest: B-eDP1
[185.541817] Dynamic subtest B-eDP1: SUCCESS (1.644s)
[185.552626] Starting dynamic subtest: C-eDP1
[187.164196] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[187.175397] Starting dynamic subtest: D-eDP1
[188.803221] Dynamic subtest D-eDP1: SUCCESS (1.637s)
[188.805706] Subtest plain-flip-interruptible: SUCCESS (6.564s)
[189.969675] [020/133] (828s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[190.054892] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[190.060345] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[190.130501] [021/133] (828s left) syncobj_wait (wait-all-for-submit-snapshot)
[190.182500] Starting subtest: wait-all-for-submit-snapshot
[190.263988] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[190.351143] [022/133] (828s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[190.440494] Starting subtest: plane-downscale-factor-0-5-with-rotation
[190.442950] Starting dynamic subtest: pipe-A
[190.460611] Dynamic subtest pipe-A: SKIP (0.015s)
[190.469346] Starting dynamic subtest: pipe-B
[190.486549] Dynamic subtest pipe-B: SKIP (0.027s)
[190.495251] Starting dynamic subtest: pipe-C
[190.514999] Dynamic subtest pipe-C: SKIP (0.028s)
[190.523180] Starting dynamic subtest: pipe-D
[190.543000] Dynamic subtest pipe-D: SKIP (0.028s)
[190.547449] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.100s)
[190.617363] [023/133] (828s left) gem_ctx_param (root-set)
[190.673900] Starting subtest: root-set
[190.676510] Subtest root-set: SUCCESS (0.002s)
[190.791906] [024/133] (828s left) kms_dsc (dsc-with-bpc)
[190.885225] Starting subtest: dsc-with-bpc
[190.918230] Subtest dsc-with-bpc: SKIP (0.001s)
[190.955158] [025/133] (827s left) kms_sequence (get-busy)
[191.046877] Starting subtest: get-busy
[191.049179] Starting dynamic subtest: pipe-A-eDP-1
[192.975190] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.928s)
[192.984159] Starting dynamic subtest: pipe-B-eDP-1
[195.555722] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s)
[195.568655] Starting dynamic subtest: pipe-C-eDP-1
[198.176613] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s)
[198.188456] Starting dynamic subtest: pipe-D-eDP-1
[200.808547] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[200.811098] Subtest get-busy: SUCCESS (9.760s)
[201.630750] [026/133] (817s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[201.681443] Starting subtest: etime-multi-wait-available-unsubmitted
[201.785012] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[201.859323] [027/133] (817s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[201.961327] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[203.118912] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.158s)
[203.240991] [028/133] (815s left) gem_reg_read (timestamp-monotonic)
[203.302999] Starting subtest: timestamp-monotonic
[207.868530] Subtest timestamp-monotonic: SUCCESS (4.566s)
[207.941016] [029/133] (811s left) gem_exec_schedule (semaphore-resolve)
[208.015656] Starting subtest: semaphore-resolve
[208.083427] Subtest semaphore-resolve: SUCCESS (0.078s)
[208.441894] [030/133] (810s left) gem_mmap_gtt (basic-read)
[208.500372] Subtest basic-read: SKIP (0.000s)
[208.557076] [031/133] (810s left) kms_cursor_edge_walk (128x128-top-edge)
[208.648110] Starting subtest: 128x128-top-edge
[208.650502] Starting dynamic subtest: pipe-A-eDP-1
[212.082429] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[212.094436] Starting dynamic subtest: pipe-D-eDP-1
[215.217221] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[215.219955] Subtest 128x128-top-edge: SUCCESS (6.570s)
[216.002158] [032/133] (803s left) kms_flip (2x-nonexisting-fb)
[216.094057] Starting subtest: 2x-nonexisting-fb
[216.101909] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[216.178174] [033/133] (803s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[216.275909] Starting subtest: y-tiled-64bpp-rotate-90
[216.281417] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[216.369620] [034/133] (802s left) gem_ccs (block-multicopy-inplace)
[216.428263] Starting subtest: block-multicopy-inplace
[216.434266] Subtest block-multicopy-inplace: SKIP (0.000s)
[216.517901] [035/133] (802s left) kms_pm_backlight (basic-brightness)
[216.634834] Starting subtest: basic-brightness
[216.685296] Starting dynamic subtest: eDP-1
[217.203069] Dynamic subtest eDP-1: SUCCESS (0.518s)
[217.205685] Subtest basic-brightness: SUCCESS (0.570s)
[218.036127] [036/133] (801s left) gem_exec_reloc (basic-gtt)
[218.097397] Subtest basic-gtt: SKIP (0.000s)
[218.168316] [037/133] (801s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[218.277782] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[222.395956] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.123s)
[223.554878] [038/133] (795s left) gem_exec_fence (syncobj-unused-fence)
[223.993879] Starting subtest: syncobj-unused-fence
[224.000038] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[225.503230] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[225.506991] [039/133] (793s left) gem_eio (in-flight-internal-1us)
[225.724836] Starting subtest: in-flight-internal-1us
[227.516437] Subtest in-flight-internal-1us: SUCCESS (1.791s)
[227.637125] [040/133] (791s left) kms_frontbuffer_tracking (fbc-2p-rte)
[227.729663] Starting subtest: fbc-2p-rte
[227.735321] Subtest fbc-2p-rte: SKIP (0.000s)
[227.830378] [041/133] (791s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[227.902556] Subtest untiled-to-tiled: SKIP (0.000s)
[227.971614] [042/133] (791s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[228.070214] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[228.075148] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[228.160441] [043/133] (791s left) kms_chamelium_audio (hdmi-audio)
[228.574092] Subtest hdmi-audio: SKIP (0.000s)
[229.361627] [044/133] (790s left) kms_lease (lease-revoke)
[229.460094] Starting subtest: lease-revoke
[229.462430] Starting dynamic subtest: pipe-A-eDP-1
[229.496132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.035s)
[229.507283] Starting dynamic subtest: pipe-B-eDP-1
[229.521458] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[229.533165] Starting dynamic subtest: pipe-C-eDP-1
[229.551871] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[229.561158] Starting dynamic subtest: pipe-D-eDP-1
[229.579443] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[229.582009] Subtest lease-revoke: SUCCESS (0.122s)
[229.690814] [045/133] (789s left) kms_flip (flip-vs-blocking-wf-vblank)
[229.799516] Starting subtest: flip-vs-blocking-wf-vblank
[229.802128] Starting dynamic subtest: A-eDP1
[238.728677] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[238.738253] Starting dynamic subtest: B-eDP1
[247.666035] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[247.676684] Starting dynamic subtest: C-eDP1
[256.574435] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[256.586661] Starting dynamic subtest: D-eDP1
[265.502364] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[265.504301] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.709s)
[266.725679] [046/133] (752s left) perf (global-sseu-config-invalid)
[266.825433] Starting subtest: global-sseu-config-invalid
[266.832136] Subtest global-sseu-config-invalid: SKIP (0.000s)
[266.886243] [047/133] (752s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[267.000364] Starting subtest: modeset-atomic-cursor-hotspot
[267.006019] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[267.144164] [048/133] (752s left) kms_color_pipeline (plane-ctm3x4)
[267.237847] Starting subtest: plane-ctm3x4
[267.393618] Starting dynamic subtest: pipe-A-plane-0
[267.516174] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[267.526477] Starting dynamic subtest: pipe-A-plane-1
[267.649525] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[267.659160] Starting dynamic subtest: pipe-A-plane-2
[267.771147] Dynamic subtest pipe-A-plane-2: SUCCESS (0.122s)
[268.927454] Starting dynamic subtest: pipe-B-plane-0
[269.064375] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[269.073685] Starting dynamic subtest: pipe-B-plane-1
[269.232412] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[269.241914] Starting dynamic subtest: pipe-B-plane-2
[269.364940] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[270.551278] Starting dynamic subtest: pipe-C-plane-0
[270.655349] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[270.664779] Starting dynamic subtest: pipe-C-plane-1
[270.766217] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s)
[270.775952] Starting dynamic subtest: pipe-C-plane-2
[270.877626] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s)
[272.115545] Starting dynamic subtest: pipe-D-plane-0
[272.229621] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s)
[272.239209] Starting dynamic subtest: pipe-D-plane-1
[272.340632] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[272.350195] Starting dynamic subtest: pipe-D-plane-2
[272.485434] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[272.775482] Subtest plane-ctm3x4: SUCCESS (5.539s)
[273.650352] [049/133] (746s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[273.752274] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[273.853973] [050/133] (746s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[273.950889] Starting subtest: fbc-pr-cursor-plane-update-sf
[273.955625] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[274.019046] [051/133] (745s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[274.108657] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[274.111319] Starting dynamic subtest: pipe-A-eDP-1
[274.255338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[274.266938] Starting dynamic subtest: pipe-B-eDP-1
[274.292467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[274.303785] Starting dynamic subtest: pipe-C-eDP-1
[274.326580] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[274.335796] Starting dynamic subtest: pipe-D-eDP-1
[274.359622] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[274.362526] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[276.529246] [052/133] (743s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[276.626605] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[276.629086] Starting dynamic subtest: pipe-A-eDP-1
[293.179817] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.555s)
[293.189317] Starting dynamic subtest: pipe-B-eDP-1
[310.415238] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.233s)
[310.417917] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.791s)
[311.284609] [053/133] (708s left) kms_addfb_basic (unused-pitches)
[311.339723] Starting subtest: unused-pitches
[311.342454] Subtest unused-pitches: SUCCESS (0.000s)
[311.472654] [054/133] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[311.568727] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[311.574058] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[311.666440] [055/133] (708s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[311.740804] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[311.746558] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[311.920996] [056/133] (708s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[312.032281] Starting subtest: fbcpsr-rgb101010-draw-render
[318.727614] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.698s)
[318.841053] [057/133] (701s left) kms_psr (fbc-psr-dpms)
[318.936479] Starting subtest: fbc-psr-dpms
[318.939283] Starting dynamic subtest: eDP-1
[318.944114] Dynamic subtest eDP-1: SKIP (0.000s)
[318.948878] Subtest fbc-psr-dpms: SKIP (0.001s)
[319.008025] [058/133] (701s left) gem_partial_pwrite_pread (reads-display)
[319.069642] Subtest reads-display: SKIP (0.000s)
[319.137242] [059/133] (701s left) gem_userptr_blits (forbidden-operations)
[319.196975] Starting subtest: forbidden-operations
[319.201543] Subtest forbidden-operations: SKIP (0.000s)
[319.327311] [060/133] (700s left) kms_hdr (static-toggle-dpms)
[319.409060] Starting subtest: static-toggle-dpms
[319.416477] Subtest static-toggle-dpms: SKIP (0.000s)
[319.481492] [061/133] (700s left) kms_atomic (plane-immutable-zpos)
[319.577316] Starting subtest: plane-immutable-zpos
[319.579895] Starting dynamic subtest: pipe-A-eDP-1
[320.210608] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[320.213330] Subtest plane-immutable-zpos: SUCCESS (0.634s)
[321.025164] [062/133] (699s left) i915_pm_freq_api (freq-reset-multiple)
[321.090642] Starting subtest: freq-reset-multiple
[321.093630] Starting dynamic subtest: gt0
[330.884464] Dynamic subtest gt0: SUCCESS (9.791s)
[330.894561] Starting dynamic subtest: gt1
[338.988957] Dynamic subtest gt1: SUCCESS (8.102s)
[338.991655] Subtest freq-reset-multiple: SUCCESS (17.896s)
[339.080783] [063/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[339.179442] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[339.184449] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[339.260566] [064/133] (681s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[339.347417] Starting subtest: primary-y-tiled-reflect-x-180
[339.407607] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[339.512665] [065/133] (680s left) gem_ctx_param (set-priority-invalid-size)
[339.572206] Starting subtest: set-priority-invalid-size
[339.575233] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[339.640082] [066/133] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[339.742833] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[344.968054] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.229s)
[346.155122] [067/133] (674s left) kms_chamelium_hpd (dp-hpd)
[346.546307] Subtest dp-hpd: SKIP (0.000s)
[347.325775] [068/133] (673s left) kms_chamelium_frames (dp-frame-dump)
[347.703217] Subtest dp-frame-dump: SKIP (0.000s)
[348.554895] [069/133] (672s left) kms_pm_rpm (modeset-stress-extra-wait)
[350.596540] Starting subtest: modeset-stress-extra-wait
[404.870738] Subtest modeset-stress-extra-wait: SUCCESS (54.272s)
[404.962163] [070/133] (615s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[405.061210] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[405.066036] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[405.145739] [071/133] (615s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[405.204627] Starting subtest: x-tiled-to-vebox-yf-tiled
[405.210405] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[405.388669] [072/133] (615s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[405.488968] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[405.515564] Starting dynamic subtest: pipe-A-plane-0
[405.946415] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[405.959053] Starting dynamic subtest: pipe-A-plane-3
[406.202445] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[407.315641] Starting dynamic subtest: pipe-B-plane-0
[407.742038] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[407.751663] Starting dynamic subtest: pipe-B-plane-3
[408.008577] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[408.321366] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.834s)
[409.181084] [073/133] (611s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[409.287442] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[410.324423] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.036s)
[410.440061] [074/133] (610s left) kms_cursor_crc (cursor-random-max-size)
[410.767184] Starting subtest: cursor-random-max-size
[410.773503] Subtest cursor-random-max-size: SKIP (0.000s)
[410.903609] [075/133] (610s left) kms_plane_multiple (2x-tiling-none)
[410.989385] Starting subtest: 2x-tiling-none
[410.993782] Subtest 2x-tiling-none: SKIP (0.000s)
[411.062301] [076/133] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[411.156917] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[411.160933] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[411.263863] [077/133] (609s left) kms_content_protection (mei-interface)
[411.397199] Starting subtest: mei-interface
[411.400927] Subtest mei-interface: SKIP (0.001s)
[411.536324] [078/133] (609s left) kms_cursor_crc (cursor-onscreen-512x512)
[411.833261] Starting subtest: cursor-onscreen-512x512
[411.837451] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[411.980853] [079/133] (609s left) perf (missing-sample-flags)
[412.075988] Starting subtest: missing-sample-flags
[412.078471] Subtest missing-sample-flags: SUCCESS (0.000s)
[412.122440] [080/133] (609s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[412.209012] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[412.211283] Starting dynamic subtest: pipe-A-eDP-1
[413.093161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.874s)
[413.102940] Starting dynamic subtest: pipe-B-eDP-1
[414.623264] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.526s)
[414.633499] Starting dynamic subtest: pipe-C-eDP-1
[416.128510] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[416.139138] Starting dynamic subtest: pipe-D-eDP-1
[417.686235] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.557s)
[417.688399] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.465s)
[418.820782] [081/133] (602s left) syncobj_basic (bad-pad-handle-to-fd)
[418.874675] Starting subtest: bad-pad-handle-to-fd
[418.877361] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[418.969679] [082/133] (602s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[419.067046] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[419.735423] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[419.888480] [083/133] (601s left) gem_exec_balancer (semaphore)
[419.939628] Starting subtest: semaphore
[421.386498] Subtest semaphore: SUCCESS (1.445s)
[421.683687] [084/133] (599s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[421.777619] Starting subtest: psr2-cursor-plane-move-continuous-sf
[421.780169] Starting dynamic subtest: pipe-A-eDP-1
[432.129417] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.358s)
[432.141755] Starting dynamic subtest: pipe-B-eDP-1
[443.208867] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.078s)
[443.211631] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.438s)
[444.084963] [085/133] (577s left) kms_psr (psr2-cursor-render)
[444.172401] Starting subtest: psr2-cursor-render
[444.174912] Starting dynamic subtest: eDP-1
[445.880418] Dynamic subtest eDP-1: SUCCESS (1.708s)
[445.883238] Subtest psr2-cursor-render: SUCCESS (1.709s)
[446.681226] [086/133] (574s left) kms_flip (flip-vs-rmfb-interruptible)
[446.775468] Starting subtest: flip-vs-rmfb-interruptible
[446.778029] Starting dynamic subtest: A-eDP1
[455.469185] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[455.479798] Starting dynamic subtest: B-eDP1
[464.093419] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[464.102974] Starting dynamic subtest: C-eDP1
[472.706569] Dynamic subtest C-eDP1: SUCCESS (8.611s)
[472.719953] Starting dynamic subtest: D-eDP1
[481.342899] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[481.347638] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.571s)
[482.524122] [087/133] (538s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[482.618809] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[489.671683] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.055s)
[489.794750] [088/133] (531s left) i915_pm_rps (thresholds)
[489.857428] Starting subtest: thresholds
[489.863135] Subtest thresholds: SKIP (0.000s)
[489.969942] [089/133] (531s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[490.058640] Starting subtest: nonblocking-crc-frame-sequence
[490.061384] Starting dynamic subtest: pipe-A-eDP-1
[490.828347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[490.839563] Starting dynamic subtest: pipe-B-eDP-1
[492.308061] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.478s)
[492.317871] Starting dynamic subtest: pipe-C-eDP-1
[493.652169] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[493.661635] Starting dynamic subtest: pipe-D-eDP-1
[494.993349] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[494.995651] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.938s)
[495.800298] [090/133] (525s left) kms_vblank (ts-continuation-suspend)
[495.889019] Starting subtest: ts-continuation-suspend
[495.891309] Starting dynamic subtest: pipe-A-eDP-1
[512.705415] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.500s)
[512.721458] Starting dynamic subtest: pipe-D-eDP-1
[529.732172] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.194s)
[529.734685] Subtest ts-continuation-suspend: SUCCESS (3.697s)
[530.554007] [091/133] (491s left) dumb_buffer (invalid-bpp)
[530.625498] Starting subtest: invalid-bpp
[530.627733] Subtest invalid-bpp: SUCCESS (0.000s)
[530.712084] [092/133] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[530.808884] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[537.960355] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.145s)
[538.123355] [093/133] (483s left) gem_ctx_persistence (engines-persistence)
[538.191696] Starting subtest: engines-persistence
[538.194395] Starting dynamic subtest: rcs0
[538.981114] Dynamic subtest rcs0: SUCCESS (0.791s)
[538.994101] Starting dynamic subtest: bcs0
[539.746242] Dynamic subtest bcs0: SUCCESS (0.762s)
[539.758702] Starting dynamic subtest: vcs0
[540.513858] Dynamic subtest vcs0: SUCCESS (0.765s)
[540.525727] Starting dynamic subtest: vcs1
[541.278189] Dynamic subtest vcs1: SUCCESS (0.761s)
[541.290621] Starting dynamic subtest: vecs0
[542.046906] Dynamic subtest vecs0: SUCCESS (0.766s)
[542.059430] Starting dynamic subtest: ccs0
[542.821587] Dynamic subtest ccs0: SUCCESS (0.772s)
[542.823976] Subtest engines-persistence: SUCCESS (4.630s)
[542.913031] [094/133] (478s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[543.015783] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[543.018369] Starting dynamic subtest: pipe-A-eDP-1
[543.042652] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[543.053816] Starting dynamic subtest: pipe-B-eDP-1
[543.079801] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[543.088811] Starting dynamic subtest: pipe-C-eDP-1
[543.114401] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[543.123295] Starting dynamic subtest: pipe-D-eDP-1
[543.148729] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[543.153888] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[545.262385] [095/133] (476s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[545.357666] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[545.362666] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[545.443214] [096/133] (476s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[545.537526] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[545.542448] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[545.633184] [097/133] (476s left) gem_mmap_gtt (zero-extend)
[545.696639] Subtest zero-extend: SKIP (0.000s)
[545.761754] [098/133] (476s left) perf_pmu (rc6)
[545.803734] Starting subtest: rc6
[545.806248] Starting dynamic subtest: gt0
[552.160299] Dynamic subtest gt0: SUCCESS (6.353s)
[552.173866] Starting dynamic subtest: runtime-pm-gt0
[559.878712] Dynamic subtest runtime-pm-gt0: SUCCESS (7.712s)
[559.892093] Starting dynamic subtest: runtime-pm-long-gt0
[572.329704] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.444s)
[572.342638] Starting dynamic subtest: other-idle-gt0
[578.676765] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[578.690484] Starting dynamic subtest: gt1
[585.019256] Dynamic subtest gt1: SUCCESS (6.337s)
[585.032910] Starting dynamic subtest: runtime-pm-gt1
[592.456593] Dynamic subtest runtime-pm-gt1: SUCCESS (7.432s)
[592.469881] Starting dynamic subtest: runtime-pm-long-gt1
[604.893897] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.431s)
[604.907515] Starting dynamic subtest: other-idle-gt1
[611.238501] Dynamic subtest other-idle-gt1: SUCCESS (6.339s)
[611.241641] Subtest rc6: SUCCESS (65.409s)
[612.518787] [099/133] (409s left) syncobj_timeline (invalid-transfer-non-existent-point)
[612.566468] Starting subtest: invalid-transfer-non-existent-point
[612.568620] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[612.626208] [100/133] (409s left) syncobj_timeline (wait-any-snapshot)
[612.684914] Starting subtest: wait-any-snapshot
[612.765323] Subtest wait-any-snapshot: SUCCESS (0.082s)
[612.818673] [101/133] (409s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[612.910897] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[612.915704] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[612.982156] [102/133] (409s left) gem_softpin (allocator-evict)
[613.042546] Starting subtest: allocator-evict
[613.044586] Starting dynamic subtest: rcs0
[636.802281] Dynamic subtest rcs0: SUCCESS (23.761s)
[636.815093] Starting dynamic subtest: bcs0
[660.492540] Dynamic subtest bcs0: SUCCESS (23.694s)
[660.503158] Starting dynamic subtest: vcs0
[684.056071] Dynamic subtest vcs0: SUCCESS (23.561s)
[684.067609] Starting dynamic subtest: vcs1
[707.877931] Dynamic subtest vcs1: SUCCESS (23.817s)
[707.891378] Starting dynamic subtest: vecs0
[731.417445] Dynamic subtest vecs0: SUCCESS (23.533s)
[731.430462] Starting dynamic subtest: ccs0
[754.884169] Dynamic subtest ccs0: SUCCESS (23.461s)
[754.887215] Subtest allocator-evict: SUCCESS (141.833s)
[754.948868] [103/133] (267s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[755.136876] Starting subtest: fbcpsr-tiling-linear
[761.722204] Subtest fbcpsr-tiling-linear: SUCCESS (6.590s)
[761.836189] [104/133] (260s left) api_intel_bb (object-reloc-purge-cache)
[761.895626] Starting subtest: object-reloc-purge-cache
[761.901365] Subtest object-reloc-purge-cache: SKIP (0.003s)
[762.002280] [105/133] (260s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[762.071647] Starting subtest: multi-wait-available-submitted-signaled
[762.074635] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[762.122553] [106/133] (260s left) syncobj_timeline (single-wait-all-available-signaled)
[762.187717] Starting subtest: single-wait-all-available-signaled
[762.190737] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[762.271396] [107/133] (260s left) gem_exec_schedule (pi-distinct-iova)
[762.453997] Starting subtest: pi-distinct-iova
[762.456426] Starting dynamic subtest: rcs0
[762.538595] Dynamic subtest rcs0: SUCCESS (0.086s)
[762.553799] Starting dynamic subtest: vcs0
[762.595594] Dynamic subtest vcs0: SUCCESS (0.057s)
[762.609559] Starting dynamic subtest: vcs1
[762.649859] Dynamic subtest vcs1: SUCCESS (0.053s)
[762.664234] Starting dynamic subtest: vecs0
[762.713414] Dynamic subtest vecs0: SUCCESS (0.062s)
[762.727616] Starting dynamic subtest: ccs0
[762.768923] Dynamic subtest ccs0: SUCCESS (0.056s)
[762.771729] Subtest pi-distinct-iova: SUCCESS (0.319s)
[764.674754] [108/133] (257s left) gen3_render_tiledy_blits
[764.812317] [109/133] (257s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[764.911745] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[771.758203] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.852s)
[771.866283] [110/133] (250s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[771.956809] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[771.959635] Starting dynamic subtest: pipe-A-eDP-1
[771.972394] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[771.983730] Starting dynamic subtest: pipe-B-eDP-1
[771.994870] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[772.004884] Starting dynamic subtest: pipe-C-eDP-1
[772.015500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[772.025090] Starting dynamic subtest: pipe-D-eDP-1
[772.035280] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[772.040004] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[774.190091] [111/133] (248s left) gem_exec_parallel (fds)
[774.248626] Starting subtest: fds
[774.251718] Starting dynamic subtest: rcs0
[777.558197] Dynamic subtest rcs0: SUCCESS (3.309s)
[777.569899] Starting dynamic subtest: bcs0
[781.872168] Dynamic subtest bcs0: SUCCESS (4.312s)
[781.886580] Starting dynamic subtest: vcs0
[787.531874] Dynamic subtest vcs0: SUCCESS (5.658s)
[787.545621] Starting dynamic subtest: vcs1
[791.949686] Dynamic subtest vcs1: SUCCESS (4.416s)
[791.964128] Starting dynamic subtest: vecs0
[797.577044] Dynamic subtest vecs0: SUCCESS (5.627s)
[797.590925] Starting dynamic subtest: ccs0
[802.455518] Dynamic subtest ccs0: SUCCESS (4.878s)
[802.458685] Subtest fds: SUCCESS (28.210s)
[802.629373] [112/133] (219s left) gem_readwrite (new-obj)
[802.691762] Subtest new-obj: SKIP (0.000s)
[802.756327] [113/133] (219s left) gem_eio (wait-10ms)
[802.983154] Starting subtest: wait-10ms
[803.365776] Subtest wait-10ms: SUCCESS (0.382s)
[803.463794] [114/133] (219s left) kms_psr (psr-sprite-plane-move)
[803.550189] Starting subtest: psr-sprite-plane-move
[803.552507] Starting dynamic subtest: eDP-1
[805.344729] Dynamic subtest eDP-1: SUCCESS (1.794s)
[805.347558] Subtest psr-sprite-plane-move: SUCCESS (1.795s)
[806.135803] [115/133] (216s left) gem_exec_store (pages)
[806.211362] Starting subtest: pages
[806.213855] Starting dynamic subtest: rcs0
[806.317666] Dynamic subtest rcs0: SUCCESS (0.109s)
[806.330915] Starting dynamic subtest: bcs0
[806.396108] Dynamic subtest bcs0: SUCCESS (0.077s)
[806.406877] Starting dynamic subtest: vcs0
[806.461442] Dynamic subtest vcs0: SUCCESS (0.065s)
[806.472031] Starting dynamic subtest: vcs1
[806.528144] Dynamic subtest vcs1: SUCCESS (0.065s)
[806.542449] Starting dynamic subtest: vecs0
[806.592704] Dynamic subtest vecs0: SUCCESS (0.063s)
[806.607145] Starting dynamic subtest: ccs0
[806.660905] Dynamic subtest ccs0: SUCCESS (0.067s)
[806.663950] Subtest pages: SUCCESS (0.454s)
[806.821886] [116/133] (215s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[806.923489] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[806.928441] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[807.015733] [117/133] (215s left) gem_ctx_persistence (legacy-engines-hostile)
[807.070698] Starting subtest: legacy-engines-hostile
[807.073679] Starting dynamic subtest: render
[807.152872] Dynamic subtest render: SUCCESS (0.082s)
[807.166899] Starting dynamic subtest: bsd1
[807.245609] Dynamic subtest bsd1: SUCCESS (0.090s)
[807.261872] Starting dynamic subtest: bsd2
[807.348461] Dynamic subtest bsd2: SUCCESS (0.099s)
[807.361448] Starting dynamic subtest: blt
[807.440227] Dynamic subtest blt: SUCCESS (0.090s)
[807.459008] Starting dynamic subtest: vebox
[807.533685] Dynamic subtest vebox: SUCCESS (0.090s)
[807.536798] Subtest legacy-engines-hostile: SUCCESS (0.465s)
[807.596400] [118/133] (215s left) gem_softpin (noreloc-s3)
[807.663368] Starting subtest: noreloc-S3
[827.517808] Subtest noreloc-S3: SUCCESS (5.400s)
[827.612924] [119/133] (195s left) api_intel_allocator (default-alignment)
[827.686905] Starting subtest: default-alignment
[827.690928] Subtest default-alignment: SUCCESS (0.008s)
[827.786488] [120/133] (195s left) gen9_exec_parse (unaligned-jump)
[827.844821] Subtest unaligned-jump: SKIP (0.000s)
[827.923410] [121/133] (195s left) gem_mmap_wc (copy)
[827.981900] Subtest copy: SKIP (0.000s)
[828.054305] [122/133] (194s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[828.159683] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[828.538363] Starting dynamic subtest: pipe-A-eDP-1
[831.268093] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.733s)
[831.632962] Starting dynamic subtest: pipe-B-eDP-1
[834.388336] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[834.760578] Starting dynamic subtest: pipe-C-eDP-1
[837.514324] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[837.886563] Starting dynamic subtest: pipe-D-eDP-1
[840.637334] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[840.639925] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.489s)
[841.808918] [123/133] (181s left) kms_big_fb (linear-32bpp-rotate-90)
[841.909616] Starting subtest: linear-32bpp-rotate-90
[841.929942] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[842.012669] [124/133] (181s left) gem_exec_fence (parallel)
[842.184993] Starting subtest: parallel
[842.187809] Starting dynamic subtest: rcs0
[844.336349] Dynamic subtest rcs0: SUCCESS (2.152s)
[844.347571] Starting dynamic subtest: bcs0
[846.486748] Dynamic subtest bcs0: SUCCESS (2.150s)
[846.498773] Starting dynamic subtest: vcs0
[848.634977] Dynamic subtest vcs0: SUCCESS (2.148s)
[848.646854] Starting dynamic subtest: vcs1
[850.787587] Dynamic subtest vcs1: SUCCESS (2.152s)
[850.798409] Starting dynamic subtest: vecs0
[852.941388] Dynamic subtest vecs0: SUCCESS (2.154s)
[852.960112] Starting dynamic subtest: ccs0
[855.091602] Dynamic subtest ccs0: SUCCESS (2.150s)
[855.093777] Subtest parallel: SUCCESS (12.910s)
[856.103660] [125/133] (167s left) i915_pm_freq_mult (media-freq)
[856.165045] Starting subtest: media-freq
[856.167923] Starting dynamic subtest: gt0
[856.174005] Dynamic subtest gt0: SKIP (0.000s)
[856.185043] Starting dynamic subtest: gt1
[856.190077] Dynamic subtest gt1: SKIP (0.000s)
[856.195353] Subtest media-freq: SKIP (0.001s)
[856.243868] [126/133] (166s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[856.301109] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[856.407240] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[856.466055] [127/133] (166s left) gem_pxp (display-protected-crc)
[856.598062] Starting subtest: display-protected-crc
[858.218707] Subtest display-protected-crc: SUCCESS (1.623s)
[858.315930] [128/133] (164s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[858.422633] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[858.427617] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[858.483089] [129/133] (164s left) kms_psr (fbc-psr2-cursor-plane-move)
[858.576936] Starting subtest: fbc-psr2-cursor-plane-move
[858.579759] Starting dynamic subtest: eDP-1
[858.584968] Dynamic subtest eDP-1: SKIP (0.000s)
[858.590500] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[858.630737] [130/133] (164s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[858.717001] Starting subtest: plane-upscale-20x20-with-pixel-format
[858.719786] Starting dynamic subtest: pipe-A
[859.788056] Dynamic subtest pipe-A: SUCCESS (1.072s)
[859.798446] Starting dynamic subtest: pipe-B
[861.930605] Dynamic subtest pipe-B: SUCCESS (2.142s)
[861.941225] Starting dynamic subtest: pipe-C
[863.129600] Dynamic subtest pipe-C: SUCCESS (1.197s)
[863.141738] Starting dynamic subtest: pipe-D
[864.276344] Dynamic subtest pipe-D: SUCCESS (1.147s)
[864.278928] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.563s)
[865.466424] [131/133] (157s left) perf_pmu (busy-idle)
[865.508059] Starting subtest: busy-idle
[865.510948] Starting dynamic subtest: rcs0
[866.184185] Dynamic subtest rcs0: SUCCESS (0.677s)
[866.199364] Starting dynamic subtest: bcs0
[866.845716] Dynamic subtest bcs0: SUCCESS (0.659s)
[866.860403] Starting dynamic subtest: vcs0
[868.002494] Dynamic subtest vcs0: SUCCESS (1.153s)
[868.014044] Starting dynamic subtest: vcs1
[870.051213] Dynamic subtest vcs1: SUCCESS (2.049s)
[870.066230] Starting dynamic subtest: vecs0
[871.971522] Dynamic subtest vecs0: SUCCESS (1.917s)
[871.986703] Starting dynamic subtest: ccs0
[872.636449] Dynamic subtest ccs0: SUCCESS (0.663s)
[872.639085] Subtest busy-idle: SUCCESS (7.133s)
[872.705650] [132/133] (150s left) prime_busy (before)
[872.770998] Starting subtest: before
[872.776837] Starting dynamic subtest: rcs0
[872.806738] Dynamic subtest rcs0: SUCCESS (0.032s)
[872.819310] Starting dynamic subtest: bcs0
[872.857866] Dynamic subtest bcs0: SUCCESS (0.051s)
[872.868971] Starting dynamic subtest: vcs0
[872.901023] Dynamic subtest vcs0: SUCCESS (0.042s)
[872.911814] Starting dynamic subtest: vcs1
[872.944548] Dynamic subtest vcs1: SUCCESS (0.043s)
[872.955594] Starting dynamic subtest: vecs0
[872.989588] Dynamic subtest vecs0: SUCCESS (0.044s)
[873.000573] Starting dynamic subtest: ccs0
[873.031964] Dynamic subtest ccs0: SUCCESS (0.042s)
[873.140972] Subtest before: SUCCESS (0.369s)
[873.200451] [133/133] (150s left) gem_userptr_blits (sync-unmap)
[873.268046] Starting subtest: sync-unmap
[873.286484] Subtest sync-unmap: SUCCESS (0.021s)
[873.398428] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: gem_mmap_wc
results: parsing output: 2/ for test: gem_ctx_shared
results: parsing output: 3/ for test: gem_close_race
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: gem_media_fill
results: parsing output: 7/ for test: gem_lmem_evict
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: kms_fbcon_fbt
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_flip_scaled_crc
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: kms_dsc
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_reg_read
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_cursor_edge_walk
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_ccs
results: parsing output: 34/ for test: kms_pm_backlight
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_set_tiling_vs_blt
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_chamelium_audio
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_partial_pwrite_pread
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_hdr
results: parsing output: 60/ for test: kms_atomic
results: parsing output: 61/ for test: i915_pm_freq_api
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: gem_ctx_param
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_chamelium_frames
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: dumb_buffer
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_ctx_persistence
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gen3_render_tiledy_blits
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_parallel
results: parsing output: 111/ for test: gem_readwrite
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_exec_store
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: gem_softpin
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: i915_pm_freq_mult
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: gem_userptr_blits
Done.