[63.031791] Initializing watchdogs
[63.031841]   /dev/watchdog0
[63.046553] [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.051199] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.053499] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.055420] [001/133] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[63.160553] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[63.862493] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[64.021986] [002/133] (959s left) kms_psr (fbc-psr-primary-mmap-gtt)
[64.109212] Starting subtest: fbc-psr-primary-mmap-gtt
[64.110195] Starting dynamic subtest: eDP-1
[64.111955] Dynamic subtest eDP-1: SKIP (0.000s)
[64.113883] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[64.179421] [003/133] (959s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[64.284109] Starting subtest: plane-lut1d-ctm3x4
[64.465182] Starting dynamic subtest: pipe-A-plane-0
[64.632099] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[64.640896] Starting dynamic subtest: pipe-A-plane-1
[64.798966] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[64.808523] Starting dynamic subtest: pipe-A-plane-2
[64.987490] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[66.197099] Starting dynamic subtest: pipe-B-plane-0
[66.391714] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[66.398918] Starting dynamic subtest: pipe-B-plane-1
[66.547257] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[66.554547] Starting dynamic subtest: pipe-B-plane-2
[66.702977] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[67.907833] Starting dynamic subtest: pipe-C-plane-0
[68.054749] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[68.064465] Starting dynamic subtest: pipe-C-plane-1
[68.209960] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[68.217351] Starting dynamic subtest: pipe-C-plane-2
[68.354257] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[69.526545] Starting dynamic subtest: pipe-D-plane-0
[69.658948] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[69.665671] Starting dynamic subtest: pipe-D-plane-1
[69.825873] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[69.832902] Starting dynamic subtest: pipe-D-plane-2
[69.982033] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[70.266409] Subtest plane-lut1d-ctm3x4: SUCCESS (5.982s)
[71.075580] [004/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[71.175045] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[77.880451] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.704s)
[77.999772] [005/133] (945s left) prime_vgem (wait)
[78.108683] Starting subtest: wait
[78.109926] Starting dynamic subtest: rcs0
[78.133062] Dynamic subtest rcs0: SUCCESS (0.024s)
[78.139252] Starting dynamic subtest: bcs0
[78.188561] Dynamic subtest bcs0: SUCCESS (0.055s)
[78.195027] Starting dynamic subtest: vcs0
[78.236286] Dynamic subtest vcs0: SUCCESS (0.047s)
[78.242675] Starting dynamic subtest: vcs1
[78.280840] Dynamic subtest vcs1: SUCCESS (0.044s)
[78.287504] Starting dynamic subtest: vecs0
[78.330385] Dynamic subtest vecs0: SUCCESS (0.049s)
[78.336467] Starting dynamic subtest: ccs0
[78.379318] Dynamic subtest ccs0: SUCCESS (0.049s)
[78.380401] Subtest wait: SUCCESS (0.271s)
[78.497542] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[78.499963] [006/133] (945s left) gem_exec_fence (syncobj-timeline-unused-fence)
[79.033086] Starting subtest: syncobj-timeline-unused-fence
[79.034469] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[79.943949] [007/133] (943s left) gem_pxp (create-valid-protected-context)
[80.073292] Starting subtest: create-valid-protected-context
[80.074501] Subtest create-valid-protected-context: SUCCESS (0.002s)
[80.182631] [008/133] (943s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[80.283513] Starting subtest: y-tiled-addfb-size-offset-overflow
[80.285382] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[80.376882] [009/133] (943s left) prime_self_import (basic-with_one_bo_two_files)
[80.413412] Starting subtest: basic-with_one_bo_two_files
[80.434127] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[80.555399] [010/133] (943s left) gem_create (busy-create)
[80.615022] Starting subtest: busy-create
[80.616044] Starting dynamic subtest: smem0
[113.891732] Dynamic subtest smem0: SUCCESS (33.265s)
[113.893260] Subtest busy-create: SUCCESS (33.266s)
[114.060269] [011/133] (909s left) gem_ctx_param (set-priority-invalid-size)
[114.110407] Starting subtest: set-priority-invalid-size
[114.111342] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[114.182509] [012/133] (909s left) kms_psr (psr-primary-render)
[114.277035] Starting subtest: psr-primary-render
[114.277972] Starting dynamic subtest: eDP-1
[115.990090] Dynamic subtest eDP-1: SUCCESS (1.713s)
[115.990955] Subtest psr-primary-render: SUCCESS (1.714s)
[116.856928] [013/133] (907s left) syncobj_basic (create-signaled)
[116.905190] Starting subtest: create-signaled
[116.906152] Subtest create-signaled: SUCCESS (0.000s)
[116.996816] [014/133] (906s left) gem_exec_schedule (u-semaphore-codependency)
[117.053293] Starting subtest: u-semaphore-codependency
[117.065905] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[117.417319] [015/133] (906s left) fbdev (write)
[117.461851] Starting subtest: write
[117.835455] Subtest write: SUCCESS (0.364s)
[117.894595] [016/133] (906s left) syncobj_wait (single-wait-all-submitted)
[117.952306] Starting subtest: single-wait-all-submitted
[118.057804] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[118.128552] [017/133] (905s left) gem_ctx_param (get-priority-new-ctx)
[118.174363] Starting subtest: get-priority-new-ctx
[118.175337] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[118.260423] [018/133] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[118.352228] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[118.353922] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[118.453869] [019/133] (905s left) i915_pm_freq_api (freq-basic-api)
[118.502818] Starting subtest: freq-basic-api
[118.503665] Starting dynamic subtest: gt0
[118.505445] Dynamic subtest gt0: SUCCESS (0.003s)
[118.512685] Starting dynamic subtest: gt1
[118.513514] Dynamic subtest gt1: SUCCESS (0.002s)
[118.514290] Subtest freq-basic-api: SUCCESS (0.006s)
[118.630600] [020/133] (905s left) gem_ctx_isolation (clean)
[118.689147] Starting subtest: clean
[118.690145] Starting dynamic subtest: rcs0
[118.744251] Dynamic subtest rcs0: SUCCESS (0.056s)
[118.753329] Starting dynamic subtest: bcs0
[118.804397] Dynamic subtest bcs0: SUCCESS (0.060s)
[118.813288] Starting dynamic subtest: vcs0
[118.867420] Dynamic subtest vcs0: SUCCESS (0.063s)
[118.876302] Starting dynamic subtest: vcs1
[120.942495] Dynamic subtest vcs1: SUCCESS (2.074s)
[120.949475] Starting dynamic subtest: vecs0
[122.902264] Dynamic subtest vecs0: SUCCESS (1.959s)
[122.911187] Starting dynamic subtest: ccs0
[124.887263] Dynamic subtest ccs0: SUCCESS (1.985s)
[124.888237] Subtest clean: SUCCESS (6.199s)
[125.106653] [021/133] (899s left) kms_vblank (ts-continuation-idle-hang)
[125.192716] Starting subtest: ts-continuation-idle-hang
[125.193474] Starting dynamic subtest: pipe-A-eDP-1
[151.711147] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.516s)
[151.719934] Starting dynamic subtest: pipe-D-eDP-1
[176.726451] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[176.727375] Subtest ts-continuation-idle-hang: SUCCESS (51.531s)
[177.521695] [022/133] (846s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[177.635542] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[177.637274] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[177.740682] [023/133] (846s left) kms_properties (get_properties-sanity-atomic)
[177.827261] Starting subtest: get_properties-sanity-atomic
[177.829226] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[177.917816] [024/133] (846s left) kms_cursor_crc (cursor-offscreen-max-size)
[178.203948] Starting subtest: cursor-offscreen-max-size
[178.206757] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[178.312698] [025/133] (846s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[178.359029] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[178.360092] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[178.446595] [026/133] (845s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[178.504338] Starting subtest: mixed-tiled-to-y-tiled-ccs
[178.506131] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[178.691513] [027/133] (845s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[179.057214] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[179.826815] [028/133] (844s left) gem_mmap_gtt (big-bo)
[179.879528] Subtest big-bo: SKIP (0.000s)
[179.969770] [029/133] (844s left) gem_partial_pwrite_pread (reads-snoop)
[180.037240] Subtest reads-snoop: SKIP (0.000s)
[180.099184] [030/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[180.188089] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[180.189786] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[180.290356] [031/133] (844s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[180.341877] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[180.343839] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[180.531949] [032/133] (844s left) kms_plane (plane-panning-top-left)
[180.611389] Starting subtest: plane-panning-top-left
[180.612303] Starting dynamic subtest: pipe-A
[182.312979] Dynamic subtest pipe-A: SUCCESS (1.701s)
[182.320105] Starting dynamic subtest: pipe-B
[184.673576] Dynamic subtest pipe-B: SUCCESS (2.358s)
[184.674522] Subtest plane-panning-top-left: SUCCESS (4.062s)
[185.483740] [033/133] (839s left) perf_pmu (most-busy-check-all)
[185.525342] Starting subtest: most-busy-check-all
[185.526419] Starting dynamic subtest: rcs0
[186.910842] Dynamic subtest rcs0: SUCCESS (1.375s)
[186.919833] Starting dynamic subtest: bcs0
[188.894960] Dynamic subtest bcs0: SUCCESS (1.982s)
[188.903841] Starting dynamic subtest: vcs0
[190.942832] Dynamic subtest vcs0: SUCCESS (2.046s)
[190.951386] Starting dynamic subtest: vcs1
[192.926584] Dynamic subtest vcs1: SUCCESS (1.983s)
[192.935371] Starting dynamic subtest: vecs0
[194.911417] Dynamic subtest vecs0: SUCCESS (1.983s)
[194.920424] Starting dynamic subtest: ccs0
[196.894813] Dynamic subtest ccs0: SUCCESS (1.982s)
[196.896054] Subtest most-busy-check-all: SUCCESS (11.360s)
[196.987399] [034/133] (827s left) kms_psr (fbc-pr-primary-page-flip)
[197.084074] Starting subtest: fbc-pr-primary-page-flip
[197.086017] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[197.166260] [035/133] (827s left) tools_test (sysfs_l3_parity)
[197.209370] Starting subtest: sysfs_l3_parity
[197.290089] Subtest sysfs_l3_parity: SKIP (0.085s)
[197.340404] [036/133] (827s left) gem_render_copy_redux (normal)
[197.395317] Starting subtest: normal
[197.655388] Subtest normal: SUCCESS (0.260s)
[197.797848] [037/133] (827s left) kms_cdclk (mode-transition-all-outputs)
[197.893103] Starting subtest: mode-transition-all-outputs
[198.186108] Subtest mode-transition-all-outputs: SKIP (0.293s)
[199.025021] [038/133] (825s left) kms_content_protection (content-type-change)
[199.163410] Starting subtest: content-type-change
[199.165486] Subtest content-type-change: SKIP (0.000s)
[199.281284] [039/133] (825s left) gem_userptr_blits (userfault)
[199.348733] Starting subtest: userfault
[199.351983] Subtest userfault: SUCCESS (0.005s)
[199.467197] [040/133] (825s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[199.601153] Starting subtest: basic-busy-flip-before-cursor-varying-size
[199.602913] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[199.743094] [041/133] (825s left) i915_selftest (live)
[203.040051] Starting subtest: live
[203.041602] Starting dynamic subtest: sanitycheck
[207.408224] Dynamic subtest sanitycheck: SUCCESS (4.368s)
[207.416488] Starting dynamic subtest: uncore
[211.733270] Dynamic subtest uncore: SUCCESS (4.323s)
[211.741622] Starting dynamic subtest: workarounds
[228.788533] Dynamic subtest workarounds: FAIL (16.851s)
[228.794541] Starting dynamic subtest: gt_engines
[231.656274] Dynamic subtest gt_engines: SUCCESS (3.070s)
[231.664969] Starting dynamic subtest: gt_timelines
[247.717489] Dynamic subtest gt_timelines: SUCCESS (16.060s)
[247.726450] Starting dynamic subtest: gt_contexts
[252.026138] Dynamic subtest gt_contexts: SUCCESS (4.307s)
[252.032435] Starting dynamic subtest: gt_lrc
[256.379387] Dynamic subtest gt_lrc: SUCCESS (4.351s)
[256.388060] Starting dynamic subtest: gt_mocs
[259.373377] Dynamic subtest gt_mocs: SUCCESS (2.993s)
[259.381268] Starting dynamic subtest: gt_pm
[266.144480] Dynamic subtest gt_pm: SUCCESS (6.769s)
[266.152445] Starting dynamic subtest: gt_heartbeat
[270.430345] Dynamic subtest gt_heartbeat: SUCCESS (4.284s)
[270.438363] Starting dynamic subtest: gt_tlb
[279.764309] Dynamic subtest gt_tlb: SUCCESS (9.333s)
[279.774292] Starting dynamic subtest: requests
[293.248033] Dynamic subtest requests: SUCCESS (13.481s)
[293.257791] Starting dynamic subtest: migrate
[300.975801] Dynamic subtest migrate: SUCCESS (7.726s)
[300.983740] Starting dynamic subtest: active
[305.343609] Dynamic subtest active: SUCCESS (4.366s)
[305.350929] Starting dynamic subtest: objects
[310.091569] Dynamic subtest objects: SUCCESS (4.748s)
[310.099910] Starting dynamic subtest: mman
[313.425193] Dynamic subtest mman: SUCCESS (3.332s)
[313.432646] Starting dynamic subtest: dmabuf
[317.744925] Dynamic subtest dmabuf: SUCCESS (4.318s)
[317.753294] Starting dynamic subtest: vma
[320.420902] Dynamic subtest vma: SUCCESS (2.675s)
[320.428967] Starting dynamic subtest: coherency
[325.376641] Dynamic subtest coherency: SUCCESS (4.953s)
[325.385226] Starting dynamic subtest: gtt
[335.437084] Dynamic subtest gtt: SUCCESS (10.058s)
[335.445596] Starting dynamic subtest: gem
[341.535628] Dynamic subtest gem: SUCCESS (6.097s)
[341.547252] Starting dynamic subtest: evict
[346.996782] Dynamic subtest evict: SUCCESS (5.460s)
[347.005348] Starting dynamic subtest: hugepages
[355.831878] Dynamic subtest hugepages: SUCCESS (8.833s)
[355.840260] Starting dynamic subtest: gem_contexts
[384.401304] Dynamic subtest gem_contexts: SUCCESS (28.566s)
[384.410060] Starting dynamic subtest: client
[387.176308] Dynamic subtest client: SUCCESS (2.775s)
[387.184985] Starting dynamic subtest: gem_migrate
[391.488271] Dynamic subtest gem_migrate: SUCCESS (4.310s)
[391.494943] Starting dynamic subtest: reset
[395.905033] Dynamic subtest reset: SUCCESS (4.415s)
[395.913742] Starting dynamic subtest: memory_region
[398.591751] Dynamic subtest memory_region: SUCCESS (2.684s)
[398.600508] Starting dynamic subtest: hangcheck
[411.535466] Dynamic subtest hangcheck: SUCCESS (12.936s)
[411.551656] Starting dynamic subtest: execlists
[415.864231] Dynamic subtest execlists: SUCCESS (4.333s)
[415.872330] Starting dynamic subtest: ring_submission
[418.561402] Dynamic subtest ring_submission: SUCCESS (2.697s)
[418.567071] Starting dynamic subtest: perf
[422.914086] Dynamic subtest perf: SUCCESS (4.350s)
[422.920887] Starting dynamic subtest: slpc
[435.061031] Dynamic subtest slpc: SUCCESS (12.144s)
[435.069216] Starting dynamic subtest: guc
[438.994296] Dynamic subtest guc: SUCCESS (3.932s)
[439.003210] Starting dynamic subtest: guc_multi_lrc
[443.332154] Dynamic subtest guc_multi_lrc: SUCCESS (4.336s)
[443.341564] Starting dynamic subtest: guc_hang
[446.702784] Dynamic subtest guc_hang: SUCCESS (3.369s)
[446.711339] Starting dynamic subtest: late_gt_pm
[451.073782] Dynamic subtest late_gt_pm: SUCCESS (4.370s)
[451.074905] Subtest live: FAIL (248.028s)
[451.096028] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[451.096719] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[451.098356] [042/133] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[452.724573] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[452.726283] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[452.816713] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[452.818365] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[452.820777] [043/133] (572s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[452.906768] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[460.131830] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.224s)
[460.240249] [044/133] (564s left) api_intel_allocator (standalone)
[460.304912] Starting subtest: standalone
[460.323110] Subtest standalone: SUCCESS (0.019s)
[460.433531] [045/133] (564s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[460.530393] Starting subtest: sprite-rotation-90-pos-100-0
[460.532094] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[460.610095] [046/133] (564s left) api_intel_bb (render)
[460.657364] Starting subtest: render
[460.658435] Starting dynamic subtest: render-none-512
[460.760785] Dynamic subtest render-none-512: SUCCESS (0.104s)
[460.770315] Starting dynamic subtest: render-none-1024
[461.158320] Dynamic subtest render-none-1024: SUCCESS (0.388s)
[461.167507] Starting dynamic subtest: render-x-512
[461.239563] Dynamic subtest render-x-512: SUCCESS (0.088s)
[461.248893] Starting dynamic subtest: render-x-1024
[461.586794] Dynamic subtest render-x-1024: SUCCESS (0.347s)
[461.595762] Starting dynamic subtest: render-y-512
[461.675021] Dynamic subtest render-y-512: SUCCESS (0.087s)
[461.684499] Starting dynamic subtest: render-y-1024
[462.034593] Dynamic subtest render-y-1024: SUCCESS (0.350s)
[462.036236] Subtest render: SUCCESS (1.370s)
[462.129973] [047/133] (563s left) gem_exec_whisper (basic-normal-all)
[462.206508] Starting subtest: basic-normal-all
[465.063389] Subtest basic-normal-all: SUCCESS (2.856s)
[465.245976] [048/133] (559s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[465.344971] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[466.136704] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[466.282385] [049/133] (558s left) gem_exec_whisper (basic-sync-all)
[466.343605] Starting subtest: basic-sync-all
[473.049313] Subtest basic-sync-all: SUCCESS (6.704s)
[473.234867] [050/133] (552s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[473.331235] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[473.332124] Starting dynamic subtest: pipe-A-eDP-1
[473.340638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.351741] Starting dynamic subtest: pipe-B-eDP-1
[473.359856] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[473.370679] Starting dynamic subtest: pipe-C-eDP-1
[473.378488] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.385206] Starting dynamic subtest: pipe-D-eDP-1
[473.393493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.395105] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[475.564921] [051/133] (549s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[475.647614] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[475.649412] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[475.716711] [052/133] (549s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[475.800446] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[475.811735] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[475.942500] [053/133] (549s left) perf (gen12-invalid-class-instance)
[476.094475] Starting subtest: gen12-invalid-class-instance
[476.106584] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[476.161455] [054/133] (549s left) gen9_exec_parse (allowed-all)
[476.206498] Subtest allowed-all: SKIP (0.000s)
[476.271975] [055/133] (549s left) vgem_basic (second-client)
[476.320887] Starting subtest: second-client
[476.344284] Subtest second-client: SUCCESS (0.023s)
[476.404906] [056/133] (549s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[476.497999] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[476.498944] Starting dynamic subtest: pipe-A
[477.547576] Dynamic subtest pipe-A: SUCCESS (1.050s)
[477.556477] Starting dynamic subtest: pipe-B
[479.686914] Dynamic subtest pipe-B: SUCCESS (2.138s)
[479.694055] Starting dynamic subtest: pipe-C
[480.876431] Dynamic subtest pipe-C: SUCCESS (1.188s)
[480.888988] Starting dynamic subtest: pipe-D
[482.127116] Dynamic subtest pipe-D: SUCCESS (1.249s)
[482.129090] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.631s)
[483.307145] [057/133] (542s left) gem_exec_fence (keep-in-fence)
[483.487788] Starting subtest: keep-in-fence
[483.488946] Starting dynamic subtest: rcs0
[483.538731] Dynamic subtest rcs0: SUCCESS (0.055s)
[483.552111] Starting dynamic subtest: bcs0
[483.593717] Dynamic subtest bcs0: SUCCESS (0.052s)
[483.605805] Starting dynamic subtest: vcs0
[484.896519] Dynamic subtest vcs0: SUCCESS (1.292s)
[484.904223] Starting dynamic subtest: vcs1
[486.942837] Dynamic subtest vcs1: SUCCESS (2.043s)
[486.952324] Starting dynamic subtest: vecs0
[488.927587] Dynamic subtest vecs0: SUCCESS (1.982s)
[488.936895] Starting dynamic subtest: ccs0
[489.143425] Dynamic subtest ccs0: SUCCESS (0.222s)
[489.144809] Subtest keep-in-fence: SUCCESS (5.661s)
[490.993172] [058/133] (534s left) prime_vgem (basic-write)
[491.054096] Starting subtest: basic-write
[491.060608] Subtest basic-write: SKIP (0.006s)
[491.155894] [059/133] (534s left) gem_exec_parallel (fds)
[491.215176] Starting subtest: fds
[491.216150] Starting dynamic subtest: rcs0
[494.717989] Dynamic subtest rcs0: SUCCESS (3.494s)
[494.726875] Starting dynamic subtest: bcs0
[498.317038] Dynamic subtest bcs0: SUCCESS (3.597s)
[498.327457] Starting dynamic subtest: vcs0
[502.205697] Dynamic subtest vcs0: SUCCESS (3.886s)
[502.215532] Starting dynamic subtest: vcs1
[506.200633] Dynamic subtest vcs1: SUCCESS (3.992s)
[506.210786] Starting dynamic subtest: vecs0
[510.228260] Dynamic subtest vecs0: SUCCESS (4.027s)
[510.239881] Starting dynamic subtest: ccs0
[513.961539] Dynamic subtest ccs0: SUCCESS (3.730s)
[513.963033] Subtest fds: SUCCESS (22.737s)
[514.150928] [060/133] (511s left) perf (blocking)
[514.248581] Starting subtest: blocking
[514.249602] Starting dynamic subtest: 0-rcs0
[524.305350] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[524.315412] Starting dynamic subtest: 1-vcs1
[534.326660] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[534.328454] Subtest blocking: SUCCESS (20.033s)
[534.359149] [061/133] (491s left) core_setmaster (master-drop-set-root)
[534.424790] Starting subtest: master-drop-set-root
[534.441214] Subtest master-drop-set-root: SUCCESS (0.016s)
[534.483865] [062/133] (491s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[534.574874] Starting subtest: fbc-psr2-cursor-plane-update-sf
[534.575822] Starting dynamic subtest: pipe-A-eDP-1
[534.675994] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[534.685789] Starting dynamic subtest: pipe-B-eDP-1
[535.794593] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[535.796364] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.221s)
[537.083382] [063/133] (488s left) gem_ctx_shared (detached-shared-gtt)
[537.147774] Starting subtest: detached-shared-gtt
[539.308153] Subtest detached-shared-gtt: SUCCESS (2.151s)
[539.633218] [064/133] (486s left) kms_flip (2x-flip-vs-expired-vblank)
[539.717810] Starting subtest: 2x-flip-vs-expired-vblank
[539.728869] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[539.806360] [065/133] (486s left) i915_pm_rpm (debugfs-forcewake-user)
[542.041215] Starting subtest: debugfs-forcewake-user
[553.421663] Subtest debugfs-forcewake-user: SUCCESS (11.382s)
[553.807757] [066/133] (472s left) gem_softpin (allocator-basic)
[553.854462] Starting subtest: allocator-basic
[553.944578] Subtest allocator-basic: SUCCESS (0.089s)
[554.073477] [067/133] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[554.170269] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[554.172171] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[554.280301] [068/133] (471s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[554.364338] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[554.365993] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[554.436825] [069/133] (471s left) kms_addfb_basic (size-max)
[554.541303] Starting subtest: size-max
[554.542187] Subtest size-max: SUCCESS (0.000s)
[554.623116] [070/133] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[554.708282] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[554.710158] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[554.800112] [071/133] (471s left) kms_chamelium_frames (hdmi-crc-single)
[555.174172] Subtest hdmi-crc-single: SKIP (0.000s)
[556.002678] [072/133] (470s left) gem_mmap_gtt (basic-write-gtt)
[556.050614] Subtest basic-write-gtt: SKIP (0.000s)
[556.097213] [073/133] (470s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[556.185656] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[556.186643] Starting dynamic subtest: pipe-A-eDP-1
[562.037567] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.852s)
[562.046561] Starting dynamic subtest: pipe-B-eDP-1
[568.721233] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.681s)
[568.722138] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.536s)
[569.589871] [074/133] (456s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[569.690065] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[574.067603] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.377s)
[575.189707] [075/133] (450s left) kms_vblank (query-busy-hang)
[575.277194] Starting subtest: query-busy-hang
[575.279199] Starting dynamic subtest: pipe-A-eDP-1
[601.683986] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.404s)
[601.693317] Starting dynamic subtest: pipe-D-eDP-1
[625.687036] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.000s)
[625.687995] Subtest query-busy-hang: SUCCESS (50.409s)
[626.535116] [076/133] (399s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[626.622443] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[626.624061] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[626.707927] [077/133] (399s left) kms_psr (pr-sprite-mmap-gtt)
[626.792583] Starting subtest: pr-sprite-mmap-gtt
[626.794340] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[626.858963] [078/133] (399s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[626.951335] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[626.952980] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[627.045507] [079/133] (399s left) kms_flip (dpms-off-confusion)
[627.129185] Starting subtest: dpms-off-confusion
[627.130072] Starting dynamic subtest: A-eDP1
[635.856987] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[635.866436] Starting dynamic subtest: B-eDP1
[644.493018] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[644.500572] Starting dynamic subtest: C-eDP1
[653.125422] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[653.141072] Starting dynamic subtest: D-eDP1
[661.755375] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[661.756198] Subtest dpms-off-confusion: SUCCESS (34.594s)
[662.884957] [080/133] (363s left) kms_psr (psr2-suspend)
[662.982347] Starting subtest: psr2-suspend
[662.983178] Starting dynamic subtest: eDP-1
[681.610882] Dynamic subtest eDP-1: SUCCESS (4.131s)
[681.612198] Subtest psr2-suspend: SUCCESS (4.132s)
[687.544886] [081/133] (343s left) gem_flink_race (flink_name)
[687.583390] Starting subtest: flink_name
[693.008088] Subtest flink_name: SUCCESS (5.398s)
[693.108313] [082/133] (338s left) kms_cursor_crc (cursor-random-64x64)
[693.276660] Starting subtest: cursor-random-64x64
[693.280029] Starting dynamic subtest: pipe-A-eDP-1
[696.626739] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[696.656991] Starting dynamic subtest: pipe-D-eDP-1
[700.607744] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.956s)
[700.608529] Subtest cursor-random-64x64: SUCCESS (7.325s)
[701.462037] [083/133] (330s left) kms_rotation_crc (bad-pixel-format)
[701.551661] Starting subtest: bad-pixel-format
[701.553344] Subtest bad-pixel-format: SKIP (0.001s)
[701.624714] [084/133] (329s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[701.715747] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[701.717542] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[701.811327] [085/133] (329s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[701.910790] Starting subtest: stress-xrgb8888-xtiled
[707.771787] Subtest stress-xrgb8888-xtiled: SUCCESS (5.859s)
[707.832765] [086/133] (323s left) gem_ctx_persistence (heartbeat-hang)
[707.973282] Starting subtest: heartbeat-hang
[707.975559] Subtest heartbeat-hang: SKIP (0.000s)
[708.188079] [087/133] (323s left) kms_joiner (basic-force-big-joiner)
[708.454872] Starting subtest: basic-force-big-joiner
[708.456673] Subtest basic-force-big-joiner: SKIP (0.000s)
[708.746867] [088/133] (322s left) kms_dsc (dsc-with-bpc-formats)
[708.963835] Starting subtest: dsc-with-bpc-formats
[709.006773] Subtest dsc-with-bpc-formats: SKIP (0.006s)
[709.192684] [089/133] (322s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[709.336478] Starting subtest: cursorB-vs-flipB-atomic-transitions
[709.338867] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[709.480314] [090/133] (322s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[709.690047] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[709.691125] Starting dynamic subtest: pipe-A-eDP-1
[709.699071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[709.707506] Starting dynamic subtest: pipe-B-eDP-1
[709.715242] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[709.723416] Starting dynamic subtest: pipe-C-eDP-1
[709.732423] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[709.745923] Starting dynamic subtest: pipe-D-eDP-1
[709.753803] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[709.754684] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[711.843286] [091/133] (320s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[711.938357] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[711.940379] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[712.034506] [092/133] (319s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[712.128036] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[712.128962] Starting dynamic subtest: pipe-A-eDP-1
[712.136259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[712.144938] Starting dynamic subtest: pipe-B-eDP-1
[712.152182] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[712.160298] Starting dynamic subtest: pipe-C-eDP-1
[712.169165] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[712.177590] Starting dynamic subtest: pipe-D-eDP-1
[712.185723] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[712.186653] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[714.400232] [093/133] (317s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[714.490767] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[714.518563] Starting dynamic subtest: pipe-A-plane-0
[714.807443] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[714.818575] Starting dynamic subtest: pipe-A-plane-3
[715.051752] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[715.060070] Starting dynamic subtest: pipe-A-plane-5
[715.061748] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[716.196782] Starting dynamic subtest: pipe-B-plane-0
[716.477451] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[716.486015] Starting dynamic subtest: pipe-B-plane-3
[716.710950] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[716.719481] Starting dynamic subtest: pipe-B-plane-5
[716.721303] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[717.021220] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.530s)
[717.858106] [094/133] (314s left) kms_hdmi_inject (inject-4k)
[718.209894] Starting subtest: inject-4k
[718.530596] Subtest inject-4k: SUCCESS (0.322s)
[719.033812] [095/133] (312s left) gem_exec_schedule (preempt-other-chain)
[719.095623] Starting subtest: preempt-other-chain
[719.096545] Starting dynamic subtest: rcs0
[719.182883] Dynamic subtest rcs0: SUCCESS (0.086s)
[719.191870] Starting dynamic subtest: bcs0
[719.273129] Dynamic subtest bcs0: SUCCESS (0.089s)
[719.285994] Starting dynamic subtest: vcs0
[719.354182] Dynamic subtest vcs0: SUCCESS (0.080s)
[719.364008] Starting dynamic subtest: vcs1
[719.438307] Dynamic subtest vcs1: SUCCESS (0.083s)
[719.450430] Starting dynamic subtest: vecs0
[719.525978] Dynamic subtest vecs0: SUCCESS (0.087s)
[719.536712] Starting dynamic subtest: ccs0
[719.609256] Dynamic subtest ccs0: SUCCESS (0.083s)
[719.610069] Subtest preempt-other-chain: SUCCESS (0.514s)
[720.530531] [096/133] (311s left) syncobj_timeline (multi-wait-available-submitted)
[720.587339] Starting subtest: multi-wait-available-submitted
[720.588479] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[720.719294] [097/133] (311s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[720.826070] Starting subtest: 4-tiled-8bpp-rotate-90
[720.850305] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.023s)
[720.947158] [098/133] (311s left) kms_pm_backlight (fade-with-dpms)
[721.040632] Starting subtest: fade-with-dpms
[723.150497] Starting dynamic subtest: eDP-1
[725.660664] Dynamic subtest eDP-1: SUCCESS (2.509s)
[725.661635] Subtest fade-with-dpms: SUCCESS (4.621s)
[726.500727] [099/133] (305s left) syncobj_wait (reset-signaled)
[726.549352] Starting subtest: reset-signaled
[726.550372] Subtest reset-signaled: SUCCESS (0.000s)
[726.641945] [100/133] (305s left) gem_eio (in-flight-1us)
[726.880604] Starting subtest: in-flight-1us
[735.404425] Subtest in-flight-1us: SUCCESS (8.526s)
[735.521529] [101/133] (296s left) kms_fbcon_fbt (psr-suspend)
[735.586730] Starting subtest: psr-suspend
[786.237976] Subtest psr-suspend: SUCCESS (20.575s)
[788.289547] [102/133] (245s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[788.384616] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[788.386940] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[788.454403] [103/133] (245s left) syncobj_timeline (device-submit-unordered)
[788.504793] Starting subtest: device-submit-unordered
[788.506151] Subtest device-submit-unordered: SUCCESS (0.000s)
[788.600406] [104/133] (245s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[788.648023] Starting subtest: multi-wait-all-for-submit-available-submitted
[788.649470] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[788.728995] [105/133] (245s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[788.821693] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[788.824380] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[788.903521] [106/133] (245s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[788.987561] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[788.988525] Starting dynamic subtest: pipe-A-default-mode
[790.110862] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[790.112997] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.122s)
[790.277471] [107/133] (244s left) syncobj_basic (bad-flags-handle-to-fd)
[790.325369] Starting subtest: bad-flags-handle-to-fd
[790.326920] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[790.416110] [108/133] (244s left) gem_exec_create (forked)
[790.476593] Starting subtest: forked
[790.477820] Starting dynamic subtest: smem
[812.429739] Dynamic subtest smem: SUCCESS (21.937s)
[812.431434] Subtest forked: SUCCESS (21.940s)
[812.603728] [109/133] (221s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[812.659554] Starting subtest: invalid-bsd2-flag-on-vebox
[812.660834] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[812.746984] [110/133] (221s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[812.796049] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[812.849922] [111/133] (221s left) gem_exec_balancer (bonded-true-hang)
[813.119943] Starting subtest: bonded-true-hang
[813.122815] Subtest bonded-true-hang: SKIP (0.000s)
[813.207762] [112/133] (221s left) kms_atomic (plane-cursor-legacy)
[813.301861] Starting subtest: plane-cursor-legacy
[813.302994] Starting dynamic subtest: pipe-A-eDP-1
[813.684028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[813.685047] Subtest plane-cursor-legacy: SUCCESS (0.383s)
[814.476652] [113/133] (220s left) kms_flip (basic-plain-flip)
[814.574566] Starting subtest: basic-plain-flip
[814.575752] Starting dynamic subtest: A-eDP1
[816.264991] Dynamic subtest A-eDP1: SUCCESS (1.690s)
[816.275342] Starting dynamic subtest: B-eDP1
[817.964069] Dynamic subtest B-eDP1: SUCCESS (1.697s)
[817.974675] Starting dynamic subtest: C-eDP1
[819.648780] Dynamic subtest C-eDP1: SUCCESS (1.680s)
[819.659980] Starting dynamic subtest: D-eDP1
[821.351388] Dynamic subtest D-eDP1: SUCCESS (1.701s)
[821.352451] Subtest basic-plain-flip: SUCCESS (6.777s)
[822.476733] [114/133] (212s left) prime_mmap (test_correct_cpu_write)
[822.529400] Starting subtest: test_correct_cpu_write
[822.530386] Starting dynamic subtest: test_correct_cpu_write-smem
[822.531444] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[822.532483] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[822.620949] [115/133] (212s left) gem_mmap_offset (isolation)
[822.675610] Starting subtest: isolation
[822.684754] Subtest isolation: SUCCESS (0.006s)
[822.779176] [116/133] (211s left) kms_plane_multiple (tiling-4)
[822.866955] Starting subtest: tiling-4
[822.868481] Starting dynamic subtest: pipe-A-eDP-1
[826.722059] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.855s)
[826.731343] Starting dynamic subtest: pipe-B-eDP-1
[831.366064] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.642s)
[831.375793] Starting dynamic subtest: pipe-C-eDP-1
[835.905783] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.538s)
[835.915431] Starting dynamic subtest: pipe-D-eDP-1
[840.508052] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.600s)
[840.509409] Subtest tiling-4: SUCCESS (17.640s)
[841.382289] [117/133] (193s left) kms_async_flips (async-flip-suspend-resume)
[841.485526] Starting subtest: async-flip-suspend-resume
[841.863998] Starting dynamic subtest: pipe-A-eDP-1
[860.197991] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.321s)
[860.579686] Starting dynamic subtest: pipe-B-eDP-1
[879.196133] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s)
[879.562299] Starting dynamic subtest: pipe-C-eDP-1
[898.204199] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.292s)
[898.568675] Starting dynamic subtest: pipe-D-eDP-1
[917.185684] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.273s)
[917.186635] Subtest async-flip-suspend-resume: SUCCESS (14.637s)
[924.423698] [118/133] (116s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[924.521877] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[924.522901] Starting dynamic subtest: pipe-A-eDP-1
[924.531188] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[924.540273] Starting dynamic subtest: pipe-B-eDP-1
[924.549246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[924.559387] Starting dynamic subtest: pipe-C-eDP-1
[924.567190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[924.575666] Starting dynamic subtest: pipe-D-eDP-1
[924.584788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[924.586566] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[926.767872] [119/133] (114s left) gem_eio (execbuf)
[926.990485] Starting subtest: execbuf
[927.335282] Subtest execbuf: SUCCESS (0.344s)
[927.487925] [120/133] (113s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[927.577590] Starting subtest: fbcpsr-1p-rte
[934.619356] Subtest fbcpsr-1p-rte: SUCCESS (7.040s)
[934.740050] [121/133] (106s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[934.840334] Starting subtest: psr-shrfb-scaledprimary
[940.539025] Subtest psr-shrfb-scaledprimary: SUCCESS (5.697s)
[940.650571] [122/133] (100s left) i915_drm_fdinfo (all-busy-idle-check-all)
[940.682955] Starting subtest: all-busy-idle-check-all
[940.687206] Subtest all-busy-idle-check-all: SKIP (0.004s)
[940.776259] [123/133] (100s left) gen3_render_mixed_blits
[940.901323] [124/133] (100s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[942.628553] Starting subtest: modeset-non-lpsp-stress-no-wait
[942.670024] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.041s)
[943.186265] [125/133] ( 97s left) syncobj_timeline (wait-for-submit-snapshot)
[943.237369] Starting subtest: wait-for-submit-snapshot
[943.319040] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[943.390797] [126/133] ( 97s left) kms_cursor_legacy (torture-move)
[943.490951] Starting subtest: torture-move
[943.492008] Starting dynamic subtest: pipe-A
[949.622100] Dynamic subtest pipe-A: SUCCESS (6.118s)
[949.633556] Starting dynamic subtest: pipe-B
[955.666366] Dynamic subtest pipe-B: SUCCESS (6.050s)
[955.681385] Starting dynamic subtest: pipe-C
[962.013388] Dynamic subtest pipe-C: SUCCESS (6.342s)
[962.025832] Starting dynamic subtest: pipe-D
[968.496248] Dynamic subtest pipe-D: SUCCESS (6.487s)
[968.507431] Starting dynamic subtest: all-pipes
[975.084682] Dynamic subtest all-pipes: SUCCESS (6.586s)
[975.085763] Subtest torture-move: SUCCESS (31.592s)
[975.242719] [127/133] ( 65s left) gem_mmap_gtt (fault-concurrent)
[975.294213] Subtest fault-concurrent: SKIP (0.000s)
[975.354491] [128/133] ( 65s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[975.445700] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[975.447435] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[975.554406] [129/133] ( 65s left) gem_exec_endless (dispatch)
[975.630094] Starting subtest: dispatch
[975.631142] Starting dynamic subtest: rcs0
[975.635820] Dynamic subtest rcs0: SUCCESS (0.005s)
[975.646495] Starting dynamic subtest: bcs0
[975.648222] Dynamic subtest bcs0: SUCCESS (0.005s)
[975.658323] Starting dynamic subtest: vcs0
[975.660177] Dynamic subtest vcs0: SUCCESS (0.007s)
[975.670410] Starting dynamic subtest: vcs1
[975.672141] Dynamic subtest vcs1: SUCCESS (0.005s)
[975.681089] Starting dynamic subtest: vecs0
[975.683146] Dynamic subtest vecs0: SUCCESS (0.004s)
[975.691854] Starting dynamic subtest: ccs0
[975.693691] Dynamic subtest ccs0: SUCCESS (0.004s)
[975.694516] Subtest dispatch: SUCCESS (0.035s)
[977.522083] [130/133] ( 63s left) gem_mmap_gtt (basic-copy)
[977.563254] Subtest basic-copy: SKIP (0.000s)
[977.632944] [131/133] ( 63s left) syncobj_timeline (single-wait-available-signaled)
[977.675378] Starting subtest: single-wait-available-signaled
[977.676473] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[977.763927] [132/133] ( 63s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[977.853955] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[977.855690] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[977.945122] [133/133] ( 63s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[978.041675] Starting subtest: fbc-rgb565-draw-render
[982.268881] Subtest fbc-rgb565-draw-render: SUCCESS (4.228s)
[983.371910] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_color_pipeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: prime_vgem
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: prime_self_import
results: parsing output: 9/ for test: gem_create
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: fbdev
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: i915_pm_freq_api
results: parsing output: 19/ for test: gem_ctx_isolation
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_properties
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: perf_pmu
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: tools_test
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: kms_cdclk
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: gem_userptr_blits
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: i915_selftest
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: api_intel_allocator
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: core_setmaster
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: i915_pm_rpm
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_frames
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_flink_race
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_pipe_stress
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_dsc
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_hdmi_inject
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_pm_backlight
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_fbcon_fbt
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: gem_exec_create
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_atomic
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: prime_mmap
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: kms_plane_multiple
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: gen3_render_mixed_blits
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_joiner
results: parsing output: 128/ for test: gem_exec_endless
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.