[56.600943] Initializing watchdogs
[56.601001]   /dev/watchdog0
[56.615643] [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]
[56.620392] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.623024] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.626530] [001/133] (960s left) kms_psr (fbc-psr2-cursor-blt)
[56.753874] Starting subtest: fbc-psr2-cursor-blt
[56.756209] Starting dynamic subtest: eDP-1
[56.760528] Dynamic subtest eDP-1: SKIP (0.000s)
[56.764887] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[56.823158] [002/133] (960s left) gem_exec_balancer (parallel-bb-first)
[57.089147] Starting subtest: parallel-bb-first
[58.041388] Subtest parallel-bb-first: SUCCESS (0.945s)
[58.935236] [003/133] (958s left) kms_cursor_edge_walk (128x128-top-edge)
[59.026197] Starting subtest: 128x128-top-edge
[59.028577] Starting dynamic subtest: pipe-A-eDP-1
[62.444579] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.403s)
[62.452743] Starting dynamic subtest: pipe-D-eDP-1
[65.587460] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[65.589846] Subtest 128x128-top-edge: SUCCESS (6.536s)
[66.386340] [004/133] (950s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[66.491706] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[66.496117] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[66.563859] [005/133] (950s left) gem_exec_parallel (contexts)
[66.621616] Starting subtest: contexts
[66.623887] Starting dynamic subtest: rcs0
[70.218906] Dynamic subtest rcs0: SUCCESS (3.591s)
[70.229053] Starting dynamic subtest: bcs0
[73.665319] Dynamic subtest bcs0: SUCCESS (3.442s)
[73.675901] Starting dynamic subtest: vcs0
[77.459999] Dynamic subtest vcs0: SUCCESS (3.792s)
[77.469885] Starting dynamic subtest: vcs1
[81.425387] Dynamic subtest vcs1: SUCCESS (3.960s)
[81.432619] Starting dynamic subtest: vecs0
[85.420321] Dynamic subtest vecs0: SUCCESS (3.992s)
[85.427808] Starting dynamic subtest: ccs0
[88.773560] Dynamic subtest ccs0: SUCCESS (3.350s)
[88.776446] Subtest contexts: SUCCESS (22.133s)
[88.957590] [006/133] (928s left) gem_exec_schedule (u-semaphore-resolve)
[89.025189] Starting subtest: u-semaphore-resolve
[89.082278] Subtest u-semaphore-resolve: SUCCESS (0.063s)
[89.434652] [007/133] (927s left) gem_exec_gttfill (engines)
[89.495940] Starting subtest: engines
[89.498319] Starting dynamic subtest: rcs0
[113.002503] Dynamic subtest rcs0: SUCCESS (23.501s)
[113.013995] Starting dynamic subtest: bcs0
[136.346825] Dynamic subtest bcs0: SUCCESS (23.341s)
[136.362689] Starting dynamic subtest: vcs0
[159.658854] Dynamic subtest vcs0: SUCCESS (23.311s)
[159.669859] Starting dynamic subtest: vcs1
[182.941337] Dynamic subtest vcs1: SUCCESS (23.284s)
[182.950083] Starting dynamic subtest: vecs0
[206.158033] Dynamic subtest vecs0: SUCCESS (23.215s)
[206.166110] Starting dynamic subtest: ccs0
[229.414234] Dynamic subtest ccs0: SUCCESS (23.255s)
[229.416691] Subtest engines: SUCCESS (139.913s)
[229.600436] [008/133] (787s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[229.757117] Starting subtest: yf-tiled-16bpp-rotate-0
[229.761327] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[229.837430] [009/133] (787s left) kms_big_fb (4-tiled-addfb)
[229.940422] Starting subtest: 4-tiled-addfb
[229.942627] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[230.058808] [010/133] (787s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[230.153273] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[230.155165] Starting dynamic subtest: pipe-A-eDP-1
[230.904528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[230.914135] Starting dynamic subtest: pipe-B-eDP-1
[232.744045] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.840s)
[232.754442] Starting dynamic subtest: pipe-C-eDP-1
[234.554924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.809s)
[234.565180] Starting dynamic subtest: pipe-D-eDP-1
[236.386875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.830s)
[236.389058] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.227s)
[237.520183] [011/133] (779s left) kms_content_protection (mei-interface)
[237.667393] Starting subtest: mei-interface
[237.677625] Subtest mei-interface: SKIP (0.008s)
[237.780389] [012/133] (779s left) i915_suspend (fence-restore-untiled)
[237.829731] Starting subtest: fence-restore-untiled
[237.834330] Subtest fence-restore-untiled: SKIP (0.000s)
[237.921734] [013/133] (779s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[238.029345] Starting subtest: fbc-psr-cursor-mmap-cpu
[238.031590] Starting dynamic subtest: eDP-1
[238.035819] Dynamic subtest eDP-1: SKIP (0.000s)
[238.040280] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[238.098828] [014/133] (779s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[238.222064] Starting subtest: flip-vs-cursor-crc-legacy
[238.949527] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.725s)
[239.754916] [015/133] (777s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[239.859952] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[239.864175] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[239.955167] [016/133] (777s left) gem_mmap_gtt (basic-small-bo-tiledy)
[240.016827] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[240.081822] [017/133] (777s left) kms_pm_rpm (basic-rte)
[240.118703] Starting subtest: basic-rte
[243.491206] Subtest basic-rte: SUCCESS (3.371s)
[244.993155] [018/133] (772s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[245.066574] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[245.069041] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[245.162212] [019/133] (772s left) i915_drm_fdinfo (virtual-busy-idle)
[245.212765] Starting subtest: virtual-busy-idle
[245.217051] Subtest virtual-busy-idle: SKIP (0.000s)
[245.275800] [020/133] (772s left) kms_psr (pr-primary-render)
[245.360845] Starting subtest: pr-primary-render
[245.364912] Subtest pr-primary-render: SKIP (0.000s)
[245.431327] [021/133] (772s left) gem_exec_big (single)
[245.490316] Starting subtest: single
[250.141587] Subtest single: SUCCESS (4.649s)
[250.415522] [022/133] (767s left) i915_drm_fdinfo (busy-idle-check-all)
[250.496569] Starting subtest: busy-idle-check-all
[250.498939] Starting dynamic subtest: rcs0
[250.503646] Dynamic subtest rcs0: SKIP (0.006s)
[250.515278] Starting dynamic subtest: bcs0
[250.519770] Dynamic subtest bcs0: SKIP (0.000s)
[250.527841] Starting dynamic subtest: vcs0
[250.532301] Dynamic subtest vcs0: SKIP (0.000s)
[250.539796] Starting dynamic subtest: vcs1
[250.544036] Dynamic subtest vcs1: SKIP (0.000s)
[250.551476] Starting dynamic subtest: vecs0
[250.555624] Dynamic subtest vecs0: SKIP (0.000s)
[250.564222] Starting dynamic subtest: ccs0
[250.568571] Dynamic subtest ccs0: SKIP (0.000s)
[250.572968] Subtest busy-idle-check-all: SKIP (0.009s)
[250.607733] [023/133] (767s left) kms_async_flips (crc)
[250.741917] Starting subtest: crc
[251.130882] Starting dynamic subtest: pipe-A-eDP-1
[254.007351] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.875s)
[254.384548] Starting dynamic subtest: pipe-B-eDP-1
[257.334571] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.958s)
[257.711044] Starting dynamic subtest: pipe-C-eDP-1
[260.640077] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.938s)
[261.001196] Starting dynamic subtest: pipe-D-eDP-1
[263.879971] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.886s)
[263.882435] Subtest crc: SUCCESS (13.139s)
[265.034305] [024/133] (752s left) gem_userptr_blits (coherency-unsync)
[265.108308] Subtest coherency-unsync: SKIP (0.000s)
[265.221200] [025/133] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[265.314494] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[265.318949] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.406365] [026/133] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[265.521339] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[269.830946] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.316s)
[270.936646] [027/133] (747s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[271.036310] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[271.040600] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[271.102526] [028/133] (747s left) kms_feature_discovery (psr2)
[271.198171] Starting subtest: psr2
[271.200360] Subtest psr2: SUCCESS (0.000s)
[271.281779] [029/133] (746s left) kms_pm_rpm (pm-tiling)
[273.034575] Starting subtest: pm-tiling
[273.039501] Subtest pm-tiling: SKIP (0.000s)
[273.561392] [030/133] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[273.668646] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[273.672685] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[273.758887] [031/133] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[273.853287] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[280.447120] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.596s)
[280.564992] [032/133] (737s left) kms_color (invalid-gamma-lut-sizes)
[280.653817] Starting subtest: invalid-gamma-lut-sizes
[280.656091] Starting dynamic subtest: pipe-A
[280.946739] Dynamic subtest pipe-A: SUCCESS (0.293s)
[280.955749] Starting dynamic subtest: pipe-B
[280.958060] Dynamic subtest pipe-B: SUCCESS (0.000s)
[280.966649] Starting dynamic subtest: pipe-C
[280.968946] Dynamic subtest pipe-C: SUCCESS (0.000s)
[280.977572] Starting dynamic subtest: pipe-D
[280.980040] Dynamic subtest pipe-D: SUCCESS (0.000s)
[280.982178] Subtest invalid-gamma-lut-sizes: SUCCESS (0.296s)
[281.812860] [033/133] (736s left) kms_dsc (dsc-basic)
[281.914696] Starting subtest: dsc-basic
[281.927575] Subtest dsc-basic: SKIP (0.000s)
[281.983284] [034/133] (736s left) gem_ctx_persistence (legacy-engines-persistence)
[282.047018] Starting subtest: legacy-engines-persistence
[282.049365] Starting dynamic subtest: render
[282.844451] Dynamic subtest render: SUCCESS (0.797s)
[282.857907] Starting dynamic subtest: bsd1
[283.612443] Dynamic subtest bsd1: SUCCESS (0.765s)
[283.623421] Starting dynamic subtest: bsd2
[284.363753] Dynamic subtest bsd2: SUCCESS (0.749s)
[284.374081] Starting dynamic subtest: blt
[285.117770] Dynamic subtest blt: SUCCESS (0.752s)
[285.128391] Starting dynamic subtest: vebox
[285.975994] Dynamic subtest vebox: SUCCESS (0.856s)
[285.978573] Subtest legacy-engines-persistence: SUCCESS (3.929s)
[286.059078] [035/133] (732s left) gem_ctx_param (invalid-get-ringsize)
[286.129165] Starting subtest: invalid-get-ringsize
[286.131538] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[286.225738] [036/133] (732s left) kms_psr (psr2-primary-mmap-cpu)
[286.318818] Starting subtest: psr2-primary-mmap-cpu
[286.321151] Starting dynamic subtest: eDP-1
[288.010680] Dynamic subtest eDP-1: SUCCESS (1.691s)
[288.013064] Subtest psr2-primary-mmap-cpu: SUCCESS (1.692s)
[288.875629] [037/133] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[288.974180] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[288.978308] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[289.044756] [038/133] (729s left) gem_userptr_blits (unsync-overlap)
[289.126399] Subtest unsync-overlap: SKIP (0.000s)
[289.262418] [039/133] (729s left) kms_dirtyfb (default-dirtyfb-ioctl)
[289.358706] Starting subtest: default-dirtyfb-ioctl
[289.361069] Starting dynamic subtest: A-eDP-1
[290.974680] Dynamic subtest A-eDP-1: SUCCESS (1.616s)
[290.976971] Subtest default-dirtyfb-ioctl: SUCCESS (1.617s)
[291.805659] [040/133] (726s left) sysfs_heartbeat_interval (idempotent)
[291.870231] Starting subtest: idempotent
[291.872495] Starting dynamic subtest: vecs0
[291.874696] Dynamic subtest vecs0: SUCCESS (0.001s)
[291.883694] Starting dynamic subtest: ccs0
[291.885771] Dynamic subtest ccs0: SUCCESS (0.001s)
[291.893581] Starting dynamic subtest: vcs0
[291.895734] Dynamic subtest vcs0: SUCCESS (0.001s)
[291.903464] Starting dynamic subtest: bcs0
[291.905581] Dynamic subtest bcs0: SUCCESS (0.001s)
[291.913619] Starting dynamic subtest: rcs0
[291.915490] Dynamic subtest rcs0: SUCCESS (0.000s)
[291.923149] Starting dynamic subtest: vcs1
[291.925251] Dynamic subtest vcs1: SUCCESS (0.000s)
[291.927305] Subtest idempotent: SUCCESS (0.007s)
[291.964639] [041/133] (726s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[292.059804] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[293.149734] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.090s)
[293.258026] [042/133] (725s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[293.311448] Starting subtest: single-wait-all-for-submit-signaled
[293.313441] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[293.404767] [043/133] (725s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[293.498530] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[293.501917] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[293.578194] [044/133] (725s left) kms_async_flips (invalid-async-flip-atomic)
[293.658127] Starting subtest: invalid-async-flip-atomic
[294.034743] Starting dynamic subtest: pipe-A-eDP-1
[294.840189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[295.206054] Starting dynamic subtest: pipe-B-eDP-1
[295.974670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s)
[296.330856] Starting dynamic subtest: pipe-C-eDP-1
[297.099197] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.775s)
[297.454075] Starting dynamic subtest: pipe-D-eDP-1
[298.228701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[298.231080] Subtest invalid-async-flip-atomic: SUCCESS (4.572s)
[299.372397] [045/133] (719s left) gem_softpin (evict-prime-sanity-check)
[299.434333] Starting subtest: evict-prime-sanity-check
[299.436726] Starting dynamic subtest: rcs0
[300.577052] Dynamic subtest rcs0: SUCCESS (1.142s)
[300.587431] Starting dynamic subtest: bcs0
[301.694932] Dynamic subtest bcs0: SUCCESS (1.117s)
[301.704378] Starting dynamic subtest: vcs0
[302.843343] Dynamic subtest vcs0: SUCCESS (1.146s)
[302.854169] Starting dynamic subtest: vcs1
[304.893305] Dynamic subtest vcs1: SUCCESS (2.046s)
[304.904068] Starting dynamic subtest: vecs0
[306.892418] Dynamic subtest vecs0: SUCCESS (1.998s)
[306.904277] Starting dynamic subtest: ccs0
[308.020587] Dynamic subtest ccs0: SUCCESS (1.127s)
[308.036645] Starting dynamic subtest: all
[309.156540] Dynamic subtest all: SUCCESS (1.135s)
[309.159131] Subtest evict-prime-sanity-check: SUCCESS (9.722s)
[309.232770] [046/133] (709s left) gem_ctx_param (basic-default)
[309.290909] Starting subtest: basic-default
[309.293745] Subtest basic-default: SUCCESS (0.000s)
[309.364734] [047/133] (709s left) kms_pipe_crc_basic (nonblocking-crc)
[309.461902] Starting subtest: nonblocking-crc
[309.463881] Starting dynamic subtest: pipe-A-eDP-1
[310.215277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s)
[310.228856] Starting dynamic subtest: pipe-B-eDP-1
[311.593491] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[311.602926] Starting dynamic subtest: pipe-C-eDP-1
[312.959728] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[312.968884] Starting dynamic subtest: pipe-D-eDP-1
[314.284188] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[314.286566] Subtest nonblocking-crc: SUCCESS (4.824s)
[315.096853] [048/133] (703s left) kms_flip (2x-absolute-wf_vblank)
[315.204872] Starting subtest: 2x-absolute-wf_vblank
[315.214244] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[315.306066] [049/133] (703s left) perf_pmu (invalid-init)
[315.345105] Starting subtest: invalid-init
[315.347485] Subtest invalid-init: SUCCESS (0.000s)
[315.454412] [050/133] (703s left) kms_addfb_basic (invalid-get-prop)
[315.512677] Starting subtest: invalid-get-prop
[315.514609] Subtest invalid-get-prop: SUCCESS (0.000s)
[315.648720] [051/133] (703s left) gem_exec_schedule (pi-shared-iova)
[315.829154] Starting subtest: pi-shared-iova
[315.831343] Starting dynamic subtest: rcs0
[315.906897] Dynamic subtest rcs0: SUCCESS (0.079s)
[315.918735] Starting dynamic subtest: vcs0
[315.963898] Dynamic subtest vcs0: SUCCESS (0.057s)
[315.975393] Starting dynamic subtest: vcs1
[316.013252] Dynamic subtest vcs1: SUCCESS (0.049s)
[316.024702] Starting dynamic subtest: vecs0
[316.085149] Dynamic subtest vecs0: SUCCESS (0.070s)
[316.095560] Starting dynamic subtest: ccs0
[316.139511] Dynamic subtest ccs0: SUCCESS (0.055s)
[316.141937] Subtest pi-shared-iova: SUCCESS (0.313s)
[318.024855] [052/133] (701s left) prime_mmap (test_forked)
[318.082933] Starting subtest: test_forked
[318.085018] Starting dynamic subtest: test_forked-smem
[318.122696] Dynamic subtest test_forked-smem: SUCCESS (0.042s)
[318.125182] Subtest test_forked: SUCCESS (0.044s)
[318.232473] [053/133] (700s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[318.327806] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[318.330260] Starting dynamic subtest: pipe-A
[318.663765] Dynamic subtest pipe-A: SUCCESS (0.338s)
[318.672189] Starting dynamic subtest: pipe-B
[320.079079] Dynamic subtest pipe-B: SUCCESS (1.414s)
[320.087674] Starting dynamic subtest: pipe-C
[321.512361] Dynamic subtest pipe-C: SUCCESS (1.432s)
[321.523810] Starting dynamic subtest: pipe-D
[322.946982] Dynamic subtest pipe-D: SUCCESS (1.434s)
[322.949304] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.621s)
[324.123032] [054/133] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[324.228281] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[324.232615] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[324.325866] [055/133] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[324.426145] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[324.430206] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[324.522083] [056/133] (694s left) gem_wait (wait)
[324.585889] Starting subtest: wait
[324.588136] Starting dynamic subtest: all-engines
[325.909514] Dynamic subtest all-engines: SUCCESS (1.322s)
[325.921076] Starting dynamic subtest: rcs0
[326.954050] Dynamic subtest rcs0: SUCCESS (1.043s)
[326.965371] Starting dynamic subtest: bcs0
[328.001249] Dynamic subtest bcs0: SUCCESS (1.045s)
[328.012599] Starting dynamic subtest: vcs0
[329.047673] Dynamic subtest vcs0: SUCCESS (1.044s)
[329.058496] Starting dynamic subtest: vcs1
[330.092770] Dynamic subtest vcs1: SUCCESS (1.043s)
[330.103285] Starting dynamic subtest: vecs0
[331.137416] Dynamic subtest vecs0: SUCCESS (1.042s)
[331.148297] Starting dynamic subtest: ccs0
[332.184419] Dynamic subtest ccs0: SUCCESS (1.045s)
[332.186945] Subtest wait: SUCCESS (7.599s)
[332.383532] [057/133] (686s left) perf (mi-rpc)
[332.541612] Starting subtest: mi-rpc
[332.545828] Subtest mi-rpc: SKIP (0.000s)
[332.584695] [058/133] (686s left) kms_flip (2x-flip-vs-dpms)
[332.694083] Starting subtest: 2x-flip-vs-dpms
[332.703273] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[332.788405] [059/133] (686s left) syncobj_basic (bad-create-flags)
[332.842954] Starting subtest: bad-create-flags
[332.845121] Subtest bad-create-flags: SUCCESS (0.000s)
[332.959290] [060/133] (686s left) api_intel_allocator (gem-pool)
[333.014324] Starting subtest: gem-pool
[333.020475] Subtest gem-pool: SUCCESS (0.009s)
[333.142861] [061/133] (686s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[333.231858] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[333.236158] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[333.305258] [062/133] (686s left) gem_exec_whisper (basic-sync)
[333.361611] Starting subtest: basic-sync
[339.973949] Subtest basic-sync: SUCCESS (6.612s)
[340.158853] [063/133] (679s left) perf_pmu (busy-start)
[340.206078] Starting subtest: busy-start
[340.208312] Starting dynamic subtest: rcs0
[342.756657] Dynamic subtest rcs0: SUCCESS (2.553s)
[342.768611] Starting dynamic subtest: bcs0
[345.306395] Dynamic subtest bcs0: SUCCESS (2.547s)
[345.319032] Starting dynamic subtest: vcs0
[348.885635] Dynamic subtest vcs0: SUCCESS (3.576s)
[348.897444] Starting dynamic subtest: vcs1
[352.919067] Dynamic subtest vcs1: SUCCESS (4.030s)
[352.929203] Starting dynamic subtest: vecs0
[356.885401] Dynamic subtest vecs0: SUCCESS (3.965s)
[356.902037] Starting dynamic subtest: ccs0
[359.433804] Dynamic subtest ccs0: SUCCESS (2.547s)
[359.436804] Subtest busy-start: SUCCESS (19.230s)
[359.548602] [064/133] (659s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[359.655955] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[359.658208] Starting dynamic subtest: pipe-A-eDP-1
[359.715625] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[359.724200] Starting dynamic subtest: pipe-B-eDP-1
[359.780994] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[359.790432] Starting dynamic subtest: pipe-C-eDP-1
[359.846609] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[359.855796] Starting dynamic subtest: pipe-D-eDP-1
[359.913977] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[359.918502] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[361.978945] [065/133] (657s left) kms_lease (lease-unleased-crtc)
[362.083141] Starting subtest: lease-unleased-crtc
[362.085342] Starting dynamic subtest: pipe-A-eDP-1
[362.371200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[362.380638] Starting dynamic subtest: pipe-B-eDP-1
[363.130153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[363.141618] Starting dynamic subtest: pipe-C-eDP-1
[363.144128] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[363.152634] Starting dynamic subtest: pipe-D-eDP-1
[363.154872] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[363.157105] Subtest lease-unleased-crtc: SUCCESS (1.060s)
[363.518479] [066/133] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[363.637187] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[363.641658] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[363.752898] [067/133] (655s left) prime_vgem (basic-fence-read)
[363.901789] Starting subtest: basic-fence-read
[363.907862] Subtest basic-fence-read: SKIP (0.007s)
[364.025300] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[364.028444] [068/133] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[364.134036] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[364.138139] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[364.252918] [069/133] (655s left) gem_exec_params (dr4-dirt)
[364.314383] Starting subtest: DR4-dirt
[364.316598] Subtest DR4-dirt: SUCCESS (0.000s)
[364.416527] [070/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[364.520931] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[372.223154] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.705s)
[372.339875] [071/133] (647s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[372.446692] Starting subtest: fbc-modesetfrombusy
[376.157032] Subtest fbc-modesetfrombusy: SUCCESS (3.714s)
[377.331920] [072/133] (642s left) gem_create (create-ext-placement-sanity-check)
[377.499381] Starting subtest: create-ext-placement-sanity-check
[377.501925] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[377.595389] [073/133] (642s left) gem_partial_pwrite_pread (reads-uncached)
[377.659247] Subtest reads-uncached: SKIP (0.000s)
[377.733727] [074/133] (642s left) gem_reg_read (timestamp-monotonic)
[377.789070] Starting subtest: timestamp-monotonic
[382.528051] Subtest timestamp-monotonic: SUCCESS (4.739s)
[382.622335] [075/133] (637s left) kms_invalid_mode (int-max-clock)
[382.734120] Starting subtest: int-max-clock
[382.736378] Starting dynamic subtest: pipe-A-eDP-1
[383.018428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[383.027768] Starting dynamic subtest: pipe-B-eDP-1
[383.030029] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[383.038383] Starting dynamic subtest: pipe-C-eDP-1
[383.040602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[383.049149] Starting dynamic subtest: pipe-D-eDP-1
[383.051537] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[383.053781] Subtest int-max-clock: SUCCESS (0.290s)
[383.841110] [076/133] (636s left) gen7_exec_parse (oacontrol-tracking)
[383.908382] Subtest oacontrol-tracking: SKIP (0.000s)
[383.981179] [077/133] (636s left) gem_flink_basic (bad-flink)
[384.040882] Starting subtest: bad-flink
[384.043056] Subtest bad-flink: SUCCESS (0.000s)
[384.147415] [078/133] (635s left) kms_chamelium_edid (dp-edid-resolution-list)
[384.550873] Subtest dp-edid-resolution-list: SKIP (0.000s)
[385.356662] [079/133] (634s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[385.452968] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[385.455286] Starting dynamic subtest: pipe-A-eDP-1
[385.477291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.487775] Starting dynamic subtest: pipe-B-eDP-1
[385.505543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.513488] Starting dynamic subtest: pipe-C-eDP-1
[385.534110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.541847] Starting dynamic subtest: pipe-D-eDP-1
[385.562840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.567056] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[387.735373] [080/133] (632s left) gen3_render_linear_blits
[387.843341] [081/133] (632s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[387.900492] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[387.964595] [082/133] (632s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[388.078247] Starting subtest: 2x-long-flip-vs-cursor-legacy
[388.082604] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[388.254530] [083/133] (632s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[388.308707] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[388.313067] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[388.494497] [084/133] (631s left) kms_busy (extended-modeset-hang-oldfb)
[388.592925] Starting subtest: extended-modeset-hang-oldfb
[388.595428] Starting dynamic subtest: pipe-A
[400.328204] Dynamic subtest pipe-A: SUCCESS (11.734s)
[400.339809] Starting dynamic subtest: pipe-D
[412.605452] Dynamic subtest pipe-D: SUCCESS (12.270s)
[412.607867] Subtest extended-modeset-hang-oldfb: SUCCESS (24.011s)
[413.398244] [085/133] (607s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[413.498630] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[420.156215] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.661s)
[420.272887] [086/133] (600s left) perf_pmu (busy-check-all)
[420.322486] Starting subtest: busy-check-all
[420.324378] Starting dynamic subtest: rcs0
[420.882090] Dynamic subtest rcs0: SUCCESS (0.561s)
[420.894965] Starting dynamic subtest: bcs0
[421.436328] Dynamic subtest bcs0: SUCCESS (0.552s)
[421.449380] Starting dynamic subtest: vcs0
[422.935289] Dynamic subtest vcs0: SUCCESS (1.494s)
[422.947771] Starting dynamic subtest: vcs1
[424.917479] Dynamic subtest vcs1: SUCCESS (1.979s)
[424.929833] Starting dynamic subtest: vecs0
[426.902166] Dynamic subtest vecs0: SUCCESS (1.981s)
[426.918510] Starting dynamic subtest: ccs0
[427.457913] Dynamic subtest ccs0: SUCCESS (0.553s)
[427.460812] Subtest busy-check-all: SUCCESS (7.138s)
[427.555886] [087/133] (592s left) gem_exec_whisper (basic-fds-all)
[427.621081] Starting subtest: basic-fds-all
[440.885064] Subtest basic-fds-all: SUCCESS (13.261s)
[441.073397] [088/133] (579s left) kms_addfb_basic (unused-pitches)
[441.131674] Starting subtest: unused-pitches
[441.134036] Subtest unused-pitches: SUCCESS (0.000s)
[441.302455] [089/133] (579s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[441.411800] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[441.413929] Starting dynamic subtest: pipe-A-eDP-1
[441.438038] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.448576] Starting dynamic subtest: pipe-B-eDP-1
[441.469273] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.478570] Starting dynamic subtest: pipe-C-eDP-1
[441.499528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.508222] Starting dynamic subtest: pipe-D-eDP-1
[441.530175] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[441.534219] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[443.696384] [090/133] (577s left) kms_psr (psr-primary-mmap-gtt)
[443.799827] Starting subtest: psr-primary-mmap-gtt
[443.802128] Starting dynamic subtest: eDP-1
[445.282325] Dynamic subtest eDP-1: SKIP (1.479s)
[445.286827] Subtest psr-primary-mmap-gtt: SKIP (1.481s)
[445.418249] [091/133] (575s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[445.517082] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[445.519342] Starting dynamic subtest: pipe-A-eDP-1
[445.528322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[445.538301] Starting dynamic subtest: pipe-B-eDP-1
[445.547089] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[445.555705] Starting dynamic subtest: pipe-C-eDP-1
[445.564317] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[445.573207] Starting dynamic subtest: pipe-D-eDP-1
[445.581722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[445.586047] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[447.810906] [092/133] (572s left) kms_flip (2x-nonexisting-fb)
[447.914280] Starting subtest: 2x-nonexisting-fb
[447.923562] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[448.056524] [093/133] (572s left) fbdev (nullptr)
[448.093681] Starting subtest: nullptr
[448.096059] Subtest nullptr: SUCCESS (0.000s)
[448.154428] [094/133] (572s left) vgem_basic (unload)
[448.197063] Starting subtest: unload
[477.277590] Subtest unload: SUCCESS (29.083s)
[477.375747] [095/133] (543s left) gem_lmem_swapping (smem-oom)
[477.426074] Subtest smem-oom: SKIP (0.000s)
[477.479354] [096/133] (543s left) dmabuf_sync_file (export-wait-after-attach)
[477.528184] Starting subtest: export-wait-after-attach
[477.530510] Subtest export-wait-after-attach: SUCCESS (0.001s)
[477.587062] [097/133] (543s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[477.689362] Starting subtest: psr-2p-primscrn-cur-indfb-move
[477.693581] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[477.788103] [098/133] (543s left) perf (invalid-create-userspace-config)
[477.885946] Starting subtest: invalid-create-userspace-config
[477.888360] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[477.931123] [099/133] (543s left) gem_ctx_sseu (invalid-args)
[477.999795] Subtest invalid-args: SKIP (0.000s)
[478.062166] [100/133] (543s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[478.173609] Starting subtest: yf-tiled-8bpp-rotate-270
[478.178069] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[478.271074] [101/133] (542s left) syncobj_timeline (32bits-limit)
[478.316548] Starting subtest: 32bits-limit
[478.318535] Subtest 32bits-limit: SUCCESS (0.001s)
[478.426272] [102/133] (542s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[478.513508] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[478.516831] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[478.595603] [103/133] (542s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[478.650348] Starting subtest: etime-single-wait-all-for-submit-submitted
[478.753618] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[478.845470] [104/133] (542s left) gem_userptr_blits (unsync-unmap-cycles)
[478.927645] Subtest unsync-unmap-cycles: SKIP (0.000s)
[479.051010] [105/133] (542s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[479.102412] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[479.104670] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[479.194912] [106/133] (542s left) gem_mmap_gtt (big-bo-tiledx)
[479.255403] Subtest big-bo-tiledX: SKIP (0.000s)
[479.316809] [107/133] (542s left) sw_sync (sync_merge_invalid)
[479.349986] Starting subtest: sync_merge_invalid
[479.364470] Subtest sync_merge_invalid: SUCCESS (0.014s)
[479.447407] [108/133] (542s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[479.543515] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[479.547983] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[479.660206] [109/133] (541s left) i915_pm_rc6_residency (rc6-accuracy)
[479.716190] Starting subtest: rc6-accuracy
[479.718073] Starting dynamic subtest: gt0
[482.889461] Dynamic subtest gt0: SUCCESS (3.169s)
[482.904278] Starting dynamic subtest: gt1
[486.060999] Dynamic subtest gt1: SUCCESS (3.168s)
[486.063624] Subtest rc6-accuracy: SUCCESS (6.343s)
[486.137685] [110/133] (535s left) perf (polling)
[486.232612] Starting subtest: polling
[486.235020] Starting dynamic subtest: 0-rcs0
[496.252915] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[496.267812] Starting dynamic subtest: 1-vcs0
[506.277897] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[506.280901] Subtest polling: SUCCESS (20.043s)
[506.330636] [111/133] (515s left) kms_cursor_crc (cursor-alpha-transparent)
[506.426423] Starting subtest: cursor-alpha-transparent
[506.428592] Starting dynamic subtest: pipe-A-eDP-1
[507.043065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[507.052991] Starting dynamic subtest: pipe-D-eDP-1
[508.363549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[508.365960] Subtest cursor-alpha-transparent: SUCCESS (1.938s)
[509.161709] [112/133] (512s left) gem_render_copy (linear-to-vebox-y-tiled)
[509.224110] Starting subtest: linear-to-vebox-y-tiled
[509.228253] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[509.418621] [113/133] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[509.523879] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[509.528262] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[509.631145] [114/133] (512s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[509.792750] Starting subtest: cursor-rapid-movement-32x10
[509.844115] Subtest cursor-rapid-movement-32x10: SKIP (0.046s)
[510.112281] [115/133] (511s left) api_intel_bb (simple-bb)
[510.174088] Starting subtest: simple-bb
[510.177831] Subtest simple-bb: SUCCESS (0.006s)
[510.293125] [116/133] (511s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[510.389031] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[517.051431] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.661s)
[517.188228] [117/133] (504s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[517.297977] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[517.344247] [118/133] (504s left) gem_mmap_offset (oob-read)
[517.394015] Starting subtest: oob-read
[517.395934] Subtest oob-read: SUCCESS (0.000s)
[517.483728] [119/133] (504s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[517.582588] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[518.690737] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.509s)
[518.732291] [120/133] (503s left) prime_busy (hang-wait)
[518.782377] Starting subtest: hang-wait
[518.784787] Starting dynamic subtest: rcs0
[545.396548] Dynamic subtest rcs0: SUCCESS (26.609s)
[545.406889] Starting dynamic subtest: bcs0
[552.486957] Dynamic subtest bcs0: SUCCESS (7.089s)
[552.495737] Starting dynamic subtest: vcs0
[559.539538] Dynamic subtest vcs0: SUCCESS (7.050s)
[559.548364] Starting dynamic subtest: vcs1
[566.510781] Dynamic subtest vcs1: SUCCESS (6.968s)
[566.521406] Starting dynamic subtest: vecs0
[573.539966] Dynamic subtest vecs0: SUCCESS (7.027s)
[573.550357] Starting dynamic subtest: ccs0
[587.377752] Dynamic subtest ccs0: SUCCESS (13.835s)
[587.380361] Subtest hang-wait: SUCCESS (68.593s)
[587.492123] [121/133] (434s left) gem_tiled_fence_blits (basic)
[587.556127] Subtest basic: SKIP (0.000s)
[587.629551] [122/133] (434s left) gem_exec_fence (syncobj-timeline-export)
[588.206067] Starting subtest: syncobj-timeline-export
[588.215186] Subtest syncobj-timeline-export: SUCCESS (0.011s)
[589.987834] [123/133] (432s left) gem_fence_thrash (bo-write-verify-none)
[590.021206] Starting subtest: bo-write-verify-none
[590.042904] Subtest bo-write-verify-none: SKIP (0.020s)
[590.106221] [124/133] (432s left) gem_tiled_blits (normal)
[590.153910] Subtest normal: SKIP (0.000s)
[590.227364] [125/133] (431s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[590.324667] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[590.329176] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[590.413894] [126/133] (431s left) kms_chamelium_hpd (hdmi-hpd)
[590.793336] Subtest hdmi-hpd: SKIP (0.000s)
[591.579884] [127/133] (430s left) kms_vblank (query-forked-busy-hang)
[591.671797] Starting subtest: query-forked-busy-hang
[591.674061] Starting dynamic subtest: pipe-A-eDP-1
[618.643246] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.968s)
[618.657482] Starting dynamic subtest: pipe-D-eDP-1
[633.690788] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s)
[633.693179] Subtest query-forked-busy-hang: SUCCESS (42.018s)
[634.584364] [128/133] (387s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[634.634830] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[634.636940] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[634.734901] [129/133] (387s left) gem_mmap (pf-nonblock)
[634.795604] Subtest pf-nonblock: SKIP (0.000s)
[634.851315] [130/133] (387s left) kms_flip (blocking-absolute-wf_vblank)
[634.952252] Starting subtest: blocking-absolute-wf_vblank
[634.954459] Starting dynamic subtest: A-eDP1
[643.736290] Dynamic subtest A-eDP1: SUCCESS (8.785s)
[643.748936] Starting dynamic subtest: B-eDP1
[652.461531] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[652.472387] Starting dynamic subtest: C-eDP1
[661.175226] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[661.185270] Starting dynamic subtest: D-eDP1
[669.936874] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[669.939361] Subtest blocking-absolute-wf_vblank: SUCCESS (34.965s)
[671.137490] [131/133] (351s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[671.230221] Starting subtest: psr2-cursor-plane-update-sf
[671.232622] Starting dynamic subtest: pipe-A-eDP-1
[671.803251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[671.812376] Starting dynamic subtest: pipe-B-eDP-1
[673.114759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[673.116695] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.886s)
[673.991419] [132/133] (348s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[674.081872] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[674.086087] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[674.177352] [133/133] (348s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[674.272974] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[674.275243] Starting dynamic subtest: pipe-A
[674.395796] Dynamic subtest pipe-A: SKIP (0.118s)
[674.407150] Starting dynamic subtest: pipe-B
[675.567220] Dynamic subtest pipe-B: SKIP (1.170s)
[675.576521] Starting dynamic subtest: pipe-C
[676.790942] Dynamic subtest pipe-C: SUCCESS (1.229s)
[676.805959] Starting dynamic subtest: pipe-D
[678.018959] Dynamic subtest pipe-D: SUCCESS (1.226s)
[678.021332] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.748s)
[679.214883] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_exec_parallel
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_exec_gttfill
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_content_protection
results: parsing output: 11/ for test: i915_suspend
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_big
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_color
results: parsing output: 32/ for test: kms_dsc
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: sysfs_heartbeat_interval
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_pipe_crc_basic
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_wait
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: gem_partial_pwrite_pread
results: parsing output: 73/ for test: gem_reg_read
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: gem_flink_basic
results: parsing output: 77/ for test: kms_chamelium_edid
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gen3_render_linear_blits
results: parsing output: 80/ for test: kms_pipe_b_c_ivb
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: vgem_basic
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: dmabuf_sync_file
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gem_ctx_sseu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_rc6_residency
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_tiled_display
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: gem_tiled_fence_blits
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: gem_tiled_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.