[42.364589] Initializing watchdogs
[42.364736]   /dev/watchdog0
[42.374626] [001/160] (960s left) i915_module_load (load)
[42.473277] Starting subtest: load
[46.683426] Subtest load: SUCCESS (4.210s)
[46.706907] [002/160] (956s left) core_auth (basic-auth)
[46.811399] Starting subtest: basic-auth
[46.813744] Subtest basic-auth: SUCCESS (0.002s)
[46.901189] [003/160] (956s left) debugfs_test (read_all_entries)
[47.021561] Starting subtest: read_all_entries
[47.103733] Subtest read_all_entries: SUCCESS (0.082s)
[47.229867] [004/160] (955s left) debugfs_test (basic-hwmon)
[47.330054] Starting subtest: basic-hwmon
[47.332165] Subtest basic-hwmon: SKIP (0.000s)
[47.433049] [005/160] (955s left) fbdev (eof)
[47.545987] Starting subtest: eof
[47.549432] Subtest eof: SUCCESS (0.001s)
[47.642241] [006/160] (955s left) fbdev (info)
[47.744081] Starting subtest: info
[47.745537] Subtest info: SUCCESS (0.000s)
[47.828090] [007/160] (955s left) fbdev (nullptr)
[47.934879] Starting subtest: nullptr
[47.936231] Subtest nullptr: SUCCESS (0.000s)
[48.002606] [008/160] (955s left) fbdev (read)
[48.101909] Starting subtest: read
[55.208192] Subtest read: SUCCESS (7.071s)
[55.241652] [009/160] (947s left) fbdev (write)
[55.343269] Starting subtest: write
[59.122264] Subtest write: SUCCESS (3.744s)
[59.163374] [010/160] (943s left) gem_basic (bad-close)
[59.266825] Starting subtest: bad-close
[59.269115] Subtest bad-close: SUCCESS (0.000s)
[59.349882] [011/160] (943s left) gem_basic (create-close)
[59.444684] Starting subtest: create-close
[59.447031] Subtest create-close: SUCCESS (0.000s)
[59.533741] [012/160] (943s left) gem_basic (create-fd-close)
[59.634570] Starting subtest: create-fd-close
[59.636690] Subtest create-fd-close: SUCCESS (0.000s)
[59.718613] [013/160] (943s left) gem_busy (busy@all-engines)
[59.832954] Starting subtest: busy
[59.834235] Starting dynamic subtest: all-engines
[59.889882] Dynamic subtest all-engines: SUCCESS (0.058s)
[59.891338] Subtest busy: SUCCESS (0.059s)
[60.287402] [014/160] (942s left) gem_close_race (basic-process)
[60.412956] Starting subtest: basic-process
[60.487496] Subtest basic-process: SUCCESS (0.075s)
[60.687017] [015/160] (942s left) gem_close_race (basic-threads)
[60.804882] Starting subtest: basic-threads
[61.977180] Subtest basic-threads: SUCCESS (1.172s)
[62.199928] [016/160] (941s left) gem_ctx_create (basic)
[62.315519] Starting subtest: basic
[62.316741] Subtest basic: SUCCESS (0.000s)
[62.522650] [017/160] (940s left) gem_ctx_create (basic-files)
[62.632771] Starting subtest: basic-files
[64.658256] Subtest basic-files: SUCCESS (2.025s)
[64.888551] [018/160] (938s left) gem_ctx_exec (basic)
[64.990500] Starting subtest: basic
[64.997066] Subtest basic: SUCCESS (0.006s)
[65.106373] [019/160] (938s left) gem_exec_basic (basic)
[65.222413] Starting subtest: basic
[65.223606] Starting dynamic subtest: rcs0-smem
[65.226090] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[65.237539] Starting dynamic subtest: bcs0-smem
[65.238810] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[65.249420] Starting dynamic subtest: vcs0-smem
[65.250669] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[65.261200] Starting dynamic subtest: vecs0-smem
[65.262617] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[65.264066] Subtest basic: SUCCESS (0.007s)
[65.437725] [020/160] (937s left) gem_exec_create (basic)
[65.554335] Starting subtest: basic
[65.555597] Starting dynamic subtest: smem
[67.624805] Dynamic subtest smem: SUCCESS (2.049s)
[67.626311] Subtest basic: SUCCESS (2.049s)
[67.814714] [021/160] (935s left) gem_exec_fence (basic-busy)
[68.073584] Starting subtest: basic-busy
[68.074893] Starting dynamic subtest: rcs0
[68.103156] Dynamic subtest rcs0: SUCCESS (0.035s)
[68.117198] Starting dynamic subtest: bcs0
[68.126815] Dynamic subtest bcs0: SUCCESS (0.023s)
[68.138768] Starting dynamic subtest: vcs0
[68.148675] Dynamic subtest vcs0: SUCCESS (0.022s)
[68.160160] Starting dynamic subtest: vecs0
[68.167541] Dynamic subtest vecs0: SUCCESS (0.019s)
[68.168637] Subtest basic-busy: SUCCESS (0.100s)
[68.767599] [022/160] (934s left) gem_exec_fence (basic-wait)
[69.031055] Starting subtest: basic-wait
[69.039777] Starting dynamic subtest: rcs0
[69.057618] Dynamic subtest rcs0: SUCCESS (0.032s)
[69.072246] Starting dynamic subtest: bcs0
[69.086729] Dynamic subtest bcs0: SUCCESS (0.029s)
[69.099298] Starting dynamic subtest: vcs0
[69.114532] Dynamic subtest vcs0: SUCCESS (0.028s)
[69.129695] Starting dynamic subtest: vecs0
[69.139452] Dynamic subtest vecs0: SUCCESS (0.025s)
[69.140530] Subtest basic-wait: SUCCESS (0.115s)
[69.679667] [023/160] (933s left) gem_exec_fence (basic-await)
[69.939492] Starting subtest: basic-await
[69.940833] Starting dynamic subtest: rcs0
[70.029365] Dynamic subtest rcs0: SUCCESS (0.097s)
[70.055271] Starting dynamic subtest: bcs0
[70.141514] Dynamic subtest bcs0: SUCCESS (0.111s)
[70.168276] Starting dynamic subtest: vcs0
[70.273762] Dynamic subtest vcs0: SUCCESS (0.128s)
[70.302338] Starting dynamic subtest: vecs0
[70.424907] Dynamic subtest vecs0: SUCCESS (0.130s)
[70.432820] Subtest basic-await: SUCCESS (0.470s)
[70.964615] [024/160] (932s left) gem_exec_fence (nb-await)
[71.234281] Starting subtest: nb-await
[71.235492] Starting dynamic subtest: rcs0
[71.294691] Dynamic subtest rcs0: SUCCESS (0.067s)
[71.312382] Starting dynamic subtest: bcs0
[71.363549] Dynamic subtest bcs0: SUCCESS (0.069s)
[71.385244] Starting dynamic subtest: vcs0
[71.437928] Dynamic subtest vcs0: SUCCESS (0.074s)
[71.466220] Starting dynamic subtest: vecs0
[71.512901] Dynamic subtest vecs0: SUCCESS (0.075s)
[71.514812] Subtest nb-await: SUCCESS (0.287s)
[72.081844] [025/160] (931s left) gem_exec_gttfill (basic)
[72.194267] Starting subtest: basic
[78.369310] Subtest basic: SUCCESS (6.167s)
[78.553216] [026/160] (924s left) gem_exec_parallel (engines)
[78.782028] Starting subtest: engines
[78.783341] Starting dynamic subtest: basic
[81.265179] Dynamic subtest basic: SUCCESS (2.458s)
[81.278551] Starting dynamic subtest: contexts
[89.358839] Dynamic subtest contexts: SUCCESS (8.112s)
[89.374930] Starting dynamic subtest: fds
[102.354087] Dynamic subtest fds: SUCCESS (13.003s)
[102.372969] Starting dynamic subtest: userptr
[105.412674] Dynamic subtest userptr: SUCCESS (3.032s)
[105.415048] Subtest engines: SUCCESS (26.606s)
[105.620140] [027/160] (897s left) gem_exec_store (basic)
[105.737956] Starting subtest: basic
[105.785919] Subtest basic: SUCCESS (0.048s)
[105.986056] [028/160] (897s left) gem_flink_basic (bad-flink)
[106.085682] Starting subtest: bad-flink
[106.086845] Subtest bad-flink: SUCCESS (0.000s)
[106.185922] [029/160] (897s left) gem_flink_basic (bad-open)
[106.282520] Starting subtest: bad-open
[106.283746] Subtest bad-open: SUCCESS (0.000s)
[106.385439] [030/160] (897s left) gem_flink_basic (basic)
[106.486645] Starting subtest: basic
[106.487760] Subtest basic: SUCCESS (0.000s)
[106.586141] [031/160] (897s left) gem_flink_basic (double-flink)
[106.684390] Starting subtest: double-flink
[106.685469] Subtest double-flink: SUCCESS (0.000s)
[106.768073] [032/160] (896s left) gem_flink_basic (flink-lifetime)
[106.865531] Starting subtest: flink-lifetime
[106.868077] Subtest flink-lifetime: SUCCESS (0.003s)
[106.970618] [033/160] (896s left) gem_huc_copy (huc-copy)
[107.078365] Starting subtest: huc-copy
[107.080544] Subtest huc-copy: SKIP (0.000s)
[107.188975] [034/160] (896s left) gem_linear_blits (basic)
[107.436195] Starting subtest: basic
[107.454451] Subtest basic: SUCCESS (0.019s)
[107.591847] [035/160] (896s left) gem_mmap (basic)
[107.756738] Starting subtest: basic
[107.762022] Subtest basic: SUCCESS (0.001s)
[107.855141] [036/160] (895s left) gem_mmap_gtt (basic)
[107.953477] Starting subtest: basic
[107.954606] Subtest basic: SUCCESS (0.002s)
[108.063620] [037/160] (895s left) gem_render_linear_blits (basic)
[108.166798] Starting subtest: basic
[108.213984] Subtest basic: SUCCESS (0.047s)
[108.281225] [038/160] (895s left) gem_render_tiled_blits (basic)
[108.390422] Starting subtest: basic
[108.447750] Subtest basic: SUCCESS (0.057s)
[108.497634] [039/160] (895s left) gem_ringfill (basic-all)
[108.750247] Starting subtest: basic-all
[109.996321] Subtest basic-all: SUCCESS (1.237s)
[110.078729] [040/160] (893s left) gem_softpin (allocator-basic)
[110.192213] Starting subtest: allocator-basic
[110.367741] Subtest allocator-basic: SUCCESS (0.167s)
[110.477797] [041/160] (893s left) gem_softpin (allocator-basic-reserve)
[110.585876] Starting subtest: allocator-basic-reserve
[110.762146] Subtest allocator-basic-reserve: SUCCESS (0.168s)
[110.877220] [042/160] (893s left) gem_softpin (safe-alignment)
[110.992331] Starting subtest: safe-alignment
[111.012439] Subtest safe-alignment: SUCCESS (0.020s)
[111.125334] [043/160] (892s left) gem_sync (basic-all)
[111.246137] Starting subtest: basic-all
[113.287198] Subtest basic-all: SUCCESS (2.041s)
[113.496522] [044/160] (890s left) gem_sync (basic-each)
[113.609921] Starting subtest: basic-each
[115.937131] Subtest basic-each: SUCCESS (2.327s)
[116.150551] [045/160] (887s left) gem_tiled_blits (basic)
[116.391338] Starting subtest: basic
[116.421749] Subtest basic: SUCCESS (0.031s)
[116.547240] [046/160] (887s left) gem_tiled_fence_blits (basic)
[116.852956] Starting subtest: basic
[116.881637] Subtest basic: SUCCESS (0.029s)
[117.013289] [047/160] (887s left) gem_tiled_pread_basic
[117.549475] [048/160] (886s left) gem_wait (busy@all-engines)
[117.679345] Starting subtest: busy
[117.680545] Starting dynamic subtest: all-engines
[118.198645] Dynamic subtest all-engines: SUCCESS (0.517s)
[118.202370] Subtest busy: SUCCESS (0.518s)
[118.451040] [049/160] (885s left) gem_wait (wait@all-engines)
[118.575085] Starting subtest: wait
[118.576323] Starting dynamic subtest: all-engines
[119.615318] Dynamic subtest all-engines: SUCCESS (1.039s)
[119.616914] Subtest wait: SUCCESS (1.040s)
[119.872091] [050/160] (884s left) i915_getparams_basic (basic-eu-total)
[119.975720] Starting subtest: basic-eu-total
[119.977872] Subtest basic-eu-total: SUCCESS (0.000s)
[120.084193] [051/160] (884s left) i915_getparams_basic (basic-subslice-total)
[120.179319] Starting subtest: basic-subslice-total
[120.181439] Subtest basic-subslice-total: SUCCESS (0.000s)
[120.266646] [052/160] (884s left) i915_hangman (error-state-basic)
[120.389599] Starting subtest: error-state-basic
[120.401504] Subtest error-state-basic: SUCCESS (0.011s)
[120.500912] [053/160] (883s left) i915_pciid
[120.702277] [054/160] (883s left) kms_addfb_basic (addfb25-4-tiled)
[120.844665] Starting subtest: addfb25-4-tiled
[120.845934] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[120.929546] [055/160] (883s left) kms_addfb_basic (addfb25-bad-modifier)
[121.039354] Starting subtest: addfb25-bad-modifier
[121.040646] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[121.169610] [056/160] (883s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[121.272717] Starting subtest: addfb25-framebuffer-vs-set-tiling
[121.273758] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[121.411291] [057/160] (883s left) kms_addfb_basic (addfb25-modifier-no-flag)
[121.513527] Starting subtest: addfb25-modifier-no-flag
[121.514627] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[121.636167] [058/160] (882s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[121.737831] Starting subtest: addfb25-x-tiled-legacy
[121.738972] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[121.864849] [059/160] (882s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[121.967684] Starting subtest: addfb25-x-tiled-mismatch-legacy
[121.968838] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[122.104628] [060/160] (882s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[122.236756] Starting subtest: addfb25-yf-tiled-legacy
[122.237990] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[122.337568] [061/160] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[122.467933] Starting subtest: addfb25-y-tiled-legacy
[122.469176] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[122.580725] [062/160] (881s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[122.710510] Starting subtest: addfb25-y-tiled-small-legacy
[122.711656] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[122.821304] [063/160] (881s left) kms_addfb_basic (bad-pitch-0)
[122.926852] Starting subtest: bad-pitch-0
[122.928206] Subtest bad-pitch-0: SUCCESS (0.000s)
[123.048563] [064/160] (881s left) kms_addfb_basic (bad-pitch-1024)
[123.147673] Starting subtest: bad-pitch-1024
[123.148792] Subtest bad-pitch-1024: SUCCESS (0.000s)
[123.271363] [065/160] (881s left) kms_addfb_basic (bad-pitch-128)
[123.377545] Starting subtest: bad-pitch-128
[123.378656] Subtest bad-pitch-128: SUCCESS (0.000s)
[123.521507] [066/160] (881s left) kms_addfb_basic (bad-pitch-256)
[123.621608] Starting subtest: bad-pitch-256
[123.622736] Subtest bad-pitch-256: SUCCESS (0.000s)
[123.757662] [067/160] (880s left) kms_addfb_basic (bad-pitch-32)
[123.859235] Starting subtest: bad-pitch-32
[123.860293] Subtest bad-pitch-32: SUCCESS (0.000s)
[124.005674] [068/160] (880s left) kms_addfb_basic (bad-pitch-63)
[124.107508] Starting subtest: bad-pitch-63
[124.108638] Subtest bad-pitch-63: SUCCESS (0.000s)
[124.234276] [069/160] (880s left) kms_addfb_basic (bad-pitch-65536)
[124.335492] Starting subtest: bad-pitch-65536
[124.336603] Subtest bad-pitch-65536: SUCCESS (0.000s)
[124.449613] [070/160] (880s left) kms_addfb_basic (bad-pitch-999)
[124.548770] Starting subtest: bad-pitch-999
[124.549955] Subtest bad-pitch-999: SUCCESS (0.000s)
[124.692230] [071/160] (880s left) kms_addfb_basic (basic)
[124.792739] Starting subtest: basic
[124.794117] Subtest basic: SUCCESS (0.000s)
[124.923206] [072/160] (879s left) kms_addfb_basic (basic-x-tiled-legacy)
[125.020665] Starting subtest: basic-x-tiled-legacy
[125.021765] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[125.156861] [073/160] (879s left) kms_addfb_basic (basic-y-tiled-legacy)
[125.258853] Starting subtest: basic-y-tiled-legacy
[125.259947] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[125.391263] [074/160] (879s left) kms_addfb_basic (bo-too-small)
[125.521341] Starting subtest: bo-too-small
[125.522514] Subtest bo-too-small: SUCCESS (0.000s)
[125.618622] [075/160] (879s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[125.745075] Starting subtest: bo-too-small-due-to-tiling
[125.746243] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[125.840254] [076/160] (879s left) kms_addfb_basic (clobberred-modifier)
[125.934407] Starting subtest: clobberred-modifier
[125.935516] Subtest clobberred-modifier: SUCCESS (0.000s)
[126.075157] [077/160] (878s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[126.179807] Starting subtest: framebuffer-vs-set-tiling
[126.181118] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[126.309634] [078/160] (878s left) kms_addfb_basic (invalid-get-prop)
[126.414028] Starting subtest: invalid-get-prop
[126.415241] Subtest invalid-get-prop: SUCCESS (0.000s)
[126.558517] [079/160] (878s left) kms_addfb_basic (invalid-get-prop-any)
[126.657672] Starting subtest: invalid-get-prop-any
[126.658721] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[126.774825] [080/160] (878s left) kms_addfb_basic (invalid-set-prop)
[126.876867] Starting subtest: invalid-set-prop
[126.878075] Subtest invalid-set-prop: SUCCESS (0.000s)
[127.007043] [081/160] (878s left) kms_addfb_basic (invalid-set-prop-any)
[127.108053] Starting subtest: invalid-set-prop-any
[127.109103] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[127.247957] [082/160] (877s left) kms_addfb_basic (no-handle)
[127.344519] Starting subtest: no-handle
[127.345649] Subtest no-handle: SUCCESS (0.000s)
[127.478169] [083/160] (877s left) kms_addfb_basic (size-max)
[127.610662] Starting subtest: size-max
[127.611866] Subtest size-max: SUCCESS (0.000s)
[127.705742] [084/160] (877s left) kms_addfb_basic (small-bo)
[127.841883] Starting subtest: small-bo
[127.846106] Subtest small-bo: SUCCESS (0.000s)
[127.940480] [085/160] (877s left) kms_addfb_basic (tile-pitch-mismatch)
[128.042736] Starting subtest: tile-pitch-mismatch
[128.043928] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[128.173852] [086/160] (877s left) kms_addfb_basic (too-high)
[128.301507] Starting subtest: too-high
[128.302727] Subtest too-high: SUCCESS (0.001s)
[128.410451] [087/160] (876s left) kms_addfb_basic (too-wide)
[128.547261] Starting subtest: too-wide
[128.548406] Subtest too-wide: SUCCESS (0.000s)
[128.659872] [088/160] (876s left) kms_addfb_basic (unused-handle)
[128.764900] Starting subtest: unused-handle
[128.766026] Subtest unused-handle: SUCCESS (0.000s)
[128.911082] [089/160] (876s left) kms_addfb_basic (unused-modifier)
[129.013482] Starting subtest: unused-modifier
[129.014607] Subtest unused-modifier: SUCCESS (0.000s)
[129.140156] [090/160] (876s left) kms_addfb_basic (unused-offsets)
[129.234483] Starting subtest: unused-offsets
[129.235604] Subtest unused-offsets: SUCCESS (0.000s)
[129.358461] [091/160] (876s left) kms_addfb_basic (unused-pitches)
[129.455414] Starting subtest: unused-pitches
[129.456531] Subtest unused-pitches: SUCCESS (0.000s)
[129.588710] [092/160] (875s left) kms_busy (basic)
[129.720748] Starting subtest: basic
[129.721984] Starting dynamic subtest: flip
[130.711786] Dynamic subtest flip: SUCCESS (0.987s)
[130.727227] Starting dynamic subtest: modeset
[134.641544] Dynamic subtest modeset: SUCCESS (3.930s)
[134.642740] Subtest basic: SUCCESS (4.920s)
[135.593962] [093/160] (869s left) kms_prop_blob (basic)
[135.702617] Starting subtest: basic
[135.703796] Subtest basic: SUCCESS (0.000s)
[135.793692] [094/160] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[135.925080] Starting subtest: basic-busy-flip-before-cursor-atomic
[135.927513] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[136.017118] [095/160] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[136.145503] Starting subtest: basic-busy-flip-before-cursor-legacy
[136.147874] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[136.226334] [096/160] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[136.350800] Starting subtest: basic-flip-after-cursor-atomic
[137.642279] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.290s)
[138.604729] [097/160] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[138.745303] Starting subtest: basic-flip-after-cursor-legacy
[140.051958] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.305s)
[140.962906] [098/160] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[141.087595] Starting subtest: basic-flip-after-cursor-varying-size
[142.397826] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.310s)
[143.336220] [099/160] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[143.464891] Starting subtest: basic-flip-before-cursor-atomic
[144.729112] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.265s)
[145.704298] [100/160] (859s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[145.839578] Starting subtest: basic-flip-before-cursor-legacy
[147.150537] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.310s)
[148.069934] [101/160] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[148.205506] Starting subtest: basic-flip-before-cursor-varying-size
[149.517721] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.311s)
[150.438383] [102/160] (855s left) kms_dsc (dsc-basic)
[150.569714] Starting subtest: dsc-basic
[150.572097] Subtest dsc-basic: SKIP (0.001s)
[150.656313] [103/160] (855s left) kms_flip (basic-flip-vs-dpms)
[150.789430] Starting subtest: basic-flip-vs-dpms
[150.792190] Starting dynamic subtest: A-eDP1
[153.642040] Dynamic subtest A-eDP1: SUCCESS (2.846s)
[153.658665] Starting dynamic subtest: B-eDP1
[156.060849] Dynamic subtest B-eDP1: SUCCESS (2.421s)
[156.078494] Starting dynamic subtest: C-eDP1
[158.498236] Dynamic subtest C-eDP1: SUCCESS (2.436s)
[158.500653] Subtest basic-flip-vs-dpms: SUCCESS (7.712s)
[159.431410] [104/160] (846s left) kms_flip (basic-flip-vs-modeset)
[159.557243] Starting subtest: basic-flip-vs-modeset
[159.559882] Starting dynamic subtest: A-eDP1
[162.394053] Dynamic subtest A-eDP1: SUCCESS (2.833s)
[162.410619] Starting dynamic subtest: B-eDP1
[164.763211] Dynamic subtest B-eDP1: SUCCESS (2.368s)
[164.780690] Starting dynamic subtest: C-eDP1
[167.132194] Dynamic subtest C-eDP1: SUCCESS (2.368s)
[167.134718] Subtest basic-flip-vs-modeset: SUCCESS (7.579s)
[168.103350] [105/160] (837s left) kms_flip (basic-flip-vs-wf_vblank)
[168.239036] Starting subtest: basic-flip-vs-wf_vblank
[168.241646] Starting dynamic subtest: A-eDP1
[170.564209] Dynamic subtest A-eDP1: SUCCESS (2.320s)
[170.581860] Starting dynamic subtest: B-eDP1
[172.851910] Dynamic subtest B-eDP1: SUCCESS (2.287s)
[172.869687] Starting dynamic subtest: C-eDP1
[175.091596] Dynamic subtest C-eDP1: SUCCESS (2.237s)
[175.096332] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.859s)
[176.422866] [106/160] (829s left) kms_flip (basic-plain-flip)
[176.560581] Starting subtest: basic-plain-flip
[176.564303] Starting dynamic subtest: A-eDP1
[178.600646] Dynamic subtest A-eDP1: SUCCESS (2.035s)
[178.624471] Starting dynamic subtest: B-eDP1
[180.568264] Dynamic subtest B-eDP1: SUCCESS (1.965s)
[180.586540] Starting dynamic subtest: C-eDP1
[182.554509] Dynamic subtest C-eDP1: SUCCESS (1.984s)
[182.561991] Subtest basic-plain-flip: SUCCESS (6.000s)
[183.860295] [107/160] (821s left) kms_force_connector_basic (force-connector-state)
[183.961445] Starting subtest: force-connector-state
[184.551281] Subtest force-connector-state: SUCCESS (0.590s)
[185.635464] [108/160] (820s left) kms_force_connector_basic (force-edid)
[185.741049] Starting subtest: force-edid
[186.005388] Subtest force-edid: SUCCESS (0.262s)
[186.128688] [109/160] (819s left) kms_force_connector_basic (force-load-detect)
[186.228343] Starting subtest: force-load-detect
[186.230564] Subtest force-load-detect: SKIP (0.000s)
[186.344350] [110/160] (819s left) kms_force_connector_basic (prune-stale-modes)
[186.445809] Starting subtest: prune-stale-modes
[186.764581] Subtest prune-stale-modes: SUCCESS (0.319s)
[186.895194] [111/160] (819s left) kms_frontbuffer_tracking (basic)
[187.030689] Starting subtest: basic
[190.747582] Subtest basic: SUCCESS (3.716s)
[190.890183] [112/160] (815s left) kms_hdmi_inject (inject-audio)
[191.318554] Starting subtest: inject-audio
[191.563047] Subtest inject-audio: SUCCESS (0.243s)
[192.257278] [113/160] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[192.397070] Starting subtest: compare-crc-sanitycheck-xr24
[192.399999] Starting dynamic subtest: pipe-A-eDP-1
[193.089241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[193.106959] Starting dynamic subtest: pipe-B-eDP-1
[194.485149] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[194.504680] Starting dynamic subtest: pipe-C-eDP-1
[195.869388] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[195.870508] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.474s)
[196.839167] [114/160] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[196.969807] Starting subtest: compare-crc-sanitycheck-nv12
[196.973039] Starting dynamic subtest: pipe-A-eDP-1
[197.902563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.930s)
[197.921462] Starting dynamic subtest: pipe-B-eDP-1
[199.299229] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[199.318529] Starting dynamic subtest: pipe-C-eDP-1
[200.675149] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[200.676386] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.706s)
[201.642194] [115/160] (804s left) kms_pipe_crc_basic (hang-read-crc)
[201.769869] Starting subtest: hang-read-crc
[201.771073] Starting dynamic subtest: pipe-A-eDP-1
[204.205147] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.434s)
[204.224089] Starting dynamic subtest: pipe-B-eDP-1
[207.290421] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.082s)
[207.309351] Starting dynamic subtest: pipe-C-eDP-1
[210.300044] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.005s)
[210.301332] Subtest hang-read-crc: SUCCESS (8.530s)
[211.240988] [116/160] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[211.372045] Starting subtest: nonblocking-crc
[211.375077] Starting dynamic subtest: pipe-A-eDP-1
[212.267718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[212.286486] Starting dynamic subtest: pipe-B-eDP-1
[213.887353] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.615s)
[213.905720] Starting dynamic subtest: pipe-C-eDP-1
[215.444666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.554s)
[215.445994] Subtest nonblocking-crc: SUCCESS (4.072s)
[216.359756] [117/160] (789s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[216.489977] Starting subtest: nonblocking-crc-frame-sequence
[216.493061] Starting dynamic subtest: pipe-A-eDP-1
[217.388598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.896s)
[217.407188] Starting dynamic subtest: pipe-B-eDP-1
[218.987247] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s)
[219.006480] Starting dynamic subtest: pipe-C-eDP-1
[220.575503] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.585s)
[220.576804] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.086s)
[221.547388] [118/160] (784s left) kms_pipe_crc_basic (read-crc)
[221.674611] Starting subtest: read-crc
[221.675732] Starting dynamic subtest: pipe-A-eDP-1
[222.518518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[222.541215] Starting dynamic subtest: pipe-B-eDP-1
[224.058595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s)
[224.077288] Starting dynamic subtest: pipe-C-eDP-1
[225.561897] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s)
[225.563173] Subtest read-crc: SUCCESS (3.889s)
[226.535159] [119/160] (779s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[226.671129] Starting subtest: read-crc-frame-sequence
[226.674193] Starting dynamic subtest: pipe-A-eDP-1
[227.499030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[227.517292] Starting dynamic subtest: pipe-B-eDP-1
[229.032580] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.531s)
[229.051402] Starting dynamic subtest: pipe-C-eDP-1
[230.547830] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[230.549080] Subtest read-crc-frame-sequence: SUCCESS (3.877s)
[231.468656] [120/160] (774s left) kms_pm_backlight (basic-brightness)
[231.596237] Starting subtest: basic-brightness
[231.696250] Starting dynamic subtest: eDP-1
[232.229623] Dynamic subtest eDP-1: SUCCESS (0.534s)
[232.230987] Subtest basic-brightness: SUCCESS (0.634s)
[233.196663] [121/160] (773s left) kms_pm_rpm (basic-pci-d3-state)
[235.027912] Starting subtest: basic-pci-d3-state
[239.427281] Subtest basic-pci-d3-state: SUCCESS (4.398s)
[239.629904] [122/160] (766s left) kms_pm_rpm (basic-rte)
[239.716060] Starting subtest: basic-rte
[245.893863] Subtest basic-rte: SUCCESS (6.174s)
[247.404318] [123/160] (758s left) kms_psr (psr-primary-page-flip)
[247.535540] Starting subtest: psr-primary-page-flip
[247.536843] Starting dynamic subtest: eDP-1
[251.323228] Dynamic subtest eDP-1: SUCCESS (3.785s)
[251.324378] Subtest psr-primary-page-flip: SUCCESS (3.787s)
[252.265903] [124/160] (754s left) kms_psr (psr-cursor-plane-move)
[252.404123] Starting subtest: psr-cursor-plane-move
[252.405455] Starting dynamic subtest: eDP-1
[256.160525] Dynamic subtest eDP-1: SUCCESS (3.755s)
[256.161681] Subtest psr-cursor-plane-move: SUCCESS (3.758s)
[257.128801] [125/160] (749s left) kms_psr (psr-sprite-plane-onoff)
[257.259912] Starting subtest: psr-sprite-plane-onoff
[257.261186] Starting dynamic subtest: eDP-1
[261.134806] Dynamic subtest eDP-1: SUCCESS (3.873s)
[261.137359] Subtest psr-sprite-plane-onoff: SUCCESS (3.875s)
[262.056328] [126/160] (744s left) kms_psr (psr-primary-mmap-gtt)
[262.194697] Starting subtest: psr-primary-mmap-gtt
[262.195920] Starting dynamic subtest: eDP-1
[265.978372] Dynamic subtest eDP-1: SUCCESS (3.778s)
[265.979532] Subtest psr-primary-mmap-gtt: SUCCESS (3.781s)
[266.918133] [127/160] (739s left) kms_setmode (basic-clone-single-crtc)
[267.023681] Starting subtest: basic-clone-single-crtc
[267.027109] Subtest basic-clone-single-crtc: SKIP (0.000s)
[267.118828] [128/160] (739s left) i915_pm_rps (basic-api)
[267.228673] Starting subtest: basic-api
[267.233733] Subtest basic-api: SUCCESS (0.005s)
[267.317688] [129/160] (739s left) prime_self_import (basic-llseek-bad)
[267.407296] Starting subtest: basic-llseek-bad
[267.422433] Subtest basic-llseek-bad: SUCCESS (0.017s)
[267.536415] [130/160] (738s left) prime_self_import (basic-llseek-size)
[267.626328] Starting subtest: basic-llseek-size
[267.633541] Subtest basic-llseek-size: SUCCESS (0.011s)
[267.752083] [131/160] (738s left) prime_self_import (basic-with_fd_dup)
[267.837894] Starting subtest: basic-with_fd_dup
[267.852444] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[267.952292] [132/160] (738s left) prime_self_import (basic-with_one_bo)
[268.038209] Starting subtest: basic-with_one_bo
[268.059495] Subtest basic-with_one_bo: SUCCESS (0.020s)
[268.163203] [133/160] (738s left) prime_self_import (basic-with_one_bo_two_files)
[268.250439] Starting subtest: basic-with_one_bo_two_files
[268.267370] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[268.372683] [134/160] (738s left) prime_self_import (basic-with_two_bos)
[268.459670] Starting subtest: basic-with_two_bos
[268.475421] Subtest basic-with_two_bos: SUCCESS (0.016s)
[268.573705] [135/160] (738s left) prime_vgem (basic-fence-flip)
[268.697810] Starting subtest: basic-fence-flip
[269.226537] Subtest basic-fence-flip: SUCCESS (0.528s)
[269.338387] [136/160] (737s left) prime_vgem (basic-fence-mmap)
[269.458169] Starting subtest: basic-fence-mmap
[269.507489] Subtest basic-fence-mmap: SUCCESS (0.049s)
[269.606131] [137/160] (737s left) prime_vgem (basic-fence-read)
[269.728623] Starting subtest: basic-fence-read
[269.827247] Subtest basic-fence-read: SUCCESS (0.098s)
[269.922543] [138/160] (736s left) prime_vgem (basic-gtt)
[270.059879] Starting subtest: basic-gtt
[270.084998] Subtest basic-gtt: SUCCESS (0.025s)
[270.188573] [139/160] (736s left) prime_vgem (basic-read)
[270.316406] Starting subtest: basic-read
[270.365245] Subtest basic-read: SUCCESS (0.049s)
[270.472568] [140/160] (736s left) prime_vgem (basic-write)
[270.597951] Starting subtest: basic-write
[270.664787] Subtest basic-write: SUCCESS (0.066s)
[270.756973] [141/160] (736s left) vgem_basic (setversion)
[270.865475] Starting subtest: setversion
[270.868192] Subtest setversion: SUCCESS (0.000s)
[270.938163] [142/160] (735s left) vgem_basic (create)
[271.028729] Starting subtest: create
[271.029875] Subtest create: SUCCESS (0.000s)
[271.106706] [143/160] (735s left) vgem_basic (debugfs)
[271.213424] Starting subtest: debugfs
[271.214649] Subtest debugfs: SUCCESS (0.001s)
[271.288273] [144/160] (735s left) vgem_basic (dmabuf-export)
[271.379807] Starting subtest: dmabuf-export
[271.396463] Subtest dmabuf-export: SUCCESS (0.016s)
[271.507592] [145/160] (735s left) vgem_basic (dmabuf-fence)
[271.614898] Starting subtest: dmabuf-fence
[271.616264] Subtest dmabuf-fence: SUCCESS (0.001s)
[271.689266] [146/160] (735s left) vgem_basic (dmabuf-fence-before)
[271.779660] Starting subtest: dmabuf-fence-before
[271.780877] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[271.855948] [147/160] (735s left) vgem_basic (dmabuf-mmap)
[271.964352] Starting subtest: dmabuf-mmap
[271.989461] Subtest dmabuf-mmap: SUCCESS (0.025s)
[272.051202] [148/160] (735s left) vgem_basic (mmap)
[272.146868] Starting subtest: mmap
[272.166775] Subtest mmap: SUCCESS (0.018s)
[272.238597] [149/160] (734s left) vgem_basic (second-client)
[272.348782] Starting subtest: second-client
[272.382734] Subtest second-client: SUCCESS (0.033s)
[272.457355] [150/160] (734s left) vgem_basic (sysfs)
[272.564353] Starting subtest: sysfs
[272.565489] Subtest sysfs: SUCCESS (0.001s)
[272.639504] [151/160] (734s left) core_hotunplug (unbind-rebind)
[272.780879] Starting subtest: unbind-rebind
[278.862197] Subtest unbind-rebind: SUCCESS (6.081s)
[278.897712] [152/160] (728s left) vgem_basic (unload)
[278.992489] Starting subtest: unload
[308.007158] Subtest unload: SUCCESS (28.981s)
[308.122472] [153/160] (699s left) i915_module_load (reload)
[308.213621] Starting subtest: reload
[313.159331] Subtest reload: SUCCESS (4.945s)
[313.188781] [154/160] (694s left) gem_lmem_swapping (basic)
[313.298179] Subtest basic: SKIP (0.000s)
[313.342923] [155/160] (693s left) gem_lmem_swapping (parallel-random-engines)
[313.440160] Subtest parallel-random-engines: SKIP (0.000s)
[313.493270] [156/160] (693s left) gem_lmem_swapping (random-engines)
[313.590876] Subtest random-engines: SKIP (0.000s)
[313.643309] [157/160] (693s left) gem_lmem_swapping (verify-random)
[313.739531] Subtest verify-random: SKIP (0.000s)
[313.795137] [158/160] (693s left) i915_pm_rpm (module-reload)
[326.284096] Starting subtest: module-reload
[358.769052] Subtest module-reload: SUCCESS (32.476s)
[358.793071] [159/160] (648s left) i915_selftest (live)
[358.891157] Starting subtest: live
[358.892498] Starting dynamic subtest: sanitycheck
[362.362805] Dynamic subtest sanitycheck: SUCCESS (3.462s)
[362.373627] Starting dynamic subtest: uncore
[365.814427] Dynamic subtest uncore: SUCCESS (3.448s)
[365.825187] Starting dynamic subtest: workarounds
[369.527470] Dynamic subtest workarounds: SUCCESS (3.710s)
[369.538127] Starting dynamic subtest: gt_engines
[373.427467] Dynamic subtest gt_engines: SUCCESS (3.897s)
[373.438238] Starting dynamic subtest: gt_timelines
[388.856626] Dynamic subtest gt_timelines: SUCCESS (15.425s)
[388.867429] Starting dynamic subtest: gt_contexts
[392.440787] Dynamic subtest gt_contexts: SUCCESS (3.581s)
[392.451693] Starting dynamic subtest: gt_lrc
[397.839937] Dynamic subtest gt_lrc: SUCCESS (5.395s)
[397.850839] Starting dynamic subtest: gt_mocs
[401.378770] Dynamic subtest gt_mocs: SUCCESS (3.535s)
[401.389910] Starting dynamic subtest: gt_pm
[408.082657] Dynamic subtest gt_pm: SUCCESS (6.700s)
[408.093665] Starting dynamic subtest: gt_heartbeat
[411.578512] Dynamic subtest gt_heartbeat: SUCCESS (3.493s)
[411.589436] Starting dynamic subtest: gt_tlb
[416.138350] Dynamic subtest gt_tlb: SUCCESS (4.555s)
[416.149382] Starting dynamic subtest: requests
[425.405622] Dynamic subtest requests: SUCCESS (9.264s)
[425.416496] Starting dynamic subtest: migrate
[431.305636] Dynamic subtest migrate: SUCCESS (5.896s)
[431.316527] Starting dynamic subtest: active
[434.779758] Dynamic subtest active: SUCCESS (3.470s)
[434.790736] Starting dynamic subtest: objects
[439.391782] Dynamic subtest objects: SUCCESS (4.609s)
[439.402753] Starting dynamic subtest: mman
[448.298798] Dynamic subtest mman: SUCCESS (8.904s)
[448.309893] Starting dynamic subtest: dmabuf
[451.800858] Dynamic subtest dmabuf: SUCCESS (3.498s)
[451.811975] Starting dynamic subtest: vma
[455.225729] Dynamic subtest vma: SUCCESS (3.421s)
[455.236731] Starting dynamic subtest: coherency
[461.557051] Dynamic subtest coherency: SUCCESS (6.327s)
[461.567901] Starting dynamic subtest: gtt
[472.262202] Dynamic subtest gtt: SUCCESS (10.702s)
[472.273108] Starting dynamic subtest: gem
[475.860488] Dynamic subtest gem: SUCCESS (3.595s)
[475.871340] Starting dynamic subtest: evict
[481.007751] Dynamic subtest evict: SUCCESS (5.144s)
[481.019034] Starting dynamic subtest: hugepages
[490.393792] Dynamic subtest hugepages: SUCCESS (9.382s)
[490.404994] Starting dynamic subtest: gem_contexts
[508.888759] Dynamic subtest gem_contexts: SUCCESS (18.465s)
[508.904199] Starting dynamic subtest: client
[512.337604] Dynamic subtest client: SUCCESS (3.472s)
[512.348818] Starting dynamic subtest: gem_migrate
[515.771843] Dynamic subtest gem_migrate: SUCCESS (3.431s)
[515.783117] Starting dynamic subtest: reset
[522.732533] Dynamic subtest reset: SUCCESS (6.956s)
[522.746414] Starting dynamic subtest: memory_region
[526.197653] Dynamic subtest memory_region: SUCCESS (3.462s)
[526.208881] Starting dynamic subtest: hangcheck
[552.272410] Dynamic subtest hangcheck: SUCCESS (26.071s)
[552.283604] Starting dynamic subtest: execlists
[564.392101] Dynamic subtest execlists: SUCCESS (12.116s)
[564.404794] Starting dynamic subtest: ring_submission
[567.880740] Dynamic subtest ring_submission: SUCCESS (3.485s)
[567.891908] Starting dynamic subtest: perf
[571.394964] Dynamic subtest perf: SUCCESS (3.511s)
[571.406417] Starting dynamic subtest: slpc
[574.840868] Dynamic subtest slpc: SUCCESS (3.443s)
[574.852059] Starting dynamic subtest: guc
[578.312545] Dynamic subtest guc: SUCCESS (3.468s)
[578.323754] Starting dynamic subtest: guc_multi_lrc
[581.776684] Dynamic subtest guc_multi_lrc: SUCCESS (3.461s)
[581.787844] Starting dynamic subtest: guc_hang
[585.223822] Dynamic subtest guc_hang: SUCCESS (3.443s)
[585.235083] Starting dynamic subtest: late_gt_pm
[588.728043] Dynamic subtest late_gt_pm: SUCCESS (3.501s)
[588.729205] Subtest live: SUCCESS (229.830s)
[588.752380] [160/160] (418s left) dmabuf (all-tests)
[588.847664] Starting subtest: all-tests
[588.848995] Starting dynamic subtest: sanitycheck
[588.917682] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[588.937625] Starting dynamic subtest: dma_fence
[589.112068] Dynamic subtest dma_fence: SUCCESS (0.190s)
[589.130288] Starting dynamic subtest: dma_fence_chain
[607.008305] Dynamic subtest dma_fence_chain: SUCCESS (17.884s)
[607.021418] Starting dynamic subtest: dma_fence_unwrap
[607.084929] Dynamic subtest dma_fence_unwrap: SUCCESS (0.081s)
[607.104699] Starting dynamic subtest: dma_resv
[607.153705] Dynamic subtest dma_resv: SUCCESS (0.065s)
[607.156252] Subtest all-tests: SUCCESS (18.307s)
[607.184027] Closing watchdogs
Done.