[26.642259] Initializing watchdogs [26.642337] /dev/watchdog0 [26.653342] [001/161] (960s left) i915_module_load (load) [26.695549] Starting subtest: load [29.516595] Subtest load: SUCCESS (2.827s) [29.541946] [002/161] (957s left) core_auth (basic-auth) [31.212276] Starting subtest: basic-auth [31.218528] Subtest basic-auth: SUCCESS (0.002s) [31.307293] [003/161] (955s left) debugfs_test (read_all_entries) [31.382060] Starting subtest: read_all_entries [31.518151] Subtest read_all_entries: SUCCESS (0.139s) [31.672452] [004/161] (955s left) debugfs_test (basic-hwmon) [31.741030] Starting subtest: basic-hwmon [31.755152] Subtest basic-hwmon: SKIP (0.000s) [31.886748] [005/161] (955s left) debugfs_test (sysfs) [31.949621] Starting subtest: sysfs [31.975737] Subtest sysfs: SUCCESS (0.018s) [32.121173] [006/161] (955s left) fbdev (eof) [32.171972] Starting subtest: eof [32.178351] Subtest eof: SUCCESS (0.000s) [32.224884] [007/161] (955s left) fbdev (info) [32.270733] Starting subtest: info [32.276879] Subtest info: SUCCESS (0.000s) [32.319175] [008/161] (954s left) fbdev (nullptr) [32.367903] Starting subtest: nullptr [32.377731] Subtest nullptr: SUCCESS (0.000s) [32.419434] [009/161] (954s left) fbdev (read) [32.469164] Starting subtest: read [33.192489] Subtest read: SUCCESS (0.725s) [33.235167] [010/161] (954s left) fbdev (write) [33.285397] Starting subtest: write [33.799539] Subtest write: SUCCESS (0.507s) [33.834417] [011/161] (953s left) gem_basic (bad-close) [33.884413] Starting subtest: bad-close [33.897136] Subtest bad-close: SUCCESS (0.000s) [33.973163] [012/161] (953s left) gem_basic (create-close) [34.023852] Starting subtest: create-close [34.036524] Subtest create-close: SUCCESS (0.000s) [34.105339] [013/161] (953s left) gem_basic (create-fd-close) [34.156267] Starting subtest: create-fd-close [34.168574] Subtest create-fd-close: SUCCESS (0.000s) [34.238490] [014/161] (953s left) gem_busy (busy@all-engines) [34.307291] Starting subtest: busy [34.313626] Starting dynamic subtest: all-engines [34.360163] Dynamic subtest all-engines: SUCCESS (0.058s) [34.366147] Subtest busy: SUCCESS (0.058s) [36.273781] [015/161] (951s left) gem_close_race (basic-process) [36.339962] Starting subtest: basic-process [36.389085] Subtest basic-process: SUCCESS (0.053s) [36.555642] [016/161] (950s left) gem_close_race (basic-threads) [36.624748] Starting subtest: basic-threads [37.828631] Subtest basic-threads: SUCCESS (1.209s) [38.005725] [017/161] (949s left) gem_ctx_create (basic) [38.077633] Starting subtest: basic [38.084042] Subtest basic: SUCCESS (0.000s) [38.239434] [018/161] (949s left) gem_ctx_create (basic-files) [38.301359] Starting subtest: basic-files [40.437470] Subtest basic-files: SUCCESS (2.126s) [42.274556] [019/161] (945s left) gem_ctx_exec (basic) [42.341055] Starting subtest: basic [42.347369] Subtest basic: SUCCESS (0.008s) [42.456617] [020/161] (945s left) gem_exec_basic (basic) [42.521739] Starting subtest: basic [42.527987] Starting dynamic subtest: rcs0-smem [42.534353] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [42.546473] Starting dynamic subtest: bcs0-smem [42.552719] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [42.562490] Starting dynamic subtest: vcs0-smem [42.568595] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [42.578368] Starting dynamic subtest: vcs1-smem [42.584503] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [42.594020] Starting dynamic subtest: vecs0-smem [42.600092] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [42.609713] Starting dynamic subtest: ccs0-smem [42.615715] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [42.621896] Subtest basic: SUCCESS (0.013s) [44.246426] [021/161] (943s left) gem_exec_create (basic) [44.316035] Starting subtest: basic [44.322515] Starting dynamic subtest: smem [48.251162] Dynamic subtest smem: SUCCESS (3.891s) [48.257651] Subtest basic: SUCCESS (3.891s) [48.426680] [022/161] (939s left) gem_exec_fence (basic-busy) [48.605913] Starting subtest: basic-busy [48.612617] Starting dynamic subtest: rcs0 [48.665385] Dynamic subtest rcs0: SUCCESS (0.060s) [48.678191] Starting dynamic subtest: bcs0 [48.719499] Dynamic subtest bcs0: SUCCESS (0.054s) [48.732571] Starting dynamic subtest: vcs0 [48.765218] Dynamic subtest vcs0: SUCCESS (0.045s) [48.777167] Starting dynamic subtest: vcs1 [48.816983] Dynamic subtest vcs1: SUCCESS (0.051s) [48.829388] Starting dynamic subtest: vecs0 [48.874039] Dynamic subtest vecs0: SUCCESS (0.056s) [48.886457] Starting dynamic subtest: ccs0 [48.922869] Dynamic subtest ccs0: SUCCESS (0.049s) [48.928792] Subtest basic-busy: SUCCESS (0.316s) [50.307242] [023/161] (937s left) gem_exec_fence (basic-wait) [50.488170] Starting subtest: basic-wait [50.494473] Starting dynamic subtest: rcs0 [50.568664] Dynamic subtest rcs0: SUCCESS (0.081s) [50.582073] Starting dynamic subtest: bcs0 [50.625577] Dynamic subtest bcs0: SUCCESS (0.056s) [50.638647] Starting dynamic subtest: vcs0 [50.679391] Dynamic subtest vcs0: SUCCESS (0.053s) [50.692603] Starting dynamic subtest: vcs1 [50.736368] Dynamic subtest vcs1: SUCCESS (0.056s) [50.749354] Starting dynamic subtest: vecs0 [50.793183] Dynamic subtest vecs0: SUCCESS (0.056s) [50.806132] Starting dynamic subtest: ccs0 [50.846446] Dynamic subtest ccs0: SUCCESS (0.053s) [50.852696] Subtest basic-wait: SUCCESS (0.358s) [52.270241] [024/161] (935s left) gem_exec_fence (basic-await) [52.451732] Starting subtest: basic-await [52.457702] Starting dynamic subtest: rcs0 [52.524326] Dynamic subtest rcs0: SUCCESS (0.073s) [52.534382] Starting dynamic subtest: bcs0 [52.591816] Dynamic subtest bcs0: SUCCESS (0.067s) [52.601682] Starting dynamic subtest: vcs0 [52.660402] Dynamic subtest vcs0: SUCCESS (0.068s) [52.670005] Starting dynamic subtest: vcs1 [52.728673] Dynamic subtest vcs1: SUCCESS (0.068s) [52.738376] Starting dynamic subtest: vecs0 [52.794913] Dynamic subtest vecs0: SUCCESS (0.066s) [52.804448] Starting dynamic subtest: ccs0 [52.862385] Dynamic subtest ccs0: SUCCESS (0.067s) [52.868694] Subtest basic-await: SUCCESS (0.410s) [54.277835] [025/161] (933s left) gem_exec_fence (nb-await) [54.458804] Starting subtest: nb-await [54.465215] Starting dynamic subtest: rcs0 [54.522507] Dynamic subtest rcs0: SUCCESS (0.064s) [54.534446] Starting dynamic subtest: bcs0 [54.582027] Dynamic subtest bcs0: SUCCESS (0.059s) [54.593695] Starting dynamic subtest: vcs0 [54.641883] Dynamic subtest vcs0: SUCCESS (0.059s) [54.653352] Starting dynamic subtest: vcs1 [54.700989] Dynamic subtest vcs1: SUCCESS (0.059s) [54.712075] Starting dynamic subtest: vecs0 [54.761767] Dynamic subtest vecs0: SUCCESS (0.061s) [54.772973] Starting dynamic subtest: ccs0 [54.821061] Dynamic subtest ccs0: SUCCESS (0.059s) [54.827435] Subtest nb-await: SUCCESS (0.362s) [56.336147] [026/161] (931s left) gem_exec_gttfill (basic) [56.411141] Starting subtest: basic [58.495910] Subtest basic: SUCCESS (2.074s) [58.657405] [027/161] (929s left) gem_exec_parallel (engines) [58.732875] Starting subtest: engines [58.739404] Starting dynamic subtest: basic [60.289405] Dynamic subtest basic: SUCCESS (1.551s) [60.303646] Starting dynamic subtest: contexts [62.517193] Dynamic subtest contexts: SUCCESS (2.224s) [62.529827] Starting dynamic subtest: fds [64.588161] Dynamic subtest fds: SUCCESS (2.068s) [64.602821] Starting dynamic subtest: userptr [65.888799] Dynamic subtest userptr: SUCCESS (1.308s) [65.894952] Subtest engines: SUCCESS (7.152s) [66.055222] [028/161] (921s left) gem_exec_store (basic) [66.129562] Starting subtest: basic [66.218776] Subtest basic: SUCCESS (0.102s) [66.385133] [029/161] (921s left) gem_flink_basic (bad-flink) [66.449651] Starting subtest: bad-flink [66.455989] Subtest bad-flink: SUCCESS (0.000s) [66.519499] [030/161] (921s left) gem_flink_basic (bad-open) [66.569408] Starting subtest: bad-open [66.575502] Subtest bad-open: SUCCESS (0.000s) [66.651434] [031/161] (921s left) gem_flink_basic (basic) [66.709445] Starting subtest: basic [66.715618] Subtest basic: SUCCESS (0.000s) [66.802213] [032/161] (921s left) gem_flink_basic (double-flink) [66.857502] Starting subtest: double-flink [66.863638] Subtest double-flink: SUCCESS (0.000s) [66.935498] [033/161] (921s left) gem_flink_basic (flink-lifetime) [66.995101] Starting subtest: flink-lifetime [67.001346] Subtest flink-lifetime: SUCCESS (0.001s) [67.068883] [034/161] (920s left) gem_huc_copy (huc-copy) [67.133662] Starting subtest: huc-copy [67.139395] Subtest huc-copy: SUCCESS (0.003s) [67.236127] [035/161] (920s left) gem_linear_blits (basic) [67.383949] Starting subtest: basic [67.390640] Subtest basic: SUCCESS (0.006s) [67.508238] [036/161] (920s left) gem_mmap (basic) [67.590185] Subtest basic: SKIP (0.000s) [67.636653] [037/161] (920s left) gem_mmap_gtt (basic) [67.699814] Subtest basic: SKIP (0.000s) [67.753574] [038/161] (920s left) gem_render_linear_blits (basic) [67.820934] Starting subtest: basic [67.851812] Subtest basic: SUCCESS (0.027s) [67.920803] [039/161] (920s left) gem_render_tiled_blits (basic) [67.982197] Subtest basic: SKIP (0.000s) [68.054078] [040/161] (920s left) gem_ringfill (basic-all) [74.250737] Starting subtest: basic-all [75.403111] Subtest basic-all: SUCCESS (1.156s) [75.491974] [041/161] (912s left) gem_softpin (allocator-basic) [75.552365] Starting subtest: allocator-basic [75.603553] Subtest allocator-basic: SUCCESS (0.055s) [75.706238] [042/161] (912s left) gem_softpin (allocator-basic-reserve) [75.770810] Starting subtest: allocator-basic-reserve [75.822353] Subtest allocator-basic-reserve: SUCCESS (0.055s) [75.940430] [043/161] (912s left) gem_softpin (safe-alignment) [76.022045] Starting subtest: safe-alignment [76.037395] Subtest safe-alignment: SUCCESS (0.018s) [77.277407] [044/161] (910s left) gem_sync (basic-all) [77.392810] Starting subtest: basic-all [81.221845] Subtest basic-all: SUCCESS (3.869s) [81.398523] [045/161] (906s left) gem_sync (basic-each) [81.514460] Starting subtest: basic-each [83.729476] Subtest basic-each: SUCCESS (2.256s) [83.900959] [046/161] (904s left) gem_tiled_blits (basic) [83.974446] Subtest basic: SKIP (0.000s) [84.009977] [047/161] (904s left) gem_tiled_fence_blits (basic) [84.075182] Subtest basic: SKIP (0.000s) [84.126033] [048/161] (904s left) gem_tiled_pread_basic [84.245557] [049/161] (904s left) gem_wait (busy@all-engines) [84.303677] Starting subtest: busy [84.312036] Starting dynamic subtest: all-engines [86.212696] Dynamic subtest all-engines: SUCCESS (1.900s) [86.218981] Subtest busy: SUCCESS (1.900s) [86.393813] [050/161] (902s left) gem_wait (wait@all-engines) [86.464834] Starting subtest: wait [86.471441] Starting dynamic subtest: all-engines [88.257709] Dynamic subtest all-engines: SUCCESS (1.789s) [88.263889] Subtest wait: SUCCESS (1.789s) [88.429305] [051/161] (900s left) i915_getparams_basic (basic-eu-total) [88.497577] Starting subtest: basic-eu-total [88.509857] Subtest basic-eu-total: SUCCESS (0.000s) [88.584195] [052/161] (899s left) i915_getparams_basic (basic-subslice-total) [88.654771] Starting subtest: basic-subslice-total [88.667158] Subtest basic-subslice-total: SUCCESS (0.000s) [88.728576] [053/161] (899s left) i915_hangman (error-state-basic) [88.797915] Starting subtest: error-state-basic [88.909692] Subtest error-state-basic: SUCCESS (0.107s) [88.977132] [054/161] (899s left) i915_pciid [89.127218] [055/161] (899s left) kms_addfb_basic (addfb25-4-tiled) [89.283276] Starting subtest: addfb25-4-tiled [89.289137] Subtest addfb25-4-tiled: SUCCESS (0.000s) [89.378938] [056/161] (899s left) kms_addfb_basic (addfb25-bad-modifier) [89.443667] Starting subtest: addfb25-bad-modifier [89.449899] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [89.617303] [057/161] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [89.696442] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [89.844461] [058/161] (898s left) kms_addfb_basic (addfb25-modifier-no-flag) [89.906316] Starting subtest: addfb25-modifier-no-flag [89.915956] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [90.078725] [059/161] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [90.150326] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [90.340333] [060/161] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [90.404514] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [90.580262] [061/161] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [90.724712] Starting subtest: addfb25-yf-tiled-legacy [90.733748] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [90.798363] [062/161] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy) [90.950443] Starting subtest: addfb25-y-tiled-legacy [90.956403] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [91.029462] [063/161] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [91.191118] Starting subtest: addfb25-y-tiled-small-legacy [91.202757] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [91.280140] [064/161] (897s left) kms_addfb_basic (bad-pitch-0) [91.357662] Starting subtest: bad-pitch-0 [91.363281] Subtest bad-pitch-0: SUCCESS (0.000s) [91.533546] [065/161] (897s left) kms_addfb_basic (bad-pitch-1024) [91.582381] Starting subtest: bad-pitch-1024 [91.588111] Subtest bad-pitch-1024: SUCCESS (0.000s) [91.753563] [066/161] (897s left) kms_addfb_basic (bad-pitch-128) [91.807215] Starting subtest: bad-pitch-128 [91.813099] Subtest bad-pitch-128: SUCCESS (0.000s) [91.979603] [067/161] (896s left) kms_addfb_basic (bad-pitch-256) [92.050769] Starting subtest: bad-pitch-256 [92.056398] Subtest bad-pitch-256: SUCCESS (0.000s) [92.215348] [068/161] (896s left) kms_addfb_basic (bad-pitch-32) [92.269891] Starting subtest: bad-pitch-32 [92.275765] Subtest bad-pitch-32: SUCCESS (0.000s) [92.462629] [069/161] (896s left) kms_addfb_basic (bad-pitch-63) [92.526758] Starting subtest: bad-pitch-63 [92.532483] Subtest bad-pitch-63: SUCCESS (0.000s) [92.695695] [070/161] (896s left) kms_addfb_basic (bad-pitch-65536) [92.764216] Starting subtest: bad-pitch-65536 [92.769982] Subtest bad-pitch-65536: SUCCESS (0.000s) [92.946026] [071/161] (896s left) kms_addfb_basic (bad-pitch-999) [93.011932] Starting subtest: bad-pitch-999 [93.017626] Subtest bad-pitch-999: SUCCESS (0.000s) [93.176654] [072/161] (895s left) kms_addfb_basic (basic) [93.233185] Starting subtest: basic [93.239067] Subtest basic: SUCCESS (0.000s) [93.429621] [073/161] (895s left) kms_addfb_basic (basic-x-tiled-legacy) [93.498766] Starting subtest: basic-x-tiled-legacy [93.510134] Subtest basic-x-tiled-legacy: SKIP (0.000s) [93.662695] [074/161] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [93.733964] Starting subtest: basic-y-tiled-legacy [93.745249] Subtest basic-y-tiled-legacy: SKIP (0.000s) [93.895747] [075/161] (895s left) kms_addfb_basic (bo-too-small) [94.040785] Starting subtest: bo-too-small [94.046080] Subtest bo-too-small: SUCCESS (0.000s) [94.129358] [076/161] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling) [94.276397] Starting subtest: bo-too-small-due-to-tiling [94.287307] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [94.363352] [077/161] (894s left) kms_addfb_basic (clobberred-modifier) [94.416878] Starting subtest: clobberred-modifier [94.428327] Subtest clobberred-modifier: SKIP (0.000s) [94.578337] [078/161] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [94.637645] Starting subtest: framebuffer-vs-set-tiling [94.648839] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [94.813194] [079/161] (894s left) kms_addfb_basic (invalid-get-prop) [94.867155] Starting subtest: invalid-get-prop [94.872653] Subtest invalid-get-prop: SUCCESS (0.000s) [95.062247] [080/161] (894s left) kms_addfb_basic (invalid-get-prop-any) [95.115029] Starting subtest: invalid-get-prop-any [95.120762] Subtest invalid-get-prop-any: SUCCESS (0.000s) [95.293850] [081/161] (893s left) kms_addfb_basic (invalid-set-prop) [95.357454] Starting subtest: invalid-set-prop [95.363479] Subtest invalid-set-prop: SUCCESS (0.000s) [95.529954] [082/161] (893s left) kms_addfb_basic (invalid-set-prop-any) [95.578427] Starting subtest: invalid-set-prop-any [95.584713] Subtest invalid-set-prop-any: SUCCESS (0.000s) [95.762289] [083/161] (893s left) kms_addfb_basic (no-handle) [95.824507] Starting subtest: no-handle [95.830545] Subtest no-handle: SUCCESS (0.000s) [95.994897] [084/161] (893s left) kms_addfb_basic (size-max) [96.136467] Starting subtest: size-max [96.141865] Subtest size-max: SUCCESS (0.000s) [96.230186] [085/161] (893s left) kms_addfb_basic (small-bo) [96.374667] Starting subtest: small-bo [96.379953] Subtest small-bo: SUCCESS (0.000s) [96.445578] [086/161] (892s left) kms_addfb_basic (tile-pitch-mismatch) [96.507682] Starting subtest: tile-pitch-mismatch [96.519903] Subtest tile-pitch-mismatch: SKIP (0.000s) [96.663508] [087/161] (892s left) kms_addfb_basic (too-high) [96.810944] Starting subtest: too-high [96.816487] Subtest too-high: SUCCESS (0.000s) [96.896499] [088/161] (892s left) kms_addfb_basic (too-wide) [97.044943] Starting subtest: too-wide [97.050552] Subtest too-wide: SUCCESS (0.000s) [97.113485] [089/161] (892s left) kms_addfb_basic (unused-handle) [97.167347] Starting subtest: unused-handle [97.172834] Subtest unused-handle: SUCCESS (0.000s) [97.329234] [090/161] (892s left) kms_addfb_basic (unused-modifier) [97.385882] Starting subtest: unused-modifier [97.392263] Subtest unused-modifier: SUCCESS (0.000s) [97.546043] [091/161] (891s left) kms_addfb_basic (unused-offsets) [97.601685] Starting subtest: unused-offsets [97.607555] Subtest unused-offsets: SUCCESS (0.000s) [97.780368] [092/161] (891s left) kms_addfb_basic (unused-pitches) [97.845902] Starting subtest: unused-pitches [97.852125] Subtest unused-pitches: SUCCESS (0.000s) [98.030398] [093/161] (891s left) kms_busy (basic) [98.181221] Starting subtest: basic [98.187017] Starting dynamic subtest: flip [98.723526] Dynamic subtest flip: SUCCESS (0.537s) [98.736064] Starting dynamic subtest: modeset [99.547685] Dynamic subtest modeset: SUCCESS (0.830s) [99.553654] Subtest basic: SUCCESS (1.368s) [99.746222] [094/161] (889s left) kms_prop_blob (basic) [99.807448] Starting subtest: basic [99.813623] Subtest basic: SUCCESS (0.000s) [99.898822] [095/161] (889s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [100.053096] Starting subtest: basic-busy-flip-before-cursor-atomic [100.064142] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [100.113229] [096/161] (889s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [100.270689] Starting subtest: basic-busy-flip-before-cursor-legacy [100.282732] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [100.329943] [097/161] (889s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [100.482555] Starting subtest: basic-flip-after-cursor-atomic [101.491370] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.006s) [101.700049] [098/161] (887s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [101.844216] Starting subtest: basic-flip-after-cursor-legacy [102.844042] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.996s) [103.053122] [099/161] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [103.198246] Starting subtest: basic-flip-after-cursor-varying-size [104.214987] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.013s) [104.418196] [100/161] (885s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [104.574203] Starting subtest: basic-flip-before-cursor-atomic [105.561040] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.983s) [105.769209] [101/161] (883s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [105.915729] Starting subtest: basic-flip-before-cursor-legacy [106.897318] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.979s) [107.102590] [102/161] (882s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [107.253321] Starting subtest: basic-flip-before-cursor-varying-size [108.244277] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.986s) [108.445172] [103/161] (881s left) kms_dsc (dsc-basic) [108.592584] Starting subtest: dsc-basic [108.603484] Subtest dsc-basic: SKIP (0.000s) [108.660432] [104/161] (881s left) kms_flip (basic-flip-vs-dpms) [108.816656] Starting subtest: basic-flip-vs-dpms [108.822270] Starting dynamic subtest: A-DP3 [109.794049] Dynamic subtest A-DP3: SUCCESS (0.978s) [109.808037] Starting dynamic subtest: B-DP3 [110.701219] Dynamic subtest B-DP3: SUCCESS (0.906s) [110.713949] Starting dynamic subtest: C-DP3 [111.532516] Dynamic subtest C-DP3: SUCCESS (0.833s) [111.545425] Starting dynamic subtest: D-DP3 [112.362490] Dynamic subtest D-DP3: SUCCESS (0.830s) [112.368495] Subtest basic-flip-vs-dpms: SUCCESS (3.552s) [112.582887] [105/161] (877s left) kms_flip (basic-flip-vs-modeset) [112.743795] Starting subtest: basic-flip-vs-modeset [112.749696] Starting dynamic subtest: A-DP3 [113.725422] Dynamic subtest A-DP3: SUCCESS (0.983s) [113.736603] Starting dynamic subtest: B-DP3 [114.628342] Dynamic subtest B-DP3: SUCCESS (0.900s) [114.639489] Starting dynamic subtest: C-DP3 [115.464923] Dynamic subtest C-DP3: SUCCESS (0.834s) [115.479226] Starting dynamic subtest: D-DP3 [116.287634] Dynamic subtest D-DP3: SUCCESS (0.828s) [116.293923] Subtest basic-flip-vs-modeset: SUCCESS (3.550s) [116.498563] [106/161] (873s left) kms_flip (basic-flip-vs-wf_vblank) [116.662854] Starting subtest: basic-flip-vs-wf_vblank [116.671390] Starting dynamic subtest: A-DP3 [117.760734] Dynamic subtest A-DP3: SUCCESS (1.100s) [117.772133] Starting dynamic subtest: B-DP3 [118.836264] Dynamic subtest B-DP3: SUCCESS (1.077s) [118.847596] Starting dynamic subtest: C-DP3 [119.906444] Dynamic subtest C-DP3: SUCCESS (1.063s) [119.917421] Starting dynamic subtest: D-DP3 [120.962528] Dynamic subtest D-DP3: SUCCESS (1.059s) [120.968671] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.309s) [121.244275] [107/161] (868s left) kms_flip (basic-plain-flip) [121.403817] Starting subtest: basic-plain-flip [121.409312] Starting dynamic subtest: A-DP3 [122.223584] Dynamic subtest A-DP3: SUCCESS (0.823s) [122.237819] Starting dynamic subtest: B-DP3 [123.021365] Dynamic subtest B-DP3: SUCCESS (0.797s) [123.033135] Starting dynamic subtest: C-DP3 [123.808418] Dynamic subtest C-DP3: SUCCESS (0.779s) [123.819974] Starting dynamic subtest: D-DP3 [124.580654] Dynamic subtest D-DP3: SUCCESS (0.778s) [124.586866] Subtest basic-plain-flip: SUCCESS (3.185s) [124.849291] [108/161] (864s left) kms_force_connector_basic (force-connector-state) [124.936066] Starting subtest: force-connector-state [125.226186] Subtest force-connector-state: SUCCESS (0.293s) [125.589259] [109/161] (864s left) kms_force_connector_basic (force-edid) [125.679807] Starting subtest: force-edid [125.719040] Subtest force-edid: SUCCESS (0.037s) [125.970440] [110/161] (863s left) kms_force_connector_basic (force-load-detect) [126.058318] Starting subtest: force-load-detect [126.069805] Subtest force-load-detect: SKIP (0.000s) [126.220785] [111/161] (863s left) kms_force_connector_basic (prune-stale-modes) [126.304638] Starting subtest: prune-stale-modes [126.345275] Subtest prune-stale-modes: SUCCESS (0.038s) [126.587202] [112/161] (863s left) kms_frontbuffer_tracking (basic) [126.762359] Starting subtest: basic [129.952870] Subtest basic: SUCCESS (3.206s) [130.073620] [113/161] (859s left) kms_hdmi_inject (inject-audio) [130.215992] Starting subtest: inject-audio [130.353174] Subtest inject-audio: SUCCESS (0.138s) [130.657380] [114/161] (859s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [130.808048] Starting subtest: compare-crc-sanitycheck-xr24 [130.813434] Starting dynamic subtest: pipe-A-DP-3 [131.268442] Dynamic subtest pipe-A-DP-3: SUCCESS (0.456s) [131.281335] Starting dynamic subtest: pipe-B-DP-3 [131.741763] Dynamic subtest pipe-B-DP-3: SUCCESS (0.471s) [131.755909] Starting dynamic subtest: pipe-C-DP-3 [132.192710] Dynamic subtest pipe-C-DP-3: SUCCESS (0.456s) [132.205761] Starting dynamic subtest: pipe-D-DP-3 [132.650292] Dynamic subtest pipe-D-DP-3: SUCCESS (0.455s) [132.659570] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.843s) [132.853510] [115/161] (857s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [133.017423] Starting subtest: compare-crc-sanitycheck-nv12 [133.023409] Starting dynamic subtest: pipe-A-DP-3 [133.531132] Dynamic subtest pipe-A-DP-3: SUCCESS (0.514s) [133.544417] Starting dynamic subtest: pipe-B-DP-3 [134.031208] Dynamic subtest pipe-B-DP-3: SUCCESS (0.505s) [134.043588] Starting dynamic subtest: pipe-C-DP-3 [134.529465] Dynamic subtest pipe-C-DP-3: SUCCESS (0.492s) [134.543331] Starting dynamic subtest: pipe-D-DP-3 [135.019790] Dynamic subtest pipe-D-DP-3: SUCCESS (0.489s) [135.025924] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.003s) [135.210695] [116/161] (854s left) kms_pipe_crc_basic (hang-read-crc) [135.370723] Starting subtest: hang-read-crc [135.376495] Starting dynamic subtest: pipe-A-DP-3 [136.702532] Dynamic subtest pipe-A-DP-3: SUCCESS (1.326s) [136.716896] Starting dynamic subtest: pipe-B-DP-3 [137.992448] Dynamic subtest pipe-B-DP-3: SUCCESS (1.289s) [138.006063] Starting dynamic subtest: pipe-C-DP-3 [139.259648] Dynamic subtest pipe-C-DP-3: SUCCESS (1.269s) [139.272636] Starting dynamic subtest: pipe-D-DP-3 [140.519556] Dynamic subtest pipe-D-DP-3: SUCCESS (1.256s) [140.525928] Subtest hang-read-crc: SUCCESS (5.145s) [140.709147] [117/161] (849s left) kms_pipe_crc_basic (nonblocking-crc) [140.857431] Starting subtest: nonblocking-crc [140.863308] Starting dynamic subtest: pipe-A-DP-3 [141.681106] Dynamic subtest pipe-A-DP-3: SUCCESS (0.812s) [141.705019] Subtest nonblocking-crc: SUCCESS (0.815s) [143.444685] [118/161] (846s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [143.594784] Starting subtest: nonblocking-crc-frame-sequence [143.600604] Starting dynamic subtest: pipe-A-DP-3 [144.239427] Dynamic subtest pipe-A-DP-3: SUCCESS (0.640s) [144.253301] Starting dynamic subtest: pipe-B-DP-3 [144.914890] Dynamic subtest pipe-B-DP-3: SUCCESS (0.675s) [144.927987] Starting dynamic subtest: pipe-C-DP-3 [145.526155] Dynamic subtest pipe-C-DP-3: SUCCESS (0.609s) [145.540323] Starting dynamic subtest: pipe-D-DP-3 [146.153598] Dynamic subtest pipe-D-DP-3: SUCCESS (0.627s) [146.159930] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.555s) [146.347738] [119/161] (843s left) kms_pipe_crc_basic (read-crc) [146.504335] Starting subtest: read-crc [146.510369] Starting dynamic subtest: pipe-A-DP-3 [147.091029] Dynamic subtest pipe-A-DP-3: SUCCESS (0.582s) [147.104398] Starting dynamic subtest: pipe-B-DP-3 [147.682360] Dynamic subtest pipe-B-DP-3: SUCCESS (0.590s) [147.696015] Starting dynamic subtest: pipe-C-DP-3 [148.221915] Dynamic subtest pipe-C-DP-3: SUCCESS (0.541s) [148.235597] Starting dynamic subtest: pipe-D-DP-3 [148.789326] Dynamic subtest pipe-D-DP-3: SUCCESS (0.564s) [148.795482] Subtest read-crc: SUCCESS (2.281s) [148.985023] [120/161] (841s left) kms_pipe_crc_basic (read-crc-frame-sequence) [149.129790] Starting subtest: read-crc-frame-sequence [149.135430] Starting dynamic subtest: pipe-A-DP-3 [149.711849] Dynamic subtest pipe-A-DP-3: SUCCESS (0.575s) [149.725724] Starting dynamic subtest: pipe-B-DP-3 [150.307790] Dynamic subtest pipe-B-DP-3: SUCCESS (0.594s) [150.321724] Starting dynamic subtest: pipe-C-DP-3 [150.866379] Dynamic subtest pipe-C-DP-3: SUCCESS (0.558s) [150.880308] Starting dynamic subtest: pipe-D-DP-3 [151.426389] Dynamic subtest pipe-D-DP-3: SUCCESS (0.559s) [151.432600] Subtest read-crc-frame-sequence: SUCCESS (2.290s) [151.621322] [121/161] (838s left) kms_pm_backlight (basic-brightness) [151.776081] Subtest basic-brightness: SKIP (0.000s) [151.807593] [122/161] (838s left) kms_pm_rpm (basic-pci-d3-state) [153.347800] Starting subtest: basic-pci-d3-state [154.742253] Subtest basic-pci-d3-state: SUCCESS (1.391s) [155.222531] [123/161] (834s left) kms_pm_rpm (basic-rte) [155.266396] Starting subtest: basic-rte [158.731390] Subtest basic-rte: SUCCESS (3.470s) [160.832327] [124/161] (829s left) kms_psr (psr-primary-page-flip) [160.994875] Subtest psr-primary-page-flip: SKIP (0.000s) [161.026666] [125/161] (829s left) kms_psr (psr-cursor-plane-move) [161.192492] Subtest psr-cursor-plane-move: SKIP (0.000s) [161.223714] [126/161] (829s left) kms_psr (psr-sprite-plane-onoff) [161.385969] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [161.417351] [127/161] (828s left) kms_psr (psr-primary-mmap-gtt) [161.583210] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [161.614556] [128/161] (828s left) kms_setmode (basic-clone-single-crtc) [161.684311] Starting subtest: basic-clone-single-crtc [161.706957] Subtest basic-clone-single-crtc: SKIP (0.000s) [161.761687] [129/161] (828s left) i915_pm_rps (basic-api) [161.820312] Starting subtest: basic-api [161.832557] Subtest basic-api: SKIP (0.000s) [161.971416] [130/161] (828s left) prime_self_import (basic-llseek-bad) [162.014267] Starting subtest: basic-llseek-bad [162.033544] Subtest basic-llseek-bad: SUCCESS (0.019s) [162.129029] [131/161] (828s left) prime_self_import (basic-llseek-size) [162.177864] Starting subtest: basic-llseek-size [162.193456] Subtest basic-llseek-size: SUCCESS (0.011s) [162.282234] [132/161] (828s left) prime_self_import (basic-with_fd_dup) [162.327322] Starting subtest: basic-with_fd_dup [162.339522] Subtest basic-with_fd_dup: SUCCESS (0.012s) [162.411925] [133/161] (828s left) prime_self_import (basic-with_one_bo) [162.460566] Starting subtest: basic-with_one_bo [162.488182] Subtest basic-with_one_bo: SUCCESS (0.030s) [162.566741] [134/161] (827s left) prime_self_import (basic-with_one_bo_two_files) [162.612539] Starting subtest: basic-with_one_bo_two_files [162.634701] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s) [162.719105] [135/161] (827s left) prime_self_import (basic-with_two_bos) [162.765192] Starting subtest: basic-with_two_bos [162.777493] Subtest basic-with_two_bos: SUCCESS (0.009s) [162.848734] [136/161] (827s left) prime_vgem (basic-fence-flip) [162.933353] Starting subtest: basic-fence-flip [163.473151] Subtest basic-fence-flip: SUCCESS (0.544s) [163.606865] [137/161] (826s left) prime_vgem (basic-fence-mmap) [163.682572] Starting subtest: basic-fence-mmap [163.698534] Subtest basic-fence-mmap: SKIP (0.000s) [163.764820] [138/161] (826s left) prime_vgem (basic-fence-read) [163.828628] Starting subtest: basic-fence-read [163.851508] Subtest basic-fence-read: SKIP (0.010s) [163.946379] [139/161] (826s left) prime_vgem (basic-gtt) [164.031034] Starting subtest: basic-gtt [164.043140] Subtest basic-gtt: SKIP (0.000s) [164.135670] [140/161] (826s left) prime_vgem (basic-read) [164.213379] Starting subtest: basic-read [164.232385] Subtest basic-read: SKIP (0.010s) [164.330425] [141/161] (826s left) prime_vgem (basic-write) [164.402503] Starting subtest: basic-write [164.421052] Subtest basic-write: SKIP (0.010s) [164.515281] [142/161] (826s left) vgem_basic (setversion) [164.581958] Starting subtest: setversion [164.599051] Subtest setversion: SUCCESS (0.000s) [164.629157] [143/161] (826s left) vgem_basic (create) [164.685692] Starting subtest: create [164.691999] Subtest create: SUCCESS (0.000s) [164.731054] [144/161] (826s left) vgem_basic (debugfs) [164.787868] Starting subtest: debugfs [164.794175] Subtest debugfs: SUCCESS (0.000s) [164.830751] [145/161] (825s left) vgem_basic (dmabuf-export) [164.886630] Starting subtest: dmabuf-export [164.899281] Subtest dmabuf-export: SUCCESS (0.018s) [164.982868] [146/161] (825s left) vgem_basic (dmabuf-fence) [165.049398] Starting subtest: dmabuf-fence [165.055585] Subtest dmabuf-fence: SUCCESS (0.000s) [165.095441] [147/161] (825s left) vgem_basic (dmabuf-fence-before) [165.150143] Starting subtest: dmabuf-fence-before [165.159033] Subtest dmabuf-fence-before: SUCCESS (0.000s) [165.194733] [148/161] (825s left) vgem_basic (dmabuf-mmap) [165.252514] Starting subtest: dmabuf-mmap [165.258903] Subtest dmabuf-mmap: SUCCESS (0.017s) [165.314637] [149/161] (825s left) vgem_basic (mmap) [165.380288] Starting subtest: mmap [165.389715] Subtest mmap: SUCCESS (0.011s) [165.434693] [150/161] (825s left) vgem_basic (second-client) [165.489445] Starting subtest: second-client [165.515367] Subtest second-client: SUCCESS (0.033s) [165.562925] [151/161] (825s left) vgem_basic (sysfs) [165.620099] Starting subtest: sysfs [165.626386] Subtest sysfs: SUCCESS (0.000s) [165.660890] [152/161] (825s left) core_hotunplug (unbind-rebind) [165.740690] Starting subtest: unbind-rebind [171.199177] Subtest unbind-rebind: SUCCESS (5.459s) [171.229575] [153/161] (819s left) vgem_basic (unload) [171.279414] Starting subtest: unload [200.320499] Subtest unload: SUCCESS (29.041s) [200.411891] [154/161] (790s left) i915_module_load (reload) [200.458181] Starting subtest: reload [204.208276] Subtest reload: SUCCESS (3.755s) [204.240558] [155/161] (786s left) gem_lmem_swapping (basic) [204.295757] Subtest basic: SKIP (0.000s) [204.322721] [156/161] (786s left) gem_lmem_swapping (parallel-random-engines) [204.376239] Subtest parallel-random-engines: SKIP (0.000s) [204.402600] [157/161] (786s left) gem_lmem_swapping (random-engines) [204.456189] Subtest random-engines: SKIP (0.000s) [204.483132] [158/161] (786s left) gem_lmem_swapping (verify-random) [204.534735] Subtest verify-random: SKIP (0.000s) [204.562307] [159/161] (786s left) i915_pm_rpm (module-reload) [216.219195] Starting subtest: module-reload [246.396967] Subtest module-reload: SUCCESS (30.171s) [246.421936] [160/161] (744s left) i915_selftest (live) [246.470950] Starting subtest: live [246.477139] Starting dynamic subtest: sanitycheck [249.738432] Dynamic subtest sanitycheck: SUCCESS (3.265s) [249.750223] Starting dynamic subtest: uncore [253.004244] Dynamic subtest uncore: SUCCESS (3.265s) [253.015673] Starting dynamic subtest: workarounds [259.857921] Warning: kernel log ringbuffer underflow, some records lost. [316.522348] Dynamic subtest workarounds: FAIL (62.667s) [316.533943] Subtest live: FAIL (69.199s) [316.547256] Killing the test because the kernel is tainted. [316.554489] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [316.560640] Closing watchdogs