[43.302611] Initializing watchdogs [43.302692] /dev/watchdog0 [43.310754] [001/165] (960s left) i915_module_load (load) [43.388589] Starting subtest: load [45.625021] Subtest load: SUCCESS (2.240s) [45.646957] [002/165] (958s left) core_auth (basic-auth) [45.730719] Starting subtest: basic-auth [45.734110] Subtest basic-auth: SUCCESS (0.001s) [45.797593] [003/165] (958s left) debugfs_test (read_all_entries) [45.892390] Starting subtest: read_all_entries [46.028448] Subtest read_all_entries: SUCCESS (0.134s) [46.326661] [004/165] (957s left) debugfs_test (basic-hwmon) [46.396683] Starting subtest: basic-hwmon [46.402649] Subtest basic-hwmon: SKIP (0.000s) [46.678253] [005/165] (957s left) fbdev (eof) [46.759304] Starting subtest: eof [46.762646] Subtest eof: SUCCESS (0.001s) [46.811280] [006/165] (957s left) fbdev (info) [46.876753] Starting subtest: info [46.880237] Subtest info: SUCCESS (0.000s) [46.951900] [007/165] (956s left) fbdev (nullptr) [47.042170] Starting subtest: nullptr [47.045417] Subtest nullptr: SUCCESS (0.000s) [47.093318] [008/165] (956s left) fbdev (read) [47.175835] Starting subtest: read [47.465032] Subtest read: SUCCESS (0.258s) [47.787359] [009/165] (956s left) fbdev (write) [48.177537] Starting subtest: write [48.244481] Subtest write: SUCCESS (0.153s) [48.752753] [010/165] (955s left) gem_basic (bad-close) [48.841168] Starting subtest: bad-close [48.850049] Subtest bad-close: SUCCESS (0.000s) [48.914533] [011/165] (955s left) gem_basic (create-close) [49.007126] Starting subtest: create-close [49.014295] Subtest create-close: SUCCESS (0.000s) [49.122103] [012/165] (955s left) gem_basic (create-fd-close) [49.192163] Starting subtest: create-fd-close [49.198934] Subtest create-fd-close: SUCCESS (0.000s) [49.269438] [013/165] (955s left) gem_busy (busy@all-engines) [49.369631] Starting subtest: busy [49.372780] Starting dynamic subtest: all-engines [49.424559] Dynamic subtest all-engines: SUCCESS (0.056s) [49.427757] Subtest busy: SUCCESS (0.056s) [49.817152] [014/165] (954s left) gem_close_race (basic-process) [49.905264] Starting subtest: basic-process [49.962727] Subtest basic-process: SUCCESS (0.057s) [50.169629] [015/165] (954s left) gem_close_race (basic-threads) [50.248668] Starting subtest: basic-threads [51.475793] Subtest basic-threads: SUCCESS (1.227s) [51.693726] [016/165] (953s left) gem_ctx_create (basic) [51.799950] Starting subtest: basic [51.803237] Subtest basic: SUCCESS (0.000s) [52.004391] [017/165] (952s left) gem_ctx_create (basic-files) [52.082812] Starting subtest: basic-files [54.100094] Subtest basic-files: SUCCESS (2.018s) [54.340455] [018/165] (950s left) gem_ctx_exec (basic) [54.437517] Starting subtest: basic [54.440581] Subtest basic: SUCCESS (0.004s) [54.554292] [019/165] (950s left) gem_exec_basic (basic) [54.646742] Starting subtest: basic [54.649877] Starting dynamic subtest: rcs0-smem [54.653091] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [54.662289] Starting dynamic subtest: bcs0-smem [54.665838] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [54.674195] Starting dynamic subtest: vcs0-smem [54.677683] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [54.685964] Starting dynamic subtest: vcs1-smem [54.689251] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [54.697596] Starting dynamic subtest: vecs0-smem [54.700805] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [54.703808] Subtest basic: SUCCESS (0.006s) [54.886115] [020/165] (949s left) gem_exec_create (basic) [54.962065] Starting subtest: basic [54.965336] Starting dynamic subtest: smem [57.002344] Dynamic subtest smem: SUCCESS (2.040s) [57.005628] Subtest basic: SUCCESS (2.040s) [57.207818] [021/165] (947s left) gem_exec_fence (basic-busy) [57.453246] Starting subtest: basic-busy [57.457910] Starting dynamic subtest: rcs0 [57.482529] Dynamic subtest rcs0: SUCCESS (0.033s) [57.498648] Starting dynamic subtest: bcs0 [57.514222] Dynamic subtest bcs0: SUCCESS (0.032s) [57.530995] Starting dynamic subtest: vcs0 [57.548045] Dynamic subtest vcs0: SUCCESS (0.034s) [57.557822] Starting dynamic subtest: vcs1 [57.573816] Dynamic subtest vcs1: SUCCESS (0.026s) [57.584146] Starting dynamic subtest: vecs0 [57.599937] Dynamic subtest vecs0: SUCCESS (0.026s) [57.603146] Subtest basic-busy: SUCCESS (0.152s) [58.282068] [022/165] (946s left) gem_exec_fence (basic-wait) [58.516453] Starting subtest: basic-wait [58.520738] Starting dynamic subtest: rcs0 [58.547196] Dynamic subtest rcs0: SUCCESS (0.031s) [58.565769] Starting dynamic subtest: bcs0 [58.587464] Dynamic subtest bcs0: SUCCESS (0.040s) [58.600043] Starting dynamic subtest: vcs0 [58.612474] Dynamic subtest vcs0: SUCCESS (0.025s) [58.624591] Starting dynamic subtest: vcs1 [58.643125] Dynamic subtest vcs1: SUCCESS (0.030s) [58.661274] Starting dynamic subtest: vecs0 [58.679225] Dynamic subtest vecs0: SUCCESS (0.036s) [58.683254] Subtest basic-wait: SUCCESS (0.163s) [59.327330] [023/165] (945s left) gem_exec_fence (basic-await) [59.548410] Starting subtest: basic-await [59.551791] Starting dynamic subtest: rcs0 [59.654973] Dynamic subtest rcs0: SUCCESS (0.105s) [59.666099] Starting dynamic subtest: bcs0 [59.760222] Dynamic subtest bcs0: SUCCESS (0.106s) [59.773274] Starting dynamic subtest: vcs0 [59.868183] Dynamic subtest vcs0: SUCCESS (0.108s) [59.880119] Starting dynamic subtest: vcs1 [59.979873] Dynamic subtest vcs1: SUCCESS (0.111s) [59.992019] Starting dynamic subtest: vecs0 [60.094531] Dynamic subtest vecs0: SUCCESS (0.114s) [60.097973] Subtest basic-await: SUCCESS (0.547s) [60.723312] [024/165] (944s left) gem_exec_fence (nb-await) [60.978508] Starting subtest: nb-await [60.983215] Starting dynamic subtest: rcs0 [61.054117] Dynamic subtest rcs0: SUCCESS (0.076s) [61.071138] Starting dynamic subtest: bcs0 [61.127083] Dynamic subtest bcs0: SUCCESS (0.072s) [61.145128] Starting dynamic subtest: vcs0 [61.203601] Dynamic subtest vcs0: SUCCESS (0.074s) [61.227772] Starting dynamic subtest: vcs1 [61.281294] Dynamic subtest vcs1: SUCCESS (0.079s) [61.302464] Starting dynamic subtest: vecs0 [61.356728] Dynamic subtest vecs0: SUCCESS (0.076s) [61.360517] Subtest nb-await: SUCCESS (0.379s) [61.951878] [025/165] (943s left) gem_exec_gttfill (basic) [62.044373] Starting subtest: basic [66.618414] Subtest basic: SUCCESS (4.574s) [66.801213] [026/165] (938s left) gem_exec_parallel (engines) [66.957277] Starting subtest: engines [66.960542] Starting dynamic subtest: basic [68.919900] Dynamic subtest basic: SUCCESS (1.964s) [68.929121] Starting dynamic subtest: contexts [74.093140] Dynamic subtest contexts: SUCCESS (5.173s) [74.102074] Starting dynamic subtest: fds [78.206161] Dynamic subtest fds: SUCCESS (4.113s) [78.215193] Starting dynamic subtest: userptr [80.230777] Dynamic subtest userptr: SUCCESS (2.023s) [80.234501] Subtest engines: SUCCESS (13.274s) [80.434100] [027/165] (924s left) gem_exec_store (basic) [80.536099] Starting subtest: basic [80.584322] Subtest basic: SUCCESS (0.053s) [80.796860] [028/165] (924s left) gem_flink_basic (bad-flink) [80.864937] Starting subtest: bad-flink [80.868141] Subtest bad-flink: SUCCESS (0.000s) [80.934569] [029/165] (924s left) gem_flink_basic (bad-open) [81.014768] Starting subtest: bad-open [81.018074] Subtest bad-open: SUCCESS (0.000s) [81.092558] [030/165] (924s left) gem_flink_basic (basic) [81.172171] Starting subtest: basic [81.175535] Subtest basic: SUCCESS (0.000s) [81.280847] [031/165] (923s left) gem_flink_basic (double-flink) [81.376150] Starting subtest: double-flink [81.379344] Subtest double-flink: SUCCESS (0.000s) [81.463862] [032/165] (923s left) gem_flink_basic (flink-lifetime) [81.539957] Starting subtest: flink-lifetime [81.543259] Subtest flink-lifetime: SUCCESS (0.001s) [81.633928] [033/165] (923s left) gem_huc_copy (huc-copy) [81.725852] Starting subtest: huc-copy [81.732664] Subtest huc-copy: SKIP (0.000s) [81.836979] [034/165] (923s left) gem_linear_blits (basic) [82.028186] Starting subtest: basic [82.038066] Subtest basic: SUCCESS (0.009s) [82.180856] [035/165] (923s left) gem_mmap (basic) [82.353630] Starting subtest: basic [82.369697] Subtest basic: SUCCESS (0.000s) [82.439185] [036/165] (923s left) gem_mmap_gtt (basic) [82.516977] Starting subtest: basic [82.520572] Subtest basic: SUCCESS (0.002s) [82.571574] [037/165] (922s left) gem_render_linear_blits (basic) [82.641607] Starting subtest: basic [82.675178] Subtest basic: SUCCESS (0.034s) [82.721161] [038/165] (922s left) gem_render_tiled_blits (basic) [82.787451] Starting subtest: basic [82.821125] Subtest basic: SUCCESS (0.034s) [82.865920] [039/165] (922s left) gem_ringfill (basic-all) [83.166670] Starting subtest: basic-all [84.348944] Subtest basic-all: SUCCESS (1.184s) [84.451068] [040/165] (921s left) gem_softpin (allocator-basic) [84.536408] Starting subtest: allocator-basic [84.650327] Subtest allocator-basic: SUCCESS (0.114s) [84.762375] [041/165] (920s left) gem_softpin (allocator-basic-reserve) [84.857781] Starting subtest: allocator-basic-reserve [84.978210] Subtest allocator-basic-reserve: SUCCESS (0.119s) [85.084879] [042/165] (920s left) gem_softpin (safe-alignment) [85.174688] Starting subtest: safe-alignment [85.188752] Subtest safe-alignment: SUCCESS (0.014s) [85.299854] [043/165] (920s left) gem_sync (basic-all) [85.415238] Starting subtest: basic-all [87.709459] Subtest basic-all: SUCCESS (2.313s) [87.918157] [044/165] (917s left) gem_sync (basic-each) [88.039195] Starting subtest: basic-each [90.254633] Subtest basic-each: SUCCESS (2.229s) [90.467806] [045/165] (915s left) gem_tiled_blits (basic) [90.669977] Starting subtest: basic [90.690210] Subtest basic: SUCCESS (0.021s) [90.819070] [046/165] (914s left) gem_tiled_fence_blits (basic) [91.092602] Starting subtest: basic [91.102648] Subtest basic: SUCCESS (0.010s) [91.255367] [047/165] (914s left) gem_tiled_pread_basic [91.669034] [048/165] (914s left) gem_wait (busy@all-engines) [91.765552] Starting subtest: busy [91.771273] Starting dynamic subtest: all-engines [92.286165] Dynamic subtest all-engines: SUCCESS (0.520s) [92.289190] Subtest busy: SUCCESS (0.521s) [92.507656] [049/165] (913s left) gem_wait (wait@all-engines) [92.606110] Starting subtest: wait [92.609281] Starting dynamic subtest: all-engines [93.634115] Dynamic subtest all-engines: SUCCESS (1.027s) [93.638039] Subtest wait: SUCCESS (1.028s) [93.901243] [050/165] (912s left) i915_getparams_basic (basic-eu-total) [93.970911] Starting subtest: basic-eu-total [93.978102] Subtest basic-eu-total: SUCCESS (0.000s) [94.032262] [051/165] (911s left) i915_getparams_basic (basic-subslice-total) [94.110455] Starting subtest: basic-subslice-total [94.117065] Subtest basic-subslice-total: SUCCESS (0.000s) [94.175940] [052/165] (911s left) i915_hangman (error-state-basic) [94.258933] Starting subtest: error-state-basic [94.267640] Subtest error-state-basic: SUCCESS (0.006s) [94.347926] [053/165] (911s left) i915_pciid [94.484976] [054/165] (911s left) kms_addfb_basic (addfb25-4-tiled) [94.786624] Starting subtest: addfb25-4-tiled [94.789735] Subtest addfb25-4-tiled: SUCCESS (0.000s) [94.865475] [055/165] (911s left) kms_addfb_basic (addfb25-bad-modifier) [94.939885] Starting subtest: addfb25-bad-modifier [94.943273] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [95.248896] [056/165] (910s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.336984] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.340266] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [95.635351] [057/165] (910s left) kms_addfb_basic (addfb25-modifier-no-flag) [95.723394] Starting subtest: addfb25-modifier-no-flag [95.726574] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [96.015847] [058/165] (910s left) kms_addfb_basic (addfb25-x-tiled-legacy) [96.098018] Starting subtest: addfb25-x-tiled-legacy [96.101099] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.416511] [059/165] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.509525] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.512682] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [96.797766] [060/165] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [97.091557] Starting subtest: addfb25-yf-tiled-legacy [97.094417] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [97.175329] [061/165] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy) [97.467845] Starting subtest: addfb25-y-tiled-legacy [97.470460] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [97.548523] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.840483] Starting subtest: addfb25-y-tiled-small-legacy [97.843193] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [97.930401] [063/165] (908s left) kms_addfb_basic (bad-pitch-0) [98.016475] Starting subtest: bad-pitch-0 [98.019489] Subtest bad-pitch-0: SUCCESS (0.000s) [98.295849] [064/165] (908s left) kms_addfb_basic (bad-pitch-1024) [98.365533] Starting subtest: bad-pitch-1024 [98.368769] Subtest bad-pitch-1024: SUCCESS (0.000s) [98.664585] [065/165] (907s left) kms_addfb_basic (bad-pitch-128) [98.735919] Starting subtest: bad-pitch-128 [98.739022] Subtest bad-pitch-128: SUCCESS (0.000s) [99.043257] [066/165] (907s left) kms_addfb_basic (bad-pitch-256) [99.120598] Starting subtest: bad-pitch-256 [99.123624] Subtest bad-pitch-256: SUCCESS (0.000s) [99.432434] [067/165] (906s left) kms_addfb_basic (bad-pitch-32) [99.521290] Starting subtest: bad-pitch-32 [99.524317] Subtest bad-pitch-32: SUCCESS (0.000s) [99.832984] [068/165] (906s left) kms_addfb_basic (bad-pitch-63) [99.927545] Starting subtest: bad-pitch-63 [99.930635] Subtest bad-pitch-63: SUCCESS (0.000s) [100.236852] [069/165] (906s left) kms_addfb_basic (bad-pitch-65536) [100.326835] Starting subtest: bad-pitch-65536 [100.330195] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.637941] [070/165] (905s left) kms_addfb_basic (bad-pitch-999) [100.731038] Starting subtest: bad-pitch-999 [100.734258] Subtest bad-pitch-999: SUCCESS (0.000s) [101.029632] [071/165] (905s left) kms_addfb_basic (basic) [101.138469] Starting subtest: basic [101.141690] Subtest basic: SUCCESS (0.000s) [101.455651] [072/165] (905s left) kms_addfb_basic (basic-x-tiled-legacy) [101.545955] Starting subtest: basic-x-tiled-legacy [101.548834] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [101.855055] [073/165] (904s left) kms_addfb_basic (basic-y-tiled-legacy) [101.951249] Starting subtest: basic-y-tiled-legacy [101.954595] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [102.250644] [074/165] (904s left) kms_addfb_basic (bo-too-small) [102.546778] Starting subtest: bo-too-small [102.549431] Subtest bo-too-small: SUCCESS (0.000s) [102.629332] [075/165] (904s left) kms_addfb_basic (bo-too-small-due-to-tiling) [102.915645] Starting subtest: bo-too-small-due-to-tiling [102.918577] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [103.000283] [076/165] (903s left) kms_addfb_basic (clobberred-modifier) [103.082920] Starting subtest: clobberred-modifier [103.086053] Subtest clobberred-modifier: SUCCESS (0.000s) [103.386527] [077/165] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling) [103.476664] Starting subtest: framebuffer-vs-set-tiling [103.479985] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [103.779688] [078/165] (902s left) kms_addfb_basic (invalid-get-prop) [103.849978] Starting subtest: invalid-get-prop [103.853362] Subtest invalid-get-prop: SUCCESS (0.000s) [104.146882] [079/165] (902s left) kms_addfb_basic (invalid-get-prop-any) [104.254903] Starting subtest: invalid-get-prop-any [104.258529] Subtest invalid-get-prop-any: SUCCESS (0.000s) [104.552827] [080/165] (902s left) kms_addfb_basic (invalid-set-prop) [104.641487] Starting subtest: invalid-set-prop [104.644672] Subtest invalid-set-prop: SUCCESS (0.000s) [104.942751] [081/165] (901s left) kms_addfb_basic (invalid-set-prop-any) [105.042684] Starting subtest: invalid-set-prop-any [105.045978] Subtest invalid-set-prop-any: SUCCESS (0.000s) [105.345938] [082/165] (901s left) kms_addfb_basic (no-handle) [105.429177] Starting subtest: no-handle [105.432419] Subtest no-handle: SUCCESS (0.000s) [105.736466] [083/165] (901s left) kms_addfb_basic (size-max) [106.041962] Starting subtest: size-max [106.044645] Subtest size-max: SUCCESS (0.000s) [106.130593] [084/165] (900s left) kms_addfb_basic (small-bo) [106.434326] Starting subtest: small-bo [106.437117] Subtest small-bo: SUCCESS (0.000s) [106.522773] [085/165] (900s left) kms_addfb_basic (tile-pitch-mismatch) [106.630273] Starting subtest: tile-pitch-mismatch [106.633391] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.923835] [086/165] (900s left) kms_addfb_basic (too-high) [107.207284] Starting subtest: too-high [107.210143] Subtest too-high: SUCCESS (0.001s) [107.298128] [087/165] (899s left) kms_addfb_basic (too-wide) [107.622710] Starting subtest: too-wide [107.625715] Subtest too-wide: SUCCESS (0.000s) [107.697983] [088/165] (899s left) kms_addfb_basic (unused-handle) [107.774477] Starting subtest: unused-handle [107.777853] Subtest unused-handle: SUCCESS (0.000s) [108.074750] [089/165] (899s left) kms_addfb_basic (unused-modifier) [108.165445] Starting subtest: unused-modifier [108.168876] Subtest unused-modifier: SUCCESS (0.000s) [108.464226] [090/165] (898s left) kms_addfb_basic (unused-offsets) [108.550531] Starting subtest: unused-offsets [108.553770] Subtest unused-offsets: SUCCESS (0.000s) [108.848108] [091/165] (898s left) kms_addfb_basic (unused-pitches) [108.933459] Starting subtest: unused-pitches [108.936775] Subtest unused-pitches: SUCCESS (0.000s) [109.253669] [092/165] (897s left) kms_busy (basic) [109.563703] Starting subtest: basic [109.567448] Starting dynamic subtest: flip [110.479758] Dynamic subtest flip: SUCCESS (0.819s) [110.544306] Starting dynamic subtest: modeset [111.629486] Dynamic subtest modeset: SUCCESS (1.198s) [111.632565] Subtest basic: SUCCESS (2.021s) [112.025204] [093/165] (895s left) kms_prop_blob (basic) [112.118081] Starting subtest: basic [112.122158] Subtest basic: SUCCESS (0.000s) [112.208261] [094/165] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [112.506568] Starting subtest: basic-busy-flip-before-cursor-atomic [112.512191] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [112.588879] [095/165] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [112.880229] Starting subtest: basic-busy-flip-before-cursor-legacy [112.885816] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [112.947179] [096/165] (894s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [113.254713] Starting subtest: basic-flip-after-cursor-atomic [114.377243] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.034s) [114.909287] [097/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [115.211858] Starting subtest: basic-flip-after-cursor-legacy [116.364941] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.041s) [116.956865] [098/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [117.526648] Starting subtest: basic-flip-after-cursor-varying-size [118.503464] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.067s) [118.926675] [099/165] (888s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [119.231987] Starting subtest: basic-flip-before-cursor-atomic [120.272506] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.040s) [120.653944] [100/165] (887s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [120.968364] Starting subtest: basic-flip-before-cursor-legacy [122.009518] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.043s) [122.428329] [101/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [122.718078] Starting subtest: basic-flip-before-cursor-varying-size [123.746491] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.032s) [124.169603] [102/165] (883s left) kms_dsc (dsc-basic) [124.479486] Subtest dsc-basic: SKIP (0.000s) [124.503453] [103/165] (883s left) kms_flip (basic-flip-vs-dpms) [124.787861] Starting subtest: basic-flip-vs-dpms [124.790965] Starting dynamic subtest: A-DP1 [125.933424] Dynamic subtest A-DP1: SUCCESS (1.141s) [125.950345] Starting dynamic subtest: B-DP1 [127.001890] Dynamic subtest B-DP1: SUCCESS (1.063s) [127.015443] Starting dynamic subtest: C-DP1 [128.053331] Dynamic subtest C-DP1: SUCCESS (1.052s) [128.065024] Starting dynamic subtest: A-DP2 [128.949407] Dynamic subtest A-DP2: SUCCESS (0.890s) [128.960496] Starting dynamic subtest: B-DP2 [129.684070] Dynamic subtest B-DP2: SUCCESS (0.733s) [129.695285] Starting dynamic subtest: C-DP2 [130.592403] Dynamic subtest C-DP2: SUCCESS (0.904s) [130.595536] Subtest basic-flip-vs-dpms: SUCCESS (5.802s) [131.084059] [104/165] (876s left) kms_flip (basic-flip-vs-modeset) [131.392109] Starting subtest: basic-flip-vs-modeset [131.394989] Starting dynamic subtest: A-DP1 [132.501373] Dynamic subtest A-DP1: SUCCESS (1.104s) [132.512251] Starting dynamic subtest: B-DP1 [133.472339] Dynamic subtest B-DP1: SUCCESS (0.960s) [133.489834] Starting dynamic subtest: C-DP1 [134.491583] Dynamic subtest C-DP1: SUCCESS (1.021s) [134.512606] Starting dynamic subtest: A-DP2 [135.239274] Dynamic subtest A-DP2: SUCCESS (0.745s) [135.249458] Starting dynamic subtest: B-DP2 [135.932665] Dynamic subtest B-DP2: SUCCESS (0.693s) [135.949231] Starting dynamic subtest: C-DP2 [136.701116] Dynamic subtest C-DP2: SUCCESS (0.767s) [136.703842] Subtest basic-flip-vs-modeset: SUCCESS (5.312s) [137.154908] [105/165] (870s left) kms_flip (basic-flip-vs-wf_vblank) [137.452203] Starting subtest: basic-flip-vs-wf_vblank [137.454947] Starting dynamic subtest: A-DP1 [138.777757] Dynamic subtest A-DP1: SUCCESS (1.214s) [138.843997] Starting dynamic subtest: B-DP1 [139.896884] Dynamic subtest B-DP1: SUCCESS (1.119s) [139.962652] Starting dynamic subtest: C-DP1 [140.922871] Dynamic subtest C-DP1: SUCCESS (1.109s) [140.934433] Starting dynamic subtest: A-DP2 [141.945193] Dynamic subtest A-DP2: SUCCESS (1.045s) [141.956772] Starting dynamic subtest: B-DP2 [142.990779] Dynamic subtest B-DP2: SUCCESS (1.043s) [143.003750] Starting dynamic subtest: C-DP2 [144.054694] Dynamic subtest C-DP2: SUCCESS (1.062s) [144.057961] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.609s) [144.599464] [106/165] (863s left) kms_flip (basic-plain-flip) [144.887170] Starting subtest: basic-plain-flip [144.894176] Starting dynamic subtest: A-DP1 [145.816846] Dynamic subtest A-DP1: SUCCESS (0.923s) [145.827761] Starting dynamic subtest: B-DP1 [146.650062] Dynamic subtest B-DP1: SUCCESS (0.832s) [146.662984] Starting dynamic subtest: C-DP1 [147.523581] Dynamic subtest C-DP1: SUCCESS (0.869s) [147.535446] Starting dynamic subtest: A-DP2 [148.294997] Dynamic subtest A-DP2: SUCCESS (0.772s) [148.306571] Starting dynamic subtest: B-DP2 [149.109609] Dynamic subtest B-DP2: SUCCESS (0.811s) [149.122489] Starting dynamic subtest: C-DP2 [149.904571] Dynamic subtest C-DP2: SUCCESS (0.790s) [149.915713] Subtest basic-plain-flip: SUCCESS (5.023s) [150.475163] [107/165] (857s left) kms_force_connector_basic (force-connector-state) [150.621250] Starting subtest: force-connector-state [151.209475] Subtest force-connector-state: SUCCESS (0.592s) [152.069661] [108/165] (856s left) kms_force_connector_basic (force-edid) [152.198460] Starting subtest: force-edid [152.308206] Subtest force-edid: SUCCESS (0.114s) [152.818973] [109/165] (855s left) kms_force_connector_basic (force-load-detect) [152.946931] Starting subtest: force-load-detect [152.952435] Subtest force-load-detect: SKIP (0.000s) [153.305579] [110/165] (854s left) kms_force_connector_basic (prune-stale-modes) [153.452551] Starting subtest: prune-stale-modes [153.560628] Subtest prune-stale-modes: SUCCESS (0.112s) [154.069343] [111/165] (854s left) kms_frontbuffer_tracking (basic) [154.388929] Starting subtest: basic [157.172543] Subtest basic: SUCCESS (2.786s) [157.465073] [112/165] (850s left) kms_hdmi_inject (inject-audio) [157.670633] Starting subtest: inject-audio [157.843402] Subtest inject-audio: SUCCESS (0.175s) [158.503763] [113/165] (849s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [158.792726] Starting subtest: compare-crc-sanitycheck-xr24 [158.795560] Starting dynamic subtest: pipe-A-DP-1 [159.394967] Dynamic subtest pipe-A-DP-1: SUCCESS (0.601s) [159.411839] Starting dynamic subtest: pipe-B-DP-2 [159.889317] Dynamic subtest pipe-B-DP-2: SUCCESS (0.487s) [159.901281] Starting dynamic subtest: pipe-C-DP-1 [160.450097] Dynamic subtest pipe-C-DP-1: SUCCESS (0.556s) [160.453514] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.656s) [160.860870] [114/165] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [161.163696] Starting subtest: compare-crc-sanitycheck-nv12 [161.166423] Starting dynamic subtest: pipe-A-DP-1 [161.827194] Dynamic subtest pipe-A-DP-1: SUCCESS (0.661s) [161.837219] Starting dynamic subtest: pipe-B-DP-2 [162.356364] Dynamic subtest pipe-B-DP-2: SUCCESS (0.525s) [162.366716] Starting dynamic subtest: pipe-C-DP-1 [162.373896] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [162.377074] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.198s) [162.784504] [115/165] (845s left) kms_pipe_crc_basic (hang-read-crc) [163.095281] Starting subtest: hang-read-crc [163.098246] Starting dynamic subtest: pipe-A-DP-1 [164.491810] Dynamic subtest pipe-A-DP-1: SUCCESS (1.395s) [164.506860] Starting dynamic subtest: pipe-B-DP-2 [165.676755] Dynamic subtest pipe-B-DP-2: SUCCESS (1.180s) [165.686817] Starting dynamic subtest: pipe-C-DP-1 [167.026349] Dynamic subtest pipe-C-DP-1: SUCCESS (1.342s) [167.029718] Subtest hang-read-crc: SUCCESS (3.930s) [167.423541] [116/165] (840s left) kms_pipe_crc_basic (nonblocking-crc) [167.710897] Starting subtest: nonblocking-crc [167.714168] Starting dynamic subtest: pipe-A-DP-1 [168.575923] Dynamic subtest pipe-A-DP-1: SUCCESS (0.764s) [168.644059] Starting dynamic subtest: pipe-B-DP-2 [169.195928] Dynamic subtest pipe-B-DP-2: SUCCESS (0.636s) [169.264522] Starting dynamic subtest: pipe-C-DP-1 [169.830305] Dynamic subtest pipe-C-DP-1: SUCCESS (0.713s) [169.833529] Subtest nonblocking-crc: SUCCESS (2.122s) [170.255842] [117/165] (838s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [170.542256] Starting subtest: nonblocking-crc-frame-sequence [170.545082] Starting dynamic subtest: pipe-A-DP-1 [171.321657] Dynamic subtest pipe-A-DP-1: SUCCESS (0.776s) [171.336687] Starting dynamic subtest: pipe-B-DP-2 [171.985423] Dynamic subtest pipe-B-DP-2: SUCCESS (0.662s) [171.997613] Starting dynamic subtest: pipe-C-DP-1 [172.730306] Dynamic subtest pipe-C-DP-1: SUCCESS (0.737s) [172.733662] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.189s) [173.140944] [118/165] (835s left) kms_pipe_crc_basic (read-crc) [173.439969] Starting subtest: read-crc [173.442761] Starting dynamic subtest: pipe-A-DP-1 [174.131307] Dynamic subtest pipe-A-DP-1: SUCCESS (0.687s) [174.153272] Starting dynamic subtest: pipe-B-DP-2 [174.731589] Dynamic subtest pipe-B-DP-2: SUCCESS (0.593s) [174.746954] Starting dynamic subtest: pipe-C-DP-1 [175.399279] Dynamic subtest pipe-C-DP-1: SUCCESS (0.660s) [175.403193] Subtest read-crc: SUCCESS (1.957s) [175.851101] [119/165] (832s left) kms_pipe_crc_basic (read-crc-frame-sequence) [176.151430] Starting subtest: read-crc-frame-sequence [176.154315] Starting dynamic subtest: pipe-A-DP-1 [176.859154] Dynamic subtest pipe-A-DP-1: SUCCESS (0.702s) [176.874189] Starting dynamic subtest: pipe-B-DP-2 [177.480079] Dynamic subtest pipe-B-DP-2: SUCCESS (0.615s) [177.496519] Starting dynamic subtest: pipe-C-DP-1 [178.164466] Dynamic subtest pipe-C-DP-1: SUCCESS (0.678s) [178.168850] Subtest read-crc-frame-sequence: SUCCESS (2.011s) [178.588633] [120/165] (829s left) kms_pm_backlight (basic-brightness) [178.907972] Subtest basic-brightness: SKIP (0.000s) [178.941410] [121/165] (829s left) kms_pm_rpm (basic-pci-d3-state) [180.841842] Starting subtest: basic-pci-d3-state [181.615480] Subtest basic-pci-d3-state: SUCCESS (0.772s) [182.040110] [122/165] (826s left) kms_pm_rpm (basic-rte) [182.129284] Starting subtest: basic-rte [184.665319] Subtest basic-rte: SUCCESS (2.532s) [185.802033] [123/165] (822s left) kms_psr (psr_primary_page_flip) [186.123556] [124/165] (822s left) kms_psr (psr_cursor_plane_move) [186.440340] [125/165] (822s left) kms_psr (psr_sprite_plane_onoff) [186.756968] [126/165] (821s left) kms_psr (psr_primary_mmap_gtt) [187.073838] [127/165] (821s left) kms_setmode (basic-clone-single-crtc) [187.148093] Starting subtest: basic-clone-single-crtc [187.314538] Subtest basic-clone-single-crtc: SKIP (0.171s) [187.742056] [128/165] (821s left) i915_pm_rps (basic-api) [187.832588] Starting subtest: basic-api [187.835604] Subtest basic-api: SUCCESS (0.004s) [187.916375] [129/165] (820s left) prime_self_import (basic-llseek-bad) [187.995730] Starting subtest: basic-llseek-bad [188.001847] Subtest basic-llseek-bad: SUCCESS (0.002s) [188.084909] [130/165] (820s left) prime_self_import (basic-llseek-size) [188.167748] Starting subtest: basic-llseek-size [188.173826] Subtest basic-llseek-size: SUCCESS (0.003s) [188.246678] [131/165] (820s left) prime_self_import (basic-with_fd_dup) [188.322745] Starting subtest: basic-with_fd_dup [188.328348] Subtest basic-with_fd_dup: SUCCESS (0.003s) [188.433848] [132/165] (820s left) prime_self_import (basic-with_one_bo) [188.518662] Starting subtest: basic-with_one_bo [188.526691] Subtest basic-with_one_bo: SUCCESS (0.003s) [188.588758] [133/165] (820s left) prime_self_import (basic-with_one_bo_two_files) [188.662095] Starting subtest: basic-with_one_bo_two_files [188.667939] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [188.775275] [134/165] (820s left) prime_self_import (basic-with_two_bos) [188.855294] Starting subtest: basic-with_two_bos [188.861612] Subtest basic-with_two_bos: SUCCESS (0.002s) [188.930670] [135/165] (820s left) prime_vgem (basic-fence-flip) [189.013637] Starting subtest: basic-fence-flip [189.678655] Subtest basic-fence-flip: SUCCESS (0.659s) [189.769447] [136/165] (819s left) prime_vgem (basic-fence-mmap) [189.867939] Starting subtest: basic-fence-mmap [189.896337] Subtest basic-fence-mmap: SUCCESS (0.028s) [190.022908] [137/165] (819s left) prime_vgem (basic-fence-read) [190.099207] Starting subtest: basic-fence-read [190.143094] Subtest basic-fence-read: SUCCESS (0.046s) [190.215922] [138/165] (818s left) prime_vgem (basic-gtt) [190.316266] Starting subtest: basic-gtt [190.326677] Subtest basic-gtt: SUCCESS (0.013s) [190.426748] [139/165] (818s left) prime_vgem (basic-read) [190.542728] Starting subtest: basic-read [190.563527] Subtest basic-read: SUCCESS (0.021s) [190.693336] [140/165] (818s left) prime_vgem (basic-write) [190.795638] Starting subtest: basic-write [190.818205] Subtest basic-write: SUCCESS (0.023s) [190.903291] [141/165] (818s left) vgem_basic (setversion) [190.994102] Starting subtest: setversion [191.001221] Subtest setversion: SUCCESS (0.000s) [191.065629] [142/165] (818s left) vgem_basic (create) [191.142543] Starting subtest: create [191.145999] Subtest create: SUCCESS (0.000s) [191.194555] [143/165] (818s left) vgem_basic (debugfs) [191.280752] Starting subtest: debugfs [191.284228] Subtest debugfs: SUCCESS (0.000s) [191.332559] [144/165] (817s left) vgem_basic (dmabuf-export) [191.425707] Starting subtest: dmabuf-export [191.431956] Subtest dmabuf-export: SUCCESS (0.002s) [191.545846] [145/165] (817s left) vgem_basic (dmabuf-fence) [191.642781] Starting subtest: dmabuf-fence [191.646216] Subtest dmabuf-fence: SUCCESS (0.001s) [191.694918] [146/165] (817s left) vgem_basic (dmabuf-fence-before) [191.776420] Starting subtest: dmabuf-fence-before [191.779465] Subtest dmabuf-fence-before: SUCCESS (0.000s) [191.829303] [147/165] (817s left) vgem_basic (dmabuf-mmap) [191.910214] Starting subtest: dmabuf-mmap [191.931965] Subtest dmabuf-mmap: SUCCESS (0.024s) [191.977034] [148/165] (817s left) vgem_basic (mmap) [192.057196] Starting subtest: mmap [192.064620] Subtest mmap: SUCCESS (0.009s) [192.111998] [149/165] (817s left) vgem_basic (second-client) [192.191882] Starting subtest: second-client [192.226064] Subtest second-client: SUCCESS (0.033s) [192.298745] [150/165] (817s left) vgem_basic (sysfs) [192.375680] Starting subtest: sysfs [192.379278] Subtest sysfs: SUCCESS (0.000s) [192.430266] [151/165] (817s left) core_hotunplug (unbind-rebind) [192.556951] Starting subtest: unbind-rebind [195.999192] Subtest unbind-rebind: SUCCESS (3.442s) [196.023640] [152/165] (813s left) vgem_basic (unload) [196.097588] Starting subtest: unload [225.139176] Subtest unload: SUCCESS (29.040s) [225.267201] [153/165] (784s left) i915_module_load (reload) [225.351882] Starting subtest: reload [228.147031] Subtest reload: SUCCESS (2.798s) [228.175092] [154/165] (781s left) gem_lmem_swapping (basic) [228.300601] Subtest basic: SKIP (0.000s) [228.329347] [155/165] (781s left) gem_lmem_swapping (parallel-random-engines) [228.403370] Subtest parallel-random-engines: SKIP (0.000s) [228.429099] [156/165] (781s left) gem_lmem_swapping (random-engines) [228.506695] Subtest random-engines: SKIP (0.000s) [228.548786] [157/165] (781s left) gem_lmem_swapping (verify-random) [228.627477] Subtest verify-random: SKIP (0.000s) [228.662065] [158/165] (781s left) i915_pm_rpm (module-reload) [231.106209] Starting subtest: module-reload [238.982427] Subtest module-reload: SUCCESS (7.884s) [239.005926] [159/165] (770s left) i915_selftest (live) [239.101487] Starting subtest: live [239.104830] Starting dynamic subtest: sanitycheck [239.759209] Dynamic subtest sanitycheck: SUCCESS (0.654s) [239.771537] Starting dynamic subtest: uncore [240.428983] Dynamic subtest uncore: SUCCESS (0.671s) [240.437823] Starting dynamic subtest: workarounds [241.291101] Dynamic subtest workarounds: SUCCESS (0.860s) [241.301026] Starting dynamic subtest: gt_engines [242.506252] Dynamic subtest gt_engines: SUCCESS (1.213s) [242.515168] Starting dynamic subtest: gt_timelines [253.720223] Dynamic subtest gt_timelines: SUCCESS (11.210s) [253.729950] Starting dynamic subtest: gt_contexts [254.536042] Dynamic subtest gt_contexts: SUCCESS (0.816s) [254.545238] Starting dynamic subtest: gt_lrc [258.169069] Dynamic subtest gt_lrc: SUCCESS (3.631s) [258.178474] Starting dynamic subtest: gt_mocs [258.945961] Dynamic subtest gt_mocs: SUCCESS (0.775s) [258.955558] Starting dynamic subtest: gt_pm [265.527897] Dynamic subtest gt_pm: SUCCESS (6.580s) [265.536875] Starting dynamic subtest: gt_heartbeat [266.326244] Dynamic subtest gt_heartbeat: SUCCESS (0.796s) [266.335708] Starting dynamic subtest: gt_tlb [268.058310] Dynamic subtest gt_tlb: SUCCESS (1.728s) [268.066695] Starting dynamic subtest: requests [276.185151] Dynamic subtest requests: SUCCESS (8.125s) [276.194564] Starting dynamic subtest: migrate [279.664114] Dynamic subtest migrate: SUCCESS (3.479s) [279.674306] Starting dynamic subtest: active [280.374271] Dynamic subtest active: SUCCESS (0.706s) [280.383242] Starting dynamic subtest: objects [282.059300] Dynamic subtest objects: SUCCESS (1.683s) [282.070858] Starting dynamic subtest: mman [286.609017] Dynamic subtest mman: SUCCESS (4.550s) [286.621039] Starting dynamic subtest: dmabuf [287.340109] Dynamic subtest dmabuf: SUCCESS (0.729s) [287.352052] Starting dynamic subtest: vma [288.003996] Dynamic subtest vma: SUCCESS (0.662s) [288.012840] Starting dynamic subtest: coherency [290.508436] Dynamic subtest coherency: SUCCESS (2.503s) [290.518636] Starting dynamic subtest: gtt [298.473265] Dynamic subtest gtt: SUCCESS (7.963s) [298.483700] Starting dynamic subtest: gem [299.334245] Dynamic subtest gem: SUCCESS (0.859s) [299.345313] Starting dynamic subtest: evict [301.651065] Dynamic subtest evict: SUCCESS (2.315s) [301.661421] Starting dynamic subtest: hugepages [308.799975] Dynamic subtest hugepages: SUCCESS (7.147s) [308.810567] Starting dynamic subtest: gem_contexts [325.361244] Dynamic subtest gem_contexts: SUCCESS (16.557s) [325.372165] Starting dynamic subtest: client [326.082191] Dynamic subtest client: SUCCESS (0.719s) [326.092796] Starting dynamic subtest: gem_migrate [326.751440] Dynamic subtest gem_migrate: SUCCESS (0.666s) [326.761405] Starting dynamic subtest: reset [328.258056] Dynamic subtest reset: SUCCESS (1.508s) [328.267789] Starting dynamic subtest: memory_region [328.928070] Dynamic subtest memory_region: SUCCESS (0.668s) [328.939955] Starting dynamic subtest: hangcheck [358.182768] Dynamic subtest hangcheck: SUCCESS (29.251s) [358.193469] Starting dynamic subtest: execlists [371.411031] Dynamic subtest execlists: SUCCESS (13.228s) [371.421700] Starting dynamic subtest: ring_submission [372.121411] Dynamic subtest ring_submission: SUCCESS (0.706s) [372.133287] Starting dynamic subtest: perf [372.867435] Dynamic subtest perf: SUCCESS (0.744s) [372.876938] Starting dynamic subtest: slpc [373.515087] Dynamic subtest slpc: SUCCESS (0.649s) [373.524777] Starting dynamic subtest: guc [374.198204] Dynamic subtest guc: SUCCESS (0.681s) [374.207874] Starting dynamic subtest: guc_multi_lrc [374.875416] Dynamic subtest guc_multi_lrc: SUCCESS (0.673s) [374.886020] Starting dynamic subtest: guc_hang [375.559155] Dynamic subtest guc_hang: SUCCESS (0.684s) [375.568958] Starting dynamic subtest: late_gt_pm [376.269180] Dynamic subtest late_gt_pm: SUCCESS (0.706s) [376.272339] Subtest live: SUCCESS (137.167s) [376.292356] [160/165] (633s left) dmabuf (all-tests) [376.373456] Starting subtest: all-tests [376.380086] Starting dynamic subtest: sanitycheck [376.461121] Dynamic subtest sanitycheck: SUCCESS (0.086s) [376.480397] Starting dynamic subtest: dma_fence [376.646477] Dynamic subtest dma_fence: SUCCESS (0.182s) [376.658878] Starting dynamic subtest: dma_fence_chain [391.589265] Dynamic subtest dma_fence_chain: SUCCESS (14.938s) [391.607258] Starting dynamic subtest: dma_fence_unwrap [391.669102] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s) [391.689126] Starting dynamic subtest: dma_resv [391.752040] Dynamic subtest dma_resv: SUCCESS (0.080s) [391.756180] Subtest all-tests: SUCCESS (15.380s) [391.794580] [161/165] (618s left) i915_suspend (basic-s2idle-without-i915) [391.883203] Starting subtest: basic-s2idle-without-i915 [411.106043] Subtest basic-s2idle-without-i915: SUCCESS (3.901s) [413.714086] [162/165] (613s left) i915_suspend (basic-s3-without-i915) [413.811411] Starting subtest: basic-s3-without-i915 [432.785636] Subtest basic-s3-without-i915: SUCCESS (3.302s) [436.353764] [163/165] (609s left) gem_exec_suspend (basic-s0) [436.448352] Starting subtest: basic-S0 [436.451508] Starting dynamic subtest: smem [455.079613] Dynamic subtest smem: SUCCESS (2.925s) [455.083065] Subtest basic-S0: SUCCESS (2.927s) [460.277426] [164/165] (606s left) gem_exec_suspend (basic-s3) [460.355922] Starting subtest: basic-S3 [460.359144] Starting dynamic subtest: smem [479.725484] Dynamic subtest smem: SUCCESS (3.526s) [479.728857] Subtest basic-S3: SUCCESS (3.527s) [482.903055] [165/165] (602s left) kms_pipe_crc_basic (suspend-read-crc) [483.222005] Starting subtest: suspend-read-crc [483.225044] Starting dynamic subtest: pipe-A-DP-1 [502.681158] Dynamic subtest pipe-A-DP-1: SUCCESS (3.040s) [502.693243] Starting dynamic subtest: pipe-B-DP-2 [521.567880] Dynamic subtest pipe-B-DP-2: SUCCESS (2.668s) [521.580388] Starting dynamic subtest: pipe-C-DP-1 [540.709985] Dynamic subtest pipe-C-DP-1: SUCCESS (3.004s) [540.713296] Subtest suspend-read-crc: SUCCESS (8.722s) [545.067665] Closing watchdogs Done.