[51.744702] Initializing watchdogs
[51.744771]   /dev/watchdog0
[51.758522] [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]
[51.762896] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.765480] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.768876] [001/133] (960s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[51.889910] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[51.892282] Starting dynamic subtest: pipe-A-eDP-1
[51.912722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[51.921158] Starting dynamic subtest: pipe-B-eDP-1
[51.940736] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[51.947707] Starting dynamic subtest: pipe-C-eDP-1
[51.967693] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[51.976183] Starting dynamic subtest: pipe-D-eDP-1
[51.995738] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[51.997970] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[54.147125] [002/133] (958s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[54.249117] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[61.064499] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.819s)
[61.198078] [003/133] (951s left) api_intel_bb (intel-bb-blit-x)
[61.252761] Starting subtest: intel-bb-blit-x
[64.939045] Subtest intel-bb-blit-x: SUCCESS (3.687s)
[65.068336] [004/133] (947s left) fbdev (info)
[65.112296] Starting subtest: info
[65.114671] Subtest info: SUCCESS (0.000s)
[65.167515] [005/133] (947s left) syncobj_wait (invalid-signal-zero-handles)
[65.213953] Starting subtest: invalid-signal-zero-handles
[65.216306] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[65.305539] [006/133] (947s left) gem_exec_fence (basic-busy)
[65.484647] Starting subtest: basic-busy
[65.488046] Starting dynamic subtest: rcs0
[65.545035] Dynamic subtest rcs0: SUCCESS (0.061s)
[65.557746] Starting dynamic subtest: bcs0
[65.613899] Dynamic subtest bcs0: SUCCESS (0.068s)
[65.623445] Starting dynamic subtest: vcs0
[65.681058] Dynamic subtest vcs0: SUCCESS (0.065s)
[65.690085] Starting dynamic subtest: vcs1
[65.740792] Dynamic subtest vcs1: SUCCESS (0.059s)
[65.749284] Starting dynamic subtest: vecs0
[65.798606] Dynamic subtest vecs0: SUCCESS (0.054s)
[65.806467] Starting dynamic subtest: ccs0
[65.850460] Dynamic subtest ccs0: SUCCESS (0.053s)
[65.852895] Subtest basic-busy: SUCCESS (0.367s)
[68.073440] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[68.076430] [007/133] (944s left) kms_big_fb (linear-32bpp-rotate-180)
[68.171319] Starting subtest: linear-32bpp-rotate-180
[69.772799] Subtest linear-32bpp-rotate-180: SUCCESS (1.602s)
[69.904537] [008/133] (942s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[70.001501] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[70.003556] Starting dynamic subtest: pipe-A-eDP-1
[70.023411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.033384] Starting dynamic subtest: pipe-B-eDP-1
[70.051619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.058169] Starting dynamic subtest: pipe-C-eDP-1
[70.076849] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.085808] Starting dynamic subtest: pipe-D-eDP-1
[70.105076] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.108454] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[72.156219] [009/133] (940s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[72.535952] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[73.383990] [010/133] (939s left) kms_plane (pixel-format-4-tiled-modifier)
[73.473290] Starting subtest: pixel-format-4-tiled-modifier
[73.501082] Starting dynamic subtest: pipe-A-plane-0
[74.156257] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[74.164457] Starting dynamic subtest: pipe-A-plane-3
[74.544935] Dynamic subtest pipe-A-plane-3: SUCCESS (0.389s)
[74.553718] Starting dynamic subtest: pipe-A-plane-5
[74.557324] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[75.690773] Starting dynamic subtest: pipe-B-plane-0
[76.360966] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s)
[76.371762] Starting dynamic subtest: pipe-B-plane-3
[76.748951] Dynamic subtest pipe-B-plane-3: SUCCESS (0.388s)
[76.756160] Starting dynamic subtest: pipe-B-plane-5
[76.759633] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[77.060485] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.585s)
[77.861871] [011/133] (934s left) gem_exec_reloc (basic-cpu-wc)
[77.928511] Subtest basic-cpu-wc: SKIP (0.000s)
[78.007525] [012/133] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[78.108533] Starting subtest: fbcpsr-1p-rte
[85.067993] Subtest fbcpsr-1p-rte: SUCCESS (6.964s)
[85.227055] [013/133] (927s left) gem_wait (busy)
[85.291709] Starting subtest: busy
[85.294115] Starting dynamic subtest: all-engines
[86.934358] Dynamic subtest all-engines: SUCCESS (1.641s)
[86.944046] Starting dynamic subtest: rcs0
[87.476510] Dynamic subtest rcs0: SUCCESS (0.543s)
[87.486995] Starting dynamic subtest: bcs0
[88.016719] Dynamic subtest bcs0: SUCCESS (0.539s)
[88.026607] Starting dynamic subtest: vcs0
[89.942576] Dynamic subtest vcs0: SUCCESS (1.924s)
[89.953028] Starting dynamic subtest: vcs1
[91.925508] Dynamic subtest vcs1: SUCCESS (1.981s)
[91.936026] Starting dynamic subtest: vecs0
[93.908853] Dynamic subtest vecs0: SUCCESS (1.982s)
[93.918837] Starting dynamic subtest: ccs0
[94.449373] Dynamic subtest ccs0: SUCCESS (0.541s)
[94.451700] Subtest busy: SUCCESS (9.157s)
[94.645811] [014/133] (918s left) gem_exec_parallel (userptr)
[94.719466] Starting subtest: userptr
[94.721820] Starting dynamic subtest: rcs0
[96.268483] Dynamic subtest rcs0: SUCCESS (1.549s)
[96.276237] Starting dynamic subtest: bcs0
[97.743629] Dynamic subtest bcs0: SUCCESS (1.474s)
[97.753410] Starting dynamic subtest: vcs0
[99.863941] Dynamic subtest vcs0: SUCCESS (2.118s)
[99.872903] Starting dynamic subtest: vcs1
[101.845819] Dynamic subtest vcs1: SUCCESS (1.980s)
[101.856324] Starting dynamic subtest: vecs0
[103.894586] Dynamic subtest vecs0: SUCCESS (2.047s)
[103.903596] Starting dynamic subtest: ccs0
[105.395156] Dynamic subtest ccs0: SUCCESS (1.500s)
[105.399741] Subtest userptr: SUCCESS (10.675s)
[105.577773] [015/133] (907s left) kms_cursor_crc (cursor-random-128x128)
[105.782390] Starting subtest: cursor-random-128x128
[105.787263] Starting dynamic subtest: pipe-A-eDP-1
[109.107119] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.320s)
[109.135623] Starting dynamic subtest: pipe-D-eDP-1
[113.134636] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.005s)
[113.136873] Subtest cursor-random-128x128: SUCCESS (7.349s)
[114.006345] [016/133] (898s left) kms_rotation_crc (bad-tiling)
[114.110204] Starting subtest: bad-tiling
[114.115223] Subtest bad-tiling: SKIP (0.001s)
[114.200418] [017/133] (898s left) gem_close_race (multigpu-basic-threads)
[114.268030] Starting subtest: multigpu-basic-threads
[114.272666] Subtest multigpu-basic-threads: SKIP (0.000s)
[114.490261] [018/133] (898s left) gem_mmap (bad-size)
[114.543260] Subtest bad-size: SKIP (0.000s)
[114.601855] [019/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[114.696841] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[114.701165] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[114.811441] [020/133] (898s left) gem_userptr_blits (create-destroy-sync)
[114.876879] Starting subtest: create-destroy-sync
[119.939737] Subtest create-destroy-sync: SUCCESS (5.011s)
[120.014838] [021/133] (893s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[120.133149] Starting subtest: cursor-tearing-framebuffer-change
[120.135541] Starting dynamic subtest: pipe-A-eDP-1
[120.702400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[120.710046] Starting dynamic subtest: pipe-D-eDP-1
[121.900669] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[121.903076] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.765s)
[122.737451] [022/133] (890s left) kms_cursor_legacy (forked-bo)
[122.856074] Starting subtest: forked-bo
[122.858202] Starting dynamic subtest: pipe-A
[128.389404] Dynamic subtest pipe-A: SUCCESS (5.469s)
[128.397784] Starting dynamic subtest: pipe-B
[133.850375] Dynamic subtest pipe-B: SUCCESS (5.468s)
[133.859214] Starting dynamic subtest: pipe-C
[139.322274] Dynamic subtest pipe-C: SUCCESS (5.470s)
[139.331390] Starting dynamic subtest: pipe-D
[144.795081] Dynamic subtest pipe-D: SUCCESS (5.472s)
[144.805196] Starting dynamic subtest: all-pipes
[150.280722] Dynamic subtest all-pipes: SUCCESS (5.483s)
[150.282783] Subtest forked-bo: SUCCESS (27.370s)
[150.374737] [023/133] (862s left) kms_async_flips (async-flip-dpms)
[150.480778] Starting subtest: async-flip-dpms
[150.858710] Starting dynamic subtest: pipe-A-eDP-1
[154.660107] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.801s)
[155.035694] Starting dynamic subtest: pipe-B-eDP-1
[157.816327] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.789s)
[158.227435] Starting dynamic subtest: pipe-C-eDP-1
[160.987830] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[161.364728] Starting dynamic subtest: pipe-D-eDP-1
[164.156634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.797s)
[164.158803] Subtest async-flip-dpms: SUCCESS (13.677s)
[165.347291] [024/133] (847s left) gem_ctx_param (invalid-get-no-zeromap)
[165.415835] Starting subtest: invalid-get-no-zeromap
[165.418273] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[165.517573] [025/133] (847s left) kms_atomic (crtc-invalid-params-fence)
[165.630662] Starting subtest: crtc-invalid-params-fence
[165.632686] Starting dynamic subtest: pipe-A-eDP-1
[166.127511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[166.129526] Subtest crtc-invalid-params-fence: SUCCESS (0.496s)
[166.980420] [026/133] (846s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[167.082258] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[168.149931] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[168.276395] [027/133] (845s left) kms_flip (2x-absolute-wf_vblank)
[168.380052] Starting subtest: 2x-absolute-wf_vblank
[168.388459] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[168.488977] [028/133] (844s left) gen9_exec_parse (valid-registers)
[168.548356] Subtest valid-registers: SKIP (0.000s)
[168.616428] [029/133] (844s left) core_setmaster_vs_auth
[168.798180] [030/133] (844s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[168.842356] Starting subtest: multi-wait-available-unsubmitted-signaled
[168.844288] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[168.946010] [031/133] (844s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[169.034443] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[169.036340] Starting dynamic subtest: pipe-A-eDP-1
[169.132500] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[169.140197] Starting dynamic subtest: pipe-B-eDP-1
[170.255912] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[170.260635] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.221s)
[171.446462] [032/133] (842s left) perf (non-zero-reason)
[171.579959] Starting subtest: non-zero-reason
[171.582324] Starting dynamic subtest: 0-rcs0
[176.980397] Dynamic subtest 0-rcs0: SUCCESS (5.348s)
[176.989800] Starting dynamic subtest: 1-vcs0
[180.788193] Dynamic subtest 1-vcs0: SUCCESS (3.859s)
[180.790953] Subtest non-zero-reason: SUCCESS (9.208s)
[180.834993] [033/133] (832s left) kms_frontbuffer_tracking (psr-slowdraw)
[180.932526] Starting subtest: psr-slowdraw
[206.175210] Subtest psr-slowdraw: SUCCESS (25.245s)
[206.297560] [034/133] (807s left) gem_tiled_wc
[206.429907] [035/133] (807s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[206.559557] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[207.466946] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.908s)
[207.634250] [036/133] (806s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[207.695907] Starting subtest: y-tiled-to-vebox-x-tiled
[207.700946] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[207.892695] [037/133] (805s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[207.954208] Starting subtest: etime-multi-wait-for-submit-submitted
[208.057855] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[208.135806] [038/133] (805s left) kms_pm_dc (dc5-dpms)
[209.233707] Starting subtest: dc5-dpms
[211.337586] Subtest dc5-dpms: SUCCESS (2.103s)
[211.426745] [039/133] (802s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[211.529253] Starting subtest: 4-tiled-8bpp-rotate-0
[212.798443] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.269s)
[212.931046] [040/133] (800s left) kms_psr (psr-primary-blt)
[213.022221] Starting subtest: psr-primary-blt
[213.024206] Starting dynamic subtest: eDP-1
[214.783120] Dynamic subtest eDP-1: SUCCESS (1.762s)
[214.785476] Subtest psr-primary-blt: SUCCESS (1.763s)
[215.651332] [041/133] (798s left) gem_exec_flush (basic-wb-pro-default)
[215.722796] Starting subtest: basic-wb-pro-default
[221.207961] Subtest basic-wb-pro-default: SUCCESS (5.471s)
[221.382631] [042/133] (792s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[221.497477] Starting subtest: yf-tiled-addfb-size-overflow
[221.501665] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[221.586338] [043/133] (792s left) gem_pread (bench)
[221.645495] Subtest bench: SKIP (0.000s)
[221.701962] [044/133] (792s left) i915_pm_rps (reset)
[221.760283] Starting subtest: reset
[230.231579] Subtest reset: SUCCESS (8.471s)
[230.372193] [045/133] (783s left) kms_psr (psr-cursor-mmap-cpu)
[230.467981] Starting subtest: psr-cursor-mmap-cpu
[230.470384] Starting dynamic subtest: eDP-1
[232.151082] Dynamic subtest eDP-1: SUCCESS (1.682s)
[232.153388] Subtest psr-cursor-mmap-cpu: SUCCESS (1.683s)
[233.013713] [046/133] (781s left) kms_rmfb (close-fd)
[233.132374] Starting subtest: close-fd
[233.134398] Starting dynamic subtest: pipe-A-eDP-1
[233.239883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[233.250070] Starting dynamic subtest: pipe-B-eDP-1
[234.381479] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[234.391294] Starting dynamic subtest: pipe-C-eDP-1
[235.507220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[235.516403] Starting dynamic subtest: pipe-D-eDP-1
[236.624445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[236.626914] Subtest close-fd: SUCCESS (3.495s)
[237.834583] [047/133] (776s left) kms_addfb_basic (bad-pitch-1024)
[237.905613] Starting subtest: bad-pitch-1024
[237.908082] Subtest bad-pitch-1024: SUCCESS (0.000s)
[238.025668] [048/133] (776s left) kms_prop_blob (invalid-get-prop)
[238.084995] Starting subtest: invalid-get-prop
[238.087356] Subtest invalid-get-prop: SUCCESS (0.000s)
[238.185346] [049/133] (776s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[238.282878] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[238.285203] Starting dynamic subtest: pipe-A-eDP-1
[238.308264] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.319236] Starting dynamic subtest: pipe-B-eDP-1
[238.341268] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.348987] Starting dynamic subtest: pipe-C-eDP-1
[238.370980] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.379106] Starting dynamic subtest: pipe-D-eDP-1
[238.402521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.406801] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[240.594271] [050/133] (773s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[240.706757] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[240.709109] Starting dynamic subtest: A-eDP1
[244.335554] Dynamic subtest A-eDP1: SUCCESS (3.631s)
[244.344455] Starting dynamic subtest: B-eDP1
[247.549068] Dynamic subtest B-eDP1: SUCCESS (3.212s)
[247.559090] Starting dynamic subtest: C-eDP1
[250.647267] Dynamic subtest C-eDP1: SUCCESS (3.097s)
[250.656636] Starting dynamic subtest: D-eDP1
[253.779300] Dynamic subtest D-eDP1: SUCCESS (3.131s)
[253.781699] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.079s)
[254.586368] [051/133] (759s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[254.680373] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[254.682773] Starting dynamic subtest: pipe-A
[255.894900] Dynamic subtest pipe-A: SUCCESS (1.217s)
[255.904680] Starting dynamic subtest: pipe-B
[258.108234] Dynamic subtest pipe-B: SUCCESS (2.211s)
[258.118960] Starting dynamic subtest: pipe-C
[259.283669] Dynamic subtest pipe-C: SUCCESS (1.173s)
[259.294565] Starting dynamic subtest: pipe-D
[260.521045] Dynamic subtest pipe-D: SUCCESS (1.236s)
[260.523347] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.845s)
[261.707123] [052/133] (752s left) core_getversion (basic)
[261.751825] Starting subtest: basic
[261.756315] Subtest basic: SUCCESS (0.000s)
[261.820072] [053/133] (752s left) kms_joiner (basic-force-ultra-joiner)
[261.907196] Starting subtest: basic-force-ultra-joiner
[261.911132] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[261.987263] [054/133] (752s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[262.073059] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[269.171852] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.101s)
[269.300930] [055/133] (745s left) prime_busy (hang)
[269.369740] Starting subtest: hang
[269.371988] Starting dynamic subtest: rcs0
[295.419080] Dynamic subtest rcs0: SUCCESS (26.037s)
[295.426567] Starting dynamic subtest: bcs0
[302.567064] Dynamic subtest bcs0: SUCCESS (7.154s)
[302.577209] Starting dynamic subtest: vcs0
[309.548105] Dynamic subtest vcs0: SUCCESS (6.969s)
[309.556252] Starting dynamic subtest: vcs1
[316.576552] Dynamic subtest vcs1: SUCCESS (7.038s)
[316.585087] Starting dynamic subtest: vecs0
[323.553908] Dynamic subtest vecs0: SUCCESS (6.978s)
[323.564799] Starting dynamic subtest: ccs0
[337.454084] Dynamic subtest ccs0: SUCCESS (13.896s)
[337.456338] Subtest hang: SUCCESS (68.080s)
[337.559768] [056/133] (676s left) kms_plane_scaling (planes-upscale-factor-0-25)
[337.662839] Starting subtest: planes-upscale-factor-0-25
[337.665144] Starting dynamic subtest: pipe-A
[337.724383] Dynamic subtest pipe-A: SUCCESS (0.063s)
[337.735269] Starting dynamic subtest: pipe-B
[338.843620] Dynamic subtest pipe-B: SUCCESS (1.118s)
[338.854234] Starting dynamic subtest: pipe-C
[339.956013] Dynamic subtest pipe-C: SUCCESS (1.111s)
[339.964670] Starting dynamic subtest: pipe-D
[341.098567] Dynamic subtest pipe-D: SUCCESS (1.142s)
[341.100919] Subtest planes-upscale-factor-0-25: SUCCESS (3.438s)
[342.268961] [057/133] (672s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[342.362372] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[342.366887] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[342.475247] [058/133] (672s left) syncobj_timeline (transfer-timeline-point)
[342.536038] Starting subtest: transfer-timeline-point
[342.538434] Subtest transfer-timeline-point: SUCCESS (0.000s)
[342.654604] [059/133] (671s left) kms_atomic_transition (plane-all-transition-fencing)
[342.752115] Starting subtest: plane-all-transition-fencing
[342.754468] Starting dynamic subtest: pipe-A-eDP-1
[345.245950] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[345.561660] Starting dynamic subtest: pipe-B-eDP-1
[348.790519] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.239s)
[349.100898] Subtest plane-all-transition-fencing: SUCCESS (6.350s)
[349.928176] [060/133] (664s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[350.028311] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[350.032669] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[350.133396] [061/133] (664s left) prime_mmap_kms (buffer-sharing)
[350.225400] Starting subtest: buffer-sharing
[350.674098] Subtest buffer-sharing: SUCCESS (0.450s)
[351.467517] [062/133] (663s left) perf_pmu (most-busy-check-all)
[351.507789] Starting subtest: most-busy-check-all
[351.510086] Starting dynamic subtest: rcs0
[352.918448] Dynamic subtest rcs0: SUCCESS (1.411s)
[352.930313] Starting dynamic subtest: bcs0
[354.902746] Dynamic subtest bcs0: SUCCESS (1.981s)
[354.913961] Starting dynamic subtest: vcs0
[356.886545] Dynamic subtest vcs0: SUCCESS (1.980s)
[356.897861] Starting dynamic subtest: vcs1
[358.934561] Dynamic subtest vcs1: SUCCESS (2.045s)
[358.947219] Starting dynamic subtest: vecs0
[360.918065] Dynamic subtest vecs0: SUCCESS (1.980s)
[360.930209] Starting dynamic subtest: ccs0
[362.902452] Dynamic subtest ccs0: SUCCESS (1.982s)
[362.905204] Subtest most-busy-check-all: SUCCESS (11.397s)
[363.014485] [063/133] (651s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[363.617575] Starting subtest: syncobj-backward-timeline-chain-engines
[363.803174] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.186s)
[364.973604] [064/133] (649s left) kms_content_protection (lic-type-1)
[365.127979] Starting subtest: lic-type-1
[365.133790] Subtest lic-type-1: SKIP (0.000s)
[365.257966] [065/133] (649s left) i915_pm_rps (waitboost)
[365.324596] Starting subtest: waitboost
[371.421191] Subtest waitboost: SUCCESS (6.099s)
[371.532904] [066/133] (643s left) gem_pread (display)
[371.600769] Subtest display: SKIP (0.000s)
[371.662706] [067/133] (643s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[371.759325] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[371.763679] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[371.860165] [068/133] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[371.950409] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[376.438438] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.492s)
[377.557569] [069/133] (637s left) gem_ctx_shared (q-out-order)
[377.623522] Starting subtest: Q-out-order
[377.625779] Starting dynamic subtest: rcs0
[377.738300] Dynamic subtest rcs0: SUCCESS (0.116s)
[377.759977] Starting dynamic subtest: vcs0
[377.835192] Dynamic subtest vcs0: SUCCESS (0.097s)
[377.852632] Starting dynamic subtest: vcs1
[377.919402] Dynamic subtest vcs1: SUCCESS (0.082s)
[377.936436] Starting dynamic subtest: vecs0
[377.998040] Dynamic subtest vecs0: SUCCESS (0.078s)
[378.013918] Starting dynamic subtest: ccs0
[378.094823] Dynamic subtest ccs0: SUCCESS (0.096s)
[378.097296] Subtest Q-out-order: SUCCESS (0.474s)
[378.983802] [070/133] (636s left) gem_exec_reloc (basic-gtt-wc-active)
[379.051746] Subtest basic-gtt-wc-active: SKIP (0.000s)
[379.136155] [071/133] (635s left) prime_mmap (test_forked)
[379.190229] Starting subtest: test_forked
[379.192453] Starting dynamic subtest: test_forked-smem
[379.226985] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[379.229491] Subtest test_forked: SUCCESS (0.040s)
[379.326658] [072/133] (635s left) gem_mmap_gtt (basic-copy)
[379.390366] Subtest basic-copy: SKIP (0.000s)
[379.448116] [073/133] (635s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[379.556924] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[379.561835] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[379.665846] [074/133] (635s left) kms_psr (fbc-pr-sprite-plane-move)
[379.765916] Starting subtest: fbc-pr-sprite-plane-move
[379.770998] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[379.847888] [075/133] (635s left) gem_exec_balancer (full)
[379.910946] Starting subtest: full
[384.727175] Subtest full: SUCCESS (4.819s)
[385.026638] [076/133] (630s left) gem_exec_schedule (pi-common)
[385.204907] Starting subtest: pi-common
[385.207188] Starting dynamic subtest: rcs0
[385.233319] Dynamic subtest rcs0: SUCCESS (0.031s)
[385.241860] Starting dynamic subtest: bcs0
[385.265123] Dynamic subtest bcs0: SUCCESS (0.031s)
[385.273678] Starting dynamic subtest: vcs0
[385.297019] Dynamic subtest vcs0: SUCCESS (0.031s)
[385.309068] Starting dynamic subtest: vcs1
[385.324739] Dynamic subtest vcs1: SUCCESS (0.027s)
[385.333501] Starting dynamic subtest: vecs0
[385.356268] Dynamic subtest vecs0: SUCCESS (0.031s)
[385.364875] Starting dynamic subtest: ccs0
[385.386071] Dynamic subtest ccs0: SUCCESS (0.029s)
[385.388308] Subtest pi-common: SUCCESS (0.185s)
[385.620697] [077/133] (629s left) gem_ctx_param (invalid-ctx-set)
[385.669884] Starting subtest: invalid-ctx-set
[385.672318] Subtest invalid-ctx-set: SUCCESS (0.002s)
[385.769179] [078/133] (629s left) prime_self_import (basic-llseek-bad)
[385.805168] Starting subtest: basic-llseek-bad
[385.821421] Subtest basic-llseek-bad: SUCCESS (0.020s)
[385.916557] [079/133] (629s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[386.012303] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[386.014668] Starting dynamic subtest: pipe-A-eDP-1
[386.072019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[386.369586] Starting dynamic subtest: pipe-B-eDP-1
[387.152289] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s)
[387.437602] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.428s)
[388.302894] [080/133] (627s left) kms_dsc (dsc-with-bpc)
[388.407332] Starting subtest: dsc-with-bpc
[388.438404] Subtest dsc-with-bpc: SKIP (0.001s)
[388.488612] [081/133] (627s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[388.545191] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[388.650333] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[388.726734] [082/133] (626s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[388.830789] Starting subtest: fbc-1p-pri-indfb-multidraw
[401.627244] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.801s)
[403.038597] [083/133] (612s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[403.101708] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[403.106279] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[403.288368] [084/133] (612s left) gem_exec_schedule (semaphore-noskip)
[403.370334] Starting subtest: semaphore-noskip
[403.795835] Subtest semaphore-noskip: SUCCESS (0.431s)
[404.131464] [085/133] (611s left) kms_sequence (get-forked)
[404.237697] Starting subtest: get-forked
[404.239870] Starting dynamic subtest: pipe-A-eDP-1
[406.120320] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.883s)
[406.132860] Starting dynamic subtest: pipe-B-eDP-1
[408.682824] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.558s)
[408.691784] Starting dynamic subtest: pipe-C-eDP-1
[411.205083] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.523s)
[411.215635] Starting dynamic subtest: pipe-D-eDP-1
[413.749764] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[413.752064] Subtest get-forked: SUCCESS (9.512s)
[414.558302] [086/133] (601s left) kms_flip (2x-flip-vs-wf_vblank)
[414.660460] Starting subtest: 2x-flip-vs-wf_vblank
[414.669353] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[414.763263] [087/133] (601s left) gem_exec_params (secure-non-root)
[414.829608] Starting subtest: secure-non-root
[414.834237] Subtest secure-non-root: SKIP (0.000s)
[414.932038] [088/133] (600s left) gem_ctx_persistence (smoketest)
[414.983473] Starting subtest: smoketest
[454.900697] Subtest smoketest: SUCCESS (39.914s)
[454.981829] [089/133] (560s left) syncobj_timeline (wait-for-submit-snapshot)
[455.037396] Starting subtest: wait-for-submit-snapshot
[455.117387] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[455.213758] [090/133] (560s left) kms_pm_rpm (package-g7)
[457.054401] Starting subtest: package-g7
[457.059605] Subtest package-g7: SKIP (0.000s)
[457.508307] [091/133] (558s left) kms_psr (pr-primary-render)
[457.606154] Starting subtest: pr-primary-render
[457.610209] Subtest pr-primary-render: SKIP (0.000s)
[457.698480] [092/133] (558s left) kms_chamelium_frames (dp-frame-dump)
[458.066955] Subtest dp-frame-dump: SKIP (0.000s)
[458.903252] [093/133] (557s left) gem_mmap_wc (read-write-distinct)
[458.971889] Subtest read-write-distinct: SKIP (0.000s)
[459.040677] [094/133] (557s left) gem_huc_copy (huc-copy)
[459.106692] Starting subtest: huc-copy
[459.111769] Subtest huc-copy: SUCCESS (0.004s)
[459.241219] [095/133] (556s left) gem_exec_store (pages)
[459.302820] Starting subtest: pages
[459.305084] Starting dynamic subtest: rcs0
[459.390640] Dynamic subtest rcs0: SUCCESS (0.090s)
[459.401625] Starting dynamic subtest: bcs0
[459.475887] Dynamic subtest bcs0: SUCCESS (0.084s)
[459.487118] Starting dynamic subtest: vcs0
[459.564086] Dynamic subtest vcs0: SUCCESS (0.086s)
[459.577994] Starting dynamic subtest: vcs1
[459.646590] Dynamic subtest vcs1: SUCCESS (0.080s)
[459.657766] Starting dynamic subtest: vecs0
[459.721359] Dynamic subtest vecs0: SUCCESS (0.073s)
[459.731865] Starting dynamic subtest: ccs0
[459.791517] Dynamic subtest ccs0: SUCCESS (0.069s)
[459.793886] Subtest pages: SUCCESS (0.491s)
[459.987596] [096/133] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[460.087401] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[460.091688] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[460.173909] [097/133] (556s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[460.286466] Starting subtest: y-tiled-addfb-size-offset-overflow
[460.290699] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[460.405041] [098/133] (555s left) kms_cursor_crc (cursor-onscreen-256x256)
[460.653879] Starting subtest: cursor-onscreen-256x256
[460.656348] Starting dynamic subtest: pipe-A-eDP-1
[462.752397] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[462.783420] Starting dynamic subtest: pipe-D-eDP-1
[465.491960] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.715s)
[465.494206] Subtest cursor-onscreen-256x256: SUCCESS (4.839s)
[466.287848] [099/133] (549s left) gem_softpin (allocator-fork)
[466.353255] Starting subtest: allocator-fork
[468.613731] Subtest allocator-fork: SUCCESS (2.206s)
[468.683611] [100/133] (547s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[468.797316] Starting subtest: flip-vs-cursor-atomic-transitions
[476.279971] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.480s)
[477.110749] [101/133] (539s left) gem_exec_params (no-blt)
[477.184176] Starting subtest: no-blt
[477.186477] Subtest no-blt: SUCCESS (0.002s)
[477.318478] [102/133] (539s left) kms_color (ctm-blue-to-red)
[477.409076] Starting subtest: ctm-blue-to-red
[477.411274] Starting dynamic subtest: pipe-A-eDP-1
[478.100936] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[478.110411] Starting dynamic subtest: pipe-B-eDP-1
[479.492632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[479.503083] Starting dynamic subtest: pipe-C-eDP-1
[480.901754] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[480.911322] Starting dynamic subtest: pipe-D-eDP-1
[482.228534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[482.230994] Subtest ctm-blue-to-red: SUCCESS (4.820s)
[483.042796] [103/133] (533s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[483.139881] Starting subtest: random-ccs-data-y-tiled-ccs
[483.142178] Starting dynamic subtest: pipe-A-eDP-1
[483.167565] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.177152] Starting dynamic subtest: pipe-B-eDP-1
[483.201198] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.210297] Starting dynamic subtest: pipe-C-eDP-1
[483.234433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.243553] Starting dynamic subtest: pipe-D-eDP-1
[483.267876] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.271987] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[485.411528] [104/133] (531s left) kms_psr (fbc-pr-primary-mmap-cpu)
[485.518695] Starting subtest: fbc-pr-primary-mmap-cpu
[485.523231] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[485.590747] [105/133] (530s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[485.676543] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[489.687921] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.016s)
[490.820138] [106/133] (525s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[490.923270] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[490.925600] Starting dynamic subtest: pipe-A-eDP-1
[490.984780] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[491.000463] Starting dynamic subtest: pipe-B-eDP-1
[491.058874] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[491.070260] Starting dynamic subtest: pipe-C-eDP-1
[491.127482] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[491.137159] Starting dynamic subtest: pipe-D-eDP-1
[491.193195] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[491.197278] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[493.170647] [107/133] (523s left) kms_psr (fbc-psr-cursor-plane-move)
[493.270665] Starting subtest: fbc-psr-cursor-plane-move
[493.272837] Starting dynamic subtest: eDP-1
[493.276739] Dynamic subtest eDP-1: SKIP (0.000s)
[493.280787] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[493.343731] [108/133] (523s left) kms_vblank (ts-continuation-modeset-hang)
[493.442726] Starting subtest: ts-continuation-modeset-hang
[493.444815] Starting dynamic subtest: pipe-A-eDP-1
[519.639166] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.194s)
[519.654301] Starting dynamic subtest: pipe-D-eDP-1
[544.672496] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s)
[544.674671] Subtest ts-continuation-modeset-hang: SUCCESS (51.229s)
[545.504626] [109/133] (471s left) kms_lease (atomic-implicit-crtc)
[545.594044] Starting subtest: atomic-implicit-crtc
[545.596231] Starting dynamic subtest: pipe-A-eDP-1
[545.607314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[545.618631] Starting dynamic subtest: pipe-B-eDP-1
[545.629585] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[545.637940] Starting dynamic subtest: pipe-C-eDP-1
[545.648653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[545.657362] Starting dynamic subtest: pipe-D-eDP-1
[545.667992] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[545.669930] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[545.741874] [110/133] (470s left) gen7_exec_parse (bitmasks)
[545.804159] Subtest bitmasks: SKIP (0.000s)
[545.877278] [111/133] (470s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[545.959237] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[545.963126] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[546.043564] [112/133] (470s left) gem_madvise (dontneed-before-pwrite)
[546.088024] Starting subtest: dontneed-before-pwrite
[546.111422] Subtest dontneed-before-pwrite: SKIP (0.021s)
[546.173191] [113/133] (470s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[546.266290] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[546.270436] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[546.369631] [114/133] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[546.462836] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[546.466047] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[546.565516] [115/133] (470s left) perf (non-sampling-read-error)
[546.667527] Starting subtest: non-sampling-read-error
[546.677063] Subtest non-sampling-read-error: SUCCESS (0.007s)
[546.719984] [116/133] (470s left) kms_plane_alpha_blend (constant-alpha-mid)
[546.806061] Starting subtest: constant-alpha-mid
[547.089421] Starting dynamic subtest: pipe-A-eDP-1
[547.944715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[547.954704] Starting dynamic subtest: pipe-D-eDP-1
[549.377566] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[549.379800] Subtest constant-alpha-mid: SUCCESS (2.572s)
[550.174383] [117/133] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[550.285553] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[550.289821] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[550.382174] [118/133] (466s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[550.510689] Starting subtest: flip-vs-cursor-legacy
[557.562667] Subtest flip-vs-cursor-legacy: SUCCESS (7.053s)
[558.418600] [119/133] (458s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[558.474064] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[558.537195] [120/133] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[558.641262] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[558.645451] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[558.757403] [121/133] (458s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[558.853729] Starting subtest: plane-primary-toggle-with-vblank-wait
[558.856702] Starting dynamic subtest: pipe-A-eDP-1
[559.026364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[559.332501] Starting dynamic subtest: pipe-B-eDP-1
[560.208915] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.884s)
[560.508787] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.656s)
[561.355993] [122/133] (455s left) i915_hangman (engine-engine-error)
[561.426741] Starting subtest: engine-engine-error
[561.429062] Starting dynamic subtest: rcs0
[562.868487] Dynamic subtest rcs0: SUCCESS (1.440s)
[562.881024] Starting dynamic subtest: bcs0
[564.851030] Dynamic subtest bcs0: SUCCESS (1.980s)
[564.863708] Starting dynamic subtest: vcs0
[566.835645] Dynamic subtest vcs0: SUCCESS (1.982s)
[566.847676] Starting dynamic subtest: vcs1
[568.884644] Dynamic subtest vcs1: SUCCESS (2.046s)
[568.896063] Starting dynamic subtest: vecs0
[570.867632] Dynamic subtest vecs0: SUCCESS (1.981s)
[570.880393] Starting dynamic subtest: ccs0
[572.852558] Dynamic subtest ccs0: SUCCESS (1.982s)
[572.855650] Subtest engine-engine-error: SUCCESS (11.427s)
[572.988838] [123/133] (444s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[573.082774] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[573.084900] Starting dynamic subtest: pipe-A-default-mode
[574.218068] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[574.222280] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.135s)
[574.354469] [124/133] (442s left) syncobj_timeline (invalid-query-one-illegal-handle)
[574.410460] Starting subtest: invalid-query-one-illegal-handle
[574.412675] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[574.503062] [125/133] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[574.592904] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[574.597069] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[574.689270] [126/133] (442s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[574.790399] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[581.556637] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.770s)
[581.692559] [127/133] (435s left) api_intel_allocator (fork-simple-stress-signal)
[581.758599] Starting subtest: fork-simple-stress-signal
[587.217794] Subtest fork-simple-stress-signal: SUCCESS (5.406s)
[587.285983] [128/133] (430s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[587.382184] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[587.386768] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[587.454924] [129/133] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[587.552615] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[587.557082] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[587.680288] [130/133] (429s left) gem_userptr_blits (usage-restrictions)
[587.757574] Starting subtest: usage-restrictions
[587.759842] Subtest usage-restrictions: SUCCESS (0.000s)
[587.892977] [131/133] (429s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[587.997976] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[595.060989] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.067s)
[595.206036] [132/133] (422s left) gem_mmap_offset (clear)
[595.263365] Starting subtest: clear
[595.265656] Starting dynamic subtest: smem0
[620.615063] Dynamic subtest smem0: SUCCESS (25.348s)
[620.617150] Subtest clear: SUCCESS (25.349s)
[620.755810] [133/133] (396s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[620.890115] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[620.901907] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[620.979612] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: fbdev
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_chamelium_hpd
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: gem_exec_parallel
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: gem_close_race
results: parsing output: 17/ for test: gem_mmap
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_atomic
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: core_setmaster_vs_auth
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_tiled_wc
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_exec_flush
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_pread
results: parsing output: 43/ for test: i915_pm_rps
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_rmfb
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_prop_blob
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: core_getversion
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: prime_busy
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: prime_mmap_kms
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_pread
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ctx_shared
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_mmap
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_ctx_param
results: parsing output: 77/ for test: prime_self_import
results: parsing output: 78/ for test: kms_atomic_transition
results: parsing output: 79/ for test: kms_dsc
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_sequence
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: gem_mmap_wc
results: parsing output: 93/ for test: gem_huc_copy
results: parsing output: 94/ for test: gem_exec_store
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_color
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: gen7_exec_parse
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_madvise
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_offset
results: parsing output: 132/ for test: kms_flip
Done.