[39.530262] Initializing watchdogs [39.530459] /dev/watchdog0 [39.564536] [001/165] (960s left) i915_module_load (load) [39.793703] Starting subtest: load [42.370355] Subtest load: SUCCESS (2.577s) [42.482335] [002/165] (957s left) core_auth (basic-auth) [42.824746] Starting subtest: basic-auth [42.844844] Subtest basic-auth: SUCCESS (0.002s) [42.931262] [003/165] (957s left) debugfs_test (read_all_entries) [43.188693] Starting subtest: read_all_entries [43.727880] Subtest read_all_entries: SUCCESS (0.544s) [43.948779] [004/165] (956s left) debugfs_test (basic-hwmon) [44.194208] Starting subtest: basic-hwmon [44.242642] Subtest basic-hwmon: SKIP (0.000s) [44.382191] [005/165] (956s left) fbdev (eof) [44.607771] Starting subtest: eof [44.628562] Subtest eof: SUCCESS (0.002s) [44.743557] [006/165] (955s left) fbdev (info) [44.957759] Starting subtest: info [44.978339] Subtest info: SUCCESS (0.000s) [45.094548] [007/165] (955s left) fbdev (nullptr) [45.304638] Starting subtest: nullptr [45.327722] Subtest nullptr: SUCCESS (0.000s) [45.444728] [008/165] (955s left) fbdev (read) [45.654876] Starting subtest: read [47.112508] Subtest read: SUCCESS (1.476s) [47.229217] [009/165] (953s left) fbdev (write) [47.438979] Starting subtest: write [48.197523] Subtest write: SUCCESS (0.761s) [48.314263] [010/165] (952s left) gem_basic (bad-close) [48.547211] Starting subtest: bad-close [48.590652] Subtest bad-close: SUCCESS (0.000s) [48.686609] [011/165] (952s left) gem_basic (create-close) [48.913230] Starting subtest: create-close [48.958566] Subtest create-close: SUCCESS (0.000s) [49.052747] [012/165] (951s left) gem_basic (create-fd-close) [49.281990] Starting subtest: create-fd-close [49.324271] Subtest create-fd-close: SUCCESS (0.000s) [49.417201] [013/165] (951s left) gem_busy (busy@all-engines) [49.657972] Starting subtest: busy [49.678390] Starting dynamic subtest: all-engines [49.749955] Dynamic subtest all-engines: SUCCESS (0.092s) [49.771987] Subtest busy: SUCCESS (0.093s) [50.173144] [014/165] (951s left) gem_close_race (basic-process) [50.433370] Starting subtest: basic-process [50.515351] Subtest basic-process: SUCCESS (0.102s) [50.748520] [015/165] (950s left) gem_close_race (basic-threads) [50.984115] Starting subtest: basic-threads [52.177286] Subtest basic-threads: SUCCESS (1.187s) [52.391779] [016/165] (949s left) gem_ctx_create (basic) [52.634263] Starting subtest: basic [52.655085] Subtest basic: SUCCESS (0.000s) [52.859282] [017/165] (948s left) gem_ctx_create (basic-files) [53.087893] Starting subtest: basic-files [55.129962] Subtest basic-files: SUCCESS (2.036s) [55.383270] [018/165] (946s left) gem_ctx_exec (basic) [55.651346] Starting subtest: basic [55.675339] Subtest basic: SUCCESS (0.007s) [55.798965] [019/165] (945s left) gem_exec_basic (basic) [56.039683] Starting subtest: basic [56.061644] Starting dynamic subtest: rcs0-smem [56.082617] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [56.123843] Starting dynamic subtest: bcs0-smem [56.146600] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [56.189089] Starting dynamic subtest: vcs0-smem [56.209688] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [56.252230] Starting dynamic subtest: vecs0-smem [56.275433] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [56.297203] Subtest basic: SUCCESS (0.010s) [56.394339] [020/165] (945s left) gem_exec_create (basic) [56.632811] Starting subtest: basic [56.654572] Starting dynamic subtest: smem [58.698795] Dynamic subtest smem: SUCCESS (2.069s) [58.721859] Subtest basic: SUCCESS (2.069s) [58.925458] [021/165] (942s left) gem_exec_fence (basic-busy) [59.286565] Starting subtest: basic-busy [59.308046] Starting dynamic subtest: rcs0 [59.351229] Dynamic subtest rcs0: SUCCESS (0.031s) [59.393486] Starting dynamic subtest: bcs0 [59.438636] Dynamic subtest bcs0: SUCCESS (0.031s) [59.480584] Starting dynamic subtest: vcs0 [59.522481] Dynamic subtest vcs0: SUCCESS (0.032s) [59.566844] Starting dynamic subtest: vecs0 [59.607958] Dynamic subtest vecs0: SUCCESS (0.022s) [59.629598] Subtest basic-busy: SUCCESS (0.116s) [60.209294] [022/165] (941s left) gem_exec_fence (basic-wait) [60.560833] Starting subtest: basic-wait [60.581933] Starting dynamic subtest: rcs0 [60.604056] Dynamic subtest rcs0: SUCCESS (0.032s) [60.649593] Starting dynamic subtest: bcs0 [60.669437] Dynamic subtest bcs0: SUCCESS (0.025s) [60.711307] Starting dynamic subtest: vcs0 [60.733565] Dynamic subtest vcs0: SUCCESS (0.024s) [60.775704] Starting dynamic subtest: vecs0 [60.795626] Dynamic subtest vecs0: SUCCESS (0.026s) [60.816854] Subtest basic-wait: SUCCESS (0.107s) [61.375290] [023/165] (940s left) gem_exec_fence (basic-await) [61.730380] Starting subtest: basic-await [61.751213] Starting dynamic subtest: rcs0 [61.863935] Dynamic subtest rcs0: SUCCESS (0.136s) [61.911984] Starting dynamic subtest: bcs0 [61.993058] Dynamic subtest bcs0: SUCCESS (0.129s) [62.040348] Starting dynamic subtest: vcs0 [62.129621] Dynamic subtest vcs0: SUCCESS (0.135s) [62.175202] Starting dynamic subtest: vecs0 [62.260664] Dynamic subtest vecs0: SUCCESS (0.129s) [62.281660] Subtest basic-await: SUCCESS (0.532s) [62.959773] [024/165] (939s left) gem_exec_fence (nb-await) [63.314762] Starting subtest: nb-await [63.336666] Starting dynamic subtest: rcs0 [63.395031] Dynamic subtest rcs0: SUCCESS (0.080s) [63.439299] Starting dynamic subtest: bcs0 [63.483965] Dynamic subtest bcs0: SUCCESS (0.071s) [63.527869] Starting dynamic subtest: vcs0 [63.549447] Dynamic subtest vcs0: SUCCESS (0.070s) [63.592692] Starting dynamic subtest: vecs0 [63.615321] Dynamic subtest vecs0: SUCCESS (0.070s) [63.636377] Subtest nb-await: SUCCESS (0.293s) [64.309612] [025/165] (937s left) gem_exec_gttfill (basic) [64.546768] Starting subtest: basic [86.497824] Subtest basic: SUCCESS (21.787s) [86.600474] [026/165] (915s left) gem_exec_parallel (engines) [86.986175] Starting subtest: engines [87.006807] Starting dynamic subtest: basic [90.735473] Dynamic subtest basic: SUCCESS (3.581s) [90.783846] Starting dynamic subtest: contexts [95.197950] Dynamic subtest contexts: SUCCESS (4.481s) [95.245775] Starting dynamic subtest: fds [101.684818] Dynamic subtest fds: SUCCESS (6.403s) [101.730798] Starting dynamic subtest: userptr [105.372281] Dynamic subtest userptr: SUCCESS (3.746s) [105.392506] Subtest engines: SUCCESS (18.213s) [105.507861] [027/165] (896s left) gem_exec_store (basic) [105.815696] Starting subtest: basic [105.839277] Subtest basic: SUCCESS (0.065s) [106.044973] [028/165] (896s left) gem_flink_basic (bad-flink) [106.276948] Starting subtest: bad-flink [106.299909] Subtest bad-flink: SUCCESS (0.000s) [106.399124] [029/165] (896s left) gem_flink_basic (bad-open) [106.627692] Starting subtest: bad-open [106.647975] Subtest bad-open: SUCCESS (0.000s) [106.749780] [030/165] (896s left) gem_flink_basic (basic) [106.985370] Starting subtest: basic [107.005316] Subtest basic: SUCCESS (0.000s) [107.105567] [031/165] (895s left) gem_flink_basic (double-flink) [107.335091] Starting subtest: double-flink [107.357975] Subtest double-flink: SUCCESS (0.000s) [107.455564] [032/165] (895s left) gem_flink_basic (flink-lifetime) [107.682227] Starting subtest: flink-lifetime [107.702182] Subtest flink-lifetime: SUCCESS (0.003s) [107.802684] [033/165] (895s left) gem_huc_copy (huc-copy) [108.031175] Starting subtest: huc-copy [108.052603] Subtest huc-copy: SUCCESS (0.005s) [108.163621] [034/165] (894s left) gem_linear_blits (basic) [108.550397] Starting subtest: basic [108.572733] Subtest basic: SUCCESS (0.019s) [108.752702] [035/165] (894s left) gem_mmap (basic) [109.145978] Starting subtest: basic [109.255451] Subtest basic: SUCCESS (0.001s) [109.354193] [036/165] (893s left) gem_mmap_gtt (basic) [109.600873] Starting subtest: basic [109.625325] Subtest basic: SUCCESS (0.001s) [109.854337] [037/165] (893s left) gem_render_linear_blits (basic) [110.116295] Starting subtest: basic [110.254610] Subtest basic: SUCCESS (0.087s) [110.384997] [038/165] (893s left) gem_render_tiled_blits (basic) [110.633505] Starting subtest: basic [110.759815] Subtest basic: SUCCESS (0.117s) [110.860428] [039/165] (892s left) gem_ringfill (basic-all) [111.380546] Starting subtest: basic-all [112.557847] Subtest basic-all: SUCCESS (1.206s) [112.712670] [040/165] (891s left) gem_softpin (allocator-basic) [112.950529] Starting subtest: allocator-basic [113.165825] Subtest allocator-basic: SUCCESS (0.239s) [113.312208] [041/165] (890s left) gem_softpin (allocator-basic-reserve) [113.542455] Starting subtest: allocator-basic-reserve [113.754140] Subtest allocator-basic-reserve: SUCCESS (0.234s) [113.911711] [042/165] (890s left) gem_softpin (safe-alignment) [114.141677] Starting subtest: safe-alignment [114.162554] Subtest safe-alignment: SUCCESS (0.030s) [114.311703] [043/165] (889s left) gem_sync (basic-all) [114.722653] Starting subtest: basic-all [116.612594] Subtest basic-all: SUCCESS (2.052s) [116.831546] [044/165] (887s left) gem_sync (basic-each) [117.240522] Starting subtest: basic-each [119.271057] Subtest basic-each: SUCCESS (2.201s) [119.494751] [045/165] (884s left) gem_tiled_blits (basic) [119.866242] Starting subtest: basic [119.919171] Subtest basic: SUCCESS (0.050s) [120.117282] [046/165] (884s left) gem_tiled_fence_blits (basic) [120.680464] Starting subtest: basic [120.724807] Subtest basic: SUCCESS (0.041s) [120.933437] [047/165] (883s left) gem_tiled_pread_basic [121.680262] [048/165] (882s left) gem_wait (busy@all-engines) [121.941235] Starting subtest: busy [121.964442] Starting dynamic subtest: all-engines [122.463209] Dynamic subtest all-engines: SUCCESS (0.530s) [122.485778] Subtest busy: SUCCESS (0.531s) [122.731712] [049/165] (881s left) gem_wait (wait@all-engines) [122.963144] Starting subtest: wait [122.983885] Starting dynamic subtest: all-engines [124.003860] Dynamic subtest all-engines: SUCCESS (1.042s) [124.024557] Subtest wait: SUCCESS (1.042s) [124.259090] [050/165] (880s left) i915_getparams_basic (basic-eu-total) [124.486358] Starting subtest: basic-eu-total [124.530051] Subtest basic-eu-total: SUCCESS (0.000s) [124.628783] [051/165] (880s left) i915_getparams_basic (basic-subslice-total) [124.858976] Starting subtest: basic-subslice-total [124.899741] Subtest basic-subslice-total: SUCCESS (0.000s) [125.011116] [052/165] (879s left) i915_hangman (error-state-basic) [125.250292] Starting subtest: error-state-basic [125.583826] Subtest error-state-basic: SUCCESS (0.327s) [125.707627] [053/165] (879s left) i915_pciid [126.134791] [054/165] (878s left) kms_addfb_basic (addfb25-4-tiled) [126.536170] Starting subtest: addfb25-4-tiled [126.558209] Subtest addfb25-4-tiled: SUCCESS (0.001s) [126.660335] [055/165] (878s left) kms_addfb_basic (addfb25-bad-modifier) [126.891552] Starting subtest: addfb25-bad-modifier [126.912581] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [127.094413] [056/165] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [127.328721] Starting subtest: addfb25-framebuffer-vs-set-tiling [127.349453] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [127.528475] [057/165] (877s left) kms_addfb_basic (addfb25-modifier-no-flag) [127.757861] Starting subtest: addfb25-modifier-no-flag [127.778617] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [127.963292] [058/165] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy) [128.182970] Starting subtest: addfb25-x-tiled-legacy [128.206284] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [128.379739] [059/165] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [128.615249] Starting subtest: addfb25-x-tiled-mismatch-legacy [128.637178] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [128.829567] [060/165] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [129.132933] Starting subtest: addfb25-yf-tiled-legacy [129.154270] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [129.265684] [061/165] (876s left) kms_addfb_basic (addfb25-y-tiled-legacy) [129.587744] Starting subtest: addfb25-y-tiled-legacy [129.610906] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [129.711707] [062/165] (876s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [130.036204] Starting subtest: addfb25-y-tiled-small-legacy [130.056799] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [130.162580] [063/165] (875s left) kms_addfb_basic (bad-pitch-0) [130.399470] Starting subtest: bad-pitch-0 [130.424461] Subtest bad-pitch-0: SUCCESS (0.000s) [130.612637] [064/165] (875s left) kms_addfb_basic (bad-pitch-1024) [130.845209] Starting subtest: bad-pitch-1024 [130.865287] Subtest bad-pitch-1024: SUCCESS (0.000s) [131.048076] [065/165] (875s left) kms_addfb_basic (bad-pitch-128) [131.281895] Starting subtest: bad-pitch-128 [131.302697] Subtest bad-pitch-128: SUCCESS (0.000s) [131.480601] [066/165] (874s left) kms_addfb_basic (bad-pitch-256) [131.713031] Starting subtest: bad-pitch-256 [131.733081] Subtest bad-pitch-256: SUCCESS (0.000s) [131.915872] [067/165] (874s left) kms_addfb_basic (bad-pitch-32) [132.152174] Starting subtest: bad-pitch-32 [132.174907] Subtest bad-pitch-32: SUCCESS (0.000s) [132.365579] [068/165] (874s left) kms_addfb_basic (bad-pitch-63) [132.596467] Starting subtest: bad-pitch-63 [132.619305] Subtest bad-pitch-63: SUCCESS (0.000s) [132.796648] [069/165] (873s left) kms_addfb_basic (bad-pitch-65536) [133.029298] Starting subtest: bad-pitch-65536 [133.050858] Subtest bad-pitch-65536: SUCCESS (0.001s) [133.226697] [070/165] (873s left) kms_addfb_basic (bad-pitch-999) [133.457289] Starting subtest: bad-pitch-999 [133.477148] Subtest bad-pitch-999: SUCCESS (0.000s) [133.663470] [071/165] (873s left) kms_addfb_basic (basic) [133.890892] Starting subtest: basic [133.910434] Subtest basic: SUCCESS (0.000s) [134.098490] [072/165] (872s left) kms_addfb_basic (basic-x-tiled-legacy) [134.355533] Starting subtest: basic-x-tiled-legacy [134.384646] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [134.552377] [073/165] (872s left) kms_addfb_basic (basic-y-tiled-legacy) [134.821102] Starting subtest: basic-y-tiled-legacy [134.850849] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [135.031472] [074/165] (871s left) kms_addfb_basic (bo-too-small) [135.368346] Starting subtest: bo-too-small [135.397167] Subtest bo-too-small: SUCCESS (0.001s) [135.525293] [075/165] (871s left) kms_addfb_basic (bo-too-small-due-to-tiling) [135.847075] Starting subtest: bo-too-small-due-to-tiling [135.869927] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [135.971285] [076/165] (871s left) kms_addfb_basic (clobberred-modifier) [136.207561] Starting subtest: clobberred-modifier [136.229086] Subtest clobberred-modifier: SUCCESS (0.000s) [136.413202] [077/165] (870s left) kms_addfb_basic (framebuffer-vs-set-tiling) [136.648585] Starting subtest: framebuffer-vs-set-tiling [136.670796] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [136.845590] [078/165] (870s left) kms_addfb_basic (invalid-get-prop) [137.077113] Starting subtest: invalid-get-prop [137.098046] Subtest invalid-get-prop: SUCCESS (0.000s) [137.277542] [079/165] (870s left) kms_addfb_basic (invalid-get-prop-any) [137.510400] Starting subtest: invalid-get-prop-any [137.530441] Subtest invalid-get-prop-any: SUCCESS (0.000s) [137.712366] [080/165] (869s left) kms_addfb_basic (invalid-set-prop) [137.942970] Starting subtest: invalid-set-prop [137.962840] Subtest invalid-set-prop: SUCCESS (0.000s) [138.132645] [081/165] (869s left) kms_addfb_basic (invalid-set-prop-any) [138.363388] Starting subtest: invalid-set-prop-any [138.391292] Subtest invalid-set-prop-any: SUCCESS (0.000s) [138.576798] [082/165] (869s left) kms_addfb_basic (no-handle) [138.811252] Starting subtest: no-handle [138.836127] Subtest no-handle: SUCCESS (0.000s) [139.009909] [083/165] (868s left) kms_addfb_basic (size-max) [139.331989] Starting subtest: size-max [139.353577] Subtest size-max: SUCCESS (0.000s) [139.460349] [084/165] (868s left) kms_addfb_basic (small-bo) [139.782505] Starting subtest: small-bo [139.805514] Subtest small-bo: SUCCESS (0.000s) [139.905840] [085/165] (868s left) kms_addfb_basic (tile-pitch-mismatch) [140.138318] Starting subtest: tile-pitch-mismatch [140.158386] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [140.349622] [086/165] (867s left) kms_addfb_basic (too-high) [140.650086] Starting subtest: too-high [140.670440] Subtest too-high: SUCCESS (0.002s) [140.780356] [087/165] (867s left) kms_addfb_basic (too-wide) [141.103602] Starting subtest: too-wide [141.132776] Subtest too-wide: SUCCESS (0.000s) [141.235407] [088/165] (867s left) kms_addfb_basic (unused-handle) [141.468092] Starting subtest: unused-handle [141.490673] Subtest unused-handle: SUCCESS (0.000s) [141.664626] [089/165] (866s left) kms_addfb_basic (unused-modifier) [141.902226] Starting subtest: unused-modifier [141.924805] Subtest unused-modifier: SUCCESS (0.000s) [142.112323] [090/165] (866s left) kms_addfb_basic (unused-offsets) [142.345334] Starting subtest: unused-offsets [142.366321] Subtest unused-offsets: SUCCESS (0.000s) [142.546704] [091/165] (866s left) kms_addfb_basic (unused-pitches) [142.776088] Starting subtest: unused-pitches [142.795961] Subtest unused-pitches: SUCCESS (0.000s) [142.998450] [092/165] (865s left) kms_busy (basic) [143.327977] Starting subtest: basic [143.354297] Starting dynamic subtest: flip [144.392565] Dynamic subtest flip: SUCCESS (1.049s) [144.466394] Starting dynamic subtest: modeset [145.743430] Dynamic subtest modeset: SUCCESS (1.368s) [145.763548] Subtest basic: SUCCESS (2.421s) [146.144458] [093/165] (862s left) kms_prop_blob (basic) [146.388915] Starting subtest: basic [146.411368] Subtest basic: SUCCESS (0.000s) [146.514240] [094/165] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [146.828754] Starting subtest: basic-busy-flip-before-cursor-atomic [146.871658] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [146.983834] [095/165] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [147.282918] Starting subtest: basic-busy-flip-before-cursor-legacy [147.327660] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [147.435356] [096/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [147.739268] Starting subtest: basic-flip-after-cursor-atomic [148.794866] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.057s) [149.182396] [097/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [149.511222] Starting subtest: basic-flip-after-cursor-legacy [150.568255] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.058s) [150.923592] [098/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [151.223109] Starting subtest: basic-flip-after-cursor-varying-size [152.298121] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.070s) [152.673978] [099/165] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [152.973385] Starting subtest: basic-flip-before-cursor-atomic [154.018563] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.048s) [154.408450] [100/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [154.740420] Starting subtest: basic-flip-before-cursor-legacy [155.785499] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.056s) [156.171123] [101/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [156.493509] Starting subtest: basic-flip-before-cursor-varying-size [157.554936] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.079s) [157.927725] [102/165] (851s left) kms_dsc (dsc-basic) [158.256172] Subtest dsc-basic: SKIP (0.000s) [158.363135] [103/165] (851s left) kms_flip (basic-flip-vs-dpms) [158.698129] Starting subtest: basic-flip-vs-dpms [158.720750] Starting dynamic subtest: A-DP1 [159.943353] Dynamic subtest A-DP1: SUCCESS (1.257s) [159.993462] Starting dynamic subtest: B-DP1 [161.078177] Dynamic subtest B-DP1: SUCCESS (1.133s) [161.128117] Starting dynamic subtest: C-DP1 [162.215393] Dynamic subtest C-DP1: SUCCESS (1.133s) [162.237649] Subtest basic-flip-vs-dpms: SUCCESS (3.533s) [162.629326] [104/165] (847s left) kms_flip (basic-flip-vs-modeset) [162.967853] Starting subtest: basic-flip-vs-modeset [162.993654] Starting dynamic subtest: A-DP1 [164.236215] Dynamic subtest A-DP1: SUCCESS (1.285s) [164.286323] Starting dynamic subtest: B-DP1 [165.381165] Dynamic subtest B-DP1: SUCCESS (1.137s) [165.429664] Starting dynamic subtest: C-DP1 [166.497464] Dynamic subtest C-DP1: SUCCESS (1.126s) [166.518398] Subtest basic-flip-vs-modeset: SUCCESS (3.558s) [166.901375] [105/165] (843s left) kms_flip (basic-flip-vs-wf_vblank) [167.229960] Starting subtest: basic-flip-vs-wf_vblank [167.251361] Starting dynamic subtest: A-DP1 [168.681366] Dynamic subtest A-DP1: SUCCESS (1.459s) [168.729910] Starting dynamic subtest: B-DP1 [170.074858] Dynamic subtest B-DP1: SUCCESS (1.393s) [170.125937] Starting dynamic subtest: C-DP1 [171.471735] Dynamic subtest C-DP1: SUCCESS (1.394s) [171.495066] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.257s) [171.941964] [106/165] (838s left) kms_flip (basic-plain-flip) [172.264348] Starting subtest: basic-plain-flip [172.284854] Starting dynamic subtest: A-DP1 [173.426577] Dynamic subtest A-DP1: SUCCESS (1.156s) [173.488350] Starting dynamic subtest: B-DP1 [174.537229] Dynamic subtest B-DP1: SUCCESS (1.112s) [174.590209] Starting dynamic subtest: C-DP1 [175.638841] Dynamic subtest C-DP1: SUCCESS (1.107s) [175.659203] Subtest basic-plain-flip: SUCCESS (3.386s) [176.104711] [107/165] (834s left) kms_force_connector_basic (force-connector-state) [176.371241] Subtest force-connector-state: SKIP (0.000s) [176.479914] [108/165] (833s left) kms_force_connector_basic (force-edid) [176.737318] Subtest force-edid: SKIP (0.000s) [176.843546] [109/165] (833s left) kms_force_connector_basic (force-load-detect) [177.097174] Subtest force-load-detect: SKIP (0.000s) [177.204925] [110/165] (833s left) kms_force_connector_basic (prune-stale-modes) [177.464491] Subtest prune-stale-modes: SKIP (0.000s) [177.567841] [111/165] (833s left) kms_frontbuffer_tracking (basic) [177.970575] Starting subtest: basic [180.932769] Subtest basic: SUCCESS (3.033s) [181.071093] [112/165] (829s left) kms_hdmi_inject (inject-audio) [181.333449] Subtest inject-audio: SKIP (0.000s) [181.438812] [113/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [181.773893] Starting subtest: compare-crc-sanitycheck-xr24 [181.795492] Starting dynamic subtest: pipe-A-DP-1 [182.209466] Dynamic subtest pipe-A-DP-1: SUCCESS (0.434s) [182.260903] Starting dynamic subtest: pipe-B-DP-1 [182.800793] Dynamic subtest pipe-B-DP-1: SUCCESS (0.607s) [182.852879] Starting dynamic subtest: pipe-C-DP-1 [183.422661] Dynamic subtest pipe-C-DP-1: SUCCESS (0.614s) [183.444049] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.668s) [183.805754] [114/165] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [184.119481] Starting subtest: compare-crc-sanitycheck-nv12 [184.146715] Starting dynamic subtest: pipe-A-DP-1 [184.205092] Dynamic subtest pipe-A-DP-1: SKIP (0.001s) [184.259641] Starting dynamic subtest: pipe-B-DP-1 [184.313783] Dynamic subtest pipe-B-DP-1: SKIP (0.001s) [184.371120] Starting dynamic subtest: pipe-C-DP-1 [184.425222] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [184.482965] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s) [184.603139] [115/165] (826s left) kms_pipe_crc_basic (hang-read-crc) [185.120089] Starting subtest: hang-read-crc [185.148415] Starting dynamic subtest: pipe-A-DP-1 [186.600878] Dynamic subtest pipe-A-DP-1: SUCCESS (1.465s) [186.659343] Starting dynamic subtest: pipe-B-DP-1 [188.234148] Dynamic subtest pipe-B-DP-1: SUCCESS (1.631s) [188.284016] Starting dynamic subtest: pipe-C-DP-1 [189.855451] Dynamic subtest pipe-C-DP-1: SUCCESS (1.616s) [189.879263] Subtest hang-read-crc: SUCCESS (4.726s) [190.200892] [116/165] (821s left) kms_pipe_crc_basic (nonblocking-crc) [190.507391] Starting subtest: nonblocking-crc [190.527944] Starting dynamic subtest: pipe-A-DP-1 [191.098825] Dynamic subtest pipe-A-DP-1: SUCCESS (0.588s) [191.176994] Starting dynamic subtest: pipe-B-DP-1 [191.867399] Dynamic subtest pipe-B-DP-1: SUCCESS (0.762s) [191.947827] Starting dynamic subtest: pipe-C-DP-1 [192.621673] Dynamic subtest pipe-C-DP-1: SUCCESS (0.755s) [192.643194] Subtest nonblocking-crc: SUCCESS (2.119s) [192.981925] [117/165] (818s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [193.276347] Starting subtest: nonblocking-crc-frame-sequence [193.296661] Starting dynamic subtest: pipe-A-DP-1 [193.846107] Dynamic subtest pipe-A-DP-1: SUCCESS (0.560s) [193.928861] Starting dynamic subtest: pipe-B-DP-1 [194.628906] Dynamic subtest pipe-B-DP-1: SUCCESS (0.762s) [194.703457] Starting dynamic subtest: pipe-C-DP-1 [195.387358] Dynamic subtest pipe-C-DP-1: SUCCESS (0.772s) [195.409742] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.109s) [195.747622] [118/165] (815s left) kms_pipe_crc_basic (read-crc) [196.060481] Starting subtest: read-crc [196.083465] Starting dynamic subtest: pipe-A-DP-1 [196.605282] Dynamic subtest pipe-A-DP-1: SUCCESS (0.519s) [196.656926] Starting dynamic subtest: pipe-B-DP-1 [197.302949] Dynamic subtest pipe-B-DP-1: SUCCESS (0.693s) [197.355029] Starting dynamic subtest: pipe-C-DP-1 [197.988467] Dynamic subtest pipe-C-DP-1: SUCCESS (0.699s) [198.011119] Subtest read-crc: SUCCESS (1.925s) [198.361386] [119/165] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence) [198.676140] Starting subtest: read-crc-frame-sequence [198.699160] Starting dynamic subtest: pipe-A-DP-1 [199.193806] Dynamic subtest pipe-A-DP-1: SUCCESS (0.493s) [199.243207] Starting dynamic subtest: pipe-B-DP-1 [199.874327] Dynamic subtest pipe-B-DP-1: SUCCESS (0.676s) [199.948069] Starting dynamic subtest: pipe-C-DP-1 [200.545839] Dynamic subtest pipe-C-DP-1: SUCCESS (0.689s) [200.566472] Subtest read-crc-frame-sequence: SUCCESS (1.872s) [200.917080] [120/165] (810s left) kms_pm_backlight (basic-brightness) [201.251988] Subtest basic-brightness: SKIP (0.000s) [201.357693] [121/165] (810s left) kms_pm_rpm (basic-pci-d3-state) [203.156476] Starting subtest: basic-pci-d3-state [203.825358] Subtest basic-pci-d3-state: SUCCESS (0.639s) [204.043888] [122/165] (807s left) kms_pm_rpm (basic-rte) [204.267088] Starting subtest: basic-rte [206.448104] Subtest basic-rte: SUCCESS (2.184s) [207.407097] [123/165] (804s left) kms_psr (psr_primary_page_flip) [207.740615] Subtest psr_primary_page_flip: SKIP (0.000s) [207.847583] [124/165] (804s left) kms_psr (psr_cursor_plane_move) [208.174281] Subtest psr_cursor_plane_move: SKIP (0.000s) [208.285647] [125/165] (803s left) kms_psr (psr_sprite_plane_onoff) [208.587912] Subtest psr_sprite_plane_onoff: SKIP (0.000s) [208.698674] [126/165] (803s left) kms_psr (psr_primary_mmap_gtt) [209.004052] Subtest psr_primary_mmap_gtt: SKIP (0.000s) [209.119791] [127/165] (803s left) kms_setmode (basic-clone-single-crtc) [209.352671] Starting subtest: basic-clone-single-crtc [209.420989] Subtest basic-clone-single-crtc: SKIP (0.000s) [209.528626] [128/165] (802s left) i915_pm_rps (basic-api) [209.770521] Starting subtest: basic-api [209.790960] Subtest basic-api: SUCCESS (0.007s) [209.917966] [129/165] (802s left) prime_self_import (basic-llseek-bad) [210.138122] Starting subtest: basic-llseek-bad [210.180827] Subtest basic-llseek-bad: SUCCESS (0.004s) [210.287704] [130/165] (802s left) prime_self_import (basic-llseek-size) [210.478387] Starting subtest: basic-llseek-size [210.518948] Subtest basic-llseek-size: SUCCESS (0.006s) [210.625125] [131/165] (802s left) prime_self_import (basic-with_fd_dup) [210.841775] Starting subtest: basic-with_fd_dup [210.884609] Subtest basic-with_fd_dup: SUCCESS (0.006s) [210.993869] [132/165] (801s left) prime_self_import (basic-with_one_bo) [211.207893] Starting subtest: basic-with_one_bo [211.251418] Subtest basic-with_one_bo: SUCCESS (0.007s) [211.357253] [133/165] (801s left) prime_self_import (basic-with_one_bo_two_files) [211.543876] Starting subtest: basic-with_one_bo_two_files [211.590234] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s) [211.697718] [134/165] (801s left) prime_self_import (basic-with_two_bos) [211.907043] Starting subtest: basic-with_two_bos [211.948945] Subtest basic-with_two_bos: SUCCESS (0.006s) [212.056951] [135/165] (801s left) prime_vgem (basic-fence-flip) [212.324280] Starting subtest: basic-fence-flip [212.899458] Subtest basic-fence-flip: SUCCESS (0.594s) [213.053049] [136/165] (800s left) prime_vgem (basic-fence-mmap) [213.292596] Starting subtest: basic-fence-mmap [213.335949] Subtest basic-fence-mmap: SUCCESS (0.072s) [213.489730] [137/165] (799s left) prime_vgem (basic-fence-read) [213.780381] Starting subtest: basic-fence-read [213.847432] Subtest basic-fence-read: SUCCESS (0.108s) [214.000839] [138/165] (799s left) prime_vgem (basic-gtt) [214.273673] Starting subtest: basic-gtt [214.302807] Subtest basic-gtt: SUCCESS (0.034s) [214.449931] [139/165] (799s left) prime_vgem (basic-read) [214.711943] Starting subtest: basic-read [214.739987] Subtest basic-read: SUCCESS (0.054s) [214.882927] [140/165] (798s left) prime_vgem (basic-write) [215.157991] Starting subtest: basic-write [215.180031] Subtest basic-write: SUCCESS (0.064s) [215.309498] [141/165] (798s left) vgem_basic (setversion) [215.535811] Starting subtest: setversion [215.580301] Subtest setversion: SUCCESS (0.000s) [215.685429] [142/165] (798s left) vgem_basic (create) [215.920496] Starting subtest: create [215.941157] Subtest create: SUCCESS (0.000s) [216.048832] [143/165] (798s left) vgem_basic (debugfs) [216.282462] Starting subtest: debugfs [216.305202] Subtest debugfs: SUCCESS (0.006s) [216.413115] [144/165] (797s left) vgem_basic (dmabuf-export) [216.650455] Starting subtest: dmabuf-export [216.692640] Subtest dmabuf-export: SUCCESS (0.004s) [216.798577] [145/165] (797s left) vgem_basic (dmabuf-fence) [217.033447] Starting subtest: dmabuf-fence [217.055883] Subtest dmabuf-fence: SUCCESS (0.002s) [217.162302] [146/165] (797s left) vgem_basic (dmabuf-fence-before) [217.396690] Starting subtest: dmabuf-fence-before [217.418720] Subtest dmabuf-fence-before: SUCCESS (0.001s) [217.525959] [147/165] (797s left) vgem_basic (dmabuf-mmap) [217.759889] Starting subtest: dmabuf-mmap [217.781515] Subtest dmabuf-mmap: SUCCESS (0.042s) [217.889100] [148/165] (796s left) vgem_basic (mmap) [218.128656] Starting subtest: mmap [218.151389] Subtest mmap: SUCCESS (0.026s) [218.258909] [149/165] (796s left) vgem_basic (second-client) [218.491339] Starting subtest: second-client [218.534339] Subtest second-client: SUCCESS (0.033s) [218.642546] [150/165] (796s left) vgem_basic (sysfs) [218.874121] Starting subtest: sysfs [218.895586] Subtest sysfs: SUCCESS (0.002s) [219.003285] [151/165] (796s left) core_hotunplug (unbind-rebind) [219.335809] Starting subtest: unbind-rebind [225.079658] Subtest unbind-rebind: SUCCESS (5.753s) [225.149786] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1843 [max: 8192] direct dependencies: 18348 [max: 32768] indirect dependencies: 144715 all direct dependencies: 380892 dependency chains: 25856 [max: 131072] dependency chain hlocks used: 108525 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 247 in-softirq chains: 698 in-process chains: 24911 stack-trace entries: 180075 [max: 1048576] number of stack traces: 9031 number of stack hash chains: 6926 combined max dependencies: 23577728 hardirq-safe locks: 97 hardirq-unsafe locks: 1092 softirq-safe locks: 218 softirq-unsafe locks: 1005 irq-safe locks: 235 irq-unsafe locks: 1092 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 318 softirq-read-safe locks: 8 softirq-read-unsafe locks: 313 irq-read-safe locks: 8 irq-read-unsafe locks: 318 uncategorized locks: 311 unused locks: 1 max locking depth: 16 max bfs queue depth: 439 max lock class index: 1987 chain lookup misses: 29631 chain lookup hits: 98119889 cyclic checks: 29753 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4951 find-mask backwards checks: 3026 hardirq on events: 59790764 hardirq off events: 59790761 redundant hardirq ons: 22 redundant hardirq offs: 62 softirq on events: 609394 softirq off events: 609394 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 149 zapped lock chains: 3712 large chain blocks: 1 [225.176221] Closing watchdogs Done.