[42.690618] Initializing watchdogs [42.690716] /dev/watchdog0 [42.697489] [001/165] (960s left) i915_module_load (load) [42.748949] Starting subtest: load [43.680923] Subtest load: SUCCESS (0.928s) [43.704099] [002/165] (959s left) core_auth (basic-auth) [43.786143] Starting subtest: basic-auth [43.787211] Subtest basic-auth: SUCCESS (0.001s) [43.841523] [003/165] (959s left) debugfs_test (read_all_entries) [43.893393] Starting subtest: read_all_entries [43.945054] Subtest read_all_entries: SUCCESS (0.051s) [44.025716] [004/165] (959s left) debugfs_test (basic-hwmon) [44.072109] Starting subtest: basic-hwmon [44.074211] Subtest basic-hwmon: SKIP (0.000s) [44.159724] [005/165] (959s left) fbdev (eof) [44.211460] Starting subtest: eof [44.212591] Subtest eof: SUCCESS (0.000s) [44.257157] [006/165] (959s left) fbdev (info) [44.301067] Starting subtest: info [44.302129] Subtest info: SUCCESS (0.000s) [44.360598] [007/165] (958s left) fbdev (nullptr) [44.412398] Starting subtest: nullptr [44.413427] Subtest nullptr: SUCCESS (0.000s) [44.457116] [008/165] (958s left) fbdev (read) [44.511490] Starting subtest: read [44.592056] Subtest read: SUCCESS (0.081s) [44.641427] [009/165] (958s left) fbdev (write) [44.694540] Starting subtest: write [44.736104] Subtest write: SUCCESS (0.042s) [44.772949] [010/165] (958s left) gem_basic (bad-close) [44.816710] Starting subtest: bad-close [44.818931] Subtest bad-close: SUCCESS (0.000s) [44.872880] [011/165] (958s left) gem_basic (create-close) [44.916357] Starting subtest: create-close [44.918408] Subtest create-close: SUCCESS (0.000s) [44.991505] [012/165] (958s left) gem_basic (create-fd-close) [45.048818] Starting subtest: create-fd-close [45.050995] Subtest create-fd-close: SUCCESS (0.000s) [45.122882] [013/165] (958s left) gem_busy (busy@all-engines) [45.175651] Starting subtest: busy [45.176770] Starting dynamic subtest: all-engines [45.201414] Dynamic subtest all-engines: SUCCESS (0.026s) [45.202584] Subtest busy: SUCCESS (0.026s) [45.506860] [014/165] (957s left) gem_close_race (basic-process) [45.561964] Starting subtest: basic-process [45.597956] Subtest basic-process: SUCCESS (0.035s) [45.758430] [015/165] (957s left) gem_close_race (basic-threads) [45.813427] Starting subtest: basic-threads [47.016366] Subtest basic-threads: SUCCESS (1.203s) [47.189743] [016/165] (956s left) gem_ctx_create (basic) [47.241199] Starting subtest: basic [47.242308] Subtest basic: SUCCESS (0.000s) [47.405732] [017/165] (956s left) gem_ctx_create (basic-files) [47.455671] Starting subtest: basic-files [49.470119] Subtest basic-files: SUCCESS (2.014s) [49.688127] [018/165] (953s left) gem_ctx_exec (basic) [49.735826] Starting subtest: basic [49.738735] Subtest basic: SUCCESS (0.003s) [49.821732] [019/165] (953s left) gem_exec_basic (basic) [49.868750] Starting subtest: basic [49.869903] Starting dynamic subtest: rcs0-smem [49.870953] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [49.876288] Starting dynamic subtest: bcs0-smem [49.877276] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [49.882386] Starting dynamic subtest: vcs0-smem [49.883498] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [49.888568] Starting dynamic subtest: vecs0-smem [49.889617] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [49.890637] Subtest basic: SUCCESS (0.002s) [50.040725] [020/165] (953s left) gem_exec_create (basic) [50.091175] Starting subtest: basic [50.092234] Starting dynamic subtest: smem [52.137629] Dynamic subtest smem: SUCCESS (2.045s) [52.138844] Subtest basic: SUCCESS (2.046s) [52.306877] [021/165] (951s left) gem_exec_fence (basic-busy) [52.474711] Starting subtest: basic-busy [52.475948] Starting dynamic subtest: rcs0 [52.501501] Dynamic subtest rcs0: SUCCESS (0.027s) [52.508752] Starting dynamic subtest: bcs0 [52.525218] Dynamic subtest bcs0: SUCCESS (0.024s) [52.532325] Starting dynamic subtest: vcs0 [52.555193] Dynamic subtest vcs0: SUCCESS (0.030s) [52.561055] Starting dynamic subtest: vecs0 [52.581159] Dynamic subtest vecs0: SUCCESS (0.026s) [52.583943] Subtest basic-busy: SUCCESS (0.107s) [53.041280] [022/165] (950s left) gem_exec_fence (basic-wait) [53.210987] Starting subtest: basic-wait [53.212191] Starting dynamic subtest: rcs0 [53.243481] Dynamic subtest rcs0: SUCCESS (0.032s) [53.249723] Starting dynamic subtest: bcs0 [53.272368] Dynamic subtest bcs0: SUCCESS (0.029s) [53.277958] Starting dynamic subtest: vcs0 [53.299360] Dynamic subtest vcs0: SUCCESS (0.027s) [53.304966] Starting dynamic subtest: vecs0 [53.325891] Dynamic subtest vecs0: SUCCESS (0.026s) [53.327238] Subtest basic-wait: SUCCESS (0.115s) [53.754404] [023/165] (949s left) gem_exec_fence (basic-await) [53.919657] Starting subtest: basic-await [53.920817] Starting dynamic subtest: rcs0 [53.991802] Dynamic subtest rcs0: SUCCESS (0.072s) [53.998797] Starting dynamic subtest: bcs0 [54.065395] Dynamic subtest bcs0: SUCCESS (0.073s) [54.071519] Starting dynamic subtest: vcs0 [54.137835] Dynamic subtest vcs0: SUCCESS (0.073s) [54.144081] Starting dynamic subtest: vecs0 [54.213583] Dynamic subtest vecs0: SUCCESS (0.075s) [54.214822] Subtest basic-await: SUCCESS (0.293s) [54.639641] [024/165] (948s left) gem_exec_fence (nb-await) [54.804963] Starting subtest: nb-await [54.806156] Starting dynamic subtest: rcs0 [54.858909] Dynamic subtest rcs0: SUCCESS (0.054s) [54.864688] Starting dynamic subtest: bcs0 [54.911430] Dynamic subtest bcs0: SUCCESS (0.052s) [54.919275] Starting dynamic subtest: vcs0 [54.968305] Dynamic subtest vcs0: SUCCESS (0.057s) [54.974995] Starting dynamic subtest: vecs0 [55.024073] Dynamic subtest vecs0: SUCCESS (0.056s) [55.025185] Subtest nb-await: SUCCESS (0.220s) [55.457458] [025/165] (948s left) gem_exec_gttfill (basic) [55.511670] Starting subtest: basic [58.622663] Subtest basic: SUCCESS (3.110s) [58.787986] [026/165] (944s left) gem_exec_parallel (engines) [58.896962] Starting subtest: engines [58.898146] Starting dynamic subtest: basic [60.243718] Dynamic subtest basic: SUCCESS (1.347s) [60.250145] Starting dynamic subtest: contexts [61.732541] Dynamic subtest contexts: SUCCESS (1.488s) [61.740180] Starting dynamic subtest: fds [63.420490] Dynamic subtest fds: SUCCESS (1.688s) [63.427323] Starting dynamic subtest: userptr [64.818377] Dynamic subtest userptr: SUCCESS (1.398s) [64.819479] Subtest engines: SUCCESS (5.921s) [64.997424] [027/165] (938s left) gem_exec_store (basic) [65.052643] Starting subtest: basic [65.097283] Subtest basic: SUCCESS (0.044s) [65.268814] [028/165] (938s left) gem_flink_basic (bad-flink) [65.313242] Starting subtest: bad-flink [65.314208] Subtest bad-flink: SUCCESS (0.000s) [65.370453] [029/165] (938s left) gem_flink_basic (bad-open) [65.413609] Starting subtest: bad-open [65.414717] Subtest bad-open: SUCCESS (0.000s) [65.468488] [030/165] (938s left) gem_flink_basic (basic) [65.511293] Starting subtest: basic [65.512467] Subtest basic: SUCCESS (0.000s) [65.591834] [031/165] (938s left) gem_flink_basic (double-flink) [65.635990] Starting subtest: double-flink [65.637021] Subtest double-flink: SUCCESS (0.000s) [65.702918] [032/165] (937s left) gem_flink_basic (flink-lifetime) [65.749436] Starting subtest: flink-lifetime [65.750561] Subtest flink-lifetime: SUCCESS (0.001s) [65.820214] [033/165] (937s left) gem_huc_copy (huc-copy) [65.869391] Subtest huc-copy: SKIP (0.000s) [65.900302] [034/165] (937s left) gem_linear_blits (basic) [66.011372] Starting subtest: basic [66.017611] Subtest basic: SUCCESS (0.006s) [66.113821] [035/165] (937s left) gem_mmap (basic) [66.225735] Starting subtest: basic [66.230860] Subtest basic: SUCCESS (0.000s) [66.305865] [036/165] (937s left) gem_mmap_gtt (basic) [66.351492] Starting subtest: basic [66.352600] Subtest basic: SUCCESS (0.000s) [66.398601] [037/165] (937s left) gem_render_linear_blits (basic) [66.448180] Starting subtest: basic [66.463085] Subtest basic: SUCCESS (0.016s) [66.498774] [038/165] (937s left) gem_render_tiled_blits (basic) [66.544512] Starting subtest: basic [66.562118] Subtest basic: SUCCESS (0.018s) [66.618064] [039/165] (937s left) gem_ringfill (basic-all) [66.776518] Starting subtest: basic-all [67.884836] Subtest basic-all: SUCCESS (1.107s) [67.969633] [040/165] (935s left) gem_softpin (allocator-basic) [68.019931] Subtest allocator-basic: SKIP (0.000s) [68.070516] [041/165] (935s left) gem_softpin (allocator-basic-reserve) [68.124460] Subtest allocator-basic-reserve: SKIP (0.000s) [68.186986] [042/165] (935s left) gem_softpin (safe-alignment) [68.235626] Starting subtest: safe-alignment [68.242369] Subtest safe-alignment: SUCCESS (0.009s) [68.335137] [043/165] (935s left) gem_sync (basic-all) [68.388090] Starting subtest: basic-all [70.548313] Subtest basic-all: SUCCESS (2.159s) [70.720428] [044/165] (933s left) gem_sync (basic-each) [70.773030] Starting subtest: basic-each [72.853962] Subtest basic-each: SUCCESS (2.079s) [73.017558] [045/165] (930s left) gem_tiled_blits (basic) [73.123708] Starting subtest: basic [73.134345] Subtest basic: SUCCESS (0.011s) [73.226328] [046/165] (930s left) gem_tiled_fence_blits (basic) [73.396689] Starting subtest: basic [73.402247] Subtest basic: SUCCESS (0.006s) [73.511825] [047/165] (930s left) gem_tiled_pread_basic [73.786456] [048/165] (930s left) gem_wait (busy@all-engines) [73.840875] Starting subtest: busy [73.842029] Starting dynamic subtest: all-engines [74.355575] Dynamic subtest all-engines: SUCCESS (0.514s) [74.356885] Subtest busy: SUCCESS (0.515s) [74.537547] [049/165] (929s left) gem_wait (wait@all-engines) [74.594928] Starting subtest: wait [74.596069] Starting dynamic subtest: all-engines [75.607382] Dynamic subtest all-engines: SUCCESS (1.014s) [75.608564] Subtest wait: SUCCESS (1.014s) [75.785198] [050/165] (928s left) i915_getparams_basic (basic-eu-total) [75.829436] Starting subtest: basic-eu-total [75.831593] Subtest basic-eu-total: SUCCESS (0.000s) [75.883805] [051/165] (928s left) i915_getparams_basic (basic-subslice-total) [75.929962] Starting subtest: basic-subslice-total [75.932038] Subtest basic-subslice-total: SUCCESS (0.000s) [75.985296] [052/165] (927s left) i915_hangman (error-state-basic) [76.035541] Starting subtest: error-state-basic [76.040325] Subtest error-state-basic: SUCCESS (0.004s) [76.122455] [053/165] (927s left) i915_pciid [76.216238] [054/165] (927s left) kms_addfb_basic (addfb25-4-tiled) [76.292607] Starting subtest: addfb25-4-tiled [76.293725] Subtest addfb25-4-tiled: SUCCESS (0.000s) [76.366312] [055/165] (927s left) kms_addfb_basic (addfb25-bad-modifier) [76.410845] Starting subtest: addfb25-bad-modifier [76.411963] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [76.502912] [056/165] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [76.548291] Starting subtest: addfb25-framebuffer-vs-set-tiling [76.549312] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [76.634474] [057/165] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [76.680456] Starting subtest: addfb25-modifier-no-flag [76.681439] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [76.767633] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy) [76.812956] Starting subtest: addfb25-x-tiled-legacy [76.813987] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [76.900583] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [76.946663] Starting subtest: addfb25-x-tiled-mismatch-legacy [76.947689] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [77.052165] [060/165] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [77.119769] Starting subtest: addfb25-yf-tiled-legacy [77.120788] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [77.203982] [061/165] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy) [77.271332] Starting subtest: addfb25-y-tiled-legacy [77.272401] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [77.333203] [062/165] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [77.397839] Starting subtest: addfb25-y-tiled-small-legacy [77.399791] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [77.467129] [063/165] (926s left) kms_addfb_basic (bad-pitch-0) [77.511456] Starting subtest: bad-pitch-0 [77.512554] Subtest bad-pitch-0: SUCCESS (0.000s) [77.600767] [064/165] (926s left) kms_addfb_basic (bad-pitch-1024) [77.645260] Starting subtest: bad-pitch-1024 [77.646338] Subtest bad-pitch-1024: SUCCESS (0.000s) [77.734614] [065/165] (926s left) kms_addfb_basic (bad-pitch-128) [77.779382] Starting subtest: bad-pitch-128 [77.780357] Subtest bad-pitch-128: SUCCESS (0.000s) [77.868305] [066/165] (926s left) kms_addfb_basic (bad-pitch-256) [77.913390] Starting subtest: bad-pitch-256 [77.914555] Subtest bad-pitch-256: SUCCESS (0.000s) [78.015792] [067/165] (926s left) kms_addfb_basic (bad-pitch-32) [78.071340] Starting subtest: bad-pitch-32 [78.072376] Subtest bad-pitch-32: SUCCESS (0.000s) [78.166173] [068/165] (926s left) kms_addfb_basic (bad-pitch-63) [78.211811] Starting subtest: bad-pitch-63 [78.212929] Subtest bad-pitch-63: SUCCESS (0.000s) [78.299942] [069/165] (925s left) kms_addfb_basic (bad-pitch-65536) [78.343363] Starting subtest: bad-pitch-65536 [78.344518] Subtest bad-pitch-65536: SUCCESS (0.000s) [78.435780] [070/165] (925s left) kms_addfb_basic (bad-pitch-999) [78.482222] Starting subtest: bad-pitch-999 [78.483316] Subtest bad-pitch-999: SUCCESS (0.000s) [78.565714] [071/165] (925s left) kms_addfb_basic (basic) [78.610841] Starting subtest: basic [78.611865] Subtest basic: SUCCESS (0.000s) [78.699831] [072/165] (925s left) kms_addfb_basic (basic-x-tiled-legacy) [78.746624] Starting subtest: basic-x-tiled-legacy [78.747698] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [78.834926] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy) [78.880239] Starting subtest: basic-y-tiled-legacy [78.881273] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [78.966574] [074/165] (925s left) kms_addfb_basic (bo-too-small) [79.034248] Starting subtest: bo-too-small [79.035242] Subtest bo-too-small: SUCCESS (0.000s) [79.099350] [075/165] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling) [79.171284] Starting subtest: bo-too-small-due-to-tiling [79.172402] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [79.249154] [076/165] (925s left) kms_addfb_basic (clobberred-modifier) [79.291815] Starting subtest: clobberred-modifier [79.292973] Subtest clobberred-modifier: SUCCESS (0.000s) [79.382396] [077/165] (924s left) kms_addfb_basic (framebuffer-vs-set-tiling) [79.427636] Starting subtest: framebuffer-vs-set-tiling [79.428813] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.521498] [078/165] (924s left) kms_addfb_basic (invalid-get-prop) [79.566895] Starting subtest: invalid-get-prop [79.567927] Subtest invalid-get-prop: SUCCESS (0.000s) [79.650534] [079/165] (924s left) kms_addfb_basic (invalid-get-prop-any) [79.699100] Starting subtest: invalid-get-prop-any [79.700146] Subtest invalid-get-prop-any: SUCCESS (0.000s) [79.782155] [080/165] (924s left) kms_addfb_basic (invalid-set-prop) [79.830069] Starting subtest: invalid-set-prop [79.831122] Subtest invalid-set-prop: SUCCESS (0.000s) [79.917754] [081/165] (924s left) kms_addfb_basic (invalid-set-prop-any) [79.962643] Starting subtest: invalid-set-prop-any [79.963856] Subtest invalid-set-prop-any: SUCCESS (0.000s) [80.050846] [082/165] (924s left) kms_addfb_basic (no-handle) [80.094347] Starting subtest: no-handle [80.095440] Subtest no-handle: SUCCESS (0.000s) [80.182197] [083/165] (924s left) kms_addfb_basic (size-max) [80.250748] Starting subtest: size-max [80.251747] Subtest size-max: SUCCESS (0.000s) [80.318086] [084/165] (924s left) kms_addfb_basic (small-bo) [80.384627] Starting subtest: small-bo [80.385604] Subtest small-bo: SUCCESS (0.000s) [80.448806] [085/165] (924s left) kms_addfb_basic (tile-pitch-mismatch) [80.495264] Starting subtest: tile-pitch-mismatch [80.496320] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [80.582539] [086/165] (923s left) kms_addfb_basic (too-high) [80.645474] Starting subtest: too-high [80.646496] Subtest too-high: SUCCESS (0.001s) [80.715337] [087/165] (923s left) kms_addfb_basic (too-wide) [80.782567] Starting subtest: too-wide [80.783578] Subtest too-wide: SUCCESS (0.000s) [80.850312] [088/165] (923s left) kms_addfb_basic (unused-handle) [80.894661] Starting subtest: unused-handle [80.895717] Subtest unused-handle: SUCCESS (0.000s) [80.982886] [089/165] (923s left) kms_addfb_basic (unused-modifier) [81.028210] Starting subtest: unused-modifier [81.029194] Subtest unused-modifier: SUCCESS (0.000s) [81.114885] [090/165] (923s left) kms_addfb_basic (unused-offsets) [81.162593] Starting subtest: unused-offsets [81.163526] Subtest unused-offsets: SUCCESS (0.000s) [81.249324] [091/165] (923s left) kms_addfb_basic (unused-pitches) [81.295457] Starting subtest: unused-pitches [81.296549] Subtest unused-pitches: SUCCESS (0.000s) [81.382297] [092/165] (923s left) kms_busy (basic) [81.451880] Starting subtest: basic [81.455676] Starting dynamic subtest: flip [81.908496] Dynamic subtest flip: SUCCESS (0.456s) [81.915045] Starting dynamic subtest: modeset [82.416812] Dynamic subtest modeset: SUCCESS (0.508s) [82.418077] Subtest basic: SUCCESS (0.966s) [82.555600] [093/165] (922s left) kms_prop_blob (basic) [82.604605] Starting subtest: basic [82.605765] Subtest basic: SUCCESS (0.000s) [82.655394] [094/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [82.723027] Starting subtest: basic-busy-flip-before-cursor-atomic [83.646930] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.923s) [83.783688] [095/165] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [83.849742] Starting subtest: basic-busy-flip-before-cursor-legacy [84.804190] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.953s) [84.932246] [096/165] (919s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [84.998861] Starting subtest: basic-flip-after-cursor-atomic [85.923793] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.926s) [86.057461] [097/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [86.123673] Starting subtest: basic-flip-after-cursor-legacy [87.046762] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.922s) [87.175732] [098/165] (917s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [87.240677] Starting subtest: basic-flip-after-cursor-varying-size [88.182380] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.941s) [88.316423] [099/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [88.386692] Starting subtest: basic-flip-before-cursor-atomic [89.319907] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.933s) [89.454676] [100/165] (915s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [89.521116] Starting subtest: basic-flip-before-cursor-legacy [90.460794] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.940s) [90.594435] [101/165] (914s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [90.661706] Starting subtest: basic-flip-before-cursor-varying-size [91.582777] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.920s) [91.712341] [102/165] (913s left) kms_dsc (dsc-basic) [91.779676] Subtest dsc-basic: SKIP (0.000s) [91.808132] [103/165] (912s left) kms_flip (basic-flip-vs-dpms) [91.866888] Starting subtest: basic-flip-vs-dpms [91.869080] Starting dynamic subtest: A-VGA1 [92.711176] Dynamic subtest A-VGA1: SUCCESS (0.839s) [92.717819] Starting dynamic subtest: B-VGA1 [93.506878] Dynamic subtest B-VGA1: SUCCESS (0.799s) [93.513827] Starting dynamic subtest: C-VGA1 [94.305186] Dynamic subtest C-VGA1: SUCCESS (0.799s) [94.309454] Subtest basic-flip-vs-dpms: SUCCESS (2.441s) [94.453055] [104/165] (910s left) kms_flip (basic-flip-vs-modeset) [94.513138] Starting subtest: basic-flip-vs-modeset [94.515295] Starting dynamic subtest: A-VGA1 [95.396132] Dynamic subtest A-VGA1: SUCCESS (0.881s) [95.403278] Starting dynamic subtest: B-VGA1 [96.206045] Dynamic subtest B-VGA1: SUCCESS (0.809s) [96.212752] Starting dynamic subtest: C-VGA1 [97.012039] Dynamic subtest C-VGA1: SUCCESS (0.806s) [97.014197] Subtest basic-flip-vs-modeset: SUCCESS (2.502s) [97.158560] [105/165] (907s left) kms_flip (basic-flip-vs-wf_vblank) [97.218403] Starting subtest: basic-flip-vs-wf_vblank [97.221728] Starting dynamic subtest: A-VGA1 [98.368278] Dynamic subtest A-VGA1: SUCCESS (1.146s) [98.375504] Starting dynamic subtest: B-VGA1 [99.491978] Dynamic subtest B-VGA1: SUCCESS (1.123s) [99.499511] Starting dynamic subtest: C-VGA1 [100.618289] Dynamic subtest C-VGA1: SUCCESS (1.125s) [100.622662] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.405s) [100.793916] [106/165] (904s left) kms_flip (basic-plain-flip) [100.851346] Starting subtest: basic-plain-flip [100.853384] Starting dynamic subtest: A-VGA1 [101.716734] Dynamic subtest A-VGA1: SUCCESS (0.863s) [101.723368] Starting dynamic subtest: B-VGA1 [102.559565] Dynamic subtest B-VGA1: SUCCESS (0.840s) [102.568063] Starting dynamic subtest: C-VGA1 [103.395544] Dynamic subtest C-VGA1: SUCCESS (0.836s) [103.397901] Subtest basic-plain-flip: SUCCESS (2.546s) [103.586809] [107/165] (901s left) kms_force_connector_basic (force-connector-state) [103.644812] Starting subtest: force-connector-state [103.780149] Subtest force-connector-state: SUCCESS (0.134s) [103.972948] [108/165] (900s left) kms_force_connector_basic (force-edid) [104.028483] Starting subtest: force-edid [104.051062] Subtest force-edid: SUCCESS (0.021s) [104.168536] [109/165] (900s left) kms_force_connector_basic (force-load-detect) [104.223856] Starting subtest: force-load-detect [104.376324] Subtest force-load-detect: SUCCESS (0.153s) [104.562964] [110/165] (900s left) kms_force_connector_basic (prune-stale-modes) [104.621157] Starting subtest: prune-stale-modes [104.638314] Subtest prune-stale-modes: SUCCESS (0.017s) [104.741091] [111/165] (900s left) kms_frontbuffer_tracking (basic) [104.822348] Starting subtest: basic [106.660373] Subtest basic: SUCCESS (1.840s) [106.725955] [112/165] (898s left) kms_hdmi_inject (inject-audio) [106.815390] Starting subtest: inject-audio [106.913336] Subtest inject-audio: SUCCESS (0.099s) [107.093570] [113/165] (897s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [107.163292] Starting subtest: compare-crc-sanitycheck-xr24 [107.164375] Starting dynamic subtest: pipe-A-VGA-1 [107.431727] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.268s) [107.438582] Starting dynamic subtest: pipe-B-VGA-1 [107.695318] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.262s) [107.703328] Starting dynamic subtest: pipe-C-VGA-1 [107.962661] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.265s) [107.963765] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.800s) [108.094248] [114/165] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [108.160751] Starting subtest: compare-crc-sanitycheck-nv12 [108.161798] Starting dynamic subtest: pipe-A-VGA-1 [108.163812] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [108.170986] Starting dynamic subtest: pipe-B-VGA-1 [108.172950] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [108.179335] Starting dynamic subtest: pipe-C-VGA-1 [108.181495] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [108.183695] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s) [108.224581] [115/165] (896s left) kms_pipe_crc_basic (hang-read-crc) [108.291261] Starting subtest: hang-read-crc [108.292314] Starting dynamic subtest: pipe-A-VGA-1 [109.023899] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.732s) [109.030907] Starting dynamic subtest: pipe-B-VGA-1 [109.749972] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.725s) [109.758483] Starting dynamic subtest: pipe-C-VGA-1 [110.476724] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.726s) [110.477827] Subtest hang-read-crc: SUCCESS (2.186s) [110.595747] [116/165] (894s left) kms_pipe_crc_basic (nonblocking-crc) [110.663766] Starting subtest: nonblocking-crc [110.664834] Starting dynamic subtest: pipe-A-VGA-1 [111.099802] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.435s) [111.107178] Starting dynamic subtest: pipe-B-VGA-1 [111.529946] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.429s) [111.537020] Starting dynamic subtest: pipe-C-VGA-1 [111.960541] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.429s) [111.961644] Subtest nonblocking-crc: SUCCESS (1.296s) [112.083821] [117/165] (892s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [112.151942] Starting subtest: nonblocking-crc-frame-sequence [112.152998] Starting dynamic subtest: pipe-A-VGA-1 [112.590291] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.436s) [112.597478] Starting dynamic subtest: pipe-B-VGA-1 [113.019767] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.429s) [113.026680] Starting dynamic subtest: pipe-C-VGA-1 [113.449284] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.429s) [113.450371] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.297s) [113.567510] [118/165] (891s left) kms_pipe_crc_basic (read-crc) [113.635819] Starting subtest: read-crc [113.636930] Starting dynamic subtest: pipe-A-VGA-1 [114.008933] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.372s) [114.016076] Starting dynamic subtest: pipe-B-VGA-1 [114.370182] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s) [114.377042] Starting dynamic subtest: pipe-C-VGA-1 [114.730869] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.360s) [114.731998] Subtest read-crc: SUCCESS (1.095s) [114.852778] [119/165] (890s left) kms_pipe_crc_basic (read-crc-frame-sequence) [114.922862] Starting subtest: read-crc-frame-sequence [114.923924] Starting dynamic subtest: pipe-A-VGA-1 [115.290036] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.366s) [115.297061] Starting dynamic subtest: pipe-B-VGA-1 [115.653161] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.361s) [115.660248] Starting dynamic subtest: pipe-C-VGA-1 [116.014876] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.362s) [116.015951] Subtest read-crc-frame-sequence: SUCCESS (1.093s) [116.134192] [120/165] (888s left) kms_pm_backlight (basic-brightness) [116.206670] Subtest basic-brightness: SKIP (0.000s) [116.225935] [121/165] (888s left) kms_psr (primary_page_flip) [116.271834] Subtest primary_page_flip: SKIP (0.000s) [116.293182] [122/165] (888s left) kms_psr (cursor_plane_move) [116.336979] Subtest cursor_plane_move: SKIP (0.000s) [116.359790] [123/165] (888s left) kms_psr (sprite_plane_onoff) [116.404387] Subtest sprite_plane_onoff: SKIP (0.000s) [116.427189] [124/165] (888s left) kms_psr (primary_mmap_gtt) [116.473165] Subtest primary_mmap_gtt: SKIP (0.000s) [116.495237] [125/165] (888s left) kms_setmode (basic-clone-single-crtc) [116.540025] Starting subtest: basic-clone-single-crtc [116.543142] Subtest basic-clone-single-crtc: SKIP (0.000s) [116.597511] [126/165] (888s left) i915_pm_rpm (basic-pci-d3-state) [117.943796] Starting subtest: basic-pci-d3-state [118.135852] Subtest basic-pci-d3-state: SUCCESS (0.191s) [118.381541] [127/165] (886s left) i915_pm_rpm (basic-rte) [118.425609] Starting subtest: basic-rte [119.911899] Subtest basic-rte: SUCCESS (1.483s) [120.362412] [128/165] (884s left) i915_pm_rps (basic-api) [120.411408] Starting subtest: basic-api [120.413728] Subtest basic-api: SUCCESS (0.002s) [120.480142] [129/165] (884s left) prime_self_import (basic-llseek-bad) [120.522997] Starting subtest: basic-llseek-bad [120.525065] Subtest basic-llseek-bad: SUCCESS (0.001s) [120.593360] [130/165] (884s left) prime_self_import (basic-llseek-size) [120.634994] Starting subtest: basic-llseek-size [120.637185] Subtest basic-llseek-size: SUCCESS (0.002s) [120.714952] [131/165] (884s left) prime_self_import (basic-with_fd_dup) [120.761425] Starting subtest: basic-with_fd_dup [120.763475] Subtest basic-with_fd_dup: SUCCESS (0.002s) [120.826353] [132/165] (884s left) prime_self_import (basic-with_one_bo) [120.871425] Starting subtest: basic-with_one_bo [120.873601] Subtest basic-with_one_bo: SUCCESS (0.002s) [120.923388] [133/165] (884s left) prime_self_import (basic-with_one_bo_two_files) [120.967673] Starting subtest: basic-with_one_bo_two_files [120.969971] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [121.043563] [134/165] (884s left) prime_self_import (basic-with_two_bos) [121.089813] Starting subtest: basic-with_two_bos [121.092051] Subtest basic-with_two_bos: SUCCESS (0.002s) [121.161129] [135/165] (884s left) prime_vgem (basic-fence-flip) [121.216167] Starting subtest: basic-fence-flip [121.545847] Subtest basic-fence-flip: SUCCESS (0.329s) [121.629997] [136/165] (883s left) prime_vgem (basic-fence-mmap) [121.681796] Starting subtest: basic-fence-mmap [121.705121] Subtest basic-fence-mmap: SUCCESS (0.023s) [121.778318] [137/165] (883s left) prime_vgem (basic-fence-read) [121.834214] Starting subtest: basic-fence-read [121.871295] Subtest basic-fence-read: SUCCESS (0.037s) [121.927806] [138/165] (883s left) prime_vgem (basic-gtt) [121.982926] Starting subtest: basic-gtt [121.995224] Subtest basic-gtt: SUCCESS (0.012s) [122.076870] [139/165] (883s left) prime_vgem (basic-read) [122.132984] Starting subtest: basic-read [122.150022] Subtest basic-read: SUCCESS (0.017s) [122.228690] [140/165] (883s left) prime_vgem (basic-write) [122.283873] Starting subtest: basic-write [122.301369] Subtest basic-write: SUCCESS (0.019s) [122.378577] [141/165] (883s left) vgem_basic (setversion) [122.429672] Starting subtest: setversion [122.431989] Subtest setversion: SUCCESS (0.000s) [122.477133] [142/165] (882s left) vgem_basic (create) [122.529697] Starting subtest: create [122.530900] Subtest create: SUCCESS (0.000s) [122.577076] [143/165] (882s left) vgem_basic (debugfs) [122.629654] Starting subtest: debugfs [122.630784] Subtest debugfs: SUCCESS (0.000s) [122.678490] [144/165] (882s left) vgem_basic (dmabuf-export) [122.746586] Starting subtest: dmabuf-export [122.748809] Subtest dmabuf-export: SUCCESS (0.002s) [122.827433] [145/165] (882s left) vgem_basic (dmabuf-fence) [122.879725] Starting subtest: dmabuf-fence [122.880860] Subtest dmabuf-fence: SUCCESS (0.001s) [122.927104] [146/165] (882s left) vgem_basic (dmabuf-fence-before) [122.981820] Starting subtest: dmabuf-fence-before [122.982908] Subtest dmabuf-fence-before: SUCCESS (0.000s) [123.027810] [147/165] (882s left) vgem_basic (dmabuf-mmap) [123.079601] Starting subtest: dmabuf-mmap [123.093954] Subtest dmabuf-mmap: SUCCESS (0.015s) [123.143971] [148/165] (882s left) vgem_basic (mmap) [123.196145] Starting subtest: mmap [123.205141] Subtest mmap: SUCCESS (0.010s) [123.243445] [149/165] (882s left) vgem_basic (second-client) [123.295977] Starting subtest: second-client [123.329605] Subtest second-client: SUCCESS (0.033s) [123.376641] [150/165] (882s left) vgem_basic (sysfs) [123.429454] Starting subtest: sysfs [123.430703] Subtest sysfs: SUCCESS (0.001s) [123.478809] [151/165] (882s left) core_hotunplug (unbind-rebind) [123.564150] Starting subtest: unbind-rebind [126.379873] Subtest unbind-rebind: SUCCESS (2.816s) [126.398406] [152/165] (879s left) vgem_basic (unload) [126.444471] Starting subtest: unload [155.350140] Subtest unload: SUCCESS (28.905s) [155.423549] [153/165] (850s left) i915_module_load (reload) [155.467175] Starting subtest: reload [157.399442] Subtest reload: SUCCESS (1.933s) [157.424451] [154/165] (848s left) gem_lmem_swapping (basic) [157.496671] Subtest basic: SKIP (0.000s) [157.526950] [155/165] (848s left) gem_lmem_swapping (parallel-random-engines) [157.576522] Subtest parallel-random-engines: SKIP (0.000s) [157.609089] [156/165] (848s left) gem_lmem_swapping (random-engines) [157.659567] Subtest random-engines: SKIP (0.000s) [157.674896] [157/165] (847s left) gem_lmem_swapping (verify-random) [157.723731] Subtest verify-random: SKIP (0.000s) [157.742836] [158/165] (847s left) i915_pm_rpm (module-reload) [159.741148] Starting subtest: module-reload [166.375365] Subtest module-reload: SUCCESS (6.634s) [166.390191] [159/165] (839s left) i915_selftest (live) [166.443460] Starting subtest: live [166.444579] Starting dynamic subtest: sanitycheck [167.101181] Dynamic subtest sanitycheck: SUCCESS (0.655s) [167.108233] Starting dynamic subtest: uncore [167.826911] Dynamic subtest uncore: SUCCESS (0.723s) [167.834415] Starting dynamic subtest: workarounds [168.567466] Dynamic subtest workarounds: SUCCESS (0.738s) [168.574685] Starting dynamic subtest: gt_engines [169.205200] Dynamic subtest gt_engines: SUCCESS (0.636s) [169.212634] Starting dynamic subtest: gt_timelines [175.134077] Dynamic subtest gt_timelines: SUCCESS (5.927s) [175.140865] Starting dynamic subtest: gt_contexts [175.844068] Dynamic subtest gt_contexts: SUCCESS (0.709s) [175.850642] Starting dynamic subtest: gt_lrc [176.483295] Dynamic subtest gt_lrc: SUCCESS (0.638s) [176.490551] Starting dynamic subtest: gt_mocs [177.095564] Dynamic subtest gt_mocs: SUCCESS (0.610s) [177.101868] Starting dynamic subtest: gt_pm [187.527218] Dynamic subtest gt_pm: SUCCESS (10.429s) [187.532957] Starting dynamic subtest: gt_heartbeat [188.336980] Dynamic subtest gt_heartbeat: SUCCESS (0.809s) [188.342953] Starting dynamic subtest: gt_tlb [188.963505] Dynamic subtest gt_tlb: SUCCESS (0.625s) [188.971051] Starting dynamic subtest: requests [195.255187] Dynamic subtest requests: SUCCESS (6.290s) [195.262825] Starting dynamic subtest: migrate [195.920523] Dynamic subtest migrate: SUCCESS (0.663s) [195.926743] Starting dynamic subtest: active [196.597868] Dynamic subtest active: SUCCESS (0.675s) [196.603503] Starting dynamic subtest: objects [197.596421] Dynamic subtest objects: SUCCESS (0.996s) [197.604296] Starting dynamic subtest: mman [201.719992] Dynamic subtest mman: SUCCESS (4.122s) [201.727280] Starting dynamic subtest: dmabuf [202.417471] Dynamic subtest dmabuf: SUCCESS (0.696s) [202.424474] Starting dynamic subtest: vma [203.073310] Dynamic subtest vma: SUCCESS (0.653s) [203.081643] Starting dynamic subtest: coherency [204.329890] Dynamic subtest coherency: SUCCESS (1.254s) [204.337216] Starting dynamic subtest: gtt [208.453163] Dynamic subtest gtt: SUCCESS (4.121s) [208.460376] Starting dynamic subtest: gem [209.287039] Dynamic subtest gem: SUCCESS (0.832s) [209.293751] Starting dynamic subtest: evict [209.955922] Dynamic subtest evict: SUCCESS (0.667s) [209.965204] Starting dynamic subtest: hugepages [211.134435] Dynamic subtest hugepages: SUCCESS (1.176s) [211.142810] Starting dynamic subtest: gem_contexts [216.003801] Dynamic subtest gem_contexts: SUCCESS (4.867s) [216.010656] Starting dynamic subtest: client [216.631917] Dynamic subtest client: SUCCESS (0.626s) [216.639285] Starting dynamic subtest: gem_migrate [217.254232] Dynamic subtest gem_migrate: SUCCESS (0.620s) [217.259994] Starting dynamic subtest: reset [219.044448] Dynamic subtest reset: SUCCESS (1.789s) [219.051603] Starting dynamic subtest: memory_region [219.680287] Dynamic subtest memory_region: SUCCESS (0.634s) [219.687958] Starting dynamic subtest: hangcheck [237.160229] Dynamic subtest hangcheck: SUCCESS (17.477s) [237.167428] Starting dynamic subtest: execlists [237.802208] Dynamic subtest execlists: SUCCESS (0.640s) [237.808415] Starting dynamic subtest: ring_submission [238.405045] Dynamic subtest ring_submission: SUCCESS (0.602s) [238.411682] Starting dynamic subtest: perf [239.117257] Dynamic subtest perf: SUCCESS (0.710s) [239.123205] Starting dynamic subtest: slpc [239.787972] Dynamic subtest slpc: SUCCESS (0.669s) [239.794843] Starting dynamic subtest: guc [240.356790] Dynamic subtest guc: SUCCESS (0.567s) [240.365159] Starting dynamic subtest: guc_multi_lrc [241.002959] Dynamic subtest guc_multi_lrc: SUCCESS (0.644s) [241.008750] Starting dynamic subtest: guc_hang [241.689994] Dynamic subtest guc_hang: SUCCESS (0.685s) [241.698884] Starting dynamic subtest: late_gt_pm [242.353143] Dynamic subtest late_gt_pm: SUCCESS (0.659s) [242.354145] Subtest live: SUCCESS (75.909s) [242.370237] [160/165] (763s left) dmabuf (all-tests) [242.419702] Starting subtest: all-tests [242.423243] Starting dynamic subtest: sanitycheck [242.492871] Dynamic subtest sanitycheck: SUCCESS (0.072s) [242.504202] Starting dynamic subtest: dma_fence [242.672659] Dynamic subtest dma_fence: SUCCESS (0.177s) [242.681696] Starting dynamic subtest: dma_fence_chain [254.208118] Dynamic subtest dma_fence_chain: SUCCESS (11.533s) [254.215904] Starting dynamic subtest: dma_fence_unwrap [254.279214] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s) [254.287926] Starting dynamic subtest: dma_resv [254.348943] Dynamic subtest dma_resv: SUCCESS (0.068s) [254.350310] Subtest all-tests: SUCCESS (11.930s) [254.363735] [161/165] (751s left) i915_suspend (basic-s2idle-without-i915) [254.408051] Starting subtest: basic-s2idle-without-i915 [271.494349] Subtest basic-s2idle-without-i915: SUCCESS (1.741s) [278.619274] [162/165] (749s left) i915_suspend (basic-s3-without-i915) [278.664600] Starting subtest: basic-s3-without-i915 [296.669217] Subtest basic-s3-without-i915: SUCCESS (1.619s) [309.737949] [163/165] (747s left) gem_exec_suspend (basic-s0) [309.797779] Starting subtest: basic-S0 [309.799106] Starting dynamic subtest: smem [326.495949] Dynamic subtest smem: SUCCESS (1.107s) [326.497308] Subtest basic-S0: SUCCESS (1.109s) [332.748794] [164/165] (746s left) gem_exec_suspend (basic-s3) [332.806070] Starting subtest: basic-S3 [332.807075] Starting dynamic subtest: smem [350.515254] Dynamic subtest smem: SUCCESS (1.127s) [350.516703] Subtest basic-S3: SUCCESS (1.129s) [356.668445] [165/165] (745s left) kms_pipe_crc_basic (suspend-read-crc) [356.737478] Starting subtest: suspend-read-crc [356.738645] Starting dynamic subtest: pipe-A-VGA-1 [374.655268] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.286s) [374.663663] Starting dynamic subtest: pipe-B-VGA-1 [392.674519] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.289s) [392.684067] Starting dynamic subtest: pipe-C-VGA-1 [410.665730] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.290s) [410.666813] Subtest suspend-read-crc: SUCCESS (3.870s) [415.769854] Closing watchdogs Done.