[60.480106] Initializing watchdogs
[60.480209]   /dev/watchdog0
[60.495948] [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]
[60.500935] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.503744] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.506206] [001/130] (960s left) fbdev (nullptr)
[60.550961] Starting subtest: nullptr
[60.551934] Subtest nullptr: SUCCESS (0.000s)
[60.599004] [002/130] (960s left) gem_set_tiling_vs_pwrite
[60.710244] [003/130] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[60.809944] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[60.810996] Starting dynamic subtest: pipe-A-eDP-1
[60.819774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.827029] Starting dynamic subtest: pipe-B-eDP-1
[60.835397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.841384] Starting dynamic subtest: pipe-C-eDP-1
[60.850056] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.855740] Starting dynamic subtest: pipe-D-eDP-1
[60.863994] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.865710] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[63.082206] [004/130] (958s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[63.187108] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[63.188079] Starting dynamic subtest: pipe-A-default-mode
[64.329366] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[64.331480] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.145s)
[64.491374] [005/130] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[64.591451] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[64.592944] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.693457] [006/130] (956s left) dmabuf_sync_file (import-multiple-read-only)
[64.759013] Starting subtest: import-multiple-read-only
[64.760935] Subtest import-multiple-read-only: SUCCESS (0.003s)
[64.819169] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[64.821173] [007/130] (956s left) gem_mmap_gtt (big-bo)
[64.862051] Subtest big-bo: SKIP (0.000s)
[64.916948] [008/130] (956s left) vgem_basic (second-client)
[64.957994] Starting subtest: second-client
[64.980059] Subtest second-client: SUCCESS (0.022s)
[65.031019] [009/130] (956s left) tools_test (tools_test)
[65.066165] Starting subtest: tools_test
[65.138255] Subtest tools_test: SUCCESS (0.079s)
[65.193141] [010/130] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[65.280867] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[69.183369] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.909s)
[70.384906] [011/130] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[70.490005] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[75.184488] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.699s)
[76.365663] [012/130] (944s left) i915_drm_fdinfo (memory-info-resident)
[76.402383] Starting subtest: memory-info-resident
[76.403899] Starting dynamic subtest: smem0
[79.013053] Dynamic subtest smem0: SUCCESS (2.611s)
[79.014769] Subtest memory-info-resident: SUCCESS (2.611s)
[79.082154] [013/130] (942s left) gem_exec_fence (submit)
[79.263045] Starting subtest: submit
[79.265141] Subtest submit: SKIP (0.000s)
[81.360071] [014/130] (940s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[81.414081] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[81.416059] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[81.592230] [015/130] (939s left) kms_psr (fbc-pr-dpms)
[81.677527] Starting subtest: fbc-pr-dpms
[81.679535] Subtest fbc-pr-dpms: SKIP (0.000s)
[81.756069] [016/130] (939s left) kms_plane (pixel-format-linear-modifier)
[81.841452] Starting subtest: pixel-format-linear-modifier
[81.868152] Starting dynamic subtest: pipe-A-plane-0
[82.446153] Dynamic subtest pipe-A-plane-0: SUCCESS (0.578s)
[82.453872] Starting dynamic subtest: pipe-A-plane-3
[82.890099] Dynamic subtest pipe-A-plane-3: SUCCESS (0.443s)
[82.898649] Starting dynamic subtest: pipe-A-plane-5
[83.112479] Dynamic subtest pipe-A-plane-5: SUCCESS (0.222s)
[84.242919] Starting dynamic subtest: pipe-B-plane-0
[84.824362] Dynamic subtest pipe-B-plane-0: SUCCESS (0.589s)
[84.831055] Starting dynamic subtest: pipe-B-plane-3
[85.268750] Dynamic subtest pipe-B-plane-3: SUCCESS (0.443s)
[85.275951] Starting dynamic subtest: pipe-B-plane-5
[85.480122] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[85.789778] Subtest pixel-format-linear-modifier: SUCCESS (3.949s)
[86.609831] [017/130] (934s left) gem_exec_balancer (bonded-sync)
[86.670067] Starting subtest: bonded-sync
[86.671802] Subtest bonded-sync: SKIP (0.000s)
[86.981307] [018/130] (934s left) kms_legacy_colorkey (basic)
[87.056236] Starting subtest: basic
[87.057199] Starting dynamic subtest: pipe-A
[87.101397] Dynamic subtest pipe-A: SUCCESS (0.045s)
[87.111746] Starting dynamic subtest: pipe-B
[87.112929] Dynamic subtest pipe-B: SUCCESS (0.001s)
[87.119513] Starting dynamic subtest: pipe-C
[87.120611] Dynamic subtest pipe-C: SUCCESS (0.000s)
[87.127574] Starting dynamic subtest: pipe-D
[87.128645] Dynamic subtest pipe-D: SUCCESS (0.001s)
[87.129870] Subtest basic: SUCCESS (0.049s)
[87.175364] [019/130] (934s left) kms_flip (plain-flip-ts-check)
[87.257923] Starting subtest: plain-flip-ts-check
[87.260749] Starting dynamic subtest: A-eDP1
[96.138113] Dynamic subtest A-eDP1: SUCCESS (8.854s)
[96.145364] Starting dynamic subtest: B-eDP1
[104.969846] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[104.977526] Starting dynamic subtest: C-eDP1
[113.797131] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[113.806990] Starting dynamic subtest: D-eDP1
[122.620547] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[122.621709] Subtest plain-flip-ts-check: SUCCESS (35.331s)
[123.753603] [020/130] (897s left) prime_mmap (test_invalid_sync_flags)
[123.800580] Starting subtest: test_invalid_sync_flags
[123.801765] Starting dynamic subtest: test_invalid_sync_flags-smem
[123.802795] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[123.803730] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[123.900624] [021/130] (897s left) kms_prop_blob (blob-prop-validate)
[123.945766] Starting subtest: blob-prop-validate
[123.946601] Subtest blob-prop-validate: SUCCESS (0.000s)
[124.045267] [022/130] (897s left) kms_cursor_crc (cursor-onscreen-256x256)
[124.277347] Starting subtest: cursor-onscreen-256x256
[124.281217] Starting dynamic subtest: pipe-A-eDP-1
[126.410239] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[126.440105] Starting dynamic subtest: pipe-D-eDP-1
[129.237515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[129.238598] Subtest cursor-onscreen-256x256: SUCCESS (4.959s)
[130.113723] [023/130] (891s left) kms_psr (psr-sprite-plane-move)
[130.195446] Starting subtest: psr-sprite-plane-move
[130.196548] Starting dynamic subtest: eDP-1
[131.929234] Dynamic subtest eDP-1: SUCCESS (1.733s)
[131.930477] Subtest psr-sprite-plane-move: SUCCESS (1.734s)
[132.785172] [024/130] (888s left) gem_wait (busy)
[132.850451] Starting subtest: busy
[132.851459] Starting dynamic subtest: all-engines
[134.309195] Dynamic subtest all-engines: SUCCESS (1.451s)
[134.318353] Starting dynamic subtest: rcs0
[134.851577] Dynamic subtest rcs0: SUCCESS (0.550s)
[134.861450] Starting dynamic subtest: bcs0
[135.392462] Dynamic subtest bcs0: SUCCESS (0.540s)
[135.402074] Starting dynamic subtest: vcs0
[137.318841] Dynamic subtest vcs0: SUCCESS (1.917s)
[137.327635] Starting dynamic subtest: vcs1
[139.364970] Dynamic subtest vcs1: SUCCESS (2.045s)
[139.373593] Starting dynamic subtest: vecs0
[141.348838] Dynamic subtest vecs0: SUCCESS (1.983s)
[141.357990] Starting dynamic subtest: ccs0
[141.883536] Dynamic subtest ccs0: SUCCESS (0.542s)
[141.884926] Subtest busy: SUCCESS (9.034s)
[142.074895] [025/130] (879s left) gem_exec_store (pages)
[142.125234] Starting subtest: pages
[142.126321] Starting dynamic subtest: rcs0
[142.233894] Dynamic subtest rcs0: SUCCESS (0.108s)
[142.244130] Starting dynamic subtest: bcs0
[142.305502] Dynamic subtest bcs0: SUCCESS (0.071s)
[142.312448] Starting dynamic subtest: vcs0
[142.372037] Dynamic subtest vcs0: SUCCESS (0.066s)
[142.379380] Starting dynamic subtest: vcs1
[142.437917] Dynamic subtest vcs1: SUCCESS (0.065s)
[142.444688] Starting dynamic subtest: vecs0
[142.502652] Dynamic subtest vecs0: SUCCESS (0.064s)
[142.512886] Starting dynamic subtest: ccs0
[142.572460] Dynamic subtest ccs0: SUCCESS (0.069s)
[142.581321] Subtest pages: SUCCESS (0.447s)
[142.760664] [026/130] (879s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[142.809469] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[142.810558] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[142.895084] [027/130] (878s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[142.994807] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[143.832266] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.838s)
[144.011914] [028/130] (877s left) gem_ctx_isolation (dirty-create)
[144.075058] Starting subtest: dirty-create
[144.076125] Starting dynamic subtest: rcs0
[144.276583] Dynamic subtest rcs0: SUCCESS (0.201s)
[144.284590] Starting dynamic subtest: bcs0
[144.488302] Dynamic subtest bcs0: SUCCESS (0.211s)
[144.496728] Starting dynamic subtest: vcs0
[144.672526] Dynamic subtest vcs0: SUCCESS (0.184s)
[144.682057] Starting dynamic subtest: vcs1
[146.496998] Dynamic subtest vcs1: SUCCESS (1.824s)
[146.506045] Starting dynamic subtest: vecs0
[148.507897] Dynamic subtest vecs0: SUCCESS (2.010s)
[148.517792] Starting dynamic subtest: ccs0
[150.523113] Dynamic subtest ccs0: SUCCESS (2.013s)
[150.524231] Subtest dirty-create: SUCCESS (6.447s)
[150.748218] [029/130] (871s left) kms_big_fb (linear-16bpp-rotate-0)
[150.851708] Starting subtest: linear-16bpp-rotate-0
[152.241188] Subtest linear-16bpp-rotate-0: SUCCESS (1.390s)
[152.360485] [030/130] (869s left) gem_exec_params (no-bsd)
[152.425938] Starting subtest: no-bsd
[152.427071] Subtest no-bsd: SUCCESS (0.002s)
[154.404709] [031/130] (867s left) api_intel_bb (delta-check)
[154.446731] Starting subtest: delta-check
[154.452080] Subtest delta-check: SUCCESS (0.006s)
[154.582433] [032/130] (867s left) gem_mmap_offset (oob-read)
[154.633593] Starting subtest: oob-read
[154.634568] Subtest oob-read: SUCCESS (0.000s)
[154.740365] [033/130] (867s left) kms_cursor_crc (cursor-random-32x10)
[154.885683] Starting subtest: cursor-random-32x10
[154.933517] Subtest cursor-random-32x10: SKIP (0.045s)
[155.176743] [034/130] (866s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[155.224171] Starting subtest: mixed-tiled-to-y-tiled-ccs
[155.225976] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[155.418953] [035/130] (866s left) kms_chamelium_hpd (hdmi-hpd)
[155.816401] Subtest hdmi-hpd: SKIP (0.000s)
[156.583670] [036/130] (865s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[156.666532] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[163.536446] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.871s)
[163.664793] [037/130] (858s left) i915_drm_fdinfo (virtual-busy-idle-all)
[163.700445] Starting subtest: virtual-busy-idle-all
[163.701925] Subtest virtual-busy-idle-all: SKIP (0.000s)
[163.764760] [038/130] (858s left) perf (mi-rpc)
[163.871745] Starting subtest: mi-rpc
[163.873427] Subtest mi-rpc: SKIP (0.000s)
[163.907434] [039/130] (858s left) kms_flip (absolute-wf_vblank)
[163.993911] Starting subtest: absolute-wf_vblank
[163.995889] Starting dynamic subtest: A-eDP1
[172.740101] Dynamic subtest A-eDP1: SUCCESS (8.718s)
[172.750447] Starting dynamic subtest: B-eDP1
[181.470061] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[181.479753] Starting dynamic subtest: C-eDP1
[190.194192] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[190.201268] Starting dynamic subtest: D-eDP1
[198.928349] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[198.929496] Subtest absolute-wf_vblank: SUCCESS (34.900s)
[200.097757] [040/130] (822s left) kms_psr (psr-cursor-render)
[200.185287] Starting subtest: psr-cursor-render
[200.186145] Starting dynamic subtest: eDP-1
[201.919417] Dynamic subtest eDP-1: SUCCESS (1.733s)
[201.920412] Subtest psr-cursor-render: SUCCESS (1.733s)
[202.772927] [041/130] (819s left) gem_exec_schedule (u-independent)
[202.835568] Starting subtest: u-independent
[202.836570] Starting dynamic subtest: rcs0
[204.326111] Dynamic subtest rcs0: SUCCESS (1.481s)
[204.335912] Starting dynamic subtest: vcs0
[206.320255] Dynamic subtest vcs0: SUCCESS (1.993s)
[206.331529] Starting dynamic subtest: vcs1
[208.374253] Dynamic subtest vcs1: SUCCESS (2.052s)
[208.384347] Starting dynamic subtest: vecs0
[210.340779] Dynamic subtest vecs0: SUCCESS (1.965s)
[210.350223] Starting dynamic subtest: ccs0
[212.325757] Dynamic subtest ccs0: SUCCESS (1.984s)
[212.327075] Subtest u-independent: SUCCESS (9.481s)
[212.612383] [042/130] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[212.701544] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[212.703086] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[212.807762] [043/130] (809s left) kms_sequence (queue-idle)
[212.892872] Starting subtest: queue-idle
[212.894411] Starting dynamic subtest: pipe-A-eDP-1
[214.683889] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.790s)
[214.691824] Starting dynamic subtest: pipe-B-eDP-1
[217.166716] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.482s)
[217.174031] Starting dynamic subtest: pipe-C-eDP-1
[219.596489] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[219.604551] Starting dynamic subtest: pipe-D-eDP-1
[222.027314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[222.028498] Subtest queue-idle: SUCCESS (9.134s)
[222.824158] [044/130] (799s left) gem_close (many-handles-one-vma)
[222.876498] Starting subtest: many-handles-one-vma
[222.901217] Subtest many-handles-one-vma: SUCCESS (0.024s)
[223.008695] [045/130] (799s left) kms_pm_rpm (system-suspend-idle)
[224.531397] Starting subtest: system-suspend-idle
[244.600187] Subtest system-suspend-idle: SUCCESS (5.075s)
[248.029388] [046/130] (777s left) kms_psr (fbc-psr2-primary-blt)
[248.133340] Starting subtest: fbc-psr2-primary-blt
[248.134242] Starting dynamic subtest: eDP-1
[248.136058] Dynamic subtest eDP-1: SKIP (0.000s)
[248.137751] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[248.214860] [047/130] (777s left) perf_pmu (init-sema)
[248.249926] Starting subtest: init-sema
[248.251242] Starting dynamic subtest: rcs0
[248.252200] Dynamic subtest rcs0: SUCCESS (0.002s)
[248.260463] Starting dynamic subtest: bcs0
[248.261347] Dynamic subtest bcs0: SUCCESS (0.000s)
[248.269083] Starting dynamic subtest: vcs0
[248.269920] Dynamic subtest vcs0: SUCCESS (0.001s)
[248.277252] Starting dynamic subtest: vcs1
[248.278061] Dynamic subtest vcs1: SUCCESS (0.001s)
[248.285436] Starting dynamic subtest: vecs0
[248.286323] Dynamic subtest vecs0: SUCCESS (0.001s)
[248.293976] Starting dynamic subtest: ccs0
[248.294883] Dynamic subtest ccs0: SUCCESS (0.000s)
[248.295758] Subtest init-sema: SUCCESS (0.007s)
[248.356650] [048/130] (777s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[248.445581] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[248.447580] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[249.573131] [049/130] (776s left) gem_exec_flush (basic-uc-rw-default)
[249.623672] Starting subtest: basic-uc-rw-default
[255.052094] Subtest basic-uc-rw-default: SUCCESS (5.463s)
[255.235144] [050/130] (770s left) kms_content_protection (atomic-dpms-hdcp14)
[255.386714] Starting subtest: atomic-dpms-hdcp14
[255.388673] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[255.508515] [051/130] (770s left) gem_mmap_wc (write-prefaulted)
[255.562696] Subtest write-prefaulted: SKIP (0.000s)
[255.631657] [052/130] (770s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[255.715459] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[259.837280] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.136s)
[261.031015] [053/130] (764s left) kms_atomic (atomic-invalid-params)
[261.111205] Starting subtest: atomic-invalid-params
[261.112057] Starting dynamic subtest: pipe-A-eDP-1
[261.497788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[261.498863] Subtest atomic-invalid-params: SUCCESS (0.388s)
[262.352563] [054/130] (763s left) gem_ctx_engines (execute-oneforall)
[262.402682] Starting subtest: execute-oneforall
[262.939151] Subtest execute-oneforall: SUCCESS (0.537s)
[264.400042] [055/130] (761s left) i915_query (query-topology-garbage-items)
[264.452954] Starting subtest: query-topology-garbage-items
[264.454084] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[264.567204] [056/130] (761s left) kms_invalid_mode (bad-vsync-end)
[264.658210] Starting subtest: bad-vsync-end
[264.659056] Starting dynamic subtest: pipe-A-eDP-1
[264.944126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[264.952186] Starting dynamic subtest: pipe-B-eDP-1
[264.953078] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[264.960758] Starting dynamic subtest: pipe-C-eDP-1
[264.961800] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[264.969765] Starting dynamic subtest: pipe-D-eDP-1
[264.970806] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[264.972037] Subtest bad-vsync-end: SUCCESS (0.291s)
[265.783816] [057/130] (760s left) kms_busy (basic-hang)
[265.884707] Starting subtest: basic-hang
[265.885726] Starting dynamic subtest: flip-pipe-A
[266.476181] Dynamic subtest flip-pipe-A: SUCCESS (0.591s)
[266.484514] Starting dynamic subtest: modeset-pipe-A
[269.915126] Dynamic subtest modeset-pipe-A: SUCCESS (3.443s)
[269.925770] Starting dynamic subtest: flip-pipe-D
[271.124344] Dynamic subtest flip-pipe-D: SUCCESS (1.209s)
[271.134368] Starting dynamic subtest: modeset-pipe-D
[274.534755] Dynamic subtest modeset-pipe-D: SUCCESS (3.412s)
[274.536430] Subtest basic-hang: SUCCESS (8.660s)
[275.323919] [058/130] (750s left) api_intel_bb (full-batch)
[275.378741] Starting subtest: full-batch
[275.383152] Subtest full-batch: SUCCESS (0.005s)
[275.515690] [059/130] (750s left) gem_spin_batch (legacy-resubmit)
[275.561467] Starting subtest: legacy-resubmit
[275.562661] Starting dynamic subtest: default
[275.568031] Dynamic subtest default: SUCCESS (0.006s)
[275.582883] Starting dynamic subtest: render
[275.583731] Dynamic subtest render: SUCCESS (0.001s)
[275.591600] Starting dynamic subtest: bsd
[275.592415] Dynamic subtest bsd: SUCCESS (0.003s)
[275.600185] Starting dynamic subtest: bsd1
[275.601079] Dynamic subtest bsd1: SUCCESS (0.003s)
[275.608908] Starting dynamic subtest: bsd2
[275.609659] Dynamic subtest bsd2: SUCCESS (0.001s)
[275.617229] Starting dynamic subtest: blt
[275.618020] Dynamic subtest blt: SUCCESS (0.002s)
[275.625420] Starting dynamic subtest: vebox
[275.626263] Dynamic subtest vebox: SUCCESS (0.003s)
[275.627014] Subtest legacy-resubmit: SUCCESS (0.024s)
[275.802835] [060/130] (750s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[275.895496] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[275.896308] Starting dynamic subtest: pipe-A-eDP-1
[275.904399] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.913055] Starting dynamic subtest: pipe-B-eDP-1
[275.921622] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[275.929817] Starting dynamic subtest: pipe-C-eDP-1
[275.938114] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[275.946241] Starting dynamic subtest: pipe-D-eDP-1
[275.954605] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.956267] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[278.200461] [061/130] (747s left) gem_lmem_swapping (heavy-verify-multi)
[278.238358] Subtest heavy-verify-multi: SKIP (0.000s)
[278.275094] [062/130] (747s left) gem_request_retire (retire-vma-not-inactive)
[278.331530] Starting subtest: retire-vma-not-inactive
[278.391778] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[278.534369] [063/130] (747s left) gem_lmem_swapping (random)
[278.577496] Subtest random: SKIP (0.000s)
[278.613781] [064/130] (747s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[278.697399] Starting subtest: psr-indfb-scaledprimary
[284.461233] Subtest psr-indfb-scaledprimary: SUCCESS (5.764s)
[284.583242] [065/130] (741s left) gem_exec_schedule (preempt-contexts)
[284.646431] Starting subtest: preempt-contexts
[284.647478] Starting dynamic subtest: rcs0
[284.711203] Dynamic subtest rcs0: SUCCESS (0.064s)
[284.719479] Starting dynamic subtest: bcs0
[284.768275] Dynamic subtest bcs0: SUCCESS (0.056s)
[284.777046] Starting dynamic subtest: vcs0
[284.813518] Dynamic subtest vcs0: SUCCESS (0.045s)
[284.823042] Starting dynamic subtest: vcs1
[284.857090] Dynamic subtest vcs1: SUCCESS (0.043s)
[284.866015] Starting dynamic subtest: vecs0
[284.899682] Dynamic subtest vecs0: SUCCESS (0.042s)
[284.911940] Starting dynamic subtest: ccs0
[284.949556] Dynamic subtest ccs0: SUCCESS (0.049s)
[284.950561] Subtest preempt-contexts: SUCCESS (0.304s)
[286.426719] [066/130] (739s left) kms_plane_multiple (tiling-yf)
[286.519411] Starting subtest: tiling-yf
[286.520949] Subtest tiling-yf: SKIP (0.000s)
[286.586741] [067/130] (739s left) gem_ctx_param (set-priority-invalid-size)
[286.633583] Starting subtest: set-priority-invalid-size
[286.635153] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[286.697263] [068/130] (739s left) kms_addfb_basic (bad-pitch-1024)
[286.739795] Starting subtest: bad-pitch-1024
[286.740846] Subtest bad-pitch-1024: SUCCESS (0.000s)
[286.867940] [069/130] (739s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[286.918210] Subtest tiled-to-untiled: SKIP (0.000s)
[286.982894] [070/130] (739s left) gem_exec_nop (basic-sequential)
[287.035685] Starting subtest: basic-sequential
[301.778442] Subtest basic-sequential: SUCCESS (14.747s)
[302.016438] [071/130] (724s left) prime_busy (hang)
[302.069311] Starting subtest: hang
[302.071162] Starting dynamic subtest: rcs0
[327.820056] Dynamic subtest rcs0: SUCCESS (25.757s)
[327.830070] Starting dynamic subtest: bcs0
[334.977061] Dynamic subtest bcs0: SUCCESS (7.158s)
[334.987520] Starting dynamic subtest: vcs0
[341.952959] Dynamic subtest vcs0: SUCCESS (6.975s)
[341.962688] Starting dynamic subtest: vcs1
[348.991407] Dynamic subtest vcs1: SUCCESS (7.036s)
[348.999680] Starting dynamic subtest: vecs0
[355.968543] Dynamic subtest vecs0: SUCCESS (6.968s)
[355.978910] Starting dynamic subtest: ccs0
[369.868009] Dynamic subtest ccs0: SUCCESS (13.900s)
[369.869461] Subtest hang: SUCCESS (67.802s)
[369.977094] [072/130] (656s left) kms_flip (2x-dpms-vs-vblank-race)
[370.062932] Starting subtest: 2x-dpms-vs-vblank-race
[370.074735] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[370.180872] [073/130] (656s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[370.272516] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[370.273609] Starting dynamic subtest: pipe-A
[370.337946] Dynamic subtest pipe-A: SUCCESS (0.066s)
[370.346970] Starting dynamic subtest: pipe-B
[371.469604] Dynamic subtest pipe-B: SUCCESS (1.131s)
[371.480989] Starting dynamic subtest: pipe-C
[372.578731] Dynamic subtest pipe-C: SUCCESS (1.107s)
[372.586812] Starting dynamic subtest: pipe-D
[373.722162] Dynamic subtest pipe-D: SUCCESS (1.143s)
[373.722949] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.451s)
[374.864140] [074/130] (651s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[374.948874] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[374.949909] Starting dynamic subtest: pipe-A-eDP-1
[385.658576] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.709s)
[385.669462] Starting dynamic subtest: pipe-B-eDP-1
[397.087800] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.428s)
[397.089067] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.140s)
[397.936245] [075/130] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[398.029476] Starting subtest: psr-2p-primscrn-cur-indfb-move
[398.031803] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[398.120857] [076/130] (628s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[398.207200] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[405.687886] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.481s)
[405.811928] [077/130] (620s left) syncobj_timeline (invalid-signal-illegal-handle)
[405.869233] Starting subtest: invalid-signal-illegal-handle
[405.870154] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[405.979286] [078/130] (620s left) kms_color (legacy-gamma)
[406.070653] Starting subtest: legacy-gamma
[406.071665] Starting dynamic subtest: pipe-A-eDP-1
[406.781513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[406.790009] Starting dynamic subtest: pipe-B-eDP-1
[408.174855] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[408.183344] Starting dynamic subtest: pipe-C-eDP-1
[409.555810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[409.565708] Starting dynamic subtest: pipe-D-eDP-1
[410.883379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[410.884156] Subtest legacy-gamma: SUCCESS (4.814s)
[411.681422] [079/130] (615s left) kms_chamelium_frames (dp-crc-single)
[412.067024] Subtest dp-crc-single: SKIP (0.000s)
[412.878596] [080/130] (613s left) syncobj_basic (bad-create-flags)
[412.938272] Starting subtest: bad-create-flags
[412.939242] Subtest bad-create-flags: SUCCESS (0.000s)
[413.033611] [081/130] (613s left) gem_madvise (dontneed-before-exec)
[413.064874] Starting subtest: dontneed-before-exec
[413.079254] Subtest dontneed-before-exec: SKIP (0.014s)
[413.133625] [082/130] (613s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[413.182761] Subtest writes-after-reads: SKIP (0.000s)
[413.242363] [083/130] (613s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[413.294136] Starting subtest: framebuffer-vs-set-tiling
[413.296046] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[413.431136] [084/130] (613s left) kms_flip (2x-flip-vs-dpms-on-nop)
[413.515193] Starting subtest: 2x-flip-vs-dpms-on-nop
[413.525407] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[413.613704] [085/130] (613s left) gen9_exec_parse (batch-zero-length)
[413.662616] Subtest batch-zero-length: SKIP (0.000s)
[413.723882] [086/130] (613s left) gem_ctx_param (basic)
[413.767602] Starting subtest: basic
[413.768766] Subtest basic: SUCCESS (0.001s)
[413.858624] [087/130] (613s left) gem_exec_schedule (fairslice)
[413.913236] Starting subtest: fairslice
[413.914369] Starting dynamic subtest: rcs0
[415.938782] Dynamic subtest rcs0: SUCCESS (2.020s)
[415.949267] Starting dynamic subtest: bcs0
[417.960606] Dynamic subtest bcs0: SUCCESS (2.017s)
[417.971609] Starting dynamic subtest: vcs0
[419.978521] Dynamic subtest vcs0: SUCCESS (2.020s)
[419.987414] Starting dynamic subtest: vcs1
[422.003713] Dynamic subtest vcs1: SUCCESS (2.025s)
[422.013227] Starting dynamic subtest: vecs0
[424.030359] Dynamic subtest vecs0: SUCCESS (2.024s)
[424.040170] Starting dynamic subtest: ccs0
[426.051853] Dynamic subtest ccs0: SUCCESS (2.022s)
[426.052821] Subtest fairslice: SUCCESS (12.137s)
[426.344458] [088/130] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[426.449867] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[434.356057] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.908s)
[434.469021] [089/130] (592s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[434.556451] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[441.703718] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.150s)
[441.824969] [090/130] (585s left) prime_vgem (basic-write)
[441.895680] Starting subtest: basic-write
[441.909984] Subtest basic-write: SKIP (0.013s)
[442.017507] [091/130] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[442.110615] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[442.112318] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.202797] [092/130] (584s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[442.293407] Starting subtest: plane-downscale-factor-0-5-with-rotation
[442.295484] Starting dynamic subtest: pipe-A
[442.314590] Dynamic subtest pipe-A: SKIP (0.020s)
[442.322889] Starting dynamic subtest: pipe-B
[442.346990] Dynamic subtest pipe-B: SKIP (0.031s)
[442.355576] Starting dynamic subtest: pipe-C
[442.379091] Dynamic subtest pipe-C: SKIP (0.032s)
[442.389416] Starting dynamic subtest: pipe-D
[442.411350] Dynamic subtest pipe-D: SKIP (0.032s)
[442.413064] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.118s)
[442.513958] [093/130] (584s left) gem_exec_basic (basic)
[442.571524] Starting subtest: basic
[442.572605] Starting dynamic subtest: rcs0-smem
[442.575869] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[442.585524] Starting dynamic subtest: bcs0-smem
[442.586479] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[442.594509] Starting dynamic subtest: vcs0-smem
[442.595423] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[442.603321] Starting dynamic subtest: vcs1-smem
[442.604262] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[442.612157] Starting dynamic subtest: vecs0-smem
[442.613049] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[442.621218] Starting dynamic subtest: ccs0-smem
[442.622135] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[442.623123] Subtest basic: SUCCESS (0.018s)
[444.386530] [094/130] (582s left) gem_ctx_persistence (legacy-engines-mixed-process)
[444.440540] Starting subtest: legacy-engines-mixed-process
[444.441400] Starting dynamic subtest: render
[446.321042] Dynamic subtest render: SUCCESS (1.880s)
[446.330562] Starting dynamic subtest: bsd1
[448.311949] Dynamic subtest bsd1: SUCCESS (1.991s)
[448.325873] Starting dynamic subtest: bsd2
[450.301364] Dynamic subtest bsd2: SUCCESS (1.988s)
[450.313612] Starting dynamic subtest: blt
[452.255434] Dynamic subtest blt: SUCCESS (1.952s)
[452.266791] Starting dynamic subtest: vebox
[454.324372] Dynamic subtest vebox: SUCCESS (2.068s)
[454.327424] Subtest legacy-engines-mixed-process: SUCCESS (9.887s)
[454.406006] [095/130] (572s left) prime_udl
[454.473363] [096/130] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[454.571271] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[454.572873] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[454.673798] [097/130] (572s left) syncobj_eventfd (timeline-wait-before-signal)
[454.720683] Starting subtest: timeline-wait-before-signal
[454.750945] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[454.834074] [098/130] (572s left) kms_psr (pr-primary-mmap-cpu)
[454.915553] Starting subtest: pr-primary-mmap-cpu
[454.917262] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[454.987149] [099/130] (572s left) i915_pm_rps (min-max-config-loaded)
[455.048445] Starting subtest: min-max-config-loaded
[455.050382] Subtest min-max-config-loaded: SKIP (0.001s)
[455.135722] [100/130] (572s left) gem_mmap_gtt (basic-read)
[455.187176] Subtest basic-read: SKIP (0.000s)
[455.249728] [101/130] (572s left) kms_psr (fbc-psr-sprite-plane-move)
[455.342318] Starting subtest: fbc-psr-sprite-plane-move
[455.343269] Starting dynamic subtest: eDP-1
[455.344990] Dynamic subtest eDP-1: SKIP (0.000s)
[455.346923] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[455.410598] [102/130] (572s left) gem_partial_pwrite_pread (write-snoop)
[455.464589] Subtest write-snoop: SKIP (0.000s)
[455.527265] [103/130] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[455.615257] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[455.616815] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[455.729574] [104/130] (571s left) kms_plane_cursor (overlay)
[455.817449] Starting subtest: overlay
[455.819373] Starting dynamic subtest: pipe-A-eDP-1-size-64
[458.423348] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.606s)
[458.486874] Starting dynamic subtest: pipe-A-eDP-1-size-128
[461.034671] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[461.096797] Starting dynamic subtest: pipe-A-eDP-1-size-256
[463.678987] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.593s)
[464.038551] Starting dynamic subtest: pipe-B-eDP-1-size-64
[467.336819] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.313s)
[467.399801] Starting dynamic subtest: pipe-B-eDP-1-size-128
[470.050583] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.661s)
[470.111088] Starting dynamic subtest: pipe-B-eDP-1-size-256
[472.719507] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.616s)
[473.066700] Starting dynamic subtest: pipe-C-eDP-1-size-64
[476.073154] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.014s)
[476.112847] Starting dynamic subtest: pipe-C-eDP-1-size-128
[478.374084] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.269s)
[478.414035] Starting dynamic subtest: pipe-C-eDP-1-size-256
[480.641752] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[480.967459] Starting dynamic subtest: pipe-D-eDP-1-size-64
[483.919666] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.960s)
[483.958581] Starting dynamic subtest: pipe-D-eDP-1-size-128
[486.187028] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.236s)
[486.226707] Starting dynamic subtest: pipe-D-eDP-1-size-256
[488.521192] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.303s)
[488.849835] Subtest overlay: SUCCESS (33.026s)
[489.644785] [105/130] (537s left) kms_draw_crc (fill-fb)
[489.732828] Starting subtest: fill-fb
[490.241350] Subtest fill-fb: SUCCESS (0.509s)
[490.332634] [106/130] (537s left) kms_dp_link_training (non-uhbr-mst)
[490.425421] Starting subtest: non-uhbr-mst
[490.428603] Subtest non-uhbr-mst: SKIP (0.000s)
[490.496428] [107/130] (537s left) kms_dsc (dsc-with-formats)
[490.580439] Starting subtest: dsc-with-formats
[490.596454] Subtest dsc-with-formats: SKIP (0.001s)
[490.651801] [108/130] (537s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[490.771927] Starting subtest: cursorB-vs-flipB-atomic-transitions
[490.773678] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[490.911948] [109/130] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[491.001101] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[491.002761] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[491.093760] [110/130] (536s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[491.192097] Starting subtest: x-tiled-16bpp-rotate-180
[492.563610] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.372s)
[492.678270] [111/130] (535s left) syncobj_wait (invalid-single-wait-unsubmitted)
[492.729436] Starting subtest: invalid-single-wait-unsubmitted
[492.730385] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[492.859668] [112/130] (534s left) kms_big_fb (4-tiled-addfb)
[492.952059] Starting subtest: 4-tiled-addfb
[492.953074] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[493.045313] [113/130] (534s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[493.094400] Starting subtest: single-wait-for-submit-available-submitted
[493.095707] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[493.206708] [114/130] (534s left) kms_async_flips (crc-atomic)
[493.305886] Starting subtest: crc-atomic
[493.685742] Starting dynamic subtest: pipe-A-eDP-1
[496.559054] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.873s)
[496.938045] Starting dynamic subtest: pipe-B-eDP-1
[499.894287] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.965s)
[500.282483] Starting dynamic subtest: pipe-C-eDP-1
[503.219926] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.948s)
[503.585467] Starting dynamic subtest: pipe-D-eDP-1
[506.454807] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.880s)
[506.455764] Subtest crc-atomic: SUCCESS (13.147s)
[507.606783] [115/130] (520s left) gem_softpin (evict-active)
[507.667099] Starting subtest: evict-active
[507.671615] Subtest evict-active: SUCCESS (0.006s)
[507.796222] [116/130] (520s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[507.884380] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[507.886124] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[509.065918] [117/130] (518s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[509.115553] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[509.116629] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[509.221911] [118/130] (518s left) kms_chamelium_color (ctm-limited-range)
[509.308279] Subtest ctm-limited-range: SKIP (0.000s)
[509.350117] [119/130] (518s left) kms_pm_rpm (dpms-lpsp)
[511.481315] Starting subtest: dpms-lpsp
[511.790773] Subtest dpms-lpsp: SUCCESS (0.311s)
[511.872079] [120/130] (516s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[511.963896] Starting subtest: yf-tiled-64bpp-rotate-270
[511.965555] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[512.056305] [121/130] (516s left) gem_exec_params (invalid-fence-in)
[512.102447] Starting subtest: invalid-fence-in
[512.103570] Subtest invalid-fence-in: SUCCESS (0.000s)
[512.195973] [122/130] (515s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[512.297456] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[512.299709] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[512.387792] [123/130] (515s left) sysfs_preempt_timeout (idempotent)
[512.440173] Starting subtest: idempotent
[512.441117] Starting dynamic subtest: vecs0
[512.442555] Dynamic subtest vecs0: SUCCESS (0.000s)
[512.453843] Starting dynamic subtest: ccs0
[512.454790] Dynamic subtest ccs0: SUCCESS (0.000s)
[512.463333] Starting dynamic subtest: vcs0
[512.464234] Dynamic subtest vcs0: SUCCESS (0.000s)
[512.472797] Starting dynamic subtest: bcs0
[512.473766] Dynamic subtest bcs0: SUCCESS (0.000s)
[512.482101] Starting dynamic subtest: rcs0
[512.482962] Dynamic subtest rcs0: SUCCESS (0.000s)
[512.491308] Starting dynamic subtest: vcs1
[512.492195] Dynamic subtest vcs1: SUCCESS (0.000s)
[512.493055] Subtest idempotent: SUCCESS (0.007s)
[512.562548] [124/130] (515s left) kms_vrr (flipline)
[512.644715] Starting subtest: flipline
[512.647460] Subtest flipline: SKIP (0.000s)
[512.713110] [125/130] (515s left) gem_madvise (dontneed-before-mmap)
[512.743204] Starting subtest: dontneed-before-mmap
[512.768904] Subtest dontneed-before-mmap: SUCCESS (0.027s)
[512.870218] [126/130] (515s left) kms_vblank (wait-forked-hang)
[512.953566] Starting subtest: wait-forked-hang
[512.954634] Starting dynamic subtest: pipe-A-eDP-1
[539.059677] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.103s)
[539.073557] Starting dynamic subtest: pipe-D-eDP-1
[564.087689] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[564.088672] Subtest wait-forked-hang: SUCCESS (51.134s)
[564.896361] [127/130] (463s left) kms_cursor_edge_walk (128x128-right-edge)
[564.983671] Starting subtest: 128x128-right-edge
[564.984698] Starting dynamic subtest: pipe-A-eDP-1
[568.459788] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[568.469891] Starting dynamic subtest: pipe-D-eDP-1
[571.581286] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[571.582156] Subtest 128x128-right-edge: SUCCESS (6.598s)
[572.381776] [128/130] (456s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[572.475257] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[572.477673] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[572.568447] [129/130] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[572.658585] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[572.660456] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[572.755284] [130/130] (455s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[572.852506] Starting subtest: y-tiled-32bpp-rotate-0
[572.854564] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[572.933317] Closing watchdogs
results: parsing output: 0/ for test: fbdev
results: parsing output: 1/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: dmabuf_sync_file
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: vgem_basic
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_legacy_colorkey
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: prime_mmap
results: parsing output: 20/ for test: kms_prop_blob
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_wait
results: parsing output: 24/ for test: gem_exec_store
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_ctx_isolation
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_sequence
results: parsing output: 43/ for test: gem_close
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_exec_flush
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: gem_mmap_wc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic
results: parsing output: 53/ for test: gem_ctx_engines
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: gem_spin_batch
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: gem_request_retire
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_plane_multiple
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: gem_set_tiling_vs_blt
results: parsing output: 69/ for test: gem_exec_nop
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: gem_madvise
results: parsing output: 81/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: gem_ctx_param
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: gem_exec_basic
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: prime_udl
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_eventfd
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: i915_pm_rps
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_partial_pwrite_pread
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_cursor
results: parsing output: 104/ for test: kms_draw_crc
results: parsing output: 105/ for test: kms_dp_link_training
results: parsing output: 106/ for test: kms_dsc
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_chamelium_color
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: sysfs_preempt_timeout
results: parsing output: 123/ for test: kms_vrr
results: parsing output: 124/ for test: gem_madvise
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
Done.