[44.827498] Initializing watchdogs [44.827608] /dev/watchdog0 [44.833705] [001/162] (960s left) i915_module_load (load) [44.899507] Starting subtest: load [45.852985] Subtest load: SUCCESS (0.953s) [45.878094] [002/162] (959s left) core_auth (basic-auth) [45.980572] Starting subtest: basic-auth [45.981703] Subtest basic-auth: SUCCESS (0.000s) [46.031599] [003/162] (959s left) debugfs_test (read_all_entries) [46.101101] Starting subtest: read_all_entries [46.136986] Subtest read_all_entries: SUCCESS (0.036s) [46.214653] [004/162] (959s left) debugfs_test (basic-hwmon) [46.277335] Starting subtest: basic-hwmon [46.279294] Subtest basic-hwmon: SKIP (0.000s) [46.348238] [005/162] (959s left) fbdev (eof) [46.420185] Starting subtest: eof [46.421335] Subtest eof: SUCCESS (0.000s) [46.464554] [006/162] (958s left) fbdev (info) [46.525784] Starting subtest: info [46.526998] Subtest info: SUCCESS (0.000s) [46.582548] [007/162] (958s left) fbdev (nullptr) [46.652632] Starting subtest: nullptr [46.653899] Subtest nullptr: SUCCESS (0.000s) [46.698396] [008/162] (958s left) fbdev (read) [46.770429] Starting subtest: read [46.851322] Subtest read: SUCCESS (0.081s) [46.900263] [009/162] (958s left) fbdev (write) [46.969190] Starting subtest: write [47.009920] Subtest write: SUCCESS (0.041s) [47.048160] [010/162] (958s left) gem_basic (bad-close) [47.110930] Starting subtest: bad-close [47.112998] Subtest bad-close: SUCCESS (0.000s) [47.164185] [011/162] (958s left) gem_basic (create-close) [47.226394] Starting subtest: create-close [47.228481] Subtest create-close: SUCCESS (0.000s) [47.298241] [012/162] (958s left) gem_basic (create-fd-close) [47.361316] Starting subtest: create-fd-close [47.363477] Subtest create-fd-close: SUCCESS (0.000s) [47.430868] [013/162] (958s left) gem_busy (busy@all-engines) [47.502931] Starting subtest: busy [47.504119] Starting dynamic subtest: all-engines [47.528281] Dynamic subtest all-engines: SUCCESS (0.025s) [47.529249] Subtest busy: SUCCESS (0.026s) [47.830612] [014/162] (957s left) gem_close_race (basic-process) [47.904049] Starting subtest: basic-process [47.938041] Subtest basic-process: SUCCESS (0.033s) [48.098608] [015/162] (957s left) gem_close_race (basic-threads) [48.170285] Starting subtest: basic-threads [49.318733] Subtest basic-threads: SUCCESS (1.148s) [49.482221] [016/162] (956s left) gem_ctx_create (basic) [49.553301] Starting subtest: basic [49.554368] Subtest basic: SUCCESS (0.000s) [49.715957] [017/162] (955s left) gem_ctx_create (basic-files) [49.788781] Starting subtest: basic-files [51.804898] Subtest basic-files: SUCCESS (2.016s) [52.038215] [018/162] (953s left) gem_ctx_exec (basic) [52.113293] Starting subtest: basic [52.117146] Subtest basic: SUCCESS (0.004s) [52.197741] [019/162] (953s left) gem_exec_basic (basic) [52.264443] Starting subtest: basic [52.265463] Starting dynamic subtest: rcs0-smem [52.266648] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [52.272032] Starting dynamic subtest: bcs0-smem [52.273147] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [52.278311] Starting dynamic subtest: vcs0-smem [52.279371] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [52.284458] Starting dynamic subtest: vecs0-smem [52.285455] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [52.286508] Subtest basic: SUCCESS (0.002s) [52.430563] [020/162] (953s left) gem_exec_create (basic) [52.499599] Starting subtest: basic [52.500749] Starting dynamic subtest: smem [54.544608] Dynamic subtest smem: SUCCESS (2.044s) [54.545979] Subtest basic: SUCCESS (2.044s) [54.715688] [021/162] (950s left) gem_exec_fence (basic-busy) [54.897051] Starting subtest: basic-busy [54.898249] Starting dynamic subtest: rcs0 [54.919317] Dynamic subtest rcs0: SUCCESS (0.023s) [54.926105] Starting dynamic subtest: bcs0 [54.943131] Dynamic subtest bcs0: SUCCESS (0.024s) [54.950217] Starting dynamic subtest: vcs0 [54.968238] Dynamic subtest vcs0: SUCCESS (0.025s) [54.974853] Starting dynamic subtest: vecs0 [54.997751] Dynamic subtest vecs0: SUCCESS (0.029s) [54.999200] Subtest basic-busy: SUCCESS (0.101s) [55.446311] [022/162] (950s left) gem_exec_fence (basic-wait) [55.630674] Starting subtest: basic-wait [55.631840] Starting dynamic subtest: rcs0 [55.662260] Dynamic subtest rcs0: SUCCESS (0.031s) [55.668221] Starting dynamic subtest: bcs0 [55.688340] Dynamic subtest bcs0: SUCCESS (0.026s) [55.696225] Starting dynamic subtest: vcs0 [55.713809] Dynamic subtest vcs0: SUCCESS (0.025s) [55.720294] Starting dynamic subtest: vecs0 [55.744615] Dynamic subtest vecs0: SUCCESS (0.031s) [55.745883] Subtest basic-wait: SUCCESS (0.114s) [56.165330] [023/162] (949s left) gem_exec_fence (basic-await) [56.347646] Starting subtest: basic-await [56.348743] Starting dynamic subtest: rcs0 [56.419358] Dynamic subtest rcs0: SUCCESS (0.071s) [56.424921] Starting dynamic subtest: bcs0 [56.489576] Dynamic subtest bcs0: SUCCESS (0.070s) [56.495524] Starting dynamic subtest: vcs0 [56.560142] Dynamic subtest vcs0: SUCCESS (0.070s) [56.565789] Starting dynamic subtest: vecs0 [56.631059] Dynamic subtest vecs0: SUCCESS (0.070s) [56.632194] Subtest basic-await: SUCCESS (0.283s) [57.066383] [024/162] (948s left) gem_exec_fence (nb-await) [57.250163] Starting subtest: nb-await [57.251204] Starting dynamic subtest: rcs0 [57.305195] Dynamic subtest rcs0: SUCCESS (0.054s) [57.311192] Starting dynamic subtest: bcs0 [57.358409] Dynamic subtest bcs0: SUCCESS (0.054s) [57.364112] Starting dynamic subtest: vcs0 [57.411651] Dynamic subtest vcs0: SUCCESS (0.053s) [57.418686] Starting dynamic subtest: vecs0 [57.465868] Dynamic subtest vecs0: SUCCESS (0.054s) [57.466977] Subtest nb-await: SUCCESS (0.216s) [57.897486] [025/162] (947s left) gem_exec_gttfill (basic) [57.969274] Starting subtest: basic [60.999830] Subtest basic: SUCCESS (3.030s) [61.163108] [026/162] (944s left) gem_exec_parallel (engines) [61.295563] Starting subtest: engines [61.296686] Starting dynamic subtest: basic [62.689427] Dynamic subtest basic: SUCCESS (1.394s) [62.696277] Starting dynamic subtest: contexts [64.206159] Dynamic subtest contexts: SUCCESS (1.517s) [64.212813] Starting dynamic subtest: fds [66.064246] Dynamic subtest fds: SUCCESS (1.858s) [66.071596] Starting dynamic subtest: userptr [67.498857] Dynamic subtest userptr: SUCCESS (1.434s) [67.500184] Subtest engines: SUCCESS (6.203s) [67.667148] [027/162] (938s left) gem_exec_store (basic) [67.741700] Starting subtest: basic [67.779048] Subtest basic: SUCCESS (0.037s) [67.953413] [028/162] (937s left) gem_flink_basic (bad-flink) [68.018291] Starting subtest: bad-flink [68.019415] Subtest bad-flink: SUCCESS (0.000s) [68.077419] [029/162] (937s left) gem_flink_basic (bad-open) [68.146962] Starting subtest: bad-open [68.147941] Subtest bad-open: SUCCESS (0.000s) [68.197557] [030/162] (937s left) gem_flink_basic (basic) [68.260019] Starting subtest: basic [68.261215] Subtest basic: SUCCESS (0.000s) [68.327294] [031/162] (937s left) gem_flink_basic (double-flink) [68.389395] Starting subtest: double-flink [68.390508] Subtest double-flink: SUCCESS (0.000s) [68.461186] [032/162] (937s left) gem_flink_basic (flink-lifetime) [68.524196] Starting subtest: flink-lifetime [68.526352] Subtest flink-lifetime: SUCCESS (0.002s) [68.594713] [033/162] (937s left) gem_huc_copy (huc-copy) [68.657860] Subtest huc-copy: SKIP (0.000s) [68.689342] [034/162] (937s left) gem_linear_blits (basic) [68.830295] Starting subtest: basic [68.836532] Subtest basic: SUCCESS (0.007s) [68.934376] [035/162] (936s left) gem_mmap (basic) [69.068710] Starting subtest: basic [69.074018] Subtest basic: SUCCESS (0.000s) [69.146169] [036/162] (936s left) gem_mmap_gtt (basic) [69.209675] Starting subtest: basic [69.210829] Subtest basic: SUCCESS (0.000s) [69.257165] [037/162] (936s left) gem_render_linear_blits (basic) [69.321280] Starting subtest: basic [69.337478] Subtest basic: SUCCESS (0.016s) [69.392477] [038/162] (936s left) gem_render_tiled_blits (basic) [69.458562] Starting subtest: basic [69.477901] Subtest basic: SUCCESS (0.020s) [69.506351] [039/162] (936s left) gem_ringfill (basic-all) [69.682565] Starting subtest: basic-all [70.786917] Subtest basic-all: SUCCESS (1.103s) [70.862165] [040/162] (935s left) gem_softpin (allocator-basic) [70.927364] Subtest allocator-basic: SKIP (0.000s) [70.977236] [041/162] (934s left) gem_softpin (allocator-basic-reserve) [71.042372] Subtest allocator-basic-reserve: SKIP (0.000s) [71.093963] [042/162] (934s left) gem_softpin (safe-alignment) [71.161183] Starting subtest: safe-alignment [71.168295] Subtest safe-alignment: SUCCESS (0.009s) [71.244825] [043/162] (934s left) gem_sync (basic-all) [71.318941] Starting subtest: basic-all [73.396332] Subtest basic-all: SUCCESS (2.077s) [73.560381] [044/162] (932s left) gem_sync (basic-each) [73.628490] Starting subtest: basic-each [75.707518] Subtest basic-each: SUCCESS (2.078s) [75.878659] [045/162] (930s left) gem_tiled_blits (basic) [76.012374] Starting subtest: basic [76.024029] Subtest basic: SUCCESS (0.011s) [76.118082] [046/162] (929s left) gem_tiled_fence_blits (basic) [76.320352] Starting subtest: basic [76.326892] Subtest basic: SUCCESS (0.006s) [76.433962] [047/162] (929s left) gem_tiled_pread_basic [76.728770] [048/162] (929s left) gem_wait (busy@all-engines) [76.802658] Starting subtest: busy [76.803745] Starting dynamic subtest: all-engines [77.317812] Dynamic subtest all-engines: SUCCESS (0.514s) [77.319084] Subtest busy: SUCCESS (0.515s) [77.493440] [049/162] (928s left) gem_wait (wait@all-engines) [77.568139] Starting subtest: wait [77.569375] Starting dynamic subtest: all-engines [78.583438] Dynamic subtest all-engines: SUCCESS (1.014s) [78.584857] Subtest wait: SUCCESS (1.015s) [78.760448] [050/162] (927s left) i915_getparams_basic (basic-eu-total) [78.822852] Starting subtest: basic-eu-total [78.824999] Subtest basic-eu-total: SUCCESS (0.000s) [78.876430] [051/162] (927s left) i915_getparams_basic (basic-subslice-total) [78.938368] Starting subtest: basic-subslice-total [78.940467] Subtest basic-subslice-total: SUCCESS (0.000s) [78.992725] [052/162] (927s left) i915_hangman (error-state-basic) [79.063468] Starting subtest: error-state-basic [79.073270] Subtest error-state-basic: SUCCESS (0.007s) [79.144050] [053/162] (926s left) i915_pciid [79.258763] [054/162] (926s left) kms_addfb_basic (addfb25-bad-modifier) [79.322674] Starting subtest: addfb25-bad-modifier [79.323936] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [79.425868] [055/162] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [79.489950] Starting subtest: addfb25-framebuffer-vs-set-tiling [79.490969] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.575264] [056/162] (926s left) kms_addfb_basic (addfb25-modifier-no-flag) [79.640967] Starting subtest: addfb25-modifier-no-flag [79.642026] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [79.724306] [057/162] (926s left) kms_addfb_basic (addfb25-x-tiled-legacy) [79.787395] Starting subtest: addfb25-x-tiled-legacy [79.788389] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [79.892481] [058/162] (926s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [79.956964] Starting subtest: addfb25-x-tiled-mismatch-legacy [79.958037] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [80.058212] [059/162] (926s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [80.151039] Starting subtest: addfb25-yf-tiled-legacy [80.152112] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [80.224305] [060/162] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy) [80.308967] Starting subtest: addfb25-y-tiled-legacy [80.309932] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [80.391398] [061/162] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [80.476188] Starting subtest: addfb25-y-tiled-small-legacy [80.478160] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [80.540833] [062/162] (925s left) kms_addfb_basic (bad-pitch-0) [80.602229] Starting subtest: bad-pitch-0 [80.603314] Subtest bad-pitch-0: SUCCESS (0.000s) [80.695227] [063/162] (925s left) kms_addfb_basic (bad-pitch-1024) [80.758951] Starting subtest: bad-pitch-1024 [80.759922] Subtest bad-pitch-1024: SUCCESS (0.000s) [80.857634] [064/162] (925s left) kms_addfb_basic (bad-pitch-128) [80.921137] Starting subtest: bad-pitch-128 [80.922189] Subtest bad-pitch-128: SUCCESS (0.000s) [81.011076] [065/162] (925s left) kms_addfb_basic (bad-pitch-256) [81.074248] Starting subtest: bad-pitch-256 [81.075176] Subtest bad-pitch-256: SUCCESS (0.000s) [81.174418] [066/162] (925s left) kms_addfb_basic (bad-pitch-32) [81.235113] Starting subtest: bad-pitch-32 [81.236218] Subtest bad-pitch-32: SUCCESS (0.000s) [81.324470] [067/162] (924s left) kms_addfb_basic (bad-pitch-63) [81.386222] Starting subtest: bad-pitch-63 [81.387380] Subtest bad-pitch-63: SUCCESS (0.000s) [81.478080] [068/162] (924s left) kms_addfb_basic (bad-pitch-65536) [81.574264] Starting subtest: bad-pitch-65536 [81.575345] Subtest bad-pitch-65536: SUCCESS (0.000s) [81.674075] [069/162] (924s left) kms_addfb_basic (bad-pitch-999) [81.736080] Starting subtest: bad-pitch-999 [81.737154] Subtest bad-pitch-999: SUCCESS (0.000s) [81.823634] [070/162] (924s left) kms_addfb_basic (basic) [81.885271] Starting subtest: basic [81.886327] Subtest basic: SUCCESS (0.000s) [81.974206] [071/162] (924s left) kms_addfb_basic (basic-x-tiled-legacy) [82.036461] Starting subtest: basic-x-tiled-legacy [82.037480] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [82.124224] [072/162] (924s left) kms_addfb_basic (basic-y-tiled-legacy) [82.190634] Starting subtest: basic-y-tiled-legacy [82.191694] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [82.290945] [073/162] (924s left) kms_addfb_basic (bo-too-small) [82.378326] Starting subtest: bo-too-small [82.379343] Subtest bo-too-small: SUCCESS (0.000s) [82.457763] [074/162] (923s left) kms_addfb_basic (bo-too-small-due-to-tiling) [82.544219] Starting subtest: bo-too-small-due-to-tiling [82.545280] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [82.606895] [075/162] (923s left) kms_addfb_basic (clobberred-modifier) [82.668640] Starting subtest: clobberred-modifier [82.669758] Subtest clobberred-modifier: SUCCESS (0.000s) [82.775982] [076/162] (923s left) kms_addfb_basic (framebuffer-vs-set-tiling) [82.840064] Starting subtest: framebuffer-vs-set-tiling [82.841196] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [82.923653] [077/162] (923s left) kms_addfb_basic (invalid-get-prop) [82.984317] Starting subtest: invalid-get-prop [82.985449] Subtest invalid-get-prop: SUCCESS (0.000s) [83.073751] [078/162] (923s left) kms_addfb_basic (invalid-get-prop-any) [83.137702] Starting subtest: invalid-get-prop-any [83.138786] Subtest invalid-get-prop-any: SUCCESS (0.000s) [83.223718] [079/162] (923s left) kms_addfb_basic (invalid-set-prop) [83.285955] Starting subtest: invalid-set-prop [83.286908] Subtest invalid-set-prop: SUCCESS (0.000s) [83.373311] [080/162] (923s left) kms_addfb_basic (invalid-set-prop-any) [83.436096] Starting subtest: invalid-set-prop-any [83.437060] Subtest invalid-set-prop-any: SUCCESS (0.000s) [83.523634] [081/162] (922s left) kms_addfb_basic (no-handle) [83.588393] Starting subtest: no-handle [83.589504] Subtest no-handle: SUCCESS (0.000s) [83.674217] [082/162] (922s left) kms_addfb_basic (size-max) [83.760138] Starting subtest: size-max [83.761280] Subtest size-max: SUCCESS (0.000s) [83.823215] [083/162] (922s left) kms_addfb_basic (small-bo) [83.908012] Starting subtest: small-bo [83.909098] Subtest small-bo: SUCCESS (0.000s) [83.973817] [084/162] (922s left) kms_addfb_basic (tile-pitch-mismatch) [84.036421] Starting subtest: tile-pitch-mismatch [84.037491] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [84.123700] [085/162] (922s left) kms_addfb_basic (too-high) [84.208414] Starting subtest: too-high [84.209409] Subtest too-high: SUCCESS (0.001s) [84.273999] [086/162] (922s left) kms_addfb_basic (too-wide) [84.358810] Starting subtest: too-wide [84.359839] Subtest too-wide: SUCCESS (0.000s) [84.423228] [087/162] (922s left) kms_addfb_basic (unused-handle) [84.484977] Starting subtest: unused-handle [84.486052] Subtest unused-handle: SUCCESS (0.000s) [84.572948] [088/162] (922s left) kms_addfb_basic (unused-modifier) [84.633312] Starting subtest: unused-modifier [84.634369] Subtest unused-modifier: SUCCESS (0.000s) [84.727387] [089/162] (921s left) kms_addfb_basic (unused-offsets) [84.789612] Starting subtest: unused-offsets [84.790719] Subtest unused-offsets: SUCCESS (0.000s) [84.890322] [090/162] (921s left) kms_addfb_basic (unused-pitches) [84.952382] Starting subtest: unused-pitches [84.953451] Subtest unused-pitches: SUCCESS (0.000s) [85.056791] [091/162] (921s left) kms_busy (basic) [85.143297] Starting subtest: basic [85.144495] Starting dynamic subtest: flip [85.597602] Dynamic subtest flip: SUCCESS (0.453s) [85.604350] Starting dynamic subtest: modeset [86.126150] Dynamic subtest modeset: SUCCESS (0.528s) [86.127198] Subtest basic: SUCCESS (0.982s) [86.271605] [092/162] (920s left) kms_prop_blob (basic) [86.336073] Starting subtest: basic [86.337215] Subtest basic: SUCCESS (0.000s) [86.386436] [093/162] (920s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [86.470315] Starting subtest: basic-busy-flip-before-cursor-atomic [87.411770] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.940s) [87.541580] [094/162] (919s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [87.625704] Starting subtest: basic-busy-flip-before-cursor-legacy [88.547267] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.921s) [88.678508] [095/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [88.762165] Starting subtest: basic-flip-after-cursor-atomic [89.685809] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.923s) [89.812841] [096/162] (916s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [89.897194] Starting subtest: basic-flip-after-cursor-legacy [90.835606] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.939s) [90.973411] [097/162] (915s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [91.062271] Starting subtest: basic-flip-after-cursor-varying-size [91.995507] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.934s) [92.133492] [098/162] (914s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [92.217185] Starting subtest: basic-flip-before-cursor-atomic [93.141771] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.925s) [93.275404] [099/162] (913s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [93.360928] Starting subtest: basic-flip-before-cursor-legacy [94.299482] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.938s) [94.431592] [100/162] (912s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [94.516737] Starting subtest: basic-flip-before-cursor-varying-size [95.438486] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.921s) [95.571634] [101/162] (911s left) kms_flip (basic-flip-vs-dpms) [95.644996] Starting subtest: basic-flip-vs-dpms [95.646247] Starting dynamic subtest: A-VGA1 [96.607958] Dynamic subtest A-VGA1: SUCCESS (0.961s) [96.614891] Starting dynamic subtest: B-VGA1 [97.502641] Dynamic subtest B-VGA1: SUCCESS (0.894s) [97.509443] Starting dynamic subtest: C-VGA1 [98.403854] Dynamic subtest C-VGA1: SUCCESS (0.901s) [98.406050] Subtest basic-flip-vs-dpms: SUCCESS (2.761s) [98.538457] [102/162] (908s left) kms_flip (basic-flip-vs-modeset) [98.616947] Starting subtest: basic-flip-vs-modeset [98.618095] Starting dynamic subtest: A-VGA1 [99.482788] Dynamic subtest A-VGA1: SUCCESS (0.865s) [99.491347] Starting dynamic subtest: B-VGA1 [100.281671] Dynamic subtest B-VGA1: SUCCESS (0.799s) [100.288464] Starting dynamic subtest: C-VGA1 [101.082073] Dynamic subtest C-VGA1: SUCCESS (0.799s) [101.083057] Subtest basic-flip-vs-modeset: SUCCESS (2.467s) [101.209898] [103/162] (905s left) kms_flip (basic-flip-vs-wf_vblank) [101.287459] Starting subtest: basic-flip-vs-wf_vblank [101.288453] Starting dynamic subtest: A-VGA1 [102.438344] Dynamic subtest A-VGA1: SUCCESS (1.150s) [102.446249] Starting dynamic subtest: B-VGA1 [103.561633] Dynamic subtest B-VGA1: SUCCESS (1.122s) [103.568245] Starting dynamic subtest: C-VGA1 [104.688746] Dynamic subtest C-VGA1: SUCCESS (1.126s) [104.691049] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.404s) [104.860498] [104/162] (901s left) kms_flip (basic-plain-flip) [104.934517] Starting subtest: basic-plain-flip [104.935510] Starting dynamic subtest: A-VGA1 [105.802719] Dynamic subtest A-VGA1: SUCCESS (0.868s) [105.809848] Starting dynamic subtest: B-VGA1 [106.642383] Dynamic subtest B-VGA1: SUCCESS (0.839s) [106.649736] Starting dynamic subtest: C-VGA1 [107.483562] Dynamic subtest C-VGA1: SUCCESS (0.840s) [107.485653] Subtest basic-plain-flip: SUCCESS (2.553s) [107.653463] [105/162] (899s left) kms_force_connector_basic (force-connector-state) [107.729396] Starting subtest: force-connector-state [107.870504] Subtest force-connector-state: SUCCESS (0.142s) [108.056816] [106/162] (898s left) kms_force_connector_basic (force-edid) [108.132297] Starting subtest: force-edid [108.153462] Subtest force-edid: SUCCESS (0.022s) [108.260915] [107/162] (898s left) kms_force_connector_basic (force-load-detect) [108.334449] Starting subtest: force-load-detect [108.481505] Subtest force-load-detect: SUCCESS (0.147s) [108.666154] [108/162] (898s left) kms_force_connector_basic (prune-stale-modes) [108.741522] Starting subtest: prune-stale-modes [108.757105] Subtest prune-stale-modes: SUCCESS (0.017s) [108.869979] [109/162] (898s left) kms_frontbuffer_tracking (basic) [108.963147] Starting subtest: basic [110.801041] Subtest basic: SUCCESS (1.840s) [110.866694] [110/162] (896s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [110.952250] Starting subtest: compare-crc-sanitycheck-xr24 [110.953415] Starting dynamic subtest: pipe-A-VGA-1 [111.223829] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.271s) [111.230663] Starting dynamic subtest: pipe-B-VGA-1 [111.490030] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.265s) [111.497862] Starting dynamic subtest: pipe-C-VGA-1 [111.766463] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.275s) [111.767563] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.815s) [111.901797] [111/162] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [111.987586] Starting subtest: compare-crc-sanitycheck-nv12 [111.988737] Starting dynamic subtest: pipe-A-VGA-1 [111.990854] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s) [111.997680] Starting dynamic subtest: pipe-B-VGA-1 [111.999786] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s) [112.006379] Starting dynamic subtest: pipe-C-VGA-1 [112.008537] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s) [112.010703] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s) [112.050961] [112/162] (894s left) kms_pipe_crc_basic (hang-read-crc) [112.136348] Starting subtest: hang-read-crc [112.137391] Starting dynamic subtest: pipe-A-VGA-1 [112.870130] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.732s) [112.876965] Starting dynamic subtest: pipe-B-VGA-1 [113.601093] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.730s) [113.607904] Starting dynamic subtest: pipe-C-VGA-1 [114.362314] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.760s) [114.363407] Subtest hang-read-crc: SUCCESS (2.226s) [114.481532] [113/162] (892s left) kms_pipe_crc_basic (nonblocking-crc) [114.567208] Starting subtest: nonblocking-crc [114.568250] Starting dynamic subtest: pipe-A-VGA-1 [115.006963] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.439s) [115.013898] Starting dynamic subtest: pipe-B-VGA-1 [115.435381] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.428s) [115.442492] Starting dynamic subtest: pipe-C-VGA-1 [115.873119] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.437s) [115.874284] Subtest nonblocking-crc: SUCCESS (1.307s) [115.992040] [114/162] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [116.076296] Starting subtest: nonblocking-crc-frame-sequence [116.077308] Starting dynamic subtest: pipe-A-VGA-1 [116.515940] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.439s) [116.524774] Starting dynamic subtest: pipe-B-VGA-1 [116.945274] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.429s) [116.952166] Starting dynamic subtest: pipe-C-VGA-1 [117.385470] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.439s) [117.386613] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.309s) [117.505381] [115/162] (889s left) kms_pipe_crc_basic (read-crc) [117.591348] Starting subtest: read-crc [117.592421] Starting dynamic subtest: pipe-A-VGA-1 [117.965312] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.373s) [117.971867] Starting dynamic subtest: pipe-B-VGA-1 [118.329163] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.362s) [118.336077] Starting dynamic subtest: pipe-C-VGA-1 [118.701897] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.372s) [118.702957] Subtest read-crc: SUCCESS (1.111s) [118.819696] [116/162] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence) [118.904695] Starting subtest: read-crc-frame-sequence [118.905906] Starting dynamic subtest: pipe-A-VGA-1 [119.277673] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.372s) [119.284403] Starting dynamic subtest: pipe-B-VGA-1 [119.637972] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.359s) [119.644805] Starting dynamic subtest: pipe-C-VGA-1 [120.010376] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.371s) [120.011486] Subtest read-crc-frame-sequence: SUCCESS (1.105s) [120.129155] [117/162] (886s left) kms_psr (primary_page_flip) [120.193707] Subtest primary_page_flip: SKIP (0.000s) [120.224923] [118/162] (886s left) kms_psr (cursor_plane_move) [120.289323] Subtest cursor_plane_move: SKIP (0.000s) [120.307294] [119/162] (886s left) kms_psr (sprite_plane_onoff) [120.370042] Subtest sprite_plane_onoff: SKIP (0.000s) [120.391408] [120/162] (886s left) kms_psr (primary_mmap_gtt) [120.455222] Subtest primary_mmap_gtt: SKIP (0.000s) [120.475792] [121/162] (886s left) kms_setmode (basic-clone-single-crtc) [120.538039] Starting subtest: basic-clone-single-crtc [120.541362] Subtest basic-clone-single-crtc: SKIP (0.000s) [120.597018] [122/162] (886s left) i915_pm_backlight (basic-brightness) [120.682805] Subtest basic-brightness: SKIP (0.000s) [120.706669] [123/162] (886s left) i915_pm_rpm (basic-pci-d3-state) [122.073650] Starting subtest: basic-pci-d3-state [122.279953] Subtest basic-pci-d3-state: SUCCESS (0.204s) [122.524685] [124/162] (884s left) i915_pm_rpm (basic-rte) [122.587382] Starting subtest: basic-rte [124.111876] Subtest basic-rte: SUCCESS (1.521s) [124.554423] [125/162] (882s left) i915_pm_rps (basic-api) [124.620430] Starting subtest: basic-api [124.622846] Subtest basic-api: SUCCESS (0.002s) [124.687466] [126/162] (882s left) prime_self_import (basic-llseek-bad) [124.749756] Starting subtest: basic-llseek-bad [124.751978] Subtest basic-llseek-bad: SUCCESS (0.001s) [124.823090] [127/162] (882s left) prime_self_import (basic-llseek-size) [124.883591] Starting subtest: basic-llseek-size [124.886920] Subtest basic-llseek-size: SUCCESS (0.003s) [124.956899] [128/162] (882s left) prime_self_import (basic-with_fd_dup) [125.018111] Starting subtest: basic-with_fd_dup [125.020285] Subtest basic-with_fd_dup: SUCCESS (0.002s) [125.087723] [129/162] (882s left) prime_self_import (basic-with_one_bo) [125.148898] Starting subtest: basic-with_one_bo [125.152244] Subtest basic-with_one_bo: SUCCESS (0.002s) [125.198583] [130/162] (882s left) prime_self_import (basic-with_one_bo_two_files) [125.258869] Starting subtest: basic-with_one_bo_two_files [125.261033] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [125.320477] [131/162] (881s left) prime_self_import (basic-with_two_bos) [125.380170] Starting subtest: basic-with_two_bos [125.382275] Subtest basic-with_two_bos: SUCCESS (0.002s) [125.456937] [132/162] (881s left) prime_vgem (basic-fence-flip) [125.527148] Starting subtest: basic-fence-flip [125.855868] Subtest basic-fence-flip: SUCCESS (0.328s) [125.925602] [133/162] (881s left) prime_vgem (basic-fence-mmap) [125.993218] Starting subtest: basic-fence-mmap [126.016038] Subtest basic-fence-mmap: SUCCESS (0.023s) [126.086917] [134/162] (881s left) prime_vgem (basic-fence-read) [126.159375] Starting subtest: basic-fence-read [126.193026] Subtest basic-fence-read: SUCCESS (0.033s) [126.270699] [135/162] (881s left) prime_vgem (basic-gtt) [126.344112] Starting subtest: basic-gtt [126.355788] Subtest basic-gtt: SUCCESS (0.012s) [126.437315] [136/162] (880s left) prime_vgem (basic-read) [126.513288] Starting subtest: basic-read [126.528451] Subtest basic-read: SUCCESS (0.016s) [126.605064] [137/162] (880s left) prime_vgem (basic-write) [126.676105] Starting subtest: basic-write [126.693423] Subtest basic-write: SUCCESS (0.017s) [126.773851] [138/162] (880s left) vgem_basic (setversion) [126.839597] Starting subtest: setversion [126.841854] Subtest setversion: SUCCESS (0.000s) [126.888213] [139/162] (880s left) vgem_basic (create) [126.956607] Starting subtest: create [126.957830] Subtest create: SUCCESS (0.000s) [127.003173] [140/162] (880s left) vgem_basic (debugfs) [127.073160] Starting subtest: debugfs [127.074231] Subtest debugfs: SUCCESS (0.000s) [127.122088] [141/162] (880s left) vgem_basic (dmabuf-export) [127.189865] Starting subtest: dmabuf-export [127.191992] Subtest dmabuf-export: SUCCESS (0.001s) [127.272163] [142/162] (880s left) vgem_basic (dmabuf-fence) [127.340053] Starting subtest: dmabuf-fence [127.341115] Subtest dmabuf-fence: SUCCESS (0.001s) [127.386943] [143/162] (880s left) vgem_basic (dmabuf-fence-before) [127.456457] Starting subtest: dmabuf-fence-before [127.457545] Subtest dmabuf-fence-before: SUCCESS (0.000s) [127.503348] [144/162] (879s left) vgem_basic (dmabuf-mmap) [127.573233] Starting subtest: dmabuf-mmap [127.587435] Subtest dmabuf-mmap: SUCCESS (0.015s) [127.637575] [145/162] (879s left) vgem_basic (mmap) [127.706565] Starting subtest: mmap [127.716919] Subtest mmap: SUCCESS (0.011s) [127.754393] [146/162] (879s left) vgem_basic (second-client) [127.823326] Starting subtest: second-client [127.856753] Subtest second-client: SUCCESS (0.033s) [127.903541] [147/162] (879s left) vgem_basic (sysfs) [127.973117] Starting subtest: sysfs [127.974182] Subtest sysfs: SUCCESS (0.000s) [128.020899] [148/162] (879s left) core_hotunplug (unbind-rebind) [128.122719] Starting subtest: unbind-rebind [130.940461] Subtest unbind-rebind: SUCCESS (2.818s) [130.959194] [149/162] (876s left) vgem_basic (unload) [131.029239] Starting subtest: unload [159.943807] Subtest unload: SUCCESS (28.913s) [160.015800] [150/162] (847s left) i915_module_load (reload) [160.076701] Starting subtest: reload [162.039915] Subtest reload: SUCCESS (1.962s) [162.065730] [151/162] (845s left) gem_lmem_swapping (basic) [162.157614] Subtest basic: SKIP (0.000s) [162.180935] [152/162] (845s left) gem_lmem_swapping (parallel-random-engines) [162.246981] Subtest parallel-random-engines: SKIP (0.000s) [162.263417] [153/162] (845s left) gem_lmem_swapping (random-engines) [162.329279] Subtest random-engines: SKIP (0.000s) [162.348078] [154/162] (845s left) gem_lmem_swapping (verify-random) [162.414282] Subtest verify-random: SKIP (0.000s) [162.430365] [155/162] (845s left) i915_pm_rpm (module-reload) [164.045862] Starting subtest: module-reload [170.873828] Subtest module-reload: SUCCESS (6.827s) [170.888751] [156/162] (836s left) i915_selftest (live) [170.959943] Starting subtest: live [170.960996] Starting dynamic subtest: sanitycheck [171.594686] Dynamic subtest sanitycheck: SUCCESS (0.633s) [171.601131] Starting dynamic subtest: uncore [172.269698] Dynamic subtest uncore: SUCCESS (0.673s) [172.275945] Starting dynamic subtest: workarounds [173.042707] Dynamic subtest workarounds: SUCCESS (0.771s) [173.048426] Starting dynamic subtest: gt_engines [173.671314] Dynamic subtest gt_engines: SUCCESS (0.627s) [173.678648] Starting dynamic subtest: gt_timelines [179.353986] Dynamic subtest gt_timelines: SUCCESS (5.681s) [179.359431] Starting dynamic subtest: gt_contexts [179.935182] Dynamic subtest gt_contexts: SUCCESS (0.580s) [179.940840] Starting dynamic subtest: gt_lrc [180.538411] Dynamic subtest gt_lrc: SUCCESS (0.601s) [180.546372] Starting dynamic subtest: gt_mocs [181.091564] Dynamic subtest gt_mocs: SUCCESS (0.551s) [181.098068] Starting dynamic subtest: gt_pm [191.453682] Dynamic subtest gt_pm: SUCCESS (10.360s) [191.459329] Starting dynamic subtest: gt_heartbeat [192.240939] Dynamic subtest gt_heartbeat: SUCCESS (0.786s) [192.246822] Starting dynamic subtest: gt_tlb [192.836688] Dynamic subtest gt_tlb: SUCCESS (0.594s) [192.842442] Starting dynamic subtest: requests [199.137046] Dynamic subtest requests: SUCCESS (6.298s) [199.143954] Starting dynamic subtest: migrate [199.671924] Dynamic subtest migrate: SUCCESS (0.533s) [199.677504] Starting dynamic subtest: active [200.219832] Dynamic subtest active: SUCCESS (0.547s) [200.225071] Starting dynamic subtest: objects [201.292110] Dynamic subtest objects: SUCCESS (1.070s) [201.298660] Starting dynamic subtest: mman [205.280450] Dynamic subtest mman: SUCCESS (3.986s) [205.285921] Starting dynamic subtest: dmabuf [206.035225] Dynamic subtest dmabuf: SUCCESS (0.752s) [206.041461] Starting dynamic subtest: vma [206.580252] Dynamic subtest vma: SUCCESS (0.543s) [206.587128] Starting dynamic subtest: coherency [208.285930] Dynamic subtest coherency: SUCCESS (1.703s) [208.292106] Starting dynamic subtest: gtt [212.287935] Dynamic subtest gtt: SUCCESS (4.000s) [212.293247] Starting dynamic subtest: gem [213.129993] Dynamic subtest gem: SUCCESS (0.841s) [213.135653] Starting dynamic subtest: evict [213.674317] Dynamic subtest evict: SUCCESS (0.543s) [213.680966] Starting dynamic subtest: hugepages [214.865244] Dynamic subtest hugepages: SUCCESS (1.190s) [214.871690] Starting dynamic subtest: gem_contexts [219.659499] Dynamic subtest gem_contexts: SUCCESS (4.793s) [219.664967] Starting dynamic subtest: client [220.311437] Dynamic subtest client: SUCCESS (0.650s) [220.318462] Starting dynamic subtest: gem_migrate [221.027219] Dynamic subtest gem_migrate: SUCCESS (0.713s) [221.035479] Starting dynamic subtest: reset [222.724232] Dynamic subtest reset: SUCCESS (1.695s) [222.729684] Starting dynamic subtest: memory_region [223.313606] Dynamic subtest memory_region: SUCCESS (0.588s) [223.319693] Starting dynamic subtest: hangcheck [240.754149] Dynamic subtest hangcheck: SUCCESS (17.439s) [240.760973] Starting dynamic subtest: execlists [241.354111] Dynamic subtest execlists: SUCCESS (0.597s) [241.359639] Starting dynamic subtest: ring_submission [242.080569] Dynamic subtest ring_submission: SUCCESS (0.724s) [242.086568] Starting dynamic subtest: perf [242.796329] Dynamic subtest perf: SUCCESS (0.714s) [242.802233] Starting dynamic subtest: slpc [243.343703] Dynamic subtest slpc: SUCCESS (0.545s) [243.349389] Starting dynamic subtest: guc [244.018474] Dynamic subtest guc: SUCCESS (0.674s) [244.024456] Starting dynamic subtest: guc_multi_lrc [244.803449] Dynamic subtest guc_multi_lrc: SUCCESS (0.784s) [244.809169] Starting dynamic subtest: guc_hang [245.389922] Dynamic subtest guc_hang: SUCCESS (0.586s) [245.395779] Starting dynamic subtest: late_gt_pm [246.071662] Dynamic subtest late_gt_pm: SUCCESS (0.680s) [246.072769] Subtest live: SUCCESS (75.112s) [246.244458] [157/162] (761s left) dmabuf (all-tests) [246.313100] Starting subtest: all-tests [246.316588] Starting dynamic subtest: sanitycheck [246.376422] Dynamic subtest sanitycheck: SUCCESS (0.063s) [246.382210] Starting dynamic subtest: dma_fence [246.559744] Dynamic subtest dma_fence: SUCCESS (0.182s) [246.566879] Starting dynamic subtest: dma_fence_chain [258.015462] Dynamic subtest dma_fence_chain: SUCCESS (11.454s) [258.021148] Starting dynamic subtest: dma_fence_unwrap [258.072104] Dynamic subtest dma_fence_unwrap: SUCCESS (0.056s) [258.078924] Starting dynamic subtest: dma_resv [258.132210] Dynamic subtest dma_resv: SUCCESS (0.059s) [258.133668] Subtest all-tests: SUCCESS (11.819s) [258.148353] [158/162] (749s left) i915_suspend (basic-s2idle-without-i915) [258.210712] Starting subtest: basic-s2idle-without-i915 [275.550850] Subtest basic-s2idle-without-i915: SUCCESS (1.945s) [282.668012] [159/162] (747s left) i915_suspend (basic-s3-without-i915) [282.732912] Starting subtest: basic-s3-without-i915 [300.535908] Subtest basic-s3-without-i915: SUCCESS (1.723s) [314.666800] [160/162] (745s left) gem_exec_suspend (basic-s0) [314.745508] Starting subtest: basic-S0 [314.746634] Starting dynamic subtest: smem [331.481523] Dynamic subtest smem: SUCCESS (1.091s) [331.482721] Subtest basic-S0: SUCCESS (1.092s) [337.697439] [161/162] (744s left) gem_exec_suspend (basic-s3) [337.775561] Starting subtest: basic-S3 [337.776729] Starting dynamic subtest: smem [355.494030] Dynamic subtest smem: SUCCESS (1.126s) [355.495170] Subtest basic-S3: SUCCESS (1.127s) [361.629661] [162/162] (742s left) kms_pipe_crc_basic (suspend-read-crc) [361.724484] Starting subtest: suspend-read-crc [361.725528] Starting dynamic subtest: pipe-A-VGA-1 [379.657822] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.279s) [379.667147] Starting dynamic subtest: pipe-B-VGA-1 [397.664196] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.284s) [397.674463] Starting dynamic subtest: pipe-C-VGA-1 [415.671477] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.302s) [415.672574] Subtest suspend-read-crc: SUCCESS (3.869s) [419.763045] Closing watchdogs Done.