[57.717910] Initializing watchdogs
[57.717960]   /dev/watchdog0
[57.732030] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.736155] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.738248] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.741312] [001/155] (960s left) gem_exec_schedule (timeslicing)
[57.827230] Starting subtest: timeslicing
[57.829152] Starting dynamic subtest: rcs0
[57.843348] Dynamic subtest rcs0: SUCCESS (0.024s)
[57.853766] Starting dynamic subtest: bcs0
[57.866788] Dynamic subtest bcs0: SUCCESS (0.024s)
[57.873860] Starting dynamic subtest: vcs0
[57.888879] Dynamic subtest vcs0: SUCCESS (0.022s)
[57.895570] Starting dynamic subtest: vcs1
[57.910453] Dynamic subtest vcs1: SUCCESS (0.021s)
[57.917605] Starting dynamic subtest: vecs0
[57.931315] Dynamic subtest vecs0: SUCCESS (0.022s)
[57.938252] Starting dynamic subtest: ccs0
[57.953468] Dynamic subtest ccs0: SUCCESS (0.022s)
[57.955770] Subtest timeslicing: SUCCESS (0.137s)
[59.376248] [002/155] (958s left) perf_pmu (busy-check-all)
[59.419146] Starting subtest: busy-check-all
[59.421530] Starting dynamic subtest: rcs0
[59.997260] Dynamic subtest rcs0: SUCCESS (0.587s)
[60.006835] Starting dynamic subtest: bcs0
[60.550504] Dynamic subtest bcs0: SUCCESS (0.561s)
[60.560981] Starting dynamic subtest: vcs0
[62.281722] Dynamic subtest vcs0: SUCCESS (1.754s)
[62.292279] Starting dynamic subtest: vcs1
[64.328456] Dynamic subtest vcs1: SUCCESS (2.068s)
[64.338256] Starting dynamic subtest: vecs0
[66.311465] Dynamic subtest vecs0: SUCCESS (1.998s)
[66.321549] Starting dynamic subtest: ccs0
[66.866265] Dynamic subtest ccs0: SUCCESS (0.559s)
[66.868764] Subtest busy-check-all: SUCCESS (7.533s)
[66.973800] [003/155] (951s left) kms_frontbuffer_tracking (psr-suspend)
[67.083076] Starting subtest: psr-suspend
[105.470034] Subtest psr-suspend: SUCCESS (9.173s)
[105.565944] [004/155] (912s left) gem_exec_reloc (basic-gtt-cpu)
[105.620995] Subtest basic-gtt-cpu: SKIP (0.000s)
[105.681852] [005/155] (912s left) gen9_exec_parse (basic-rejected)
[105.734439] Subtest basic-rejected: SKIP (0.000s)
[105.807390] [006/155] (912s left) kms_flip (2x-flip-vs-wf_vblank)
[105.902251] Starting subtest: 2x-flip-vs-wf_vblank
[105.913943] Subtest 2x-flip-vs-wf_vblank: SKIP (0.012s)
[105.988530] [007/155] (912s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[106.078454] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[112.892684] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.992s)
[113.013263] [008/155] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[113.116289] Starting subtest: psr-1p-primscrn-spr-indfb-move
[120.541325] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.502s)
[120.700694] [009/155] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[120.807057] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[120.811447] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[120.897203] [010/155] (897s left) kms_force_connector_basic (prune-stale-modes)
[120.974628] Starting subtest: prune-stale-modes
[121.416060] Subtest prune-stale-modes: SUCCESS (0.445s)
[121.546159] [011/155] (897s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[121.645151] Starting subtest: 4-tiled-32bpp-rotate-0
[122.984787] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.346s)
[123.116155] [012/155] (895s left) gem_partial_pwrite_pread (write-snoop)
[123.184478] Subtest write-snoop: SKIP (0.000s)
[123.240225] [013/155] (895s left) api_intel_allocator (reopen-fork)
[123.287377] Starting subtest: reopen-fork
[126.580354] Subtest reopen-fork: SUCCESS (3.305s)
[126.659278] [014/155] (892s left) kms_psr (fbc-pr-primary-render)
[126.764534] Starting subtest: fbc-pr-primary-render
[126.768943] Subtest fbc-pr-primary-render: SKIP (0.000s)
[126.836093] [015/155] (891s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[126.938678] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[126.941051] Starting dynamic subtest: pipe-A-eDP-1
[126.964065] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[126.974886] Starting dynamic subtest: pipe-B-eDP-1
[126.996488] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[127.004305] Starting dynamic subtest: pipe-C-eDP-1
[127.025554] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[127.033338] Starting dynamic subtest: pipe-D-eDP-1
[127.054838] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[127.059151] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[129.412442] [016/155] (889s left) gem_ctx_shared (q-in-order)
[129.479250] Starting subtest: Q-in-order
[129.481528] Starting dynamic subtest: rcs0
[129.614479] Dynamic subtest rcs0: SUCCESS (0.134s)
[129.632928] Starting dynamic subtest: vcs0
[129.692866] Dynamic subtest vcs0: SUCCESS (0.079s)
[129.709644] Starting dynamic subtest: vcs1
[129.770236] Dynamic subtest vcs1: SUCCESS (0.076s)
[129.786154] Starting dynamic subtest: vecs0
[129.845162] Dynamic subtest vecs0: SUCCESS (0.074s)
[129.861004] Starting dynamic subtest: ccs0
[129.926153] Dynamic subtest ccs0: SUCCESS (0.082s)
[129.928685] Subtest Q-in-order: SUCCESS (0.447s)
[131.685505] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[131.688506] [017/155] (887s left) kms_flip (absolute-wf_vblank)
[131.780159] Starting subtest: absolute-wf_vblank
[131.782581] Starting dynamic subtest: A-eDP1
[140.560838] Dynamic subtest A-eDP1: SUCCESS (8.776s)
[140.571304] Starting dynamic subtest: B-eDP1
[149.301218] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[149.312442] Starting dynamic subtest: C-eDP1
[158.024433] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[158.034861] Starting dynamic subtest: D-eDP1
[166.753967] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[166.756487] Subtest absolute-wf_vblank: SUCCESS (34.959s)
[167.964712] [018/155] (850s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[168.086074] Starting subtest: short-flip-before-cursor-toggle
[169.004458] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s)
[169.809130] [019/155] (849s left) gem_exec_fence (concurrent)
[169.981420] Starting subtest: concurrent
[169.986142] Subtest concurrent: SKIP (0.000s)
[171.648385] [020/155] (847s left) gem_exec_balancer (busy)
[171.706762] Starting subtest: busy
[173.635595] Subtest busy: SUCCESS (1.927s)
[173.972480] [021/155] (845s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[174.036460] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[174.144165] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[174.220633] [022/155] (844s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[174.280330] Starting subtest: single-wait-for-submit-available-submitted
[174.282643] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[174.370635] [023/155] (844s left) sw_sync (sync_expired_merge)
[174.413919] Starting subtest: sync_expired_merge
[175.487740] Subtest sync_expired_merge: SUCCESS (1.074s)
[175.550004] [024/155] (843s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[175.657648] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[175.661785] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[175.739395] [025/155] (843s left) kms_chamelium_frames (vga-frame-dump)
[176.115460] Subtest vga-frame-dump: SKIP (0.000s)
[176.917316] [026/155] (842s left) kms_fbcon_fbt (psr-suspend)
[176.977284] Starting subtest: psr-suspend
[226.964977] Subtest psr-suspend: SUCCESS (19.941s)
[227.036687] [027/155] (792s left) gem_flink_race (flink_close)
[227.077017] Starting subtest: flink_close
[232.168928] Subtest flink_close: SUCCESS (5.209s)
[232.243197] [028/155] (787s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[232.363595] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[232.367771] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[232.486736] [029/155] (786s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[232.596882] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[232.601291] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[232.673673] [030/155] (786s left) gem_basic (create-fd-close)
[232.749133] Starting subtest: create-fd-close
[232.753669] Subtest create-fd-close: SUCCESS (0.000s)
[232.847638] [031/155] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[232.947387] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[232.951434] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[233.048155] [032/155] (786s left) gem_exec_schedule (preempt)
[233.116633] Starting subtest: preempt
[233.118379] Starting dynamic subtest: rcs0
[233.130768] Dynamic subtest rcs0: SUCCESS (0.022s)
[233.143686] Starting dynamic subtest: bcs0
[233.157938] Dynamic subtest bcs0: SUCCESS (0.027s)
[233.170694] Starting dynamic subtest: vcs0
[233.177620] Dynamic subtest vcs0: SUCCESS (0.020s)
[233.185981] Starting dynamic subtest: vcs1
[233.203264] Dynamic subtest vcs1: SUCCESS (0.025s)
[233.211743] Starting dynamic subtest: vecs0
[233.222181] Dynamic subtest vecs0: SUCCESS (0.019s)
[233.230694] Starting dynamic subtest: ccs0
[233.254342] Dynamic subtest ccs0: SUCCESS (0.032s)
[233.256363] Subtest preempt: SUCCESS (0.148s)
[235.076790] [033/155] (784s left) prime_mmap (test_aperture_limit)
[235.134826] Starting subtest: test_aperture_limit
[235.137223] Starting dynamic subtest: test_aperture_limit-smem
[235.146797] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[235.151236] Subtest test_aperture_limit: SKIP (0.011s)
[235.227507] [034/155] (784s left) kms_prop_blob (basic)
[235.300518] Starting subtest: basic
[235.302577] Subtest basic: SUCCESS (0.000s)
[235.429392] [035/155] (784s left) kms_psr (pr-cursor-mmap-gtt)
[235.529959] Starting subtest: pr-cursor-mmap-gtt
[235.534084] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[235.600078] [036/155] (784s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[235.689694] Starting subtest: yf-tiled-16bpp-rotate-270
[235.694064] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[235.797314] [037/155] (783s left) kms_flip (modeset-vs-vblank-race-interruptible)
[235.886835] Starting subtest: modeset-vs-vblank-race-interruptible
[235.889048] Starting dynamic subtest: A-eDP1
[240.553070] Dynamic subtest A-eDP1: SUCCESS (4.700s)
[240.565402] Starting dynamic subtest: B-eDP1
[245.187671] Dynamic subtest B-eDP1: SUCCESS (4.651s)
[245.199403] Starting dynamic subtest: C-eDP1
[249.717663] Dynamic subtest C-eDP1: SUCCESS (4.539s)
[249.726450] Starting dynamic subtest: D-eDP1
[254.331071] Dynamic subtest D-eDP1: SUCCESS (4.620s)
[254.336358] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.523s)
[255.486207] [038/155] (764s left) core_getversion (all-cards)
[255.532657] Starting subtest: all-cards
[255.541456] Subtest all-cards: SUCCESS (0.011s)
[255.585996] [039/155] (764s left) gem_vm_create (create-ext)
[255.659769] Starting subtest: create-ext
[255.662121] Subtest create-ext: SUCCESS (0.005s)
[255.826367] [040/155] (764s left) gem_exec_flush (basic-uc-set-default)
[255.886819] Starting subtest: basic-uc-set-default
[261.345389] Subtest basic-uc-set-default: SUCCESS (5.457s)
[261.542637] [041/155] (758s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[261.631421] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[261.635907] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[262.738529] [042/155] (757s left) kms_invalid_mode (uint-max-clock)
[262.841534] Starting subtest: uint-max-clock
[262.843721] Starting dynamic subtest: pipe-A-eDP-1
[263.123448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[263.133898] Starting dynamic subtest: pipe-B-eDP-1
[263.135846] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[263.144954] Starting dynamic subtest: pipe-C-eDP-1
[263.147170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[263.156094] Starting dynamic subtest: pipe-D-eDP-1
[263.158467] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[263.160754] Subtest uint-max-clock: SUCCESS (0.288s)
[263.956132] [043/155] (756s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[264.049739] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[264.053959] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[264.147422] [044/155] (755s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[264.243572] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[264.248027] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.343853] [045/155] (755s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[264.445125] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[264.449473] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[264.550987] [046/155] (755s left) kms_cursor_crc (cursor-sliding-512x170)
[264.832529] Starting subtest: cursor-sliding-512x170
[264.836643] Subtest cursor-sliding-512x170: SKIP (0.001s)
[264.960473] [047/155] (755s left) kms_psr (fbc-psr-primary-blt)
[265.055159] Starting subtest: fbc-psr-primary-blt
[265.056987] Starting dynamic subtest: eDP-1
[265.060317] Dynamic subtest eDP-1: SKIP (0.000s)
[265.063579] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[265.139670] [048/155] (755s left) gem_exec_fence (submit)
[265.325506] Starting subtest: submit
[265.329751] Subtest submit: SKIP (0.000s)
[267.059891] [049/155] (753s left) gem_create (create-size-update)
[267.112589] Starting subtest: create-size-update
[267.114960] Subtest create-size-update: SUCCESS (0.000s)
[267.327589] [050/155] (752s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[267.430091] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[267.433990] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[267.530565] [051/155] (752s left) kms_plane (pixel-format-x-tiled-modifier)
[267.618746] Starting subtest: pixel-format-x-tiled-modifier
[267.645114] Starting dynamic subtest: pipe-A-plane-0
[268.289075] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[268.300118] Starting dynamic subtest: pipe-A-plane-3
[268.689113] Dynamic subtest pipe-A-plane-3: SUCCESS (0.398s)
[268.698069] Starting dynamic subtest: pipe-A-plane-5
[268.701569] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[269.837325] Starting dynamic subtest: pipe-B-plane-0
[270.462760] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[270.472911] Starting dynamic subtest: pipe-B-plane-3
[270.862643] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s)
[270.872287] Starting dynamic subtest: pipe-B-plane-5
[270.876307] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[271.186662] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.568s)
[272.031043] [052/155] (748s left) kms_plane_cursor (overlay)
[272.132591] Starting subtest: overlay
[272.136863] Starting dynamic subtest: pipe-A-eDP-1-size-64
[274.538520] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.407s)
[274.599611] Starting dynamic subtest: pipe-A-eDP-1-size-128
[276.975938] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.383s)
[277.033951] Starting dynamic subtest: pipe-A-eDP-1-size-256
[279.429635] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.405s)
[279.787211] Starting dynamic subtest: pipe-B-eDP-1-size-64
[283.002356] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.228s)
[283.062501] Starting dynamic subtest: pipe-B-eDP-1-size-128
[285.480559] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s)
[285.544237] Starting dynamic subtest: pipe-B-eDP-1-size-256
[288.004541] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.471s)
[288.354523] Starting dynamic subtest: pipe-C-eDP-1-size-64
[291.120300] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.776s)
[291.157716] Starting dynamic subtest: pipe-C-eDP-1-size-128
[293.208181] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.058s)
[293.249123] Starting dynamic subtest: pipe-C-eDP-1-size-256
[295.297941] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.058s)
[295.628635] Starting dynamic subtest: pipe-D-eDP-1-size-64
[298.326470] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.709s)
[298.363043] Starting dynamic subtest: pipe-D-eDP-1-size-128
[300.359585] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.003s)
[300.397267] Starting dynamic subtest: pipe-D-eDP-1-size-256
[302.436354] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.048s)
[302.758345] Subtest overlay: SUCCESS (30.630s)
[303.556788] [053/155] (716s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[303.662612] Starting subtest: extended-modeset-hang-newfb-with-reset
[303.664816] Starting dynamic subtest: pipe-A
[319.168971] Dynamic subtest pipe-A: SUCCESS (15.510s)
[319.179546] Starting dynamic subtest: pipe-D
[334.664264] Dynamic subtest pipe-D: SUCCESS (15.491s)
[334.666704] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.005s)
[335.466179] [054/155] (684s left) kms_color_pipeline (plane-lut1d-lut1d)
[335.572311] Starting subtest: plane-lut1d-lut1d
[335.706706] Starting dynamic subtest: pipe-A-plane-0
[335.851013] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[335.861532] Starting dynamic subtest: pipe-A-plane-1
[335.995430] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[336.005464] Starting dynamic subtest: pipe-A-plane-2
[336.139922] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[337.380505] Starting dynamic subtest: pipe-B-plane-0
[337.522378] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[337.532388] Starting dynamic subtest: pipe-B-plane-1
[337.656282] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[337.672753] Starting dynamic subtest: pipe-B-plane-2
[337.845009] Dynamic subtest pipe-B-plane-2: SUCCESS (0.186s)
[338.993883] Starting dynamic subtest: pipe-C-plane-0
[339.130130] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[339.140166] Starting dynamic subtest: pipe-C-plane-1
[339.263511] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[339.273541] Starting dynamic subtest: pipe-C-plane-2
[339.407964] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[340.622299] Starting dynamic subtest: pipe-D-plane-0
[340.778448] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[340.788715] Starting dynamic subtest: pipe-D-plane-1
[340.911968] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[340.921438] Starting dynamic subtest: pipe-D-plane-2
[341.045209] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[341.335006] Subtest plane-lut1d-lut1d: SUCCESS (5.764s)
[342.208283] [055/155] (678s left) gem_ctx_persistence (hostile)
[342.266019] Starting subtest: hostile
[352.423436] Subtest hostile: SUCCESS (10.152s)
[352.583045] [056/155] (667s left) kms_flip (wf_vblank-ts-check-interruptible)
[352.688894] Starting subtest: wf_vblank-ts-check-interruptible
[352.691214] Starting dynamic subtest: A-eDP1
[361.557217] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[361.567528] Starting dynamic subtest: B-eDP1
[370.493149] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[370.507061] Starting dynamic subtest: C-eDP1
[379.417038] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[379.426734] Starting dynamic subtest: D-eDP1
[388.337888] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[388.343930] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.659s)
[389.573707] [057/155] (631s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[389.668154] Starting subtest: random-ccs-data-y-tiled-ccs
[389.670419] Starting dynamic subtest: pipe-A-eDP-1
[389.695210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.710305] Starting dynamic subtest: pipe-B-eDP-1
[389.732833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.742731] Starting dynamic subtest: pipe-C-eDP-1
[389.765092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.776869] Starting dynamic subtest: pipe-D-eDP-1
[389.800555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.804851] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[391.927805] [058/155] (628s left) api_intel_bb (object-reloc-keep-cache)
[391.984017] Starting subtest: object-reloc-keep-cache
[391.988552] Subtest object-reloc-keep-cache: SKIP (0.002s)
[392.109015] [059/155] (628s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[392.202018] Starting subtest: fbc-psr2-cursor-plane-update-sf
[392.204452] Starting dynamic subtest: pipe-A-eDP-1
[392.273787] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[392.285579] Starting dynamic subtest: pipe-B-eDP-1
[393.407675] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[393.411980] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.211s)
[394.628409] [060/155] (626s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[394.742439] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[394.746876] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[394.836740] [061/155] (625s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[394.937632] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[394.941779] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[395.037233] [062/155] (625s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[395.147987] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[395.152117] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[395.246629] [063/155] (625s left) gem_exec_whisper (basic-fds-forked-all)
[395.310334] Starting subtest: basic-fds-forked-all
[416.924971] Subtest basic-fds-forked-all: SUCCESS (21.617s)
[417.112221] [064/155] (603s left) gem_mmap_gtt (cpuset-big-copy-xy)
[417.162437] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[417.227231] [065/155] (603s left) i915_drm_fdinfo (memory-info-active)
[417.272316] Starting subtest: memory-info-active
[417.274963] Starting dynamic subtest: smem0
[419.710112] Dynamic subtest smem0: SUCCESS (2.440s)
[419.712292] Subtest memory-info-active: SUCCESS (2.441s)
[419.783100] [066/155] (601s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[419.878282] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[419.881793] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[419.978092] [067/155] (601s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[420.037750] Starting subtest: framebuffer-vs-set-tiling
[420.041301] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[420.180872] [068/155] (600s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[420.248777] Starting subtest: multi-wait-all-for-submit-signaled
[420.250844] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[420.358968] [069/155] (600s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[420.440357] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[420.444017] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[420.510954] [070/155] (600s left) perf_pmu (faulting-read)
[420.549036] Starting subtest: faulting-read
[420.551110] Starting dynamic subtest: wb
[420.553192] Dynamic subtest wb: SUCCESS (0.001s)
[420.563197] Starting dynamic subtest: wc
[420.565029] Dynamic subtest wc: SUCCESS (0.000s)
[420.573859] Starting dynamic subtest: uc
[420.575663] Dynamic subtest uc: SUCCESS (0.000s)
[420.577478] Subtest faulting-read: SUCCESS (0.003s)
[420.656644] [071/155] (600s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[420.741658] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[420.745182] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[420.864944] [072/155] (600s left) prime_busy (before)
[420.925277] Starting subtest: before
[420.927320] Starting dynamic subtest: rcs0
[420.957551] Dynamic subtest rcs0: SUCCESS (0.031s)
[420.968635] Starting dynamic subtest: bcs0
[421.014778] Dynamic subtest bcs0: SUCCESS (0.055s)
[421.026496] Starting dynamic subtest: vcs0
[421.055178] Dynamic subtest vcs0: SUCCESS (0.039s)
[421.066261] Starting dynamic subtest: vcs1
[421.096908] Dynamic subtest vcs1: SUCCESS (0.041s)
[421.106876] Starting dynamic subtest: vecs0
[421.139314] Dynamic subtest vecs0: SUCCESS (0.041s)
[421.151043] Starting dynamic subtest: ccs0
[421.178519] Dynamic subtest ccs0: SUCCESS (0.038s)
[421.287378] Subtest before: SUCCESS (0.362s)
[421.369473] [073/155] (599s left) i915_pm_rpm (reg-read-ioctl)
[423.220872] Starting subtest: reg-read-ioctl
[425.523042] Subtest reg-read-ioctl: SUCCESS (2.307s)
[425.894590] [074/155] (595s left) kms_chamelium_edid (dp-mode-timings)
[426.281667] Subtest dp-mode-timings: SKIP (0.000s)
[427.125830] [075/155] (594s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[427.219975] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[427.224299] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[427.322184] [076/155] (594s left) kms_plane_scaling (planes-downscale-factor-0-5)
[427.412676] Starting subtest: planes-downscale-factor-0-5
[427.414927] Starting dynamic subtest: pipe-A
[427.432443] Dynamic subtest pipe-A: SKIP (0.016s)
[427.442867] Starting dynamic subtest: pipe-B
[427.463640] Dynamic subtest pipe-B: SKIP (0.029s)
[427.477095] Starting dynamic subtest: pipe-C
[427.492154] Dynamic subtest pipe-C: SKIP (0.029s)
[427.502138] Starting dynamic subtest: pipe-D
[427.521878] Dynamic subtest pipe-D: SKIP (0.029s)
[427.525593] Subtest planes-downscale-factor-0-5: SKIP (0.105s)
[427.634466] [077/155] (593s left) i915_getparams_basic (basic-subslice-total)
[427.687294] Starting subtest: basic-subslice-total
[427.691827] Subtest basic-subslice-total: SUCCESS (0.000s)
[427.786137] [078/155] (593s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc)
[427.905284] Starting subtest: psrhdr-rgb565-draw-mmap-wc
[427.909427] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[428.012059] [079/155] (593s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[428.112666] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[428.116265] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[428.207522] [080/155] (593s left) gem_softpin (allocator-basic-reserve)
[428.257775] Starting subtest: allocator-basic-reserve
[428.323385] Subtest allocator-basic-reserve: SUCCESS (0.066s)
[428.459599] [081/155] (593s left) kms_lease (implicit-plane-lease)
[428.542263] Starting subtest: implicit-plane-lease
[428.544291] Subtest implicit-plane-lease: SUCCESS (0.002s)
[428.690720] [082/155] (592s left) gem_exercise_blt (fast-copy-emit)
[428.741634] Starting subtest: fast-copy-emit
[428.743527] Starting dynamic subtest: linear-smem-smem-emit
[428.763266] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[428.773568] Starting dynamic subtest: xmajor-smem-smem-emit
[428.780166] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[428.789775] Starting dynamic subtest: tile4-smem-smem-emit
[428.796348] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[428.805283] Starting dynamic subtest: tile64-smem-smem-emit
[428.813357] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[428.815376] Subtest fast-copy-emit: SUCCESS (0.072s)
[428.921446] [083/155] (592s left) syncobj_timeline (reset-unsignaled)
[428.984435] Starting subtest: reset-unsignaled
[428.986397] Subtest reset-unsignaled: SUCCESS (0.000s)
[429.102023] [084/155] (592s left) gem_tiled_pread_pwrite
[429.234410] [085/155] (592s left) kms_dsc (dsc-with-output-formats-with-bpc)
[429.325621] Starting subtest: dsc-with-output-formats-with-bpc
[429.371007] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[429.406448] [086/155] (592s left) kms_tiled_display (basic-test-pattern)
[429.520523] Subtest basic-test-pattern: SKIP (0.000s)
[429.567008] [087/155] (592s left) gem_userptr_blits (create-destroy-sync)
[429.628739] Starting subtest: create-destroy-sync
[434.647575] Subtest create-destroy-sync: SUCCESS (5.019s)
[434.777627] [088/155] (587s left) gem_render_copy (yf-tiled-to-vebox-linear)
[434.831229] Starting subtest: yf-tiled-to-vebox-linear
[434.835772] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[435.016309] [089/155] (586s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[435.111580] Starting subtest: fbc-dirtyfb-ioctl
[435.113735] Starting dynamic subtest: A-eDP-1
[437.714781] Dynamic subtest A-eDP-1: SUCCESS (2.603s)
[437.717074] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.604s)
[438.657265] [090/155] (583s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[438.768138] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[438.770462] Starting dynamic subtest: pipe-A-eDP-1
[438.791333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[438.803562] Starting dynamic subtest: pipe-B-eDP-1
[438.823017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[438.832210] Starting dynamic subtest: pipe-C-eDP-1
[438.851539] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[438.860771] Starting dynamic subtest: pipe-D-eDP-1
[438.880208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[438.882108] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[440.960755] [091/155] (581s left) syncobj_basic (bad-create-flags)
[441.021533] Starting subtest: bad-create-flags
[441.023875] Subtest bad-create-flags: SUCCESS (0.000s)
[441.171616] [092/155] (581s left) prime_vgem (basic-gtt)
[441.250775] Starting subtest: basic-gtt
[441.255420] Subtest basic-gtt: SKIP (0.000s)
[441.358626] [093/155] (580s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[441.460676] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[441.465035] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[441.558254] [094/155] (580s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[441.665442] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite
[441.669903] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[441.765510] [095/155] (580s left) kms_content_protection (dp-mst-lic-type-1)
[441.922526] Starting subtest: dp-mst-lic-type-1
[441.926750] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[442.044802] [096/155] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[442.149364] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[442.152764] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[442.241535] [097/155] (580s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render)
[442.332901] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render
[442.336225] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[442.425763] [098/155] (580s left) kms_cursor_crc (cursor-offscreen-64x21)
[442.641889] Starting subtest: cursor-offscreen-64x21
[442.688521] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[442.977567] [099/155] (579s left) drm_read (fault-buffer)
[443.137226] Starting subtest: fault-buffer
[443.139203] Subtest fault-buffer: SUCCESS (0.000s)
[443.271762] [100/155] (579s left) gem_pxp (reject-modify-context-protection-off-1)
[443.413233] Starting subtest: reject-modify-context-protection-off-1
[443.415309] Subtest reject-modify-context-protection-off-1: SUCCESS (0.003s)
[443.530595] [101/155] (579s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[443.625343] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[443.628433] Starting dynamic subtest: pipe-A
[443.645441] Dynamic subtest pipe-A: SKIP (0.017s)
[443.656255] Starting dynamic subtest: pipe-B
[443.674629] Dynamic subtest pipe-B: SKIP (0.031s)
[443.684263] Starting dynamic subtest: pipe-C
[443.704379] Dynamic subtest pipe-C: SKIP (0.029s)
[443.714052] Starting dynamic subtest: pipe-D
[443.733900] Dynamic subtest pipe-D: SKIP (0.029s)
[443.737067] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.109s)
[443.823282] [102/155] (578s left) gem_mmap_gtt (isolation)
[443.876554] Subtest isolation: SKIP (0.000s)
[443.942301] [103/155] (578s left) gem_ctx_isolation (dirty-create)
[443.987805] Starting subtest: dirty-create
[443.989747] Starting dynamic subtest: rcs0
[444.191939] Dynamic subtest rcs0: SUCCESS (0.204s)
[444.204115] Starting dynamic subtest: bcs0
[444.414622] Dynamic subtest bcs0: SUCCESS (0.222s)
[444.424918] Starting dynamic subtest: vcs0
[444.653680] Dynamic subtest vcs0: SUCCESS (0.238s)
[444.663130] Starting dynamic subtest: vcs1
[446.188036] Dynamic subtest vcs1: SUCCESS (1.533s)
[446.198061] Starting dynamic subtest: vecs0
[448.226059] Dynamic subtest vecs0: SUCCESS (2.038s)
[448.236762] Starting dynamic subtest: ccs0
[450.193352] Dynamic subtest ccs0: SUCCESS (1.967s)
[450.195872] Subtest dirty-create: SUCCESS (6.207s)
[450.431156] [104/155] (572s left) kms_big_fb (linear-32bpp-rotate-0)
[450.529789] Starting subtest: linear-32bpp-rotate-0
[452.109365] Subtest linear-32bpp-rotate-0: SUCCESS (1.578s)
[452.221412] [105/155] (570s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[452.314393] Starting subtest: pr-plane-move-sf-dmg-area
[452.317718] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[452.382104] [106/155] (570s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[452.476276] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[452.479629] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[452.569793] [107/155] (570s left) kms_cursor_crc (cursor-sliding-128x42)
[452.794278] Starting subtest: cursor-sliding-128x42
[452.840190] Subtest cursor-sliding-128x42: SKIP (0.042s)
[453.047091] [108/155] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[453.142503] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[453.146027] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[453.238022] [109/155] (569s left) syncobj_wait (wait-all-for-submit-snapshot)
[453.293094] Starting subtest: wait-all-for-submit-snapshot
[453.374043] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[453.461630] [110/155] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[453.555310] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[453.558593] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[453.646790] [111/155] (569s left) gem_exec_reloc (basic-write-read)
[453.698607] Subtest basic-write-read: SKIP (0.000s)
[453.771509] [112/155] (569s left) kms_psr (fbc-psr2-primary-page-flip)
[453.862069] Starting subtest: fbc-psr2-primary-page-flip
[453.863975] Starting dynamic subtest: eDP-1
[453.867526] Dynamic subtest eDP-1: SKIP (0.000s)
[453.871056] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[453.939146] [113/155] (569s left) kms_plane_multiple (tiling-y)
[454.039975] Starting subtest: tiling-y
[454.043251] Subtest tiling-y: SKIP (0.000s)
[454.111208] [114/155] (568s left) gem_tiling_max_stride
[454.215128] [115/155] (568s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[454.301670] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[454.305024] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[454.392257] [116/155] (568s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[454.483028] Starting subtest: yf-tiled-8bpp-rotate-180
[454.486628] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[454.581109] [117/155] (568s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[454.714783] Starting subtest: basic-flip-before-cursor-atomic
[455.656517] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.940s)
[456.503694] [118/155] (566s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[456.609002] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[456.613464] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[456.724495] [119/155] (566s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[456.826081] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[456.829939] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[456.922004] [120/155] (566s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[457.026221] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[457.030504] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[457.117336] [121/155] (566s left) kms_atomic_transition (modeset-transition)
[457.210834] Starting subtest: modeset-transition
[457.212949] Starting dynamic subtest: 1x-outputs
[468.041851] Dynamic subtest 1x-outputs: SUCCESS (10.826s)
[468.044532] Subtest modeset-transition: SUCCESS (10.828s)
[468.902226] [122/155] (554s left) kms_async_flips (async-flip-suspend-resume)
[468.993106] Starting subtest: async-flip-suspend-resume
[469.372391] Starting dynamic subtest: pipe-A-eDP-1
[487.968037] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.980s)
[488.354847] Starting dynamic subtest: pipe-B-eDP-1
[505.956646] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.909s)
[506.342196] Starting dynamic subtest: pipe-C-eDP-1
[523.940143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.906s)
[524.314050] Starting dynamic subtest: pipe-D-eDP-1
[541.972148] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.944s)
[541.974489] Subtest async-flip-suspend-resume: SUCCESS (13.267s)
[543.109245] [123/155] (480s left) syncobj_wait (invalid-reset-zero-handles)
[543.169915] Starting subtest: invalid-reset-zero-handles
[543.172267] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[543.295413] [124/155] (480s left) kms_flip (2x-nonexisting-fb-interruptible)
[543.382987] Starting subtest: 2x-nonexisting-fb-interruptible
[543.407507] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.023s)
[543.491096] [125/155] (480s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[543.592333] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[544.541259] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[544.660937] [126/155] (478s left) prime_mmap (test_forked)
[544.714656] Starting subtest: test_forked
[544.716574] Starting dynamic subtest: test_forked-smem
[544.756459] Dynamic subtest test_forked-smem: SUCCESS (0.046s)
[544.758744] Subtest test_forked: SUCCESS (0.046s)
[544.865149] [127/155] (478s left) kms_psr (psr2-suspend)
[544.960483] Starting subtest: psr2-suspend
[544.962323] Starting dynamic subtest: eDP-1
[563.352866] Dynamic subtest eDP-1: SUCCESS (2.880s)
[563.355297] Subtest psr2-suspend: SUCCESS (2.881s)
[564.142103] [128/155] (459s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[564.241673] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[564.247572] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[564.317125] [129/155] (459s left) vgem_basic (mmap)
[564.366340] Starting subtest: mmap
[564.415126] Subtest mmap: SUCCESS (0.052s)
[564.493940] [130/155] (459s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[564.588098] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[564.592607] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[564.688293] [131/155] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[564.793033] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[571.607444] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.901s)
[571.781861] [132/155] (452s left) i915_pm_sseu (full-enable)
[571.852504] Subtest full-enable: SKIP (0.000s)
[571.938479] [133/155] (451s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[571.990605] Subtest no-spare-fences-busy: SKIP (0.000s)
[572.056213] [134/155] (451s left) gem_ccs (ctrl-surf-copy-new-ctx)
[572.113801] Starting subtest: ctrl-surf-copy-new-ctx
[572.119540] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[572.218260] [135/155] (451s left) kms_addfb_basic (addfb25-bad-modifier)
[572.310682] Starting subtest: addfb25-bad-modifier
[572.313233] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[572.400083] [136/155] (451s left) kms_properties (plane-properties-legacy)
[572.489644] Starting subtest: plane-properties-legacy
[572.492351] Starting dynamic subtest: pipe-A-eDP-1
[573.047660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[573.058778] Starting dynamic subtest: pipe-B-eDP-1
[574.362895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s)
[574.373329] Starting dynamic subtest: pipe-C-eDP-1
[575.596115] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[575.607871] Starting dynamic subtest: pipe-D-eDP-1
[576.833244] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[576.835642] Subtest plane-properties-legacy: SUCCESS (4.366s)
[577.626283] [137/155] (446s left) kms_pm_dc (dc5-dpms-negative)
[578.726888] Starting subtest: dc5-dpms-negative
[578.732246] Subtest dc5-dpms-negative: SKIP (0.000s)
[578.848031] [138/155] (445s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[578.958284] Starting subtest: psr-indfb-scaledprimary
[584.636300] Subtest psr-indfb-scaledprimary: SUCCESS (5.697s)
[584.760965] [139/155] (439s left) kms_vblank (ts-continuation-idle)
[584.851591] Starting subtest: ts-continuation-idle
[584.853898] Starting dynamic subtest: pipe-A-eDP-1
[585.246310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[585.265933] Starting dynamic subtest: pipe-D-eDP-1
[586.330347] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.082s)
[586.332904] Subtest ts-continuation-idle: SUCCESS (1.483s)
[587.199991] [140/155] (437s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[587.268029] Starting subtest: etime-single-wait-all-for-submit-submitted
[587.369553] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[587.463193] [141/155] (436s left) gem_workarounds (basic-read-context)
[587.538051] Starting subtest: basic-read-context
[587.551337] Subtest basic-read-context: SUCCESS (0.012s)
[587.668016] [142/155] (436s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[587.724563] Starting subtest: invalid-multi-wait-unsubmitted
[587.727540] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[587.820037] [143/155] (436s left) gem_render_copy_redux (interruptible)
[587.863468] Starting subtest: interruptible
[588.161099] Subtest interruptible: SUCCESS (0.298s)
[588.289483] [144/155] (436s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[588.383129] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[588.387517] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[588.476816] [145/155] (435s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[588.584125] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[588.588237] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[588.683128] [146/155] (435s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[588.766988] Starting subtest: multiplane-rotation-cropping-top
[606.199510] Subtest multiplane-rotation-cropping-top: SUCCESS (17.549s)
[606.308249] [147/155] (418s left) kms_setmode (invalid-clone-single-crtc)
[606.368170] Starting subtest: invalid-clone-single-crtc
[606.375033] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[606.457503] [148/155] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[606.551876] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[606.555429] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[606.648624] [149/155] (417s left) gem_exec_params (rs-invalid)
[606.714413] Starting subtest: rs-invalid
[606.716659] Subtest rs-invalid: SUCCESS (0.003s)
[606.847002] [150/155] (417s left) gem_pxp (create-protected-buffer)
[606.941499] Starting subtest: create-protected-buffer
[606.944131] Subtest create-protected-buffer: SUCCESS (0.000s)
[607.048055] [151/155] (417s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[607.144612] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[607.149423] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[607.236960] [152/155] (417s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[607.337513] Starting subtest: hdr-rgb101010-draw-blt
[607.341393] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[607.431162] [153/155] (417s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[607.522405] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[607.524410] Starting dynamic subtest: pipe-A-eDP-1
[607.540982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[607.551317] Starting dynamic subtest: pipe-B-eDP-1
[607.569509] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[607.578788] Starting dynamic subtest: pipe-C-eDP-1
[607.598498] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[607.607553] Starting dynamic subtest: pipe-D-eDP-1
[607.626810] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[607.628812] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[609.840534] [154/155] (414s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[609.961000] Starting subtest: cursorB-vs-flipA-legacy
[609.965659] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[610.111114] [155/155] (414s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[610.209653] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[610.214409] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[610.287124] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_force_connector_basic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: sw_sync
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_fbcon_fbt
results: parsing output: 26/ for test: gem_flink_race
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: gem_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: core_getversion
results: parsing output: 38/ for test: gem_vm_create
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_plane_cursor
results: parsing output: 52/ for test: kms_busy
results: parsing output: 53/ for test: kms_color_pipeline
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: prime_busy
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: kms_chamelium_edid
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: i915_getparams_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: gem_exercise_blt
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_tiled_pread_pwrite
results: parsing output: 84/ for test: kms_dsc
results: parsing output: 85/ for test: kms_tiled_display
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: prime_vgem
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: drm_read
results: parsing output: 99/ for test: gem_pxp
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_tiling_max_stride
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: vgem_basic
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pm_sseu
results: parsing output: 132/ for test: gem_fenced_exec_thrash
results: parsing output: 133/ for test: gem_ccs
results: parsing output: 134/ for test: kms_addfb_basic
results: parsing output: 135/ for test: kms_properties
results: parsing output: 136/ for test: kms_pm_dc
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_vblank
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: gem_workarounds
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: gem_render_copy_redux
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_rotation_crc
results: parsing output: 146/ for test: kms_setmode
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: gem_pxp
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_ccs
results: parsing output: 153/ for test: kms_cursor_legacy
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.