[40.297099] Initializing watchdogs [40.297228] /dev/watchdog0 [40.309479] [001/164] (960s left) i915_module_load (load) [40.395039] Starting subtest: load [42.584979] Subtest load: SUCCESS (2.186s) [42.604282] [002/164] (958s left) core_auth (basic-auth) [42.686957] Starting subtest: basic-auth [42.690398] Subtest basic-auth: SUCCESS (0.001s) [42.749603] [003/164] (958s left) debugfs_test (read_all_entries) [42.863232] Starting subtest: read_all_entries [42.982804] Subtest read_all_entries: SUCCESS (0.121s) [43.265239] [004/164] (957s left) debugfs_test (basic-hwmon) [43.333333] Starting subtest: basic-hwmon [43.339127] Subtest basic-hwmon: SKIP (0.000s) [43.614081] [005/164] (957s left) fbdev (eof) [43.696760] Starting subtest: eof [43.700489] Subtest eof: SUCCESS (0.001s) [43.751862] [006/164] (957s left) fbdev (info) [43.832067] Starting subtest: info [43.835611] Subtest info: SUCCESS (0.000s) [43.905857] [007/164] (957s left) fbdev (nullptr) [43.996272] Starting subtest: nullptr [43.999574] Subtest nullptr: SUCCESS (0.000s) [44.053024] [008/164] (956s left) fbdev (read) [44.144519] Starting subtest: read [44.445080] Subtest read: SUCCESS (0.257s) [44.739717] [009/164] (956s left) fbdev (write) [45.101513] Starting subtest: write [45.234768] Subtest write: SUCCESS (0.160s) [45.534584] [010/164] (955s left) gem_basic (bad-close) [45.735649] Starting subtest: bad-close [45.742417] Subtest bad-close: SUCCESS (0.000s) [45.826132] [011/164] (955s left) gem_basic (create-close) [45.922579] Starting subtest: create-close [45.929146] Subtest create-close: SUCCESS (0.000s) [45.999152] [012/164] (955s left) gem_basic (create-fd-close) [46.084798] Starting subtest: create-fd-close [46.091344] Subtest create-fd-close: SUCCESS (0.000s) [46.190373] [013/164] (955s left) gem_busy (busy@all-engines) [46.290093] Starting subtest: busy [46.293269] Starting dynamic subtest: all-engines [46.359697] Dynamic subtest all-engines: SUCCESS (0.069s) [46.363031] Subtest busy: SUCCESS (0.070s) [46.756287] [014/164] (954s left) gem_close_race (basic-process) [46.859929] Starting subtest: basic-process [46.924526] Subtest basic-process: SUCCESS (0.065s) [47.128234] [015/164] (954s left) gem_close_race (basic-threads) [47.230280] Starting subtest: basic-threads [48.374998] Subtest basic-threads: SUCCESS (1.144s) [48.591493] [016/164] (953s left) gem_ctx_create (basic) [48.701355] Starting subtest: basic [48.705158] Subtest basic: SUCCESS (0.000s) [48.904891] [017/164] (952s left) gem_ctx_create (basic-files) [49.019366] Starting subtest: basic-files [51.038694] Subtest basic-files: SUCCESS (2.020s) [51.256161] [018/164] (950s left) gem_ctx_exec (basic) [51.327524] Starting subtest: basic [51.330751] Subtest basic: SUCCESS (0.003s) [51.420825] [019/164] (950s left) gem_exec_basic (basic) [51.509109] Starting subtest: basic [51.512129] Starting dynamic subtest: rcs0-smem [51.515249] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [51.523511] Starting dynamic subtest: bcs0-smem [51.526842] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [51.534874] Starting dynamic subtest: vcs0-smem [51.538499] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [51.546811] Starting dynamic subtest: vcs1-smem [51.550061] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [51.557991] Starting dynamic subtest: vecs0-smem [51.561371] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [51.564631] Subtest basic: SUCCESS (0.005s) [51.743605] [020/164] (950s left) gem_exec_create (basic) [51.831743] Starting subtest: basic [51.835092] Starting dynamic subtest: smem [53.879512] Dynamic subtest smem: SUCCESS (2.050s) [53.882824] Subtest basic: SUCCESS (2.050s) [54.088553] [021/164] (947s left) gem_exec_fence (basic-busy) [54.328176] Starting subtest: basic-busy [54.332460] Starting dynamic subtest: rcs0 [54.368471] Dynamic subtest rcs0: SUCCESS (0.038s) [54.388596] Starting dynamic subtest: bcs0 [54.395525] Dynamic subtest bcs0: SUCCESS (0.028s) [54.407435] Starting dynamic subtest: vcs0 [54.425720] Dynamic subtest vcs0: SUCCESS (0.031s) [54.436252] Starting dynamic subtest: vcs1 [54.451896] Dynamic subtest vcs1: SUCCESS (0.026s) [54.462290] Starting dynamic subtest: vecs0 [54.482371] Dynamic subtest vecs0: SUCCESS (0.031s) [54.485904] Subtest basic-busy: SUCCESS (0.155s) [55.139255] [022/164] (946s left) gem_exec_fence (basic-wait) [55.372372] Starting subtest: basic-wait [55.376643] Starting dynamic subtest: rcs0 [55.409532] Dynamic subtest rcs0: SUCCESS (0.038s) [55.430593] Starting dynamic subtest: bcs0 [55.449136] Dynamic subtest bcs0: SUCCESS (0.039s) [55.460869] Starting dynamic subtest: vcs0 [55.484232] Dynamic subtest vcs0: SUCCESS (0.036s) [55.498350] Starting dynamic subtest: vcs1 [55.501983] Dynamic subtest vcs1: SUCCESS (0.016s) [55.514593] Starting dynamic subtest: vecs0 [55.532144] Dynamic subtest vecs0: SUCCESS (0.030s) [55.535684] Subtest basic-wait: SUCCESS (0.160s) [56.141945] [023/164] (945s left) gem_exec_fence (basic-await) [56.373113] Starting subtest: basic-await [56.377245] Starting dynamic subtest: rcs0 [56.487907] Dynamic subtest rcs0: SUCCESS (0.115s) [56.498168] Starting dynamic subtest: bcs0 [56.590646] Dynamic subtest bcs0: SUCCESS (0.102s) [56.604044] Starting dynamic subtest: vcs0 [56.702300] Dynamic subtest vcs0: SUCCESS (0.112s) [56.712698] Starting dynamic subtest: vcs1 [56.812741] Dynamic subtest vcs1: SUCCESS (0.109s) [56.829105] Starting dynamic subtest: vecs0 [56.952682] Dynamic subtest vecs0: SUCCESS (0.140s) [56.956478] Subtest basic-await: SUCCESS (0.580s) [57.805947] [024/164] (944s left) gem_exec_fence (nb-await) [58.362854] Starting subtest: nb-await [58.429044] Starting dynamic subtest: rcs0 [58.544448] Dynamic subtest rcs0: SUCCESS (0.072s) [58.561148] Starting dynamic subtest: bcs0 [58.565088] Dynamic subtest bcs0: SUCCESS (0.071s) [58.583827] Starting dynamic subtest: vcs0 [58.587700] Dynamic subtest vcs0: SUCCESS (0.072s) [58.603771] Starting dynamic subtest: vcs1 [58.607777] Dynamic subtest vcs1: SUCCESS (0.070s) [58.620969] Starting dynamic subtest: vecs0 [58.624791] Dynamic subtest vecs0: SUCCESS (0.069s) [58.628609] Subtest nb-await: SUCCESS (0.357s) [59.171509] [025/164] (942s left) gem_exec_gttfill (basic) [59.271945] Starting subtest: basic [64.027703] Subtest basic: SUCCESS (4.756s) [64.204094] [026/164] (937s left) gem_exec_parallel (engines) [64.355874] Starting subtest: engines [64.358973] Starting dynamic subtest: basic [66.381426] Dynamic subtest basic: SUCCESS (2.026s) [66.390624] Starting dynamic subtest: contexts [69.822498] Dynamic subtest contexts: SUCCESS (3.440s) [69.831839] Starting dynamic subtest: fds [75.389225] Dynamic subtest fds: SUCCESS (5.567s) [75.398443] Starting dynamic subtest: userptr [77.447391] Dynamic subtest userptr: SUCCESS (2.058s) [77.450730] Subtest engines: SUCCESS (13.092s) [77.646438] [027/164] (924s left) gem_exec_store (basic) [77.728628] Starting subtest: basic [77.773639] Subtest basic: SUCCESS (0.049s) [77.984201] [028/164] (924s left) gem_flink_basic (bad-flink) [78.068263] Starting subtest: bad-flink [78.071518] Subtest bad-flink: SUCCESS (0.000s) [78.148188] [029/164] (924s left) gem_flink_basic (bad-open) [78.232389] Starting subtest: bad-open [78.235503] Subtest bad-open: SUCCESS (0.000s) [78.303153] [030/164] (924s left) gem_flink_basic (basic) [78.377638] Starting subtest: basic [78.380556] Subtest basic: SUCCESS (0.000s) [78.489185] [031/164] (923s left) gem_flink_basic (double-flink) [78.580118] Starting subtest: double-flink [78.583146] Subtest double-flink: SUCCESS (0.000s) [78.662669] [032/164] (923s left) gem_flink_basic (flink-lifetime) [78.741684] Starting subtest: flink-lifetime [78.745199] Subtest flink-lifetime: SUCCESS (0.001s) [78.835810] [033/164] (923s left) gem_huc_copy (huc-copy) [78.914079] Starting subtest: huc-copy [78.920231] Subtest huc-copy: SKIP (0.000s) [79.019596] [034/164] (923s left) gem_linear_blits (basic) [79.229103] Starting subtest: basic [79.238531] Subtest basic: SUCCESS (0.008s) [79.386123] [035/164] (923s left) gem_mmap (basic) [79.551406] Starting subtest: basic [79.567687] Subtest basic: SUCCESS (0.000s) [79.651827] [036/164] (922s left) gem_mmap_gtt (basic) [79.730548] Starting subtest: basic [79.733800] Subtest basic: SUCCESS (0.001s) [79.795349] [037/164] (922s left) gem_render_linear_blits (basic) [79.881026] Starting subtest: basic [79.909438] Subtest basic: SUCCESS (0.031s) [79.957866] [038/164] (922s left) gem_render_tiled_blits (basic) [80.028090] Starting subtest: basic [80.060197] Subtest basic: SUCCESS (0.033s) [80.107763] [039/164] (922s left) gem_ringfill (basic-all) [80.361267] Starting subtest: basic-all [81.528907] Subtest basic-all: SUCCESS (1.169s) [81.630886] [040/164] (921s left) gem_softpin (allocator-basic) [81.727273] Starting subtest: allocator-basic [81.839241] Subtest allocator-basic: SUCCESS (0.113s) [81.947876] [041/164] (920s left) gem_softpin (allocator-basic-reserve) [82.038379] Starting subtest: allocator-basic-reserve [82.154907] Subtest allocator-basic-reserve: SUCCESS (0.116s) [82.252233] [042/164] (920s left) gem_softpin (safe-alignment) [82.349649] Starting subtest: safe-alignment [82.366222] Subtest safe-alignment: SUCCESS (0.014s) [82.473581] [043/164] (920s left) gem_sync (basic-all) [82.590357] Starting subtest: basic-all [84.853887] Subtest basic-all: SUCCESS (2.284s) [85.057197] [044/164] (917s left) gem_sync (basic-each) [85.151084] Starting subtest: basic-each [87.273245] Subtest basic-each: SUCCESS (2.140s) [87.474238] [045/164] (915s left) gem_tiled_blits (basic) [87.683755] Starting subtest: basic [87.703334] Subtest basic: SUCCESS (0.019s) [87.858532] [046/164] (915s left) gem_tiled_fence_blits (basic) [88.150515] Starting subtest: basic [88.161541] Subtest basic: SUCCESS (0.010s) [88.322880] [047/164] (914s left) gem_tiled_pread_basic [88.693211] [048/164] (914s left) gem_wait (busy@all-engines) [88.794417] Starting subtest: busy [88.797680] Starting dynamic subtest: all-engines [89.329227] Dynamic subtest all-engines: SUCCESS (0.534s) [89.332472] Subtest busy: SUCCESS (0.534s) [89.573869] [049/164] (913s left) gem_wait (wait@all-engines) [89.675055] Starting subtest: wait [89.678270] Starting dynamic subtest: all-engines [90.706254] Dynamic subtest all-engines: SUCCESS (1.031s) [90.709774] Subtest wait: SUCCESS (1.031s) [90.931567] [050/164] (912s left) i915_getparams_basic (basic-eu-total) [91.016925] Starting subtest: basic-eu-total [91.023437] Subtest basic-eu-total: SUCCESS (0.000s) [91.081162] [051/164] (911s left) i915_getparams_basic (basic-subslice-total) [91.150584] Starting subtest: basic-subslice-total [91.157431] Subtest basic-subslice-total: SUCCESS (0.000s) [91.218752] [052/164] (911s left) i915_hangman (error-state-basic) [91.305079] Starting subtest: error-state-basic [91.309841] Subtest error-state-basic: SUCCESS (0.006s) [91.381279] [053/164] (911s left) i915_pciid [91.520114] [054/164] (911s left) kms_addfb_basic (addfb25-4-tiled) [91.809677] Starting subtest: addfb25-4-tiled [91.812725] Subtest addfb25-4-tiled: SUCCESS (0.000s) [91.903828] [055/164] (911s left) kms_addfb_basic (addfb25-bad-modifier) [91.980039] Starting subtest: addfb25-bad-modifier [91.982657] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [92.266332] [056/164] (910s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [92.337946] Starting subtest: addfb25-framebuffer-vs-set-tiling [92.341058] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [92.631829] [057/164] (910s left) kms_addfb_basic (addfb25-modifier-no-flag) [92.701848] Starting subtest: addfb25-modifier-no-flag [92.705184] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [92.982292] [058/164] (910s left) kms_addfb_basic (addfb25-x-tiled-legacy) [93.050642] Starting subtest: addfb25-x-tiled-legacy [93.053920] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [93.335828] [059/164] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [93.415955] Starting subtest: addfb25-x-tiled-mismatch-legacy [93.419278] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [93.699064] [060/164] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [93.976063] Starting subtest: addfb25-yf-tiled-legacy [93.979099] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [94.048131] [061/164] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy) [94.324806] Starting subtest: addfb25-y-tiled-legacy [94.327568] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [94.398102] [062/164] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [94.675779] Starting subtest: addfb25-y-tiled-small-legacy [94.678707] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [94.749328] [063/164] (908s left) kms_addfb_basic (bad-pitch-0) [94.817706] Starting subtest: bad-pitch-0 [94.820279] Subtest bad-pitch-0: SUCCESS (0.000s) [95.119366] [064/164] (908s left) kms_addfb_basic (bad-pitch-1024) [95.199290] Starting subtest: bad-pitch-1024 [95.202347] Subtest bad-pitch-1024: SUCCESS (0.000s) [95.484894] [065/164] (907s left) kms_addfb_basic (bad-pitch-128) [95.560024] Starting subtest: bad-pitch-128 [95.563086] Subtest bad-pitch-128: SUCCESS (0.000s) [95.848609] [066/164] (907s left) kms_addfb_basic (bad-pitch-256) [95.918905] Starting subtest: bad-pitch-256 [95.922449] Subtest bad-pitch-256: SUCCESS (0.000s) [96.203347] [067/164] (907s left) kms_addfb_basic (bad-pitch-32) [96.284956] Starting subtest: bad-pitch-32 [96.288184] Subtest bad-pitch-32: SUCCESS (0.000s) [96.569368] [068/164] (906s left) kms_addfb_basic (bad-pitch-63) [96.648434] Starting subtest: bad-pitch-63 [96.651648] Subtest bad-pitch-63: SUCCESS (0.000s) [96.934916] [069/164] (906s left) kms_addfb_basic (bad-pitch-65536) [97.014366] Starting subtest: bad-pitch-65536 [97.017551] Subtest bad-pitch-65536: SUCCESS (0.000s) [97.323530] [070/164] (906s left) kms_addfb_basic (bad-pitch-999) [97.409314] Starting subtest: bad-pitch-999 [97.412357] Subtest bad-pitch-999: SUCCESS (0.000s) [97.716928] [071/164] (905s left) kms_addfb_basic (basic) [97.795554] Starting subtest: basic [97.798833] Subtest basic: SUCCESS (0.000s) [98.088131] [072/164] (905s left) kms_addfb_basic (basic-x-tiled-legacy) [98.176089] Starting subtest: basic-x-tiled-legacy [98.179160] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [98.470821] [073/164] (905s left) kms_addfb_basic (basic-y-tiled-legacy) [98.552950] Starting subtest: basic-y-tiled-legacy [98.556701] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [98.857640] [074/164] (904s left) kms_addfb_basic (bo-too-small) [99.169579] Starting subtest: bo-too-small [99.172167] Subtest bo-too-small: SUCCESS (0.000s) [99.231592] [075/164] (904s left) kms_addfb_basic (bo-too-small-due-to-tiling) [99.509872] Starting subtest: bo-too-small-due-to-tiling [99.512775] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [99.581677] [076/164] (904s left) kms_addfb_basic (clobberred-modifier) [99.649524] Starting subtest: clobberred-modifier [99.652661] Subtest clobberred-modifier: SUCCESS (0.000s) [99.933425] [077/164] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling) [100.005290] Starting subtest: framebuffer-vs-set-tiling [100.008410] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.298529] [078/164] (903s left) kms_addfb_basic (invalid-get-prop) [100.367683] Starting subtest: invalid-get-prop [100.371203] Subtest invalid-get-prop: SUCCESS (0.000s) [100.652265] [079/164] (903s left) kms_addfb_basic (invalid-get-prop-any) [100.728279] Starting subtest: invalid-get-prop-any [100.731482] Subtest invalid-get-prop-any: SUCCESS (0.000s) [101.016083] [080/164] (902s left) kms_addfb_basic (invalid-set-prop) [101.086695] Starting subtest: invalid-set-prop [101.089841] Subtest invalid-set-prop: SUCCESS (0.000s) [101.368226] [081/164] (902s left) kms_addfb_basic (invalid-set-prop-any) [101.442476] Starting subtest: invalid-set-prop-any [101.445837] Subtest invalid-set-prop-any: SUCCESS (0.000s) [101.736500] [082/164] (902s left) kms_addfb_basic (no-handle) [101.819559] Starting subtest: no-handle [101.822668] Subtest no-handle: SUCCESS (0.000s) [102.121580] [083/164] (901s left) kms_addfb_basic (size-max) [102.417980] Starting subtest: size-max [102.420764] Subtest size-max: SUCCESS (0.000s) [102.507415] [084/164] (901s left) kms_addfb_basic (small-bo) [102.802926] Starting subtest: small-bo [102.805693] Subtest small-bo: SUCCESS (0.000s) [102.881693] [085/164] (901s left) kms_addfb_basic (tile-pitch-mismatch) [102.949569] Starting subtest: tile-pitch-mismatch [102.952406] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [103.235522] [086/164] (900s left) kms_addfb_basic (too-high) [103.526885] Starting subtest: too-high [103.529568] Subtest too-high: SUCCESS (0.001s) [103.617129] [087/164] (900s left) kms_addfb_basic (too-wide) [103.911813] Starting subtest: too-wide [103.914539] Subtest too-wide: SUCCESS (0.000s) [103.984573] [088/164] (899s left) kms_addfb_basic (unused-handle) [104.056386] Starting subtest: unused-handle [104.059622] Subtest unused-handle: SUCCESS (0.000s) [104.359459] [089/164] (899s left) kms_addfb_basic (unused-modifier) [104.467060] Starting subtest: unused-modifier [104.470675] Subtest unused-modifier: SUCCESS (0.000s) [104.773855] [090/164] (899s left) kms_addfb_basic (unused-offsets) [104.866302] Starting subtest: unused-offsets [104.869311] Subtest unused-offsets: SUCCESS (0.000s) [105.172438] [091/164] (898s left) kms_addfb_basic (unused-pitches) [105.254956] Starting subtest: unused-pitches [105.258191] Subtest unused-pitches: SUCCESS (0.000s) [105.558138] [092/164] (898s left) kms_busy (basic) [105.854313] Starting subtest: basic [105.858220] Starting dynamic subtest: flip [106.775967] Dynamic subtest flip: SUCCESS (0.815s) [106.841418] Starting dynamic subtest: modeset [107.947749] Dynamic subtest modeset: SUCCESS (1.118s) [107.952311] Subtest basic: SUCCESS (1.935s) [108.182485] [093/164] (895s left) kms_prop_blob (basic) [108.273122] Starting subtest: basic [108.276506] Subtest basic: SUCCESS (0.000s) [108.345784] [094/164] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [108.636674] Starting subtest: basic-busy-flip-before-cursor-atomic [108.643022] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [108.704556] [095/164] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [108.982296] Starting subtest: basic-busy-flip-before-cursor-legacy [108.987869] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [109.038967] [096/164] (895s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [109.318367] Starting subtest: basic-flip-after-cursor-atomic [110.414090] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.022s) [110.988604] [097/164] (893s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [111.296744] Starting subtest: basic-flip-after-cursor-legacy [112.316403] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.022s) [112.717400] [098/164] (891s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [113.015839] Starting subtest: basic-flip-after-cursor-varying-size [114.062173] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.045s) [114.475928] [099/164] (890s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [114.785986] Starting subtest: basic-flip-before-cursor-atomic [115.801413] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.018s) [116.185946] [100/164] (888s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [116.492066] Starting subtest: basic-flip-before-cursor-legacy [117.546344] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.055s) [117.939251] [101/164] (886s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [118.223527] Starting subtest: basic-flip-before-cursor-varying-size [119.263944] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.040s) [119.667874] [102/164] (884s left) kms_flip (basic-flip-vs-dpms) [119.929258] Starting subtest: basic-flip-vs-dpms [119.931991] Starting dynamic subtest: A-DP1 [121.091778] Dynamic subtest A-DP1: SUCCESS (1.162s) [121.107786] Starting dynamic subtest: B-DP1 [122.140499] Dynamic subtest B-DP1: SUCCESS (1.044s) [122.158090] Starting dynamic subtest: C-DP1 [123.195043] Dynamic subtest C-DP1: SUCCESS (1.047s) [123.211289] Starting dynamic subtest: A-DP2 [124.110084] Dynamic subtest A-DP2: SUCCESS (0.913s) [124.122811] Starting dynamic subtest: B-DP2 [124.893388] Dynamic subtest B-DP2: SUCCESS (0.779s) [124.905194] Starting dynamic subtest: C-DP2 [125.787948] Dynamic subtest C-DP2: SUCCESS (0.898s) [125.792813] Subtest basic-flip-vs-dpms: SUCCESS (5.865s) [126.220609] [103/164] (878s left) kms_flip (basic-flip-vs-modeset) [126.502512] Starting subtest: basic-flip-vs-modeset [126.505315] Starting dynamic subtest: A-DP1 [127.585358] Dynamic subtest A-DP1: SUCCESS (1.080s) [127.598892] Starting dynamic subtest: B-DP1 [128.573247] Dynamic subtest B-DP1: SUCCESS (0.982s) [128.587836] Starting dynamic subtest: C-DP1 [129.555774] Dynamic subtest C-DP1: SUCCESS (0.980s) [129.567296] Starting dynamic subtest: A-DP2 [130.323309] Dynamic subtest A-DP2: SUCCESS (0.766s) [130.333666] Starting dynamic subtest: B-DP2 [131.042661] Dynamic subtest B-DP2: SUCCESS (0.720s) [131.052874] Starting dynamic subtest: C-DP2 [131.927347] Dynamic subtest C-DP2: SUCCESS (0.880s) [131.930425] Subtest basic-flip-vs-modeset: SUCCESS (5.428s) [132.357283] [104/164] (872s left) kms_flip (basic-flip-vs-wf_vblank) [132.634295] Starting subtest: basic-flip-vs-wf_vblank [132.640601] Starting dynamic subtest: A-DP1 [133.968166] Dynamic subtest A-DP1: SUCCESS (1.218s) [134.033714] Starting dynamic subtest: B-DP1 [134.987209] Dynamic subtest B-DP1: SUCCESS (1.128s) [135.000112] Starting dynamic subtest: C-DP1 [136.106648] Dynamic subtest C-DP1: SUCCESS (1.115s) [136.118775] Starting dynamic subtest: A-DP2 [137.277560] Dynamic subtest A-DP2: SUCCESS (1.065s) [137.343870] Starting dynamic subtest: B-DP2 [138.233646] Dynamic subtest B-DP2: SUCCESS (1.061s) [138.248632] Starting dynamic subtest: C-DP2 [139.307467] Dynamic subtest C-DP2: SUCCESS (1.072s) [139.311153] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.675s) [139.816807] [105/164] (864s left) kms_flip (basic-plain-flip) [140.093355] Starting subtest: basic-plain-flip [140.096303] Starting dynamic subtest: A-DP1 [141.056761] Dynamic subtest A-DP1: SUCCESS (0.957s) [141.068362] Starting dynamic subtest: B-DP1 [141.887058] Dynamic subtest B-DP1: SUCCESS (0.832s) [141.900438] Starting dynamic subtest: C-DP1 [142.765711] Dynamic subtest C-DP1: SUCCESS (0.876s) [142.777511] Starting dynamic subtest: A-DP2 [143.564516] Dynamic subtest A-DP2: SUCCESS (0.793s) [143.593350] Starting dynamic subtest: B-DP2 [144.402289] Dynamic subtest B-DP2: SUCCESS (0.834s) [144.414635] Starting dynamic subtest: C-DP2 [145.186257] Dynamic subtest C-DP2: SUCCESS (0.782s) [145.189485] Subtest basic-plain-flip: SUCCESS (5.096s) [145.669604] [106/164] (859s left) kms_force_connector_basic (force-connector-state) [145.813216] Starting subtest: force-connector-state [146.444597] Subtest force-connector-state: SUCCESS (0.630s) [147.395229] [107/164] (857s left) kms_force_connector_basic (force-edid) [147.519414] Starting subtest: force-edid [147.620912] Subtest force-edid: SUCCESS (0.105s) [148.145264] [108/164] (856s left) kms_force_connector_basic (force-load-detect) [148.269584] Starting subtest: force-load-detect [148.275794] Subtest force-load-detect: SKIP (0.000s) [148.578482] [109/164] (856s left) kms_force_connector_basic (prune-stale-modes) [148.705269] Starting subtest: prune-stale-modes [148.813384] Subtest prune-stale-modes: SUCCESS (0.108s) [149.344531] [110/164] (855s left) kms_frontbuffer_tracking (basic) [149.644078] Starting subtest: basic [152.378486] Subtest basic: SUCCESS (2.737s) [152.651926] [111/164] (852s left) kms_hdmi_inject (inject-audio) [152.895236] Starting subtest: inject-audio [153.071057] Subtest inject-audio: SUCCESS (0.176s) [153.749742] [112/164] (851s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [154.037251] Starting subtest: compare-crc-sanitycheck-xr24 [154.040099] Starting dynamic subtest: pipe-A-DP-1 [154.628664] Dynamic subtest pipe-A-DP-1: SUCCESS (0.588s) [154.658227] Starting dynamic subtest: pipe-B-DP-2 [155.129060] Dynamic subtest pipe-B-DP-2: SUCCESS (0.495s) [155.145612] Starting dynamic subtest: pipe-C-DP-1 [155.701174] Dynamic subtest pipe-C-DP-1: SUCCESS (0.561s) [155.704667] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.661s) [156.108057] [113/164] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [156.422404] Starting subtest: compare-crc-sanitycheck-nv12 [156.425337] Starting dynamic subtest: pipe-A-DP-1 [157.086215] Dynamic subtest pipe-A-DP-1: SUCCESS (0.658s) [157.099785] Starting dynamic subtest: pipe-B-DP-2 [157.594874] Dynamic subtest pipe-B-DP-2: SUCCESS (0.507s) [157.607984] Starting dynamic subtest: pipe-C-DP-1 [157.615628] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [157.619029] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.179s) [157.980663] [114/164] (847s left) kms_pipe_crc_basic (hang-read-crc) [158.284017] Starting subtest: hang-read-crc [158.286759] Starting dynamic subtest: pipe-A-DP-1 [159.686861] Dynamic subtest pipe-A-DP-1: SUCCESS (1.400s) [159.707834] Starting dynamic subtest: pipe-B-DP-2 [160.871860] Dynamic subtest pipe-B-DP-2: SUCCESS (1.180s) [160.886119] Starting dynamic subtest: pipe-C-DP-1 [162.200360] Dynamic subtest pipe-C-DP-1: SUCCESS (1.318s) [162.204122] Subtest hang-read-crc: SUCCESS (3.914s) [162.576285] [115/164] (842s left) kms_pipe_crc_basic (nonblocking-crc) [162.895279] Starting subtest: nonblocking-crc [162.898423] Starting dynamic subtest: pipe-A-DP-1 [163.722320] Dynamic subtest pipe-A-DP-1: SUCCESS (0.760s) [163.790151] Starting dynamic subtest: pipe-B-DP-2 [164.370573] Dynamic subtest pipe-B-DP-2: SUCCESS (0.621s) [164.439643] Starting dynamic subtest: pipe-C-DP-1 [165.012449] Dynamic subtest pipe-C-DP-1: SUCCESS (0.726s) [165.015586] Subtest nonblocking-crc: SUCCESS (2.120s) [165.403275] [116/164] (839s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [165.707726] Starting subtest: nonblocking-crc-frame-sequence [165.710906] Starting dynamic subtest: pipe-A-DP-1 [166.478712] Dynamic subtest pipe-A-DP-1: SUCCESS (0.769s) [166.491668] Starting dynamic subtest: pipe-B-DP-2 [167.126526] Dynamic subtest pipe-B-DP-2: SUCCESS (0.641s) [167.147091] Starting dynamic subtest: pipe-C-DP-1 [167.867433] Dynamic subtest pipe-C-DP-1: SUCCESS (0.733s) [167.871261] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.158s) [168.265333] [117/164] (836s left) kms_pipe_crc_basic (read-crc) [168.570106] Starting subtest: read-crc [168.572866] Starting dynamic subtest: pipe-A-DP-1 [169.259468] Dynamic subtest pipe-A-DP-1: SUCCESS (0.687s) [169.273507] Starting dynamic subtest: pipe-B-DP-2 [169.836122] Dynamic subtest pipe-B-DP-2: SUCCESS (0.574s) [169.853848] Starting dynamic subtest: pipe-C-DP-1 [170.520092] Dynamic subtest pipe-C-DP-1: SUCCESS (0.683s) [170.523389] Subtest read-crc: SUCCESS (1.956s) [170.906366] [118/164] (834s left) kms_pipe_crc_basic (read-crc-frame-sequence) [171.220090] Starting subtest: read-crc-frame-sequence [171.222950] Starting dynamic subtest: pipe-A-DP-1 [171.918865] Dynamic subtest pipe-A-DP-1: SUCCESS (0.695s) [171.933964] Starting dynamic subtest: pipe-B-DP-2 [172.511449] Dynamic subtest pipe-B-DP-2: SUCCESS (0.591s) [172.522268] Starting dynamic subtest: pipe-C-DP-1 [173.183803] Dynamic subtest pipe-C-DP-1: SUCCESS (0.666s) [173.187875] Subtest read-crc-frame-sequence: SUCCESS (1.965s) [173.593655] [119/164] (831s left) kms_pm_backlight (basic-brightness) [173.893502] Subtest basic-brightness: SKIP (0.000s) [173.927968] [120/164] (831s left) kms_psr (primary_page_flip) [174.002281] Subtest primary_page_flip: SKIP (0.000s) [174.027983] [121/164] (831s left) kms_psr (cursor_plane_move) [174.096201] Subtest cursor_plane_move: SKIP (0.000s) [174.127470] [122/164] (831s left) kms_psr (sprite_plane_onoff) [174.199504] Subtest sprite_plane_onoff: SKIP (0.000s) [174.227990] [123/164] (831s left) kms_psr (primary_mmap_gtt) [174.298534] Subtest primary_mmap_gtt: SKIP (0.000s) [174.340145] [124/164] (831s left) kms_setmode (basic-clone-single-crtc) [174.436284] Starting subtest: basic-clone-single-crtc [174.608334] Subtest basic-clone-single-crtc: SKIP (0.170s) [175.008067] [125/164] (830s left) i915_pm_rpm (basic-pci-d3-state) [176.858373] Starting subtest: basic-pci-d3-state [177.756118] Subtest basic-pci-d3-state: SUCCESS (0.904s) [178.186998] [126/164] (827s left) i915_pm_rpm (basic-rte) [178.280200] Starting subtest: basic-rte [180.921207] Subtest basic-rte: SUCCESS (2.639s) [182.139170] [127/164] (823s left) i915_pm_rps (basic-api) [182.243537] Starting subtest: basic-api [182.253212] Subtest basic-api: SUCCESS (0.008s) [182.370846] [128/164] (823s left) prime_self_import (basic-llseek-bad) [182.455923] Starting subtest: basic-llseek-bad [182.463575] Subtest basic-llseek-bad: SUCCESS (0.005s) [182.571890] [129/164] (823s left) prime_self_import (basic-llseek-size) [182.654273] Starting subtest: basic-llseek-size [182.660628] Subtest basic-llseek-size: SUCCESS (0.003s) [182.763176] [130/164] (822s left) prime_self_import (basic-with_fd_dup) [182.844522] Starting subtest: basic-with_fd_dup [182.850801] Subtest basic-with_fd_dup: SUCCESS (0.002s) [182.940691] [131/164] (822s left) prime_self_import (basic-with_one_bo) [183.025752] Starting subtest: basic-with_one_bo [183.032203] Subtest basic-with_one_bo: SUCCESS (0.003s) [183.086190] [132/164] (822s left) prime_self_import (basic-with_one_bo_two_files) [183.185684] Starting subtest: basic-with_one_bo_two_files [183.191942] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [183.296645] [133/164] (822s left) prime_self_import (basic-with_two_bos) [183.365202] Starting subtest: basic-with_two_bos [183.372120] Subtest basic-with_two_bos: SUCCESS (0.004s) [183.486517] [134/164] (822s left) prime_vgem (basic-fence-flip) [183.598146] Starting subtest: basic-fence-flip [184.261094] Subtest basic-fence-flip: SUCCESS (0.659s) [184.381941] [135/164] (821s left) prime_vgem (basic-fence-mmap) [184.480696] Starting subtest: basic-fence-mmap [184.508044] Subtest basic-fence-mmap: SUCCESS (0.029s) [184.578447] [136/164] (821s left) prime_vgem (basic-fence-read) [184.660109] Starting subtest: basic-fence-read [184.706122] Subtest basic-fence-read: SUCCESS (0.046s) [184.791110] [137/164] (821s left) prime_vgem (basic-gtt) [184.895255] Starting subtest: basic-gtt [184.917988] Subtest basic-gtt: SUCCESS (0.023s) [185.025068] [138/164] (820s left) prime_vgem (basic-read) [185.135625] Starting subtest: basic-read [185.157408] Subtest basic-read: SUCCESS (0.021s) [185.270669] [139/164] (820s left) prime_vgem (basic-write) [185.345053] Starting subtest: basic-write [185.368158] Subtest basic-write: SUCCESS (0.024s) [185.446584] [140/164] (820s left) vgem_basic (setversion) [185.539820] Starting subtest: setversion [185.545318] Subtest setversion: SUCCESS (0.000s) [185.595752] [141/164] (820s left) vgem_basic (create) [185.675701] Starting subtest: create [185.679104] Subtest create: SUCCESS (0.000s) [185.746620] [142/164] (820s left) vgem_basic (debugfs) [185.840880] Starting subtest: debugfs [185.844905] Subtest debugfs: SUCCESS (0.000s) [185.913280] [143/164] (820s left) vgem_basic (dmabuf-export) [186.007053] Starting subtest: dmabuf-export [186.020854] Subtest dmabuf-export: SUCCESS (0.016s) [186.136907] [144/164] (820s left) vgem_basic (dmabuf-fence) [186.225860] Starting subtest: dmabuf-fence [186.229206] Subtest dmabuf-fence: SUCCESS (0.001s) [186.296133] [145/164] (819s left) vgem_basic (dmabuf-fence-before) [186.393424] Starting subtest: dmabuf-fence-before [186.396452] Subtest dmabuf-fence-before: SUCCESS (0.000s) [186.442367] [146/164] (819s left) vgem_basic (dmabuf-mmap) [186.524572] Starting subtest: dmabuf-mmap [186.541249] Subtest dmabuf-mmap: SUCCESS (0.019s) [186.592398] [147/164] (819s left) vgem_basic (mmap) [186.672795] Starting subtest: mmap [186.680632] Subtest mmap: SUCCESS (0.009s) [186.744364] [148/164] (819s left) vgem_basic (second-client) [186.840943] Starting subtest: second-client [186.874256] Subtest second-client: SUCCESS (0.033s) [186.947376] [149/164] (819s left) vgem_basic (sysfs) [187.040963] Starting subtest: sysfs [187.044332] Subtest sysfs: SUCCESS (0.001s) [187.093708] [150/164] (819s left) core_hotunplug (unbind-rebind) [187.222760] Starting subtest: unbind-rebind [190.643389] Subtest unbind-rebind: SUCCESS (3.417s) [190.671460] [151/164] (815s left) vgem_basic (unload) [190.744707] Starting subtest: unload [219.743446] Subtest unload: SUCCESS (28.999s) [219.862236] [152/164] (786s left) i915_module_load (reload) [219.960885] Starting subtest: reload [223.028339] Subtest reload: SUCCESS (3.068s) [223.049510] [153/164] (783s left) gem_lmem_swapping (basic) [223.155401] Subtest basic: SKIP (0.000s) [223.202446] [154/164] (783s left) gem_lmem_swapping (parallel-random-engines) [223.290271] Subtest parallel-random-engines: SKIP (0.000s) [223.323843] [155/164] (783s left) gem_lmem_swapping (random-engines) [223.400160] Subtest random-engines: SKIP (0.000s) [223.435111] [156/164] (783s left) gem_lmem_swapping (verify-random) [223.517607] Subtest verify-random: SKIP (0.000s) [223.540109] [157/164] (783s left) i915_pm_rpm (module-reload) [225.982366] Starting subtest: module-reload [236.995333] Subtest module-reload: SUCCESS (11.018s) [237.020525] [158/164] (769s left) i915_selftest (live) [237.112838] Starting subtest: live [237.116127] Starting dynamic subtest: sanitycheck [237.807872] Dynamic subtest sanitycheck: SUCCESS (0.694s) [237.818856] Starting dynamic subtest: uncore [238.482977] Dynamic subtest uncore: SUCCESS (0.673s) [238.492609] Starting dynamic subtest: workarounds [239.364312] Dynamic subtest workarounds: SUCCESS (0.879s) [239.374641] Starting dynamic subtest: gt_engines [240.636966] Dynamic subtest gt_engines: SUCCESS (1.271s) [240.645975] Starting dynamic subtest: gt_timelines [252.359208] Dynamic subtest gt_timelines: SUCCESS (11.720s) [252.370413] Starting dynamic subtest: gt_contexts [253.186206] Dynamic subtest gt_contexts: SUCCESS (0.823s) [253.195864] Starting dynamic subtest: gt_lrc [256.948886] Dynamic subtest gt_lrc: SUCCESS (3.763s) [256.957424] Starting dynamic subtest: gt_mocs [257.727342] Dynamic subtest gt_mocs: SUCCESS (0.777s) [257.738735] Starting dynamic subtest: gt_pm [264.326989] Dynamic subtest gt_pm: SUCCESS (6.598s) [264.335916] Starting dynamic subtest: gt_heartbeat [265.107193] Dynamic subtest gt_heartbeat: SUCCESS (0.777s) [265.118493] Starting dynamic subtest: gt_tlb [266.868261] Dynamic subtest gt_tlb: SUCCESS (1.759s) [266.877841] Starting dynamic subtest: requests [274.978420] Dynamic subtest requests: SUCCESS (8.110s) [274.989083] Starting dynamic subtest: migrate [278.490182] Dynamic subtest migrate: SUCCESS (3.508s) [278.499245] Starting dynamic subtest: active [279.182163] Dynamic subtest active: SUCCESS (0.692s) [279.192119] Starting dynamic subtest: objects [280.864099] Dynamic subtest objects: SUCCESS (1.680s) [280.875388] Starting dynamic subtest: mman [285.378865] Dynamic subtest mman: SUCCESS (4.513s) [285.389409] Starting dynamic subtest: dmabuf [286.162929] Dynamic subtest dmabuf: SUCCESS (0.782s) [286.173531] Starting dynamic subtest: vma [286.862951] Dynamic subtest vma: SUCCESS (0.698s) [286.872656] Starting dynamic subtest: coherency [289.427060] Dynamic subtest coherency: SUCCESS (2.562s) [289.438348] Starting dynamic subtest: gtt [297.314974] Dynamic subtest gtt: SUCCESS (7.886s) [297.324999] Starting dynamic subtest: gem [298.182161] Dynamic subtest gem: SUCCESS (0.866s) [298.191893] Starting dynamic subtest: evict [300.498234] Dynamic subtest evict: SUCCESS (2.312s) [300.508980] Starting dynamic subtest: hugepages [307.657258] Dynamic subtest hugepages: SUCCESS (7.157s) [307.669984] Starting dynamic subtest: gem_contexts [324.261984] Dynamic subtest gem_contexts: SUCCESS (16.605s) [324.272856] Starting dynamic subtest: client [324.964947] Dynamic subtest client: SUCCESS (0.701s) [324.974889] Starting dynamic subtest: gem_migrate [325.632210] Dynamic subtest gem_migrate: SUCCESS (0.663s) [325.644537] Starting dynamic subtest: reset [327.183202] Dynamic subtest reset: SUCCESS (1.552s) [327.193693] Starting dynamic subtest: memory_region [327.864989] Dynamic subtest memory_region: SUCCESS (0.680s) [327.875099] Starting dynamic subtest: hangcheck [357.163828] Dynamic subtest hangcheck: SUCCESS (29.297s) [357.174701] Starting dynamic subtest: execlists [370.327026] Dynamic subtest execlists: SUCCESS (13.161s) [370.339402] Starting dynamic subtest: ring_submission [371.020967] Dynamic subtest ring_submission: SUCCESS (0.692s) [371.030159] Starting dynamic subtest: perf [371.803951] Dynamic subtest perf: SUCCESS (0.782s) [371.816097] Starting dynamic subtest: slpc [372.519141] Dynamic subtest slpc: SUCCESS (0.713s) [372.530689] Starting dynamic subtest: guc [373.195193] Dynamic subtest guc: SUCCESS (0.672s) [373.204321] Starting dynamic subtest: guc_multi_lrc [373.913980] Dynamic subtest guc_multi_lrc: SUCCESS (0.664s) [373.981618] Starting dynamic subtest: guc_hang [374.587593] Dynamic subtest guc_hang: SUCCESS (0.676s) [374.653249] Starting dynamic subtest: late_gt_pm [375.328219] Dynamic subtest late_gt_pm: SUCCESS (0.789s) [375.331653] Subtest live: SUCCESS (138.216s) [375.360506] [159/164] (631s left) dmabuf (all-tests) [375.464337] Starting subtest: all-tests [375.468048] Starting dynamic subtest: sanitycheck [375.527980] Dynamic subtest sanitycheck: SUCCESS (0.069s) [375.547484] Starting dynamic subtest: dma_fence [375.708435] Dynamic subtest dma_fence: SUCCESS (0.178s) [375.719137] Starting dynamic subtest: dma_fence_chain [390.397414] Dynamic subtest dma_fence_chain: SUCCESS (14.687s) [390.411954] Starting dynamic subtest: dma_fence_unwrap [390.473209] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s) [390.494699] Starting dynamic subtest: dma_resv [390.553307] Dynamic subtest dma_resv: SUCCESS (0.077s) [390.557414] Subtest all-tests: SUCCESS (15.097s) [390.595374] [160/164] (616s left) i915_suspend (basic-s2idle-without-i915) [390.665185] Starting subtest: basic-s2idle-without-i915 [408.999622] Subtest basic-s2idle-without-i915: SUCCESS (3.699s) [412.648344] [161/164] (611s left) i915_suspend (basic-s3-without-i915) [412.730208] Starting subtest: basic-s3-without-i915 [431.711724] Subtest basic-s3-without-i915: SUCCESS (3.100s) [434.570995] [162/164] (607s left) gem_exec_suspend (basic-s0) [434.679955] Starting subtest: basic-S0 [434.683105] Starting dynamic subtest: smem [453.091892] Dynamic subtest smem: SUCCESS (2.845s) [453.095296] Subtest basic-S0: SUCCESS (2.847s) [456.287237] [163/164] (604s left) gem_exec_suspend (basic-s3) [456.412933] Starting subtest: basic-S3 [456.416307] Starting dynamic subtest: smem [475.707743] Dynamic subtest smem: SUCCESS (3.524s) [475.710945] Subtest basic-S3: SUCCESS (3.526s) [480.897777] [164/164] (601s left) kms_pipe_crc_basic (suspend-read-crc) [481.188744] Starting subtest: suspend-read-crc [481.191792] Starting dynamic subtest: pipe-A-DP-1 [500.770154] Dynamic subtest pipe-A-DP-1: SUCCESS (3.108s) [500.783468] Starting dynamic subtest: pipe-B-DP-2 [520.621385] Dynamic subtest pipe-B-DP-2: SUCCESS (2.582s) [520.639684] Starting dynamic subtest: pipe-C-DP-1 [540.770967] Dynamic subtest pipe-C-DP-1: SUCCESS (2.812s) [540.774289] Subtest suspend-read-crc: SUCCESS (8.512s) [545.117693] Closing watchdogs Done.