[86.389420] Initializing watchdogs
[86.389599]   /dev/watchdog0
[86.429222] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.443801] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.450877] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.459319] [001/133] (960s left) kms_psr (fbc-psr-primary-page-flip)
[86.671164] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[86.774830] [002/133] (960s left) drm_buddy (drm_buddy)
[86.882203] Starting subtest: drm_buddy
[86.890380] Subtest drm_buddy: SKIP (0.003s)
[87.027057] [003/133] (960s left) gem_ppgtt (shrink-vs-evict-pinned)
[87.154416] Starting subtest: shrink-vs-evict-pinned
[92.222717] Subtest shrink-vs-evict-pinned: SUCCESS (5.067s)
[92.337384] [004/133] (954s left) kms_color_pipeline (plane-ctm3x4)
[92.524070] Starting subtest: plane-ctm3x4
[94.243903] Subtest plane-ctm3x4: SKIP (1.717s)
[94.537994] [005/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[94.754853] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[97.200027] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.446s)
[97.404341] [006/133] (950s left) kms_properties (colorop-properties-legacy)
[97.589084] Starting subtest: colorop-properties-legacy
[97.592633] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.102135] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.509s)
[98.123105] Starting dynamic subtest: pipe-A-HDMI-A-2
[98.437214] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.333s)
[98.466605] Starting dynamic subtest: pipe-B-HDMI-A-1
[98.741159] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.300s)
[98.778308] Starting dynamic subtest: pipe-B-HDMI-A-2
[99.068109] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.324s)
[99.107387] Starting dynamic subtest: pipe-C-HDMI-A-1
[99.432106] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.359s)
[99.453910] Starting dynamic subtest: pipe-C-HDMI-A-2
[99.852672] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.414s)
[99.857466] Subtest colorop-properties-legacy: SUCCESS (2.261s)
[100.213562] [007/133] (947s left) kms_psr (psr-sprite-mmap-cpu)
[100.420074] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[100.526467] [008/133] (947s left) kms_psr (fbc-psr2-no-drrs)
[100.713079] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[100.833366] [009/133] (946s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[101.030076] Starting subtest: async-flip-with-page-flip-events-linear
[101.638370] Subtest async-flip-with-page-flip-events-linear: SKIP (0.610s)
[101.954168] [010/133] (945s left) kms_joiner (basic-big-joiner)
[102.160516] Starting subtest: basic-big-joiner
[102.169111] Subtest basic-big-joiner: SKIP (0.000s)
[102.285307] [011/133] (945s left) sw_sync (sync_random_merge)
[102.390743] Starting subtest: sync_random_merge
[102.597610] Subtest sync_random_merge: SUCCESS (0.211s)
[102.718779] [012/133] (945s left) gen9_exec_parse (valid-registers)
[102.843380] Starting subtest: valid-registers
[103.023637] Subtest valid-registers: SUCCESS (0.178s)
[103.287612] [013/133] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[103.400624] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[103.503485] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[103.664916] [014/133] (944s left) i915_hangman (gt-engine-error)
[103.795076] Starting subtest: gt-engine-error
[103.798838] Starting dynamic subtest: rcs0
[103.882781] Dynamic subtest rcs0: SUCCESS (0.084s)
[103.909048] Starting dynamic subtest: bcs0
[103.918151] Dynamic subtest bcs0: SKIP (0.003s)
[103.944736] Starting dynamic subtest: vcs0
[103.955995] Dynamic subtest vcs0: SUCCESS (0.070s)
[103.977071] Starting dynamic subtest: vecs0
[104.028162] Dynamic subtest vecs0: SUCCESS (0.070s)
[104.031620] Subtest gt-engine-error: SUCCESS (0.232s)
[104.186477] [015/133] (944s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[104.364190] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[104.369186] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.419562] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[104.462491] Starting dynamic subtest: pipe-A-HDMI-A-2
[104.512201] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[104.538309] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.570938] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[104.590131] Starting dynamic subtest: pipe-B-HDMI-A-2
[104.622751] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[104.641932] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.674834] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[104.695047] Starting dynamic subtest: pipe-C-HDMI-A-2
[104.726394] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[104.732550] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.029s)
[105.353753] [016/133] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[105.574411] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[108.032129] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.461s)
[108.232482] [017/133] (940s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[108.439108] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[108.446137] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[108.585657] [018/133] (939s left) kms_plane (pixel-format-y-tiled-modifier)
[108.772498] Starting subtest: pixel-format-y-tiled-modifier
[108.999049] Starting dynamic subtest: pipe-A-plane-0
[109.828168] Dynamic subtest pipe-A-plane-0: SUCCESS (0.832s)
[109.848573] Starting dynamic subtest: pipe-A-plane-1
[110.644884] Dynamic subtest pipe-A-plane-1: SUCCESS (0.816s)
[110.665441] Starting dynamic subtest: pipe-A-plane-2
[111.228953] Dynamic subtest pipe-A-plane-2: SUCCESS (0.583s)
[111.249399] Starting dynamic subtest: pipe-A-plane-3
[111.794582] Dynamic subtest pipe-A-plane-3: SUCCESS (0.566s)
[111.817116] Starting dynamic subtest: pipe-A-plane-4
[111.829485] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[112.172467] Starting dynamic subtest: pipe-B-plane-0
[112.957504] Dynamic subtest pipe-B-plane-0: SUCCESS (0.800s)
[112.978481] Starting dynamic subtest: pipe-B-plane-1
[113.773193] Dynamic subtest pipe-B-plane-1: SUCCESS (0.816s)
[113.793407] Starting dynamic subtest: pipe-B-plane-2
[114.340306] Dynamic subtest pipe-B-plane-2: SUCCESS (0.566s)
[114.360452] Starting dynamic subtest: pipe-B-plane-3
[114.922059] Dynamic subtest pipe-B-plane-3: SUCCESS (0.582s)
[114.942699] Starting dynamic subtest: pipe-B-plane-4
[114.955427] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[115.257405] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.370s)
[115.884399] [019/133] (933s left) gem_exec_balancer (bonded-sync)
[116.285033] Starting subtest: bonded-sync
[120.376429] Subtest bonded-sync: SUCCESS (4.311s)
[120.627423] [020/133] (928s left) gem_close_race (multigpu-basic-threads)
[120.759764] Starting subtest: multigpu-basic-threads
[120.767537] Subtest multigpu-basic-threads: SKIP (0.000s)
[121.010462] [021/133] (928s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[121.205189] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[121.209766] Starting dynamic subtest: pipe-A
[122.256108] Dynamic subtest pipe-A: SUCCESS (1.056s)
[122.295949] Starting dynamic subtest: pipe-B
[123.388597] Dynamic subtest pipe-B: SUCCESS (1.133s)
[123.410066] Starting dynamic subtest: pipe-C
[123.835312] Dynamic subtest pipe-C: SUCCESS (0.443s)
[123.839921] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.636s)
[124.385936] [022/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[124.605361] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[124.611803] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[124.749096] [023/133] (924s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[124.944102] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[126.334148] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.390s)
[126.680919] [024/133] (922s left) kms_lease (setcrtc-implicit-plane)
[126.876796] Starting subtest: setcrtc-implicit-plane
[126.880954] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.600974] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.722s)
[127.634226] Starting dynamic subtest: pipe-A-HDMI-A-2
[128.086970] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.481s)
[128.112890] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.570387] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.472s)
[128.615083] Starting dynamic subtest: pipe-B-HDMI-A-2
[128.983159] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.414s)
[129.032090] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.432134] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.443s)
[129.486170] Starting dynamic subtest: pipe-C-HDMI-A-2
[129.924121] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.480s)
[129.928721] Subtest setcrtc-implicit-plane: SUCCESS (3.050s)
[130.287248] [025/133] (919s left) gem_tiled_fence_blits (normal)
[131.001884] Starting subtest: normal
[133.319031] Subtest normal: SUCCESS (2.320s)
[133.479667] [026/133] (916s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[133.895339] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[133.903710] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[134.042969] [027/133] (915s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[134.263975] Starting subtest: x-tiled-addfb-size-offset-overflow
[134.267228] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[134.410548] [028/133] (915s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[134.621075] Starting subtest: x-tiled-32bpp-rotate-270
[134.991381] Subtest x-tiled-32bpp-rotate-270: SKIP (0.364s)
[135.258354] [029/133] (914s left) gem_userptr_blits (userfault)
[135.397503] Starting subtest: userfault
[135.400802] Subtest userfault: SUCCESS (0.008s)
[135.589604] [030/133] (914s left) gem_userptr_blits (sync-overlap)
[135.723287] Starting subtest: sync-overlap
[135.726597] Subtest sync-overlap: SUCCESS (0.001s)
[135.888441] [031/133] (914s left) kms_chamelium_color (ctm-negative)
[136.084068] Subtest ctm-negative: SKIP (0.000s)
[136.197892] [032/133] (914s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[136.431244] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[136.441069] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[136.534166] [033/133] (913s left) sysfs_timeslice_duration (timeout)
[136.664275] Starting subtest: timeout
[136.669278] Starting dynamic subtest: vecs0
[137.502218] Dynamic subtest vecs0: SUCCESS (0.842s)
[137.525921] Starting dynamic subtest: vcs0
[138.334775] Dynamic subtest vcs0: SUCCESS (0.828s)
[138.361148] Starting dynamic subtest: bcs0
[139.161558] Dynamic subtest bcs0: SUCCESS (0.827s)
[139.188876] Starting dynamic subtest: rcs0
[140.014317] Dynamic subtest rcs0: SUCCESS (0.848s)
[140.019255] Subtest timeout: SUCCESS (3.355s)
[140.158527] [034/133] (910s left) kms_frontbuffer_tracking (psr-suspend)
[140.366151] Starting subtest: psr-suspend
[140.373053] Subtest psr-suspend: SKIP (0.000s)
[140.508618] [035/133] (910s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[140.706089] Starting subtest: cursorA-vs-flipA-varying-size
[152.162180] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.343s)
[152.716275] [036/133] (898s left) gem_mmap_gtt (flink-race)
[153.281703] Starting subtest: flink-race
[173.161950] Subtest flink-race: SUCCESS (20.067s)
[173.312462] [037/133] (877s left) gem_mmap_gtt (bad-object)
[173.425586] Starting subtest: bad-object
[173.430520] Subtest bad-object: SUCCESS (0.000s)
[173.562826] [038/133] (877s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[173.680796] Starting subtest: writes-after-reads-uncached
[194.638658] Subtest writes-after-reads-uncached: SUCCESS (20.958s)
[194.796264] [039/133] (856s left) gem_busy (busy)
[194.933205] Starting subtest: busy
[194.938209] Starting dynamic subtest: all-engines
[195.014907] Dynamic subtest all-engines: SUCCESS (0.079s)
[195.040578] Starting dynamic subtest: rcs0
[195.045715] Dynamic subtest rcs0: SUCCESS (0.013s)
[195.070438] Starting dynamic subtest: bcs0
[195.074586] Dynamic subtest bcs0: SUCCESS (0.014s)
[195.096525] Starting dynamic subtest: vcs0
[195.100546] Dynamic subtest vcs0: SUCCESS (0.010s)
[195.123080] Starting dynamic subtest: vecs0
[195.127425] Dynamic subtest vecs0: SUCCESS (0.007s)
[195.131574] Subtest busy: SUCCESS (0.141s)
[195.882448] [040/133] (855s left) prime_mmap_coherency (write)
[196.442353] Starting subtest: write
[201.587334] Subtest write: SUCCESS (5.383s)
[201.765706] [041/133] (850s left) gem_reg_read (timestamp-monotonic)
[201.874084] Starting subtest: timestamp-monotonic
[206.664092] Subtest timestamp-monotonic: SUCCESS (4.792s)
[206.814192] [042/133] (845s left) kms_plane_alpha_blend (alpha-7efc)
[207.009019] Starting subtest: alpha-7efc
[207.224351] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.340975] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.112s)
[208.443477] Starting dynamic subtest: pipe-C-HDMI-A-1
[209.251125] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.862s)
[209.259320] Subtest alpha-7efc: SUCCESS (2.246s)
[209.607407] [043/133] (842s left) syncobj_wait (multi-wait-submitted)
[209.741442] Starting subtest: multi-wait-submitted
[209.853498] Subtest multi-wait-submitted: SUCCESS (0.109s)
[209.994867] [044/133] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[210.221469] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[210.228866] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[210.362417] [045/133] (841s left) i915_selftest (live)
[211.915074] Starting subtest: live
[211.920455] Starting dynamic subtest: sanitycheck
[214.532265] Dynamic subtest sanitycheck: SUCCESS (2.616s)
[214.555577] Starting dynamic subtest: uncore
[216.971875] Dynamic subtest uncore: SUCCESS (2.434s)
[216.996105] Starting dynamic subtest: workarounds
[219.619130] Dynamic subtest workarounds: SUCCESS (2.643s)
[219.662151] Starting dynamic subtest: gt_engines
[222.586728] Dynamic subtest gt_engines: SUCCESS (2.965s)
[222.609626] Starting dynamic subtest: gt_timelines
[238.913274] Dynamic subtest gt_timelines: SUCCESS (16.324s)
[238.943252] Starting dynamic subtest: gt_contexts
[241.673848] Dynamic subtest gt_contexts: SUCCESS (2.753s)
[241.698387] Starting dynamic subtest: gt_lrc
[247.146884] Dynamic subtest gt_lrc: SUCCESS (5.469s)
[247.171382] Starting dynamic subtest: gt_mocs
[249.656150] Dynamic subtest gt_mocs: SUCCESS (2.507s)
[249.734297] Starting dynamic subtest: gt_pm
[260.771501] Dynamic subtest gt_pm: SUCCESS (11.112s)
[260.796368] Starting dynamic subtest: gt_heartbeat
[263.275658] Dynamic subtest gt_heartbeat: SUCCESS (2.499s)
[263.298561] Starting dynamic subtest: gt_tlb
[267.243845] Dynamic subtest gt_tlb: SUCCESS (3.963s)
[267.268332] Starting dynamic subtest: requests
[276.320520] Dynamic subtest requests: SUCCESS (9.073s)
[276.343475] Starting dynamic subtest: migrate
[281.647769] Dynamic subtest migrate: SUCCESS (5.323s)
[281.672395] Starting dynamic subtest: active
[284.102596] Dynamic subtest active: SUCCESS (2.452s)
[284.125923] Starting dynamic subtest: objects
[288.442905] Dynamic subtest objects: SUCCESS (4.336s)
[288.468318] Starting dynamic subtest: mman
[296.287782] Dynamic subtest mman: SUCCESS (7.841s)
[296.311770] Starting dynamic subtest: dmabuf
[299.053800] Dynamic subtest dmabuf: SUCCESS (2.760s)
[299.078403] Starting dynamic subtest: vma
[301.680547] Dynamic subtest vma: SUCCESS (2.623s)
[301.703724] Starting dynamic subtest: coherency
[311.082798] Dynamic subtest coherency: SUCCESS (9.396s)
[311.106211] Starting dynamic subtest: gtt
[321.278737] Dynamic subtest gtt: SUCCESS (10.194s)
[321.302868] Starting dynamic subtest: gem
[324.023742] Dynamic subtest gem: SUCCESS (2.740s)
[324.046869] Starting dynamic subtest: evict
[329.448919] Dynamic subtest evict: SUCCESS (5.421s)
[329.472234] Starting dynamic subtest: hugepages
[338.294748] Dynamic subtest hugepages: SUCCESS (8.841s)
[338.317832] Starting dynamic subtest: gem_contexts
[358.834926] Dynamic subtest gem_contexts: SUCCESS (20.538s)
[358.858739] Starting dynamic subtest: client
[361.458524] Dynamic subtest client: SUCCESS (2.620s)
[361.482612] Starting dynamic subtest: gem_migrate
[364.017520] Dynamic subtest gem_migrate: SUCCESS (2.547s)
[364.041252] Starting dynamic subtest: reset
[370.365090] Dynamic subtest reset: SUCCESS (6.350s)
[370.389429] Starting dynamic subtest: memory_region
[372.843306] Dynamic subtest memory_region: SUCCESS (2.474s)
[372.867506] Starting dynamic subtest: hangcheck
[398.503587] Dynamic subtest hangcheck: SUCCESS (25.657s)
[398.527427] Starting dynamic subtest: execlists
[410.416528] Dynamic subtest execlists: SUCCESS (11.909s)
[410.447269] Starting dynamic subtest: ring_submission
[412.850650] Dynamic subtest ring_submission: SUCCESS (2.429s)
[412.876427] Starting dynamic subtest: perf
[415.677765] Dynamic subtest perf: SUCCESS (2.784s)
[415.744092] Starting dynamic subtest: slpc
[418.320821] Dynamic subtest slpc: SUCCESS (2.676s)
[418.345338] Starting dynamic subtest: guc
[420.713785] Dynamic subtest guc: SUCCESS (2.388s)
[420.737234] Starting dynamic subtest: guc_multi_lrc
[423.122884] Dynamic subtest guc_multi_lrc: SUCCESS (2.406s)
[423.147065] Starting dynamic subtest: guc_hang
[425.808991] Dynamic subtest guc_hang: SUCCESS (2.682s)
[425.833399] Starting dynamic subtest: late_gt_pm
[428.545343] Dynamic subtest late_gt_pm: SUCCESS (2.732s)
[428.548796] Subtest live: SUCCESS (216.634s)
[428.619681] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[428.626649] [046/133] (623s left) gem_exec_schedule (wide)
[431.505136] Starting subtest: wide
[431.519844] Starting dynamic subtest: rcs0
[451.044933] Dynamic subtest rcs0: SUCCESS (19.521s)
[451.190827] Starting dynamic subtest: bcs0
[471.864895] Dynamic subtest bcs0: SUCCESS (20.807s)
[471.993146] Starting dynamic subtest: vcs0
[491.925456] Dynamic subtest vcs0: SUCCESS (20.060s)
[492.056079] Starting dynamic subtest: vecs0
[512.030524] Dynamic subtest vecs0: SUCCESS (20.097s)
[512.037398] Subtest wide: SUCCESS (80.518s)
[512.988468] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.i915: true
[512.990306] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[512.997931] [047/133] (539s left) kms_cursor_edge_walk (128x128-top-bottom)
[513.187032] Starting subtest: 128x128-top-bottom
[513.203417] Starting dynamic subtest: pipe-A-HDMI-A-1
[517.078436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.882s)
[517.123500] Starting dynamic subtest: pipe-C-HDMI-A-1
[520.531880] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.449s)
[520.539107] Subtest 128x128-top-bottom: SUCCESS (7.345s)
[520.854068] [048/133] (531s left) syncobj_timeline (invalid-query-bad-pad)
[520.972333] Starting subtest: invalid-query-bad-pad
[520.975864] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[521.113439] [049/133] (531s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[521.227138] Starting subtest: single-wait-all-for-submit-signaled
[521.230573] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[521.401351] [050/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[521.608403] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[521.616120] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[521.768979] [051/133] (531s left) gem_exec_async (concurrent-writes)
[521.905305] Starting subtest: concurrent-writes
[521.910276] Starting dynamic subtest: rcs0
[521.924351] Dynamic subtest rcs0: SUCCESS (0.018s)
[521.968373] Starting dynamic subtest: bcs0
[521.971958] Dynamic subtest bcs0: SUCCESS (0.011s)
[521.994693] Starting dynamic subtest: vcs0
[521.999167] Dynamic subtest vcs0: SUCCESS (0.012s)
[522.022394] Starting dynamic subtest: vecs0
[522.026508] Dynamic subtest vecs0: SUCCESS (0.012s)
[522.030560] Subtest concurrent-writes: SUCCESS (0.065s)
[522.249925] [052/133] (530s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[522.817169] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[523.175556] [053/133] (529s left) gem_ctx_persistence (engines-hang)
[523.301115] Starting subtest: engines-hang
[523.304437] Starting dynamic subtest: rcs0
[523.326059] Dynamic subtest rcs0: SUCCESS (0.023s)
[523.351234] Starting dynamic subtest: bcs0
[523.365562] Dynamic subtest bcs0: SKIP (0.011s)
[523.390457] Starting dynamic subtest: vcs0
[523.394727] Dynamic subtest vcs0: SUCCESS (0.023s)
[523.420640] Starting dynamic subtest: vecs0
[523.425629] Dynamic subtest vecs0: SUCCESS (0.039s)
[523.429337] Subtest engines-hang: SUCCESS (0.113s)
[523.569192] [054/133] (529s left) gem_exec_schedule (implicit-write-read)
[523.724738] Starting subtest: implicit-write-read
[523.728598] Starting dynamic subtest: rcs0
[523.825732] Dynamic subtest rcs0: SUCCESS (0.118s)
[523.849849] Starting dynamic subtest: bcs0
[523.973143] Dynamic subtest bcs0: SUCCESS (0.139s)
[524.007570] Starting dynamic subtest: vcs0
[524.093872] Dynamic subtest vcs0: SUCCESS (0.118s)
[524.123845] Starting dynamic subtest: vecs0
[524.224576] Dynamic subtest vecs0: SUCCESS (0.120s)
[524.229713] Subtest implicit-write-read: SUCCESS (0.516s)
[524.624319] [055/133] (528s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[524.748684] Starting subtest: untiled-to-tiled
[524.887177] Subtest untiled-to-tiled: SUCCESS (0.135s)
[525.059366] [056/133] (528s left) kms_chamelium_edid (dp-mode-timings)
[525.681988] Subtest dp-mode-timings: SKIP (0.000s)
[526.027550] [057/133] (527s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[526.143325] Starting subtest: multi-wait-for-submit-available-submitted
[526.147361] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[526.317351] [058/133] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[526.523442] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[529.367062] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.843s)
[529.616878] [059/133] (524s left) api_intel_allocator (two-level-inception-interruptible)
[529.731239] Starting subtest: two-level-inception-interruptible
[535.283353] Subtest two-level-inception-interruptible: SUCCESS (5.558s)
[535.436896] [060/133] (518s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[535.627107] Starting subtest: plane-all-transition-nonblocking-fencing
[535.631148] Starting dynamic subtest: pipe-A-HDMI-A-1
[540.650503] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.020s)
[541.049950] Starting dynamic subtest: pipe-A-HDMI-A-2
[545.801095] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.901s)
[546.082315] Starting dynamic subtest: pipe-B-HDMI-A-1
[551.568605] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.531s)
[551.855493] Starting dynamic subtest: pipe-B-HDMI-A-2
[556.894072] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.087s)
[557.115776] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (21.486s)
[557.465601] [061/133] (496s left) gem_ctx_persistence (legacy-engines-cleanup)
[557.622093] Starting subtest: legacy-engines-cleanup
[557.626460] Starting dynamic subtest: render
[557.648065] Dynamic subtest render: SUCCESS (0.018s)
[557.684620] Starting dynamic subtest: bsd
[557.691583] Dynamic subtest bsd: SUCCESS (0.031s)
[557.729896] Starting dynamic subtest: blt
[557.737293] Dynamic subtest blt: SUCCESS (0.021s)
[557.768115] Starting dynamic subtest: vebox
[557.773382] Dynamic subtest vebox: SUCCESS (0.028s)
[557.776654] Subtest legacy-engines-cleanup: SUCCESS (0.119s)
[557.896736] [062/133] (496s left) syncobj_timeline (host-signal-points)
[558.013905] Starting subtest: host-signal-points
[558.039681] Subtest host-signal-points: SUCCESS (0.026s)
[558.196460] [063/133] (495s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[558.399104] Starting subtest: cursorA-vs-flipA-atomic-transitions
[569.859416] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.341s)
[570.628987] [064/133] (484s left) kms_dp_link_training (non-uhbr-mst)
[571.334198] Starting subtest: non-uhbr-mst
[571.360301] Subtest non-uhbr-mst: SKIP (0.001s)
[571.464644] [065/133] (483s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[571.691092] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[574.170692] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.486s)
[574.500665] [066/133] (480s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[574.703883] Starting subtest: cursor-rapid-movement-32x32
[574.897056] Subtest cursor-rapid-movement-32x32: SKIP (0.189s)
[575.080138] [067/133] (479s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[575.284296] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[575.291157] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[575.445934] [068/133] (479s left) kms_atomic_interruptible (universal-setplane-cursor)
[575.642214] Starting subtest: universal-setplane-cursor
[575.646612] Starting dynamic subtest: pipe-A-HDMI-A-1
[582.435319] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.788s)
[582.439345] Subtest universal-setplane-cursor: SUCCESS (6.796s)
[582.742583] [069/133] (472s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[582.947209] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[582.955092] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[583.089801] [070/133] (472s left) kms_prime (basic-crc-hybrid)
[583.337476] Subtest basic-crc-hybrid: SKIP (0.000s)
[583.517616] [071/133] (471s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[583.717169] Starting subtest: crc-primary-suspend-y-tiled-ccs
[583.721060] Starting dynamic subtest: pipe-A-HDMI-A-1
[600.325296] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.504s)
[600.386832] Starting dynamic subtest: pipe-A-HDMI-A-2