[45.296795] Initializing watchdogs [45.296883] /dev/watchdog0 [45.306214] [001/165] (960s left) i915_module_load (load) [45.378622] Starting subtest: load [47.636831] Subtest load: SUCCESS (2.258s) [47.658391] [002/165] (958s left) core_auth (basic-auth) [47.774045] Starting subtest: basic-auth [47.777149] Subtest basic-auth: SUCCESS (0.001s) [47.824420] [003/165] (958s left) debugfs_test (read_all_entries) [47.902422] Starting subtest: read_all_entries [48.038666] Subtest read_all_entries: SUCCESS (0.135s) [48.338576] [004/165] (957s left) debugfs_test (basic-hwmon) [48.422205] Starting subtest: basic-hwmon [48.428522] Subtest basic-hwmon: SKIP (0.000s) [48.708090] [005/165] (957s left) fbdev (eof) [48.789365] Starting subtest: eof [48.792651] Subtest eof: SUCCESS (0.000s) [48.839649] [006/165] (957s left) fbdev (info) [48.919481] Starting subtest: info [48.922653] Subtest info: SUCCESS (0.000s) [48.987314] [007/165] (956s left) fbdev (nullptr) [49.054440] Starting subtest: nullptr [49.057834] Subtest nullptr: SUCCESS (0.000s) [49.107986] [008/165] (956s left) fbdev (read) [49.186727] Starting subtest: read [49.444266] Subtest read: SUCCESS (0.257s) [49.487222] [009/165] (956s left) fbdev (write) [49.554276] Starting subtest: write [49.687211] Subtest write: SUCCESS (0.134s) [49.738474] [010/165] (956s left) gem_basic (bad-close) [49.805305] Starting subtest: bad-close [49.811963] Subtest bad-close: SUCCESS (0.000s) [49.871359] [011/165] (956s left) gem_basic (create-close) [49.948697] Starting subtest: create-close [49.954461] Subtest create-close: SUCCESS (0.000s) [50.029180] [012/165] (956s left) gem_basic (create-fd-close) [50.114977] Starting subtest: create-fd-close [50.121048] Subtest create-fd-close: SUCCESS (0.000s) [50.189563] [013/165] (955s left) gem_busy (busy@all-engines) [50.270389] Starting subtest: busy [50.273234] Starting dynamic subtest: all-engines [50.324507] Dynamic subtest all-engines: SUCCESS (0.054s) [50.327621] Subtest busy: SUCCESS (0.055s) [50.708503] [014/165] (955s left) gem_close_race (basic-process) [50.807365] Starting subtest: basic-process [50.867596] Subtest basic-process: SUCCESS (0.060s) [51.089096] [015/165] (955s left) gem_close_race (basic-threads) [51.166800] Starting subtest: basic-threads [52.307830] Subtest basic-threads: SUCCESS (1.141s) [52.516286] [016/165] (953s left) gem_ctx_create (basic) [52.615514] Starting subtest: basic [52.618832] Subtest basic: SUCCESS (0.000s) [52.813914] [017/165] (953s left) gem_ctx_create (basic-files) [52.917158] Starting subtest: basic-files [54.933218] Subtest basic-files: SUCCESS (2.017s) [55.162424] [018/165] (951s left) gem_ctx_exec (basic) [55.229767] Starting subtest: basic [55.233663] Subtest basic: SUCCESS (0.003s) [55.362945] [019/165] (950s left) gem_exec_basic (basic) [55.435016] Starting subtest: basic [55.438166] Starting dynamic subtest: rcs0-smem [55.441338] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.449297] Starting dynamic subtest: bcs0-smem [55.452740] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [55.461068] Starting dynamic subtest: vcs0-smem [55.464569] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.473058] Starting dynamic subtest: vcs1-smem [55.476771] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [55.485031] Starting dynamic subtest: vecs0-smem [55.488252] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [55.491636] Subtest basic: SUCCESS (0.004s) [55.663938] [020/165] (950s left) gem_exec_create (basic) [55.761500] Starting subtest: basic [55.764575] Starting dynamic subtest: smem [57.807957] Dynamic subtest smem: SUCCESS (2.049s) [57.811322] Subtest basic: SUCCESS (2.049s) [58.007330] [021/165] (948s left) gem_exec_fence (basic-busy) [58.218223] Starting subtest: basic-busy [58.222731] Starting dynamic subtest: rcs0 [58.245425] Dynamic subtest rcs0: SUCCESS (0.026s) [58.261687] Starting dynamic subtest: bcs0 [58.278901] Dynamic subtest bcs0: SUCCESS (0.035s) [58.289127] Starting dynamic subtest: vcs0 [58.301516] Dynamic subtest vcs0: SUCCESS (0.023s) [58.310701] Starting dynamic subtest: vcs1 [58.324265] Dynamic subtest vcs1: SUCCESS (0.023s) [58.333469] Starting dynamic subtest: vecs0 [58.344301] Dynamic subtest vecs0: SUCCESS (0.020s) [58.347781] Subtest basic-busy: SUCCESS (0.128s) [59.014437] [022/165] (947s left) gem_exec_fence (basic-wait) [59.237627] Starting subtest: basic-wait [59.244394] Starting dynamic subtest: rcs0 [59.260421] Dynamic subtest rcs0: SUCCESS (0.021s) [59.273888] Starting dynamic subtest: bcs0 [59.285494] Dynamic subtest bcs0: SUCCESS (0.026s) [59.294231] Starting dynamic subtest: vcs0 [59.303249] Dynamic subtest vcs0: SUCCESS (0.018s) [59.312404] Starting dynamic subtest: vcs1 [59.324229] Dynamic subtest vcs1: SUCCESS (0.021s) [59.332138] Starting dynamic subtest: vecs0 [59.352347] Dynamic subtest vecs0: SUCCESS (0.028s) [59.355607] Subtest basic-wait: SUCCESS (0.116s) [59.964151] [023/165] (946s left) gem_exec_fence (basic-await) [60.167789] Starting subtest: basic-await [60.171537] Starting dynamic subtest: rcs0 [60.281987] Dynamic subtest rcs0: SUCCESS (0.114s) [60.291846] Starting dynamic subtest: bcs0 [60.385126] Dynamic subtest bcs0: SUCCESS (0.103s) [60.398476] Starting dynamic subtest: vcs0 [60.492849] Dynamic subtest vcs0: SUCCESS (0.107s) [60.505621] Starting dynamic subtest: vcs1 [60.605760] Dynamic subtest vcs1: SUCCESS (0.113s) [60.615587] Starting dynamic subtest: vecs0 [60.714329] Dynamic subtest vecs0: SUCCESS (0.109s) [60.717733] Subtest basic-await: SUCCESS (0.547s) [61.345806] [024/165] (945s left) gem_exec_fence (nb-await) [61.558857] Starting subtest: nb-await [61.562868] Starting dynamic subtest: rcs0 [61.636675] Dynamic subtest rcs0: SUCCESS (0.074s) [61.656823] Starting dynamic subtest: bcs0 [61.714414] Dynamic subtest bcs0: SUCCESS (0.078s) [61.736823] Starting dynamic subtest: vcs0 [61.789270] Dynamic subtest vcs0: SUCCESS (0.075s) [61.809946] Starting dynamic subtest: vcs1 [61.866375] Dynamic subtest vcs1: SUCCESS (0.076s) [61.882659] Starting dynamic subtest: vecs0 [61.934118] Dynamic subtest vecs0: SUCCESS (0.069s) [61.938171] Subtest nb-await: SUCCESS (0.375s) [62.617339] [025/165] (943s left) gem_exec_gttfill (basic) [62.717066] Starting subtest: basic [67.209227] Subtest basic: SUCCESS (4.493s) [67.388149] [026/165] (939s left) gem_exec_parallel (engines) [67.535377] Starting subtest: engines [67.539200] Starting dynamic subtest: basic [69.623285] Dynamic subtest basic: SUCCESS (1.991s) [69.694952] Starting dynamic subtest: contexts [74.132903] Dynamic subtest contexts: SUCCESS (4.606s) [74.142059] Starting dynamic subtest: fds [80.073159] Dynamic subtest fds: SUCCESS (5.940s) [80.081928] Starting dynamic subtest: userptr [82.104555] Dynamic subtest userptr: SUCCESS (2.032s) [82.107868] Subtest engines: SUCCESS (14.569s) [82.318965] [027/165] (924s left) gem_exec_store (basic) [82.410748] Starting subtest: basic [82.459294] Subtest basic: SUCCESS (0.052s) [82.662895] [028/165] (923s left) gem_flink_basic (bad-flink) [82.751555] Starting subtest: bad-flink [82.755105] Subtest bad-flink: SUCCESS (0.000s) [82.807916] [029/165] (923s left) gem_flink_basic (bad-open) [82.875569] Starting subtest: bad-open [82.878820] Subtest bad-open: SUCCESS (0.000s) [82.941806] [030/165] (923s left) gem_flink_basic (basic) [83.013381] Starting subtest: basic [83.016660] Subtest basic: SUCCESS (0.000s) [83.099320] [031/165] (923s left) gem_flink_basic (double-flink) [83.176278] Starting subtest: double-flink [83.179634] Subtest double-flink: SUCCESS (0.000s) [83.257822] [032/165] (923s left) gem_flink_basic (flink-lifetime) [83.346308] Starting subtest: flink-lifetime [83.349624] Subtest flink-lifetime: SUCCESS (0.001s) [83.436437] [033/165] (923s left) gem_huc_copy (huc-copy) [83.531743] Starting subtest: huc-copy [83.538270] Subtest huc-copy: SKIP (0.000s) [83.645378] [034/165] (923s left) gem_linear_blits (basic) [83.830933] Starting subtest: basic [83.840613] Subtest basic: SUCCESS (0.008s) [83.986075] [035/165] (922s left) gem_mmap (basic) [84.133291] Starting subtest: basic [84.149270] Subtest basic: SUCCESS (0.000s) [84.227169] [036/165] (922s left) gem_mmap_gtt (basic) [84.310856] Starting subtest: basic [84.314342] Subtest basic: SUCCESS (0.001s) [84.364966] [037/165] (922s left) gem_render_linear_blits (basic) [84.436288] Starting subtest: basic [84.467306] Subtest basic: SUCCESS (0.031s) [84.514682] [038/165] (922s left) gem_render_tiled_blits (basic) [84.579087] Starting subtest: basic [84.613109] Subtest basic: SUCCESS (0.034s) [84.648138] [039/165] (922s left) gem_ringfill (basic-all) [84.925965] Starting subtest: basic-all [86.086662] Subtest basic-all: SUCCESS (1.158s) [86.186951] [040/165] (920s left) gem_softpin (allocator-basic) [86.278427] Starting subtest: allocator-basic [86.385306] Subtest allocator-basic: SUCCESS (0.107s) [86.500585] [041/165] (920s left) gem_softpin (allocator-basic-reserve) [86.591350] Starting subtest: allocator-basic-reserve [86.703530] Subtest allocator-basic-reserve: SUCCESS (0.113s) [86.827065] [042/165] (920s left) gem_softpin (safe-alignment) [86.906882] Starting subtest: safe-alignment [86.913179] Subtest safe-alignment: SUCCESS (0.014s) [87.031759] [043/165] (919s left) gem_sync (basic-all) [87.130187] Starting subtest: basic-all [89.342623] Subtest basic-all: SUCCESS (2.232s) [89.550488] [044/165] (917s left) gem_sync (basic-each) [89.666289] Starting subtest: basic-each [91.843463] Subtest basic-each: SUCCESS (2.193s) [92.047709] [045/165] (915s left) gem_tiled_blits (basic) [92.281596] Starting subtest: basic [92.301628] Subtest basic: SUCCESS (0.018s) [92.445513] [046/165] (914s left) gem_tiled_fence_blits (basic) [92.729688] Starting subtest: basic [92.741727] Subtest basic: SUCCESS (0.011s) [92.891305] [047/165] (914s left) gem_tiled_pread_basic [93.265963] [048/165] (913s left) gem_wait (busy@all-engines) [93.367131] Starting subtest: busy [93.370509] Starting dynamic subtest: all-engines [93.888243] Dynamic subtest all-engines: SUCCESS (0.523s) [93.891456] Subtest busy: SUCCESS (0.523s) [94.132534] [049/165] (913s left) gem_wait (wait@all-engines) [94.230630] Starting subtest: wait [94.236304] Starting dynamic subtest: all-engines [95.264255] Dynamic subtest all-engines: SUCCESS (1.030s) [95.267398] Subtest wait: SUCCESS (1.030s) [95.517646] [050/165] (911s left) i915_getparams_basic (basic-eu-total) [95.606530] Starting subtest: basic-eu-total [95.613195] Subtest basic-eu-total: SUCCESS (0.000s) [95.680086] [051/165] (911s left) i915_getparams_basic (basic-subslice-total) [95.766868] Starting subtest: basic-subslice-total [95.773228] Subtest basic-subslice-total: SUCCESS (0.000s) [95.827105] [052/165] (911s left) i915_hangman (error-state-basic) [95.907993] Starting subtest: error-state-basic [95.917120] Subtest error-state-basic: SUCCESS (0.005s) [96.016044] [053/165] (911s left) i915_pciid [96.157295] [054/165] (911s left) kms_addfb_basic (addfb25-4-tiled) [96.448538] Starting subtest: addfb25-4-tiled [96.451728] Subtest addfb25-4-tiled: SUCCESS (0.000s) [96.525163] [055/165] (910s left) kms_addfb_basic (addfb25-bad-modifier) [96.598484] Starting subtest: addfb25-bad-modifier [96.601611] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [96.893565] [056/165] (910s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [96.972592] Starting subtest: addfb25-framebuffer-vs-set-tiling [96.975968] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [97.270580] [057/165] (910s left) kms_addfb_basic (addfb25-modifier-no-flag) [97.360696] Starting subtest: addfb25-modifier-no-flag [97.363920] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [97.662852] [058/165] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy) [97.751865] Starting subtest: addfb25-x-tiled-legacy [97.755259] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [98.036251] [059/165] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [98.103137] Starting subtest: addfb25-x-tiled-mismatch-legacy [98.106249] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [98.389115] [060/165] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [98.661827] Starting subtest: addfb25-yf-tiled-legacy [98.665086] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [98.742076] [061/165] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy) [99.023803] Starting subtest: addfb25-y-tiled-legacy [99.026733] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [99.108397] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [99.397596] Starting subtest: addfb25-y-tiled-small-legacy [99.400326] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [99.472746] [063/165] (908s left) kms_addfb_basic (bad-pitch-0) [99.542176] Starting subtest: bad-pitch-0 [99.545489] Subtest bad-pitch-0: SUCCESS (0.000s) [99.848226] [064/165] (907s left) kms_addfb_basic (bad-pitch-1024) [99.941115] Starting subtest: bad-pitch-1024 [99.944136] Subtest bad-pitch-1024: SUCCESS (0.000s) [100.240828] [065/165] (907s left) kms_addfb_basic (bad-pitch-128) [100.312926] Starting subtest: bad-pitch-128 [100.316305] Subtest bad-pitch-128: SUCCESS (0.000s) [100.607152] [066/165] (907s left) kms_addfb_basic (bad-pitch-256) [100.680512] Starting subtest: bad-pitch-256 [100.683513] Subtest bad-pitch-256: SUCCESS (0.000s) [100.973601] [067/165] (906s left) kms_addfb_basic (bad-pitch-32) [101.042246] Starting subtest: bad-pitch-32 [101.045378] Subtest bad-pitch-32: SUCCESS (0.000s) [101.341027] [068/165] (906s left) kms_addfb_basic (bad-pitch-63) [101.419857] Starting subtest: bad-pitch-63 [101.423319] Subtest bad-pitch-63: SUCCESS (0.000s) [101.728756] [069/165] (906s left) kms_addfb_basic (bad-pitch-65536) [101.818710] Starting subtest: bad-pitch-65536 [101.821584] Subtest bad-pitch-65536: SUCCESS (0.000s) [102.109901] [070/165] (905s left) kms_addfb_basic (bad-pitch-999) [102.186179] Starting subtest: bad-pitch-999 [102.189046] Subtest bad-pitch-999: SUCCESS (0.000s) [102.472206] [071/165] (905s left) kms_addfb_basic (basic) [102.541136] Starting subtest: basic [102.543927] Subtest basic: SUCCESS (0.000s) [102.846533] [072/165] (905s left) kms_addfb_basic (basic-x-tiled-legacy) [102.935064] Starting subtest: basic-x-tiled-legacy [102.938080] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [103.227362] [073/165] (904s left) kms_addfb_basic (basic-y-tiled-legacy) [103.304728] Starting subtest: basic-y-tiled-legacy [103.308099] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [103.612472] [074/165] (904s left) kms_addfb_basic (bo-too-small) [103.918044] Starting subtest: bo-too-small [103.920813] Subtest bo-too-small: SUCCESS (0.000s) [103.992245] [075/165] (903s left) kms_addfb_basic (bo-too-small-due-to-tiling) [104.278557] Starting subtest: bo-too-small-due-to-tiling [104.281377] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [104.359406] [076/165] (903s left) kms_addfb_basic (clobberred-modifier) [104.434266] Starting subtest: clobberred-modifier [104.437197] Subtest clobberred-modifier: SUCCESS (0.000s) [104.726594] [077/165] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling) [104.802774] Starting subtest: framebuffer-vs-set-tiling [104.805789] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [105.113950] [078/165] (902s left) kms_addfb_basic (invalid-get-prop) [105.202562] Starting subtest: invalid-get-prop [105.205815] Subtest invalid-get-prop: SUCCESS (0.000s) [105.515702] [079/165] (902s left) kms_addfb_basic (invalid-get-prop-any) [105.607569] Starting subtest: invalid-get-prop-any [105.610696] Subtest invalid-get-prop-any: SUCCESS (0.000s) [105.893478] [080/165] (902s left) kms_addfb_basic (invalid-set-prop) [105.973471] Starting subtest: invalid-set-prop [105.976810] Subtest invalid-set-prop: SUCCESS (0.000s) [106.274094] [081/165] (901s left) kms_addfb_basic (invalid-set-prop-any) [106.344177] Starting subtest: invalid-set-prop-any [106.347465] Subtest invalid-set-prop-any: SUCCESS (0.000s) [106.626722] [082/165] (901s left) kms_addfb_basic (no-handle) [106.706574] Starting subtest: no-handle [106.709855] Subtest no-handle: SUCCESS (0.000s) [106.993456] [083/165] (901s left) kms_addfb_basic (size-max) [107.277191] Starting subtest: size-max [107.280236] Subtest size-max: SUCCESS (0.000s) [107.360350] [084/165] (900s left) kms_addfb_basic (small-bo) [107.655038] Starting subtest: small-bo [107.657793] Subtest small-bo: SUCCESS (0.000s) [107.740636] [085/165] (900s left) kms_addfb_basic (tile-pitch-mismatch) [107.813481] Starting subtest: tile-pitch-mismatch [107.816627] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [108.110674] [086/165] (900s left) kms_addfb_basic (too-high) [108.399696] Starting subtest: too-high [108.402590] Subtest too-high: SUCCESS (0.001s) [108.472544] [087/165] (899s left) kms_addfb_basic (too-wide) [108.757812] Starting subtest: too-wide [108.760804] Subtest too-wide: SUCCESS (0.000s) [108.869778] [088/165] (899s left) kms_addfb_basic (unused-handle) [108.958217] Starting subtest: unused-handle [108.961366] Subtest unused-handle: SUCCESS (0.000s) [109.253720] [089/165] (899s left) kms_addfb_basic (unused-modifier) [109.322559] Starting subtest: unused-modifier [109.325839] Subtest unused-modifier: SUCCESS (0.000s) [109.606413] [090/165] (898s left) kms_addfb_basic (unused-offsets) [109.673417] Starting subtest: unused-offsets [109.676820] Subtest unused-offsets: SUCCESS (0.000s) [109.976459] [091/165] (898s left) kms_addfb_basic (unused-pitches) [110.058771] Starting subtest: unused-pitches [110.061939] Subtest unused-pitches: SUCCESS (0.000s) [110.340143] [092/165] (898s left) kms_busy (basic) [110.623766] Starting subtest: basic [110.627015] Starting dynamic subtest: flip [112.309445] Dynamic subtest flip: SUCCESS (1.564s) [112.427052] Starting dynamic subtest: modeset [113.350753] Dynamic subtest modeset: SUCCESS (1.156s) [113.354333] Subtest basic: SUCCESS (2.723s) [113.782116] [093/165] (894s left) kms_prop_blob (basic) [113.860116] Starting subtest: basic [113.863978] Subtest basic: SUCCESS (0.000s) [113.920680] [094/165] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [114.205347] Starting subtest: basic-busy-flip-before-cursor-atomic [114.210994] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [114.267800] [095/165] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [114.549347] Starting subtest: basic-busy-flip-before-cursor-legacy [114.554954] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [114.622471] [096/165] (893s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.908326] Starting subtest: basic-flip-after-cursor-atomic [116.066169] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.028s) [116.585915] [097/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.893782] Starting subtest: basic-flip-after-cursor-legacy [118.032741] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.038s) [118.562653] [098/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [118.866527] Starting subtest: basic-flip-after-cursor-varying-size [119.898348] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.035s) [120.311340] [099/165] (888s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [120.615096] Starting subtest: basic-flip-before-cursor-atomic [121.651230] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.039s) [122.071974] [100/165] (887s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [122.373457] Starting subtest: basic-flip-before-cursor-legacy [123.424362] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.052s) [123.845256] [101/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [124.137698] Starting subtest: basic-flip-before-cursor-varying-size [125.181873] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s) [125.584532] [102/165] (883s left) kms_dsc (dsc-basic) [125.877770] Subtest dsc-basic: SKIP (0.000s) [125.915109] [103/165] (883s left) kms_flip (basic-flip-vs-dpms) [126.173370] Starting subtest: basic-flip-vs-dpms [126.176150] Starting dynamic subtest: A-DP1 [127.299153] Dynamic subtest A-DP1: SUCCESS (1.120s) [127.315599] Starting dynamic subtest: B-DP1 [128.348338] Dynamic subtest B-DP1: SUCCESS (1.043s) [128.363665] Starting dynamic subtest: C-DP1 [129.355115] Dynamic subtest C-DP1: SUCCESS (1.010s) [129.365938] Starting dynamic subtest: A-DP2 [130.265317] Dynamic subtest A-DP2: SUCCESS (0.906s) [130.275020] Starting dynamic subtest: B-DP2 [130.984296] Dynamic subtest B-DP2: SUCCESS (0.715s) [130.995670] Starting dynamic subtest: C-DP2 [131.861777] Dynamic subtest C-DP2: SUCCESS (0.874s) [131.865181] Subtest basic-flip-vs-dpms: SUCCESS (5.689s) [132.329522] [104/165] (876s left) kms_flip (basic-flip-vs-modeset) [132.596608] Starting subtest: basic-flip-vs-modeset [132.599352] Starting dynamic subtest: A-DP1 [133.729711] Dynamic subtest A-DP1: SUCCESS (1.128s) [133.747566] Starting dynamic subtest: B-DP1 [134.709980] Dynamic subtest B-DP1: SUCCESS (0.976s) [134.728819] Starting dynamic subtest: C-DP1 [135.747307] Dynamic subtest C-DP1: SUCCESS (1.030s) [135.765704] Starting dynamic subtest: A-DP2 [136.663659] Dynamic subtest A-DP2: SUCCESS (0.919s) [136.672879] Starting dynamic subtest: B-DP2 [137.369425] Dynamic subtest B-DP2: SUCCESS (0.701s) [137.380853] Starting dynamic subtest: C-DP2 [138.267229] Dynamic subtest C-DP2: SUCCESS (0.895s) [138.270504] Subtest basic-flip-vs-modeset: SUCCESS (5.674s) [138.725827] [105/165] (870s left) kms_flip (basic-flip-vs-wf_vblank) [138.990870] Starting subtest: basic-flip-vs-wf_vblank [138.993987] Starting dynamic subtest: A-DP1 [140.312946] Dynamic subtest A-DP1: SUCCESS (1.211s) [140.378864] Starting dynamic subtest: B-DP1 [141.420282] Dynamic subtest B-DP1: SUCCESS (1.112s) [141.485590] Starting dynamic subtest: C-DP1 [142.440779] Dynamic subtest C-DP1: SUCCESS (1.120s) [142.455228] Starting dynamic subtest: A-DP2 [143.590118] Dynamic subtest A-DP2: SUCCESS (1.059s) [143.658501] Starting dynamic subtest: B-DP2 [144.570460] Dynamic subtest B-DP2: SUCCESS (1.070s) [144.583021] Starting dynamic subtest: C-DP2 [145.609521] Dynamic subtest C-DP2: SUCCESS (1.035s) [145.612745] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.623s) [146.140888] [106/165] (863s left) kms_flip (basic-plain-flip) [146.412503] Starting subtest: basic-plain-flip [146.415763] Starting dynamic subtest: A-DP1 [147.324991] Dynamic subtest A-DP1: SUCCESS (0.906s) [147.336573] Starting dynamic subtest: B-DP1 [148.230058] Dynamic subtest B-DP1: SUCCESS (0.906s) [148.240654] Starting dynamic subtest: C-DP1 [149.110863] Dynamic subtest C-DP1: SUCCESS (0.881s) [149.122542] Starting dynamic subtest: A-DP2 [149.919789] Dynamic subtest A-DP2: SUCCESS (0.805s) [149.931420] Starting dynamic subtest: B-DP2 [150.681330] Dynamic subtest B-DP2: SUCCESS (0.758s) [150.692804] Starting dynamic subtest: C-DP2 [151.563090] Dynamic subtest C-DP2: SUCCESS (0.777s) [151.628636] Subtest basic-plain-flip: SUCCESS (5.049s) [152.147054] [107/165] (857s left) kms_force_connector_basic (force-connector-state) [152.596217] Starting subtest: force-connector-state [153.164430] Subtest force-connector-state: SUCCESS (0.568s) [154.010723] [108/165] (855s left) kms_force_connector_basic (force-edid) [154.136707] Starting subtest: force-edid [154.239376] Subtest force-edid: SUCCESS (0.107s) [154.761793] [109/165] (854s left) kms_force_connector_basic (force-load-detect) [154.886982] Starting subtest: force-load-detect [154.892546] Subtest force-load-detect: SKIP (0.000s) [155.195959] [110/165] (854s left) kms_force_connector_basic (prune-stale-modes) [155.322249] Starting subtest: prune-stale-modes [155.432549] Subtest prune-stale-modes: SUCCESS (0.110s) [155.943687] [111/165] (853s left) kms_frontbuffer_tracking (basic) [156.240100] Starting subtest: basic [158.996355] Subtest basic: SUCCESS (2.758s) [159.263321] [112/165] (850s left) kms_hdmi_inject (inject-audio) [159.477781] Starting subtest: inject-audio [159.648468] Subtest inject-audio: SUCCESS (0.174s) [160.315683] [113/165] (849s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [160.605851] Starting subtest: compare-crc-sanitycheck-xr24 [160.608624] Starting dynamic subtest: pipe-A-DP-1 [161.214121] Dynamic subtest pipe-A-DP-1: SUCCESS (0.607s) [161.228521] Starting dynamic subtest: pipe-B-DP-2 [161.698279] Dynamic subtest pipe-B-DP-2: SUCCESS (0.477s) [161.708834] Starting dynamic subtest: pipe-C-DP-1 [162.271691] Dynamic subtest pipe-C-DP-1: SUCCESS (0.566s) [162.274911] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.663s) [162.752241] [114/165] (846s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [163.081195] Starting subtest: compare-crc-sanitycheck-nv12 [163.083990] Starting dynamic subtest: pipe-A-DP-1 [163.705509] Dynamic subtest pipe-A-DP-1: SUCCESS (0.635s) [163.715462] Starting dynamic subtest: pipe-B-DP-2 [164.228276] Dynamic subtest pipe-B-DP-2: SUCCESS (0.521s) [164.238277] Starting dynamic subtest: pipe-C-DP-1 [164.246771] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [164.251146] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.167s) [164.631656] [115/165] (845s left) kms_pipe_crc_basic (hang-read-crc) [164.914799] Starting subtest: hang-read-crc [164.917717] Starting dynamic subtest: pipe-A-DP-1 [166.299799] Dynamic subtest pipe-A-DP-1: SUCCESS (1.379s) [166.316645] Starting dynamic subtest: pipe-B-DP-2 [167.479691] Dynamic subtest pipe-B-DP-2: SUCCESS (1.179s) [167.489986] Starting dynamic subtest: pipe-C-DP-1 [168.817264] Dynamic subtest pipe-C-DP-1: SUCCESS (1.333s) [168.820306] Subtest hang-read-crc: SUCCESS (3.904s) [169.249198] [116/165] (840s left) kms_pipe_crc_basic (nonblocking-crc) [169.544932] Starting subtest: nonblocking-crc [169.547747] Starting dynamic subtest: pipe-A-DP-1 [170.302065] Dynamic subtest pipe-A-DP-1: SUCCESS (0.754s) [170.316907] Starting dynamic subtest: pipe-B-DP-2 [170.962280] Dynamic subtest pipe-B-DP-2: SUCCESS (0.658s) [170.972364] Starting dynamic subtest: pipe-C-DP-1 [171.702500] Dynamic subtest pipe-C-DP-1: SUCCESS (0.737s) [171.707206] Subtest nonblocking-crc: SUCCESS (2.160s) [172.121880] [117/165] (837s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [172.406893] Starting subtest: nonblocking-crc-frame-sequence [172.409638] Starting dynamic subtest: pipe-A-DP-1 [173.174404] Dynamic subtest pipe-A-DP-1: SUCCESS (0.763s) [173.195923] Starting dynamic subtest: pipe-B-DP-2 [173.844137] Dynamic subtest pipe-B-DP-2: SUCCESS (0.662s) [173.869537] Starting dynamic subtest: pipe-C-DP-1 [174.588095] Dynamic subtest pipe-C-DP-1: SUCCESS (0.744s) [174.591523] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.184s) [175.018309] [118/165] (834s left) kms_pipe_crc_basic (read-crc) [175.322947] Starting subtest: read-crc [175.325802] Starting dynamic subtest: pipe-A-DP-1 [176.033799] Dynamic subtest pipe-A-DP-1: SUCCESS (0.710s) [176.044067] Starting dynamic subtest: pipe-B-DP-2 [176.614876] Dynamic subtest pipe-B-DP-2: SUCCESS (0.578s) [176.626408] Starting dynamic subtest: pipe-C-DP-1 [177.271603] Dynamic subtest pipe-C-DP-1: SUCCESS (0.648s) [177.275101] Subtest read-crc: SUCCESS (1.947s) [177.671698] [119/165] (832s left) kms_pipe_crc_basic (read-crc-frame-sequence) [177.969999] Starting subtest: read-crc-frame-sequence [177.972938] Starting dynamic subtest: pipe-A-DP-1 [178.684920] Dynamic subtest pipe-A-DP-1: SUCCESS (0.709s) [178.704760] Starting dynamic subtest: pipe-B-DP-2 [179.329074] Dynamic subtest pipe-B-DP-2: SUCCESS (0.638s) [179.342810] Starting dynamic subtest: pipe-C-DP-1 [180.004029] Dynamic subtest pipe-C-DP-1: SUCCESS (0.670s) [180.007485] Subtest read-crc-frame-sequence: SUCCESS (2.034s) [180.405885] [120/165] (829s left) kms_pm_backlight (basic-brightness) [180.708160] Subtest basic-brightness: SKIP (0.000s) [180.744904] [121/165] (829s left) kms_pm_rpm (basic-pci-d3-state) [182.614427] Starting subtest: basic-pci-d3-state [183.360941] Subtest basic-pci-d3-state: SUCCESS (0.749s) [183.754807] [122/165] (826s left) kms_pm_rpm (basic-rte) [183.840873] Starting subtest: basic-rte [186.337901] Subtest basic-rte: SUCCESS (2.493s) [187.493514] [123/165] (822s left) kms_psr (psr_primary_page_flip) [187.781138] Subtest psr_primary_page_flip: SKIP (0.000s) [187.814033] [124/165] (822s left) kms_psr (psr_cursor_plane_move) [188.104144] Subtest psr_cursor_plane_move: SKIP (0.000s) [188.144241] [125/165] (821s left) kms_psr (psr_sprite_plane_onoff) [188.428169] Subtest psr_sprite_plane_onoff: SKIP (0.000s) [188.463138] [126/165] (821s left) kms_psr (psr_primary_mmap_gtt) [188.750422] Subtest psr_primary_mmap_gtt: SKIP (0.000s) [188.779455] [127/165] (821s left) kms_setmode (basic-clone-single-crtc) [188.849536] Starting subtest: basic-clone-single-crtc [189.020708] Subtest basic-clone-single-crtc: SKIP (0.174s) [189.401020] [128/165] (820s left) i915_pm_rps (basic-api) [189.487534] Starting subtest: basic-api [189.490941] Subtest basic-api: SUCCESS (0.003s) [189.559606] [129/165] (820s left) prime_self_import (basic-llseek-bad) [189.628489] Starting subtest: basic-llseek-bad [189.634182] Subtest basic-llseek-bad: SUCCESS (0.002s) [189.724293] [130/165] (820s left) prime_self_import (basic-llseek-size) [189.813455] Starting subtest: basic-llseek-size [189.819856] Subtest basic-llseek-size: SUCCESS (0.002s) [189.931161] [131/165] (820s left) prime_self_import (basic-with_fd_dup) [190.014908] Starting subtest: basic-with_fd_dup [190.021320] Subtest basic-with_fd_dup: SUCCESS (0.002s) [190.131398] [132/165] (820s left) prime_self_import (basic-with_one_bo) [190.214843] Starting subtest: basic-with_one_bo [190.221629] Subtest basic-with_one_bo: SUCCESS (0.003s) [190.266892] [133/165] (820s left) prime_self_import (basic-with_one_bo_two_files) [190.331628] Starting subtest: basic-with_one_bo_two_files [190.337321] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [190.419674] [134/165] (819s left) prime_self_import (basic-with_two_bos) [190.500158] Starting subtest: basic-with_two_bos [190.506579] Subtest basic-with_two_bos: SUCCESS (0.003s) [190.576630] [135/165] (819s left) prime_vgem (basic-fence-flip) [190.660422] Starting subtest: basic-fence-flip [191.440642] Subtest basic-fence-flip: SUCCESS (0.660s) [191.750486] [136/165] (818s left) prime_vgem (basic-fence-mmap) [192.227929] Starting subtest: basic-fence-mmap [192.297441] Subtest basic-fence-mmap: SUCCESS (0.040s) [192.617354] [137/165] (818s left) prime_vgem (basic-fence-read) [192.707312] Starting subtest: basic-fence-read [192.750497] Subtest basic-fence-read: SUCCESS (0.045s) [192.827531] [138/165] (818s left) prime_vgem (basic-gtt) [192.918874] Starting subtest: basic-gtt [192.931799] Subtest basic-gtt: SUCCESS (0.013s) [193.055539] [139/165] (817s left) prime_vgem (basic-read) [193.160220] Starting subtest: basic-read [193.180580] Subtest basic-read: SUCCESS (0.021s) [193.305080] [140/165] (817s left) prime_vgem (basic-write) [193.421693] Starting subtest: basic-write [193.444134] Subtest basic-write: SUCCESS (0.023s) [193.508587] [141/165] (817s left) vgem_basic (setversion) [193.590708] Starting subtest: setversion [193.598276] Subtest setversion: SUCCESS (0.000s) [193.645255] [142/165] (817s left) vgem_basic (create) [193.727325] Starting subtest: create [193.730910] Subtest create: SUCCESS (0.000s) [193.775417] [143/165] (817s left) vgem_basic (debugfs) [193.857249] Starting subtest: debugfs [193.861128] Subtest debugfs: SUCCESS (0.000s) [193.911798] [144/165] (817s left) vgem_basic (dmabuf-export) [193.990505] Starting subtest: dmabuf-export [194.001161] Subtest dmabuf-export: SUCCESS (0.009s) [194.100293] [145/165] (817s left) vgem_basic (dmabuf-fence) [194.175681] Starting subtest: dmabuf-fence [194.178881] Subtest dmabuf-fence: SUCCESS (0.001s) [194.226219] [146/165] (816s left) vgem_basic (dmabuf-fence-before) [194.307332] Starting subtest: dmabuf-fence-before [194.310757] Subtest dmabuf-fence-before: SUCCESS (0.000s) [194.361036] [147/165] (816s left) vgem_basic (dmabuf-mmap) [194.439984] Starting subtest: dmabuf-mmap [194.450368] Subtest dmabuf-mmap: SUCCESS (0.013s) [194.512639] [148/165] (816s left) vgem_basic (mmap) [194.606687] Starting subtest: mmap [194.613491] Subtest mmap: SUCCESS (0.009s) [194.657656] [149/165] (816s left) vgem_basic (second-client) [194.739549] Starting subtest: second-client [194.774566] Subtest second-client: SUCCESS (0.033s) [194.855492] [150/165] (816s left) vgem_basic (sysfs) [194.957318] Starting subtest: sysfs [194.960564] Subtest sysfs: SUCCESS (0.001s) [195.010697] [151/165] (816s left) core_hotunplug (unbind-rebind) [195.123646] Starting subtest: unbind-rebind [198.541536] Subtest unbind-rebind: SUCCESS (3.420s) [198.571829] [152/165] (812s left) vgem_basic (unload) [198.653554] Starting subtest: unload [227.685078] Subtest unload: SUCCESS (29.030s) [227.813423] [153/165] (783s left) i915_module_load (reload) [227.877784] Starting subtest: reload [230.765796] Subtest reload: SUCCESS (2.893s) [230.788184] [154/165] (780s left) gem_lmem_swapping (basic) [230.912379] Subtest basic: SKIP (0.000s) [230.945699] [155/165] (780s left) gem_lmem_swapping (parallel-random-engines) [231.029935] Subtest parallel-random-engines: SKIP (0.000s) [231.050073] [156/165] (780s left) gem_lmem_swapping (random-engines) [231.130815] Subtest random-engines: SKIP (0.000s) [231.160788] [157/165] (780s left) gem_lmem_swapping (verify-random) [231.231666] Subtest verify-random: SKIP (0.000s) [231.262548] [158/165] (780s left) i915_pm_rpm (module-reload) [233.747432] Starting subtest: module-reload [241.510237] Subtest module-reload: SUCCESS (7.766s) [241.544843] [159/165] (769s left) i915_selftest (live) [241.653916] Starting subtest: live [241.657190] Starting dynamic subtest: sanitycheck [242.390410] Dynamic subtest sanitycheck: SUCCESS (0.735s) [242.399867] Starting dynamic subtest: uncore [243.098050] Dynamic subtest uncore: SUCCESS (0.706s) [243.107321] Starting dynamic subtest: workarounds [243.988246] Dynamic subtest workarounds: SUCCESS (0.888s) [243.997865] Starting dynamic subtest: gt_engines [245.228236] Dynamic subtest gt_engines: SUCCESS (1.236s) [245.240062] Starting dynamic subtest: gt_timelines [255.828861] Dynamic subtest gt_timelines: SUCCESS (10.601s) [255.838425] Starting dynamic subtest: gt_contexts [256.642172] Dynamic subtest gt_contexts: SUCCESS (0.809s) [256.655189] Starting dynamic subtest: gt_lrc [260.363165] Dynamic subtest gt_lrc: SUCCESS (3.721s) [260.372023] Starting dynamic subtest: gt_mocs [261.129045] Dynamic subtest gt_mocs: SUCCESS (0.764s) [261.137566] Starting dynamic subtest: gt_pm [267.747072] Dynamic subtest gt_pm: SUCCESS (6.616s) [267.755977] Starting dynamic subtest: gt_heartbeat [268.527028] Dynamic subtest gt_heartbeat: SUCCESS (0.778s) [268.536297] Starting dynamic subtest: gt_tlb [270.231247] Dynamic subtest gt_tlb: SUCCESS (1.700s) [270.241911] Starting dynamic subtest: requests [278.401416] Dynamic subtest requests: SUCCESS (8.169s) [278.411356] Starting dynamic subtest: migrate [281.949194] Dynamic subtest migrate: SUCCESS (3.546s) [281.958590] Starting dynamic subtest: active [282.643119] Dynamic subtest active: SUCCESS (0.694s) [282.654099] Starting dynamic subtest: objects [284.300020] Dynamic subtest objects: SUCCESS (1.655s) [284.309331] Starting dynamic subtest: mman [289.031306] Dynamic subtest mman: SUCCESS (4.729s) [289.040376] Starting dynamic subtest: dmabuf [289.793316] Dynamic subtest dmabuf: SUCCESS (0.758s) [289.802024] Starting dynamic subtest: vma [290.511178] Dynamic subtest vma: SUCCESS (0.716s) [290.520544] Starting dynamic subtest: coherency [292.236222] Dynamic subtest coherency: SUCCESS (1.725s) [292.247252] Starting dynamic subtest: gtt [300.120882] Dynamic subtest gtt: SUCCESS (7.883s) [300.129279] Starting dynamic subtest: gem [300.985104] Dynamic subtest gem: SUCCESS (0.863s) [300.995136] Starting dynamic subtest: evict [303.342052] Dynamic subtest evict: SUCCESS (2.355s) [303.350835] Starting dynamic subtest: hugepages [310.482481] Dynamic subtest hugepages: SUCCESS (7.138s) [310.502108] Starting dynamic subtest: gem_contexts [327.056316] Dynamic subtest gem_contexts: SUCCESS (16.570s) [327.067853] Starting dynamic subtest: client [327.771254] Dynamic subtest client: SUCCESS (0.712s) [327.780895] Starting dynamic subtest: gem_migrate [328.427230] Dynamic subtest gem_migrate: SUCCESS (0.655s) [328.436801] Starting dynamic subtest: reset [329.923232] Dynamic subtest reset: SUCCESS (1.494s) [329.932397] Starting dynamic subtest: memory_region [330.625015] Dynamic subtest memory_region: SUCCESS (0.702s) [330.634020] Starting dynamic subtest: hangcheck [359.891317] Dynamic subtest hangcheck: SUCCESS (29.264s) [359.901559] Starting dynamic subtest: execlists [372.999014] Dynamic subtest execlists: SUCCESS (13.106s) [373.008599] Starting dynamic subtest: ring_submission [373.697348] Dynamic subtest ring_submission: SUCCESS (0.694s) [373.706283] Starting dynamic subtest: perf [374.447092] Dynamic subtest perf: SUCCESS (0.750s) [374.456692] Starting dynamic subtest: slpc [375.104559] Dynamic subtest slpc: SUCCESS (0.655s) [375.116100] Starting dynamic subtest: guc [375.806054] Dynamic subtest guc: SUCCESS (0.700s) [375.815633] Starting dynamic subtest: guc_multi_lrc [376.432170] Dynamic subtest guc_multi_lrc: SUCCESS (0.624s) [376.444708] Starting dynamic subtest: guc_hang [377.139340] Dynamic subtest guc_hang: SUCCESS (0.702s) [377.148952] Starting dynamic subtest: late_gt_pm [377.869172] Dynamic subtest late_gt_pm: SUCCESS (0.729s) [377.872130] Subtest live: SUCCESS (136.214s) [377.893681] [160/165] (633s left) dmabuf (all-tests) [377.974132] Starting subtest: all-tests [377.979678] Starting dynamic subtest: sanitycheck [378.052293] Dynamic subtest sanitycheck: SUCCESS (0.079s) [378.070038] Starting dynamic subtest: dma_fence [378.233477] Dynamic subtest dma_fence: SUCCESS (0.181s) [378.244565] Starting dynamic subtest: dma_fence_chain [392.885239] Dynamic subtest dma_fence_chain: SUCCESS (14.649s) [392.903671] Starting dynamic subtest: dma_fence_unwrap [392.960198] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s) [392.981647] Starting dynamic subtest: dma_resv [393.038319] Dynamic subtest dma_resv: SUCCESS (0.074s) [393.042505] Subtest all-tests: SUCCESS (15.069s) [393.079894] [161/165] (618s left) i915_suspend (basic-s2idle-without-i915) [393.158258] Starting subtest: basic-s2idle-without-i915 [412.157591] Subtest basic-s2idle-without-i915: SUCCESS (3.995s) [415.759389] [162/165] (613s left) i915_suspend (basic-s3-without-i915) [415.833623] Starting subtest: basic-s3-without-i915 [434.881391] Subtest basic-s3-without-i915: SUCCESS (3.297s) [438.474299] [163/165] (609s left) gem_exec_suspend (basic-s0) [438.566899] Starting subtest: basic-S0 [438.570283] Starting dynamic subtest: smem [457.058563] Dynamic subtest smem: SUCCESS (2.743s) [457.062263] Subtest basic-S0: SUCCESS (2.744s) [462.240548] [164/165] (606s left) gem_exec_suspend (basic-s3) [462.320916] Starting subtest: basic-S3 [462.323977] Starting dynamic subtest: smem [481.739906] Dynamic subtest smem: SUCCESS (3.498s) [481.743256] Subtest basic-S3: SUCCESS (3.500s) [485.922760] [165/165] (603s left) kms_pipe_crc_basic (suspend-read-crc) [486.210924] Starting subtest: suspend-read-crc [486.214195] Starting dynamic subtest: pipe-A-DP-1 [505.719617] Dynamic subtest pipe-A-DP-1: SUCCESS (2.921s) [505.733440] Starting dynamic subtest: pipe-B-DP-2 [524.632469] Dynamic subtest pipe-B-DP-2: SUCCESS (2.647s) [524.645663] Starting dynamic subtest: pipe-C-DP-1 [543.704307] Dynamic subtest pipe-C-DP-1: SUCCESS (2.858s) [543.707597] Subtest suspend-read-crc: SUCCESS (8.434s) [548.061979] Closing watchdogs Done.