[37.334868] Initializing watchdogs
[37.335182]   /dev/watchdog0
[37.369941] [001/165] (960s left) i915_module_load (load)
[37.615635] Starting subtest: load
[40.192651] Subtest load: SUCCESS (2.598s)
[40.278287] [002/165] (957s left) core_auth (basic-auth)
[40.551355] Starting subtest: basic-auth
[40.570618] Subtest basic-auth: SUCCESS (0.003s)
[40.654164] [003/165] (957s left) debugfs_test (read_all_entries)
[40.885682] Starting subtest: read_all_entries
[41.295093] Subtest read_all_entries: SUCCESS (0.408s)
[41.488581] [004/165] (956s left) debugfs_test (basic-hwmon)
[41.739998] Starting subtest: basic-hwmon
[41.779677] Subtest basic-hwmon: SKIP (0.000s)
[41.907533] [005/165] (956s left) fbdev (eof)
[42.120829] Starting subtest: eof
[42.140158] Subtest eof: SUCCESS (0.002s)
[42.245699] [006/165] (956s left) fbdev (info)
[42.462356] Starting subtest: info
[42.484351] Subtest info: SUCCESS (0.000s)
[42.588546] [007/165] (955s left) fbdev (nullptr)
[42.815264] Starting subtest: nullptr
[42.835854] Subtest nullptr: SUCCESS (0.000s)
[42.942328] [008/165] (955s left) fbdev (read)
[43.147585] Starting subtest: read
[44.618414] Subtest read: SUCCESS (1.474s)
[44.725442] [009/165] (953s left) fbdev (write)
[44.929203] Starting subtest: write
[45.689963] Subtest write: SUCCESS (0.762s)
[45.795466] [010/165] (952s left) gem_basic (bad-close)
[46.042096] Starting subtest: bad-close
[46.081203] Subtest bad-close: SUCCESS (0.000s)
[46.166230] [011/165] (952s left) gem_basic (create-close)
[46.392318] Starting subtest: create-close
[46.433689] Subtest create-close: SUCCESS (0.000s)
[46.517778] [012/165] (952s left) gem_basic (create-fd-close)
[46.722409] Starting subtest: create-fd-close
[46.761825] Subtest create-fd-close: SUCCESS (0.000s)
[46.845638] [013/165] (951s left) gem_busy (busy@all-engines)
[47.077981] Starting subtest: busy
[47.097549] Starting dynamic subtest: all-engines
[47.161741] Dynamic subtest all-engines: SUCCESS (0.090s)
[47.184260] Subtest busy: SUCCESS (0.091s)
[47.574605] [014/165] (951s left) gem_close_race (basic-process)
[47.817161] Starting subtest: basic-process
[47.907355] Subtest basic-process: SUCCESS (0.094s)
[48.126555] [015/165] (950s left) gem_close_race (basic-threads)
[48.332532] Starting subtest: basic-threads
[49.622036] Subtest basic-threads: SUCCESS (1.293s)
[49.843149] [016/165] (949s left) gem_ctx_create (basic)
[50.073451] Starting subtest: basic
[50.095513] Subtest basic: SUCCESS (0.000s)
[50.291970] [017/165] (948s left) gem_ctx_create (basic-files)
[50.515841] Starting subtest: basic-files
[52.552284] Subtest basic-files: SUCCESS (2.036s)
[52.790321] [018/165] (946s left) gem_ctx_exec (basic)
[53.026087] Starting subtest: basic
[53.045144] Subtest basic: SUCCESS (0.008s)
[53.131689] [019/165] (946s left) gem_exec_basic (basic)
[53.360171] Starting subtest: basic
[53.381759] Starting dynamic subtest: rcs0-smem
[53.403465] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[53.435091] Starting dynamic subtest: bcs0-smem
[53.453864] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[53.488715] Starting dynamic subtest: vcs0-smem
[53.510216] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[53.541975] Starting dynamic subtest: vecs0-smem
[53.561179] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[53.583056] Subtest basic: SUCCESS (0.012s)
[53.666258] [020/165] (945s left) gem_exec_create (basic)
[53.900622] Starting subtest: basic
[53.919334] Starting dynamic subtest: smem
[55.971710] Dynamic subtest smem: SUCCESS (2.067s)
[55.991470] Subtest basic: SUCCESS (2.068s)
[56.179767] [021/165] (943s left) gem_exec_fence (basic-busy)
[56.536819] Starting subtest: basic-busy
[56.556309] Starting dynamic subtest: rcs0
[56.600189] Dynamic subtest rcs0: SUCCESS (0.031s)
[56.633475] Starting dynamic subtest: bcs0
[56.674935] Dynamic subtest bcs0: SUCCESS (0.035s)
[56.709444] Starting dynamic subtest: vcs0
[56.748128] Dynamic subtest vcs0: SUCCESS (0.022s)
[56.783258] Starting dynamic subtest: vecs0
[56.826667] Dynamic subtest vecs0: SUCCESS (0.024s)
[56.845307] Subtest basic-busy: SUCCESS (0.114s)
[57.473858] [022/165] (942s left) gem_exec_fence (basic-wait)
[57.821710] Starting subtest: basic-wait
[57.840835] Starting dynamic subtest: rcs0
[57.859568] Dynamic subtest rcs0: SUCCESS (0.035s)
[57.895396] Starting dynamic subtest: bcs0
[57.916797] Dynamic subtest bcs0: SUCCESS (0.031s)
[57.950392] Starting dynamic subtest: vcs0
[57.970186] Dynamic subtest vcs0: SUCCESS (0.032s)
[58.006099] Starting dynamic subtest: vecs0
[58.027816] Dynamic subtest vecs0: SUCCESS (0.028s)
[58.046947] Subtest basic-wait: SUCCESS (0.126s)
[58.644309] [023/165] (940s left) gem_exec_fence (basic-await)
[58.971478] Starting subtest: basic-await
[58.991096] Starting dynamic subtest: rcs0
[59.112776] Dynamic subtest rcs0: SUCCESS (0.138s)
[59.148325] Starting dynamic subtest: bcs0
[59.245550] Dynamic subtest bcs0: SUCCESS (0.133s)
[59.284967] Starting dynamic subtest: vcs0
[59.378100] Dynamic subtest vcs0: SUCCESS (0.133s)
[59.416277] Starting dynamic subtest: vecs0
[59.514281] Dynamic subtest vecs0: SUCCESS (0.134s)
[59.533668] Subtest basic-await: SUCCESS (0.542s)
[60.221941] [024/165] (939s left) gem_exec_fence (nb-await)
[60.572367] Starting subtest: nb-await
[60.593094] Starting dynamic subtest: rcs0
[60.648118] Dynamic subtest rcs0: SUCCESS (0.077s)
[60.687395] Starting dynamic subtest: bcs0
[60.729112] Dynamic subtest bcs0: SUCCESS (0.071s)
[60.763640] Starting dynamic subtest: vcs0
[60.809111] Dynamic subtest vcs0: SUCCESS (0.071s)
[60.844107] Starting dynamic subtest: vecs0
[60.863361] Dynamic subtest vecs0: SUCCESS (0.070s)
[60.883440] Subtest nb-await: SUCCESS (0.291s)
[61.584240] [025/165] (938s left) gem_exec_gttfill (basic)
[61.830291] Starting subtest: basic
[83.824234] Subtest basic: SUCCESS (21.829s)
[83.916410] [026/165] (915s left) gem_exec_parallel (engines)
[84.315306] Starting subtest: engines
[84.334490] Starting dynamic subtest: basic
[88.126254] Dynamic subtest basic: SUCCESS (3.642s)
[88.162577] Starting dynamic subtest: contexts
[93.260225] Dynamic subtest contexts: SUCCESS (5.154s)
[93.297662] Starting dynamic subtest: fds
[99.393186] Dynamic subtest fds: SUCCESS (6.138s)
[99.428410] Starting dynamic subtest: userptr
[103.058515] Dynamic subtest userptr: SUCCESS (3.637s)
[103.077788] Subtest engines: SUCCESS (18.573s)
[103.183683] [027/165] (896s left) gem_exec_store (basic)
[103.500235] Starting subtest: basic
[103.522328] Subtest basic: SUCCESS (0.079s)
[103.711426] [028/165] (896s left) gem_flink_basic (bad-flink)
[103.958477] Starting subtest: bad-flink
[103.977619] Subtest bad-flink: SUCCESS (0.000s)
[104.065413] [029/165] (896s left) gem_flink_basic (bad-open)
[104.284370] Starting subtest: bad-open
[104.306114] Subtest bad-open: SUCCESS (0.000s)
[104.391456] [030/165] (895s left) gem_flink_basic (basic)
[104.614906] Starting subtest: basic
[104.633907] Subtest basic: SUCCESS (0.000s)
[104.720666] [031/165] (895s left) gem_flink_basic (double-flink)
[104.992608] Starting subtest: double-flink
[105.019142] Subtest double-flink: SUCCESS (0.000s)
[105.125563] [032/165] (895s left) gem_flink_basic (flink-lifetime)
[105.372279] Starting subtest: flink-lifetime
[105.397172] Subtest flink-lifetime: SUCCESS (0.003s)
[105.504866] [033/165] (895s left) gem_huc_copy (huc-copy)
[105.769562] Starting subtest: huc-copy
[105.788739] Subtest huc-copy: SUCCESS (0.007s)
[105.877257] [034/165] (894s left) gem_linear_blits (basic)
[106.264894] Starting subtest: basic
[106.285996] Subtest basic: SUCCESS (0.019s)
[106.464705] [035/165] (894s left) gem_mmap (basic)
[106.856201] Starting subtest: basic
[106.957502] Subtest basic: SUCCESS (0.001s)
[107.043460] [036/165] (893s left) gem_mmap_gtt (basic)
[107.294422] Starting subtest: basic
[107.316616] Subtest basic: SUCCESS (0.002s)
[107.404661] [037/165] (893s left) gem_render_linear_blits (basic)
[107.630715] Starting subtest: basic
[107.731788] Subtest basic: SUCCESS (0.079s)
[107.823444] [038/165] (893s left) gem_render_tiled_blits (basic)
[108.054630] Starting subtest: basic
[108.175650] Subtest basic: SUCCESS (0.107s)
[108.263858] [039/165] (892s left) gem_ringfill (basic-all)
[108.761651] Starting subtest: basic-all
[109.944132] Subtest basic-all: SUCCESS (1.210s)
[110.091939] [040/165] (891s left) gem_softpin (allocator-basic)
[110.338207] Starting subtest: allocator-basic
[110.537582] Subtest allocator-basic: SUCCESS (0.241s)
[110.677414] [041/165] (890s left) gem_softpin (allocator-basic-reserve)
[110.899155] Starting subtest: allocator-basic-reserve
[111.122181] Subtest allocator-basic-reserve: SUCCESS (0.240s)
[111.263479] [042/165] (890s left) gem_softpin (safe-alignment)
[111.495641] Starting subtest: safe-alignment
[111.516987] Subtest safe-alignment: SUCCESS (0.030s)
[111.642314] [043/165] (889s left) gem_sync (basic-all)
[112.048617] Starting subtest: basic-all
[113.954077] Subtest basic-all: SUCCESS (2.080s)
[114.179408] [044/165] (887s left) gem_sync (basic-each)
[114.615370] Starting subtest: basic-each
[116.759883] Subtest basic-each: SUCCESS (2.359s)
[116.977661] [045/165] (884s left) gem_tiled_blits (basic)
[117.348901] Starting subtest: basic
[117.406125] Subtest basic: SUCCESS (0.060s)
[117.597981] [046/165] (884s left) gem_tiled_fence_blits (basic)
[118.146815] Starting subtest: basic
[118.189824] Subtest basic: SUCCESS (0.041s)
[118.381941] [047/165] (883s left) gem_tiled_pread_basic
[119.113636] [048/165] (882s left) gem_wait (busy@all-engines)
[119.362766] Starting subtest: busy
[119.384756] Starting dynamic subtest: all-engines
[119.891919] Dynamic subtest all-engines: SUCCESS (0.534s)
[119.915253] Subtest busy: SUCCESS (0.534s)
[120.191885] [049/165] (881s left) gem_wait (wait@all-engines)
[120.453121] Starting subtest: wait
[120.478086] Starting dynamic subtest: all-engines
[121.498644] Dynamic subtest all-engines: SUCCESS (1.042s)
[121.522847] Subtest wait: SUCCESS (1.042s)
[121.761553] [050/165] (880s left) i915_getparams_basic (basic-eu-total)
[122.004951] Starting subtest: basic-eu-total
[122.053912] Subtest basic-eu-total: SUCCESS (0.000s)
[122.154177] [051/165] (879s left) i915_getparams_basic (basic-subslice-total)
[122.410194] Starting subtest: basic-subslice-total
[122.452966] Subtest basic-subslice-total: SUCCESS (0.000s)
[122.541495] [052/165] (879s left) i915_hangman (error-state-basic)
[122.792188] Starting subtest: error-state-basic
[123.052430] Subtest error-state-basic: SUCCESS (0.290s)
[123.174837] [053/165] (879s left) i915_pciid
[123.508416] [054/165] (878s left) kms_addfb_basic (addfb25-4-tiled)
[123.879454] Starting subtest: addfb25-4-tiled
[123.898967] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[123.993833] [055/165] (878s left) kms_addfb_basic (addfb25-bad-modifier)
[124.219430] Starting subtest: addfb25-bad-modifier
[124.239094] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[124.411610] [056/165] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[124.656874] Starting subtest: addfb25-framebuffer-vs-set-tiling
[124.676524] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[124.843442] [057/165] (877s left) kms_addfb_basic (addfb25-modifier-no-flag)
[125.076021] Starting subtest: addfb25-modifier-no-flag
[125.095328] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[125.257921] [058/165] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[125.481922] Starting subtest: addfb25-x-tiled-legacy
[125.501469] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[125.676850] [059/165] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[125.905872] Starting subtest: addfb25-x-tiled-mismatch-legacy
[125.924716] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[126.112281] [060/165] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[126.419349] Starting subtest: addfb25-yf-tiled-legacy
[126.439788] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[126.531171] [061/165] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[126.842706] Starting subtest: addfb25-y-tiled-legacy
[126.862529] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[126.961717] [062/165] (876s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[127.267610] Starting subtest: addfb25-y-tiled-small-legacy
[127.287700] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[127.377909] [063/165] (875s left) kms_addfb_basic (bad-pitch-0)
[127.605763] Starting subtest: bad-pitch-0
[127.625881] Subtest bad-pitch-0: SUCCESS (0.000s)
[127.793220] [064/165] (875s left) kms_addfb_basic (bad-pitch-1024)
[128.015624] Starting subtest: bad-pitch-1024
[128.034204] Subtest bad-pitch-1024: SUCCESS (0.000s)
[128.213597] [065/165] (875s left) kms_addfb_basic (bad-pitch-128)
[128.433526] Starting subtest: bad-pitch-128
[128.454604] Subtest bad-pitch-128: SUCCESS (0.000s)
[128.625977] [066/165] (874s left) kms_addfb_basic (bad-pitch-256)
[128.868709] Starting subtest: bad-pitch-256
[128.887355] Subtest bad-pitch-256: SUCCESS (0.000s)
[129.040657] [067/165] (874s left) kms_addfb_basic (bad-pitch-32)
[129.291214] Starting subtest: bad-pitch-32
[129.315567] Subtest bad-pitch-32: SUCCESS (0.000s)
[129.463719] [068/165] (874s left) kms_addfb_basic (bad-pitch-63)
[129.716162] Starting subtest: bad-pitch-63
[129.741749] Subtest bad-pitch-63: SUCCESS (0.000s)
[129.906214] [069/165] (873s left) kms_addfb_basic (bad-pitch-65536)
[130.151918] Starting subtest: bad-pitch-65536
[130.177318] Subtest bad-pitch-65536: SUCCESS (0.001s)
[130.346601] [070/165] (873s left) kms_addfb_basic (bad-pitch-999)
[130.568154] Starting subtest: bad-pitch-999
[130.589792] Subtest bad-pitch-999: SUCCESS (0.000s)
[130.760270] [071/165] (872s left) kms_addfb_basic (basic)
[130.991918] Starting subtest: basic
[131.012933] Subtest basic: SUCCESS (0.000s)
[131.195216] [072/165] (872s left) kms_addfb_basic (basic-x-tiled-legacy)
[131.418048] Starting subtest: basic-x-tiled-legacy
[131.436696] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[131.611945] [073/165] (872s left) kms_addfb_basic (basic-y-tiled-legacy)
[131.837302] Starting subtest: basic-y-tiled-legacy
[131.858469] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[132.028569] [074/165] (871s left) kms_addfb_basic (bo-too-small)
[132.336376] Starting subtest: bo-too-small
[132.356605] Subtest bo-too-small: SUCCESS (0.001s)
[132.446472] [075/165] (871s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[132.752235] Starting subtest: bo-too-small-due-to-tiling
[132.772590] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[132.862296] [076/165] (871s left) kms_addfb_basic (clobberred-modifier)
[133.085930] Starting subtest: clobberred-modifier
[133.105835] Subtest clobberred-modifier: SUCCESS (0.000s)
[133.297878] [077/165] (870s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[133.529917] Starting subtest: framebuffer-vs-set-tiling
[133.549883] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[133.729333] [078/165] (870s left) kms_addfb_basic (invalid-get-prop)
[133.972131] Starting subtest: invalid-get-prop
[133.991897] Subtest invalid-get-prop: SUCCESS (0.000s)
[134.142707] [079/165] (870s left) kms_addfb_basic (invalid-get-prop-any)
[134.385748] Starting subtest: invalid-get-prop-any
[134.404633] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[134.558954] [080/165] (869s left) kms_addfb_basic (invalid-set-prop)
[134.800993] Starting subtest: invalid-set-prop
[134.820870] Subtest invalid-set-prop: SUCCESS (0.000s)
[134.978216] [081/165] (869s left) kms_addfb_basic (invalid-set-prop-any)
[135.221705] Starting subtest: invalid-set-prop-any
[135.243398] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[135.394968] [082/165] (869s left) kms_addfb_basic (no-handle)
[135.621320] Starting subtest: no-handle
[135.642144] Subtest no-handle: SUCCESS (0.000s)
[135.825599] [083/165] (868s left) kms_addfb_basic (size-max)
[136.134938] Starting subtest: size-max
[136.155224] Subtest size-max: SUCCESS (0.000s)
[136.246090] [084/165] (868s left) kms_addfb_basic (small-bo)
[136.553764] Starting subtest: small-bo
[136.574175] Subtest small-bo: SUCCESS (0.000s)
[136.664097] [085/165] (868s left) kms_addfb_basic (tile-pitch-mismatch)
[136.887536] Starting subtest: tile-pitch-mismatch
[136.907085] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[137.075907] [086/165] (867s left) kms_addfb_basic (too-high)
[137.404435] Starting subtest: too-high
[137.428726] Subtest too-high: SUCCESS (0.002s)
[137.535590] [087/165] (867s left) kms_addfb_basic (too-wide)
[137.864897] Starting subtest: too-wide
[137.892247] Subtest too-wide: SUCCESS (0.000s)
[137.996571] [088/165] (867s left) kms_addfb_basic (unused-handle)
[138.271359] Starting subtest: unused-handle
[138.296467] Subtest unused-handle: SUCCESS (0.000s)
[138.431980] [089/165] (866s left) kms_addfb_basic (unused-modifier)
[138.675112] Starting subtest: unused-modifier
[138.698359] Subtest unused-modifier: SUCCESS (0.000s)
[138.846959] [090/165] (866s left) kms_addfb_basic (unused-offsets)
[139.093506] Starting subtest: unused-offsets
[139.114216] Subtest unused-offsets: SUCCESS (0.000s)
[139.261094] [091/165] (866s left) kms_addfb_basic (unused-pitches)
[139.484460] Starting subtest: unused-pitches
[139.505103] Subtest unused-pitches: SUCCESS (0.000s)
[139.674592] [092/165] (865s left) kms_busy (basic)
[139.993923] Starting subtest: basic
[140.013587] Starting dynamic subtest: flip
[141.007973] Dynamic subtest flip: SUCCESS (1.005s)
[141.045933] Starting dynamic subtest: modeset
[142.422720] Dynamic subtest modeset: SUCCESS (1.413s)
[142.443143] Subtest basic: SUCCESS (2.422s)
[142.796476] [093/165] (862s left) kms_prop_blob (basic)
[143.032544] Starting subtest: basic
[143.051453] Subtest basic: SUCCESS (0.000s)
[143.141252] [094/165] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[143.459418] Starting subtest: basic-busy-flip-before-cursor-atomic
[143.499374] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[143.592206] [095/165] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[143.900473] Starting subtest: basic-busy-flip-before-cursor-legacy
[143.942876] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[144.032760] [096/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[144.337139] Starting subtest: basic-flip-after-cursor-atomic
[145.388826] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.056s)
[145.745411] [097/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[146.057832] Starting subtest: basic-flip-after-cursor-legacy
[147.116260] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.053s)
[147.478821] [098/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[147.789572] Starting subtest: basic-flip-after-cursor-varying-size
[148.860624] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.073s)
[149.219089] [099/165] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[149.525490] Starting subtest: basic-flip-before-cursor-atomic
[150.577629] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.049s)
[150.930377] [100/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[151.237094] Starting subtest: basic-flip-before-cursor-legacy
[152.290073] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.050s)
[152.629704] [101/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[152.945954] Starting subtest: basic-flip-before-cursor-varying-size
[153.989828] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.049s)
[154.340440] [102/165] (852s left) kms_dsc (dsc-basic)
[154.672872] Subtest dsc-basic: SKIP (0.000s)
[154.765087] [103/165] (851s left) kms_flip (basic-flip-vs-dpms)
[155.102278] Starting subtest: basic-flip-vs-dpms
[155.122054] Starting dynamic subtest: A-DP1
[156.337506] Dynamic subtest A-DP1: SUCCESS (1.245s)
[156.378871] Starting dynamic subtest: B-DP1
[157.474795] Dynamic subtest B-DP1: SUCCESS (1.133s)
[157.515550] Starting dynamic subtest: C-DP1
[158.581606] Dynamic subtest C-DP1: SUCCESS (1.121s)
[158.608889] Subtest basic-flip-vs-dpms: SUCCESS (3.508s)
[159.009889] [104/165] (847s left) kms_flip (basic-flip-vs-modeset)
[159.360216] Starting subtest: basic-flip-vs-modeset
[159.385411] Starting dynamic subtest: A-DP1
[160.625228] Dynamic subtest A-DP1: SUCCESS (1.292s)
[160.663525] Starting dynamic subtest: B-DP1
[161.763921] Dynamic subtest B-DP1: SUCCESS (1.144s)
[161.805097] Starting dynamic subtest: C-DP1
[162.910992] Dynamic subtest C-DP1: SUCCESS (1.141s)
[162.931885] Subtest basic-flip-vs-modeset: SUCCESS (3.587s)
[163.301075] [105/165] (843s left) kms_flip (basic-flip-vs-wf_vblank)
[163.638314] Starting subtest: basic-flip-vs-wf_vblank
[163.659210] Starting dynamic subtest: A-DP1
[165.075322] Dynamic subtest A-DP1: SUCCESS (1.452s)
[165.119127] Starting dynamic subtest: B-DP1
[166.463381] Dynamic subtest B-DP1: SUCCESS (1.397s)
[166.503924] Starting dynamic subtest: C-DP1
[167.859427] Dynamic subtest C-DP1: SUCCESS (1.395s)
[167.878467] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.255s)
[168.301131] [106/165] (838s left) kms_flip (basic-plain-flip)
[168.616453] Starting subtest: basic-plain-flip
[168.637161] Starting dynamic subtest: A-DP1
[169.782088] Dynamic subtest A-DP1: SUCCESS (1.176s)
[169.821081] Starting dynamic subtest: B-DP1
[170.897431] Dynamic subtest B-DP1: SUCCESS (1.110s)
[170.935916] Starting dynamic subtest: C-DP1
[172.007308] Dynamic subtest C-DP1: SUCCESS (1.112s)
[172.028099] Subtest basic-plain-flip: SUCCESS (3.408s)
[172.469290] [107/165] (834s left) kms_force_connector_basic (force-connector-state)
[172.742704] Subtest force-connector-state: SKIP (0.000s)
[172.834340] [108/165] (834s left) kms_force_connector_basic (force-edid)
[173.082786] Subtest force-edid: SKIP (0.000s)
[173.177126] [109/165] (833s left) kms_force_connector_basic (force-load-detect)
[173.448190] Subtest force-load-detect: SKIP (0.000s)
[173.541769] [110/165] (833s left) kms_force_connector_basic (prune-stale-modes)
[173.792374] Subtest prune-stale-modes: SKIP (0.000s)
[173.883374] [111/165] (833s left) kms_frontbuffer_tracking (basic)
[174.271823] Starting subtest: basic
[177.261400] Subtest basic: SUCCESS (3.047s)
[177.397770] [112/165] (829s left) kms_hdmi_inject (inject-audio)
[177.721967] Subtest inject-audio: SKIP (0.000s)
[177.838955] [113/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[178.161248] Starting subtest: compare-crc-sanitycheck-xr24
[178.190118] Starting dynamic subtest: pipe-A-DP-1
[178.608333] Dynamic subtest pipe-A-DP-1: SUCCESS (0.425s)
[178.663755] Starting dynamic subtest: pipe-B-DP-1
[179.202536] Dynamic subtest pipe-B-DP-1: SUCCESS (0.606s)
[179.244291] Starting dynamic subtest: pipe-C-DP-1
[179.828919] Dynamic subtest pipe-C-DP-1: SUCCESS (0.617s)
[179.850019] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.661s)
[180.178856] [114/165] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[180.475126] Starting subtest: compare-crc-sanitycheck-nv12
[180.494763] Starting dynamic subtest: pipe-A-DP-1
[180.538624] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[180.578038] Starting dynamic subtest: pipe-B-DP-1
[180.621353] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[180.660715] Starting dynamic subtest: pipe-C-DP-1
[180.701162] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[180.746827] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[180.843323] [115/165] (826s left) kms_pipe_crc_basic (hang-read-crc)
[181.137514] Starting subtest: hang-read-crc
[181.157232] Starting dynamic subtest: pipe-A-DP-1
[182.654575] Dynamic subtest pipe-A-DP-1: SUCCESS (1.495s)
[182.706935] Starting dynamic subtest: pipe-B-DP-1
[184.284909] Dynamic subtest pipe-B-DP-1: SUCCESS (1.627s)
[184.325869] Starting dynamic subtest: pipe-C-DP-1
[185.932385] Dynamic subtest pipe-C-DP-1: SUCCESS (1.643s)
[185.959446] Subtest hang-read-crc: SUCCESS (4.778s)
[186.459996] [116/165] (821s left) kms_pipe_crc_basic (nonblocking-crc)
[186.778745] Starting subtest: nonblocking-crc
[186.799863] Starting dynamic subtest: pipe-A-DP-1
[187.337758] Dynamic subtest pipe-A-DP-1: SUCCESS (0.575s)
[187.395212] Starting dynamic subtest: pipe-B-DP-1
[188.112655] Dynamic subtest pipe-B-DP-1: SUCCESS (0.750s)
[188.154350] Starting dynamic subtest: pipe-C-DP-1
[188.871293] Dynamic subtest pipe-C-DP-1: SUCCESS (0.758s)
[188.891333] Subtest nonblocking-crc: SUCCESS (2.098s)
[189.213359] [117/165] (818s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[189.534078] Starting subtest: nonblocking-crc-frame-sequence
[189.554938] Starting dynamic subtest: pipe-A-DP-1
[190.108644] Dynamic subtest pipe-A-DP-1: SUCCESS (0.573s)
[190.147484] Starting dynamic subtest: pipe-B-DP-1
[190.856962] Dynamic subtest pipe-B-DP-1: SUCCESS (0.744s)
[190.909965] Starting dynamic subtest: pipe-C-DP-1
[191.638223] Dynamic subtest pipe-C-DP-1: SUCCESS (0.771s)
[191.658234] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.102s)
[191.978356] [118/165] (815s left) kms_pipe_crc_basic (read-crc)
[192.299162] Starting subtest: read-crc
[192.321035] Starting dynamic subtest: pipe-A-DP-1
[192.817088] Dynamic subtest pipe-A-DP-1: SUCCESS (0.516s)
[192.868832] Starting dynamic subtest: pipe-B-DP-1
[193.518575] Dynamic subtest pipe-B-DP-1: SUCCESS (0.695s)
[193.558612] Starting dynamic subtest: pipe-C-DP-1
[194.209594] Dynamic subtest pipe-C-DP-1: SUCCESS (0.685s)
[194.230660] Subtest read-crc: SUCCESS (1.911s)
[194.553915] [119/165] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[194.855681] Starting subtest: read-crc-frame-sequence
[194.882961] Starting dynamic subtest: pipe-A-DP-1
[195.397137] Dynamic subtest pipe-A-DP-1: SUCCESS (0.508s)
[195.442986] Starting dynamic subtest: pipe-B-DP-1
[196.067101] Dynamic subtest pipe-B-DP-1: SUCCESS (0.680s)
[196.106872] Starting dynamic subtest: pipe-C-DP-1
[196.759321] Dynamic subtest pipe-C-DP-1: SUCCESS (0.684s)
[196.782367] Subtest read-crc-frame-sequence: SUCCESS (1.886s)
[197.104574] [120/165] (810s left) kms_pm_backlight (basic-brightness)
[197.430704] Subtest basic-brightness: SKIP (0.000s)
[197.529192] [121/165] (810s left) kms_pm_rpm (basic-pci-d3-state)
[199.416063] Starting subtest: basic-pci-d3-state
[200.073912] Subtest basic-pci-d3-state: SUCCESS (0.645s)
[200.283285] [122/165] (807s left) kms_pm_rpm (basic-rte)
[200.514133] Starting subtest: basic-rte
[202.675963] Subtest basic-rte: SUCCESS (2.187s)
[203.630752] [123/165] (804s left) kms_psr (psr-primary-page-flip)
[203.963179] Subtest psr-primary-page-flip: SKIP (0.000s)
[204.059549] [124/165] (804s left) kms_psr (psr-cursor-plane-move)
[204.376419] Subtest psr-cursor-plane-move: SKIP (0.000s)
[204.472876] [125/165] (804s left) kms_psr (psr-sprite-plane-onoff)
[204.792578] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[204.889714] [126/165] (803s left) kms_psr (psr-primary-mmap-gtt)
[205.230086] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[205.346498] [127/165] (803s left) kms_setmode (basic-clone-single-crtc)
[205.643710] Starting subtest: basic-clone-single-crtc
[205.707757] Subtest basic-clone-single-crtc: SKIP (0.000s)
[205.807827] [128/165] (803s left) i915_pm_rps (basic-api)
[206.045705] Starting subtest: basic-api
[206.067923] Subtest basic-api: SUCCESS (0.007s)
[206.184618] [129/165] (802s left) prime_self_import (basic-llseek-bad)
[206.421660] Starting subtest: basic-llseek-bad
[206.466299] Subtest basic-llseek-bad: SUCCESS (0.004s)
[206.562968] [130/165] (802s left) prime_self_import (basic-llseek-size)
[206.792396] Starting subtest: basic-llseek-size
[206.834934] Subtest basic-llseek-size: SUCCESS (0.006s)
[206.933446] [131/165] (802s left) prime_self_import (basic-with_fd_dup)
[207.160138] Starting subtest: basic-with_fd_dup
[207.202873] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[207.298649] [132/165] (801s left) prime_self_import (basic-with_one_bo)
[207.530897] Starting subtest: basic-with_one_bo
[207.572607] Subtest basic-with_one_bo: SUCCESS (0.007s)
[207.670339] [133/165] (801s left) prime_self_import (basic-with_one_bo_two_files)
[207.902569] Starting subtest: basic-with_one_bo_two_files
[207.946253] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[208.043469] [134/165] (801s left) prime_self_import (basic-with_two_bos)
[208.268801] Starting subtest: basic-with_two_bos
[208.312056] Subtest basic-with_two_bos: SUCCESS (0.006s)
[208.406824] [135/165] (801s left) prime_vgem (basic-fence-flip)
[208.687246] Starting subtest: basic-fence-flip
[209.200471] Subtest basic-fence-flip: SUCCESS (0.586s)
[209.349618] [136/165] (800s left) prime_vgem (basic-fence-mmap)
[209.628379] Starting subtest: basic-fence-mmap
[209.647983] Subtest basic-fence-mmap: SUCCESS (0.071s)
[209.765153] [137/165] (800s left) prime_vgem (basic-fence-read)
[210.037228] Starting subtest: basic-fence-read
[210.102373] Subtest basic-fence-read: SUCCESS (0.111s)
[210.231150] [138/165] (799s left) prime_vgem (basic-gtt)
[210.504229] Starting subtest: basic-gtt
[210.524293] Subtest basic-gtt: SUCCESS (0.034s)
[210.641326] [139/165] (799s left) prime_vgem (basic-read)
[210.900222] Starting subtest: basic-read
[210.919696] Subtest basic-read: SUCCESS (0.056s)
[211.046961] [140/165] (798s left) prime_vgem (basic-write)
[211.320999] Starting subtest: basic-write
[211.343229] Subtest basic-write: SUCCESS (0.064s)
[211.458972] [141/165] (798s left) vgem_basic (setversion)
[211.699929] Starting subtest: setversion
[211.743531] Subtest setversion: SUCCESS (0.000s)
[211.839612] [142/165] (798s left) vgem_basic (create)
[212.070621] Starting subtest: create
[212.092463] Subtest create: SUCCESS (0.000s)
[212.189253] [143/165] (798s left) vgem_basic (debugfs)
[212.442949] Starting subtest: debugfs
[212.463507] Subtest debugfs: SUCCESS (0.001s)
[212.561192] [144/165] (797s left) vgem_basic (dmabuf-export)
[212.792635] Starting subtest: dmabuf-export
[212.836330] Subtest dmabuf-export: SUCCESS (0.005s)
[212.933743] [145/165] (797s left) vgem_basic (dmabuf-fence)
[213.164438] Starting subtest: dmabuf-fence
[213.185448] Subtest dmabuf-fence: SUCCESS (0.002s)
[213.278554] [146/165] (797s left) vgem_basic (dmabuf-fence-before)
[213.532969] Starting subtest: dmabuf-fence-before
[213.555270] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[213.660754] [147/165] (797s left) vgem_basic (dmabuf-mmap)
[213.947907] Starting subtest: dmabuf-mmap
[213.978053] Subtest dmabuf-mmap: SUCCESS (0.042s)
[214.092321] [148/165] (796s left) vgem_basic (mmap)
[214.392566] Starting subtest: mmap
[214.422074] Subtest mmap: SUCCESS (0.026s)
[214.541889] [149/165] (796s left) vgem_basic (second-client)
[214.837069] Starting subtest: second-client
[214.894772] Subtest second-client: SUCCESS (0.032s)
[215.009303] [150/165] (796s left) vgem_basic (sysfs)
[215.259211] Starting subtest: sysfs
[215.281226] Subtest sysfs: SUCCESS (0.002s)
[215.377800] [151/165] (795s left) core_hotunplug (unbind-rebind)
[215.703944] Starting subtest: unbind-rebind
[219.596400] Subtest unbind-rebind: SUCCESS (3.892s)
[219.692251] [152/165] (791s left) vgem_basic (unload)
[219.921655] Starting subtest: unload
[249.120189] Subtest unload: SUCCESS (29.051s)
[249.215269] [153/165] (762s left) i915_module_load (reload)
[249.450092] Starting subtest: reload
[253.162212] Subtest reload: SUCCESS (3.729s)
[253.281333] [154/165] (758s left) gem_lmem_swapping (basic)
[253.589497] Subtest basic: SKIP (0.000s)
[253.681951] [155/165] (758s left) gem_lmem_swapping (parallel-random-engines)
[253.950358] Subtest parallel-random-engines: SKIP (0.000s)
[254.041545] [156/165] (757s left) gem_lmem_swapping (random-engines)
[254.312079] Subtest random-engines: SKIP (0.000s)
[254.405358] [157/165] (757s left) gem_lmem_swapping (verify-random)
[254.709359] Subtest verify-random: SKIP (0.000s)
[254.824749] [158/165] (757s left) i915_pm_rpm (module-reload)
[257.025401] Starting subtest: module-reload
[266.420840] Subtest module-reload: SUCCESS (9.400s)
[266.511534] [159/165] (745s left) i915_selftest (live)
[266.748854] Starting subtest: live
[266.768178] Starting dynamic subtest: sanitycheck
[268.417147] Dynamic subtest sanitycheck: SUCCESS (1.669s)
[268.464061] Starting dynamic subtest: uncore
[270.044829] Dynamic subtest uncore: SUCCESS (1.626s)
[270.088966] Starting dynamic subtest: workarounds
[272.000662] Dynamic subtest workarounds: SUCCESS (1.942s)
[272.057126] Starting dynamic subtest: gt_engines
[274.164676] Dynamic subtest gt_engines: SUCCESS (2.166s)
[274.200632] Starting dynamic subtest: gt_timelines
[297.099922] Dynamic subtest gt_timelines: SUCCESS (22.931s)
[297.135883] Starting dynamic subtest: gt_contexts
[298.924493] Dynamic subtest gt_contexts: SUCCESS (1.824s)
[298.960769] Starting dynamic subtest: gt_lrc
[303.253583] Dynamic subtest gt_lrc: SUCCESS (4.323s)
[303.300396] Starting dynamic subtest: gt_mocs
[305.129502] Dynamic subtest gt_mocs: SUCCESS (1.875s)
[305.166066] Starting dynamic subtest: gt_pm
[314.040153] Dynamic subtest gt_pm: SUCCESS (8.897s)
[314.083457] Starting dynamic subtest: gt_heartbeat
[315.775462] Dynamic subtest gt_heartbeat: SUCCESS (1.737s)
[315.811597] Starting dynamic subtest: gt_tlb
[318.260255] Dynamic subtest gt_tlb: SUCCESS (2.482s)
[318.296356] Starting dynamic subtest: requests
[326.333571] Dynamic subtest requests: SUCCESS (8.071s)
[326.368072] Starting dynamic subtest: migrate
[331.116137] Dynamic subtest migrate: SUCCESS (4.777s)
[331.162179] Starting dynamic subtest: active
[332.615113] Dynamic subtest active: SUCCESS (1.496s)
[332.660245] Starting dynamic subtest: objects
[337.013214] Dynamic subtest objects: SUCCESS (4.398s)
[337.058542] Starting dynamic subtest: mman
[346.179740] Dynamic subtest mman: SUCCESS (9.163s)
[346.216185] Starting dynamic subtest: dmabuf
[347.831048] Dynamic subtest dmabuf: SUCCESS (1.646s)
[347.866603] Starting dynamic subtest: vma
[349.494500] Dynamic subtest vma: SUCCESS (1.661s)
[349.541634] Starting dynamic subtest: coherency
[353.896875] Dynamic subtest coherency: SUCCESS (4.399s)
[353.933263] Starting dynamic subtest: gtt
[363.330460] Dynamic subtest gtt: SUCCESS (9.433s)
[363.378327] Starting dynamic subtest: gem
[366.140152] Dynamic subtest gem: SUCCESS (2.804s)
[366.184625] Starting dynamic subtest: evict
[372.473774] Dynamic subtest evict: SUCCESS (6.332s)
[372.516665] Starting dynamic subtest: hugepages
[380.565056] Dynamic subtest hugepages: SUCCESS (8.080s)
[380.604221] Starting dynamic subtest: gem_contexts
[405.639631] Dynamic subtest gem_contexts: SUCCESS (24.908s)
[405.673123] Starting dynamic subtest: client
[407.092248] Dynamic subtest client: SUCCESS (1.610s)
[407.137048] Starting dynamic subtest: gem_migrate
[408.609783] Dynamic subtest gem_migrate: SUCCESS (1.526s)
[408.658556] Starting dynamic subtest: reset
[421.244798] Dynamic subtest reset: SUCCESS (12.631s)
[421.279599] Starting dynamic subtest: memory_region
[422.944521] Dynamic subtest memory_region: SUCCESS (1.698s)
[422.978999] Starting dynamic subtest: hangcheck
[447.908838] Dynamic subtest hangcheck: SUCCESS (24.961s)
[447.943727] Starting dynamic subtest: execlists
[460.355237] Dynamic subtest execlists: SUCCESS (12.441s)
[460.390252] Starting dynamic subtest: ring_submission
[462.008834] Dynamic subtest ring_submission: SUCCESS (1.649s)
[462.045543] Starting dynamic subtest: perf
[463.785710] Dynamic subtest perf: SUCCESS (1.770s)
[463.841627] Starting dynamic subtest: slpc
[465.457874] Dynamic subtest slpc: SUCCESS (1.673s)
[465.503291] Starting dynamic subtest: guc
[466.960219] Dynamic subtest guc: SUCCESS (1.497s)
[466.994623] Starting dynamic subtest: guc_multi_lrc
[468.482481] Dynamic subtest guc_multi_lrc: SUCCESS (1.521s)
[468.517505] Starting dynamic subtest: guc_hang
[470.131271] Dynamic subtest guc_hang: SUCCESS (1.646s)
[470.166230] Starting dynamic subtest: late_gt_pm
[471.865275] Dynamic subtest late_gt_pm: SUCCESS (1.730s)
[471.884822] Subtest live: SUCCESS (205.121s)
[471.983103] [160/165] (540s left) dmabuf (all-tests)
[472.226759] Starting subtest: all-tests
[472.247339] Starting dynamic subtest: sanitycheck
[472.306098] Dynamic subtest sanitycheck: SUCCESS (0.083s)
[472.345964] Starting dynamic subtest: dma_fence
[472.499493] Dynamic subtest dma_fence: SUCCESS (0.188s)
[472.535094] Starting dynamic subtest: dma_fence_chain
[495.634788] Dynamic subtest dma_fence_chain: SUCCESS (23.137s)
[495.675757] Starting dynamic subtest: dma_fence_unwrap
[495.718669] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s)
[495.754816] Starting dynamic subtest: dma_resv
[495.799745] Dynamic subtest dma_resv: SUCCESS (0.070s)
[495.819984] Subtest all-tests: SUCCESS (23.569s)
[495.910756] [161/165] (516s left) i915_suspend (basic-s2idle-without-i915)
[496.124964] Starting subtest: basic-s2idle-without-i915
[516.530148] Subtest basic-s2idle-without-i915: SUCCESS (5.415s)
[519.939487] [162/165] (510s left) i915_suspend (basic-s3-without-i915)
[520.202411] Starting subtest: basic-s3-without-i915
[538.150867] Subtest basic-s3-without-i915: SUCCESS (3.364s)
[541.842931] [163/165] (506s left) gem_exec_suspend (basic-s0)
[542.107438] Starting subtest: basic-S0
[542.129773] Starting dynamic subtest: smem
[562.840123] Dynamic subtest smem: SUCCESS (5.441s)
[562.860189] Subtest basic-S0: SUCCESS (5.443s)
[568.228494] [164/165] (500s left) gem_exec_suspend (basic-s3)
[568.480075] Starting subtest: basic-S3
[568.500506] Starting dynamic subtest: smem
[589.285606] Dynamic subtest smem: SUCCESS (5.667s)
[589.306869] Subtest basic-S3: SUCCESS (5.670s)
[591.673212] [165/165] (494s left) kms_pipe_crc_basic (suspend-read-crc)
[591.992152] Starting subtest: suspend-read-crc
[592.013888] Starting dynamic subtest: pipe-A-DP-1
[610.106202] Dynamic subtest pipe-A-DP-1: SUCCESS (2.435s)
[610.162340] Starting dynamic subtest: pipe-B-DP-1
[628.104142] Dynamic subtest pipe-B-DP-1: SUCCESS (2.372s)
[628.153524] Starting dynamic subtest: pipe-C-DP-1
[646.102999] Dynamic subtest pipe-C-DP-1: SUCCESS (2.558s)
[646.122335] Subtest suspend-read-crc: SUCCESS (7.380s)
[651.513066] Closing watchdogs
Done.