[34.592195] Initializing watchdogs
[34.592413]   /dev/watchdog0
[34.625089] [001/165] (960s left) i915_module_load (load)
[34.788921] Starting subtest: load
[36.342280] Subtest load: SUCCESS (1.533s)
[36.443757] [002/165] (958s left) core_auth (basic-auth)
[36.667792] Starting subtest: basic-auth
[36.689768] Subtest basic-auth: SUCCESS (0.001s)
[36.761318] [003/165] (958s left) debugfs_test (read_all_entries)
[36.936975] Starting subtest: read_all_entries
[36.978446] Subtest read_all_entries: SUCCESS (0.057s)
[37.083169] [004/165] (958s left) debugfs_test (basic-hwmon)
[37.275714] Starting subtest: basic-hwmon
[37.319465] Subtest basic-hwmon: SKIP (0.000s)
[37.399610] [005/165] (958s left) fbdev (eof)
[37.564082] Starting subtest: eof
[37.585082] Subtest eof: SUCCESS (0.001s)
[37.680661] [006/165] (957s left) fbdev (info)
[37.839666] Starting subtest: info
[37.861653] Subtest info: SUCCESS (0.000s)
[37.956126] [007/165] (957s left) fbdev (nullptr)
[38.131665] Starting subtest: nullptr
[38.150228] Subtest nullptr: SUCCESS (0.000s)
[38.244204] [008/165] (957s left) fbdev (read)
[38.392703] Starting subtest: read
[38.659128] Subtest read: SUCCESS (0.274s)
[38.763220] [009/165] (956s left) fbdev (write)
[38.945367] Starting subtest: write
[39.086420] Subtest write: SUCCESS (0.147s)
[39.209316] [010/165] (956s left) gem_basic (bad-close)
[39.408790] Starting subtest: bad-close
[39.455367] Subtest bad-close: SUCCESS (0.000s)
[39.552588] [011/165] (956s left) gem_basic (create-close)
[39.756583] Starting subtest: create-close
[39.812961] Subtest create-close: SUCCESS (0.000s)
[39.916569] [012/165] (956s left) gem_basic (create-fd-close)
[40.146713] Starting subtest: create-fd-close
[40.189447] Subtest create-fd-close: SUCCESS (0.000s)
[40.286511] [013/165] (955s left) gem_busy (busy@all-engines)
[40.492584] Starting subtest: busy
[40.831144] Starting dynamic subtest: all-engines
[40.860937] Dynamic subtest all-engines: SUCCESS (0.034s)
[40.886816] Subtest busy: SUCCESS (0.035s)
[41.005349] [014/165] (955s left) gem_close_race (basic-process)
[41.203173] Starting subtest: basic-process
[41.257225] Subtest basic-process: SUCCESS (0.051s)
[41.454549] [015/165] (954s left) gem_close_race (basic-threads)
[41.649562] Starting subtest: basic-threads
[42.810780] Subtest basic-threads: SUCCESS (1.195s)
[43.039704] [016/165] (953s left) gem_ctx_create (basic)
[43.200196] Starting subtest: basic
[43.221513] Subtest basic: SUCCESS (0.000s)
[43.397104] [017/165] (952s left) gem_ctx_create (basic-files)
[43.585674] Starting subtest: basic-files
[45.606816] Subtest basic-files: SUCCESS (2.020s)
[45.860987] [018/165] (950s left) gem_ctx_exec (basic)
[46.057271] Starting subtest: basic
[46.076067] Subtest basic: SUCCESS (0.001s)
[46.150846] [019/165] (950s left) gem_exec_basic (basic)
[46.347130] Starting subtest: basic
[46.366124] Starting dynamic subtest: rcs0-smem
[46.386396] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[46.420342] Starting dynamic subtest: vcs0-smem
[46.441174] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.462584] Subtest basic: SUCCESS (0.001s)
[46.552411] [020/165] (950s left) gem_exec_create (basic)
[46.740903] Starting subtest: basic
[46.758978] Starting dynamic subtest: smem
[48.800920] Dynamic subtest smem: SUCCESS (2.050s)
[48.822081] Subtest basic: SUCCESS (2.051s)
[48.993907] [021/165] (947s left) gem_exec_fence (basic-busy)
[49.304415] Starting subtest: basic-busy
[49.325496] Starting dynamic subtest: rcs0
[49.366977] Dynamic subtest rcs0: SUCCESS (0.018s)
[49.399824] Starting dynamic subtest: vcs0
[49.438170] Dynamic subtest vcs0: SUCCESS (0.021s)
[49.456960] Subtest basic-busy: SUCCESS (0.039s)
[49.924377] [022/165] (946s left) gem_exec_fence (basic-wait)
[50.219350] Starting subtest: basic-wait
[50.238311] Starting dynamic subtest: rcs0
[50.257550] Dynamic subtest rcs0: SUCCESS (0.022s)
[50.292100] Starting dynamic subtest: vcs0
[50.311333] Dynamic subtest vcs0: SUCCESS (0.022s)
[50.332907] Subtest basic-wait: SUCCESS (0.045s)
[50.798932] [023/165] (946s left) gem_exec_fence (basic-await)
[51.089420] Starting subtest: basic-await
[51.111052] Starting dynamic subtest: rcs0
[51.159735] Dynamic subtest rcs0: SUCCESS (0.070s)
[51.188581] Starting dynamic subtest: vcs0
[51.233898] Dynamic subtest vcs0: SUCCESS (0.071s)
[51.254993] Subtest basic-await: SUCCESS (0.142s)
[51.765304] [024/165] (945s left) gem_exec_fence (nb-await)
[52.061725] Starting subtest: nb-await
[52.080630] Starting dynamic subtest: rcs0
[52.123546] Dynamic subtest rcs0: SUCCESS (0.055s)
[52.160257] Starting dynamic subtest: vcs0
[52.181518] Dynamic subtest vcs0: SUCCESS (0.055s)
[52.200652] Subtest nb-await: SUCCESS (0.111s)
[52.681641] [025/165] (944s left) gem_exec_gttfill (basic)
[52.886911] Starting subtest: basic
[62.618642] Subtest basic: SUCCESS (9.744s)
[62.841065] [026/165] (934s left) gem_exec_parallel (engines)
[63.151985] Starting subtest: engines
[63.172177] Starting dynamic subtest: basic
[64.754330] Dynamic subtest basic: SUCCESS (1.611s)
[64.781962] Starting dynamic subtest: contexts
[66.758946] Dynamic subtest contexts: SUCCESS (2.015s)
[66.789853] Starting dynamic subtest: fds
[66.827875] Dynamic subtest fds: SKIP (0.001s)
[66.855936] Starting dynamic subtest: userptr
[68.402076] Dynamic subtest userptr: SUCCESS (1.625s)
[68.423204] Subtest engines: SUCCESS (5.252s)
[68.624457] [027/165] (928s left) gem_exec_store (basic)
[68.863791] Starting subtest: basic
[68.884564] Subtest basic: SUCCESS (0.041s)
[69.031870] [028/165] (928s left) gem_flink_basic (bad-flink)
[69.217803] Starting subtest: bad-flink
[69.236798] Subtest bad-flink: SUCCESS (0.000s)
[69.325633] [029/165] (928s left) gem_flink_basic (bad-open)
[69.489857] Starting subtest: bad-open
[69.510644] Subtest bad-open: SUCCESS (0.000s)
[69.594456] [030/165] (927s left) gem_flink_basic (basic)
[69.775635] Starting subtest: basic
[69.796107] Subtest basic: SUCCESS (0.000s)
[69.876075] [031/165] (927s left) gem_flink_basic (double-flink)
[70.077488] Starting subtest: double-flink
[70.096407] Subtest double-flink: SUCCESS (0.000s)
[70.176577] [032/165] (927s left) gem_flink_basic (flink-lifetime)
[70.358722] Starting subtest: flink-lifetime
[70.377717] Subtest flink-lifetime: SUCCESS (0.002s)
[70.465682] [033/165] (927s left) gem_huc_copy (huc-copy)
[70.668968] Subtest huc-copy: SKIP (0.000s)
[70.758439] [034/165] (926s left) gem_linear_blits (basic)
[71.012165] Starting subtest: basic
[71.034192] Subtest basic: SUCCESS (0.017s)
[71.230762] [035/165] (926s left) gem_mmap (basic)
[71.611626] Starting subtest: basic
[71.715310] Subtest basic: SUCCESS (0.001s)
[71.793847] [036/165] (926s left) gem_mmap_gtt (basic)
[72.000148] Starting subtest: basic
[72.018970] Subtest basic: SUCCESS (0.002s)
[72.101487] [037/165] (925s left) gem_render_linear_blits (basic)
[72.272885] Starting subtest: basic
[72.379881] Subtest basic: SUCCESS (0.038s)
[72.455083] [038/165] (925s left) gem_render_tiled_blits (basic)
[72.658083] Starting subtest: basic
[72.780731] Subtest basic: SUCCESS (0.041s)
[72.857322] [039/165] (925s left) gem_ringfill (basic-all)
[73.120234] Starting subtest: basic-all
[74.207748] Subtest basic-all: SUCCESS (1.111s)
[74.309942] [040/165] (923s left) gem_softpin (allocator-basic)
[74.521157] Subtest allocator-basic: SKIP (0.000s)
[74.617859] [041/165] (923s left) gem_softpin (allocator-basic-reserve)
[74.809153] Subtest allocator-basic-reserve: SKIP (0.000s)
[74.914152] [042/165] (923s left) gem_softpin (safe-alignment)
[75.138313] Starting subtest: safe-alignment
[75.157274] Subtest safe-alignment: SUCCESS (0.007s)
[75.235631] [043/165] (923s left) gem_sync (basic-all)
[75.467772] Starting subtest: basic-all
[77.774399] Subtest basic-all: SUCCESS (2.169s)
[77.886102] [044/165] (920s left) gem_sync (basic-each)
[78.115429] Starting subtest: basic-each
[80.186896] Subtest basic-each: SUCCESS (2.114s)
[80.393346] [045/165] (918s left) gem_tiled_blits (basic)
[80.687564] Starting subtest: basic
[80.729146] Subtest basic: SUCCESS (0.034s)
[80.899496] [046/165] (917s left) gem_tiled_fence_blits (basic)
[81.293213] Starting subtest: basic
[81.316234] Subtest basic: SUCCESS (0.013s)
[81.454333] [047/165] (917s left) gem_tiled_pread_basic
[82.002078] [048/165] (916s left) gem_wait (busy@all-engines)
[82.162323] Starting subtest: busy
[82.181205] Starting dynamic subtest: all-engines
[82.679784] Dynamic subtest all-engines: SUCCESS (0.513s)
[82.701112] Subtest busy: SUCCESS (0.513s)
[82.925828] [049/165] (916s left) gem_wait (wait@all-engines)
[83.093434] Starting subtest: wait
[83.115312] Starting dynamic subtest: all-engines
[84.121863] Dynamic subtest all-engines: SUCCESS (1.023s)
[84.141138] Subtest wait: SUCCESS (1.024s)
[84.367763] [050/165] (914s left) i915_getparams_basic (basic-eu-total)
[84.548143] Starting subtest: basic-eu-total
[84.591176] Subtest basic-eu-total: SUCCESS (0.000s)
[84.672236] [051/165] (914s left) i915_getparams_basic (basic-subslice-total)
[84.850398] Starting subtest: basic-subslice-total
[84.891253] Subtest basic-subslice-total: SUCCESS (0.000s)
[84.968047] [052/165] (914s left) i915_hangman (error-state-basic)
[85.148212] Starting subtest: error-state-basic
[85.167111] Subtest error-state-basic: SUCCESS (0.004s)
[85.263675] [053/165] (913s left) i915_pciid
[85.557377] [054/165] (913s left) kms_addfb_basic (addfb25-4-tiled)
[85.794400] Starting subtest: addfb25-4-tiled
[85.814527] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[85.898533] [055/165] (913s left) kms_addfb_basic (addfb25-bad-modifier)
[86.075278] Starting subtest: addfb25-bad-modifier
[86.094988] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[86.179555] [056/165] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[86.357576] Starting subtest: addfb25-framebuffer-vs-set-tiling
[86.378309] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[86.465550] [057/165] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[86.656948] Starting subtest: addfb25-modifier-no-flag
[86.678786] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[86.761532] [058/165] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[86.941323] Starting subtest: addfb25-x-tiled-legacy
[86.961987] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[87.041314] [059/165] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[87.229359] Starting subtest: addfb25-x-tiled-mismatch-legacy
[87.248496] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[87.332926] [060/165] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[87.509023] Starting subtest: addfb25-yf-tiled-legacy
[87.530537] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[87.616874] [061/165] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[87.814127] Starting subtest: addfb25-y-tiled-legacy
[87.835101] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[87.921262] [062/165] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[88.109377] Starting subtest: addfb25-y-tiled-small-legacy
[88.146929] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[88.228871] [063/165] (911s left) kms_addfb_basic (bad-pitch-0)
[88.412205] Starting subtest: bad-pitch-0
[88.431303] Subtest bad-pitch-0: SUCCESS (0.000s)
[88.517865] [064/165] (911s left) kms_addfb_basic (bad-pitch-1024)
[88.696085] Starting subtest: bad-pitch-1024
[88.717478] Subtest bad-pitch-1024: SUCCESS (0.000s)
[88.799234] [065/165] (911s left) kms_addfb_basic (bad-pitch-128)
[88.982118] Starting subtest: bad-pitch-128
[89.004880] Subtest bad-pitch-128: SUCCESS (0.000s)
[89.083799] [066/165] (911s left) kms_addfb_basic (bad-pitch-256)
[89.267227] Starting subtest: bad-pitch-256
[89.286570] Subtest bad-pitch-256: SUCCESS (0.000s)
[89.365557] [067/165] (910s left) kms_addfb_basic (bad-pitch-32)
[89.540100] Starting subtest: bad-pitch-32
[89.559164] Subtest bad-pitch-32: SUCCESS (0.000s)
[89.645239] [068/165] (910s left) kms_addfb_basic (bad-pitch-63)
[89.849823] Starting subtest: bad-pitch-63
[89.871122] Subtest bad-pitch-63: SUCCESS (0.000s)
[89.955053] [069/165] (910s left) kms_addfb_basic (bad-pitch-65536)
[90.134121] Starting subtest: bad-pitch-65536
[90.155151] Subtest bad-pitch-65536: SUCCESS (0.000s)
[90.233588] [070/165] (910s left) kms_addfb_basic (bad-pitch-999)
[90.413472] Starting subtest: bad-pitch-999
[90.432743] Subtest bad-pitch-999: SUCCESS (0.000s)
[90.512216] [071/165] (910s left) kms_addfb_basic (basic)
[90.690315] Starting subtest: basic
[90.709443] Subtest basic: SUCCESS (0.000s)
[90.798208] [072/165] (909s left) kms_addfb_basic (basic-x-tiled-legacy)
[90.972731] Starting subtest: basic-x-tiled-legacy
[90.994258] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[91.083491] [073/165] (909s left) kms_addfb_basic (basic-y-tiled-legacy)
[91.266948] Starting subtest: basic-y-tiled-legacy
[91.287997] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[91.364528] [074/165] (909s left) kms_addfb_basic (bo-too-small)
[91.543810] Starting subtest: bo-too-small
[91.562931] Subtest bo-too-small: SUCCESS (0.000s)
[91.646941] [075/165] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[91.812774] Starting subtest: bo-too-small-due-to-tiling
[91.833932] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[91.918131] [076/165] (909s left) kms_addfb_basic (clobberred-modifier)
[92.100040] Starting subtest: clobberred-modifier
[92.120464] Subtest clobberred-modifier: SUCCESS (0.000s)
[92.205080] [077/165] (908s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[92.397424] Starting subtest: framebuffer-vs-set-tiling
[92.417063] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.504587] [078/165] (908s left) kms_addfb_basic (invalid-get-prop)
[92.708223] Starting subtest: invalid-get-prop
[92.733933] Subtest invalid-get-prop: SUCCESS (0.000s)
[92.838386] [079/165] (908s left) kms_addfb_basic (invalid-get-prop-any)
[93.048431] Starting subtest: invalid-get-prop-any
[93.072941] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[93.170629] [080/165] (908s left) kms_addfb_basic (invalid-set-prop)
[93.367048] Starting subtest: invalid-set-prop
[93.392855] Subtest invalid-set-prop: SUCCESS (0.000s)
[93.500341] [081/165] (907s left) kms_addfb_basic (invalid-set-prop-any)
[93.711133] Starting subtest: invalid-set-prop-any
[93.737586] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[93.835533] [082/165] (907s left) kms_addfb_basic (no-handle)
[94.037502] Starting subtest: no-handle
[94.060408] Subtest no-handle: SUCCESS (0.000s)
[94.170113] [083/165] (907s left) kms_addfb_basic (size-max)
[94.365039] Starting subtest: size-max
[94.392518] Subtest size-max: SUCCESS (0.000s)
[94.490588] [084/165] (907s left) kms_addfb_basic (small-bo)
[94.701048] Starting subtest: small-bo
[94.726110] Subtest small-bo: SUCCESS (0.000s)
[94.828587] [085/165] (906s left) kms_addfb_basic (tile-pitch-mismatch)
[95.038443] Starting subtest: tile-pitch-mismatch
[95.057637] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[95.140121] [086/165] (906s left) kms_addfb_basic (too-high)
[95.323446] Starting subtest: too-high
[95.343468] Subtest too-high: SUCCESS (0.001s)
[95.427489] [087/165] (906s left) kms_addfb_basic (too-wide)
[95.622116] Starting subtest: too-wide
[95.642658] Subtest too-wide: SUCCESS (0.000s)
[95.723124] [088/165] (906s left) kms_addfb_basic (unused-handle)
[95.907162] Starting subtest: unused-handle
[95.927192] Subtest unused-handle: SUCCESS (0.000s)
[96.009620] [089/165] (906s left) kms_addfb_basic (unused-modifier)
[96.194113] Starting subtest: unused-modifier
[96.212671] Subtest unused-modifier: SUCCESS (0.000s)
[96.293902] [090/165] (905s left) kms_addfb_basic (unused-offsets)
[96.464054] Starting subtest: unused-offsets
[96.483921] Subtest unused-offsets: SUCCESS (0.000s)
[96.576053] [091/165] (905s left) kms_addfb_basic (unused-pitches)
[96.760131] Starting subtest: unused-pitches
[96.781473] Subtest unused-pitches: SUCCESS (0.000s)
[96.863433] [092/165] (905s left) kms_busy (basic)
[97.041535] Starting subtest: basic
[97.060930] Starting dynamic subtest: flip
[97.793656] Dynamic subtest flip: SUCCESS (0.756s)
[97.821314] Starting dynamic subtest: modeset
[98.418588] Dynamic subtest modeset: SUCCESS (0.624s)
[98.437116] Subtest basic: SUCCESS (1.380s)
[98.602173] [093/165] (903s left) kms_prop_blob (basic)
[98.782552] Starting subtest: basic
[98.803755] Subtest basic: SUCCESS (0.000s)
[98.895257] [094/165] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[99.080548] Starting subtest: basic-busy-flip-before-cursor-atomic
[100.062358] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.977s)
[100.237356] [095/165] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[100.411058] Starting subtest: basic-busy-flip-before-cursor-legacy
[101.413100] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.002s)
[101.593780] [096/165] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[101.800930] Starting subtest: basic-flip-after-cursor-atomic
[102.788105] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.986s)
[102.945183] [097/165] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[103.135727] Starting subtest: basic-flip-after-cursor-legacy
[104.115206] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.974s)
[104.279485] [098/165] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[104.452715] Starting subtest: basic-flip-after-cursor-varying-size
[105.424851] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.969s)
[105.586871] [099/165] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[105.767200] Starting subtest: basic-flip-before-cursor-atomic
[106.734051] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.976s)
[106.900245] [100/165] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[107.079487] Starting subtest: basic-flip-before-cursor-legacy
[108.062116] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.985s)
[108.237101] [101/165] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[108.410331] Starting subtest: basic-flip-before-cursor-varying-size
[109.381977] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.975s)
[109.552045] [102/165] (893s left) kms_dsc (dsc-basic)
[109.751662] Subtest dsc-basic: SKIP (0.000s)
[109.833786] [103/165] (893s left) kms_flip (basic-flip-vs-dpms)
[110.039228] Starting subtest: basic-flip-vs-dpms
[110.060426] Starting dynamic subtest: A-VGA1
[111.342039] Dynamic subtest A-VGA1: SUCCESS (1.321s)
[111.375263] Starting dynamic subtest: B-VGA1
[112.561128] Dynamic subtest B-VGA1: SUCCESS (1.221s)
[112.579247] Subtest basic-flip-vs-dpms: SUCCESS (2.546s)
[112.757766] [104/165] (890s left) kms_flip (basic-flip-vs-modeset)
[112.960260] Starting subtest: basic-flip-vs-modeset
[112.978735] Starting dynamic subtest: A-VGA1
[114.290909] Dynamic subtest A-VGA1: SUCCESS (1.348s)
[114.329181] Starting dynamic subtest: B-VGA1
[115.441483] Dynamic subtest B-VGA1: SUCCESS (1.150s)
[115.462315] Subtest basic-flip-vs-modeset: SUCCESS (2.501s)
[115.611686] [105/165] (887s left) kms_flip (basic-flip-vs-wf_vblank)
[115.838069] Starting subtest: basic-flip-vs-wf_vblank
[115.860101] Starting dynamic subtest: A-VGA1
[117.315456] Dynamic subtest A-VGA1: SUCCESS (1.527s)
[117.346841] Starting dynamic subtest: B-VGA1
[118.818488] Dynamic subtest B-VGA1: SUCCESS (1.502s)
[118.844279] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.032s)
[119.043729] [106/165] (884s left) kms_flip (basic-plain-flip)
[119.273156] Starting subtest: basic-plain-flip
[119.296171] Starting dynamic subtest: A-VGA1
[120.476832] Dynamic subtest A-VGA1: SUCCESS (1.251s)
[120.511018] Starting dynamic subtest: B-VGA1
[121.671596] Dynamic subtest B-VGA1: SUCCESS (1.198s)
[121.695264] Subtest basic-plain-flip: SUCCESS (2.453s)
[121.921997] [107/165] (881s left) kms_force_connector_basic (force-connector-state)
[122.117858] Starting subtest: force-connector-state
[122.228585] Subtest force-connector-state: SUCCESS (0.126s)
[122.443461] [108/165] (881s left) kms_force_connector_basic (force-edid)
[122.630744] Starting subtest: force-edid
[122.651101] Subtest force-edid: SUCCESS (0.016s)
[122.752938] [109/165] (880s left) kms_force_connector_basic (force-load-detect)
[122.939599] Starting subtest: force-load-detect
[123.087555] Subtest force-load-detect: SUCCESS (0.162s)
[123.300492] [110/165] (880s left) kms_force_connector_basic (prune-stale-modes)
[123.487045] Starting subtest: prune-stale-modes
[123.507662] Subtest prune-stale-modes: SUCCESS (0.015s)
[123.624101] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[123.878090] Starting subtest: basic
[126.072104] Subtest basic: SUCCESS (2.259s)
[126.210148] [112/165] (877s left) kms_hdmi_inject (inject-audio)
[126.417803] Starting subtest: inject-audio
[126.607035] Subtest inject-audio: SUCCESS (0.170s)
[126.847807] [113/165] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[127.040382] Starting subtest: compare-crc-sanitycheck-xr24
[127.062131] Starting dynamic subtest: pipe-A-VGA-1
[127.366413] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.318s)
[127.397848] Starting dynamic subtest: pipe-B-VGA-1
[127.711864] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.345s)
[127.730467] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.667s)
[127.887565] [114/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[128.064498] Starting subtest: compare-crc-sanitycheck-nv12
[128.085922] Starting dynamic subtest: pipe-A-VGA-1
[128.127401] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[128.160393] Starting dynamic subtest: pipe-B-VGA-1
[128.198565] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[128.242460] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[128.329269] [115/165] (875s left) kms_pipe_crc_basic (hang-read-crc)
[128.512239] Starting subtest: hang-read-crc
[128.533036] Starting dynamic subtest: pipe-A-VGA-1
[129.395956] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.874s)
[129.425578] Starting dynamic subtest: pipe-B-VGA-1
[130.238427] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.853s)
[130.258633] Subtest hang-read-crc: SUCCESS (1.730s)
[130.392071] [116/165] (873s left) kms_pipe_crc_basic (nonblocking-crc)
[130.579380] Starting subtest: nonblocking-crc
[130.598488] Starting dynamic subtest: pipe-A-VGA-1
[131.056339] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.481s)
[131.086123] Starting dynamic subtest: pipe-B-VGA-1
[131.549652] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.490s)
[131.568030] Subtest nonblocking-crc: SUCCESS (0.973s)
[131.708072] [117/165] (872s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[131.887444] Starting subtest: nonblocking-crc-frame-sequence
[131.908340] Starting dynamic subtest: pipe-A-VGA-1
[132.402669] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.511s)
[132.428646] Starting dynamic subtest: pipe-B-VGA-1
[132.946414] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.541s)
[132.965022] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.057s)
[133.109236] [118/165] (871s left) kms_pipe_crc_basic (read-crc)
[133.279991] Starting subtest: read-crc
[133.301894] Starting dynamic subtest: pipe-A-VGA-1
[133.685036] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.400s)
[133.715255] Starting dynamic subtest: pipe-B-VGA-1
[134.118560] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.433s)
[134.138176] Subtest read-crc: SUCCESS (0.835s)
[134.272650] [119/165] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[134.468970] Starting subtest: read-crc-frame-sequence
[134.488572] Starting dynamic subtest: pipe-A-VGA-1
[134.882977] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.427s)
[134.909510] Starting dynamic subtest: pipe-B-VGA-1
[135.340067] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.455s)
[135.361952] Subtest read-crc-frame-sequence: SUCCESS (0.885s)
[135.515538] [120/165] (868s left) kms_pm_backlight (basic-brightness)
[135.750099] Subtest basic-brightness: SKIP (0.000s)
[135.851702] [121/165] (868s left) kms_pm_rpm (basic-pci-d3-state)
[137.350846] Subtest basic-pci-d3-state: SKIP (0.000s)
[137.429829] [122/165] (867s left) kms_pm_rpm (basic-rte)
[137.593951] Starting subtest: basic-rte
[139.225469] Subtest basic-rte: SKIP (1.572s)
[139.349863] [123/165] (865s left) kms_psr (primary_page_flip)
[139.549192] Subtest primary_page_flip: SKIP (0.000s)
[139.632721] [124/165] (865s left) kms_psr (cursor_plane_move)
[139.822479] Subtest cursor_plane_move: SKIP (0.000s)
[139.902746] [125/165] (865s left) kms_psr (sprite_plane_onoff)
[140.114286] Subtest sprite_plane_onoff: SKIP (0.000s)
[140.195966] [126/165] (864s left) kms_psr (primary_mmap_gtt)
[140.379153] Subtest primary_mmap_gtt: SKIP (0.000s)
[140.460513] [127/165] (864s left) kms_setmode (basic-clone-single-crtc)
[140.651226] Starting subtest: basic-clone-single-crtc
[140.712661] Subtest basic-clone-single-crtc: SKIP (0.000s)
[140.794692] [128/165] (864s left) i915_pm_rps (basic-api)
[140.996437] Subtest basic-api: SKIP (0.000s)
[141.078165] [129/165] (864s left) prime_self_import (basic-llseek-bad)
[141.259726] Starting subtest: basic-llseek-bad
[141.297231] Subtest basic-llseek-bad: SUCCESS (0.004s)
[141.384344] [130/165] (863s left) prime_self_import (basic-llseek-size)
[141.551163] Starting subtest: basic-llseek-size
[141.589448] Subtest basic-llseek-size: SUCCESS (0.006s)
[141.676063] [131/165] (863s left) prime_self_import (basic-with_fd_dup)
[141.805786] Starting subtest: basic-with_fd_dup
[141.845896] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[141.932681] [132/165] (863s left) prime_self_import (basic-with_one_bo)
[142.105063] Starting subtest: basic-with_one_bo
[142.147417] Subtest basic-with_one_bo: SUCCESS (0.003s)
[142.230082] [133/165] (863s left) prime_self_import (basic-with_one_bo_two_files)
[142.401835] Starting subtest: basic-with_one_bo_two_files
[142.442342] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[142.519292] [134/165] (863s left) prime_self_import (basic-with_two_bos)
[142.682129] Starting subtest: basic-with_two_bos
[142.719461] Subtest basic-with_two_bos: SUCCESS (0.010s)
[142.804929] [135/165] (863s left) prime_vgem (basic-fence-flip)
[143.004056] Starting subtest: basic-fence-flip
[143.338714] Subtest basic-fence-flip: SUCCESS (0.378s)
[143.461969] [136/165] (862s left) prime_vgem (basic-fence-mmap)
[143.680180] Starting subtest: basic-fence-mmap
[143.701461] Subtest basic-fence-mmap: SUCCESS (0.051s)
[143.809761] [137/165] (862s left) prime_vgem (basic-fence-read)
[144.007686] Starting subtest: basic-fence-read
[144.046270] Subtest basic-fence-read: SUCCESS (0.076s)
[144.153354] [138/165] (861s left) prime_vgem (basic-gtt)
[144.358661] Starting subtest: basic-gtt
[144.381352] Subtest basic-gtt: SUCCESS (0.026s)
[144.482705] [139/165] (861s left) prime_vgem (basic-read)
[144.685471] Starting subtest: basic-read
[144.704838] Subtest basic-read: SUCCESS (0.035s)
[144.808383] [140/165] (861s left) prime_vgem (basic-write)
[144.987414] Starting subtest: basic-write
[145.008778] Subtest basic-write: SUCCESS (0.036s)
[145.113648] [141/165] (861s left) vgem_basic (setversion)
[145.312390] Starting subtest: setversion
[145.352632] Subtest setversion: SUCCESS (0.000s)
[145.430527] [142/165] (860s left) vgem_basic (create)
[145.630289] Starting subtest: create
[145.649362] Subtest create: SUCCESS (0.001s)
[145.739897] [143/165] (860s left) vgem_basic (debugfs)
[145.937156] Starting subtest: debugfs
[145.958038] Subtest debugfs: SUCCESS (0.001s)
[146.039255] [144/165] (860s left) vgem_basic (dmabuf-export)
[146.225831] Starting subtest: dmabuf-export
[146.263352] Subtest dmabuf-export: SUCCESS (0.003s)
[146.346200] [145/165] (860s left) vgem_basic (dmabuf-fence)
[146.523297] Starting subtest: dmabuf-fence
[146.542306] Subtest dmabuf-fence: SUCCESS (0.001s)
[146.634571] [146/165] (860s left) vgem_basic (dmabuf-fence-before)
[146.810660] Starting subtest: dmabuf-fence-before
[146.831728] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[146.915403] [147/165] (859s left) vgem_basic (dmabuf-mmap)
[147.110553] Starting subtest: dmabuf-mmap
[147.132222] Subtest dmabuf-mmap: SUCCESS (0.030s)
[147.209323] [148/165] (859s left) vgem_basic (mmap)
[147.378710] Starting subtest: mmap
[147.397662] Subtest mmap: SUCCESS (0.021s)
[147.478146] [149/165] (859s left) vgem_basic (second-client)
[147.662928] Starting subtest: second-client
[147.701582] Subtest second-client: SUCCESS (0.034s)
[147.792480] [150/165] (859s left) vgem_basic (sysfs)
[147.950446] Starting subtest: sysfs
[147.971745] Subtest sysfs: SUCCESS (0.001s)
[148.055416] [151/165] (859s left) core_hotunplug (unbind-rebind)
[148.312666] Starting subtest: unbind-rebind
[151.184980] Subtest unbind-rebind: SUCCESS (2.865s)
[151.279758] [152/165] (855s left) vgem_basic (unload)
[151.444547] Starting subtest: unload
[180.575946] Subtest unload: SUCCESS (28.936s)
[180.662187] [153/165] (826s left) i915_module_load (reload)
[180.804770] Starting subtest: reload
[182.780780] Subtest reload: SUCCESS (1.971s)
[182.901741] [154/165] (824s left) gem_lmem_swapping (basic)
[183.104497] Subtest basic: SKIP (0.000s)
[183.190859] [155/165] (824s left) gem_lmem_swapping (parallel-random-engines)
[183.390892] Subtest parallel-random-engines: SKIP (0.000s)
[183.469564] [156/165] (824s left) gem_lmem_swapping (random-engines)
[183.684697] Subtest random-engines: SKIP (0.000s)
[183.765126] [157/165] (823s left) gem_lmem_swapping (verify-random)
[183.987961] Subtest verify-random: SKIP (0.000s)
[184.073796] [158/165] (823s left) i915_pm_rpm (module-reload)
[185.614749] Subtest module-reload: SKIP (0.000s)
[185.717835] [159/165] (822s left) i915_selftest (live)
[186.565578] Starting subtest: live
[186.584512] Starting dynamic subtest: sanitycheck
[187.275289] Dynamic subtest sanitycheck: SUCCESS (0.705s)
[187.303855] Starting dynamic subtest: uncore
[187.963195] Dynamic subtest uncore: SUCCESS (0.687s)
[187.991049] Starting dynamic subtest: workarounds
[188.653809] Dynamic subtest workarounds: SUCCESS (0.686s)
[188.684221] Starting dynamic subtest: gt_engines
[189.303845] Dynamic subtest gt_engines: SUCCESS (0.649s)
[189.331576] Starting dynamic subtest: gt_timelines
[194.145390] Dynamic subtest gt_timelines: SUCCESS (4.836s)
[194.171181] Starting dynamic subtest: gt_contexts
[194.832255] Dynamic subtest gt_contexts: SUCCESS (0.683s)
[194.864081] Starting dynamic subtest: gt_lrc
[195.491032] Dynamic subtest gt_lrc: SUCCESS (0.658s)
[195.516560] Starting dynamic subtest: gt_mocs
[196.158208] Dynamic subtest gt_mocs: SUCCESS (0.663s)
[196.186279] Starting dynamic subtest: gt_pm
[197.375986] Dynamic subtest gt_pm: SUCCESS (1.214s)
[197.400989] Starting dynamic subtest: gt_heartbeat
[198.098624] Dynamic subtest gt_heartbeat: SUCCESS (0.721s)
[198.125108] Starting dynamic subtest: gt_tlb
[198.832685] Dynamic subtest gt_tlb: SUCCESS (0.733s)
[198.861378] Starting dynamic subtest: requests
[203.130895] Dynamic subtest requests: SUCCESS (4.293s)
[203.159941] Starting dynamic subtest: migrate
[203.829794] Dynamic subtest migrate: SUCCESS (0.692s)
[203.860353] Starting dynamic subtest: active
[204.477760] Dynamic subtest active: SUCCESS (0.650s)
[204.504823] Starting dynamic subtest: objects
[206.605302] Dynamic subtest objects: SUCCESS (2.121s)
[206.637357] Starting dynamic subtest: mman
[212.679913] Dynamic subtest mman: SUCCESS (6.068s)
[212.710985] Starting dynamic subtest: dmabuf
[213.438311] Dynamic subtest dmabuf: SUCCESS (0.756s)
[213.466300] Starting dynamic subtest: vma
[214.109275] Dynamic subtest vma: SUCCESS (0.671s)
[214.134886] Starting dynamic subtest: coherency
[215.841103] Dynamic subtest coherency: SUCCESS (1.726s)
[215.868528] Starting dynamic subtest: gtt
[219.953846] Dynamic subtest gtt: SUCCESS (4.105s)
[219.984511] Starting dynamic subtest: gem
[220.808340] Dynamic subtest gem: SUCCESS (0.854s)
[220.837392] Starting dynamic subtest: evict
[221.484081] Dynamic subtest evict: SUCCESS (0.674s)
[221.513792] Starting dynamic subtest: hugepages
[222.154681] Dynamic subtest hugepages: SUCCESS (0.667s)
[222.181974] Starting dynamic subtest: gem_contexts
[225.863262] Dynamic subtest gem_contexts: SUCCESS (3.705s)
[225.890863] Starting dynamic subtest: client
[226.556983] Dynamic subtest client: SUCCESS (0.692s)
[226.582727] Starting dynamic subtest: gem_migrate
[227.229042] Dynamic subtest gem_migrate: SUCCESS (0.668s)
[227.256944] Starting dynamic subtest: reset
[227.990891] Dynamic subtest reset: SUCCESS (0.761s)
[228.016425] Starting dynamic subtest: memory_region
[228.705461] Dynamic subtest memory_region: SUCCESS (0.710s)
[228.738129] Starting dynamic subtest: hangcheck
[230.962760] Dynamic subtest hangcheck: SUCCESS (2.255s)
[230.989471] Starting dynamic subtest: execlists
[231.691901] Dynamic subtest execlists: SUCCESS (0.722s)
[231.718209] Starting dynamic subtest: ring_submission
[232.432949] Dynamic subtest ring_submission: SUCCESS (0.739s)
[232.462777] Starting dynamic subtest: perf
[233.102125] Dynamic subtest perf: SUCCESS (0.665s)
[233.128125] Starting dynamic subtest: slpc
[233.755840] Dynamic subtest slpc: SUCCESS (0.651s)
[233.788525] Starting dynamic subtest: guc
[234.432780] Dynamic subtest guc: SUCCESS (0.659s)
[234.460753] Starting dynamic subtest: guc_multi_lrc
[235.093591] Dynamic subtest guc_multi_lrc: SUCCESS (0.670s)
[235.127367] Starting dynamic subtest: guc_hang
[235.751342] Dynamic subtest guc_hang: SUCCESS (0.657s)
[235.780147] Starting dynamic subtest: late_gt_pm
[236.419123] Dynamic subtest late_gt_pm: SUCCESS (0.660s)
[236.442261] Subtest live: SUCCESS (49.823s)
[236.536826] [160/165] (771s left) dmabuf (all-tests)
[236.703986] Starting subtest: all-tests
[236.727329] Starting dynamic subtest: sanitycheck
[237.050072] Dynamic subtest sanitycheck: SUCCESS (0.082s)
[237.090580] Starting dynamic subtest: dma_fence
[237.116849] Dynamic subtest dma_fence: SUCCESS (0.173s)
[237.154690] Starting dynamic subtest: dma_fence_chain
[252.446595] Dynamic subtest dma_fence_chain: SUCCESS (15.476s)
[252.485152] Starting dynamic subtest: dma_fence_unwrap
[252.538155] Dynamic subtest dma_fence_unwrap: SUCCESS (0.084s)
[252.567264] Starting dynamic subtest: dma_resv
[252.616065] Dynamic subtest dma_resv: SUCCESS (0.078s)
[252.640447] Subtest all-tests: SUCCESS (15.902s)
[252.748807] [161/165] (755s left) i915_suspend (basic-s2idle-without-i915)
[252.941653] Starting subtest: basic-s2idle-without-i915
[270.515794] Subtest basic-s2idle-without-i915: SUCCESS (2.305s)
[273.648770] [162/165] (752s left) i915_suspend (basic-s3-without-i915)
[273.812729] Starting subtest: basic-s3-without-i915
[290.622240] Subtest basic-s3-without-i915: SUCCESS (1.954s)
[299.785043] [163/165] (750s left) gem_exec_suspend (basic-s0)
[299.973835] Starting subtest: basic-S0
[299.994355] Starting dynamic subtest: smem
[317.622035] Dynamic subtest smem: SUCCESS (2.113s)
[317.643832] Subtest basic-S0: SUCCESS (2.114s)
[322.851544] [164/165] (748s left) gem_exec_suspend (basic-s3)
[323.035577] Starting subtest: basic-S3
[323.053515] Starting dynamic subtest: smem
[339.590191] Dynamic subtest smem: SUCCESS (2.044s)
[339.611567] Subtest basic-S3: SUCCESS (2.045s)
[342.816853] [165/165] (746s left) kms_pipe_crc_basic (suspend-read-crc)
[343.043129] Starting subtest: suspend-read-crc
[343.064176] Starting dynamic subtest: pipe-A-VGA-1
[360.579635] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.734s)
[360.609947] Starting dynamic subtest: pipe-B-VGA-1
[377.558017] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.740s)
[377.576552] Subtest suspend-read-crc: SUCCESS (3.481s)
[380.699339] Closing watchdogs
Done.