[63.200324] Initializing watchdogs
[63.200371]   /dev/watchdog0
[63.214281] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[63.218593] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.220776] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.224248] [001/131] (960s left) kms_flip (2x-dpms-vs-vblank-race)
[63.344131] Starting subtest: 2x-dpms-vs-vblank-race
[63.352751] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[63.488937] [002/131] (960s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[63.583946] Starting subtest: fbc-psr2-cursor-plane-onoff
[63.586308] Starting dynamic subtest: eDP-1
[63.590496] Dynamic subtest eDP-1: SKIP (0.000s)
[63.594680] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[63.678118] [003/131] (960s left) prime_busy (after)
[63.733294] Starting subtest: after
[63.737752] Starting dynamic subtest: rcs0
[63.782339] Dynamic subtest rcs0: SUCCESS (0.046s)
[63.791159] Starting dynamic subtest: bcs0
[63.838905] Dynamic subtest bcs0: SUCCESS (0.057s)
[63.847644] Starting dynamic subtest: vcs0
[63.878904] Dynamic subtest vcs0: SUCCESS (0.039s)
[63.887091] Starting dynamic subtest: vcs1
[63.918750] Dynamic subtest vcs1: SUCCESS (0.040s)
[63.927100] Starting dynamic subtest: vecs0
[63.959600] Dynamic subtest vecs0: SUCCESS (0.040s)
[63.968507] Starting dynamic subtest: ccs0
[63.999338] Dynamic subtest ccs0: SUCCESS (0.040s)
[64.107703] Subtest after: SUCCESS (0.372s)
[64.202715] [004/131] (959s left) gem_exec_balancer (bonded-chain)
[64.267073] Starting subtest: bonded-chain
[71.656335] Subtest bonded-chain: SUCCESS (7.388s)
[72.056589] [005/131] (951s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[72.203805] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[72.208152] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[72.301577] [006/131] (951s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[72.407583] Starting subtest: x-tiled-64bpp-rotate-90
[72.439131] Subtest x-tiled-64bpp-rotate-90: SKIP (0.030s)
[72.594195] [007/131] (951s left) kms_vblank (accuracy-idle)
[72.685907] Starting subtest: accuracy-idle
[72.688074] Starting dynamic subtest: pipe-A-eDP-1
[74.441340] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[74.454356] Starting dynamic subtest: pipe-D-eDP-1
[76.891767] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.447s)
[76.893838] Subtest accuracy-idle: SUCCESS (4.206s)
[77.727416] [008/131] (946s left) kms_cursor_crc (cursor-onscreen-128x42)
[77.942794] Starting subtest: cursor-onscreen-128x42
[77.991354] Subtest cursor-onscreen-128x42: SKIP (0.043s)
[78.221747] [009/131] (945s left) kms_chamelium_frames (hdmi-aspect-ratio)
[78.601766] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[79.422698] [010/131] (944s left) gem_ctx_param (invalid-get-ringsize)
[79.479333] Starting subtest: invalid-get-ringsize
[79.482430] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[79.613497] [011/131] (944s left) kms_psr (psr-primary-page-flip)
[79.698325] Starting subtest: psr-primary-page-flip
[79.700657] Starting dynamic subtest: eDP-1
[81.446360] Dynamic subtest eDP-1: SUCCESS (1.749s)
[81.448353] Subtest psr-primary-page-flip: SUCCESS (1.749s)
[82.317571] [012/131] (941s left) i915_query (test-query-geometry-subslices)
[82.369075] Starting subtest: test-query-geometry-subslices
[82.371238] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[82.473378] [013/131] (941s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[82.571383] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[82.575654] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[82.690711] [014/131] (941s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[82.748936] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[82.753497] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[82.938515] [015/131] (941s left) syncobj_timeline (wait-for-submit-snapshot)
[83.000397] Starting subtest: wait-for-submit-snapshot
[83.080888] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[83.166251] [016/131] (941s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[83.262774] Starting subtest: y-tiled-32bpp-rotate-270
[83.267059] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[83.360782] [017/131] (940s left) kms_plane (plane-position-hole-dpms)
[83.460893] Starting subtest: plane-position-hole-dpms
[83.983289] Starting dynamic subtest: pipe-A-plane-1
[86.326047] Dynamic subtest pipe-A-plane-1: SUCCESS (2.343s)
[86.336345] Starting dynamic subtest: pipe-A-plane-2
[88.669279] Dynamic subtest pipe-A-plane-2: SUCCESS (2.343s)
[88.676984] Starting dynamic subtest: pipe-A-plane-3
[91.026364] Dynamic subtest pipe-A-plane-3: SUCCESS (2.356s)
[91.035389] Starting dynamic subtest: pipe-A-plane-4
[93.404631] Dynamic subtest pipe-A-plane-4: SUCCESS (2.377s)
[93.411866] Starting dynamic subtest: pipe-A-plane-5
[93.429504] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[94.578064] Starting dynamic subtest: pipe-B-plane-1
[97.004247] Dynamic subtest pipe-B-plane-1: SUCCESS (2.432s)
[97.013639] Starting dynamic subtest: pipe-B-plane-2
[99.371033] Dynamic subtest pipe-B-plane-2: SUCCESS (2.367s)
[99.379557] Starting dynamic subtest: pipe-B-plane-3
[101.729114] Dynamic subtest pipe-B-plane-3: SUCCESS (2.357s)
[101.738467] Starting dynamic subtest: pipe-B-plane-4
[104.101074] Dynamic subtest pipe-B-plane-4: SUCCESS (2.373s)
[104.111016] Starting dynamic subtest: pipe-B-plane-5
[104.126655] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[104.128664] Subtest plane-position-hole-dpms: SUCCESS (20.665s)
[104.925888] [018/131] (919s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[104.992628] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[104.995044] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[105.124194] [019/131] (919s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[105.243440] Starting subtest: basic-flip-after-cursor-varying-size
[106.190518] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.948s)
[107.046806] [020/131] (917s left) syncobj_wait (multi-wait-all-submitted-signaled)
[107.096130] Starting subtest: multi-wait-all-submitted-signaled
[107.202251] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[107.291698] [021/131] (917s left) gem_ctx_persistence (engines-queued)
[107.355162] Starting subtest: engines-queued
[107.357406] Starting dynamic subtest: rcs0
[107.446861] Dynamic subtest rcs0: SUCCESS (0.094s)
[107.457786] Starting dynamic subtest: bcs0
[107.475549] Dynamic subtest bcs0: SUCCESS (0.028s)
[107.483273] Starting dynamic subtest: vcs0
[108.851143] Dynamic subtest vcs0: SUCCESS (1.374s)
[108.860530] Starting dynamic subtest: vcs1
[110.900395] Dynamic subtest vcs1: SUCCESS (2.047s)
[110.912217] Starting dynamic subtest: vecs0
[112.883621] Dynamic subtest vecs0: SUCCESS (1.981s)
[112.894210] Starting dynamic subtest: ccs0
[113.072295] Dynamic subtest ccs0: SUCCESS (0.189s)
[113.074784] Subtest engines-queued: SUCCESS (5.720s)
[113.238693] [022/131] (911s left) kms_rotation_crc (bad-tiling)
[113.331066] Starting subtest: bad-tiling
[113.335613] Subtest bad-tiling: SKIP (0.001s)
[113.410783] [023/131] (911s left) gem_exec_big (single)
[113.469432] Starting subtest: single
[115.715899] Subtest single: SUCCESS (2.244s)
[115.933184] [024/131] (908s left) gem_exec_reloc (basic-gtt-wc)
[116.029770] Subtest basic-gtt-wc: SKIP (0.000s)
[116.088699] [025/131] (908s left) vgem_basic (dmabuf-mmap)
[116.185478] Starting subtest: dmabuf-mmap
[116.188673] Subtest dmabuf-mmap: SUCCESS (0.008s)
[116.231857] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[116.235174] [026/131] (908s left) kms_cursor_edge_walk (128x128-top-bottom)
[116.331399] Starting subtest: 128x128-top-bottom
[116.333690] Starting dynamic subtest: pipe-A-eDP-1
[119.810755] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[119.819479] Starting dynamic subtest: pipe-D-eDP-1
[122.931325] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[122.933729] Subtest 128x128-top-bottom: SUCCESS (6.599s)
[123.749308] [027/131] (900s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[128.708642] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[128.711081] Starting dynamic subtest: pipe-A-eDP-1
[129.510637] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[129.521853] Starting dynamic subtest: pipe-B-eDP-1
[130.640993] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[130.645799] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.929s)
[131.842322] [028/131] (892s left) gem_tiled_fence_blits (basic)
[131.906192] Subtest basic: SKIP (0.000s)
[131.974011] [029/131] (892s left) gem_exec_reloc (basic-write-cpu-active)
[132.027227] Subtest basic-write-cpu-active: SKIP (0.000s)
[132.102932] [030/131] (892s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[132.206694] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[132.211171] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[132.307402] [031/131] (892s left) i915_drm_fdinfo (busy-idle-check-all)
[132.344228] Starting subtest: busy-idle-check-all
[132.346676] Starting dynamic subtest: rcs0
[132.351256] Dynamic subtest rcs0: SKIP (0.004s)
[132.360602] Starting dynamic subtest: bcs0
[132.364830] Dynamic subtest bcs0: SKIP (0.000s)
[132.372935] Starting dynamic subtest: vcs0
[132.376654] Dynamic subtest vcs0: SKIP (0.000s)
[132.383691] Starting dynamic subtest: vcs1
[132.387753] Dynamic subtest vcs1: SKIP (0.000s)
[132.396134] Starting dynamic subtest: vecs0
[132.400106] Dynamic subtest vecs0: SKIP (0.000s)
[132.407139] Starting dynamic subtest: ccs0
[132.411097] Dynamic subtest ccs0: SKIP (0.000s)
[132.415077] Subtest busy-idle-check-all: SKIP (0.008s)
[132.448713] [032/131] (892s left) syncobj_wait (wait-any-complex)
[132.550613] Starting subtest: wait-any-complex
[132.612618] Subtest wait-any-complex: SUCCESS (0.062s)
[132.695705] [033/131] (892s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[132.783577] Starting subtest: coverage-vs-premult-vs-constant
[133.058789] Starting dynamic subtest: pipe-A-eDP-1
[133.659690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[133.668641] Starting dynamic subtest: pipe-D-eDP-1
[134.957582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[134.959880] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.174s)
[135.808326] [034/131] (889s left) kms_flip (wf_vblank-ts-check)
[135.901628] Starting subtest: wf_vblank-ts-check
[135.904055] Starting dynamic subtest: A-eDP1
[144.834737] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[144.844062] Starting dynamic subtest: B-eDP1
[153.758628] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[153.766648] Starting dynamic subtest: C-eDP1
[162.678090] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[162.686685] Starting dynamic subtest: D-eDP1
[171.608249] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[171.611102] Subtest wf_vblank-ts-check: SUCCESS (35.711s)
[172.852692] [035/131] (852s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[172.930538] Starting subtest: y-tiled-ccs-to-x-tiled
[172.935302] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[173.130312] [036/131] (851s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[173.228056] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[174.173767] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.946s)
[174.332224] [037/131] (850s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[174.446226] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[174.450047] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[174.596591] [038/131] (850s left) prime_mmap_coherency (write)
[174.660463] Starting subtest: write
[180.042069] Subtest write: SUCCESS (5.379s)
[180.218807] [039/131] (844s left) gem_exec_suspend (basic)
[180.287912] Starting subtest: basic
[180.290535] Starting dynamic subtest: smem
[181.911232] Dynamic subtest smem: SUCCESS (1.621s)
[181.914056] Subtest basic: SUCCESS (1.623s)
[182.110287] [040/131] (843s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[182.213784] Starting subtest: fbc-pr-cursor-mmap-cpu
[182.217815] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[182.307008] [041/131] (842s left) kms_atomic (plane-invalid-params-fence)
[182.402532] Starting subtest: plane-invalid-params-fence
[182.404981] Starting dynamic subtest: pipe-A-eDP-1
[182.764800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[182.767072] Subtest plane-invalid-params-fence: SUCCESS (0.364s)
[183.568353] [042/131] (841s left) kms_atomic_transition (plane-all-modeset-transition)
[183.667183] Starting subtest: plane-all-modeset-transition
[183.671226] Subtest plane-all-modeset-transition: SKIP (0.000s)
[183.751412] [043/131] (841s left) gem_exec_schedule (thriceslice)
[183.828469] Starting subtest: thriceslice
[183.830450] Starting dynamic subtest: rcs0
[183.846365] Dynamic subtest rcs0: SUCCESS (0.029s)
[183.855447] Starting dynamic subtest: bcs0
[183.874129] Dynamic subtest bcs0: SUCCESS (0.027s)
[183.881549] Starting dynamic subtest: vcs0
[183.924599] Dynamic subtest vcs0: SUCCESS (0.050s)
[183.932321] Starting dynamic subtest: vcs1
[183.975668] Dynamic subtest vcs1: SUCCESS (0.049s)
[183.987260] Starting dynamic subtest: vecs0
[184.005382] Dynamic subtest vecs0: SUCCESS (0.028s)
[184.013326] Starting dynamic subtest: ccs0
[184.036054] Dynamic subtest ccs0: SUCCESS (0.030s)
[184.038287] Subtest thriceslice: SUCCESS (0.220s)
[186.004691] [044/131] (839s left) gem_mmap_gtt (hang-busy)
[186.065040] Subtest hang-busy: SKIP (0.000s)
[186.134215] [045/131] (839s left) gem_softpin (evict-active)
[186.193676] Starting subtest: evict-active
[186.205118] Subtest evict-active: SUCCESS (0.011s)
[186.315223] [046/131] (839s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[186.418760] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[186.423062] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[186.528725] [047/131] (838s left) gem_softpin (32b-excludes-last-page)
[186.584622] Starting subtest: 32b-excludes-last-page
[186.589166] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[186.725504] [048/131] (838s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[186.824085] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[186.828519] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[186.948387] [049/131] (838s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[187.042226] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[193.972179] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.931s)
[194.117399] [050/131] (831s left) kms_vblank (ts-continuation-suspend)
[194.219240] Starting subtest: ts-continuation-suspend
[194.221085] Starting dynamic subtest: pipe-A-eDP-1
[210.477841] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.418s)
[210.491654] Starting dynamic subtest: pipe-D-eDP-1
[227.431837] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.130s)
[227.434083] Subtest ts-continuation-suspend: SUCCESS (4.552s)
[228.305912] [051/131] (797s left) gem_exec_reloc (basic-concurrent16)
[228.368538] Subtest basic-concurrent16: SKIP (0.000s)
[228.454147] [052/131] (797s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[228.608067] Starting subtest: cursor-rapid-movement-32x32
[228.652857] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[228.954659] [053/131] (796s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[229.048715] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[229.052322] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[229.163587] [054/131] (796s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[229.240929] Starting subtest: plane-primary-toggle-with-vblank-wait
[229.242996] Starting dynamic subtest: pipe-A-eDP-1
[229.413259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[229.730433] Starting dynamic subtest: pipe-B-eDP-1
[230.608791] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.886s)
[230.905567] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.665s)
[231.788564] [055/131] (793s left) i915_hangman (detector)
[231.856754] Starting subtest: detector
[231.859104] Starting dynamic subtest: rcs0
[243.562770] Dynamic subtest rcs0: SUCCESS (11.702s)
[243.574579] Starting dynamic subtest: bcs0
[255.532001] Dynamic subtest bcs0: SUCCESS (11.964s)
[255.544454] Starting dynamic subtest: vcs0
[267.500036] Dynamic subtest vcs0: SUCCESS (11.963s)
[267.512888] Starting dynamic subtest: vcs1
[279.466261] Dynamic subtest vcs1: SUCCESS (11.962s)
[279.477158] Starting dynamic subtest: vecs0
[290.475359] Dynamic subtest vecs0: SUCCESS (11.004s)
[290.486560] Starting dynamic subtest: ccs0
[301.546144] Dynamic subtest ccs0: SUCCESS (11.066s)
[301.549279] Subtest detector: SUCCESS (69.679s)
[301.651610] [056/131] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[301.755428] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[309.094743] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.341s)
[309.254602] [057/131] (716s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[309.355522] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[310.023611] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[310.253468] [058/131] (715s left) gem_exec_whisper (basic-forked-all)
[310.310275] Starting subtest: basic-forked-all
[323.536728] Subtest basic-forked-all: SUCCESS (13.222s)
[323.731405] [059/131] (702s left) gem_tiled_wc
[323.862122] [060/131] (702s left) kms_psr (psr2-cursor-plane-onoff)
[323.960489] Starting subtest: psr2-cursor-plane-onoff
[323.962841] Starting dynamic subtest: eDP-1
[325.683060] Dynamic subtest eDP-1: SUCCESS (1.723s)
[325.685258] Subtest psr2-cursor-plane-onoff: SUCCESS (1.724s)
[326.489761] [061/131] (699s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[326.556042] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[326.558311] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[326.682582] [062/131] (699s left) gem_create (create-ext-cpu-access-big)
[326.849986] Starting subtest: create-ext-cpu-access-big
[326.854687] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[326.936884] [063/131] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[327.035959] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[327.040182] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[327.152817] [064/131] (698s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[327.204844] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[327.206805] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[327.327670] [065/131] (698s left) kms_psr (fbc-psr-primary-mmap-gtt)
[327.424353] Starting subtest: fbc-psr-primary-mmap-gtt
[327.426647] Starting dynamic subtest: eDP-1
[327.431001] Dynamic subtest eDP-1: SKIP (0.000s)
[327.435389] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[327.508988] [066/131] (698s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[327.573770] Starting subtest: multi-wait-all-for-submit-signaled
[327.576022] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[327.721480] [067/131] (698s left) gen7_exec_parse (basic-offset)
[327.788778] Subtest basic-offset: SKIP (0.000s)
[327.861626] [068/131] (698s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[332.861752] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[332.864129] Starting dynamic subtest: pipe-A-eDP-1
[333.678294] Dynamic subtest pipe-A-eDP-1: SKIP (0.812s)
[333.689281] Starting dynamic subtest: pipe-B-eDP-1
[334.806185] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[334.811161] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.942s)
[336.018406] [069/131] (690s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[336.123894] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[336.128318] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.240789] [070/131] (690s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[336.344777] Starting subtest: psr-2p-pri-indfb-multidraw
[336.349192] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[336.474383] [071/131] (689s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[336.575124] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[336.577441] Starting dynamic subtest: pipe-A-default-mode
[336.873978] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[336.878483] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.297s)
[337.741829] [072/131] (688s left) gem_wait (write-wait)
[337.818595] Starting subtest: write-wait
[337.821086] Starting dynamic subtest: all-engines
[338.966287] Dynamic subtest all-engines: SUCCESS (1.147s)
[338.982319] Starting dynamic subtest: rcs0
[340.029584] Dynamic subtest rcs0: SUCCESS (1.062s)
[340.046932] Starting dynamic subtest: bcs0
[341.086527] Dynamic subtest bcs0: SUCCESS (1.056s)
[341.104314] Starting dynamic subtest: vcs0
[342.143603] Dynamic subtest vcs0: SUCCESS (1.055s)
[342.163788] Starting dynamic subtest: vcs1
[343.199588] Dynamic subtest vcs1: SUCCESS (1.053s)
[343.216260] Starting dynamic subtest: vecs0
[344.253718] Dynamic subtest vecs0: SUCCESS (1.052s)
[344.269901] Starting dynamic subtest: ccs0
[345.312612] Dynamic subtest ccs0: SUCCESS (1.056s)
[345.315617] Subtest write-wait: SUCCESS (7.494s)
[345.538409] [073/131] (680s left) sw_sync (alloc_merge_fence)
[345.583935] Starting subtest: alloc_merge_fence
[345.586290] Subtest alloc_merge_fence: SUCCESS (0.000s)
[345.669006] [074/131] (680s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[345.772151] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[345.774447] Starting dynamic subtest: pipe-A-eDP-1
[345.797674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.809665] Starting dynamic subtest: pipe-B-eDP-1
[345.831887] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.840615] Starting dynamic subtest: pipe-C-eDP-1
[345.862395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.871038] Starting dynamic subtest: pipe-D-eDP-1
[345.893176] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[345.897309] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[348.001301] [075/131] (678s left) api_intel_allocator (reserve-simple)
[348.064797] Starting subtest: reserve-simple
[348.067207] Subtest reserve-simple: SUCCESS (0.004s)
[348.239086] [076/131] (678s left) gem_ctx_shared (q-out-order)
[348.296157] Starting subtest: Q-out-order
[348.298522] Starting dynamic subtest: rcs0
[348.396890] Dynamic subtest rcs0: SUCCESS (0.100s)
[348.411248] Starting dynamic subtest: vcs0
[348.471575] Dynamic subtest vcs0: SUCCESS (0.074s)
[348.488298] Starting dynamic subtest: vcs1
[348.545485] Dynamic subtest vcs1: SUCCESS (0.072s)
[348.562050] Starting dynamic subtest: vecs0
[348.617062] Dynamic subtest vecs0: SUCCESS (0.071s)
[348.633046] Starting dynamic subtest: ccs0
[348.707099] Dynamic subtest ccs0: SUCCESS (0.089s)
[348.709686] Subtest Q-out-order: SUCCESS (0.411s)
[349.720550] [077/131] (676s left) kms_lease (invalid-create-leases)
[349.804509] Starting subtest: invalid-create-leases
[349.809880] Subtest invalid-create-leases: SUCCESS (0.006s)
[349.956797] [078/131] (676s left) kms_pm_backlight (basic-brightness)
[350.039381] Starting subtest: basic-brightness
[350.090158] Starting dynamic subtest: eDP-1
[350.599786] Dynamic subtest eDP-1: SUCCESS (0.511s)
[350.602290] Subtest basic-brightness: SUCCESS (0.561s)
[351.426068] [079/131] (675s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[351.485318] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[351.489716] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[351.694133] [080/131] (675s left) syncobj_eventfd (timeline-wait-signaled)
[351.752915] Starting subtest: timeline-wait-signaled
[351.754946] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[351.875320] [081/131] (674s left) gem_exec_whisper (basic-queues-forked-all)
[351.946935] Starting subtest: basic-queues-forked-all
[373.849427] Subtest basic-queues-forked-all: SUCCESS (21.896s)
[374.045634] [082/131] (652s left) gem_exec_suspend (basic-s3-devices)
[374.112929] Starting subtest: basic-S3-devices
[374.115318] Starting dynamic subtest: smem
[384.523219] Dynamic subtest smem: SUCCESS (10.407s)
[384.525769] Subtest basic-S3-devices: SUCCESS (10.409s)
[384.718592] [083/131] (642s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[384.830904] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[384.842077] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[384.988362] [084/131] (641s left) kms_fb_coherency (memset-crc)
[385.080489] Starting subtest: memset-crc
[385.082337] Starting dynamic subtest: mmap-offset-wc
[385.742918] Dynamic subtest mmap-offset-wc: CRASH (0.149s)
[386.184056] Subtest memset-crc: CRASH (0.622s)
[386.219795] [085/131] (640s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[386.270302] Starting subtest: framebuffer-vs-set-tiling
[386.274273] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[386.426125] [086/131] (640s left) gem_softpin (evict-snoop-interruptible)
[386.480015] Starting subtest: evict-snoop-interruptible
[386.483773] Subtest evict-snoop-interruptible: SKIP (0.000s)
[386.603817] [087/131] (640s left) kms_pm_rpm (legacy-planes-dpms)
[388.726120] Starting subtest: legacy-planes-dpms
[388.728116] Starting dynamic subtest: plane-63
[397.042595] Dynamic subtest plane-63: SUCCESS (8.318s)
[397.053379] Starting dynamic subtest: plane-93
[405.396000] Dynamic subtest plane-93: SUCCESS (8.351s)
[405.407519] Starting dynamic subtest: plane-123
[413.804865] Dynamic subtest plane-123: SUCCESS (8.404s)
[413.818019] Starting dynamic subtest: plane-133
[422.384984] Dynamic subtest plane-133: SUCCESS (8.577s)
[422.387930] Subtest legacy-planes-dpms: SUCCESS (33.661s)
[422.784424] [088/131] (604s left) gem_exec_fence (syncobj-signal)
[423.231893] Starting subtest: syncobj-signal
[423.237260] Subtest syncobj-signal: SUCCESS (0.004s)
[424.713347] [089/131] (602s left) fbdev (unaligned-read)
[424.751948] Starting subtest: unaligned-read
[424.766037] Subtest unaligned-read: SUCCESS (0.015s)
[424.849019] [090/131] (602s left) gem_lmem_swapping (verify-random-ccs)
[424.883793] Subtest verify-random-ccs: SKIP (0.000s)
[424.929382] [091/131] (602s left) kms_color (ctm-green-to-red)
[425.013080] Starting subtest: ctm-green-to-red
[425.015366] Starting dynamic subtest: pipe-A-eDP-1
[425.689887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s)
[425.700359] Starting dynamic subtest: pipe-B-eDP-1
[427.032752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[427.043287] Starting dynamic subtest: pipe-C-eDP-1
[428.440472] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.408s)
[428.450280] Starting dynamic subtest: pipe-D-eDP-1
[429.766287] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[429.768433] Subtest ctm-green-to-red: SUCCESS (4.753s)
[430.585285] [092/131] (596s left) kms_chamelium_hpd (hdmi-hpd)
[430.973984] Subtest hdmi-hpd: SKIP (0.000s)
[431.788325] [093/131] (595s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[431.852201] Starting subtest: multi-wait-all-for-submit-available-submitted
[431.854397] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[431.964753] [094/131] (595s left) api_intel_bb (full-batch)
[432.005952] Starting subtest: full-batch
[432.011245] Subtest full-batch: SUCCESS (0.006s)
[432.154663] [095/131] (595s left) perf_pmu (semaphore-wait)
[432.200060] Starting subtest: semaphore-wait
[432.202327] Starting dynamic subtest: rcs0
[432.713656] Dynamic subtest rcs0: SUCCESS (0.513s)
[432.726119] Starting dynamic subtest: bcs0
[433.227636] Dynamic subtest bcs0: SUCCESS (0.510s)
[433.240556] Starting dynamic subtest: vcs0
[433.740852] Dynamic subtest vcs0: SUCCESS (0.510s)
[433.753836] Starting dynamic subtest: vcs1
[434.253593] Dynamic subtest vcs1: SUCCESS (0.510s)
[434.266021] Starting dynamic subtest: vecs0
[434.766337] Dynamic subtest vecs0: SUCCESS (0.509s)
[434.777694] Starting dynamic subtest: ccs0
[435.280650] Dynamic subtest ccs0: SUCCESS (0.512s)
[435.283966] Subtest semaphore-wait: SUCCESS (3.083s)
[436.591042] [096/131] (590s left) kms_big_fb (linear-32bpp-rotate-270)
[436.695472] Starting subtest: linear-32bpp-rotate-270
[436.715112] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[436.864133] [097/131] (590s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[436.948060] Starting subtest: basic-modeset-with-all-modifiers-formats
[437.326980] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[438.691392] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: FAIL (0.776s)
[438.701204] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[438.837556] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: FAIL (0.461s)
[438.848998] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[438.984980] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: FAIL (0.016s)
[438.996918] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[439.295687] Dynamic subtest pipe-A-eDP-1-4-RGB565: FAIL (0.577s)
[439.306472] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[439.419052] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: FAIL (0.018s)
[439.429854] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[439.542393] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: FAIL (0.008s)
[439.552681] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[439.664349] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: FAIL (0.011s)
[439.673802] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[439.784635] Dynamic subtest pipe-A-eDP-1-4-YUYV: FAIL (0.422s)
[439.795268] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[439.906766] Dynamic subtest pipe-A-eDP-1-4-Y210: FAIL (0.016s)
[439.916887] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[440.028712] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: FAIL (0.009s)
[440.039266] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[440.146190] Dynamic subtest pipe-A-eDP-1-4-XV30: FAIL (0.011s)
[440.155601] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[440.268948] Dynamic subtest pipe-A-eDP-1-4-XV36: FAIL (0.421s)
[440.280295] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[440.584736] Dynamic subtest pipe-A-eDP-1-x-RGB565: FAIL (0.132s)
[440.595666] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[440.705375] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: FAIL (0.006s)
[440.714282] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[440.825860] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: FAIL (0.422s)
[440.836536] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[440.946096] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: FAIL (0.018s)
[440.955858] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[441.064715] Dynamic subtest pipe-A-eDP-1-x-YUYV: FAIL (0.008s)
[441.076081] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[441.190688] Dynamic subtest pipe-A-eDP-1-x-Y210: FAIL (0.010s)
[441.202336] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[441.313167] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: FAIL (0.420s)
[441.322517] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[441.435762] Dynamic subtest pipe-A-eDP-1-x-XV30: FAIL (0.016s)
[441.446703] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[441.556104] Dynamic subtest pipe-A-eDP-1-x-XV36: FAIL (0.014s)
[441.565490] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[441.830852] Dynamic subtest pipe-A-eDP-1-linear-RGB565: FAIL (0.540s)
[441.840532] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[441.946979] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: FAIL (0.017s)
[441.955716] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[442.064991] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: FAIL (0.008s)
[442.083976] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[442.199864] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: FAIL (0.011s)
[442.210126] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[442.322660] Dynamic subtest pipe-A-eDP-1-linear-YUYV: FAIL (0.414s)
[442.333593] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[442.448957] Dynamic subtest pipe-A-eDP-1-linear-Y210: FAIL (0.017s)
[442.460322] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[442.573177] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: FAIL (0.009s)
[442.583812] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[442.697337] Dynamic subtest pipe-A-eDP-1-linear-XV30: FAIL (0.010s)
[442.708499] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[442.821007] Dynamic subtest pipe-A-eDP-1-linear-XV36: FAIL (0.433s)
[442.998910] Subtest basic-modeset-with-all-modifiers-formats: FAIL (6.053s)
[443.795880] [098/131] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[443.885809] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[443.890028] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[444.025563] [099/131] (583s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[444.109735] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[444.111652] Starting dynamic subtest: pipe-A-eDP-1
[444.169634] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[444.178892] Starting dynamic subtest: pipe-B-eDP-1
[444.235546] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[444.246046] Starting dynamic subtest: pipe-C-eDP-1
[444.303787] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[444.315741] Starting dynamic subtest: pipe-D-eDP-1
[444.373911] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[444.378471] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.012s)
[446.360878] [100/131] (581s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[446.414390] Starting subtest: invalid-bsd1-flag-on-vebox
[446.416802] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[446.537387] [101/131] (581s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[446.632419] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[446.637262] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[447.796983] [102/131] (579s left) kms_getfb (getfb-repeated-different-handles)
[447.901454] Starting subtest: getfb-repeated-different-handles
[447.903753] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[448.007967] [103/131] (579s left) kms_psr (psr-dpms)
[448.105936] Starting subtest: psr-dpms
[448.108200] Starting dynamic subtest: eDP-1
[451.108039] Dynamic subtest eDP-1: SUCCESS (3.008s)
[451.110451] Subtest psr-dpms: SUCCESS (3.010s)
[451.990656] [104/131] (575s left) gem_exec_schedule (manyslice)
[452.068501] Starting subtest: manyslice
[452.070584] Starting dynamic subtest: rcs0
[456.672252] Dynamic subtest rcs0: SUCCESS (4.612s)
[456.689357] Starting dynamic subtest: bcs0
[462.787271] Dynamic subtest bcs0: SUCCESS (6.111s)
[462.804739] Starting dynamic subtest: vcs0
[468.377488] Dynamic subtest vcs0: SUCCESS (5.588s)
[468.390989] Starting dynamic subtest: vcs1
[474.458582] Dynamic subtest vcs1: SUCCESS (6.080s)
[474.474094] Starting dynamic subtest: vecs0
[480.533269] Dynamic subtest vecs0: SUCCESS (6.073s)
[480.549778] Starting dynamic subtest: ccs0
[486.198891] Dynamic subtest ccs0: SUCCESS (5.663s)
[486.201843] Subtest manyslice: SUCCESS (34.138s)
[486.524322] [105/131] (541s left) gem_exec_reloc (basic-cpu-active)
[486.586468] Subtest basic-cpu-active: SKIP (0.000s)
[486.655686] [106/131] (541s left) core_auth (basic-auth)
[486.710619] Starting subtest: basic-auth
[486.712990] Subtest basic-auth: SUCCESS (0.001s)
[486.827849] [107/131] (541s left) gem_exec_parallel (basic)
[486.898000] Starting subtest: basic
[486.900418] Starting dynamic subtest: rcs0
[488.452473] Dynamic subtest rcs0: SUCCESS (1.554s)
[488.465050] Starting dynamic subtest: bcs0
[489.948905] Dynamic subtest bcs0: SUCCESS (1.494s)
[489.958397] Starting dynamic subtest: vcs0
[491.587490] Dynamic subtest vcs0: SUCCESS (1.638s)
[491.596845] Starting dynamic subtest: vcs1
[493.515209] Dynamic subtest vcs1: SUCCESS (1.926s)
[493.526762] Starting dynamic subtest: vecs0
[495.499140] Dynamic subtest vecs0: SUCCESS (1.981s)
[495.511344] Starting dynamic subtest: ccs0
[496.976287] Dynamic subtest ccs0: SUCCESS (1.476s)
[496.978572] Subtest basic: SUCCESS (10.078s)
[497.187150] [108/131] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[497.297654] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[504.250664] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.955s)
[504.409954] [109/131] (523s left) i915_pm_rps (basic-api)
[504.471377] Starting subtest: basic-api
[504.475916] Subtest basic-api: SKIP (0.001s)
[504.607629] [110/131] (523s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[504.706441] Starting subtest: primary-x-tiled-reflect-x-180
[511.696317] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.990s)
[512.889974] [111/131] (515s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[512.987667] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[512.992172] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[513.127703] [112/131] (514s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[513.213378] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[513.215612] Starting dynamic subtest: pipe-A-default-mode
[513.506693] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[513.511384] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.291s)
[514.298731] [113/131] (513s left) kms_hdr (static-toggle-dpms)
[514.385783] Starting subtest: static-toggle-dpms
[514.392376] Subtest static-toggle-dpms: SKIP (0.000s)
[514.474238] [114/131] (513s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[514.554186] Starting subtest: disable-crc-after-crtc
[514.556151] Starting dynamic subtest: pipe-A-eDP-1
[516.252288] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.696s)
[516.266782] Starting dynamic subtest: pipe-B-eDP-1
[518.535286] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.281s)
[518.545204] Starting dynamic subtest: pipe-C-eDP-1
[520.768586] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.233s)
[520.779996] Starting dynamic subtest: pipe-D-eDP-1
[523.052712] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.280s)
[523.054912] Subtest disable-crc-after-crtc: SUCCESS (8.498s)
[523.877442] [115/131] (504s left) gem_userptr_blits (usage-restrictions)
[523.939627] Starting subtest: usage-restrictions
[523.941544] Subtest usage-restrictions: SUCCESS (0.000s)
[524.108453] [116/131] (504s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[524.203399] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[524.207973] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[525.325788] [117/131] (502s left) gem_mmap_wc (write-prefaulted)
[525.374984] Subtest write-prefaulted: SKIP (0.000s)
[525.437727] [118/131] (502s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[525.507915] Starting subtest: invalid-multi-wait-all-unsubmitted
[525.510255] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[525.642409] [119/131] (502s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[527.667096] Starting subtest: modeset-non-lpsp-stress-no-wait
[527.715074] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.049s)
[528.047818] [120/131] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[528.155028] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[528.159458] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[528.282264] [121/131] (500s left) vgem_basic (sysfs)
[528.326993] Starting subtest: sysfs
[528.329195] Subtest sysfs: SUCCESS (0.000s)
[528.406963] [122/131] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[528.507515] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[535.363610] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.859s)
[535.558941] [123/131] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[535.657869] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[535.661980] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[535.788506] [124/131] (492s left) kms_chamelium_audio (hdmi-audio)
[536.193059] Subtest hdmi-audio: SKIP (0.000s)
[536.980067] [125/131] (491s left) core_getstats (basic)
[537.038312] Starting subtest: basic
[537.040762] Subtest basic: SUCCESS (0.000s)
[537.159852] [126/131] (491s left) syncobj_wait (wait-zero-handles)
[537.215056] Starting subtest: wait-zero-handles
[537.217386] Subtest wait-zero-handles: SUCCESS (0.000s)
[537.336901] [127/131] (491s left) prime_self_import (export-vs-gem_close-race)
[537.372275] Starting subtest: export-vs-gem_close-race
[542.474194] Subtest export-vs-gem_close-race: SUCCESS (5.100s)
[542.563479] [128/131] (486s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[542.665478] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[542.669696] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[542.794409] [129/131] (485s left) kms_cursor_edge_walk (64x64-right-edge)
[542.892770] Starting subtest: 64x64-right-edge
[542.895087] Starting dynamic subtest: pipe-A-eDP-1
[546.369719] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[546.379437] Starting dynamic subtest: pipe-D-eDP-1
[549.478503] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[549.480844] Subtest 64x64-right-edge: SUCCESS (6.587s)
[550.318184] [130/131] (478s left) perf_pmu (busy-double-start)
[550.357558] Starting subtest: busy-double-start
[550.359445] Starting dynamic subtest: rcs0
[553.992481] Dynamic subtest rcs0: FAIL (3.569s)
[554.004220] Starting dynamic subtest: bcs0
[557.500142] Dynamic subtest bcs0: SUCCESS (3.574s)
[557.511327] Starting dynamic subtest: vcs0
[562.090216] Dynamic subtest vcs0: SUCCESS (4.587s)
[562.106994] Starting dynamic subtest: vcs1
[566.114083] Dynamic subtest vcs1: SUCCESS (4.021s)
[566.126719] Starting dynamic subtest: vecs0
[570.090030] Dynamic subtest vecs0: SUCCESS (3.973s)
[570.102265] Starting dynamic subtest: ccs0
[573.725243] Dynamic subtest ccs0: FAIL (3.565s)
[573.727463] Subtest busy-double-start: FAIL (23.301s)
[573.787613] [131/131] (455s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[573.890095] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[580.916547] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.030s)
[581.043445] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: prime_busy
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_vblank
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_chamelium_frames
results: parsing output: 9/ for test: gem_ctx_param
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: i915_query
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: gem_exec_big
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: kms_cursor_edge_walk
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: gem_tiled_fence_blits
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: prime_mmap_coherency
results: parsing output: 38/ for test: gem_exec_suspend
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_atomic
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: i915_hangman
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: gem_tiled_wc
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_create
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_wait
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_pm_backlight
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: syncobj_eventfd
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_exec_suspend
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_fb_coherency
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: fbdev
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_getfb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: core_auth
results: parsing output: 106/ for test: gem_exec_parallel
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_rps
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_hdr
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: core_getstats
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: prime_self_import
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_edge_walk
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.