[43.814264] Initializing watchdogs [43.814350] /dev/watchdog0 [43.819971] [001/165] (960s left) i915_module_load (load) [43.875125] Starting subtest: load [45.925461] Subtest load: SUCCESS (2.050s) [45.944070] [002/165] (958s left) core_auth (basic-auth) [46.000615] Starting subtest: basic-auth [46.002149] Subtest basic-auth: SUCCESS (0.001s) [46.100652] [003/165] (958s left) debugfs_test (read_all_entries) [46.167371] Starting subtest: read_all_entries [46.449500] Subtest read_all_entries: SUCCESS (0.287s) [46.539140] [004/165] (957s left) debugfs_test (basic-hwmon) [46.612792] Starting subtest: basic-hwmon [46.614691] Subtest basic-hwmon: SKIP (0.000s) [46.716996] [005/165] (957s left) fbdev (eof) [46.789077] Starting subtest: eof [46.790468] Subtest eof: SUCCESS (0.001s) [46.849237] [006/165] (957s left) fbdev (info) [46.912195] Starting subtest: info [46.913238] Subtest info: SUCCESS (0.000s) [46.982978] [007/165] (957s left) fbdev (nullptr) [47.055802] Starting subtest: nullptr [47.057430] Subtest nullptr: SUCCESS (0.000s) [47.115453] [008/165] (957s left) fbdev (read) [47.188226] Starting subtest: read [54.549927] Subtest read: SUCCESS (7.327s) [54.588485] [009/165] (949s left) fbdev (write) [54.647458] Starting subtest: write [58.330802] Subtest write: SUCCESS (3.673s) [58.390823] [010/165] (946s left) gem_basic (bad-close) [58.443365] Starting subtest: bad-close [58.444921] Subtest bad-close: SUCCESS (0.000s) [58.510362] [011/165] (945s left) gem_basic (create-close) [58.557641] Starting subtest: create-close [58.559260] Subtest create-close: SUCCESS (0.000s) [58.646760] [012/165] (945s left) gem_basic (create-fd-close) [58.693467] Starting subtest: create-fd-close [58.695117] Subtest create-fd-close: SUCCESS (0.000s) [58.776916] [013/165] (945s left) gem_busy (busy@all-engines) [58.832509] Starting subtest: busy [58.833447] Starting dynamic subtest: all-engines [58.875695] Dynamic subtest all-engines: SUCCESS (0.045s) [58.876489] Subtest busy: SUCCESS (0.045s) [59.229346] [014/165] (945s left) gem_close_race (basic-process) [59.285237] Starting subtest: basic-process [59.322489] Subtest basic-process: SUCCESS (0.037s) [59.513436] [015/165] (945s left) gem_close_race (basic-threads) [59.569445] Starting subtest: basic-threads [60.701460] Subtest basic-threads: SUCCESS (1.131s) [60.902181] [016/165] (943s left) gem_ctx_create (basic) [60.985642] Starting subtest: basic [60.986686] Subtest basic: SUCCESS (0.000s) [61.183889] [017/165] (943s left) gem_ctx_create (basic-files) [61.258820] Starting subtest: basic-files [63.304171] Subtest basic-files: SUCCESS (2.045s) [63.501842] [018/165] (941s left) gem_ctx_exec (basic) [63.574243] Starting subtest: basic [63.578398] Subtest basic: SUCCESS (0.004s) [63.686315] [019/165] (940s left) gem_exec_basic (basic) [63.760431] Starting subtest: basic [63.761432] Starting dynamic subtest: rcs0-smem [63.762373] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [63.770975] Starting dynamic subtest: bcs0-smem [63.771926] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [63.780469] Starting dynamic subtest: vcs0-smem [63.781443] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [63.789736] Starting dynamic subtest: vecs0-smem [63.790788] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [63.791803] Subtest basic: SUCCESS (0.005s) [63.963993] [020/165] (940s left) gem_exec_create (basic) [64.036370] Starting subtest: basic [64.037357] Starting dynamic subtest: smem [66.138482] Dynamic subtest smem: SUCCESS (2.102s) [66.139636] Subtest basic: SUCCESS (2.102s) [66.333900] [021/165] (938s left) gem_exec_fence (basic-busy) [66.523633] Starting subtest: basic-busy [66.524784] Starting dynamic subtest: rcs0 [66.585070] Dynamic subtest rcs0: SUCCESS (0.069s) [66.596859] Starting dynamic subtest: bcs0 [66.632208] Dynamic subtest bcs0: SUCCESS (0.046s) [66.644232] Starting dynamic subtest: vcs0 [66.679970] Dynamic subtest vcs0: SUCCESS (0.047s) [66.690684] Starting dynamic subtest: vecs0 [66.726854] Dynamic subtest vecs0: SUCCESS (0.046s) [66.728489] Subtest basic-busy: SUCCESS (0.212s) [67.267866] [022/165] (937s left) gem_exec_fence (basic-wait) [67.445253] Starting subtest: basic-wait [67.446376] Starting dynamic subtest: rcs0 [67.487989] Dynamic subtest rcs0: SUCCESS (0.050s) [67.499199] Starting dynamic subtest: bcs0 [67.538851] Dynamic subtest bcs0: SUCCESS (0.050s) [67.550135] Starting dynamic subtest: vcs0 [67.586435] Dynamic subtest vcs0: SUCCESS (0.047s) [67.596778] Starting dynamic subtest: vecs0 [67.643738] Dynamic subtest vecs0: SUCCESS (0.057s) [67.645155] Subtest basic-wait: SUCCESS (0.207s) [68.141557] [023/165] (936s left) gem_exec_fence (basic-await) [68.317715] Starting subtest: basic-await [68.318544] Starting dynamic subtest: rcs0 [68.389723] Dynamic subtest rcs0: SUCCESS (0.080s) [68.403724] Starting dynamic subtest: bcs0 [68.480419] Dynamic subtest bcs0: SUCCESS (0.089s) [68.494163] Starting dynamic subtest: vcs0 [68.566881] Dynamic subtest vcs0: SUCCESS (0.085s) [68.582414] Starting dynamic subtest: vecs0 [68.654257] Dynamic subtest vecs0: SUCCESS (0.088s) [68.656105] Subtest basic-await: SUCCESS (0.344s) [69.136130] [024/165] (935s left) gem_exec_fence (nb-await) [69.316579] Starting subtest: nb-await [69.317588] Starting dynamic subtest: rcs0 [69.374764] Dynamic subtest rcs0: SUCCESS (0.066s) [69.388104] Starting dynamic subtest: bcs0 [69.436779] Dynamic subtest bcs0: SUCCESS (0.061s) [69.442657] Starting dynamic subtest: vcs0 [69.495827] Dynamic subtest vcs0: SUCCESS (0.058s) [69.515095] Starting dynamic subtest: vecs0 [69.562529] Dynamic subtest vecs0: SUCCESS (0.067s) [69.563383] Subtest nb-await: SUCCESS (0.254s) [70.065594] [025/165] (934s left) gem_exec_gttfill (basic) [70.119038] Starting subtest: basic [73.824394] Subtest basic: SUCCESS (3.696s) [74.010841] [026/165] (930s left) gem_exec_parallel (engines) [74.137096] Starting subtest: engines [74.138188] Starting dynamic subtest: basic [76.914197] Dynamic subtest basic: SUCCESS (2.775s) [76.926191] Starting dynamic subtest: contexts [80.479604] Dynamic subtest contexts: SUCCESS (3.558s) [80.489451] Starting dynamic subtest: fds [85.975178] Dynamic subtest fds: SUCCESS (5.497s) [85.985759] Starting dynamic subtest: userptr [88.024359] Dynamic subtest userptr: SUCCESS (2.055s) [88.025998] Subtest engines: SUCCESS (13.887s) [88.231329] [027/165] (916s left) gem_exec_store (basic) [88.299770] Starting subtest: basic [88.399067] Subtest basic: SUCCESS (0.099s) [88.592711] [028/165] (916s left) gem_flink_basic (bad-flink) [88.643635] Starting subtest: bad-flink [88.644620] Subtest bad-flink: SUCCESS (0.000s) [88.708383] [029/165] (916s left) gem_flink_basic (bad-open) [88.757628] Starting subtest: bad-open [88.758696] Subtest bad-open: SUCCESS (0.000s) [88.826553] [030/165] (916s left) gem_flink_basic (basic) [88.878734] Starting subtest: basic [88.879644] Subtest basic: SUCCESS (0.000s) [88.959399] [031/165] (915s left) gem_flink_basic (double-flink) [89.012642] Starting subtest: double-flink [89.013529] Subtest double-flink: SUCCESS (0.000s) [89.110513] [032/165] (915s left) gem_flink_basic (flink-lifetime) [89.163973] Starting subtest: flink-lifetime [89.164870] Subtest flink-lifetime: SUCCESS (0.001s) [89.262724] [033/165] (915s left) gem_huc_copy (huc-copy) [89.316377] Starting subtest: huc-copy [89.319538] Subtest huc-copy: SUCCESS (0.003s) [89.433556] [034/165] (915s left) gem_linear_blits (basic) [89.574706] Starting subtest: basic [89.581299] Subtest basic: SUCCESS (0.007s) [89.711800] [035/165] (915s left) gem_mmap (basic) [89.806443] Starting subtest: basic [89.810277] Subtest basic: SUCCESS (0.000s) [89.912734] [036/165] (915s left) gem_mmap_gtt (basic) [89.964652] Starting subtest: basic [89.965496] Subtest basic: SUCCESS (0.001s) [90.048120] [037/165] (914s left) gem_render_linear_blits (basic) [90.102828] Starting subtest: basic [90.139498] Subtest basic: SUCCESS (0.037s) [90.227662] [038/165] (914s left) gem_render_tiled_blits (basic) [90.283067] Starting subtest: basic [90.320648] Subtest basic: SUCCESS (0.037s) [90.388188] [039/165] (914s left) gem_ringfill (basic-all) [90.688750] Starting subtest: basic-all [91.832501] Subtest basic-all: SUCCESS (1.135s) [91.945912] [040/165] (913s left) gem_softpin (allocator-basic) [92.010201] Starting subtest: allocator-basic [92.128801] Subtest allocator-basic: SUCCESS (0.110s) [92.249520] [041/165] (912s left) gem_softpin (allocator-basic-reserve) [92.310306] Starting subtest: allocator-basic-reserve [92.418944] Subtest allocator-basic-reserve: SUCCESS (0.108s) [92.543688] [042/165] (912s left) gem_softpin (safe-alignment) [92.607605] Starting subtest: safe-alignment [92.619788] Subtest safe-alignment: SUCCESS (0.012s) [92.730628] [043/165] (912s left) gem_sync (basic-all) [92.799602] Starting subtest: basic-all [95.144810] Subtest basic-all: SUCCESS (2.344s) [95.339277] [044/165] (909s left) gem_sync (basic-each) [95.393109] Starting subtest: basic-each [98.316060] Subtest basic-each: SUCCESS (2.922s) [98.510922] [045/165] (906s left) gem_tiled_blits (basic) [98.638724] Starting subtest: basic [98.657928] Subtest basic: SUCCESS (0.019s) [98.796823] [046/165] (906s left) gem_tiled_fence_blits (basic) [98.992048] Starting subtest: basic [99.012657] Subtest basic: SUCCESS (0.021s) [99.147257] [047/165] (906s left) gem_tiled_pread_basic [99.274823] [048/165] (905s left) gem_wait (busy@all-engines) [99.341300] Starting subtest: busy [99.342143] Starting dynamic subtest: all-engines [99.903101] Dynamic subtest all-engines: SUCCESS (0.561s) [99.904643] Subtest busy: SUCCESS (0.561s) [100.118914] [049/165] (905s left) gem_wait (wait@all-engines) [100.181619] Starting subtest: wait [100.182479] Starting dynamic subtest: all-engines [101.234376] Dynamic subtest all-engines: SUCCESS (1.052s) [101.236093] Subtest wait: SUCCESS (1.052s) [101.447866] [050/165] (903s left) i915_getparams_basic (basic-eu-total) [101.493206] Starting subtest: basic-eu-total [101.494835] Subtest basic-eu-total: SUCCESS (0.000s) [101.562551] [051/165] (903s left) i915_getparams_basic (basic-subslice-total) [101.611138] Starting subtest: basic-subslice-total [101.612588] Subtest basic-subslice-total: SUCCESS (0.000s) [101.681308] [052/165] (903s left) i915_hangman (error-state-basic) [101.728203] Starting subtest: error-state-basic [101.840632] Subtest error-state-basic: SUCCESS (0.113s) [101.929821] [053/165] (903s left) i915_pciid [102.045530] [054/165] (903s left) kms_addfb_basic (addfb25-4-tiled) [102.112639] Starting subtest: addfb25-4-tiled [102.113696] Subtest addfb25-4-tiled: SUCCESS (0.000s) [102.197164] [055/165] (903s left) kms_addfb_basic (addfb25-bad-modifier) [102.242410] Starting subtest: addfb25-bad-modifier [102.243219] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [102.347667] [056/165] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [102.396416] Starting subtest: addfb25-framebuffer-vs-set-tiling [102.397347] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.515559] [057/165] (902s left) kms_addfb_basic (addfb25-modifier-no-flag) [102.563633] Starting subtest: addfb25-modifier-no-flag [102.564552] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [102.666787] [058/165] (902s left) kms_addfb_basic (addfb25-x-tiled-legacy) [102.716457] Starting subtest: addfb25-x-tiled-legacy [102.717355] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [102.817613] [059/165] (902s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [102.864971] Starting subtest: addfb25-x-tiled-mismatch-legacy [102.865811] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [102.967499] [060/165] (902s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [103.032783] Starting subtest: addfb25-yf-tiled-legacy [103.033820] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [103.118360] [061/165] (902s left) kms_addfb_basic (addfb25-y-tiled-legacy) [103.184461] Starting subtest: addfb25-y-tiled-legacy [103.185281] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [103.267520] [062/165] (902s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [103.334500] Starting subtest: addfb25-y-tiled-small-legacy [103.335363] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [103.437119] [063/165] (902s left) kms_addfb_basic (bad-pitch-0) [103.487474] Starting subtest: bad-pitch-0 [103.488454] Subtest bad-pitch-0: SUCCESS (0.000s) [103.611899] [064/165] (901s left) kms_addfb_basic (bad-pitch-1024) [103.664991] Starting subtest: bad-pitch-1024 [103.665888] Subtest bad-pitch-1024: SUCCESS (0.000s) [103.762721] [065/165] (901s left) kms_addfb_basic (bad-pitch-128) [103.815899] Starting subtest: bad-pitch-128 [103.816773] Subtest bad-pitch-128: SUCCESS (0.000s) [103.913202] [066/165] (901s left) kms_addfb_basic (bad-pitch-256) [103.968911] Starting subtest: bad-pitch-256 [103.969713] Subtest bad-pitch-256: SUCCESS (0.000s) [104.082454] [067/165] (901s left) kms_addfb_basic (bad-pitch-32) [104.133368] Starting subtest: bad-pitch-32 [104.134238] Subtest bad-pitch-32: SUCCESS (0.000s) [104.253673] [068/165] (901s left) kms_addfb_basic (bad-pitch-63) [104.305699] Starting subtest: bad-pitch-63 [104.306544] Subtest bad-pitch-63: SUCCESS (0.000s) [104.426697] [069/165] (901s left) kms_addfb_basic (bad-pitch-65536) [104.477408] Starting subtest: bad-pitch-65536 [104.478495] Subtest bad-pitch-65536: SUCCESS (0.000s) [104.575563] [070/165] (900s left) kms_addfb_basic (bad-pitch-999) [104.627779] Starting subtest: bad-pitch-999 [104.628659] Subtest bad-pitch-999: SUCCESS (0.000s) [104.726209] [071/165] (900s left) kms_addfb_basic (basic) [104.777938] Starting subtest: basic [104.779141] Subtest basic: SUCCESS (0.000s) [104.900269] [072/165] (900s left) kms_addfb_basic (basic-x-tiled-legacy) [104.954264] Starting subtest: basic-x-tiled-legacy [104.955074] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [105.050189] [073/165] (900s left) kms_addfb_basic (basic-y-tiled-legacy) [105.108198] Starting subtest: basic-y-tiled-legacy [105.109071] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [105.231782] [074/165] (900s left) kms_addfb_basic (bo-too-small) [105.300212] Starting subtest: bo-too-small [105.301119] Subtest bo-too-small: SUCCESS (0.000s) [105.405926] [075/165] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling) [105.477205] Starting subtest: bo-too-small-due-to-tiling [105.478353] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [105.578162] [076/165] (900s left) kms_addfb_basic (clobberred-modifier) [105.632563] Starting subtest: clobberred-modifier [105.633687] Subtest clobberred-modifier: SUCCESS (0.000s) [105.756609] [077/165] (899s left) kms_addfb_basic (framebuffer-vs-set-tiling) [105.808968] Starting subtest: framebuffer-vs-set-tiling [105.809868] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [105.929629] [078/165] (899s left) kms_addfb_basic (invalid-get-prop) [105.983606] Starting subtest: invalid-get-prop [105.984454] Subtest invalid-get-prop: SUCCESS (0.000s) [106.104261] [079/165] (899s left) kms_addfb_basic (invalid-get-prop-any) [106.157802] Starting subtest: invalid-get-prop-any [106.158771] Subtest invalid-get-prop-any: SUCCESS (0.000s) [106.254836] [080/165] (899s left) kms_addfb_basic (invalid-set-prop) [106.309386] Starting subtest: invalid-set-prop [106.310463] Subtest invalid-set-prop: SUCCESS (0.000s) [106.404572] [081/165] (899s left) kms_addfb_basic (invalid-set-prop-any) [106.458999] Starting subtest: invalid-set-prop-any [106.465826] Subtest invalid-set-prop-any: SUCCESS (0.000s) [106.579253] [082/165] (899s left) kms_addfb_basic (no-handle) [106.633125] Starting subtest: no-handle [106.633983] Subtest no-handle: SUCCESS (0.000s) [106.759122] [083/165] (899s left) kms_addfb_basic (size-max) [106.829466] Starting subtest: size-max [106.830369] Subtest size-max: SUCCESS (0.000s) [106.928356] [084/165] (898s left) kms_addfb_basic (small-bo) [106.999509] Starting subtest: small-bo [107.000467] Subtest small-bo: SUCCESS (0.000s) [107.099754] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch) [107.153753] Starting subtest: tile-pitch-mismatch [107.154701] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [107.275164] [086/165] (898s left) kms_addfb_basic (too-high) [107.344117] Starting subtest: too-high [107.344998] Subtest too-high: SUCCESS (0.001s) [107.425883] [087/165] (898s left) kms_addfb_basic (too-wide) [107.496849] Starting subtest: too-wide [107.497881] Subtest too-wide: SUCCESS (0.000s) [107.598577] [088/165] (898s left) kms_addfb_basic (unused-handle) [107.650869] Starting subtest: unused-handle [107.651810] Subtest unused-handle: SUCCESS (0.000s) [107.784347] [089/165] (898s left) kms_addfb_basic (unused-modifier) [107.837528] Starting subtest: unused-modifier [107.838375] Subtest unused-modifier: SUCCESS (0.000s) [107.959229] [090/165] (897s left) kms_addfb_basic (unused-offsets) [108.010311] Starting subtest: unused-offsets [108.011308] Subtest unused-offsets: SUCCESS (0.000s) [108.108862] [091/165] (897s left) kms_addfb_basic (unused-pitches) [108.163884] Starting subtest: unused-pitches [108.164749] Subtest unused-pitches: SUCCESS (0.000s) [108.285225] [092/165] (897s left) kms_busy (basic) [108.358694] Starting subtest: basic [108.359574] Starting dynamic subtest: flip [109.237453] Dynamic subtest flip: SUCCESS (0.877s) [109.252708] Starting dynamic subtest: modeset [113.060500] Dynamic subtest modeset: SUCCESS (3.824s) [113.061650] Subtest basic: SUCCESS (4.702s) [113.963697] [093/165] (892s left) kms_prop_blob (basic) [114.008432] Starting subtest: basic [114.009323] Subtest basic: SUCCESS (0.000s) [114.079967] [094/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [114.171928] Starting subtest: basic-busy-flip-before-cursor-atomic [114.173550] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [114.281905] [095/165] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [114.375455] Starting subtest: basic-busy-flip-before-cursor-legacy [114.377528] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [114.519923] [096/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.610847] Starting subtest: basic-flip-after-cursor-atomic [115.810985] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.200s) [116.730145] [097/165] (889s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.825448] Starting subtest: basic-flip-after-cursor-legacy [118.042744] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.217s) [118.951406] [098/165] (887s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [119.060013] Starting subtest: basic-flip-after-cursor-varying-size [120.281236] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.220s) [121.193795] [099/165] (884s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [121.288662] Starting subtest: basic-flip-before-cursor-atomic [122.499497] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.211s) [123.430065] [100/165] (882s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [123.544275] Starting subtest: basic-flip-before-cursor-legacy [124.753717] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.211s) [125.672893] [101/165] (880s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [125.768739] Starting subtest: basic-flip-before-cursor-varying-size [126.987489] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.217s) [127.912991] [102/165] (878s left) kms_dsc (dsc-basic) [127.976784] Subtest dsc-basic: SKIP (0.000s) [128.008590] [103/165] (878s left) kms_flip (basic-flip-vs-dpms) [128.057891] Starting subtest: basic-flip-vs-dpms [128.058791] Starting dynamic subtest: A-eDP1 [130.902052] Dynamic subtest A-eDP1: SUCCESS (2.840s) [130.919199] Starting dynamic subtest: B-eDP1 [133.321604] Dynamic subtest B-eDP1: SUCCESS (2.422s) [133.339651] Starting dynamic subtest: C-eDP1 [135.715279] Dynamic subtest C-eDP1: SUCCESS (2.394s) [135.716156] Subtest basic-flip-vs-dpms: SUCCESS (7.659s) [136.642137] [104/165] (869s left) kms_flip (basic-flip-vs-modeset) [136.697324] Starting subtest: basic-flip-vs-modeset [136.698374] Starting dynamic subtest: A-eDP1 [139.496091] Dynamic subtest A-eDP1: SUCCESS (2.802s) [139.513028] Starting dynamic subtest: B-eDP1 [141.861129] Dynamic subtest B-eDP1: SUCCESS (2.364s) [141.869152] Starting dynamic subtest: C-eDP1 [144.227954] Dynamic subtest C-eDP1: SUCCESS (2.368s) [144.230093] Subtest basic-flip-vs-modeset: SUCCESS (7.538s) [145.129739] [105/165] (861s left) kms_flip (basic-flip-vs-wf_vblank) [145.185509] Starting subtest: basic-flip-vs-wf_vblank [145.188710] Starting dynamic subtest: A-eDP1 [147.478461] Dynamic subtest A-eDP1: SUCCESS (2.289s) [147.497046] Starting dynamic subtest: B-eDP1 [149.718338] Dynamic subtest B-eDP1: SUCCESS (2.238s) [149.738463] Starting dynamic subtest: C-eDP1 [151.938239] Dynamic subtest C-eDP1: SUCCESS (2.218s) [151.941514] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.756s) [153.192768] [106/165] (853s left) kms_flip (basic-plain-flip) [153.245542] Starting subtest: basic-plain-flip [153.246345] Starting dynamic subtest: A-eDP1 [155.193524] Dynamic subtest A-eDP1: SUCCESS (1.946s) [155.212043] Starting dynamic subtest: B-eDP1 [157.178692] Dynamic subtest B-eDP1: SUCCESS (1.983s) [157.196758] Starting dynamic subtest: C-eDP1 [159.142038] Dynamic subtest C-eDP1: SUCCESS (1.962s) [159.145422] Subtest basic-plain-flip: SUCCESS (5.901s) [160.426054] [107/165] (845s left) kms_force_connector_basic (force-connector-state) [160.477724] Starting subtest: force-connector-state [160.922697] Subtest force-connector-state: SUCCESS (0.435s) [162.137739] [108/165] (844s left) kms_force_connector_basic (force-edid) [162.178585] Starting subtest: force-edid [162.202825] Subtest force-edid: SUCCESS (0.024s) [162.323186] [109/165] (843s left) kms_force_connector_basic (force-load-detect) [162.364754] Starting subtest: force-load-detect [162.366306] Subtest force-load-detect: SKIP (0.000s) [162.456560] [110/165] (843s left) kms_force_connector_basic (prune-stale-modes) [162.500805] Starting subtest: prune-stale-modes [162.523117] Subtest prune-stale-modes: SUCCESS (0.022s) [162.622694] [111/165] (843s left) kms_frontbuffer_tracking (basic) [162.679581] Starting subtest: basic [167.421873] Subtest basic: SUCCESS (4.742s) [167.517059] [112/165] (838s left) kms_hdmi_inject (inject-audio) [167.863677] Starting subtest: inject-audio [167.993976] Subtest inject-audio: SUCCESS (0.128s) [168.778933] [113/165] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [168.836556] Starting subtest: compare-crc-sanitycheck-xr24 [168.837410] Starting dynamic subtest: pipe-A-eDP-1 [169.603947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.767s) [169.620842] Starting dynamic subtest: pipe-B-eDP-1 [171.111162] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.505s) [171.119316] Starting dynamic subtest: pipe-C-eDP-1 [172.600987] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s) [172.602196] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.764s) [173.545387] [114/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [173.603925] Starting subtest: compare-crc-sanitycheck-nv12 [173.605962] Starting dynamic subtest: pipe-A-eDP-1 [174.472493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s) [174.488996] Starting dynamic subtest: pipe-B-eDP-1 [175.928711] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s) [175.944286] Starting dynamic subtest: pipe-C-eDP-1 [177.361377] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.429s) [177.362725] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.756s) [178.259715] [115/165] (828s left) kms_pipe_crc_basic (hang-read-crc) [178.322779] Starting subtest: hang-read-crc [178.323663] Starting dynamic subtest: pipe-A-eDP-1 [180.673749] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.350s) [180.693723] Starting dynamic subtest: pipe-B-eDP-1 [183.780451] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.105s) [183.793902] Starting dynamic subtest: pipe-C-eDP-1 [186.785091] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.003s) [186.785876] Subtest hang-read-crc: SUCCESS (8.463s) [187.689457] [116/165] (818s left) kms_pipe_crc_basic (nonblocking-crc) [187.750795] Starting subtest: nonblocking-crc [187.751902] Starting dynamic subtest: pipe-A-eDP-1 [188.643304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.891s) [188.656414] Starting dynamic subtest: pipe-B-eDP-1 [190.349090] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.704s) [190.362319] Starting dynamic subtest: pipe-C-eDP-1 [191.948038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.597s) [191.949292] Subtest nonblocking-crc: SUCCESS (4.199s) [192.874326] [117/165] (813s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [192.935056] Starting subtest: nonblocking-crc-frame-sequence [192.935920] Starting dynamic subtest: pipe-A-eDP-1 [193.848840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.913s) [193.862091] Starting dynamic subtest: pipe-B-eDP-1 [195.534010] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.683s) [195.545941] Starting dynamic subtest: pipe-C-eDP-1 [197.127758] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.592s) [197.128587] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.194s) [198.059084] [118/165] (808s left) kms_pipe_crc_basic (read-crc) [198.117465] Starting subtest: read-crc [198.119848] Starting dynamic subtest: pipe-A-eDP-1 [198.913386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [198.927272] Starting dynamic subtest: pipe-B-eDP-1 [200.484759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.569s) [200.497743] Starting dynamic subtest: pipe-C-eDP-1 [201.995252] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s) [202.003026] Subtest read-crc: SUCCESS (3.873s) [202.920187] [119/165] (803s left) kms_pipe_crc_basic (read-crc-frame-sequence) [202.995923] Starting subtest: read-crc-frame-sequence [202.996929] Starting dynamic subtest: pipe-A-eDP-1 [203.776147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [203.789467] Starting dynamic subtest: pipe-B-eDP-1 [205.355640] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.578s) [205.365083] Starting dynamic subtest: pipe-C-eDP-1 [206.923843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s) [206.925205] Subtest read-crc-frame-sequence: SUCCESS (3.932s) [207.847531] [120/165] (798s left) kms_pm_backlight (basic-brightness) [207.907815] Starting subtest: basic-brightness [207.975421] Starting dynamic subtest: eDP-1 [208.303701] Dynamic subtest eDP-1: SUCCESS (0.331s) [208.305333] Subtest basic-brightness: SUCCESS (0.398s) [209.253255] [121/165] (797s left) kms_pm_rpm (basic-pci-d3-state) [210.766911] Starting subtest: basic-pci-d3-state [215.373841] Subtest basic-pci-d3-state: SUCCESS (4.607s) [215.546694] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1774 [max: 8192] direct dependencies: 17530 [max: 32768] indirect dependencies: 134384 all direct dependencies: 362680 dependency chains: 25578 [max: 131072] dependency chain hlocks used: 107293 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 289 in-softirq chains: 581 in-process chains: 24708 stack-trace entries: 165496 [max: 1048576] number of stack traces: 8401 number of stack hash chains: 6547 combined max dependencies: 4170385020 hardirq-safe locks: 103 hardirq-unsafe locks: 1062 softirq-safe locks: 207 softirq-unsafe locks: 976 irq-safe locks: 222 irq-unsafe locks: 1062 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 309 softirq-read-safe locks: 7 softirq-read-unsafe locks: 304 irq-read-safe locks: 7 irq-read-unsafe locks: 309 uncategorized locks: 290 unused locks: 1 max locking depth: 15 max bfs queue depth: 395 max lock class index: 1773 chain lookup misses: 25755 chain lookup hits: 132402691 cyclic checks: 25929 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4492 find-mask backwards checks: 2653 hardirq on events: 85207445 hardirq off events: 85207441 redundant hardirq ons: 44 redundant hardirq offs: 16 softirq on events: 328166 softirq off events: 328166 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 111 large chain blocks: 1 [215.548088] Closing watchdogs Done.