[46.029412] Initializing watchdogs [46.029510] /dev/watchdog0 [46.038966] [001/165] (960s left) i915_module_load (load) [46.302619] Starting subtest: load [48.729603] Subtest load: SUCCESS (2.427s) [48.750513] [002/165] (957s left) core_auth (basic-auth) [48.872721] Starting subtest: basic-auth [48.876276] Subtest basic-auth: SUCCESS (0.004s) [48.954854] [003/165] (957s left) debugfs_test (read_all_entries) [49.041493] Starting subtest: read_all_entries [49.188918] Subtest read_all_entries: SUCCESS (0.146s) [49.507161] [004/165] (957s left) debugfs_test (basic-hwmon) [49.601020] Starting subtest: basic-hwmon [49.607089] Subtest basic-hwmon: SKIP (0.000s) [49.898231] [005/165] (956s left) fbdev (eof) [49.986171] Starting subtest: eof [49.989132] Subtest eof: SUCCESS (0.001s) [50.038267] [006/165] (956s left) fbdev (info) [50.107276] Starting subtest: info [50.110678] Subtest info: SUCCESS (0.000s) [50.176067] [007/165] (956s left) fbdev (nullptr) [50.268649] Starting subtest: nullptr [50.271977] Subtest nullptr: SUCCESS (0.000s) [50.320028] [008/165] (956s left) fbdev (read) [50.402289] Starting subtest: read [50.660570] Subtest read: SUCCESS (0.258s) [50.713176] [009/165] (956s left) fbdev (write) [50.796146] Starting subtest: write [50.930804] Subtest write: SUCCESS (0.135s) [50.989021] [010/165] (955s left) gem_basic (bad-close) [51.061814] Starting subtest: bad-close [51.068564] Subtest bad-close: SUCCESS (0.000s) [51.155458] [011/165] (955s left) gem_basic (create-close) [51.251209] Starting subtest: create-close [51.257848] Subtest create-close: SUCCESS (0.000s) [51.330192] [012/165] (955s left) gem_basic (create-fd-close) [51.419967] Starting subtest: create-fd-close [51.426265] Subtest create-fd-close: SUCCESS (0.000s) [51.510631] [013/165] (955s left) gem_busy (busy@all-engines) [51.617341] Starting subtest: busy [51.620680] Starting dynamic subtest: all-engines [51.674052] Dynamic subtest all-engines: SUCCESS (0.057s) [51.677340] Subtest busy: SUCCESS (0.057s) [52.060493] [014/165] (954s left) gem_close_race (basic-process) [52.191696] Starting subtest: basic-process [52.255432] Subtest basic-process: SUCCESS (0.065s) [52.460667] [015/165] (954s left) gem_close_race (basic-threads) [52.573210] Starting subtest: basic-threads [53.730072] Subtest basic-threads: SUCCESS (1.157s) [53.939295] [016/165] (953s left) gem_ctx_create (basic) [54.041800] Starting subtest: basic [54.044991] Subtest basic: SUCCESS (0.000s) [54.261049] [017/165] (952s left) gem_ctx_create (basic-files) [54.355308] Starting subtest: basic-files [56.375026] Subtest basic-files: SUCCESS (2.020s) [56.766466] [018/165] (950s left) gem_ctx_exec (basic) [57.139472] Starting subtest: basic [57.204978] Subtest basic: SUCCESS (0.011s) [57.435415] [019/165] (949s left) gem_exec_basic (basic) [57.946651] Starting subtest: basic [57.951409] Starting dynamic subtest: rcs0-smem [57.955817] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [57.973376] Starting dynamic subtest: bcs0-smem [57.977646] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [57.993949] Starting dynamic subtest: vcs0-smem [57.998169] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [58.013644] Starting dynamic subtest: vcs1-smem [58.017560] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [58.028198] Starting dynamic subtest: vecs0-smem [58.031610] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [58.035486] Subtest basic: SUCCESS (0.011s) [58.055769] [020/165] (949s left) gem_exec_create (basic) [58.150996] Starting subtest: basic [58.154262] Starting dynamic subtest: smem [60.200422] Dynamic subtest smem: SUCCESS (2.049s) [60.204122] Subtest basic: SUCCESS (2.050s) [60.412774] [021/165] (946s left) gem_exec_fence (basic-busy) [60.654224] Starting subtest: basic-busy [60.657960] Starting dynamic subtest: rcs0 [60.675235] Dynamic subtest rcs0: SUCCESS (0.020s) [60.686537] Starting dynamic subtest: bcs0 [60.704320] Dynamic subtest bcs0: SUCCESS (0.029s) [60.716063] Starting dynamic subtest: vcs0 [60.730658] Dynamic subtest vcs0: SUCCESS (0.028s) [60.742076] Starting dynamic subtest: vcs1 [60.758042] Dynamic subtest vcs1: SUCCESS (0.027s) [60.769276] Starting dynamic subtest: vecs0 [60.790604] Dynamic subtest vecs0: SUCCESS (0.033s) [60.794195] Subtest basic-busy: SUCCESS (0.137s) [61.462918] [022/165] (945s left) gem_exec_fence (basic-wait) [61.698122] Starting subtest: basic-wait [61.702070] Starting dynamic subtest: rcs0 [61.730512] Dynamic subtest rcs0: SUCCESS (0.033s) [61.743087] Starting dynamic subtest: bcs0 [61.757574] Dynamic subtest bcs0: SUCCESS (0.027s) [61.769896] Starting dynamic subtest: vcs0 [61.780422] Dynamic subtest vcs0: SUCCESS (0.023s) [61.791929] Starting dynamic subtest: vcs1 [61.805074] Dynamic subtest vcs1: SUCCESS (0.024s) [61.816540] Starting dynamic subtest: vecs0 [61.826559] Dynamic subtest vecs0: SUCCESS (0.022s) [61.830144] Subtest basic-wait: SUCCESS (0.129s) [62.480502] [023/165] (944s left) gem_exec_fence (basic-await) [62.722319] Starting subtest: basic-await [62.726410] Starting dynamic subtest: rcs0 [62.837432] Dynamic subtest rcs0: SUCCESS (0.116s) [62.848762] Starting dynamic subtest: bcs0 [62.945173] Dynamic subtest bcs0: SUCCESS (0.108s) [62.956970] Starting dynamic subtest: vcs0 [63.063080] Dynamic subtest vcs0: SUCCESS (0.118s) [63.072941] Starting dynamic subtest: vcs1 [63.170086] Dynamic subtest vcs1: SUCCESS (0.107s) [63.185225] Starting dynamic subtest: vecs0 [63.303155] Dynamic subtest vecs0: SUCCESS (0.132s) [63.307029] Subtest basic-await: SUCCESS (0.583s) [63.968086] [024/165] (943s left) gem_exec_fence (nb-await) [64.213206] Starting subtest: nb-await [64.216503] Starting dynamic subtest: rcs0 [64.282415] Dynamic subtest rcs0: SUCCESS (0.069s) [64.300471] Starting dynamic subtest: bcs0 [64.357260] Dynamic subtest bcs0: SUCCESS (0.075s) [64.378777] Starting dynamic subtest: vcs0 [64.436573] Dynamic subtest vcs0: SUCCESS (0.078s) [64.458835] Starting dynamic subtest: vcs1 [64.516473] Dynamic subtest vcs1: SUCCESS (0.080s) [64.536420] Starting dynamic subtest: vecs0 [64.591045] Dynamic subtest vecs0: SUCCESS (0.074s) [64.595178] Subtest nb-await: SUCCESS (0.378s) [65.242579] [025/165] (942s left) gem_exec_gttfill (basic) [65.352143] Starting subtest: basic [70.004314] Subtest basic: SUCCESS (4.652s) [70.185248] [026/165] (937s left) gem_exec_parallel (engines) [70.350312] Starting subtest: engines [70.353466] Starting dynamic subtest: basic [72.789259] Dynamic subtest basic: SUCCESS (2.436s) [72.798308] Starting dynamic subtest: contexts [79.691189] Dynamic subtest contexts: SUCCESS (6.904s) [79.700313] Starting dynamic subtest: fds [88.112380] Dynamic subtest fds: SUCCESS (8.346s) [88.235715] Starting dynamic subtest: userptr [90.531171] Dynamic subtest userptr: SUCCESS (2.493s) [90.534778] Subtest engines: SUCCESS (20.179s) [90.729870] [027/165] (916s left) gem_exec_store (basic) [90.824269] Starting subtest: basic [90.871686] Subtest basic: SUCCESS (0.048s) [91.088854] [028/165] (916s left) gem_flink_basic (bad-flink) [91.186307] Starting subtest: bad-flink [91.189625] Subtest bad-flink: SUCCESS (0.000s) [91.293499] [029/165] (916s left) gem_flink_basic (bad-open) [91.386423] Starting subtest: bad-open [91.389779] Subtest bad-open: SUCCESS (0.000s) [91.480332] [030/165] (916s left) gem_flink_basic (basic) [91.569201] Starting subtest: basic [91.572609] Subtest basic: SUCCESS (0.000s) [91.669174] [031/165] (916s left) gem_flink_basic (double-flink) [91.769495] Starting subtest: double-flink [91.772688] Subtest double-flink: SUCCESS (0.000s) [91.849098] [032/165] (915s left) gem_flink_basic (flink-lifetime) [91.949363] Starting subtest: flink-lifetime [91.952624] Subtest flink-lifetime: SUCCESS (0.002s) [92.053267] [033/165] (915s left) gem_huc_copy (huc-copy) [92.147304] Starting subtest: huc-copy [92.153946] Subtest huc-copy: SKIP (0.000s) [92.267492] [034/165] (915s left) gem_linear_blits (basic) [92.490021] Starting subtest: basic [92.503141] Subtest basic: SUCCESS (0.011s) [92.661462] [035/165] (915s left) gem_mmap (basic) [92.819361] Starting subtest: basic [92.834154] Subtest basic: SUCCESS (0.000s) [92.923293] [036/165] (914s left) gem_mmap_gtt (basic) [93.008652] Starting subtest: basic [93.011757] Subtest basic: SUCCESS (0.001s) [93.096863] [037/165] (914s left) gem_render_linear_blits (basic) [93.206625] Starting subtest: basic [93.237147] Subtest basic: SUCCESS (0.031s) [93.280264] [038/165] (914s left) gem_render_tiled_blits (basic) [93.356796] Starting subtest: basic [93.395841] Subtest basic: SUCCESS (0.039s) [93.440503] [039/165] (914s left) gem_ringfill (basic-all) [93.716305] Starting subtest: basic-all [94.897628] Subtest basic-all: SUCCESS (1.173s) [94.997403] [040/165] (913s left) gem_softpin (allocator-basic) [95.102952] Starting subtest: allocator-basic [95.227221] Subtest allocator-basic: SUCCESS (0.123s) [95.333515] [041/165] (912s left) gem_softpin (allocator-basic-reserve) [95.433494] Starting subtest: allocator-basic-reserve [95.558293] Subtest allocator-basic-reserve: SUCCESS (0.125s) [95.677994] [042/165] (912s left) gem_softpin (safe-alignment) [95.783027] Starting subtest: safe-alignment [95.798522] Subtest safe-alignment: SUCCESS (0.016s) [95.915682] [043/165] (912s left) gem_sync (basic-all) [96.044314] Starting subtest: basic-all [98.369422] Subtest basic-all: SUCCESS (2.341s) [98.582461] [044/165] (909s left) gem_sync (basic-each) [98.701268] Starting subtest: basic-each [100.892300] Subtest basic-each: SUCCESS (2.209s) [101.103353] [045/165] (907s left) gem_tiled_blits (basic) [101.330114] Starting subtest: basic [101.352604] Subtest basic: SUCCESS (0.022s) [101.501035] [046/165] (906s left) gem_tiled_fence_blits (basic) [101.755838] Starting subtest: basic [101.768364] Subtest basic: SUCCESS (0.012s) [101.925400] [047/165] (906s left) gem_tiled_pread_basic [102.263096] [048/165] (906s left) gem_wait (busy@all-engines) [102.366223] Starting subtest: busy [102.369454] Starting dynamic subtest: all-engines [102.892255] Dynamic subtest all-engines: SUCCESS (0.526s) [102.895520] Subtest busy: SUCCESS (0.526s) [103.147131] [049/165] (905s left) gem_wait (wait@all-engines) [103.256817] Starting subtest: wait [103.260188] Starting dynamic subtest: all-engines [104.295276] Dynamic subtest all-engines: SUCCESS (1.036s) [104.299201] Subtest wait: SUCCESS (1.037s) [104.527717] [050/165] (903s left) i915_getparams_basic (basic-eu-total) [104.618320] Starting subtest: basic-eu-total [104.624844] Subtest basic-eu-total: SUCCESS (0.000s) [104.714635] [051/165] (903s left) i915_getparams_basic (basic-subslice-total) [104.815206] Starting subtest: basic-subslice-total [104.821458] Subtest basic-subslice-total: SUCCESS (0.000s) [104.910375] [052/165] (903s left) i915_hangman (error-state-basic) [105.013785] Starting subtest: error-state-basic [105.023740] Subtest error-state-basic: SUCCESS (0.007s) [105.089644] [053/165] (903s left) i915_pciid [105.275631] [054/165] (903s left) kms_addfb_basic (addfb25-4-tiled) [105.590886] Starting subtest: addfb25-4-tiled [105.594130] Subtest addfb25-4-tiled: SUCCESS (0.000s) [105.672471] [055/165] (902s left) kms_addfb_basic (addfb25-bad-modifier) [105.764446] Starting subtest: addfb25-bad-modifier [105.768234] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [106.076493] [056/165] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [106.181950] Starting subtest: addfb25-framebuffer-vs-set-tiling [106.184840] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [106.491030] [057/165] (902s left) kms_addfb_basic (addfb25-modifier-no-flag) [106.583497] Starting subtest: addfb25-modifier-no-flag [106.586958] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [106.887843] [058/165] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [106.981341] Starting subtest: addfb25-x-tiled-legacy [106.984530] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [107.288264] [059/165] (901s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [107.379427] Starting subtest: addfb25-x-tiled-mismatch-legacy [107.382487] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [107.696661] [060/165] (900s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [108.017422] Starting subtest: addfb25-yf-tiled-legacy [108.020176] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [108.091376] [061/165] (900s left) kms_addfb_basic (addfb25-y-tiled-legacy) [108.400055] Starting subtest: addfb25-y-tiled-legacy [108.402853] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [108.483593] [062/165] (900s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [108.789518] Starting subtest: addfb25-y-tiled-small-legacy [108.792119] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [108.865222] [063/165] (899s left) kms_addfb_basic (bad-pitch-0) [108.944361] Starting subtest: bad-pitch-0 [108.947563] Subtest bad-pitch-0: SUCCESS (0.000s) [109.238874] [064/165] (899s left) kms_addfb_basic (bad-pitch-1024) [109.323096] Starting subtest: bad-pitch-1024 [109.326147] Subtest bad-pitch-1024: SUCCESS (0.000s) [109.623977] [065/165] (899s left) kms_addfb_basic (bad-pitch-128) [109.708469] Starting subtest: bad-pitch-128 [109.711436] Subtest bad-pitch-128: SUCCESS (0.000s) [110.022187] [066/165] (898s left) kms_addfb_basic (bad-pitch-256) [110.106516] Starting subtest: bad-pitch-256 [110.109620] Subtest bad-pitch-256: SUCCESS (0.000s) [110.408401] [067/165] (898s left) kms_addfb_basic (bad-pitch-32) [110.495546] Starting subtest: bad-pitch-32 [110.498605] Subtest bad-pitch-32: SUCCESS (0.000s) [110.815743] [068/165] (898s left) kms_addfb_basic (bad-pitch-63) [110.921357] Starting subtest: bad-pitch-63 [110.924497] Subtest bad-pitch-63: SUCCESS (0.000s) [111.222063] [069/165] (897s left) kms_addfb_basic (bad-pitch-65536) [111.296480] Starting subtest: bad-pitch-65536 [111.299740] Subtest bad-pitch-65536: SUCCESS (0.000s) [111.616063] [070/165] (897s left) kms_addfb_basic (bad-pitch-999) [111.726329] Starting subtest: bad-pitch-999 [111.729725] Subtest bad-pitch-999: SUCCESS (0.000s) [112.041128] [071/165] (896s left) kms_addfb_basic (basic) [112.142282] Starting subtest: basic [112.145366] Subtest basic: SUCCESS (0.000s) [112.455868] [072/165] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [112.557552] Starting subtest: basic-x-tiled-legacy [112.560839] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [112.860361] [073/165] (896s left) kms_addfb_basic (basic-y-tiled-legacy) [112.949944] Starting subtest: basic-y-tiled-legacy [112.953299] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [113.275609] [074/165] (895s left) kms_addfb_basic (bo-too-small) [113.609894] Starting subtest: bo-too-small [113.612611] Subtest bo-too-small: SUCCESS (0.000s) [113.703739] [075/165] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling) [114.034678] Starting subtest: bo-too-small-due-to-tiling [114.037298] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [114.115389] [076/165] (895s left) kms_addfb_basic (clobberred-modifier) [114.197342] Starting subtest: clobberred-modifier [114.200319] Subtest clobberred-modifier: SUCCESS (0.000s) [114.513943] [077/165] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [114.617564] Starting subtest: framebuffer-vs-set-tiling [114.620885] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [114.926463] [078/165] (894s left) kms_addfb_basic (invalid-get-prop) [115.020567] Starting subtest: invalid-get-prop [115.023800] Subtest invalid-get-prop: SUCCESS (0.000s) [115.315792] [079/165] (893s left) kms_addfb_basic (invalid-get-prop-any) [115.398682] Starting subtest: invalid-get-prop-any [115.401820] Subtest invalid-get-prop-any: SUCCESS (0.000s) [115.717783] [080/165] (893s left) kms_addfb_basic (invalid-set-prop) [115.816988] Starting subtest: invalid-set-prop [115.820793] Subtest invalid-set-prop: SUCCESS (0.000s) [116.121864] [081/165] (893s left) kms_addfb_basic (invalid-set-prop-any) [116.196274] Starting subtest: invalid-set-prop-any [116.199310] Subtest invalid-set-prop-any: SUCCESS (0.000s) [116.510545] [082/165] (892s left) kms_addfb_basic (no-handle) [116.603606] Starting subtest: no-handle [116.607041] Subtest no-handle: SUCCESS (0.000s) [116.905627] [083/165] (892s left) kms_addfb_basic (size-max) [117.209104] Starting subtest: size-max [117.211965] Subtest size-max: SUCCESS (0.000s) [117.297177] [084/165] (892s left) kms_addfb_basic (small-bo) [117.621130] Starting subtest: small-bo [117.623881] Subtest small-bo: SUCCESS (0.000s) [117.704635] [085/165] (891s left) kms_addfb_basic (tile-pitch-mismatch) [117.801278] Starting subtest: tile-pitch-mismatch [117.804547] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [118.111130] [086/165] (891s left) kms_addfb_basic (too-high) [118.424848] Starting subtest: too-high [118.427749] Subtest too-high: SUCCESS (0.001s) [118.510166] [087/165] (890s left) kms_addfb_basic (too-wide) [118.832870] Starting subtest: too-wide [118.835731] Subtest too-wide: SUCCESS (0.000s) [118.921774] [088/165] (890s left) kms_addfb_basic (unused-handle) [119.013561] Starting subtest: unused-handle [119.016760] Subtest unused-handle: SUCCESS (0.000s) [119.327215] [089/165] (890s left) kms_addfb_basic (unused-modifier) [119.418506] Starting subtest: unused-modifier [119.421623] Subtest unused-modifier: SUCCESS (0.000s) [119.724966] [090/165] (889s left) kms_addfb_basic (unused-offsets) [119.820223] Starting subtest: unused-offsets [119.823427] Subtest unused-offsets: SUCCESS (0.000s) [120.131939] [091/165] (889s left) kms_addfb_basic (unused-pitches) [120.209779] Starting subtest: unused-pitches [120.212892] Subtest unused-pitches: SUCCESS (0.000s) [120.523709] [092/165] (889s left) kms_busy (basic) [120.851398] Starting subtest: basic [120.854802] Starting dynamic subtest: flip [121.780666] Dynamic subtest flip: SUCCESS (0.844s) [121.845187] Starting dynamic subtest: modeset [122.942432] Dynamic subtest modeset: SUCCESS (1.140s) [122.945515] Subtest basic: SUCCESS (1.987s) [123.446087] [093/165] (886s left) kms_prop_blob (basic) [123.961106] Starting subtest: basic [124.028818] Subtest basic: SUCCESS (0.000s) [124.267299] [094/165] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [124.803374] Starting subtest: basic-busy-flip-before-cursor-atomic [124.809568] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [125.028061] [095/165] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [125.578182] Starting subtest: basic-busy-flip-before-cursor-legacy [125.708880] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [125.939504] [096/165] (884s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [126.405982] Starting subtest: basic-flip-after-cursor-atomic [127.414204] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.010s) [127.836087] [097/165] (882s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [128.151778] Starting subtest: basic-flip-after-cursor-legacy [129.297276] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s) [129.827913] [098/165] (880s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [130.151405] Starting subtest: basic-flip-after-cursor-varying-size [131.175745] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.027s) [131.608846] [099/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [131.924166] Starting subtest: basic-flip-before-cursor-atomic [132.952857] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.028s) [133.383415] [100/165] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [133.718412] Starting subtest: basic-flip-before-cursor-legacy [134.740486] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.026s) [135.152395] [101/165] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [135.462702] Starting subtest: basic-flip-before-cursor-varying-size [136.482566] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.018s) [136.910343] [102/165] (873s left) kms_dsc (dsc-basic) [137.220699] Subtest dsc-basic: SKIP (0.000s) [137.250646] [103/165] (873s left) kms_flip (basic-flip-vs-dpms) [137.566459] Starting subtest: basic-flip-vs-dpms [137.569619] Starting dynamic subtest: A-DP1 [138.746185] Dynamic subtest A-DP1: SUCCESS (1.181s) [138.759971] Starting dynamic subtest: B-DP1 [139.815401] Dynamic subtest B-DP1: SUCCESS (1.066s) [139.831684] Starting dynamic subtest: C-DP1 [140.905165] Dynamic subtest C-DP1: SUCCESS (1.084s) [140.919100] Starting dynamic subtest: A-DP2 [141.651199] Dynamic subtest A-DP2: SUCCESS (0.748s) [141.665670] Starting dynamic subtest: B-DP2 [142.590903] Dynamic subtest B-DP2: SUCCESS (0.931s) [142.606213] Starting dynamic subtest: C-DP2 [143.352258] Dynamic subtest C-DP2: SUCCESS (0.760s) [143.355332] Subtest basic-flip-vs-dpms: SUCCESS (5.790s) [143.871266] [104/165] (866s left) kms_flip (basic-flip-vs-modeset) [144.203531] Starting subtest: basic-flip-vs-modeset [144.210152] Starting dynamic subtest: A-DP1 [145.426957] Dynamic subtest A-DP1: SUCCESS (1.216s) [145.440811] Starting dynamic subtest: B-DP1 [146.530322] Dynamic subtest B-DP1: SUCCESS (1.103s) [146.542703] Starting dynamic subtest: C-DP1 [147.546668] Dynamic subtest C-DP1: SUCCESS (1.012s) [147.560769] Starting dynamic subtest: A-DP2 [148.272065] Dynamic subtest A-DP2: SUCCESS (0.719s) [148.283693] Starting dynamic subtest: B-DP2 [148.992537] Dynamic subtest B-DP2: SUCCESS (0.721s) [149.002338] Starting dynamic subtest: C-DP2 [149.728114] Dynamic subtest C-DP2: SUCCESS (0.732s) [149.731393] Subtest basic-flip-vs-modeset: SUCCESS (5.523s) [150.174932] [105/165] (860s left) kms_flip (basic-flip-vs-wf_vblank) [150.511177] Starting subtest: basic-flip-vs-wf_vblank [150.514115] Starting dynamic subtest: A-DP1 [151.843128] Dynamic subtest A-DP1: SUCCESS (1.215s) [151.909140] Starting dynamic subtest: B-DP1 [152.938446] Dynamic subtest B-DP1: SUCCESS (1.116s) [153.003081] Starting dynamic subtest: C-DP1 [154.009961] Dynamic subtest C-DP1: SUCCESS (1.124s) [154.022478] Starting dynamic subtest: A-DP2 [155.024466] Dynamic subtest A-DP2: SUCCESS (1.046s) [155.036742] Starting dynamic subtest: B-DP2 [156.093694] Dynamic subtest B-DP2: SUCCESS (1.069s) [156.106369] Starting dynamic subtest: C-DP2 [157.158344] Dynamic subtest C-DP2: SUCCESS (1.063s) [157.161781] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.649s) [157.693774] [106/165] (853s left) kms_flip (basic-plain-flip) [158.002348] Starting subtest: basic-plain-flip [158.005567] Starting dynamic subtest: A-DP1 [158.992710] Dynamic subtest A-DP1: SUCCESS (0.985s) [159.008097] Starting dynamic subtest: B-DP1 [159.875699] Dynamic subtest B-DP1: SUCCESS (0.885s) [159.889484] Starting dynamic subtest: C-DP1 [160.754503] Dynamic subtest C-DP1: SUCCESS (0.875s) [160.768077] Starting dynamic subtest: A-DP2 [161.554851] Dynamic subtest A-DP2: SUCCESS (0.799s) [161.569552] Starting dynamic subtest: B-DP2 [162.348715] Dynamic subtest B-DP2: SUCCESS (0.784s) [162.358754] Starting dynamic subtest: C-DP2 [163.107238] Dynamic subtest C-DP2: SUCCESS (0.756s) [163.110659] Subtest basic-plain-flip: SUCCESS (5.104s) [163.649467] [107/165] (847s left) kms_force_connector_basic (force-connector-state) [163.801805] Starting subtest: force-connector-state [164.378933] Subtest force-connector-state: SUCCESS (0.581s) [165.269705] [108/165] (845s left) kms_force_connector_basic (force-edid) [165.409656] Starting subtest: force-edid [165.514303] Subtest force-edid: SUCCESS (0.109s) [166.053708] [109/165] (844s left) kms_force_connector_basic (force-load-detect) [166.202427] Starting subtest: force-load-detect [166.207852] Subtest force-load-detect: SKIP (0.000s) [166.536706] [110/165] (844s left) kms_force_connector_basic (prune-stale-modes) [166.689260] Starting subtest: prune-stale-modes [166.793266] Subtest prune-stale-modes: SUCCESS (0.108s) [167.336331] [111/165] (843s left) kms_frontbuffer_tracking (basic) [167.674967] Starting subtest: basic [170.623891] Subtest basic: SUCCESS (2.829s) [170.999583] [112/165] (840s left) kms_hdmi_inject (inject-audio) [171.339777] Starting subtest: inject-audio [171.512181] Subtest inject-audio: SUCCESS (0.176s) [172.206734] [113/165] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [172.516569] Starting subtest: compare-crc-sanitycheck-xr24 [172.519469] Starting dynamic subtest: pipe-A-DP-1 [173.126729] Dynamic subtest pipe-A-DP-1: SUCCESS (0.609s) [173.143846] Starting dynamic subtest: pipe-B-DP-2 [173.612548] Dynamic subtest pipe-B-DP-2: SUCCESS (0.477s) [173.625107] Starting dynamic subtest: pipe-C-DP-1 [174.189272] Dynamic subtest pipe-C-DP-1: SUCCESS (0.574s) [174.192683] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.673s) [174.600831] [114/165] (836s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [174.928147] Starting subtest: compare-crc-sanitycheck-nv12 [174.930979] Starting dynamic subtest: pipe-A-DP-1 [175.543310] Dynamic subtest pipe-A-DP-1: SUCCESS (0.610s) [175.559345] Starting dynamic subtest: pipe-B-DP-2 [176.054039] Dynamic subtest pipe-B-DP-2: SUCCESS (0.507s) [176.067984] Starting dynamic subtest: pipe-C-DP-1 [176.074495] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [176.077608] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.132s) [176.464488] [115/165] (834s left) kms_pipe_crc_basic (hang-read-crc) [176.795634] Starting subtest: hang-read-crc [176.798510] Starting dynamic subtest: pipe-A-DP-1 [178.202594] Dynamic subtest pipe-A-DP-1: SUCCESS (1.403s) [178.218440] Starting dynamic subtest: pipe-B-DP-2 [179.443890] Dynamic subtest pipe-B-DP-2: SUCCESS (1.240s) [179.465136] Starting dynamic subtest: pipe-C-DP-1 [180.819699] Dynamic subtest pipe-C-DP-1: SUCCESS (1.365s) [180.823023] Subtest hang-read-crc: SUCCESS (4.021s) [181.228108] [116/165] (830s left) kms_pipe_crc_basic (nonblocking-crc) [181.553150] Starting subtest: nonblocking-crc [181.556015] Starting dynamic subtest: pipe-A-DP-1 [182.311167] Dynamic subtest pipe-A-DP-1: SUCCESS (0.754s) [182.326678] Starting dynamic subtest: pipe-B-DP-2 [182.964138] Dynamic subtest pipe-B-DP-2: SUCCESS (0.649s) [182.976382] Starting dynamic subtest: pipe-C-DP-1 [183.713843] Dynamic subtest pipe-C-DP-1: SUCCESS (0.744s) [183.717164] Subtest nonblocking-crc: SUCCESS (2.161s) [184.108414] [117/165] (827s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [184.418718] Starting subtest: nonblocking-crc-frame-sequence [184.421669] Starting dynamic subtest: pipe-A-DP-1 [185.185834] Dynamic subtest pipe-A-DP-1: SUCCESS (0.765s) [185.201548] Starting dynamic subtest: pipe-B-DP-2 [185.871293] Dynamic subtest pipe-B-DP-2: SUCCESS (0.680s) [185.887735] Starting dynamic subtest: pipe-C-DP-1 [186.637800] Dynamic subtest pipe-C-DP-1: SUCCESS (0.758s) [186.641259] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.219s) [187.122705] [118/165] (824s left) kms_pipe_crc_basic (read-crc) [187.447238] Starting subtest: read-crc [187.450057] Starting dynamic subtest: pipe-A-DP-1 [188.126359] Dynamic subtest pipe-A-DP-1: SUCCESS (0.676s) [188.145935] Starting dynamic subtest: pipe-B-DP-2 [188.735063] Dynamic subtest pipe-B-DP-2: SUCCESS (0.601s) [188.750064] Starting dynamic subtest: pipe-C-DP-1 [189.414828] Dynamic subtest pipe-C-DP-1: SUCCESS (0.675s) [189.418796] Subtest read-crc: SUCCESS (1.968s) [189.842938] [119/165] (821s left) kms_pipe_crc_basic (read-crc-frame-sequence) [190.153812] Starting subtest: read-crc-frame-sequence [190.156633] Starting dynamic subtest: pipe-A-DP-1 [190.854251] Dynamic subtest pipe-A-DP-1: SUCCESS (0.696s) [190.874063] Starting dynamic subtest: pipe-B-DP-2 [191.474491] Dynamic subtest pipe-B-DP-2: SUCCESS (0.611s) [191.486197] Starting dynamic subtest: pipe-C-DP-1 [192.153613] Dynamic subtest pipe-C-DP-1: SUCCESS (0.678s) [192.156844] Subtest read-crc-frame-sequence: SUCCESS (2.002s) [192.588873] [120/165] (819s left) kms_pm_backlight (basic-brightness) [192.918947] Subtest basic-brightness: SKIP (0.000s) [192.947160] [121/165] (818s left) kms_pm_rpm (basic-pci-d3-state) [194.856655] Starting subtest: basic-pci-d3-state [195.617754] Subtest basic-pci-d3-state: SUCCESS (0.760s) [196.081219] [122/165] (815s left) kms_pm_rpm (basic-rte) [196.191642] Starting subtest: basic-rte [198.795096] Subtest basic-rte: SUCCESS (2.610s) [200.022741] [123/165] (811s left) kms_psr (psr-primary-page-flip) [200.362564] Subtest psr-primary-page-flip: SKIP (0.000s) [200.392043] [124/165] (811s left) kms_psr (psr-cursor-plane-move) [200.706776] Subtest psr-cursor-plane-move: SKIP (0.000s) [200.741985] [125/165] (811s left) kms_psr (psr-sprite-plane-onoff) [201.069245] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [201.108609] [126/165] (810s left) kms_psr (psr-primary-mmap-gtt) [201.410857] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [201.454219] [127/165] (810s left) kms_setmode (basic-clone-single-crtc) [201.561670] Starting subtest: basic-clone-single-crtc [201.737153] Subtest basic-clone-single-crtc: SKIP (0.173s) [202.138456] [128/165] (809s left) i915_pm_rps (basic-api) [202.248539] Starting subtest: basic-api [202.251844] Subtest basic-api: SUCCESS (0.005s) [202.347250] [129/165] (809s left) prime_self_import (basic-llseek-bad) [202.442806] Starting subtest: basic-llseek-bad [202.450329] Subtest basic-llseek-bad: SUCCESS (0.010s) [202.555837] [130/165] (809s left) prime_self_import (basic-llseek-size) [202.641935] Starting subtest: basic-llseek-size [202.654853] Subtest basic-llseek-size: SUCCESS (0.014s) [202.764427] [131/165] (809s left) prime_self_import (basic-with_fd_dup) [202.834798] Starting subtest: basic-with_fd_dup [202.846834] Subtest basic-with_fd_dup: SUCCESS (0.013s) [202.979120] [132/165] (809s left) prime_self_import (basic-with_one_bo) [203.060102] Starting subtest: basic-with_one_bo [203.072909] Subtest basic-with_one_bo: SUCCESS (0.016s) [203.152797] [133/165] (808s left) prime_self_import (basic-with_one_bo_two_files) [203.229976] Starting subtest: basic-with_one_bo_two_files [203.248269] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s) [203.368805] [134/165] (808s left) prime_self_import (basic-with_two_bos) [203.458489] Starting subtest: basic-with_two_bos [203.476042] Subtest basic-with_two_bos: SUCCESS (0.019s) [203.582536] [135/165] (808s left) prime_vgem (basic-fence-flip) [203.678103] Starting subtest: basic-fence-flip [204.392871] Subtest basic-fence-flip: SUCCESS (0.707s) [204.518890] [136/165] (807s left) prime_vgem (basic-fence-mmap) [204.633092] Starting subtest: basic-fence-mmap [204.662823] Subtest basic-fence-mmap: SUCCESS (0.030s) [204.769149] [137/165] (807s left) prime_vgem (basic-fence-read) [204.872976] Starting subtest: basic-fence-read [204.937966] Subtest basic-fence-read: SUCCESS (0.065s) [205.022406] [138/165] (807s left) prime_vgem (basic-gtt) [205.122571] Starting subtest: basic-gtt [205.135302] Subtest basic-gtt: SUCCESS (0.013s) [205.212330] [139/165] (807s left) prime_vgem (basic-read) [205.316144] Starting subtest: basic-read [205.345421] Subtest basic-read: SUCCESS (0.030s) [205.456833] [140/165] (806s left) prime_vgem (basic-write) [205.587842] Starting subtest: basic-write [205.626572] Subtest basic-write: SUCCESS (0.039s) [205.695169] [141/165] (806s left) vgem_basic (setversion) [205.792620] Starting subtest: setversion [205.799873] Subtest setversion: SUCCESS (0.000s) [205.845665] [142/165] (806s left) vgem_basic (create) [205.923543] Starting subtest: create [205.926629] Subtest create: SUCCESS (0.000s) [205.977813] [143/165] (806s left) vgem_basic (debugfs) [206.061371] Starting subtest: debugfs [206.064985] Subtest debugfs: SUCCESS (0.001s) [206.126299] [144/165] (806s left) vgem_basic (dmabuf-export) [206.224309] Starting subtest: dmabuf-export [206.240301] Subtest dmabuf-export: SUCCESS (0.015s) [206.355446] [145/165] (806s left) vgem_basic (dmabuf-fence) [206.458952] Starting subtest: dmabuf-fence [206.463051] Subtest dmabuf-fence: SUCCESS (0.002s) [206.524849] [146/165] (806s left) vgem_basic (dmabuf-fence-before) [206.622340] Starting subtest: dmabuf-fence-before [206.625354] Subtest dmabuf-fence-before: SUCCESS (0.000s) [206.681883] [147/165] (805s left) vgem_basic (dmabuf-mmap) [206.774019] Starting subtest: dmabuf-mmap [206.783937] Subtest dmabuf-mmap: SUCCESS (0.013s) [206.860303] [148/165] (805s left) vgem_basic (mmap) [206.957621] Starting subtest: mmap [206.967896] Subtest mmap: SUCCESS (0.013s) [207.026402] [149/165] (805s left) vgem_basic (second-client) [207.107150] Starting subtest: second-client [207.140188] Subtest second-client: SUCCESS (0.033s) [207.209884] [150/165] (805s left) vgem_basic (sysfs) [207.336456] Starting subtest: sysfs [207.339693] Subtest sysfs: SUCCESS (0.001s) [207.367915] [151/165] (805s left) core_hotunplug (unbind-rebind) [207.521922] Starting subtest: unbind-rebind [211.032548] Subtest unbind-rebind: SUCCESS (3.511s) [211.060089] [152/165] (801s left) vgem_basic (unload) [211.139716] Starting subtest: unload [240.195110] Subtest unload: SUCCESS (29.056s) [240.355252] [153/165] (772s left) i915_module_load (reload) [240.442171] Starting subtest: reload [243.353342] Subtest reload: SUCCESS (2.913s) [243.375694] [154/165] (769s left) gem_lmem_swapping (basic) [243.499148] Subtest basic: SKIP (0.000s) [243.531235] [155/165] (769s left) gem_lmem_swapping (parallel-random-engines) [243.608243] Subtest parallel-random-engines: SKIP (0.000s) [243.643040] [156/165] (769s left) gem_lmem_swapping (random-engines) [243.752347] Subtest random-engines: SKIP (0.000s) [243.792880] [157/165] (769s left) gem_lmem_swapping (verify-random) [243.883606] Subtest verify-random: SKIP (0.000s) [243.913376] [158/165] (769s left) i915_pm_rpm (module-reload) [246.337939] Starting subtest: module-reload [254.089707] Subtest module-reload: SUCCESS (7.847s) [254.114699] [159/165] (758s left) i915_selftest (live) [254.211978] Starting subtest: live [254.215137] Starting dynamic subtest: sanitycheck [254.932301] Dynamic subtest sanitycheck: SUCCESS (0.719s) [254.941508] Starting dynamic subtest: uncore [255.665376] Dynamic subtest uncore: SUCCESS (0.731s) [255.675301] Starting dynamic subtest: workarounds [256.584078] Dynamic subtest workarounds: SUCCESS (0.917s) [256.594662] Starting dynamic subtest: gt_engines [257.868344] Dynamic subtest gt_engines: SUCCESS (1.280s) [257.876899] Starting dynamic subtest: gt_timelines [271.401948] Dynamic subtest gt_timelines: SUCCESS (13.534s) [271.411066] Starting dynamic subtest: gt_contexts [272.287102] Dynamic subtest gt_contexts: SUCCESS (0.883s) [272.297760] Starting dynamic subtest: gt_lrc [276.074647] Dynamic subtest gt_lrc: SUCCESS (3.785s) [276.085060] Starting dynamic subtest: gt_mocs [276.890876] Dynamic subtest gt_mocs: SUCCESS (0.815s) [276.900927] Starting dynamic subtest: gt_pm [283.546380] Dynamic subtest gt_pm: SUCCESS (6.654s) [283.556365] Starting dynamic subtest: gt_heartbeat [284.388208] Dynamic subtest gt_heartbeat: SUCCESS (0.840s) [284.397017] Starting dynamic subtest: gt_tlb [286.184308] Dynamic subtest gt_tlb: SUCCESS (1.792s) [286.193450] Starting dynamic subtest: requests [294.451308] Dynamic subtest requests: SUCCESS (8.264s) [294.461209] Starting dynamic subtest: migrate [297.964328] Dynamic subtest migrate: SUCCESS (3.511s) [297.973175] Starting dynamic subtest: active [298.679215] Dynamic subtest active: SUCCESS (0.716s) [298.690740] Starting dynamic subtest: objects [300.398345] Dynamic subtest objects: SUCCESS (1.717s) [300.407723] Starting dynamic subtest: mman [304.989319] Dynamic subtest mman: SUCCESS (4.587s) [304.998612] Starting dynamic subtest: dmabuf [305.776280] Dynamic subtest dmabuf: SUCCESS (0.785s) [305.786812] Starting dynamic subtest: vma [306.516235] Dynamic subtest vma: SUCCESS (0.738s) [306.526137] Starting dynamic subtest: coherency [308.542049] Dynamic subtest coherency: SUCCESS (2.026s) [308.551978] Starting dynamic subtest: gtt [316.874179] Dynamic subtest gtt: SUCCESS (8.330s) [316.883977] Starting dynamic subtest: gem [317.798160] Dynamic subtest gem: SUCCESS (0.922s) [317.807838] Starting dynamic subtest: evict [320.582089] Dynamic subtest evict: SUCCESS (2.782s) [320.591767] Starting dynamic subtest: hugepages [327.790051] Dynamic subtest hugepages: SUCCESS (7.206s) [327.799393] Starting dynamic subtest: gem_contexts [345.578207] Dynamic subtest gem_contexts: SUCCESS (17.786s) [345.587740] Starting dynamic subtest: client [346.367160] Dynamic subtest client: SUCCESS (0.787s) [346.378605] Starting dynamic subtest: gem_migrate [347.084961] Dynamic subtest gem_migrate: SUCCESS (0.716s) [347.095725] Starting dynamic subtest: reset [348.621066] Dynamic subtest reset: SUCCESS (1.534s) [348.631099] Starting dynamic subtest: memory_region [349.334960] Dynamic subtest memory_region: SUCCESS (0.712s) [349.344502] Starting dynamic subtest: hangcheck [378.638300] Dynamic subtest hangcheck: SUCCESS (29.301s) [378.648129] Starting dynamic subtest: execlists [392.208122] Dynamic subtest execlists: SUCCESS (13.568s) [392.219031] Starting dynamic subtest: ring_submission [392.931239] Dynamic subtest ring_submission: SUCCESS (0.721s) [392.940207] Starting dynamic subtest: perf [393.748538] Dynamic subtest perf: SUCCESS (0.815s) [393.772213] Starting dynamic subtest: slpc [394.477227] Dynamic subtest slpc: SUCCESS (0.727s) [394.487506] Starting dynamic subtest: guc [395.181144] Dynamic subtest guc: SUCCESS (0.701s) [395.199527] Starting dynamic subtest: guc_multi_lrc [395.899391] Dynamic subtest guc_multi_lrc: SUCCESS (0.715s) [395.909750] Starting dynamic subtest: guc_hang [396.639980] Dynamic subtest guc_hang: SUCCESS (0.739s) [396.648398] Starting dynamic subtest: late_gt_pm [397.410026] Dynamic subtest late_gt_pm: SUCCESS (0.769s) [397.413338] Subtest live: SUCCESS (143.199s) [397.435865] [160/165] (615s left) dmabuf (all-tests) [397.517144] Starting subtest: all-tests [397.524993] Starting dynamic subtest: sanitycheck [397.597314] Dynamic subtest sanitycheck: SUCCESS (0.077s) [397.616993] Starting dynamic subtest: dma_fence [397.785472] Dynamic subtest dma_fence: SUCCESS (0.187s) [397.799145] Starting dynamic subtest: dma_fence_chain [412.783353] Dynamic subtest dma_fence_chain: SUCCESS (14.995s) [412.803095] Starting dynamic subtest: dma_fence_unwrap [412.865674] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s) [412.885584] Starting dynamic subtest: dma_resv [412.949500] Dynamic subtest dma_resv: SUCCESS (0.080s) [412.953637] Subtest all-tests: SUCCESS (15.433s) [412.996110] [161/165] (600s left) i915_suspend (basic-s2idle-without-i915) [413.075035] Starting subtest: basic-s2idle-without-i915 [432.655954] Subtest basic-s2idle-without-i915: SUCCESS (4.483s) [436.307758] [162/165] (594s left) i915_suspend (basic-s3-without-i915) [436.432944] Starting subtest: basic-s3-without-i915 [456.368293] Subtest basic-s3-without-i915: SUCCESS (3.293s) [460.018377] [163/165] (590s left) gem_exec_suspend (basic-s0) [460.168342] Starting subtest: basic-S0 [460.171665] Starting dynamic subtest: smem [478.692413] Dynamic subtest smem: SUCCESS (3.275s) [478.696050] Subtest basic-S0: SUCCESS (3.277s) [483.894469] [164/165] (587s left) gem_exec_suspend (basic-s3) [483.989324] Starting subtest: basic-S3 [483.992743] Starting dynamic subtest: smem [504.304955] Dynamic subtest smem: SUCCESS (3.856s) [504.308549] Subtest basic-S3: SUCCESS (3.858s) [507.493980] [165/165] (583s left) kms_pipe_crc_basic (suspend-read-crc) [507.822386] Starting subtest: suspend-read-crc [507.825407] Starting dynamic subtest: pipe-A-DP-1 [527.221047] Dynamic subtest pipe-A-DP-1: SUCCESS (3.085s) [527.233982] Starting dynamic subtest: pipe-B-DP-2 [546.086927] Dynamic subtest pipe-B-DP-2: SUCCESS (2.782s) [546.099627] Starting dynamic subtest: pipe-C-DP-1 [565.173877] Dynamic subtest pipe-C-DP-1: SUCCESS (2.805s) [565.177076] Subtest suspend-read-crc: SUCCESS (8.681s) [569.550378] Closing watchdogs Done.