[37.905606] Initializing watchdogs [37.905706] /dev/watchdog0 [37.911899] [001/170] (960s left) i915_module_load (load) [37.991767] Starting subtest: load [40.118905] Subtest load: SUCCESS (2.127s) [40.140821] [002/170] (958s left) core_auth (basic-auth) [40.277405] Starting subtest: basic-auth [40.281304] Subtest basic-auth: SUCCESS (0.001s) [40.363106] [003/170] (958s left) debugfs_test (read_all_entries) [40.627571] Starting subtest: read_all_entries [40.979728] Subtest read_all_entries: SUCCESS (0.352s) [41.089893] [004/170] (957s left) debugfs_test (basic-hwmon) [41.211749] Starting subtest: basic-hwmon [41.213859] Subtest basic-hwmon: SKIP (0.000s) [41.320445] [005/170] (957s left) fbdev (eof) [41.450093] Starting subtest: eof [41.451527] Subtest eof: SUCCESS (0.000s) [41.508627] [006/170] (956s left) fbdev (info) [41.605288] Starting subtest: info [41.606261] Subtest info: SUCCESS (0.000s) [41.685282] [007/170] (956s left) fbdev (nullptr) [41.796968] Starting subtest: nullptr [41.798448] Subtest nullptr: SUCCESS (0.000s) [41.858069] [008/170] (956s left) fbdev (read) [41.965667] Starting subtest: read [49.362081] Subtest read: SUCCESS (7.362s) [49.396240] [009/170] (949s left) fbdev (write) [49.476162] Starting subtest: write [53.188627] Subtest write: SUCCESS (3.678s) [53.224764] [010/170] (945s left) gem_basic (bad-close) [53.291873] Starting subtest: bad-close [53.293422] Subtest bad-close: SUCCESS (0.000s) [53.355650] [011/170] (945s left) gem_basic (create-close) [53.421424] Starting subtest: create-close [53.422915] Subtest create-close: SUCCESS (0.000s) [53.506162] [012/170] (945s left) gem_basic (create-fd-close) [53.572655] Starting subtest: create-fd-close [53.574252] Subtest create-fd-close: SUCCESS (0.000s) [53.681137] [013/170] (944s left) gem_busy (busy@all-engines) [53.758360] Starting subtest: busy [53.759468] Starting dynamic subtest: all-engines [53.795995] Dynamic subtest all-engines: SUCCESS (0.038s) [53.796813] Subtest busy: SUCCESS (0.038s) [54.156847] [014/170] (944s left) gem_close_race (basic-process) [54.227608] Starting subtest: basic-process [54.271277] Subtest basic-process: SUCCESS (0.043s) [54.458414] [015/170] (944s left) gem_close_race (basic-threads) [54.534758] Starting subtest: basic-threads [55.673450] Subtest basic-threads: SUCCESS (1.138s) [55.872333] [016/170] (942s left) gem_ctx_create (basic) [55.978870] Starting subtest: basic [55.979972] Subtest basic: SUCCESS (0.000s) [56.173182] [017/170] (942s left) gem_ctx_create (basic-files) [56.265527] Starting subtest: basic-files [58.314216] Subtest basic-files: SUCCESS (2.048s) [58.510752] [018/170] (940s left) gem_ctx_exec (basic) [58.609429] Starting subtest: basic [58.614197] Subtest basic: SUCCESS (0.005s) [58.748562] [019/170] (939s left) gem_exec_basic (basic) [58.841482] Starting subtest: basic [58.842467] Starting dynamic subtest: rcs0-smem [58.843454] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [58.851099] Starting dynamic subtest: bcs0-smem [58.851983] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [58.858698] Starting dynamic subtest: vcs0-smem [58.859617] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [58.866399] Starting dynamic subtest: vecs0-smem [58.867416] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [58.868425] Subtest basic: SUCCESS (0.004s) [59.043936] [020/170] (939s left) gem_exec_create (basic) [59.132878] Starting subtest: basic [59.133933] Starting dynamic subtest: smem [61.237313] Dynamic subtest smem: SUCCESS (2.104s) [61.238803] Subtest basic: SUCCESS (2.104s) [61.426431] [021/170] (937s left) gem_exec_fence (basic-busy) [61.633169] Starting subtest: basic-busy [61.634349] Starting dynamic subtest: rcs0 [61.678428] Dynamic subtest rcs0: SUCCESS (0.053s) [61.689083] Starting dynamic subtest: bcs0 [61.727258] Dynamic subtest bcs0: SUCCESS (0.048s) [61.737356] Starting dynamic subtest: vcs0 [61.775350] Dynamic subtest vcs0: SUCCESS (0.047s) [61.786105] Starting dynamic subtest: vecs0 [61.824834] Dynamic subtest vecs0: SUCCESS (0.049s) [61.826536] Subtest basic-busy: SUCCESS (0.200s) [62.357993] [022/170] (936s left) gem_exec_fence (basic-wait) [62.548741] Starting subtest: basic-wait [62.550114] Starting dynamic subtest: rcs0 [62.608833] Dynamic subtest rcs0: SUCCESS (0.068s) [62.619427] Starting dynamic subtest: bcs0 [62.660970] Dynamic subtest bcs0: SUCCESS (0.052s) [62.672424] Starting dynamic subtest: vcs0 [62.712036] Dynamic subtest vcs0: SUCCESS (0.051s) [62.723519] Starting dynamic subtest: vecs0 [62.758867] Dynamic subtest vecs0: SUCCESS (0.047s) [62.760772] Subtest basic-wait: SUCCESS (0.218s) [63.247929] [023/170] (935s left) gem_exec_fence (basic-await) [63.444158] Starting subtest: basic-await [63.444953] Starting dynamic subtest: rcs0 [63.516446] Dynamic subtest rcs0: SUCCESS (0.081s) [63.527145] Starting dynamic subtest: bcs0 [63.598624] Dynamic subtest bcs0: SUCCESS (0.082s) [63.614494] Starting dynamic subtest: vcs0 [63.685989] Dynamic subtest vcs0: SUCCESS (0.087s) [63.702413] Starting dynamic subtest: vecs0 [63.775677] Dynamic subtest vecs0: SUCCESS (0.089s) [63.777733] Subtest basic-await: SUCCESS (0.340s) [64.281632] [024/170] (934s left) gem_exec_fence (nb-await) [64.473406] Starting subtest: nb-await [64.474340] Starting dynamic subtest: rcs0 [64.529816] Dynamic subtest rcs0: SUCCESS (0.064s) [64.538820] Starting dynamic subtest: bcs0 [64.588713] Dynamic subtest bcs0: SUCCESS (0.058s) [64.600814] Starting dynamic subtest: vcs0 [64.650641] Dynamic subtest vcs0: SUCCESS (0.061s) [64.660622] Starting dynamic subtest: vecs0 [64.710585] Dynamic subtest vecs0: SUCCESS (0.060s) [64.712319] Subtest nb-await: SUCCESS (0.245s) [65.209734] [025/170] (933s left) gem_exec_gttfill (basic) [65.289225] Starting subtest: basic [69.255332] Subtest basic: SUCCESS (3.957s) [69.439552] [026/170] (929s left) gem_exec_parallel (engines) [69.595899] Starting subtest: engines [69.596998] Starting dynamic subtest: basic [71.679290] Dynamic subtest basic: SUCCESS (2.083s) [71.691777] Starting dynamic subtest: contexts [74.831427] Dynamic subtest contexts: SUCCESS (3.144s) [74.840090] Starting dynamic subtest: fds [79.423437] Dynamic subtest fds: SUCCESS (4.592s) [79.434735] Starting dynamic subtest: userptr [81.436165] Dynamic subtest userptr: SUCCESS (2.021s) [81.437890] Subtest engines: SUCCESS (11.840s) [81.629162] [027/170] (917s left) gem_exec_store (basic) [81.716063] Starting subtest: basic [81.810809] Subtest basic: SUCCESS (0.096s) [82.001464] [028/170] (916s left) gem_flink_basic (bad-flink) [82.073182] Starting subtest: bad-flink [82.074176] Subtest bad-flink: SUCCESS (0.000s) [82.133428] [029/170] (916s left) gem_flink_basic (bad-open) [82.205570] Starting subtest: bad-open [82.206410] Subtest bad-open: SUCCESS (0.000s) [82.266788] [030/170] (916s left) gem_flink_basic (basic) [82.340212] Starting subtest: basic [82.341202] Subtest basic: SUCCESS (0.000s) [82.417669] [031/170] (916s left) gem_flink_basic (double-flink) [82.492073] Starting subtest: double-flink [82.492924] Subtest double-flink: SUCCESS (0.000s) [82.596566] [032/170] (916s left) gem_flink_basic (flink-lifetime) [82.669276] Starting subtest: flink-lifetime [82.670120] Subtest flink-lifetime: SUCCESS (0.001s) [82.779182] [033/170] (916s left) gem_huc_copy (huc-copy) [82.855161] Starting subtest: huc-copy [82.858210] Subtest huc-copy: SUCCESS (0.003s) [82.966457] [034/170] (916s left) gem_linear_blits (basic) [83.143327] Starting subtest: basic [83.151541] Subtest basic: SUCCESS (0.008s) [83.272764] [035/170] (915s left) gem_mmap (basic) [83.390117] Starting subtest: basic [83.394369] Subtest basic: SUCCESS (0.001s) [83.479496] [036/170] (915s left) gem_mmap_gtt (basic) [83.551454] Starting subtest: basic [83.552320] Subtest basic: SUCCESS (0.001s) [83.635530] [037/170] (915s left) gem_render_linear_blits (basic) [83.710874] Starting subtest: basic [83.750657] Subtest basic: SUCCESS (0.040s) [83.841115] [038/170] (915s left) gem_render_tiled_blits (basic) [83.917672] Starting subtest: basic [83.962803] Subtest basic: SUCCESS (0.045s) [84.057987] [039/170] (915s left) gem_ringfill (basic-all) [84.385194] Starting subtest: basic-all [85.545134] Subtest basic-all: SUCCESS (1.153s) [85.655453] [040/170] (913s left) gem_softpin (allocator-basic) [85.741705] Starting subtest: allocator-basic [85.845589] Subtest allocator-basic: SUCCESS (0.104s) [85.967470] [041/170] (913s left) gem_softpin (allocator-basic-reserve) [86.049581] Starting subtest: allocator-basic-reserve [86.147859] Subtest allocator-basic-reserve: SUCCESS (0.098s) [86.258754] [042/170] (912s left) gem_softpin (safe-alignment) [86.341509] Starting subtest: safe-alignment [86.355093] Subtest safe-alignment: SUCCESS (0.014s) [86.473761] [043/170] (912s left) gem_sync (basic-all) [86.560926] Starting subtest: basic-all [88.761987] Subtest basic-all: SUCCESS (2.200s) [88.953943] [044/170] (910s left) gem_sync (basic-each) [89.026852] Starting subtest: basic-each [91.798958] Subtest basic-each: SUCCESS (2.771s) [91.994410] [045/170] (907s left) gem_tiled_blits (basic) [92.152017] Starting subtest: basic [92.170312] Subtest basic: SUCCESS (0.019s) [92.288109] [046/170] (906s left) gem_tiled_fence_blits (basic) [92.514605] Starting subtest: basic [92.535173] Subtest basic: SUCCESS (0.021s) [92.657144] [047/170] (906s left) gem_tiled_pread_basic [92.811250] [048/170] (906s left) gem_wait (busy@all-engines) [92.896651] Starting subtest: busy [92.897714] Starting dynamic subtest: all-engines [93.450534] Dynamic subtest all-engines: SUCCESS (0.553s) [93.452040] Subtest busy: SUCCESS (0.553s) [93.666414] [049/170] (905s left) gem_wait (wait@all-engines) [93.746250] Starting subtest: wait [93.747071] Starting dynamic subtest: all-engines [94.803242] Dynamic subtest all-engines: SUCCESS (1.056s) [94.804781] Subtest wait: SUCCESS (1.056s) [95.015580] [050/170] (904s left) i915_getparams_basic (basic-eu-total) [95.070579] Starting subtest: basic-eu-total [95.072087] Subtest basic-eu-total: SUCCESS (0.000s) [95.131672] [051/170] (904s left) i915_getparams_basic (basic-subslice-total) [95.190379] Starting subtest: basic-subslice-total [95.192310] Subtest basic-subslice-total: SUCCESS (0.000s) [95.263472] [052/170] (904s left) i915_hangman (error-state-basic) [95.328240] Starting subtest: error-state-basic [95.444068] Subtest error-state-basic: SUCCESS (0.115s) [95.528758] [053/170] (903s left) i915_pciid [95.662616] [054/170] (903s left) kms_addfb_basic (addfb25-bad-modifier) [95.725196] Starting subtest: addfb25-bad-modifier [95.725950] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [95.844431] [055/170] (903s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.909199] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.910077] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.035831] [056/170] (903s left) kms_addfb_basic (addfb25-modifier-no-flag) [96.102078] Starting subtest: addfb25-modifier-no-flag [96.102857] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [96.212717] [057/170] (903s left) kms_addfb_basic (addfb25-x-tiled-legacy) [96.280890] Starting subtest: addfb25-x-tiled-legacy [96.281736] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.393849] [058/170] (903s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.464318] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.465136] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [96.578457] [059/170] (902s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [96.665075] Starting subtest: addfb25-yf-tiled-legacy [96.666134] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [96.768350] [060/170] (902s left) kms_addfb_basic (addfb25-y-tiled-legacy) [96.857374] Starting subtest: addfb25-y-tiled-legacy [96.858374] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [96.959092] [061/170] (902s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.046267] Starting subtest: addfb25-y-tiled-small-legacy [97.047220] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [97.151838] [062/170] (902s left) kms_addfb_basic (bad-pitch-0) [97.223699] Starting subtest: bad-pitch-0 [97.224561] Subtest bad-pitch-0: SUCCESS (0.000s) [97.335153] [063/170] (902s left) kms_addfb_basic (bad-pitch-1024) [97.408058] Starting subtest: bad-pitch-1024 [97.408940] Subtest bad-pitch-1024: SUCCESS (0.000s) [97.522657] [064/170] (901s left) kms_addfb_basic (bad-pitch-128) [97.595960] Starting subtest: bad-pitch-128 [97.596791] Subtest bad-pitch-128: SUCCESS (0.000s) [97.711180] [065/170] (901s left) kms_addfb_basic (bad-pitch-256) [97.784350] Starting subtest: bad-pitch-256 [97.785269] Subtest bad-pitch-256: SUCCESS (0.000s) [97.901938] [066/170] (901s left) kms_addfb_basic (bad-pitch-32) [97.975107] Starting subtest: bad-pitch-32 [97.975925] Subtest bad-pitch-32: SUCCESS (0.000s) [98.091329] [067/170] (901s left) kms_addfb_basic (bad-pitch-63) [98.164816] Starting subtest: bad-pitch-63 [98.165670] Subtest bad-pitch-63: SUCCESS (0.000s) [98.279517] [068/170] (901s left) kms_addfb_basic (bad-pitch-65536) [98.353043] Starting subtest: bad-pitch-65536 [98.353910] Subtest bad-pitch-65536: SUCCESS (0.000s) [98.467215] [069/170] (901s left) kms_addfb_basic (bad-pitch-999) [98.540976] Starting subtest: bad-pitch-999 [98.541925] Subtest bad-pitch-999: SUCCESS (0.000s) [98.667021] [070/170] (900s left) kms_addfb_basic (basic) [98.740315] Starting subtest: basic [98.741208] Subtest basic: SUCCESS (0.000s) [98.856204] [071/170] (900s left) kms_addfb_basic (basic-x-tiled-legacy) [98.932367] Starting subtest: basic-x-tiled-legacy [98.933251] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [99.043722] [072/170] (900s left) kms_addfb_basic (basic-y-tiled-legacy) [99.117996] Starting subtest: basic-y-tiled-legacy [99.118878] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [99.236821] [073/170] (900s left) kms_addfb_basic (bo-too-small) [99.326781] Starting subtest: bo-too-small [99.327707] Subtest bo-too-small: SUCCESS (0.000s) [99.427299] [074/170] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling) [99.518789] Starting subtest: bo-too-small-due-to-tiling [99.519806] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [99.609493] [075/170] (900s left) kms_addfb_basic (clobberred-modifier) [99.683775] Starting subtest: clobberred-modifier [99.684767] Subtest clobberred-modifier: SUCCESS (0.000s) [99.813774] [076/170] (899s left) kms_addfb_basic (framebuffer-vs-set-tiling) [99.887853] Starting subtest: framebuffer-vs-set-tiling [99.888835] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.004303] [077/170] (899s left) kms_addfb_basic (invalid-get-prop) [100.078617] Starting subtest: invalid-get-prop [100.079501] Subtest invalid-get-prop: SUCCESS (0.000s) [100.198950] [078/170] (899s left) kms_addfb_basic (invalid-get-prop-any) [100.271771] Starting subtest: invalid-get-prop-any [100.272628] Subtest invalid-get-prop-any: SUCCESS (0.000s) [100.399455] [079/170] (899s left) kms_addfb_basic (invalid-set-prop) [100.473107] Starting subtest: invalid-set-prop [100.473989] Subtest invalid-set-prop: SUCCESS (0.000s) [100.598696] [080/170] (899s left) kms_addfb_basic (invalid-set-prop-any) [100.671967] Starting subtest: invalid-set-prop-any [100.672978] Subtest invalid-set-prop-any: SUCCESS (0.000s) [100.788666] [081/170] (899s left) kms_addfb_basic (no-handle) [100.861083] Starting subtest: no-handle [100.861940] Subtest no-handle: SUCCESS (0.000s) [100.980417] [082/170] (898s left) kms_addfb_basic (size-max) [101.075154] Starting subtest: size-max [101.075992] Subtest size-max: SUCCESS (0.000s) [101.179303] [083/170] (898s left) kms_addfb_basic (small-bo) [101.268936] Starting subtest: small-bo [101.269864] Subtest small-bo: SUCCESS (0.000s) [101.373183] [084/170] (898s left) kms_addfb_basic (tile-pitch-mismatch) [101.446162] Starting subtest: tile-pitch-mismatch [101.447015] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [101.564176] [085/170] (898s left) kms_addfb_basic (too-high) [101.653181] Starting subtest: too-high [101.654143] Subtest too-high: SUCCESS (0.001s) [101.755259] [086/170] (898s left) kms_addfb_basic (too-wide) [101.845068] Starting subtest: too-wide [101.845928] Subtest too-wide: SUCCESS (0.000s) [101.943381] [087/170] (897s left) kms_addfb_basic (unused-handle) [102.016408] Starting subtest: unused-handle [102.017248] Subtest unused-handle: SUCCESS (0.000s) [102.130646] [088/170] (897s left) kms_addfb_basic (unused-modifier) [102.204997] Starting subtest: unused-modifier [102.206034] Subtest unused-modifier: SUCCESS (0.000s) [102.321194] [089/170] (897s left) kms_addfb_basic (unused-offsets) [102.395993] Starting subtest: unused-offsets [102.396858] Subtest unused-offsets: SUCCESS (0.000s) [102.515662] [090/170] (897s left) kms_addfb_basic (unused-pitches) [102.591944] Starting subtest: unused-pitches [102.592754] Subtest unused-pitches: SUCCESS (0.000s) [102.697651] [091/170] (897s left) kms_busy (basic) [102.798489] Starting subtest: basic [102.800293] Starting dynamic subtest: flip [103.690899] Dynamic subtest flip: SUCCESS (0.887s) [103.707172] Starting dynamic subtest: modeset [107.493778] Dynamic subtest modeset: SUCCESS (3.806s) [107.494526] Subtest basic: SUCCESS (4.695s) [108.391425] [092/170] (891s left) kms_chamelium_hpd (dp-hpd-fast) [108.777178] Subtest dp-hpd-fast: SKIP (0.000s) [109.628793] [093/170] (890s left) kms_chamelium_edid (dp-edid-read) [110.001406] Subtest dp-edid-read: SKIP (0.000s) [110.904193] [094/170] (889s left) kms_chamelium_frames (dp-crc-fast) [111.289689] Subtest dp-crc-fast: SKIP (0.000s) [112.183509] [095/170] (887s left) kms_chamelium_hpd (hdmi-hpd-fast) [112.565463] Subtest hdmi-hpd-fast: SKIP (0.000s) [113.466579] [096/170] (886s left) kms_chamelium_edid (hdmi-edid-read) [113.836707] Subtest hdmi-edid-read: SKIP (0.000s) [114.744291] [097/170] (885s left) kms_chamelium_frames (hdmi-crc-fast) [115.114868] Subtest hdmi-crc-fast: SKIP (0.000s) [116.027142] [098/170] (884s left) kms_chamelium_hpd (vga-hpd-fast) [116.422252] Subtest vga-hpd-fast: SKIP (0.000s) [117.303279] [099/170] (882s left) kms_chamelium_edid (vga-edid-read) [117.684869] Subtest vga-edid-read: SKIP (0.000s) [118.586128] [100/170] (881s left) kms_prop_blob (basic) [118.643401] Starting subtest: basic [118.644173] Subtest basic: SUCCESS (0.000s) [118.716482] [101/170] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [118.825099] Starting subtest: basic-busy-flip-before-cursor-atomic [118.826745] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [118.925456] [102/170] (881s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [119.027692] Starting subtest: basic-busy-flip-before-cursor-legacy [119.029271] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [119.128071] [103/170] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [119.229737] Starting subtest: basic-flip-after-cursor-atomic [120.453899] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.223s) [121.382528] [104/170] (878s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [121.491011] Starting subtest: basic-flip-after-cursor-legacy [122.706320] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.215s) [123.623076] [105/170] (876s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [123.731138] Starting subtest: basic-flip-after-cursor-varying-size [124.950899] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.218s) [125.863326] [106/170] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [125.971948] Starting subtest: basic-flip-before-cursor-atomic [127.193380] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.219s) [128.102778] [107/170] (872s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [128.212788] Starting subtest: basic-flip-before-cursor-legacy [129.426770] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.214s) [130.344513] [108/170] (869s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [130.452104] Starting subtest: basic-flip-before-cursor-varying-size [131.675967] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.223s) [132.586092] [109/170] (867s left) kms_flip (basic-flip-vs-dpms) [132.646849] Starting subtest: basic-flip-vs-dpms [132.647684] Starting dynamic subtest: A-eDP1 [135.477438] Dynamic subtest A-eDP1: SUCCESS (2.829s) [135.493461] Starting dynamic subtest: B-eDP1 [137.842573] Dynamic subtest B-eDP1: SUCCESS (2.363s) [137.859359] Starting dynamic subtest: C-eDP1 [140.192867] Dynamic subtest C-eDP1: SUCCESS (2.351s) [140.195449] Subtest basic-flip-vs-dpms: SUCCESS (7.550s) [141.097575] [110/170] (859s left) kms_flip (basic-flip-vs-modeset) [141.161354] Starting subtest: basic-flip-vs-modeset [141.162139] Starting dynamic subtest: A-eDP1 [143.963521] Dynamic subtest A-eDP1: SUCCESS (2.800s) [143.982106] Starting dynamic subtest: B-eDP1 [146.326393] Dynamic subtest B-eDP1: SUCCESS (2.363s) [146.336997] Starting dynamic subtest: C-eDP1 [148.696183] Dynamic subtest C-eDP1: SUCCESS (2.368s) [148.697766] Subtest basic-flip-vs-modeset: SUCCESS (7.537s) [149.607086] [111/170] (850s left) kms_flip (basic-flip-vs-wf_vblank) [149.671684] Starting subtest: basic-flip-vs-wf_vblank [149.673873] Starting dynamic subtest: A-eDP1 [151.959447] Dynamic subtest A-eDP1: SUCCESS (2.285s) [151.968621] Starting dynamic subtest: B-eDP1 [154.203365] Dynamic subtest B-eDP1: SUCCESS (2.242s) [154.213174] Starting dynamic subtest: C-eDP1 [156.415440] Dynamic subtest C-eDP1: SUCCESS (2.212s) [156.416601] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.745s) [157.736977] [112/170] (842s left) kms_flip (basic-plain-flip) [157.799123] Starting subtest: basic-plain-flip [157.799908] Starting dynamic subtest: A-eDP1 [159.801614] Dynamic subtest A-eDP1: SUCCESS (2.001s) [159.811258] Starting dynamic subtest: B-eDP1 [161.786047] Dynamic subtest B-eDP1: SUCCESS (1.983s) [161.795505] Starting dynamic subtest: C-eDP1 [163.685464] Dynamic subtest C-eDP1: SUCCESS (1.898s) [163.686291] Subtest basic-plain-flip: SUCCESS (5.888s) [164.970662] [113/170] (835s left) kms_force_connector_basic (force-connector-state) [165.028409] Starting subtest: force-connector-state [165.822414] Subtest force-connector-state: SUCCESS (0.794s) [166.602183] [114/170] (833s left) kms_force_connector_basic (force-edid) [166.656314] Starting subtest: force-edid [166.683386] Subtest force-edid: SUCCESS (0.025s) [166.804769] [115/170] (833s left) kms_force_connector_basic (force-load-detect) [166.858190] Starting subtest: force-load-detect [166.859691] Subtest force-load-detect: SKIP (0.000s) [166.937300] [116/170] (833s left) kms_force_connector_basic (prune-stale-modes) [166.992296] Starting subtest: prune-stale-modes [167.015199] Subtest prune-stale-modes: SUCCESS (0.023s) [167.131756] [117/170] (833s left) kms_frontbuffer_tracking (basic) [167.201459] Starting subtest: basic [171.428943] Subtest basic: SUCCESS (4.228s) [171.519128] [118/170] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [171.596955] Starting subtest: compare-crc-sanitycheck [171.597926] Starting dynamic subtest: pipe-A-eDP-1 [172.263171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s) [172.277219] Starting dynamic subtest: pipe-B-eDP-1 [173.652385] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s) [173.669772] Starting dynamic subtest: pipe-C-eDP-1 [174.996910] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s) [174.997746] Subtest compare-crc-sanitycheck: SUCCESS (3.400s) [175.910292] [119/170] (824s left) kms_pipe_crc_basic (hang-read-crc) [175.989833] Starting subtest: hang-read-crc [175.991909] Starting dynamic subtest: pipe-A-eDP-1 [178.275232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.284s) [178.294620] Starting dynamic subtest: pipe-B-eDP-1 [181.282231] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.003s) [181.300660] Starting dynamic subtest: pipe-C-eDP-1 [184.209023] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.923s) [184.209980] Subtest hang-read-crc: SUCCESS (8.218s) [185.120333] [120/170] (815s left) kms_pipe_crc_basic (nonblocking-crc) [185.212584] Starting subtest: nonblocking-crc [185.214842] Starting dynamic subtest: pipe-A-eDP-1 [186.041745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s) [186.057891] Starting dynamic subtest: pipe-B-eDP-1 [187.591103] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [187.600352] Starting dynamic subtest: pipe-C-eDP-1 [189.118989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.525s) [189.119949] Subtest nonblocking-crc: SUCCESS (3.905s) [190.056569] [121/170] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [190.135592] Starting subtest: nonblocking-crc-frame-sequence [190.138503] Starting dynamic subtest: pipe-A-eDP-1 [190.982705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.845s) [191.000739] Starting dynamic subtest: pipe-B-eDP-1 [192.537573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s) [192.555206] Starting dynamic subtest: pipe-C-eDP-1 [194.063321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s) [194.064211] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.927s) [194.986071] [122/170] (805s left) kms_pipe_crc_basic (read-crc) [195.064339] Starting subtest: read-crc [195.067332] Starting dynamic subtest: pipe-A-eDP-1 [195.844626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s) [195.861776] Starting dynamic subtest: pipe-B-eDP-1 [197.332385] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.484s) [197.349168] Starting dynamic subtest: pipe-C-eDP-1 [198.796502] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s) [198.797375] Subtest read-crc: SUCCESS (3.733s) [199.718474] [123/170] (800s left) kms_pipe_crc_basic (read-crc-frame-sequence) [199.796545] Starting subtest: read-crc-frame-sequence [199.799340] Starting dynamic subtest: pipe-A-eDP-1 [200.595078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s) [200.612190] Starting dynamic subtest: pipe-B-eDP-1 [202.088472] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s) [202.106390] Starting dynamic subtest: pipe-C-eDP-1 [203.532609] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.440s) [203.533492] Subtest read-crc-frame-sequence: SUCCESS (3.735s) [204.456350] [124/170] (796s left) kms_psr (primary_page_flip) [204.538961] Starting subtest: primary_page_flip [206.454688] Subtest primary_page_flip: SUCCESS (1.916s) [207.398698] [125/170] (793s left) kms_psr (cursor_plane_move) [207.482685] Starting subtest: cursor_plane_move [209.365351] Subtest cursor_plane_move: SUCCESS (1.882s) [210.272233] [126/170] (790s left) kms_psr (sprite_plane_onoff) [210.362255] Starting subtest: sprite_plane_onoff [212.333380] Subtest sprite_plane_onoff: SUCCESS (1.971s) [213.285608] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1759 [max: 8192] direct dependencies: 17120 [max: 32768] indirect dependencies: 128947 all direct dependencies: 358896 dependency chains: 24667 [max: 131072] dependency chain hlocks used: 102247 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 275 in-softirq chains: 562 in-process chains: 23830 stack-trace entries: 156796 [max: 1048576] number of stack traces: 8231 number of stack hash chains: 6414 combined max dependencies: 3703051428 hardirq-safe locks: 106 hardirq-unsafe locks: 1042 softirq-safe locks: 207 softirq-unsafe locks: 959 irq-safe locks: 222 irq-unsafe locks: 1042 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 310 softirq-read-safe locks: 7 softirq-read-unsafe locks: 305 irq-read-safe locks: 7 irq-read-unsafe locks: 310 uncategorized locks: 291 unused locks: 1 max locking depth: 15 max bfs queue depth: 388 max lock class index: 1758 chain lookup misses: 24854 chain lookup hits: 189205892 cyclic checks: 24596 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4234 find-mask backwards checks: 2618 hardirq on events: 123913190 hardirq off events: 123913186 redundant hardirq ons: 58 redundant hardirq offs: 26 softirq on events: 336750 softirq off events: 336750 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 115 large chain blocks: 1 [213.286880] Closing watchdogs Done.