[55.960989] Initializing watchdogs
[55.961227]   /dev/watchdog0
[55.994538] [001/165] (960s left) i915_module_load (load)
[56.224623] Starting subtest: load
[58.960389] Subtest load: SUCCESS (2.737s)
[59.071169] [002/165] (957s left) core_auth (basic-auth)
[59.346516] Starting subtest: basic-auth
[59.369232] Subtest basic-auth: SUCCESS (0.003s)
[59.453437] [003/165] (957s left) debugfs_test (read_all_entries)
[59.697154] Starting subtest: read_all_entries
[60.102977] Subtest read_all_entries: SUCCESS (0.404s)
[60.292106] [004/165] (956s left) debugfs_test (basic-hwmon)
[60.499997] Starting subtest: basic-hwmon
[60.539860] Subtest basic-hwmon: SKIP (0.000s)
[60.695604] [005/165] (956s left) fbdev (eof)
[60.914129] Starting subtest: eof
[60.934716] Subtest eof: SUCCESS (0.002s)
[61.044637] [006/165] (955s left) fbdev (info)
[61.251408] Starting subtest: info
[61.273277] Subtest info: SUCCESS (0.000s)
[61.382076] [007/165] (955s left) fbdev (nullptr)
[61.591998] Starting subtest: nullptr
[61.612230] Subtest nullptr: SUCCESS (0.000s)
[61.724166] [008/165] (955s left) fbdev (read)
[61.908590] Starting subtest: read
[63.374161] Subtest read: SUCCESS (1.477s)
[63.481589] [009/165] (953s left) fbdev (write)
[63.688358] Starting subtest: write
[64.445206] Subtest write: SUCCESS (0.764s)
[64.556839] [010/165] (952s left) gem_basic (bad-close)
[64.787886] Starting subtest: bad-close
[64.831506] Subtest bad-close: SUCCESS (0.000s)
[64.918724] [011/165] (952s left) gem_basic (create-close)
[65.145331] Starting subtest: create-close
[65.185904] Subtest create-close: SUCCESS (0.000s)
[65.274233] [012/165] (952s left) gem_basic (create-fd-close)
[65.504480] Starting subtest: create-fd-close
[65.547051] Subtest create-fd-close: SUCCESS (0.000s)
[65.639652] [013/165] (951s left) gem_busy (busy@all-engines)
[65.878541] Starting subtest: busy
[65.900701] Starting dynamic subtest: all-engines
[65.959241] Dynamic subtest all-engines: SUCCESS (0.089s)
[65.982393] Subtest busy: SUCCESS (0.090s)
[66.359954] [014/165] (951s left) gem_close_race (basic-process)
[66.621276] Starting subtest: basic-process
[66.698126] Subtest basic-process: SUCCESS (0.100s)
[66.927335] [015/165] (950s left) gem_close_race (basic-threads)
[67.174989] Starting subtest: basic-threads
[68.372413] Subtest basic-threads: SUCCESS (1.190s)
[68.578306] [016/165] (949s left) gem_ctx_create (basic)
[68.821350] Starting subtest: basic
[68.842884] Subtest basic: SUCCESS (0.000s)
[69.027510] [017/165] (948s left) gem_ctx_create (basic-files)
[69.256621] Starting subtest: basic-files
[71.288196] Subtest basic-files: SUCCESS (2.036s)
[71.544722] [018/165] (946s left) gem_ctx_exec (basic)
[71.790273] Starting subtest: basic
[71.811442] Subtest basic: SUCCESS (0.010s)
[71.899140] [019/165] (946s left) gem_exec_basic (basic)
[72.142413] Starting subtest: basic
[72.163937] Starting dynamic subtest: rcs0-smem
[72.186677] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[72.220844] Starting dynamic subtest: bcs0-smem
[72.240699] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[72.276782] Starting dynamic subtest: vcs0-smem
[72.300766] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[72.336411] Starting dynamic subtest: vecs0-smem
[72.356659] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[72.378833] Subtest basic: SUCCESS (0.012s)
[72.469085] [020/165] (945s left) gem_exec_create (basic)
[72.707683] Starting subtest: basic
[72.728749] Starting dynamic subtest: smem
[74.779562] Dynamic subtest smem: SUCCESS (2.072s)
[74.800256] Subtest basic: SUCCESS (2.072s)
[74.998521] [021/165] (943s left) gem_exec_fence (basic-busy)
[75.359486] Starting subtest: basic-busy
[75.382084] Starting dynamic subtest: rcs0
[75.424217] Dynamic subtest rcs0: SUCCESS (0.027s)
[75.458379] Starting dynamic subtest: bcs0
[75.503750] Dynamic subtest bcs0: SUCCESS (0.025s)
[75.537941] Starting dynamic subtest: vcs0
[75.581789] Dynamic subtest vcs0: SUCCESS (0.030s)
[75.616250] Starting dynamic subtest: vecs0
[75.655813] Dynamic subtest vecs0: SUCCESS (0.025s)
[75.678456] Subtest basic-busy: SUCCESS (0.109s)
[76.262401] [022/165] (941s left) gem_exec_fence (basic-wait)
[76.623806] Starting subtest: basic-wait
[76.648887] Starting dynamic subtest: rcs0
[76.672568] Dynamic subtest rcs0: SUCCESS (0.035s)
[76.711716] Starting dynamic subtest: bcs0
[76.734274] Dynamic subtest bcs0: SUCCESS (0.031s)
[76.767993] Starting dynamic subtest: vcs0
[76.792344] Dynamic subtest vcs0: SUCCESS (0.033s)
[76.829513] Starting dynamic subtest: vecs0
[76.851192] Dynamic subtest vecs0: SUCCESS (0.030s)
[76.874188] Subtest basic-wait: SUCCESS (0.130s)
[77.449368] [023/165] (940s left) gem_exec_fence (basic-await)
[77.806532] Starting subtest: basic-await
[77.828561] Starting dynamic subtest: rcs0
[77.943251] Dynamic subtest rcs0: SUCCESS (0.136s)
[77.982061] Starting dynamic subtest: bcs0
[78.071224] Dynamic subtest bcs0: SUCCESS (0.128s)
[78.110193] Starting dynamic subtest: vcs0
[78.205275] Dynamic subtest vcs0: SUCCESS (0.134s)
[78.246507] Starting dynamic subtest: vecs0
[78.337777] Dynamic subtest vecs0: SUCCESS (0.133s)
[78.359419] Subtest basic-await: SUCCESS (0.534s)
[79.061434] [024/165] (939s left) gem_exec_fence (nb-await)
[79.411111] Starting subtest: nb-await
[79.432212] Starting dynamic subtest: rcs0
[79.486124] Dynamic subtest rcs0: SUCCESS (0.075s)
[79.525571] Starting dynamic subtest: bcs0
[79.567846] Dynamic subtest bcs0: SUCCESS (0.071s)
[79.606210] Starting dynamic subtest: vcs0
[79.650779] Dynamic subtest vcs0: SUCCESS (0.071s)
[79.686590] Starting dynamic subtest: vecs0
[79.708177] Dynamic subtest vecs0: SUCCESS (0.072s)
[79.731323] Subtest nb-await: SUCCESS (0.291s)
[80.411103] [025/165] (938s left) gem_exec_gttfill (basic)
[80.650861] Starting subtest: basic
[102.581801] Subtest basic: SUCCESS (21.770s)
[102.679309] [026/165] (915s left) gem_exec_parallel (engines)
[103.086874] Starting subtest: engines
[103.108762] Starting dynamic subtest: basic
[106.915764] Dynamic subtest basic: SUCCESS (3.663s)
[106.953750] Starting dynamic subtest: contexts
[111.601070] Dynamic subtest contexts: SUCCESS (4.706s)
[111.638806] Starting dynamic subtest: fds
[118.642122] Dynamic subtest fds: SUCCESS (7.032s)
[118.683090] Starting dynamic subtest: userptr
[122.420882] Dynamic subtest userptr: SUCCESS (3.757s)
[122.442934] Subtest engines: SUCCESS (19.159s)
[122.550670] [027/165] (896s left) gem_exec_store (basic)
[122.855199] Starting subtest: basic
[122.875347] Subtest basic: SUCCESS (0.069s)
[123.079092] [028/165] (895s left) gem_flink_basic (bad-flink)
[123.309735] Starting subtest: bad-flink
[123.330383] Subtest bad-flink: SUCCESS (0.000s)
[123.423592] [029/165] (895s left) gem_flink_basic (bad-open)
[123.652759] Starting subtest: bad-open
[123.675220] Subtest bad-open: SUCCESS (0.000s)
[123.765936] [030/165] (895s left) gem_flink_basic (basic)
[123.994513] Starting subtest: basic
[124.017766] Subtest basic: SUCCESS (0.000s)
[124.111244] [031/165] (895s left) gem_flink_basic (double-flink)
[124.342607] Starting subtest: double-flink
[124.364817] Subtest double-flink: SUCCESS (0.000s)
[124.457870] [032/165] (894s left) gem_flink_basic (flink-lifetime)
[124.684697] Starting subtest: flink-lifetime
[124.704889] Subtest flink-lifetime: SUCCESS (0.003s)
[124.796700] [033/165] (894s left) gem_huc_copy (huc-copy)
[125.028870] Starting subtest: huc-copy
[125.051270] Subtest huc-copy: SUCCESS (0.005s)
[125.145762] [034/165] (894s left) gem_linear_blits (basic)
[125.521752] Starting subtest: basic
[125.544708] Subtest basic: SUCCESS (0.019s)
[125.721826] [035/165] (893s left) gem_mmap (basic)
[126.131270] Starting subtest: basic
[126.242930] Subtest basic: SUCCESS (0.001s)
[126.333779] [036/165] (893s left) gem_mmap_gtt (basic)
[126.575493] Starting subtest: basic
[126.595305] Subtest basic: SUCCESS (0.001s)
[126.693994] [037/165] (892s left) gem_render_linear_blits (basic)
[126.923760] Starting subtest: basic
[127.029854] Subtest basic: SUCCESS (0.085s)
[127.119600] [038/165] (892s left) gem_render_tiled_blits (basic)
[127.361224] Starting subtest: basic
[127.484084] Subtest basic: SUCCESS (0.117s)
[127.575726] [039/165] (892s left) gem_ringfill (basic-all)
[128.079612] Starting subtest: basic-all
[129.262421] Subtest basic-all: SUCCESS (1.202s)
[129.412595] [040/165] (890s left) gem_softpin (allocator-basic)
[129.649287] Starting subtest: allocator-basic
[129.868016] Subtest allocator-basic: SUCCESS (0.246s)
[130.009620] [041/165] (889s left) gem_softpin (allocator-basic-reserve)
[130.236573] Starting subtest: allocator-basic-reserve
[130.455953] Subtest allocator-basic-reserve: SUCCESS (0.246s)
[130.610384] [042/165] (889s left) gem_softpin (safe-alignment)
[130.839631] Starting subtest: safe-alignment
[130.860550] Subtest safe-alignment: SUCCESS (0.030s)
[130.995650] [043/165] (889s left) gem_sync (basic-all)
[131.410790] Starting subtest: basic-all
[134.360587] Subtest basic-all: SUCCESS (2.963s)
[134.452446] [044/165] (885s left) gem_sync (basic-each)
[134.849498] Starting subtest: basic-each
[137.058454] Subtest basic-each: SUCCESS (2.377s)
[137.277239] [045/165] (883s left) gem_tiled_blits (basic)
[137.653852] Starting subtest: basic
[137.704354] Subtest basic: SUCCESS (0.048s)
[137.907940] [046/165] (882s left) gem_tiled_fence_blits (basic)
[138.473300] Starting subtest: basic
[138.497855] Subtest basic: SUCCESS (0.041s)
[138.682818] [047/165] (881s left) gem_tiled_pread_basic
[139.445121] [048/165] (881s left) gem_wait (busy@all-engines)
[139.699407] Starting subtest: busy
[139.722713] Starting dynamic subtest: all-engines
[140.224882] Dynamic subtest all-engines: SUCCESS (0.528s)
[140.247972] Subtest busy: SUCCESS (0.529s)
[140.485493] [049/165] (880s left) gem_wait (wait@all-engines)
[140.736604] Starting subtest: wait
[140.756637] Starting dynamic subtest: all-engines
[141.774317] Dynamic subtest all-engines: SUCCESS (1.044s)
[141.794413] Subtest wait: SUCCESS (1.045s)
[142.033365] [050/165] (878s left) i915_getparams_basic (basic-eu-total)
[142.260977] Starting subtest: basic-eu-total
[142.303575] Subtest basic-eu-total: SUCCESS (0.000s)
[142.392457] [051/165] (878s left) i915_getparams_basic (basic-subslice-total)
[142.622716] Starting subtest: basic-subslice-total
[142.663948] Subtest basic-subslice-total: SUCCESS (0.000s)
[142.758094] [052/165] (878s left) i915_hangman (error-state-basic)
[142.996319] Starting subtest: error-state-basic
[143.295357] Subtest error-state-basic: SUCCESS (0.288s)
[143.420660] [053/165] (877s left) i915_pciid
[143.764403] [054/165] (877s left) kms_addfb_basic (addfb25-4-tiled)
[144.128767] Starting subtest: addfb25-4-tiled
[144.150738] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[144.265549] [055/165] (876s left) kms_addfb_basic (addfb25-bad-modifier)
[144.490550] Starting subtest: addfb25-bad-modifier
[144.509870] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[144.682264] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[144.912894] Starting subtest: addfb25-framebuffer-vs-set-tiling
[144.935050] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[145.095308] [057/165] (876s left) kms_addfb_basic (addfb25-modifier-no-flag)
[145.326331] Starting subtest: addfb25-modifier-no-flag
[145.347584] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[145.529566] [058/165] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[145.756402] Starting subtest: addfb25-x-tiled-legacy
[145.775723] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[145.948262] [059/165] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[146.172107] Starting subtest: addfb25-x-tiled-mismatch-legacy
[146.194297] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[146.382703] [060/165] (875s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[146.698800] Starting subtest: addfb25-yf-tiled-legacy
[146.724275] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[146.840445] [061/165] (874s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[147.162632] Starting subtest: addfb25-y-tiled-legacy
[147.191988] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[147.303659] [062/165] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[147.630916] Starting subtest: addfb25-y-tiled-small-legacy
[147.651348] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[147.745800] [063/165] (874s left) kms_addfb_basic (bad-pitch-0)
[147.971562] Starting subtest: bad-pitch-0
[147.992237] Subtest bad-pitch-0: SUCCESS (0.000s)
[148.162630] [064/165] (873s left) kms_addfb_basic (bad-pitch-1024)
[148.392309] Starting subtest: bad-pitch-1024
[148.414098] Subtest bad-pitch-1024: SUCCESS (0.000s)
[148.578470] [065/165] (873s left) kms_addfb_basic (bad-pitch-128)
[148.809936] Starting subtest: bad-pitch-128
[148.830483] Subtest bad-pitch-128: SUCCESS (0.000s)
[148.998159] [066/165] (873s left) kms_addfb_basic (bad-pitch-256)
[149.224514] Starting subtest: bad-pitch-256
[149.246077] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.432064] [067/165] (872s left) kms_addfb_basic (bad-pitch-32)
[149.657612] Starting subtest: bad-pitch-32
[149.679881] Subtest bad-pitch-32: SUCCESS (0.000s)
[149.844538] [068/165] (872s left) kms_addfb_basic (bad-pitch-63)
[150.078583] Starting subtest: bad-pitch-63
[150.098046] Subtest bad-pitch-63: SUCCESS (0.000s)
[150.264796] [069/165] (872s left) kms_addfb_basic (bad-pitch-65536)
[150.492042] Starting subtest: bad-pitch-65536
[150.512903] Subtest bad-pitch-65536: SUCCESS (0.001s)
[150.696667] [070/165] (871s left) kms_addfb_basic (bad-pitch-999)
[150.926071] Starting subtest: bad-pitch-999
[150.950192] Subtest bad-pitch-999: SUCCESS (0.000s)
[151.126931] [071/165] (871s left) kms_addfb_basic (basic)
[151.356034] Starting subtest: basic
[151.376620] Subtest basic: SUCCESS (0.000s)
[151.551138] [072/165] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[151.778364] Starting subtest: basic-x-tiled-legacy
[151.798966] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[151.980621] [073/165] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[152.210183] Starting subtest: basic-y-tiled-legacy
[152.232294] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[152.409615] [074/165] (870s left) kms_addfb_basic (bo-too-small)
[152.726254] Starting subtest: bo-too-small
[152.747567] Subtest bo-too-small: SUCCESS (0.001s)
[152.841402] [075/165] (870s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[153.158822] Starting subtest: bo-too-small-due-to-tiling
[153.180080] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[153.278540] [076/165] (869s left) kms_addfb_basic (clobberred-modifier)
[153.487204] Starting subtest: clobberred-modifier
[153.508901] Subtest clobberred-modifier: SUCCESS (0.000s)
[153.678502] [077/165] (869s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[153.910099] Starting subtest: framebuffer-vs-set-tiling
[153.930466] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[154.095184] [078/165] (869s left) kms_addfb_basic (invalid-get-prop)
[154.326450] Starting subtest: invalid-get-prop
[154.345749] Subtest invalid-get-prop: SUCCESS (0.000s)
[154.514274] [079/165] (868s left) kms_addfb_basic (invalid-get-prop-any)
[154.767856] Starting subtest: invalid-get-prop-any
[154.793186] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[154.945382] [080/165] (868s left) kms_addfb_basic (invalid-set-prop)
[155.213741] Starting subtest: invalid-set-prop
[155.241733] Subtest invalid-set-prop: SUCCESS (0.000s)
[155.394983] [081/165] (868s left) kms_addfb_basic (invalid-set-prop-any)
[155.654227] Starting subtest: invalid-set-prop-any
[155.679747] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[155.824820] [082/165] (867s left) kms_addfb_basic (no-handle)
[156.056148] Starting subtest: no-handle
[156.075755] Subtest no-handle: SUCCESS (0.000s)
[156.247508] [083/165] (867s left) kms_addfb_basic (size-max)
[156.542778] Starting subtest: size-max
[156.562152] Subtest size-max: SUCCESS (0.000s)
[156.667076] [084/165] (867s left) kms_addfb_basic (small-bo)
[156.980516] Starting subtest: small-bo
[157.002997] Subtest small-bo: SUCCESS (0.000s)
[157.095233] [085/165] (866s left) kms_addfb_basic (tile-pitch-mismatch)
[157.323836] Starting subtest: tile-pitch-mismatch
[157.343393] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[157.512631] [086/165] (866s left) kms_addfb_basic (too-high)
[157.828109] Starting subtest: too-high
[157.848644] Subtest too-high: SUCCESS (0.002s)
[157.944684] [087/165] (866s left) kms_addfb_basic (too-wide)
[158.265600] Starting subtest: too-wide
[158.287536] Subtest too-wide: SUCCESS (0.000s)
[158.380086] [088/165] (865s left) kms_addfb_basic (unused-handle)
[158.609064] Starting subtest: unused-handle
[158.628628] Subtest unused-handle: SUCCESS (0.000s)
[158.798537] [089/165] (865s left) kms_addfb_basic (unused-modifier)
[159.026431] Starting subtest: unused-modifier
[159.048467] Subtest unused-modifier: SUCCESS (0.000s)
[159.229680] [090/165] (865s left) kms_addfb_basic (unused-offsets)
[159.458116] Starting subtest: unused-offsets
[159.479201] Subtest unused-offsets: SUCCESS (0.000s)
[159.667427] [091/165] (864s left) kms_addfb_basic (unused-pitches)
[159.895540] Starting subtest: unused-pitches
[159.914882] Subtest unused-pitches: SUCCESS (0.000s)
[160.099549] [092/165] (864s left) kms_busy (basic)
[160.428147] Starting subtest: basic
[160.450825] Starting dynamic subtest: flip
[161.393229] Dynamic subtest flip: SUCCESS (0.980s)
[161.434441] Starting dynamic subtest: modeset
[162.801800] Dynamic subtest modeset: SUCCESS (1.403s)
[162.823364] Subtest basic: SUCCESS (2.386s)
[163.207473] [093/165] (861s left) kms_prop_blob (basic)
[163.455486] Starting subtest: basic
[163.476877] Subtest basic: SUCCESS (0.000s)
[163.570969] [094/165] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[163.901892] Starting subtest: basic-busy-flip-before-cursor-atomic
[163.944464] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[164.041190] [095/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[164.357851] Starting subtest: basic-busy-flip-before-cursor-legacy
[164.401922] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[164.496410] [096/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[164.811589] Starting subtest: basic-flip-after-cursor-atomic
[165.854989] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.056s)
[166.228306] [097/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[166.543973] Starting subtest: basic-flip-after-cursor-legacy
[167.605344] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.058s)
[167.955669] [098/165] (857s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[168.271358] Starting subtest: basic-flip-after-cursor-varying-size
[169.324506] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.068s)
[169.693389] [099/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[170.020301] Starting subtest: basic-flip-before-cursor-atomic
[171.073048] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.055s)
[171.421698] [100/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[171.741296] Starting subtest: basic-flip-before-cursor-legacy
[172.781809] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.064s)
[173.156257] [101/165] (852s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[173.475824] Starting subtest: basic-flip-before-cursor-varying-size
[174.533572] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.058s)
[174.888300] [102/165] (850s left) kms_dsc (dsc-basic)
[175.213963] Subtest dsc-basic: SKIP (0.000s)
[175.525404] [103/165] (850s left) kms_flip (basic-flip-vs-dpms)
[175.847480] Starting subtest: basic-flip-vs-dpms
[175.868175] Starting dynamic subtest: A-DP1
[177.063497] Dynamic subtest A-DP1: SUCCESS (1.241s)
[177.103750] Starting dynamic subtest: B-DP1
[178.221516] Dynamic subtest B-DP1: SUCCESS (1.140s)
[178.261550] Starting dynamic subtest: C-DP1
[179.323928] Dynamic subtest C-DP1: SUCCESS (1.123s)
[179.346264] Subtest basic-flip-vs-dpms: SUCCESS (3.514s)
[179.744517] [104/165] (846s left) kms_flip (basic-flip-vs-modeset)
[180.065732] Starting subtest: basic-flip-vs-modeset
[180.087051] Starting dynamic subtest: A-DP1
[181.309612] Dynamic subtest A-DP1: SUCCESS (1.268s)
[181.348518] Starting dynamic subtest: B-DP1
[182.472960] Dynamic subtest B-DP1: SUCCESS (1.147s)
[182.520808] Starting dynamic subtest: C-DP1
[183.603954] Dynamic subtest C-DP1: SUCCESS (1.129s)
[183.626396] Subtest basic-flip-vs-modeset: SUCCESS (3.554s)
[183.993483] [105/165] (841s left) kms_flip (basic-flip-vs-wf_vblank)
[184.315555] Starting subtest: basic-flip-vs-wf_vblank
[184.334985] Starting dynamic subtest: A-DP1
[185.756394] Dynamic subtest A-DP1: SUCCESS (1.458s)
[185.798461] Starting dynamic subtest: B-DP1
[187.156124] Dynamic subtest B-DP1: SUCCESS (1.397s)
[187.195254] Starting dynamic subtest: C-DP1
[188.547286] Dynamic subtest C-DP1: SUCCESS (1.392s)
[188.566912] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.257s)
[189.002095] [106/165] (836s left) kms_flip (basic-plain-flip)
[189.323276] Starting subtest: basic-plain-flip
[189.342697] Starting dynamic subtest: A-DP1
[190.472937] Dynamic subtest A-DP1: SUCCESS (1.174s)
[190.512388] Starting dynamic subtest: B-DP1
[191.572102] Dynamic subtest B-DP1: SUCCESS (1.097s)
[191.613609] Starting dynamic subtest: C-DP1
[192.678199] Dynamic subtest C-DP1: SUCCESS (1.107s)
[192.700759] Subtest basic-plain-flip: SUCCESS (3.389s)
[193.130564] [107/165] (832s left) kms_force_connector_basic (force-connector-state)
[193.391623] Subtest force-connector-state: SKIP (0.000s)
[193.499619] [108/165] (832s left) kms_force_connector_basic (force-edid)
[193.788983] Subtest force-edid: SKIP (0.000s)
[193.906157] [109/165] (832s left) kms_force_connector_basic (force-load-detect)
[194.193545] Subtest force-load-detect: SKIP (0.000s)
[194.316830] [110/165] (832s left) kms_force_connector_basic (prune-stale-modes)
[194.580123] Subtest prune-stale-modes: SKIP (0.000s)
[194.695896] [111/165] (831s left) kms_frontbuffer_tracking (basic)
[195.089812] Starting subtest: basic
[198.082555] Subtest basic: SUCCESS (3.063s)
[198.211220] [112/165] (828s left) kms_hdmi_inject (inject-audio)
[198.468713] Subtest inject-audio: SKIP (0.000s)
[198.563515] [113/165] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[198.891324] Starting subtest: compare-crc-sanitycheck-xr24
[198.912095] Starting dynamic subtest: pipe-A-DP-1
[199.322510] Dynamic subtest pipe-A-DP-1: SUCCESS (0.431s)
[199.366553] Starting dynamic subtest: pipe-B-DP-1
[199.933034] Dynamic subtest pipe-B-DP-1: SUCCESS (0.604s)
[199.973027] Starting dynamic subtest: pipe-C-DP-1
[200.552962] Dynamic subtest pipe-C-DP-1: SUCCESS (0.615s)
[200.573609] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.663s)
[200.911273] [114/165] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[201.232665] Starting subtest: compare-crc-sanitycheck-nv12
[201.254199] Starting dynamic subtest: pipe-A-DP-1
[201.294424] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[201.335691] Starting dynamic subtest: pipe-B-DP-1
[201.379066] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[201.417778] Starting dynamic subtest: pipe-C-DP-1
[201.463543] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[201.504905] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[201.603473] [115/165] (825s left) kms_pipe_crc_basic (hang-read-crc)
[201.925844] Starting subtest: hang-read-crc
[201.947702] Starting dynamic subtest: pipe-A-DP-1
[203.397041] Dynamic subtest pipe-A-DP-1: SUCCESS (1.470s)
[203.437800] Starting dynamic subtest: pipe-B-DP-1
[205.058430] Dynamic subtest pipe-B-DP-1: SUCCESS (1.664s)
[205.104184] Starting dynamic subtest: pipe-C-DP-1
[206.672162] Dynamic subtest pipe-C-DP-1: SUCCESS (1.618s)
[206.694884] Subtest hang-read-crc: SUCCESS (4.766s)
[207.042223] [116/165] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[207.346630] Starting subtest: nonblocking-crc
[207.367240] Starting dynamic subtest: pipe-A-DP-1
[207.906628] Dynamic subtest pipe-A-DP-1: SUCCESS (0.562s)
[207.948515] Starting dynamic subtest: pipe-B-DP-1
[208.673167] Dynamic subtest pipe-B-DP-1: SUCCESS (0.758s)
[208.715714] Starting dynamic subtest: pipe-C-DP-1
[209.449350] Dynamic subtest pipe-C-DP-1: SUCCESS (0.769s)
[209.471521] Subtest nonblocking-crc: SUCCESS (2.102s)
[209.811265] [117/165] (817s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[210.117640] Starting subtest: nonblocking-crc-frame-sequence
[210.137988] Starting dynamic subtest: pipe-A-DP-1
[210.703973] Dynamic subtest pipe-A-DP-1: SUCCESS (0.580s)
[210.756850] Starting dynamic subtest: pipe-B-DP-1
[211.465589] Dynamic subtest pipe-B-DP-1: SUCCESS (0.763s)
[211.506745] Starting dynamic subtest: pipe-C-DP-1
[212.245853] Dynamic subtest pipe-C-DP-1: SUCCESS (0.752s)
[212.266540] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.110s)
[212.598158] [118/165] (814s left) kms_pipe_crc_basic (read-crc)
[212.931082] Starting subtest: read-crc
[212.960913] Starting dynamic subtest: pipe-A-DP-1
[213.450120] Dynamic subtest pipe-A-DP-1: SUCCESS (0.522s)
[213.503196] Starting dynamic subtest: pipe-B-DP-1
[214.146397] Dynamic subtest pipe-B-DP-1: SUCCESS (0.695s)
[214.187081] Starting dynamic subtest: pipe-C-DP-1
[214.847706] Dynamic subtest pipe-C-DP-1: SUCCESS (0.701s)
[214.869824] Subtest read-crc: SUCCESS (1.931s)
[215.216703] [119/165] (812s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[215.526476] Starting subtest: read-crc-frame-sequence
[215.546500] Starting dynamic subtest: pipe-A-DP-1
[216.034211] Dynamic subtest pipe-A-DP-1: SUCCESS (0.514s)
[216.077549] Starting dynamic subtest: pipe-B-DP-1
[216.716046] Dynamic subtest pipe-B-DP-1: SUCCESS (0.673s)
[216.770125] Starting dynamic subtest: pipe-C-DP-1
[217.421093] Dynamic subtest pipe-C-DP-1: SUCCESS (0.695s)
[217.443891] Subtest read-crc-frame-sequence: SUCCESS (1.897s)
[217.775489] [120/165] (809s left) kms_pm_backlight (basic-brightness)
[218.116368] Subtest basic-brightness: SKIP (0.000s)
[218.217980] [121/165] (809s left) kms_pm_rpm (basic-pci-d3-state)
[220.110292] Starting subtest: basic-pci-d3-state
[220.761359] Subtest basic-pci-d3-state: SUCCESS (0.638s)
[220.970428] [122/165] (806s left) kms_pm_rpm (basic-rte)
[221.185319] Starting subtest: basic-rte
[223.374865] Subtest basic-rte: SUCCESS (2.183s)
[224.319886] [123/165] (803s left) kms_psr (psr_primary_page_flip)
[224.654030] Subtest psr_primary_page_flip: SKIP (0.000s)
[224.753241] [124/165] (802s left) kms_psr (psr_cursor_plane_move)
[225.085369] Subtest psr_cursor_plane_move: SKIP (0.000s)
[225.183606] [125/165] (802s left) kms_psr (psr_sprite_plane_onoff)
[225.511921] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[225.613676] [126/165] (802s left) kms_psr (psr_primary_mmap_gtt)
[225.942634] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[226.041852] [127/165] (801s left) kms_setmode (basic-clone-single-crtc)
[226.278751] Starting subtest: basic-clone-single-crtc
[226.345194] Subtest basic-clone-single-crtc: SKIP (0.000s)
[226.445585] [128/165] (801s left) i915_pm_rps (basic-api)
[226.686146] Starting subtest: basic-api
[226.709608] Subtest basic-api: SUCCESS (0.007s)
[226.830209] [129/165] (801s left) prime_self_import (basic-llseek-bad)
[227.051859] Starting subtest: basic-llseek-bad
[227.093958] Subtest basic-llseek-bad: SUCCESS (0.004s)
[227.193862] [130/165] (801s left) prime_self_import (basic-llseek-size)
[227.388653] Starting subtest: basic-llseek-size
[227.435213] Subtest basic-llseek-size: SUCCESS (0.007s)
[227.536573] [131/165] (800s left) prime_self_import (basic-with_fd_dup)
[227.749284] Starting subtest: basic-with_fd_dup
[227.792688] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[227.889684] [132/165] (800s left) prime_self_import (basic-with_one_bo)
[228.077532] Starting subtest: basic-with_one_bo
[228.123263] Subtest basic-with_one_bo: SUCCESS (0.007s)
[228.225733] [133/165] (800s left) prime_self_import (basic-with_one_bo_two_files)
[228.434606] Starting subtest: basic-with_one_bo_two_files
[228.478458] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[228.586136] [134/165] (800s left) prime_self_import (basic-with_two_bos)
[228.797076] Starting subtest: basic-with_two_bos
[228.839645] Subtest basic-with_two_bos: SUCCESS (0.006s)
[228.940307] [135/165] (799s left) prime_vgem (basic-fence-flip)
[229.204942] Starting subtest: basic-fence-flip
[229.780732] Subtest basic-fence-flip: SUCCESS (0.604s)
[229.911167] [136/165] (798s left) prime_vgem (basic-fence-mmap)
[230.166498] Starting subtest: basic-fence-mmap
[230.213690] Subtest basic-fence-mmap: SUCCESS (0.072s)
[230.334829] [137/165] (798s left) prime_vgem (basic-fence-read)
[230.592387] Starting subtest: basic-fence-read
[230.670889] Subtest basic-fence-read: SUCCESS (0.110s)
[230.794644] [138/165] (798s left) prime_vgem (basic-gtt)
[231.034639] Starting subtest: basic-gtt
[231.056128] Subtest basic-gtt: SUCCESS (0.037s)
[231.177556] [139/165] (797s left) prime_vgem (basic-read)
[231.411186] Starting subtest: basic-read
[231.433339] Subtest basic-read: SUCCESS (0.053s)
[231.577287] [140/165] (797s left) prime_vgem (basic-write)
[231.809743] Starting subtest: basic-write
[231.863692] Subtest basic-write: SUCCESS (0.065s)
[232.017544] [141/165] (797s left) vgem_basic (setversion)
[232.271269] Starting subtest: setversion
[232.315583] Subtest setversion: SUCCESS (0.000s)
[232.414107] [142/165] (797s left) vgem_basic (create)
[232.628839] Starting subtest: create
[232.649288] Subtest create: SUCCESS (0.000s)
[232.748688] [143/165] (796s left) vgem_basic (debugfs)
[232.959903] Starting subtest: debugfs
[232.983315] Subtest debugfs: SUCCESS (0.001s)
[233.086199] [144/165] (796s left) vgem_basic (dmabuf-export)
[233.317999] Starting subtest: dmabuf-export
[233.362931] Subtest dmabuf-export: SUCCESS (0.011s)
[233.460962] [145/165] (796s left) vgem_basic (dmabuf-fence)
[233.698250] Starting subtest: dmabuf-fence
[233.719206] Subtest dmabuf-fence: SUCCESS (0.002s)
[233.818606] [146/165] (796s left) vgem_basic (dmabuf-fence-before)
[234.051351] Starting subtest: dmabuf-fence-before
[234.075262] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[234.173724] [147/165] (795s left) vgem_basic (dmabuf-mmap)
[234.407970] Starting subtest: dmabuf-mmap
[234.429205] Subtest dmabuf-mmap: SUCCESS (0.041s)
[234.528062] [148/165] (795s left) vgem_basic (mmap)
[234.745039] Starting subtest: mmap
[234.765574] Subtest mmap: SUCCESS (0.026s)
[234.865589] [149/165] (795s left) vgem_basic (second-client)
[235.102421] Starting subtest: second-client
[235.146550] Subtest second-client: SUCCESS (0.032s)
[235.250775] [150/165] (795s left) vgem_basic (sysfs)
[235.465750] Starting subtest: sysfs
[235.489645] Subtest sysfs: SUCCESS (0.001s)
[235.594945] [151/165] (794s left) core_hotunplug (unbind-rebind)
[235.907852] Starting subtest: unbind-rebind
[239.808391] Subtest unbind-rebind: SUCCESS (3.884s)
[239.908910] [152/165] (790s left) vgem_basic (unload)
[240.134407] Starting subtest: unload
[269.374146] Subtest unload: SUCCESS (29.065s)
[269.471370] [153/165] (761s left) i915_module_load (reload)
[269.685984] Starting subtest: reload
[273.499219] Subtest reload: SUCCESS (3.802s)
[273.715393] [154/165] (757s left) gem_lmem_swapping (basic)
[273.998105] Subtest basic: SKIP (0.000s)
[274.093315] [155/165] (756s left) gem_lmem_swapping (parallel-random-engines)
[274.333677] Subtest parallel-random-engines: SKIP (0.000s)
[274.431077] [156/165] (756s left) gem_lmem_swapping (random-engines)
[274.687230] Subtest random-engines: SKIP (0.000s)
[274.782517] [157/165] (756s left) gem_lmem_swapping (verify-random)
[275.039835] Subtest verify-random: SKIP (0.000s)
[275.133943] [158/165] (756s left) i915_pm_rpm (module-reload)
[277.386617] Starting subtest: module-reload
[286.833179] Subtest module-reload: SUCCESS (9.456s)
[286.926175] [159/165] (744s left) i915_selftest (live)
[287.160286] Starting subtest: live
[287.181614] Starting dynamic subtest: sanitycheck
[288.831109] Dynamic subtest sanitycheck: SUCCESS (1.654s)
[288.874762] Starting dynamic subtest: uncore
[290.516221] Dynamic subtest uncore: SUCCESS (1.681s)
[290.559121] Starting dynamic subtest: workarounds
[292.345046] Dynamic subtest workarounds: SUCCESS (1.841s)
[292.382755] Starting dynamic subtest: gt_engines
[294.282353] Dynamic subtest gt_engines: SUCCESS (1.934s)
[294.319986] Starting dynamic subtest: gt_timelines
[317.442220] Dynamic subtest gt_timelines: SUCCESS (23.157s)
[317.479632] Starting dynamic subtest: gt_contexts
[319.095167] Dynamic subtest gt_contexts: SUCCESS (1.648s)
[319.130272] Starting dynamic subtest: gt_lrc
[323.594124] Dynamic subtest gt_lrc: SUCCESS (4.493s)
[323.629139] Starting dynamic subtest: gt_mocs
[325.186838] Dynamic subtest gt_mocs: SUCCESS (1.590s)
[325.233821] Starting dynamic subtest: gt_pm
[333.066063] Dynamic subtest gt_pm: SUCCESS (7.874s)
[333.114047] Starting dynamic subtest: gt_heartbeat
[334.706802] Dynamic subtest gt_heartbeat: SUCCESS (1.640s)
[334.756344] Starting dynamic subtest: gt_tlb
[337.202063] Dynamic subtest gt_tlb: SUCCESS (2.490s)
[337.248281] Starting dynamic subtest: requests
[345.299079] Dynamic subtest requests: SUCCESS (8.094s)
[345.343637] Starting dynamic subtest: migrate
[350.255362] Dynamic subtest migrate: SUCCESS (4.951s)
[350.290857] Starting dynamic subtest: active
[352.024897] Dynamic subtest active: SUCCESS (1.757s)
[352.063793] Starting dynamic subtest: objects
[356.657919] Dynamic subtest objects: SUCCESS (4.630s)
[356.698666] Starting dynamic subtest: mman
[365.369831] Dynamic subtest mman: SUCCESS (8.716s)
[365.405134] Starting dynamic subtest: dmabuf
[366.940470] Dynamic subtest dmabuf: SUCCESS (1.566s)
[366.977444] Starting dynamic subtest: vma
[368.500678] Dynamic subtest vma: SUCCESS (1.558s)
[368.537431] Starting dynamic subtest: coherency
[372.814809] Dynamic subtest coherency: SUCCESS (4.310s)
[372.850216] Starting dynamic subtest: gtt
[382.104682] Dynamic subtest gtt: SUCCESS (9.287s)
[382.142652] Starting dynamic subtest: gem
[385.163348] Dynamic subtest gem: SUCCESS (3.053s)
[385.200724] Starting dynamic subtest: evict
[391.224820] Dynamic subtest evict: SUCCESS (6.046s)
[391.266425] Starting dynamic subtest: hugepages
[399.407744] Dynamic subtest hugepages: SUCCESS (8.192s)
[399.463559] Starting dynamic subtest: gem_contexts
[424.639876] Dynamic subtest gem_contexts: SUCCESS (25.058s)
[424.674785] Starting dynamic subtest: client
[426.000555] Dynamic subtest client: SUCCESS (1.529s)
[426.039411] Starting dynamic subtest: gem_migrate
[427.713298] Dynamic subtest gem_migrate: SUCCESS (1.708s)
[427.748944] Starting dynamic subtest: reset
[440.479098] Dynamic subtest reset: SUCCESS (12.762s)
[440.517535] Starting dynamic subtest: memory_region
[442.006687] Dynamic subtest memory_region: SUCCESS (1.518s)
[442.063577] Starting dynamic subtest: hangcheck
[467.025551] Dynamic subtest hangcheck: SUCCESS (25.020s)
[467.061987] Starting dynamic subtest: execlists
[479.323463] Dynamic subtest execlists: SUCCESS (12.295s)
[479.362371] Starting dynamic subtest: ring_submission
[480.841754] Dynamic subtest ring_submission: SUCCESS (1.510s)
[480.880337] Starting dynamic subtest: perf
[482.659824] Dynamic subtest perf: SUCCESS (1.816s)
[482.700784] Starting dynamic subtest: slpc
[484.278209] Dynamic subtest slpc: SUCCESS (1.618s)
[484.314068] Starting dynamic subtest: guc
[485.780437] Dynamic subtest guc: SUCCESS (1.498s)
[485.829780] Starting dynamic subtest: guc_multi_lrc
[487.483958] Dynamic subtest guc_multi_lrc: SUCCESS (1.700s)
[487.521138] Starting dynamic subtest: guc_hang
[488.952915] Dynamic subtest guc_hang: SUCCESS (1.466s)
[489.003474] Starting dynamic subtest: late_gt_pm
[490.745413] Dynamic subtest late_gt_pm: SUCCESS (1.790s)
[490.767830] Subtest live: SUCCESS (203.584s)
[490.859167] [160/165] (540s left) dmabuf (all-tests)
[491.072387] Starting subtest: all-tests
[491.093538] Starting dynamic subtest: sanitycheck
[491.156861] Dynamic subtest sanitycheck: SUCCESS (0.084s)
[491.193593] Starting dynamic subtest: dma_fence
[491.343650] Dynamic subtest dma_fence: SUCCESS (0.184s)
[491.387079] Starting dynamic subtest: dma_fence_chain
[514.477574] Dynamic subtest dma_fence_chain: SUCCESS (23.131s)
[514.517411] Starting dynamic subtest: dma_fence_unwrap
[514.566858] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[514.606763] Starting dynamic subtest: dma_resv
[514.654609] Dynamic subtest dma_resv: SUCCESS (0.087s)
[514.675626] Subtest all-tests: SUCCESS (23.573s)
[514.776161] [161/165] (516s left) i915_suspend (basic-s2idle-without-i915)
[514.983096] Starting subtest: basic-s2idle-without-i915
[535.652627] Subtest basic-s2idle-without-i915: SUCCESS (5.680s)
[539.033943] [162/165] (510s left) i915_suspend (basic-s3-without-i915)
[539.232765] Starting subtest: basic-s3-without-i915
[557.386315] Subtest basic-s3-without-i915: SUCCESS (3.430s)
[561.739962] [163/165] (507s left) gem_exec_suspend (basic-s0)
[562.023534] Starting subtest: basic-S0
[562.047379] Starting dynamic subtest: smem
[583.904140] Dynamic subtest smem: SUCCESS (5.821s)
[583.925380] Subtest basic-S0: SUCCESS (5.823s)
[587.286940] [164/165] (500s left) gem_exec_suspend (basic-s3)
[587.517953] Starting subtest: basic-S3
[587.538716] Starting dynamic subtest: smem
[608.230572] Dynamic subtest smem: SUCCESS (5.830s)
[608.252312] Subtest basic-S3: SUCCESS (5.833s)
[610.608963] [165/165] (494s left) kms_pipe_crc_basic (suspend-read-crc)
[610.938926] Starting subtest: suspend-read-crc
[610.959214] Starting dynamic subtest: pipe-A-DP-1
[629.019188] Dynamic subtest pipe-A-DP-1: SUCCESS (2.408s)
[629.066043] Starting dynamic subtest: pipe-B-DP-1
[647.077474] Dynamic subtest pipe-B-DP-1: SUCCESS (2.414s)
[647.124722] Starting dynamic subtest: pipe-C-DP-1
[666.022286] Dynamic subtest pipe-C-DP-1: SUCCESS (2.549s)
[666.044705] Subtest suspend-read-crc: SUCCESS (7.387s)
[670.442675] Closing watchdogs
Done.