[58.845315] Initializing watchdogs
[58.845359]   /dev/watchdog0
[58.859529] [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]
[58.863946] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.866206] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.869562] [001/133] (960s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[59.007505] Starting subtest: fbc-psr2-cursor-plane-update-sf
[59.009721] Starting dynamic subtest: pipe-A-eDP-1
[59.105263] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[59.114519] Starting dynamic subtest: pipe-B-eDP-1
[60.264650] Dynamic subtest pipe-B-eDP-1: SKIP (1.165s)
[60.268852] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.269s)
[61.447148] [002/133] (957s left) prime_mmap (test_forked)
[61.506594] Starting subtest: test_forked
[61.508571] Starting dynamic subtest: test_forked-smem
[61.543566] Dynamic subtest test_forked-smem: SUCCESS (0.038s)
[61.546234] Subtest test_forked: SUCCESS (0.039s)
[61.648458] [003/133] (957s left) perf (blocking)
[61.774275] Starting subtest: blocking
[61.776140] Starting dynamic subtest: 0-rcs0
[71.790945] Dynamic subtest 0-rcs0: SUCCESS (10.040s)
[71.799119] Starting dynamic subtest: 1-vecs0
[81.805827] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[81.808066] Subtest blocking: SUCCESS (20.062s)
[81.849626] [004/133] (937s left) kms_pipe_crc_basic (suspend-read-crc)
[81.951055] Starting subtest: suspend-read-crc
[81.953473] Starting dynamic subtest: pipe-A-eDP-1
[99.998540] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.769s)
[100.008839] Starting dynamic subtest: pipe-B-eDP-1
[117.960862] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.205s)
[117.970291] Starting dynamic subtest: pipe-C-eDP-1
[135.914017] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.051s)
[135.927577] Starting dynamic subtest: pipe-D-eDP-1
[153.905152] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.055s)
[153.907385] Subtest suspend-read-crc: SUCCESS (12.085s)
[154.738114] [005/133] (864s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[154.861111] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[155.941167] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.093s)
[156.078901] [006/133] (863s left) kms_content_protection (dp-mst-lic-type-0)
[156.218357] Starting subtest: dp-mst-lic-type-0
[156.221855] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[156.331648] [007/133] (863s left) gem_exec_params (no-blt)
[156.387769] Starting subtest: no-blt
[156.391941] Subtest no-blt: SUCCESS (0.003s)
[156.497414] [008/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[156.613106] Starting subtest: basic-flip-before-cursor-varying-size
[157.534667] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.929s)
[158.326865] [009/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[158.436360] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[158.440291] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[158.530161] [010/133] (861s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[158.629281] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[158.631459] Starting dynamic subtest: pipe-A-default-mode
[159.778311] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[159.782599] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.158s)
[159.929640] [011/133] (859s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[160.323138] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[161.141286] [012/133] (858s left) gem_mmap_gtt (basic-write)
[161.197216] Subtest basic-write: SKIP (0.000s)
[161.246290] [013/133] (858s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[161.347365] Starting subtest: psr-rgb101010-draw-mmap-cpu
[168.394920] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.074s)
[168.530378] [014/133] (851s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[168.629889] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[168.634292] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[168.727201] [015/133] (851s left) gem_exec_fence (concurrent)
[168.911828] Starting subtest: concurrent
[168.916006] Subtest concurrent: SKIP (0.000s)
[170.331818] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[170.334945] [016/133] (849s left) gem_softpin (evict-single-offset)
[170.402229] Starting subtest: evict-single-offset
[198.290594] Subtest evict-single-offset: SUCCESS (27.896s)
[198.373290] [017/133] (821s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[198.530273] Starting subtest: plane-ctm3x4-lut1d
[198.664760] Starting dynamic subtest: pipe-A-plane-0
[198.853673] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[198.864013] Starting dynamic subtest: pipe-A-plane-1
[199.031142] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[199.040509] Starting dynamic subtest: pipe-A-plane-2
[199.220573] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s)
[200.422563] Starting dynamic subtest: pipe-B-plane-0
[200.559399] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[200.569549] Starting dynamic subtest: pipe-B-plane-1
[200.703840] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[200.713340] Starting dynamic subtest: pipe-B-plane-2
[200.837124] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[202.060429] Starting dynamic subtest: pipe-C-plane-0
[202.184129] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[202.192991] Starting dynamic subtest: pipe-C-plane-1
[202.328389] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[202.338186] Starting dynamic subtest: pipe-C-plane-2
[202.473148] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[203.690345] Starting dynamic subtest: pipe-D-plane-0
[203.849571] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[203.859179] Starting dynamic subtest: pipe-D-plane-1
[204.005070] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[204.014784] Starting dynamic subtest: pipe-D-plane-2
[204.149663] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[204.459693] Subtest plane-ctm3x4-lut1d: SUCCESS (5.932s)
[205.268646] [018/133] (814s left) kms_pm_backlight (fade)
[205.364446] Starting subtest: fade
[205.438793] Starting dynamic subtest: eDP-1
[208.432284] Dynamic subtest eDP-1: SUCCESS (2.996s)
[208.434493] Subtest fade: SUCCESS (3.070s)
[209.328131] [019/133] (810s left) gem_mmap (big-bo)
[209.383684] Subtest big-bo: SKIP (0.000s)
[209.440186] [020/133] (810s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[209.552468] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[210.516847] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.964s)
[211.370320] [021/133] (808s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[211.462455] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[211.466543] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[211.560943] [022/133] (808s left) kms_pm_rpm (system-suspend-idle)
[213.383207] Starting subtest: system-suspend-idle
[233.584809] Subtest system-suspend-idle: SUCCESS (4.653s)
[233.956906] [023/133] (786s left) fbdev (eof)
[234.016596] Starting subtest: eof
[234.018978] Subtest eof: SUCCESS (0.000s)
[234.087170] [024/133] (786s left) api_intel_allocator (simple-allocator)
[234.152245] Starting subtest: simple-allocator
[234.154805] Starting dynamic subtest: basic
[234.157171] Dynamic subtest basic: SUCCESS (0.003s)
[234.170835] Starting dynamic subtest: parallel-one
[234.334352] Dynamic subtest parallel-one: SUCCESS (0.182s)
[234.346329] Starting dynamic subtest: print
[234.348611] Dynamic subtest print: SUCCESS (0.000s)
[234.357560] Starting dynamic subtest: reuse
[234.359726] Dynamic subtest reuse: SUCCESS (0.000s)
[234.368472] Starting dynamic subtest: reserve
[234.370709] Dynamic subtest reserve: SUCCESS (0.000s)
[234.379602] Starting dynamic subtest: fork-reopen-allocator
[234.381790] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[234.384044] Subtest simple-allocator: SUCCESS (0.200s)
[234.480303] [025/133] (785s left) gem_ctx_persistence (many-contexts)
[234.536869] Starting subtest: many-contexts
[272.142351] Subtest many-contexts: SUCCESS (37.685s)
[272.222844] [026/133] (748s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[272.340524] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[272.931770] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.592s)
[273.097078] [027/133] (747s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[273.189578] Starting subtest: fbc-pr-sprite-mmap-cpu
[273.193662] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[273.275758] [028/133] (747s left) kms_atomic_interruptible (universal-setplane-cursor)
[273.375986] Starting subtest: universal-setplane-cursor
[273.378229] Starting dynamic subtest: pipe-A-eDP-1
[280.754730] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.374s)
[280.756949] Subtest universal-setplane-cursor: SUCCESS (7.375s)
[281.602188] [029/133] (738s left) kms_vblank (query-forked-hang)
[281.711547] Starting subtest: query-forked-hang
[281.713816] Starting dynamic subtest: pipe-A-eDP-1
[309.602529] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.896s)
[309.617435] Starting dynamic subtest: pipe-D-eDP-1
[334.642455] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.042s)
[334.644942] Subtest query-forked-hang: SUCCESS (52.942s)
[335.468478] [030/133] (685s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[335.529374] Starting subtest: invalid-multi-wait-unsubmitted
[335.531596] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[335.628021] [031/133] (684s left) prime_vgem (basic-fence-read)
[335.704723] Starting subtest: basic-fence-read
[335.726026] Subtest basic-fence-read: SKIP (0.021s)
[335.836036] [032/133] (684s left) gem_exec_balancer (noheartbeat)
[336.103136] Starting subtest: noheartbeat
[336.107973] Subtest noheartbeat: SKIP (0.000s)
[336.206850] [033/133] (684s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[336.318302] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[336.320576] Starting dynamic subtest: pipe-A
[336.658019] Dynamic subtest pipe-A: SUCCESS (0.342s)
[336.668535] Starting dynamic subtest: pipe-B
[338.060031] Dynamic subtest pipe-B: SUCCESS (1.401s)
[338.069765] Starting dynamic subtest: pipe-C
[339.467467] Dynamic subtest pipe-C: SUCCESS (1.406s)
[339.476852] Starting dynamic subtest: pipe-D
[340.908598] Dynamic subtest pipe-D: SUCCESS (1.440s)
[340.910781] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.592s)
[342.066558] [034/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[342.162891] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[342.166927] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.271899] [035/133] (678s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[342.390422] Starting subtest: cursorA-vs-flipB-atomic
[342.394975] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[342.535005] [036/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[342.628754] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[349.376344] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.750s)
[349.512195] [037/133] (671s left) gen9_exec_parse (bb-chained)
[349.571718] Subtest bb-chained: SKIP (0.000s)
[349.638326] [038/133] (671s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[349.737386] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[349.739526] Starting dynamic subtest: pipe-A-eDP-1
[349.760804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.771122] Starting dynamic subtest: pipe-B-eDP-1
[349.791691] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.801097] Starting dynamic subtest: pipe-C-eDP-1
[349.821797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.833916] Starting dynamic subtest: pipe-D-eDP-1
[349.855882] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.859933] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[351.976478] [039/133] (668s left) vgem_basic (dmabuf-fence-before)
[352.025182] Starting subtest: dmabuf-fence-before
[352.027293] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[352.097606] [040/133] (668s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[352.184653] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[352.186950] Starting dynamic subtest: pipe-A-eDP-1
[352.209439] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.220389] Starting dynamic subtest: pipe-B-eDP-1
[352.241639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.249993] Starting dynamic subtest: pipe-C-eDP-1
[352.271396] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.280113] Starting dynamic subtest: pipe-D-eDP-1
[352.301723] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.306009] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[354.347831] [041/133] (666s left) gen9_exec_parse (shadow-peek)
[354.419197] Subtest shadow-peek: SKIP (0.000s)
[354.504449] [042/133] (666s left) kms_big_fb (linear-32bpp-rotate-270)
[354.602785] Starting subtest: linear-32bpp-rotate-270
[354.622132] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[354.737120] [043/133] (666s left) syncobj_timeline (wait-all-interrupted)
[354.795843] Starting subtest: wait-all-interrupted
[354.902366] Subtest wait-all-interrupted: SUCCESS (0.106s)
[354.979111] [044/133] (666s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[355.070593] Starting subtest: y-tiled-8bpp-rotate-0
[355.074880] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[355.157166] [045/133] (666s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[355.245872] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[355.248019] Starting dynamic subtest: pipe-A-eDP-1
[355.269948] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.280833] Starting dynamic subtest: pipe-B-eDP-1
[355.301564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.310746] Starting dynamic subtest: pipe-C-eDP-1
[355.332159] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.342860] Starting dynamic subtest: pipe-D-eDP-1
[355.363713] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.367561] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[357.414829] [046/133] (663s left) gem_cs_tlb (engines)
[357.479014] Starting subtest: engines
[357.481176] Starting dynamic subtest: rcs0
[359.634018] Dynamic subtest rcs0: SUCCESS (2.151s)
[359.643809] Starting dynamic subtest: bcs0
[361.785556] Dynamic subtest bcs0: SUCCESS (2.150s)
[361.794569] Starting dynamic subtest: vcs0
[363.938296] Dynamic subtest vcs0: SUCCESS (2.152s)
[363.949694] Starting dynamic subtest: vcs1
[366.090692] Dynamic subtest vcs1: SUCCESS (2.152s)
[366.100533] Starting dynamic subtest: vecs0
[368.244271] Dynamic subtest vecs0: SUCCESS (2.152s)
[368.255936] Starting dynamic subtest: ccs0
[370.398703] Dynamic subtest ccs0: SUCCESS (2.153s)
[370.400779] Subtest engines: SUCCESS (12.917s)
[370.518362] [047/133] (650s left) kms_flip (basic-flip-vs-wf_vblank)
[370.628203] Starting subtest: basic-flip-vs-wf_vblank
[370.630152] Starting dynamic subtest: A-eDP1
[372.559384] Dynamic subtest A-eDP1: SUCCESS (1.932s)
[372.571052] Starting dynamic subtest: B-eDP1
[374.491960] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[374.506466] Starting dynamic subtest: C-eDP1
[376.415216] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[376.426816] Starting dynamic subtest: D-eDP1
[378.341074] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[378.346279] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.721s)
[379.573544] [048/133] (641s left) gem_mmap_offset (open-flood)
[379.637635] Starting subtest: open-flood
[401.122013] Subtest open-flood: SUCCESS (21.490s)
[401.223354] [049/133] (620s left) perf (invalid-remove-userspace-config)
[401.353327] Starting subtest: invalid-remove-userspace-config
[401.360405] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[401.400587] [050/133] (620s left) kms_cursor_legacy (forked-bo)
[401.539175] Starting subtest: forked-bo
[401.541306] Starting dynamic subtest: pipe-A
[407.005945] Dynamic subtest pipe-A: SUCCESS (5.464s)
[407.019437] Starting dynamic subtest: pipe-B
[412.489372] Dynamic subtest pipe-B: SUCCESS (5.483s)
[412.502654] Starting dynamic subtest: pipe-C
[417.986630] Dynamic subtest pipe-C: SUCCESS (5.496s)
[418.002040] Starting dynamic subtest: pipe-D
[423.496295] Dynamic subtest pipe-D: SUCCESS (5.509s)
[423.511728] Starting dynamic subtest: all-pipes
[429.012717] Dynamic subtest all-pipes: SUCCESS (5.516s)
[429.015228] Subtest forked-bo: SUCCESS (27.476s)
[429.175680] [051/133] (592s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[429.231829] Starting subtest: etime-multi-wait-all-for-submit-submitted
[429.332166] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[429.423145] [052/133] (592s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[429.485892] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[429.542225] [053/133] (591s left) gem_exec_params (cliprects_ptr-dirt)
[429.618598] Starting subtest: cliprects_ptr-dirt
[429.620998] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[429.725366] [054/133] (591s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[429.821521] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[429.823786] Starting dynamic subtest: pipe-A-eDP-1
[429.882737] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[429.894027] Starting dynamic subtest: pipe-B-eDP-1
[429.951019] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[429.961481] Starting dynamic subtest: pipe-C-eDP-1
[430.018207] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[430.028120] Starting dynamic subtest: pipe-D-eDP-1
[430.074717] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[430.078314] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[432.115083] [055/133] (589s left) syncobj_timeline (multi-wait-all-signaled)
[432.173356] Starting subtest: multi-wait-all-signaled
[432.175633] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[432.265380] [056/133] (589s left) kms_legacy_colorkey (invalid-plane)
[432.359698] Starting subtest: invalid-plane
[432.361968] Starting dynamic subtest: zero-id
[432.364054] Dynamic subtest zero-id: SUCCESS (0.000s)
[432.373284] Starting dynamic subtest: outrange-id
[432.375478] Dynamic subtest outrange-id: SUCCESS (0.000s)
[432.377293] Subtest invalid-plane: SUCCESS (0.001s)
[432.431798] [057/133] (589s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[432.524708] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[432.537060] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[432.644596] [058/133] (589s left) gem_exec_store (dword)
[432.711335] Starting subtest: dword
[432.713644] Starting dynamic subtest: rcs0
[432.789417] Dynamic subtest rcs0: SUCCESS (0.080s)
[432.801776] Starting dynamic subtest: bcs0
[432.831944] Dynamic subtest bcs0: SUCCESS (0.041s)
[432.843109] Starting dynamic subtest: vcs0
[432.873799] Dynamic subtest vcs0: SUCCESS (0.040s)
[432.884029] Starting dynamic subtest: vcs1
[432.915895] Dynamic subtest vcs1: SUCCESS (0.040s)
[432.926554] Starting dynamic subtest: vecs0
[432.958745] Dynamic subtest vecs0: SUCCESS (0.041s)
[432.972588] Starting dynamic subtest: ccs0
[433.001964] Dynamic subtest ccs0: SUCCESS (0.042s)
[433.004270] Subtest dword: SUCCESS (0.294s)
[433.199397] [059/133] (588s left) gem_render_copy (linear-to-vebox-yf-tiled)
[433.259285] Starting subtest: linear-to-vebox-yf-tiled
[433.263754] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[433.443032] [060/133] (588s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[433.545512] Starting subtest: random-ccs-data-yf-tiled-ccs
[433.547675] Starting dynamic subtest: pipe-A-eDP-1
[433.571726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.581668] Starting dynamic subtest: pipe-B-eDP-1
[433.604087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.612792] Starting dynamic subtest: pipe-C-eDP-1
[433.635145] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[433.643735] Starting dynamic subtest: pipe-D-eDP-1
[433.666319] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[433.670477] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[435.773111] [061/133] (586s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[435.875700] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[435.879669] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[435.986053] [062/133] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[436.086924] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[443.546325] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.464s)
[443.683210] [063/133] (578s left) kms_cursor_crc (cursor-size-hints)
[443.824195] Starting subtest: cursor-size-hints
[443.826693] Starting dynamic subtest: pipe-A-eDP-1
[444.432193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[444.441933] Starting dynamic subtest: pipe-D-eDP-1
[445.657260] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[445.659447] Subtest cursor-size-hints: SUCCESS (1.834s)
[446.461290] [064/133] (575s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[446.583733] Starting subtest: 2x-cursor-vs-flip-atomic
[446.588092] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[446.729632] [065/133] (575s left) gem_exec_schedule (fairslice-all)
[446.803733] Starting subtest: fairslice-all
[448.856352] Subtest fairslice-all: SUCCESS (2.060s)
[450.875118] [066/133] (571s left) gem_mmap_offset (ptrace)
[450.936338] Starting subtest: ptrace
[450.940972] Starting dynamic subtest: smem0-wb
[450.964311] Dynamic subtest smem0-wb: SUCCESS (0.024s)
[450.976083] Starting dynamic subtest: smem0-wc
[450.983268] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[450.992923] Starting dynamic subtest: smem0-uc
[451.003979] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[451.006426] Subtest ptrace: SUCCESS (0.070s)
[451.133339] [067/133] (570s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[451.250390] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[454.937406] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.693s)
[456.086726] [068/133] (566s left) gem_exec_reloc (basic-write-gtt-active)
[456.140978] Subtest basic-write-gtt-active: SKIP (0.000s)
[456.211186] [069/133] (565s left) gem_exec_whisper (basic-sync-all)
[456.290279] Starting subtest: basic-sync-all
[462.947542] Subtest basic-sync-all: SUCCESS (6.655s)
[463.133048] [070/133] (559s left) kms_hdr (static-toggle-suspend)
[463.248469] Starting subtest: static-toggle-suspend
[463.254946] Subtest static-toggle-suspend: SKIP (0.000s)
[463.329025] [071/133] (558s left) kms_flip (flip-vs-fences)
[463.436202] Starting subtest: flip-vs-fences
[463.440392] Subtest flip-vs-fences: SKIP (0.000s)
[463.516733] [072/133] (558s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[463.898544] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[464.682957] [073/133] (557s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[464.775073] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[464.779193] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[464.881254] [074/133] (557s left) kms_busy (extended-modeset-hang-newfb)
[464.979996] Starting subtest: extended-modeset-hang-newfb
[464.981976] Starting dynamic subtest: pipe-A
[499.751558] Dynamic subtest pipe-A: SUCCESS (34.761s)
[499.762857] Starting dynamic subtest: pipe-D
[522.738156] Dynamic subtest pipe-D: SUCCESS (22.982s)
[522.740550] Subtest extended-modeset-hang-newfb: SUCCESS (57.749s)
[523.544864] [075/133] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[523.640727] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[523.645074] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[523.752778] [076/133] (498s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[523.839527] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[523.843720] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[523.913708] [077/133] (498s left) prime_mmap (test_dup)
[523.977018] Starting subtest: test_dup
[523.979007] Starting dynamic subtest: test_dup-smem
[524.005255] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[524.007725] Subtest test_dup: SUCCESS (0.032s)
[524.081085] [078/133] (498s left) kms_dsc (dsc-with-bpc-formats)
[524.182616] Starting subtest: dsc-with-bpc-formats
[524.291006] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[524.332369] [079/133] (498s left) gem_userptr_blits (unsync-unmap)
[524.405234] Subtest unsync-unmap: SKIP (0.000s)
[524.535440] [080/133] (498s left) kms_addfb_basic (unused-offsets)
[524.601418] Starting subtest: unused-offsets
[524.603165] Subtest unused-offsets: SUCCESS (0.000s)
[524.741288] [081/133] (497s left) kms_plane_multiple (2x-tiling-y)
[524.830627] Starting subtest: 2x-tiling-y
[524.834019] Subtest 2x-tiling-y: SKIP (0.000s)
[524.916324] [082/133] (497s left) kms_async_flips (invalid-async-flip-atomic)
[525.002858] Starting subtest: invalid-async-flip-atomic
[525.376889] Starting dynamic subtest: pipe-A-eDP-1
[526.150272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s)
[526.509845] Starting dynamic subtest: pipe-B-eDP-1
[527.285008] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[527.642042] Starting dynamic subtest: pipe-C-eDP-1
[528.390912] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.755s)
[528.753153] Starting dynamic subtest: pipe-D-eDP-1
[529.515816] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[529.518009] Subtest invalid-async-flip-atomic: SUCCESS (4.514s)
[530.678894] [083/133] (492s left) gem_eio (in-flight-internal-10ms)
[530.930495] Starting subtest: in-flight-internal-10ms
[532.861185] Subtest in-flight-internal-10ms: SUCCESS (1.930s)
[533.004566] [084/133] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[533.114816] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[540.322877] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.211s)
[540.464409] [085/133] (482s left) kms_big_fb (x-tiled-addfb)
[540.565750] Starting subtest: x-tiled-addfb
[540.567898] Subtest x-tiled-addfb: SUCCESS (0.000s)
[540.681941] [086/133] (482s left) kms_flip (flip-vs-expired-vblank-interruptible)
[540.783153] Starting subtest: flip-vs-expired-vblank-interruptible
[540.785348] Starting dynamic subtest: A-eDP1
[549.425062] Dynamic subtest A-eDP1: SUCCESS (8.642s)
[549.438765] Starting dynamic subtest: B-eDP1
[558.059984] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[558.075700] Starting dynamic subtest: C-eDP1
[566.670007] Dynamic subtest C-eDP1: SUCCESS (8.608s)
[566.680558] Starting dynamic subtest: D-eDP1
[575.309914] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[575.312271] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.533s)
[576.477001] [087/133] (446s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[576.572587] Starting subtest: yf-tiled-8bpp-rotate-90
[576.577034] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[576.682071] [088/133] (446s left) i915_pm_rpm (gem-idle)
[578.205037] Starting subtest: gem-idle
[584.403960] Subtest gem-idle: SUCCESS (6.200s)
[584.731776] [089/133] (438s left) syncobj_timeline (etime-single-wait-submitted)
[585.805050] Starting subtest: etime-single-wait-submitted
[585.909094] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[585.992477] [090/133] (437s left) kms_selftest (drm_format_helper)
[586.038744] Starting subtest: drm_format_helper
[586.086328] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[586.178875] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.095s)
[586.190405] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[586.270068] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.091s)
[586.282266] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[586.377169] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.106s)
[586.389889] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[586.486111] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.104s)
[586.496934] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[586.585154] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.098s)
[586.596686] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[586.700241] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.115s)
[586.710229] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[586.802814] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.104s)
[586.815018] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[586.907327] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.103s)
[586.919125] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[587.008534] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.098s)
[587.021242] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[587.108868] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.100s)
[587.120553] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[587.220765] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.111s)
[587.231098] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[587.327538] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.103s)
[587.337949] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[587.421454] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s)
[587.434266] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[587.522292] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.100s)
[587.533403] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[587.620048] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.097s)
[587.631015] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[587.728081] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.107s)
[587.739508] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[587.828817] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.099s)
[587.830663] Subtest drm_format_helper: SUCCESS (1.790s)
[587.993830] [091/133] (435s left) kms_pm_backlight (bad-brightness)
[588.089089] Starting subtest: bad-brightness
[588.138144] Starting dynamic subtest: eDP-1
[588.453070] Dynamic subtest eDP-1: SUCCESS (0.312s)
[588.455535] Subtest bad-brightness: SUCCESS (0.363s)
[589.275907] [092/133] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[589.361727] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[589.365970] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[589.486096] [093/133] (433s left) gem_eio (create-ext)
[589.707526] Starting subtest: create-ext
[590.027794] Subtest create-ext: SUCCESS (0.319s)
[590.191211] [094/133] (433s left) i915_power (sanity)
[590.249569] Starting subtest: sanity
[594.291806] Subtest sanity: SUCCESS (4.035s)
[595.961954] [095/133] (427s left) prime_vgem (busy)
[596.035552] Starting subtest: busy
[596.037762] Starting dynamic subtest: rcs0
[596.080604] Dynamic subtest rcs0: SUCCESS (0.045s)
[596.091392] Starting dynamic subtest: bcs0
[596.142689] Dynamic subtest bcs0: SUCCESS (0.061s)
[596.153088] Starting dynamic subtest: vcs0
[596.190239] Dynamic subtest vcs0: SUCCESS (0.047s)
[596.200624] Starting dynamic subtest: vcs1
[596.237308] Dynamic subtest vcs1: SUCCESS (0.046s)
[596.247660] Starting dynamic subtest: vecs0
[596.284107] Dynamic subtest vecs0: SUCCESS (0.046s)
[596.294492] Starting dynamic subtest: ccs0
[596.333417] Dynamic subtest ccs0: SUCCESS (0.048s)
[596.335697] Subtest busy: SUCCESS (0.299s)
[596.466355] [096/133] (426s left) gem_wait (await)
[596.525349] Starting subtest: await
[596.527797] Starting dynamic subtest: all-engines
[597.631122] Dynamic subtest all-engines: SUCCESS (1.106s)
[597.649243] Starting dynamic subtest: rcs0
[598.688961] Dynamic subtest rcs0: SUCCESS (1.055s)
[598.706770] Starting dynamic subtest: bcs0
[599.745373] Dynamic subtest bcs0: SUCCESS (1.055s)
[599.762706] Starting dynamic subtest: vcs0
[600.800252] Dynamic subtest vcs0: SUCCESS (1.052s)
[600.817773] Starting dynamic subtest: vcs1
[601.853942] Dynamic subtest vcs1: SUCCESS (1.052s)
[601.871279] Starting dynamic subtest: vecs0
[602.906768] Dynamic subtest vecs0: SUCCESS (1.051s)
[602.924563] Starting dynamic subtest: ccs0
[603.963690] Dynamic subtest ccs0: SUCCESS (1.054s)
[603.966038] Subtest await: SUCCESS (7.441s)
[604.165124] [097/133] (419s left) gem_mmap_gtt (cpuset-big-copy-xy)
[604.216969] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[604.286162] [098/133] (419s left) kms_rotation_crc (sprite-rotation-90)
[604.379021] Starting subtest: sprite-rotation-90
[604.383474] Subtest sprite-rotation-90: SKIP (0.001s)
[604.470342] [099/133] (419s left) perf (global-sseu-config)
[604.560705] Starting subtest: global-sseu-config
[604.565357] Subtest global-sseu-config: SKIP (0.000s)
[604.609866] [100/133] (418s left) kms_cursor_edge_walk (128x128-right-edge)
[604.707555] Starting subtest: 128x128-right-edge
[604.709883] Starting dynamic subtest: pipe-A-eDP-1
[608.113569] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.409s)
[608.128560] Starting dynamic subtest: pipe-D-eDP-1
[611.239909] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[611.242147] Subtest 128x128-right-edge: SUCCESS (6.536s)
[612.071551] [101/133] (411s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[612.190885] Starting subtest: flip-vs-cursor-crc-atomic
[612.836188] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.646s)
[613.686848] [102/133] (409s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[613.789317] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[620.744943] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.958s)
[620.887150] [103/133] (402s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[620.987595] Starting subtest: fbc-psr2-sprite-plane-onoff
[620.989773] Starting dynamic subtest: eDP-1
[620.993772] Dynamic subtest eDP-1: SKIP (0.000s)
[620.997802] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[621.063172] [104/133] (402s left) gem_ctx_persistence (engines-cleanup)
[621.124554] Starting subtest: engines-cleanup
[621.126447] Starting dynamic subtest: rcs0
[621.198263] Dynamic subtest rcs0: SUCCESS (0.076s)
[621.211223] Starting dynamic subtest: bcs0
[621.259405] Dynamic subtest bcs0: SUCCESS (0.059s)
[621.272775] Starting dynamic subtest: vcs0
[621.305276] Dynamic subtest vcs0: SUCCESS (0.044s)
[621.318355] Starting dynamic subtest: vcs1
[621.353240] Dynamic subtest vcs1: SUCCESS (0.046s)
[621.365395] Starting dynamic subtest: vecs0
[621.374728] Dynamic subtest vecs0: SUCCESS (0.020s)
[621.385259] Starting dynamic subtest: ccs0
[621.462040] Dynamic subtest ccs0: SUCCESS (0.086s)
[621.464575] Subtest engines-cleanup: SUCCESS (0.341s)
[621.568951] [105/133] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[621.683225] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[628.449131] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.771s)
[628.563078] [106/133] (395s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[628.652058] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[628.663316] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[628.752444] [107/133] (395s left) kms_prop_blob (blob-prop-lifetime)
[628.803822] Starting subtest: blob-prop-lifetime
[628.806155] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[628.902695] [108/133] (395s left) gem_exec_reloc (basic-write-read-noreloc)
[628.958551] Subtest basic-write-read-noreloc: SKIP (0.000s)
[629.034883] [109/133] (394s left) perf_pmu (busy-start)
[629.079010] Starting subtest: busy-start
[629.081149] Starting dynamic subtest: rcs0
[631.631041] Dynamic subtest rcs0: SUCCESS (2.553s)
[631.644310] Starting dynamic subtest: bcs0
[634.181958] Dynamic subtest bcs0: SUCCESS (2.549s)
[634.194673] Starting dynamic subtest: vcs0
[637.864783] Dynamic subtest vcs0: SUCCESS (3.680s)
[637.877903] Starting dynamic subtest: vcs1
[641.832788] Dynamic subtest vcs1: SUCCESS (3.966s)
[641.844955] Starting dynamic subtest: vecs0
[645.864389] Dynamic subtest vecs0: SUCCESS (4.030s)
[645.877227] Starting dynamic subtest: ccs0
[648.415019] Dynamic subtest ccs0: SUCCESS (2.549s)
[648.418069] Subtest busy-start: SUCCESS (19.341s)
[648.547783] [110/133] (375s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[648.651449] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[648.655567] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[648.752911] [111/133] (375s left) kms_psr (psr2-primary-render)
[648.848684] Starting subtest: psr2-primary-render
[648.850964] Starting dynamic subtest: eDP-1
[650.545547] Dynamic subtest eDP-1: SUCCESS (1.698s)
[650.547777] Subtest psr2-primary-render: SUCCESS (1.699s)
[651.411456] [112/133] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[651.509239] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[651.513716] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[651.607757] [113/133] (372s left) kms_psr (pr-primary-mmap-cpu)
[651.698930] Starting subtest: pr-primary-mmap-cpu
[651.703304] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[651.774975] [114/133] (372s left) kms_cursor_crc (cursor-onscreen-32x10)
[651.932499] Starting subtest: cursor-onscreen-32x10
[651.990674] Subtest cursor-onscreen-32x10: SKIP (0.052s)
[652.270618] [115/133] (371s left) i915_hangman (detector)
[652.345476] Starting subtest: detector
[652.347328] Starting dynamic subtest: rcs0
[662.856854] Dynamic subtest rcs0: SUCCESS (10.513s)
[662.870186] Starting dynamic subtest: bcs0
[674.824358] Dynamic subtest bcs0: SUCCESS (11.966s)
[674.838210] Starting dynamic subtest: vcs0
[686.792445] Dynamic subtest vcs0: SUCCESS (11.967s)
[686.806231] Starting dynamic subtest: vcs1
[698.758769] Dynamic subtest vcs1: SUCCESS (11.966s)
[698.771977] Starting dynamic subtest: vecs0
[708.744160] Dynamic subtest vecs0: SUCCESS (9.984s)
[708.757864] Starting dynamic subtest: ccs0
[718.856024] Dynamic subtest ccs0: SUCCESS (10.105s)
[718.859101] Subtest detector: SUCCESS (66.519s)
[718.939705] [116/133] (305s left) gem_exec_schedule (semaphore-codependency)
[719.005786] Starting subtest: semaphore-codependency
[719.023104] Subtest semaphore-codependency: SUCCESS (0.021s)
[719.369937] [117/133] (304s left) kms_addfb_basic (unused-handle)
[719.431002] Starting subtest: unused-handle
[719.433261] Subtest unused-handle: SUCCESS (0.000s)
[719.581297] [118/133] (304s left) gem_ringfill (basic-all)
[724.844374] Starting subtest: basic-all
[726.015962] Subtest basic-all: SUCCESS (1.170s)
[726.148404] [119/133] (298s left) kms_psr (fbc-pr-cursor-plane-move)
[726.245721] Starting subtest: fbc-pr-cursor-plane-move
[726.249784] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[726.351769] [120/133] (298s left) kms_async_flips (alternate-sync-async-flip-atomic)
[726.445561] Starting subtest: alternate-sync-async-flip-atomic
[726.816739] Starting dynamic subtest: pipe-A-eDP-1
[729.592621] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.774s)
[729.960876] Starting dynamic subtest: pipe-B-eDP-1
[732.718101] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[733.110640] Starting dynamic subtest: pipe-C-eDP-1
[735.854566] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[736.229628] Starting dynamic subtest: pipe-D-eDP-1
[738.975523] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s)
[738.977621] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.525s)
[740.148356] [121/133] (284s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[740.252193] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[740.256230] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[740.355092] [122/133] (284s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[740.450034] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[740.454110] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[740.552284] [123/133] (284s left) kms_flip (flip-vs-panning-vs-hang)
[740.653803] Starting subtest: flip-vs-panning-vs-hang
[740.656053] Starting dynamic subtest: A-eDP1
[780.307789] Dynamic subtest A-eDP1: SUCCESS (39.642s)
[780.321114] Starting dynamic subtest: D-eDP1
[821.332627] Dynamic subtest D-eDP1: SUCCESS (41.014s)
[821.337925] Subtest flip-vs-panning-vs-hang: SUCCESS (80.664s)
[822.487142] [124/133] (202s left) gem_exec_reloc (basic-cpu-noreloc)
[822.548627] Subtest basic-cpu-noreloc: SKIP (0.000s)
[822.617390] [125/133] (202s left) kms_psr (psr-suspend)
[822.710173] Starting subtest: psr-suspend
[822.712504] Starting dynamic subtest: eDP-1
[840.502463] Dynamic subtest eDP-1: SUCCESS (2.904s)
[840.505227] Subtest psr-suspend: SUCCESS (2.906s)
[841.372396] [126/133] (183s left) gem_exec_schedule (preempt-queue)
[841.464327] Subtest preempt-queue: SKIP (0.000s)
[841.764960] [127/133] (183s left) kms_atomic_interruptible (legacy-pageflip)
[841.854179] Starting subtest: legacy-pageflip
[841.856789] Starting dynamic subtest: pipe-A-eDP-1
[849.302370] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[849.305259] Subtest legacy-pageflip: SUCCESS (7.410s)
[850.175329] [128/133] (174s left) sysfs_preempt_timeout (invalid)
[850.232232] Starting subtest: invalid
[850.234821] Starting dynamic subtest: vecs0
[850.237235] Dynamic subtest vecs0: SUCCESS (0.000s)
[850.248265] Starting dynamic subtest: ccs0
[850.250726] Dynamic subtest ccs0: SUCCESS (0.000s)
[850.261211] Starting dynamic subtest: vcs0
[850.264043] Dynamic subtest vcs0: SUCCESS (0.000s)
[850.274416] Starting dynamic subtest: bcs0
[850.276765] Dynamic subtest bcs0: SUCCESS (0.000s)
[850.287040] Starting dynamic subtest: rcs0
[850.289440] Dynamic subtest rcs0: SUCCESS (0.000s)
[850.299426] Starting dynamic subtest: vcs1
[850.301766] Dynamic subtest vcs1: SUCCESS (0.000s)
[850.304032] Subtest invalid: SUCCESS (0.006s)
[850.344126] [129/133] (174s left) dmabuf_sync_file (export-basic)
[850.393725] Starting subtest: export-basic
[850.396438] Subtest export-basic: SUCCESS (0.001s)
[850.455298] [130/133] (174s left) kms_draw_crc (fill-fb)
[850.553163] Starting subtest: fill-fb
[850.995308] Subtest fill-fb: SUCCESS (0.441s)
[851.092580] [131/133] (173s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[851.153244] Starting subtest: wait-all-for-submit-delayed-submit
[851.256938] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[851.339360] [132/133] (173s left) api_intel_bb (reset-bb)
[851.394992] Starting subtest: reset-bb
[851.399175] Subtest reset-bb: SUCCESS (0.004s)
[851.512923] [133/133] (173s left) gem_exec_fence (syncobj-export)
[851.925076] Starting subtest: syncobj-export
[851.932024] Subtest syncobj-export: SUCCESS (0.006s)
[853.838550] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_content_protection
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_chamelium_edid
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: kms_pm_backlight
results: parsing output: 18/ for test: gem_mmap
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: fbdev
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_atomic_interruptible
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gen9_exec_parse
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_cs_tlb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_pipe_b_c_ivb
results: parsing output: 52/ for test: gem_exec_params
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_legacy_colorkey
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_store
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: kms_hdr
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_busy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_dsc
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_plane_multiple
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: i915_pm_rpm
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_selftest
results: parsing output: 90/ for test: kms_pm_backlight
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: i915_power
results: parsing output: 94/ for test: prime_vgem
results: parsing output: 95/ for test: gem_wait
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: kms_cursor_edge_walk
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: i915_hangman
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: gem_ringfill
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_atomic_interruptible
results: parsing output: 127/ for test: sysfs_preempt_timeout
results: parsing output: 128/ for test: dmabuf_sync_file
results: parsing output: 129/ for test: kms_draw_crc
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: api_intel_bb
results: parsing output: 132/ for test: gem_exec_fence
Done.