[38.662553] Initializing watchdogs [38.662601] /dev/watchdog0 [38.666843] [001/165] (960s left) i915_module_load (load) [38.701754] Starting subtest: load [41.596902] Subtest load: SUCCESS (2.896s) [41.609872] [002/165] (957s left) core_auth (basic-auth) [41.670789] Starting subtest: basic-auth [41.671849] Subtest basic-auth: SUCCESS (0.001s) [41.766686] [003/165] (957s left) debugfs_test (read_all_entries) [41.807059] Starting subtest: read_all_entries [41.931306] Subtest read_all_entries: SUCCESS (0.124s) [42.183962] [004/165] (957s left) debugfs_test (basic-hwmon) [42.219718] Starting subtest: basic-hwmon [42.221284] Subtest basic-hwmon: SKIP (0.000s) [42.467927] [005/165] (956s left) fbdev (eof) [42.513948] Starting subtest: eof [42.514898] Subtest eof: SUCCESS (0.000s) [42.566400] [006/165] (956s left) fbdev (info) [42.599614] Starting subtest: info [42.600655] Subtest info: SUCCESS (0.000s) [42.666411] [007/165] (956s left) fbdev (nullptr) [42.714535] Starting subtest: nullptr [42.720161] Subtest nullptr: SUCCESS (0.000s) [42.763383] [008/165] (956s left) fbdev (read) [42.813720] Starting subtest: read [43.605993] Subtest read: SUCCESS (0.788s) [43.645380] [009/165] (955s left) fbdev (write) [43.680231] Starting subtest: write [44.209373] Subtest write: SUCCESS (0.525s) [44.242735] [010/165] (955s left) gem_basic (bad-close) [44.274889] Starting subtest: bad-close [44.276324] Subtest bad-close: SUCCESS (0.000s) [44.332877] [011/165] (954s left) gem_basic (create-close) [44.371152] Starting subtest: create-close [44.372495] Subtest create-close: SUCCESS (0.000s) [44.450172] [012/165] (954s left) gem_basic (create-fd-close) [44.484800] Starting subtest: create-fd-close [44.486339] Subtest create-fd-close: SUCCESS (0.000s) [44.566040] [013/165] (954s left) gem_busy (busy@all-engines) [44.611852] Starting subtest: busy [44.612634] Starting dynamic subtest: all-engines [44.635084] Dynamic subtest all-engines: SUCCESS (0.023s) [44.636303] Subtest busy: SUCCESS (0.023s) [44.967926] [014/165] (954s left) gem_close_race (basic-process) [45.018049] Starting subtest: basic-process [45.060442] Subtest basic-process: SUCCESS (0.042s) [45.234387] [015/165] (954s left) gem_close_race (basic-threads) [45.278222] Starting subtest: basic-threads [46.470081] Subtest basic-threads: SUCCESS (1.190s) [46.635290] [016/165] (952s left) gem_ctx_create (basic) [46.683440] Starting subtest: basic [46.684594] Subtest basic: SUCCESS (0.000s) [46.850811] [017/165] (952s left) gem_ctx_create (basic-files) [46.891385] Starting subtest: basic-files [48.900111] Subtest basic-files: SUCCESS (2.009s) [49.342735] [018/165] (950s left) gem_ctx_exec (basic) [49.384983] Starting subtest: basic [49.387373] Subtest basic: SUCCESS (0.002s) [49.475385] [019/165] (949s left) gem_exec_basic (basic) [49.515881] Starting subtest: basic [49.516615] Starting dynamic subtest: rcs0-smem [49.517333] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [49.521204] Starting dynamic subtest: bcs0-smem [49.522075] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [49.525840] Starting dynamic subtest: vcs0-smem [49.526745] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [49.531336] Starting dynamic subtest: vcs1-smem [49.532279] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [49.537014] Starting dynamic subtest: vecs0-smem [49.538020] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [49.538938] Subtest basic: SUCCESS (0.002s) [49.693120] [020/165] (949s left) gem_exec_create (basic) [49.738686] Starting subtest: basic [49.739940] Starting dynamic subtest: smem [51.826486] Dynamic subtest smem: SUCCESS (2.087s) [51.828183] Subtest basic: SUCCESS (2.087s) [52.005017] [021/165] (947s left) gem_exec_fence (basic-busy) [52.171178] Starting subtest: basic-busy [52.172933] Starting dynamic subtest: rcs0 [52.232728] Dynamic subtest rcs0: SUCCESS (0.065s) [52.241248] Starting dynamic subtest: bcs0 [52.279167] Dynamic subtest bcs0: SUCCESS (0.046s) [52.288573] Starting dynamic subtest: vcs0 [52.325992] Dynamic subtest vcs0: SUCCESS (0.047s) [52.334802] Starting dynamic subtest: vcs1 [52.372956] Dynamic subtest vcs1: SUCCESS (0.047s) [52.382879] Starting dynamic subtest: vecs0 [52.421855] Dynamic subtest vecs0: SUCCESS (0.048s) [52.423661] Subtest basic-busy: SUCCESS (0.254s) [52.921841] [022/165] (946s left) gem_exec_fence (basic-wait) [53.083923] Starting subtest: basic-wait [53.085391] Starting dynamic subtest: rcs0 [53.157311] Dynamic subtest rcs0: SUCCESS (0.073s) [53.167293] Starting dynamic subtest: bcs0 [53.205963] Dynamic subtest bcs0: SUCCESS (0.048s) [53.215404] Starting dynamic subtest: vcs0 [53.256855] Dynamic subtest vcs0: SUCCESS (0.051s) [53.266276] Starting dynamic subtest: vcs1 [53.304701] Dynamic subtest vcs1: SUCCESS (0.047s) [53.315276] Starting dynamic subtest: vecs0 [53.354610] Dynamic subtest vecs0: SUCCESS (0.049s) [53.356453] Subtest basic-wait: SUCCESS (0.270s) [53.836047] [023/165] (945s left) gem_exec_fence (basic-await) [54.002140] Starting subtest: basic-await [54.003569] Starting dynamic subtest: rcs0 [54.075667] Dynamic subtest rcs0: SUCCESS (0.078s) [54.084519] Starting dynamic subtest: bcs0 [54.150219] Dynamic subtest bcs0: SUCCESS (0.074s) [54.159382] Starting dynamic subtest: vcs0 [54.228763] Dynamic subtest vcs0: SUCCESS (0.076s) [54.234586] Starting dynamic subtest: vcs1 [54.299666] Dynamic subtest vcs1: SUCCESS (0.072s) [54.313183] Starting dynamic subtest: vecs0 [54.380250] Dynamic subtest vecs0: SUCCESS (0.080s) [54.382566] Subtest basic-await: SUCCESS (0.382s) [54.855884] [024/165] (944s left) gem_exec_fence (nb-await) [55.022881] Starting subtest: nb-await [55.024313] Starting dynamic subtest: rcs0 [55.079804] Dynamic subtest rcs0: SUCCESS (0.061s) [55.092069] Starting dynamic subtest: bcs0 [55.139553] Dynamic subtest bcs0: SUCCESS (0.059s) [55.150988] Starting dynamic subtest: vcs0 [55.197783] Dynamic subtest vcs0: SUCCESS (0.059s) [55.206295] Starting dynamic subtest: vcs1 [55.255893] Dynamic subtest vcs1: SUCCESS (0.058s) [55.270421] Starting dynamic subtest: vecs0 [55.317553] Dynamic subtest vecs0: SUCCESS (0.061s) [55.318976] Subtest nb-await: SUCCESS (0.299s) [55.806083] [025/165] (943s left) gem_exec_gttfill (basic) [55.858108] Starting subtest: basic [58.030414] Subtest basic: SUCCESS (2.173s) [58.211058] [026/165] (941s left) gem_exec_parallel (engines) [58.304815] Starting subtest: engines [58.305940] Starting dynamic subtest: basic [59.643100] Dynamic subtest basic: SUCCESS (1.337s) [59.655332] Starting dynamic subtest: contexts [61.375136] Dynamic subtest contexts: SUCCESS (1.728s) [61.380755] Starting dynamic subtest: fds [63.207116] Dynamic subtest fds: SUCCESS (1.836s) [63.211936] Starting dynamic subtest: userptr [64.508609] Dynamic subtest userptr: SUCCESS (1.301s) [64.510348] Subtest engines: SUCCESS (6.204s) [64.699729] [027/165] (934s left) gem_exec_store (basic) [64.745559] Starting subtest: basic [64.818950] Subtest basic: SUCCESS (0.073s) [64.990740] [028/165] (934s left) gem_flink_basic (bad-flink) [65.029442] Starting subtest: bad-flink [65.030120] Subtest bad-flink: SUCCESS (0.000s) [65.085777] [029/165] (934s left) gem_flink_basic (bad-open) [65.124535] Starting subtest: bad-open [65.125252] Subtest bad-open: SUCCESS (0.000s) [65.189918] [030/165] (934s left) gem_flink_basic (basic) [65.223872] Starting subtest: basic [65.224660] Subtest basic: SUCCESS (0.000s) [65.304040] [031/165] (934s left) gem_flink_basic (double-flink) [65.342501] Starting subtest: double-flink [65.343311] Subtest double-flink: SUCCESS (0.000s) [65.420066] [032/165] (934s left) gem_flink_basic (flink-lifetime) [65.456998] Starting subtest: flink-lifetime [65.457935] Subtest flink-lifetime: SUCCESS (0.001s) [65.532184] [033/165] (934s left) gem_huc_copy (huc-copy) [65.569100] Starting subtest: huc-copy [65.570984] Subtest huc-copy: SUCCESS (0.002s) [65.667672] [034/165] (934s left) gem_linear_blits (basic) [65.757021] Starting subtest: basic [65.763177] Subtest basic: SUCCESS (0.006s) [65.892988] [035/165] (933s left) gem_mmap (basic) [65.980137] Starting subtest: basic [65.984698] Subtest basic: SUCCESS (0.000s) [66.054218] [036/165] (933s left) gem_mmap_gtt (basic) [66.088863] Starting subtest: basic [66.089824] Subtest basic: SUCCESS (0.000s) [66.141422] [037/165] (933s left) gem_render_linear_blits (basic) [66.176410] Starting subtest: basic [66.191728] Subtest basic: SUCCESS (0.015s) [66.262814] [038/165] (933s left) gem_render_tiled_blits (basic) [66.297062] Starting subtest: basic [66.317728] Subtest basic: SUCCESS (0.021s) [66.397300] [039/165] (933s left) gem_ringfill (basic-all) [66.723861] Starting subtest: basic-all [67.845919] Subtest basic-all: SUCCESS (1.118s) [67.939242] [040/165] (931s left) gem_softpin (allocator-basic) [67.984592] Starting subtest: allocator-basic [68.036576] Subtest allocator-basic: SUCCESS (0.053s) [68.137731] [041/165] (931s left) gem_softpin (allocator-basic-reserve) [68.176780] Starting subtest: allocator-basic-reserve [68.229032] Subtest allocator-basic-reserve: SUCCESS (0.052s) [68.320847] [042/165] (931s left) gem_softpin (safe-alignment) [68.358517] Starting subtest: safe-alignment [68.365988] Subtest safe-alignment: SUCCESS (0.007s) [68.453869] [043/165] (931s left) gem_sync (basic-all) [68.498741] Starting subtest: basic-all [70.579800] Subtest basic-all: SUCCESS (2.080s) [70.750860] [044/165] (929s left) gem_sync (basic-each) [70.792771] Starting subtest: basic-each [73.050318] Subtest basic-each: SUCCESS (2.257s) [73.231171] [045/165] (926s left) gem_tiled_blits (basic) [73.311819] Starting subtest: basic [73.322726] Subtest basic: SUCCESS (0.011s) [73.448153] [046/165] (926s left) gem_tiled_fence_blits (basic) [73.573710] Starting subtest: basic [73.592846] Subtest basic: SUCCESS (0.019s) [73.702693] [047/165] (926s left) gem_tiled_pread_basic [73.817959] [048/165] (926s left) gem_wait (busy@all-engines) [73.865742] Starting subtest: busy [73.866970] Starting dynamic subtest: all-engines [74.410251] Dynamic subtest all-engines: SUCCESS (0.544s) [74.411960] Subtest busy: SUCCESS (0.544s) [74.612705] [049/165] (925s left) gem_wait (wait@all-engines) [74.649075] Starting subtest: wait [74.649943] Starting dynamic subtest: all-engines [75.700091] Dynamic subtest all-engines: SUCCESS (1.050s) [75.701795] Subtest wait: SUCCESS (1.050s) [75.887326] [050/165] (924s left) i915_getparams_basic (basic-eu-total) [75.921620] Starting subtest: basic-eu-total [75.924253] Subtest basic-eu-total: SUCCESS (0.000s) [75.991885] [051/165] (923s left) i915_getparams_basic (basic-subslice-total) [76.030506] Starting subtest: basic-subslice-total [76.031744] Subtest basic-subslice-total: SUCCESS (0.000s) [76.085289] [052/165] (923s left) i915_hangman (error-state-basic) [76.123310] Starting subtest: error-state-basic [76.224870] Subtest error-state-basic: SUCCESS (0.101s) [76.287699] [053/165] (923s left) i915_pciid [76.385250] [054/165] (923s left) kms_addfb_basic (addfb25-4-tiled) [76.609396] Starting subtest: addfb25-4-tiled [76.610591] Subtest addfb25-4-tiled: SUCCESS (0.000s) [76.686811] [055/165] (923s left) kms_addfb_basic (addfb25-bad-modifier) [76.722048] Starting subtest: addfb25-bad-modifier [76.722838] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [76.990538] [056/165] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [77.029104] Starting subtest: addfb25-framebuffer-vs-set-tiling [77.029902] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [77.303480] [057/165] (922s left) kms_addfb_basic (addfb25-modifier-no-flag) [77.343388] Starting subtest: addfb25-modifier-no-flag [77.344298] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [77.605145] [058/165] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [77.645603] Starting subtest: addfb25-x-tiled-legacy [77.646563] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [77.902270] [059/165] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [77.941769] Starting subtest: addfb25-x-tiled-mismatch-legacy [77.942927] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [78.261094] [060/165] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [78.545308] Starting subtest: addfb25-yf-tiled-legacy [78.559700] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [78.632098] [061/165] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy) [78.903222] Starting subtest: addfb25-y-tiled-legacy [78.923142] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [78.966835] [062/165] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [79.240977] Starting subtest: addfb25-y-tiled-small-legacy [79.243034] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [79.304950] [063/165] (920s left) kms_addfb_basic (bad-pitch-0) [79.342685] Starting subtest: bad-pitch-0 [79.343403] Subtest bad-pitch-0: SUCCESS (0.000s) [79.602398] [064/165] (920s left) kms_addfb_basic (bad-pitch-1024) [79.635991] Starting subtest: bad-pitch-1024 [79.636886] Subtest bad-pitch-1024: SUCCESS (0.000s) [79.921895] [065/165] (920s left) kms_addfb_basic (bad-pitch-128) [79.960693] Starting subtest: bad-pitch-128 [79.961542] Subtest bad-pitch-128: SUCCESS (0.000s) [80.238851] [066/165] (920s left) kms_addfb_basic (bad-pitch-256) [80.278195] Starting subtest: bad-pitch-256 [80.279086] Subtest bad-pitch-256: SUCCESS (0.000s) [80.535805] [067/165] (919s left) kms_addfb_basic (bad-pitch-32) [80.574116] Starting subtest: bad-pitch-32 [80.575158] Subtest bad-pitch-32: SUCCESS (0.000s) [80.837153] [068/165] (919s left) kms_addfb_basic (bad-pitch-63) [80.875695] Starting subtest: bad-pitch-63 [80.876460] Subtest bad-pitch-63: SUCCESS (0.000s) [81.137073] [069/165] (919s left) kms_addfb_basic (bad-pitch-65536) [81.172875] Starting subtest: bad-pitch-65536 [81.173855] Subtest bad-pitch-65536: SUCCESS (0.000s) [81.437118] [070/165] (918s left) kms_addfb_basic (bad-pitch-999) [81.476597] Starting subtest: bad-pitch-999 [81.477356] Subtest bad-pitch-999: SUCCESS (0.000s) [81.737099] [071/165] (918s left) kms_addfb_basic (basic) [81.774304] Starting subtest: basic [81.774974] Subtest basic: SUCCESS (0.000s) [82.037249] [072/165] (918s left) kms_addfb_basic (basic-x-tiled-legacy) [82.072124] Starting subtest: basic-x-tiled-legacy [82.072863] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [82.337167] [073/165] (918s left) kms_addfb_basic (basic-y-tiled-legacy) [82.379988] Starting subtest: basic-y-tiled-legacy [82.381865] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [82.653630] [074/165] (917s left) kms_addfb_basic (bo-too-small) [82.871987] Starting subtest: bo-too-small [82.872985] Subtest bo-too-small: SUCCESS (0.000s) [82.953960] [075/165] (917s left) kms_addfb_basic (bo-too-small-due-to-tiling) [83.198227] Starting subtest: bo-too-small-due-to-tiling [83.199556] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [83.269739] [076/165] (917s left) kms_addfb_basic (clobberred-modifier) [83.311470] Starting subtest: clobberred-modifier [83.312797] Subtest clobberred-modifier: SUCCESS (0.000s) [83.570728] [077/165] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [83.611541] Starting subtest: framebuffer-vs-set-tiling [83.612746] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [83.869455] [078/165] (916s left) kms_addfb_basic (invalid-get-prop) [83.902706] Starting subtest: invalid-get-prop [83.903531] Subtest invalid-get-prop: SUCCESS (0.000s) [84.170281] [079/165] (916s left) kms_addfb_basic (invalid-get-prop-any) [84.207964] Starting subtest: invalid-get-prop-any [84.208795] Subtest invalid-get-prop-any: SUCCESS (0.000s) [84.485202] [080/165] (916s left) kms_addfb_basic (invalid-set-prop) [84.517735] Starting subtest: invalid-set-prop [84.518396] Subtest invalid-set-prop: SUCCESS (0.000s) [84.771981] [081/165] (915s left) kms_addfb_basic (invalid-set-prop-any) [84.809100] Starting subtest: invalid-set-prop-any [84.810361] Subtest invalid-set-prop-any: SUCCESS (0.000s) [85.070051] [082/165] (915s left) kms_addfb_basic (no-handle) [85.108570] Starting subtest: no-handle [85.109690] Subtest no-handle: SUCCESS (0.000s) [85.370828] [083/165] (915s left) kms_addfb_basic (size-max) [85.586161] Starting subtest: size-max [85.587316] Subtest size-max: SUCCESS (0.000s) [85.653518] [084/165] (914s left) kms_addfb_basic (small-bo) [85.870218] Starting subtest: small-bo [85.871366] Subtest small-bo: SUCCESS (0.000s) [85.954426] [085/165] (914s left) kms_addfb_basic (tile-pitch-mismatch) [85.997919] Starting subtest: tile-pitch-mismatch [85.998689] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [86.253429] [086/165] (914s left) kms_addfb_basic (too-high) [86.495115] Starting subtest: too-high [86.496133] Subtest too-high: SUCCESS (0.000s) [86.570652] [087/165] (914s left) kms_addfb_basic (too-wide) [86.787881] Starting subtest: too-wide [86.788821] Subtest too-wide: SUCCESS (0.000s) [86.870886] [088/165] (913s left) kms_addfb_basic (unused-handle) [86.910400] Starting subtest: unused-handle [86.911393] Subtest unused-handle: SUCCESS (0.000s) [87.170155] [089/165] (913s left) kms_addfb_basic (unused-modifier) [87.207316] Starting subtest: unused-modifier [87.208057] Subtest unused-modifier: SUCCESS (0.000s) [87.471402] [090/165] (913s left) kms_addfb_basic (unused-offsets) [87.506754] Starting subtest: unused-offsets [87.511522] Subtest unused-offsets: SUCCESS (0.000s) [87.770286] [091/165] (912s left) kms_addfb_basic (unused-pitches) [87.810766] Starting subtest: unused-pitches [87.812124] Subtest unused-pitches: SUCCESS (0.000s) [88.070842] [092/165] (912s left) kms_busy (basic) [88.290354] Starting subtest: basic [88.291729] Starting dynamic subtest: flip [89.122053] Dynamic subtest flip: SUCCESS (0.831s) [89.131077] Starting dynamic subtest: modeset [92.998288] Dynamic subtest modeset: SUCCESS (3.877s) [92.998907] Subtest basic: SUCCESS (4.709s) [93.893186] [093/165] (906s left) kms_prop_blob (basic) [93.936989] Starting subtest: basic [93.937947] Subtest basic: SUCCESS (0.000s) [94.007412] [094/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [94.231201] Starting subtest: basic-busy-flip-before-cursor-atomic [94.233266] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [94.290254] [095/165] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [94.507310] Starting subtest: basic-busy-flip-before-cursor-legacy [94.509940] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [94.573227] [096/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [94.795394] Starting subtest: basic-flip-after-cursor-atomic [96.000285] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.204s) [96.899931] [097/165] (903s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [97.123226] Starting subtest: basic-flip-after-cursor-legacy [98.329297] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.204s) [99.269041] [098/165] (901s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [99.491104] Starting subtest: basic-flip-after-cursor-varying-size [100.696858] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.205s) [101.635740] [099/165] (899s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [101.859172] Starting subtest: basic-flip-before-cursor-atomic [103.043409] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.188s) [103.942331] [100/165] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [104.164956] Starting subtest: basic-flip-before-cursor-legacy [105.352801] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.189s) [106.245084] [101/165] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [106.465012] Starting subtest: basic-flip-before-cursor-varying-size [107.668943] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.204s) [108.611893] [102/165] (892s left) kms_dsc (dsc-basic) [108.833955] Subtest dsc-basic: SKIP (0.000s) [108.861885] [103/165] (892s left) kms_flip (basic-flip-vs-dpms) [109.079833] Starting subtest: basic-flip-vs-dpms [109.082072] Starting dynamic subtest: A-eDP1 [111.815664] Dynamic subtest A-eDP1: SUCCESS (2.733s) [111.828179] Starting dynamic subtest: B-eDP1 [114.184137] Dynamic subtest B-eDP1: SUCCESS (2.369s) [114.194059] Starting dynamic subtest: C-eDP1 [116.554783] Dynamic subtest C-eDP1: SUCCESS (2.365s) [116.560649] Starting dynamic subtest: D-eDP1 [118.902809] Dynamic subtest D-eDP1: SUCCESS (2.351s) [118.906676] Subtest basic-flip-vs-dpms: SUCCESS (9.825s) [119.813756] [104/165] (881s left) kms_flip (basic-flip-vs-modeset) [120.038735] Starting subtest: basic-flip-vs-modeset [120.040089] Starting dynamic subtest: A-eDP1 [122.757069] Dynamic subtest A-eDP1: SUCCESS (2.717s) [122.762828] Starting dynamic subtest: B-eDP1 [125.109913] Dynamic subtest B-eDP1: SUCCESS (2.353s) [125.115885] Starting dynamic subtest: C-eDP1 [127.475938] Dynamic subtest C-eDP1: SUCCESS (2.366s) [127.482310] Starting dynamic subtest: D-eDP1 [129.850495] Dynamic subtest D-eDP1: SUCCESS (2.373s) [129.853682] Subtest basic-flip-vs-modeset: SUCCESS (9.815s) [130.754330] [105/165] (870s left) kms_flip (basic-flip-vs-wf_vblank) [130.971995] Starting subtest: basic-flip-vs-wf_vblank [130.974217] Starting dynamic subtest: A-eDP1 [133.009603] Dynamic subtest A-eDP1: SUCCESS (2.032s) [133.021833] Starting dynamic subtest: B-eDP1 [135.035644] Dynamic subtest B-eDP1: SUCCESS (2.027s) [135.048122] Starting dynamic subtest: C-eDP1 [137.023419] Dynamic subtest C-eDP1: SUCCESS (1.986s) [137.031417] Starting dynamic subtest: D-eDP1 [139.068184] Dynamic subtest D-eDP1: SUCCESS (2.043s) [139.073842] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.102s) [140.292708] [106/165] (860s left) kms_flip (basic-plain-flip) [140.515872] Starting subtest: basic-plain-flip [140.517770] Starting dynamic subtest: A-eDP1 [142.259382] Dynamic subtest A-eDP1: SUCCESS (1.740s) [142.273958] Starting dynamic subtest: B-eDP1 [144.032810] Dynamic subtest B-eDP1: SUCCESS (1.771s) [144.045286] Starting dynamic subtest: C-eDP1 [145.759700] Dynamic subtest C-eDP1: SUCCESS (1.725s) [145.768144] Starting dynamic subtest: D-eDP1 [147.487851] Dynamic subtest D-eDP1: SUCCESS (1.727s) [147.493323] Subtest basic-plain-flip: SUCCESS (6.977s) [148.740561] [107/165] (852s left) kms_force_connector_basic (force-connector-state) [149.040200] Starting subtest: force-connector-state [150.002417] Subtest force-connector-state: SUCCESS (0.962s) [151.219448] [108/165] (849s left) kms_force_connector_basic (force-edid) [151.553853] Starting subtest: force-edid [152.071717] Subtest force-edid: SUCCESS (0.519s) [152.595322] [109/165] (848s left) kms_force_connector_basic (force-load-detect) [152.885670] Starting subtest: force-load-detect [152.887531] Subtest force-load-detect: SKIP (0.000s) [153.308165] [110/165] (847s left) kms_force_connector_basic (prune-stale-modes) [153.598791] Starting subtest: prune-stale-modes [154.160798] Subtest prune-stale-modes: SUCCESS (0.562s) [154.682674] [111/165] (846s left) kms_frontbuffer_tracking (basic) [154.915478] Starting subtest: basic [157.727718] Subtest basic: SUCCESS (2.814s) [157.831709] [112/165] (843s left) kms_hdmi_inject (inject-audio) [158.175929] Starting subtest: inject-audio [158.759676] Subtest inject-audio: SUCCESS (0.584s) [159.306080] [113/165] (841s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [159.522172] Starting subtest: compare-crc-sanitycheck-xr24 [159.523178] Starting dynamic subtest: pipe-A-eDP-1 [160.154417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s) [160.167566] Starting dynamic subtest: pipe-B-eDP-1 [161.550313] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s) [161.556074] Starting dynamic subtest: pipe-C-eDP-1 [162.958898] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s) [162.965097] Starting dynamic subtest: pipe-D-eDP-1 [164.368663] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s) [164.369941] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.846s) [165.316664] [114/165] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [165.568856] Starting subtest: compare-crc-sanitycheck-nv12 [165.569932] Starting dynamic subtest: pipe-A-eDP-1 [166.264277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s) [166.276455] Starting dynamic subtest: pipe-B-eDP-1 [167.632992] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s) [167.642966] Starting dynamic subtest: pipe-C-eDP-1 [169.040555] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s) [169.049106] Starting dynamic subtest: pipe-D-eDP-1 [170.462241] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s) [170.463433] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.895s) [171.397313] [115/165] (829s left) kms_pipe_crc_basic (hang-read-crc) [171.622067] Starting subtest: hang-read-crc [171.623121] Starting dynamic subtest: pipe-A-eDP-1 [173.891729] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.271s) [173.899054] Starting dynamic subtest: pipe-B-eDP-1 [176.849496] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.956s) [176.856471] Starting dynamic subtest: pipe-C-eDP-1 [179.803059] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.952s) [179.809602] Starting dynamic subtest: pipe-D-eDP-1 [182.754985] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.950s) [182.756117] Subtest hang-read-crc: SUCCESS (11.134s) [183.684672] [116/165] (817s left) kms_pipe_crc_basic (nonblocking-crc) [183.908456] Starting subtest: nonblocking-crc [183.909470] Starting dynamic subtest: pipe-A-eDP-1 [184.727135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s) [184.738043] Starting dynamic subtest: pipe-B-eDP-1 [186.292380] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s) [186.299739] Starting dynamic subtest: pipe-C-eDP-1 [187.848547] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.553s) [187.854938] Starting dynamic subtest: pipe-D-eDP-1 [189.366058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.516s) [189.367214] Subtest nonblocking-crc: SUCCESS (5.458s) [190.277810] [117/165] (810s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [190.513866] Starting subtest: nonblocking-crc-frame-sequence [190.529408] Starting dynamic subtest: pipe-A-eDP-1 [191.336154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s) [191.355717] Starting dynamic subtest: pipe-B-eDP-1 [192.889688] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s) [192.896924] Starting dynamic subtest: pipe-C-eDP-1 [194.421441] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.530s) [194.428371] Starting dynamic subtest: pipe-D-eDP-1 [195.962518] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s) [195.963858] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.461s) [196.869665] [118/165] (804s left) kms_pipe_crc_basic (read-crc) [197.088056] Starting subtest: read-crc [197.088902] Starting dynamic subtest: pipe-A-eDP-1 [197.827599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [197.834128] Starting dynamic subtest: pipe-B-eDP-1 [199.299797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s) [199.305847] Starting dynamic subtest: pipe-C-eDP-1 [200.755642] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s) [200.762602] Starting dynamic subtest: pipe-D-eDP-1 [202.228362] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.471s) [202.229177] Subtest read-crc: SUCCESS (5.141s) [203.144733] [119/165] (798s left) kms_pipe_crc_basic (read-crc-frame-sequence) [203.394839] Starting subtest: read-crc-frame-sequence [203.395969] Starting dynamic subtest: pipe-A-eDP-1 [204.169147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.775s) [204.177257] Starting dynamic subtest: pipe-B-eDP-1 [205.625852] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s) [205.634342] Starting dynamic subtest: pipe-C-eDP-1 [207.098336] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.470s) [207.106158] Starting dynamic subtest: pipe-D-eDP-1 [208.581854] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s) [208.582882] Subtest read-crc-frame-sequence: SUCCESS (5.188s) [209.479301] [120/165] (791s left) kms_pm_backlight (basic-brightness) [209.706216] Starting subtest: basic-brightness [209.736355] Starting dynamic subtest: eDP-1 [210.274314] Dynamic subtest eDP-1: SUCCESS (0.537s) [210.275451] Subtest basic-brightness: SUCCESS (0.568s) [211.198990] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1771 [max: 8192] direct dependencies: 17702 [max: 32768] indirect dependencies: 132680 all direct dependencies: 362762 dependency chains: 25666 [max: 131072] dependency chain hlocks used: 106466 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 283 in-softirq chains: 570 in-process chains: 24813 stack-trace entries: 169375 [max: 1048576] number of stack traces: 8531 number of stack hash chains: 6644 combined max dependencies: 4023937496 hardirq-safe locks: 101 hardirq-unsafe locks: 1065 softirq-safe locks: 206 softirq-unsafe locks: 977 irq-safe locks: 223 irq-unsafe locks: 1065 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 306 softirq-read-safe locks: 7 softirq-read-unsafe locks: 301 irq-read-safe locks: 7 irq-read-unsafe locks: 306 uncategorized locks: 287 unused locks: 1 max locking depth: 15 max bfs queue depth: 392 max lock class index: 1770 chain lookup misses: 26102 chain lookup hits: 214960186 cyclic checks: 26078 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4344 find-mask backwards checks: 2651 hardirq on events: 129588960 hardirq off events: 129588944 redundant hardirq ons: 36 redundant hardirq offs: 26 softirq on events: 687160 softirq off events: 687160 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 106 large chain blocks: 1 [211.200797] Closing watchdogs Done.