[59.796279] Initializing watchdogs
[59.796327]   /dev/watchdog0
[59.811688] [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]
[59.818623] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.820883] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.822736] [001/133] (960s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[59.921049] Starting subtest: psr-rgb101010-draw-render
[67.448442] Subtest psr-rgb101010-draw-render: SUCCESS (7.509s)
[67.756000] [002/133] (952s left) kms_vblank (query-forked)
[67.872703] Starting subtest: query-forked
[67.873746] Starting dynamic subtest: pipe-A-eDP-1
[69.750050] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[69.758224] Starting dynamic subtest: pipe-D-eDP-1
[72.246363] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.493s)
[72.247301] Subtest query-forked: SUCCESS (4.370s)
[73.114102] [003/133] (947s left) kms_psr (fbc-psr-suspend)
[73.214453] Starting subtest: fbc-psr-suspend
[73.215442] Starting dynamic subtest: eDP-1
[73.217363] Dynamic subtest eDP-1: SKIP (0.000s)
[73.219088] Subtest fbc-psr-suspend: SKIP (0.000s)
[73.292717] [004/133] (947s left) gem_exec_balancer (bonded-dual)
[73.355858] Starting subtest: bonded-dual
[73.357829] Subtest bonded-dual: SKIP (0.000s)
[73.655544] [005/133] (946s left) gem_userptr_blits (vma-merge)
[73.720609] Starting subtest: vma-merge
[73.761574] Subtest vma-merge: SUCCESS (0.040s)
[73.871036] [006/133] (946s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[73.960255] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[73.961272] Starting dynamic subtest: pipe-A-eDP-1
[73.985365] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[73.994248] Starting dynamic subtest: pipe-B-eDP-1
[74.016215] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[74.022515] Starting dynamic subtest: pipe-C-eDP-1
[74.042868] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[74.048604] Starting dynamic subtest: pipe-D-eDP-1
[74.068617] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[74.070192] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[76.261566] [007/133] (944s left) gem_sync (basic-store-all)
[76.325346] Starting subtest: basic-store-all
[79.439176] Subtest basic-store-all: SUCCESS (3.113s)
[79.616599] [008/133] (940s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[79.724478] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[79.726170] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[79.798577] [009/133] (940s left) kms_dsc (dsc-with-output-formats-with-bpc)
[79.893472] Starting subtest: dsc-with-output-formats-with-bpc
[79.916242] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[79.957426] [010/133] (940s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[80.066582] Starting subtest: cursorB-vs-flipB-atomic
[80.068415] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[80.200894] [011/133] (940s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[80.267032] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[80.330099] [012/133] (940s left) syncobj_timeline (etime-single-wait-submitted)
[80.373020] Starting subtest: etime-single-wait-submitted
[80.492572] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[80.546941] [013/133] (940s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[80.634134] Starting subtest: bo-too-small-due-to-tiling
[80.635983] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[80.735808] [014/133] (939s left) gem_shrink (reclaim)
[80.792692] Starting subtest: reclaim
[83.199880] Subtest reclaim: SUCCESS (2.405s)
[83.337773] [015/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[83.426453] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[87.490219] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.062s)
[88.675355] [016/133] (932s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[88.771423] Starting subtest: fbc-psr2-cursor-plane-update-sf
[88.772325] Starting dynamic subtest: pipe-A-eDP-1
[88.850254] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[88.857275] Starting dynamic subtest: pipe-B-eDP-1
[89.944239] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[89.945980] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.172s)
[91.125094] [017/133] (929s left) kms_psr (psr-cursor-mmap-cpu)
[91.213125] Starting subtest: psr-cursor-mmap-cpu
[91.214109] Starting dynamic subtest: eDP-1
[92.933354] Dynamic subtest eDP-1: SUCCESS (1.719s)
[92.934229] Subtest psr-cursor-mmap-cpu: SUCCESS (1.720s)
[93.787685] [018/133] (927s left) kms_plane_multiple (2x-tiling-yf)
[93.884472] Starting subtest: 2x-tiling-yf
[93.886167] Subtest 2x-tiling-yf: SKIP (0.000s)
[93.953562] [019/133] (926s left) kms_color (legacy-gamma-reset)
[94.049912] Starting subtest: legacy-gamma-reset
[94.050903] Starting dynamic subtest: pipe-A-eDP-1
[94.418063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[94.425061] Starting dynamic subtest: pipe-B-eDP-1
[94.430514] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[94.436807] Starting dynamic subtest: pipe-C-eDP-1
[94.443121] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[94.449512] Starting dynamic subtest: pipe-D-eDP-1
[94.456273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[94.457278] Subtest legacy-gamma-reset: SUCCESS (0.415s)
[95.231770] [020/133] (925s left) syncobj_timeline (wait-for-submit-delayed-submit)
[95.284965] Starting subtest: wait-for-submit-delayed-submit
[95.391549] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[95.456533] [021/133] (925s left) gen9_exec_parse (secure-batches)
[95.520344] Subtest secure-batches: SKIP (0.000s)
[95.574898] [022/133] (925s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[95.659863] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[102.594837] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.923s)
[102.710735] [023/133] (918s left) gem_lmem_swapping (verify-ccs)
[102.755450] Subtest verify-ccs: SKIP (0.000s)
[102.788825] [024/133] (918s left) kms_pm_rpm (modeset-non-lpsp-stress)
[105.033643] Starting subtest: modeset-non-lpsp-stress
[106.182485] Subtest modeset-non-lpsp-stress: SKIP (1.148s)
[106.562405] [025/133] (914s left) kms_content_protection (legacy)
[106.717742] Starting subtest: legacy
[106.720044] Subtest legacy: SKIP (0.000s)
[106.818050] [026/133] (914s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[106.903204] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[106.904095] Starting dynamic subtest: pipe-A
[106.921867] Dynamic subtest pipe-A: SKIP (0.017s)
[106.930174] Starting dynamic subtest: pipe-B
[106.953572] Dynamic subtest pipe-B: SKIP (0.032s)
[106.960204] Starting dynamic subtest: pipe-C
[106.992656] Dynamic subtest pipe-C: SKIP (0.039s)
[106.998913] Starting dynamic subtest: pipe-D
[107.023261] Dynamic subtest pipe-D: SKIP (0.030s)
[107.024795] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.120s)
[107.117853] [027/133] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[107.210864] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[107.212776] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[107.315579] [028/133] (913s left) vgem_slow (nohang)
[107.394532] Starting subtest: nohang
[117.928086] Subtest nohang: SUCCESS (10.486s)
[117.955848] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[117.958402] [029/133] (903s left) gem_render_copy (yf-tiled)
[118.014437] Starting subtest: yf-tiled
[118.016227] Subtest yf-tiled: SKIP (0.000s)
[118.205635] [030/133] (902s left) api_intel_bb (offset-control)
[118.247865] Starting subtest: offset-control
[118.254051] Subtest offset-control: SUCCESS (0.007s)
[118.363904] [031/133] (902s left) kms_scaling_modes (scaling-mode-full)
[118.464077] Starting subtest: scaling-mode-full
[118.464959] Starting dynamic subtest: pipe-A-eDP-1
[118.559193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[118.568172] Starting dynamic subtest: pipe-B-eDP-1
[119.691251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[119.700195] Starting dynamic subtest: pipe-C-eDP-1
[120.800188] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[120.808220] Starting dynamic subtest: pipe-D-eDP-1
[121.936302] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[121.937595] Subtest scaling-mode-full: SUCCESS (3.473s)
[123.101443] [032/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[123.205566] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[130.512365] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.307s)
[130.619009] [033/133] (890s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[130.664196] Starting subtest: single-wait-all-for-submit-signaled
[130.665341] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[130.760401] [034/133] (890s left) gem_exec_schedule (implicit-write-read)
[130.811869] Starting subtest: implicit-write-read
[130.812770] Starting dynamic subtest: rcs0
[130.929365] Dynamic subtest rcs0: SUCCESS (0.116s)
[130.939518] Starting dynamic subtest: vcs0
[131.021069] Dynamic subtest vcs0: SUCCESS (0.092s)
[131.033301] Starting dynamic subtest: vcs1
[131.101724] Dynamic subtest vcs1: SUCCESS (0.080s)
[131.110790] Starting dynamic subtest: vecs0
[131.180855] Dynamic subtest vecs0: SUCCESS (0.079s)
[131.195490] Starting dynamic subtest: ccs0
[131.275138] Dynamic subtest ccs0: SUCCESS (0.094s)
[131.276138] Subtest implicit-write-read: SUCCESS (0.464s)
[132.014471] [035/133] (889s left) vgem_basic (second-client)
[132.059389] Starting subtest: second-client
[132.081168] Subtest second-client: SUCCESS (0.022s)
[132.134494] [036/133] (889s left) gem_ctx_engines (execute-one)
[132.199812] Starting subtest: execute-one
[135.062502] Subtest execute-one: SUCCESS (2.863s)
[135.252440] [037/133] (886s left) kms_pm_dc (dc6-psr)
[136.343024] Starting subtest: dc6-psr
[139.236409] Subtest dc6-psr: SUCCESS (2.892s)
[140.062880] [038/133] (881s left) perf (buffer-fill)
[140.184502] Starting subtest: buffer-fill
[140.185388] Starting dynamic subtest: 0-rcs0
[142.442152] Dynamic subtest 0-rcs0: SUCCESS (2.249s)
[142.450784] Starting dynamic subtest: 1-vcs1
[146.866970] Dynamic subtest 1-vcs1: SUCCESS (4.431s)
[146.868524] Subtest buffer-fill: SUCCESS (6.682s)
[146.911277] [039/133] (874s left) syncobj_timeline (reset-during-wait-for-submit)
[146.955201] Starting subtest: reset-during-wait-for-submit
[147.058705] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[147.137735] [040/133] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[147.230441] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[154.369129] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.140s)
[154.498740] [041/133] (867s left) gem_caching (read-writes)
[154.547168] Subtest read-writes: SKIP (0.000s)
[154.624403] [042/133] (866s left) gem_exec_schedule (wide)
[154.807373] Starting subtest: wide
[154.808541] Starting dynamic subtest: rcs0
[165.227877] Dynamic subtest rcs0: SUCCESS (10.381s)
[165.237665] Starting dynamic subtest: vcs0
[176.744741] Dynamic subtest vcs0: SUCCESS (11.552s)
[176.754290] Starting dynamic subtest: vcs1
[188.606590] Dynamic subtest vcs1: SUCCESS (11.860s)
[188.616280] Starting dynamic subtest: vecs0
[199.580610] Dynamic subtest vecs0: SUCCESS (10.972s)
[199.590660] Starting dynamic subtest: ccs0
[213.782132] Dynamic subtest ccs0: SUCCESS (14.163s)
[213.784053] Subtest wide: SUCCESS (58.933s)
[215.224934] [043/133] (806s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[215.478299] Starting subtest: cursor-rapid-movement-256x256
[215.481510] Starting dynamic subtest: pipe-A-eDP-1
[216.048850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[216.081174] Starting dynamic subtest: pipe-D-eDP-1
[217.297758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[217.298744] Subtest cursor-rapid-movement-256x256: SUCCESS (1.819s)
[218.153747] [044/133] (803s left) kms_cursor_edge_walk (256x256-top-edge)
[218.236375] Starting subtest: 256x256-top-edge
[218.237281] Starting dynamic subtest: pipe-A-eDP-1
[221.726975] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[221.734360] Starting dynamic subtest: pipe-D-eDP-1
[224.858777] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[224.859680] Subtest 256x256-top-edge: SUCCESS (6.622s)
[225.657167] [045/133] (796s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[225.748303] Starting subtest: plane-use-after-nonblocking-unbind
[225.750337] Starting dynamic subtest: pipe-A-eDP-1
[225.815396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[226.118540] Starting dynamic subtest: pipe-B-eDP-1
[226.958996] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.847s)
[227.244331] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.495s)
[228.134235] [046/133] (793s left) gem_mmap_wc (bad-object)
[228.182556] Subtest bad-object: SKIP (0.000s)
[228.236775] [047/133] (793s left) i915_drm_fdinfo (virtual-busy-idle-all)
[228.272438] Starting subtest: virtual-busy-idle-all
[228.274340] Subtest virtual-busy-idle-all: SKIP (0.000s)
[228.337914] [048/133] (793s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[228.431173] Starting subtest: x-tiled-8bpp-rotate-90
[228.453184] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[228.563178] [049/133] (793s left) gem_ctx_persistence (engines-mixed)
[228.626330] Starting subtest: engines-mixed
[228.627175] Starting dynamic subtest: rcs0
[228.736942] Dynamic subtest rcs0: SUCCESS (0.111s)
[228.747431] Starting dynamic subtest: bcs0
[228.793867] Dynamic subtest bcs0: SUCCESS (0.055s)
[228.804681] Starting dynamic subtest: vcs0
[228.851783] Dynamic subtest vcs0: SUCCESS (0.056s)
[228.861604] Starting dynamic subtest: vcs1
[228.907326] Dynamic subtest vcs1: SUCCESS (0.054s)
[228.917055] Starting dynamic subtest: vecs0
[228.953323] Dynamic subtest vecs0: SUCCESS (0.044s)
[228.962639] Starting dynamic subtest: ccs0
[229.021689] Dynamic subtest ccs0: SUCCESS (0.066s)
[229.022997] Subtest engines-mixed: SUCCESS (0.397s)
[229.094450] [050/133] (792s left) kms_chamelium_hpd (dp-hpd-fast)
[229.468623] Subtest dp-hpd-fast: SKIP (0.000s)
[230.241621] [051/133] (791s left) kms_flip (basic-flip-vs-wf_vblank)
[230.331022] Starting subtest: basic-flip-vs-wf_vblank
[230.333138] Starting dynamic subtest: A-eDP1
[232.211975] Dynamic subtest A-eDP1: SUCCESS (1.879s)
[232.220837] Starting dynamic subtest: B-eDP1
[234.147743] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[234.157226] Starting dynamic subtest: C-eDP1
[236.074319] Dynamic subtest C-eDP1: SUCCESS (1.922s)
[236.083861] Starting dynamic subtest: D-eDP1
[238.008561] Dynamic subtest D-eDP1: SUCCESS (1.932s)
[238.009513] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.678s)
[239.228197] [052/133] (782s left) kms_big_fb (linear-32bpp-rotate-90)
[239.319703] Starting subtest: linear-32bpp-rotate-90
[239.340273] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[239.436758] [053/133] (782s left) syncobj_wait (reset-signaled)
[239.487660] Starting subtest: reset-signaled
[239.488855] Subtest reset-signaled: SUCCESS (0.000s)
[239.579675] [054/133] (782s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[239.669128] Starting subtest: bad-pixel-format-yf-tiled-ccs
[239.669967] Starting dynamic subtest: pipe-A-eDP-1
[239.678481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.685849] Starting dynamic subtest: pipe-B-eDP-1
[239.694474] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.703976] Starting dynamic subtest: pipe-C-eDP-1
[239.711984] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.718632] Starting dynamic subtest: pipe-D-eDP-1
[239.726709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.728220] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[241.900796] [055/133] (780s left) prime_vgem (basic-fence-mmap)
[241.972490] Starting subtest: basic-fence-mmap
[241.974267] Subtest basic-fence-mmap: SKIP (0.000s)
[242.060446] [056/133] (780s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[242.154046] Starting subtest: random-ccs-data-yf-tiled-ccs
[242.154825] Starting dynamic subtest: pipe-A-eDP-1
[242.163577] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.170725] Starting dynamic subtest: pipe-B-eDP-1
[242.179064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.188562] Starting dynamic subtest: pipe-C-eDP-1
[242.197179] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.203628] Starting dynamic subtest: pipe-D-eDP-1
[242.212428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.213952] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[244.371903] [057/133] (777s left) gem_exec_fence (syncobj-timeline-unused-fence)
[244.946842] Starting subtest: syncobj-timeline-unused-fence
[244.948226] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[245.980091] [058/133] (776s left) kms_legacy_colorkey (invalid-plane)
[246.068297] Starting subtest: invalid-plane
[246.069187] Starting dynamic subtest: zero-id
[246.070076] Dynamic subtest zero-id: SUCCESS (0.000s)
[246.077059] Starting dynamic subtest: outrange-id
[246.077888] Dynamic subtest outrange-id: SUCCESS (0.000s)
[246.078789] Subtest invalid-plane: SUCCESS (0.001s)
[246.135575] [059/133] (776s left) kms_async_flips (async-flip-dpms)
[246.218573] Starting subtest: async-flip-dpms
[246.610951] Starting dynamic subtest: pipe-A-eDP-1
[250.408906] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.797s)
[250.789837] Starting dynamic subtest: pipe-B-eDP-1
[253.584420] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s)
[253.971060] Starting dynamic subtest: pipe-C-eDP-1
[256.752587] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.789s)
[257.134261] Starting dynamic subtest: pipe-D-eDP-1
[259.912426] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.784s)
[259.913336] Subtest async-flip-dpms: SUCCESS (13.695s)
[261.097429] [060/133] (761s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[261.208456] Starting subtest: basic-busy-flip-before-cursor-atomic
[261.210267] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[261.360053] [061/133] (760s left) kms_fbcon_fbt (fbc-suspend)
[261.408857] Starting subtest: fbc-suspend
[311.333386] Subtest fbc-suspend: SUCCESS (20.747s)
[313.724901] [062/133] (709s left) core_sysfs (read-all-entries)
[313.777902] Starting subtest: read-all-entries
[313.787921] Subtest read-all-entries: SUCCESS (0.011s)
[313.870067] [063/133] (709s left) kms_plane (plane-position-hole)
[313.959288] Starting subtest: plane-position-hole
[314.465695] Starting dynamic subtest: pipe-A-plane-1
[315.745803] Dynamic subtest pipe-A-plane-1: SUCCESS (1.265s)
[315.753891] Starting dynamic subtest: pipe-A-plane-2
[317.057541] Dynamic subtest pipe-A-plane-2: SUCCESS (1.297s)
[317.065439] Starting dynamic subtest: pipe-A-plane-3
[318.314409] Dynamic subtest pipe-A-plane-3: SUCCESS (1.246s)
[318.322323] Starting dynamic subtest: pipe-A-plane-4
[319.559663] Dynamic subtest pipe-A-plane-4: SUCCESS (1.235s)
[319.567571] Starting dynamic subtest: pipe-A-plane-5
[319.584614] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[320.713881] Starting dynamic subtest: pipe-B-plane-1
[321.975411] Dynamic subtest pipe-B-plane-1: SUCCESS (1.262s)
[321.983174] Starting dynamic subtest: pipe-B-plane-2
[323.318397] Dynamic subtest pipe-B-plane-2: SUCCESS (1.337s)
[323.326663] Starting dynamic subtest: pipe-B-plane-3
[324.643581] Dynamic subtest pipe-B-plane-3: SUCCESS (1.318s)
[324.651496] Starting dynamic subtest: pipe-B-plane-4
[326.028394] Dynamic subtest pipe-B-plane-4: SUCCESS (1.379s)
[326.040058] Starting dynamic subtest: pipe-B-plane-5
[326.054112] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[326.055015] Subtest plane-position-hole: SUCCESS (12.011s)
[326.844300] [064/133] (696s left) kms_properties (plane-properties-atomic)
[326.939266] Starting subtest: plane-properties-atomic
[326.940326] Starting dynamic subtest: pipe-A-eDP-1
[327.491674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[327.504123] Starting dynamic subtest: pipe-B-eDP-1
[328.733454] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[328.741138] Starting dynamic subtest: pipe-C-eDP-1
[329.973214] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[329.981831] Starting dynamic subtest: pipe-D-eDP-1
[331.213189] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[331.214010] Subtest plane-properties-atomic: SUCCESS (4.265s)
[332.007670] [065/133] (691s left) vgem_basic (unload)
[332.042426] Starting subtest: unload
[361.078125] Subtest unload: SUCCESS (29.013s)
[361.163262] [066/133] (662s left) kms_psr (fbc-psr-primary-blt)
[361.263124] Starting subtest: fbc-psr-primary-blt
[361.264051] Starting dynamic subtest: eDP-1
[361.265880] Dynamic subtest eDP-1: SKIP (0.000s)
[361.268010] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[361.336213] [067/133] (662s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[361.394194] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[361.461190] [068/133] (662s left) gem_eio (throttle)
[361.680720] Starting subtest: throttle
[362.002750] Subtest throttle: SUCCESS (0.322s)
[362.161175] [069/133] (661s left) gem_eio (wait-wedge-10ms)
[362.396531] Starting subtest: wait-wedge-10ms
[363.969579] Subtest wait-wedge-10ms: SUCCESS (1.573s)
[364.083818] [070/133] (659s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[364.181146] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[365.226306] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.045s)
[365.331653] [071/133] (658s left) fbdev (unaligned-write)
[365.367672] Starting subtest: unaligned-write
[365.487869] Subtest unaligned-write: SUCCESS (0.110s)
[365.547705] [072/133] (658s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[365.651746] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[365.653593] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[365.752315] [073/133] (657s left) drm_read (empty-block)
[365.899660] Starting subtest: empty-block
[366.899314] Subtest empty-block: SUCCESS (1.000s)
[367.025954] [074/133] (656s left) syncobj_basic (bad-flags-handle-to-fd)
[367.078314] Starting subtest: bad-flags-handle-to-fd
[367.079279] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[367.164528] [075/133] (656s left) gem_exec_capture (pi)
[367.213352] Starting subtest: pi
[367.214215] Starting dynamic subtest: rcs0
[371.697747] Dynamic subtest rcs0: SUCCESS (4.484s)
[371.709238] Starting dynamic subtest: bcs0
[375.860343] Dynamic subtest bcs0: SUCCESS (4.161s)
[375.871067] Starting dynamic subtest: vcs0
[380.036192] Dynamic subtest vcs0: SUCCESS (4.173s)
[380.048025] Starting dynamic subtest: vcs1
[384.202711] Dynamic subtest vcs1: SUCCESS (4.163s)
[384.215194] Starting dynamic subtest: vecs0
[388.398218] Dynamic subtest vecs0: SUCCESS (4.192s)
[388.413381] Starting dynamic subtest: ccs0
[392.586750] Dynamic subtest ccs0: SUCCESS (4.184s)
[392.588484] Subtest pi: SUCCESS (25.367s)
[392.679304] [076/133] (631s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[392.814494] Starting subtest: psr2-overlay-plane-move-continuous-sf
[392.815427] Starting dynamic subtest: pipe-A-eDP-1
[398.798131] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.980s)
[398.810591] Starting dynamic subtest: pipe-B-eDP-1
[405.522675] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.721s)
[405.523532] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.704s)
[406.399229] [077/133] (617s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[406.510127] Starting subtest: 4-tiled-8bpp-rotate-270
[406.532015] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[406.629593] [078/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[406.721792] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[406.723558] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[406.828197] [079/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[406.921898] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[406.923707] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[407.016134] [080/133] (616s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[407.107513] Starting subtest: fbcpsr-slowdraw
[432.421623] Subtest fbcpsr-slowdraw: SUCCESS (25.319s)
[432.552962] [081/133] (591s left) api_intel_allocator (reopen-fork)
[432.606536] Starting subtest: reopen-fork
[435.903501] Subtest reopen-fork: SUCCESS (3.288s)
[435.971152] [082/133] (588s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[436.067974] Starting subtest: fbc-psr2-cursor-mmap-gtt
[436.068795] Starting dynamic subtest: eDP-1
[436.070493] Dynamic subtest eDP-1: SKIP (0.000s)
[436.072180] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[436.149125] [083/133] (587s left) gem_userptr_blits (sync-unmap)
[436.227272] Starting subtest: sync-unmap
[436.242295] Subtest sync-unmap: SUCCESS (0.014s)
[436.356078] [084/133] (587s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[436.437156] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[436.438768] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[436.508406] [085/133] (587s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[436.596121] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[436.597867] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[436.677472] [086/133] (587s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[437.230005] Starting subtest: syncobj-stationary-timeline-chain-engines
[437.359079] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.127s)
[439.054253] [087/133] (585s left) i915_query (query-regions-sanity-check)
[439.110657] Starting subtest: query-regions-sanity-check
[439.122077] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[439.239081] [088/133] (584s left) kms_plane_alpha_blend (alpha-opaque-fb)
[439.338989] Starting subtest: alpha-opaque-fb
[439.625484] Starting dynamic subtest: pipe-A-eDP-1
[440.238257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[440.246723] Starting dynamic subtest: pipe-D-eDP-1
[441.582101] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[441.582964] Subtest alpha-opaque-fb: SUCCESS (2.244s)
[442.377804] [089/133] (581s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[442.462762] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[442.464281] Starting dynamic subtest: pipe-A-eDP-1
[442.473914] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[442.483163] Starting dynamic subtest: pipe-B-eDP-1
[442.491901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[442.500236] Starting dynamic subtest: pipe-C-eDP-1
[442.508281] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[442.516353] Starting dynamic subtest: pipe-D-eDP-1
[442.525209] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[442.526883] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[444.735880] [090/133] (579s left) gem_exec_schedule (promotion)
[444.799730] Starting subtest: promotion
[444.800703] Starting dynamic subtest: rcs0
[444.905784] Dynamic subtest rcs0: SUCCESS (0.105s)
[444.918374] Starting dynamic subtest: vcs0
[445.021245] Dynamic subtest vcs0: SUCCESS (0.115s)
[445.039065] Starting dynamic subtest: vcs1
[445.116704] Dynamic subtest vcs1: SUCCESS (0.093s)
[445.128484] Starting dynamic subtest: vecs0
[445.213790] Dynamic subtest vecs0: SUCCESS (0.096s)
[445.225484] Starting dynamic subtest: ccs0
[445.317887] Dynamic subtest ccs0: SUCCESS (0.103s)
[445.319591] Subtest promotion: SUCCESS (0.519s)
[447.007596] [091/133] (577s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[447.102086] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[447.103994] Starting dynamic subtest: pipe-A-default-mode
[448.308343] Dynamic subtest pipe-A-default-mode: SKIP (1.202s)
[448.310054] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.205s)
[448.441258] [092/133] (575s left) gem_ctx_shared (detached-shared-gtt)
[448.504975] Starting subtest: detached-shared-gtt
[450.701862] Subtest detached-shared-gtt: SUCCESS (2.151s)
[451.004183] [093/133] (573s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[451.096159] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[451.097060] Starting dynamic subtest: pipe-A-eDP-1
[451.119946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[451.129755] Starting dynamic subtest: pipe-B-eDP-1
[451.143458] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[451.153230] Starting dynamic subtest: pipe-C-eDP-1
[451.167418] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[451.177235] Starting dynamic subtest: pipe-D-eDP-1
[451.190788] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[451.191860] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[453.355545] [094/133] (571s left) gem_exec_nop (basic-series)
[453.417718] Starting subtest: basic-series
[469.952087] Subtest basic-series: SUCCESS (16.522s)
[470.183510] [095/133] (554s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[470.299660] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[470.300626] Starting dynamic subtest: pipe-A-eDP-1
[470.372601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.072s)
[470.382665] Starting dynamic subtest: pipe-B-eDP-1
[470.435225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[470.444933] Starting dynamic subtest: pipe-C-eDP-1
[470.496273] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[470.506431] Starting dynamic subtest: pipe-D-eDP-1
[470.569380] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.072s)
[470.570245] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.271s)
[472.834641] [096/133] (551s left) kms_atomic (crtc-invalid-params)
[472.936424] Starting subtest: crtc-invalid-params
[472.937318] Starting dynamic subtest: pipe-A-eDP-1
[473.323919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[473.324924] Subtest crtc-invalid-params: SUCCESS (0.388s)
[474.162205] [097/133] (550s left) gem_render_copy (y-tiled-ccs-to-linear)
[474.233564] Starting subtest: y-tiled-ccs-to-linear
[474.235238] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[474.412455] [098/133] (550s left) kms_cursor_crc (cursor-onscreen-512x512)
[474.700033] Starting subtest: cursor-onscreen-512x512
[474.701686] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[474.855507] [099/133] (549s left) syncobj_wait (multi-wait-submitted)
[474.901724] Starting subtest: multi-wait-submitted
[475.008752] Subtest multi-wait-submitted: SUCCESS (0.106s)
[475.079680] [100/133] (549s left) kms_dp_aux_dev (basic)
[475.129234] Starting subtest: basic
[475.351798] Subtest basic: SUCCESS (0.221s)
[475.420214] [101/133] (549s left) syncobj_timeline (invalid-query-one-illegal-handle)
[475.479498] Starting subtest: invalid-query-one-illegal-handle
[475.480486] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[475.592753] [102/133] (549s left) gem_ctx_persistence (userptr)
[475.651202] Starting subtest: userptr
[475.839687] Subtest userptr: SUCCESS (0.188s)
[475.916445] [103/133] (548s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[476.005585] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[476.007284] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[476.086401] [104/133] (548s left) kms_getfb (getfb-handle-closed)
[476.177791] Starting subtest: getfb-handle-closed
[476.178649] Subtest getfb-handle-closed: SUCCESS (0.000s)
[476.274296] [105/133] (548s left) sw_sync (sync_multi_producer_single_consumer)
[476.307000] Starting subtest: sync_multi_producer_single_consumer
[477.390395] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[477.440698] [106/133] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[477.532814] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[477.534667] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[477.618874] [107/133] (547s left) kms_setmode (basic-clone-single-crtc)
[477.662782] Starting subtest: basic-clone-single-crtc
[477.665003] Subtest basic-clone-single-crtc: SKIP (0.000s)
[477.762820] [108/133] (547s left) gem_mmap_gtt (hang-busy)
[477.815244] Subtest hang-busy: SKIP (0.000s)
[477.868697] [109/133] (547s left) gem_exec_whisper (basic-queues-forked-all)
[477.923255] Starting subtest: basic-queues-forked-all
[498.464692] Subtest basic-queues-forked-all: SUCCESS (20.527s)
[498.649442] [110/133] (526s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[498.740826] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[498.742631] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[498.808985] [111/133] (526s left) gem_ctx_bad_destroy (invalid-pad)
[498.861943] Starting subtest: invalid-pad
[498.863006] Subtest invalid-pad: SUCCESS (0.000s)
[498.935048] [112/133] (526s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[499.310741] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[500.083650] [113/133] (524s left) gem_ctx_param (set-priority-not-supported)
[500.133363] Starting subtest: set-priority-not-supported
[500.135226] Subtest set-priority-not-supported: SKIP (0.000s)
[500.204629] [114/133] (524s left) syncobj_eventfd (binary-wait-signaled)
[500.267613] Starting subtest: binary-wait-signaled
[500.268658] Subtest binary-wait-signaled: SUCCESS (0.000s)
[500.360141] [115/133] (524s left) i915_pm_rps (reset)
[500.418159] Starting subtest: reset
[508.889312] Subtest reset: SUCCESS (8.461s)
[508.992123] [116/133] (516s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[509.085357] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[509.087109] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[509.182794] [117/133] (515s left) kms_invalid_mode (zero-vdisplay)
[509.272620] Starting subtest: zero-vdisplay
[509.273514] Starting dynamic subtest: pipe-A-eDP-1
[509.559822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[509.571382] Starting dynamic subtest: pipe-B-eDP-1
[509.572330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[509.581401] Starting dynamic subtest: pipe-C-eDP-1
[509.582866] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[509.592575] Starting dynamic subtest: pipe-D-eDP-1
[509.593508] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[509.594353] Subtest zero-vdisplay: SUCCESS (0.291s)
[510.353000] [118/133] (514s left) perf_pmu (busy-accuracy-2)
[510.388753] Starting subtest: busy-accuracy-2
[510.389867] Starting dynamic subtest: rcs0
[513.436884] Dynamic subtest rcs0: SUCCESS (3.041s)
[513.448811] Starting dynamic subtest: bcs0
[516.495224] Dynamic subtest bcs0: SUCCESS (3.055s)
[516.504574] Starting dynamic subtest: vcs0
[519.540692] Dynamic subtest vcs0: SUCCESS (3.042s)
[519.552592] Starting dynamic subtest: vcs1
[522.588270] Dynamic subtest vcs1: SUCCESS (3.044s)
[522.598775] Starting dynamic subtest: vecs0
[525.633665] Dynamic subtest vecs0: SUCCESS (3.045s)
[525.643174] Starting dynamic subtest: ccs0
[528.696169] Dynamic subtest ccs0: SUCCESS (3.057s)
[528.697126] Subtest busy-accuracy-2: SUCCESS (18.297s)
[528.812990] [119/133] (496s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[528.903095] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[528.904907] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[528.983381] [120/133] (496s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[529.081352] Starting subtest: plane-all-transition-nonblocking-fencing
[529.082246] Starting dynamic subtest: pipe-A-eDP-1
[531.579739] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[531.884962] Starting dynamic subtest: pipe-B-eDP-1
[535.093081] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.216s)
[535.391181] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.308s)
[536.215353] [121/133] (489s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[536.312269] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[536.313879] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[536.401072] [122/133] (488s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[536.488612] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[536.500266] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[536.575107] [123/133] (488s left) syncobj_basic (bad-destroy-pad)
[536.629239] Starting subtest: bad-destroy-pad
[536.630191] Subtest bad-destroy-pad: SUCCESS (0.000s)
[536.728123] [124/133] (488s left) kms_selftest (drm_dp_mst_helper)
[536.766358] Starting subtest: drm_dp_mst_helper
[536.847199] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[536.941304] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.093s)
[536.951426] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[537.041678] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.101s)
[537.050997] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[537.140375] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.098s)
[537.141259] Subtest drm_dp_mst_helper: SUCCESS (0.374s)
[537.302972] [125/133] (488s left) kms_rotation_crc (bad-tiling)
[537.389341] Starting subtest: bad-tiling
[537.391000] Subtest bad-tiling: SKIP (0.001s)
[537.476047] [126/133] (488s left) gem_spin_batch (spin-all)
[537.523994] Starting subtest: spin-all
[537.544292] Subtest spin-all: SUCCESS (0.020s)
[538.967189] [127/133] (486s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[539.068067] Starting subtest: y-tiled-16bpp-rotate-270
[539.070015] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[539.150881] [128/133] (486s left) i915_drm_fdinfo (all-busy-check-all)
[539.187332] Starting subtest: all-busy-check-all
[539.192223] Subtest all-busy-check-all: SKIP (0.004s)
[539.247985] [129/133] (486s left) gem_softpin (overlap)
[539.336733] Starting subtest: overlap
[540.365587] Subtest overlap: SUCCESS (1.029s)
[540.491363] [130/133] (485s left) perf_pmu (idle-no-semaphores)
[540.528713] Starting subtest: idle-no-semaphores
[540.530025] Starting dynamic subtest: rcs0
[541.074046] Dynamic subtest rcs0: SUCCESS (0.534s)
[541.101711] Starting dynamic subtest: bcs0
[541.598490] Dynamic subtest bcs0: SUCCESS (0.530s)
[541.609746] Starting dynamic subtest: vcs0
[542.129719] Dynamic subtest vcs0: SUCCESS (0.521s)
[542.141678] Starting dynamic subtest: vcs1
[542.645157] Dynamic subtest vcs1: SUCCESS (0.512s)
[542.656692] Starting dynamic subtest: vecs0
[543.160419] Dynamic subtest vecs0: SUCCESS (0.512s)
[543.173071] Starting dynamic subtest: ccs0
[543.677411] Dynamic subtest ccs0: SUCCESS (0.514s)
[543.678708] Subtest idle-no-semaphores: SUCCESS (3.141s)
[543.759069] [131/133] (481s left) gem_render_copy (yf-tiled-to-vebox-linear)
[543.819578] Starting subtest: yf-tiled-to-vebox-linear
[543.821327] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[544.027535] [132/133] (481s left) prime_busy (before)
[544.082787] Starting subtest: before
[544.087155] Starting dynamic subtest: rcs0
[544.125919] Dynamic subtest rcs0: SUCCESS (0.039s)
[544.137270] Starting dynamic subtest: bcs0
[544.179479] Dynamic subtest bcs0: SUCCESS (0.053s)
[544.189856] Starting dynamic subtest: vcs0
[544.222524] Dynamic subtest vcs0: SUCCESS (0.042s)
[544.231864] Starting dynamic subtest: vcs1
[544.263820] Dynamic subtest vcs1: SUCCESS (0.041s)
[544.273107] Starting dynamic subtest: vecs0
[544.307182] Dynamic subtest vecs0: SUCCESS (0.043s)
[544.316152] Starting dynamic subtest: ccs0
[544.349615] Dynamic subtest ccs0: SUCCESS (0.042s)
[544.457583] Subtest before: SUCCESS (0.374s)
[544.531921] [133/133] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[544.630725] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[544.632415] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[544.726530] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: gem_sync
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_dsc
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: gem_shrink
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_plane_multiple
results: parsing output: 18/ for test: kms_color
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_content_protection
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: vgem_slow
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: kms_scaling_modes
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: gem_ctx_engines
results: parsing output: 36/ for test: kms_pm_dc
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_caching
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_cursor_edge_walk
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: prime_vgem
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_legacy_colorkey
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_fbcon_fbt
results: parsing output: 61/ for test: core_sysfs
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_pipe_b_c_ivb
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: fbdev
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: drm_read
results: parsing output: 73/ for test: syncobj_basic
results: parsing output: 74/ for test: gem_exec_capture
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: i915_query
results: parsing output: 87/ for test: kms_plane_alpha_blend
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: gem_ctx_shared
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_nop
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_atomic
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_dp_aux_dev
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_setmode
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_ctx_bad_destroy
results: parsing output: 111/ for test: kms_chamelium_edid
results: parsing output: 112/ for test: gem_ctx_param
results: parsing output: 113/ for test: syncobj_eventfd
results: parsing output: 114/ for test: i915_pm_rps
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_invalid_mode
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: kms_selftest
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: gem_spin_batch
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.