[43.183397] Initializing watchdogs [43.183480] /dev/watchdog0 [43.191318] [001/165] (960s left) i915_module_load (load) [43.467181] Starting subtest: load [45.653209] Subtest load: SUCCESS (2.182s) [45.679947] [002/165] (958s left) core_auth (basic-auth) [45.774887] Starting subtest: basic-auth [45.779050] Subtest basic-auth: SUCCESS (0.001s) [45.842957] [003/165] (957s left) debugfs_test (read_all_entries) [45.919824] Starting subtest: read_all_entries [46.106847] Subtest read_all_entries: SUCCESS (0.184s) [46.427482] [004/165] (957s left) debugfs_test (basic-hwmon) [46.540266] Starting subtest: basic-hwmon [46.546697] Subtest basic-hwmon: SKIP (0.000s) [46.818818] [005/165] (956s left) fbdev (eof) [46.899206] Starting subtest: eof [46.902535] Subtest eof: SUCCESS (0.001s) [46.969070] [006/165] (956s left) fbdev (info) [47.054798] Starting subtest: info [47.058295] Subtest info: SUCCESS (0.000s) [47.136993] [007/165] (956s left) fbdev (nullptr) [47.217197] Starting subtest: nullptr [47.220530] Subtest nullptr: SUCCESS (0.000s) [47.269871] [008/165] (956s left) fbdev (read) [47.367659] Starting subtest: read [47.658048] Subtest read: SUCCESS (0.256s) [47.983997] [009/165] (956s left) fbdev (write) [48.317278] Starting subtest: write [48.485920] Subtest write: SUCCESS (0.158s) [48.950439] [010/165] (955s left) gem_basic (bad-close) [49.023190] Starting subtest: bad-close [49.031138] Subtest bad-close: SUCCESS (0.000s) [49.100590] [011/165] (955s left) gem_basic (create-close) [49.173354] Starting subtest: create-close [49.179616] Subtest create-close: SUCCESS (0.000s) [49.277291] [012/165] (955s left) gem_basic (create-fd-close) [49.368983] Starting subtest: create-fd-close [49.375799] Subtest create-fd-close: SUCCESS (0.000s) [49.479702] [013/165] (954s left) gem_busy (busy@all-engines) [49.577819] Starting subtest: busy [49.581055] Starting dynamic subtest: all-engines [49.633637] Dynamic subtest all-engines: SUCCESS (0.056s) [49.637077] Subtest busy: SUCCESS (0.056s) [50.030578] [014/165] (954s left) gem_close_race (basic-process) [50.130072] Starting subtest: basic-process [50.186790] Subtest basic-process: SUCCESS (0.057s) [50.397972] [015/165] (954s left) gem_close_race (basic-threads) [50.496571] Starting subtest: basic-threads [51.685435] Subtest basic-threads: SUCCESS (1.189s) [51.869896] [016/165] (952s left) gem_ctx_create (basic) [51.969934] Starting subtest: basic [51.973647] Subtest basic: SUCCESS (0.000s) [52.172186] [017/165] (952s left) gem_ctx_create (basic-files) [52.244174] Starting subtest: basic-files [54.263288] Subtest basic-files: SUCCESS (2.019s) [54.495766] [018/165] (950s left) gem_ctx_exec (basic) [54.596307] Starting subtest: basic [54.599901] Subtest basic: SUCCESS (0.003s) [54.677367] [019/165] (950s left) gem_exec_basic (basic) [54.765389] Starting subtest: basic [54.768903] Starting dynamic subtest: rcs0-smem [54.772813] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [54.784886] Starting dynamic subtest: bcs0-smem [54.788750] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [54.801109] Starting dynamic subtest: vcs0-smem [54.804928] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [54.817173] Starting dynamic subtest: vcs1-smem [54.820925] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [54.832908] Starting dynamic subtest: vecs0-smem [54.836319] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [54.839772] Subtest basic: SUCCESS (0.004s) [54.994577] [020/165] (949s left) gem_exec_create (basic) [55.092718] Starting subtest: basic [55.096125] Starting dynamic subtest: smem [57.140148] Dynamic subtest smem: SUCCESS (2.047s) [57.143496] Subtest basic: SUCCESS (2.048s) [57.345927] [021/165] (947s left) gem_exec_fence (basic-busy) [57.585875] Starting subtest: basic-busy [57.589664] Starting dynamic subtest: rcs0 [57.614555] Dynamic subtest rcs0: SUCCESS (0.027s) [57.633341] Starting dynamic subtest: bcs0 [57.648149] Dynamic subtest bcs0: SUCCESS (0.034s) [57.661604] Starting dynamic subtest: vcs0 [57.679813] Dynamic subtest vcs0: SUCCESS (0.032s) [57.691331] Starting dynamic subtest: vcs1 [57.706921] Dynamic subtest vcs1: SUCCESS (0.027s) [57.722179] Starting dynamic subtest: vecs0 [57.740209] Dynamic subtest vecs0: SUCCESS (0.033s) [57.744172] Subtest basic-busy: SUCCESS (0.154s) [58.414290] [022/165] (946s left) gem_exec_fence (basic-wait) [58.650321] Starting subtest: basic-wait [58.654573] Starting dynamic subtest: rcs0 [58.686928] Dynamic subtest rcs0: SUCCESS (0.038s) [58.701857] Starting dynamic subtest: bcs0 [58.719174] Dynamic subtest bcs0: SUCCESS (0.032s) [58.731739] Starting dynamic subtest: vcs0 [58.744621] Dynamic subtest vcs0: SUCCESS (0.026s) [58.755978] Starting dynamic subtest: vcs1 [58.765156] Dynamic subtest vcs1: SUCCESS (0.018s) [58.783889] Starting dynamic subtest: vecs0 [58.787622] Dynamic subtest vecs0: SUCCESS (0.022s) [58.791032] Subtest basic-wait: SUCCESS (0.137s) [59.395402] [023/165] (945s left) gem_exec_fence (basic-await) [59.656227] Starting subtest: basic-await [59.659492] Starting dynamic subtest: rcs0 [59.759417] Dynamic subtest rcs0: SUCCESS (0.102s) [59.769501] Starting dynamic subtest: bcs0 [59.860092] Dynamic subtest bcs0: SUCCESS (0.103s) [59.870915] Starting dynamic subtest: vcs0 [59.970783] Dynamic subtest vcs0: SUCCESS (0.111s) [59.981105] Starting dynamic subtest: vcs1 [60.080407] Dynamic subtest vcs1: SUCCESS (0.109s) [60.094397] Starting dynamic subtest: vecs0 [60.232434] Dynamic subtest vecs0: SUCCESS (0.150s) [60.236095] Subtest basic-await: SUCCESS (0.575s) [60.882061] [024/165] (944s left) gem_exec_fence (nb-await) [61.133745] Starting subtest: nb-await [61.137562] Starting dynamic subtest: rcs0 [61.201358] Dynamic subtest rcs0: SUCCESS (0.073s) [61.216879] Starting dynamic subtest: bcs0 [61.276340] Dynamic subtest bcs0: SUCCESS (0.072s) [61.296422] Starting dynamic subtest: vcs0 [61.351472] Dynamic subtest vcs0: SUCCESS (0.075s) [61.367480] Starting dynamic subtest: vcs1 [61.421727] Dynamic subtest vcs1: SUCCESS (0.071s) [61.438611] Starting dynamic subtest: vecs0 [61.494267] Dynamic subtest vecs0: SUCCESS (0.072s) [61.498446] Subtest nb-await: SUCCESS (0.365s) [62.130344] [025/165] (942s left) gem_exec_gttfill (basic) [62.225104] Starting subtest: basic [66.885391] Subtest basic: SUCCESS (4.660s) [67.057089] [026/165] (937s left) gem_exec_parallel (engines) [67.202272] Starting subtest: engines [67.205521] Starting dynamic subtest: basic [69.194442] Dynamic subtest basic: SUCCESS (1.994s) [69.203412] Starting dynamic subtest: contexts [73.353323] Dynamic subtest contexts: SUCCESS (4.158s) [73.362260] Starting dynamic subtest: fds [79.622762] Dynamic subtest fds: SUCCESS (6.199s) [79.688621] Starting dynamic subtest: userptr [81.623039] Dynamic subtest userptr: SUCCESS (2.066s) [81.626323] Subtest engines: SUCCESS (14.417s) [81.827299] [027/165] (923s left) gem_exec_store (basic) [81.920963] Starting subtest: basic [81.972501] Subtest basic: SUCCESS (0.056s) [82.174080] [028/165] (922s left) gem_flink_basic (bad-flink) [82.263309] Starting subtest: bad-flink [82.266658] Subtest bad-flink: SUCCESS (0.000s) [82.333472] [029/165] (922s left) gem_flink_basic (bad-open) [82.419334] Starting subtest: bad-open [82.422702] Subtest bad-open: SUCCESS (0.000s) [82.494997] [030/165] (922s left) gem_flink_basic (basic) [82.579266] Starting subtest: basic [82.582700] Subtest basic: SUCCESS (0.000s) [82.692451] [031/165] (922s left) gem_flink_basic (double-flink) [82.760567] Starting subtest: double-flink [82.764176] Subtest double-flink: SUCCESS (0.000s) [82.857448] [032/165] (922s left) gem_flink_basic (flink-lifetime) [82.954936] Starting subtest: flink-lifetime [82.958127] Subtest flink-lifetime: SUCCESS (0.002s) [83.077884] [033/165] (922s left) gem_huc_copy (huc-copy) [83.152601] Starting subtest: huc-copy [83.159395] Subtest huc-copy: SKIP (0.000s) [83.275117] [034/165] (921s left) gem_linear_blits (basic) [83.465145] Starting subtest: basic [83.473620] Subtest basic: SUCCESS (0.007s) [83.621049] [035/165] (921s left) gem_mmap (basic) [83.796933] Starting subtest: basic [83.817975] Subtest basic: SUCCESS (0.000s) [83.892367] [036/165] (921s left) gem_mmap_gtt (basic) [83.992080] Starting subtest: basic [83.995533] Subtest basic: SUCCESS (0.001s) [84.054495] [037/165] (921s left) gem_render_linear_blits (basic) [84.158336] Starting subtest: basic [84.190588] Subtest basic: SUCCESS (0.032s) [84.229064] [038/165] (921s left) gem_render_tiled_blits (basic) [84.297707] Starting subtest: basic [84.333349] Subtest basic: SUCCESS (0.034s) [84.386240] [039/165] (921s left) gem_ringfill (basic-all) [84.707532] Starting subtest: basic-all [85.879194] Subtest basic-all: SUCCESS (1.169s) [85.993555] [040/165] (919s left) gem_softpin (allocator-basic) [86.066220] Starting subtest: allocator-basic [86.177409] Subtest allocator-basic: SUCCESS (0.113s) [86.284264] [041/165] (919s left) gem_softpin (allocator-basic-reserve) [86.365776] Starting subtest: allocator-basic-reserve [86.474149] Subtest allocator-basic-reserve: SUCCESS (0.111s) [86.585827] [042/165] (918s left) gem_softpin (safe-alignment) [86.665369] Starting subtest: safe-alignment [86.677969] Subtest safe-alignment: SUCCESS (0.014s) [86.796064] [043/165] (918s left) gem_sync (basic-all) [86.889279] Starting subtest: basic-all [89.100635] Subtest basic-all: SUCCESS (2.227s) [89.312805] [044/165] (916s left) gem_sync (basic-each) [89.433278] Starting subtest: basic-each [91.576627] Subtest basic-each: SUCCESS (2.166s) [91.775467] [045/165] (913s left) gem_tiled_blits (basic) [91.981833] Starting subtest: basic [92.001088] Subtest basic: SUCCESS (0.018s) [92.169878] [046/165] (913s left) gem_tiled_fence_blits (basic) [92.462449] Starting subtest: basic [92.469811] Subtest basic: SUCCESS (0.010s) [92.624442] [047/165] (913s left) gem_tiled_pread_basic [93.335198] [048/165] (912s left) gem_wait (busy@all-engines) [93.820905] Starting subtest: busy [93.886623] Starting dynamic subtest: all-engines [94.303991] Dynamic subtest all-engines: SUCCESS (0.514s) [94.420107] Subtest busy: SUCCESS (0.515s) [94.450245] [049/165] (911s left) gem_wait (wait@all-engines) [94.533407] Starting subtest: wait [94.536928] Starting dynamic subtest: all-engines [95.576232] Dynamic subtest all-engines: SUCCESS (1.042s) [95.580202] Subtest wait: SUCCESS (1.042s) [95.802139] [050/165] (910s left) i915_getparams_basic (basic-eu-total) [95.876328] Starting subtest: basic-eu-total [95.882686] Subtest basic-eu-total: SUCCESS (0.000s) [95.943281] [051/165] (910s left) i915_getparams_basic (basic-subslice-total) [96.023786] Starting subtest: basic-subslice-total [96.030046] Subtest basic-subslice-total: SUCCESS (0.000s) [96.096581] [052/165] (909s left) i915_hangman (error-state-basic) [96.191638] Starting subtest: error-state-basic [96.200469] Subtest error-state-basic: SUCCESS (0.007s) [96.270789] [053/165] (909s left) i915_pciid [96.424406] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled) [96.730122] Starting subtest: addfb25-4-tiled [96.733266] Subtest addfb25-4-tiled: SUCCESS (0.000s) [96.815329] [055/165] (909s left) kms_addfb_basic (addfb25-bad-modifier) [96.904113] Starting subtest: addfb25-bad-modifier [96.907274] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [97.206206] [056/165] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [97.282396] Starting subtest: addfb25-framebuffer-vs-set-tiling [97.285647] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [97.575483] [057/165] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [97.658458] Starting subtest: addfb25-modifier-no-flag [97.661495] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [97.936761] [058/165] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy) [98.017941] Starting subtest: addfb25-x-tiled-legacy [98.021100] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [98.309586] [059/165] (908s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [98.406652] Starting subtest: addfb25-x-tiled-mismatch-legacy [98.409745] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [98.713326] [060/165] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [99.025933] Starting subtest: addfb25-yf-tiled-legacy [99.028823] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [99.107185] [061/165] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy) [99.400454] Starting subtest: addfb25-y-tiled-legacy [99.403518] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [99.496743] [062/165] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [99.796673] Starting subtest: addfb25-y-tiled-small-legacy [99.799396] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [99.872722] [063/165] (906s left) kms_addfb_basic (bad-pitch-0) [99.949465] Starting subtest: bad-pitch-0 [99.952702] Subtest bad-pitch-0: SUCCESS (0.000s) [100.237459] [064/165] (906s left) kms_addfb_basic (bad-pitch-1024) [100.341245] Starting subtest: bad-pitch-1024 [100.344633] Subtest bad-pitch-1024: SUCCESS (0.000s) [100.636296] [065/165] (905s left) kms_addfb_basic (bad-pitch-128) [100.706099] Starting subtest: bad-pitch-128 [100.709417] Subtest bad-pitch-128: SUCCESS (0.000s) [101.012733] [066/165] (905s left) kms_addfb_basic (bad-pitch-256) [101.116038] Starting subtest: bad-pitch-256 [101.119220] Subtest bad-pitch-256: SUCCESS (0.000s) [101.425441] [067/165] (905s left) kms_addfb_basic (bad-pitch-32) [101.512638] Starting subtest: bad-pitch-32 [101.515743] Subtest bad-pitch-32: SUCCESS (0.000s) [101.802856] [068/165] (904s left) kms_addfb_basic (bad-pitch-63) [101.871614] Starting subtest: bad-pitch-63 [101.874744] Subtest bad-pitch-63: SUCCESS (0.000s) [102.177677] [069/165] (904s left) kms_addfb_basic (bad-pitch-65536) [102.260897] Starting subtest: bad-pitch-65536 [102.264370] Subtest bad-pitch-65536: SUCCESS (0.000s) [102.559583] [070/165] (904s left) kms_addfb_basic (bad-pitch-999) [102.641342] Starting subtest: bad-pitch-999 [102.644363] Subtest bad-pitch-999: SUCCESS (0.000s) [102.955437] [071/165] (903s left) kms_addfb_basic (basic) [103.031759] Starting subtest: basic [103.035097] Subtest basic: SUCCESS (0.000s) [103.319727] [072/165] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [103.384185] Starting subtest: basic-x-tiled-legacy [103.387276] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [103.697088] [073/165] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [103.791091] Starting subtest: basic-y-tiled-legacy [103.794824] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [104.098432] [074/165] (902s left) kms_addfb_basic (bo-too-small) [104.392709] Starting subtest: bo-too-small [104.395699] Subtest bo-too-small: SUCCESS (0.000s) [104.473407] [075/165] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [104.762637] Starting subtest: bo-too-small-due-to-tiling [104.765513] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [104.840992] [076/165] (901s left) kms_addfb_basic (clobberred-modifier) [104.926983] Starting subtest: clobberred-modifier [104.930508] Subtest clobberred-modifier: SUCCESS (0.000s) [105.225536] [077/165] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [105.302891] Starting subtest: framebuffer-vs-set-tiling [105.306093] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [105.605634] [078/165] (901s left) kms_addfb_basic (invalid-get-prop) [105.677039] Starting subtest: invalid-get-prop [105.680379] Subtest invalid-get-prop: SUCCESS (0.000s) [105.983261] [079/165] (900s left) kms_addfb_basic (invalid-get-prop-any) [106.085864] Starting subtest: invalid-get-prop-any [106.089271] Subtest invalid-get-prop-any: SUCCESS (0.000s) [106.389256] [080/165] (900s left) kms_addfb_basic (invalid-set-prop) [106.463400] Starting subtest: invalid-set-prop [106.466055] Subtest invalid-set-prop: SUCCESS (0.000s) [106.770308] [081/165] (900s left) kms_addfb_basic (invalid-set-prop-any) [106.843216] Starting subtest: invalid-set-prop-any [106.845806] Subtest invalid-set-prop-any: SUCCESS (0.000s) [107.136201] [082/165] (899s left) kms_addfb_basic (no-handle) [107.205594] Starting subtest: no-handle [107.208881] Subtest no-handle: SUCCESS (0.000s) [107.503248] [083/165] (899s left) kms_addfb_basic (size-max) [107.780885] Starting subtest: size-max [107.783725] Subtest size-max: SUCCESS (0.000s) [107.864996] [084/165] (899s left) kms_addfb_basic (small-bo) [108.165064] Starting subtest: small-bo [108.168214] Subtest small-bo: SUCCESS (0.000s) [108.258253] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch) [108.371704] Starting subtest: tile-pitch-mismatch [108.375281] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [108.670970] [086/165] (898s left) kms_addfb_basic (too-high) [108.969346] Starting subtest: too-high [108.972145] Subtest too-high: SUCCESS (0.001s) [109.054018] [087/165] (898s left) kms_addfb_basic (too-wide) [109.352336] Starting subtest: too-wide [109.355125] Subtest too-wide: SUCCESS (0.000s) [109.423216] [088/165] (897s left) kms_addfb_basic (unused-handle) [109.502186] Starting subtest: unused-handle [109.505483] Subtest unused-handle: SUCCESS (0.000s) [109.786415] [089/165] (897s left) kms_addfb_basic (unused-modifier) [109.852215] Starting subtest: unused-modifier [109.855391] Subtest unused-modifier: SUCCESS (0.000s) [110.165727] [090/165] (897s left) kms_addfb_basic (unused-offsets) [110.259672] Starting subtest: unused-offsets [110.262981] Subtest unused-offsets: SUCCESS (0.000s) [110.559731] [091/165] (896s left) kms_addfb_basic (unused-pitches) [110.643201] Starting subtest: unused-pitches [110.646384] Subtest unused-pitches: SUCCESS (0.000s) [110.941458] [092/165] (896s left) kms_busy (basic) [111.242805] Starting subtest: basic [111.246834] Starting dynamic subtest: flip [112.875369] Dynamic subtest flip: SUCCESS (1.514s) [113.033422] Starting dynamic subtest: modeset [113.958961] Dynamic subtest modeset: SUCCESS (1.202s) [113.963698] Subtest basic: SUCCESS (2.719s) [114.369898] [093/165] (892s left) kms_prop_blob (basic) [114.446188] Starting subtest: basic [114.449645] Subtest basic: SUCCESS (0.000s) [114.522602] [094/165] (892s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [114.837180] Starting subtest: basic-busy-flip-before-cursor-atomic [114.842805] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [114.906337] [095/165] (892s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [115.200263] Starting subtest: basic-busy-flip-before-cursor-legacy [115.205733] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [115.258318] [096/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [115.544252] Starting subtest: basic-flip-after-cursor-atomic [116.634477] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.016s) [117.214112] [097/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [117.528622] Starting subtest: basic-flip-after-cursor-legacy [118.572226] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.046s) [118.954691] [098/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [119.258374] Starting subtest: basic-flip-after-cursor-varying-size [120.287837] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.029s) [120.687136] [099/165] (886s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [120.983857] Starting subtest: basic-flip-before-cursor-atomic [122.003346] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.022s) [122.413609] [100/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [122.701518] Starting subtest: basic-flip-before-cursor-legacy [123.740253] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.040s) [124.142984] [101/165] (883s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [124.448294] Starting subtest: basic-flip-before-cursor-varying-size [125.489156] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.041s) [125.918769] [102/165] (881s left) kms_dsc (dsc-basic) [126.216666] Subtest dsc-basic: SKIP (0.000s) [126.251451] [103/165] (881s left) kms_flip (basic-flip-vs-dpms) [126.515214] Starting subtest: basic-flip-vs-dpms [126.517948] Starting dynamic subtest: A-DP1 [127.632217] Dynamic subtest A-DP1: SUCCESS (1.114s) [127.645972] Starting dynamic subtest: B-DP1 [128.650022] Dynamic subtest B-DP1: SUCCESS (1.019s) [128.663919] Starting dynamic subtest: C-DP1 [129.649373] Dynamic subtest C-DP1: SUCCESS (0.995s) [129.662331] Starting dynamic subtest: A-DP2 [130.547136] Dynamic subtest A-DP2: SUCCESS (0.890s) [130.559358] Starting dynamic subtest: B-DP2 [131.450921] Dynamic subtest B-DP2: SUCCESS (0.905s) [131.461448] Starting dynamic subtest: C-DP2 [132.186223] Dynamic subtest C-DP2: SUCCESS (0.733s) [132.188947] Subtest basic-flip-vs-dpms: SUCCESS (5.674s) [132.644945] [104/165] (875s left) kms_flip (basic-flip-vs-modeset) [132.936851] Starting subtest: basic-flip-vs-modeset [132.939783] Starting dynamic subtest: A-DP1 [134.067399] Dynamic subtest A-DP1: SUCCESS (1.124s) [134.077254] Starting dynamic subtest: B-DP1 [135.050406] Dynamic subtest B-DP1: SUCCESS (0.978s) [135.069636] Starting dynamic subtest: C-DP1 [136.042893] Dynamic subtest C-DP1: SUCCESS (0.993s) [136.057355] Starting dynamic subtest: A-DP2 [136.917465] Dynamic subtest A-DP2: SUCCESS (0.870s) [136.928443] Starting dynamic subtest: B-DP2 [137.604527] Dynamic subtest B-DP2: SUCCESS (0.683s) [137.615285] Starting dynamic subtest: C-DP2 [138.526319] Dynamic subtest C-DP2: SUCCESS (0.916s) [138.530401] Subtest basic-flip-vs-modeset: SUCCESS (5.589s) [139.038927] [105/165] (868s left) kms_flip (basic-flip-vs-wf_vblank) [139.320573] Starting subtest: basic-flip-vs-wf_vblank [139.323343] Starting dynamic subtest: A-DP1 [140.655126] Dynamic subtest A-DP1: SUCCESS (1.220s) [140.720749] Starting dynamic subtest: B-DP1 [141.696306] Dynamic subtest B-DP1: SUCCESS (1.147s) [141.707644] Starting dynamic subtest: C-DP1 [142.818167] Dynamic subtest C-DP1: SUCCESS (1.120s) [142.830712] Starting dynamic subtest: A-DP2 [143.885657] Dynamic subtest A-DP2: SUCCESS (1.065s) [143.898188] Starting dynamic subtest: B-DP2 [144.958977] Dynamic subtest B-DP2: SUCCESS (1.073s) [144.971708] Starting dynamic subtest: C-DP2 [146.003636] Dynamic subtest C-DP2: SUCCESS (1.042s) [146.006823] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.690s) [146.531246] [106/165] (861s left) kms_flip (basic-plain-flip) [146.807261] Starting subtest: basic-plain-flip [146.810517] Starting dynamic subtest: A-DP1 [147.723114] Dynamic subtest A-DP1: SUCCESS (0.905s) [147.747547] Starting dynamic subtest: B-DP1 [148.632384] Dynamic subtest B-DP1: SUCCESS (0.911s) [148.645366] Starting dynamic subtest: C-DP1 [149.489431] Dynamic subtest C-DP1: SUCCESS (0.857s) [149.502119] Starting dynamic subtest: A-DP2 [150.381815] Dynamic subtest A-DP2: SUCCESS (0.782s) [150.448830] Starting dynamic subtest: B-DP2 [151.139235] Dynamic subtest B-DP2: SUCCESS (0.770s) [151.301552] Starting dynamic subtest: C-DP2 [151.903222] Dynamic subtest C-DP2: SUCCESS (0.760s) [151.971062] Subtest basic-plain-flip: SUCCESS (5.003s) [152.490550] [107/165] (855s left) kms_force_connector_basic (force-connector-state) [152.947424] Starting subtest: force-connector-state [153.567970] Subtest force-connector-state: SUCCESS (0.617s) [154.520390] [108/165] (853s left) kms_force_connector_basic (force-edid) [154.675749] Starting subtest: force-edid [154.782275] Subtest force-edid: SUCCESS (0.107s) [155.303997] [109/165] (852s left) kms_force_connector_basic (force-load-detect) [155.427478] Starting subtest: force-load-detect [155.433550] Subtest force-load-detect: SKIP (0.000s) [155.767625] [110/165] (852s left) kms_force_connector_basic (prune-stale-modes) [155.924750] Starting subtest: prune-stale-modes [156.034267] Subtest prune-stale-modes: SUCCESS (0.108s) [156.555262] [111/165] (851s left) kms_frontbuffer_tracking (basic) [156.877347] Starting subtest: basic [159.586052] Subtest basic: SUCCESS (2.715s) [159.861868] [112/165] (848s left) kms_hdmi_inject (inject-audio) [160.059637] Starting subtest: inject-audio [160.238274] Subtest inject-audio: SUCCESS (0.180s) [160.917639] [113/165] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [161.205260] Starting subtest: compare-crc-sanitycheck-xr24 [161.208074] Starting dynamic subtest: pipe-A-DP-1 [161.821583] Dynamic subtest pipe-A-DP-1: SUCCESS (0.615s) [161.837076] Starting dynamic subtest: pipe-B-DP-2 [162.300414] Dynamic subtest pipe-B-DP-2: SUCCESS (0.474s) [162.310739] Starting dynamic subtest: pipe-C-DP-1 [162.852195] Dynamic subtest pipe-C-DP-1: SUCCESS (0.542s) [162.856186] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.644s) [163.266969] [114/165] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [163.558898] Starting subtest: compare-crc-sanitycheck-nv12 [163.561752] Starting dynamic subtest: pipe-A-DP-1 [164.263738] Dynamic subtest pipe-A-DP-1: SUCCESS (0.618s) [164.328927] Starting dynamic subtest: pipe-B-DP-2 [164.791134] Dynamic subtest pipe-B-DP-2: SUCCESS (0.488s) [164.857293] Starting dynamic subtest: pipe-C-DP-1 [164.989833] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [165.055769] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.116s) [165.296871] [115/165] (843s left) kms_pipe_crc_basic (hang-read-crc) [165.739544] Starting subtest: hang-read-crc [165.742640] Starting dynamic subtest: pipe-A-DP-1 [167.116562] Dynamic subtest pipe-A-DP-1: SUCCESS (1.372s) [167.137345] Starting dynamic subtest: pipe-B-DP-2 [168.300083] Dynamic subtest pipe-B-DP-2: SUCCESS (1.182s) [168.315383] Starting dynamic subtest: pipe-C-DP-1 [169.660289] Dynamic subtest pipe-C-DP-1: SUCCESS (1.352s) [169.664375] Subtest hang-read-crc: SUCCESS (3.921s) [170.075200] [116/165] (838s left) kms_pipe_crc_basic (nonblocking-crc) [170.361942] Starting subtest: nonblocking-crc [170.364729] Starting dynamic subtest: pipe-A-DP-1 [171.127250] Dynamic subtest pipe-A-DP-1: SUCCESS (0.758s) [171.142015] Starting dynamic subtest: pipe-B-DP-2 [171.783527] Dynamic subtest pipe-B-DP-2: SUCCESS (0.657s) [171.794346] Starting dynamic subtest: pipe-C-DP-1 [172.508705] Dynamic subtest pipe-C-DP-1: SUCCESS (0.717s) [172.512123] Subtest nonblocking-crc: SUCCESS (2.146s) [172.880842] [117/165] (835s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [173.168819] Starting subtest: nonblocking-crc-frame-sequence [173.171655] Starting dynamic subtest: pipe-A-DP-1 [173.934440] Dynamic subtest pipe-A-DP-1: SUCCESS (0.760s) [173.954600] Starting dynamic subtest: pipe-B-DP-2 [174.607711] Dynamic subtest pipe-B-DP-2: SUCCESS (0.672s) [174.622755] Starting dynamic subtest: pipe-C-DP-1 [175.339725] Dynamic subtest pipe-C-DP-1: SUCCESS (0.722s) [175.343416] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.171s) [175.728506] [118/165] (832s left) kms_pipe_crc_basic (read-crc) [176.069871] Starting subtest: read-crc [176.072617] Starting dynamic subtest: pipe-A-DP-1 [176.774722] Dynamic subtest pipe-A-DP-1: SUCCESS (0.703s) [176.787454] Starting dynamic subtest: pipe-B-DP-2 [177.369601] Dynamic subtest pipe-B-DP-2: SUCCESS (0.592s) [177.380371] Starting dynamic subtest: pipe-C-DP-1 [178.038839] Dynamic subtest pipe-C-DP-1: SUCCESS (0.665s) [178.042015] Subtest read-crc: SUCCESS (1.971s) [178.443100] [119/165] (830s left) kms_pipe_crc_basic (read-crc-frame-sequence) [178.750867] Starting subtest: read-crc-frame-sequence [178.753734] Starting dynamic subtest: pipe-A-DP-1 [179.447348] Dynamic subtest pipe-A-DP-1: SUCCESS (0.693s) [179.464287] Starting dynamic subtest: pipe-B-DP-2 [180.043158] Dynamic subtest pipe-B-DP-2: SUCCESS (0.590s) [180.057388] Starting dynamic subtest: pipe-C-DP-1 [180.709289] Dynamic subtest pipe-C-DP-1: SUCCESS (0.661s) [180.713325] Subtest read-crc-frame-sequence: SUCCESS (1.958s) [181.107842] [120/165] (827s left) kms_pm_backlight (basic-brightness) [181.408437] Subtest basic-brightness: SKIP (0.000s) [181.439869] [121/165] (827s left) kms_pm_rpm (basic-pci-d3-state) [183.496936] Starting subtest: basic-pci-d3-state [184.252278] Subtest basic-pci-d3-state: SUCCESS (0.900s) [184.830886] [122/165] (824s left) kms_pm_rpm (basic-rte) [185.097682] Starting subtest: basic-rte [187.729106] Subtest basic-rte: SUCCESS (2.628s) [189.040997] [123/165] (819s left) kms_psr (primary_page_flip) [189.145694] Subtest primary_page_flip: SKIP (0.000s) [189.170101] [124/165] (819s left) kms_psr (cursor_plane_move) [189.241072] Subtest cursor_plane_move: SKIP (0.000s) [189.269398] [125/165] (819s left) kms_psr (sprite_plane_onoff) [189.341780] Subtest sprite_plane_onoff: SKIP (0.000s) [189.369951] [126/165] (819s left) kms_psr (primary_mmap_gtt) [189.437025] Subtest primary_mmap_gtt: SKIP (0.000s) [189.477273] [127/165] (819s left) kms_setmode (basic-clone-single-crtc) [189.566983] Starting subtest: basic-clone-single-crtc [189.763078] Subtest basic-clone-single-crtc: SKIP (0.197s) [190.173588] [128/165] (818s left) i915_pm_rps (basic-api) [190.247647] Starting subtest: basic-api [190.251163] Subtest basic-api: SUCCESS (0.004s) [190.326198] [129/165] (818s left) prime_self_import (basic-llseek-bad) [190.398443] Starting subtest: basic-llseek-bad [190.404456] Subtest basic-llseek-bad: SUCCESS (0.002s) [190.499403] [130/165] (818s left) prime_self_import (basic-llseek-size) [190.580293] Starting subtest: basic-llseek-size [190.586774] Subtest basic-llseek-size: SUCCESS (0.003s) [190.704083] [131/165] (818s left) prime_self_import (basic-with_fd_dup) [190.785263] Starting subtest: basic-with_fd_dup [190.791634] Subtest basic-with_fd_dup: SUCCESS (0.003s) [190.918198] [132/165] (818s left) prime_self_import (basic-with_one_bo) [190.998908] Starting subtest: basic-with_one_bo [191.005539] Subtest basic-with_one_bo: SUCCESS (0.003s) [191.064062] [133/165] (818s left) prime_self_import (basic-with_one_bo_two_files) [191.155067] Starting subtest: basic-with_one_bo_two_files [191.161416] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [191.258911] [134/165] (818s left) prime_self_import (basic-with_two_bos) [191.329207] Starting subtest: basic-with_two_bos [191.336703] Subtest basic-with_two_bos: SUCCESS (0.004s) [191.419809] [135/165] (817s left) prime_vgem (basic-fence-flip) [191.528226] Starting subtest: basic-fence-flip [192.169844] Subtest basic-fence-flip: SUCCESS (0.643s) [192.297303] [136/165] (817s left) prime_vgem (basic-fence-mmap) [192.388412] Starting subtest: basic-fence-mmap [192.430057] Subtest basic-fence-mmap: SUCCESS (0.042s) [192.549678] [137/165] (816s left) prime_vgem (basic-fence-read) [192.631243] Starting subtest: basic-fence-read [192.682995] Subtest basic-fence-read: SUCCESS (0.052s) [192.781157] [138/165] (816s left) prime_vgem (basic-gtt) [192.908983] Starting subtest: basic-gtt [192.933513] Subtest basic-gtt: SUCCESS (0.024s) [193.032832] [139/165] (816s left) prime_vgem (basic-read) [193.131773] Starting subtest: basic-read [193.155954] Subtest basic-read: SUCCESS (0.026s) [193.258071] [140/165] (816s left) prime_vgem (basic-write) [193.359289] Starting subtest: basic-write [193.379167] Subtest basic-write: SUCCESS (0.024s) [193.466130] [141/165] (816s left) vgem_basic (setversion) [193.554788] Starting subtest: setversion [193.561630] Subtest setversion: SUCCESS (0.000s) [193.623951] [142/165] (816s left) vgem_basic (create) [193.721807] Starting subtest: create [193.725531] Subtest create: SUCCESS (0.000s) [193.776755] [143/165] (815s left) vgem_basic (debugfs) [193.851832] Starting subtest: debugfs [193.854705] Subtest debugfs: SUCCESS (0.000s) [193.905956] [144/165] (815s left) vgem_basic (dmabuf-export) [194.019401] Starting subtest: dmabuf-export [194.026299] Subtest dmabuf-export: SUCCESS (0.002s) [194.130078] [145/165] (815s left) vgem_basic (dmabuf-fence) [194.222144] Starting subtest: dmabuf-fence [194.225211] Subtest dmabuf-fence: SUCCESS (0.001s) [194.295146] [146/165] (815s left) vgem_basic (dmabuf-fence-before) [194.386867] Starting subtest: dmabuf-fence-before [194.390549] Subtest dmabuf-fence-before: SUCCESS (0.001s) [194.449137] [147/165] (815s left) vgem_basic (dmabuf-mmap) [194.536790] Starting subtest: dmabuf-mmap [194.546579] Subtest dmabuf-mmap: SUCCESS (0.014s) [194.604517] [148/165] (815s left) vgem_basic (mmap) [194.686620] Starting subtest: mmap [194.693506] Subtest mmap: SUCCESS (0.009s) [194.750147] [149/165] (815s left) vgem_basic (second-client) [194.835714] Starting subtest: second-client [194.871572] Subtest second-client: SUCCESS (0.033s) [194.943798] [150/165] (815s left) vgem_basic (sysfs) [195.037280] Starting subtest: sysfs [195.040701] Subtest sysfs: SUCCESS (0.000s) [195.089841] [151/165] (814s left) core_hotunplug (unbind-rebind) [195.219402] Starting subtest: unbind-rebind [198.719074] Subtest unbind-rebind: SUCCESS (3.499s) [198.761676] [152/165] (811s left) vgem_basic (unload) [198.831840] Starting subtest: unload [227.858975] Subtest unload: SUCCESS (29.022s) [227.986456] [153/165] (782s left) i915_module_load (reload) [228.057735] Starting subtest: reload [230.857797] Subtest reload: SUCCESS (2.793s) [230.888822] [154/165] (779s left) gem_lmem_swapping (basic) [231.014201] Subtest basic: SKIP (0.000s) [231.043795] [155/165] (779s left) gem_lmem_swapping (parallel-random-engines) [231.114568] Subtest parallel-random-engines: SKIP (0.000s) [231.143559] [156/165] (779s left) gem_lmem_swapping (random-engines) [231.216403] Subtest random-engines: SKIP (0.000s) [231.243783] [157/165] (778s left) gem_lmem_swapping (verify-random) [231.322240] Subtest verify-random: SKIP (0.000s) [231.367121] [158/165] (778s left) i915_pm_rpm (module-reload) [233.835389] Starting subtest: module-reload [241.182357] Subtest module-reload: SUCCESS (7.355s) [241.202860] [159/165] (769s left) i915_selftest (live) [241.282256] Starting subtest: live [241.285212] Starting dynamic subtest: sanitycheck [241.954168] Dynamic subtest sanitycheck: SUCCESS (0.671s) [241.964925] Starting dynamic subtest: uncore [242.646287] Dynamic subtest uncore: SUCCESS (0.690s) [242.655843] Starting dynamic subtest: workarounds [243.571056] Dynamic subtest workarounds: SUCCESS (0.923s) [243.581878] Starting dynamic subtest: gt_engines [244.811341] Dynamic subtest gt_engines: SUCCESS (1.238s) [244.821490] Starting dynamic subtest: gt_timelines [256.149790] Dynamic subtest gt_timelines: SUCCESS (11.337s) [256.159284] Starting dynamic subtest: gt_contexts [256.993987] Dynamic subtest gt_contexts: SUCCESS (0.842s) [257.003305] Starting dynamic subtest: gt_lrc [260.652195] Dynamic subtest gt_lrc: SUCCESS (3.656s) [260.662310] Starting dynamic subtest: gt_mocs [261.426120] Dynamic subtest gt_mocs: SUCCESS (0.772s) [261.435621] Starting dynamic subtest: gt_pm [268.011916] Dynamic subtest gt_pm: SUCCESS (6.584s) [268.020185] Starting dynamic subtest: gt_heartbeat [268.861691] Dynamic subtest gt_heartbeat: SUCCESS (0.807s) [268.929170] Starting dynamic subtest: gt_tlb [270.596154] Dynamic subtest gt_tlb: SUCCESS (1.740s) [270.663849] Starting dynamic subtest: requests [278.720947] Dynamic subtest requests: SUCCESS (8.157s) [278.729793] Starting dynamic subtest: migrate [282.133969] Dynamic subtest migrate: SUCCESS (3.411s) [282.144874] Starting dynamic subtest: active [282.796081] Dynamic subtest active: SUCCESS (0.660s) [282.806228] Starting dynamic subtest: objects [284.495056] Dynamic subtest objects: SUCCESS (1.697s) [284.506894] Starting dynamic subtest: mman [289.032965] Dynamic subtest mman: SUCCESS (4.536s) [289.042368] Starting dynamic subtest: dmabuf [289.814953] Dynamic subtest dmabuf: SUCCESS (0.780s) [289.823806] Starting dynamic subtest: vma [290.543281] Dynamic subtest vma: SUCCESS (0.724s) [290.552738] Starting dynamic subtest: coherency [292.171258] Dynamic subtest coherency: SUCCESS (1.626s) [292.180699] Starting dynamic subtest: gtt [300.057961] Dynamic subtest gtt: SUCCESS (7.887s) [300.066504] Starting dynamic subtest: gem [300.931270] Dynamic subtest gem: SUCCESS (0.869s) [300.940682] Starting dynamic subtest: evict [303.299266] Dynamic subtest evict: SUCCESS (2.366s) [303.308077] Starting dynamic subtest: hugepages [310.479875] Dynamic subtest hugepages: SUCCESS (7.181s) [310.488933] Starting dynamic subtest: gem_contexts [327.065058] Dynamic subtest gem_contexts: SUCCESS (16.583s) [327.075044] Starting dynamic subtest: client [327.831049] Dynamic subtest client: SUCCESS (0.765s) [327.842447] Starting dynamic subtest: gem_migrate [328.532401] Dynamic subtest gem_migrate: SUCCESS (0.696s) [328.545263] Starting dynamic subtest: reset [330.046999] Dynamic subtest reset: SUCCESS (1.516s) [330.058291] Starting dynamic subtest: memory_region [330.760808] Dynamic subtest memory_region: SUCCESS (0.712s) [330.770422] Starting dynamic subtest: hangcheck [359.999076] Dynamic subtest hangcheck: SUCCESS (29.236s) [360.010304] Starting dynamic subtest: execlists [373.173186] Dynamic subtest execlists: SUCCESS (13.172s) [373.183550] Starting dynamic subtest: ring_submission [373.878192] Dynamic subtest ring_submission: SUCCESS (0.701s) [373.889989] Starting dynamic subtest: perf [374.635224] Dynamic subtest perf: SUCCESS (0.757s) [374.647928] Starting dynamic subtest: slpc [375.323062] Dynamic subtest slpc: SUCCESS (0.686s) [375.333682] Starting dynamic subtest: guc [376.020165] Dynamic subtest guc: SUCCESS (0.696s) [376.031603] Starting dynamic subtest: guc_multi_lrc [376.722026] Dynamic subtest guc_multi_lrc: SUCCESS (0.700s) [376.731690] Starting dynamic subtest: guc_hang [377.412998] Dynamic subtest guc_hang: SUCCESS (0.690s) [377.424274] Starting dynamic subtest: late_gt_pm [378.174113] Dynamic subtest late_gt_pm: SUCCESS (0.760s) [378.177484] Subtest live: SUCCESS (136.893s) [378.203937] [160/165] (632s left) dmabuf (all-tests) [378.283582] Starting subtest: all-tests [378.290383] Starting dynamic subtest: sanitycheck [378.352835] Dynamic subtest sanitycheck: SUCCESS (0.068s) [378.372607] Starting dynamic subtest: dma_fence [378.537567] Dynamic subtest dma_fence: SUCCESS (0.182s) [378.550627] Starting dynamic subtest: dma_fence_chain [393.370890] Dynamic subtest dma_fence_chain: SUCCESS (14.831s) [393.388566] Starting dynamic subtest: dma_fence_unwrap [393.440281] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s) [393.460602] Starting dynamic subtest: dma_resv [393.518165] Dynamic subtest dma_resv: SUCCESS (0.075s) [393.522285] Subtest all-tests: SUCCESS (15.235s) [393.560391] [161/165] (616s left) i915_suspend (basic-s2idle-without-i915) [393.643228] Starting subtest: basic-s2idle-without-i915 [412.989072] Subtest basic-s2idle-without-i915: SUCCESS (3.648s) [416.658021] [162/165] (612s left) i915_suspend (basic-s3-without-i915) [416.737885] Starting subtest: basic-s3-without-i915 [435.696571] Subtest basic-s3-without-i915: SUCCESS (3.125s) [439.346229] [163/165] (608s left) gem_exec_suspend (basic-s0) [439.439841] Starting subtest: basic-S0 [439.443002] Starting dynamic subtest: smem [458.093896] Dynamic subtest smem: SUCCESS (2.897s) [458.097645] Subtest basic-S0: SUCCESS (2.899s) [463.279592] [164/165] (605s left) gem_exec_suspend (basic-s3) [463.356711] Starting subtest: basic-S3 [463.359848] Starting dynamic subtest: smem [482.754042] Dynamic subtest smem: SUCCESS (3.452s) [482.757945] Subtest basic-S3: SUCCESS (3.455s) [485.941606] [165/165] (601s left) kms_pipe_crc_basic (suspend-read-crc) [486.237932] Starting subtest: suspend-read-crc [486.241044] Starting dynamic subtest: pipe-A-DP-1 [505.710239] Dynamic subtest pipe-A-DP-1: SUCCESS (2.883s) [505.727560] Starting dynamic subtest: pipe-B-DP-2 [524.710768] Dynamic subtest pipe-B-DP-2: SUCCESS (2.784s) [524.724262] Starting dynamic subtest: pipe-C-DP-1 [544.791575] Dynamic subtest pipe-C-DP-1: SUCCESS (2.862s) [544.794747] Subtest suspend-read-crc: SUCCESS (8.540s) [549.182475] Closing watchdogs Done.