[41.926541] Initializing watchdogs [41.926617] /dev/watchdog0 [41.931241] [001/165] (960s left) i915_module_load (load) [41.978152] Starting subtest: load [42.905233] Subtest load: SUCCESS (0.927s) [42.928179] [002/165] (959s left) core_auth (basic-auth) [43.003906] Starting subtest: basic-auth [43.005128] Subtest basic-auth: SUCCESS (0.001s) [43.071377] [003/165] (959s left) debugfs_test (read_all_entries) [43.123167] Starting subtest: read_all_entries [43.173120] Subtest read_all_entries: SUCCESS (0.049s) [43.250549] [004/165] (959s left) debugfs_test (basic-hwmon) [43.295933] Starting subtest: basic-hwmon [43.298021] Subtest basic-hwmon: SKIP (0.000s) [43.369771] [005/165] (959s left) fbdev (eof) [43.422552] Starting subtest: eof [43.423626] Subtest eof: SUCCESS (0.000s) [43.468554] [006/165] (959s left) fbdev (info) [43.510799] Starting subtest: info [43.512103] Subtest info: SUCCESS (0.000s) [43.567329] [007/165] (958s left) fbdev (nullptr) [43.621869] Starting subtest: nullptr [43.622916] Subtest nullptr: SUCCESS (0.000s) [43.666670] [008/165] (958s left) fbdev (read) [43.721983] Starting subtest: read [43.803012] Subtest read: SUCCESS (0.081s) [43.853772] [009/165] (958s left) fbdev (write) [43.905185] Starting subtest: write [43.944448] Subtest write: SUCCESS (0.039s) [43.984469] [010/165] (958s left) gem_basic (bad-close) [44.028389] Starting subtest: bad-close [44.032211] Subtest bad-close: SUCCESS (0.000s) [44.084292] [011/165] (958s left) gem_basic (create-close) [44.127276] Starting subtest: create-close [44.129425] Subtest create-close: SUCCESS (0.000s) [44.200656] [012/165] (958s left) gem_basic (create-fd-close) [44.243195] Starting subtest: create-fd-close [44.245278] Subtest create-fd-close: SUCCESS (0.000s) [44.318587] [013/165] (958s left) gem_busy (busy@all-engines) [44.377233] Starting subtest: busy [44.381170] Starting dynamic subtest: all-engines [44.400154] Dynamic subtest all-engines: SUCCESS (0.026s) [44.401228] Subtest busy: SUCCESS (0.027s) [44.701794] [014/165] (957s left) gem_close_race (basic-process) [44.755793] Starting subtest: basic-process [44.789407] Subtest basic-process: SUCCESS (0.033s) [44.954436] [015/165] (957s left) gem_close_race (basic-threads) [45.010130] Starting subtest: basic-threads [46.205178] Subtest basic-threads: SUCCESS (1.196s) [46.370065] [016/165] (956s left) gem_ctx_create (basic) [46.425992] Starting subtest: basic [46.427250] Subtest basic: SUCCESS (0.000s) [46.585108] [017/165] (956s left) gem_ctx_create (basic-files) [46.636518] Starting subtest: basic-files [48.649740] Subtest basic-files: SUCCESS (2.013s) [48.902755] [018/165] (953s left) gem_ctx_exec (basic) [48.953564] Starting subtest: basic [48.955677] Subtest basic: SUCCESS (0.004s) [49.033590] [019/165] (953s left) gem_exec_basic (basic) [49.084701] Starting subtest: basic [49.085835] Starting dynamic subtest: rcs0-smem [49.087015] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [49.092384] Starting dynamic subtest: bcs0-smem [49.093398] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [49.098412] Starting dynamic subtest: vcs0-smem [49.099423] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [49.104527] Starting dynamic subtest: vecs0-smem [49.105631] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [49.106690] Subtest basic: SUCCESS (0.003s) [49.249104] [020/165] (953s left) gem_exec_create (basic) [49.298371] Starting subtest: basic [49.299467] Starting dynamic subtest: smem [51.334710] Dynamic subtest smem: SUCCESS (2.037s) [51.335961] Subtest basic: SUCCESS (2.037s) [51.499203] [021/165] (951s left) gem_exec_fence (basic-busy) [51.660545] Starting subtest: basic-busy [51.661691] Starting dynamic subtest: rcs0 [51.689441] Dynamic subtest rcs0: SUCCESS (0.029s) [51.695593] Starting dynamic subtest: bcs0 [51.710260] Dynamic subtest bcs0: SUCCESS (0.020s) [51.715798] Starting dynamic subtest: vcs0 [51.729165] Dynamic subtest vcs0: SUCCESS (0.019s) [51.734826] Starting dynamic subtest: vecs0 [51.744574] Dynamic subtest vecs0: SUCCESS (0.015s) [51.745766] Subtest basic-busy: SUCCESS (0.084s) [52.204509] [022/165] (950s left) gem_exec_fence (basic-wait) [52.367105] Starting subtest: basic-wait [52.368204] Starting dynamic subtest: rcs0 [52.397260] Dynamic subtest rcs0: SUCCESS (0.030s) [52.403222] Starting dynamic subtest: bcs0 [52.414237] Dynamic subtest bcs0: SUCCESS (0.017s) [52.419982] Starting dynamic subtest: vcs0 [52.440554] Dynamic subtest vcs0: SUCCESS (0.026s) [52.450241] Starting dynamic subtest: vecs0 [52.464992] Dynamic subtest vecs0: SUCCESS (0.024s) [52.466387] Subtest basic-wait: SUCCESS (0.098s) [52.900874] [023/165] (949s left) gem_exec_fence (basic-await) [53.068142] Starting subtest: basic-await [53.069131] Starting dynamic subtest: rcs0 [53.140148] Dynamic subtest rcs0: SUCCESS (0.071s) [53.145733] Starting dynamic subtest: bcs0 [53.210465] Dynamic subtest bcs0: SUCCESS (0.071s) [53.216934] Starting dynamic subtest: vcs0 [53.282888] Dynamic subtest vcs0: SUCCESS (0.072s) [53.288404] Starting dynamic subtest: vecs0 [53.353609] Dynamic subtest vecs0: SUCCESS (0.071s) [53.354744] Subtest basic-await: SUCCESS (0.286s) [53.787346] [024/165] (948s left) gem_exec_fence (nb-await) [53.949331] Starting subtest: nb-await [53.950352] Starting dynamic subtest: rcs0 [54.004033] Dynamic subtest rcs0: SUCCESS (0.053s) [54.009856] Starting dynamic subtest: bcs0 [54.058173] Dynamic subtest bcs0: SUCCESS (0.053s) [54.063944] Starting dynamic subtest: vcs0 [54.110854] Dynamic subtest vcs0: SUCCESS (0.053s) [54.116690] Starting dynamic subtest: vecs0 [54.162876] Dynamic subtest vecs0: SUCCESS (0.052s) [54.163910] Subtest nb-await: SUCCESS (0.213s) [54.587402] [025/165] (948s left) gem_exec_gttfill (basic) [54.640053] Starting subtest: basic [57.690762] Subtest basic: SUCCESS (3.050s) [57.852758] [026/165] (944s left) gem_exec_parallel (engines) [57.965957] Starting subtest: engines [57.967140] Starting dynamic subtest: basic [59.313171] Dynamic subtest basic: SUCCESS (1.347s) [59.319921] Starting dynamic subtest: contexts [60.776151] Dynamic subtest contexts: SUCCESS (1.463s) [60.782536] Starting dynamic subtest: fds [62.458028] Dynamic subtest fds: SUCCESS (1.682s) [62.464540] Starting dynamic subtest: userptr [63.873556] Dynamic subtest userptr: SUCCESS (1.415s) [63.874945] Subtest engines: SUCCESS (5.908s) [64.041635] [027/165] (938s left) gem_exec_store (basic) [64.096835] Starting subtest: basic [64.132332] Subtest basic: SUCCESS (0.035s) [64.296757] [028/165] (938s left) gem_flink_basic (bad-flink) [64.339233] Starting subtest: bad-flink [64.340295] Subtest bad-flink: SUCCESS (0.000s) [64.397152] [029/165] (938s left) gem_flink_basic (bad-open) [64.439432] Starting subtest: bad-open [64.440442] Subtest bad-open: SUCCESS (0.000s) [64.498131] [030/165] (938s left) gem_flink_basic (basic) [64.541547] Starting subtest: basic [64.542616] Subtest basic: SUCCESS (0.000s) [64.614566] [031/165] (938s left) gem_flink_basic (double-flink) [64.656932] Starting subtest: double-flink [64.657988] Subtest double-flink: SUCCESS (0.000s) [64.712725] [032/165] (938s left) gem_flink_basic (flink-lifetime) [64.754851] Starting subtest: flink-lifetime [64.755944] Subtest flink-lifetime: SUCCESS (0.001s) [64.829924] [033/165] (938s left) gem_huc_copy (huc-copy) [64.874903] Subtest huc-copy: SKIP (0.000s) [64.891730] [034/165] (938s left) gem_linear_blits (basic) [64.997185] Starting subtest: basic [65.003563] Subtest basic: SUCCESS (0.007s) [65.106581] [035/165] (937s left) gem_mmap (basic) [65.220639] Starting subtest: basic [65.225871] Subtest basic: SUCCESS (0.000s) [65.296113] [036/165] (937s left) gem_mmap_gtt (basic) [65.339762] Starting subtest: basic [65.340873] Subtest basic: SUCCESS (0.000s) [65.392777] [037/165] (937s left) gem_render_linear_blits (basic) [65.441915] Starting subtest: basic [65.457709] Subtest basic: SUCCESS (0.016s) [65.491269] [038/165] (937s left) gem_render_tiled_blits (basic) [65.538236] Starting subtest: basic [65.553279] Subtest basic: SUCCESS (0.019s) [65.593153] [039/165] (937s left) gem_ringfill (basic-all) [65.755470] Starting subtest: basic-all [66.858161] Subtest basic-all: SUCCESS (1.103s) [66.949478] [040/165] (936s left) gem_softpin (allocator-basic) [66.998749] Subtest allocator-basic: SKIP (0.000s) [67.046803] [041/165] (935s left) gem_softpin (allocator-basic-reserve) [67.092984] Subtest allocator-basic-reserve: SKIP (0.000s) [67.147773] [042/165] (935s left) gem_softpin (safe-alignment) [67.196788] Starting subtest: safe-alignment [67.202018] Subtest safe-alignment: SUCCESS (0.009s) [67.281352] [043/165] (935s left) gem_sync (basic-all) [67.332934] Starting subtest: basic-all [69.448217] Subtest basic-all: SUCCESS (2.114s) [69.614377] [044/165] (933s left) gem_sync (basic-each) [69.667176] Starting subtest: basic-each [71.742803] Subtest basic-each: SUCCESS (2.075s) [71.915672] [045/165] (931s left) gem_tiled_blits (basic) [72.019166] Starting subtest: basic [72.028958] Subtest basic: SUCCESS (0.010s) [72.124114] [046/165] (930s left) gem_tiled_fence_blits (basic) [72.298657] Starting subtest: basic [72.304466] Subtest basic: SUCCESS (0.006s) [72.423835] [047/165] (930s left) gem_tiled_pread_basic [72.695646] [048/165] (930s left) gem_wait (busy@all-engines) [72.751879] Starting subtest: busy [72.752965] Starting dynamic subtest: all-engines [73.264792] Dynamic subtest all-engines: SUCCESS (0.512s) [73.266254] Subtest busy: SUCCESS (0.513s) [73.447782] [049/165] (929s left) gem_wait (wait@all-engines) [73.501674] Starting subtest: wait [73.502657] Starting dynamic subtest: all-engines [74.515349] Dynamic subtest all-engines: SUCCESS (1.014s) [74.516463] Subtest wait: SUCCESS (1.014s) [74.696309] [050/165] (928s left) i915_getparams_basic (basic-eu-total) [74.743548] Starting subtest: basic-eu-total [74.745662] Subtest basic-eu-total: SUCCESS (0.000s) [74.794105] [051/165] (928s left) i915_getparams_basic (basic-subslice-total) [74.837475] Starting subtest: basic-subslice-total [74.839763] Subtest basic-subslice-total: SUCCESS (0.000s) [74.895651] [052/165] (928s left) i915_hangman (error-state-basic) [74.945416] Starting subtest: error-state-basic [74.951986] Subtest error-state-basic: SUCCESS (0.004s) [75.010800] [053/165] (928s left) i915_pciid [75.110863] [054/165] (928s left) kms_addfb_basic (addfb25-4-tiled) [75.184130] Starting subtest: addfb25-4-tiled [75.185206] Subtest addfb25-4-tiled: SUCCESS (0.000s) [75.244951] [055/165] (927s left) kms_addfb_basic (addfb25-bad-modifier) [75.288416] Starting subtest: addfb25-bad-modifier [75.289484] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [75.397300] [056/165] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [75.444837] Starting subtest: addfb25-framebuffer-vs-set-tiling [75.445988] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [75.544154] [057/165] (927s left) kms_addfb_basic (addfb25-modifier-no-flag) [75.587687] Starting subtest: addfb25-modifier-no-flag [75.588709] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [75.696321] [058/165] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy) [75.743939] Starting subtest: addfb25-x-tiled-legacy [75.744969] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [75.827485] [059/165] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [75.871274] Starting subtest: addfb25-x-tiled-mismatch-legacy [75.872280] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [75.960818] [060/165] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [76.026637] Starting subtest: addfb25-yf-tiled-legacy [76.027730] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [76.094242] [061/165] (927s left) kms_addfb_basic (addfb25-y-tiled-legacy) [76.162828] Starting subtest: addfb25-y-tiled-legacy [76.163866] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [76.227085] [062/165] (927s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [76.296898] Starting subtest: addfb25-y-tiled-small-legacy [76.298960] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [76.360344] [063/165] (926s left) kms_addfb_basic (bad-pitch-0) [76.403298] Starting subtest: bad-pitch-0 [76.404436] Subtest bad-pitch-0: SUCCESS (0.000s) [76.494143] [064/165] (926s left) kms_addfb_basic (bad-pitch-1024) [76.540286] Starting subtest: bad-pitch-1024 [76.541391] Subtest bad-pitch-1024: SUCCESS (0.000s) [76.629381] [065/165] (926s left) kms_addfb_basic (bad-pitch-128) [76.679101] Starting subtest: bad-pitch-128 [76.680211] Subtest bad-pitch-128: SUCCESS (0.000s) [76.763220] [066/165] (926s left) kms_addfb_basic (bad-pitch-256) [76.807621] Starting subtest: bad-pitch-256 [76.808694] Subtest bad-pitch-256: SUCCESS (0.000s) [76.894155] [067/165] (926s left) kms_addfb_basic (bad-pitch-32) [76.943203] Starting subtest: bad-pitch-32 [76.944246] Subtest bad-pitch-32: SUCCESS (0.000s) [77.028319] [068/165] (926s left) kms_addfb_basic (bad-pitch-63) [77.072947] Starting subtest: bad-pitch-63 [77.074022] Subtest bad-pitch-63: SUCCESS (0.000s) [77.160442] [069/165] (926s left) kms_addfb_basic (bad-pitch-65536) [77.211708] Starting subtest: bad-pitch-65536 [77.212860] Subtest bad-pitch-65536: SUCCESS (0.000s) [77.310334] [070/165] (926s left) kms_addfb_basic (bad-pitch-999) [77.352984] Starting subtest: bad-pitch-999 [77.354022] Subtest bad-pitch-999: SUCCESS (0.000s) [77.446788] [071/165] (926s left) kms_addfb_basic (basic) [77.492412] Starting subtest: basic [77.493529] Subtest basic: SUCCESS (0.000s) [77.577721] [072/165] (925s left) kms_addfb_basic (basic-x-tiled-legacy) [77.622167] Starting subtest: basic-x-tiled-legacy [77.623228] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [77.710037] [073/165] (925s left) kms_addfb_basic (basic-y-tiled-legacy) [77.755268] Starting subtest: basic-y-tiled-legacy [77.756338] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [77.843714] [074/165] (925s left) kms_addfb_basic (bo-too-small) [77.916866] Starting subtest: bo-too-small [77.917857] Subtest bo-too-small: SUCCESS (0.000s) [77.976877] [075/165] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling) [78.043471] Starting subtest: bo-too-small-due-to-tiling [78.044616] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [78.110082] [076/165] (925s left) kms_addfb_basic (clobberred-modifier) [78.152405] Starting subtest: clobberred-modifier [78.153566] Subtest clobberred-modifier: SUCCESS (0.000s) [78.243326] [077/165] (925s left) kms_addfb_basic (framebuffer-vs-set-tiling) [78.289228] Starting subtest: framebuffer-vs-set-tiling [78.290277] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [78.376277] [078/165] (925s left) kms_addfb_basic (invalid-get-prop) [78.419321] Starting subtest: invalid-get-prop [78.420409] Subtest invalid-get-prop: SUCCESS (0.000s) [78.510538] [079/165] (925s left) kms_addfb_basic (invalid-get-prop-any) [78.553292] Starting subtest: invalid-get-prop-any [78.554406] Subtest invalid-get-prop-any: SUCCESS (0.000s) [78.643303] [080/165] (924s left) kms_addfb_basic (invalid-set-prop) [78.684929] Starting subtest: invalid-set-prop [78.686049] Subtest invalid-set-prop: SUCCESS (0.000s) [78.777728] [081/165] (924s left) kms_addfb_basic (invalid-set-prop-any) [78.827759] Starting subtest: invalid-set-prop-any [78.828956] Subtest invalid-set-prop-any: SUCCESS (0.000s) [78.926333] [082/165] (924s left) kms_addfb_basic (no-handle) [78.969068] Starting subtest: no-handle [78.970202] Subtest no-handle: SUCCESS (0.000s) [79.060220] [083/165] (924s left) kms_addfb_basic (size-max) [79.127034] Starting subtest: size-max [79.128105] Subtest size-max: SUCCESS (0.000s) [79.193190] [084/165] (924s left) kms_addfb_basic (small-bo) [79.259023] Starting subtest: small-bo [79.260140] Subtest small-bo: SUCCESS (0.000s) [79.326293] [085/165] (924s left) kms_addfb_basic (tile-pitch-mismatch) [79.371676] Starting subtest: tile-pitch-mismatch [79.372803] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [79.459645] [086/165] (924s left) kms_addfb_basic (too-high) [79.525072] Starting subtest: too-high [79.526706] Subtest too-high: SUCCESS (0.001s) [79.593305] [087/165] (924s left) kms_addfb_basic (too-wide) [79.660179] Starting subtest: too-wide [79.661210] Subtest too-wide: SUCCESS (0.000s) [79.726985] [088/165] (923s left) kms_addfb_basic (unused-handle) [79.770929] Starting subtest: unused-handle [79.771943] Subtest unused-handle: SUCCESS (0.000s) [79.861169] [089/165] (923s left) kms_addfb_basic (unused-modifier) [79.904952] Starting subtest: unused-modifier [79.906015] Subtest unused-modifier: SUCCESS (0.000s) [79.992996] [090/165] (923s left) kms_addfb_basic (unused-offsets) [80.035294] Starting subtest: unused-offsets [80.036285] Subtest unused-offsets: SUCCESS (0.000s) [80.126906] [091/165] (923s left) kms_addfb_basic (unused-pitches) [80.169474] Starting subtest: unused-pitches [80.170651] Subtest unused-pitches: SUCCESS (0.000s) [80.259756] [092/165] (923s left) kms_busy (basic) [80.327849] Starting subtest: basic [80.330249] Starting dynamic subtest: flip [80.768839] Dynamic subtest flip: SUCCESS (0.441s) [80.775358] Starting dynamic subtest: modeset [81.269051] Dynamic subtest modeset: SUCCESS (0.500s) [81.270094] Subtest basic: SUCCESS (0.942s) [81.400443] [093/165] (922s left) kms_prop_blob (basic) [81.446767] Starting subtest: basic [81.447865] Subtest basic: SUCCESS (0.000s) [81.497899] [094/165] (922s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [81.564155] Starting subtest: basic-busy-flip-before-cursor-atomic [82.489944] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.927s) [82.623902] [095/165] (921s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [82.692593] Starting subtest: basic-busy-flip-before-cursor-legacy [83.643484] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.951s) [83.771342] [096/165] (920s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [83.837414] Starting subtest: basic-flip-after-cursor-atomic [84.761896] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.923s) [84.891179] [097/165] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [84.956818] Starting subtest: basic-flip-after-cursor-legacy [85.896762] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.939s) [86.021438] [098/165] (917s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [86.089087] Starting subtest: basic-flip-after-cursor-varying-size [87.011081] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.922s) [87.141716] [099/165] (916s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [87.207473] Starting subtest: basic-flip-before-cursor-atomic [88.130954] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.922s) [88.259357] [100/165] (915s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [88.326552] Starting subtest: basic-flip-before-cursor-legacy [89.267468] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.941s) [89.398175] [101/165] (914s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [89.462423] Starting subtest: basic-flip-before-cursor-varying-size [90.386526] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.923s) [90.516563] [102/165] (913s left) kms_dsc (dsc-basic) [90.585384] Subtest dsc-basic: SKIP (0.000s) [90.606520] [103/165] (913s left) kms_flip (basic-flip-vs-dpms) [90.662116] Starting subtest: basic-flip-vs-dpms [90.663189] Starting dynamic subtest: A-VGA1 [91.513195] Dynamic subtest A-VGA1: SUCCESS (0.847s) [91.519577] Starting dynamic subtest: B-VGA1 [92.311287] Dynamic subtest B-VGA1: SUCCESS (0.800s) [92.318178] Starting dynamic subtest: C-VGA1 [93.116763] Dynamic subtest C-VGA1: SUCCESS (0.804s) [93.117839] Subtest basic-flip-vs-dpms: SUCCESS (2.457s) [93.272097] [104/165] (910s left) kms_flip (basic-flip-vs-modeset) [93.329084] Starting subtest: basic-flip-vs-modeset [93.330134] Starting dynamic subtest: A-VGA1 [94.188444] Dynamic subtest A-VGA1: SUCCESS (0.857s) [94.195191] Starting dynamic subtest: B-VGA1 [95.006743] Dynamic subtest B-VGA1: SUCCESS (0.818s) [95.013514] Starting dynamic subtest: C-VGA1 [95.820914] Dynamic subtest C-VGA1: SUCCESS (0.813s) [95.822015] Subtest basic-flip-vs-modeset: SUCCESS (2.494s) [95.955750] [105/165] (907s left) kms_flip (basic-flip-vs-wf_vblank) [96.015367] Starting subtest: basic-flip-vs-wf_vblank [96.016382] Starting dynamic subtest: A-VGA1 [97.161172] Dynamic subtest A-VGA1: SUCCESS (1.145s) [97.167783] Starting dynamic subtest: B-VGA1 [98.285446] Dynamic subtest B-VGA1: SUCCESS (1.123s) [98.292733] Starting dynamic subtest: C-VGA1 [99.408809] Dynamic subtest C-VGA1: SUCCESS (1.122s) [99.411232] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.397s) [99.583451] [106/165] (904s left) kms_flip (basic-plain-flip) [99.639177] Starting subtest: basic-plain-flip [99.640281] Starting dynamic subtest: A-VGA1 [100.507240] Dynamic subtest A-VGA1: SUCCESS (0.868s) [100.515272] Starting dynamic subtest: B-VGA1 [101.348368] Dynamic subtest B-VGA1: SUCCESS (0.839s) [101.357353] Starting dynamic subtest: C-VGA1 [102.187813] Dynamic subtest C-VGA1: SUCCESS (0.838s) [102.190303] Subtest basic-plain-flip: SUCCESS (2.553s) [102.377457] [107/165] (901s left) kms_force_connector_basic (force-connector-state) [102.434330] Starting subtest: force-connector-state [102.569843] Subtest force-connector-state: SUCCESS (0.135s) [102.743679] [108/165] (901s left) kms_force_connector_basic (force-edid) [102.797902] Starting subtest: force-edid [102.818865] Subtest force-edid: SUCCESS (0.020s) [102.929061] [109/165] (901s left) kms_force_connector_basic (force-load-detect) [102.983903] Starting subtest: force-load-detect [103.141807] Subtest force-load-detect: SUCCESS (0.158s) [103.316610] [110/165] (900s left) kms_force_connector_basic (prune-stale-modes) [103.373073] Starting subtest: prune-stale-modes [103.391539] Subtest prune-stale-modes: SUCCESS (0.019s) [103.481927] [111/165] (900s left) kms_frontbuffer_tracking (basic) [103.557267] Starting subtest: basic [105.368460] Subtest basic: SUCCESS (1.817s) [105.437426] [112/165] (898s left) kms_hdmi_inject (inject-audio) [105.525146] Starting subtest: inject-audio [105.626277] Subtest inject-audio: SUCCESS (0.098s) [105.815349] [113/165] (898s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [105.880842] Starting subtest: compare-crc-sanitycheck-xr24 [105.881922] Starting dynamic subtest: pipe-A-VGA-1 [106.157043] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.275s) [106.164575] Starting dynamic subtest: pipe-B-VGA-1 [106.421231] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.263s) [106.428351] Starting dynamic subtest: pipe-C-VGA-1 [106.687461] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.266s) [106.688731] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.807s) [106.818754] [114/165] (897s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [106.892224] Starting subtest: compare-crc-sanitycheck-nv12 [106.893401] Starting dynamic subtest: pipe-A-VGA-1 [106.895974] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [106.902884] Starting dynamic subtest: pipe-B-VGA-1 [106.905621] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [106.912606] Starting dynamic subtest: pipe-C-VGA-1 [106.915052] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [106.917718] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s) [106.952337] [115/165] (897s left) kms_pipe_crc_basic (hang-read-crc) [107.022408] Starting subtest: hang-read-crc [107.023703] Starting dynamic subtest: pipe-A-VGA-1 [107.753020] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.730s) [107.760079] Starting dynamic subtest: pipe-B-VGA-1 [108.480173] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.726s) [108.487116] Starting dynamic subtest: pipe-C-VGA-1 [109.208426] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.727s) [109.209593] Subtest hang-read-crc: SUCCESS (2.187s) [109.329435] [116/165] (894s left) kms_pipe_crc_basic (nonblocking-crc) [109.396185] Starting subtest: nonblocking-crc [109.397261] Starting dynamic subtest: pipe-A-VGA-1 [109.836240] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.439s) [109.843153] Starting dynamic subtest: pipe-B-VGA-1 [110.263568] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.427s) [110.270921] Starting dynamic subtest: pipe-C-VGA-1 [110.694327] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.430s) [110.695434] Subtest nonblocking-crc: SUCCESS (1.299s) [110.813410] [117/165] (893s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [110.878722] Starting subtest: nonblocking-crc-frame-sequence [110.879813] Starting dynamic subtest: pipe-A-VGA-1 [111.320233] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.441s) [111.328840] Starting dynamic subtest: pipe-B-VGA-1 [111.752947] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.430s) [111.759888] Starting dynamic subtest: pipe-C-VGA-1 [112.181183] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.428s) [112.182228] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.303s) [112.303567] [118/165] (891s left) kms_pipe_crc_basic (read-crc) [112.368945] Starting subtest: read-crc [112.370156] Starting dynamic subtest: pipe-A-VGA-1 [112.740911] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.371s) [112.750117] Starting dynamic subtest: pipe-B-VGA-1 [113.103254] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.361s) [113.111737] Starting dynamic subtest: pipe-C-VGA-1 [113.467536] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.363s) [113.468574] Subtest read-crc: SUCCESS (1.099s) [113.592455] [119/165] (890s left) kms_pipe_crc_basic (read-crc-frame-sequence) [113.664986] Starting subtest: read-crc-frame-sequence [113.666108] Starting dynamic subtest: pipe-A-VGA-1 [114.026862] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.361s) [114.036025] Starting dynamic subtest: pipe-B-VGA-1 [114.392176] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.365s) [114.399043] Starting dynamic subtest: pipe-C-VGA-1 [114.755052] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.361s) [114.756142] Subtest read-crc-frame-sequence: SUCCESS (1.091s) [114.875407] [120/165] (889s left) kms_pm_backlight (basic-brightness) [114.940625] Subtest basic-brightness: SKIP (0.000s) [114.967612] [121/165] (889s left) kms_pm_rpm (basic-pci-d3-state) [116.333483] Starting subtest: basic-pci-d3-state [116.531246] Subtest basic-pci-d3-state: SUCCESS (0.196s) [116.775592] [122/165] (887s left) kms_pm_rpm (basic-rte) [116.819321] Starting subtest: basic-rte [118.320375] Subtest basic-rte: SUCCESS (1.500s) [118.863941] [123/165] (885s left) kms_psr (psr_primary_page_flip) [118.939143] Subtest psr_primary_page_flip: SKIP (0.000s) [118.958461] [124/165] (885s left) kms_psr (psr_cursor_plane_move) [119.024383] Subtest psr_cursor_plane_move: SKIP (0.000s) [119.041637] [125/165] (885s left) kms_psr (psr_sprite_plane_onoff) [119.108564] Subtest psr_sprite_plane_onoff: SKIP (0.000s) [119.125498] [126/165] (885s left) kms_psr (psr_primary_mmap_gtt) [119.190922] Subtest psr_primary_mmap_gtt: SKIP (0.000s) [119.207426] [127/165] (885s left) kms_setmode (basic-clone-single-crtc) [119.251942] Starting subtest: basic-clone-single-crtc [119.255198] Subtest basic-clone-single-crtc: SKIP (0.000s) [119.316116] [128/165] (884s left) i915_pm_rps (basic-api) [119.361963] Starting subtest: basic-api [119.364444] Subtest basic-api: SUCCESS (0.002s) [119.431478] [129/165] (884s left) prime_self_import (basic-llseek-bad) [119.475024] Starting subtest: basic-llseek-bad [119.477228] Subtest basic-llseek-bad: SUCCESS (0.001s) [119.548827] [130/165] (884s left) prime_self_import (basic-llseek-size) [119.590858] Starting subtest: basic-llseek-size [119.594206] Subtest basic-llseek-size: SUCCESS (0.002s) [119.665571] [131/165] (884s left) prime_self_import (basic-with_fd_dup) [119.710192] Starting subtest: basic-with_fd_dup [119.712346] Subtest basic-with_fd_dup: SUCCESS (0.002s) [119.779843] [132/165] (884s left) prime_self_import (basic-with_one_bo) [119.820529] Starting subtest: basic-with_one_bo [119.822915] Subtest basic-with_one_bo: SUCCESS (0.002s) [119.875316] [133/165] (884s left) prime_self_import (basic-with_one_bo_two_files) [119.917261] Starting subtest: basic-with_one_bo_two_files [119.919483] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [119.997051] [134/165] (884s left) prime_self_import (basic-with_two_bos) [120.040204] Starting subtest: basic-with_two_bos [120.042407] Subtest basic-with_two_bos: SUCCESS (0.002s) [120.116426] [135/165] (884s left) prime_vgem (basic-fence-flip) [120.169986] Starting subtest: basic-fence-flip [120.498791] Subtest basic-fence-flip: SUCCESS (0.329s) [120.582868] [136/165] (883s left) prime_vgem (basic-fence-mmap) [120.635876] Starting subtest: basic-fence-mmap [120.660037] Subtest basic-fence-mmap: SUCCESS (0.024s) [120.733472] [137/165] (883s left) prime_vgem (basic-fence-read) [120.786639] Starting subtest: basic-fence-read [120.821585] Subtest basic-fence-read: SUCCESS (0.035s) [120.896341] [138/165] (883s left) prime_vgem (basic-gtt) [120.953656] Starting subtest: basic-gtt [120.965984] Subtest basic-gtt: SUCCESS (0.012s) [121.032955] [139/165] (883s left) prime_vgem (basic-read) [121.087945] Starting subtest: basic-read [121.105127] Subtest basic-read: SUCCESS (0.017s) [121.181456] [140/165] (883s left) prime_vgem (basic-write) [121.237235] Starting subtest: basic-write [121.254818] Subtest basic-write: SUCCESS (0.018s) [121.312751] [141/165] (883s left) vgem_basic (setversion) [121.366652] Starting subtest: setversion [121.369194] Subtest setversion: SUCCESS (0.000s) [121.412761] [142/165] (883s left) vgem_basic (create) [121.468116] Starting subtest: create [121.469283] Subtest create: SUCCESS (0.000s) [121.512674] [143/165] (883s left) vgem_basic (debugfs) [121.568488] Starting subtest: debugfs [121.569677] Subtest debugfs: SUCCESS (0.001s) [121.613725] [144/165] (882s left) vgem_basic (dmabuf-export) [121.666474] Starting subtest: dmabuf-export [121.668722] Subtest dmabuf-export: SUCCESS (0.001s) [121.747850] [145/165] (882s left) vgem_basic (dmabuf-fence) [121.799571] Starting subtest: dmabuf-fence [121.800712] Subtest dmabuf-fence: SUCCESS (0.001s) [121.847122] [146/165] (882s left) vgem_basic (dmabuf-fence-before) [121.899461] Starting subtest: dmabuf-fence-before [121.900577] Subtest dmabuf-fence-before: SUCCESS (0.001s) [121.947216] [147/165] (882s left) vgem_basic (dmabuf-mmap) [122.001075] Starting subtest: dmabuf-mmap [122.016104] Subtest dmabuf-mmap: SUCCESS (0.016s) [122.062631] [148/165] (882s left) vgem_basic (mmap) [122.116475] Starting subtest: mmap [122.125748] Subtest mmap: SUCCESS (0.010s) [122.163409] [149/165] (882s left) vgem_basic (second-client) [122.216577] Starting subtest: second-client [122.250094] Subtest second-client: SUCCESS (0.033s) [122.296824] [150/165] (882s left) vgem_basic (sysfs) [122.349541] Starting subtest: sysfs [122.350658] Subtest sysfs: SUCCESS (0.000s) [122.398117] [151/165] (882s left) core_hotunplug (unbind-rebind) [122.483999] Starting subtest: unbind-rebind [125.295825] Subtest unbind-rebind: SUCCESS (2.812s) [125.315165] [152/165] (879s left) vgem_basic (unload) [125.361512] Starting subtest: unload [154.242102] Subtest unload: SUCCESS (28.879s) [154.323254] [153/165] (850s left) i915_module_load (reload) [154.369146] Starting subtest: reload [156.180628] Subtest reload: SUCCESS (1.814s) [156.203741] [154/165] (848s left) gem_lmem_swapping (basic) [156.261641] Subtest basic: SKIP (0.000s) [156.292401] [155/165] (848s left) gem_lmem_swapping (parallel-random-engines) [156.340486] Subtest parallel-random-engines: SKIP (0.000s) [156.375813] [156/165] (848s left) gem_lmem_swapping (random-engines) [156.423955] Subtest random-engines: SKIP (0.000s) [156.457128] [157/165] (848s left) gem_lmem_swapping (verify-random) [156.505389] Subtest verify-random: SKIP (0.000s) [156.521381] [158/165] (848s left) i915_pm_rpm (module-reload) [158.113801] Starting subtest: module-reload [164.053938] Subtest module-reload: SUCCESS (5.940s) [164.070394] [159/165] (840s left) i915_selftest (live) [164.120903] Starting subtest: live [164.122032] Starting dynamic subtest: sanitycheck [164.792609] Dynamic subtest sanitycheck: SUCCESS (0.670s) [164.799703] Starting dynamic subtest: uncore [165.483015] Dynamic subtest uncore: SUCCESS (0.688s) [165.489553] Starting dynamic subtest: workarounds [166.168610] Dynamic subtest workarounds: SUCCESS (0.684s) [166.175877] Starting dynamic subtest: gt_engines [166.847170] Dynamic subtest gt_engines: SUCCESS (0.676s) [166.854237] Starting dynamic subtest: gt_timelines [172.649827] Dynamic subtest gt_timelines: SUCCESS (5.800s) [172.657385] Starting dynamic subtest: gt_contexts [173.337129] Dynamic subtest gt_contexts: SUCCESS (0.684s) [173.345068] Starting dynamic subtest: gt_lrc [174.062199] Dynamic subtest gt_lrc: SUCCESS (0.722s) [174.071969] Starting dynamic subtest: gt_mocs [174.767989] Dynamic subtest gt_mocs: SUCCESS (0.704s) [174.778307] Starting dynamic subtest: gt_pm [185.459392] Dynamic subtest gt_pm: SUCCESS (10.688s) [185.466214] Starting dynamic subtest: gt_heartbeat [186.255076] Dynamic subtest gt_heartbeat: SUCCESS (0.793s) [186.262284] Starting dynamic subtest: gt_tlb [186.809011] Dynamic subtest gt_tlb: SUCCESS (0.552s) [186.814668] Starting dynamic subtest: requests [193.163207] Dynamic subtest requests: SUCCESS (6.349s) [193.168891] Starting dynamic subtest: migrate [193.752327] Dynamic subtest migrate: SUCCESS (0.589s) [193.757925] Starting dynamic subtest: active [194.489341] Dynamic subtest active: SUCCESS (0.736s) [194.497263] Starting dynamic subtest: objects [195.461047] Dynamic subtest objects: SUCCESS (0.970s) [195.466807] Starting dynamic subtest: mman [199.434948] Dynamic subtest mman: SUCCESS (3.972s) [199.440894] Starting dynamic subtest: dmabuf [200.030014] Dynamic subtest dmabuf: SUCCESS (0.593s) [200.035690] Starting dynamic subtest: vma [200.617173] Dynamic subtest vma: SUCCESS (0.584s) [200.622703] Starting dynamic subtest: coherency [201.890318] Dynamic subtest coherency: SUCCESS (1.270s) [201.896341] Starting dynamic subtest: gtt [205.947790] Dynamic subtest gtt: SUCCESS (4.059s) [205.955278] Starting dynamic subtest: gem [206.697853] Dynamic subtest gem: SUCCESS (0.747s) [206.705215] Starting dynamic subtest: evict [207.402170] Dynamic subtest evict: SUCCESS (0.701s) [207.409451] Starting dynamic subtest: hugepages [208.626700] Dynamic subtest hugepages: SUCCESS (1.222s) [208.635948] Starting dynamic subtest: gem_contexts [213.427566] Dynamic subtest gem_contexts: SUCCESS (4.798s) [213.434954] Starting dynamic subtest: client [214.137044] Dynamic subtest client: SUCCESS (0.707s) [214.145758] Starting dynamic subtest: gem_migrate [214.837994] Dynamic subtest gem_migrate: SUCCESS (0.698s) [214.843846] Starting dynamic subtest: reset [216.676529] Dynamic subtest reset: SUCCESS (1.836s) [216.684700] Starting dynamic subtest: memory_region [217.282814] Dynamic subtest memory_region: SUCCESS (0.604s) [217.290057] Starting dynamic subtest: hangcheck [234.532959] Dynamic subtest hangcheck: SUCCESS (17.248s) [234.538798] Starting dynamic subtest: execlists [235.116560] Dynamic subtest execlists: SUCCESS (0.582s) [235.123529] Starting dynamic subtest: ring_submission [235.823953] Dynamic subtest ring_submission: SUCCESS (0.705s) [235.831419] Starting dynamic subtest: perf [236.612096] Dynamic subtest perf: SUCCESS (0.786s) [236.618433] Starting dynamic subtest: slpc [237.293145] Dynamic subtest slpc: SUCCESS (0.676s) [237.299154] Starting dynamic subtest: guc [237.923202] Dynamic subtest guc: SUCCESS (0.631s) [237.930243] Starting dynamic subtest: guc_multi_lrc [238.480806] Dynamic subtest guc_multi_lrc: SUCCESS (0.555s) [238.487971] Starting dynamic subtest: guc_hang [239.058034] Dynamic subtest guc_hang: SUCCESS (0.575s) [239.064289] Starting dynamic subtest: late_gt_pm [239.753766] Dynamic subtest late_gt_pm: SUCCESS (0.694s) [239.754938] Subtest live: SUCCESS (75.633s) [239.770198] [160/165] (765s left) dmabuf (all-tests) [239.819170] Starting subtest: all-tests [239.822846] Starting dynamic subtest: sanitycheck [239.884761] Dynamic subtest sanitycheck: SUCCESS (0.065s) [239.891444] Starting dynamic subtest: dma_fence [240.057616] Dynamic subtest dma_fence: SUCCESS (0.171s) [240.065643] Starting dynamic subtest: dma_fence_chain [251.567874] Dynamic subtest dma_fence_chain: SUCCESS (11.508s) [251.574767] Starting dynamic subtest: dma_fence_unwrap [251.632439] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s) [251.638485] Starting dynamic subtest: dma_resv [251.699439] Dynamic subtest dma_resv: SUCCESS (0.066s) [251.700600] Subtest all-tests: SUCCESS (11.880s) [251.714993] [161/165] (753s left) i915_suspend (basic-s2idle-without-i915) [251.759899] Starting subtest: basic-s2idle-without-i915 [268.566056] Subtest basic-s2idle-without-i915: SUCCESS (1.782s) [274.692672] [162/165] (751s left) i915_suspend (basic-s3-without-i915) [274.735977] Starting subtest: basic-s3-without-i915 [293.062854] Subtest basic-s3-without-i915: SUCCESS (1.618s) [296.084282] [163/165] (749s left) gem_exec_suspend (basic-s0) [296.141510] Starting subtest: basic-S0 [296.142541] Starting dynamic subtest: smem [312.484245] Dynamic subtest smem: SUCCESS (1.061s) [312.485749] Subtest basic-S0: SUCCESS (1.062s) [319.685172] [164/165] (747s left) gem_exec_suspend (basic-s3) [319.735646] Starting subtest: basic-S3 [319.736818] Starting dynamic subtest: smem [337.518000] Dynamic subtest smem: SUCCESS (1.134s) [337.519212] Subtest basic-S3: SUCCESS (1.136s) [343.667623] [165/165] (746s left) kms_pipe_crc_basic (suspend-read-crc) [343.736546] Starting subtest: suspend-read-crc [343.737689] Starting dynamic subtest: pipe-A-VGA-1 [361.669910] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.289s) [361.679782] Starting dynamic subtest: pipe-B-VGA-1 [379.674143] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.286s) [379.683950] Starting dynamic subtest: pipe-C-VGA-1 [397.677687] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.276s) [397.678743] Subtest suspend-read-crc: SUCCESS (3.854s) [402.772415] Closing watchdogs Done.