[57.295604] Initializing watchdogs
[57.295651]   /dev/watchdog0
[57.310007] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.314474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.317165] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.320602] [001/133] (960s left) kms_prop_blob (invalid-set-prop-any)
[57.398910] Starting subtest: invalid-set-prop-any
[57.401305] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[57.519224] [002/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[57.631889] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[58.468794] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.838s)
[58.637895] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[58.750300] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[58.754729] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[58.848299] [004/133] (959s left) gem_vm_create (isolation)
[58.919282] Starting subtest: isolation
[58.928340] Subtest isolation: SUCCESS (0.009s)
[59.055907] [005/133] (958s left) kms_force_connector_basic (force-edid)
[59.130920] Starting subtest: force-edid
[59.491490] Subtest force-edid: SUCCESS (0.363s)
[59.627222] [006/133] (958s left) gem_render_copy (y-tiled)
[59.687374] Starting subtest: y-tiled
[59.691246] Subtest y-tiled: SKIP (0.000s)
[59.869402] [007/133] (958s left) kms_pipe_crc_basic (read-crc)
[59.971847] Starting subtest: read-crc
[59.974192] Starting dynamic subtest: pipe-A-eDP-1
[60.687309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[60.694474] Starting dynamic subtest: pipe-B-eDP-1
[62.098231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s)
[62.109588] Starting dynamic subtest: pipe-C-eDP-1
[63.446521] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[63.454874] Starting dynamic subtest: pipe-D-eDP-1
[64.749846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[64.752481] Subtest read-crc: SUCCESS (4.778s)
[65.538974] [008/133] (952s left) gem_partial_pwrite_pread (reads-uncached)
[65.617840] Subtest reads-uncached: SKIP (0.000s)
[65.677793] [009/133] (952s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[65.779270] Starting subtest: yf-tiled-8bpp-rotate-90
[65.783620] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[65.890181] [010/133] (952s left) kms_dsc (dsc-basic)
[65.985882] Starting subtest: dsc-basic
[65.998572] Subtest dsc-basic: SKIP (0.000s)
[66.053338] [011/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[66.159539] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[73.112058] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.958s)
[73.243726] [012/133] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[73.347728] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[79.896922] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.553s)
[80.033720] [013/133] (938s left) kms_content_protection (uevent)
[80.177139] Starting subtest: uevent
[80.181596] Subtest uevent: SKIP (0.000s)
[80.301663] [014/133] (938s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[80.409533] Starting subtest: extended-pageflip-modeset-hang-oldfb
[80.411511] Starting dynamic subtest: pipe-A
[88.301860] Dynamic subtest pipe-A: SUCCESS (7.892s)
[88.310906] Starting dynamic subtest: pipe-D
[96.920938] Dynamic subtest pipe-D: SUCCESS (8.615s)
[96.923464] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.513s)
[97.754510] [015/133] (920s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[97.856515] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[98.949619] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.094s)
[99.086782] [016/133] (919s left) gem_eio (throttle)
[99.268082] Starting subtest: throttle
[99.527164] Subtest throttle: SUCCESS (0.260s)
[99.692205] [017/133] (918s left) api_intel_bb (object-reloc-keep-cache)
[99.752117] Starting subtest: object-reloc-keep-cache
[99.755588] Subtest object-reloc-keep-cache: SKIP (0.003s)
[99.877613] [018/133] (918s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[99.930121] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[99.931767] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[100.016736] [019/133] (918s left) perf_pmu (semaphore-wait-idle)
[100.057592] Starting subtest: semaphore-wait-idle
[100.059463] Starting dynamic subtest: rcs0
[100.571788] Dynamic subtest rcs0: SUCCESS (0.513s)
[100.583440] Starting dynamic subtest: bcs0
[101.084451] Dynamic subtest bcs0: SUCCESS (0.511s)
[101.096473] Starting dynamic subtest: vcs0
[101.598063] Dynamic subtest vcs0: SUCCESS (0.512s)
[101.609205] Starting dynamic subtest: vcs1
[102.108705] Dynamic subtest vcs1: SUCCESS (0.510s)
[102.117787] Starting dynamic subtest: vecs0
[102.623143] Dynamic subtest vecs0: SUCCESS (0.513s)
[102.633734] Starting dynamic subtest: ccs0
[103.138067] Dynamic subtest ccs0: SUCCESS (0.513s)
[103.140679] Subtest semaphore-wait-idle: SUCCESS (3.081s)
[103.904284] [020/133] (914s left) kms_psr (fbc-psr2-sprite-blt)
[104.007805] Starting subtest: fbc-psr2-sprite-blt
[104.010109] Starting dynamic subtest: eDP-1
[104.014418] Dynamic subtest eDP-1: SKIP (0.000s)
[104.018667] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[104.082855] [021/133] (914s left) gem_eio (wait-immediate)
[104.261291] Starting subtest: wait-immediate
[104.537026] Subtest wait-immediate: SUCCESS (0.276s)
[104.650172] [022/133] (913s left) i915_drm_fdinfo (virtual-busy)
[104.691885] Starting subtest: virtual-busy
[104.696804] Subtest virtual-busy: SKIP (0.000s)
[104.766777] [023/133] (913s left) gem_pxp (verify-pxp-stale-buf-execution)
[104.885242] Starting subtest: verify-pxp-stale-buf-execution
[105.948634] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.065s)
[106.055678] [024/133] (912s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[106.157246] Starting subtest: 4-tiled-16bpp-rotate-90
[106.176270] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[106.288622] [025/133] (912s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[106.391336] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[106.394938] Starting dynamic subtest: pipe-A-eDP-1
[106.423054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.432600] Starting dynamic subtest: pipe-B-eDP-1
[106.453165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.460744] Starting dynamic subtest: pipe-C-eDP-1
[106.481745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.489305] Starting dynamic subtest: pipe-D-eDP-1
[106.511200] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.515566] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[108.626945] [026/133] (910s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[108.701796] Starting subtest: invalid-bsd2-flag-on-vebox
[108.704036] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[108.801111] [027/133] (910s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[108.914403] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[108.918676] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[109.004383] [028/133] (909s left) gem_mmap_gtt (big-bo-tiledx)
[109.061072] Subtest big-bo-tiledX: SKIP (0.000s)
[109.119432] [029/133] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[109.208970] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[116.337639] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.131s)
[117.547225] [030/133] (901s left) kms_cursor_edge_walk (128x128-left-edge)
[117.641847] Starting subtest: 128x128-left-edge
[117.644138] Starting dynamic subtest: pipe-A-eDP-1
[121.062451] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[121.072296] Starting dynamic subtest: pipe-D-eDP-1
[124.258171] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.195s)
[124.260479] Subtest 128x128-left-edge: SUCCESS (6.617s)
[125.143773] [031/133] (893s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[125.236303] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[125.245660] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[125.334114] [032/133] (893s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[125.425702] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[125.427932] Starting dynamic subtest: pipe-A-eDP-1
[142.235517] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.239s)
[142.246474] Starting dynamic subtest: pipe-B-eDP-1
[159.211354] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.445s)
[159.222047] Starting dynamic subtest: pipe-C-eDP-1
[176.197734] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.353s)
[176.207287] Starting dynamic subtest: pipe-D-eDP-1
[193.206045] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.358s)
[193.208524] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.399s)
[194.418937] [033/133] (824s left) kms_psr (psr2-cursor-mmap-gtt)
[194.521868] Starting subtest: psr2-cursor-mmap-gtt
[194.524507] Starting dynamic subtest: eDP-1
[196.188170] Dynamic subtest eDP-1: SUCCESS (1.664s)
[196.191060] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.665s)
[197.022393] [034/133] (822s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[197.117858] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[203.943209] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.825s)
[204.053687] [035/133] (815s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[204.120392] Starting subtest: single-wait-for-submit-available-submitted
[204.123071] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[204.231115] [036/133] (814s left) kms_color (ctm-negative)
[204.325799] Starting subtest: ctm-negative
[204.328011] Starting dynamic subtest: pipe-A-eDP-1
[205.047485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[205.057215] Starting dynamic subtest: pipe-B-eDP-1
[206.432443] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[206.442391] Starting dynamic subtest: pipe-C-eDP-1
[207.759004] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.326s)
[207.769174] Starting dynamic subtest: pipe-D-eDP-1
[209.159307] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[209.161852] Subtest ctm-negative: SUCCESS (4.832s)
[210.032788] [037/133] (809s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[210.128111] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[210.133952] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[210.196535] [038/133] (809s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[210.309863] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[211.787254] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.474s)
[212.654720] [039/133] (806s left) api_intel_allocator (reserve-simple)
[212.711395] Starting subtest: reserve-simple
[212.714217] Subtest reserve-simple: SUCCESS (0.003s)
[212.825375] [040/133] (806s left) kms_tv_load_detect (load-detect)
[212.879226] Subtest load-detect: SKIP (0.000s)
[212.938629] [041/133] (806s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[213.076456] Starting subtest: 2x-long-flip-vs-cursor-atomic
[213.080975] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[213.234681] [042/133] (806s left) gem_exec_schedule (pi-common)
[213.413890] Starting subtest: pi-common
[213.416265] Starting dynamic subtest: rcs0
[213.482802] Dynamic subtest rcs0: SUCCESS (0.071s)
[213.497526] Starting dynamic subtest: bcs0
[213.511897] Dynamic subtest bcs0: SUCCESS (0.028s)
[213.525492] Starting dynamic subtest: vcs0
[213.540687] Dynamic subtest vcs0: SUCCESS (0.028s)
[213.555065] Starting dynamic subtest: vcs1
[213.567460] Dynamic subtest vcs1: SUCCESS (0.026s)
[213.580910] Starting dynamic subtest: vecs0
[213.594846] Dynamic subtest vecs0: SUCCESS (0.027s)
[213.608199] Starting dynamic subtest: ccs0
[213.622246] Dynamic subtest ccs0: SUCCESS (0.027s)
[213.624659] Subtest pi-common: SUCCESS (0.211s)
[213.838941] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[213.843031] [043/133] (805s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[213.945688] Starting subtest: fbc-psr-cursor-mmap-gtt
[213.948261] Starting dynamic subtest: eDP-1
[213.953872] Dynamic subtest eDP-1: SKIP (0.000s)
[213.958920] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[214.030678] [044/133] (805s left) gem_create (create-valid-nonaligned)
[214.077998] Starting subtest: create-valid-nonaligned
[214.080648] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[214.289737] [045/133] (805s left) gem_mmap_gtt (medium-copy)
[214.336890] Subtest medium-copy: SKIP (0.000s)
[214.400301] [046/133] (805s left) gem_exec_schedule (u-fairslice-all)
[214.473922] Starting subtest: u-fairslice-all
[216.535023] Subtest u-fairslice-all: SUCCESS (2.064s)
[218.318044] [047/133] (801s left) syncobj_wait (wait-all-complex)
[218.368113] Starting subtest: wait-all-complex
[218.586285] Subtest wait-all-complex: SUCCESS (0.218s)
[218.681952] [048/133] (801s left) drm_mm (drm_mm)
[218.722130] Starting subtest: drm_mm
[218.731262] Starting dynamic subtest: drm_test_mm_init
[218.814860] Dynamic subtest drm_test_mm_init: SUCCESS (0.084s)
[218.826177] Starting dynamic subtest: drm_test_mm_debug
[218.910808] Dynamic subtest drm_test_mm_debug: SUCCESS (0.095s)
[218.922524] Starting dynamic subtest: drm_test_mm_align32
[218.999784] Dynamic subtest drm_test_mm_align32: SUCCESS (0.089s)
[219.010963] Starting dynamic subtest: drm_test_mm_align64
[219.093306] Dynamic subtest drm_test_mm_align64: SUCCESS (0.090s)
[219.103173] Starting dynamic subtest: drm_test_mm_lowest
[219.182076] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.090s)
[219.191809] Starting dynamic subtest: drm_test_mm_highest
[219.261987] Dynamic subtest drm_test_mm_highest: SUCCESS (0.079s)
[219.264786] Subtest drm_mm: SUCCESS (0.541s)
[219.411369] [049/133] (800s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[219.512907] Starting subtest: primary-4-tiled-reflect-x-0
[226.636015] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.124s)
[227.851680] [050/133] (791s left) kms_psr (fbc-pr-primary-mmap-cpu)
[227.950706] Starting subtest: fbc-pr-primary-mmap-cpu
[227.955938] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[228.071609] [051/133] (791s left) gem_lmem_swapping (parallel-random-engines)
[228.115005] Subtest parallel-random-engines: SKIP (0.000s)
[228.164147] [052/133] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[228.255074] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[228.260176] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[228.349702] [053/133] (791s left) gem_exec_params (rel-constants-invalid-ring)
[228.404127] Starting subtest: rel-constants-invalid-ring
[228.406496] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[228.503479] [054/133] (791s left) gem_softpin (safe-alignment)
[228.556092] Starting subtest: safe-alignment
[228.581956] Subtest safe-alignment: SUCCESS (0.026s)
[230.277430] [055/133] (789s left) gem_mmap_wc (write-cpu-read-wc)
[230.342535] Subtest write-cpu-read-wc: SKIP (0.000s)
[230.403605] [056/133] (789s left) gem_linear_blits (basic)
[230.749223] Starting subtest: basic
[230.757890] Subtest basic: SUCCESS (0.013s)
[230.911133] [057/133] (789s left) gem_exec_params (invalid-fence-in)
[231.028056] Starting subtest: invalid-fence-in
[231.031035] Subtest invalid-fence-in: SUCCESS (0.000s)
[231.138539] [058/133] (789s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[231.257924] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[231.263128] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[231.373338] [059/133] (788s left) gem_busy (parallel)
[231.568732] Starting subtest: parallel
[231.571267] Starting dynamic subtest: rcs0
[233.245037] Dynamic subtest rcs0: SUCCESS (1.674s)
[233.258074] Starting dynamic subtest: bcs0
[235.228553] Dynamic subtest bcs0: SUCCESS (1.981s)
[235.247284] Starting dynamic subtest: vcs0
[237.276918] Dynamic subtest vcs0: SUCCESS (2.046s)
[237.290015] Starting dynamic subtest: vcs1
[239.261096] Dynamic subtest vcs1: SUCCESS (1.981s)
[239.275270] Starting dynamic subtest: vecs0
[241.245079] Dynamic subtest vecs0: SUCCESS (1.981s)
[241.258790] Starting dynamic subtest: ccs0
[243.292741] Dynamic subtest ccs0: SUCCESS (2.044s)
[243.295777] Subtest parallel: SUCCESS (11.723s)
[243.538994] [060/133] (776s left) kms_chamelium_hpd (hdmi-hpd-storm)
[243.921036] Subtest hdmi-hpd-storm: SKIP (0.000s)
[244.714348] [061/133] (775s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[244.916129] Starting subtest: cursor-rapid-movement-128x128
[244.918980] Starting dynamic subtest: pipe-A-eDP-1
[245.489265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[245.521217] Starting dynamic subtest: pipe-D-eDP-1
[246.708079] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s)
[246.710519] Subtest cursor-rapid-movement-128x128: SUCCESS (1.793s)
[247.537449] [062/133] (772s left) kms_pm_dc (dc3co-vpb-simulation)
[248.654778] Starting subtest: dc3co-vpb-simulation
[257.733101] Subtest dc3co-vpb-simulation: SKIP (9.073s)
[257.844905] [063/133] (762s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[257.897097] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[257.900037] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[257.987371] [064/133] (762s left) gem_sync (basic-store-each)
[258.055676] Starting subtest: basic-store-each
[260.498511] Subtest basic-store-each: SUCCESS (2.454s)
[260.714111] [065/133] (759s left) i915_selftest (mock)
[262.477706] Starting subtest: mock
[262.480572] Starting dynamic subtest: sanitycheck
[264.046579] Dynamic subtest sanitycheck: SUCCESS (1.567s)
[264.057128] Starting dynamic subtest: shmem
[265.590250] Dynamic subtest shmem: SUCCESS (1.542s)
[265.608489] Starting dynamic subtest: fence
[274.392460] Dynamic subtest fence: SUCCESS (8.797s)
[274.403205] Starting dynamic subtest: scatterlist
[276.938249] Dynamic subtest scatterlist: SUCCESS (2.544s)
[276.948848] Starting dynamic subtest: syncmap
[280.966887] Dynamic subtest syncmap: SUCCESS (4.025s)
[280.977497] Starting dynamic subtest: uncore
[282.457530] Dynamic subtest uncore: SUCCESS (1.489s)
[282.468171] Starting dynamic subtest: ring
[283.967577] Dynamic subtest ring: SUCCESS (1.507s)
[283.978099] Starting dynamic subtest: engine
[285.562690] Dynamic subtest engine: SUCCESS (1.593s)
[285.573088] Starting dynamic subtest: timelines
[290.201548] Dynamic subtest timelines: SUCCESS (4.638s)
[290.212815] Starting dynamic subtest: requests
[295.234783] Dynamic subtest requests: SUCCESS (5.034s)
[295.244906] Starting dynamic subtest: objects
[296.876281] Dynamic subtest objects: SUCCESS (1.641s)
[296.885734] Starting dynamic subtest: phys
[298.465392] Dynamic subtest phys: SUCCESS (1.588s)
[298.475908] Starting dynamic subtest: dmabuf
[300.086008] Dynamic subtest dmabuf: SUCCESS (1.620s)
[300.096518] Starting dynamic subtest: vma
[306.635653] Dynamic subtest vma: SUCCESS (6.550s)
[306.647565] Starting dynamic subtest: evict
[308.868397] Dynamic subtest evict: SUCCESS (2.231s)
[308.878663] Starting dynamic subtest: gtt
[313.032538] Dynamic subtest gtt: SUCCESS (4.164s)
[313.043254] Starting dynamic subtest: hugepages
[314.801086] Dynamic subtest hugepages: SUCCESS (1.767s)
[314.816795] Starting dynamic subtest: memory_region
[318.136221] Dynamic subtest memory_region: SUCCESS (3.334s)
[318.138930] Subtest mock: SUCCESS (55.660s)
[318.169446] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[318.170151] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[318.173587] [066/133] (702s left) syncobj_wait (multi-wait-all-submitted-signaled)
[320.567250] Starting subtest: multi-wait-all-submitted-signaled
[320.670701] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[320.721599] [FACT syncobj_wait (multi-wait-all-submitted-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[320.722806] [FACT syncobj_wait (multi-wait-all-submitted-signaled)] new: kernel.kmod_is_loaded.i915: true
[320.726741] [067/133] (699s left) kms_pm_rpm (legacy-planes-dpms)
[322.379013] Starting subtest: legacy-planes-dpms
[322.381709] Starting dynamic subtest: plane-64
[330.706833] Dynamic subtest plane-64: SUCCESS (8.327s)
[330.718585] Starting dynamic subtest: plane-94
[339.024613] Dynamic subtest plane-94: SUCCESS (8.316s)
[339.034825] Starting dynamic subtest: plane-124
[347.619901] Dynamic subtest plane-124: SUCCESS (8.592s)
[347.632245] Starting dynamic subtest: plane-134
[356.225858] Dynamic subtest plane-134: SUCCESS (8.602s)
[356.228915] Subtest legacy-planes-dpms: SUCCESS (33.847s)
[356.613887] [068/133] (664s left) syncobj_eventfd (binary-wait-before-signal)
[356.666531] Starting subtest: binary-wait-before-signal
[356.695421] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[356.786500] [069/133] (663s left) i915_getparams_basic (basic-eu-total)
[356.832421] Starting subtest: basic-eu-total
[356.837617] Subtest basic-eu-total: SUCCESS (0.000s)
[356.923856] [070/133] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[357.034087] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[357.039600] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[357.131606] [071/133] (663s left) gen7_exec_parse (basic-offset)
[357.198508] Subtest basic-offset: SKIP (0.000s)
[357.277767] [072/133] (663s left) gem_ctx_sseu (engines)
[357.337060] Subtest engines: SKIP (0.000s)
[357.414002] [073/133] (663s left) kms_vrr (flip-basic-fastset)
[357.513778] Starting subtest: flip-basic-fastset
[357.521256] Subtest flip-basic-fastset: SKIP (0.000s)
[357.589928] [074/133] (663s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[357.688993] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[357.693062] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[357.791347] [075/133] (663s left) kms_plane_multiple (tiling-x)
[357.882242] Starting subtest: tiling-x
[357.884310] Starting dynamic subtest: pipe-A-eDP-1
[361.631901] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.748s)
[361.641900] Starting dynamic subtest: pipe-B-eDP-1
[366.181502] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.546s)
[366.191776] Starting dynamic subtest: pipe-C-eDP-1
[370.489476] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.310s)
[370.500162] Starting dynamic subtest: pipe-D-eDP-1
[374.844774] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.351s)
[374.846756] Subtest tiling-x: SUCCESS (16.960s)
[375.667441] [076/133] (645s left) gem_exec_params (sol-reset-invalid)
[375.742884] Starting subtest: sol-reset-invalid
[375.745159] Subtest sol-reset-invalid: SUCCESS (0.002s)
[377.378895] [077/133] (643s left) kms_plane (plane-panning-bottom-right-suspend)
[377.470223] Starting subtest: plane-panning-bottom-right-suspend
[377.472531] Starting dynamic subtest: pipe-A
[395.422207] Dynamic subtest pipe-A: SUCCESS (2.946s)
[395.434831] Starting dynamic subtest: pipe-B
[414.414147] Dynamic subtest pipe-B: SUCCESS (3.495s)
[414.417049] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.444s)
[415.237907] [078/133] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[415.357079] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[419.125268] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.768s)
[420.255891] [079/133] (600s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[420.360992] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[427.085755] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.720s)
[427.193815] [080/133] (593s left) gem_exec_reloc (basic-write-read)
[427.258794] Subtest basic-write-read: SKIP (0.000s)
[427.336817] [081/133] (593s left) kms_lease (atomic-implicit-crtc)
[427.423624] Starting subtest: atomic-implicit-crtc
[427.425794] Starting dynamic subtest: pipe-A-eDP-1
[427.436653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[427.446712] Starting dynamic subtest: pipe-B-eDP-1
[427.458639] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[427.469306] Starting dynamic subtest: pipe-C-eDP-1
[427.482164] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[427.491770] Starting dynamic subtest: pipe-D-eDP-1
[427.504057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.014s)
[427.506576] Subtest atomic-implicit-crtc: SUCCESS (0.040s)
[427.564090] [082/133] (593s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[427.657495] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[427.659788] Starting dynamic subtest: pipe-A-eDP-1
[427.685205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.696789] Starting dynamic subtest: pipe-B-eDP-1
[427.723198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.733076] Starting dynamic subtest: pipe-C-eDP-1
[427.758265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.767217] Starting dynamic subtest: pipe-D-eDP-1
[427.792920] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.797132] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[429.967989] [083/133] (591s left) gem_exec_flush (basic-wb-ro-before-default)
[430.031862] Starting subtest: basic-wb-ro-before-default
[435.516503] Subtest basic-wb-ro-before-default: SUCCESS (5.482s)
[435.729731] [084/133] (585s left) gem_create (create-clear)
[435.790154] Starting subtest: create-clear
[435.794552] Starting dynamic subtest: smem0
[468.882758] Dynamic subtest smem0: SUCCESS (33.088s)
[468.885216] Subtest create-clear: SUCCESS (33.089s)
[469.077252] [085/133] (552s left) i915_pm_rpm (system-suspend)
[470.882848] Starting subtest: system-suspend
[488.735256] Subtest system-suspend: SUCCESS (2.764s)
[489.124193] [086/133] (532s left) kms_flip (2x-flip-vs-dpms-on-nop)
[489.242177] Starting subtest: 2x-flip-vs-dpms-on-nop
[489.253468] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[489.350639] [087/133] (532s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[489.436989] Starting subtest: modeset-transition-nonblocking-fencing
[489.439418] Starting dynamic subtest: 1x-outputs
[500.237488] Dynamic subtest 1x-outputs: SUCCESS (10.790s)
[500.240312] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.792s)
[501.126043] [088/133] (520s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[501.232708] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[507.585506] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.353s)
[508.709569] [089/133] (512s left) gem_ctx_persistence (saturated-hostile)
[508.762461] Starting subtest: saturated-hostile
[508.765298] Starting dynamic subtest: rcs0
[509.574479] Dynamic subtest rcs0: SUCCESS (0.811s)
[509.588521] Starting dynamic subtest: bcs0
[510.366451] Dynamic subtest bcs0: SUCCESS (0.789s)
[510.380501] Starting dynamic subtest: vcs0
[511.153259] Dynamic subtest vcs0: SUCCESS (0.784s)
[511.166563] Starting dynamic subtest: vcs1
[511.953527] Dynamic subtest vcs1: SUCCESS (0.797s)
[511.968304] Starting dynamic subtest: vecs0
[512.752752] Dynamic subtest vecs0: SUCCESS (0.797s)
[512.765709] Starting dynamic subtest: ccs0
[513.592265] Dynamic subtest ccs0: SUCCESS (0.837s)
[513.595352] Subtest saturated-hostile: SUCCESS (4.829s)
[513.680934] [090/133] (507s left) kms_vblank (query-busy)
[513.774466] Starting subtest: query-busy
[513.776398] Starting dynamic subtest: pipe-A-eDP-1
[515.661243] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[515.677791] Starting dynamic subtest: pipe-D-eDP-1
[518.277324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.614s)
[518.280384] Subtest query-busy: SUCCESS (4.501s)
[519.085189] [091/133] (502s left) kms_flip (flip-vs-rmfb-interruptible)
[519.180193] Starting subtest: flip-vs-rmfb-interruptible
[519.182950] Starting dynamic subtest: A-eDP1
[527.864069] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[527.877219] Starting dynamic subtest: B-eDP1
[536.490070] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[536.500115] Starting dynamic subtest: C-eDP1
[545.114017] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[545.124767] Starting dynamic subtest: D-eDP1
[553.746910] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[553.751726] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.567s)
[554.931668] [092/133] (466s left) gem_exec_fence (submit)
[555.107965] Starting subtest: submit
[555.113375] Subtest submit: SKIP (0.000s)
[556.928893] [093/133] (464s left) kms_flip (dpms-vs-vblank-race)
[557.023125] Starting subtest: dpms-vs-vblank-race
[557.025532] Starting dynamic subtest: A-eDP1
[560.977998] Dynamic subtest A-eDP1: SUCCESS (3.952s)
[560.991194] Starting dynamic subtest: B-eDP1
[565.607312] Dynamic subtest B-eDP1: SUCCESS (4.624s)
[565.617960] Starting dynamic subtest: C-eDP1
[570.233190] Dynamic subtest C-eDP1: SUCCESS (4.621s)
[570.243498] Starting dynamic subtest: D-eDP1
[574.877748] Dynamic subtest D-eDP1: SUCCESS (4.643s)
[574.880819] Subtest dpms-vs-vblank-race: SUCCESS (17.851s)
[575.761949] [094/133] (446s left) gem_ctx_isolation (clean)
[575.824013] Starting subtest: clean
[575.826660] Starting dynamic subtest: rcs0
[575.860230] Dynamic subtest rcs0: SUCCESS (0.036s)
[575.871496] Starting dynamic subtest: bcs0
[575.917474] Dynamic subtest bcs0: SUCCESS (0.056s)
[575.929076] Starting dynamic subtest: vcs0
[575.989474] Dynamic subtest vcs0: SUCCESS (0.071s)
[576.001395] Starting dynamic subtest: vcs1
[577.923489] Dynamic subtest vcs1: SUCCESS (1.932s)
[577.935415] Starting dynamic subtest: vecs0
[579.908961] Dynamic subtest vecs0: SUCCESS (1.984s)
[579.921396] Starting dynamic subtest: ccs0
[581.906652] Dynamic subtest ccs0: SUCCESS (1.996s)
[581.909456] Subtest clean: SUCCESS (6.080s)
[582.132668] [095/133] (439s left) syncobj_basic (bad-destroy-pad)
[582.195322] Starting subtest: bad-destroy-pad
[582.197735] Subtest bad-destroy-pad: SUCCESS (0.000s)
[582.280578] [096/133] (439s left) gem_mmap_gtt (pf-nonblock)
[582.342970] Subtest pf-nonblock: SKIP (0.000s)
[582.406200] [097/133] (439s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[582.522832] Starting subtest: 2x-long-cursor-vs-flip-atomic
[582.527467] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[582.674047] [098/133] (439s left) gem_eio (in-flight-external)
[582.880156] Starting subtest: in-flight-external
[583.914546] Subtest in-flight-external: SUCCESS (1.033s)
[584.031644] [099/133] (438s left) gem_exec_fence (syncobj-wait)
[584.452468] Starting subtest: syncobj-wait
[585.925857] Subtest syncobj-wait: SUCCESS (1.473s)
[587.930555] [100/133] (434s left) gem_tiled_fence_blits (normal)
[588.000453] Subtest normal: SKIP (0.000s)
[588.064062] [101/133] (434s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[588.174339] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[588.179525] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[588.273840] [102/133] (433s left) syncobj_wait (invalid-single-wait-unsubmitted)
[588.336387] Starting subtest: invalid-single-wait-unsubmitted
[588.338909] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[588.422196] [103/133] (433s left) gem_mmap_wc (write-prefaulted)
[588.479167] Subtest write-prefaulted: SKIP (0.000s)
[588.541881] [104/133] (433s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[588.634191] Starting subtest: fbc-rgb565-draw-mmap-wc
[592.690029] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.061s)
[593.857016] [105/133] (428s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[593.954544] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[593.980024] Starting dynamic subtest: pipe-A-plane-0
[594.713500] Dynamic subtest pipe-A-plane-0: SUCCESS (0.733s)
[594.725389] Starting dynamic subtest: pipe-A-plane-3
[595.190279] Dynamic subtest pipe-A-plane-3: SUCCESS (0.477s)
[596.331869] Starting dynamic subtest: pipe-B-plane-0
[597.081130] Dynamic subtest pipe-B-plane-0: SUCCESS (0.755s)
[597.092007] Starting dynamic subtest: pipe-B-plane-3
[597.567766] Dynamic subtest pipe-B-plane-3: SUCCESS (0.486s)
[597.877986] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.928s)
[598.700629] [106/133] (423s left) kms_psr (fbc-psr-sprite-render)
[598.796637] Starting subtest: fbc-psr-sprite-render
[598.798934] Starting dynamic subtest: eDP-1
[598.803268] Dynamic subtest eDP-1: SKIP (0.000s)
[598.807490] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[598.871078] [107/133] (423s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[599.257504] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[600.119304] [108/133] (422s left) kms_cursor_crc (cursor-onscreen-64x21)
[600.312042] Starting subtest: cursor-onscreen-64x21
[600.364240] Subtest cursor-onscreen-64x21: SKIP (0.048s)
[600.636991] [109/133] (421s left) perf (global-sseu-config)
[600.773822] Starting subtest: global-sseu-config
[600.779001] Subtest global-sseu-config: SKIP (0.000s)
[600.822759] [110/133] (421s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[600.886513] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[600.947972] [111/133] (421s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[601.047094] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[601.143001] [112/133] (421s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[601.235769] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[601.238093] Starting dynamic subtest: pipe-A-eDP-1
[601.294503] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[601.305747] Starting dynamic subtest: pipe-B-eDP-1
[601.362263] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[601.372762] Starting dynamic subtest: pipe-C-eDP-1
[601.429673] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[601.440818] Starting dynamic subtest: pipe-D-eDP-1
[601.491175] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[601.495274] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[603.406890] [113/133] (419s left) gem_exec_balancer (bonded-chain)
[603.474462] Starting subtest: bonded-chain
[610.506289] Subtest bonded-chain: SUCCESS (7.031s)
[610.826043] [114/133] (411s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[610.921976] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[610.924404] Starting dynamic subtest: pipe-A-default-mode
[613.630402] Dynamic subtest pipe-A-default-mode: SUCCESS (2.707s)
[613.632954] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.709s)
[614.508626] [115/133] (408s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[614.611362] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[614.616336] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[614.707536] [116/133] (408s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[614.821804] Starting subtest: pipe-fbc-rte
[614.828750] Starting dynamic subtest: pipe-B-eDP-1
[620.267782] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.451s)
[620.275776] Subtest pipe-fbc-rte: SUCCESS (5.454s)
[622.529883] [117/133] (400s left) perf_pmu (event-wait)
[622.582082] Starting subtest: event-wait
[622.584765] Starting dynamic subtest: rcs0
[622.590033] Dynamic subtest rcs0: SKIP (0.000s)
[622.595267] Subtest event-wait: SKIP (0.001s)
[622.685187] [118/133] (400s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[622.741740] Starting subtest: multi-wait-all-for-submit-available-signaled
[622.744185] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[622.834084] [119/133] (400s left) sysfs_defaults (readonly)
[622.896275] Starting subtest: readonly
[622.898911] Starting dynamic subtest: vecs0
[622.901266] Dynamic subtest vecs0: SUCCESS (0.000s)
[622.912950] Starting dynamic subtest: ccs0
[622.915199] Dynamic subtest ccs0: SUCCESS (0.000s)
[622.925189] Starting dynamic subtest: vcs0
[622.927416] Dynamic subtest vcs0: SUCCESS (0.000s)
[622.937448] Starting dynamic subtest: bcs0
[622.939867] Dynamic subtest bcs0: SUCCESS (0.000s)
[622.949970] Starting dynamic subtest: rcs0
[622.952063] Dynamic subtest rcs0: SUCCESS (0.000s)
[622.962219] Starting dynamic subtest: vcs1
[622.964522] Dynamic subtest vcs1: SUCCESS (0.000s)
[622.966953] Subtest readonly: SUCCESS (0.006s)
[623.008500] [120/133] (399s left) gem_exec_basic (basic)
[623.072769] Starting subtest: basic
[623.075023] Starting dynamic subtest: rcs0-smem
[623.077317] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[623.088265] Starting dynamic subtest: bcs0-smem
[623.091107] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[623.101520] Starting dynamic subtest: vcs0-smem
[623.104467] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[623.115139] Starting dynamic subtest: vcs1-smem
[623.117622] Dynamic subtest vcs1-smem: SUCCESS (0.004s)
[623.128456] Starting dynamic subtest: vecs0-smem
[623.131324] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[623.142105] Starting dynamic subtest: ccs0-smem
[623.144684] Dynamic subtest ccs0-smem: SUCCESS (0.004s)
[623.147238] Subtest basic: SUCCESS (0.030s)
[624.927289] [121/133] (398s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[625.039445] Starting subtest: short-busy-flip-before-cursor-toggle
[625.044249] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[625.186080] [122/133] (397s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[625.248877] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[625.354514] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[625.447452] [123/133] (397s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[625.551282] Starting subtest: psr-1p-primscrn-cur-indfb-move
[632.940509] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.392s)
[633.074968] [124/133] (390s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[633.143034] Starting subtest: invalid-multi-wait-all-unsubmitted
[633.145737] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[633.251701] [125/133] (389s left) kms_invalid_mode (bad-hsync-start)
[633.349886] Starting subtest: bad-hsync-start
[633.352369] Starting dynamic subtest: pipe-A-eDP-1
[633.646290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[633.658082] Starting dynamic subtest: pipe-B-eDP-1
[633.660373] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[633.670894] Starting dynamic subtest: pipe-C-eDP-1
[633.673339] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[633.683941] Starting dynamic subtest: pipe-D-eDP-1
[633.686480] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[633.689219] Subtest bad-hsync-start: SUCCESS (0.304s)
[634.492772] [126/133] (388s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[634.588998] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[634.591461] Starting dynamic subtest: pipe-A-eDP-1
[634.618019] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.631704] Starting dynamic subtest: pipe-B-eDP-1
[634.657793] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.668388] Starting dynamic subtest: pipe-C-eDP-1
[634.694699] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.705304] Starting dynamic subtest: pipe-D-eDP-1
[634.732207] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.737116] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[636.846021] [127/133] (386s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[636.954342] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[643.663838] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.712s)
[643.805046] [128/133] (379s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[643.906512] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[643.911485] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[644.006774] [129/133] (379s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[644.066350] Starting subtest: y-tiled-ccs-to-yf-tiled
[644.071318] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[644.264618] [130/133] (379s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[644.368369] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[644.374032] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[644.464982] [131/133] (378s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[644.559880] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[644.562366] Starting dynamic subtest: pipe-A
[644.896738] Dynamic subtest pipe-A: SUCCESS (0.338s)
[644.907766] Starting dynamic subtest: pipe-B
[646.281507] Dynamic subtest pipe-B: SUCCESS (1.384s)
[646.292422] Starting dynamic subtest: pipe-C
[647.707001] Dynamic subtest pipe-C: SUCCESS (1.424s)
[647.718168] Starting dynamic subtest: pipe-D
[649.139951] Dynamic subtest pipe-D: SUCCESS (1.430s)
[649.142563] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.580s)
[650.312408] [132/133] (373s left) gem_exec_schedule (wide)
[650.507461] Starting subtest: wide
[650.510125] Starting dynamic subtest: rcs0
[662.171001] Dynamic subtest rcs0: SUCCESS (11.656s)
[662.185696] Starting dynamic subtest: vcs0
[674.824142] Dynamic subtest vcs0: SUCCESS (12.651s)
[674.838050] Starting dynamic subtest: vcs1
[686.947461] Dynamic subtest vcs1: SUCCESS (12.118s)
[686.960462] Starting dynamic subtest: vecs0
[699.514657] Dynamic subtest vecs0: SUCCESS (12.562s)
[699.528290] Starting dynamic subtest: ccs0
[714.774488] Dynamic subtest ccs0: SUCCESS (15.256s)
[714.777883] Subtest wide: SUCCESS (64.250s)
[716.136090] [133/133] (307s left) kms_atomic_transition (plane-all-transition)
[716.246128] Starting subtest: plane-all-transition
[716.248643] Starting dynamic subtest: pipe-A-eDP-1
[718.740039] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[719.054093] Starting dynamic subtest: pipe-B-eDP-1
[722.244111] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.200s)
[722.540474] Subtest plane-all-transition: SUCCESS (6.298s)
[723.367523] 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.