[60.418109] Initializing watchdogs
[60.418154]   /dev/watchdog0
[60.432130] [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]
[60.436400] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.438534] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.441749] [001/133] (960s left) kms_prop_blob (invalid-set-prop-any)
[60.512895] Starting subtest: invalid-set-prop-any
[60.514954] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[60.606843] [002/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[60.730526] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[61.581071] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s)
[61.749311] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[61.859296] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[61.863517] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[61.955220] [004/133] (959s left) gem_vm_create (isolation)
[62.023830] Starting subtest: isolation
[62.037227] Subtest isolation: SUCCESS (0.012s)
[62.170667] [005/133] (958s left) kms_force_connector_basic (force-edid)
[62.248656] Starting subtest: force-edid
[62.611175] Subtest force-edid: SUCCESS (0.361s)
[62.750565] [006/133] (958s left) gem_render_copy (y-tiled)
[62.809236] Starting subtest: y-tiled
[62.813121] Subtest y-tiled: SKIP (0.000s)
[63.003704] [007/133] (958s left) kms_pipe_crc_basic (read-crc)
[63.093481] Starting subtest: read-crc
[63.095853] Starting dynamic subtest: pipe-A-eDP-1
[63.802375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[63.810330] Starting dynamic subtest: pipe-B-eDP-1
[65.150224] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[65.161762] Starting dynamic subtest: pipe-C-eDP-1
[66.524430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[66.536415] Starting dynamic subtest: pipe-D-eDP-1
[67.838639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[67.841156] Subtest read-crc: SUCCESS (4.734s)
[68.711363] [008/133] (952s left) gem_partial_pwrite_pread (reads-uncached)
[68.776408] Subtest reads-uncached: SKIP (0.000s)
[68.845901] [009/133] (952s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[68.948932] Starting subtest: yf-tiled-8bpp-rotate-90
[68.953037] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[69.046911] [010/133] (952s left) kms_dsc (dsc-basic)
[69.131109] Starting subtest: dsc-basic
[69.144058] Subtest dsc-basic: SKIP (0.000s)
[69.219187] [011/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[69.314175] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[76.540837] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.224s)
[76.664161] [012/133] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[76.781254] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[83.340051] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.560s)
[83.475177] [013/133] (937s left) kms_content_protection (uevent)
[83.610931] Starting subtest: uevent
[83.615466] Subtest uevent: SKIP (0.000s)
[83.754800] [014/133] (937s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[83.860886] Starting subtest: extended-pageflip-modeset-hang-oldfb
[83.863152] Starting dynamic subtest: pipe-A
[91.752537] Dynamic subtest pipe-A: SUCCESS (7.887s)
[91.762924] Starting dynamic subtest: pipe-D
[100.410728] Dynamic subtest pipe-D: SUCCESS (8.653s)
[100.413181] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.544s)
[101.233914] [015/133] (920s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[101.338391] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[102.307447] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.968s)
[102.415950] [016/133] (919s left) gem_eio (throttle)
[102.604312] Starting subtest: throttle
[102.852438] Subtest throttle: SUCCESS (0.248s)
[102.985651] [017/133] (918s left) api_intel_bb (object-reloc-keep-cache)
[103.047341] Starting subtest: object-reloc-keep-cache
[103.051337] Subtest object-reloc-keep-cache: SKIP (0.002s)
[103.163635] [018/133] (918s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[103.226084] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[103.227984] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[103.343493] [019/133] (918s left) perf_pmu (semaphore-wait-idle)
[103.380805] Starting subtest: semaphore-wait-idle
[103.382913] Starting dynamic subtest: rcs0
[103.896456] Dynamic subtest rcs0: SUCCESS (0.514s)
[103.907527] Starting dynamic subtest: bcs0
[104.412013] Dynamic subtest bcs0: SUCCESS (0.513s)
[104.429350] Starting dynamic subtest: vcs0
[104.926844] Dynamic subtest vcs0: SUCCESS (0.513s)
[104.937851] Starting dynamic subtest: vcs1
[105.437289] Dynamic subtest vcs1: SUCCESS (0.510s)
[105.448043] Starting dynamic subtest: vecs0
[105.952096] Dynamic subtest vecs0: SUCCESS (0.512s)
[105.962760] Starting dynamic subtest: ccs0
[106.469253] Dynamic subtest ccs0: SUCCESS (0.514s)
[106.472196] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[106.989210] [020/133] (914s left) kms_psr (fbc-psr2-sprite-blt)
[107.098770] Starting subtest: fbc-psr2-sprite-blt
[107.100606] Starting dynamic subtest: eDP-1
[107.104649] Dynamic subtest eDP-1: SKIP (0.000s)
[107.108687] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[107.181169] [021/133] (914s left) gem_eio (wait-immediate)
[107.350671] Starting subtest: wait-immediate
[107.630909] Subtest wait-immediate: SUCCESS (0.281s)
[107.793278] [022/133] (913s left) i915_drm_fdinfo (virtual-busy)
[107.832668] Starting subtest: virtual-busy
[107.836953] Subtest virtual-busy: SKIP (0.000s)
[107.899639] [023/133] (913s left) gem_pxp (verify-pxp-stale-buf-execution)
[108.016208] Starting subtest: verify-pxp-stale-buf-execution
[109.078799] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[109.211797] [024/133] (912s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[109.311905] Starting subtest: 4-tiled-16bpp-rotate-90
[109.330808] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.018s)
[109.451386] [025/133] (912s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[109.553896] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[109.556313] Starting dynamic subtest: pipe-A-eDP-1
[109.578574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[109.588864] Starting dynamic subtest: pipe-B-eDP-1
[109.609294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[109.616956] Starting dynamic subtest: pipe-C-eDP-1
[109.637575] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[109.645178] Starting dynamic subtest: pipe-D-eDP-1
[109.666998] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[109.671152] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[111.833244] [026/133] (910s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[111.895420] Starting subtest: invalid-bsd2-flag-on-vebox
[111.897675] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[112.005216] [027/133] (909s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[112.112469] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[112.116741] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[112.213942] [028/133] (909s left) gem_mmap_gtt (big-bo-tiledx)
[112.265038] Subtest big-bo-tiledX: SKIP (0.000s)
[112.322048] [029/133] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[112.427094] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[119.587733] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.163s)
[120.738236] [030/133] (901s left) kms_cursor_edge_walk (128x128-left-edge)
[120.830937] Starting subtest: 128x128-left-edge
[120.833282] Starting dynamic subtest: pipe-A-eDP-1
[124.281386] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[124.289716] Starting dynamic subtest: pipe-D-eDP-1
[127.461266] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.180s)
[127.463469] Subtest 128x128-left-edge: SUCCESS (6.632s)
[128.332728] [031/133] (893s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[128.436028] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[128.448881] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s)
[128.522409] [032/133] (893s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[128.620804] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[128.623134] Starting dynamic subtest: pipe-A-eDP-1
[145.250787] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.287s)
[145.266792] Starting dynamic subtest: pipe-B-eDP-1
[162.224860] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.393s)
[162.233649] Starting dynamic subtest: pipe-C-eDP-1
[179.169295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.377s)
[179.180341] Starting dynamic subtest: pipe-D-eDP-1
[196.174963] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.353s)
[196.177433] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.417s)
[197.329648] [033/133] (824s left) kms_psr (psr2-cursor-mmap-gtt)
[197.429220] Starting subtest: psr2-cursor-mmap-gtt
[197.432114] Starting dynamic subtest: eDP-1
[199.139744] Dynamic subtest eDP-1: SUCCESS (1.671s)
[199.142032] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.672s)
[199.998849] [034/133] (822s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[200.108755] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[206.943498] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.754s)
[207.052488] [035/133] (815s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[207.117565] Starting subtest: single-wait-for-submit-available-submitted
[207.119719] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[207.227207] [036/133] (815s left) kms_color (ctm-negative)
[207.317427] Starting subtest: ctm-negative
[207.319329] Starting dynamic subtest: pipe-A-eDP-1
[208.032186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[208.042168] Starting dynamic subtest: pipe-B-eDP-1
[209.491901] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.449s)
[209.501825] Starting dynamic subtest: pipe-C-eDP-1
[210.829406] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.331s)
[210.838263] Starting dynamic subtest: pipe-D-eDP-1
[212.236387] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[212.238697] Subtest ctm-negative: SUCCESS (4.892s)
[213.126750] [037/133] (809s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[213.232628] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[213.236726] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[213.300083] [038/133] (809s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[213.414561] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[214.861756] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.441s)
[215.719714] [039/133] (806s left) api_intel_allocator (reserve-simple)
[215.782586] Starting subtest: reserve-simple
[215.784946] Subtest reserve-simple: SUCCESS (0.003s)
[215.901722] [040/133] (806s left) kms_tv_load_detect (load-detect)
[215.965992] Subtest load-detect: SKIP (0.000s)
[216.032738] [041/133] (806s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[216.148731] Starting subtest: 2x-long-flip-vs-cursor-atomic
[216.153099] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[216.287981] [042/133] (806s left) gem_exec_schedule (pi-common)
[216.472163] Starting subtest: pi-common
[216.474375] Starting dynamic subtest: rcs0
[216.539360] Dynamic subtest rcs0: SUCCESS (0.070s)
[216.552121] Starting dynamic subtest: bcs0
[216.568000] Dynamic subtest bcs0: SUCCESS (0.028s)
[216.580693] Starting dynamic subtest: vcs0
[216.596088] Dynamic subtest vcs0: SUCCESS (0.027s)
[216.609438] Starting dynamic subtest: vcs1
[216.622420] Dynamic subtest vcs1: SUCCESS (0.025s)
[216.634105] Starting dynamic subtest: vecs0
[216.649375] Dynamic subtest vecs0: SUCCESS (0.026s)
[216.661386] Starting dynamic subtest: ccs0
[216.676204] Dynamic subtest ccs0: SUCCESS (0.026s)
[216.678518] Subtest pi-common: SUCCESS (0.207s)
[216.904491] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[216.907926] [043/133] (805s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[216.997188] Starting subtest: fbc-psr-cursor-mmap-gtt
[216.999393] Starting dynamic subtest: eDP-1
[217.003897] Dynamic subtest eDP-1: SKIP (0.000s)
[217.008126] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.002s)
[217.080094] [044/133] (805s left) gem_create (create-valid-nonaligned)
[217.138428] Starting subtest: create-valid-nonaligned
[217.140613] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[217.322141] [045/133] (805s left) gem_mmap_gtt (medium-copy)
[217.372537] Subtest medium-copy: SKIP (0.000s)
[217.438678] [046/133] (805s left) gem_exec_schedule (u-fairslice-all)
[217.511465] Starting subtest: u-fairslice-all
[219.568764] Subtest u-fairslice-all: SUCCESS (2.053s)
[220.872580] [047/133] (801s left) syncobj_wait (wait-all-complex)
[220.932530] Starting subtest: wait-all-complex
[221.145793] Subtest wait-all-complex: SUCCESS (0.213s)
[221.222364] [048/133] (801s left) drm_mm (drm_mm)
[221.273913] Starting subtest: drm_mm
[221.281690] Starting dynamic subtest: drm_test_mm_init
[221.381243] Dynamic subtest drm_test_mm_init: SUCCESS (0.099s)
[221.391563] Starting dynamic subtest: drm_test_mm_debug
[221.532342] Dynamic subtest drm_test_mm_debug: SUCCESS (0.130s)
[221.541454] Starting dynamic subtest: drm_test_mm_align32
[221.630359] Dynamic subtest drm_test_mm_align32: SUCCESS (0.116s)
[221.640928] Starting dynamic subtest: drm_test_mm_align64
[221.738302] Dynamic subtest drm_test_mm_align64: SUCCESS (0.106s)
[221.748491] Starting dynamic subtest: drm_test_mm_lowest
[221.845277] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.107s)
[221.854085] Starting dynamic subtest: drm_test_mm_highest
[221.942185] Dynamic subtest drm_test_mm_highest: SUCCESS (0.094s)
[221.944400] Subtest drm_mm: SUCCESS (0.668s)
[222.113389] [049/133] (800s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[222.214146] Starting subtest: primary-4-tiled-reflect-x-0
[229.229481] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.013s)
[230.454772] [050/133] (792s left) kms_psr (fbc-pr-primary-mmap-cpu)
[230.549942] Starting subtest: fbc-pr-primary-mmap-cpu
[230.554121] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[230.634651] [051/133] (792s left) gem_lmem_swapping (parallel-random-engines)
[230.683684] Subtest parallel-random-engines: SKIP (0.000s)
[230.730674] [052/133] (792s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[230.829785] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[230.833989] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[230.929739] [053/133] (792s left) gem_exec_params (rel-constants-invalid-ring)
[230.979868] Starting subtest: rel-constants-invalid-ring
[230.982277] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[231.075246] [054/133] (791s left) gem_softpin (safe-alignment)
[231.141605] Starting subtest: safe-alignment
[231.162869] Subtest safe-alignment: SUCCESS (0.024s)
[232.877163] [055/133] (790s left) gem_mmap_wc (write-cpu-read-wc)
[232.948109] Subtest write-cpu-read-wc: SKIP (0.000s)
[233.004894] [056/133] (790s left) gem_linear_blits (basic)
[233.402076] Starting subtest: basic
[233.416918] Subtest basic: SUCCESS (0.015s)
[233.567482] [057/133] (789s left) gem_exec_params (invalid-fence-in)
[233.683567] Starting subtest: invalid-fence-in
[233.685917] Subtest invalid-fence-in: SUCCESS (0.000s)
[233.798877] [058/133] (789s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[233.909562] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[233.913418] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[233.991091] [059/133] (789s left) gem_busy (parallel)
[234.169941] Starting subtest: parallel
[234.172347] Starting dynamic subtest: rcs0
[235.899099] Dynamic subtest rcs0: SUCCESS (1.727s)
[235.911433] Starting dynamic subtest: bcs0
[237.882102] Dynamic subtest bcs0: SUCCESS (1.981s)
[237.896893] Starting dynamic subtest: vcs0
[239.866911] Dynamic subtest vcs0: SUCCESS (1.982s)
[239.879549] Starting dynamic subtest: vcs1
[241.850168] Dynamic subtest vcs1: SUCCESS (1.980s)
[241.862553] Starting dynamic subtest: vecs0
[243.894728] Dynamic subtest vecs0: SUCCESS (2.043s)
[243.905511] Starting dynamic subtest: ccs0
[245.882087] Dynamic subtest ccs0: SUCCESS (1.984s)
[245.884869] Subtest parallel: SUCCESS (11.713s)
[246.171613] [060/133] (777s left) kms_chamelium_hpd (hdmi-hpd-storm)
[246.572633] Subtest hdmi-hpd-storm: SKIP (0.000s)
[247.409759] [061/133] (775s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[247.637789] Starting subtest: cursor-rapid-movement-128x128
[247.642475] Starting dynamic subtest: pipe-A-eDP-1
[248.231518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[248.264166] Starting dynamic subtest: pipe-D-eDP-1
[249.403319] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.147s)
[249.405716] Subtest cursor-rapid-movement-128x128: SUCCESS (1.764s)
[250.237988] [062/133] (773s left) kms_pm_dc (dc3co-vpb-simulation)
[251.347022] Starting subtest: dc3co-vpb-simulation
[260.603367] Subtest dc3co-vpb-simulation: SKIP (9.252s)
[260.710546] [063/133] (762s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[260.763633] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[260.765449] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[260.868177] [064/133] (762s left) gem_sync (basic-store-each)
[260.930920] Starting subtest: basic-store-each
[263.302402] Subtest basic-store-each: SUCCESS (2.381s)
[263.503472] [065/133] (760s left) i915_selftest (mock)
[266.789363] Starting subtest: mock
[266.792225] Starting dynamic subtest: sanitycheck
[267.475433] Dynamic subtest sanitycheck: SUCCESS (0.685s)
[267.485665] Starting dynamic subtest: shmem
[268.148671] Dynamic subtest shmem: SUCCESS (0.671s)
[268.158533] Starting dynamic subtest: fence
[275.934026] Dynamic subtest fence: SUCCESS (7.780s)
[275.943998] Starting dynamic subtest: scatterlist
[277.601250] Dynamic subtest scatterlist: SUCCESS (1.666s)
[277.610991] Starting dynamic subtest: syncmap
[281.125992] Dynamic subtest syncmap: SUCCESS (3.520s)
[281.136991] Starting dynamic subtest: uncore
[281.758797] Dynamic subtest uncore: SUCCESS (0.631s)
[281.776383] Starting dynamic subtest: ring
[282.467705] Dynamic subtest ring: SUCCESS (0.706s)
[282.475451] Starting dynamic subtest: engine
[283.141361] Dynamic subtest engine: SUCCESS (0.671s)
[283.150962] Starting dynamic subtest: timelines
[286.914395] Dynamic subtest timelines: SUCCESS (3.769s)
[286.923645] Starting dynamic subtest: requests
[290.508212] Dynamic subtest requests: SUCCESS (3.591s)
[290.517616] Starting dynamic subtest: objects
[291.237215] Dynamic subtest objects: SUCCESS (0.728s)
[291.246456] Starting dynamic subtest: phys
[291.996470] Dynamic subtest phys: SUCCESS (0.758s)
[292.006024] Starting dynamic subtest: dmabuf
[292.769369] Dynamic subtest dmabuf: SUCCESS (0.771s)
[292.779500] Starting dynamic subtest: vma
[298.391235] Dynamic subtest vma: SUCCESS (5.621s)
[298.401316] Starting dynamic subtest: evict
[299.765310] Dynamic subtest evict: SUCCESS (1.374s)
[299.775060] Starting dynamic subtest: gtt
[303.049719] Dynamic subtest gtt: SUCCESS (3.283s)
[303.062011] Starting dynamic subtest: hugepages
[303.992382] Dynamic subtest hugepages: SUCCESS (0.923s)
[304.000657] Starting dynamic subtest: memory_region
[306.392403] Dynamic subtest memory_region: SUCCESS (2.417s)
[306.394971] Subtest mock: SUCCESS (39.599s)
[306.422840] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[306.423512] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[306.426459] [066/133] (717s left) syncobj_wait (multi-wait-all-submitted-signaled)
[307.970487] Starting subtest: multi-wait-all-submitted-signaled
[308.076176] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[308.130246] [FACT syncobj_wait (multi-wait-all-submitted-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[308.131553] [FACT syncobj_wait (multi-wait-all-submitted-signaled)] new: kernel.kmod_is_loaded.i915: true
[308.135409] [067/133] (715s left) kms_pm_rpm (legacy-planes-dpms)
[310.078212] Starting subtest: legacy-planes-dpms
[310.081052] Starting dynamic subtest: plane-64
[318.478321] Dynamic subtest plane-64: SUCCESS (8.405s)
[318.490160] Starting dynamic subtest: plane-94
[326.813632] Dynamic subtest plane-94: SUCCESS (8.332s)
[326.825342] Starting dynamic subtest: plane-124
[335.412217] Dynamic subtest plane-124: SUCCESS (8.596s)
[335.423367] Starting dynamic subtest: plane-134
[343.813657] Dynamic subtest plane-134: SUCCESS (8.397s)
[343.816350] Subtest legacy-planes-dpms: SUCCESS (33.740s)
[344.189099] [068/133] (679s left) syncobj_eventfd (binary-wait-before-signal)
[344.240731] Starting subtest: binary-wait-before-signal
[344.269648] Subtest binary-wait-before-signal: SUCCESS (0.030s)
[344.346003] [069/133] (679s left) i915_getparams_basic (basic-eu-total)
[344.404791] Starting subtest: basic-eu-total
[344.409255] Subtest basic-eu-total: SUCCESS (0.000s)
[344.496895] [070/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[344.594592] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[344.599183] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[344.692724] [071/133] (679s left) gen7_exec_parse (basic-offset)
[344.752088] Subtest basic-offset: SKIP (0.000s)
[344.814701] [072/133] (679s left) gem_ctx_sseu (engines)
[344.874059] Subtest engines: SKIP (0.000s)
[344.956360] [073/133] (678s left) kms_vrr (flip-basic-fastset)
[345.051358] Starting subtest: flip-basic-fastset
[345.057598] Subtest flip-basic-fastset: SKIP (0.000s)
[345.124021] [074/133] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[345.229193] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[345.232735] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[345.314221] [075/133] (678s left) kms_plane_multiple (tiling-x)
[345.402379] Starting subtest: tiling-x
[345.404017] Starting dynamic subtest: pipe-A-eDP-1
[349.126408] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.721s)
[349.135920] Starting dynamic subtest: pipe-B-eDP-1
[353.574348] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.445s)
[353.585359] Starting dynamic subtest: pipe-C-eDP-1
[357.907850] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.334s)
[357.917729] Starting dynamic subtest: pipe-D-eDP-1
[362.245368] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.335s)
[362.247805] Subtest tiling-x: SUCCESS (16.840s)
[363.048987] [076/133] (660s left) gem_exec_params (sol-reset-invalid)
[363.110909] Starting subtest: sol-reset-invalid
[363.113228] Subtest sol-reset-invalid: SUCCESS (0.002s)
[364.939053] [077/133] (659s left) kms_plane (plane-panning-bottom-right-suspend)
[365.037430] Starting subtest: plane-panning-bottom-right-suspend
[365.039739] Starting dynamic subtest: pipe-A
[382.398066] Dynamic subtest pipe-A: SUCCESS (2.844s)
[382.409899] Starting dynamic subtest: pipe-B
[400.455854] Dynamic subtest pipe-B: SUCCESS (3.429s)
[400.458269] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.276s)
[401.259368] [078/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[401.381236] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[405.142038] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.690s)
[406.361185] [079/133] (617s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[406.457491] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[413.239893] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.723s)
[413.343524] [080/133] (610s left) gem_exec_reloc (basic-write-read)
[413.396666] Subtest basic-write-read: SKIP (0.000s)
[413.467966] [081/133] (610s left) kms_lease (atomic-implicit-crtc)
[413.556182] Starting subtest: atomic-implicit-crtc
[413.558395] Starting dynamic subtest: pipe-A-eDP-1
[413.569144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[413.578698] Starting dynamic subtest: pipe-B-eDP-1
[413.590036] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[413.599170] Starting dynamic subtest: pipe-C-eDP-1
[413.610231] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[413.619602] Starting dynamic subtest: pipe-D-eDP-1
[413.630458] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[413.632257] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[413.692390] [082/133] (610s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[413.785374] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[413.787661] Starting dynamic subtest: pipe-A-eDP-1
[413.812491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.823689] Starting dynamic subtest: pipe-B-eDP-1
[413.847444] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.857236] Starting dynamic subtest: pipe-C-eDP-1
[413.882004] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.891471] Starting dynamic subtest: pipe-D-eDP-1
[413.915691] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.919772] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[416.014991] [083/133] (608s left) gem_exec_flush (basic-wb-ro-before-default)
[416.074538] Starting subtest: basic-wb-ro-before-default
[421.545613] Subtest basic-wb-ro-before-default: SUCCESS (5.455s)
[421.733023] [084/133] (602s left) gem_create (create-clear)
[421.787670] Starting subtest: create-clear
[421.790580] Starting dynamic subtest: smem0
[454.576518] Dynamic subtest smem0: SUCCESS (32.774s)
[454.578779] Subtest create-clear: SUCCESS (32.775s)
[454.777069] [085/133] (569s left) i915_pm_rpm (system-suspend)
[457.024506] Starting subtest: system-suspend
[474.808377] Subtest system-suspend: SUCCESS (2.824s)
[475.246720] [086/133] (549s left) kms_flip (2x-flip-vs-dpms-on-nop)
[475.360290] Starting subtest: 2x-flip-vs-dpms-on-nop
[475.369262] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[475.449650] [087/133] (549s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[475.551240] Starting subtest: modeset-transition-nonblocking-fencing
[475.554228] Starting dynamic subtest: 1x-outputs
[486.700367] Dynamic subtest 1x-outputs: SUCCESS (10.989s)
[486.703262] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.990s)
[487.575669] [088/133] (536s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[487.673173] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[493.880519] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.187s)
[495.006316] [089/133] (529s left) gem_ctx_persistence (saturated-hostile)
[495.060328] Starting subtest: saturated-hostile
[495.063034] Starting dynamic subtest: rcs0
[495.885807] Dynamic subtest rcs0: SUCCESS (0.825s)
[495.899449] Starting dynamic subtest: bcs0
[496.671677] Dynamic subtest bcs0: SUCCESS (0.782s)
[496.683800] Starting dynamic subtest: vcs0
[497.454691] Dynamic subtest vcs0: SUCCESS (0.779s)
[497.467427] Starting dynamic subtest: vcs1
[498.260855] Dynamic subtest vcs1: SUCCESS (0.803s)
[498.274025] Starting dynamic subtest: vecs0
[499.064069] Dynamic subtest vecs0: SUCCESS (0.800s)
[499.075553] Starting dynamic subtest: ccs0
[499.883972] Dynamic subtest ccs0: SUCCESS (0.816s)
[499.886951] Subtest saturated-hostile: SUCCESS (4.818s)
[499.984083] [090/133] (524s left) kms_vblank (query-busy)
[500.087278] Starting subtest: query-busy
[500.090150] Starting dynamic subtest: pipe-A-eDP-1
[501.967206] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[501.983250] Starting dynamic subtest: pipe-D-eDP-1
[504.571365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[504.574225] Subtest query-busy: SUCCESS (4.481s)
[505.377672] [091/133] (519s left) kms_flip (flip-vs-rmfb-interruptible)
[505.480233] Starting subtest: flip-vs-rmfb-interruptible
[505.483613] Starting dynamic subtest: A-eDP1
[514.170208] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[514.182435] Starting dynamic subtest: B-eDP1
[522.799640] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[522.809633] Starting dynamic subtest: C-eDP1
[531.425192] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[531.436810] Starting dynamic subtest: D-eDP1
[540.055659] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[540.061006] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.572s)
[541.259645] [092/133] (483s left) gem_exec_fence (submit)
[541.461401] Starting subtest: submit
[541.467038] Subtest submit: SKIP (0.000s)
[542.943822] [093/133] (481s left) kms_flip (dpms-vs-vblank-race)
[543.044532] Starting subtest: dpms-vs-vblank-race
[543.047305] Starting dynamic subtest: A-eDP1
[546.932303] Dynamic subtest A-eDP1: SUCCESS (3.886s)
[546.942425] Starting dynamic subtest: B-eDP1
[550.518091] Dynamic subtest B-eDP1: SUCCESS (3.584s)
[550.534637] Starting dynamic subtest: C-eDP1
[555.148945] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[555.159626] Starting dynamic subtest: D-eDP1
[559.777134] Dynamic subtest D-eDP1: SUCCESS (4.624s)
[559.779561] Subtest dpms-vs-vblank-race: SUCCESS (16.728s)
[560.652565] [094/133] (464s left) gem_ctx_isolation (clean)
[560.725188] Starting subtest: clean
[560.728210] Starting dynamic subtest: rcs0
[560.777369] Dynamic subtest rcs0: SUCCESS (0.052s)
[560.788584] Starting dynamic subtest: bcs0
[560.850095] Dynamic subtest bcs0: SUCCESS (0.071s)
[560.860909] Starting dynamic subtest: vcs0
[560.903420] Dynamic subtest vcs0: SUCCESS (0.052s)
[560.914327] Starting dynamic subtest: vcs1
[562.867840] Dynamic subtest vcs1: SUCCESS (1.963s)
[562.881121] Starting dynamic subtest: vecs0
[564.921710] Dynamic subtest vecs0: SUCCESS (2.052s)
[564.934006] Starting dynamic subtest: ccs0
[566.882317] Dynamic subtest ccs0: SUCCESS (1.958s)
[566.885694] Subtest clean: SUCCESS (6.154s)
[567.102448] [095/133] (457s left) syncobj_basic (bad-destroy-pad)
[567.158971] Starting subtest: bad-destroy-pad
[567.161649] Subtest bad-destroy-pad: SUCCESS (0.000s)
[567.259548] [096/133] (457s left) gem_mmap_gtt (pf-nonblock)
[567.313786] Subtest pf-nonblock: SKIP (0.000s)
[567.375773] [097/133] (457s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[567.501168] Starting subtest: 2x-long-cursor-vs-flip-atomic
[567.506377] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[567.649015] [098/133] (457s left) gem_eio (in-flight-external)
[567.890761] Starting subtest: in-flight-external
[568.926186] Subtest in-flight-external: SUCCESS (1.035s)
[569.039718] [099/133] (455s left) gem_exec_fence (syncobj-wait)
[569.523094] Starting subtest: syncobj-wait
[570.871412] Subtest syncobj-wait: SUCCESS (1.348s)
[571.198919] [100/133] (453s left) gem_tiled_fence_blits (normal)
[571.263200] Subtest normal: SKIP (0.000s)
[571.349567] [101/133] (453s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[571.442241] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[571.447153] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[571.533882] [102/133] (453s left) syncobj_wait (invalid-single-wait-unsubmitted)
[571.582505] Starting subtest: invalid-single-wait-unsubmitted
[571.585192] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[571.664954] [103/133] (453s left) gem_mmap_wc (write-prefaulted)
[571.728141] Subtest write-prefaulted: SKIP (0.000s)
[571.789836] [104/133] (453s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[571.890285] Starting subtest: fbc-rgb565-draw-mmap-wc
[575.873649] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.987s)
[577.039402] [105/133] (448s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[577.141514] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[577.168438] Starting dynamic subtest: pipe-A-plane-0
[577.879818] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[577.890088] Starting dynamic subtest: pipe-A-plane-3
[578.358303] Dynamic subtest pipe-A-plane-3: SUCCESS (0.477s)
[579.437575] Starting dynamic subtest: pipe-B-plane-0
[580.129055] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[580.138375] Starting dynamic subtest: pipe-B-plane-3
[580.640417] Dynamic subtest pipe-B-plane-3: SUCCESS (0.510s)
[580.955741] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.817s)
[581.824190] [106/133] (443s left) kms_psr (fbc-psr-sprite-render)
[581.916380] Starting subtest: fbc-psr-sprite-render
[581.918898] Starting dynamic subtest: eDP-1
[581.924042] Dynamic subtest eDP-1: SKIP (0.000s)
[581.929294] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[581.991286] [107/133] (443s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[582.387990] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[583.241680] [108/133] (442s left) kms_cursor_crc (cursor-onscreen-64x21)
[583.437421] Starting subtest: cursor-onscreen-64x21
[583.483918] Subtest cursor-onscreen-64x21: SKIP (0.039s)
[583.728771] [109/133] (441s left) perf (global-sseu-config)
[583.871509] Starting subtest: global-sseu-config
[583.876349] Subtest global-sseu-config: SKIP (0.000s)
[583.915042] [110/133] (441s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[583.973179] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[584.028437] [111/133] (441s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[584.120933] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[584.201072] [112/133] (441s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[584.286958] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[584.292274] Starting dynamic subtest: pipe-A-eDP-1
[584.342115] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[584.351792] Starting dynamic subtest: pipe-B-eDP-1
[584.400801] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[584.409305] Starting dynamic subtest: pipe-C-eDP-1
[584.457967] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[584.466603] Starting dynamic subtest: pipe-D-eDP-1
[584.515988] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[584.519871] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[586.532980] [113/133] (439s left) gem_exec_balancer (bonded-chain)
[586.606168] Starting subtest: bonded-chain
[593.613288] Subtest bonded-chain: SUCCESS (7.009s)
[593.951480] [114/133] (431s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[594.060326] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[594.062705] Starting dynamic subtest: pipe-A-default-mode
[596.791856] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[596.794382] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.733s)
[597.631882] [115/133] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[597.741398] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[597.747001] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[597.832159] [116/133] (427s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[597.934765] Starting subtest: pipe-fbc-rte
[597.941112] Starting dynamic subtest: pipe-B-eDP-1
[603.403747] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.471s)
[603.412257] Subtest pipe-fbc-rte: SUCCESS (5.474s)
[605.671484] [117/133] (420s left) perf_pmu (event-wait)
[605.714637] Starting subtest: event-wait
[605.717276] Starting dynamic subtest: rcs0
[605.722677] Dynamic subtest rcs0: SKIP (0.000s)
[605.727637] Subtest event-wait: SKIP (0.001s)
[605.809928] [118/133] (419s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[605.871170] Starting subtest: multi-wait-all-for-submit-available-signaled
[605.874066] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[605.965895] [119/133] (419s left) sysfs_defaults (readonly)
[606.031176] Starting subtest: readonly
[606.034160] Starting dynamic subtest: vecs0
[606.037136] Dynamic subtest vecs0: SUCCESS (0.000s)
[606.049236] Starting dynamic subtest: ccs0
[606.052164] Dynamic subtest ccs0: SUCCESS (0.000s)
[606.062267] Starting dynamic subtest: vcs0
[606.064671] Dynamic subtest vcs0: SUCCESS (0.000s)
[606.074768] Starting dynamic subtest: bcs0
[606.076819] Dynamic subtest bcs0: SUCCESS (0.000s)
[606.086055] Starting dynamic subtest: rcs0
[606.088190] Dynamic subtest rcs0: SUCCESS (0.000s)
[606.097443] Starting dynamic subtest: vcs1
[606.100168] Dynamic subtest vcs1: SUCCESS (0.000s)
[606.102588] Subtest readonly: SUCCESS (0.006s)
[606.145209] [120/133] (419s left) gem_exec_basic (basic)
[606.208719] Starting subtest: basic
[606.211321] Starting dynamic subtest: rcs0-smem
[606.214205] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[606.224934] Starting dynamic subtest: bcs0-smem
[606.227254] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[606.236401] Starting dynamic subtest: vcs0-smem
[606.238356] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[606.247347] Starting dynamic subtest: vcs1-smem
[606.249388] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[606.258277] Starting dynamic subtest: vecs0-smem
[606.260391] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[606.269307] Starting dynamic subtest: ccs0-smem
[606.271492] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[606.273375] Subtest basic: SUCCESS (0.021s)
[607.941437] [121/133] (417s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[608.054830] Starting subtest: short-busy-flip-before-cursor-toggle
[608.059396] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[608.200601] [122/133] (417s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[608.263223] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[608.370522] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[608.463147] [123/133] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[608.564840] Starting subtest: psr-1p-primscrn-cur-indfb-move
[615.941151] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s)
[616.068512] [124/133] (409s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[616.129443] Starting subtest: invalid-multi-wait-all-unsubmitted
[616.132183] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[616.229418] [125/133] (409s left) kms_invalid_mode (bad-hsync-start)
[616.332931] Starting subtest: bad-hsync-start
[616.335328] Starting dynamic subtest: pipe-A-eDP-1
[616.616914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[616.628523] Starting dynamic subtest: pipe-B-eDP-1
[616.630848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[616.640577] Starting dynamic subtest: pipe-C-eDP-1
[616.643405] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[616.656420] Starting dynamic subtest: pipe-D-eDP-1
[616.659399] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[616.662242] Subtest bad-hsync-start: SUCCESS (0.292s)
[617.443685] [126/133] (408s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[617.536763] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[617.539146] Starting dynamic subtest: pipe-A-eDP-1
[617.561063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[617.571370] Starting dynamic subtest: pipe-B-eDP-1
[617.596395] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[617.605712] Starting dynamic subtest: pipe-C-eDP-1
[617.631785] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[617.641269] Starting dynamic subtest: pipe-D-eDP-1
[617.668037] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[617.673025] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[619.784787] [127/133] (406s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[619.883962] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[626.584347] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.701s)
[626.699251] [128/133] (399s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[626.797822] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[626.803193] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[626.900460] [129/133] (399s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[626.947434] Starting subtest: y-tiled-ccs-to-yf-tiled
[626.953033] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[627.132430] [130/133] (399s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[627.226261] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[627.231423] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[627.355007] [131/133] (399s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[627.445533] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[627.448181] Starting dynamic subtest: pipe-A
[627.780822] Dynamic subtest pipe-A: SUCCESS (0.338s)
[627.794417] Starting dynamic subtest: pipe-B
[629.200775] Dynamic subtest pipe-B: SUCCESS (1.419s)
[629.211987] Starting dynamic subtest: pipe-C
[630.638368] Dynamic subtest pipe-C: SUCCESS (1.437s)
[630.648110] Starting dynamic subtest: pipe-D
[632.070914] Dynamic subtest pipe-D: SUCCESS (1.431s)
[632.073422] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.628s)
[633.246107] [132/133] (393s left) gem_exec_schedule (wide)
[633.421532] Starting subtest: wide
[633.424261] Starting dynamic subtest: rcs0
[644.254147] Dynamic subtest rcs0: SUCCESS (10.828s)
[644.271861] Starting dynamic subtest: vcs0
[655.386468] Dynamic subtest vcs0: SUCCESS (11.129s)
[655.399249] Starting dynamic subtest: vcs1
[667.591801] Dynamic subtest vcs1: SUCCESS (12.199s)
[667.605162] Starting dynamic subtest: vecs0
[680.097834] Dynamic subtest vecs0: SUCCESS (12.501s)
[680.116583] Starting dynamic subtest: ccs0
[693.897377] Dynamic subtest ccs0: SUCCESS (13.793s)
[693.900769] Subtest wide: SUCCESS (60.455s)
[695.239923] [133/133] (331s left) kms_atomic_transition (plane-all-transition)
[695.340168] Starting subtest: plane-all-transition
[695.342908] Starting dynamic subtest: pipe-A-eDP-1
[697.836097] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[698.149133] Starting dynamic subtest: pipe-B-eDP-1
[701.375063] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.236s)
[701.671532] Subtest plane-all-transition: SUCCESS (6.334s)
[702.498187] Closing watchdogs
results: parsing output: 0/ for test: kms_prop_blob
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_vm_create
results: parsing output: 4/ for test: kms_force_connector_basic
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: gem_partial_pwrite_pread
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_dsc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: kms_busy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: kms_tv_load_detect
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_create
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: drm_mm
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_params
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: gem_linear_blits
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_busy
results: parsing output: 59/ for test: kms_chamelium_hpd
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_sync
results: parsing output: 64/ for test: i915_selftest
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: syncobj_eventfd
results: parsing output: 68/ for test: i915_getparams_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gen7_exec_parse
results: parsing output: 71/ for test: gem_ctx_sseu
results: parsing output: 72/ for test: kms_vrr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_multiple
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: i915_pm_rpm
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_atomic_transition
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_ctx_isolation
results: parsing output: 94/ for test: syncobj_basic
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_tiled_fence_blits
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: sysfs_defaults
results: parsing output: 119/ for test: gem_exec_basic
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_atomic_transition
Done.