[45.186694] Initializing watchdogs [45.186781] /dev/watchdog0 [45.194629] [001/165] (960s left) i915_module_load (load) [45.267719] Starting subtest: load [47.526716] Subtest load: SUCCESS (2.259s) [47.543567] [002/165] (958s left) core_auth (basic-auth) [47.620194] Starting subtest: basic-auth [47.623545] Subtest basic-auth: SUCCESS (0.001s) [47.685604] [003/165] (958s left) debugfs_test (read_all_entries) [47.792783] Starting subtest: read_all_entries [47.929603] Subtest read_all_entries: SUCCESS (0.135s) [48.229253] [004/165] (957s left) debugfs_test (basic-hwmon) [48.314956] Starting subtest: basic-hwmon [48.321186] Subtest basic-hwmon: SKIP (0.000s) [48.596166] [005/165] (957s left) fbdev (eof) [48.677495] Starting subtest: eof [48.680974] Subtest eof: SUCCESS (0.001s) [48.746253] [006/165] (957s left) fbdev (info) [48.818947] Starting subtest: info [48.822546] Subtest info: SUCCESS (0.000s) [48.887928] [007/165] (956s left) fbdev (nullptr) [48.977755] Starting subtest: nullptr [48.981713] Subtest nullptr: SUCCESS (0.000s) [49.040176] [008/165] (956s left) fbdev (read) [49.113038] Starting subtest: read [49.367225] Subtest read: SUCCESS (0.257s) [49.411368] [009/165] (956s left) fbdev (write) [49.494030] Starting subtest: write [49.631263] Subtest write: SUCCESS (0.138s) [49.683827] [010/165] (956s left) gem_basic (bad-close) [49.757321] Starting subtest: bad-close [49.763837] Subtest bad-close: SUCCESS (0.000s) [49.815045] [011/165] (956s left) gem_basic (create-close) [49.890945] Starting subtest: create-close [49.897506] Subtest create-close: SUCCESS (0.000s) [49.969586] [012/165] (956s left) gem_basic (create-fd-close) [50.054517] Starting subtest: create-fd-close [50.060752] Subtest create-fd-close: SUCCESS (0.000s) [50.135452] [013/165] (955s left) gem_busy (busy@all-engines) [50.219858] Starting subtest: busy [50.223644] Starting dynamic subtest: all-engines [50.295888] Dynamic subtest all-engines: SUCCESS (0.076s) [50.299583] Subtest busy: SUCCESS (0.076s) [50.849104] [014/165] (955s left) gem_close_race (basic-process) [51.340125] Starting subtest: basic-process [51.406907] Subtest basic-process: SUCCESS (0.066s) [51.640300] [015/165] (954s left) gem_close_race (basic-threads) [51.914235] Starting subtest: basic-threads [53.111487] Subtest basic-threads: SUCCESS (1.200s) [53.324744] [016/165] (953s left) gem_ctx_create (basic) [53.428373] Starting subtest: basic [53.431965] Subtest basic: SUCCESS (0.000s) [53.625128] [017/165] (952s left) gem_ctx_create (basic-files) [53.699531] Starting subtest: basic-files [55.718032] Subtest basic-files: SUCCESS (2.019s) [55.969568] [018/165] (950s left) gem_ctx_exec (basic) [56.065073] Starting subtest: basic [56.072617] Subtest basic: SUCCESS (0.006s) [56.190952] [019/165] (950s left) gem_exec_basic (basic) [56.263676] Starting subtest: basic [56.266978] Starting dynamic subtest: rcs0-smem [56.270420] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [56.278680] Starting dynamic subtest: bcs0-smem [56.282413] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [56.290786] Starting dynamic subtest: vcs0-smem [56.294211] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [56.302527] Starting dynamic subtest: vcs1-smem [56.305943] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [56.313682] Starting dynamic subtest: vecs0-smem [56.316949] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [56.320218] Subtest basic: SUCCESS (0.004s) [56.487039] [020/165] (950s left) gem_exec_create (basic) [56.575621] Starting subtest: basic [56.578646] Starting dynamic subtest: smem [58.623652] Dynamic subtest smem: SUCCESS (2.048s) [58.626939] Subtest basic: SUCCESS (2.048s) [58.821563] [021/165] (947s left) gem_exec_fence (basic-busy) [59.016515] Starting subtest: basic-busy [59.019874] Starting dynamic subtest: rcs0 [59.042370] Dynamic subtest rcs0: SUCCESS (0.025s) [59.061692] Starting dynamic subtest: bcs0 [59.076634] Dynamic subtest bcs0: SUCCESS (0.034s) [59.088808] Starting dynamic subtest: vcs0 [59.107194] Dynamic subtest vcs0: SUCCESS (0.030s) [59.123757] Starting dynamic subtest: vcs1 [59.138536] Dynamic subtest vcs1: SUCCESS (0.031s) [59.155079] Starting dynamic subtest: vecs0 [59.178123] Dynamic subtest vecs0: SUCCESS (0.026s) [59.182158] Subtest basic-busy: SUCCESS (0.148s) [59.824479] [022/165] (946s left) gem_exec_fence (basic-wait) [60.064562] Starting subtest: basic-wait [60.069141] Starting dynamic subtest: rcs0 [60.099299] Dynamic subtest rcs0: SUCCESS (0.034s) [60.118456] Starting dynamic subtest: bcs0 [60.134295] Dynamic subtest bcs0: SUCCESS (0.034s) [60.150497] Starting dynamic subtest: vcs0 [60.167200] Dynamic subtest vcs0: SUCCESS (0.033s) [60.183674] Starting dynamic subtest: vcs1 [60.197162] Dynamic subtest vcs1: SUCCESS (0.030s) [60.211225] Starting dynamic subtest: vecs0 [60.229319] Dynamic subtest vecs0: SUCCESS (0.032s) [60.232741] Subtest basic-wait: SUCCESS (0.166s) [60.876394] [023/165] (945s left) gem_exec_fence (basic-await) [61.114339] Starting subtest: basic-await [61.118425] Starting dynamic subtest: rcs0 [61.226762] Dynamic subtest rcs0: SUCCESS (0.116s) [61.237889] Starting dynamic subtest: bcs0 [61.332133] Dynamic subtest bcs0: SUCCESS (0.105s) [61.343479] Starting dynamic subtest: vcs0 [61.440654] Dynamic subtest vcs0: SUCCESS (0.108s) [61.453260] Starting dynamic subtest: vcs1 [61.552647] Dynamic subtest vcs1: SUCCESS (0.112s) [61.564398] Starting dynamic subtest: vecs0 [61.674517] Dynamic subtest vecs0: SUCCESS (0.121s) [61.678395] Subtest basic-await: SUCCESS (0.563s) [62.303539] [024/165] (944s left) gem_exec_fence (nb-await) [62.551442] Starting subtest: nb-await [62.555941] Starting dynamic subtest: rcs0 [62.626302] Dynamic subtest rcs0: SUCCESS (0.074s) [62.653340] Starting dynamic subtest: bcs0 [62.707119] Dynamic subtest bcs0: SUCCESS (0.081s) [62.728785] Starting dynamic subtest: vcs0 [62.784102] Dynamic subtest vcs0: SUCCESS (0.077s) [62.801229] Starting dynamic subtest: vcs1 [62.856982] Dynamic subtest vcs1: SUCCESS (0.073s) [62.879568] Starting dynamic subtest: vecs0 [62.934359] Dynamic subtest vecs0: SUCCESS (0.076s) [62.938255] Subtest nb-await: SUCCESS (0.383s) [63.555054] [025/165] (943s left) gem_exec_gttfill (basic) [63.643813] Starting subtest: basic [68.262177] Subtest basic: SUCCESS (4.619s) [68.430837] [026/165] (938s left) gem_exec_parallel (engines) [68.586326] Starting subtest: engines [68.589550] Starting dynamic subtest: basic [70.565070] Dynamic subtest basic: SUCCESS (1.979s) [70.573833] Starting dynamic subtest: contexts [73.353275] Dynamic subtest contexts: SUCCESS (2.788s) [73.362216] Starting dynamic subtest: fds [78.291914] Dynamic subtest fds: SUCCESS (4.885s) [78.358048] Starting dynamic subtest: userptr [80.296836] Dynamic subtest userptr: SUCCESS (2.059s) [80.300537] Subtest engines: SUCCESS (11.711s) [80.506744] [027/165] (926s left) gem_exec_store (basic) [80.596505] Starting subtest: basic [80.645427] Subtest basic: SUCCESS (0.052s) [80.855321] [028/165] (925s left) gem_flink_basic (bad-flink) [80.943079] Starting subtest: bad-flink [80.946259] Subtest bad-flink: SUCCESS (0.000s) [81.023976] [029/165] (925s left) gem_flink_basic (bad-open) [81.107906] Starting subtest: bad-open [81.111044] Subtest bad-open: SUCCESS (0.000s) [81.180144] [030/165] (925s left) gem_flink_basic (basic) [81.269016] Starting subtest: basic [81.272190] Subtest basic: SUCCESS (0.000s) [81.369529] [031/165] (925s left) gem_flink_basic (double-flink) [81.440919] Starting subtest: double-flink [81.444357] Subtest double-flink: SUCCESS (0.000s) [81.535984] [032/165] (925s left) gem_flink_basic (flink-lifetime) [81.623567] Starting subtest: flink-lifetime [81.626868] Subtest flink-lifetime: SUCCESS (0.001s) [81.706428] [033/165] (925s left) gem_huc_copy (huc-copy) [81.787179] Starting subtest: huc-copy [81.794313] Subtest huc-copy: SKIP (0.000s) [81.906301] [034/165] (925s left) gem_linear_blits (basic) [82.095902] Starting subtest: basic [82.106592] Subtest basic: SUCCESS (0.008s) [82.251517] [035/165] (924s left) gem_mmap (basic) [82.409566] Starting subtest: basic [82.427303] Subtest basic: SUCCESS (0.000s) [82.523966] [036/165] (924s left) gem_mmap_gtt (basic) [82.618997] Starting subtest: basic [82.622426] Subtest basic: SUCCESS (0.001s) [82.674035] [037/165] (924s left) gem_render_linear_blits (basic) [82.756803] Starting subtest: basic [82.785022] Subtest basic: SUCCESS (0.032s) [82.838295] [038/165] (924s left) gem_render_tiled_blits (basic) [82.905224] Starting subtest: basic [82.939583] Subtest basic: SUCCESS (0.035s) [82.985803] [039/165] (924s left) gem_ringfill (basic-all) [83.279092] Starting subtest: basic-all [84.458059] Subtest basic-all: SUCCESS (1.176s) [84.567623] [040/165] (922s left) gem_softpin (allocator-basic) [84.664484] Starting subtest: allocator-basic [84.775401] Subtest allocator-basic: SUCCESS (0.111s) [84.889597] [041/165] (922s left) gem_softpin (allocator-basic-reserve) [84.978606] Starting subtest: allocator-basic-reserve [85.085675] Subtest allocator-basic-reserve: SUCCESS (0.109s) [85.193287] [042/165] (922s left) gem_softpin (safe-alignment) [85.286724] Starting subtest: safe-alignment [85.298454] Subtest safe-alignment: SUCCESS (0.014s) [85.390725] [043/165] (921s left) gem_sync (basic-all) [85.506788] Starting subtest: basic-all [87.807744] Subtest basic-all: SUCCESS (2.317s) [88.005496] [044/165] (919s left) gem_sync (basic-each) [88.120362] Starting subtest: basic-each [90.331307] Subtest basic-each: SUCCESS (2.231s) [90.537919] [045/165] (916s left) gem_tiled_blits (basic) [90.727963] Starting subtest: basic [90.747252] Subtest basic: SUCCESS (0.018s) [90.901605] [046/165] (916s left) gem_tiled_fence_blits (basic) [91.204290] Starting subtest: basic [91.212637] Subtest basic: SUCCESS (0.010s) [91.350314] [047/165] (916s left) gem_tiled_pread_basic [91.697934] [048/165] (915s left) gem_wait (busy@all-engines) [91.791310] Starting subtest: busy [91.794457] Starting dynamic subtest: all-engines [92.310374] Dynamic subtest all-engines: SUCCESS (0.519s) [92.313614] Subtest busy: SUCCESS (0.519s) [92.519630] [049/165] (915s left) gem_wait (wait@all-engines) [92.605089] Starting subtest: wait [92.608279] Starting dynamic subtest: all-engines [93.632283] Dynamic subtest all-engines: SUCCESS (1.025s) [93.635852] Subtest wait: SUCCESS (1.026s) [93.835364] [050/165] (913s left) i915_getparams_basic (basic-eu-total) [93.924905] Starting subtest: basic-eu-total [93.931948] Subtest basic-eu-total: SUCCESS (0.000s) [93.998874] [051/165] (913s left) i915_getparams_basic (basic-subslice-total) [94.065162] Starting subtest: basic-subslice-total [94.071925] Subtest basic-subslice-total: SUCCESS (0.000s) [94.154504] [052/165] (913s left) i915_hangman (error-state-basic) [94.251728] Starting subtest: error-state-basic [94.260620] Subtest error-state-basic: SUCCESS (0.007s) [94.341231] [053/165] (913s left) i915_pciid [94.520903] [054/165] (913s left) kms_addfb_basic (addfb25-4-tiled) [94.823546] Starting subtest: addfb25-4-tiled [94.827191] Subtest addfb25-4-tiled: SUCCESS (0.000s) [94.896161] [055/165] (912s left) kms_addfb_basic (addfb25-bad-modifier) [94.964624] Starting subtest: addfb25-bad-modifier [94.967823] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [95.263993] [056/165] (912s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.352256] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.355268] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [95.631969] [057/165] (912s left) kms_addfb_basic (addfb25-modifier-no-flag) [95.702743] Starting subtest: addfb25-modifier-no-flag [95.705647] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [96.003698] [058/165] (911s left) kms_addfb_basic (addfb25-x-tiled-legacy) [96.094653] Starting subtest: addfb25-x-tiled-legacy [96.098029] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.383113] [059/165] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.463462] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.466604] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [96.773299] [060/165] (911s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [97.074254] Starting subtest: addfb25-yf-tiled-legacy [97.077339] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [97.149713] [061/165] (910s left) kms_addfb_basic (addfb25-y-tiled-legacy) [97.438224] Starting subtest: addfb25-y-tiled-legacy [97.441110] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [97.516130] [062/165] (910s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.802857] Starting subtest: addfb25-y-tiled-small-legacy [97.805790] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [97.879510] [063/165] (910s left) kms_addfb_basic (bad-pitch-0) [97.950091] Starting subtest: bad-pitch-0 [97.953466] Subtest bad-pitch-0: SUCCESS (0.000s) [98.250887] [064/165] (909s left) kms_addfb_basic (bad-pitch-1024) [98.334704] Starting subtest: bad-pitch-1024 [98.338482] Subtest bad-pitch-1024: SUCCESS (0.000s) [98.630258] [065/165] (909s left) kms_addfb_basic (bad-pitch-128) [98.697617] Starting subtest: bad-pitch-128 [98.700860] Subtest bad-pitch-128: SUCCESS (0.000s) [98.997137] [066/165] (909s left) kms_addfb_basic (bad-pitch-256) [99.070156] Starting subtest: bad-pitch-256 [99.073317] Subtest bad-pitch-256: SUCCESS (0.000s) [99.369502] [067/165] (908s left) kms_addfb_basic (bad-pitch-32) [99.459162] Starting subtest: bad-pitch-32 [99.462494] Subtest bad-pitch-32: SUCCESS (0.000s) [99.764918] [068/165] (908s left) kms_addfb_basic (bad-pitch-63) [99.839266] Starting subtest: bad-pitch-63 [99.842139] Subtest bad-pitch-63: SUCCESS (0.000s) [100.130540] [069/165] (907s left) kms_addfb_basic (bad-pitch-65536) [100.200052] Starting subtest: bad-pitch-65536 [100.203180] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.504080] [070/165] (907s left) kms_addfb_basic (bad-pitch-999) [100.591053] Starting subtest: bad-pitch-999 [100.594402] Subtest bad-pitch-999: SUCCESS (0.000s) [100.884607] [071/165] (907s left) kms_addfb_basic (basic) [100.966314] Starting subtest: basic [100.969427] Subtest basic: SUCCESS (0.000s) [101.270802] [072/165] (906s left) kms_addfb_basic (basic-x-tiled-legacy) [101.359623] Starting subtest: basic-x-tiled-legacy [101.363237] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [101.647902] [073/165] (906s left) kms_addfb_basic (basic-y-tiled-legacy) [101.724189] Starting subtest: basic-y-tiled-legacy [101.727389] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [102.016587] [074/165] (906s left) kms_addfb_basic (bo-too-small) [102.314983] Starting subtest: bo-too-small [102.317762] Subtest bo-too-small: SUCCESS (0.000s) [102.404750] [075/165] (905s left) kms_addfb_basic (bo-too-small-due-to-tiling) [102.704890] Starting subtest: bo-too-small-due-to-tiling [102.707778] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [102.783204] [076/165] (905s left) kms_addfb_basic (clobberred-modifier) [102.860079] Starting subtest: clobberred-modifier [102.863133] Subtest clobberred-modifier: SUCCESS (0.000s) [103.150158] [077/165] (905s left) kms_addfb_basic (framebuffer-vs-set-tiling) [103.229513] Starting subtest: framebuffer-vs-set-tiling [103.232636] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [103.540611] [078/165] (904s left) kms_addfb_basic (invalid-get-prop) [103.634224] Starting subtest: invalid-get-prop [103.637369] Subtest invalid-get-prop: SUCCESS (0.000s) [103.937590] [079/165] (904s left) kms_addfb_basic (invalid-get-prop-any) [104.025217] Starting subtest: invalid-get-prop-any [104.028318] Subtest invalid-get-prop-any: SUCCESS (0.000s) [104.329448] [080/165] (904s left) kms_addfb_basic (invalid-set-prop) [104.433205] Starting subtest: invalid-set-prop [104.436537] Subtest invalid-set-prop: SUCCESS (0.000s) [104.734152] [081/165] (903s left) kms_addfb_basic (invalid-set-prop-any) [104.818150] Starting subtest: invalid-set-prop-any [104.821388] Subtest invalid-set-prop-any: SUCCESS (0.000s) [105.096844] [082/165] (903s left) kms_addfb_basic (no-handle) [105.169946] Starting subtest: no-handle [105.173077] Subtest no-handle: SUCCESS (0.000s) [105.466868] [083/165] (903s left) kms_addfb_basic (size-max) [105.765975] Starting subtest: size-max [105.768674] Subtest size-max: SUCCESS (0.000s) [105.859526] [084/165] (902s left) kms_addfb_basic (small-bo) [106.174997] Starting subtest: small-bo [106.177792] Subtest small-bo: SUCCESS (0.000s) [106.246257] [085/165] (902s left) kms_addfb_basic (tile-pitch-mismatch) [106.348531] Starting subtest: tile-pitch-mismatch [106.351826] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.631412] [086/165] (901s left) kms_addfb_basic (too-high) [106.921341] Starting subtest: too-high [106.924125] Subtest too-high: SUCCESS (0.001s) [106.999533] [087/165] (901s left) kms_addfb_basic (too-wide) [107.299842] Starting subtest: too-wide [107.302752] Subtest too-wide: SUCCESS (0.000s) [107.381789] [088/165] (901s left) kms_addfb_basic (unused-handle) [107.470991] Starting subtest: unused-handle [107.474527] Subtest unused-handle: SUCCESS (0.000s) [107.763811] [089/165] (900s left) kms_addfb_basic (unused-modifier) [107.862418] Starting subtest: unused-modifier [107.865610] Subtest unused-modifier: SUCCESS (0.000s) [108.166042] [090/165] (900s left) kms_addfb_basic (unused-offsets) [108.246543] Starting subtest: unused-offsets [108.249571] Subtest unused-offsets: SUCCESS (0.000s) [108.531299] [091/165] (900s left) kms_addfb_basic (unused-pitches) [108.605885] Starting subtest: unused-pitches [108.608753] Subtest unused-pitches: SUCCESS (0.000s) [108.901833] [092/165] (899s left) kms_busy (basic) [109.212668] Starting subtest: basic [109.215906] Starting dynamic subtest: flip [110.109177] Dynamic subtest flip: SUCCESS (0.801s) [110.173704] Starting dynamic subtest: modeset [111.221546] Dynamic subtest modeset: SUCCESS (1.111s) [111.348055] Subtest basic: SUCCESS (1.914s) [111.687094] [093/165] (897s left) kms_prop_blob (basic) [112.194801] Starting subtest: basic [112.262364] Subtest basic: SUCCESS (0.000s) [112.505501] [094/165] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [113.069758] Starting subtest: basic-busy-flip-before-cursor-atomic [113.077022] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [113.202237] [095/165] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [113.762595] Starting subtest: basic-busy-flip-before-cursor-legacy [113.896322] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [114.131638] [096/165] (895s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.618477] Starting subtest: basic-flip-after-cursor-atomic [115.709613] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.033s) [116.128938] [097/165] (893s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.426061] Starting subtest: basic-flip-after-cursor-legacy [117.443312] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.018s) [117.868029] [098/165] (891s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [118.169194] Starting subtest: basic-flip-after-cursor-varying-size [119.201403] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.033s) [119.644141] [099/165] (890s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [119.925707] Starting subtest: basic-flip-before-cursor-atomic [121.048674] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.027s) [121.578584] [100/165] (888s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [121.873888] Starting subtest: basic-flip-before-cursor-legacy [122.929477] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.058s) [123.334088] [101/165] (886s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [123.636168] Starting subtest: basic-flip-before-cursor-varying-size [124.667710] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.034s) [125.061568] [102/165] (884s left) kms_dsc (dsc-basic) [125.365246] Subtest dsc-basic: SKIP (0.000s) [125.387843] [103/165] (884s left) kms_flip (basic-flip-vs-dpms) [125.663093] Starting subtest: basic-flip-vs-dpms [125.666330] Starting dynamic subtest: A-DP1 [126.800943] Dynamic subtest A-DP1: SUCCESS (1.132s) [126.813466] Starting dynamic subtest: B-DP1 [127.803396] Dynamic subtest B-DP1: SUCCESS (1.000s) [127.824851] Starting dynamic subtest: C-DP1 [128.819331] Dynamic subtest C-DP1: SUCCESS (1.015s) [128.831514] Starting dynamic subtest: A-DP2 [129.703993] Dynamic subtest A-DP2: SUCCESS (0.882s) [129.713817] Starting dynamic subtest: B-DP2 [130.568809] Dynamic subtest B-DP2: SUCCESS (0.863s) [130.585275] Starting dynamic subtest: C-DP2 [131.496601] Dynamic subtest C-DP2: SUCCESS (0.921s) [131.499866] Subtest basic-flip-vs-dpms: SUCCESS (5.834s) [131.998451] [104/165] (878s left) kms_flip (basic-flip-vs-modeset) [132.265433] Starting subtest: basic-flip-vs-modeset [132.268321] Starting dynamic subtest: A-DP1 [133.451169] Dynamic subtest A-DP1: SUCCESS (1.180s) [133.461304] Starting dynamic subtest: B-DP1 [134.416618] Dynamic subtest B-DP1: SUCCESS (0.960s) [134.429041] Starting dynamic subtest: C-DP1 [135.409439] Dynamic subtest C-DP1: SUCCESS (0.989s) [135.428677] Starting dynamic subtest: A-DP2 [136.342496] Dynamic subtest A-DP2: SUCCESS (0.930s) [136.352399] Starting dynamic subtest: B-DP2 [137.047335] Dynamic subtest B-DP2: SUCCESS (0.704s) [137.057178] Starting dynamic subtest: C-DP2 [137.750308] Dynamic subtest C-DP2: SUCCESS (0.701s) [137.753499] Subtest basic-flip-vs-modeset: SUCCESS (5.484s) [138.177932] [105/165] (871s left) kms_flip (basic-flip-vs-wf_vblank) [138.461674] Starting subtest: basic-flip-vs-wf_vblank [138.464555] Starting dynamic subtest: A-DP1 [139.760883] Dynamic subtest A-DP1: SUCCESS (1.191s) [139.826552] Starting dynamic subtest: B-DP1 [140.775027] Dynamic subtest B-DP1: SUCCESS (1.116s) [140.786489] Starting dynamic subtest: C-DP1 [141.883627] Dynamic subtest C-DP1: SUCCESS (1.106s) [141.896385] Starting dynamic subtest: A-DP2 [142.929427] Dynamic subtest A-DP2: SUCCESS (1.045s) [142.941125] Starting dynamic subtest: B-DP2 [144.150873] Dynamic subtest B-DP2: SUCCESS (1.213s) [144.178813] Starting dynamic subtest: C-DP2 [145.244948] Dynamic subtest C-DP2: SUCCESS (1.089s) [145.248412] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.782s) [145.799631] [106/165] (864s left) kms_flip (basic-plain-flip) [146.079381] Starting subtest: basic-plain-flip [146.082349] Starting dynamic subtest: A-DP1 [147.119672] Dynamic subtest A-DP1: SUCCESS (0.925s) [147.185377] Starting dynamic subtest: B-DP1 [148.017568] Dynamic subtest B-DP1: SUCCESS (0.840s) [148.031551] Starting dynamic subtest: C-DP1 [148.723546] Dynamic subtest C-DP1: SUCCESS (0.870s) [148.736083] Starting dynamic subtest: A-DP2 [149.494240] Dynamic subtest A-DP2: SUCCESS (0.769s) [149.505441] Starting dynamic subtest: B-DP2 [150.256236] Dynamic subtest B-DP2: SUCCESS (0.760s) [150.268869] Starting dynamic subtest: C-DP2 [151.032905] Dynamic subtest C-DP2: SUCCESS (0.775s) [151.036432] Subtest basic-plain-flip: SUCCESS (4.957s) [151.547233] [107/165] (858s left) kms_force_connector_basic (force-connector-state) [151.700845] Starting subtest: force-connector-state [152.303332] Subtest force-connector-state: SUCCESS (0.605s) [153.167537] [108/165] (857s left) kms_force_connector_basic (force-edid) [153.297577] Starting subtest: force-edid [153.403859] Subtest force-edid: SUCCESS (0.107s) [153.916954] [109/165] (856s left) kms_force_connector_basic (force-load-detect) [154.042442] Starting subtest: force-load-detect [154.048617] Subtest force-load-detect: SKIP (0.000s) [154.380159] [110/165] (855s left) kms_force_connector_basic (prune-stale-modes) [154.531843] Starting subtest: prune-stale-modes [154.641427] Subtest prune-stale-modes: SUCCESS (0.109s) [155.151042] [111/165] (855s left) kms_frontbuffer_tracking (basic) [155.458923] Starting subtest: basic [158.264864] Subtest basic: SUCCESS (2.810s) [158.545283] [112/165] (851s left) kms_hdmi_inject (inject-audio) [158.749420] Starting subtest: inject-audio [158.923458] Subtest inject-audio: SUCCESS (0.171s) [159.587939] [113/165] (850s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [159.903694] Starting subtest: compare-crc-sanitycheck-xr24 [159.906517] Starting dynamic subtest: pipe-A-DP-1 [160.508496] Dynamic subtest pipe-A-DP-1: SUCCESS (0.600s) [160.520805] Starting dynamic subtest: pipe-B-DP-2 [160.985354] Dynamic subtest pipe-B-DP-2: SUCCESS (0.474s) [160.997814] Starting dynamic subtest: pipe-C-DP-1 [161.548171] Dynamic subtest pipe-C-DP-1: SUCCESS (0.556s) [161.551561] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.642s) [161.973920] [114/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [162.273914] Starting subtest: compare-crc-sanitycheck-nv12 [162.276752] Starting dynamic subtest: pipe-A-DP-1 [162.891994] Dynamic subtest pipe-A-DP-1: SUCCESS (0.614s) [162.905640] Starting dynamic subtest: pipe-B-DP-2 [163.416310] Dynamic subtest pipe-B-DP-2: SUCCESS (0.522s) [163.429065] Starting dynamic subtest: pipe-C-DP-1 [163.435427] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [163.438727] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.147s) [163.830278] [115/165] (846s left) kms_pipe_crc_basic (hang-read-crc) [164.139072] Starting subtest: hang-read-crc [164.142183] Starting dynamic subtest: pipe-A-DP-1 [165.564659] Dynamic subtest pipe-A-DP-1: SUCCESS (1.327s) [165.631173] Starting dynamic subtest: pipe-B-DP-2 [166.634290] Dynamic subtest pipe-B-DP-2: SUCCESS (1.163s) [166.646601] Starting dynamic subtest: pipe-C-DP-1 [167.993378] Dynamic subtest pipe-C-DP-1: SUCCESS (1.357s) [167.996597] Subtest hang-read-crc: SUCCESS (3.857s) [168.401912] [116/165] (842s left) kms_pipe_crc_basic (nonblocking-crc) [168.701653] Starting subtest: nonblocking-crc [168.704737] Starting dynamic subtest: pipe-A-DP-1 [169.480426] Dynamic subtest pipe-A-DP-1: SUCCESS (0.778s) [169.490804] Starting dynamic subtest: pipe-B-DP-2 [170.149334] Dynamic subtest pipe-B-DP-2: SUCCESS (0.664s) [170.159233] Starting dynamic subtest: pipe-C-DP-1 [170.893188] Dynamic subtest pipe-C-DP-1: SUCCESS (0.739s) [170.896860] Subtest nonblocking-crc: SUCCESS (2.193s) [171.308984] [117/165] (839s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [171.620834] Starting subtest: nonblocking-crc-frame-sequence [171.623564] Starting dynamic subtest: pipe-A-DP-1 [172.373109] Dynamic subtest pipe-A-DP-1: SUCCESS (0.752s) [172.383567] Starting dynamic subtest: pipe-B-DP-2 [173.023994] Dynamic subtest pipe-B-DP-2: SUCCESS (0.647s) [173.035774] Starting dynamic subtest: pipe-C-DP-1 [173.756334] Dynamic subtest pipe-C-DP-1: SUCCESS (0.724s) [173.759807] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.135s) [174.214432] [118/165] (836s left) kms_pipe_crc_basic (read-crc) [174.512553] Starting subtest: read-crc [174.515381] Starting dynamic subtest: pipe-A-DP-1 [175.214245] Dynamic subtest pipe-A-DP-1: SUCCESS (0.699s) [175.225907] Starting dynamic subtest: pipe-B-DP-2 [175.791060] Dynamic subtest pipe-B-DP-2: SUCCESS (0.575s) [175.807072] Starting dynamic subtest: pipe-C-DP-1 [176.478352] Dynamic subtest pipe-C-DP-1: SUCCESS (0.680s) [176.481423] Subtest read-crc: SUCCESS (1.967s) [176.906587] [119/165] (833s left) kms_pipe_crc_basic (read-crc-frame-sequence) [177.206080] Starting subtest: read-crc-frame-sequence [177.208748] Starting dynamic subtest: pipe-A-DP-1 [177.907590] Dynamic subtest pipe-A-DP-1: SUCCESS (0.701s) [177.924664] Starting dynamic subtest: pipe-B-DP-2 [178.506369] Dynamic subtest pipe-B-DP-2: SUCCESS (0.593s) [178.516673] Starting dynamic subtest: pipe-C-DP-1 [179.168605] Dynamic subtest pipe-C-DP-1: SUCCESS (0.656s) [179.172217] Subtest read-crc-frame-sequence: SUCCESS (1.965s) [179.576347] [120/165] (831s left) kms_pm_backlight (basic-brightness) [179.887956] Subtest basic-brightness: SKIP (0.000s) [179.914761] [121/165] (830s left) kms_pm_rpm (basic-pci-d3-state) [181.801316] Starting subtest: basic-pci-d3-state [182.561280] Subtest basic-pci-d3-state: SUCCESS (0.755s) [183.024582] [122/165] (827s left) kms_pm_rpm (basic-rte) [183.115379] Starting subtest: basic-rte [185.635842] Subtest basic-rte: SUCCESS (2.518s) [186.994667] [123/165] (824s left) kms_psr (primary_page_flip) [187.532240] Subtest primary_page_flip: SKIP (0.000s) [187.578594] [124/165] (823s left) kms_psr (cursor_plane_move) [187.656194] Subtest cursor_plane_move: SKIP (0.000s) [187.684710] [125/165] (823s left) kms_psr (sprite_plane_onoff) [187.757125] Subtest sprite_plane_onoff: SKIP (0.000s) [187.784568] [126/165] (823s left) kms_psr (primary_mmap_gtt) [187.855718] Subtest primary_mmap_gtt: SKIP (0.000s) [187.884080] [127/165] (823s left) kms_setmode (basic-clone-single-crtc) [187.951101] Starting subtest: basic-clone-single-crtc [188.127307] Subtest basic-clone-single-crtc: SKIP (0.172s) [188.524306] [128/165] (822s left) i915_pm_rps (basic-api) [188.600928] Starting subtest: basic-api [188.604760] Subtest basic-api: SUCCESS (0.004s) [188.670829] [129/165] (822s left) prime_self_import (basic-llseek-bad) [188.737040] Starting subtest: basic-llseek-bad [188.743220] Subtest basic-llseek-bad: SUCCESS (0.002s) [188.871498] [130/165] (822s left) prime_self_import (basic-llseek-size) [188.956509] Starting subtest: basic-llseek-size [188.962873] Subtest basic-llseek-size: SUCCESS (0.002s) [189.048210] [131/165] (822s left) prime_self_import (basic-with_fd_dup) [189.128779] Starting subtest: basic-with_fd_dup [189.135247] Subtest basic-with_fd_dup: SUCCESS (0.003s) [189.206607] [132/165] (822s left) prime_self_import (basic-with_one_bo) [189.277461] Starting subtest: basic-with_one_bo [189.283159] Subtest basic-with_one_bo: SUCCESS (0.003s) [189.346270] [133/165] (822s left) prime_self_import (basic-with_one_bo_two_files) [189.414450] Starting subtest: basic-with_one_bo_two_files [189.421032] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [189.521735] [134/165] (821s left) prime_self_import (basic-with_two_bos) [189.608660] Starting subtest: basic-with_two_bos [189.615127] Subtest basic-with_two_bos: SUCCESS (0.003s) [189.691398] [135/165] (821s left) prime_vgem (basic-fence-flip) [189.775323] Starting subtest: basic-fence-flip [190.441050] Subtest basic-fence-flip: SUCCESS (0.660s) [190.558714] [136/165] (820s left) prime_vgem (basic-fence-mmap) [190.644482] Starting subtest: basic-fence-mmap [190.672957] Subtest basic-fence-mmap: SUCCESS (0.029s) [190.778123] [137/165] (820s left) prime_vgem (basic-fence-read) [190.880967] Starting subtest: basic-fence-read [190.928493] Subtest basic-fence-read: SUCCESS (0.047s) [191.021090] [138/165] (820s left) prime_vgem (basic-gtt) [191.133728] Starting subtest: basic-gtt [191.147337] Subtest basic-gtt: SUCCESS (0.013s) [191.223828] [139/165] (820s left) prime_vgem (basic-read) [191.307585] Starting subtest: basic-read [191.325507] Subtest basic-read: SUCCESS (0.021s) [191.436310] [140/165] (820s left) prime_vgem (basic-write) [191.521938] Starting subtest: basic-write [191.544613] Subtest basic-write: SUCCESS (0.023s) [191.626270] [141/165] (819s left) vgem_basic (setversion) [191.702900] Starting subtest: setversion [191.710239] Subtest setversion: SUCCESS (0.000s) [191.753989] [142/165] (819s left) vgem_basic (create) [191.836980] Starting subtest: create [191.840437] Subtest create: SUCCESS (0.000s) [191.888529] [143/165] (819s left) vgem_basic (debugfs) [191.968188] Starting subtest: debugfs [191.971455] Subtest debugfs: SUCCESS (0.000s) [192.021125] [144/165] (819s left) vgem_basic (dmabuf-export) [192.101787] Starting subtest: dmabuf-export [192.111905] Subtest dmabuf-export: SUCCESS (0.011s) [192.202731] [145/165] (819s left) vgem_basic (dmabuf-fence) [192.302467] Starting subtest: dmabuf-fence [192.305921] Subtest dmabuf-fence: SUCCESS (0.001s) [192.354932] [146/165] (819s left) vgem_basic (dmabuf-fence-before) [192.435084] Starting subtest: dmabuf-fence-before [192.438287] Subtest dmabuf-fence-before: SUCCESS (0.000s) [192.489662] [147/165] (819s left) vgem_basic (dmabuf-mmap) [192.568653] Starting subtest: dmabuf-mmap [192.579746] Subtest dmabuf-mmap: SUCCESS (0.013s) [192.640798] [148/165] (819s left) vgem_basic (mmap) [192.719202] Starting subtest: mmap [192.726130] Subtest mmap: SUCCESS (0.009s) [192.769370] [149/165] (819s left) vgem_basic (second-client) [192.851593] Starting subtest: second-client [192.886085] Subtest second-client: SUCCESS (0.033s) [192.955654] [150/165] (818s left) vgem_basic (sysfs) [193.052713] Starting subtest: sysfs [193.056488] Subtest sysfs: SUCCESS (0.001s) [193.106695] [151/165] (818s left) core_hotunplug (unbind-rebind) [193.233474] Starting subtest: unbind-rebind [196.697311] Subtest unbind-rebind: SUCCESS (3.464s) [196.722090] [152/165] (815s left) vgem_basic (unload) [196.796761] Starting subtest: unload [225.843141] Subtest unload: SUCCESS (29.045s) [225.978497] [153/165] (785s left) i915_module_load (reload) [226.051600] Starting subtest: reload [228.979018] Subtest reload: SUCCESS (2.930s) [229.000936] [154/165] (782s left) gem_lmem_swapping (basic) [229.118414] Subtest basic: SKIP (0.000s) [229.159219] [155/165] (782s left) gem_lmem_swapping (parallel-random-engines) [229.233091] Subtest parallel-random-engines: SKIP (0.000s) [229.260965] [156/165] (782s left) gem_lmem_swapping (random-engines) [229.334328] Subtest random-engines: SKIP (0.000s) [229.361264] [157/165] (782s left) gem_lmem_swapping (verify-random) [229.430653] Subtest verify-random: SKIP (0.000s) [229.457446] [158/165] (782s left) i915_pm_rpm (module-reload) [231.745087] Starting subtest: module-reload [239.553331] Subtest module-reload: SUCCESS (7.817s) [239.576763] [159/165] (772s left) i915_selftest (live) [239.676890] Starting subtest: live [239.680405] Starting dynamic subtest: sanitycheck [240.413049] Dynamic subtest sanitycheck: SUCCESS (0.735s) [240.422466] Starting dynamic subtest: uncore [241.099343] Dynamic subtest uncore: SUCCESS (0.682s) [241.109911] Starting dynamic subtest: workarounds [241.964252] Dynamic subtest workarounds: SUCCESS (0.862s) [241.973770] Starting dynamic subtest: gt_engines [243.189955] Dynamic subtest gt_engines: SUCCESS (1.227s) [243.198758] Starting dynamic subtest: gt_timelines [254.560257] Dynamic subtest gt_timelines: SUCCESS (11.369s) [254.571316] Starting dynamic subtest: gt_contexts [255.357252] Dynamic subtest gt_contexts: SUCCESS (0.795s) [255.366647] Starting dynamic subtest: gt_lrc [259.026305] Dynamic subtest gt_lrc: SUCCESS (3.665s) [259.036995] Starting dynamic subtest: gt_mocs [259.791027] Dynamic subtest gt_mocs: SUCCESS (0.765s) [259.801213] Starting dynamic subtest: gt_pm [266.348185] Dynamic subtest gt_pm: SUCCESS (6.555s) [266.357542] Starting dynamic subtest: gt_heartbeat [267.115888] Dynamic subtest gt_heartbeat: SUCCESS (0.766s) [267.128272] Starting dynamic subtest: gt_tlb [268.910083] Dynamic subtest gt_tlb: SUCCESS (1.738s) [268.977127] Starting dynamic subtest: requests [276.955049] Dynamic subtest requests: SUCCESS (8.097s) [276.966050] Starting dynamic subtest: migrate [280.521011] Dynamic subtest migrate: SUCCESS (3.564s) [280.530690] Starting dynamic subtest: active [281.230291] Dynamic subtest active: SUCCESS (0.708s) [281.241904] Starting dynamic subtest: objects [282.897891] Dynamic subtest objects: SUCCESS (1.666s) [282.907457] Starting dynamic subtest: mman [287.429018] Dynamic subtest mman: SUCCESS (4.529s) [287.438492] Starting dynamic subtest: dmabuf [288.166061] Dynamic subtest dmabuf: SUCCESS (0.736s) [288.176083] Starting dynamic subtest: vma [288.905334] Dynamic subtest vma: SUCCESS (0.735s) [288.916336] Starting dynamic subtest: coherency [290.509430] Dynamic subtest coherency: SUCCESS (1.601s) [290.519826] Starting dynamic subtest: gtt [298.506321] Dynamic subtest gtt: SUCCESS (7.996s) [298.517237] Starting dynamic subtest: gem [299.367185] Dynamic subtest gem: SUCCESS (0.859s) [299.377308] Starting dynamic subtest: evict [301.713389] Dynamic subtest evict: SUCCESS (2.344s) [301.723907] Starting dynamic subtest: hugepages [308.825327] Dynamic subtest hugepages: SUCCESS (7.112s) [308.836413] Starting dynamic subtest: gem_contexts [325.465063] Dynamic subtest gem_contexts: SUCCESS (16.638s) [325.476395] Starting dynamic subtest: client [326.227622] Dynamic subtest client: SUCCESS (0.760s) [326.236505] Starting dynamic subtest: gem_migrate [326.897279] Dynamic subtest gem_migrate: SUCCESS (0.669s) [326.909424] Starting dynamic subtest: reset [328.398257] Dynamic subtest reset: SUCCESS (1.497s) [328.407962] Starting dynamic subtest: memory_region [329.062184] Dynamic subtest memory_region: SUCCESS (0.662s) [329.072880] Starting dynamic subtest: hangcheck [358.268289] Dynamic subtest hangcheck: SUCCESS (29.205s) [358.279250] Starting dynamic subtest: execlists [371.465222] Dynamic subtest execlists: SUCCESS (13.196s) [371.475019] Starting dynamic subtest: ring_submission [372.167692] Dynamic subtest ring_submission: SUCCESS (0.700s) [372.177859] Starting dynamic subtest: perf [372.943767] Dynamic subtest perf: SUCCESS (0.775s) [372.952191] Starting dynamic subtest: slpc [373.622206] Dynamic subtest slpc: SUCCESS (0.677s) [373.635579] Starting dynamic subtest: guc [374.324055] Dynamic subtest guc: SUCCESS (0.700s) [374.334288] Starting dynamic subtest: guc_multi_lrc [374.989282] Dynamic subtest guc_multi_lrc: SUCCESS (0.663s) [374.999759] Starting dynamic subtest: guc_hang [375.671351] Dynamic subtest guc_hang: SUCCESS (0.677s) [375.681702] Starting dynamic subtest: late_gt_pm [376.371102] Dynamic subtest late_gt_pm: SUCCESS (0.701s) [376.374509] Subtest live: SUCCESS (136.695s) [376.398065] [160/165] (635s left) dmabuf (all-tests) [376.479720] Starting subtest: all-tests [376.486407] Starting dynamic subtest: sanitycheck [376.553364] Dynamic subtest sanitycheck: SUCCESS (0.070s) [376.572985] Starting dynamic subtest: dma_fence [376.740491] Dynamic subtest dma_fence: SUCCESS (0.187s) [376.753136] Starting dynamic subtest: dma_fence_chain [392.066093] Dynamic subtest dma_fence_chain: SUCCESS (15.323s) [392.083696] Starting dynamic subtest: dma_fence_unwrap [392.148047] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s) [392.168160] Starting dynamic subtest: dma_resv [392.221906] Dynamic subtest dma_resv: SUCCESS (0.071s) [392.225967] Subtest all-tests: SUCCESS (15.744s) [392.263067] [161/165] (619s left) i915_suspend (basic-s2idle-without-i915) [392.345440] Starting subtest: basic-s2idle-without-i915 [411.175386] Subtest basic-s2idle-without-i915: SUCCESS (3.711s) [414.764495] [162/165] (615s left) i915_suspend (basic-s3-without-i915) [414.843276] Starting subtest: basic-s3-without-i915 [433.849837] Subtest basic-s3-without-i915: SUCCESS (3.365s) [437.439723] [163/165] (611s left) gem_exec_suspend (basic-s0) [437.569653] Starting subtest: basic-S0 [437.572674] Starting dynamic subtest: smem [456.134954] Dynamic subtest smem: SUCCESS (2.837s) [456.138328] Subtest basic-S0: SUCCESS (2.838s) [461.329492] [164/165] (608s left) gem_exec_suspend (basic-s3) [461.407792] Starting subtest: basic-S3 [461.410957] Starting dynamic subtest: smem [480.885251] Dynamic subtest smem: SUCCESS (3.718s) [480.888835] Subtest basic-S3: SUCCESS (3.720s) [484.064666] [165/165] (604s left) kms_pipe_crc_basic (suspend-read-crc) [484.402507] Starting subtest: suspend-read-crc [484.405842] Starting dynamic subtest: pipe-A-DP-1 [503.679272] Dynamic subtest pipe-A-DP-1: SUCCESS (2.996s) [503.692502] Starting dynamic subtest: pipe-B-DP-2 [522.660423] Dynamic subtest pipe-B-DP-2: SUCCESS (2.724s) [522.672099] Starting dynamic subtest: pipe-C-DP-1 [541.675090] Dynamic subtest pipe-C-DP-1: SUCCESS (2.927s) [541.678202] Subtest suspend-read-crc: SUCCESS (8.656s) [546.034436] Closing watchdogs Done.