[42.776988] Initializing watchdogs
[42.777163]   /dev/watchdog0
[42.786536] [001/160] (960s left) i915_module_load (load)
[42.885349] Starting subtest: load
[47.269432] Subtest load: SUCCESS (4.384s)
[47.292508] [002/160] (956s left) core_auth (basic-auth)
[47.405719] Starting subtest: basic-auth
[47.408247] Subtest basic-auth: SUCCESS (0.002s)
[47.519811] [003/160] (955s left) debugfs_test (read_all_entries)
[47.632484] Starting subtest: read_all_entries
[47.724513] Subtest read_all_entries: SUCCESS (0.090s)
[47.839831] [004/160] (955s left) debugfs_test (basic-hwmon)
[47.947664] Starting subtest: basic-hwmon
[47.949920] Subtest basic-hwmon: SKIP (0.000s)
[48.051409] [005/160] (955s left) fbdev (eof)
[48.190898] Starting subtest: eof
[48.192385] Subtest eof: SUCCESS (0.001s)
[48.267498] [006/160] (955s left) fbdev (info)
[48.355487] Starting subtest: info
[48.356726] Subtest info: SUCCESS (0.000s)
[48.438917] [007/160] (954s left) fbdev (nullptr)
[48.537538] Starting subtest: nullptr
[48.538700] Subtest nullptr: SUCCESS (0.000s)
[48.605859] [008/160] (954s left) fbdev (read)
[48.705288] Starting subtest: read
[55.795947] Subtest read: SUCCESS (7.057s)
[55.826602] [009/160] (947s left) fbdev (write)
[55.928711] Starting subtest: write
[59.700508] Subtest write: SUCCESS (3.738s)
[59.751124] [010/160] (943s left) gem_basic (bad-close)
[59.850629] Starting subtest: bad-close
[59.853235] Subtest bad-close: SUCCESS (0.000s)
[59.954145] [011/160] (943s left) gem_basic (create-close)
[60.053469] Starting subtest: create-close
[60.055501] Subtest create-close: SUCCESS (0.000s)
[60.153194] [012/160] (943s left) gem_basic (create-fd-close)
[60.257764] Starting subtest: create-fd-close
[60.260037] Subtest create-fd-close: SUCCESS (0.000s)
[60.352833] [013/160] (943s left) gem_busy (busy@all-engines)
[60.465788] Starting subtest: busy
[60.466970] Starting dynamic subtest: all-engines
[60.525790] Dynamic subtest all-engines: SUCCESS (0.061s)
[60.526973] Subtest busy: SUCCESS (0.061s)
[60.905376] [014/160] (942s left) gem_close_race (basic-process)
[61.025055] Starting subtest: basic-process
[61.091298] Subtest basic-process: SUCCESS (0.066s)
[61.289567] [015/160] (942s left) gem_close_race (basic-threads)
[61.411789] Starting subtest: basic-threads
[62.603353] Subtest basic-threads: SUCCESS (1.194s)
[62.835565] [016/160] (940s left) gem_ctx_create (basic)
[62.949457] Starting subtest: basic
[62.950553] Subtest basic: SUCCESS (0.000s)
[63.158437] [017/160] (940s left) gem_ctx_create (basic-files)
[63.275201] Starting subtest: basic-files
[65.299985] Subtest basic-files: SUCCESS (2.025s)
[65.533305] [018/160] (938s left) gem_ctx_exec (basic)
[65.633462] Starting subtest: basic
[65.639929] Subtest basic: SUCCESS (0.006s)
[65.751465] [019/160] (937s left) gem_exec_basic (basic)
[65.859215] Starting subtest: basic
[65.860358] Starting dynamic subtest: rcs0-smem
[65.862780] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[65.874260] Starting dynamic subtest: bcs0-smem
[65.875771] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[65.886584] Starting dynamic subtest: vcs0-smem
[65.887901] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[65.898428] Starting dynamic subtest: vecs0-smem
[65.899764] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[65.901191] Subtest basic: SUCCESS (0.007s)
[66.077885] [020/160] (937s left) gem_exec_create (basic)
[66.195942] Starting subtest: basic
[66.197182] Starting dynamic subtest: smem
[68.248583] Dynamic subtest smem: SUCCESS (2.053s)
[68.249675] Subtest basic: SUCCESS (2.053s)
[68.481526] [021/160] (935s left) gem_exec_fence (basic-busy)
[68.748792] Starting subtest: basic-busy
[68.750172] Starting dynamic subtest: rcs0
[68.770119] Dynamic subtest rcs0: SUCCESS (0.030s)
[68.781850] Starting dynamic subtest: bcs0
[68.802438] Dynamic subtest bcs0: SUCCESS (0.032s)
[68.814553] Starting dynamic subtest: vcs0
[68.830329] Dynamic subtest vcs0: SUCCESS (0.028s)
[68.846810] Starting dynamic subtest: vecs0
[68.849419] Dynamic subtest vecs0: SUCCESS (0.019s)
[68.850531] Subtest basic-busy: SUCCESS (0.110s)
[69.470585] [022/160] (934s left) gem_exec_fence (basic-wait)
[69.727906] Starting subtest: basic-wait
[69.729321] Starting dynamic subtest: rcs0
[69.750557] Dynamic subtest rcs0: SUCCESS (0.031s)
[69.765097] Starting dynamic subtest: bcs0
[69.771038] Dynamic subtest bcs0: SUCCESS (0.020s)
[69.785627] Starting dynamic subtest: vcs0
[69.787671] Dynamic subtest vcs0: SUCCESS (0.015s)
[69.801366] Starting dynamic subtest: vecs0
[69.816082] Dynamic subtest vecs0: SUCCESS (0.027s)
[69.817390] Subtest basic-wait: SUCCESS (0.093s)
[70.368517] [023/160] (933s left) gem_exec_fence (basic-await)
[70.640288] Starting subtest: basic-await
[70.641428] Starting dynamic subtest: rcs0
[70.731036] Dynamic subtest rcs0: SUCCESS (0.098s)
[70.751617] Starting dynamic subtest: bcs0
[70.836653] Dynamic subtest bcs0: SUCCESS (0.105s)
[70.864249] Starting dynamic subtest: vcs0
[70.965452] Dynamic subtest vcs0: SUCCESS (0.127s)
[70.993057] Starting dynamic subtest: vecs0
[71.096789] Dynamic subtest vecs0: SUCCESS (0.130s)
[71.099183] Subtest basic-await: SUCCESS (0.463s)
[71.670212] [024/160] (932s left) gem_exec_fence (nb-await)
[71.935160] Starting subtest: nb-await
[71.936360] Starting dynamic subtest: rcs0
[71.994304] Dynamic subtest rcs0: SUCCESS (0.066s)
[72.012994] Starting dynamic subtest: bcs0
[72.064592] Dynamic subtest bcs0: SUCCESS (0.069s)
[72.084523] Starting dynamic subtest: vcs0
[72.136144] Dynamic subtest vcs0: SUCCESS (0.071s)
[72.163123] Starting dynamic subtest: vecs0
[72.211690] Dynamic subtest vecs0: SUCCESS (0.075s)
[72.213643] Subtest nb-await: SUCCESS (0.285s)
[72.770924] [025/160] (931s left) gem_exec_gttfill (basic)
[72.889731] Starting subtest: basic
[79.078656] Subtest basic: SUCCESS (6.181s)
[79.257755] [026/160] (924s left) gem_exec_parallel (engines)
[79.505113] Starting subtest: engines
[79.506377] Starting dynamic subtest: basic
[82.005770] Dynamic subtest basic: SUCCESS (2.483s)
[82.019294] Starting dynamic subtest: contexts
[88.436902] Dynamic subtest contexts: SUCCESS (6.445s)
[88.450735] Starting dynamic subtest: fds
[101.227358] Dynamic subtest fds: SUCCESS (12.798s)
[101.252783] Starting dynamic subtest: userptr
[103.726752] Dynamic subtest userptr: SUCCESS (2.476s)
[103.728808] Subtest engines: SUCCESS (24.203s)
[103.935752] [027/160] (900s left) gem_exec_store (basic)
[104.050179] Starting subtest: basic
[104.118145] Subtest basic: SUCCESS (0.068s)
[104.320235] [028/160] (899s left) gem_flink_basic (bad-flink)
[104.414618] Starting subtest: bad-flink
[104.415864] Subtest bad-flink: SUCCESS (0.000s)
[104.503738] [029/160] (899s left) gem_flink_basic (bad-open)
[104.605627] Starting subtest: bad-open
[104.606685] Subtest bad-open: SUCCESS (0.000s)
[104.711911] [030/160] (899s left) gem_flink_basic (basic)
[104.808798] Starting subtest: basic
[104.809946] Subtest basic: SUCCESS (0.000s)
[104.921194] [031/160] (899s left) gem_flink_basic (double-flink)
[105.024754] Starting subtest: double-flink
[105.025882] Subtest double-flink: SUCCESS (0.000s)
[105.120561] [032/160] (898s left) gem_flink_basic (flink-lifetime)
[105.214595] Starting subtest: flink-lifetime
[105.217182] Subtest flink-lifetime: SUCCESS (0.003s)
[105.320249] [033/160] (898s left) gem_huc_copy (huc-copy)
[105.432158] Starting subtest: huc-copy
[105.434764] Subtest huc-copy: SKIP (0.000s)
[105.535661] [034/160] (898s left) gem_linear_blits (basic)
[105.814320] Starting subtest: basic
[105.832231] Subtest basic: SUCCESS (0.017s)
[105.958446] [035/160] (898s left) gem_mmap (basic)
[106.132587] Starting subtest: basic
[106.138064] Subtest basic: SUCCESS (0.001s)
[106.221264] [036/160] (897s left) gem_mmap_gtt (basic)
[106.321595] Starting subtest: basic
[106.322780] Subtest basic: SUCCESS (0.002s)
[106.414082] [037/160] (897s left) gem_render_linear_blits (basic)
[106.522877] Starting subtest: basic
[106.578963] Subtest basic: SUCCESS (0.056s)
[106.630175] [038/160] (897s left) gem_render_tiled_blits (basic)
[106.742087] Starting subtest: basic
[106.806687] Subtest basic: SUCCESS (0.064s)
[106.864763] [039/160] (897s left) gem_ringfill (basic-all)
[107.106644] Starting subtest: basic-all
[108.356708] Subtest basic-all: SUCCESS (1.240s)
[108.447083] [040/160] (895s left) gem_softpin (allocator-basic)
[108.553157] Starting subtest: allocator-basic
[108.722149] Subtest allocator-basic: SUCCESS (0.160s)
[108.841425] [041/160] (895s left) gem_softpin (allocator-basic-reserve)
[108.953260] Starting subtest: allocator-basic-reserve
[109.121414] Subtest allocator-basic-reserve: SUCCESS (0.159s)
[109.241249] [042/160] (895s left) gem_softpin (safe-alignment)
[109.357786] Starting subtest: safe-alignment
[109.377631] Subtest safe-alignment: SUCCESS (0.020s)
[109.492319] [043/160] (894s left) gem_sync (basic-all)
[109.617229] Starting subtest: basic-all
[112.239088] Subtest basic-all: SUCCESS (2.599s)
[112.430289] [044/160] (892s left) gem_sync (basic-each)
[112.548040] Starting subtest: basic-each
[114.894546] Subtest basic-each: SUCCESS (2.347s)
[115.116577] [045/160] (889s left) gem_tiled_blits (basic)
[115.367986] Starting subtest: basic
[115.397335] Subtest basic: SUCCESS (0.031s)
[115.534421] [046/160] (888s left) gem_tiled_fence_blits (basic)
[115.852922] Starting subtest: basic
[115.881129] Subtest basic: SUCCESS (0.028s)
[116.020447] [047/160] (888s left) gem_tiled_pread_basic
[116.604407] [048/160] (887s left) gem_wait (busy@all-engines)
[116.729522] Starting subtest: busy
[116.730842] Starting dynamic subtest: all-engines
[117.258354] Dynamic subtest all-engines: SUCCESS (0.528s)
[117.259585] Subtest busy: SUCCESS (0.529s)
[117.498996] [049/160] (887s left) gem_wait (wait@all-engines)
[117.628031] Starting subtest: wait
[117.629125] Starting dynamic subtest: all-engines
[118.659290] Dynamic subtest all-engines: SUCCESS (1.029s)
[118.660357] Subtest wait: SUCCESS (1.029s)
[118.903039] [050/160] (885s left) i915_getparams_basic (basic-eu-total)
[119.003671] Starting subtest: basic-eu-total
[119.006341] Subtest basic-eu-total: SUCCESS (0.000s)
[119.099979] [051/160] (885s left) i915_getparams_basic (basic-subslice-total)
[119.195405] Starting subtest: basic-subslice-total
[119.197518] Subtest basic-subslice-total: SUCCESS (0.000s)
[119.302896] [052/160] (885s left) i915_hangman (error-state-basic)
[119.418575] Starting subtest: error-state-basic
[119.428459] Subtest error-state-basic: SUCCESS (0.010s)
[119.520395] [053/160] (885s left) i915_pciid
[119.722152] [054/160] (885s left) kms_addfb_basic (addfb25-4-tiled)
[119.858358] Starting subtest: addfb25-4-tiled
[119.859443] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[119.953423] [055/160] (884s left) kms_addfb_basic (addfb25-bad-modifier)
[120.054440] Starting subtest: addfb25-bad-modifier
[120.055626] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[120.185061] [056/160] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[120.287155] Starting subtest: addfb25-framebuffer-vs-set-tiling
[120.288246] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[120.421574] [057/160] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[120.518918] Starting subtest: addfb25-modifier-no-flag
[120.519976] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[120.656093] [058/160] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[120.764865] Starting subtest: addfb25-x-tiled-legacy
[120.766238] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[120.888664] [059/160] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[120.987752] Starting subtest: addfb25-x-tiled-mismatch-legacy
[120.989031] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[121.121361] [060/160] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[121.251238] Starting subtest: addfb25-yf-tiled-legacy
[121.252399] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[121.354552] [061/160] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[121.480951] Starting subtest: addfb25-y-tiled-legacy
[121.482445] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[121.565694] [062/160] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[121.696740] Starting subtest: addfb25-y-tiled-small-legacy
[121.698096] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[121.823380] [063/160] (883s left) kms_addfb_basic (bad-pitch-0)
[121.919872] Starting subtest: bad-pitch-0
[121.921113] Subtest bad-pitch-0: SUCCESS (0.000s)
[122.038082] [064/160] (882s left) kms_addfb_basic (bad-pitch-1024)
[122.145357] Starting subtest: bad-pitch-1024
[122.146512] Subtest bad-pitch-1024: SUCCESS (0.000s)
[122.271405] [065/160] (882s left) kms_addfb_basic (bad-pitch-128)
[122.370638] Starting subtest: bad-pitch-128
[122.371743] Subtest bad-pitch-128: SUCCESS (0.000s)
[122.506311] [066/160] (882s left) kms_addfb_basic (bad-pitch-256)
[122.609410] Starting subtest: bad-pitch-256
[122.610508] Subtest bad-pitch-256: SUCCESS (0.000s)
[122.734705] [067/160] (882s left) kms_addfb_basic (bad-pitch-32)
[122.837596] Starting subtest: bad-pitch-32
[122.838696] Subtest bad-pitch-32: SUCCESS (0.000s)
[122.975222] [068/160] (882s left) kms_addfb_basic (bad-pitch-63)
[123.076694] Starting subtest: bad-pitch-63
[123.077797] Subtest bad-pitch-63: SUCCESS (0.000s)
[123.206251] [069/160] (881s left) kms_addfb_basic (bad-pitch-65536)
[123.303576] Starting subtest: bad-pitch-65536
[123.304693] Subtest bad-pitch-65536: SUCCESS (0.000s)
[123.440179] [070/160] (881s left) kms_addfb_basic (bad-pitch-999)
[123.535775] Starting subtest: bad-pitch-999
[123.536922] Subtest bad-pitch-999: SUCCESS (0.000s)
[123.657575] [071/160] (881s left) kms_addfb_basic (basic)
[123.758501] Starting subtest: basic
[123.759608] Subtest basic: SUCCESS (0.000s)
[123.891031] [072/160] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[123.998728] Starting subtest: basic-x-tiled-legacy
[123.999830] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[124.118232] [073/160] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[124.225019] Starting subtest: basic-y-tiled-legacy
[124.226257] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[124.359867] [074/160] (880s left) kms_addfb_basic (bo-too-small)
[124.487375] Starting subtest: bo-too-small
[124.488526] Subtest bo-too-small: SUCCESS (0.000s)
[124.592279] [075/160] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[124.724852] Starting subtest: bo-too-small-due-to-tiling
[124.726048] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[124.825450] [076/160] (880s left) kms_addfb_basic (clobberred-modifier)
[124.923694] Starting subtest: clobberred-modifier
[124.924825] Subtest clobberred-modifier: SUCCESS (0.000s)
[125.058875] [077/160] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[125.159896] Starting subtest: framebuffer-vs-set-tiling
[125.161016] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[125.287699] [078/160] (880s left) kms_addfb_basic (invalid-get-prop)
[125.388936] Starting subtest: invalid-get-prop
[125.390174] Subtest invalid-get-prop: SUCCESS (0.000s)
[125.525414] [079/160] (879s left) kms_addfb_basic (invalid-get-prop-any)
[125.623776] Starting subtest: invalid-get-prop-any
[125.624822] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[125.747106] [080/160] (879s left) kms_addfb_basic (invalid-set-prop)
[125.857767] Starting subtest: invalid-set-prop
[125.859113] Subtest invalid-set-prop: SUCCESS (0.000s)
[125.993417] [081/160] (879s left) kms_addfb_basic (invalid-set-prop-any)
[126.093095] Starting subtest: invalid-set-prop-any
[126.094330] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[126.227146] [082/160] (879s left) kms_addfb_basic (no-handle)
[126.326487] Starting subtest: no-handle
[126.327603] Subtest no-handle: SUCCESS (0.000s)
[126.480335] [083/160] (879s left) kms_addfb_basic (size-max)
[126.613141] Starting subtest: size-max
[126.614241] Subtest size-max: SUCCESS (0.000s)
[126.727433] [084/160] (878s left) kms_addfb_basic (small-bo)
[126.863848] Starting subtest: small-bo
[126.865089] Subtest small-bo: SUCCESS (0.000s)
[126.954640] [085/160] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[127.058255] Starting subtest: tile-pitch-mismatch
[127.059327] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[127.194811] [086/160] (878s left) kms_addfb_basic (too-high)
[127.322198] Starting subtest: too-high
[127.323414] Subtest too-high: SUCCESS (0.001s)
[127.428473] [087/160] (878s left) kms_addfb_basic (too-wide)
[127.560287] Starting subtest: too-wide
[127.561545] Subtest too-wide: SUCCESS (0.000s)
[127.661673] [088/160] (878s left) kms_addfb_basic (unused-handle)
[127.760514] Starting subtest: unused-handle
[127.761624] Subtest unused-handle: SUCCESS (0.000s)
[127.872162] [089/160] (877s left) kms_addfb_basic (unused-modifier)
[127.967500] Starting subtest: unused-modifier
[127.968725] Subtest unused-modifier: SUCCESS (0.000s)
[128.093893] [090/160] (877s left) kms_addfb_basic (unused-offsets)
[128.188435] Starting subtest: unused-offsets
[128.189544] Subtest unused-offsets: SUCCESS (0.000s)
[128.313521] [091/160] (877s left) kms_addfb_basic (unused-pitches)
[128.414766] Starting subtest: unused-pitches
[128.416040] Subtest unused-pitches: SUCCESS (0.000s)
[128.545815] [092/160] (877s left) kms_busy (basic)
[128.677851] Starting subtest: basic
[128.680576] Starting dynamic subtest: flip
[129.680895] Dynamic subtest flip: SUCCESS (1.000s)
[129.697699] Starting dynamic subtest: modeset
[133.539222] Dynamic subtest modeset: SUCCESS (3.859s)
[133.540366] Subtest basic: SUCCESS (4.862s)
[134.511153] [093/160] (871s left) kms_prop_blob (basic)
[134.625881] Starting subtest: basic
[134.627076] Subtest basic: SUCCESS (0.000s)
[134.725369] [094/160] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[134.855193] Starting subtest: basic-busy-flip-before-cursor-atomic
[134.857457] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[134.937199] [095/160] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[135.070126] Starting subtest: basic-busy-flip-before-cursor-legacy
[135.072396] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[135.153783] [096/160] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[135.287506] Starting subtest: basic-flip-after-cursor-atomic
[136.589097] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.301s)
[137.515055] [097/160] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[137.645514] Starting subtest: basic-flip-after-cursor-legacy
[138.943398] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.298s)
[139.886739] [098/160] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[140.015063] Starting subtest: basic-flip-after-cursor-varying-size
[141.279509] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.265s)
[142.253356] [099/160] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[142.394434] Starting subtest: basic-flip-before-cursor-atomic
[143.699732] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.312s)
[144.634158] [100/160] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[144.766073] Starting subtest: basic-flip-before-cursor-legacy
[146.061827] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.296s)
[146.990489] [101/160] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[147.112593] Starting subtest: basic-flip-before-cursor-varying-size
[148.417499] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.304s)
[149.358465] [102/160] (856s left) kms_dsc (dsc-basic)
[149.484486] Starting subtest: dsc-basic
[149.486770] Subtest dsc-basic: SKIP (0.001s)
[149.567291] [103/160] (856s left) kms_flip (basic-flip-vs-dpms)
[149.704714] Starting subtest: basic-flip-vs-dpms
[149.707528] Starting dynamic subtest: A-eDP1
[152.628427] Dynamic subtest A-eDP1: SUCCESS (2.919s)
[152.643843] Starting dynamic subtest: B-eDP1
[154.998410] Dynamic subtest B-eDP1: SUCCESS (2.370s)
[155.014540] Starting dynamic subtest: C-eDP1
[157.430307] Dynamic subtest C-eDP1: SUCCESS (2.432s)
[157.432777] Subtest basic-flip-vs-dpms: SUCCESS (7.729s)
[158.361720] [104/160] (847s left) kms_flip (basic-flip-vs-modeset)
[158.493503] Starting subtest: basic-flip-vs-modeset
[158.496340] Starting dynamic subtest: A-eDP1
[161.376292] Dynamic subtest A-eDP1: SUCCESS (2.880s)
[161.399268] Starting dynamic subtest: B-eDP1
[163.764364] Dynamic subtest B-eDP1: SUCCESS (2.386s)
[163.782353] Starting dynamic subtest: C-eDP1
[166.183025] Dynamic subtest C-eDP1: SUCCESS (2.415s)
[166.184397] Subtest basic-flip-vs-modeset: SUCCESS (7.690s)
[167.154508] [105/160] (839s left) kms_flip (basic-flip-vs-wf_vblank)
[167.287263] Starting subtest: basic-flip-vs-wf_vblank
[167.290740] Starting dynamic subtest: A-eDP1
[169.610551] Dynamic subtest A-eDP1: SUCCESS (2.318s)
[169.628221] Starting dynamic subtest: B-eDP1
[171.898744] Dynamic subtest B-eDP1: SUCCESS (2.286s)
[171.917928] Starting dynamic subtest: C-eDP1
[174.138315] Dynamic subtest C-eDP1: SUCCESS (2.237s)
[174.148486] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.857s)
[175.469474] [106/160] (830s left) kms_flip (basic-plain-flip)
[175.596667] Starting subtest: basic-plain-flip
[175.599600] Starting dynamic subtest: A-eDP1
[177.647629] Dynamic subtest A-eDP1: SUCCESS (2.047s)
[177.666399] Starting dynamic subtest: B-eDP1
[179.614775] Dynamic subtest B-eDP1: SUCCESS (1.964s)
[179.633396] Starting dynamic subtest: C-eDP1
[181.598597] Dynamic subtest C-eDP1: SUCCESS (1.982s)
[181.604764] Subtest basic-plain-flip: SUCCESS (6.009s)
[182.895895] [107/160] (823s left) kms_force_connector_basic (force-connector-state)
[183.001897] Starting subtest: force-connector-state
[183.586888] Subtest force-connector-state: SUCCESS (0.585s)
[184.660229] [108/160] (821s left) kms_force_connector_basic (force-edid)
[184.767921] Starting subtest: force-edid
[185.030147] Subtest force-edid: SUCCESS (0.262s)
[185.175399] [109/160] (821s left) kms_force_connector_basic (force-load-detect)
[185.282623] Starting subtest: force-load-detect
[185.284830] Subtest force-load-detect: SKIP (0.000s)
[185.404555] [110/160] (820s left) kms_force_connector_basic (prune-stale-modes)
[185.505301] Starting subtest: prune-stale-modes
[185.830901] Subtest prune-stale-modes: SUCCESS (0.323s)
[185.976979] [111/160] (820s left) kms_frontbuffer_tracking (basic)
[186.117647] Starting subtest: basic
[189.837751] Subtest basic: SUCCESS (3.720s)
[189.964960] [112/160] (816s left) kms_hdmi_inject (inject-audio)
[190.394246] Starting subtest: inject-audio
[190.643978] Subtest inject-audio: SUCCESS (0.244s)
[191.336726] [113/160] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[191.469160] Starting subtest: compare-crc-sanitycheck-xr24
[191.472144] Starting dynamic subtest: pipe-A-eDP-1
[192.166384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[192.184032] Starting dynamic subtest: pipe-B-eDP-1
[193.611026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[193.634259] Starting dynamic subtest: pipe-C-eDP-1
[195.013212] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[195.014375] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.544s)
[195.949626] [114/160] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[196.075734] Starting subtest: compare-crc-sanitycheck-nv12
[196.077021] Starting dynamic subtest: pipe-A-eDP-1
[197.012248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.934s)
[197.030961] Starting dynamic subtest: pipe-B-eDP-1
[198.441198] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s)
[198.460202] Starting dynamic subtest: pipe-C-eDP-1
[199.843618] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[199.844742] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.769s)
[200.815678] [115/160] (805s left) kms_pipe_crc_basic (hang-read-crc)
[200.946957] Starting subtest: hang-read-crc
[200.948290] Starting dynamic subtest: pipe-A-eDP-1
[203.362212] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.413s)
[203.381372] Starting dynamic subtest: pipe-B-eDP-1
[206.447438] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.082s)
[206.466592] Starting dynamic subtest: pipe-C-eDP-1
[209.440591] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.989s)
[209.441909] Subtest hang-read-crc: SUCCESS (8.494s)
[210.413106] [116/160] (796s left) kms_pipe_crc_basic (nonblocking-crc)
[210.541071] Starting subtest: nonblocking-crc
[210.542301] Starting dynamic subtest: pipe-A-eDP-1
[211.444388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.900s)
[211.462682] Starting dynamic subtest: pipe-B-eDP-1
[213.058690] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s)
[213.078140] Starting dynamic subtest: pipe-C-eDP-1
[214.625615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s)
[214.626916] Subtest nonblocking-crc: SUCCESS (4.086s)
[215.601773] [117/160] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[215.733412] Starting subtest: nonblocking-crc-frame-sequence
[215.734656] Starting dynamic subtest: pipe-A-eDP-1
[216.629449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.894s)
[216.648354] Starting dynamic subtest: pipe-B-eDP-1
[218.223555] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.590s)
[218.244397] Starting dynamic subtest: pipe-C-eDP-1
[219.769340] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s)
[219.770645] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.037s)
[220.714779] [118/160] (785s left) kms_pipe_crc_basic (read-crc)
[220.847537] Starting subtest: read-crc
[220.850550] Starting dynamic subtest: pipe-A-eDP-1
[221.678907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[221.698124] Starting dynamic subtest: pipe-B-eDP-1
[223.222135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.532s)
[223.238503] Starting dynamic subtest: pipe-C-eDP-1
[224.725911] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[224.727240] Subtest read-crc: SUCCESS (3.877s)
[225.643333] [119/160] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[225.770832] Starting subtest: read-crc-frame-sequence
[225.773875] Starting dynamic subtest: pipe-A-eDP-1
[226.604882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.831s)
[226.623464] Starting dynamic subtest: pipe-B-eDP-1
[228.143476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[228.161898] Starting dynamic subtest: pipe-C-eDP-1
[229.646911] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[229.648144] Subtest read-crc-frame-sequence: SUCCESS (3.877s)
[230.576080] [120/160] (776s left) kms_pm_backlight (basic-brightness)
[230.707069] Starting subtest: basic-brightness
[230.801402] Starting dynamic subtest: eDP-1
[231.338329] Dynamic subtest eDP-1: SUCCESS (0.535s)
[231.341514] Subtest basic-brightness: SUCCESS (0.630s)
[232.303396] [121/160] (774s left) kms_pm_rpm (basic-pci-d3-state)
[234.138832] Starting subtest: basic-pci-d3-state
[238.535458] Subtest basic-pci-d3-state: SUCCESS (4.397s)
[238.737482] [122/160] (767s left) kms_pm_rpm (basic-rte)
[238.824839] Starting subtest: basic-rte
[244.999413] Subtest basic-rte: SUCCESS (6.172s)
[250.388505] [123/160] (756s left) kms_psr (psr-primary-page-flip)
[250.518527] Starting subtest: psr-primary-page-flip
[250.519854] Starting dynamic subtest: eDP-1
[254.312705] Dynamic subtest eDP-1: SUCCESS (3.789s)
[254.314038] Subtest psr-primary-page-flip: SUCCESS (3.792s)
[255.280284] [124/160] (751s left) kms_psr (psr-cursor-plane-move)
[255.408030] Starting subtest: psr-cursor-plane-move
[255.409319] Starting dynamic subtest: eDP-1
[259.200825] Dynamic subtest eDP-1: SUCCESS (3.790s)
[259.202031] Subtest psr-cursor-plane-move: SUCCESS (3.794s)
[260.144656] [125/160] (746s left) kms_psr (psr-sprite-plane-onoff)
[260.283209] Starting subtest: psr-sprite-plane-onoff
[260.284428] Starting dynamic subtest: eDP-1
[264.173912] Dynamic subtest eDP-1: SUCCESS (3.889s)
[264.175137] Subtest psr-sprite-plane-onoff: SUCCESS (3.892s)
[265.136305] [126/160] (741s left) kms_psr (psr-primary-mmap-gtt)
[265.272613] Starting subtest: psr-primary-mmap-gtt
[265.273890] Starting dynamic subtest: eDP-1
[269.135875] Dynamic subtest eDP-1: SUCCESS (3.862s)
[269.139261] Subtest psr-primary-mmap-gtt: SUCCESS (3.865s)
[270.062786] [127/160] (736s left) kms_setmode (basic-clone-single-crtc)
[270.163460] Starting subtest: basic-clone-single-crtc
[270.166837] Subtest basic-clone-single-crtc: SKIP (0.000s)
[270.269047] [128/160] (736s left) i915_pm_rps (basic-api)
[270.387259] Starting subtest: basic-api
[270.391981] Subtest basic-api: SUCCESS (0.005s)
[270.479070] [129/160] (736s left) prime_self_import (basic-llseek-bad)
[270.568200] Starting subtest: basic-llseek-bad
[270.583341] Subtest basic-llseek-bad: SUCCESS (0.015s)
[270.697047] [130/160] (736s left) prime_self_import (basic-llseek-size)
[270.785329] Starting subtest: basic-llseek-size
[270.806799] Subtest basic-llseek-size: SUCCESS (0.023s)
[270.915063] [131/160] (736s left) prime_self_import (basic-with_fd_dup)
[271.001316] Starting subtest: basic-with_fd_dup
[271.016419] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[271.131566] [132/160] (735s left) prime_self_import (basic-with_one_bo)
[271.219250] Starting subtest: basic-with_one_bo
[271.234270] Subtest basic-with_one_bo: SUCCESS (0.016s)
[271.326168] [133/160] (735s left) prime_self_import (basic-with_one_bo_two_files)
[271.412375] Starting subtest: basic-with_one_bo_two_files
[271.425664] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[271.531032] [134/160] (735s left) prime_self_import (basic-with_two_bos)
[271.618322] Starting subtest: basic-with_two_bos
[271.640460] Subtest basic-with_two_bos: SUCCESS (0.021s)
[271.748879] [135/160] (735s left) prime_vgem (basic-fence-flip)
[271.875406] Starting subtest: basic-fence-flip
[272.420675] Subtest basic-fence-flip: SUCCESS (0.545s)
[272.535274] [136/160] (734s left) prime_vgem (basic-fence-mmap)
[272.663853] Starting subtest: basic-fence-mmap
[272.712822] Subtest basic-fence-mmap: SUCCESS (0.049s)
[272.801098] [137/160] (734s left) prime_vgem (basic-fence-read)
[272.933137] Starting subtest: basic-fence-read
[273.030106] Subtest basic-fence-read: SUCCESS (0.097s)
[273.125113] [138/160] (734s left) prime_vgem (basic-gtt)
[273.250506] Starting subtest: basic-gtt
[273.275667] Subtest basic-gtt: SUCCESS (0.025s)
[273.383960] [139/160] (733s left) prime_vgem (basic-read)
[273.513541] Starting subtest: basic-read
[273.561891] Subtest basic-read: SUCCESS (0.048s)
[273.667308] [140/160] (733s left) prime_vgem (basic-write)
[273.777173] Starting subtest: basic-write
[273.842240] Subtest basic-write: SUCCESS (0.065s)
[273.932643] [141/160] (733s left) vgem_basic (setversion)
[274.040508] Starting subtest: setversion
[274.042946] Subtest setversion: SUCCESS (0.000s)
[274.117465] [142/160] (733s left) vgem_basic (create)
[274.224259] Starting subtest: create
[274.225527] Subtest create: SUCCESS (0.000s)
[274.300732] [143/160] (733s left) vgem_basic (debugfs)
[274.408757] Starting subtest: debugfs
[274.410770] Subtest debugfs: SUCCESS (0.001s)
[274.484636] [144/160] (732s left) vgem_basic (dmabuf-export)
[274.590993] Starting subtest: dmabuf-export
[274.603609] Subtest dmabuf-export: SUCCESS (0.012s)
[274.701919] [145/160] (732s left) vgem_basic (dmabuf-fence)
[274.807742] Starting subtest: dmabuf-fence
[274.809014] Subtest dmabuf-fence: SUCCESS (0.001s)
[274.885638] [146/160] (732s left) vgem_basic (dmabuf-fence-before)
[274.992849] Starting subtest: dmabuf-fence-before
[274.994078] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[275.067808] [147/160] (732s left) vgem_basic (dmabuf-mmap)
[275.176907] Starting subtest: dmabuf-mmap
[275.204126] Subtest dmabuf-mmap: SUCCESS (0.028s)
[275.282717] [148/160] (732s left) vgem_basic (mmap)
[275.375853] Starting subtest: mmap
[275.391593] Subtest mmap: SUCCESS (0.017s)
[275.466614] [149/160] (732s left) vgem_basic (second-client)
[275.560499] Starting subtest: second-client
[275.592189] Subtest second-client: SUCCESS (0.033s)
[275.669424] [150/160] (731s left) vgem_basic (sysfs)
[275.775796] Starting subtest: sysfs
[275.777533] Subtest sysfs: SUCCESS (0.001s)
[275.853373] [151/160] (731s left) core_hotunplug (unbind-rebind)
[275.992562] Starting subtest: unbind-rebind
[282.085728] Subtest unbind-rebind: SUCCESS (6.093s)
[282.121144] [152/160] (725s left) vgem_basic (unload)
[282.260569] Starting subtest: unload
[311.250485] Subtest unload: SUCCESS (29.002s)
[311.394521] [153/160] (696s left) i915_module_load (reload)
[311.481741] Starting subtest: reload
[316.441758] Subtest reload: SUCCESS (4.960s)
[316.471930] [154/160] (691s left) gem_lmem_swapping (basic)
[316.582529] Subtest basic: SKIP (0.000s)
[316.626245] [155/160] (691s left) gem_lmem_swapping (parallel-random-engines)
[316.722221] Subtest parallel-random-engines: SKIP (0.000s)
[316.777948] [156/160] (690s left) gem_lmem_swapping (random-engines)
[316.873564] Subtest random-engines: SKIP (0.000s)
[316.926883] [157/160] (690s left) gem_lmem_swapping (verify-random)
[317.024237] Subtest verify-random: SKIP (0.000s)
[317.076423] [158/160] (690s left) i915_pm_rpm (module-reload)
[329.546057] Starting subtest: module-reload
[362.022997] Subtest module-reload: SUCCESS (32.470s)
[362.046636] [159/160] (645s left) i915_selftest (live)
[362.147478] Starting subtest: live
[362.148774] Starting dynamic subtest: sanitycheck
[365.646642] Dynamic subtest sanitycheck: SUCCESS (3.489s)
[365.657260] Starting dynamic subtest: uncore
[369.083473] Dynamic subtest uncore: SUCCESS (3.433s)
[369.093975] Starting dynamic subtest: workarounds
[372.807576] Dynamic subtest workarounds: SUCCESS (3.721s)
[372.818239] Starting dynamic subtest: gt_engines
[376.703774] Dynamic subtest gt_engines: SUCCESS (3.892s)
[376.714553] Starting dynamic subtest: gt_timelines
[392.070675] Dynamic subtest gt_timelines: SUCCESS (15.363s)
[392.081642] Starting dynamic subtest: gt_contexts
[395.642557] Dynamic subtest gt_contexts: SUCCESS (3.568s)
[395.653196] Starting dynamic subtest: gt_lrc
[401.048550] Dynamic subtest gt_lrc: SUCCESS (5.403s)
[401.059486] Starting dynamic subtest: gt_mocs
[404.547533] Dynamic subtest gt_mocs: SUCCESS (3.496s)
[404.558109] Starting dynamic subtest: gt_pm
[411.241535] Dynamic subtest gt_pm: SUCCESS (6.691s)
[411.252179] Starting dynamic subtest: gt_heartbeat
[414.787528] Dynamic subtest gt_heartbeat: SUCCESS (3.542s)
[414.798189] Starting dynamic subtest: gt_tlb
[419.348576] Dynamic subtest gt_tlb: SUCCESS (4.558s)
[419.359250] Starting dynamic subtest: requests
[428.570548] Dynamic subtest requests: SUCCESS (9.218s)
[428.581446] Starting dynamic subtest: migrate
[434.496534] Dynamic subtest migrate: SUCCESS (5.923s)
[434.507215] Starting dynamic subtest: active
[437.968431] Dynamic subtest active: SUCCESS (3.469s)
[437.979058] Starting dynamic subtest: objects
[442.507439] Dynamic subtest objects: SUCCESS (4.536s)
[442.518195] Starting dynamic subtest: mman
[451.032532] Dynamic subtest mman: SUCCESS (8.522s)
[451.043492] Starting dynamic subtest: dmabuf
[454.550425] Dynamic subtest dmabuf: SUCCESS (3.516s)
[454.563317] Starting dynamic subtest: vma
[458.010668] Dynamic subtest vma: SUCCESS (3.454s)
[458.021378] Starting dynamic subtest: coherency
[464.366649] Dynamic subtest coherency: SUCCESS (6.353s)
[464.377575] Starting dynamic subtest: gtt
[474.956711] Dynamic subtest gtt: SUCCESS (10.587s)
[474.967528] Starting dynamic subtest: gem
[478.555501] Dynamic subtest gem: SUCCESS (3.595s)
[478.566441] Starting dynamic subtest: evict
[483.625583] Dynamic subtest evict: SUCCESS (5.066s)
[483.636528] Starting dynamic subtest: hugepages
[492.982751] Dynamic subtest hugepages: SUCCESS (9.354s)
[492.993954] Starting dynamic subtest: gem_contexts
[511.129769] Dynamic subtest gem_contexts: SUCCESS (18.143s)
[511.142100] Starting dynamic subtest: client
[514.628390] Dynamic subtest client: SUCCESS (3.495s)
[514.639643] Starting dynamic subtest: gem_migrate
[518.080904] Dynamic subtest gem_migrate: SUCCESS (3.449s)
[518.092414] Starting dynamic subtest: reset
[525.021551] Dynamic subtest reset: SUCCESS (6.937s)
[525.032608] Starting dynamic subtest: memory_region
[528.440490] Dynamic subtest memory_region: SUCCESS (3.416s)
[528.451625] Starting dynamic subtest: hangcheck
[554.480144] Dynamic subtest hangcheck: SUCCESS (26.037s)
[554.491214] Starting dynamic subtest: execlists
[566.573866] Dynamic subtest execlists: SUCCESS (12.091s)
[566.585624] Starting dynamic subtest: ring_submission
[570.041494] Dynamic subtest ring_submission: SUCCESS (3.464s)
[570.052676] Starting dynamic subtest: perf
[573.589024] Dynamic subtest perf: SUCCESS (3.544s)
[573.600142] Starting dynamic subtest: slpc
[577.034892] Dynamic subtest slpc: SUCCESS (3.442s)
[577.046155] Starting dynamic subtest: guc
[580.505790] Dynamic subtest guc: SUCCESS (3.467s)
[580.517543] Starting dynamic subtest: guc_multi_lrc
[583.934741] Dynamic subtest guc_multi_lrc: SUCCESS (3.425s)
[583.945940] Starting dynamic subtest: guc_hang
[587.410395] Dynamic subtest guc_hang: SUCCESS (3.480s)
[587.426230] Starting dynamic subtest: late_gt_pm
[590.905401] Dynamic subtest late_gt_pm: SUCCESS (3.483s)
[590.906586] Subtest live: SUCCESS (228.751s)
[590.931836] [160/160] (416s left) dmabuf (all-tests)
[591.024622] Starting subtest: all-tests
[591.025889] Starting dynamic subtest: sanitycheck
[591.094670] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[591.113840] Starting dynamic subtest: dma_fence
[591.291833] Dynamic subtest dma_fence: SUCCESS (0.193s)
[591.310939] Starting dynamic subtest: dma_fence_chain
[609.170224] Dynamic subtest dma_fence_chain: SUCCESS (17.866s)
[609.183553] Starting dynamic subtest: dma_fence_unwrap
[609.251798] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s)
[609.272143] Starting dynamic subtest: dma_resv
[609.328802] Dynamic subtest dma_resv: SUCCESS (0.073s)
[609.331052] Subtest all-tests: SUCCESS (18.305s)
[609.359766] Closing watchdogs
Done.