[61.917553] Initializing watchdogs
[61.917601]   /dev/watchdog0
[61.931403] [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]
[61.935879] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.938404] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.941972] [001/131] (960s left) kms_addfb_basic (unused-modifier)
[62.024831] Starting subtest: unused-modifier
[62.026825] Subtest unused-modifier: SUCCESS (0.000s)
[62.192723] [002/131] (960s left) prime_vgem (coherency-gtt)
[62.310024] Starting subtest: coherency-gtt
[62.314668] Subtest coherency-gtt: SKIP (0.000s)
[62.439247] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[62.442808] [003/131] (960s left) gem_exec_balancer (parallel-bb-first)
[62.700595] Starting subtest: parallel-bb-first
[63.750937] Subtest parallel-bb-first: SUCCESS (1.054s)
[63.960238] [004/131] (958s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[64.072860] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[65.247383] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.178s)
[65.414696] [005/131] (957s left) perf_pmu (busy-idle-check-all)
[65.462582] Starting subtest: busy-idle-check-all
[65.464508] Starting dynamic subtest: rcs0
[66.136978] Dynamic subtest rcs0: SUCCESS (0.675s)
[66.147417] Starting dynamic subtest: bcs0
[66.789426] Dynamic subtest bcs0: SUCCESS (0.653s)
[66.799082] Starting dynamic subtest: vcs0
[67.926044] Dynamic subtest vcs0: SUCCESS (1.137s)
[67.936897] Starting dynamic subtest: vcs1
[69.913963] Dynamic subtest vcs1: SUCCESS (1.989s)
[69.923062] Starting dynamic subtest: vecs0
[71.895078] Dynamic subtest vecs0: SUCCESS (1.983s)
[71.905864] Starting dynamic subtest: ccs0
[72.551414] Dynamic subtest ccs0: SUCCESS (0.656s)
[72.554174] Subtest busy-idle-check-all: SUCCESS (7.101s)
[72.693878] [006/131] (949s left) gem_userptr_blits (coherency-sync)
[72.774732] Starting subtest: coherency-sync
[73.017652] Subtest coherency-sync: SKIP (0.203s)
[73.169195] [007/131] (949s left) gem_exec_fence (parallel)
[73.389498] Starting subtest: parallel
[73.391750] Starting dynamic subtest: rcs0
[75.542394] Dynamic subtest rcs0: SUCCESS (2.155s)
[75.554159] Starting dynamic subtest: bcs0
[77.693798] Dynamic subtest bcs0: SUCCESS (2.152s)
[77.704234] Starting dynamic subtest: vcs0
[79.847861] Dynamic subtest vcs0: SUCCESS (2.154s)
[79.859619] Starting dynamic subtest: vcs1
[82.000442] Dynamic subtest vcs1: SUCCESS (2.152s)
[82.010685] Starting dynamic subtest: vecs0
[84.152309] Dynamic subtest vecs0: SUCCESS (2.151s)
[84.162789] Starting dynamic subtest: ccs0
[86.302271] Dynamic subtest ccs0: SUCCESS (2.149s)
[86.304408] Subtest parallel: SUCCESS (12.917s)
[87.055644] [008/131] (935s left) gem_exec_reloc (basic-write-read-active)
[87.132811] Subtest basic-write-read-active: SKIP (0.000s)
[87.218073] [009/131] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[87.328793] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[87.332821] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[87.452323] [010/131] (935s left) gem_busy (parallel)
[87.635963] Starting subtest: parallel
[87.638518] Starting dynamic subtest: rcs0
[88.919680] Dynamic subtest rcs0: SUCCESS (1.282s)
[88.931840] Starting dynamic subtest: bcs0
[90.902396] Dynamic subtest bcs0: SUCCESS (1.981s)
[90.914113] Starting dynamic subtest: vcs0
[92.887632] Dynamic subtest vcs0: SUCCESS (1.984s)
[92.903923] Starting dynamic subtest: vcs1
[94.934950] Dynamic subtest vcs1: SUCCESS (2.046s)
[94.947226] Starting dynamic subtest: vecs0
[96.920913] Dynamic subtest vecs0: SUCCESS (1.984s)
[96.932803] Starting dynamic subtest: ccs0
[98.904786] Dynamic subtest ccs0: SUCCESS (1.983s)
[98.907743] Subtest parallel: SUCCESS (11.268s)
[99.188311] [011/131] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[99.295278] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[106.247073] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.957s)
[106.407024] [012/131] (916s left) kms_mmap_write_crc (main)
[106.502605] Starting subtest: main
[106.504509] Starting dynamic subtest: pipe-A-eDP-1
[110.077406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.575s)
[110.079429] Subtest main: SUCCESS (3.576s)
[110.911668] [013/131] (912s left) syncobj_wait (invalid-reset-bad-pad)
[110.972733] Starting subtest: invalid-reset-bad-pad
[110.974918] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[111.090899] [014/131] (911s left) gem_exec_reloc (basic-scanout)
[111.160538] Subtest basic-scanout: SKIP (0.000s)
[111.250960] [015/131] (911s left) kms_rotation_crc (primary-rotation-180)
[111.352204] Starting subtest: primary-rotation-180
[118.317453] Subtest primary-rotation-180: SUCCESS (6.967s)
[119.579992] [016/131] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[119.685973] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[120.720186] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.034s)
[120.856779] [017/131] (902s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[120.953169] Starting subtest: fbc-rgb565-draw-pwrite
[125.480808] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.531s)
[126.678968] [018/131] (896s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[126.794761] Starting subtest: plane-upscale-20x20-with-modifiers
[126.797514] Starting dynamic subtest: pipe-A
[127.129896] Dynamic subtest pipe-A: SUCCESS (0.338s)
[127.139859] Starting dynamic subtest: pipe-B
[128.544051] Dynamic subtest pipe-B: SUCCESS (1.414s)
[128.554468] Starting dynamic subtest: pipe-C
[129.966121] Dynamic subtest pipe-C: SUCCESS (1.422s)
[129.976174] Starting dynamic subtest: pipe-D
[131.389060] Dynamic subtest pipe-D: SUCCESS (1.422s)
[131.391426] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.598s)
[132.584873] [019/131] (890s left) kms_addfb_basic (tile-pitch-mismatch)
[132.657181] Starting subtest: tile-pitch-mismatch
[132.661666] Subtest tile-pitch-mismatch: SKIP (0.000s)
[132.826269] [020/131] (890s left) kms_getfb (getfb-reject-nv12)
[132.927306] Starting subtest: getfb-reject-nv12
[132.929663] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[133.071063] [021/131] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[133.178449] Starting subtest: psr-2p-primscrn-spr-indfb-move
[133.182592] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[133.299116] [022/131] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[133.403984] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[139.973037] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.573s)
[140.127784] [023/131] (883s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[140.223391] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[143.791372] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.570s)
[145.003107] [024/131] (878s left) kms_big_fb (linear-32bpp-rotate-270)
[145.103282] Starting subtest: linear-32bpp-rotate-270
[145.122538] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[145.279900] [025/131] (878s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[145.369904] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[145.372023] Starting dynamic subtest: pipe-A-eDP-1
[145.409100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[145.418462] Starting dynamic subtest: pipe-B-eDP-1
[145.437137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[145.445711] Starting dynamic subtest: pipe-C-eDP-1
[145.464125] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[145.472109] Starting dynamic subtest: pipe-D-eDP-1
[145.490628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[145.492469] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[147.662203] [026/131] (875s left) kms_vrr (max-min)
[147.761806] Starting subtest: max-min
[147.767808] Subtest max-min: SKIP (0.000s)
[147.862904] [027/131] (875s left) gem_tiled_partial_pwrite_pread (writes)
[147.917258] Subtest writes: SKIP (0.000s)
[147.999376] [028/131] (875s left) kms_plane_alpha_blend (constant-alpha-min)
[148.096210] Starting subtest: constant-alpha-min
[148.375344] Starting dynamic subtest: pipe-A-eDP-1
[149.110520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[149.120195] Starting dynamic subtest: pipe-D-eDP-1
[150.603443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[150.605733] Subtest constant-alpha-min: SUCCESS (2.507s)
[151.418345] [029/131] (872s left) kms_pm_lpsp (kms-lpsp)
[152.519733] Starting subtest: kms-lpsp
[152.521707] Starting dynamic subtest: pipe-A-eDP-1
[152.665698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[152.971559] Subtest kms-lpsp: SUCCESS (0.455s)
[153.860209] [030/131] (869s left) i915_drm_fdinfo (most-busy-idle-check-all)
[153.905063] Starting subtest: most-busy-idle-check-all
[153.907425] Starting dynamic subtest: rcs0
[153.911928] Dynamic subtest rcs0: SKIP (0.003s)
[153.925233] Starting dynamic subtest: bcs0
[153.929191] Dynamic subtest bcs0: SKIP (0.000s)
[153.939813] Starting dynamic subtest: vcs0
[153.944926] Dynamic subtest vcs0: SKIP (0.000s)
[153.953619] Starting dynamic subtest: vcs1
[153.958130] Dynamic subtest vcs1: SKIP (0.000s)
[153.967037] Starting dynamic subtest: vecs0
[153.971446] Dynamic subtest vecs0: SKIP (0.000s)
[153.982110] Starting dynamic subtest: ccs0
[153.986329] Dynamic subtest ccs0: SKIP (0.000s)
[153.990607] Subtest most-busy-idle-check-all: SKIP (0.008s)
[154.027271] [031/131] (869s left) gem_exec_params (invalid-fence-in)
[154.144740] Starting subtest: invalid-fence-in
[154.147195] Subtest invalid-fence-in: SUCCESS (0.000s)
[154.276430] [032/131] (869s left) kms_universal_plane (universal-plane-pageflip-windowed)
[154.373325] Starting subtest: universal-plane-pageflip-windowed
[154.375932] Starting dynamic subtest: pipe-A-eDP-1
[154.984398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[154.994731] Starting dynamic subtest: pipe-B-eDP-1
[156.177727] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s)
[156.188072] Starting dynamic subtest: pipe-C-eDP-1
[157.399056] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[157.408636] Starting dynamic subtest: pipe-D-eDP-1
[158.624028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[158.626419] Subtest universal-plane-pageflip-windowed: SUCCESS (4.251s)
[159.496254] [033/131] (864s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[164.459521] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[164.461905] Starting dynamic subtest: pipe-A-eDP-1
[171.089573] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.628s)
[171.099554] Starting dynamic subtest: pipe-B-eDP-1
[177.749295] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[177.751464] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.290s)
[178.651664] [034/131] (845s left) kms_cursor_crc (cursor-sliding-512x170)
[178.945957] Starting subtest: cursor-sliding-512x170
[178.949983] Subtest cursor-sliding-512x170: SKIP (0.001s)
[179.140012] [035/131] (844s left) gem_exec_reloc (basic-range-active)
[179.211393] Subtest basic-range-active: SKIP (0.000s)
[179.319105] [036/131] (844s left) gem_exec_flush (basic-wb-rw-before-default)
[179.387428] Starting subtest: basic-wb-rw-before-default
[184.849251] Subtest basic-wb-rw-before-default: SUCCESS (5.462s)
[185.062751] [037/131] (838s left) gem_mmap_offset (partial-unmap)
[185.131867] Starting subtest: partial-unmap
[185.133902] Starting dynamic subtest: smem0
[185.619745] Dynamic subtest smem0: SUCCESS (0.488s)
[185.622863] Subtest partial-unmap: SUCCESS (0.489s)
[185.787519] [038/131] (838s left) kms_properties (get_properties-sanity-atomic)
[185.891255] Starting subtest: get_properties-sanity-atomic
[185.893575] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[185.988874] [039/131] (838s left) kms_psr (psr2-sprite-plane-move)
[186.092320] Starting subtest: psr2-sprite-plane-move
[186.094610] Starting dynamic subtest: eDP-1
[187.845214] Dynamic subtest eDP-1: SUCCESS (1.753s)
[187.847482] Subtest psr2-sprite-plane-move: SUCCESS (1.754s)
[188.722407] [040/131] (835s left) gen9_exec_parse (bb-large)
[188.794241] Subtest bb-large: SKIP (0.000s)
[188.876611] [041/131] (835s left) kms_psr (pr-cursor-plane-move)
[188.969928] Starting subtest: pr-cursor-plane-move
[188.974191] Subtest pr-cursor-plane-move: SKIP (0.000s)
[189.065944] [042/131] (835s left) kms_cursor_crc (cursor-offscreen-32x10)
[189.236215] Starting subtest: cursor-offscreen-32x10
[189.283774] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[189.567461] [043/131] (834s left) kms_feature_discovery (display-4x)
[189.659147] Starting subtest: display-4x
[189.662803] Subtest display-4x: SKIP (0.000s)
[189.757905] [044/131] (834s left) i915_pm_rpm (gem-execbuf)
[192.095163] Starting subtest: gem-execbuf
[192.097297] Starting dynamic subtest: smem0
[193.817183] Dynamic subtest smem0: SUCCESS (1.725s)
[193.819536] Subtest gem-execbuf: SUCCESS (1.726s)
[193.927253] [045/131] (830s left) kms_dsc (dsc-with-bpc-formats)
[194.026209] Starting subtest: dsc-with-bpc-formats
[194.135953] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[194.178891] [046/131] (830s left) gem_userptr_blits (set-cache-level)
[194.261338] Starting subtest: set-cache-level
[194.265616] Subtest set-cache-level: SKIP (0.000s)
[194.415511] [047/131] (829s left) gem_ccs (large-ctrl-surf-copy)
[194.469392] Starting subtest: large-ctrl-surf-copy
[194.473852] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[194.609317] [048/131] (829s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[194.702955] Starting subtest: 4-tiled-8bpp-rotate-0
[195.895086] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[196.039148] [049/131] (828s left) syncobj_wait (single-wait-all-for-submit-signaled)
[196.094053] Starting subtest: single-wait-all-for-submit-signaled
[196.095852] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[196.213091] [050/131] (828s left) kms_pm_rpm (system-suspend-modeset)
[198.041841] Starting subtest: system-suspend-modeset
[218.180749] Subtest system-suspend-modeset: SUCCESS (8.150s)
[218.550952] [051/131] (805s left) kms_psr (fbc-psr2-primary-page-flip)
[218.660853] Starting subtest: fbc-psr2-primary-page-flip
[218.663179] Starting dynamic subtest: eDP-1
[218.667296] Dynamic subtest eDP-1: SKIP (0.000s)
[218.671382] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[218.754530] [052/131] (805s left) gem_pwrite_snooped
[218.901198] [053/131] (805s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[219.002775] Starting subtest: primary-yf-tiled-reflect-x-90
[219.006934] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[219.100954] [054/131] (805s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[219.202940] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[219.205171] Starting dynamic subtest: pipe-A-default-mode
[219.525650] Dynamic subtest pipe-A-default-mode: SKIP (0.330s)
[219.529911] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.331s)
[220.345714] [055/131] (804s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[220.451091] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[220.453093] Starting dynamic subtest: pipe-A-eDP-1
[221.185484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[221.195992] Starting dynamic subtest: pipe-B-eDP-1
[223.026977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.869s)
[223.037592] Starting dynamic subtest: pipe-C-eDP-1
[224.829706] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.824s)
[224.840689] Starting dynamic subtest: pipe-D-eDP-1
[226.650517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.833s)
[226.652708] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.272s)
[227.806390] [056/131] (796s left) device_reset (cold-reset-bound)
[227.857554] Starting subtest: cold-reset-bound
[227.861950] Subtest cold-reset-bound: SKIP (0.000s)
[227.954404] [057/131] (796s left) tools_test (tools_test)
[228.005703] Starting subtest: tools_test
[228.050450] Subtest tools_test: SUCCESS (0.063s)
[228.136942] [058/131] (796s left) syncobj_wait (single-wait-signaled)
[228.197214] Starting subtest: single-wait-signaled
[228.199332] Subtest single-wait-signaled: SUCCESS (0.000s)
[228.332248] [059/131] (796s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[228.421728] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[228.423947] Starting dynamic subtest: pipe-A-default-mode
[228.717801] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[228.722124] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.296s)
[229.542149] [060/131] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[229.641128] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[229.645483] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[229.780628] [061/131] (795s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[229.893786] Starting subtest: fbc-rgb565-draw-render
[234.113649] Subtest fbc-rgb565-draw-render: SUCCESS (4.243s)
[235.307984] [062/131] (789s left) gem_mmap_gtt (big-bo-tiledx)
[235.371121] Subtest big-bo-tiledX: SKIP (0.000s)
[235.436399] [063/131] (789s left) gem_gpgpu_fill (offset-16x16)
[235.505513] Starting subtest: offset-16x16
[235.514103] Subtest offset-16x16: SUCCESS (0.009s)
[235.697776] [064/131] (789s left) gem_exec_schedule (preempt-queue-contexts-chain)
[235.782732] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[236.094120] [065/131] (789s left) kms_lease (implicit-plane-lease)
[236.187925] Starting subtest: implicit-plane-lease
[236.190118] Subtest implicit-plane-lease: SUCCESS (0.003s)
[236.332655] [066/131] (788s left) gem_spin_batch (resubmit-new)
[236.399132] Starting subtest: resubmit-new
[236.401406] Starting dynamic subtest: rcs0
[236.406893] Dynamic subtest rcs0: SUCCESS (0.008s)
[236.418182] Starting dynamic subtest: bcs0
[236.419946] Dynamic subtest bcs0: SUCCESS (0.004s)
[236.429739] Starting dynamic subtest: vcs0
[236.431930] Dynamic subtest vcs0: SUCCESS (0.004s)
[236.440981] Starting dynamic subtest: vcs1
[236.442933] Dynamic subtest vcs1: SUCCESS (0.005s)
[236.452239] Starting dynamic subtest: vecs0
[236.454128] Dynamic subtest vecs0: SUCCESS (0.004s)
[236.463400] Starting dynamic subtest: ccs0
[236.465252] Dynamic subtest ccs0: SUCCESS (0.004s)
[236.467118] Subtest resubmit-new: SUCCESS (0.033s)
[237.988578] [067/131] (787s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[238.083157] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[238.085388] Starting dynamic subtest: pipe-A-eDP-1
[238.143132] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[238.154845] Starting dynamic subtest: pipe-B-eDP-1
[238.211673] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[238.223191] Starting dynamic subtest: pipe-C-eDP-1
[238.283266] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[238.294705] Starting dynamic subtest: pipe-D-eDP-1
[238.351126] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[238.355532] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[240.344195] [068/131] (784s left) kms_hdr (static-toggle-suspend)
[240.444134] Starting subtest: static-toggle-suspend
[240.450910] Subtest static-toggle-suspend: SKIP (0.000s)
[240.542402] [069/131] (784s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[240.668133] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[240.672616] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[240.836090] [070/131] (784s left) kms_atomic_interruptible (atomic-setmode)
[240.938625] Starting subtest: atomic-setmode
[240.940768] Starting dynamic subtest: pipe-A-eDP-1
[247.835505] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.903s)
[247.837751] Subtest atomic-setmode: SUCCESS (6.904s)
[248.662283] [071/131] (776s left) gem_ctx_persistence (legacy-engines-hang)
[248.725329] Starting subtest: legacy-engines-hang
[248.727764] Starting dynamic subtest: render
[248.822106] Dynamic subtest render: SUCCESS (0.096s)
[248.835169] Starting dynamic subtest: bsd1
[248.921725] Dynamic subtest bsd1: SUCCESS (0.097s)
[248.937194] Starting dynamic subtest: bsd2
[249.037799] Dynamic subtest bsd2: SUCCESS (0.113s)
[249.050476] Starting dynamic subtest: blt
[249.146820] Dynamic subtest blt: SUCCESS (0.106s)
[249.161983] Starting dynamic subtest: vebox
[249.249661] Dynamic subtest vebox: SUCCESS (0.100s)
[249.252315] Subtest legacy-engines-hang: SUCCESS (0.525s)
[249.354737] [072/131] (776s left) kms_chamelium_hpd (dp-hpd)
[249.741664] Subtest dp-hpd: SKIP (0.000s)
[250.540754] [073/131] (774s left) i915_pciid
[250.718298] [074/131] (774s left) kms_display_modes (extended-mode-basic)
[250.809931] Starting subtest: extended-mode-basic
[250.814162] Subtest extended-mode-basic: SKIP (0.000s)
[250.859003] [075/131] (774s left) kms_properties (colorop-properties-legacy)
[250.944948] Starting subtest: colorop-properties-legacy
[250.947136] Starting dynamic subtest: pipe-A-eDP-1
[251.318468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[251.328245] Starting dynamic subtest: pipe-B-eDP-1
[252.339183] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.021s)
[252.349266] Starting dynamic subtest: pipe-C-eDP-1
[253.374999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.032s)
[253.385128] Starting dynamic subtest: pipe-D-eDP-1
[254.398964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.022s)
[254.401194] Subtest colorop-properties-legacy: SUCCESS (3.454s)
[255.219508] [076/131] (770s left) gem_exec_balancer (indices)
[255.281777] Starting subtest: indices
[257.920248] Subtest indices: SUCCESS (2.636s)
[258.282344] [077/131] (767s left) sw_sync (sync_busy_fork_unixsocket)
[258.316134] Starting subtest: sync_busy_fork_unixsocket
[258.322010] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[258.416819] [078/131] (767s left) syncobj_timeline (multi-wait-available-signaled)
[258.469404] Starting subtest: multi-wait-available-signaled
[258.471765] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[258.599981] [079/131] (767s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[258.659633] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[258.728650] [080/131] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[258.837122] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[262.562820] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.731s)
[263.739613] [081/131] (762s left) kms_flip (basic-plain-flip)
[263.841766] Starting subtest: basic-plain-flip
[263.844193] Starting dynamic subtest: A-eDP1
[265.516567] Dynamic subtest A-eDP1: SUCCESS (1.677s)
[265.530655] Starting dynamic subtest: B-eDP1
[267.155559] Dynamic subtest B-eDP1: SUCCESS (1.636s)
[267.168232] Starting dynamic subtest: C-eDP1
[268.793411] Dynamic subtest C-eDP1: SUCCESS (1.636s)
[268.808088] Starting dynamic subtest: D-eDP1
[270.425356] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[270.430436] Subtest basic-plain-flip: SUCCESS (6.594s)
[271.630858] [082/131] (754s left) prime_mmap_coherency (write)
[271.692479] Starting subtest: write
[277.067417] Subtest write: SUCCESS (5.375s)
[277.235227] [083/131] (748s left) kms_atomic (test-only)
[277.342111] Starting subtest: test-only
[277.423310] Starting dynamic subtest: pipe-A-eDP-1
[279.935774] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.513s)
[279.938015] Subtest test-only: SUCCESS (2.596s)
[280.830161] [084/131] (745s left) gem_pxp (hw-rejects-pxp-context)
[280.963162] Starting subtest: hw-rejects-pxp-context
[280.967604] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[281.093244] [085/131] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[281.196366] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[281.200478] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[281.311474] [086/131] (744s left) gem_partial_pwrite_pread (reads-display)
[281.379147] Subtest reads-display: SKIP (0.000s)
[281.470115] [087/131] (744s left) api_intel_allocator (simple-allocator)
[281.528581] Starting subtest: simple-allocator
[281.530930] Starting dynamic subtest: basic
[281.532899] Dynamic subtest basic: SUCCESS (0.003s)
[281.546147] Starting dynamic subtest: parallel-one
[281.708536] Dynamic subtest parallel-one: SUCCESS (0.178s)
[281.718771] Starting dynamic subtest: print
[281.721123] Dynamic subtest print: SUCCESS (0.000s)
[281.734429] Starting dynamic subtest: reuse
[281.736601] Dynamic subtest reuse: SUCCESS (0.000s)
[281.746231] Starting dynamic subtest: reserve
[281.748436] Dynamic subtest reserve: SUCCESS (0.000s)
[281.758256] Starting dynamic subtest: fork-reopen-allocator
[281.760424] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[281.762560] Subtest simple-allocator: SUCCESS (0.199s)
[281.897644] [088/131] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[281.999856] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[282.003809] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[282.119995] [089/131] (744s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[287.060429] Starting subtest: pr-cursor-plane-move-continuous-sf
[287.065003] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[287.947898] [090/131] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[288.052336] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[294.609234] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.561s)
[294.772303] [091/131] (731s left) gem_exec_whisper (basic-forked-all)
[294.854221] Starting subtest: basic-forked-all
[307.387307] Subtest basic-forked-all: SUCCESS (12.540s)
[307.596799] [092/131] (718s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[307.704073] Starting subtest: fbc-psr-sprite-mmap-cpu
[307.706445] Starting dynamic subtest: eDP-1
[307.710939] Dynamic subtest eDP-1: SKIP (0.000s)
[307.715387] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[307.802012] [093/131] (718s left) kms_concurrent (multi-plane-atomic-lowres)
[307.906947] Starting subtest: multi-plane-atomic-lowres
[307.909181] Starting dynamic subtest: pipe-A-eDP-1
[308.396848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[308.399152] Subtest multi-plane-atomic-lowres: SUCCESS (0.490s)
[309.277081] [094/131] (717s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[309.336383] Starting subtest: multi-wait-for-submit-submitted-signaled
[309.338335] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[309.465022] [095/131] (716s left) kms_psr (psr-primary-page-flip)
[309.566932] Starting subtest: psr-primary-page-flip
[309.569202] Starting dynamic subtest: eDP-1
[311.340672] Dynamic subtest eDP-1: SUCCESS (1.774s)
[311.342942] Subtest psr-primary-page-flip: SUCCESS (1.775s)
[312.229569] [096/131] (714s left) gem_exec_schedule (independent)
[312.310937] Starting subtest: independent
[312.313137] Starting dynamic subtest: rcs0
[313.953591] Dynamic subtest rcs0: SUCCESS (1.650s)
[313.966147] Starting dynamic subtest: vcs0
[315.992633] Dynamic subtest vcs0: SUCCESS (2.034s)
[316.005808] Starting dynamic subtest: vcs1
[318.002545] Dynamic subtest vcs1: SUCCESS (2.006s)
[318.015245] Starting dynamic subtest: vecs0
[319.991850] Dynamic subtest vecs0: SUCCESS (1.987s)
[320.003522] Starting dynamic subtest: ccs0
[321.954424] Dynamic subtest ccs0: SUCCESS (1.959s)
[321.957190] Subtest independent: SUCCESS (9.648s)
[322.286451] [097/131] (704s left) kms_pwrite_crc
[323.974800] [098/131] (702s left) gem_mmap_gtt (cpuset-medium-copy)
[324.040549] Subtest cpuset-medium-copy: SKIP (0.000s)
[324.106483] [099/131] (702s left) sysfs_heartbeat_interval (nopreempt)
[324.172354] Starting subtest: nopreempt
[324.174617] Starting dynamic subtest: vecs0
[333.951476] Dynamic subtest vecs0: SUCCESS (9.772s)
[333.963676] Starting dynamic subtest: ccs0
[338.067766] Dynamic subtest ccs0: SUCCESS (4.115s)
[338.081644] Starting dynamic subtest: vcs0
[346.981839] Dynamic subtest vcs0: SUCCESS (8.909s)
[346.996275] Starting dynamic subtest: bcs0
[350.965146] Dynamic subtest bcs0: SUCCESS (3.983s)
[350.979334] Starting dynamic subtest: rcs0
[355.090720] Dynamic subtest rcs0: SUCCESS (4.124s)
[355.104627] Starting dynamic subtest: vcs1
[364.968093] Dynamic subtest vcs1: SUCCESS (9.876s)
[364.970715] Subtest nopreempt: SUCCESS (40.793s)
[365.072764] [100/131] (661s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[365.190668] Starting subtest: y-tiled-8bpp-rotate-270
[365.195002] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[365.326339] [101/131] (661s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[365.419673] Starting subtest: bad-pixel-format-yf-tiled-ccs
[365.421801] Starting dynamic subtest: pipe-A-eDP-1
[365.443762] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[365.455924] Starting dynamic subtest: pipe-B-eDP-1
[365.476298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[365.486351] Starting dynamic subtest: pipe-C-eDP-1
[365.507159] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[365.516962] Starting dynamic subtest: pipe-D-eDP-1
[365.538837] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[365.542929] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[367.739425] [102/131] (658s left) syncobj_timeline (wait-for-submit-snapshot)
[367.799596] Starting subtest: wait-for-submit-snapshot
[367.879153] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[367.981483] [103/131] (658s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[368.031954] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[368.132522] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[368.234576] [104/131] (658s left) kms_cursor_crc (cursor-onscreen-max-size)
[368.545934] Starting subtest: cursor-onscreen-max-size
[368.552352] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[368.699808] [105/131] (658s left) gem_exec_params (batch-first)
[368.777109] Starting subtest: batch-first
[368.780786] Subtest batch-first: SUCCESS (0.006s)
[368.949304] [106/131] (657s left) gem_ctx_shared (q-out-order)
[369.014114] Starting subtest: Q-out-order
[369.016138] Starting dynamic subtest: rcs0
[369.128464] Dynamic subtest rcs0: SUCCESS (0.111s)
[369.149658] Starting dynamic subtest: vcs0
[369.211831] Dynamic subtest vcs0: SUCCESS (0.084s)
[369.230550] Starting dynamic subtest: vcs1
[369.296936] Dynamic subtest vcs1: SUCCESS (0.084s)
[369.316071] Starting dynamic subtest: vecs0
[369.373023] Dynamic subtest vecs0: SUCCESS (0.076s)
[369.391231] Starting dynamic subtest: ccs0
[369.467650] Dynamic subtest ccs0: SUCCESS (0.093s)
[369.470669] Subtest Q-out-order: SUCCESS (0.453s)
[371.124149] [107/131] (655s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[371.231320] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[375.807314] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.579s)
[377.040898] [108/131] (649s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[377.145524] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[377.150145] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[377.278789] [109/131] (649s left) gem_mmap (pf-nonblock)
[377.340335] Subtest pf-nonblock: SKIP (0.000s)
[377.416227] [110/131] (649s left) kms_busy (basic-hang)
[377.518934] Starting subtest: basic-hang
[377.521044] Starting dynamic subtest: flip-pipe-A
[378.121496] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[378.132882] Starting dynamic subtest: modeset-pipe-A
[381.537814] Dynamic subtest modeset-pipe-A: SUCCESS (3.417s)
[381.549063] Starting dynamic subtest: flip-pipe-D
[382.744803] Dynamic subtest flip-pipe-D: SUCCESS (1.204s)
[382.758073] Starting dynamic subtest: modeset-pipe-D
[386.161644] Dynamic subtest modeset-pipe-D: SUCCESS (3.418s)
[386.164181] Subtest basic-hang: SUCCESS (8.647s)
[386.987383] [111/131] (640s left) kms_flip (busy-flip)
[387.088586] Starting subtest: busy-flip
[387.090702] Starting dynamic subtest: A-eDP1
[388.771458] Dynamic subtest A-eDP1: SUCCESS (1.685s)
[388.785414] Starting dynamic subtest: B-eDP1
[390.425233] Dynamic subtest B-eDP1: SUCCESS (1.651s)
[390.437922] Starting dynamic subtest: C-eDP1
[392.060310] Dynamic subtest C-eDP1: SUCCESS (1.634s)
[392.072329] Starting dynamic subtest: D-eDP1
[393.699445] Dynamic subtest D-eDP1: SUCCESS (1.638s)
[393.701843] Subtest busy-flip: SUCCESS (6.618s)
[394.979663] [112/131] (632s left) gem_ctx_persistence (engines-mixed)
[395.048780] Starting subtest: engines-mixed
[395.051300] Starting dynamic subtest: rcs0
[395.189097] Dynamic subtest rcs0: SUCCESS (0.140s)
[395.206092] Starting dynamic subtest: bcs0
[395.269492] Dynamic subtest bcs0: SUCCESS (0.078s)
[395.281905] Starting dynamic subtest: vcs0
[395.329609] Dynamic subtest vcs0: SUCCESS (0.058s)
[395.343115] Starting dynamic subtest: vcs1
[395.387735] Dynamic subtest vcs1: SUCCESS (0.056s)
[395.400153] Starting dynamic subtest: vecs0
[395.464759] Dynamic subtest vecs0: SUCCESS (0.074s)
[395.477925] Starting dynamic subtest: ccs0
[395.542724] Dynamic subtest ccs0: SUCCESS (0.076s)
[395.545383] Subtest engines-mixed: SUCCESS (0.495s)
[395.649098] [113/131] (631s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[395.710471] Starting subtest: invalid-multi-wait-all-unsubmitted
[395.712866] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[395.849636] [114/131] (631s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[395.950378] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[402.721105] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.773s)
[402.871047] [115/131] (624s left) gem_workarounds (reset-context)
[402.942492] Starting subtest: reset-context
[403.129936] Subtest reset-context: SUCCESS (0.186s)
[403.267185] [116/131] (624s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[403.367657] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[403.739269] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[406.560024] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[406.573347] Starting dynamic subtest: pipe-A-eDP-1-4
[408.745777] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.205s)
[408.759555] Starting dynamic subtest: pipe-A-eDP-1-4
[410.754625] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[410.767783] Starting dynamic subtest: pipe-A-eDP-1-x
[412.944277] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[413.310498] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[416.064355] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.761s)
[416.077528] Starting dynamic subtest: pipe-B-eDP-1-4
[418.249936] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[418.263635] Starting dynamic subtest: pipe-B-eDP-1-4
[420.259458] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[420.272760] Starting dynamic subtest: pipe-B-eDP-1-x
[422.449296] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[422.821416] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[425.591212] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[425.602741] Starting dynamic subtest: pipe-C-eDP-1-4
[427.765939] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[427.777409] Starting dynamic subtest: pipe-C-eDP-1-4
[429.775507] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[429.788894] Starting dynamic subtest: pipe-C-eDP-1-x
[431.965573] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[432.332562] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[435.120105] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[435.133895] Starting dynamic subtest: pipe-D-eDP-1-4
[437.294737] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[437.308103] Starting dynamic subtest: pipe-D-eDP-1-4
[439.304638] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[439.318001] Starting dynamic subtest: pipe-D-eDP-1-x
[441.493841] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[441.496403] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.133s)
[442.732299] [117/131] (584s left) gem_exec_params (invalid-ring)
[442.781472] Starting subtest: invalid-ring
[442.783845] Subtest invalid-ring: SUCCESS (0.000s)
[442.920854] [118/131] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[443.033510] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[450.071124] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.037s)
[450.256297] [119/131] (577s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[450.364157] Starting subtest: fbc-modesetfrombusy
[454.194783] Subtest fbc-modesetfrombusy: SUCCESS (3.833s)
[455.460217] [120/131] (571s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[455.572978] Starting subtest: blocking-absolute-wf_vblank-interruptible
[455.575136] Starting dynamic subtest: A-eDP1
[464.313700] Dynamic subtest A-eDP1: SUCCESS (8.736s)
[464.324654] Starting dynamic subtest: B-eDP1
[473.050060] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[473.070220] Starting dynamic subtest: C-eDP1
[481.774767] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[481.786846] Starting dynamic subtest: D-eDP1
[490.509437] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[490.512091] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.933s)
[491.749645] [121/131] (535s left) kms_plane_scaling (invalid-parameters)
[491.849299] Starting subtest: invalid-parameters
[491.851674] Starting dynamic subtest: less-than-1-height-src
[491.863296] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[491.879966] Starting dynamic subtest: less-than-1-width-src
[491.882354] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[491.884740] Subtest invalid-parameters: SUCCESS (0.028s)
[492.015436] [122/131] (535s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[492.123180] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[492.125265] Starting dynamic subtest: pipe-A-eDP-1
[492.925068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[492.935342] Starting dynamic subtest: pipe-B-eDP-1
[494.509244] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.580s)
[494.520217] Starting dynamic subtest: pipe-C-eDP-1
[496.030625] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.520s)
[496.047114] Starting dynamic subtest: pipe-D-eDP-1
[497.564717] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[497.566602] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.435s)
[498.775867] [123/131] (528s left) i915_query (query-topology-garbage-items)
[498.842498] Starting subtest: query-topology-garbage-items
[498.844472] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[498.983505] [124/131] (528s left) prime_vgem (wait)
[499.069690] Starting subtest: wait
[499.072509] Starting dynamic subtest: rcs0
[499.156842] Dynamic subtest rcs0: SUCCESS (0.086s)
[499.168246] Starting dynamic subtest: bcs0
[499.238662] Dynamic subtest bcs0: SUCCESS (0.080s)
[499.249553] Starting dynamic subtest: vcs0
[499.279212] Dynamic subtest vcs0: SUCCESS (0.042s)
[499.290038] Starting dynamic subtest: vcs1
[499.322070] Dynamic subtest vcs1: SUCCESS (0.042s)
[499.332768] Starting dynamic subtest: vecs0
[499.367632] Dynamic subtest vecs0: SUCCESS (0.044s)
[499.378288] Starting dynamic subtest: ccs0
[499.416253] Dynamic subtest ccs0: SUCCESS (0.048s)
[499.418576] Subtest wait: SUCCESS (0.347s)
[499.575936] [125/131] (528s left) gem_render_copy (y-tiled-to-vebox-linear)
[499.651005] Starting subtest: y-tiled-to-vebox-linear
[499.655356] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[499.856284] [126/131] (527s left) kms_vblank (crtc-id)
[499.947147] Starting subtest: crtc-id
[499.949091] Starting dynamic subtest: pipe-A-eDP-1
[500.402315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[500.418484] Starting dynamic subtest: pipe-D-eDP-1
[501.489937] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s)
[501.491930] Subtest crtc-id: SUCCESS (1.542s)
[502.344108] [127/131] (525s left) kms_atomic_transition (plane-all-transition-nonblocking)
[502.428115] Starting subtest: plane-all-transition-nonblocking
[502.430374] Starting dynamic subtest: pipe-A-eDP-1
[504.922377] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[505.230345] Starting dynamic subtest: pipe-B-eDP-1
[508.462244] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.243s)
[508.760953] Subtest plane-all-transition-nonblocking: SUCCESS (6.333s)
[509.616576] [128/131] (518s left) gem_mmap_wc (write-read-distinct)
[509.679613] Subtest write-read-distinct: SKIP (0.000s)
[509.748281] [129/131] (518s left) perf_pmu (render-node-busy-idle)
[509.807688] Starting subtest: render-node-busy-idle
[509.809945] Starting dynamic subtest: rcs0
[510.507805] Dynamic subtest rcs0: SUCCESS (0.699s)
[510.521087] Starting dynamic subtest: bcs0
[511.172489] Dynamic subtest bcs0: SUCCESS (0.662s)
[511.185600] Starting dynamic subtest: vcs0
[512.931101] Dynamic subtest vcs0: SUCCESS (1.754s)
[512.948826] Starting dynamic subtest: vcs1
[514.978588] Dynamic subtest vcs1: SUCCESS (2.044s)
[514.991935] Starting dynamic subtest: vecs0
[516.962584] Dynamic subtest vecs0: SUCCESS (1.981s)
[516.974176] Starting dynamic subtest: ccs0
[517.635271] Dynamic subtest ccs0: SUCCESS (0.671s)
[517.637650] Subtest render-node-busy-idle: SUCCESS (7.828s)
[517.739465] [130/131] (510s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[518.130923] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[518.908502] [131/131] (509s left) core_debugfs (read-all-entries)
[518.982016] Starting subtest: read-all-entries
[519.066307] Subtest read-all-entries: SUCCESS (0.094s)
[519.160370] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_busy
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_mmap_write_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_getfb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: kms_plane_alpha_blend
results: parsing output: 28/ for test: kms_pm_lpsp
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_universal_plane
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: gem_mmap_offset
results: parsing output: 37/ for test: kms_properties
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gen9_exec_parse
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_feature_discovery
results: parsing output: 43/ for test: i915_pm_rpm
results: parsing output: 44/ for test: kms_dsc
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_ccs
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_pwrite_snooped
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: device_reset
results: parsing output: 56/ for test: tools_test
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_gpgpu_fill
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_spin_batch
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_hdr
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_atomic_interruptible
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: i915_pciid
results: parsing output: 73/ for test: kms_display_modes
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: prime_mmap_coherency
results: parsing output: 82/ for test: kms_atomic
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_partial_pwrite_pread
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_concurrent
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_pwrite_crc
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: sysfs_heartbeat_interval
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: gem_ctx_shared
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_mmap
results: parsing output: 109/ for test: kms_busy
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_workarounds
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: i915_query
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: core_debugfs
Done.