[51.852658] Initializing watchdogs
[51.852815]   /dev/watchdog0
[51.863953] [001/165] (960s left) i915_module_load (load)
[51.981620] Starting subtest: load
[53.673942] Subtest load: SUCCESS (1.690s)
[53.705797] [002/165] (958s left) core_auth (basic-auth)
[53.936314] Starting subtest: basic-auth
[53.937726] Subtest basic-auth: SUCCESS (0.003s)
[54.021321] [003/165] (958s left) debugfs_test (read_all_entries)
[54.198644] Starting subtest: read_all_entries
[54.341884] Subtest read_all_entries: SUCCESS (0.143s)
[54.480691] [004/165] (957s left) debugfs_test (basic-hwmon)
[54.593041] Starting subtest: basic-hwmon
[54.595898] Subtest basic-hwmon: SKIP (0.000s)
[54.728133] [005/165] (957s left) fbdev (eof)
[54.842579] Starting subtest: eof
[54.843762] Subtest eof: SUCCESS (0.001s)
[54.897741] [006/165] (957s left) fbdev (info)
[54.998131] Starting subtest: info
[54.999212] Subtest info: SUCCESS (0.000s)
[55.064294] [007/165] (957s left) fbdev (nullptr)
[55.174145] Starting subtest: nullptr
[55.175876] Subtest nullptr: SUCCESS (0.000s)
[55.231699] [008/165] (957s left) fbdev (read)
[55.339145] Starting subtest: read
[56.931959] Subtest read: SUCCESS (1.592s)
[57.002039] [009/165] (955s left) fbdev (write)
[57.105696] Starting subtest: write
[57.910598] Subtest write: SUCCESS (0.805s)
[57.964762] [010/165] (954s left) gem_basic (bad-close)
[58.071656] Starting subtest: bad-close
[58.074016] Subtest bad-close: SUCCESS (0.000s)
[58.148709] [011/165] (954s left) gem_basic (create-close)
[58.251844] Starting subtest: create-close
[58.254703] Subtest create-close: SUCCESS (0.000s)
[58.330719] [012/165] (954s left) gem_basic (create-fd-close)
[58.437504] Starting subtest: create-fd-close
[58.441030] Subtest create-fd-close: SUCCESS (0.000s)
[58.514979] [013/165] (954s left) gem_busy (busy@all-engines)
[58.640495] Starting subtest: busy
[58.643226] Starting dynamic subtest: all-engines
[58.718989] Dynamic subtest all-engines: SUCCESS (0.077s)
[58.720179] Subtest busy: SUCCESS (0.077s)
[59.065792] [014/165] (953s left) gem_close_race (basic-process)
[59.197087] Starting subtest: basic-process
[59.274404] Subtest basic-process: SUCCESS (0.077s)
[59.464524] [015/165] (953s left) gem_close_race (basic-threads)
[59.593195] Starting subtest: basic-threads
[60.745104] Subtest basic-threads: SUCCESS (1.151s)
[60.932826] [016/165] (951s left) gem_ctx_create (basic)
[61.056186] Starting subtest: basic
[61.057250] Subtest basic: SUCCESS (0.000s)
[61.249294] [017/165] (951s left) gem_ctx_create (basic-files)
[61.371849] Starting subtest: basic-files
[63.399468] Subtest basic-files: SUCCESS (2.028s)
[63.599528] [018/165] (949s left) gem_ctx_exec (basic)
[63.712141] Starting subtest: basic
[63.716262] Subtest basic: SUCCESS (0.006s)
[63.797924] [019/165] (949s left) gem_exec_basic (basic)
[63.912921] Starting subtest: basic
[63.914132] Starting dynamic subtest: rcs0-smem
[63.915345] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[63.927503] Starting dynamic subtest: bcs0-smem
[63.928686] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[63.937896] Starting dynamic subtest: vcs0-smem
[63.939116] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[63.948134] Starting dynamic subtest: vecs0-smem
[63.949324] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[63.950794] Subtest basic: SUCCESS (0.009s)
[64.115828] [020/165] (948s left) gem_exec_create (basic)
[64.237330] Starting subtest: basic
[64.238443] Starting dynamic subtest: smem
[66.289726] Dynamic subtest smem: SUCCESS (2.051s)
[66.290805] Subtest basic: SUCCESS (2.052s)
[66.483317] [021/165] (946s left) gem_exec_fence (basic-busy)
[66.739159] Starting subtest: basic-busy
[66.741115] Starting dynamic subtest: rcs0
[66.753625] Dynamic subtest rcs0: SUCCESS (0.015s)
[66.765474] Starting dynamic subtest: bcs0
[66.773529] Dynamic subtest bcs0: SUCCESS (0.019s)
[66.785341] Starting dynamic subtest: vcs0
[66.793864] Dynamic subtest vcs0: SUCCESS (0.019s)
[66.807674] Starting dynamic subtest: vecs0
[66.809920] Dynamic subtest vecs0: SUCCESS (0.014s)
[66.811058] Subtest basic-busy: SUCCESS (0.068s)
[67.450657] [022/165] (945s left) gem_exec_fence (basic-wait)
[67.706857] Starting subtest: basic-wait
[67.708074] Starting dynamic subtest: rcs0
[67.726634] Dynamic subtest rcs0: SUCCESS (0.019s)
[67.737705] Starting dynamic subtest: bcs0
[67.751810] Dynamic subtest bcs0: SUCCESS (0.024s)
[67.763275] Starting dynamic subtest: vcs0
[67.766521] Dynamic subtest vcs0: SUCCESS (0.015s)
[67.780393] Starting dynamic subtest: vecs0
[67.781449] Dynamic subtest vecs0: SUCCESS (0.013s)
[67.782628] Subtest basic-wait: SUCCESS (0.074s)
[68.365253] [023/165] (944s left) gem_exec_fence (basic-await)
[68.616522] Starting subtest: basic-await
[68.617611] Starting dynamic subtest: rcs0
[68.729635] Dynamic subtest rcs0: SUCCESS (0.113s)
[68.739967] Starting dynamic subtest: bcs0
[68.841321] Dynamic subtest bcs0: SUCCESS (0.110s)
[68.851426] Starting dynamic subtest: vcs0
[68.953400] Dynamic subtest vcs0: SUCCESS (0.113s)
[68.963762] Starting dynamic subtest: vecs0
[69.068717] Dynamic subtest vecs0: SUCCESS (0.115s)
[69.070224] Subtest basic-await: SUCCESS (0.454s)
[69.666555] [024/165] (943s left) gem_exec_fence (nb-await)
[69.917964] Starting subtest: nb-await
[69.919162] Starting dynamic subtest: rcs0
[69.987490] Dynamic subtest rcs0: SUCCESS (0.068s)
[69.999034] Starting dynamic subtest: bcs0
[70.051268] Dynamic subtest bcs0: SUCCESS (0.064s)
[70.061689] Starting dynamic subtest: vcs0
[70.119385] Dynamic subtest vcs0: SUCCESS (0.067s)
[70.130935] Starting dynamic subtest: vecs0
[70.185517] Dynamic subtest vecs0: SUCCESS (0.067s)
[70.186943] Subtest nb-await: SUCCESS (0.270s)
[70.783842] [025/165] (942s left) gem_exec_gttfill (basic)
[70.912785] Starting subtest: basic
[81.509919] Subtest basic: SUCCESS (10.596s)
[81.719175] [026/165] (931s left) gem_exec_parallel (engines)
[81.952887] Starting subtest: engines
[81.954668] Starting dynamic subtest: basic
[84.805864] Dynamic subtest basic: SUCCESS (2.852s)
[84.818136] Starting dynamic subtest: contexts
[88.564956] Dynamic subtest contexts: SUCCESS (3.758s)
[88.577341] Starting dynamic subtest: fds
[96.811607] Dynamic subtest fds: SUCCESS (8.247s)
[96.825454] Starting dynamic subtest: userptr
[99.719955] Dynamic subtest userptr: SUCCESS (2.908s)
[99.721317] Subtest engines: SUCCESS (17.767s)
[99.915517] [027/165] (913s left) gem_exec_store (basic)
[100.042780] Starting subtest: basic
[100.083794] Subtest basic: SUCCESS (0.041s)
[100.273684] [028/165] (912s left) gem_flink_basic (bad-flink)
[100.382227] Starting subtest: bad-flink
[100.383305] Subtest bad-flink: SUCCESS (0.000s)
[100.450624] [029/165] (912s left) gem_flink_basic (bad-open)
[100.553880] Starting subtest: bad-open
[100.554986] Subtest bad-open: SUCCESS (0.000s)
[100.640919] [030/165] (912s left) gem_flink_basic (basic)
[100.745998] Starting subtest: basic
[100.748389] Subtest basic: SUCCESS (0.000s)
[100.818454] [031/165] (912s left) gem_flink_basic (double-flink)
[100.921570] Starting subtest: double-flink
[100.922914] Subtest double-flink: SUCCESS (0.000s)
[101.002219] [032/165] (912s left) gem_flink_basic (flink-lifetime)
[101.108202] Starting subtest: flink-lifetime
[101.109212] Subtest flink-lifetime: SUCCESS (0.002s)
[101.185469] [033/165] (912s left) gem_huc_copy (huc-copy)
[101.301662] Starting subtest: huc-copy
[101.305221] Subtest huc-copy: SKIP (0.000s)
[101.383309] [034/165] (911s left) gem_linear_blits (basic)
[101.678813] Starting subtest: basic
[101.692946] Subtest basic: SUCCESS (0.014s)
[101.813509] [035/165] (911s left) gem_mmap (basic)
[102.020278] Starting subtest: basic
[102.026604] Subtest basic: SUCCESS (0.001s)
[102.102573] [036/165] (911s left) gem_mmap_gtt (basic)
[102.212740] Starting subtest: basic
[102.213837] Subtest basic: SUCCESS (0.001s)
[102.269590] [037/165] (911s left) gem_render_linear_blits (basic)
[102.380744] Starting subtest: basic
[102.444063] Subtest basic: SUCCESS (0.059s)
[102.487808] [038/165] (910s left) gem_render_tiled_blits (basic)
[102.599673] Starting subtest: basic
[102.682429] Subtest basic: SUCCESS (0.079s)
[102.738373] [039/165] (910s left) gem_ringfill (basic-all)
[103.061851] Starting subtest: basic-all
[104.240952] Subtest basic-all: SUCCESS (1.177s)
[104.335722] [040/165] (909s left) gem_softpin (allocator-basic)
[104.451734] Starting subtest: allocator-basic
[104.639326] Subtest allocator-basic: SUCCESS (0.178s)
[104.736536] [041/165] (908s left) gem_softpin (allocator-basic-reserve)
[104.850071] Starting subtest: allocator-basic-reserve
[105.034202] Subtest allocator-basic-reserve: SUCCESS (0.178s)
[105.116374] [042/165] (908s left) gem_softpin (safe-alignment)
[105.231158] Starting subtest: safe-alignment
[105.252311] Subtest safe-alignment: SUCCESS (0.020s)
[105.350718] [043/165] (908s left) gem_sync (basic-all)
[105.475494] Starting subtest: basic-all
[107.537501] Subtest basic-all: SUCCESS (2.061s)
[107.735548] [044/165] (905s left) gem_sync (basic-each)
[107.860835] Starting subtest: basic-each
[110.168155] Subtest basic-each: SUCCESS (2.307s)
[110.352849] [045/165] (903s left) gem_tiled_blits (basic)
[110.619835] Starting subtest: basic
[110.655594] Subtest basic: SUCCESS (0.035s)
[110.795402] [046/165] (902s left) gem_tiled_fence_blits (basic)
[111.168618] Starting subtest: basic
[111.200475] Subtest basic: SUCCESS (0.032s)
[111.346699] [047/165] (902s left) gem_tiled_pread_basic
[111.852134] [048/165] (901s left) gem_wait (busy@all-engines)
[111.987483] Starting subtest: busy
[111.988625] Starting dynamic subtest: all-engines
[112.512524] Dynamic subtest all-engines: SUCCESS (0.520s)
[112.513535] Subtest busy: SUCCESS (0.522s)
[112.736138] [049/165] (900s left) gem_wait (wait@all-engines)
[112.872337] Starting subtest: wait
[112.875030] Starting dynamic subtest: all-engines
[113.905535] Dynamic subtest all-engines: SUCCESS (1.031s)
[113.906750] Subtest wait: SUCCESS (1.032s)
[114.118499] [050/165] (899s left) i915_getparams_basic (basic-eu-total)
[114.224623] Starting subtest: basic-eu-total
[114.226940] Subtest basic-eu-total: SUCCESS (0.000s)
[114.300259] [051/165] (899s left) i915_getparams_basic (basic-subslice-total)
[114.405710] Starting subtest: basic-subslice-total
[114.408211] Subtest basic-subslice-total: SUCCESS (0.000s)
[114.485100] [052/165] (899s left) i915_hangman (error-state-basic)
[114.611561] Starting subtest: error-state-basic
[114.628814] Subtest error-state-basic: SUCCESS (0.013s)
[114.700107] [053/165] (899s left) i915_pciid
[114.884468] [054/165] (898s left) kms_addfb_basic (addfb25-4-tiled)
[115.056108] Starting subtest: addfb25-4-tiled
[115.057230] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[115.132162] [055/165] (898s left) kms_addfb_basic (addfb25-bad-modifier)
[115.236107] Starting subtest: addfb25-bad-modifier
[115.238770] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[115.382089] [056/165] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[115.490597] Starting subtest: addfb25-framebuffer-vs-set-tiling
[115.491760] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[115.632950] [057/165] (898s left) kms_addfb_basic (addfb25-modifier-no-flag)
[115.740050] Starting subtest: addfb25-modifier-no-flag
[115.741136] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[115.882747] [058/165] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[115.989864] Starting subtest: addfb25-x-tiled-legacy
[115.990936] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[116.132703] [059/165] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.237850] Starting subtest: addfb25-x-tiled-mismatch-legacy
[116.239158] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[116.382428] [060/165] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[116.549465] Starting subtest: addfb25-yf-tiled-legacy
[116.550659] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[116.632372] [061/165] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[116.798531] Starting subtest: addfb25-y-tiled-legacy
[116.799616] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[116.882754] [062/165] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[117.054999] Starting subtest: addfb25-y-tiled-small-legacy
[117.056304] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.002s)
[117.132302] [063/165] (896s left) kms_addfb_basic (bad-pitch-0)
[117.241357] Starting subtest: bad-pitch-0
[117.242522] Subtest bad-pitch-0: SUCCESS (0.000s)
[117.382485] [064/165] (896s left) kms_addfb_basic (bad-pitch-1024)
[117.490836] Starting subtest: bad-pitch-1024
[117.491933] Subtest bad-pitch-1024: SUCCESS (0.000s)
[117.632687] [065/165] (896s left) kms_addfb_basic (bad-pitch-128)
[117.741221] Starting subtest: bad-pitch-128
[117.743565] Subtest bad-pitch-128: SUCCESS (0.000s)
[117.882892] [066/165] (896s left) kms_addfb_basic (bad-pitch-256)
[117.991162] Starting subtest: bad-pitch-256
[117.992281] Subtest bad-pitch-256: SUCCESS (0.000s)
[118.131744] [067/165] (896s left) kms_addfb_basic (bad-pitch-32)
[118.240460] Starting subtest: bad-pitch-32
[118.241569] Subtest bad-pitch-32: SUCCESS (0.000s)
[118.382545] [068/165] (895s left) kms_addfb_basic (bad-pitch-63)
[118.488169] Starting subtest: bad-pitch-63
[118.492061] Subtest bad-pitch-63: SUCCESS (0.000s)
[118.632555] [069/165] (895s left) kms_addfb_basic (bad-pitch-65536)
[118.744111] Starting subtest: bad-pitch-65536
[118.745179] Subtest bad-pitch-65536: SUCCESS (0.001s)
[118.882172] [070/165] (895s left) kms_addfb_basic (bad-pitch-999)
[118.989207] Starting subtest: bad-pitch-999
[118.990355] Subtest bad-pitch-999: SUCCESS (0.000s)
[119.148683] [071/165] (895s left) kms_addfb_basic (basic)
[119.256922] Starting subtest: basic
[119.259059] Subtest basic: SUCCESS (0.000s)
[119.398810] [072/165] (894s left) kms_addfb_basic (basic-x-tiled-legacy)
[119.503169] Starting subtest: basic-x-tiled-legacy
[119.504636] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[119.648926] [073/165] (894s left) kms_addfb_basic (basic-y-tiled-legacy)
[119.759573] Starting subtest: basic-y-tiled-legacy
[119.762108] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[119.899690] [074/165] (894s left) kms_addfb_basic (bo-too-small)
[120.060841] Starting subtest: bo-too-small
[120.062228] Subtest bo-too-small: SUCCESS (0.000s)
[120.149180] [075/165] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[120.314204] Starting subtest: bo-too-small-due-to-tiling
[120.315921] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[120.399112] [076/165] (894s left) kms_addfb_basic (clobberred-modifier)
[120.505971] Starting subtest: clobberred-modifier
[120.507581] Subtest clobberred-modifier: SUCCESS (0.000s)
[120.632112] [077/165] (893s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[120.737573] Starting subtest: framebuffer-vs-set-tiling
[120.738766] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[120.882492] [078/165] (893s left) kms_addfb_basic (invalid-get-prop)
[120.994122] Starting subtest: invalid-get-prop
[120.995242] Subtest invalid-get-prop: SUCCESS (0.000s)
[121.132833] [079/165] (893s left) kms_addfb_basic (invalid-get-prop-any)
[121.241387] Starting subtest: invalid-get-prop-any
[121.243799] Subtest invalid-get-prop-any: SUCCESS (0.001s)
[121.382428] [080/165] (893s left) kms_addfb_basic (invalid-set-prop)
[121.488909] Starting subtest: invalid-set-prop
[121.491754] Subtest invalid-set-prop: SUCCESS (0.000s)
[121.633196] [081/165] (892s left) kms_addfb_basic (invalid-set-prop-any)
[121.741232] Starting subtest: invalid-set-prop-any
[121.742314] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[121.882459] [082/165] (892s left) kms_addfb_basic (no-handle)
[121.988111] Starting subtest: no-handle
[121.989187] Subtest no-handle: SUCCESS (0.000s)
[122.132773] [083/165] (892s left) kms_addfb_basic (size-max)
[122.299405] Starting subtest: size-max
[122.300432] Subtest size-max: SUCCESS (0.000s)
[122.365514] [084/165] (892s left) kms_addfb_basic (small-bo)
[122.535264] Starting subtest: small-bo
[122.536286] Subtest small-bo: SUCCESS (0.000s)
[122.615432] [085/165] (892s left) kms_addfb_basic (tile-pitch-mismatch)
[122.723824] Starting subtest: tile-pitch-mismatch
[122.726586] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[122.865307] [086/165] (891s left) kms_addfb_basic (too-high)
[123.031200] Starting subtest: too-high
[123.032575] Subtest too-high: SUCCESS (0.001s)
[123.115460] [087/165] (891s left) kms_addfb_basic (too-wide)
[123.282076] Starting subtest: too-wide
[123.283131] Subtest too-wide: SUCCESS (0.000s)
[123.365844] [088/165] (891s left) kms_addfb_basic (unused-handle)
[123.474083] Starting subtest: unused-handle
[123.476738] Subtest unused-handle: SUCCESS (0.000s)
[123.614434] [089/165] (891s left) kms_addfb_basic (unused-modifier)
[123.719357] Starting subtest: unused-modifier
[123.721900] Subtest unused-modifier: SUCCESS (0.000s)
[123.865317] [090/165] (891s left) kms_addfb_basic (unused-offsets)
[123.972304] Starting subtest: unused-offsets
[123.974086] Subtest unused-offsets: SUCCESS (0.000s)
[124.115246] [091/165] (890s left) kms_addfb_basic (unused-pitches)
[124.221531] Starting subtest: unused-pitches
[124.223802] Subtest unused-pitches: SUCCESS (0.000s)
[124.364579] [092/165] (890s left) kms_busy (basic)
[124.533044] Starting subtest: basic
[124.540112] Starting dynamic subtest: flip
[125.388348] Dynamic subtest flip: SUCCESS (0.844s)
[125.406070] Starting dynamic subtest: modeset
[126.702511] Dynamic subtest modeset: SUCCESS (1.310s)
[126.704661] Subtest basic: SUCCESS (2.161s)
[126.915244] [093/165] (888s left) kms_prop_blob (basic)
[127.024434] Starting subtest: basic
[127.025535] Subtest basic: SUCCESS (0.000s)
[127.097249] [094/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[127.267155] Starting subtest: basic-busy-flip-before-cursor-atomic
[127.271727] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[127.345068] [095/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[127.513778] Starting subtest: basic-busy-flip-before-cursor-legacy
[127.517414] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[127.578386] [096/165] (887s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[127.746879] Starting subtest: basic-flip-after-cursor-atomic
[128.901267] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.156s)
[129.082667] [097/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[129.248839] Starting subtest: basic-flip-after-cursor-legacy
[130.460621] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.206s)
[130.613253] [098/165] (884s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[130.774585] Starting subtest: basic-flip-after-cursor-varying-size
[131.967424] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.193s)
[132.151634] [099/165] (882s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[132.312775] Starting subtest: basic-flip-before-cursor-atomic
[133.484224] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.168s)
[133.730366] [100/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[133.938198] Starting subtest: basic-flip-before-cursor-legacy
[135.106318] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.168s)
[135.282205] [101/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[135.447727] Starting subtest: basic-flip-before-cursor-varying-size
[136.652776] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.205s)
[136.814187] [102/165] (878s left) kms_dsc (dsc-basic)
[136.981220] Subtest dsc-basic: SKIP (0.000s)
[137.016678] [103/165] (878s left) kms_flip (basic-flip-vs-dpms)
[137.162851] Starting subtest: basic-flip-vs-dpms
[137.167313] Starting dynamic subtest: A-HDMI-A2
[138.413982] Dynamic subtest A-HDMI-A2: SUCCESS (1.241s)
[138.428460] Starting dynamic subtest: B-HDMI-A2
[139.380807] Dynamic subtest B-HDMI-A2: SUCCESS (0.968s)
[139.402171] Starting dynamic subtest: C-HDMI-A2
[140.378578] Dynamic subtest C-HDMI-A2: SUCCESS (0.994s)
[140.379812] Subtest basic-flip-vs-dpms: SUCCESS (3.215s)
[140.576382] [104/165] (874s left) kms_flip (basic-flip-vs-modeset)
[140.731851] Starting subtest: basic-flip-vs-modeset
[140.739112] Starting dynamic subtest: A-HDMI-A2
[142.077089] Dynamic subtest A-HDMI-A2: SUCCESS (1.337s)
[142.098898] Starting dynamic subtest: B-HDMI-A2
[143.086460] Dynamic subtest B-HDMI-A2: SUCCESS (0.996s)
[143.100946] Starting dynamic subtest: C-HDMI-A2
[144.095977] Dynamic subtest C-HDMI-A2: SUCCESS (1.004s)
[144.097791] Subtest basic-flip-vs-modeset: SUCCESS (3.357s)
[144.273461] [105/165] (871s left) kms_flip (basic-flip-vs-wf_vblank)
[144.423389] Starting subtest: basic-flip-vs-wf_vblank
[144.428911] Starting dynamic subtest: A-HDMI-A2
[145.844795] Dynamic subtest A-HDMI-A2: SUCCESS (1.411s)
[145.858282] Starting dynamic subtest: B-HDMI-A2
[147.164885] Dynamic subtest B-HDMI-A2: SUCCESS (1.319s)
[147.180757] Starting dynamic subtest: C-HDMI-A2
[148.516127] Dynamic subtest C-HDMI-A2: SUCCESS (1.347s)
[148.517549] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.093s)
[148.884799] [106/165] (866s left) kms_flip (basic-plain-flip)
[149.041016] Starting subtest: basic-plain-flip
[149.047565] Starting dynamic subtest: A-HDMI-A2
[150.177635] Dynamic subtest A-HDMI-A2: SUCCESS (1.127s)
[150.194216] Starting dynamic subtest: B-HDMI-A2
[151.217273] Dynamic subtest B-HDMI-A2: SUCCESS (1.033s)
[151.233746] Starting dynamic subtest: C-HDMI-A2
[152.285062] Dynamic subtest C-HDMI-A2: SUCCESS (1.064s)
[152.286863] Subtest basic-plain-flip: SUCCESS (3.243s)
[152.624149] [107/165] (862s left) kms_force_connector_basic (force-connector-state)
[152.816809] Starting subtest: force-connector-state
[153.230614] Subtest force-connector-state: SUCCESS (0.412s)
[153.718337] [108/165] (861s left) kms_force_connector_basic (force-edid)
[153.915205] Starting subtest: force-edid
[153.966232] Subtest force-edid: SUCCESS (0.052s)
[154.250760] [109/165] (861s left) kms_force_connector_basic (force-load-detect)
[154.448137] Starting subtest: force-load-detect
[154.451109] Subtest force-load-detect: SKIP (0.000s)
[154.684295] [110/165] (860s left) kms_force_connector_basic (prune-stale-modes)
[154.870815] Starting subtest: prune-stale-modes
[154.930297] Subtest prune-stale-modes: SUCCESS (0.059s)
[155.218039] [111/165] (860s left) kms_frontbuffer_tracking (basic)
[155.395437] Starting subtest: basic
[158.177472] Subtest basic: SUCCESS (2.781s)
[158.269549] [112/165] (857s left) kms_hdmi_inject (inject-audio)
[158.602769] Starting subtest: inject-audio
[158.796391] Subtest inject-audio: SUCCESS (0.194s)
[159.160357] [113/165] (856s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[159.329387] Starting subtest: compare-crc-sanitycheck-xr24
[159.330498] Starting dynamic subtest: pipe-A-HDMI-A-2
[159.855292] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.522s)
[159.869869] Starting dynamic subtest: pipe-B-HDMI-A-2
[160.397782] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.539s)
[160.418673] Starting dynamic subtest: pipe-C-HDMI-A-2
[160.940468] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.534s)
[160.941768] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.613s)
[161.104104] [114/165] (854s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[161.270892] Starting subtest: compare-crc-sanitycheck-nv12
[161.278993] Starting dynamic subtest: pipe-A-HDMI-A-2
[161.931898] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.650s)
[161.946910] Starting dynamic subtest: pipe-B-HDMI-A-2
[162.539309] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.603s)
[162.557559] Starting dynamic subtest: pipe-C-HDMI-A-2
[163.151890] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.610s)
[163.156070] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.881s)
[163.319532] [115/165] (852s left) kms_pipe_crc_basic (hang-read-crc)
[163.482461] Starting subtest: hang-read-crc
[163.490572] Starting dynamic subtest: pipe-A-HDMI-A-2
[164.802450] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.315s)
[164.819882] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.046901] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.241s)
[166.074573] Starting dynamic subtest: pipe-C-HDMI-A-2
[167.303395] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.245s)
[167.308057] Subtest hang-read-crc: SUCCESS (3.821s)
[167.460818] [116/165] (848s left) kms_pipe_crc_basic (nonblocking-crc)
[167.632122] Starting subtest: nonblocking-crc
[167.636224] Starting dynamic subtest: pipe-A-HDMI-A-2
[168.370832] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.734s)
[168.387150] Starting dynamic subtest: pipe-B-HDMI-A-2
[169.103921] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.725s)
[169.120998] Starting dynamic subtest: pipe-C-HDMI-A-2
[169.810708] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.700s)
[169.813231] Subtest nonblocking-crc: SUCCESS (2.178s)
[169.995421] [117/165] (845s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[170.165877] Starting subtest: nonblocking-crc-frame-sequence
[170.173618] Starting dynamic subtest: pipe-A-HDMI-A-2
[170.928812] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.754s)
[170.948023] Starting dynamic subtest: pipe-B-HDMI-A-2
[171.630268] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.698s)
[171.650837] Starting dynamic subtest: pipe-C-HDMI-A-2
[172.327215] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.690s)
[172.328968] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.161s)
[172.493064] [118/165] (843s left) kms_pipe_crc_basic (read-crc)
[172.678148] Starting subtest: read-crc
[172.684459] Starting dynamic subtest: pipe-A-HDMI-A-2
[173.362975] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.680s)
[173.380490] Starting dynamic subtest: pipe-B-HDMI-A-2
[173.975792] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.604s)
[173.992713] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.615463] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.636s)
[174.616958] Subtest read-crc: SUCCESS (1.939s)
[174.780829] [119/165] (840s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[174.955215] Starting subtest: read-crc-frame-sequence
[174.956308] Starting dynamic subtest: pipe-A-HDMI-A-2
[175.634596] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.675s)
[175.650191] Starting dynamic subtest: pipe-B-HDMI-A-2
[176.296837] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.656s)
[176.315020] Starting dynamic subtest: pipe-C-HDMI-A-2
[176.935874] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.631s)
[176.937900] Subtest read-crc-frame-sequence: SUCCESS (1.983s)
[177.101734] [120/165] (838s left) kms_pm_backlight (basic-brightness)
[177.273343] Subtest basic-brightness: SKIP (0.000s)
[177.322104] [121/165] (838s left) kms_pm_rpm (basic-pci-d3-state)
[179.159190] Starting subtest: basic-pci-d3-state
[179.491228] Subtest basic-pci-d3-state: SUCCESS (0.328s)
[179.733203] [122/165] (836s left) kms_pm_rpm (basic-rte)
[179.838173] Starting subtest: basic-rte
[181.804608] Subtest basic-rte: SUCCESS (1.959s)
[182.524127] [123/165] (833s left) kms_psr (primary_page_flip)
[182.636335] Subtest primary_page_flip: SKIP (0.000s)
[182.679430] [124/165] (833s left) kms_psr (cursor_plane_move)
[182.784230] Subtest cursor_plane_move: SKIP (0.000s)
[182.829232] [125/165] (833s left) kms_psr (sprite_plane_onoff)
[182.936847] Subtest sprite_plane_onoff: SKIP (0.000s)
[182.978842] [126/165] (833s left) kms_psr (primary_mmap_gtt)
[183.095018] Subtest primary_mmap_gtt: SKIP (0.000s)
[183.144623] [127/165] (832s left) kms_setmode (basic-clone-single-crtc)
[183.251382] Starting subtest: basic-clone-single-crtc
[183.256628] Subtest basic-clone-single-crtc: SKIP (0.000s)
[183.341498] [128/165] (832s left) i915_pm_rps (basic-api)
[183.454338] Starting subtest: basic-api
[183.463073] Subtest basic-api: SUCCESS (0.010s)
[183.557984] [129/165] (832s left) prime_self_import (basic-llseek-bad)
[183.664580] Starting subtest: basic-llseek-bad
[183.666984] Subtest basic-llseek-bad: SUCCESS (0.003s)
[183.758106] [130/165] (832s left) prime_self_import (basic-llseek-size)
[183.863322] Starting subtest: basic-llseek-size
[183.865548] Subtest basic-llseek-size: SUCCESS (0.005s)
[183.956799] [131/165] (832s left) prime_self_import (basic-with_fd_dup)
[184.061894] Starting subtest: basic-with_fd_dup
[184.068763] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[184.157645] [132/165] (832s left) prime_self_import (basic-with_one_bo)
[184.264774] Starting subtest: basic-with_one_bo
[184.267770] Subtest basic-with_one_bo: SUCCESS (0.005s)
[184.361890] [133/165] (831s left) prime_self_import (basic-with_one_bo_two_files)
[184.466641] Starting subtest: basic-with_one_bo_two_files
[184.471373] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[184.558182] [134/165] (831s left) prime_self_import (basic-with_two_bos)
[184.664134] Starting subtest: basic-with_two_bos
[184.666308] Subtest basic-with_two_bos: SUCCESS (0.005s)
[184.757829] [135/165] (831s left) prime_vgem (basic-fence-flip)
[184.892798] Starting subtest: basic-fence-flip
[185.393439] Subtest basic-fence-flip: SUCCESS (0.500s)
[185.509524] [136/165] (830s left) prime_vgem (basic-fence-mmap)
[185.636998] Starting subtest: basic-fence-mmap
[185.695824] Subtest basic-fence-mmap: SUCCESS (0.059s)
[185.775171] [137/165] (830s left) prime_vgem (basic-fence-read)
[185.903825] Starting subtest: basic-fence-read
[186.003696] Subtest basic-fence-read: SUCCESS (0.098s)
[186.093678] [138/165] (830s left) prime_vgem (basic-gtt)
[186.220133] Starting subtest: basic-gtt
[186.253537] Subtest basic-gtt: SUCCESS (0.031s)
[186.342650] [139/165] (830s left) prime_vgem (basic-read)
[186.470187] Starting subtest: basic-read
[186.522818] Subtest basic-read: SUCCESS (0.050s)
[186.609312] [140/165] (829s left) prime_vgem (basic-write)
[186.737916] Starting subtest: basic-write
[186.793466] Subtest basic-write: SUCCESS (0.057s)
[186.875831] [141/165] (829s left) vgem_basic (setversion)
[186.998962] Starting subtest: setversion
[187.001316] Subtest setversion: SUCCESS (0.000s)
[187.057266] [142/165] (829s left) vgem_basic (create)
[187.182519] Starting subtest: create
[187.183693] Subtest create: SUCCESS (0.000s)
[187.242280] [143/165] (829s left) vgem_basic (debugfs)
[187.360436] Starting subtest: debugfs
[187.361747] Subtest debugfs: SUCCESS (0.001s)
[187.425108] [144/165] (829s left) vgem_basic (dmabuf-export)
[187.546885] Starting subtest: dmabuf-export
[187.550144] Subtest dmabuf-export: SUCCESS (0.003s)
[187.642190] [145/165] (828s left) vgem_basic (dmabuf-fence)
[187.761817] Starting subtest: dmabuf-fence
[187.763731] Subtest dmabuf-fence: SUCCESS (0.001s)
[187.825887] [146/165] (828s left) vgem_basic (dmabuf-fence-before)
[187.947056] Starting subtest: dmabuf-fence-before
[187.948326] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[188.007759] [147/165] (828s left) vgem_basic (dmabuf-mmap)
[188.128590] Starting subtest: dmabuf-mmap
[188.156631] Subtest dmabuf-mmap: SUCCESS (0.030s)
[188.224083] [148/165] (828s left) vgem_basic (mmap)
[188.345749] Starting subtest: mmap
[188.363550] Subtest mmap: SUCCESS (0.020s)
[188.426280] [149/165] (828s left) vgem_basic (second-client)
[188.545405] Starting subtest: second-client
[188.577038] Subtest second-client: SUCCESS (0.031s)
[188.642115] [150/165] (828s left) vgem_basic (sysfs)
[188.761468] Starting subtest: sysfs
[188.764885] Subtest sysfs: SUCCESS (0.001s)
[188.823959] [151/165] (827s left) core_hotunplug (unbind-rebind)
[188.994958] Starting subtest: unbind-rebind
[192.395814] Subtest unbind-rebind: SUCCESS (3.401s)
[192.432976] [152/165] (824s left) vgem_basic (unload)
[192.550327] Starting subtest: unload
[221.547903] Subtest unload: SUCCESS (28.995s)
[221.679789] [153/165] (795s left) i915_module_load (reload)
[221.783670] Starting subtest: reload
[224.277806] Subtest reload: SUCCESS (2.494s)
[224.368982] [154/165] (792s left) gem_lmem_swapping (basic)
[224.691841] Subtest basic: SKIP (0.000s)
[224.779710] [155/165] (792s left) gem_lmem_swapping (parallel-random-engines)
[224.945358] Subtest parallel-random-engines: SKIP (0.000s)
[224.977585] [156/165] (792s left) gem_lmem_swapping (random-engines)
[225.091143] Subtest random-engines: SKIP (0.000s)
[225.129709] [157/165] (791s left) gem_lmem_swapping (verify-random)
[225.241626] Subtest verify-random: SKIP (0.000s)
[225.279281] [158/165] (791s left) i915_pm_rpm (module-reload)
[227.261186] Starting subtest: module-reload
[234.462215] Subtest module-reload: SUCCESS (7.200s)
[234.491713] [159/165] (782s left) i915_selftest (live)
[234.618176] Starting subtest: live
[234.619297] Starting dynamic subtest: sanitycheck
[235.620571] Dynamic subtest sanitycheck: SUCCESS (1.003s)
[235.634381] Starting dynamic subtest: uncore
[236.438373] Dynamic subtest uncore: SUCCESS (0.812s)
[236.449316] Starting dynamic subtest: workarounds
[237.437251] Dynamic subtest workarounds: SUCCESS (0.996s)
[237.448091] Starting dynamic subtest: gt_engines
[238.893771] Dynamic subtest gt_engines: SUCCESS (1.454s)
[238.904321] Starting dynamic subtest: gt_timelines
[251.932294] Dynamic subtest gt_timelines: SUCCESS (13.035s)
[251.943155] Starting dynamic subtest: gt_contexts
[252.937161] Dynamic subtest gt_contexts: SUCCESS (1.004s)
[252.950788] Starting dynamic subtest: gt_lrc
[256.302137] Dynamic subtest gt_lrc: SUCCESS (3.359s)
[256.313155] Starting dynamic subtest: gt_mocs
[257.334875] Dynamic subtest gt_mocs: SUCCESS (1.031s)
[257.345704] Starting dynamic subtest: gt_pm
[265.128557] Dynamic subtest gt_pm: SUCCESS (7.792s)
[265.141600] Starting dynamic subtest: gt_heartbeat
[266.093997] Dynamic subtest gt_heartbeat: SUCCESS (0.962s)
[266.105704] Starting dynamic subtest: gt_tlb
[267.763212] Dynamic subtest gt_tlb: SUCCESS (1.665s)
[267.774628] Starting dynamic subtest: requests
[275.000698] Dynamic subtest requests: SUCCESS (7.235s)
[275.014233] Starting dynamic subtest: migrate
[278.719345] Dynamic subtest migrate: SUCCESS (3.714s)
[278.730325] Starting dynamic subtest: active
[279.588674] Dynamic subtest active: SUCCESS (0.866s)
[279.599619] Starting dynamic subtest: objects
[282.520711] Dynamic subtest objects: SUCCESS (2.929s)
[282.531839] Starting dynamic subtest: mman
[289.214163] Dynamic subtest mman: SUCCESS (6.692s)
[289.225344] Starting dynamic subtest: dmabuf
[290.219811] Dynamic subtest dmabuf: SUCCESS (1.003s)
[290.230947] Starting dynamic subtest: vma
[291.191147] Dynamic subtest vma: SUCCESS (0.969s)
[291.202311] Starting dynamic subtest: coherency
[294.041297] Dynamic subtest coherency: SUCCESS (2.847s)
[294.052320] Starting dynamic subtest: gtt
[302.353023] Dynamic subtest gtt: SUCCESS (8.310s)
[302.366858] Starting dynamic subtest: gem
[303.346779] Dynamic subtest gem: SUCCESS (0.990s)
[303.360808] Starting dynamic subtest: evict
[306.549437] Dynamic subtest evict: SUCCESS (3.198s)
[306.560252] Starting dynamic subtest: hugepages
[313.914699] Dynamic subtest hugepages: SUCCESS (7.363s)
[313.926434] Starting dynamic subtest: gem_contexts
[331.056164] Dynamic subtest gem_contexts: SUCCESS (17.137s)
[331.067768] Starting dynamic subtest: client
[331.912713] Dynamic subtest client: SUCCESS (0.855s)
[331.923971] Starting dynamic subtest: gem_migrate
[332.869903] Dynamic subtest gem_migrate: SUCCESS (0.956s)
[332.883796] Starting dynamic subtest: reset
[338.075638] Dynamic subtest reset: SUCCESS (5.201s)
[338.086835] Starting dynamic subtest: memory_region
[339.006151] Dynamic subtest memory_region: SUCCESS (0.928s)
[339.019387] Starting dynamic subtest: hangcheck
[362.832017] Dynamic subtest hangcheck: SUCCESS (23.819s)
[362.843862] Starting dynamic subtest: execlists
[372.617868] Dynamic subtest execlists: SUCCESS (9.787s)
[372.631832] Starting dynamic subtest: ring_submission
[373.637719] Dynamic subtest ring_submission: SUCCESS (1.016s)
[373.649171] Starting dynamic subtest: perf
[374.614339] Dynamic subtest perf: SUCCESS (0.974s)
[374.625594] Starting dynamic subtest: slpc
[375.419292] Dynamic subtest slpc: SUCCESS (0.802s)
[375.430615] Starting dynamic subtest: guc
[376.256215] Dynamic subtest guc: SUCCESS (0.832s)
[376.267918] Starting dynamic subtest: guc_multi_lrc
[377.125403] Dynamic subtest guc_multi_lrc: SUCCESS (0.868s)
[377.136708] Starting dynamic subtest: guc_hang
[377.987462] Dynamic subtest guc_hang: SUCCESS (0.859s)
[377.998843] Starting dynamic subtest: late_gt_pm
[378.841220] Dynamic subtest late_gt_pm: SUCCESS (0.849s)
[378.842820] Subtest live: SUCCESS (144.224s)
[378.906147] [160/165] (638s left) dmabuf (all-tests)
[379.055650] Starting subtest: all-tests
[379.057293] Starting dynamic subtest: sanitycheck
[379.112912] Dynamic subtest sanitycheck: SUCCESS (0.055s)
[379.143051] Starting dynamic subtest: dma_fence
[379.289899] Dynamic subtest dma_fence: SUCCESS (0.173s)
[379.316789] Starting dynamic subtest: dma_fence_chain
[397.568332] Dynamic subtest dma_fence_chain: SUCCESS (18.278s)
[397.581865] Starting dynamic subtest: dma_fence_unwrap
[397.629222] Dynamic subtest dma_fence_unwrap: SUCCESS (0.058s)
[397.646324] Starting dynamic subtest: dma_resv
[397.691653] Dynamic subtest dma_resv: SUCCESS (0.058s)
[397.693256] Subtest all-tests: SUCCESS (18.639s)
[397.720738] [161/165] (619s left) i915_suspend (basic-s2idle-without-i915)
[397.822035] Starting subtest: basic-s2idle-without-i915
[416.935450] Subtest basic-s2idle-without-i915: SUCCESS (3.525s)
[421.202683] [162/165] (615s left) i915_suspend (basic-s3-without-i915)
[421.325353] Starting subtest: basic-s3-without-i915
[441.463252] Subtest basic-s3-without-i915: SUCCESS (2.198s)
[443.512603] [163/165] (611s left) gem_exec_suspend (basic-s0)
[443.648162] Starting subtest: basic-S0
[443.652363] Starting dynamic subtest: smem
[462.626648] Dynamic subtest smem: SUCCESS (4.201s)
[462.628371] Subtest basic-S0: SUCCESS (4.205s)
[465.789519] [164/165] (607s left) gem_exec_suspend (basic-s3)
[465.913906] Starting subtest: basic-S3
[465.920382] Starting dynamic subtest: smem
[485.791601] Dynamic subtest smem: SUCCESS (3.710s)
[485.793390] Subtest basic-S3: SUCCESS (3.713s)
[490.830060] [165/165] (603s left) kms_pipe_crc_basic (suspend-read-crc)
[491.003290] Starting subtest: suspend-read-crc
[491.004368] Starting dynamic subtest: pipe-A-HDMI-A-2
[510.159439] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.998s)
[510.185350] Starting dynamic subtest: pipe-B-HDMI-A-2
[530.028660] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.347s)
[530.050943] Starting dynamic subtest: pipe-C-HDMI-A-2
[549.454855] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (3.707s)
[549.456881] Subtest suspend-read-crc: SUCCESS (8.066s)
[554.504863] Closing watchdogs
Done.