[87.391554] Initializing watchdogs
[87.391721]   /dev/watchdog0
[87.431569] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.446326] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.454716] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.462721] [001/133] (960s left) kms_psr (fbc-psr-primary-page-flip)
[87.676066] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[87.786507] [002/133] (960s left) drm_buddy (drm_buddy)
[87.893602] Starting subtest: drm_buddy
[87.901584] Subtest drm_buddy: SKIP (0.002s)
[88.037094] [003/133] (960s left) gem_ppgtt (shrink-vs-evict-pinned)
[88.160276] Starting subtest: shrink-vs-evict-pinned
[93.225733] Subtest shrink-vs-evict-pinned: SUCCESS (5.063s)
[93.353280] [004/133] (954s left) kms_color_pipeline (plane-ctm3x4)
[93.565199] Starting subtest: plane-ctm3x4
[95.329419] Subtest plane-ctm3x4: SKIP (1.758s)
[95.642403] [005/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[95.854133] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[98.286453] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.436s)
[98.491283] [006/133] (949s left) kms_properties (colorop-properties-legacy)
[98.673640] Starting subtest: colorop-properties-legacy
[98.678161] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.213062] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.532s)
[99.237213] Starting dynamic subtest: pipe-A-HDMI-A-2
[99.530749] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.320s)
[99.559067] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.861133] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.321s)
[99.898414] Starting dynamic subtest: pipe-B-HDMI-A-2
[100.204138] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.339s)
[100.235036] Starting dynamic subtest: pipe-C-HDMI-A-1
[100.576136] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.368s)
[100.614433] Starting dynamic subtest: pipe-C-HDMI-A-2
[100.963067] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.382s)
[100.968133] Subtest colorop-properties-legacy: SUCCESS (2.287s)
[101.273519] [007/133] (947s left) kms_psr (psr-sprite-mmap-cpu)
[101.480204] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[101.583023] [008/133] (947s left) kms_psr (fbc-psr2-no-drrs)
[101.783147] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[101.882614] [009/133] (946s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[102.072460] Starting subtest: async-flip-with-page-flip-events-linear
[102.680770] Subtest async-flip-with-page-flip-events-linear: SKIP (0.605s)
[102.983598] [010/133] (945s left) kms_joiner (basic-big-joiner)
[103.181971] Starting subtest: basic-big-joiner
[103.190161] Subtest basic-big-joiner: SKIP (0.000s)
[103.314973] [011/133] (945s left) sw_sync (sync_random_merge)
[103.421891] Starting subtest: sync_random_merge
[103.631831] Subtest sync_random_merge: SUCCESS (0.209s)
[103.744776] [012/133] (945s left) gen9_exec_parse (valid-registers)
[103.876117] Starting subtest: valid-registers
[104.049616] Subtest valid-registers: SUCCESS (0.178s)
[104.334905] [013/133] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[104.446519] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[104.548755] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[104.677384] [014/133] (944s left) i915_hangman (gt-engine-error)
[104.814061] Starting subtest: gt-engine-error
[104.818109] Starting dynamic subtest: rcs0
[104.894420] Dynamic subtest rcs0: SUCCESS (0.082s)
[104.919049] Starting dynamic subtest: bcs0
[104.926764] Dynamic subtest bcs0: SKIP (0.003s)
[104.952840] Starting dynamic subtest: vcs0
[104.974238] Dynamic subtest vcs0: SUCCESS (0.071s)
[104.994918] Starting dynamic subtest: vecs0
[105.052959] Dynamic subtest vecs0: SUCCESS (0.078s)
[105.056575] Subtest gt-engine-error: SUCCESS (0.241s)
[105.195236] [015/133] (944s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[105.382158] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[105.385360] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.427473] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[105.467470] Starting dynamic subtest: pipe-A-HDMI-A-2
[105.517501] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[105.552449] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.590621] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[105.611074] Starting dynamic subtest: pipe-B-HDMI-A-2
[105.644972] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[105.665207] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.698781] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[105.730115] Starting dynamic subtest: pipe-C-HDMI-A-2
[105.764734] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[105.771691] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.033s)
[106.446888] [016/133] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[106.654061] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[109.178107] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.530s)
[109.378062] [017/133] (940s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[109.590877] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[109.599094] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[109.729898] [018/133] (939s left) kms_plane (pixel-format-y-tiled-modifier)
[109.914977] Starting subtest: pixel-format-y-tiled-modifier
[110.144517] Starting dynamic subtest: pipe-A-plane-0
[110.991182] Dynamic subtest pipe-A-plane-0: SUCCESS (0.849s)
[111.011755] Starting dynamic subtest: pipe-A-plane-1
[111.807199] Dynamic subtest pipe-A-plane-1: SUCCESS (0.815s)
[111.827554] Starting dynamic subtest: pipe-A-plane-2
[112.356460] Dynamic subtest pipe-A-plane-2: SUCCESS (0.549s)
[112.377028] Starting dynamic subtest: pipe-A-plane-3
[112.940379] Dynamic subtest pipe-A-plane-3: SUCCESS (0.582s)
[112.962047] Starting dynamic subtest: pipe-A-plane-4
[112.972291] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[113.307067] Starting dynamic subtest: pipe-B-plane-0
[114.090133] Dynamic subtest pipe-B-plane-0: SUCCESS (0.800s)
[114.109828] Starting dynamic subtest: pipe-B-plane-1
[114.874202] Dynamic subtest pipe-B-plane-1: SUCCESS (0.782s)
[114.894077] Starting dynamic subtest: pipe-B-plane-2
[115.438266] Dynamic subtest pipe-B-plane-2: SUCCESS (0.566s)
[115.458435] Starting dynamic subtest: pipe-B-plane-3
[116.006268] Dynamic subtest pipe-B-plane-3: SUCCESS (0.565s)
[116.027031] Starting dynamic subtest: pipe-B-plane-4
[116.033088] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[116.238863] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.322s)
[116.589322] [019/133] (933s left) gem_exec_balancer (bonded-sync)
[116.733143] Starting subtest: bonded-sync
[121.074081] Subtest bonded-sync: SUCCESS (4.335s)
[121.340086] [020/133] (928s left) gem_close_race (multigpu-basic-threads)
[121.474743] Starting subtest: multigpu-basic-threads
[121.482963] Subtest multigpu-basic-threads: SKIP (0.000s)
[121.724379] [021/133] (928s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[121.913134] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[121.918801] Starting dynamic subtest: pipe-A
[122.948186] Dynamic subtest pipe-A: SUCCESS (1.042s)
[122.989499] Starting dynamic subtest: pipe-B
[124.109527] Dynamic subtest pipe-B: SUCCESS (1.160s)
[124.150087] Starting dynamic subtest: pipe-C
[124.539386] Dynamic subtest pipe-C: SUCCESS (0.428s)
[124.544232] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.634s)
[125.085487] [022/133] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[125.316966] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[125.322744] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[125.617194] [023/133] (924s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[125.868891] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[127.342135] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.477s)
[127.693220] [024/133] (922s left) kms_lease (setcrtc-implicit-plane)
[127.886157] Starting subtest: setcrtc-implicit-plane
[127.889418] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.602617] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.717s)
[128.647981] Starting dynamic subtest: pipe-A-HDMI-A-2
[129.078442] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.461s)
[129.107285] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.552315] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.466s)
[129.597245] Starting dynamic subtest: pipe-B-HDMI-A-2
[129.990145] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.429s)
[130.017785] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.443092] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.445s)
[130.467703] Starting dynamic subtest: pipe-C-HDMI-A-2
[130.866533] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.421s)
[130.869935] Subtest setcrtc-implicit-plane: SUCCESS (2.986s)
[131.192273] [025/133] (919s left) gem_tiled_fence_blits (normal)
[132.149060] Starting subtest: normal
[134.489665] Subtest normal: SUCCESS (2.343s)
[134.650352] [026/133] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[135.084962] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[135.092904] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[135.230179] [027/133] (915s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[135.445403] Starting subtest: x-tiled-addfb-size-offset-overflow
[135.449170] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[135.592891] [028/133] (915s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[135.803262] Starting subtest: x-tiled-32bpp-rotate-270
[136.173319] Subtest x-tiled-32bpp-rotate-270: SKIP (0.367s)
[136.409411] [029/133] (914s left) gem_userptr_blits (userfault)
[136.547038] Starting subtest: userfault
[136.554810] Subtest userfault: SUCCESS (0.011s)
[136.771667] [030/133] (914s left) gem_userptr_blits (sync-overlap)
[136.912033] Starting subtest: sync-overlap
[136.916020] Subtest sync-overlap: SUCCESS (0.000s)
[137.090453] [031/133] (913s left) kms_chamelium_color (ctm-negative)
[137.290036] Subtest ctm-negative: SKIP (0.000s)
[137.400053] [032/133] (913s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[137.588488] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[137.595281] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[137.726628] [033/133] (913s left) sysfs_timeslice_duration (timeout)
[137.853821] Starting subtest: timeout
[137.858269] Starting dynamic subtest: vecs0
[138.700160] Dynamic subtest vecs0: SUCCESS (0.845s)
[138.725534] Starting dynamic subtest: vcs0
[139.516207] Dynamic subtest vcs0: SUCCESS (0.819s)
[139.538736] Starting dynamic subtest: bcs0
[140.360019] Dynamic subtest bcs0: SUCCESS (0.840s)
[140.386237] Starting dynamic subtest: rcs0
[141.215121] Dynamic subtest rcs0: SUCCESS (0.854s)
[141.219318] Subtest timeout: SUCCESS (3.368s)
[141.355535] [034/133] (909s left) kms_frontbuffer_tracking (psr-suspend)
[141.557070] Starting subtest: psr-suspend
[141.566845] Subtest psr-suspend: SKIP (0.000s)
[141.693376] [035/133] (909s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[141.900116] Starting subtest: cursorA-vs-flipA-varying-size
[153.237905] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.338s)
[153.563083] [036/133] (897s left) gem_mmap_gtt (flink-race)
[153.682553] Starting subtest: flink-race
[173.768196] Subtest flink-race: SUCCESS (20.089s)
[173.916714] [037/133] (877s left) gem_mmap_gtt (bad-object)
[174.028204] Starting subtest: bad-object
[174.031600] Subtest bad-object: SUCCESS (0.001s)
[174.181749] [038/133] (877s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[174.304985] Starting subtest: writes-after-reads-uncached
[195.173242] Subtest writes-after-reads-uncached: SUCCESS (20.871s)
[195.332786] [039/133] (856s left) gem_busy (busy)
[195.474046] Starting subtest: busy
[195.477283] Starting dynamic subtest: all-engines
[195.552768] Dynamic subtest all-engines: SUCCESS (0.082s)
[195.583235] Starting dynamic subtest: rcs0
[195.587078] Dynamic subtest rcs0: SUCCESS (0.011s)
[195.613162] Starting dynamic subtest: bcs0
[195.617390] Dynamic subtest bcs0: SUCCESS (0.007s)
[195.639138] Starting dynamic subtest: vcs0
[195.643348] Dynamic subtest vcs0: SUCCESS (0.014s)
[195.665438] Starting dynamic subtest: vecs0
[195.669601] Dynamic subtest vecs0: SUCCESS (0.014s)
[195.673423] Subtest busy: SUCCESS (0.142s)
[196.354503] [040/133] (855s left) prime_mmap_coherency (write)
[196.894771] Starting subtest: write
[202.065861] Subtest write: SUCCESS (5.375s)
[202.234936] [041/133] (849s left) gem_reg_read (timestamp-monotonic)
[202.340033] Starting subtest: timestamp-monotonic
[206.640094] Subtest timestamp-monotonic: SUCCESS (4.304s)
[206.783141] [042/133] (845s left) kms_plane_alpha_blend (alpha-7efc)
[206.966162] Starting subtest: alpha-7efc
[207.171215] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.260576] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.084s)
[208.392140] Starting dynamic subtest: pipe-C-HDMI-A-1
[209.361283] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.006s)
[209.365706] Subtest alpha-7efc: SUCCESS (2.391s)
[209.692990] [043/133] (842s left) syncobj_wait (multi-wait-submitted)
[209.829942] Starting subtest: multi-wait-submitted
[209.932329] Subtest multi-wait-submitted: SUCCESS (0.104s)
[210.075590] [044/133] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[210.301311] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[210.308592] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[210.441710] [045/133] (842s left) i915_selftest (live)
[212.075186] Starting subtest: live
[212.080356] Starting dynamic subtest: sanitycheck
[214.818317] Dynamic subtest sanitycheck: SUCCESS (2.740s)
[214.841264] Starting dynamic subtest: uncore
[217.318588] Dynamic subtest uncore: SUCCESS (2.497s)
[217.349296] Starting dynamic subtest: workarounds
[219.987369] Dynamic subtest workarounds: SUCCESS (2.659s)
[220.011274] Starting dynamic subtest: gt_engines
[222.888108] Dynamic subtest gt_engines: SUCCESS (2.902s)
[222.911955] Starting dynamic subtest: gt_timelines
[238.949084] Dynamic subtest gt_timelines: SUCCESS (16.056s)
[238.977609] Starting dynamic subtest: gt_contexts
[241.593090] Dynamic subtest gt_contexts: SUCCESS (2.637s)
[241.619342] Starting dynamic subtest: gt_lrc
[247.017868] Dynamic subtest gt_lrc: SUCCESS (5.421s)
[247.041271] Starting dynamic subtest: gt_mocs
[249.628499] Dynamic subtest gt_mocs: SUCCESS (2.607s)
[249.652883] Starting dynamic subtest: gt_pm
[261.378467] Dynamic subtest gt_pm: SUCCESS (11.745s)
[261.410337] Starting dynamic subtest: gt_heartbeat
[263.936737] Dynamic subtest gt_heartbeat: SUCCESS (2.551s)
[263.960235] Starting dynamic subtest: gt_tlb
[267.667742] Dynamic subtest gt_tlb: SUCCESS (3.728s)
[267.691234] Starting dynamic subtest: requests
[276.422155] Dynamic subtest requests: SUCCESS (8.751s)
[276.446208] Starting dynamic subtest: migrate
[281.972652] Dynamic subtest migrate: SUCCESS (5.547s)
[282.004220] Starting dynamic subtest: active
[284.495516] Dynamic subtest active: SUCCESS (2.518s)
[284.526294] Starting dynamic subtest: objects
[289.063404] Dynamic subtest objects: SUCCESS (4.563s)
[289.091141] Starting dynamic subtest: mman
[296.671631] Dynamic subtest mman: SUCCESS (7.604s)
[296.700479] Starting dynamic subtest: dmabuf
[299.337350] Dynamic subtest dmabuf: SUCCESS (2.660s)
[299.367327] Starting dynamic subtest: vma
[301.797464] Dynamic subtest vma: SUCCESS (2.455s)
[301.823333] Starting dynamic subtest: coherency
[307.608172] Dynamic subtest coherency: SUCCESS (5.805s)
[307.633281] Starting dynamic subtest: gtt
[317.957422] Dynamic subtest gtt: SUCCESS (10.346s)
[317.986297] Starting dynamic subtest: gem
[320.897755] Dynamic subtest gem: SUCCESS (2.936s)
[320.922250] Starting dynamic subtest: evict
[326.454892] Dynamic subtest evict: SUCCESS (5.553s)
[326.483830] Starting dynamic subtest: hugepages
[335.426377] Dynamic subtest hugepages: SUCCESS (8.967s)
[335.457045] Starting dynamic subtest: gem_contexts
[356.192969] Dynamic subtest gem_contexts: SUCCESS (20.763s)
[356.223378] Starting dynamic subtest: client
[358.824553] Dynamic subtest client: SUCCESS (2.627s)
[358.850292] Starting dynamic subtest: gem_migrate
[361.436922] Dynamic subtest gem_migrate: SUCCESS (2.608s)
[361.462418] Starting dynamic subtest: reset
[367.740554] Dynamic subtest reset: SUCCESS (6.299s)
[367.771215] Starting dynamic subtest: memory_region
[370.390209] Dynamic subtest memory_region: SUCCESS (2.645s)
[370.414594] Starting dynamic subtest: hangcheck
[396.002067] Dynamic subtest hangcheck: SUCCESS (25.605s)
[396.027318] Starting dynamic subtest: execlists
[407.766514] Dynamic subtest execlists: SUCCESS (11.761s)
[407.791426] Starting dynamic subtest: ring_submission
[410.204833] Dynamic subtest ring_submission: SUCCESS (2.434s)
[410.229346] Starting dynamic subtest: perf
[412.895526] Dynamic subtest perf: SUCCESS (2.686s)
[412.920313] Starting dynamic subtest: slpc
[415.485718] Dynamic subtest slpc: SUCCESS (2.586s)
[415.509439] Starting dynamic subtest: guc
[417.944932] Dynamic subtest guc: SUCCESS (2.456s)
[417.974307] Starting dynamic subtest: guc_multi_lrc
[420.633296] Dynamic subtest guc_multi_lrc: SUCCESS (2.684s)
[420.657906] Starting dynamic subtest: guc_hang
[423.205848] Dynamic subtest guc_hang: SUCCESS (2.567s)
[423.230370] Starting dynamic subtest: late_gt_pm
[425.632349] Dynamic subtest late_gt_pm: SUCCESS (2.423s)
[425.636242] Subtest live: SUCCESS (213.560s)
[425.704499] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[425.711425] [046/133] (626s left) gem_exec_schedule (wide)
[428.701476] Starting subtest: wide
[428.706319] Starting dynamic subtest: rcs0
[448.364697] Dynamic subtest rcs0: SUCCESS (19.645s)
[448.496638] Starting dynamic subtest: bcs0
[468.955856] Dynamic subtest bcs0: SUCCESS (20.588s)
[469.060062] Starting dynamic subtest: vcs0
[489.116070] Dynamic subtest vcs0: SUCCESS (20.156s)
[489.173021] Starting dynamic subtest: vecs0
[509.033878] Dynamic subtest vecs0: SUCCESS (19.914s)
[509.037677] Subtest wide: SUCCESS (80.335s)
[510.067802] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.i915: true
[510.069678] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[510.077215] [047/133] (542s left) kms_cursor_edge_walk (128x128-top-bottom)
[510.267652] Starting subtest: 128x128-top-bottom
[510.284204] Starting dynamic subtest: pipe-A-HDMI-A-1
[514.182060] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.908s)
[514.223419] Starting dynamic subtest: pipe-C-HDMI-A-1
[517.612116] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.419s)
[517.617045] Subtest 128x128-top-bottom: SUCCESS (7.340s)
[517.949078] [048/133] (534s left) syncobj_timeline (invalid-query-bad-pad)
[518.072038] Starting subtest: invalid-query-bad-pad
[518.075822] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[518.215310] [049/133] (534s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[518.327510] Starting subtest: single-wait-all-for-submit-signaled
[518.331156] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[518.481867] [050/133] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[518.697804] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[518.705525] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[518.853249] [051/133] (534s left) gem_exec_async (concurrent-writes)
[518.983535] Starting subtest: concurrent-writes
[518.987375] Starting dynamic subtest: rcs0
[519.003638] Dynamic subtest rcs0: SUCCESS (0.017s)
[519.039265] Starting dynamic subtest: bcs0
[519.046144] Dynamic subtest bcs0: SUCCESS (0.011s)
[519.073507] Starting dynamic subtest: vcs0
[519.077477] Dynamic subtest vcs0: SUCCESS (0.012s)
[519.101795] Starting dynamic subtest: vecs0
[519.105962] Dynamic subtest vecs0: SUCCESS (0.018s)
[519.110185] Subtest concurrent-writes: SUCCESS (0.073s)
[519.347878] [052/133] (533s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[519.936510] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[520.213147] [053/133] (533s left) gem_ctx_persistence (engines-hang)
[520.352270] Starting subtest: engines-hang
[520.356488] Starting dynamic subtest: rcs0
[520.388404] Dynamic subtest rcs0: SUCCESS (0.042s)
[520.438990] Starting dynamic subtest: bcs0
[520.452260] Dynamic subtest bcs0: SKIP (0.012s)
[520.488857] Starting dynamic subtest: vcs0
[520.492175] Dynamic subtest vcs0: SUCCESS (0.021s)
[520.515543] Starting dynamic subtest: vecs0
[520.519389] Dynamic subtest vecs0: SUCCESS (0.028s)
[520.527024] Subtest engines-hang: SUCCESS (0.121s)
[520.626898] [054/133] (532s left) gem_exec_schedule (implicit-write-read)
[520.762388] Starting subtest: implicit-write-read
[520.765662] Starting dynamic subtest: rcs0
[520.885099] Dynamic subtest rcs0: SUCCESS (0.122s)
[520.909247] Starting dynamic subtest: bcs0
[521.022083] Dynamic subtest bcs0: SUCCESS (0.133s)
[521.053413] Starting dynamic subtest: vcs0
[521.144959] Dynamic subtest vcs0: SUCCESS (0.119s)
[521.176303] Starting dynamic subtest: vecs0
[521.264838] Dynamic subtest vecs0: SUCCESS (0.116s)
[521.268871] Subtest implicit-write-read: SUCCESS (0.508s)
[521.675055] [055/133] (531s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[521.794965] Starting subtest: untiled-to-tiled
[521.930110] Subtest untiled-to-tiled: SUCCESS (0.131s)
[522.091397] [056/133] (531s left) kms_chamelium_edid (dp-mode-timings)
[522.668092] Subtest dp-mode-timings: SKIP (0.000s)
[522.951556] [057/133] (530s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[523.068141] Starting subtest: multi-wait-for-submit-available-submitted
[523.072797] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[523.217209] [058/133] (530s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[523.442076] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[526.310403] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.872s)
[526.529218] [059/133] (527s left) api_intel_allocator (two-level-inception-interruptible)
[526.639088] Starting subtest: two-level-inception-interruptible
[532.201242] Subtest two-level-inception-interruptible: SUCCESS (5.564s)
[532.349244] [060/133] (521s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[532.540102] Starting subtest: plane-all-transition-nonblocking-fencing
[532.543431] Starting dynamic subtest: pipe-A-HDMI-A-1
[537.843535] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.299s)
[538.190057] Starting dynamic subtest: pipe-A-HDMI-A-2
[542.964921] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.882s)
[543.213347] Starting dynamic subtest: pipe-B-HDMI-A-1
[548.860521] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.671s)
[549.151274] Starting dynamic subtest: pipe-B-HDMI-A-2
[554.383212] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.279s)
[554.718873] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (22.057s)
[555.475268] [061/133] (499s left) gem_ctx_persistence (legacy-engines-cleanup)
[555.966343] Starting subtest: legacy-engines-cleanup
[556.036021] Starting dynamic subtest: render
[556.156189] Dynamic subtest render: SUCCESS (0.032s)
[556.179276] Starting dynamic subtest: bsd
[556.182825] Dynamic subtest bsd: SUCCESS (0.024s)
[556.205659] Starting dynamic subtest: blt
[556.209873] Dynamic subtest blt: SUCCESS (0.026s)
[556.232926] Starting dynamic subtest: vebox
[556.236290] Dynamic subtest vebox: SUCCESS (0.027s)
[556.239868] Subtest legacy-engines-cleanup: SUCCESS (0.126s)
[556.342879] [062/133] (498s left) syncobj_timeline (host-signal-points)
[556.471468] Starting subtest: host-signal-points
[556.496620] Subtest host-signal-points: SUCCESS (0.026s)
[556.680168] [063/133] (498s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[556.891115] Starting subtest: cursorA-vs-flipA-atomic-transitions
[568.276369] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.379s)
[568.666825] [064/133] (486s left) kms_dp_link_training (non-uhbr-mst)
[568.916050] Starting subtest: non-uhbr-mst
[568.941602] Subtest non-uhbr-mst: SKIP (0.000s)
[569.069617] [065/133] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[569.291820] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[571.765475] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.477s)
[572.091345] [066/133] (483s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[572.294357] Starting subtest: cursor-rapid-movement-32x32
[572.492847] Subtest cursor-rapid-movement-32x32: SKIP (0.191s)
[572.665781] [067/133] (482s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[572.862083] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[572.868501] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[573.020636] [068/133] (482s left) kms_atomic_interruptible (universal-setplane-cursor)
[573.237027] Starting subtest: universal-setplane-cursor
[573.244505] Starting dynamic subtest: pipe-A-HDMI-A-1
[580.110108] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.871s)
[580.114121] Subtest universal-setplane-cursor: SUCCESS (6.879s)
[580.443650] [069/133] (475s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[580.640759] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[580.648121] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[580.790442] [070/133] (474s left) kms_prime (basic-crc-hybrid)
[581.033589] Subtest basic-crc-hybrid: SKIP (0.000s)
[581.237702] [071/133] (474s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[581.427523] Starting subtest: crc-primary-suspend-y-tiled-ccs
[581.432160] Starting dynamic subtest: pipe-A-HDMI-A-1
[598.403995] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.693s)
[598.455324] Starting dynamic subtest: pipe-A-HDMI-A-2