[29.461462] Initializing watchdogs [29.461503] /dev/watchdog0 [29.468158] [001/165] (960s left) i915_module_load (load) [29.539163] Starting subtest: load [31.473338] Subtest load: SUCCESS (1.933s) [31.496642] [002/165] (958s left) core_auth (basic-auth) [31.551281] Starting subtest: basic-auth [31.552580] Subtest basic-auth: SUCCESS (0.001s) [31.607424] [003/165] (958s left) debugfs_test (read_all_entries) [31.638070] Starting subtest: read_all_entries [31.773831] Subtest read_all_entries: SUCCESS (0.134s) [32.023290] [004/165] (957s left) debugfs_test (basic-hwmon) [32.050558] Starting subtest: basic-hwmon [32.052435] Subtest basic-hwmon: SKIP (0.000s) [32.309215] [005/165] (957s left) fbdev (eof) [32.338607] Starting subtest: eof [32.339316] Subtest eof: SUCCESS (0.000s) [32.388284] [006/165] (957s left) fbdev (info) [32.414426] Starting subtest: info [32.415145] Subtest info: SUCCESS (0.000s) [32.472103] [007/165] (957s left) fbdev (nullptr) [32.505243] Starting subtest: nullptr [32.506184] Subtest nullptr: SUCCESS (0.000s) [32.556201] [008/165] (957s left) fbdev (read) [32.588489] Starting subtest: read [35.094504] Subtest read: SUCCESS (2.506s) [35.136560] [009/165] (954s left) fbdev (write) [35.172099] Starting subtest: write [37.043684] Subtest write: SUCCESS (1.862s) [37.087438] [010/165] (952s left) gem_basic (bad-close) [37.114684] Starting subtest: bad-close [37.116089] Subtest bad-close: SUCCESS (0.000s) [37.170900] [011/165] (952s left) gem_basic (create-close) [37.197070] Starting subtest: create-close [37.198875] Subtest create-close: SUCCESS (0.000s) [37.270562] [012/165] (952s left) gem_basic (create-fd-close) [37.297724] Starting subtest: create-fd-close [37.299248] Subtest create-fd-close: SUCCESS (0.000s) [37.372863] [013/165] (952s left) gem_busy (busy@all-engines) [37.406885] Starting subtest: busy [37.407756] Starting dynamic subtest: all-engines [37.428471] Dynamic subtest all-engines: SUCCESS (0.021s) [37.429272] Subtest busy: SUCCESS (0.022s) [37.760836] [014/165] (952s left) gem_close_race (basic-process) [37.795014] Starting subtest: basic-process [37.831913] Subtest basic-process: SUCCESS (0.036s) [38.011197] [015/165] (952s left) gem_close_race (basic-threads) [38.046203] Starting subtest: basic-threads [39.252036] Subtest basic-threads: SUCCESS (1.206s) [39.427785] [016/165] (950s left) gem_ctx_create (basic) [39.460301] Starting subtest: basic [39.461066] Subtest basic: SUCCESS (0.000s) [39.629333] [017/165] (950s left) gem_ctx_create (basic-files) [39.664174] Starting subtest: basic-files [41.672080] Subtest basic-files: SUCCESS (2.008s) [41.854805] [018/165] (948s left) gem_ctx_exec (basic) [41.897059] Starting subtest: basic [41.898690] Subtest basic: SUCCESS (0.002s) [41.998717] [019/165] (948s left) gem_exec_basic (basic) [42.028433] Starting subtest: basic [42.030176] Starting dynamic subtest: rcs0-smem [42.030955] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [42.036230] Starting dynamic subtest: bcs0-smem [42.037068] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [42.042127] Starting dynamic subtest: vcs0-smem [42.042852] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [42.046315] Starting dynamic subtest: vcs1-smem [42.046984] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [42.050148] Starting dynamic subtest: vecs0-smem [42.050816] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [42.051523] Subtest basic: SUCCESS (0.002s) [42.205430] [020/165] (947s left) gem_exec_create (basic) [42.241091] Starting subtest: basic [42.241932] Starting dynamic subtest: smem [44.324133] Dynamic subtest smem: SUCCESS (2.083s) [44.325317] Subtest basic: SUCCESS (2.083s) [44.493327] [021/165] (945s left) gem_exec_fence (basic-busy) [44.651737] Starting subtest: basic-busy [44.652755] Starting dynamic subtest: rcs0 [44.713160] Dynamic subtest rcs0: SUCCESS (0.070s) [44.725143] Starting dynamic subtest: bcs0 [44.760657] Dynamic subtest bcs0: SUCCESS (0.047s) [44.771876] Starting dynamic subtest: vcs0 [44.808095] Dynamic subtest vcs0: SUCCESS (0.047s) [44.816589] Starting dynamic subtest: vcs1 [44.859171] Dynamic subtest vcs1: SUCCESS (0.050s) [44.871644] Starting dynamic subtest: vecs0 [44.907940] Dynamic subtest vecs0: SUCCESS (0.049s) [44.909989] Subtest basic-busy: SUCCESS (0.265s) [45.410060] [022/165] (944s left) gem_exec_fence (basic-wait) [45.565861] Starting subtest: basic-wait [45.566847] Starting dynamic subtest: rcs0 [45.612894] Dynamic subtest rcs0: SUCCESS (0.056s) [45.624017] Starting dynamic subtest: bcs0 [45.666292] Dynamic subtest bcs0: SUCCESS (0.053s) [45.677181] Starting dynamic subtest: vcs0 [45.720958] Dynamic subtest vcs0: SUCCESS (0.055s) [45.732039] Starting dynamic subtest: vcs1 [45.767915] Dynamic subtest vcs1: SUCCESS (0.047s) [45.776216] Starting dynamic subtest: vecs0 [45.818965] Dynamic subtest vecs0: SUCCESS (0.051s) [45.820566] Subtest basic-wait: SUCCESS (0.262s) [46.294563] [023/165] (943s left) gem_exec_fence (basic-await) [46.454784] Starting subtest: basic-await [46.455632] Starting dynamic subtest: rcs0 [46.517751] Dynamic subtest rcs0: SUCCESS (0.072s) [46.524116] Starting dynamic subtest: bcs0 [46.591466] Dynamic subtest bcs0: SUCCESS (0.070s) [46.598134] Starting dynamic subtest: vcs0 [46.661504] Dynamic subtest vcs0: SUCCESS (0.073s) [46.669617] Starting dynamic subtest: vcs1 [46.734116] Dynamic subtest vcs1: SUCCESS (0.072s) [46.743284] Starting dynamic subtest: vecs0 [46.808123] Dynamic subtest vecs0: SUCCESS (0.074s) [46.809786] Subtest basic-await: SUCCESS (0.362s) [47.279135] [024/165] (942s left) gem_exec_fence (nb-await) [47.436303] Starting subtest: nb-await [47.437241] Starting dynamic subtest: rcs0 [47.484491] Dynamic subtest rcs0: SUCCESS (0.056s) [47.493409] Starting dynamic subtest: bcs0 [47.543248] Dynamic subtest bcs0: SUCCESS (0.059s) [47.553150] Starting dynamic subtest: vcs0 [47.604485] Dynamic subtest vcs0: SUCCESS (0.061s) [47.611717] Starting dynamic subtest: vcs1 [47.663801] Dynamic subtest vcs1: SUCCESS (0.059s) [47.674948] Starting dynamic subtest: vecs0 [47.724502] Dynamic subtest vecs0: SUCCESS (0.060s) [47.726591] Subtest nb-await: SUCCESS (0.297s) [48.193993] [025/165] (942s left) gem_exec_gttfill (basic) [48.227305] Starting subtest: basic [50.418760] Subtest basic: SUCCESS (2.182s) [50.572866] [026/165] (939s left) gem_exec_parallel (engines) [50.643216] Starting subtest: engines [50.644219] Starting dynamic subtest: basic [51.953688] Dynamic subtest basic: SUCCESS (1.310s) [51.960906] Starting dynamic subtest: contexts [53.615328] Dynamic subtest contexts: SUCCESS (1.652s) [53.620936] Starting dynamic subtest: fds [55.417681] Dynamic subtest fds: SUCCESS (1.812s) [55.423437] Starting dynamic subtest: userptr [56.704183] Dynamic subtest userptr: SUCCESS (1.286s) [56.706077] Subtest engines: SUCCESS (6.060s) [56.887258] [027/165] (933s left) gem_exec_store (basic) [56.918612] Starting subtest: basic [56.996384] Subtest basic: SUCCESS (0.076s) [57.180400] [028/165] (933s left) gem_flink_basic (bad-flink) [57.205628] Starting subtest: bad-flink [57.206699] Subtest bad-flink: SUCCESS (0.000s) [57.256957] [029/165] (932s left) gem_flink_basic (bad-open) [57.284344] Starting subtest: bad-open [57.285140] Subtest bad-open: SUCCESS (0.000s) [57.342713] [030/165] (932s left) gem_flink_basic (basic) [57.369033] Starting subtest: basic [57.369760] Subtest basic: SUCCESS (0.000s) [57.461011] [031/165] (932s left) gem_flink_basic (double-flink) [57.489107] Starting subtest: double-flink [57.490031] Subtest double-flink: SUCCESS (0.000s) [57.578363] [032/165] (932s left) gem_flink_basic (flink-lifetime) [57.606206] Starting subtest: flink-lifetime [57.606932] Subtest flink-lifetime: SUCCESS (0.001s) [57.678546] [033/165] (932s left) gem_huc_copy (huc-copy) [57.717609] Starting subtest: huc-copy [57.718931] Subtest huc-copy: SUCCESS (0.002s) [57.810938] [034/165] (932s left) gem_linear_blits (basic) [57.889332] Starting subtest: basic [57.892694] Subtest basic: SUCCESS (0.004s) [58.008670] [035/165] (932s left) gem_mmap (basic) [58.074132] Starting subtest: basic [58.078420] Subtest basic: SUCCESS (0.000s) [58.161361] [036/165] (932s left) gem_mmap_gtt (basic) [58.189989] Starting subtest: basic [58.190759] Subtest basic: SUCCESS (0.000s) [58.245242] [037/165] (932s left) gem_render_linear_blits (basic) [58.275453] Starting subtest: basic [58.288475] Subtest basic: SUCCESS (0.013s) [58.345278] [038/165] (931s left) gem_render_tiled_blits (basic) [58.386978] Starting subtest: basic [58.404611] Subtest basic: SUCCESS (0.018s) [58.462957] [039/165] (931s left) gem_ringfill (basic-all) [58.771416] Starting subtest: basic-all [59.909547] Subtest basic-all: SUCCESS (1.128s) [60.016154] [040/165] (930s left) gem_softpin (allocator-basic) [60.053291] Starting subtest: allocator-basic [60.097869] Subtest allocator-basic: SUCCESS (0.044s) [60.196381] [041/165] (930s left) gem_softpin (allocator-basic-reserve) [60.223587] Starting subtest: allocator-basic-reserve [60.268583] Subtest allocator-basic-reserve: SUCCESS (0.044s) [60.361640] [042/165] (930s left) gem_softpin (safe-alignment) [60.393514] Starting subtest: safe-alignment [60.399903] Subtest safe-alignment: SUCCESS (0.007s) [60.495649] [043/165] (929s left) gem_sync (basic-all) [60.528059] Starting subtest: basic-all [62.879398] Subtest basic-all: SUCCESS (2.351s) [63.046678] [044/165] (927s left) gem_sync (basic-each) [63.081222] Starting subtest: basic-each [65.313321] Subtest basic-each: SUCCESS (2.231s) [65.478686] [045/165] (924s left) gem_tiled_blits (basic) [65.550816] Starting subtest: basic [65.559524] Subtest basic: SUCCESS (0.009s) [65.675313] [046/165] (924s left) gem_tiled_fence_blits (basic) [65.789189] Starting subtest: basic [65.809834] Subtest basic: SUCCESS (0.021s) [65.901514] [047/165] (924s left) gem_tiled_pread_basic [65.997688] [048/165] (924s left) gem_wait (busy@all-engines) [66.032081] Starting subtest: busy [66.032964] Starting dynamic subtest: all-engines [66.572449] Dynamic subtest all-engines: SUCCESS (0.540s) [66.573827] Subtest busy: SUCCESS (0.540s) [66.779327] [049/165] (923s left) gem_wait (wait@all-engines) [66.815621] Starting subtest: wait [66.816327] Starting dynamic subtest: all-engines [67.864070] Dynamic subtest all-engines: SUCCESS (1.047s) [67.865964] Subtest wait: SUCCESS (1.048s) [68.062642] [050/165] (922s left) i915_getparams_basic (basic-eu-total) [68.089494] Starting subtest: basic-eu-total [68.090780] Subtest basic-eu-total: SUCCESS (0.000s) [68.163237] [051/165] (922s left) i915_getparams_basic (basic-subslice-total) [68.191018] Starting subtest: basic-subslice-total [68.192243] Subtest basic-subslice-total: SUCCESS (0.000s) [68.260646] [052/165] (922s left) i915_hangman (error-state-basic) [68.289611] Starting subtest: error-state-basic [68.379536] Subtest error-state-basic: SUCCESS (0.090s) [68.443387] [053/165] (922s left) i915_pciid [68.525095] [054/165] (921s left) kms_addfb_basic (addfb25-4-tiled) [68.743909] Starting subtest: addfb25-4-tiled [68.744684] Subtest addfb25-4-tiled: SUCCESS (0.000s) [68.829225] [055/165] (921s left) kms_addfb_basic (addfb25-bad-modifier) [68.857441] Starting subtest: addfb25-bad-modifier [68.858242] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [69.129386] [056/165] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [69.160093] Starting subtest: addfb25-framebuffer-vs-set-tiling [69.160890] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [69.410337] [057/165] (921s left) kms_addfb_basic (addfb25-modifier-no-flag) [69.436525] Starting subtest: addfb25-modifier-no-flag [69.437253] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [69.695747] [058/165] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy) [69.721146] Starting subtest: addfb25-x-tiled-legacy [69.721962] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [69.997676] [059/165] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [70.027237] Starting subtest: addfb25-x-tiled-mismatch-legacy [70.028093] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [70.298299] [060/165] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [70.517150] Starting subtest: addfb25-yf-tiled-legacy [70.518064] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [70.597196] [061/165] (919s left) kms_addfb_basic (addfb25-y-tiled-legacy) [70.811241] Starting subtest: addfb25-y-tiled-legacy [70.812279] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [70.897084] [062/165] (919s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [71.112211] Starting subtest: addfb25-y-tiled-small-legacy [71.113133] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [71.197132] [063/165] (919s left) kms_addfb_basic (bad-pitch-0) [71.225938] Starting subtest: bad-pitch-0 [71.226893] Subtest bad-pitch-0: SUCCESS (0.000s) [71.480122] [064/165] (919s left) kms_addfb_basic (bad-pitch-1024) [71.509999] Starting subtest: bad-pitch-1024 [71.510878] Subtest bad-pitch-1024: SUCCESS (0.000s) [71.763790] [065/165] (918s left) kms_addfb_basic (bad-pitch-128) [71.798039] Starting subtest: bad-pitch-128 [71.798824] Subtest bad-pitch-128: SUCCESS (0.000s) [72.062872] [066/165] (918s left) kms_addfb_basic (bad-pitch-256) [72.090011] Starting subtest: bad-pitch-256 [72.090936] Subtest bad-pitch-256: SUCCESS (0.000s) [72.382176] [067/165] (918s left) kms_addfb_basic (bad-pitch-32) [72.410729] Starting subtest: bad-pitch-32 [72.411571] Subtest bad-pitch-32: SUCCESS (0.000s) [72.681624] [068/165] (917s left) kms_addfb_basic (bad-pitch-63) [72.711999] Starting subtest: bad-pitch-63 [72.712669] Subtest bad-pitch-63: SUCCESS (0.000s) [72.982357] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536) [73.012640] Starting subtest: bad-pitch-65536 [73.013396] Subtest bad-pitch-65536: SUCCESS (0.000s) [73.281284] [070/165] (917s left) kms_addfb_basic (bad-pitch-999) [73.309638] Starting subtest: bad-pitch-999 [73.310454] Subtest bad-pitch-999: SUCCESS (0.000s) [73.581499] [071/165] (917s left) kms_addfb_basic (basic) [73.608968] Starting subtest: basic [73.609751] Subtest basic: SUCCESS (0.000s) [73.882203] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy) [73.911352] Starting subtest: basic-x-tiled-legacy [73.912059] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [74.181057] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy) [74.212992] Starting subtest: basic-y-tiled-legacy [74.213745] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [74.481461] [074/165] (916s left) kms_addfb_basic (bo-too-small) [74.696226] Starting subtest: bo-too-small [74.696937] Subtest bo-too-small: SUCCESS (0.000s) [74.780706] [075/165] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling) [74.995887] Starting subtest: bo-too-small-due-to-tiling [74.996663] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [75.081064] [076/165] (915s left) kms_addfb_basic (clobberred-modifier) [75.111920] Starting subtest: clobberred-modifier [75.112734] Subtest clobberred-modifier: SUCCESS (0.000s) [75.363280] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling) [75.394425] Starting subtest: framebuffer-vs-set-tiling [75.395248] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [75.648256] [078/165] (915s left) kms_addfb_basic (invalid-get-prop) [75.677604] Starting subtest: invalid-get-prop [75.678379] Subtest invalid-get-prop: SUCCESS (0.000s) [75.949452] [079/165] (914s left) kms_addfb_basic (invalid-get-prop-any) [75.979191] Starting subtest: invalid-get-prop-any [75.979893] Subtest invalid-get-prop-any: SUCCESS (0.000s) [76.251327] [080/165] (914s left) kms_addfb_basic (invalid-set-prop) [76.278645] Starting subtest: invalid-set-prop [76.279423] Subtest invalid-set-prop: SUCCESS (0.000s) [76.529445] [081/165] (914s left) kms_addfb_basic (invalid-set-prop-any) [76.558674] Starting subtest: invalid-set-prop-any [76.559548] Subtest invalid-set-prop-any: SUCCESS (0.000s) [76.816373] [082/165] (913s left) kms_addfb_basic (no-handle) [76.846452] Starting subtest: no-handle [76.847180] Subtest no-handle: SUCCESS (0.000s) [77.115779] [083/165] (913s left) kms_addfb_basic (size-max) [77.329996] Starting subtest: size-max [77.331133] Subtest size-max: SUCCESS (0.000s) [77.415520] [084/165] (913s left) kms_addfb_basic (small-bo) [77.630097] Starting subtest: small-bo [77.630916] Subtest small-bo: SUCCESS (0.000s) [77.715221] [085/165] (913s left) kms_addfb_basic (tile-pitch-mismatch) [77.745913] Starting subtest: tile-pitch-mismatch [77.746940] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [78.014879] [086/165] (912s left) kms_addfb_basic (too-high) [78.230086] Starting subtest: too-high [78.230828] Subtest too-high: SUCCESS (0.000s) [78.315289] [087/165] (912s left) kms_addfb_basic (too-wide) [78.530154] Starting subtest: too-wide [78.531110] Subtest too-wide: SUCCESS (0.000s) [78.615713] [088/165] (912s left) kms_addfb_basic (unused-handle) [78.647575] Starting subtest: unused-handle [78.648347] Subtest unused-handle: SUCCESS (0.000s) [78.914237] [089/165] (911s left) kms_addfb_basic (unused-modifier) [78.939386] Starting subtest: unused-modifier [78.940300] Subtest unused-modifier: SUCCESS (0.000s) [79.219487] [090/165] (911s left) kms_addfb_basic (unused-offsets) [79.248794] Starting subtest: unused-offsets [79.249571] Subtest unused-offsets: SUCCESS (0.000s) [79.534127] [091/165] (911s left) kms_addfb_basic (unused-pitches) [79.562471] Starting subtest: unused-pitches [79.563194] Subtest unused-pitches: SUCCESS (0.000s) [79.830626] [092/165] (911s left) kms_busy (basic) [80.047253] Starting subtest: basic [80.048239] Starting dynamic subtest: flip [80.621957] Dynamic subtest flip: SUCCESS (0.575s) [80.626788] Starting dynamic subtest: modeset [81.401969] Dynamic subtest modeset: SUCCESS (0.780s) [81.402729] Subtest basic: SUCCESS (1.355s) [81.590234] [093/165] (909s left) kms_prop_blob (basic) [81.620941] Starting subtest: basic [81.621759] Subtest basic: SUCCESS (0.000s) [81.685203] [094/165] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [81.897195] Starting subtest: basic-busy-flip-before-cursor-atomic [81.898939] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [81.951876] [095/165] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [82.168056] Starting subtest: basic-busy-flip-before-cursor-legacy [82.169640] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [82.237070] [096/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [82.450157] Starting subtest: basic-flip-after-cursor-atomic [83.424924] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.975s) [83.604692] [097/165] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [83.817099] Starting subtest: basic-flip-after-cursor-legacy [84.796025] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.979s) [84.963417] [098/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [85.179106] Starting subtest: basic-flip-after-cursor-varying-size [86.147467] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.968s) [86.309220] [099/165] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [86.527278] Starting subtest: basic-flip-before-cursor-atomic [87.497132] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.970s) [87.670199] [100/165] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [87.884255] Starting subtest: basic-flip-before-cursor-legacy [88.873063] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.989s) [89.057849] [101/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [89.281541] Starting subtest: basic-flip-before-cursor-varying-size [90.262471] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.982s) [90.425820] [102/165] (900s left) kms_dsc (dsc-basic) [90.644243] Starting subtest: dsc-basic [90.645759] Subtest dsc-basic: SKIP (0.000s) [90.704990] [103/165] (900s left) kms_flip (basic-flip-vs-dpms) [90.845562] Starting subtest: basic-flip-vs-dpms [90.846451] Starting dynamic subtest: A-DP1 [91.735986] Dynamic subtest A-DP1: SUCCESS (0.889s) [91.741602] Starting dynamic subtest: B-DP1 [92.486380] Dynamic subtest B-DP1: SUCCESS (0.750s) [92.491145] Starting dynamic subtest: C-DP1 [93.225799] Dynamic subtest C-DP1: SUCCESS (0.739s) [93.232698] Starting dynamic subtest: D-DP1 [93.976978] Dynamic subtest D-DP1: SUCCESS (0.750s) [93.979108] Subtest basic-flip-vs-dpms: SUCCESS (3.135s) [94.150792] [104/165] (896s left) kms_flip (basic-flip-vs-modeset) [94.296125] Starting subtest: basic-flip-vs-modeset [94.298379] Starting dynamic subtest: A-DP1 [95.195819] Dynamic subtest A-DP1: SUCCESS (0.898s) [95.201483] Starting dynamic subtest: B-DP1 [95.931515] Dynamic subtest B-DP1: SUCCESS (0.735s) [95.937522] Starting dynamic subtest: C-DP1 [96.669559] Dynamic subtest C-DP1: SUCCESS (0.738s) [96.676021] Starting dynamic subtest: D-DP1 [97.414707] Dynamic subtest D-DP1: SUCCESS (0.745s) [97.416470] Subtest basic-flip-vs-modeset: SUCCESS (3.122s) [97.565444] [105/165] (893s left) kms_flip (basic-flip-vs-wf_vblank) [97.704779] Starting subtest: basic-flip-vs-wf_vblank [97.706521] Starting dynamic subtest: A-DP1 [98.764105] Dynamic subtest A-DP1: SUCCESS (1.056s) [98.775881] Starting dynamic subtest: B-DP1 [99.778437] Dynamic subtest B-DP1: SUCCESS (1.011s) [99.785065] Starting dynamic subtest: C-DP1 [100.795144] Dynamic subtest C-DP1: SUCCESS (1.011s) [100.800864] Starting dynamic subtest: D-DP1 [101.805664] Dynamic subtest D-DP1: SUCCESS (1.014s) [101.810966] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.107s) [102.028054] [106/165] (889s left) kms_flip (basic-plain-flip) [102.169882] Starting subtest: basic-plain-flip [102.170843] Starting dynamic subtest: A-DP1 [102.953591] Dynamic subtest A-DP1: SUCCESS (0.782s) [102.963532] Starting dynamic subtest: B-DP1 [103.684701] Dynamic subtest B-DP1: SUCCESS (0.729s) [103.692802] Starting dynamic subtest: C-DP1 [104.416805] Dynamic subtest C-DP1: SUCCESS (0.730s) [104.424952] Starting dynamic subtest: D-DP1 [105.147463] Dynamic subtest D-DP1: SUCCESS (0.727s) [105.151283] Subtest basic-plain-flip: SUCCESS (2.983s) [105.363675] [107/165] (885s left) kms_force_connector_basic (force-connector-state) [105.604401] Starting subtest: force-connector-state [106.317044] Subtest force-connector-state: SUCCESS (0.713s) [106.998432] [108/165] (884s left) kms_force_connector_basic (force-edid) [107.234702] Starting subtest: force-edid [107.644438] Subtest force-edid: SUCCESS (0.410s) [108.148406] [109/165] (882s left) kms_force_connector_basic (force-load-detect) [108.383792] Starting subtest: force-load-detect [108.385454] Subtest force-load-detect: SKIP (0.000s) [108.766819] [110/165] (882s left) kms_force_connector_basic (prune-stale-modes) [109.002182] Starting subtest: prune-stale-modes [109.466459] Subtest prune-stale-modes: SUCCESS (0.464s) [109.965649] [111/165] (881s left) kms_frontbuffer_tracking (basic) [110.186552] Starting subtest: basic [113.660699] Subtest basic: SUCCESS (3.475s) [113.768103] [112/165] (877s left) kms_hdmi_inject (inject-audio) [113.888850] Starting subtest: inject-audio [114.418216] Subtest inject-audio: SUCCESS (0.529s) [114.812138] [113/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [115.036285] Starting subtest: compare-crc-sanitycheck-xr24 [115.037162] Starting dynamic subtest: pipe-A-DP-1 [115.451192] Dynamic subtest pipe-A-DP-1: SUCCESS (0.414s) [115.457852] Starting dynamic subtest: pipe-B-DP-1 [115.852131] Dynamic subtest pipe-B-DP-1: SUCCESS (0.399s) [115.857018] Starting dynamic subtest: pipe-C-DP-1 [116.254559] Dynamic subtest pipe-C-DP-1: SUCCESS (0.401s) [116.261823] Starting dynamic subtest: pipe-D-DP-1 [116.655056] Dynamic subtest pipe-D-DP-1: SUCCESS (0.400s) [116.655805] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.620s) [116.826869] [114/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [117.042573] Starting subtest: compare-crc-sanitycheck-nv12 [117.043467] Starting dynamic subtest: pipe-A-DP-1 [117.630367] Dynamic subtest pipe-A-DP-1: SUCCESS (0.588s) [117.635976] Starting dynamic subtest: pipe-B-DP-1 [118.183864] Dynamic subtest pipe-B-DP-1: SUCCESS (0.552s) [118.188896] Starting dynamic subtest: pipe-C-DP-1 [118.765224] Dynamic subtest pipe-C-DP-1: SUCCESS (0.580s) [118.771511] Starting dynamic subtest: pipe-D-DP-1 [119.322922] Dynamic subtest pipe-D-DP-1: SUCCESS (0.556s) [119.323615] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.280s) [119.496503] [115/165] (871s left) kms_pipe_crc_basic (hang-read-crc) [119.712184] Starting subtest: hang-read-crc [119.713081] Starting dynamic subtest: pipe-A-DP-1 [120.860447] Dynamic subtest pipe-A-DP-1: SUCCESS (1.148s) [120.866488] Starting dynamic subtest: pipe-B-DP-1 [121.973836] Dynamic subtest pipe-B-DP-1: SUCCESS (1.111s) [121.979206] Starting dynamic subtest: pipe-C-DP-1 [123.093633] Dynamic subtest pipe-C-DP-1: SUCCESS (1.115s) [123.099071] Starting dynamic subtest: pipe-D-DP-1 [124.205614] Dynamic subtest pipe-D-DP-1: SUCCESS (1.115s) [124.206293] Subtest hang-read-crc: SUCCESS (4.494s) [124.349323] [116/165] (866s left) kms_pipe_crc_basic (nonblocking-crc) [124.564042] Starting subtest: nonblocking-crc [124.564894] Starting dynamic subtest: pipe-A-DP-1 [125.172305] Dynamic subtest pipe-A-DP-1: SUCCESS (0.607s) [125.177428] Starting dynamic subtest: pipe-B-DP-1 [125.746344] Dynamic subtest pipe-B-DP-1: SUCCESS (0.574s) [125.751566] Starting dynamic subtest: pipe-C-DP-1 [126.326376] Dynamic subtest pipe-C-DP-1: SUCCESS (0.578s) [126.331648] Starting dynamic subtest: pipe-D-DP-1 [126.907662] Dynamic subtest pipe-D-DP-1: SUCCESS (0.579s) [126.908415] Subtest nonblocking-crc: SUCCESS (2.343s) [127.053171] [117/165] (864s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [127.275566] Starting subtest: nonblocking-crc-frame-sequence [127.276539] Starting dynamic subtest: pipe-A-DP-1 [127.888910] Dynamic subtest pipe-A-DP-1: SUCCESS (0.612s) [127.895440] Starting dynamic subtest: pipe-B-DP-1 [128.444455] Dynamic subtest pipe-B-DP-1: SUCCESS (0.555s) [128.449678] Starting dynamic subtest: pipe-C-DP-1 [129.001026] Dynamic subtest pipe-C-DP-1: SUCCESS (0.555s) [129.006313] Starting dynamic subtest: pipe-D-DP-1 [129.559673] Dynamic subtest pipe-D-DP-1: SUCCESS (0.557s) [129.560644] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.284s) [129.704259] [118/165] (861s left) kms_pipe_crc_basic (read-crc) [129.920028] Starting subtest: read-crc [129.921143] Starting dynamic subtest: pipe-A-DP-1 [130.455590] Dynamic subtest pipe-A-DP-1: SUCCESS (0.536s) [130.462016] Starting dynamic subtest: pipe-B-DP-1 [130.952494] Dynamic subtest pipe-B-DP-1: SUCCESS (0.495s) [130.957654] Starting dynamic subtest: pipe-C-DP-1 [131.463670] Dynamic subtest pipe-C-DP-1: SUCCESS (0.510s) [131.469583] Starting dynamic subtest: pipe-D-DP-1 [131.978507] Dynamic subtest pipe-D-DP-1: SUCCESS (0.511s) [131.979431] Subtest read-crc: SUCCESS (2.057s) [132.117841] [119/165] (859s left) kms_pipe_crc_basic (read-crc-frame-sequence) [132.332759] Starting subtest: read-crc-frame-sequence [132.333684] Starting dynamic subtest: pipe-A-DP-1 [132.871621] Dynamic subtest pipe-A-DP-1: SUCCESS (0.539s) [132.881375] Starting dynamic subtest: pipe-B-DP-1 [133.381599] Dynamic subtest pipe-B-DP-1: SUCCESS (0.508s) [133.387735] Starting dynamic subtest: pipe-C-DP-1 [133.891534] Dynamic subtest pipe-C-DP-1: SUCCESS (0.509s) [133.897819] Starting dynamic subtest: pipe-D-DP-1 [134.406366] Dynamic subtest pipe-D-DP-1: SUCCESS (0.513s) [134.407151] Subtest read-crc-frame-sequence: SUCCESS (2.074s) [134.552889] [120/165] (856s left) kms_pm_backlight (basic-brightness) [134.772659] Subtest basic-brightness: SKIP (0.000s) [134.807404] [121/165] (856s left) kms_psr (primary_page_flip) [134.838787] Subtest primary_page_flip: SKIP (0.000s) [134.872536] [122/165] (856s left) kms_psr (cursor_plane_move) [134.900854] Subtest cursor_plane_move: SKIP (0.000s) [134.918858] [123/165] (856s left) kms_psr (sprite_plane_onoff) [134.945973] Subtest sprite_plane_onoff: SKIP (0.000s) [134.968070] [124/165] (856s left) kms_psr (primary_mmap_gtt) [134.995281] Subtest primary_mmap_gtt: SKIP (0.000s) [135.018012] [125/165] (856s left) kms_setmode (basic-clone-single-crtc) [135.045530] Starting subtest: basic-clone-single-crtc [135.047796] Subtest basic-clone-single-crtc: SKIP (0.000s) [135.116663] [126/165] (856s left) i915_pm_rpm (basic-pci-d3-state) [136.645904] Starting subtest: basic-pci-d3-state [144.330451] Subtest basic-pci-d3-state: SUCCESS (7.684s) [144.551125] [127/165] (846s left) i915_pm_rpm (basic-rte) [144.580874] Starting subtest: basic-rte [146.893525] Subtest basic-rte: SUCCESS (2.311s) [147.575373] [128/165] (843s left) i915_pm_rps (basic-api) [147.612063] Starting subtest: basic-api [147.613640] Subtest basic-api: SKIP (0.000s) [147.672327] [129/165] (843s left) prime_self_import (basic-llseek-bad) [147.699810] Starting subtest: basic-llseek-bad [147.701588] Subtest basic-llseek-bad: SUCCESS (0.001s) [147.792500] [130/165] (843s left) prime_self_import (basic-llseek-size) [147.818975] Starting subtest: basic-llseek-size [147.820988] Subtest basic-llseek-size: SUCCESS (0.002s) [147.906980] [131/165] (843s left) prime_self_import (basic-with_fd_dup) [147.938819] Starting subtest: basic-with_fd_dup [147.940483] Subtest basic-with_fd_dup: SUCCESS (0.001s) [148.023587] [132/165] (843s left) prime_self_import (basic-with_one_bo) [148.048951] Starting subtest: basic-with_one_bo [148.050646] Subtest basic-with_one_bo: SUCCESS (0.002s) [148.093242] [133/165] (843s left) prime_self_import (basic-with_one_bo_two_files) [148.125953] Starting subtest: basic-with_one_bo_two_files [148.127682] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [148.223481] [134/165] (843s left) prime_self_import (basic-with_two_bos) [148.246578] Starting subtest: basic-with_two_bos [148.248777] Subtest basic-with_two_bos: SUCCESS (0.002s) [148.325365] [135/165] (843s left) prime_vgem (basic-fence-flip) [148.372740] Starting subtest: basic-fence-flip [148.952640] Subtest basic-fence-flip: SUCCESS (0.580s) [149.042110] [136/165] (842s left) prime_vgem (basic-fence-mmap) [149.072701] Starting subtest: basic-fence-mmap [149.088769] Subtest basic-fence-mmap: SUCCESS (0.016s) [149.174810] [137/165] (842s left) prime_vgem (basic-fence-read) [149.229506] Starting subtest: basic-fence-read [149.233851] Subtest basic-fence-read: SKIP (0.004s) [149.325790] [138/165] (842s left) prime_vgem (basic-gtt) [149.391228] Starting subtest: basic-gtt [149.399992] Subtest basic-gtt: SUCCESS (0.009s) [149.473931] [139/165] (841s left) prime_vgem (basic-read) [149.505022] Starting subtest: basic-read [149.508543] Subtest basic-read: SKIP (0.003s) [149.590782] [140/165] (841s left) prime_vgem (basic-write) [149.648306] Starting subtest: basic-write [149.653150] Subtest basic-write: SKIP (0.005s) [149.740735] [141/165] (841s left) vgem_basic (setversion) [149.769830] Starting subtest: setversion [149.771440] Subtest setversion: SUCCESS (0.000s) [149.822774] [142/165] (841s left) vgem_basic (create) [149.853224] Starting subtest: create [149.853979] Subtest create: SUCCESS (0.000s) [149.907594] [143/165] (841s left) vgem_basic (debugfs) [149.936512] Starting subtest: debugfs [149.937213] Subtest debugfs: SUCCESS (0.000s) [149.990247] [144/165] (841s left) vgem_basic (dmabuf-export) [150.019505] Starting subtest: dmabuf-export [150.020833] Subtest dmabuf-export: SUCCESS (0.001s) [150.107809] [145/165] (841s left) vgem_basic (dmabuf-fence) [150.153808] Starting subtest: dmabuf-fence [150.154844] Subtest dmabuf-fence: SUCCESS (0.001s) [150.206753] [146/165] (841s left) vgem_basic (dmabuf-fence-before) [150.236289] Starting subtest: dmabuf-fence-before [150.236969] Subtest dmabuf-fence-before: SUCCESS (0.000s) [150.287226] [147/165] (841s left) vgem_basic (dmabuf-mmap) [150.320011] Starting subtest: dmabuf-mmap [150.325779] Subtest dmabuf-mmap: SUCCESS (0.006s) [150.370580] [148/165] (841s left) vgem_basic (mmap) [150.403062] Starting subtest: mmap [150.406863] Subtest mmap: SUCCESS (0.005s) [150.454748] [149/165] (841s left) vgem_basic (second-client) [150.486483] Starting subtest: second-client [150.522302] Subtest second-client: SUCCESS (0.034s) [150.574927] [150/165] (840s left) vgem_basic (sysfs) [150.602912] Starting subtest: sysfs [150.603711] Subtest sysfs: SUCCESS (0.000s) [150.656551] [151/165] (840s left) core_hotunplug (unbind-rebind) [150.702509] Starting subtest: unbind-rebind [154.859465] Subtest unbind-rebind: SUCCESS (4.157s) [154.870825] [152/165] (836s left) vgem_basic (unload) [154.904310] Starting subtest: unload [183.855660] Subtest unload: SUCCESS (28.916s) [183.899192] [153/165] (807s left) i915_module_load (reload) [183.932498] Starting subtest: reload [186.806734] Subtest reload: SUCCESS (2.874s) [186.817935] [154/165] (804s left) gem_lmem_swapping (basic) [186.853570] Subtest basic: SKIP (0.000s) [186.882734] [155/165] (804s left) gem_lmem_swapping (parallel-random-engines) [186.915168] Subtest parallel-random-engines: SKIP (0.000s) [186.946853] [156/165] (804s left) gem_lmem_swapping (random-engines) [186.976027] Subtest random-engines: SKIP (0.000s) [186.996215] [157/165] (804s left) gem_lmem_swapping (verify-random) [187.025490] Subtest verify-random: SKIP (0.000s) [187.046630] [158/165] (804s left) i915_pm_rpm (module-reload) [188.812931] Starting subtest: module-reload [204.567624] Subtest module-reload: SUCCESS (15.747s) [204.592533] [159/165] (787s left) i915_selftest (live) [204.639625] Starting subtest: live [204.640551] Starting dynamic subtest: sanitycheck [206.303821] Dynamic subtest sanitycheck: SUCCESS (1.656s) [206.309272] Starting dynamic subtest: uncore [207.970879] Dynamic subtest uncore: SUCCESS (1.661s) [207.984178] Starting dynamic subtest: workarounds [210.615073] Dynamic subtest workarounds: SUCCESS (2.647s) [210.618516] Starting dynamic subtest: gt_engines [212.820468] Dynamic subtest gt_engines: SUCCESS (2.204s) [212.824241] Starting dynamic subtest: gt_timelines [223.406477] Dynamic subtest gt_timelines: SUCCESS (10.585s) [223.410459] Starting dynamic subtest: gt_contexts [225.076991] Dynamic subtest gt_contexts: SUCCESS (1.671s) [225.080944] Starting dynamic subtest: gt_lrc [229.618092] Dynamic subtest gt_lrc: SUCCESS (4.538s) [229.621778] Starting dynamic subtest: gt_mocs [231.810678] Dynamic subtest gt_mocs: SUCCESS (2.191s) [231.814560] Starting dynamic subtest: gt_pm [234.364092] Dynamic subtest gt_pm: SUCCESS (2.552s) [234.367442] Starting dynamic subtest: gt_heartbeat [236.181251] Dynamic subtest gt_heartbeat: SUCCESS (1.816s) [236.185106] Starting dynamic subtest: gt_tlb [239.323415] Dynamic subtest gt_tlb: SUCCESS (3.139s) [239.327171] Starting dynamic subtest: requests [248.915759] Dynamic subtest requests: SUCCESS (9.591s) [248.919820] Starting dynamic subtest: migrate [253.306372] Dynamic subtest migrate: SUCCESS (4.390s) [253.310074] Starting dynamic subtest: active [254.963370] Dynamic subtest active: SUCCESS (1.656s) [254.967123] Starting dynamic subtest: objects [257.060569] Dynamic subtest objects: SUCCESS (2.096s) [257.064356] Starting dynamic subtest: mman [262.369555] Dynamic subtest mman: SUCCESS (5.308s) [262.375011] Starting dynamic subtest: dmabuf [264.076310] Dynamic subtest dmabuf: SUCCESS (1.706s) [264.082017] Starting dynamic subtest: vma [265.761576] Dynamic subtest vma: SUCCESS (1.684s) [265.765520] Starting dynamic subtest: coherency [269.347633] Dynamic subtest coherency: SUCCESS (3.585s) [269.353484] Starting dynamic subtest: gtt [278.056688] Dynamic subtest gtt: SUCCESS (8.708s) [278.062772] Starting dynamic subtest: gem [279.904831] Dynamic subtest gem: SUCCESS (1.846s) [279.908798] Starting dynamic subtest: evict [282.935439] Dynamic subtest evict: SUCCESS (3.029s) [282.939223] Starting dynamic subtest: hugepages [291.134161] Dynamic subtest hugepages: SUCCESS (8.197s) [291.138849] Starting dynamic subtest: gem_contexts [307.638428] Dynamic subtest gem_contexts: SUCCESS (16.502s) [307.643709] Starting dynamic subtest: client [309.348906] Dynamic subtest client: SUCCESS (1.710s) [309.352777] Starting dynamic subtest: gem_migrate [311.012301] Dynamic subtest gem_migrate: SUCCESS (1.662s) [311.018156] Starting dynamic subtest: reset [316.531983] Dynamic subtest reset: SUCCESS (5.518s) [316.537872] Starting dynamic subtest: memory_region [318.168904] Dynamic subtest memory_region: SUCCESS (1.636s) [318.174929] Starting dynamic subtest: hangcheck [337.120217] Dynamic subtest hangcheck: SUCCESS (18.951s) [337.124116] Starting dynamic subtest: execlists [338.789533] Dynamic subtest execlists: SUCCESS (1.668s) [338.795329] Starting dynamic subtest: ring_submission [340.405600] Dynamic subtest ring_submission: SUCCESS (1.615s) [340.411150] Starting dynamic subtest: perf [342.118526] Dynamic subtest perf: SUCCESS (1.712s) [342.122491] Starting dynamic subtest: slpc [350.301287] Dynamic subtest slpc: SUCCESS (8.182s) [350.305128] Starting dynamic subtest: guc [352.820573] Dynamic subtest guc: SUCCESS (2.518s) [352.825668] Starting dynamic subtest: guc_multi_lrc [354.535770] Dynamic subtest guc_multi_lrc: SUCCESS (1.713s) [354.541543] Starting dynamic subtest: guc_hang [356.828578] Dynamic subtest guc_hang: SUCCESS (2.292s) [356.834470] Starting dynamic subtest: late_gt_pm [358.523729] Dynamic subtest late_gt_pm: SUCCESS (1.694s) [358.525157] Subtest live: SUCCESS (153.875s) [358.539804] [160/165] (633s left) dmabuf (all-tests) [358.573255] Starting subtest: all-tests [358.574310] Starting dynamic subtest: sanitycheck [358.636517] Dynamic subtest sanitycheck: SUCCESS (0.063s) [358.645276] Starting dynamic subtest: dma_fence [358.817575] Dynamic subtest dma_fence: SUCCESS (0.179s) [358.828252] Starting dynamic subtest: dma_fence_chain [368.000517] Dynamic subtest dma_fence_chain: SUCCESS (9.178s) [368.008169] Starting dynamic subtest: dma_fence_unwrap [368.065396] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [368.079527] Starting dynamic subtest: dma_resv [368.147571] Dynamic subtest dma_resv: SUCCESS (0.079s) [368.149603] Subtest all-tests: SUCCESS (9.576s) [368.163926] [161/165] (623s left) i915_suspend (basic-s2idle-without-i915) [368.195164] Starting subtest: basic-s2idle-without-i915 [388.292385] Subtest basic-s2idle-without-i915: SUCCESS (5.493s) [388.575008] [162/165] (617s left) i915_suspend (basic-s3-without-i915) [388.611786] Starting subtest: basic-s3-without-i915 [408.861260] Subtest basic-s3-without-i915: SUCCESS (4.303s) [409.145514] [163/165] (613s left) gem_exec_suspend (basic-s0) [409.185127] Starting subtest: basic-S0 [409.186007] Starting dynamic subtest: smem [427.198510] Dynamic subtest smem: SUCCESS (2.527s) [427.200139] Subtest basic-S0: SUCCESS (2.528s) [427.332372] [164/165] (610s left) gem_exec_suspend (basic-s3) [427.365158] Starting subtest: basic-S3 [427.365986] Starting dynamic subtest: smem [445.207185] Dynamic subtest smem: SUCCESS (2.575s) [445.208377] Subtest basic-S3: SUCCESS (2.576s) [445.354460] [165/165] (607s left) kms_pipe_crc_basic (suspend-read-crc) [445.573329] Starting subtest: suspend-read-crc [445.574207] Starting dynamic subtest: pipe-A-DP-1 [463.316473] Dynamic subtest pipe-A-DP-1: SUCCESS (2.393s) [463.324307] Starting dynamic subtest: pipe-B-DP-1 [481.302206] Dynamic subtest pipe-B-DP-1: SUCCESS (2.264s) [481.307662] Starting dynamic subtest: pipe-C-DP-1 [499.280300] Dynamic subtest pipe-C-DP-1: SUCCESS (2.291s) [499.285546] Starting dynamic subtest: pipe-D-DP-1 [516.275909] Dynamic subtest pipe-D-DP-1: SUCCESS (2.235s) [516.276707] Subtest suspend-read-crc: SUCCESS (9.188s) [516.379927] Closing watchdogs Done.