[42.204523] Initializing watchdogs [42.204556] /dev/watchdog0 [42.220748] [001/161] (960s left) i915_module_load (load) [42.280477] Starting subtest: load [44.094521] Subtest load: SUCCESS (1.829s) [44.156225] [002/161] (958s left) core_auth (basic-auth) [46.013132] Starting subtest: basic-auth [46.022418] Subtest basic-auth: SUCCESS (0.000s) [46.085361] [003/161] (956s left) debugfs_test (read_all_entries) [46.170079] Starting subtest: read_all_entries [46.322927] Subtest read_all_entries: SUCCESS (0.176s) [46.436187] [004/161] (956s left) debugfs_test (basic-hwmon) [46.492158] Starting subtest: basic-hwmon [46.506443] Subtest basic-hwmon: SKIP (0.000s) [46.592772] [005/161] (956s left) debugfs_test (sysfs) [46.652642] Starting subtest: sysfs [46.666157] Subtest sysfs: SUCCESS (0.022s) [46.766113] [006/161] (956s left) fbdev (eof) [46.816039] Starting subtest: eof [46.822877] Subtest eof: SUCCESS (0.000s) [46.863649] [007/161] (956s left) fbdev (info) [46.898891] Starting subtest: info [46.905683] Subtest info: SUCCESS (0.000s) [46.947499] [008/161] (955s left) fbdev (nullptr) [46.995830] Starting subtest: nullptr [47.002622] Subtest nullptr: SUCCESS (0.000s) [47.060107] [009/161] (955s left) fbdev (read) [47.111191] Starting subtest: read [47.969641] Subtest read: SUCCESS (0.858s) [48.021808] [010/161] (954s left) fbdev (write) [48.066246] Starting subtest: write [48.638515] Subtest write: SUCCESS (0.572s) [48.675877] [011/161] (954s left) gem_basic (bad-close) [48.721376] Starting subtest: bad-close [48.736087] Subtest bad-close: SUCCESS (0.000s) [48.783376] [012/161] (954s left) gem_basic (create-close) [48.843083] Starting subtest: create-close [48.858168] Subtest create-close: SUCCESS (0.000s) [48.929134] [013/161] (954s left) gem_basic (create-fd-close) [48.984925] Starting subtest: create-fd-close [48.998796] Subtest create-fd-close: SUCCESS (0.000s) [49.055890] [014/161] (954s left) gem_busy (busy@all-engines) [49.131309] Starting subtest: busy [49.140912] Starting dynamic subtest: all-engines [49.154286] Dynamic subtest all-engines: SUCCESS (0.023s) [49.164066] Subtest busy: SUCCESS (0.023s) [51.080933] [015/161] (952s left) gem_close_race (basic-process) [51.167945] Starting subtest: basic-process [51.203049] Subtest basic-process: SUCCESS (0.058s) [51.381836] [016/161] (951s left) gem_close_race (basic-threads) [51.453899] Starting subtest: basic-threads [52.616108] Subtest basic-threads: SUCCESS (1.198s) [52.796272] [017/161] (950s left) gem_ctx_create (basic) [52.865259] Starting subtest: basic [52.881750] Subtest basic: SUCCESS (0.000s) [53.017452] [018/161] (950s left) gem_ctx_create (basic-files) [53.085576] Starting subtest: basic-files [55.102581] Subtest basic-files: SUCCESS (2.044s) [57.093991] [019/161] (946s left) gem_ctx_exec (basic) [57.165728] Starting subtest: basic [57.181993] Subtest basic: SUCCESS (0.006s) [57.280137] [020/161] (946s left) gem_exec_basic (basic) [57.346935] Starting subtest: basic [57.360230] Starting dynamic subtest: rcs0-smem [57.369898] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [57.397652] Starting dynamic subtest: bcs0-smem [57.406490] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [57.431611] Starting dynamic subtest: vcs0-smem [57.444905] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [57.475332] Starting dynamic subtest: vcs1-smem [57.485322] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [57.516794] Starting dynamic subtest: vecs0-smem [57.523769] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [57.549305] Starting dynamic subtest: ccs0-smem [57.563145] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [57.572648] Subtest basic: SUCCESS (0.011s) [59.080559] [021/161] (944s left) gem_exec_create (basic) [59.170419] Starting subtest: basic [59.177088] Starting dynamic subtest: smem [63.006806] Dynamic subtest smem: SUCCESS (3.862s) [63.019749] Subtest basic: SUCCESS (3.862s) [63.217030] [022/161] (940s left) gem_exec_fence (basic-busy) [63.391786] Starting subtest: basic-busy [63.408291] Starting dynamic subtest: rcs0 [63.453254] Dynamic subtest rcs0: SUCCESS (0.063s) [63.475387] Starting dynamic subtest: bcs0 [63.508558] Dynamic subtest bcs0: SUCCESS (0.061s) [63.523299] Starting dynamic subtest: vcs0 [63.564584] Dynamic subtest vcs0: SUCCESS (0.052s) [63.586289] Starting dynamic subtest: vcs1 [63.619621] Dynamic subtest vcs1: SUCCESS (0.059s) [63.634421] Starting dynamic subtest: vecs0 [63.675552] Dynamic subtest vecs0: SUCCESS (0.051s) [63.697407] Starting dynamic subtest: ccs0 [63.735595] Dynamic subtest ccs0: SUCCESS (0.058s) [63.742353] Subtest basic-busy: SUCCESS (0.344s) [65.148936] [023/161] (938s left) gem_exec_fence (basic-wait) [65.325156] Starting subtest: basic-wait [65.334312] Starting dynamic subtest: rcs0 [65.406808] Dynamic subtest rcs0: SUCCESS (0.093s) [65.425754] Starting dynamic subtest: bcs0 [65.450953] Dynamic subtest bcs0: SUCCESS (0.046s) [65.470452] Starting dynamic subtest: vcs0 [65.512883] Dynamic subtest vcs0: SUCCESS (0.056s) [65.524690] Starting dynamic subtest: vcs1 [65.554075] Dynamic subtest vcs1: SUCCESS (0.045s) [65.563819] Starting dynamic subtest: vecs0 [65.600301] Dynamic subtest vecs0: SUCCESS (0.045s) [65.614894] Starting dynamic subtest: ccs0 [65.642548] Dynamic subtest ccs0: SUCCESS (0.046s) [65.655841] Subtest basic-wait: SUCCESS (0.332s) [67.146198] [024/161] (936s left) gem_exec_fence (basic-await) [67.320233] Starting subtest: basic-await [67.327395] Starting dynamic subtest: rcs0 [67.378316] Dynamic subtest rcs0: SUCCESS (0.073s) [67.407352] Starting dynamic subtest: bcs0 [67.451674] Dynamic subtest bcs0: SUCCESS (0.070s) [67.479261] Starting dynamic subtest: vcs0 [67.524942] Dynamic subtest vcs0: SUCCESS (0.071s) [67.554322] Starting dynamic subtest: vcs1 [67.591298] Dynamic subtest vcs1: SUCCESS (0.068s) [67.624104] Starting dynamic subtest: vecs0 [67.662114] Dynamic subtest vecs0: SUCCESS (0.071s) [67.695093] Starting dynamic subtest: ccs0 [67.720916] Dynamic subtest ccs0: SUCCESS (0.065s) [67.734180] Subtest basic-await: SUCCESS (0.420s) [69.139965] [025/161] (934s left) gem_exec_fence (nb-await) [69.318571] Starting subtest: nb-await [69.335195] Starting dynamic subtest: rcs0 [69.391173] Dynamic subtest rcs0: SUCCESS (0.076s) [69.407636] Starting dynamic subtest: bcs0 [69.465451] Dynamic subtest bcs0: SUCCESS (0.074s) [69.493271] Starting dynamic subtest: vcs0 [69.537820] Dynamic subtest vcs0: SUCCESS (0.072s) [69.565958] Starting dynamic subtest: vcs1 [69.611391] Dynamic subtest vcs1: SUCCESS (0.073s) [69.639702] Starting dynamic subtest: vecs0 [69.677530] Dynamic subtest vecs0: SUCCESS (0.069s) [69.711629] Starting dynamic subtest: ccs0 [69.740112] Dynamic subtest ccs0: SUCCESS (0.069s) [69.756497] Subtest nb-await: SUCCESS (0.434s) [71.159444] [026/161] (932s left) gem_exec_gttfill (basic) [71.234483] Starting subtest: basic [73.455240] Subtest basic: SUCCESS (2.249s) [73.646138] [027/161] (929s left) gem_exec_parallel (engines) [73.754106] Starting subtest: engines [73.762993] Starting dynamic subtest: basic [77.020375] Dynamic subtest basic: SUCCESS (3.286s) [77.039015] Starting dynamic subtest: contexts [81.158567] Dynamic subtest contexts: SUCCESS (4.129s) [81.179141] Starting dynamic subtest: fds [85.073417] Dynamic subtest fds: SUCCESS (3.923s) [85.092207] Starting dynamic subtest: userptr [87.008363] Dynamic subtest userptr: SUCCESS (1.929s) [87.021820] Subtest engines: SUCCESS (13.268s) [87.187127] [028/161] (916s left) gem_exec_store (basic) [87.310388] Starting subtest: basic [87.366980] Subtest basic: SUCCESS (0.114s) [87.537908] [029/161] (916s left) gem_flink_basic (bad-flink) [87.606517] Starting subtest: bad-flink [87.619791] Subtest bad-flink: SUCCESS (0.000s) [87.669752] [030/161] (916s left) gem_flink_basic (bad-open) [87.739332] Starting subtest: bad-open [87.753357] Subtest bad-open: SUCCESS (0.000s) [87.808859] [031/161] (915s left) gem_flink_basic (basic) [87.883388] Starting subtest: basic [87.892987] Subtest basic: SUCCESS (0.000s) [87.946101] [032/161] (915s left) gem_flink_basic (double-flink) [88.015547] Starting subtest: double-flink [88.032280] Subtest double-flink: SUCCESS (0.000s) [88.081321] [033/161] (915s left) gem_flink_basic (flink-lifetime) [88.155457] Starting subtest: flink-lifetime [88.168855] Subtest flink-lifetime: SUCCESS (0.001s) [88.217547] [034/161] (915s left) gem_huc_copy (huc-copy) [88.292172] Starting subtest: huc-copy [88.305377] Subtest huc-copy: SUCCESS (0.004s) [88.420466] [035/161] (915s left) gem_linear_blits (basic) [88.534913] Starting subtest: basic [88.551651] Subtest basic: SUCCESS (0.008s) [88.700060] [036/161] (915s left) gem_mmap (basic) [88.816963] Subtest basic: SKIP (0.000s) [88.857500] [037/161] (915s left) gem_mmap_gtt (basic) [88.930203] Subtest basic: SKIP (0.000s) [88.970578] [038/161] (915s left) gem_render_linear_blits (basic) [89.043883] Starting subtest: basic [89.103628] Subtest basic: SUCCESS (0.021s) [89.148802] [039/161] (915s left) gem_render_tiled_blits (basic) [89.223668] Subtest basic: SKIP (0.000s) [89.266103] [040/161] (914s left) gem_ringfill (basic-all) [95.011390] Starting subtest: basic-all [96.161968] Subtest basic-all: SUCCESS (1.157s) [96.283834] [041/161] (907s left) gem_softpin (allocator-basic) [96.335575] Starting subtest: allocator-basic [96.376550] Subtest allocator-basic: SUCCESS (0.051s) [96.503282] [042/161] (907s left) gem_softpin (allocator-basic-reserve) [96.551091] Starting subtest: allocator-basic-reserve [96.592408] Subtest allocator-basic-reserve: SUCCESS (0.051s) [96.720645] [043/161] (907s left) gem_softpin (safe-alignment) [96.766649] Starting subtest: safe-alignment [96.785155] Subtest safe-alignment: SUCCESS (0.019s) [98.036370] [044/161] (906s left) gem_sync (basic-all) [98.148542] Starting subtest: basic-all [102.043570] Subtest basic-all: SUCCESS (3.949s) [102.238964] [045/161] (902s left) gem_sync (basic-each) [102.355845] Starting subtest: basic-each [104.702232] Subtest basic-each: SUCCESS (2.418s) [104.879160] [046/161] (899s left) gem_tiled_blits (basic) [104.947739] Subtest basic: SKIP (0.000s) [104.989208] [047/161] (899s left) gem_tiled_fence_blits (basic) [105.071271] Subtest basic: SKIP (0.000s) [105.109166] [048/161] (899s left) gem_tiled_pread_basic [105.219301] [049/161] (899s left) gem_wait (busy@all-engines) [105.299605] Starting subtest: busy [105.309423] Starting dynamic subtest: all-engines [107.043276] Dynamic subtest all-engines: SUCCESS (1.749s) [107.051993] Subtest busy: SUCCESS (1.749s) [107.227777] [050/161] (897s left) gem_wait (wait@all-engines) [107.300582] Starting subtest: wait [107.317122] Starting dynamic subtest: all-engines [109.024015] Dynamic subtest all-engines: SUCCESS (1.738s) [109.037246] Subtest wait: SUCCESS (1.738s) [109.206556] [051/161] (895s left) i915_getparams_basic (basic-eu-total) [109.273898] Starting subtest: basic-eu-total [109.297126] Subtest basic-eu-total: SUCCESS (0.000s) [109.342313] [052/161] (895s left) i915_getparams_basic (basic-subslice-total) [109.411155] Starting subtest: basic-subslice-total [109.433092] Subtest basic-subslice-total: SUCCESS (0.000s) [109.474346] [053/161] (895s left) i915_hangman (error-state-basic) [109.543089] Starting subtest: error-state-basic [109.643876] Subtest error-state-basic: SUCCESS (0.115s) [109.719745] [054/161] (895s left) i915_pciid [109.851944] [055/161] (894s left) kms_addfb_basic (addfb25-4-tiled) [109.923546] Starting subtest: addfb25-4-tiled [109.940115] Subtest addfb25-4-tiled: SUCCESS (0.000s) [110.031612] [056/161] (894s left) kms_addfb_basic (addfb25-bad-modifier) [110.104584] Starting subtest: addfb25-bad-modifier [110.117973] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [110.208353] [057/161] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [110.290331] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [110.390116] [058/161] (894s left) kms_addfb_basic (addfb25-modifier-no-flag) [110.460809] Starting subtest: addfb25-modifier-no-flag [110.476985] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [110.601535] [059/161] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy) [110.694198] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [110.785307] [060/161] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [110.873994] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [110.940341] [061/161] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [111.022773] Starting subtest: addfb25-yf-tiled-legacy [111.031624] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [111.094736] [062/161] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy) [111.176850] Starting subtest: addfb25-y-tiled-legacy [111.185602] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [111.269684] [063/161] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [111.352141] Starting subtest: addfb25-y-tiled-small-legacy [111.374215] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [111.424142] [064/161] (893s left) kms_addfb_basic (bad-pitch-0) [111.502572] Starting subtest: bad-pitch-0 [111.515883] Subtest bad-pitch-0: SUCCESS (0.000s) [111.583009] [065/161] (893s left) kms_addfb_basic (bad-pitch-1024) [111.651290] Starting subtest: bad-pitch-1024 [111.664690] Subtest bad-pitch-1024: SUCCESS (0.000s) [111.760764] [066/161] (893s left) kms_addfb_basic (bad-pitch-128) [111.829196] Starting subtest: bad-pitch-128 [111.842599] Subtest bad-pitch-128: SUCCESS (0.000s) [111.946010] [067/161] (893s left) kms_addfb_basic (bad-pitch-256) [112.018509] Starting subtest: bad-pitch-256 [112.031848] Subtest bad-pitch-256: SUCCESS (0.000s) [112.119660] [068/161] (893s left) kms_addfb_basic (bad-pitch-32) [112.188268] Starting subtest: bad-pitch-32 [112.201438] Subtest bad-pitch-32: SUCCESS (0.000s) [112.294366] [069/161] (892s left) kms_addfb_basic (bad-pitch-63) [112.356588] Starting subtest: bad-pitch-63 [112.372988] Subtest bad-pitch-63: SUCCESS (0.000s) [112.480572] [070/161] (892s left) kms_addfb_basic (bad-pitch-65536) [112.551730] Starting subtest: bad-pitch-65536 [112.564876] Subtest bad-pitch-65536: SUCCESS (0.000s) [112.666120] [071/161] (892s left) kms_addfb_basic (bad-pitch-999) [112.738246] Starting subtest: bad-pitch-999 [112.754770] Subtest bad-pitch-999: SUCCESS (0.000s) [112.843595] [072/161] (892s left) kms_addfb_basic (basic) [112.912208] Starting subtest: basic [112.925309] Subtest basic: SUCCESS (0.000s) [113.021514] [073/161] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [113.103602] Starting subtest: basic-x-tiled-legacy [113.120144] Subtest basic-x-tiled-legacy: SKIP (0.000s) [113.192422] [074/161] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [113.278101] Starting subtest: basic-y-tiled-legacy [113.301185] Subtest basic-y-tiled-legacy: SKIP (0.000s) [113.365883] [075/161] (892s left) kms_addfb_basic (bo-too-small) [113.447722] Starting subtest: bo-too-small [113.456489] Subtest bo-too-small: SUCCESS (0.000s) [113.519705] [076/161] (891s left) kms_addfb_basic (bo-too-small-due-to-tiling) [113.610425] Starting subtest: bo-too-small-due-to-tiling [113.632446] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [113.698085] [077/161] (891s left) kms_addfb_basic (clobberred-modifier) [113.746942] Starting subtest: clobberred-modifier [113.761692] Subtest clobberred-modifier: SKIP (0.000s) [113.882496] [078/161] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [113.946247] Starting subtest: framebuffer-vs-set-tiling [113.959716] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [114.057261] [079/161] (891s left) kms_addfb_basic (invalid-get-prop) [114.104965] Starting subtest: invalid-get-prop [114.111717] Subtest invalid-get-prop: SUCCESS (0.000s) [114.208186] [080/161] (891s left) kms_addfb_basic (invalid-get-prop-any) [114.254658] Starting subtest: invalid-get-prop-any [114.261453] Subtest invalid-get-prop-any: SUCCESS (0.000s) [114.357165] [081/161] (891s left) kms_addfb_basic (invalid-set-prop) [114.404601] Starting subtest: invalid-set-prop [114.414542] Subtest invalid-set-prop: SUCCESS (0.000s) [114.529509] [082/161] (891s left) kms_addfb_basic (invalid-set-prop-any) [114.607180] Starting subtest: invalid-set-prop-any [114.615978] Subtest invalid-set-prop-any: SUCCESS (0.000s) [114.722322] [083/161] (890s left) kms_addfb_basic (no-handle) [114.782307] Starting subtest: no-handle [114.791135] Subtest no-handle: SUCCESS (0.000s) [114.895763] [084/161] (890s left) kms_addfb_basic (size-max) [114.964662] Starting subtest: size-max [114.981184] Subtest size-max: SUCCESS (0.000s) [115.067695] [085/161] (890s left) kms_addfb_basic (small-bo) [115.160706] Starting subtest: small-bo [115.177341] Subtest small-bo: SUCCESS (0.000s) [115.269932] [086/161] (890s left) kms_addfb_basic (tile-pitch-mismatch) [115.359801] Starting subtest: tile-pitch-mismatch [115.382964] Subtest tile-pitch-mismatch: SKIP (0.000s) [115.471321] [087/161] (890s left) kms_addfb_basic (too-high) [115.553265] Starting subtest: too-high [115.559829] Subtest too-high: SUCCESS (0.000s) [115.641382] [088/161] (890s left) kms_addfb_basic (too-wide) [115.732249] Starting subtest: too-wide [115.745515] Subtest too-wide: SUCCESS (0.000s) [115.819779] [089/161] (890s left) kms_addfb_basic (unused-handle) [115.894826] Starting subtest: unused-handle [115.908392] Subtest unused-handle: SUCCESS (0.000s) [115.998280] [090/161] (889s left) kms_addfb_basic (unused-modifier) [116.066941] Starting subtest: unused-modifier [116.080136] Subtest unused-modifier: SUCCESS (0.000s) [116.172146] [091/161] (889s left) kms_addfb_basic (unused-offsets) [116.240997] Starting subtest: unused-offsets [116.254192] Subtest unused-offsets: SUCCESS (0.000s) [116.348505] [092/161] (889s left) kms_addfb_basic (unused-pitches) [116.417114] Starting subtest: unused-pitches [116.430421] Subtest unused-pitches: SUCCESS (0.000s) [116.532516] [093/161] (889s left) kms_busy (basic) [116.601735] Starting subtest: basic [116.618323] Starting dynamic subtest: flip [117.293868] Dynamic subtest flip: SUCCESS (0.680s) [117.310528] Starting dynamic subtest: modeset [120.959944] Dynamic subtest modeset: SUCCESS (3.667s) [120.976255] Subtest basic: SUCCESS (4.348s) [121.873400] [094/161] (884s left) kms_prop_blob (basic) [121.942386] Starting subtest: basic [121.955491] Subtest basic: SUCCESS (0.000s) [121.993712] [095/161] (884s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [122.110234] Starting subtest: basic-busy-flip-before-cursor-atomic [122.132056] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [122.225136] [096/161] (883s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [122.336166] Starting subtest: basic-busy-flip-before-cursor-legacy [122.349850] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [122.448444] [097/161] (883s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [122.554143] Starting subtest: basic-flip-after-cursor-atomic [123.768875] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.203s) [124.692911] [098/161] (881s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [124.814692] Starting subtest: basic-flip-after-cursor-legacy [126.018747] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.202s) [126.926222] [099/161] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [127.053519] Starting subtest: basic-flip-after-cursor-varying-size [128.253617] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.202s) [129.165435] [100/161] (877s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [129.264270] Starting subtest: basic-flip-before-cursor-atomic [130.475926] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.204s) [131.403056] [101/161] (874s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [131.501794] Starting subtest: basic-flip-before-cursor-legacy [132.696955] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.187s) [133.581542] [102/161] (872s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [133.694166] Starting subtest: basic-flip-before-cursor-varying-size [134.910777] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.203s) [135.820941] [103/161] (870s left) kms_dsc (dsc-basic) [135.911422] Starting subtest: dsc-basic [135.933151] Subtest dsc-basic: SKIP (0.000s) [135.974413] [104/161] (870s left) kms_flip (basic-flip-vs-dpms) [136.078087] Starting subtest: basic-flip-vs-dpms [136.087045] Starting dynamic subtest: A-eDP1 [138.816295] Dynamic subtest A-eDP1: SUCCESS (2.749s) [138.832883] Starting dynamic subtest: B-eDP1 [141.137025] Dynamic subtest B-eDP1: SUCCESS (2.303s) [141.153966] Starting dynamic subtest: C-eDP1 [143.428494] Dynamic subtest C-eDP1: SUCCESS (2.304s) [143.443311] Starting dynamic subtest: D-eDP1 [145.729360] Dynamic subtest D-eDP1: SUCCESS (2.303s) [145.745900] Subtest basic-flip-vs-dpms: SUCCESS (9.666s) [146.644770] [105/161] (859s left) kms_flip (basic-flip-vs-modeset) [146.748546] Starting subtest: basic-flip-vs-modeset [146.757351] Starting dynamic subtest: A-eDP1 [149.431193] Dynamic subtest A-eDP1: SUCCESS (2.701s) [149.442510] Starting dynamic subtest: B-eDP1 [151.747729] Dynamic subtest B-eDP1: SUCCESS (2.303s) [151.762410] Starting dynamic subtest: C-eDP1 [154.099043] Dynamic subtest C-eDP1: SUCCESS (2.366s) [154.115466] Starting dynamic subtest: D-eDP1 [156.423724] Dynamic subtest D-eDP1: SUCCESS (2.313s) [156.437052] Subtest basic-flip-vs-modeset: SUCCESS (9.694s) [157.337648] [106/161] (849s left) kms_flip (basic-flip-vs-wf_vblank) [157.439071] Starting subtest: basic-flip-vs-wf_vblank [157.448806] Starting dynamic subtest: A-eDP1 [159.453405] Dynamic subtest A-eDP1: SUCCESS (2.026s) [159.474566] Starting dynamic subtest: B-eDP1 [161.498534] Dynamic subtest B-eDP1: SUCCESS (2.046s) [161.526860] Starting dynamic subtest: C-eDP1 [163.533138] Dynamic subtest C-eDP1: SUCCESS (2.032s) [163.560716] Starting dynamic subtest: D-eDP1 [165.583985] Dynamic subtest D-eDP1: SUCCESS (2.048s) [165.597270] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.158s) [166.864211] [107/161] (839s left) kms_flip (basic-plain-flip) [166.957963] Starting subtest: basic-plain-flip [166.966684] Starting dynamic subtest: A-eDP1 [168.706203] Dynamic subtest A-eDP1: SUCCESS (1.752s) [168.725584] Starting dynamic subtest: B-eDP1 [170.497164] Dynamic subtest B-eDP1: SUCCESS (1.792s) [170.513887] Starting dynamic subtest: C-eDP1 [172.269324] Dynamic subtest C-eDP1: SUCCESS (1.773s) [172.280409] Starting dynamic subtest: D-eDP1 [174.003386] Dynamic subtest D-eDP1: SUCCESS (1.729s) [174.010219] Subtest basic-plain-flip: SUCCESS (7.052s) [175.261852] [108/161] (831s left) kms_force_connector_basic (force-connector-state) [175.338756] Starting subtest: force-connector-state [175.877390] Subtest force-connector-state: SUCCESS (0.551s) [176.914109] [109/161] (829s left) kms_force_connector_basic (force-edid) [176.982757] Starting subtest: force-edid [177.232360] Subtest force-edid: SUCCESS (0.252s) [177.363023] [110/161] (829s left) kms_force_connector_basic (force-load-detect) [177.431432] Starting subtest: force-load-detect [177.453523] Subtest force-load-detect: SKIP (0.000s) [177.517062] [111/161] (829s left) kms_force_connector_basic (prune-stale-modes) [177.576545] Starting subtest: prune-stale-modes [177.771958] Subtest prune-stale-modes: SKIP (0.180s) [177.882541] [112/161] (828s left) kms_frontbuffer_tracking (basic) [177.993783] Starting subtest: basic [181.791402] Subtest basic: SUCCESS (3.814s) [181.923245] [113/161] (824s left) kms_hdmi_inject (inject-audio) [182.267480] Starting subtest: inject-audio [182.489465] Subtest inject-audio: SUCCESS (0.227s) [183.183413] [114/161] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [183.260893] Starting subtest: compare-crc-sanitycheck-xr24 [183.269649] Starting dynamic subtest: pipe-A-eDP-1 [183.971802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s) [183.993871] Starting dynamic subtest: pipe-B-eDP-1 [185.359398] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s) [185.397151] Starting dynamic subtest: pipe-C-eDP-1 [186.716233] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s) [186.753182] Starting dynamic subtest: pipe-D-eDP-1 [188.060544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s) [188.074040] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.804s) [188.976128] [115/161] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [189.064314] Starting subtest: compare-crc-sanitycheck-nv12 [189.076608] Starting dynamic subtest: pipe-A-eDP-1 [189.822166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s) [189.833245] Starting dynamic subtest: pipe-B-eDP-1 [191.215386] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s) [191.226664] Starting dynamic subtest: pipe-C-eDP-1 [192.558081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [192.569057] Starting dynamic subtest: pipe-D-eDP-1 [193.905685] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [193.912220] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.834s) [194.845486] [116/161] (812s left) kms_pipe_crc_basic (hang-read-crc) [194.935874] Starting subtest: hang-read-crc [194.948814] Starting dynamic subtest: pipe-A-eDP-1 [197.276477] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.344s) [197.293130] Starting dynamic subtest: pipe-B-eDP-1 [200.367425] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.086s) [200.382151] Starting dynamic subtest: pipe-C-eDP-1 [203.370629] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.003s) [203.387130] Starting dynamic subtest: pipe-D-eDP-1 [206.370295] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.000s) [206.386794] Subtest hang-read-crc: SUCCESS (11.440s) [207.321672] [117/161] (799s left) kms_pipe_crc_basic (nonblocking-crc) [207.411739] Starting subtest: nonblocking-crc [207.424990] Starting dynamic subtest: pipe-A-eDP-1 [208.259719] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.846s) [208.276151] Starting dynamic subtest: pipe-B-eDP-1 [209.832763] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.582s) [209.843875] Starting dynamic subtest: pipe-C-eDP-1 [211.391601] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.547s) [211.408126] Starting dynamic subtest: pipe-D-eDP-1 [212.926446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s) [212.942752] Subtest nonblocking-crc: SUCCESS (5.515s) [213.847022] [118/161] (793s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [213.937742] Starting subtest: nonblocking-crc-frame-sequence [213.950914] Starting dynamic subtest: pipe-A-eDP-1 [214.788544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.849s) [214.804984] Starting dynamic subtest: pipe-B-eDP-1 [216.372801] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.580s) [216.387678] Starting dynamic subtest: pipe-C-eDP-1 [217.910913] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.549s) [217.922806] Starting dynamic subtest: pipe-D-eDP-1 [219.454921] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s) [219.468244] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.516s) [220.375760] [119/161] (786s left) kms_pipe_crc_basic (read-crc) [220.473140] Starting subtest: read-crc [220.486503] Starting dynamic subtest: pipe-A-eDP-1 [221.255754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s) [221.270369] Starting dynamic subtest: pipe-B-eDP-1 [222.782802] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s) [222.797374] Starting dynamic subtest: pipe-C-eDP-1 [224.251834] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.469s) [224.264037] Starting dynamic subtest: pipe-D-eDP-1 [225.724877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s) [225.738325] Subtest read-crc: SUCCESS (5.257s) [226.647055] [120/161] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence) [226.740655] Starting subtest: read-crc-frame-sequence [226.757169] Starting dynamic subtest: pipe-A-eDP-1 [227.523957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s) [227.539061] Starting dynamic subtest: pipe-B-eDP-1 [229.070199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s) [229.091885] Starting dynamic subtest: pipe-C-eDP-1 [230.565616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s) [230.580516] Starting dynamic subtest: pipe-D-eDP-1 [232.101728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s) [232.115058] Subtest read-crc-frame-sequence: SUCCESS (5.366s) [233.050265] [121/161] (773s left) kms_pm_backlight (basic-brightness) [233.137865] Starting subtest: basic-brightness [233.190658] Starting dynamic subtest: eDP-1 [233.522978] Dynamic subtest eDP-1: SUCCESS (0.322s) [233.536444] Subtest basic-brightness: SUCCESS (0.378s) [234.451790] [122/161] (772s left) kms_pm_rpm (basic-pci-d3-state) [236.171842] Starting subtest: basic-pci-d3-state [237.620430] Subtest basic-pci-d3-state: SUCCESS (1.443s) [237.698683] [123/161] (769s left) kms_pm_rpm (basic-rte) [237.757565] Starting subtest: basic-rte [240.637545] Subtest basic-rte: SUCCESS (2.894s) [242.372999] [124/161] (764s left) kms_psr (psr-primary-page-flip) [242.468359] Starting subtest: psr-primary-page-flip [242.481480] Starting dynamic subtest: eDP-1 [244.469375] Dynamic subtest eDP-1: SUCCESS (2.000s) [244.485809] Subtest psr-primary-page-flip: SUCCESS (2.001s) [245.398862] [125/161] (761s left) kms_psr (psr-cursor-plane-move) [245.486935] Starting subtest: psr-cursor-plane-move [245.500370] Starting dynamic subtest: eDP-1 [247.387097] Dynamic subtest eDP-1: SUCCESS (1.906s) [247.393615] Subtest psr-cursor-plane-move: SUCCESS (1.907s) [248.335729] [126/161] (758s left) kms_psr (psr-sprite-plane-onoff) [248.421279] Starting subtest: psr-sprite-plane-onoff [248.430190] Starting dynamic subtest: eDP-1 [250.392239] Dynamic subtest eDP-1: SUCCESS (1.965s) [250.408881] Subtest psr-sprite-plane-onoff: SUCCESS (1.966s) [251.274726] [127/161] (755s left) kms_psr (psr-primary-mmap-gtt) [251.365215] Starting subtest: psr-primary-mmap-gtt [251.378259] Starting dynamic subtest: eDP-1 [252.993288] Dynamic subtest eDP-1: SKIP (1.625s) [253.006837] Subtest psr-primary-mmap-gtt: SKIP (1.626s) [253.118850] [128/161] (754s left) kms_setmode (basic-clone-single-crtc) [253.169075] Starting subtest: basic-clone-single-crtc [253.190140] Subtest basic-clone-single-crtc: SKIP (0.000s) [253.218094] [129/161] (754s left) i915_pm_rps (basic-api) [253.260734] Starting subtest: basic-api [253.275065] Subtest basic-api: SKIP (0.000s) [253.437435] [130/161] (753s left) prime_self_import (basic-llseek-bad) [253.485517] Starting subtest: basic-llseek-bad [253.499067] Subtest basic-llseek-bad: SUCCESS (0.001s) [253.588729] [131/161] (753s left) prime_self_import (basic-llseek-size) [253.636171] Starting subtest: basic-llseek-size [253.656746] Subtest basic-llseek-size: SUCCESS (0.002s) [253.731411] [132/161] (753s left) prime_self_import (basic-with_fd_dup) [253.795115] Starting subtest: basic-with_fd_dup [253.817129] Subtest basic-with_fd_dup: SUCCESS (0.002s) [253.861969] [133/161] (753s left) prime_self_import (basic-with_one_bo) [253.907248] Starting subtest: basic-with_one_bo [253.929375] Subtest basic-with_one_bo: SUCCESS (0.002s) [254.003117] [134/161] (753s left) prime_self_import (basic-with_one_bo_two_files) [254.053140] Starting subtest: basic-with_one_bo_two_files [254.074198] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [254.150325] [135/161] (753s left) prime_self_import (basic-with_two_bos) [254.204241] Starting subtest: basic-with_two_bos [254.225906] Subtest basic-with_two_bos: SUCCESS (0.002s) [254.280564] [136/161] (753s left) prime_vgem (basic-fence-flip) [254.367621] Starting subtest: basic-fence-flip [254.807537] Subtest basic-fence-flip: SUCCESS (0.455s) [254.902054] [137/161] (752s left) prime_vgem (basic-fence-mmap) [254.990756] Starting subtest: basic-fence-mmap [255.012593] Subtest basic-fence-mmap: SKIP (0.000s) [255.079783] [138/161] (752s left) prime_vgem (basic-fence-read) [255.174141] Starting subtest: basic-fence-read [255.196169] Subtest basic-fence-read: SKIP (0.011s) [255.257858] [139/161] (752s left) prime_vgem (basic-gtt) [255.320568] Starting subtest: basic-gtt [255.334166] Subtest basic-gtt: SKIP (0.000s) [255.390089] [140/161] (752s left) prime_vgem (basic-read) [255.456334] Starting subtest: basic-read [255.476451] Subtest basic-read: SKIP (0.010s) [255.557233] [141/161] (752s left) prime_vgem (basic-write) [255.637259] Starting subtest: basic-write [255.651656] Subtest basic-write: SKIP (0.010s) [255.722679] [142/161] (752s left) vgem_basic (setversion) [255.780859] Starting subtest: setversion [255.794334] Subtest setversion: SUCCESS (0.000s) [255.823709] [143/161] (751s left) vgem_basic (create) [255.866118] Starting subtest: create [255.872968] Subtest create: SUCCESS (0.000s) [255.907063] [144/161] (751s left) vgem_basic (debugfs) [255.962606] Starting subtest: debugfs [255.970523] Subtest debugfs: SUCCESS (0.000s) [256.004948] [145/161] (751s left) vgem_basic (dmabuf-export) [256.046443] Starting subtest: dmabuf-export [256.059830] Subtest dmabuf-export: SUCCESS (0.003s) [256.139008] [146/161] (751s left) vgem_basic (dmabuf-fence) [256.194989] Starting subtest: dmabuf-fence [256.201684] Subtest dmabuf-fence: SUCCESS (0.000s) [256.238267] [147/161] (751s left) vgem_basic (dmabuf-fence-before) [256.284180] Starting subtest: dmabuf-fence-before [256.291380] Subtest dmabuf-fence-before: SUCCESS (0.000s) [256.321818] [148/161] (751s left) vgem_basic (dmabuf-mmap) [256.364440] Starting subtest: dmabuf-mmap [256.377929] Subtest dmabuf-mmap: SUCCESS (0.017s) [256.421848] [149/161] (751s left) vgem_basic (mmap) [256.478423] Starting subtest: mmap [256.485111] Subtest mmap: SUCCESS (0.011s) [256.527020] [150/161] (751s left) vgem_basic (second-client) [256.580917] Starting subtest: second-client [256.611978] Subtest second-client: SUCCESS (0.033s) [256.660759] [151/161] (751s left) vgem_basic (sysfs) [256.715860] Starting subtest: sysfs [256.722683] Subtest sysfs: SUCCESS (0.000s) [256.755030] [152/161] (751s left) core_hotunplug (unbind-rebind) [256.868471] Starting subtest: unbind-rebind [261.173173] Subtest unbind-rebind: SUCCESS (4.320s) [261.218533] [153/161] (746s left) vgem_basic (unload) [261.278136] Starting subtest: unload [290.237900] Subtest unload: SUCCESS (28.961s) [290.397767] [154/161] (717s left) i915_module_load (reload) [290.461570] Starting subtest: reload [293.530682] Subtest reload: SUCCESS (3.081s) [293.561643] [155/161] (714s left) gem_lmem_swapping (basic) [293.633984] Subtest basic: SKIP (0.000s) [293.668200] [156/161] (714s left) gem_lmem_swapping (parallel-random-engines) [293.735549] Subtest parallel-random-engines: SKIP (0.000s) [293.773082] [157/161] (714s left) gem_lmem_swapping (random-engines) [293.869155] Subtest random-engines: SKIP (0.000s) [293.910120] [158/161] (714s left) gem_lmem_swapping (verify-random) [293.994533] Subtest verify-random: SKIP (0.000s) [294.035555] [159/161] (714s left) i915_pm_rpm (module-reload) [296.274465] Starting subtest: module-reload [307.754912] Subtest module-reload: SUCCESS (11.474s) [307.797512] [160/161] (700s left) i915_selftest (live) [307.865166] Starting subtest: live [307.874928] Starting dynamic subtest: sanitycheck [310.131743] Dynamic subtest sanitycheck: SUCCESS (2.274s) [310.150922] Starting dynamic subtest: uncore [312.461254] Dynamic subtest uncore: SUCCESS (2.327s) [312.477768] Starting dynamic subtest: workarounds [317.916828] Warning: kernel log ringbuffer underflow, some records lost. [395.571895] Dynamic subtest workarounds: FAIL (82.253s) [395.593895] Subtest live: FAIL (86.856s) [395.615998] Killing the test because the kernel is tainted. [395.621701] Aborting: Kernel badly tainted (0x240, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [395.628838] Closing watchdogs