[40.505981] Initializing watchdogs
[40.506287]   /dev/watchdog0
[40.538987] [001/165] (960s left) i915_module_load (load)
[40.723576] Starting subtest: load
[42.320276] Subtest load: SUCCESS (1.606s)
[42.406660] [002/165] (958s left) core_auth (basic-auth)
[42.625082] Starting subtest: basic-auth
[42.646805] Subtest basic-auth: SUCCESS (0.001s)
[42.722657] [003/165] (958s left) debugfs_test (read_all_entries)
[42.907751] Starting subtest: read_all_entries
[42.950129] Subtest read_all_entries: SUCCESS (0.060s)
[43.051636] [004/165] (958s left) debugfs_test (basic-hwmon)
[43.219089] Starting subtest: basic-hwmon
[43.262722] Subtest basic-hwmon: SKIP (0.000s)
[43.342249] [005/165] (957s left) fbdev (eof)
[43.506582] Starting subtest: eof
[43.528522] Subtest eof: SUCCESS (0.001s)
[43.625601] [006/165] (957s left) fbdev (info)
[43.784688] Starting subtest: info
[43.803968] Subtest info: SUCCESS (0.000s)
[43.922763] [007/165] (957s left) fbdev (nullptr)
[44.116822] Starting subtest: nullptr
[44.138335] Subtest nullptr: SUCCESS (0.000s)
[44.237577] [008/165] (957s left) fbdev (read)
[44.398995] Starting subtest: read
[44.660668] Subtest read: SUCCESS (0.275s)
[44.751280] [009/165] (956s left) fbdev (write)
[44.885376] Starting subtest: write
[44.996598] Subtest write: SUCCESS (0.128s)
[45.096177] [010/165] (956s left) gem_basic (bad-close)
[45.264380] Starting subtest: bad-close
[45.308232] Subtest bad-close: SUCCESS (0.000s)
[45.387134] [011/165] (956s left) gem_basic (create-close)
[45.561728] Starting subtest: create-close
[45.601776] Subtest create-close: SUCCESS (0.000s)
[45.677506] [012/165] (956s left) gem_basic (create-fd-close)
[45.856880] Starting subtest: create-fd-close
[45.894694] Subtest create-fd-close: SUCCESS (0.000s)
[45.979428] [013/165] (955s left) gem_busy (busy@all-engines)
[46.143650] Starting subtest: busy
[46.166089] Starting dynamic subtest: all-engines
[46.187864] Dynamic subtest all-engines: SUCCESS (0.033s)
[46.209109] Subtest busy: SUCCESS (0.033s)
[46.525917] [014/165] (955s left) gem_close_race (basic-process)
[46.744198] Starting subtest: basic-process
[46.765855] Subtest basic-process: SUCCESS (0.056s)
[46.975837] [015/165] (955s left) gem_close_race (basic-threads)
[47.186507] Starting subtest: basic-threads
[48.388942] Subtest basic-threads: SUCCESS (1.237s)
[48.610845] [016/165] (953s left) gem_ctx_create (basic)
[48.828058] Starting subtest: basic
[48.855489] Subtest basic: SUCCESS (0.000s)
[49.032547] [017/165] (953s left) gem_ctx_create (basic-files)
[49.222142] Starting subtest: basic-files
[51.232119] Subtest basic-files: SUCCESS (2.021s)
[51.490072] [018/165] (950s left) gem_ctx_exec (basic)
[51.674149] Starting subtest: basic
[51.695388] Subtest basic: SUCCESS (0.002s)
[51.772359] [019/165] (950s left) gem_exec_basic (basic)
[51.960503] Starting subtest: basic
[51.979606] Starting dynamic subtest: rcs0-smem
[51.998775] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[52.028134] Starting dynamic subtest: vcs0-smem
[52.046943] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[52.068830] Subtest basic: SUCCESS (0.001s)
[52.151962] [020/165] (950s left) gem_exec_create (basic)
[52.331445] Starting subtest: basic
[52.351241] Starting dynamic subtest: smem
[54.353839] Dynamic subtest smem: SUCCESS (2.043s)
[54.373918] Subtest basic: SUCCESS (2.043s)
[54.573405] [021/165] (947s left) gem_exec_fence (basic-busy)
[54.862360] Starting subtest: basic-busy
[54.881305] Starting dynamic subtest: rcs0
[54.922245] Dynamic subtest rcs0: SUCCESS (0.024s)
[54.956953] Starting dynamic subtest: vcs0
[54.999552] Dynamic subtest vcs0: SUCCESS (0.020s)
[55.020198] Subtest basic-busy: SUCCESS (0.045s)
[55.487839] [022/165] (947s left) gem_exec_fence (basic-wait)
[55.792225] Starting subtest: basic-wait
[55.814258] Starting dynamic subtest: rcs0
[55.835239] Dynamic subtest rcs0: SUCCESS (0.025s)
[55.862206] Starting dynamic subtest: vcs0
[55.882170] Dynamic subtest vcs0: SUCCESS (0.018s)
[55.901570] Subtest basic-wait: SUCCESS (0.043s)
[56.353441] [023/165] (946s left) gem_exec_fence (basic-await)
[56.657976] Starting subtest: basic-await
[56.678826] Starting dynamic subtest: rcs0
[56.727091] Dynamic subtest rcs0: SUCCESS (0.071s)
[56.753856] Starting dynamic subtest: vcs0
[56.801698] Dynamic subtest vcs0: SUCCESS (0.074s)
[56.823322] Subtest basic-await: SUCCESS (0.146s)
[57.324128] [024/165] (945s left) gem_exec_fence (nb-await)
[57.633320] Starting subtest: nb-await
[57.652557] Starting dynamic subtest: rcs0
[57.691819] Dynamic subtest rcs0: SUCCESS (0.054s)
[57.720425] Starting dynamic subtest: vcs0
[57.742565] Dynamic subtest vcs0: SUCCESS (0.053s)
[57.764484] Subtest nb-await: SUCCESS (0.108s)
[58.266939] [025/165] (944s left) gem_exec_gttfill (basic)
[58.481919] Starting subtest: basic
[68.090835] Subtest basic: SUCCESS (9.648s)
[68.310607] [026/165] (934s left) gem_exec_parallel (engines)
[68.604017] Starting subtest: engines
[68.622324] Starting dynamic subtest: basic
[70.225183] Dynamic subtest basic: SUCCESS (1.643s)
[70.255339] Starting dynamic subtest: contexts
[72.095904] Dynamic subtest contexts: SUCCESS (1.873s)
[72.122896] Starting dynamic subtest: fds
[72.159901] Dynamic subtest fds: SKIP (0.001s)
[72.186507] Starting dynamic subtest: userptr
[73.706839] Dynamic subtest userptr: SUCCESS (1.605s)
[73.727069] Subtest engines: SUCCESS (5.123s)
[73.914105] [027/165] (929s left) gem_exec_store (basic)
[74.173521] Starting subtest: basic
[74.195273] Subtest basic: SUCCESS (0.036s)
[74.344351] [028/165] (928s left) gem_flink_basic (bad-flink)
[74.516962] Starting subtest: bad-flink
[74.537565] Subtest bad-flink: SUCCESS (0.000s)
[74.621026] [029/165] (928s left) gem_flink_basic (bad-open)
[74.773788] Starting subtest: bad-open
[74.795706] Subtest bad-open: SUCCESS (0.000s)
[74.877699] [030/165] (928s left) gem_flink_basic (basic)
[75.056574] Starting subtest: basic
[75.077393] Subtest basic: SUCCESS (0.000s)
[75.163971] [031/165] (928s left) gem_flink_basic (double-flink)
[75.357549] Starting subtest: double-flink
[75.376710] Subtest double-flink: SUCCESS (0.000s)
[75.465174] [032/165] (927s left) gem_flink_basic (flink-lifetime)
[75.653868] Starting subtest: flink-lifetime
[75.675132] Subtest flink-lifetime: SUCCESS (0.003s)
[75.756545] [033/165] (927s left) gem_huc_copy (huc-copy)
[75.961291] Subtest huc-copy: SKIP (0.000s)
[76.038553] [034/165] (927s left) gem_linear_blits (basic)
[76.271149] Starting subtest: basic
[76.290417] Subtest basic: SUCCESS (0.023s)
[76.437979] [035/165] (927s left) gem_mmap (basic)
[76.752070] Starting subtest: basic
[76.850291] Subtest basic: SUCCESS (0.000s)
[76.935060] [036/165] (926s left) gem_mmap_gtt (basic)
[77.145353] Starting subtest: basic
[77.166608] Subtest basic: SUCCESS (0.001s)
[77.244782] [037/165] (926s left) gem_render_linear_blits (basic)
[77.423614] Starting subtest: basic
[77.522391] Subtest basic: SUCCESS (0.034s)
[77.605569] [038/165] (926s left) gem_render_tiled_blits (basic)
[77.779041] Starting subtest: basic
[77.898891] Subtest basic: SUCCESS (0.040s)
[77.982349] [039/165] (925s left) gem_ringfill (basic-all)
[78.220361] Starting subtest: basic-all
[79.301538] Subtest basic-all: SUCCESS (1.116s)
[79.411875] [040/165] (924s left) gem_softpin (allocator-basic)
[79.610457] Subtest allocator-basic: SKIP (0.000s)
[79.715411] [041/165] (924s left) gem_softpin (allocator-basic-reserve)
[79.913221] Subtest allocator-basic-reserve: SKIP (0.000s)
[80.009971] [042/165] (924s left) gem_softpin (safe-alignment)
[80.235229] Starting subtest: safe-alignment
[80.254880] Subtest safe-alignment: SUCCESS (0.008s)
[80.335378] [043/165] (923s left) gem_sync (basic-all)
[80.611627] Starting subtest: basic-all
[82.621540] Subtest basic-all: SUCCESS (2.097s)
[82.836400] [044/165] (921s left) gem_sync (basic-each)
[83.066209] Starting subtest: basic-each
[85.122390] Subtest basic-each: SUCCESS (2.111s)
[85.349755] [045/165] (919s left) gem_tiled_blits (basic)
[85.596167] Starting subtest: basic
[85.636430] Subtest basic: SUCCESS (0.034s)
[85.783568] [046/165] (918s left) gem_tiled_fence_blits (basic)
[86.167098] Starting subtest: basic
[86.189093] Subtest basic: SUCCESS (0.018s)
[86.334082] [047/165] (918s left) gem_tiled_pread_basic
[86.937192] [048/165] (917s left) gem_wait (busy@all-engines)
[87.094116] Starting subtest: busy
[87.117746] Starting dynamic subtest: all-engines
[87.613764] Dynamic subtest all-engines: SUCCESS (0.519s)
[87.633757] Subtest busy: SUCCESS (0.519s)
[87.872728] [049/165] (916s left) gem_wait (wait@all-engines)
[88.044349] Starting subtest: wait
[88.066179] Starting dynamic subtest: all-engines
[89.062441] Dynamic subtest all-engines: SUCCESS (1.020s)
[89.082153] Subtest wait: SUCCESS (1.020s)
[89.322920] [050/165] (915s left) i915_getparams_basic (basic-eu-total)
[89.513537] Starting subtest: basic-eu-total
[89.555552] Subtest basic-eu-total: SUCCESS (0.000s)
[89.640912] [051/165] (915s left) i915_getparams_basic (basic-subslice-total)
[89.821487] Starting subtest: basic-subslice-total
[89.861778] Subtest basic-subslice-total: SUCCESS (0.000s)
[89.947608] [052/165] (914s left) i915_hangman (error-state-basic)
[90.132934] Starting subtest: error-state-basic
[90.160697] Subtest error-state-basic: SUCCESS (0.004s)
[90.260412] [053/165] (914s left) i915_pciid
[90.552057] [054/165] (914s left) kms_addfb_basic (addfb25-4-tiled)
[90.787266] Starting subtest: addfb25-4-tiled
[90.809183] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[90.906761] [055/165] (914s left) kms_addfb_basic (addfb25-bad-modifier)
[91.089523] Starting subtest: addfb25-bad-modifier
[91.111056] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[91.192694] [056/165] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[91.366415] Starting subtest: addfb25-framebuffer-vs-set-tiling
[91.385995] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[91.467125] [057/165] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[91.640070] Starting subtest: addfb25-modifier-no-flag
[91.660148] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[91.759185] [058/165] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[91.939082] Starting subtest: addfb25-x-tiled-legacy
[91.961220] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[92.047643] [059/165] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[92.232875] Starting subtest: addfb25-x-tiled-mismatch-legacy
[92.253954] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[92.332242] [060/165] (913s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[92.512972] Starting subtest: addfb25-yf-tiled-legacy
[92.532893] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[92.617074] [061/165] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[92.801506] Starting subtest: addfb25-y-tiled-legacy
[92.823878] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[92.908958] [062/165] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.095232] Starting subtest: addfb25-y-tiled-small-legacy
[93.136177] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[93.219406] [063/165] (912s left) kms_addfb_basic (bad-pitch-0)
[93.404566] Starting subtest: bad-pitch-0
[93.424400] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.509372] [064/165] (912s left) kms_addfb_basic (bad-pitch-1024)
[93.687204] Starting subtest: bad-pitch-1024
[93.709161] Subtest bad-pitch-1024: SUCCESS (0.000s)
[93.793336] [065/165] (912s left) kms_addfb_basic (bad-pitch-128)
[93.981565] Starting subtest: bad-pitch-128
[94.003294] Subtest bad-pitch-128: SUCCESS (0.000s)
[94.083871] [066/165] (911s left) kms_addfb_basic (bad-pitch-256)
[94.284172] Starting subtest: bad-pitch-256
[94.304615] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.388359] [067/165] (911s left) kms_addfb_basic (bad-pitch-32)
[94.568241] Starting subtest: bad-pitch-32
[94.588508] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.673491] [068/165] (911s left) kms_addfb_basic (bad-pitch-63)
[94.849182] Starting subtest: bad-pitch-63
[94.871332] Subtest bad-pitch-63: SUCCESS (0.000s)
[94.960164] [069/165] (911s left) kms_addfb_basic (bad-pitch-65536)
[95.139464] Starting subtest: bad-pitch-65536
[95.161074] Subtest bad-pitch-65536: SUCCESS (0.000s)
[95.241150] [070/165] (911s left) kms_addfb_basic (bad-pitch-999)
[95.429511] Starting subtest: bad-pitch-999
[95.449325] Subtest bad-pitch-999: SUCCESS (0.000s)
[95.531855] [071/165] (910s left) kms_addfb_basic (basic)
[95.722681] Starting subtest: basic
[95.745077] Subtest basic: SUCCESS (0.000s)
[95.832301] [072/165] (910s left) kms_addfb_basic (basic-x-tiled-legacy)
[96.029156] Starting subtest: basic-x-tiled-legacy
[96.049822] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[96.132837] [073/165] (910s left) kms_addfb_basic (basic-y-tiled-legacy)
[96.328997] Starting subtest: basic-y-tiled-legacy
[96.349499] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[96.433498] [074/165] (910s left) kms_addfb_basic (bo-too-small)
[96.617333] Starting subtest: bo-too-small
[96.639141] Subtest bo-too-small: SUCCESS (0.000s)
[96.726431] [075/165] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[96.907587] Starting subtest: bo-too-small-due-to-tiling
[96.929653] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[97.011697] [076/165] (909s left) kms_addfb_basic (clobberred-modifier)
[97.196059] Starting subtest: clobberred-modifier
[97.215599] Subtest clobberred-modifier: SUCCESS (0.000s)
[97.299428] [077/165] (909s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[97.465134] Starting subtest: framebuffer-vs-set-tiling
[97.484946] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[97.570596] [078/165] (909s left) kms_addfb_basic (invalid-get-prop)
[97.749398] Starting subtest: invalid-get-prop
[97.771699] Subtest invalid-get-prop: SUCCESS (0.000s)
[97.854342] [079/165] (909s left) kms_addfb_basic (invalid-get-prop-any)
[98.037634] Starting subtest: invalid-get-prop-any
[98.058245] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[98.136145] [080/165] (908s left) kms_addfb_basic (invalid-set-prop)
[98.328900] Starting subtest: invalid-set-prop
[98.348602] Subtest invalid-set-prop: SUCCESS (0.000s)
[98.430749] [081/165] (908s left) kms_addfb_basic (invalid-set-prop-any)
[98.628621] Starting subtest: invalid-set-prop-any
[98.649313] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[98.734465] [082/165] (908s left) kms_addfb_basic (no-handle)
[98.934273] Starting subtest: no-handle
[98.954930] Subtest no-handle: SUCCESS (0.000s)
[99.037204] [083/165] (908s left) kms_addfb_basic (size-max)
[99.226474] Starting subtest: size-max
[99.245833] Subtest size-max: SUCCESS (0.000s)
[99.338752] [084/165] (908s left) kms_addfb_basic (small-bo)
[99.524982] Starting subtest: small-bo
[99.545432] Subtest small-bo: SUCCESS (0.000s)
[99.636283] [085/165] (907s left) kms_addfb_basic (tile-pitch-mismatch)
[99.809126] Starting subtest: tile-pitch-mismatch
[99.830543] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[99.920314] [086/165] (907s left) kms_addfb_basic (too-high)
[100.102923] Starting subtest: too-high
[100.122990] Subtest too-high: SUCCESS (0.001s)
[100.206606] [087/165] (907s left) kms_addfb_basic (too-wide)
[100.375985] Starting subtest: too-wide
[100.395423] Subtest too-wide: SUCCESS (0.000s)
[100.476247] [088/165] (907s left) kms_addfb_basic (unused-handle)
[100.711624] Starting subtest: unused-handle
[100.737284] Subtest unused-handle: SUCCESS (0.000s)
[100.831745] [089/165] (906s left) kms_addfb_basic (unused-modifier)
[101.202334] Starting subtest: unused-modifier
[101.229584] Subtest unused-modifier: SUCCESS (0.000s)
[101.334532] [090/165] (906s left) kms_addfb_basic (unused-offsets)
[101.546548] Starting subtest: unused-offsets
[101.571410] Subtest unused-offsets: SUCCESS (0.000s)
[101.678948] [091/165] (906s left) kms_addfb_basic (unused-pitches)
[101.873483] Starting subtest: unused-pitches
[101.900293] Subtest unused-pitches: SUCCESS (0.000s)
[102.005226] [092/165] (906s left) kms_busy (basic)
[102.210192] Starting subtest: basic
[102.236380] Starting dynamic subtest: flip
[102.990550] Dynamic subtest flip: SUCCESS (0.796s)
[103.020100] Starting dynamic subtest: modeset
[103.606259] Dynamic subtest modeset: SUCCESS (0.621s)
[103.627883] Subtest basic: SUCCESS (1.419s)
[103.796937] [093/165] (904s left) kms_prop_blob (basic)
[103.989968] Starting subtest: basic
[104.011206] Subtest basic: SUCCESS (0.000s)
[104.106260] [094/165] (904s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[104.310601] Starting subtest: basic-busy-flip-before-cursor-atomic
[105.265124] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.967s)
[105.442631] [095/165] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[105.634752] Starting subtest: basic-busy-flip-before-cursor-legacy
[106.594267] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.962s)
[106.758906] [096/165] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[106.941142] Starting subtest: basic-flip-after-cursor-atomic
[107.920306] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.974s)
[108.088328] [097/165] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[108.270415] Starting subtest: basic-flip-after-cursor-legacy
[109.261457] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.988s)
[109.434646] [098/165] (899s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[109.607685] Starting subtest: basic-flip-after-cursor-varying-size
[110.586063] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.979s)
[110.763064] [099/165] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[110.943029] Starting subtest: basic-flip-before-cursor-atomic
[111.925145] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.998s)
[112.108940] [100/165] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[112.299359] Starting subtest: basic-flip-before-cursor-legacy
[113.318269] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.008s)
[113.476227] [101/165] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[113.659346] Starting subtest: basic-flip-before-cursor-varying-size
[114.633129] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.971s)
[114.797205] [102/165] (893s left) kms_dsc (dsc-basic)
[115.014313] Subtest dsc-basic: SKIP (0.000s)
[115.105544] [103/165] (893s left) kms_flip (basic-flip-vs-dpms)
[115.334136] Starting subtest: basic-flip-vs-dpms
[115.354808] Starting dynamic subtest: A-VGA1
[116.576259] Dynamic subtest A-VGA1: SUCCESS (1.278s)
[116.615854] Starting dynamic subtest: B-VGA1
[117.824675] Dynamic subtest B-VGA1: SUCCESS (1.251s)
[117.846206] Subtest basic-flip-vs-dpms: SUCCESS (2.531s)
[118.021348] [104/165] (890s left) kms_flip (basic-flip-vs-modeset)
[118.234051] Starting subtest: basic-flip-vs-modeset
[118.254134] Starting dynamic subtest: A-VGA1
[119.465945] Dynamic subtest A-VGA1: SUCCESS (1.252s)
[119.495717] Starting dynamic subtest: B-VGA1
[120.645439] Dynamic subtest B-VGA1: SUCCESS (1.172s)
[120.667636] Subtest basic-flip-vs-modeset: SUCCESS (2.428s)
[120.821228] [105/165] (888s left) kms_flip (basic-flip-vs-wf_vblank)
[121.050175] Starting subtest: basic-flip-vs-wf_vblank
[121.072186] Starting dynamic subtest: A-VGA1
[122.541907] Dynamic subtest A-VGA1: SUCCESS (1.541s)
[122.569843] Starting dynamic subtest: B-VGA1
[124.037061] Dynamic subtest B-VGA1: SUCCESS (1.496s)
[124.058026] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.041s)
[124.276998] [106/165] (884s left) kms_flip (basic-plain-flip)
[124.518603] Starting subtest: basic-plain-flip
[124.543312] Starting dynamic subtest: A-VGA1
[125.718692] Dynamic subtest A-VGA1: SUCCESS (1.253s)
[125.749360] Starting dynamic subtest: B-VGA1
[126.938824] Dynamic subtest B-VGA1: SUCCESS (1.215s)
[126.962855] Subtest basic-plain-flip: SUCCESS (2.474s)
[127.169031] [107/165] (882s left) kms_force_connector_basic (force-connector-state)
[127.392339] Starting subtest: force-connector-state
[127.442747] Subtest force-connector-state: SUCCESS (0.107s)
[127.666530] [108/165] (881s left) kms_force_connector_basic (force-edid)
[127.875155] Starting subtest: force-edid
[127.899519] Subtest force-edid: SUCCESS (0.026s)
[127.989793] [109/165] (881s left) kms_force_connector_basic (force-load-detect)
[128.183515] Starting subtest: force-load-detect
[128.320853] Subtest force-load-detect: SUCCESS (0.166s)
[128.524058] [110/165] (880s left) kms_force_connector_basic (prune-stale-modes)
[128.728759] Starting subtest: prune-stale-modes
[128.750322] Subtest prune-stale-modes: SUCCESS (0.021s)
[128.837644] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[129.086842] Starting subtest: basic
[131.282369] Subtest basic: SUCCESS (2.263s)
[131.412746] [112/165] (878s left) kms_hdmi_inject (inject-audio)
[131.624385] Starting subtest: inject-audio
[131.811318] Subtest inject-audio: SUCCESS (0.160s)
[132.046301] [113/165] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[132.246257] Starting subtest: compare-crc-sanitycheck-xr24
[132.266160] Starting dynamic subtest: pipe-A-VGA-1
[132.557183] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.313s)
[132.587141] Starting dynamic subtest: pipe-B-VGA-1
[132.877816] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.333s)
[132.897085] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.649s)
[133.076713] [114/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[133.259167] Starting subtest: compare-crc-sanitycheck-nv12
[133.280683] Starting dynamic subtest: pipe-A-VGA-1
[133.319973] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[133.350391] Starting dynamic subtest: pipe-B-VGA-1
[133.393723] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[133.437690] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[133.527283] [115/165] (876s left) kms_pipe_crc_basic (hang-read-crc)
[133.721089] Starting subtest: hang-read-crc
[133.741176] Starting dynamic subtest: pipe-A-VGA-1
[134.598993] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.874s)
[134.626665] Starting dynamic subtest: pipe-B-VGA-1
[135.454704] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.854s)
[135.474372] Subtest hang-read-crc: SUCCESS (1.732s)
[135.604540] [116/165] (874s left) kms_pipe_crc_basic (nonblocking-crc)
[135.811972] Starting subtest: nonblocking-crc
[135.834301] Starting dynamic subtest: pipe-A-VGA-1
[136.287284] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.494s)
[136.315903] Starting dynamic subtest: pipe-B-VGA-1
[136.818308] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.526s)
[136.838853] Subtest nonblocking-crc: SUCCESS (1.022s)
[136.974380] [117/165] (872s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[137.159031] Starting subtest: nonblocking-crc-frame-sequence
[137.181587] Starting dynamic subtest: pipe-A-VGA-1
[137.644178] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.483s)
[137.671788] Starting dynamic subtest: pipe-B-VGA-1
[138.159775] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.514s)
[138.181809] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.001s)
[138.316603] [118/165] (871s left) kms_pipe_crc_basic (read-crc)
[138.502795] Starting subtest: read-crc
[138.522565] Starting dynamic subtest: pipe-A-VGA-1
[138.942448] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.432s)
[138.971261] Starting dynamic subtest: pipe-B-VGA-1
[139.376153] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.439s)
[139.395481] Subtest read-crc: SUCCESS (0.875s)
[139.535559] [119/165] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[139.724728] Starting subtest: read-crc-frame-sequence
[139.746772] Starting dynamic subtest: pipe-A-VGA-1
[140.132096] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.406s)
[140.158847] Starting dynamic subtest: pipe-B-VGA-1
[140.546528] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.425s)
[140.568329] Subtest read-crc-frame-sequence: SUCCESS (0.833s)
[140.705725] [120/165] (869s left) kms_pm_backlight (basic-brightness)
[140.917792] Subtest basic-brightness: SKIP (0.000s)
[141.000924] [121/165] (869s left) kms_pm_rpm (basic-pci-d3-state)
[142.607394] Subtest basic-pci-d3-state: SKIP (0.000s)
[142.687548] [122/165] (867s left) kms_pm_rpm (basic-rte)
[142.853109] Starting subtest: basic-rte
[144.507312] Subtest basic-rte: SKIP (1.591s)
[144.630169] [123/165] (865s left) kms_psr (psr-primary-page-flip)
[144.836274] Subtest psr-primary-page-flip: SKIP (0.000s)
[144.924384] [124/165] (865s left) kms_psr (psr-cursor-plane-move)
[145.144754] Subtest psr-cursor-plane-move: SKIP (0.000s)
[145.228901] [125/165] (865s left) kms_psr (psr-sprite-plane-onoff)
[145.445529] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[145.526256] [126/165] (865s left) kms_psr (psr-primary-mmap-gtt)
[145.730093] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[145.814034] [127/165] (864s left) kms_setmode (basic-clone-single-crtc)
[146.037385] Starting subtest: basic-clone-single-crtc
[146.101755] Subtest basic-clone-single-crtc: SKIP (0.000s)
[146.183934] [128/165] (864s left) i915_pm_rps (basic-api)
[146.417537] Subtest basic-api: SKIP (0.000s)
[146.526227] [129/165] (864s left) prime_self_import (basic-llseek-bad)
[146.705278] Starting subtest: basic-llseek-bad
[146.757661] Subtest basic-llseek-bad: SUCCESS (0.002s)
[146.867762] [130/165] (864s left) prime_self_import (basic-llseek-size)
[147.070294] Starting subtest: basic-llseek-size
[147.124473] Subtest basic-llseek-size: SUCCESS (0.003s)
[147.214953] [131/165] (863s left) prime_self_import (basic-with_fd_dup)
[147.396216] Starting subtest: basic-with_fd_dup
[147.444157] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[147.533959] [132/165] (863s left) prime_self_import (basic-with_one_bo)
[147.681332] Starting subtest: basic-with_one_bo
[147.722656] Subtest basic-with_one_bo: SUCCESS (0.007s)
[147.810581] [133/165] (863s left) prime_self_import (basic-with_one_bo_two_files)
[147.956226] Starting subtest: basic-with_one_bo_two_files
[148.005131] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[148.084575] [134/165] (863s left) prime_self_import (basic-with_two_bos)
[148.251726] Starting subtest: basic-with_two_bos
[148.293353] Subtest basic-with_two_bos: SUCCESS (0.006s)
[148.376376] [135/165] (863s left) prime_vgem (basic-fence-flip)
[148.607147] Starting subtest: basic-fence-flip
[148.933401] Subtest basic-fence-flip: SUCCESS (0.380s)
[149.069152] [136/165] (862s left) prime_vgem (basic-fence-mmap)
[149.277923] Starting subtest: basic-fence-mmap
[149.301215] Subtest basic-fence-mmap: SUCCESS (0.051s)
[149.410862] [137/165] (862s left) prime_vgem (basic-fence-read)
[149.612752] Starting subtest: basic-fence-read
[149.653916] Subtest basic-fence-read: SUCCESS (0.076s)
[149.758117] [138/165] (861s left) prime_vgem (basic-gtt)
[149.985886] Starting subtest: basic-gtt
[150.007948] Subtest basic-gtt: SUCCESS (0.026s)
[150.110985] [139/165] (861s left) prime_vgem (basic-read)
[150.325350] Starting subtest: basic-read
[150.345114] Subtest basic-read: SUCCESS (0.032s)
[150.451859] [140/165] (861s left) prime_vgem (basic-write)
[150.644481] Starting subtest: basic-write
[150.672018] Subtest basic-write: SUCCESS (0.037s)
[150.782707] [141/165] (861s left) vgem_basic (setversion)
[150.979901] Starting subtest: setversion
[151.020800] Subtest setversion: SUCCESS (0.000s)
[151.108686] [142/165] (860s left) vgem_basic (create)
[151.319552] Starting subtest: create
[151.341281] Subtest create: SUCCESS (0.000s)
[151.422791] [143/165] (860s left) vgem_basic (debugfs)
[151.604390] Starting subtest: debugfs
[151.624512] Subtest debugfs: SUCCESS (0.001s)
[151.706714] [144/165] (860s left) vgem_basic (dmabuf-export)
[151.899923] Starting subtest: dmabuf-export
[151.942912] Subtest dmabuf-export: SUCCESS (0.004s)
[152.030556] [145/165] (860s left) vgem_basic (dmabuf-fence)
[152.241917] Starting subtest: dmabuf-fence
[152.263058] Subtest dmabuf-fence: SUCCESS (0.001s)
[152.344136] [146/165] (860s left) vgem_basic (dmabuf-fence-before)
[152.530705] Starting subtest: dmabuf-fence-before
[152.550445] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[152.636879] [147/165] (859s left) vgem_basic (dmabuf-mmap)
[152.827687] Starting subtest: dmabuf-mmap
[152.849916] Subtest dmabuf-mmap: SUCCESS (0.035s)
[152.946950] [148/165] (859s left) vgem_basic (mmap)
[153.104902] Starting subtest: mmap
[153.126503] Subtest mmap: SUCCESS (0.023s)
[153.210671] [149/165] (859s left) vgem_basic (second-client)
[153.394951] Starting subtest: second-client
[153.435127] Subtest second-client: SUCCESS (0.033s)
[153.519625] [150/165] (859s left) vgem_basic (sysfs)
[153.692499] Starting subtest: sysfs
[153.712542] Subtest sysfs: SUCCESS (0.001s)
[153.806131] [151/165] (858s left) core_hotunplug (unbind-rebind)
[154.028441] Starting subtest: unbind-rebind
[156.853416] Subtest unbind-rebind: SUCCESS (2.819s)
[156.948843] [152/165] (855s left) vgem_basic (unload)
[157.135352] Starting subtest: unload
[186.328928] Subtest unload: SUCCESS (28.938s)
[186.408764] [153/165] (826s left) i915_module_load (reload)
[186.601156] Starting subtest: reload
[188.563964] Subtest reload: SUCCESS (1.983s)
[188.669302] [154/165] (824s left) gem_lmem_swapping (basic)
[188.892420] Subtest basic: SKIP (0.000s)
[188.973194] [155/165] (824s left) gem_lmem_swapping (parallel-random-engines)
[189.185803] Subtest parallel-random-engines: SKIP (0.000s)
[189.285107] [156/165] (823s left) gem_lmem_swapping (random-engines)
[189.511975] Subtest random-engines: SKIP (0.000s)
[189.592587] [157/165] (823s left) gem_lmem_swapping (verify-random)
[189.818245] Subtest verify-random: SKIP (0.000s)
[189.900175] [158/165] (823s left) i915_pm_rpm (module-reload)
[191.472263] Subtest module-reload: SKIP (0.000s)
[191.552639] [159/165] (821s left) i915_selftest (live)
[192.350931] Starting subtest: live
[192.370077] Starting dynamic subtest: sanitycheck
[193.095619] Dynamic subtest sanitycheck: SUCCESS (0.743s)
[193.124152] Starting dynamic subtest: uncore
[193.736141] Dynamic subtest uncore: SUCCESS (0.638s)
[193.766644] Starting dynamic subtest: workarounds
[194.417845] Dynamic subtest workarounds: SUCCESS (0.679s)
[194.445080] Starting dynamic subtest: gt_engines
[195.088338] Dynamic subtest gt_engines: SUCCESS (0.667s)
[195.114114] Starting dynamic subtest: gt_timelines
[199.775577] Dynamic subtest gt_timelines: SUCCESS (4.680s)
[199.807919] Starting dynamic subtest: gt_contexts
[200.522460] Dynamic subtest gt_contexts: SUCCESS (0.745s)
[200.562076] Starting dynamic subtest: gt_lrc
[201.184593] Dynamic subtest gt_lrc: SUCCESS (0.657s)
[201.221750] Starting dynamic subtest: gt_mocs
[201.842091] Dynamic subtest gt_mocs: SUCCESS (0.655s)
[201.873633] Starting dynamic subtest: gt_pm
[202.950394] Dynamic subtest gt_pm: SUCCESS (1.112s)
[202.981506] Starting dynamic subtest: gt_heartbeat
[203.680359] Dynamic subtest gt_heartbeat: SUCCESS (0.723s)
[203.716087] Starting dynamic subtest: gt_tlb
[204.385199] Dynamic subtest gt_tlb: SUCCESS (0.711s)
[204.413548] Starting dynamic subtest: requests
[208.667066] Dynamic subtest requests: SUCCESS (4.278s)
[208.695624] Starting dynamic subtest: migrate
[209.333588] Dynamic subtest migrate: SUCCESS (0.655s)
[209.365309] Starting dynamic subtest: active
[210.008826] Dynamic subtest active: SUCCESS (0.683s)
[210.041818] Starting dynamic subtest: objects
[212.131354] Dynamic subtest objects: SUCCESS (2.119s)
[212.157251] Starting dynamic subtest: mman
[218.062997] Dynamic subtest mman: SUCCESS (5.925s)
[218.090959] Starting dynamic subtest: dmabuf
[218.833328] Dynamic subtest dmabuf: SUCCESS (0.771s)
[218.865784] Starting dynamic subtest: vma
[219.488617] Dynamic subtest vma: SUCCESS (0.654s)
[219.521222] Starting dynamic subtest: coherency
[221.192481] Dynamic subtest coherency: SUCCESS (1.700s)
[221.220947] Starting dynamic subtest: gtt
[225.219480] Dynamic subtest gtt: SUCCESS (4.021s)
[225.247393] Starting dynamic subtest: gem
[225.980842] Dynamic subtest gem: SUCCESS (0.764s)
[226.011136] Starting dynamic subtest: evict
[226.720251] Dynamic subtest evict: SUCCESS (0.735s)
[226.746206] Starting dynamic subtest: hugepages
[227.456266] Dynamic subtest hugepages: SUCCESS (0.735s)
[227.484788] Starting dynamic subtest: gem_contexts
[231.176666] Dynamic subtest gem_contexts: SUCCESS (3.719s)
[231.203147] Starting dynamic subtest: client
[231.865305] Dynamic subtest client: SUCCESS (0.684s)
[231.892808] Starting dynamic subtest: gem_migrate
[232.563887] Dynamic subtest gem_migrate: SUCCESS (0.698s)
[232.591323] Starting dynamic subtest: reset
[233.384876] Dynamic subtest reset: SUCCESS (0.814s)
[233.416880] Starting dynamic subtest: memory_region
[234.044481] Dynamic subtest memory_region: SUCCESS (0.658s)
[234.072666] Starting dynamic subtest: hangcheck
[236.380676] Dynamic subtest hangcheck: SUCCESS (2.335s)
[236.408942] Starting dynamic subtest: execlists
[237.107102] Dynamic subtest execlists: SUCCESS (0.721s)
[237.141101] Starting dynamic subtest: ring_submission
[237.757077] Dynamic subtest ring_submission: SUCCESS (0.650s)
[237.783504] Starting dynamic subtest: perf
[238.429329] Dynamic subtest perf: SUCCESS (0.667s)
[238.458228] Starting dynamic subtest: slpc
[239.076230] Dynamic subtest slpc: SUCCESS (0.647s)
[239.105343] Starting dynamic subtest: guc
[239.785052] Dynamic subtest guc: SUCCESS (0.704s)
[239.813117] Starting dynamic subtest: guc_multi_lrc
[240.424557] Dynamic subtest guc_multi_lrc: SUCCESS (0.638s)
[240.455876] Starting dynamic subtest: guc_hang
[241.105473] Dynamic subtest guc_hang: SUCCESS (0.676s)
[241.135165] Starting dynamic subtest: late_gt_pm
[241.859287] Dynamic subtest late_gt_pm: SUCCESS (0.754s)
[241.878519] Subtest live: SUCCESS (49.512s)
[241.961093] [160/165] (771s left) dmabuf (all-tests)
[242.158312] Starting subtest: all-tests
[242.179658] Starting dynamic subtest: sanitycheck
[242.238609] Dynamic subtest sanitycheck: SUCCESS (0.084s)
[242.264877] Starting dynamic subtest: dma_fence
[242.423237] Dynamic subtest dma_fence: SUCCESS (0.180s)
[242.449730] Starting dynamic subtest: dma_fence_chain
[257.656099] Dynamic subtest dma_fence_chain: SUCCESS (15.231s)
[257.686622] Starting dynamic subtest: dma_fence_unwrap
[257.725815] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s)
[257.755937] Starting dynamic subtest: dma_resv
[257.803282] Dynamic subtest dma_resv: SUCCESS (0.072s)
[257.824683] Subtest all-tests: SUCCESS (15.646s)
[257.904188] [161/165] (755s left) i915_suspend (basic-s2idle-without-i915)
[258.075481] Starting subtest: basic-s2idle-without-i915
[275.492043] Subtest basic-s2idle-without-i915: SUCCESS (2.211s)
[278.620083] [162/165] (753s left) i915_suspend (basic-s3-without-i915)
[278.784614] Starting subtest: basic-s3-without-i915
[297.504383] Subtest basic-s3-without-i915: SUCCESS (3.708s)
[298.637761] [163/165] (749s left) gem_exec_suspend (basic-s0)
[298.829874] Starting subtest: basic-S0
[298.848006] Starting dynamic subtest: smem
[318.258131] Dynamic subtest smem: SUCCESS (4.674s)
[318.277437] Subtest basic-S0: SUCCESS (4.675s)
[319.487369] [164/165] (744s left) gem_exec_suspend (basic-s3)
[319.689894] Starting subtest: basic-S3
[319.710121] Starting dynamic subtest: smem
[336.717544] Dynamic subtest smem: SUCCESS (3.292s)
[336.738743] Subtest basic-S3: SUCCESS (3.294s)
[340.113098] [165/165] (740s left) kms_pipe_crc_basic (suspend-read-crc)
[340.290645] Starting subtest: suspend-read-crc
[340.311651] Starting dynamic subtest: pipe-A-VGA-1
[359.390533] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.554s)
[359.420135] Starting dynamic subtest: pipe-B-VGA-1
[376.792611] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.591s)
[376.812577] Subtest suspend-read-crc: SUCCESS (6.149s)
[379.930523] Closing watchdogs
Done.