[45.712405] Initializing watchdogs
[45.712470]   /dev/watchdog0
[45.728240] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.733976] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.736438] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.738522] [001/133] (960s left) kms_chamelium_frames (vga-frame-dump)
[45.888600] Subtest vga-frame-dump: SKIP (0.000s)
[45.987829] [002/133] (960s left) gem_userptr_blits (unsync-unmap-cycles)
[46.031390] Subtest unsync-unmap-cycles: SKIP (0.000s)
[46.152205] [003/133] (960s left) kms_flip (flip-vs-wf_vblank-interruptible)
[46.241609] Starting subtest: flip-vs-wf_vblank-interruptible
[46.244164] Starting dynamic subtest: A-HDMI-A1
[47.058379] Dynamic subtest A-HDMI-A1: SUCCESS (0.814s)
[47.071214] Starting dynamic subtest: B-HDMI-A1
[47.830194] Dynamic subtest B-HDMI-A1: SUCCESS (0.768s)
[47.838773] Starting dynamic subtest: C-HDMI-A1
[48.604472] Dynamic subtest C-HDMI-A1: SUCCESS (0.774s)
[48.611661] Starting dynamic subtest: D-HDMI-A1
[49.387637] Dynamic subtest D-HDMI-A1: SUCCESS (0.783s)
[49.388674] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (3.146s)
[49.527249] [004/133] (956s left) kms_sequence (get-forked-busy)
[49.619273] Starting subtest: get-forked-busy
[49.619987] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.935366] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.315s)
[50.943850] Starting dynamic subtest: pipe-B-HDMI-A-1
[52.219516] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.283s)
[52.226836] Starting dynamic subtest: pipe-C-HDMI-A-1
[53.506930] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.287s)
[53.514649] Starting dynamic subtest: pipe-D-HDMI-A-1
[54.816050] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.308s)
[54.816815] Subtest get-forked-busy: SUCCESS (5.197s)
[54.940595] [005/133] (951s left) gen9_exec_parse (allowed-single)
[54.982176] Subtest allowed-single: SKIP (0.000s)
[55.024992] [006/133] (951s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[55.109511] Starting subtest: plane-upscale-20x20-with-rotation
[55.110249] Starting dynamic subtest: pipe-A
[56.239917] Dynamic subtest pipe-A: SKIP (1.129s)
[56.251144] Starting dynamic subtest: pipe-B
[57.477430] Dynamic subtest pipe-B: SKIP (1.237s)
[57.484742] Starting dynamic subtest: pipe-C
[58.644608] Dynamic subtest pipe-C: SKIP (1.167s)
[58.650749] Starting dynamic subtest: pipe-D
[59.774663] Dynamic subtest pipe-D: SKIP (1.129s)
[59.776061] Subtest plane-upscale-20x20-with-rotation: SKIP (4.664s)
[59.941269] [007/133] (946s left) kms_lease (empty-lease)
[60.050944] Starting subtest: empty-lease
[60.051688] Starting dynamic subtest: pipe-A-HDMI-A-1
[60.052380] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[60.059103] Starting dynamic subtest: pipe-B-HDMI-A-1
[60.059942] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[60.066150] Starting dynamic subtest: pipe-C-HDMI-A-1
[60.066927] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[60.072419] Starting dynamic subtest: pipe-D-HDMI-A-1
[60.073117] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[60.073854] Subtest empty-lease: SUCCESS (0.010s)
[60.114482] [008/133] (946s left) kms_chamelium_frames (dp-crc-single)
[60.250842] Subtest dp-crc-single: SKIP (0.000s)
[60.337104] [009/133] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[60.426150] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[60.427657] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[60.580204] [010/133] (945s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[60.631260] Starting subtest: map-fixed-invalidate-overlap-busy
[60.632064] Starting dynamic subtest: gtt
[62.259860] Dynamic subtest gtt: SUCCESS (1.621s)
[62.265594] Starting dynamic subtest: wb
[63.784402] Dynamic subtest wb: SUCCESS (1.523s)
[63.789951] Starting dynamic subtest: wc
[65.306887] Dynamic subtest wc: SUCCESS (1.521s)
[65.312886] Starting dynamic subtest: uc
[66.862114] Dynamic subtest uc: SUCCESS (1.554s)
[66.862943] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (6.225s)
[67.179942] [011/133] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[67.309088] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[67.310553] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[67.714682] [012/133] (938s left) kms_cursor_crc (cursor-sliding-max-size)
[67.822464] Starting subtest: cursor-sliding-max-size
[67.824780] Subtest cursor-sliding-max-size: SKIP (0.000s)
[67.981785] [013/133] (938s left) kms_joiner (basic-force-ultra-joiner)
[68.113221] Starting subtest: basic-force-ultra-joiner
[68.114588] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[68.178802] [014/133] (938s left) kms_psr (fbc-psr2-sprite-blt)
[68.265380] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[68.307664] [015/133] (938s left) gem_cs_tlb (engines)
[68.344631] Starting subtest: engines
[68.345352] Starting dynamic subtest: rcs0
[70.504802] Dynamic subtest rcs0: SUCCESS (2.150s)
[70.511296] Starting dynamic subtest: bcs0
[72.680767] Dynamic subtest bcs0: SUCCESS (2.149s)
[72.686431] Starting dynamic subtest: vcs0
[74.831626] Dynamic subtest vcs0: SUCCESS (2.150s)
[74.837335] Starting dynamic subtest: vcs1
[76.982532] Dynamic subtest vcs1: SUCCESS (2.150s)
[76.988221] Starting dynamic subtest: vecs0
[79.133810] Dynamic subtest vecs0: SUCCESS (2.150s)
[79.134790] Subtest engines: SUCCESS (10.755s)
[79.192298] [016/133] (927s left) core_setmaster (master-drop-set-user)
[79.267488] Starting subtest: master-drop-set-user
[79.287195] Subtest master-drop-set-user: SUCCESS (0.020s)
[79.319215] [017/133] (927s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[79.406984] Starting subtest: plane-lut1d-ctm3x4-lut1d
[79.493201] Starting dynamic subtest: pipe-A-plane-0
[79.590145] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[79.604636] Starting dynamic subtest: pipe-A-plane-1
[79.681636] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[79.694795] Starting dynamic subtest: pipe-A-plane-2
[79.773340] Dynamic subtest pipe-A-plane-2: SUCCESS (0.089s)
[79.958229] Starting dynamic subtest: pipe-B-plane-0
[80.044641] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[80.056059] Starting dynamic subtest: pipe-B-plane-1
[80.136410] Dynamic subtest pipe-B-plane-1: SUCCESS (0.090s)
[80.149780] Starting dynamic subtest: pipe-B-plane-2
[80.228042] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[80.434289] Starting dynamic subtest: pipe-C-plane-0
[80.512652] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[80.523988] Starting dynamic subtest: pipe-C-plane-1
[80.612877] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[80.625192] Starting dynamic subtest: pipe-C-plane-2
[80.712577] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s)
[80.910376] Starting dynamic subtest: pipe-D-plane-0
[80.994861] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[81.004536] Starting dynamic subtest: pipe-D-plane-1
[81.095016] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[81.105540] Starting dynamic subtest: pipe-D-plane-2
[81.195389] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[81.244576] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (1.838s)
[81.350309] [018/133] (925s left) gem_lmem_swapping (verify-ccs)
[81.394848] Subtest verify-ccs: SKIP (0.000s)
[81.437483] [019/133] (925s left) kms_psr (pr-suspend)
[81.524457] Subtest pr-suspend: SKIP (0.000s)
[81.562947] [020/133] (925s left) gem_exec_params (invalid-fence-in-submit)
[81.599683] Starting subtest: invalid-fence-in-submit
[81.602877] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[81.703504] [021/133] (925s left) perf_pmu (all-busy-check-all)
[81.739554] Starting subtest: all-busy-check-all
[82.258174] Subtest all-busy-check-all: SUCCESS (0.518s)
[82.322570] [022/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[82.410769] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[82.412135] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[82.502743] [023/133] (924s left) sysfs_timeslice_duration (duration)
[82.540292] Starting subtest: duration
[82.542177] Starting dynamic subtest: vecs0
[82.601981] Dynamic subtest vecs0: SUCCESS (0.060s)
[82.615427] Starting dynamic subtest: vcs0
[82.673167] Dynamic subtest vcs0: SUCCESS (0.068s)
[82.687790] Starting dynamic subtest: bcs0
[82.747958] Dynamic subtest bcs0: SUCCESS (0.072s)
[82.763398] Starting dynamic subtest: rcs0
[82.818927] Dynamic subtest rcs0: SUCCESS (0.068s)
[82.836405] Starting dynamic subtest: vcs1
[82.888034] Dynamic subtest vcs1: SUCCESS (0.066s)
[82.893104] Subtest duration: SUCCESS (0.349s)
[82.953050] [024/133] (924s left) kms_fbcon_fbt (fbc-suspend)
[82.989482] Starting subtest: fbc-suspend
[129.188770] Subtest fbc-suspend: SUCCESS (16.100s)
[132.301032] [025/133] (877s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[132.408632] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[133.681511] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.273s)
[133.795641] [026/133] (876s left) gem_softpin (allocator-basic-reserve)
[133.836637] Starting subtest: allocator-basic-reserve
[133.927545] Subtest allocator-basic-reserve: SUCCESS (0.091s)
[134.032873] [027/133] (876s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[134.069869] Starting subtest: rel-constants-invalid-rel-gen5
[134.070636] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[134.178602] [028/133] (876s left) syncobj_timeline (etime-single-wait-all-submitted)
[134.212474] Starting subtest: etime-single-wait-all-submitted
[134.319031] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[134.391759] [029/133] (875s left) gem_tiled_fence_blits (basic)
[134.787009] Starting subtest: basic
[134.817724] Subtest basic: SUCCESS (0.031s)
[134.976446] [030/133] (875s left) kms_chamelium_audio (hdmi-audio)
[135.181830] Subtest hdmi-audio: SKIP (0.000s)
[135.306491] [031/133] (875s left) gem_pread (snoop)
[135.345221] Starting subtest: snoop
[136.161096] Subtest snoop: SUCCESS (0.816s)
[136.233305] [032/133] (874s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[136.319546] Starting subtest: crc-primary-suspend-y-tiled-ccs
[136.321349] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.324000] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[136.331415] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.334108] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[136.341413] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.344101] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[136.351065] Starting dynamic subtest: pipe-D-HDMI-A-1
[136.353760] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[136.355089] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.007s)
[136.552295] [033/133] (874s left) i915_selftest (live)
[137.462768] Starting subtest: live
[137.463866] Starting dynamic subtest: sanitycheck
[138.732155] Dynamic subtest sanitycheck: SUCCESS (1.262s)
[138.739144] Starting dynamic subtest: uncore
[139.939228] Dynamic subtest uncore: SUCCESS (1.205s)
[139.946811] Starting dynamic subtest: workarounds
[141.478402] Dynamic subtest workarounds: SUCCESS (1.537s)
[141.487785] Starting dynamic subtest: gt_engines
[143.240244] Dynamic subtest gt_engines: SUCCESS (1.760s)
[143.247909] Starting dynamic subtest: gt_timelines
[152.666071] Dynamic subtest gt_timelines: SUCCESS (9.424s)
[152.673265] Starting dynamic subtest: gt_contexts
[153.989286] Dynamic subtest gt_contexts: SUCCESS (1.321s)
[153.995613] Starting dynamic subtest: gt_lrc
[158.248186] Dynamic subtest gt_lrc: SUCCESS (4.256s)
[158.255998] Starting dynamic subtest: gt_mocs
[159.619094] Dynamic subtest gt_mocs: SUCCESS (1.369s)
[159.630190] Starting dynamic subtest: gt_pm
[180.941120] Dynamic subtest gt_pm: SUCCESS (21.321s)
[180.948310] Starting dynamic subtest: gt_heartbeat
[182.140073] Dynamic subtest gt_heartbeat: SUCCESS (1.197s)
[182.152343] Starting dynamic subtest: gt_tlb
[185.644194] Dynamic subtest gt_tlb: SUCCESS (3.502s)
[185.651261] Starting dynamic subtest: requests
[194.248393] Dynamic subtest requests: SUCCESS (8.602s)
[194.257630] Starting dynamic subtest: migrate
[198.537147] Dynamic subtest migrate: SUCCESS (4.286s)
[198.544601] Starting dynamic subtest: active
[199.764250] Dynamic subtest active: SUCCESS (1.225s)
[199.772179] Starting dynamic subtest: objects
[201.446046] Dynamic subtest objects: SUCCESS (1.679s)
[201.455346] Starting dynamic subtest: mman
[206.140122] Dynamic subtest mman: SUCCESS (4.692s)
[206.147374] Starting dynamic subtest: dmabuf
[207.406223] Dynamic subtest dmabuf: SUCCESS (1.264s)
[207.413667] Starting dynamic subtest: vma
[208.673054] Dynamic subtest vma: SUCCESS (1.265s)
[208.680330] Starting dynamic subtest: coherency
[211.576295] Dynamic subtest coherency: SUCCESS (2.901s)
[211.587400] Starting dynamic subtest: gtt
[219.940116] Dynamic subtest gtt: SUCCESS (8.362s)
[219.946524] Starting dynamic subtest: gem
[222.057489] Dynamic subtest gem: SUCCESS (2.114s)
[222.066941] Starting dynamic subtest: evict
[224.327386] Dynamic subtest evict: SUCCESS (2.268s)
[224.339298] Starting dynamic subtest: hugepages
[231.986354] Dynamic subtest hugepages: SUCCESS (7.657s)
[231.997230] Starting dynamic subtest: gem_contexts
[247.400930] Dynamic subtest gem_contexts: SUCCESS (15.412s)
[247.407302] Starting dynamic subtest: client
[248.705322] Dynamic subtest client: SUCCESS (1.302s)
[248.716327] Starting dynamic subtest: gem_migrate
[249.931319] Dynamic subtest gem_migrate: SUCCESS (1.224s)
[249.939494] Starting dynamic subtest: reset
[254.878287] Dynamic subtest reset: SUCCESS (4.945s)
[254.885707] Starting dynamic subtest: memory_region
[256.087319] Dynamic subtest memory_region: SUCCESS (1.207s)
[256.095024] Starting dynamic subtest: hangcheck
[286.065227] Dynamic subtest hangcheck: SUCCESS (29.975s)
[286.076432] Starting dynamic subtest: execlists
[299.786416] Dynamic subtest execlists: SUCCESS (13.719s)
[299.794274] Starting dynamic subtest: ring_submission
[300.980169] Dynamic subtest ring_submission: SUCCESS (1.192s)
[300.987478] Starting dynamic subtest: perf
[302.281345] Dynamic subtest perf: SUCCESS (1.299s)
[302.289332] Starting dynamic subtest: slpc
[303.492289] Dynamic subtest slpc: SUCCESS (1.209s)
[303.499788] Starting dynamic subtest: guc
[304.689158] Dynamic subtest guc: SUCCESS (1.195s)
[304.697038] Starting dynamic subtest: guc_multi_lrc
[305.920294] Dynamic subtest guc_multi_lrc: SUCCESS (1.229s)
[305.931653] Starting dynamic subtest: guc_hang
[307.146304] Dynamic subtest guc_hang: SUCCESS (1.224s)
[307.157340] Starting dynamic subtest: late_gt_pm
[308.408172] Dynamic subtest late_gt_pm: SUCCESS (1.260s)
[308.409017] Subtest live: SUCCESS (170.940s)
[308.434758] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[308.437889] [034/133] (702s left) kms_async_flips (async-flip-dpms)
[309.487068] Starting subtest: async-flip-dpms
[309.626042] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.113894] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (12.487s)
[322.273313] Starting dynamic subtest: pipe-B-HDMI-A-1
[324.346039] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.071s)
[324.463379] Starting dynamic subtest: pipe-C-HDMI-A-1
[326.537501] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.072s)
[326.649173] Starting dynamic subtest: pipe-D-HDMI-A-1
[328.713859] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.063s)
[328.714642] Subtest async-flip-dpms: SUCCESS (19.218s)
[328.956237] [FACT kms_async_flips (async-flip-dpms)] new: kernel.kmod_is_loaded.i915: true
[328.958575] [035/133] (681s left) perf_pmu (busy-start)
[329.000800] Starting subtest: busy-start
[329.001593] Starting dynamic subtest: rcs0
[331.549115] Dynamic subtest rcs0: SUCCESS (2.531s)
[331.559680] Starting dynamic subtest: bcs0
[334.078851] Dynamic subtest bcs0: SUCCESS (2.519s)
[334.089355] Starting dynamic subtest: vcs0
[336.576823] Dynamic subtest vcs0: SUCCESS (2.520s)
[336.589196] Starting dynamic subtest: vcs1
[339.122454] Dynamic subtest vcs1: SUCCESS (2.518s)
[339.133128] Starting dynamic subtest: vecs0
[341.618812] Dynamic subtest vecs0: SUCCESS (2.519s)
[341.622083] Subtest busy-start: SUCCESS (12.619s)
[341.691029] [036/133] (668s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[341.785146] Starting subtest: fbc-tiling-linear
[342.925366] Subtest fbc-tiling-linear: SUCCESS (1.140s)
[343.069819] [037/133] (667s left) gem_ccs (ctrl-surf-copy)
[343.107509] Starting subtest: ctrl-surf-copy
[343.109046] Subtest ctrl-surf-copy: SKIP (0.000s)
[343.168417] [038/133] (667s left) gem_exec_create (legacy)
[343.209156] Starting subtest: legacy
[343.209889] Starting dynamic subtest: smem
[345.265025] Dynamic subtest smem: SUCCESS (2.055s)
[345.265828] Subtest legacy: SUCCESS (2.056s)
[345.445269] [039/133] (665s left) gem_pread (exhaustion)
[345.478785] Starting subtest: exhaustion
[348.831744] Subtest exhaustion: SUCCESS (3.342s)
[349.103214] [FACT gem_pread (exhaustion)] new: kernel.kmod_is_loaded.vgem: true
[349.106238] [040/133] (661s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[349.193946] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[349.196123] Starting dynamic subtest: pipe-A-HDMI-A-1
[349.250555] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.055s)
[349.315912] Starting dynamic subtest: pipe-B-HDMI-A-1
[349.468801] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.160s)
[349.517165] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.323s)
[349.639895] [041/133] (661s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[349.729083] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[349.769165] [042/133] (661s left) kms_atomic (atomic-invalid-params)
[349.855766] Starting subtest: atomic-invalid-params
[349.857561] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.028370] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.171s)
[350.029086] Subtest atomic-invalid-params: SUCCESS (0.173s)
[350.157465] [043/133] (660s left) i915_drm_fdinfo (busy-hang)
[350.201714] Starting subtest: busy-hang
[350.202456] Starting dynamic subtest: rcs0
[351.229187] Dynamic subtest rcs0: SUCCESS (1.026s)
[351.242157] Starting dynamic subtest: bcs0
[352.259897] Dynamic subtest bcs0: SUCCESS (1.027s)
[352.270884] Starting dynamic subtest: vcs0
[353.286898] Dynamic subtest vcs0: SUCCESS (1.025s)
[353.297551] Starting dynamic subtest: vcs1
[354.314107] Dynamic subtest vcs1: SUCCESS (1.024s)
[354.324529] Starting dynamic subtest: vecs0
[355.340147] Dynamic subtest vecs0: SUCCESS (1.023s)
[355.341476] Subtest busy-hang: SUCCESS (5.139s)
[355.413587] [044/133] (655s left) prime_self_import (basic-with_two_bos)
[355.445825] Starting subtest: basic-with_two_bos
[355.449015] Subtest basic-with_two_bos: SUCCESS (0.003s)
[355.541888] [045/133] (655s left) kms_pm_rpm (basic-pci-d3-state)
[366.992944] Starting subtest: basic-pci-d3-state
[368.317499] Subtest basic-pci-d3-state: SUCCESS (1.321s)
[368.426936] [046/133] (642s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[368.516690] Starting subtest: flip-vs-dpms-off-vs-modeset
[368.519055] Starting dynamic subtest: A-HDMI-A1
[369.184439] Dynamic subtest A-HDMI-A1: SUCCESS (0.665s)
[369.193453] Starting dynamic subtest: B-HDMI-A1
[369.843490] Dynamic subtest B-HDMI-A1: SUCCESS (0.657s)
[369.851737] Starting dynamic subtest: C-HDMI-A1
[370.502242] Dynamic subtest C-HDMI-A1: SUCCESS (0.657s)
[370.510119] Starting dynamic subtest: D-HDMI-A1
[371.168523] Dynamic subtest D-HDMI-A1: SUCCESS (0.666s)
[371.170326] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (2.654s)
[371.280673] [047/133] (639s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[371.377480] Starting subtest: cursor-rapid-movement-256x85
[371.381836] Starting dynamic subtest: pipe-A-HDMI-A-1
[371.634818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.252s)
[371.668599] Starting dynamic subtest: pipe-D-HDMI-A-1
[371.882284] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.221s)
[371.882974] Subtest cursor-rapid-movement-256x85: SUCCESS (0.505s)
[372.022820] [048/133] (639s left) kms_rotation_crc (bad-pixel-format)
[372.108658] Starting subtest: bad-pixel-format
[373.121993] Subtest bad-pixel-format: SUCCESS (1.013s)
[373.317835] [049/133] (637s left) kms_plane_multiple (2x-tiling-none)
[373.407920] Starting subtest: 2x-tiling-none
[373.409425] Subtest 2x-tiling-none: SKIP (0.000s)
[373.467067] [050/133] (637s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[373.557056] Starting subtest: psr-shrfb-scaledprimary
[373.558499] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[373.664872] [051/133] (637s left) kms_plane (pixel-format-4-tiled-modifier)
[373.752683] Starting subtest: pixel-format-4-tiled-modifier
[373.754085] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[373.809235] [052/133] (637s left) gem_userptr_blits (set-cache-level)
[373.848982] Starting subtest: set-cache-level
[373.849713] Subtest set-cache-level: SUCCESS (0.000s)
[373.970679] [053/133] (637s left) syncobj_timeline (wait-all-snapshot)
[374.004501] Starting subtest: wait-all-snapshot
[374.086506] Subtest wait-all-snapshot: SUCCESS (0.082s)
[374.162672] [054/133] (637s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[374.259136] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[374.260535] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[374.352830] [055/133] (637s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[374.443461] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[374.444920] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[374.547227] [056/133] (636s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[374.582375] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[374.583140] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[374.651412] [057/133] (636s left) gem_ctx_persistence (legacy-engines-mixed-process)
[374.690743] Starting subtest: legacy-engines-mixed-process
[374.691510] Starting dynamic subtest: render
[375.068725] Dynamic subtest render: SUCCESS (0.378s)
[375.082896] Starting dynamic subtest: bsd1
[375.418262] Dynamic subtest bsd1: SUCCESS (0.348s)
[375.431073] Starting dynamic subtest: bsd2
[375.776269] Dynamic subtest bsd2: SUCCESS (0.355s)
[375.791916] Starting dynamic subtest: blt
[376.135649] Dynamic subtest blt: SUCCESS (0.356s)
[376.152518] Starting dynamic subtest: vebox
[376.486532] Dynamic subtest vebox: SUCCESS (0.348s)
[376.489834] Subtest legacy-engines-mixed-process: SUCCESS (1.798s)
[376.558748] [058/133] (634s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[376.657829] Starting subtest: y-tiled-64bpp-rotate-90
[376.706049] Subtest y-tiled-64bpp-rotate-90: SKIP (0.047s)
[376.813332] [059/133] (634s left) prime_vgem (shrink)
[376.883593] Starting subtest: shrink
[376.889063] Subtest shrink: SUCCESS (0.006s)
[376.998536] [060/133] (634s left) api_intel_bb (simple-bb-ctx)
[377.033623] Starting subtest: simple-bb-ctx
[377.039028] Subtest simple-bb-ctx: SUCCESS (0.006s)
[377.144307] [061/133] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[377.234312] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[377.235697] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.320405] [062/133] (634s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[377.410921] Starting subtest: dp-mst-type-1-suspend-resume
[377.412315] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[377.501734] [063/133] (634s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[377.534985] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[377.638264] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[377.714066] [064/133] (634s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[377.810017] Starting subtest: x-tiled-64bpp-rotate-0
[379.349439] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.539s)
[379.471802] [065/133] (632s left) gem_exec_reloc (basic-cpu-wc)
[379.510770] Starting subtest: basic-cpu-wc
[379.516864] Subtest basic-cpu-wc: SUCCESS (0.006s)
[379.636011] [066/133] (632s left) syncobj_timeline (reset-during-wait-for-submit)
[379.669712] Starting subtest: reset-during-wait-for-submit
[379.773332] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[379.848003] [067/133] (632s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[379.935061] Starting subtest: plane-all-modeset-transition-fencing
[379.936999] Starting dynamic subtest: pipe-A-HDMI-A-1
[392.105907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (12.135s)
[392.120580] Starting dynamic subtest: pipe-B-HDMI-A-1
[402.433479] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (10.287s)
[402.434563] Subtest plane-all-modeset-transition-fencing: SUCCESS (22.489s)
[402.566882] [068/133] (609s left) gem_lmem_swapping (basic)
[402.606498] Subtest basic: SKIP (0.000s)
[402.650481] [069/133] (609s left) syncobj_timeline (invalid-query-zero-handles)
[402.685869] Starting subtest: invalid-query-zero-handles
[402.686661] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[402.749805] [070/133] (609s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[402.839574] Starting subtest: short-flip-before-cursor-atomic-transitions
[403.368665] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.529s)
[403.501464] [071/133] (608s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[403.593094] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[404.678527] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.085s)
[404.819069] [072/133] (607s left) gem_basic (bad-close)
[404.855947] Starting subtest: bad-close
[404.857447] Subtest bad-close: SUCCESS (0.000s)
[404.923808] [073/133] (607s left) kms_psr (fbc-psr2-suspend)
[405.013210] Subtest fbc-psr2-suspend: SKIP (0.000s)
[405.057638] [074/133] (607s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[405.144667] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[405.146459] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.153049] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[405.161245] Starting dynamic subtest: pipe-B-HDMI-A-1
[405.167984] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[405.176236] Starting dynamic subtest: pipe-C-HDMI-A-1
[405.182921] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[405.190894] Starting dynamic subtest: pipe-D-HDMI-A-1
[405.197590] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[405.198914] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[405.386681] [075/133] (606s left) gem_mmap_gtt (hang-busy)
[405.421852] Starting subtest: hang-busy
[441.348318] Subtest hang-busy: SUCCESS (35.924s)
[441.466426] [076/133] (570s left) gem_exec_fence (syncobj-repeat)
[441.797843] Starting subtest: syncobj-repeat
[442.075952] Subtest syncobj-repeat: SUCCESS (0.269s)
[442.353159] [077/133] (569s left) gem_userptr_blits (usage-restrictions)
[442.391540] Starting subtest: usage-restrictions
[442.392225] Subtest usage-restrictions: SUCCESS (0.000s)
[442.524202] [078/133] (569s left) kms_addfb_basic (bad-pitch-0)
[442.557699] Starting subtest: bad-pitch-0
[442.558506] Subtest bad-pitch-0: SUCCESS (0.000s)
[442.710981] [079/133] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[442.802339] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[442.803727] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[442.884170] [080/133] (569s left) kms_psr (psr-sprite-plane-onoff)
[442.970932] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[443.015552] [081/133] (569s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[443.103958] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[443.106351] Starting dynamic subtest: pipe-A-valid-mode
[443.925637] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.820s)
[443.926380] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.822s)
[444.070559] [082/133] (568s left) kms_dp_link_training (non-uhbr-sst)
[444.160129] Starting subtest: non-uhbr-sst
[444.163013] Subtest non-uhbr-sst: SKIP (0.000s)
[444.217756] [083/133] (568s left) gem_exec_balancer (full)
[444.260321] Starting subtest: full
[445.867055] Subtest full: SUCCESS (1.607s)
[446.061560] [084/133] (566s left) gem_mmap_wc (read-write-distinct)
[446.095859] Starting subtest: read-write-distinct
[446.097734] Subtest read-write-distinct: SUCCESS (0.003s)
[446.196258] [085/133] (566s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[446.289291] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[446.290802] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[446.386884] [086/133] (566s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[446.477102] Starting subtest: cursorB-vs-flipB-atomic-transitions
[446.478671] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s)
[446.534122] [087/133] (566s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[446.622184] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[446.664406] [088/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[446.754458] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[446.755883] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[446.865948] [089/133] (565s left) kms_prime (basic-crc-hybrid)
[446.964860] Subtest basic-crc-hybrid: SKIP (0.000s)
[447.062883] [090/133] (565s left) kms_flip (2x-flip-vs-fences)
[447.156480] Starting subtest: 2x-flip-vs-fences
[447.165688] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[447.246309] [091/133] (565s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[447.332990] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[447.334948] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.341467] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[447.350068] Starting dynamic subtest: pipe-B-HDMI-A-1
[447.356666] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[447.365319] Starting dynamic subtest: pipe-C-HDMI-A-1
[447.371886] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[447.379987] Starting dynamic subtest: pipe-D-HDMI-A-1
[447.386096] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[447.386799] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.009s)
[447.575265] [092/133] (565s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[447.616835] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[447.617625] Starting dynamic subtest: smem
[447.691935] Dynamic subtest smem: SUCCESS (0.075s)
[447.692652] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.076s)
[447.871977] [093/133] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[447.960846] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[449.208398] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.247s)
[449.329425] [094/133] (563s left) gem_ctx_param (invalid-size-set)
[449.363968] Starting subtest: invalid-size-set
[449.364677] Subtest invalid-size-set: SUCCESS (0.000s)
[449.434838] [095/133] (563s left) kms_properties (colorop-properties-legacy)
[449.523677] Starting subtest: colorop-properties-legacy
[449.525818] Starting dynamic subtest: pipe-A-HDMI-A-1
[449.598477] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.073s)
[449.608217] Starting dynamic subtest: pipe-B-HDMI-A-1
[449.694622] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.095s)
[449.704178] Starting dynamic subtest: pipe-C-HDMI-A-1
[449.812529] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.116s)
[449.822063] Starting dynamic subtest: pipe-D-HDMI-A-1
[449.918621] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.104s)
[449.919383] Subtest colorop-properties-legacy: SUCCESS (0.395s)
[450.042203] [096/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[450.137319] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[450.139201] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[450.222418] [097/133] (562s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[450.308991] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[450.309706] Starting dynamic subtest: pipe-A-HDMI-A-1
[450.316973] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[450.325725] Starting dynamic subtest: pipe-B-HDMI-A-1
[450.332942] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[450.341353] Starting dynamic subtest: pipe-C-HDMI-A-1
[450.348539] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[450.356603] Starting dynamic subtest: pipe-D-HDMI-A-1
[450.363681] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[450.365036] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[450.547000] [098/133] (562s left) gem_exec_reloc (basic-wc-active)
[450.584670] Starting subtest: basic-wc-active
[450.712810] Subtest basic-wc-active: SUCCESS (0.121s)
[450.834258] [099/133] (562s left) kms_vrr (flip-suspend)
[450.921712] Starting subtest: flip-suspend
[450.923776] Subtest flip-suspend: SKIP (0.000s)
[450.984934] [100/133] (562s left) kms_pipe_crc_basic (hang-read-crc)
[451.073142] Starting subtest: hang-read-crc
[451.073909] Starting dynamic subtest: pipe-A-HDMI-A-1
[451.695983] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.622s)
[451.705307] Starting dynamic subtest: pipe-B-HDMI-A-1
[452.303167] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.605s)
[452.316201] Starting dynamic subtest: pipe-C-HDMI-A-1
[452.900154] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.595s)
[452.909435] Starting dynamic subtest: pipe-D-HDMI-A-1
[453.485648] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.583s)
[453.486371] Subtest hang-read-crc: SUCCESS (2.414s)
[453.592359] [101/133] (559s left) gem_softpin (evict-active-interruptible)
[453.632398] Starting subtest: evict-active-interruptible
[453.637200] Subtest evict-active-interruptible: SUCCESS (0.005s)
[453.751872] [102/133] (559s left) gem_fence_thrash (bo-write-verify-y)
[453.783784] Starting subtest: bo-write-verify-y
[454.930371] Subtest bo-write-verify-y: SUCCESS (1.138s)
[455.011861] [103/133] (558s left) kms_big_fb (linear-8bpp-rotate-0)
[455.112539] Starting subtest: linear-8bpp-rotate-0
[456.404342] Subtest linear-8bpp-rotate-0: SUCCESS (1.291s)
[456.526588] [104/133] (556s left) gem_render_copy (y-tiled)
[456.565509] Starting subtest: y-tiled
[456.566216] Starting dynamic subtest: smem
[456.664461] Dynamic subtest smem: SUCCESS (0.098s)
[456.665196] Subtest y-tiled: SUCCESS (0.099s)
[456.855700] [105/133] (556s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[456.943646] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[456.945046] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[457.007921] [106/133] (556s left) kms_draw_crc (draw-method-blt)
[457.096314] Starting subtest: draw-method-blt
[457.097050] Starting dynamic subtest: xrgb8888-untiled
[457.262184] Dynamic subtest xrgb8888-untiled: SUCCESS (0.165s)
[457.283120] Starting dynamic subtest: rgb565-untiled
[457.429098] Dynamic subtest rgb565-untiled: SUCCESS (0.164s)
[457.449414] Starting dynamic subtest: xrgb2101010-untiled
[457.587157] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.155s)
[457.606420] Starting dynamic subtest: xbgr16161616f-untiled
[457.753839] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.164s)
[457.773650] Starting dynamic subtest: xrgb8888-xtiled
[457.845924] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[457.867380] Starting dynamic subtest: rgb565-xtiled
[457.929007] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[457.947505] Starting dynamic subtest: xrgb2101010-xtiled
[458.003920] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.073s)
[458.022920] Starting dynamic subtest: xbgr16161616f-xtiled
[458.095881] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.089s)
[458.115666] Starting dynamic subtest: xrgb8888-ytiled
[458.187301] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.088s)
[458.206604] Starting dynamic subtest: rgb565-ytiled
[458.270700] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[458.289842] Starting dynamic subtest: xrgb2101010-ytiled
[458.354070] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[458.373625] Starting dynamic subtest: xbgr16161616f-ytiled
[458.437286] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[458.441024] Subtest draw-method-blt: SUCCESS (1.342s)
[458.550280] [107/133] (555s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[458.651229] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[458.652671] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[458.751852] [108/133] (554s left) gem_exec_whisper (basic-contexts-priority-all)
[458.795391] Starting subtest: basic-contexts-priority-all
[462.392766] Subtest basic-contexts-priority-all: SUCCESS (3.588s)
[462.570349] [109/133] (551s left) kms_hdr (static-swap)
[462.663924] Starting subtest: static-swap
[462.666133] Subtest static-swap: SKIP (0.001s)
[462.724825] [110/133] (550s left) kms_force_connector_basic (force-connector-state)
[462.851761] Starting subtest: force-connector-state
[463.209683] Subtest force-connector-state: SUCCESS (0.358s)
[463.623117] [111/133] (550s left) i915_pm_rc6_residency (rc6-accuracy)
[463.659135] Starting subtest: rc6-accuracy
[463.659853] Starting dynamic subtest: gt0
[466.862726] Dynamic subtest gt0: SUCCESS (3.168s)
[466.863508] Subtest rc6-accuracy: SUCCESS (3.171s)
[466.901142] [112/133] (546s left) i915_pm_freq_api (freq-reset-multiple)
[466.938532] Subtest freq-reset-multiple: SKIP (0.000s)
[466.985044] [113/133] (546s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[467.082485] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[467.761602] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.678s)
[467.875012] [114/133] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[467.967308] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[467.968772] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[468.074513] [115/133] (545s left) gem_exec_params (no-blt)
[468.111766] Starting subtest: no-blt
[468.114134] Subtest no-blt: SUCCESS (0.001s)
[468.219578] [116/133] (545s left) kms_vblank (ts-continuation-dpms-suspend)
[468.307249] Starting subtest: ts-continuation-dpms-suspend
[468.309532] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.034850] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.431s)
[485.049424] Starting dynamic subtest: pipe-D-HDMI-A-1
[502.011482] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.326s)
[502.012273] Subtest ts-continuation-dpms-suspend: SUCCESS (2.764s)
[511.196482] [117/133] (511s left) gem_ringfill (basic-all)
[511.441448] Starting subtest: basic-all
[512.569768] Subtest basic-all: SUCCESS (1.120s)
[512.687356] [118/133] (510s left) perf (low-oa-exponent-permissions)
[512.778871] Starting subtest: low-oa-exponent-permissions
[512.815519] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[512.859609] [119/133] (510s left) gem_ctx_persistence (engines-cleanup)
[512.897371] Starting subtest: engines-cleanup
[512.898090] Starting dynamic subtest: rcs0
[512.940307] Dynamic subtest rcs0: SUCCESS (0.042s)
[512.961403] Starting dynamic subtest: bcs0
[512.995287] Dynamic subtest bcs0: SUCCESS (0.052s)
[513.015743] Starting dynamic subtest: vcs0
[513.043369] Dynamic subtest vcs0: SUCCESS (0.046s)
[513.062661] Starting dynamic subtest: vcs1
[513.080306] Dynamic subtest vcs1: SUCCESS (0.035s)
[513.097757] Starting dynamic subtest: vecs0
[513.121414] Dynamic subtest vecs0: SUCCESS (0.039s)
[513.122573] Subtest engines-cleanup: SUCCESS (0.225s)
[513.203816] [120/133] (509s left) kms_cursor_crc (cursor-onscreen-64x64)
[513.292936] Starting subtest: cursor-onscreen-64x64
[513.297892] Starting dynamic subtest: pipe-A-HDMI-A-1
[514.482338] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.183s)
[514.516314] Starting dynamic subtest: pipe-D-HDMI-A-1
[515.655790] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.147s)
[515.656501] Subtest cursor-onscreen-64x64: SUCCESS (2.363s)
[515.831190] [121/133] (507s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[515.920843] Starting subtest: plane-scaler-unity-scaling-with-rotation
[515.921549] Starting dynamic subtest: pipe-A
[516.981263] Dynamic subtest pipe-A: SKIP (1.059s)
[516.992829] Starting dynamic subtest: pipe-B
[518.123985] Dynamic subtest pipe-B: SKIP (1.142s)
[518.133226] Starting dynamic subtest: pipe-C
[519.267586] Dynamic subtest pipe-C: SKIP (1.142s)
[519.277843] Starting dynamic subtest: pipe-D
[520.401873] Dynamic subtest pipe-D: SKIP (1.133s)
[520.403348] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (4.480s)
[520.578354] [122/133] (502s left) gem_exec_schedule (implicit-write-read)
[520.630376] Starting subtest: implicit-write-read
[520.631145] Starting dynamic subtest: rcs0
[520.693466] Dynamic subtest rcs0: SUCCESS (0.062s)
[520.704925] Starting dynamic subtest: bcs0
[520.758897] Dynamic subtest bcs0: SUCCESS (0.064s)
[520.770366] Starting dynamic subtest: vcs0
[520.824591] Dynamic subtest vcs0: SUCCESS (0.064s)
[520.835242] Starting dynamic subtest: vcs1
[520.888832] Dynamic subtest vcs1: SUCCESS (0.063s)
[520.897960] Starting dynamic subtest: vecs0
[520.950196] Dynamic subtest vecs0: SUCCESS (0.060s)
[520.950985] Subtest implicit-write-read: SUCCESS (0.320s)
[521.229435] [123/133] (502s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[521.324266] Starting subtest: psr-rgb565-draw-blt
[521.325785] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[521.421253] [124/133] (501s left) kms_psr (psr2-sprite-mmap-cpu)
[521.507528] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[521.551563] [125/133] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[521.642134] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[521.643629] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.721945] [126/133] (501s left) gem_ctx_shared (single-timeline)
[521.766767] Starting subtest: single-timeline
[521.772188] Subtest single-timeline: SUCCESS (0.005s)
[521.939221] [127/133] (501s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[522.025046] Starting subtest: plane-primary-toggle-with-vblank-wait
[522.025844] Starting dynamic subtest: pipe-A-HDMI-A-1
[522.141640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.116s)
[522.207298] Starting dynamic subtest: pipe-B-HDMI-A-1
[522.352685] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.154s)
[522.392478] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.368s)
[522.516488] [128/133] (500s left) syncobj_basic (create-signaled)
[522.551525] Starting subtest: create-signaled
[522.552230] Subtest create-signaled: SUCCESS (0.000s)
[522.616240] [129/133] (500s left) api_intel_allocator (two-level-inception-interruptible)
[522.649877] Starting subtest: two-level-inception-interruptible
[528.110863] Subtest two-level-inception-interruptible: SUCCESS (5.424s)
[528.175413] [130/133] (495s left) kms_flip (wf_vblank-ts-check-interruptible)
[528.267034] Starting subtest: wf_vblank-ts-check-interruptible
[528.269945] Starting dynamic subtest: A-HDMI-A1
[536.077792] Dynamic subtest A-HDMI-A1: SUCCESS (7.789s)
[536.088919] Starting dynamic subtest: B-HDMI-A1
[543.858810] Dynamic subtest B-HDMI-A1: SUCCESS (7.769s)
[543.867751] Starting dynamic subtest: C-HDMI-A1
[551.631947] Dynamic subtest C-HDMI-A1: SUCCESS (7.770s)
[551.641107] Starting dynamic subtest: D-HDMI-A1
[559.376533] Dynamic subtest D-HDMI-A1: SUCCESS (7.770s)
[559.378655] Subtest wf_vblank-ts-check-interruptible: SUCCESS (31.111s)
[559.558391] [131/133] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[559.649795] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[559.651204] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[559.740591] [132/133] (463s left) gem_partial_pwrite_pread (write-uncached)
[559.778107] Starting subtest: write-uncached
[570.126954] Subtest write-uncached: SUCCESS (10.349s)
[570.240602] [133/133] (453s left) gem_exec_schedule (smoketest)
[570.406768] Starting subtest: smoketest
[570.407898] Starting dynamic subtest: rcs0
[575.869297] Dynamic subtest rcs0: SUCCESS (5.420s)
[575.879575] Starting dynamic subtest: bcs0
[581.289545] Dynamic subtest bcs0: SUCCESS (5.420s)
[581.299579] Starting dynamic subtest: vcs0
[586.707911] Dynamic subtest vcs0: SUCCESS (5.417s)
[586.718455] Starting dynamic subtest: vcs1
[592.126836] Dynamic subtest vcs1: SUCCESS (5.418s)
[592.137268] Starting dynamic subtest: vecs0
[597.547672] Dynamic subtest vecs0: SUCCESS (5.417s)
[597.548666] Subtest smoketest: SUCCESS (27.100s)
[597.688388] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_sequence
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_joiner
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_cs_tlb
results: parsing output: 15/ for test: core_setmaster
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: sysfs_timeslice_duration
results: parsing output: 23/ for test: kms_fbcon_fbt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_tiled_fence_blits
results: parsing output: 29/ for test: kms_chamelium_audio
results: parsing output: 30/ for test: gem_pread
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: i915_selftest
results: parsing output: 33/ for test: kms_async_flips
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: gem_exec_create
results: parsing output: 38/ for test: gem_pread
results: parsing output: 39/ for test: kms_atomic_transition
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_atomic
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: kms_plane_multiple
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_basic
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_dp_link_training
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_prime
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: kms_properties
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_vrr
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_fence_thrash
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_draw_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: kms_hdr
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: i915_pm_rc6_residency
results: parsing output: 111/ for test: i915_pm_freq_api
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: gem_ringfill
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_shared
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_partial_pwrite_pread
results: parsing output: 132/ for test: gem_exec_schedule
Done.