[33.604893] Initializing watchdogs
[33.605278]   /dev/watchdog0
[33.642348] [001/165] (960s left) i915_module_load (load)
[33.911052] Starting subtest: load
[36.462805] Subtest load: SUCCESS (2.551s)
[36.551259] [002/165] (957s left) core_auth (basic-auth)
[36.815459] Starting subtest: basic-auth
[36.835574] Subtest basic-auth: SUCCESS (0.002s)
[36.921771] [003/165] (957s left) debugfs_test (read_all_entries)
[37.157560] Starting subtest: read_all_entries
[37.534328] Subtest read_all_entries: SUCCESS (0.391s)
[37.742488] [004/165] (956s left) debugfs_test (basic-hwmon)
[37.971989] Starting subtest: basic-hwmon
[38.015640] Subtest basic-hwmon: SKIP (0.000s)
[38.158410] [005/165] (956s left) fbdev (eof)
[38.397841] Starting subtest: eof
[38.419708] Subtest eof: SUCCESS (0.002s)
[38.526830] [006/165] (956s left) fbdev (info)
[38.754691] Starting subtest: info
[38.778471] Subtest info: SUCCESS (0.000s)
[38.887185] [007/165] (955s left) fbdev (nullptr)
[39.098393] Starting subtest: nullptr
[39.118521] Subtest nullptr: SUCCESS (0.000s)
[39.226695] [008/165] (955s left) fbdev (read)
[39.433465] Starting subtest: read
[40.905704] Subtest read: SUCCESS (1.476s)
[41.012762] [009/165] (953s left) fbdev (write)
[41.219875] Starting subtest: write
[41.977831] Subtest write: SUCCESS (0.763s)
[42.085344] [010/165] (952s left) gem_basic (bad-close)
[42.318648] Starting subtest: bad-close
[42.362531] Subtest bad-close: SUCCESS (0.000s)
[42.449843] [011/165] (952s left) gem_basic (create-close)
[42.676511] Starting subtest: create-close
[42.717372] Subtest create-close: SUCCESS (0.000s)
[42.807361] [012/165] (952s left) gem_basic (create-fd-close)
[43.063205] Starting subtest: create-fd-close
[43.102842] Subtest create-fd-close: SUCCESS (0.000s)
[43.191233] [013/165] (951s left) gem_busy (busy@all-engines)
[43.429168] Starting subtest: busy
[43.450421] Starting dynamic subtest: all-engines
[43.510857] Dynamic subtest all-engines: SUCCESS (0.090s)
[43.539052] Subtest busy: SUCCESS (0.090s)
[43.926500] [014/165] (951s left) gem_close_race (basic-process)
[44.185079] Starting subtest: basic-process
[44.262063] Subtest basic-process: SUCCESS (0.098s)
[44.491805] [015/165] (950s left) gem_close_race (basic-threads)
[44.742964] Starting subtest: basic-threads
[45.952405] Subtest basic-threads: SUCCESS (1.222s)
[46.173427] [016/165] (949s left) gem_ctx_create (basic)
[46.458342] Starting subtest: basic
[46.482477] Subtest basic: SUCCESS (0.000s)
[46.652143] [017/165] (948s left) gem_ctx_create (basic-files)
[46.895288] Starting subtest: basic-files
[48.918363] Subtest basic-files: SUCCESS (2.038s)
[49.175892] [018/165] (946s left) gem_ctx_exec (basic)
[49.412428] Starting subtest: basic
[49.435707] Subtest basic: SUCCESS (0.009s)
[49.527411] [019/165] (946s left) gem_exec_basic (basic)
[49.765517] Starting subtest: basic
[49.786239] Starting dynamic subtest: rcs0-smem
[49.809847] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[49.845164] Starting dynamic subtest: bcs0-smem
[49.866101] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[49.900853] Starting dynamic subtest: vcs0-smem
[49.924116] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[49.960281] Starting dynamic subtest: vecs0-smem
[49.981238] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[50.001727] Subtest basic: SUCCESS (0.010s)
[50.093559] [020/165] (945s left) gem_exec_create (basic)
[50.358821] Starting subtest: basic
[50.378949] Starting dynamic subtest: smem
[52.416895] Dynamic subtest smem: SUCCESS (2.077s)
[52.437660] Subtest basic: SUCCESS (2.077s)
[52.629908] [021/165] (943s left) gem_exec_fence (basic-busy)
[52.991386] Starting subtest: basic-busy
[53.013384] Starting dynamic subtest: rcs0
[53.057975] Dynamic subtest rcs0: SUCCESS (0.028s)
[53.092160] Starting dynamic subtest: bcs0
[53.134351] Dynamic subtest bcs0: SUCCESS (0.035s)
[53.169526] Starting dynamic subtest: vcs0
[53.209939] Dynamic subtest vcs0: SUCCESS (0.030s)
[53.245540] Starting dynamic subtest: vecs0
[53.290897] Dynamic subtest vecs0: SUCCESS (0.027s)
[53.310411] Subtest basic-busy: SUCCESS (0.121s)
[53.944123] [022/165] (941s left) gem_exec_fence (basic-wait)
[54.309037] Starting subtest: basic-wait
[54.330850] Starting dynamic subtest: rcs0
[54.350916] Dynamic subtest rcs0: SUCCESS (0.029s)
[54.387179] Starting dynamic subtest: bcs0
[54.409883] Dynamic subtest bcs0: SUCCESS (0.030s)
[54.446982] Starting dynamic subtest: vcs0
[54.468462] Dynamic subtest vcs0: SUCCESS (0.029s)
[54.502544] Starting dynamic subtest: vecs0
[54.525160] Dynamic subtest vecs0: SUCCESS (0.025s)
[54.547096] Subtest basic-wait: SUCCESS (0.114s)
[55.108072] [023/165] (940s left) gem_exec_fence (basic-await)
[55.455255] Starting subtest: basic-await
[55.475171] Starting dynamic subtest: rcs0
[55.589956] Dynamic subtest rcs0: SUCCESS (0.133s)
[55.628726] Starting dynamic subtest: bcs0
[55.719731] Dynamic subtest bcs0: SUCCESS (0.131s)
[55.760456] Starting dynamic subtest: vcs0
[55.849370] Dynamic subtest vcs0: SUCCESS (0.129s)
[55.886629] Starting dynamic subtest: vecs0
[55.984283] Dynamic subtest vecs0: SUCCESS (0.131s)
[56.004809] Subtest basic-await: SUCCESS (0.528s)
[56.680781] [024/165] (939s left) gem_exec_fence (nb-await)
[57.033195] Starting subtest: nb-await
[57.055366] Starting dynamic subtest: rcs0
[57.106488] Dynamic subtest rcs0: SUCCESS (0.073s)
[57.150730] Starting dynamic subtest: bcs0
[57.201128] Dynamic subtest bcs0: SUCCESS (0.076s)
[57.245105] Starting dynamic subtest: vcs0
[57.280211] Dynamic subtest vcs0: SUCCESS (0.071s)
[57.324149] Starting dynamic subtest: vecs0
[57.352263] Dynamic subtest vecs0: SUCCESS (0.070s)
[57.378590] Subtest nb-await: SUCCESS (0.292s)
[58.035430] [025/165] (938s left) gem_exec_gttfill (basic)
[58.278249] Starting subtest: basic
[80.149871] Subtest basic: SUCCESS (21.878s)
[80.382512] [026/165] (915s left) gem_exec_parallel (engines)
[80.776391] Starting subtest: engines
[80.798899] Starting dynamic subtest: basic
[85.881503] Dynamic subtest basic: SUCCESS (4.932s)
[85.925078] Starting dynamic subtest: contexts
[91.819680] Dynamic subtest contexts: SUCCESS (6.119s)
[91.856489] Starting dynamic subtest: fds
[99.444467] Dynamic subtest fds: SUCCESS (7.456s)
[99.484135] Starting dynamic subtest: userptr
[104.468647] Dynamic subtest userptr: SUCCESS (5.008s)
[104.489075] Subtest engines: SUCCESS (23.516s)
[104.597494] [027/165] (891s left) gem_exec_store (basic)
[104.903748] Starting subtest: basic
[104.924523] Subtest basic: SUCCESS (0.069s)
[105.129405] [028/165] (891s left) gem_flink_basic (bad-flink)
[105.357301] Starting subtest: bad-flink
[105.378051] Subtest bad-flink: SUCCESS (0.000s)
[105.473686] [029/165] (891s left) gem_flink_basic (bad-open)
[105.703119] Starting subtest: bad-open
[105.725636] Subtest bad-open: SUCCESS (0.000s)
[105.817912] [030/165] (890s left) gem_flink_basic (basic)
[106.078148] Starting subtest: basic
[106.106403] Subtest basic: SUCCESS (0.000s)
[106.216997] [031/165] (890s left) gem_flink_basic (double-flink)
[106.507720] Starting subtest: double-flink
[106.536668] Subtest double-flink: SUCCESS (0.000s)
[106.652285] [032/165] (890s left) gem_flink_basic (flink-lifetime)
[106.938211] Starting subtest: flink-lifetime
[106.971516] Subtest flink-lifetime: SUCCESS (0.003s)
[107.088500] [033/165] (889s left) gem_huc_copy (huc-copy)
[107.324196] Starting subtest: huc-copy
[107.345889] Subtest huc-copy: SUCCESS (0.008s)
[107.445589] [034/165] (889s left) gem_linear_blits (basic)
[107.839409] Starting subtest: basic
[107.861033] Subtest basic: SUCCESS (0.018s)
[108.045380] [035/165] (889s left) gem_mmap (basic)
[108.435650] Starting subtest: basic
[108.545535] Subtest basic: SUCCESS (0.001s)
[108.637369] [036/165] (888s left) gem_mmap_gtt (basic)
[108.873969] Starting subtest: basic
[108.894865] Subtest basic: SUCCESS (0.002s)
[108.990231] [037/165] (888s left) gem_render_linear_blits (basic)
[109.224347] Starting subtest: basic
[109.327759] Subtest basic: SUCCESS (0.091s)
[109.421077] [038/165] (887s left) gem_render_tiled_blits (basic)
[109.659156] Starting subtest: basic
[109.786770] Subtest basic: SUCCESS (0.117s)
[109.880981] [039/165] (887s left) gem_ringfill (basic-all)
[110.389145] Starting subtest: basic-all
[111.572147] Subtest basic-all: SUCCESS (1.211s)
[111.713892] [040/165] (885s left) gem_softpin (allocator-basic)
[111.947333] Starting subtest: allocator-basic
[112.163771] Subtest allocator-basic: SUCCESS (0.239s)
[112.314570] [041/165] (885s left) gem_softpin (allocator-basic-reserve)
[112.564455] Starting subtest: allocator-basic-reserve
[112.764348] Subtest allocator-basic-reserve: SUCCESS (0.245s)
[112.911469] [042/165] (884s left) gem_softpin (safe-alignment)
[113.139071] Starting subtest: safe-alignment
[113.159289] Subtest safe-alignment: SUCCESS (0.031s)
[113.287331] [043/165] (884s left) gem_sync (basic-all)
[113.692160] Starting subtest: basic-all
[116.688512] Subtest basic-all: SUCCESS (3.006s)
[116.778109] [044/165] (881s left) gem_sync (basic-each)
[117.213548] Starting subtest: basic-each
[119.306983] Subtest basic-each: SUCCESS (2.302s)
[119.531084] [045/165] (878s left) gem_tiled_blits (basic)
[119.900568] Starting subtest: basic
[119.948844] Subtest basic: SUCCESS (0.051s)
[120.143143] [046/165] (877s left) gem_tiled_fence_blits (basic)
[120.688928] Starting subtest: basic
[120.732774] Subtest basic: SUCCESS (0.043s)
[120.941406] [047/165] (877s left) gem_tiled_pread_basic
[121.711404] [048/165] (876s left) gem_wait (busy@all-engines)
[121.986363] Starting subtest: busy
[122.009882] Starting dynamic subtest: all-engines
[122.510347] Dynamic subtest all-engines: SUCCESS (0.528s)
[122.536052] Subtest busy: SUCCESS (0.529s)
[122.762589] [049/165] (875s left) gem_wait (wait@all-engines)
[123.013239] Starting subtest: wait
[123.033506] Starting dynamic subtest: all-engines
[124.047451] Dynamic subtest all-engines: SUCCESS (1.053s)
[124.067247] Subtest wait: SUCCESS (1.053s)
[124.319645] [050/165] (874s left) i915_getparams_basic (basic-eu-total)
[124.549999] Starting subtest: basic-eu-total
[124.595614] Subtest basic-eu-total: SUCCESS (0.000s)
[124.687962] [051/165] (873s left) i915_getparams_basic (basic-subslice-total)
[124.914412] Starting subtest: basic-subslice-total
[124.957935] Subtest basic-subslice-total: SUCCESS (0.000s)
[125.050357] [052/165] (873s left) i915_hangman (error-state-basic)
[125.298647] Starting subtest: error-state-basic
[125.601588] Subtest error-state-basic: SUCCESS (0.310s)
[125.713766] [053/165] (872s left) i915_pciid
[126.054633] [054/165] (872s left) kms_addfb_basic (addfb25-4-tiled)
[126.437169] Starting subtest: addfb25-4-tiled
[126.457080] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[126.551327] [055/165] (872s left) kms_addfb_basic (addfb25-bad-modifier)
[126.778651] Starting subtest: addfb25-bad-modifier
[126.800706] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[127.001123] [056/165] (871s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[127.233827] Starting subtest: addfb25-framebuffer-vs-set-tiling
[127.254240] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[127.429489] [057/165] (871s left) kms_addfb_basic (addfb25-modifier-no-flag)
[127.641474] Starting subtest: addfb25-modifier-no-flag
[127.661082] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[127.828705] [058/165] (871s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[128.062318] Starting subtest: addfb25-x-tiled-legacy
[128.081685] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[128.266087] [059/165] (870s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[128.496602] Starting subtest: addfb25-x-tiled-mismatch-legacy
[128.518630] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[128.697958] [060/165] (870s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[128.996413] Starting subtest: addfb25-yf-tiled-legacy
[129.016355] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[129.130405] [061/165] (870s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[129.443423] Starting subtest: addfb25-y-tiled-legacy
[129.462767] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[129.556558] [062/165] (869s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[129.871933] Starting subtest: addfb25-y-tiled-small-legacy
[129.893629] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[129.984497] [063/165] (869s left) kms_addfb_basic (bad-pitch-0)
[130.212420] Starting subtest: bad-pitch-0
[130.231964] Subtest bad-pitch-0: SUCCESS (0.000s)
[130.416462] [064/165] (869s left) kms_addfb_basic (bad-pitch-1024)
[130.646728] Starting subtest: bad-pitch-1024
[130.668685] Subtest bad-pitch-1024: SUCCESS (0.000s)
[130.848382] [065/165] (868s left) kms_addfb_basic (bad-pitch-128)
[131.073279] Starting subtest: bad-pitch-128
[131.093879] Subtest bad-pitch-128: SUCCESS (0.000s)
[131.278578] [066/165] (868s left) kms_addfb_basic (bad-pitch-256)
[131.505957] Starting subtest: bad-pitch-256
[131.525378] Subtest bad-pitch-256: SUCCESS (0.000s)
[131.723291] [067/165] (868s left) kms_addfb_basic (bad-pitch-32)
[131.972827] Starting subtest: bad-pitch-32
[131.997676] Subtest bad-pitch-32: SUCCESS (0.000s)
[132.170962] [068/165] (867s left) kms_addfb_basic (bad-pitch-63)
[132.409508] Starting subtest: bad-pitch-63
[132.436977] Subtest bad-pitch-63: SUCCESS (0.000s)
[132.619062] [069/165] (867s left) kms_addfb_basic (bad-pitch-65536)
[132.910711] Starting subtest: bad-pitch-65536
[132.939587] Subtest bad-pitch-65536: SUCCESS (0.001s)
[133.086823] [070/165] (867s left) kms_addfb_basic (bad-pitch-999)
[133.353848] Starting subtest: bad-pitch-999
[133.379639] Subtest bad-pitch-999: SUCCESS (0.000s)
[133.548933] [071/165] (866s left) kms_addfb_basic (basic)
[133.811290] Starting subtest: basic
[133.840154] Subtest basic: SUCCESS (0.000s)
[134.048352] [072/165] (866s left) kms_addfb_basic (basic-x-tiled-legacy)
[134.294336] Starting subtest: basic-x-tiled-legacy
[134.318175] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[134.488465] [073/165] (866s left) kms_addfb_basic (basic-y-tiled-legacy)
[134.746541] Starting subtest: basic-y-tiled-legacy
[134.775341] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[134.948322] [074/165] (865s left) kms_addfb_basic (bo-too-small)
[135.275549] Starting subtest: bo-too-small
[135.298082] Subtest bo-too-small: SUCCESS (0.001s)
[135.390229] [075/165] (865s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[135.701983] Starting subtest: bo-too-small-due-to-tiling
[135.721099] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[135.816110] [076/165] (865s left) kms_addfb_basic (clobberred-modifier)
[136.067651] Starting subtest: clobberred-modifier
[136.088110] Subtest clobberred-modifier: SUCCESS (0.000s)
[136.244824] [077/165] (864s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[136.473479] Starting subtest: framebuffer-vs-set-tiling
[136.493514] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[136.663662] [078/165] (864s left) kms_addfb_basic (invalid-get-prop)
[136.888194] Starting subtest: invalid-get-prop
[136.907477] Subtest invalid-get-prop: SUCCESS (0.000s)
[137.082218] [079/165] (863s left) kms_addfb_basic (invalid-get-prop-any)
[137.329270] Starting subtest: invalid-get-prop-any
[137.350438] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[137.515086] [080/165] (863s left) kms_addfb_basic (invalid-set-prop)
[137.744759] Starting subtest: invalid-set-prop
[137.765915] Subtest invalid-set-prop: SUCCESS (0.000s)
[137.946816] [081/165] (863s left) kms_addfb_basic (invalid-set-prop-any)
[138.171408] Starting subtest: invalid-set-prop-any
[138.190770] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[138.364596] [082/165] (862s left) kms_addfb_basic (no-handle)
[138.589978] Starting subtest: no-handle
[138.612167] Subtest no-handle: SUCCESS (0.000s)
[138.778510] [083/165] (862s left) kms_addfb_basic (size-max)
[139.072270] Starting subtest: size-max
[139.094954] Subtest size-max: SUCCESS (0.000s)
[139.195565] [084/165] (862s left) kms_addfb_basic (small-bo)
[139.489423] Starting subtest: small-bo
[139.509268] Subtest small-bo: SUCCESS (0.000s)
[139.602465] [085/165] (861s left) kms_addfb_basic (tile-pitch-mismatch)
[139.828720] Starting subtest: tile-pitch-mismatch
[139.850735] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[140.028295] [086/165] (861s left) kms_addfb_basic (too-high)
[140.340653] Starting subtest: too-high
[140.364885] Subtest too-high: SUCCESS (0.002s)
[140.470706] [087/165] (861s left) kms_addfb_basic (too-wide)
[140.785941] Starting subtest: too-wide
[140.809147] Subtest too-wide: SUCCESS (0.000s)
[140.924973] [088/165] (860s left) kms_addfb_basic (unused-handle)
[141.172480] Starting subtest: unused-handle
[141.198795] Subtest unused-handle: SUCCESS (0.000s)
[141.371612] [089/165] (860s left) kms_addfb_basic (unused-modifier)
[141.637291] Starting subtest: unused-modifier
[141.663660] Subtest unused-modifier: SUCCESS (0.000s)
[141.839259] [090/165] (860s left) kms_addfb_basic (unused-offsets)
[142.066366] Starting subtest: unused-offsets
[142.087319] Subtest unused-offsets: SUCCESS (0.000s)
[142.260583] [091/165] (859s left) kms_addfb_basic (unused-pitches)
[142.488036] Starting subtest: unused-pitches
[142.507500] Subtest unused-pitches: SUCCESS (0.000s)
[142.697324] [092/165] (859s left) kms_busy (basic)
[143.020965] Starting subtest: basic
[143.041686] Starting dynamic subtest: flip
[143.991118] Dynamic subtest flip: SUCCESS (0.969s)
[144.029204] Starting dynamic subtest: modeset
[145.387386] Dynamic subtest modeset: SUCCESS (1.397s)
[145.407244] Subtest basic: SUCCESS (2.370s)
[145.768352] [093/165] (856s left) kms_prop_blob (basic)
[146.031689] Starting subtest: basic
[146.054318] Subtest basic: SUCCESS (0.000s)
[146.148438] [094/165] (856s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[146.473476] Starting subtest: basic-busy-flip-before-cursor-atomic
[146.514552] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[146.608399] [095/165] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[146.922923] Starting subtest: basic-busy-flip-before-cursor-legacy
[146.967071] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[147.063354] [096/165] (855s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[147.377140] Starting subtest: basic-flip-after-cursor-atomic
[148.430451] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.051s)
[148.775769] [097/165] (853s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[149.069769] Starting subtest: basic-flip-after-cursor-legacy
[150.153239] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.063s)
[150.522412] [098/165] (852s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[150.848452] Starting subtest: basic-flip-after-cursor-varying-size
[151.931531] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.080s)
[152.275912] [099/165] (850s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[152.587634] Starting subtest: basic-flip-before-cursor-atomic
[153.639944] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.049s)
[153.990285] [100/165] (848s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[154.303711] Starting subtest: basic-flip-before-cursor-legacy
[155.348362] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.049s)
[155.701070] [101/165] (847s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[155.993623] Starting subtest: basic-flip-before-cursor-varying-size
[157.069418] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.068s)
[157.433600] [102/165] (845s left) kms_dsc (dsc-basic)
[157.783848] Subtest dsc-basic: SKIP (0.000s)
[157.875768] [103/165] (845s left) kms_flip (basic-flip-vs-dpms)
[158.220427] Starting subtest: basic-flip-vs-dpms
[158.241341] Starting dynamic subtest: A-DP1
[159.464195] Dynamic subtest A-DP1: SUCCESS (1.256s)
[159.506378] Starting dynamic subtest: B-DP1
[160.592289] Dynamic subtest B-DP1: SUCCESS (1.148s)
[160.632995] Starting dynamic subtest: C-DP1
[161.748812] Dynamic subtest C-DP1: SUCCESS (1.125s)
[161.774925] Subtest basic-flip-vs-dpms: SUCCESS (3.538s)
[162.154085] [104/165] (841s left) kms_flip (basic-flip-vs-modeset)
[162.497442] Starting subtest: basic-flip-vs-modeset
[162.522725] Starting dynamic subtest: A-DP1
[163.771500] Dynamic subtest A-DP1: SUCCESS (1.299s)
[163.811895] Starting dynamic subtest: B-DP1
[164.900955] Dynamic subtest B-DP1: SUCCESS (1.132s)
[164.941533] Starting dynamic subtest: C-DP1
[166.052726] Dynamic subtest C-DP1: SUCCESS (1.149s)
[166.074522] Subtest basic-flip-vs-modeset: SUCCESS (3.590s)
[166.440640] [105/165] (836s left) kms_flip (basic-flip-vs-wf_vblank)
[166.762236] Starting subtest: basic-flip-vs-wf_vblank
[166.784439] Starting dynamic subtest: A-DP1
[168.220948] Dynamic subtest A-DP1: SUCCESS (1.457s)
[168.269892] Starting dynamic subtest: B-DP1
[169.601460] Dynamic subtest B-DP1: SUCCESS (1.380s)
[169.649809] Starting dynamic subtest: C-DP1
[171.004585] Dynamic subtest C-DP1: SUCCESS (1.395s)
[171.031919] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.243s)
[171.450604] [106/165] (832s left) kms_flip (basic-plain-flip)
[171.772145] Starting subtest: basic-plain-flip
[171.793239] Starting dynamic subtest: A-DP1
[172.929700] Dynamic subtest A-DP1: SUCCESS (1.165s)
[172.970254] Starting dynamic subtest: B-DP1
[174.039111] Dynamic subtest B-DP1: SUCCESS (1.110s)
[174.080815] Starting dynamic subtest: C-DP1
[175.157464] Dynamic subtest C-DP1: SUCCESS (1.110s)
[175.178351] Subtest basic-plain-flip: SUCCESS (3.396s)
[175.613658] [107/165] (827s left) kms_force_connector_basic (force-connector-state)
[175.877505] Subtest force-connector-state: SKIP (0.000s)
[175.978553] [108/165] (827s left) kms_force_connector_basic (force-edid)
[176.249318] Subtest force-edid: SKIP (0.000s)
[176.343863] [109/165] (827s left) kms_force_connector_basic (force-load-detect)
[176.592886] Subtest force-load-detect: SKIP (0.000s)
[176.689801] [110/165] (827s left) kms_force_connector_basic (prune-stale-modes)
[176.960775] Subtest prune-stale-modes: SKIP (0.000s)
[177.055302] [111/165] (826s left) kms_frontbuffer_tracking (basic)
[177.435234] Starting subtest: basic
[180.417674] Subtest basic: SUCCESS (3.039s)
[180.555173] [112/165] (823s left) kms_hdmi_inject (inject-audio)
[180.836618] Subtest inject-audio: SKIP (0.000s)
[180.944900] [113/165] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[181.276272] Starting subtest: compare-crc-sanitycheck-xr24
[181.303314] Starting dynamic subtest: pipe-A-DP-1
[181.714066] Dynamic subtest pipe-A-DP-1: SUCCESS (0.433s)
[181.761773] Starting dynamic subtest: pipe-B-DP-1
[182.322266] Dynamic subtest pipe-B-DP-1: SUCCESS (0.603s)
[182.365261] Starting dynamic subtest: pipe-C-DP-1
[182.941363] Dynamic subtest pipe-C-DP-1: SUCCESS (0.611s)
[182.963303] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.659s)
[183.291770] [114/165] (820s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[183.584632] Starting subtest: compare-crc-sanitycheck-nv12
[183.604372] Starting dynamic subtest: pipe-A-DP-1
[183.647899] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[183.687601] Starting dynamic subtest: pipe-B-DP-1
[183.730589] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[183.771319] Starting dynamic subtest: pipe-C-DP-1
[183.814136] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[183.859257] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[183.955958] [115/165] (820s left) kms_pipe_crc_basic (hang-read-crc)
[184.253565] Starting subtest: hang-read-crc
[184.275053] Starting dynamic subtest: pipe-A-DP-1
[185.724635] Dynamic subtest pipe-A-DP-1: SUCCESS (1.451s)
[185.779797] Starting dynamic subtest: pipe-B-DP-1
[187.390789] Dynamic subtest pipe-B-DP-1: SUCCESS (1.664s)
[187.438403] Starting dynamic subtest: pipe-C-DP-1
[189.002171] Dynamic subtest pipe-C-DP-1: SUCCESS (1.623s)
[189.022267] Subtest hang-read-crc: SUCCESS (4.751s)
[189.366700] [116/165] (815s left) kms_pipe_crc_basic (nonblocking-crc)
[189.664479] Starting subtest: nonblocking-crc
[189.685660] Starting dynamic subtest: pipe-A-DP-1
[190.276722] Dynamic subtest pipe-A-DP-1: SUCCESS (0.571s)
[190.326550] Starting dynamic subtest: pipe-B-DP-1
[191.013878] Dynamic subtest pipe-B-DP-1: SUCCESS (0.762s)
[191.075231] Starting dynamic subtest: pipe-C-DP-1
[191.806744] Dynamic subtest pipe-C-DP-1: SUCCESS (0.764s)
[191.836549] Subtest nonblocking-crc: SUCCESS (2.111s)
[192.159295] [117/165] (812s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[192.499064] Starting subtest: nonblocking-crc-frame-sequence
[192.528291] Starting dynamic subtest: pipe-A-DP-1
[193.050096] Dynamic subtest pipe-A-DP-1: SUCCESS (0.561s)
[193.090793] Starting dynamic subtest: pipe-B-DP-1
[193.795579] Dynamic subtest pipe-B-DP-1: SUCCESS (0.743s)
[193.836305] Starting dynamic subtest: pipe-C-DP-1
[194.574985] Dynamic subtest pipe-C-DP-1: SUCCESS (0.769s)
[194.595048] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.087s)
[194.916942] [118/165] (809s left) kms_pipe_crc_basic (read-crc)
[195.238274] Starting subtest: read-crc
[195.259349] Starting dynamic subtest: pipe-A-DP-1
[195.739344] Dynamic subtest pipe-A-DP-1: SUCCESS (0.499s)
[195.777887] Starting dynamic subtest: pipe-B-DP-1
[196.440458] Dynamic subtest pipe-B-DP-1: SUCCESS (0.694s)
[196.484899] Starting dynamic subtest: pipe-C-DP-1
[197.148638] Dynamic subtest pipe-C-DP-1: SUCCESS (0.704s)
[197.168583] Subtest read-crc: SUCCESS (1.912s)
[197.491305] [119/165] (807s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[197.812208] Starting subtest: read-crc-frame-sequence
[197.833241] Starting dynamic subtest: pipe-A-DP-1
[198.335947] Dynamic subtest pipe-A-DP-1: SUCCESS (0.523s)
[198.377632] Starting dynamic subtest: pipe-B-DP-1
[199.032182] Dynamic subtest pipe-B-DP-1: SUCCESS (0.696s)
[199.072449] Starting dynamic subtest: pipe-C-DP-1
[199.740317] Dynamic subtest pipe-C-DP-1: SUCCESS (0.687s)
[199.769213] Subtest read-crc-frame-sequence: SUCCESS (1.920s)
[200.092172] [120/165] (804s left) kms_pm_backlight (basic-brightness)
[200.419771] Subtest basic-brightness: SKIP (0.000s)
[200.537864] [121/165] (804s left) kms_pm_rpm (basic-pci-d3-state)
[202.421462] Starting subtest: basic-pci-d3-state
[203.068245] Subtest basic-pci-d3-state: SUCCESS (0.640s)
[203.294745] [122/165] (801s left) kms_pm_rpm (basic-rte)
[203.529971] Starting subtest: basic-rte
[205.684596] Subtest basic-rte: SUCCESS (2.187s)
[206.568348] [123/165] (798s left) kms_psr (psr-primary-page-flip)
[206.892859] Subtest psr-primary-page-flip: SKIP (0.000s)
[207.010564] [124/165] (798s left) kms_psr (psr-cursor-plane-move)
[207.330944] Subtest psr-cursor-plane-move: SKIP (0.000s)
[207.429810] [125/165] (797s left) kms_psr (psr-sprite-plane-onoff)
[207.747955] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[207.845818] [126/165] (797s left) kms_psr (psr-primary-mmap-gtt)
[208.168195] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[208.267291] [127/165] (797s left) kms_setmode (basic-clone-single-crtc)
[208.526251] Starting subtest: basic-clone-single-crtc
[208.591264] Subtest basic-clone-single-crtc: SKIP (0.000s)
[208.687052] [128/165] (796s left) i915_pm_rps (basic-api)
[208.924667] Starting subtest: basic-api
[208.946093] Subtest basic-api: SUCCESS (0.007s)
[209.065668] [129/165] (796s left) prime_self_import (basic-llseek-bad)
[209.317207] Starting subtest: basic-llseek-bad
[209.365159] Subtest basic-llseek-bad: SUCCESS (0.004s)
[209.475200] [130/165] (796s left) prime_self_import (basic-llseek-size)
[209.740944] Starting subtest: basic-llseek-size
[209.797156] Subtest basic-llseek-size: SUCCESS (0.006s)
[209.911784] [131/165] (796s left) prime_self_import (basic-with_fd_dup)
[210.182659] Starting subtest: basic-with_fd_dup
[210.240462] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[210.362218] [132/165] (795s left) prime_self_import (basic-with_one_bo)
[210.606570] Starting subtest: basic-with_one_bo
[210.647952] Subtest basic-with_one_bo: SUCCESS (0.007s)
[210.745836] [133/165] (795s left) prime_self_import (basic-with_one_bo_two_files)
[210.975880] Starting subtest: basic-with_one_bo_two_files
[211.020091] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[211.118068] [134/165] (795s left) prime_self_import (basic-with_two_bos)
[211.326895] Starting subtest: basic-with_two_bos
[211.368127] Subtest basic-with_two_bos: SUCCESS (0.006s)
[211.463436] [135/165] (794s left) prime_vgem (basic-fence-flip)
[211.742271] Starting subtest: basic-fence-flip
[212.303124] Subtest basic-fence-flip: SUCCESS (0.593s)
[212.428299] [136/165] (794s left) prime_vgem (basic-fence-mmap)
[212.696095] Starting subtest: basic-fence-mmap
[212.717167] Subtest basic-fence-mmap: SUCCESS (0.071s)
[212.845303] [137/165] (793s left) prime_vgem (basic-fence-read)
[213.113577] Starting subtest: basic-fence-read
[213.179113] Subtest basic-fence-read: SUCCESS (0.109s)
[213.297947] [138/165] (793s left) prime_vgem (basic-gtt)
[213.549812] Starting subtest: basic-gtt
[213.571279] Subtest basic-gtt: SUCCESS (0.035s)
[213.690069] [139/165] (793s left) prime_vgem (basic-read)
[213.961568] Starting subtest: basic-read
[213.982401] Subtest basic-read: SUCCESS (0.054s)
[214.111974] [140/165] (792s left) prime_vgem (basic-write)
[214.382899] Starting subtest: basic-write
[214.410619] Subtest basic-write: SUCCESS (0.064s)
[214.528214] [141/165] (792s left) vgem_basic (setversion)
[214.785971] Starting subtest: setversion
[214.829867] Subtest setversion: SUCCESS (0.000s)
[214.924568] [142/165] (792s left) vgem_basic (create)
[215.174426] Starting subtest: create
[215.196305] Subtest create: SUCCESS (0.001s)
[215.293198] [143/165] (791s left) vgem_basic (debugfs)
[215.546314] Starting subtest: debugfs
[215.568225] Subtest debugfs: SUCCESS (0.001s)
[215.665906] [144/165] (791s left) vgem_basic (dmabuf-export)
[215.915198] Starting subtest: dmabuf-export
[215.955882] Subtest dmabuf-export: SUCCESS (0.005s)
[216.052145] [145/165] (791s left) vgem_basic (dmabuf-fence)
[216.291948] Starting subtest: dmabuf-fence
[216.312264] Subtest dmabuf-fence: SUCCESS (0.002s)
[216.409875] [146/165] (791s left) vgem_basic (dmabuf-fence-before)
[216.638198] Starting subtest: dmabuf-fence-before
[216.661044] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[216.754704] [147/165] (790s left) vgem_basic (dmabuf-mmap)
[217.006052] Starting subtest: dmabuf-mmap
[217.029386] Subtest dmabuf-mmap: SUCCESS (0.043s)
[217.125414] [148/165] (790s left) vgem_basic (mmap)
[217.370983] Starting subtest: mmap
[217.394715] Subtest mmap: SUCCESS (0.026s)
[217.488580] [149/165] (790s left) vgem_basic (second-client)
[217.717482] Starting subtest: second-client
[217.757462] Subtest second-client: SUCCESS (0.032s)
[217.854257] [150/165] (790s left) vgem_basic (sysfs)
[218.125995] Starting subtest: sysfs
[218.150197] Subtest sysfs: SUCCESS (0.001s)
[218.258097] [151/165] (789s left) core_hotunplug (unbind-rebind)
[218.739309] Starting subtest: unbind-rebind
[222.627673] Subtest unbind-rebind: SUCCESS (3.899s)
[222.725840] [152/165] (785s left) vgem_basic (unload)
[222.959736] Starting subtest: unload
[252.243101] Subtest unload: SUCCESS (29.128s)
[252.341724] [153/165] (755s left) i915_module_load (reload)
[252.578403] Starting subtest: reload
[256.325202] Subtest reload: SUCCESS (3.766s)
[256.448112] [154/165] (751s left) gem_lmem_swapping (basic)
[256.720437] Subtest basic: SKIP (0.000s)
[256.816161] [155/165] (751s left) gem_lmem_swapping (parallel-random-engines)
[257.085422] Subtest parallel-random-engines: SKIP (0.000s)
[257.177261] [156/165] (751s left) gem_lmem_swapping (random-engines)
[257.429905] Subtest random-engines: SKIP (0.000s)
[257.524886] [157/165] (751s left) gem_lmem_swapping (verify-random)
[257.798407] Subtest verify-random: SKIP (0.000s)
[257.893217] [158/165] (750s left) i915_pm_rpm (module-reload)
[260.155741] Starting subtest: module-reload
[269.640880] Subtest module-reload: SUCCESS (9.499s)
[269.734135] [159/165] (739s left) i915_selftest (live)
[269.970154] Starting subtest: live
[269.992735] Starting dynamic subtest: sanitycheck
[271.675665] Dynamic subtest sanitycheck: SUCCESS (1.706s)
[271.710520] Starting dynamic subtest: uncore
[273.344823] Dynamic subtest uncore: SUCCESS (1.664s)
[273.380156] Starting dynamic subtest: workarounds
[275.065672] Dynamic subtest workarounds: SUCCESS (1.715s)
[275.111898] Starting dynamic subtest: gt_engines
[277.193353] Dynamic subtest gt_engines: SUCCESS (2.117s)
[277.245886] Starting dynamic subtest: gt_timelines
[299.447390] Dynamic subtest gt_timelines: SUCCESS (22.258s)
[299.484370] Starting dynamic subtest: gt_contexts
[301.272693] Dynamic subtest gt_contexts: SUCCESS (1.822s)
[301.307504] Starting dynamic subtest: gt_lrc
[305.620813] Dynamic subtest gt_lrc: SUCCESS (4.346s)
[305.658815] Starting dynamic subtest: gt_mocs
[307.450761] Dynamic subtest gt_mocs: SUCCESS (1.825s)
[307.498317] Starting dynamic subtest: gt_pm
[316.490801] Dynamic subtest gt_pm: SUCCESS (9.036s)
[316.527946] Starting dynamic subtest: gt_heartbeat
[318.132568] Dynamic subtest gt_heartbeat: SUCCESS (1.635s)
[318.187197] Starting dynamic subtest: gt_tlb
[320.664889] Dynamic subtest gt_tlb: SUCCESS (2.532s)
[320.710366] Starting dynamic subtest: requests
[328.723257] Dynamic subtest requests: SUCCESS (8.056s)
[328.769684] Starting dynamic subtest: migrate
[333.500484] Dynamic subtest migrate: SUCCESS (4.775s)
[333.536890] Starting dynamic subtest: active
[335.274754] Dynamic subtest active: SUCCESS (1.770s)
[335.320926] Starting dynamic subtest: objects
[339.884469] Dynamic subtest objects: SUCCESS (4.605s)
[339.931449] Starting dynamic subtest: mman
[348.865728] Dynamic subtest mman: SUCCESS (8.978s)
[348.901624] Starting dynamic subtest: dmabuf
[350.440609] Dynamic subtest dmabuf: SUCCESS (1.569s)
[350.480286] Starting dynamic subtest: vma
[352.187863] Dynamic subtest vma: SUCCESS (1.748s)
[352.237599] Starting dynamic subtest: coherency
[356.718438] Dynamic subtest coherency: SUCCESS (4.524s)
[356.753975] Starting dynamic subtest: gtt
[366.146882] Dynamic subtest gtt: SUCCESS (9.424s)
[366.194198] Starting dynamic subtest: gem
[369.092537] Dynamic subtest gem: SUCCESS (2.945s)
[369.138415] Starting dynamic subtest: evict
[375.451192] Dynamic subtest evict: SUCCESS (6.353s)
[375.497224] Starting dynamic subtest: hugepages
[383.765261] Dynamic subtest hugepages: SUCCESS (8.312s)
[383.800835] Starting dynamic subtest: gem_contexts
[408.902611] Dynamic subtest gem_contexts: SUCCESS (24.959s)
[408.937704] Starting dynamic subtest: client
[410.485215] Dynamic subtest client: SUCCESS (1.753s)
[410.523724] Starting dynamic subtest: gem_migrate
[412.201604] Dynamic subtest gem_migrate: SUCCESS (1.709s)
[412.239420] Starting dynamic subtest: reset
[425.728069] Dynamic subtest reset: SUCCESS (13.523s)
[425.775945] Starting dynamic subtest: memory_region
[427.266134] Dynamic subtest memory_region: SUCCESS (1.537s)
[427.305377] Starting dynamic subtest: hangcheck
[452.029518] Dynamic subtest hangcheck: SUCCESS (24.758s)
[452.077327] Starting dynamic subtest: execlists
[464.487324] Dynamic subtest execlists: SUCCESS (12.454s)
[464.524910] Starting dynamic subtest: ring_submission
[466.229759] Dynamic subtest ring_submission: SUCCESS (1.740s)
[466.273949] Starting dynamic subtest: perf
[468.057943] Dynamic subtest perf: SUCCESS (1.817s)
[468.104297] Starting dynamic subtest: slpc
[469.609520] Dynamic subtest slpc: SUCCESS (1.555s)
[469.657472] Starting dynamic subtest: guc
[471.160899] Dynamic subtest guc: SUCCESS (1.548s)
[471.207968] Starting dynamic subtest: guc_multi_lrc
[472.833106] Dynamic subtest guc_multi_lrc: SUCCESS (1.666s)
[472.870673] Starting dynamic subtest: guc_hang
[474.344570] Dynamic subtest guc_hang: SUCCESS (1.509s)
[474.391706] Starting dynamic subtest: late_gt_pm
[476.119218] Dynamic subtest late_gt_pm: SUCCESS (1.769s)
[476.139945] Subtest live: SUCCESS (206.151s)
[476.231123] [160/165] (532s left) dmabuf (all-tests)
[476.454222] Starting subtest: all-tests
[476.473879] Starting dynamic subtest: sanitycheck
[476.532862] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[476.568902] Starting dynamic subtest: dma_fence
[476.738500] Dynamic subtest dma_fence: SUCCESS (0.203s)
[476.774096] Starting dynamic subtest: dma_fence_chain
[499.988142] Dynamic subtest dma_fence_chain: SUCCESS (23.243s)
[500.028064] Starting dynamic subtest: dma_fence_unwrap
[500.072975] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s)
[500.108316] Starting dynamic subtest: dma_resv
[500.152826] Dynamic subtest dma_resv: SUCCESS (0.074s)
[500.175315] Subtest all-tests: SUCCESS (23.691s)
[500.266689] [161/165] (508s left) i915_suspend (basic-s2idle-without-i915)
[500.483239] Starting subtest: basic-s2idle-without-i915
[521.135612] Subtest basic-s2idle-without-i915: SUCCESS (5.656s)
[524.515469] [162/165] (502s left) i915_suspend (basic-s3-without-i915)
[524.742151] Starting subtest: basic-s3-without-i915
[543.002158] Subtest basic-s3-without-i915: SUCCESS (3.455s)
[546.368923] [163/165] (499s left) gem_exec_suspend (basic-s0)
[546.609495] Starting subtest: basic-S0
[546.629854] Starting dynamic subtest: smem
[568.636551] Dynamic subtest smem: SUCCESS (6.008s)
[568.659259] Subtest basic-S0: SUCCESS (6.011s)
[572.029006] [164/165] (492s left) gem_exec_suspend (basic-s3)
[572.280032] Starting subtest: basic-S3
[572.299056] Starting dynamic subtest: smem
[592.845232] Dynamic subtest smem: SUCCESS (5.605s)
[592.868009] Subtest basic-S3: SUCCESS (5.607s)
[595.236382] [165/165] (486s left) kms_pipe_crc_basic (suspend-read-crc)
[595.537826] Starting subtest: suspend-read-crc
[595.560078] Starting dynamic subtest: pipe-A-DP-1
[613.688913] Dynamic subtest pipe-A-DP-1: SUCCESS (2.466s)
[613.734622] Starting dynamic subtest: pipe-B-DP-1
[632.687823] Dynamic subtest pipe-B-DP-1: SUCCESS (2.583s)
[632.735327] Starting dynamic subtest: pipe-C-DP-1
[650.677619] Dynamic subtest pipe-C-DP-1: SUCCESS (2.442s)
[650.698696] Subtest suspend-read-crc: SUCCESS (7.506s)
[655.115303] Closing watchdogs
Done.