[36.191627] Initializing watchdogs [36.191673] /dev/watchdog0 [36.197415] [001/161] (960s left) i915_module_load (load) [36.235633] Starting subtest: load [39.241075] Subtest load: SUCCESS (3.005s) [39.259714] [002/161] (957s left) core_auth (basic-auth) [39.338695] Starting subtest: basic-auth [39.340554] Subtest basic-auth: SUCCESS (0.002s) [39.427394] [003/161] (957s left) debugfs_test (read_all_entries) [39.487357] Starting subtest: read_all_entries [39.626550] Subtest read_all_entries: SUCCESS (0.138s) [39.878911] [004/161] (956s left) debugfs_test (basic-hwmon) [39.930031] Starting subtest: basic-hwmon [39.931791] Subtest basic-hwmon: SKIP (0.000s) [40.175883] [005/161] (956s left) debugfs_test (sysfs) [40.225907] Starting subtest: sysfs [40.249157] Subtest sysfs: SUCCESS (0.024s) [40.510076] [006/161] (956s left) fbdev (eof) [40.558258] Starting subtest: eof [40.559283] Subtest eof: SUCCESS (0.001s) [40.609215] [007/161] (956s left) fbdev (info) [40.646153] Starting subtest: info [40.647148] Subtest info: SUCCESS (0.000s) [40.710158] [008/161] (956s left) fbdev (nullptr) [40.757979] Starting subtest: nullptr [40.759179] Subtest nullptr: SUCCESS (0.000s) [40.811181] [009/161] (956s left) fbdev (read) [40.857875] Starting subtest: read [41.642078] Subtest read: SUCCESS (0.779s) [41.691710] [010/161] (955s left) fbdev (write) [41.745438] Starting subtest: write [42.251190] Subtest write: SUCCESS (0.510s) [42.285811] [011/161] (954s left) gem_basic (bad-close) [42.327014] Starting subtest: bad-close [42.328671] Subtest bad-close: SUCCESS (0.000s) [42.408588] [012/161] (954s left) gem_basic (create-close) [42.455257] Starting subtest: create-close [42.458199] Subtest create-close: SUCCESS (0.000s) [42.550821] [013/161] (954s left) gem_basic (create-fd-close) [42.601946] Starting subtest: create-fd-close [42.604140] Subtest create-fd-close: SUCCESS (0.000s) [42.677323] [014/161] (954s left) gem_busy (busy@all-engines) [42.751383] Starting subtest: busy [42.752462] Starting dynamic subtest: all-engines [42.775373] Dynamic subtest all-engines: SUCCESS (0.025s) [42.776404] Subtest busy: SUCCESS (0.025s) [43.113910] [015/161] (953s left) gem_close_race (basic-process) [43.174483] Starting subtest: basic-process [43.234797] Subtest basic-process: SUCCESS (0.059s) [43.385604] [016/161] (953s left) gem_close_race (basic-threads) [43.434285] Starting subtest: basic-threads [44.632866] Subtest basic-threads: SUCCESS (1.198s) [44.800094] [017/161] (952s left) gem_ctx_create (basic) [44.854727] Starting subtest: basic [44.856181] Subtest basic: SUCCESS (0.000s) [45.030123] [018/161] (951s left) gem_ctx_create (basic-files) [45.087730] Starting subtest: basic-files [47.139653] Subtest basic-files: SUCCESS (2.052s) [47.431070] [019/161] (949s left) gem_ctx_exec (basic) [47.556467] Starting subtest: basic [47.559189] Subtest basic: SUCCESS (0.006s) [47.666373] [020/161] (949s left) gem_exec_basic (basic) [47.771755] Starting subtest: basic [47.786705] Starting dynamic subtest: rcs0-smem [47.793611] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [47.818624] Starting dynamic subtest: bcs0-smem [47.835754] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [47.862265] Starting dynamic subtest: vcs0-smem [47.882126] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [47.904782] Starting dynamic subtest: vcs1-smem [47.921523] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [47.948069] Starting dynamic subtest: vecs0-smem [47.969329] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [47.984332] Subtest basic: SUCCESS (0.003s) [48.013856] [021/161] (949s left) gem_exec_create (basic) [48.102531] Starting subtest: basic [48.114424] Starting dynamic subtest: smem [50.189401] Dynamic subtest smem: SUCCESS (2.100s) [50.191203] Subtest basic: SUCCESS (2.100s) [50.369606] [022/161] (946s left) gem_exec_fence (basic-busy) [50.541843] Starting subtest: basic-busy [50.543040] Starting dynamic subtest: rcs0 [50.602095] Dynamic subtest rcs0: SUCCESS (0.066s) [50.610874] Starting dynamic subtest: bcs0 [50.653916] Dynamic subtest bcs0: SUCCESS (0.053s) [50.662992] Starting dynamic subtest: vcs0 [50.711312] Dynamic subtest vcs0: SUCCESS (0.059s) [50.718366] Starting dynamic subtest: vcs1 [50.766754] Dynamic subtest vcs1: SUCCESS (0.057s) [50.774936] Starting dynamic subtest: vecs0 [50.818397] Dynamic subtest vecs0: SUCCESS (0.052s) [50.819890] Subtest basic-busy: SUCCESS (0.289s) [51.302077] [023/161] (945s left) gem_exec_fence (basic-wait) [51.458976] Starting subtest: basic-wait [51.460110] Starting dynamic subtest: rcs0 [51.532867] Dynamic subtest rcs0: SUCCESS (0.079s) [51.543051] Starting dynamic subtest: bcs0 [51.580397] Dynamic subtest bcs0: SUCCESS (0.048s) [51.590276] Starting dynamic subtest: vcs0 [51.628169] Dynamic subtest vcs0: SUCCESS (0.049s) [51.638120] Starting dynamic subtest: vcs1 [51.678342] Dynamic subtest vcs1: SUCCESS (0.051s) [51.688112] Starting dynamic subtest: vecs0 [51.730499] Dynamic subtest vecs0: SUCCESS (0.053s) [51.732287] Subtest basic-wait: SUCCESS (0.282s) [52.206143] [024/161] (944s left) gem_exec_fence (basic-await) [52.388967] Starting subtest: basic-await [52.390901] Starting dynamic subtest: rcs0 [52.460996] Dynamic subtest rcs0: SUCCESS (0.077s) [52.471334] Starting dynamic subtest: bcs0 [52.535663] Dynamic subtest bcs0: SUCCESS (0.076s) [52.548547] Starting dynamic subtest: vcs0 [52.613827] Dynamic subtest vcs0: SUCCESS (0.080s) [52.627076] Starting dynamic subtest: vcs1 [52.694340] Dynamic subtest vcs1: SUCCESS (0.082s) [52.706836] Starting dynamic subtest: vecs0 [52.772936] Dynamic subtest vecs0: SUCCESS (0.080s) [52.774684] Subtest basic-await: SUCCESS (0.397s) [53.248393] [025/161] (943s left) gem_exec_fence (nb-await) [53.433966] Starting subtest: nb-await [53.435267] Starting dynamic subtest: rcs0 [53.490299] Dynamic subtest rcs0: SUCCESS (0.062s) [53.503032] Starting dynamic subtest: bcs0 [53.551364] Dynamic subtest bcs0: SUCCESS (0.062s) [53.564608] Starting dynamic subtest: vcs0 [53.611996] Dynamic subtest vcs0: SUCCESS (0.061s) [53.626976] Starting dynamic subtest: vcs1 [53.672672] Dynamic subtest vcs1: SUCCESS (0.062s) [53.687878] Starting dynamic subtest: vecs0 [53.733469] Dynamic subtest vecs0: SUCCESS (0.062s) [53.735168] Subtest nb-await: SUCCESS (0.311s) [54.214988] [026/161] (942s left) gem_exec_gttfill (basic) [54.271363] Starting subtest: basic [56.479021] Subtest basic: SUCCESS (2.240s) [56.639472] [027/161] (940s left) gem_exec_parallel (engines) [56.753595] Starting subtest: engines [56.755135] Starting dynamic subtest: basic [58.048774] Dynamic subtest basic: SUCCESS (1.309s) [58.060618] Starting dynamic subtest: contexts [59.951060] Dynamic subtest contexts: SUCCESS (1.915s) [59.956372] Starting dynamic subtest: fds [62.188038] Dynamic subtest fds: SUCCESS (2.256s) [62.197180] Starting dynamic subtest: userptr [63.492079] Dynamic subtest userptr: SUCCESS (1.311s) [63.493877] Subtest engines: SUCCESS (6.793s) [63.682110] [028/161] (933s left) gem_exec_store (basic) [63.751955] Starting subtest: basic [63.823902] Subtest basic: SUCCESS (0.072s) [64.002230] [029/161] (932s left) gem_flink_basic (bad-flink) [64.055221] Starting subtest: bad-flink [64.056579] Subtest bad-flink: SUCCESS (0.000s) [64.149759] [030/161] (932s left) gem_flink_basic (bad-open) [64.201321] Starting subtest: bad-open [64.202388] Subtest bad-open: SUCCESS (0.000s) [64.280902] [031/161] (932s left) gem_flink_basic (basic) [64.330048] Starting subtest: basic [64.331088] Subtest basic: SUCCESS (0.000s) [64.398088] [032/161] (932s left) gem_flink_basic (double-flink) [64.458091] Starting subtest: double-flink [64.459855] Subtest double-flink: SUCCESS (0.000s) [64.532786] [033/161] (932s left) gem_flink_basic (flink-lifetime) [64.590704] Starting subtest: flink-lifetime [64.592305] Subtest flink-lifetime: SUCCESS (0.003s) [64.681023] [034/161] (932s left) gem_huc_copy (huc-copy) [64.733057] Starting subtest: huc-copy [64.733799] Subtest huc-copy: SUCCESS (0.002s) [64.848263] [035/161] (932s left) gem_linear_blits (basic) [64.980265] Starting subtest: basic [64.986225] Subtest basic: SUCCESS (0.006s) [65.103263] [036/161] (932s left) gem_mmap (basic) [65.206371] Starting subtest: basic [65.213083] Subtest basic: SUCCESS (0.000s) [65.278912] [037/161] (931s left) gem_mmap_gtt (basic) [65.338424] Starting subtest: basic [65.340115] Subtest basic: SUCCESS (0.001s) [65.403347] [038/161] (931s left) gem_render_linear_blits (basic) [65.460877] Starting subtest: basic [65.481709] Subtest basic: SUCCESS (0.022s) [65.553925] [039/161] (931s left) gem_render_tiled_blits (basic) [65.604808] Starting subtest: basic [65.626776] Subtest basic: SUCCESS (0.022s) [65.706308] [040/161] (931s left) gem_ringfill (basic-all) [66.045819] Starting subtest: basic-all [67.163093] Subtest basic-all: SUCCESS (1.117s) [67.258433] [041/161] (929s left) gem_softpin (allocator-basic) [67.316087] Starting subtest: allocator-basic [67.367814] Subtest allocator-basic: SUCCESS (0.052s) [67.485937] [042/161] (929s left) gem_softpin (allocator-basic-reserve) [67.544260] Starting subtest: allocator-basic-reserve [67.596028] Subtest allocator-basic-reserve: SUCCESS (0.052s) [67.704208] [043/161] (929s left) gem_softpin (safe-alignment) [67.759910] Starting subtest: safe-alignment [67.776171] Subtest safe-alignment: SUCCESS (0.017s) [67.889279] [044/161] (929s left) gem_sync (basic-all) [67.956595] Starting subtest: basic-all [70.209379] Subtest basic-all: SUCCESS (2.258s) [70.381847] [045/161] (926s left) gem_sync (basic-each) [70.452054] Starting subtest: basic-each [72.733627] Subtest basic-each: SUCCESS (2.285s) [72.918715] [046/161] (924s left) gem_tiled_blits (basic) [73.058684] Starting subtest: basic [73.072244] Subtest basic: SUCCESS (0.014s) [73.195364] [047/161] (924s left) gem_tiled_fence_blits (basic) [73.365135] Starting subtest: basic [73.383238] Subtest basic: SUCCESS (0.019s) [73.521713] [048/161] (923s left) gem_tiled_pread_basic [73.660236] [049/161] (923s left) gem_wait (busy@all-engines) [73.732344] Starting subtest: busy [73.733298] Starting dynamic subtest: all-engines [74.293512] Dynamic subtest all-engines: SUCCESS (0.558s) [74.294723] Subtest busy: SUCCESS (0.558s) [74.495658] [050/161] (922s left) gem_wait (wait@all-engines) [74.560914] Starting subtest: wait [74.561788] Starting dynamic subtest: all-engines [75.631740] Dynamic subtest all-engines: SUCCESS (1.071s) [75.633222] Subtest wait: SUCCESS (1.072s) [75.840330] [051/161] (921s left) i915_getparams_basic (basic-eu-total) [75.897135] Starting subtest: basic-eu-total [75.899048] Subtest basic-eu-total: SUCCESS (0.000s) [75.973267] [052/161] (921s left) i915_getparams_basic (basic-subslice-total) [76.017067] Starting subtest: basic-subslice-total [76.019789] Subtest basic-subslice-total: SUCCESS (0.000s) [76.090346] [053/161] (921s left) i915_hangman (error-state-basic) [76.150550] Starting subtest: error-state-basic [76.251605] Subtest error-state-basic: SUCCESS (0.102s) [76.322950] [054/161] (921s left) i915_pciid [76.473286] [055/161] (920s left) kms_addfb_basic (addfb25-4-tiled) [76.710298] Starting subtest: addfb25-4-tiled [76.711323] Subtest addfb25-4-tiled: SUCCESS (0.000s) [76.789607] [056/161] (920s left) kms_addfb_basic (addfb25-bad-modifier) [76.837577] Starting subtest: addfb25-bad-modifier [76.838731] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [77.088281] [057/161] (920s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [77.138784] Starting subtest: addfb25-framebuffer-vs-set-tiling [77.139670] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [77.389974] [058/161] (920s left) kms_addfb_basic (addfb25-modifier-no-flag) [77.439169] Starting subtest: addfb25-modifier-no-flag [77.440385] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [77.688340] [059/161] (919s left) kms_addfb_basic (addfb25-x-tiled-legacy) [77.737051] Starting subtest: addfb25-x-tiled-legacy [77.737884] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [77.987831] [060/161] (919s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [78.040367] Starting subtest: addfb25-x-tiled-mismatch-legacy [78.041529] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [78.301704] [061/161] (919s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [78.528189] Starting subtest: addfb25-yf-tiled-legacy [78.529209] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [78.606240] [062/161] (918s left) kms_addfb_basic (addfb25-y-tiled-legacy) [78.842235] Starting subtest: addfb25-y-tiled-legacy [78.843726] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [78.921408] [063/161] (918s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [79.172049] Starting subtest: addfb25-y-tiled-small-legacy [79.172925] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [79.253252] [064/161] (918s left) kms_addfb_basic (bad-pitch-0) [79.299901] Starting subtest: bad-pitch-0 [79.300800] Subtest bad-pitch-0: SUCCESS (0.000s) [79.552129] [065/161] (918s left) kms_addfb_basic (bad-pitch-1024) [79.597080] Starting subtest: bad-pitch-1024 [79.597972] Subtest bad-pitch-1024: SUCCESS (0.000s) [79.857689] [066/161] (917s left) kms_addfb_basic (bad-pitch-128) [79.910815] Starting subtest: bad-pitch-128 [79.912277] Subtest bad-pitch-128: SUCCESS (0.000s) [80.168668] [067/161] (917s left) kms_addfb_basic (bad-pitch-256) [80.221669] Starting subtest: bad-pitch-256 [80.222828] Subtest bad-pitch-256: SUCCESS (0.000s) [80.486793] [068/161] (917s left) kms_addfb_basic (bad-pitch-32) [80.533632] Starting subtest: bad-pitch-32 [80.534833] Subtest bad-pitch-32: SUCCESS (0.000s) [80.804209] [069/161] (916s left) kms_addfb_basic (bad-pitch-63) [80.858165] Starting subtest: bad-pitch-63 [80.859236] Subtest bad-pitch-63: SUCCESS (0.000s) [81.118797] [070/161] (916s left) kms_addfb_basic (bad-pitch-65536) [81.175985] Starting subtest: bad-pitch-65536 [81.180629] Subtest bad-pitch-65536: SUCCESS (0.000s) [81.437206] [071/161] (916s left) kms_addfb_basic (bad-pitch-999) [81.486224] Starting subtest: bad-pitch-999 [81.487333] Subtest bad-pitch-999: SUCCESS (0.000s) [81.770143] [072/161] (915s left) kms_addfb_basic (basic) [81.823645] Starting subtest: basic [81.824984] Subtest basic: SUCCESS (0.000s) [82.085449] [073/161] (915s left) kms_addfb_basic (basic-x-tiled-legacy) [82.142503] Starting subtest: basic-x-tiled-legacy [82.143631] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [82.401023] [074/161] (915s left) kms_addfb_basic (basic-y-tiled-legacy) [82.457402] Starting subtest: basic-y-tiled-legacy [82.458918] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [82.720172] [075/161] (915s left) kms_addfb_basic (bo-too-small) [82.960434] Starting subtest: bo-too-small [82.961804] Subtest bo-too-small: SUCCESS (0.000s) [83.035071] [076/161] (914s left) kms_addfb_basic (bo-too-small-due-to-tiling) [83.276531] Starting subtest: bo-too-small-due-to-tiling [83.277614] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [83.368749] [077/161] (914s left) kms_addfb_basic (clobberred-modifier) [83.416367] Starting subtest: clobberred-modifier [83.417999] Subtest clobberred-modifier: SUCCESS (0.000s) [83.685524] [078/161] (914s left) kms_addfb_basic (framebuffer-vs-set-tiling) [83.741389] Starting subtest: framebuffer-vs-set-tiling [83.742911] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [84.002446] [079/161] (913s left) kms_addfb_basic (invalid-get-prop) [84.050203] Starting subtest: invalid-get-prop [84.051436] Subtest invalid-get-prop: SUCCESS (0.000s) [84.302284] [080/161] (913s left) kms_addfb_basic (invalid-get-prop-any) [84.356064] Starting subtest: invalid-get-prop-any [84.357451] Subtest invalid-get-prop-any: SUCCESS (0.000s) [84.619355] [081/161] (913s left) kms_addfb_basic (invalid-set-prop) [84.665504] Starting subtest: invalid-set-prop [84.666934] Subtest invalid-set-prop: SUCCESS (0.000s) [84.919815] [082/161] (913s left) kms_addfb_basic (invalid-set-prop-any) [84.976680] Starting subtest: invalid-set-prop-any [84.977903] Subtest invalid-set-prop-any: SUCCESS (0.000s) [85.237361] [083/161] (912s left) kms_addfb_basic (no-handle) [85.284122] Starting subtest: no-handle [85.285112] Subtest no-handle: SUCCESS (0.000s) [85.537263] [084/161] (912s left) kms_addfb_basic (size-max) [85.767437] Starting subtest: size-max [85.768870] Subtest size-max: SUCCESS (0.000s) [85.837228] [085/161] (912s left) kms_addfb_basic (small-bo) [86.076182] Starting subtest: small-bo [86.077348] Subtest small-bo: SUCCESS (0.000s) [86.151780] [086/161] (911s left) kms_addfb_basic (tile-pitch-mismatch) [86.207678] Starting subtest: tile-pitch-mismatch [86.208957] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [86.470233] [087/161] (911s left) kms_addfb_basic (too-high) [86.710561] Starting subtest: too-high [86.711811] Subtest too-high: SUCCESS (0.000s) [86.787286] [088/161] (911s left) kms_addfb_basic (too-wide) [87.027170] Starting subtest: too-wide [87.028283] Subtest too-wide: SUCCESS (0.000s) [87.102961] [089/161] (910s left) kms_addfb_basic (unused-handle) [87.160482] Starting subtest: unused-handle [87.161696] Subtest unused-handle: SUCCESS (0.000s) [87.435661] [090/161] (910s left) kms_addfb_basic (unused-modifier) [87.485594] Starting subtest: unused-modifier [87.486806] Subtest unused-modifier: SUCCESS (0.000s) [87.746192] [091/161] (910s left) kms_addfb_basic (unused-offsets) [87.786344] Starting subtest: unused-offsets [87.787502] Subtest unused-offsets: SUCCESS (0.000s) [88.053404] [092/161] (910s left) kms_addfb_basic (unused-pitches) [88.104290] Starting subtest: unused-pitches [88.105505] Subtest unused-pitches: SUCCESS (0.000s) [88.387127] [093/161] (909s left) kms_busy (basic) [88.624977] Starting subtest: basic [88.625888] Starting dynamic subtest: flip [89.458499] Dynamic subtest flip: SUCCESS (0.810s) [89.472991] Starting dynamic subtest: modeset [93.332024] Dynamic subtest modeset: SUCCESS (3.895s) [93.332886] Subtest basic: SUCCESS (4.706s) [94.226031] [094/161] (903s left) kms_prop_blob (basic) [94.272599] Starting subtest: basic [94.273532] Subtest basic: SUCCESS (0.000s) [94.342118] [095/161] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [94.590265] Starting subtest: basic-busy-flip-before-cursor-atomic [94.592074] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [94.657295] [096/161] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [94.888351] Starting subtest: basic-busy-flip-before-cursor-legacy [94.890489] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [94.957789] [097/161] (903s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [95.184115] Starting subtest: basic-flip-after-cursor-atomic [96.364950] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.181s) [97.298479] [098/161] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [97.534294] Starting subtest: basic-flip-after-cursor-legacy [98.726577] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.192s) [99.666362] [099/161] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [99.910169] Starting subtest: basic-flip-after-cursor-varying-size [101.111197] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.201s) [102.031426] [100/161] (896s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [102.266233] Starting subtest: basic-flip-before-cursor-atomic [103.458296] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.191s) [104.402064] [101/161] (893s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [104.646031] Starting subtest: basic-flip-before-cursor-legacy [105.846042] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.198s) [106.768778] [102/161] (891s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [107.033232] Starting subtest: basic-flip-before-cursor-varying-size [108.231460] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.198s) [109.138214] [103/161] (889s left) kms_dsc (dsc-basic) [109.374529] Starting subtest: dsc-basic [109.377409] Subtest dsc-basic: SKIP (0.000s) [109.435523] [104/161] (888s left) kms_flip (basic-flip-vs-dpms) [109.682296] Starting subtest: basic-flip-vs-dpms [109.683130] Starting dynamic subtest: A-eDP1 [112.405915] Dynamic subtest A-eDP1: SUCCESS (2.726s) [112.412584] Starting dynamic subtest: B-eDP1 [114.820797] Dynamic subtest B-eDP1: SUCCESS (2.414s) [114.826736] Starting dynamic subtest: C-eDP1 [117.202990] Dynamic subtest C-eDP1: SUCCESS (2.382s) [117.212078] Starting dynamic subtest: D-eDP1 [119.555691] Dynamic subtest D-eDP1: SUCCESS (2.352s) [119.556594] Subtest basic-flip-vs-dpms: SUCCESS (9.879s) [120.466619] [105/161] (877s left) kms_flip (basic-flip-vs-modeset) [120.703861] Starting subtest: basic-flip-vs-modeset [120.705838] Starting dynamic subtest: A-eDP1 [123.473846] Dynamic subtest A-eDP1: SUCCESS (2.768s) [123.480020] Starting dynamic subtest: B-eDP1 [125.826161] Dynamic subtest B-eDP1: SUCCESS (2.351s) [125.833024] Starting dynamic subtest: C-eDP1 [128.194909] Dynamic subtest C-eDP1: SUCCESS (2.368s) [128.200929] Starting dynamic subtest: D-eDP1 [130.564424] Dynamic subtest D-eDP1: SUCCESS (2.369s) [130.566920] Subtest basic-flip-vs-modeset: SUCCESS (9.862s) [131.473846] [106/161] (866s left) kms_flip (basic-flip-vs-wf_vblank) [131.710528] Starting subtest: basic-flip-vs-wf_vblank [131.712278] Starting dynamic subtest: A-eDP1 [133.789233] Dynamic subtest A-eDP1: SUCCESS (2.075s) [133.802825] Starting dynamic subtest: B-eDP1 [135.984235] Dynamic subtest B-eDP1: SUCCESS (2.193s) [135.992980] Starting dynamic subtest: C-eDP1 [137.991614] Dynamic subtest C-eDP1: SUCCESS (2.005s) [137.999202] Starting dynamic subtest: D-eDP1 [139.981487] Dynamic subtest D-eDP1: SUCCESS (1.984s) [139.985511] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.272s) [141.200699] [107/161] (857s left) kms_flip (basic-plain-flip) [141.447384] Starting subtest: basic-plain-flip [141.449352] Starting dynamic subtest: A-eDP1 [143.231409] Dynamic subtest A-eDP1: SUCCESS (1.780s) [143.247073] Starting dynamic subtest: B-eDP1 [145.006912] Dynamic subtest B-eDP1: SUCCESS (1.773s) [145.022023] Starting dynamic subtest: C-eDP1 [146.731649] Dynamic subtest C-eDP1: SUCCESS (1.724s) [146.739148] Starting dynamic subtest: D-eDP1 [148.462517] Dynamic subtest D-eDP1: SUCCESS (1.730s) [148.467318] Subtest basic-plain-flip: SUCCESS (7.019s) [149.716961] [108/161] (848s left) kms_force_connector_basic (force-connector-state) [150.027611] Starting subtest: force-connector-state [150.968291] Subtest force-connector-state: SUCCESS (0.940s) [152.191904] [109/161] (846s left) kms_force_connector_basic (force-edid) [152.503852] Starting subtest: force-edid [153.002940] Subtest force-edid: SUCCESS (0.499s) [153.523476] [110/161] (844s left) kms_force_connector_basic (force-load-detect) [153.863975] Starting subtest: force-load-detect [153.865981] Subtest force-load-detect: SKIP (0.000s) [154.291477] [111/161] (844s left) kms_force_connector_basic (prune-stale-modes) [154.592872] Starting subtest: prune-stale-modes [155.156303] Subtest prune-stale-modes: SUCCESS (0.564s) [155.688167] [112/161] (842s left) kms_frontbuffer_tracking (basic) [155.959119] Starting subtest: basic [158.782962] Subtest basic: SUCCESS (2.824s) [158.888162] [113/161] (839s left) kms_hdmi_inject (inject-audio) [159.250966] Starting subtest: inject-audio [159.829471] Subtest inject-audio: SUCCESS (0.580s) [160.381637] [114/161] (838s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [160.607743] Starting subtest: compare-crc-sanitycheck-xr24 [160.608875] Starting dynamic subtest: pipe-A-eDP-1 [161.242239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s) [161.250380] Starting dynamic subtest: pipe-B-eDP-1 [162.666695] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s) [162.674282] Starting dynamic subtest: pipe-C-eDP-1 [164.064036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s) [164.071056] Starting dynamic subtest: pipe-D-eDP-1 [165.471762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s) [165.473065] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.865s) [166.414222] [115/161] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [166.647956] Starting subtest: compare-crc-sanitycheck-nv12 [166.649169] Starting dynamic subtest: pipe-A-eDP-1 [167.340630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s) [167.350978] Starting dynamic subtest: pipe-B-eDP-1 [168.749838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s) [168.756159] Starting dynamic subtest: pipe-C-eDP-1 [170.139187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s) [170.145649] Starting dynamic subtest: pipe-D-eDP-1 [171.549418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s) [171.550443] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.903s) [172.497286] [116/161] (826s left) kms_pipe_crc_basic (hang-read-crc) [172.731369] Starting subtest: hang-read-crc [172.732223] Starting dynamic subtest: pipe-A-eDP-1 [175.012664] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.280s) [175.018626] Starting dynamic subtest: pipe-B-eDP-1 [178.004241] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.989s) [178.010920] Starting dynamic subtest: pipe-C-eDP-1 [180.912993] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.907s) [180.918956] Starting dynamic subtest: pipe-D-eDP-1 [183.854302] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.941s) [183.855469] Subtest hang-read-crc: SUCCESS (11.124s) [184.789763] [117/161] (813s left) kms_pipe_crc_basic (nonblocking-crc) [185.032351] Starting subtest: nonblocking-crc [185.033547] Starting dynamic subtest: pipe-A-eDP-1 [185.861114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s) [185.867263] Starting dynamic subtest: pipe-B-eDP-1 [187.412566] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s) [187.420642] Starting dynamic subtest: pipe-C-eDP-1 [188.934445] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.521s) [188.942026] Starting dynamic subtest: pipe-D-eDP-1 [190.467626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s) [190.468736] Subtest nonblocking-crc: SUCCESS (5.435s) [191.377130] [118/161] (807s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [191.657274] Starting subtest: nonblocking-crc-frame-sequence [191.658138] Starting dynamic subtest: pipe-A-eDP-1 [192.504135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s) [192.510148] Starting dynamic subtest: pipe-B-eDP-1 [194.069626] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s) [194.077522] Starting dynamic subtest: pipe-C-eDP-1 [195.650979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.580s) [195.658414] Starting dynamic subtest: pipe-D-eDP-1 [197.189887] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s) [197.190900] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.533s) [198.096267] [119/161] (800s left) kms_pipe_crc_basic (read-crc) [198.327293] Starting subtest: read-crc [198.328196] Starting dynamic subtest: pipe-A-eDP-1 [199.090872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s) [199.101204] Starting dynamic subtest: pipe-B-eDP-1 [200.595619] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s) [200.603108] Starting dynamic subtest: pipe-C-eDP-1 [202.056757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.458s) [202.064223] Starting dynamic subtest: pipe-D-eDP-1 [203.527224] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s) [203.528272] Subtest read-crc: SUCCESS (5.201s) [204.442045] [120/161] (794s left) kms_pipe_crc_basic (read-crc-frame-sequence) [204.688732] Starting subtest: read-crc-frame-sequence [204.690381] Starting dynamic subtest: pipe-A-eDP-1 [205.465779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.779s) [205.472909] Starting dynamic subtest: pipe-B-eDP-1 [207.009134] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s) [207.016598] Starting dynamic subtest: pipe-C-eDP-1 [208.527524] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s) [208.535667] Starting dynamic subtest: pipe-D-eDP-1 [209.982332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.453s) [209.983359] Subtest read-crc-frame-sequence: SUCCESS (5.296s) [210.890168] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1872 [max: 8192] direct dependencies: 18718 [max: 32768] indirect dependencies: 147097 all direct dependencies: 367212 dependency chains: 27278 [max: 131072] dependency chain hlocks used: 112832 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 264 in-softirq chains: 605 in-process chains: 26409 stack-trace entries: 170418 [max: 1048576] number of stack traces: 8601 number of stack hash chains: 6690 combined max dependencies: 4241181900 hardirq-safe locks: 99 hardirq-unsafe locks: 1069 softirq-safe locks: 211 softirq-unsafe locks: 978 irq-safe locks: 227 irq-unsafe locks: 1069 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 400 softirq-read-safe locks: 7 softirq-read-unsafe locks: 395 irq-read-safe locks: 7 irq-read-unsafe locks: 400 uncategorized locks: 289 unused locks: 1 max locking depth: 16 max bfs queue depth: 427 max lock class index: 1871 chain lookup misses: 27705 chain lookup hits: 224681298 cyclic checks: 28048 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4393 find-mask backwards checks: 2844 hardirq on events: 124431403 hardirq off events: 124431388 redundant hardirq ons: 34 redundant hardirq offs: 24 softirq on events: 691028 softirq off events: 691028 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 97 large chain blocks: 1 [210.891929] Closing watchdogs Done.