[61.454501] Initializing watchdogs
[61.455096]   /dev/watchdog0
[61.479385] [001/165] (960s left) i915_module_load (load)
[61.921601] Starting subtest: load
[66.146500] Subtest load: SUCCESS (4.212s)
[66.289713] [002/165] (955s left) core_auth (basic-auth)
[67.162643] Starting subtest: basic-auth
[67.166853] Subtest basic-auth: SUCCESS (0.004s)
[67.309577] [003/165] (954s left) debugfs_test (read_all_entries)
[67.751645] Starting subtest: read_all_entries
[67.917228] Subtest read_all_entries: SUCCESS (0.156s)
[68.074578] [004/165] (954s left) debugfs_test (basic-hwmon)
[68.494624] Starting subtest: basic-hwmon
[68.502811] Subtest basic-hwmon: SKIP (0.000s)
[68.690201] [005/165] (953s left) fbdev (eof)
[69.155344] Starting subtest: eof
[69.159696] Subtest eof: SUCCESS (0.003s)
[69.261468] [006/165] (953s left) fbdev (info)
[69.647254] Starting subtest: info
[69.651125] Subtest info: SUCCESS (0.000s)
[69.762139] [007/165] (952s left) fbdev (nullptr)
[70.171423] Starting subtest: nullptr
[70.176121] Subtest nullptr: SUCCESS (0.000s)
[70.280813] [008/165] (952s left) fbdev (read)
[70.737192] Starting subtest: read
[71.021175] Subtest read: SUCCESS (0.284s)
[71.131526] [009/165] (951s left) fbdev (write)
[71.538367] Starting subtest: write
[71.715473] Subtest write: SUCCESS (0.177s)
[71.829714] [010/165] (950s left) gem_basic (bad-close)
[72.231440] Starting subtest: bad-close
[72.239164] Subtest bad-close: SUCCESS (0.000s)
[72.344825] [011/165] (950s left) gem_basic (create-close)
[72.744347] Starting subtest: create-close
[72.752185] Subtest create-close: SUCCESS (0.001s)
[72.883244] [012/165] (950s left) gem_basic (create-fd-close)
[73.325613] Starting subtest: create-fd-close
[73.334543] Subtest create-fd-close: SUCCESS (0.002s)
[73.466801] [013/165] (949s left) gem_busy (busy@all-engines)
[73.955465] Starting subtest: busy
[73.959135] Starting dynamic subtest: all-engines
[74.059486] Dynamic subtest all-engines: SUCCESS (0.108s)
[74.063160] Subtest busy: SUCCESS (0.112s)
[74.554266] [014/165] (948s left) gem_close_race (basic-process)
[75.027494] Starting subtest: basic-process
[75.193282] Subtest basic-process: SUCCESS (0.166s)
[75.457190] [015/165] (947s left) gem_close_race (basic-threads)
[75.972981] Starting subtest: basic-threads
[77.749116] Subtest basic-threads: SUCCESS (1.790s)
[78.052313] [016/165] (945s left) gem_ctx_create (basic)
[78.490422] Subtest basic: SKIP (0.000s)
[78.617138] [017/165] (944s left) gem_ctx_create (basic-files)
[79.092538] Subtest basic-files: SKIP (0.000s)
[79.215358] [018/165] (944s left) gem_ctx_exec (basic)
[79.662151] Subtest basic: SKIP (0.000s)
[79.802483] [019/165] (943s left) gem_exec_basic (basic)
[80.282913] Starting subtest: basic
[80.287252] Starting dynamic subtest: rcs0-smem
[80.291168] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[80.294937] Subtest basic: SUCCESS (0.006s)
[80.566162] [020/165] (943s left) gem_exec_create (basic)
[81.058245] Starting subtest: basic
[81.061801] Starting dynamic subtest: smem
[83.189998] Dynamic subtest smem: SUCCESS (2.136s)
[83.193318] Subtest basic: SUCCESS (2.138s)
[83.462430] [021/165] (940s left) gem_exec_fence (basic-busy)
[84.135287] Starting subtest: basic-busy
[84.139955] Starting dynamic subtest: rcs0
[84.166476] Dynamic subtest rcs0: SUCCESS (0.028s)
[84.169593] Subtest basic-busy: SUCCESS (0.032s)
[85.046097] [022/165] (938s left) gem_exec_fence (basic-wait)
[85.706123] Starting subtest: basic-wait
[85.710575] Starting dynamic subtest: rcs0
[85.748331] Dynamic subtest rcs0: SUCCESS (0.041s)
[85.751668] Subtest basic-wait: SUCCESS (0.043s)
[86.433993] [023/165] (937s left) gem_exec_fence (basic-await)
[87.082819] Starting subtest: basic-await
[87.086864] Starting dynamic subtest: rcs0
[87.196624] Dynamic subtest rcs0: SUCCESS (0.111s)
[87.200187] Subtest basic-await: SUCCESS (0.114s)
[87.885748] [024/165] (936s left) gem_exec_fence (nb-await)
[88.541519] Starting subtest: nb-await
[88.545677] Starting dynamic subtest: rcs0
[88.605112] Dynamic subtest rcs0: SUCCESS (0.062s)
[88.607947] Subtest nb-await: SUCCESS (0.064s)
[89.284733] [025/165] (934s left) gem_exec_gttfill (basic)
[89.748482] Starting subtest: basic
[104.312742] Subtest basic: SUCCESS (14.556s)
[104.616271] [026/165] (919s left) gem_exec_parallel (engines)
[105.476753] Starting subtest: engines
[105.479697] Starting dynamic subtest: basic
[108.820289] Dynamic subtest basic: SUCCESS (3.346s)
[108.864671] Starting dynamic subtest: contexts
[108.872141] Dynamic subtest contexts: SKIP (0.003s)
[108.912154] Starting dynamic subtest: fds
[108.917578] Dynamic subtest fds: SKIP (0.003s)
[108.950580] Starting dynamic subtest: userptr
[112.418654] Dynamic subtest userptr: SUCCESS (3.585s)
[112.421707] Subtest engines: SUCCESS (6.944s)
[112.714753] [027/165] (911s left) gem_exec_store (basic)
[113.183331] Starting subtest: basic
[113.240376] Subtest basic: SUCCESS (0.059s)
[113.525281] [028/165] (910s left) gem_flink_basic (bad-flink)
[113.923222] Starting subtest: bad-flink
[113.927557] Subtest bad-flink: SUCCESS (0.000s)
[114.048924] [029/165] (910s left) gem_flink_basic (bad-open)
[114.456489] Starting subtest: bad-open
[114.459958] Subtest bad-open: SUCCESS (0.000s)
[114.583778] [030/165] (909s left) gem_flink_basic (basic)
[114.982657] Starting subtest: basic
[114.987513] Subtest basic: SUCCESS (0.001s)
[115.119308] [031/165] (909s left) gem_flink_basic (double-flink)
[115.517979] Starting subtest: double-flink
[115.521193] Subtest double-flink: SUCCESS (0.000s)
[115.667416] [032/165] (908s left) gem_flink_basic (flink-lifetime)
[116.069880] Starting subtest: flink-lifetime
[116.074730] Subtest flink-lifetime: SUCCESS (0.007s)
[116.215954] [033/165] (908s left) gem_huc_copy (huc-copy)
[116.630430] Subtest huc-copy: SKIP (0.000s)
[116.743394] [034/165] (908s left) gem_linear_blits (basic)
[117.574909] Starting subtest: basic
[117.628202] Subtest basic: SUCCESS (0.054s)
[117.868494] [035/165] (907s left) gem_mmap (basic)
[118.563913] Starting subtest: basic
[118.580122] Subtest basic: SUCCESS (0.002s)
[118.704831] [036/165] (906s left) gem_mmap_gtt (basic)
[119.125675] Starting subtest: basic
[119.130327] Subtest basic: SUCCESS (0.004s)
[119.261222] [037/165] (905s left) gem_render_linear_blits (basic)
[119.682733] Starting subtest: basic
[119.806782] Subtest basic: SUCCESS (0.124s)
[119.928301] [038/165] (905s left) gem_render_tiled_blits (basic)
[120.336817] Starting subtest: basic
[120.474982] Subtest basic: SUCCESS (0.134s)
[120.595574] [039/165] (904s left) gem_ringfill (basic-all)
[121.051523] Starting subtest: basic-all
[122.245625] Subtest basic-all: SUCCESS (1.194s)
[122.392988] [040/165] (902s left) gem_softpin (allocator-basic)
[122.822147] Subtest allocator-basic: SKIP (0.000s)
[122.939363] [041/165] (902s left) gem_softpin (allocator-basic-reserve)
[123.357636] Subtest allocator-basic-reserve: SKIP (0.000s)
[123.491884] [042/165] (902s left) gem_softpin (safe-alignment)
[123.915636] Starting subtest: safe-alignment
[123.940796] Subtest safe-alignment: SUCCESS (0.032s)
[124.093321] [043/165] (901s left) gem_sync (basic-all)
[124.567853] Starting subtest: basic-all
[126.861297] Subtest basic-all: SUCCESS (2.295s)
[127.136955] [044/165] (898s left) gem_sync (basic-each)
[127.599660] Starting subtest: basic-each
[129.903254] Subtest basic-each: SUCCESS (2.303s)
[130.185696] [045/165] (895s left) gem_tiled_blits (basic)
[130.847413] Starting subtest: basic
[130.935263] Subtest basic: SUCCESS (0.089s)
[131.168847] [046/165] (894s left) gem_tiled_fence_blits (basic)
[132.163900] Starting subtest: basic
[132.237228] Subtest basic: SUCCESS (0.072s)
[132.471907] [047/165] (893s left) gem_tiled_pread_basic
[134.961995] [048/165] (891s left) gem_wait (busy@all-engines)
[135.469974] Starting subtest: busy
[135.474603] Starting dynamic subtest: all-engines
[136.001734] Dynamic subtest all-engines: SUCCESS (0.534s)
[136.006138] Subtest busy: SUCCESS (0.537s)
[136.410264] [049/165] (889s left) gem_wait (wait@all-engines)
[136.913857] Starting subtest: wait
[136.918497] Starting dynamic subtest: all-engines
[137.960141] Dynamic subtest all-engines: SUCCESS (1.044s)
[137.963532] Subtest wait: SUCCESS (1.047s)
[138.361732] [050/165] (887s left) i915_getparams_basic (basic-eu-total)
[138.777584] Starting subtest: basic-eu-total
[138.783520] Subtest basic-eu-total: SUCCESS (0.000s)
[138.906359] [051/165] (887s left) i915_getparams_basic (basic-subslice-total)
[139.313300] Starting subtest: basic-subslice-total
[139.319923] Subtest basic-subslice-total: SUCCESS (0.000s)
[139.443905] [052/165] (886s left) i915_hangman (error-state-basic)
[139.881798] Starting subtest: error-state-basic
[140.199189] Subtest error-state-basic: SUCCESS (0.309s)
[140.319230] [053/165] (886s left) i915_pciid
[140.890607] [054/165] (885s left) kms_addfb_basic (addfb25-4-tiled)
[141.389326] Starting subtest: addfb25-4-tiled
[141.393588] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[141.542408] [055/165] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[141.970872] Starting subtest: addfb25-bad-modifier
[141.974745] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[142.145928] [056/165] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[142.558618] Starting subtest: addfb25-framebuffer-vs-set-tiling
[142.561485] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[142.741752] [057/165] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[143.162736] Starting subtest: addfb25-modifier-no-flag
[143.167299] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[143.375414] [058/165] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[143.808597] Starting subtest: addfb25-x-tiled-legacy
[143.812669] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[144.091511] [059/165] (882s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[144.687652] Starting subtest: addfb25-x-tiled-mismatch-legacy
[144.691822] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[144.901845] [060/165] (882s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[145.381516] Starting subtest: addfb25-yf-tiled-legacy
[145.385977] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[145.571326] [061/165] (881s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[146.145417] Starting subtest: addfb25-y-tiled-legacy
[146.149992] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[146.317811] [062/165] (881s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[146.779799] Starting subtest: addfb25-y-tiled-small-legacy
[146.785605] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[146.948091] [063/165] (880s left) kms_addfb_basic (bad-pitch-0)
[147.356927] Starting subtest: bad-pitch-0
[147.361151] Subtest bad-pitch-0: SUCCESS (0.000s)
[147.551804] [064/165] (880s left) kms_addfb_basic (bad-pitch-1024)
[147.966762] Starting subtest: bad-pitch-1024
[147.971702] Subtest bad-pitch-1024: SUCCESS (0.000s)
[148.151903] [065/165] (879s left) kms_addfb_basic (bad-pitch-128)
[148.555123] Starting subtest: bad-pitch-128
[148.559609] Subtest bad-pitch-128: SUCCESS (0.000s)
[148.733142] [066/165] (879s left) kms_addfb_basic (bad-pitch-256)
[149.145205] Starting subtest: bad-pitch-256
[149.149105] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.333562] [067/165] (878s left) kms_addfb_basic (bad-pitch-32)
[149.753598] Starting subtest: bad-pitch-32
[149.757646] Subtest bad-pitch-32: SUCCESS (0.000s)
[149.936250] [068/165] (878s left) kms_addfb_basic (bad-pitch-63)
[150.350332] Starting subtest: bad-pitch-63
[150.354632] Subtest bad-pitch-63: SUCCESS (0.000s)
[150.540913] [069/165] (877s left) kms_addfb_basic (bad-pitch-65536)
[150.949938] Starting subtest: bad-pitch-65536
[150.954640] Subtest bad-pitch-65536: SUCCESS (0.002s)
[151.136612] [070/165] (877s left) kms_addfb_basic (bad-pitch-999)
[151.546342] Starting subtest: bad-pitch-999
[151.550415] Subtest bad-pitch-999: SUCCESS (0.000s)
[151.759148] [071/165] (876s left) kms_addfb_basic (basic)
[152.168739] Starting subtest: basic
[152.172913] Subtest basic: SUCCESS (0.000s)
[152.354692] [072/165] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[152.761736] Starting subtest: basic-x-tiled-legacy
[152.764651] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[152.960983] [073/165] (875s left) kms_addfb_basic (basic-y-tiled-legacy)
[153.371884] Starting subtest: basic-y-tiled-legacy
[153.376540] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[153.569966] [074/165] (874s left) kms_addfb_basic (bo-too-small)
[154.016648] Starting subtest: bo-too-small
[154.020769] Subtest bo-too-small: SUCCESS (0.002s)
[154.154323] [075/165] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[154.605151] Starting subtest: bo-too-small-due-to-tiling
[154.608466] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[154.755503] [076/165] (873s left) kms_addfb_basic (clobberred-modifier)
[155.161094] Starting subtest: clobberred-modifier
[155.165759] Subtest clobberred-modifier: SUCCESS (0.001s)
[155.340688] [077/165] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[155.757687] Starting subtest: framebuffer-vs-set-tiling
[155.761253] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[155.942737] [078/165] (872s left) kms_addfb_basic (invalid-get-prop)
[156.353467] Starting subtest: invalid-get-prop
[156.357441] Subtest invalid-get-prop: SUCCESS (0.000s)
[156.539874] [079/165] (872s left) kms_addfb_basic (invalid-get-prop-any)
[156.949594] Starting subtest: invalid-get-prop-any
[156.953454] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[157.142386] [080/165] (871s left) kms_addfb_basic (invalid-set-prop)
[157.552220] Starting subtest: invalid-set-prop
[157.555316] Subtest invalid-set-prop: SUCCESS (0.000s)
[157.752941] [081/165] (871s left) kms_addfb_basic (invalid-set-prop-any)
[158.168614] Starting subtest: invalid-set-prop-any
[158.171601] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[158.364192] [082/165] (870s left) kms_addfb_basic (no-handle)
[158.777865] Starting subtest: no-handle
[158.782281] Subtest no-handle: SUCCESS (0.000s)
[158.958856] [083/165] (870s left) kms_addfb_basic (size-max)
[159.427515] Starting subtest: size-max
[159.430661] Subtest size-max: SUCCESS (0.001s)
[159.579180] [084/165] (869s left) kms_addfb_basic (small-bo)
[160.041368] Starting subtest: small-bo
[160.045248] Subtest small-bo: SUCCESS (0.000s)
[160.190816] [085/165] (869s left) kms_addfb_basic (tile-pitch-mismatch)
[160.616488] Starting subtest: tile-pitch-mismatch
[160.620670] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[160.813510] [086/165] (868s left) kms_addfb_basic (too-high)
[161.258649] Starting subtest: too-high
[161.263722] Subtest too-high: SUCCESS (0.005s)
[161.413138] [087/165] (868s left) kms_addfb_basic (too-wide)
[161.874972] Starting subtest: too-wide
[161.878671] Subtest too-wide: SUCCESS (0.000s)
[162.029177] [088/165] (867s left) kms_addfb_basic (unused-handle)
[162.432716] Starting subtest: unused-handle
[162.436873] Subtest unused-handle: SUCCESS (0.000s)
[162.635184] [089/165] (867s left) kms_addfb_basic (unused-modifier)
[163.034234] Starting subtest: unused-modifier
[163.038402] Subtest unused-modifier: SUCCESS (0.000s)
[163.216566] [090/165] (866s left) kms_addfb_basic (unused-offsets)
[163.617826] Starting subtest: unused-offsets
[163.622351] Subtest unused-offsets: SUCCESS (0.000s)
[163.810357] [091/165] (866s left) kms_addfb_basic (unused-pitches)
[164.218141] Starting subtest: unused-pitches
[164.221689] Subtest unused-pitches: SUCCESS (0.000s)
[164.421407] [092/165] (865s left) kms_busy (basic)
[164.894785] Starting subtest: basic
[164.899304] Starting dynamic subtest: flip
[166.372577] Dynamic subtest flip: SUCCESS (1.471s)
[166.417719] Starting dynamic subtest: modeset
[166.422973] Dynamic subtest modeset: SKIP (0.000s)
[166.425962] Subtest basic: SUCCESS (1.478s)
[166.648393] [093/165] (863s left) kms_prop_blob (basic)
[167.074877] Starting subtest: basic
[167.079197] Subtest basic: SUCCESS (0.000s)
[167.209611] [094/165] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[167.644719] Starting subtest: basic-busy-flip-before-cursor-atomic
[167.658502] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.012s)
[167.798213] [095/165] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[168.246281] Starting subtest: basic-busy-flip-before-cursor-legacy
[169.521264] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.273s)
[169.798905] [096/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[170.244721] Starting subtest: basic-flip-after-cursor-atomic
[170.252314] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[170.382757] [097/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[170.843730] Starting subtest: basic-flip-after-cursor-legacy
[172.101745] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.254s)
[172.381583] [098/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[172.848688] Starting subtest: basic-flip-after-cursor-varying-size
[174.119413] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.272s)
[174.399736] [099/165] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[174.866738] Starting subtest: basic-flip-before-cursor-atomic
[174.873646] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[175.002501] [100/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[175.466791] Starting subtest: basic-flip-before-cursor-legacy
[176.715279] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.250s)
[176.981532] [101/165] (854s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[177.420658] Starting subtest: basic-flip-before-cursor-varying-size
[178.749631] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.321s)
[179.017780] [102/165] (852s left) kms_dsc (dsc-basic)
[179.478147] Subtest dsc-basic: SKIP (0.000s)
[179.583515] [103/165] (851s left) kms_flip (basic-flip-vs-dpms)
[180.022668] Starting subtest: basic-flip-vs-dpms
[180.027209] Starting dynamic subtest: A-VGA1
[181.615573] Dynamic subtest A-VGA1: SUCCESS (1.589s)
[181.663317] Starting dynamic subtest: B-VGA1
[183.131555] Dynamic subtest B-VGA1: SUCCESS (1.505s)
[183.137174] Subtest basic-flip-vs-dpms: SUCCESS (3.102s)
[183.556773] [104/165] (847s left) kms_flip (basic-flip-vs-modeset)
[183.989425] Starting subtest: basic-flip-vs-modeset
[183.993889] Starting dynamic subtest: A-VGA1
[185.570912] Dynamic subtest A-VGA1: SUCCESS (1.582s)
[185.619224] Starting dynamic subtest: B-VGA1
[186.859201] Dynamic subtest B-VGA1: SUCCESS (1.281s)
[186.865421] Subtest basic-flip-vs-modeset: SUCCESS (2.868s)
[187.223424] [105/165] (844s left) kms_flip (basic-flip-vs-wf_vblank)
[187.677713] Starting subtest: basic-flip-vs-wf_vblank
[187.681481] Starting dynamic subtest: A-VGA1
[189.567994] Dynamic subtest A-VGA1: SUCCESS (1.889s)
[189.611342] Starting dynamic subtest: B-VGA1
[191.261480] Dynamic subtest B-VGA1: SUCCESS (1.694s)
[191.265431] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.590s)
[191.710366] [106/165] (839s left) kms_flip (basic-plain-flip)
[192.141862] Starting subtest: basic-plain-flip
[192.146413] Starting dynamic subtest: A-VGA1
[193.761319] Dynamic subtest A-VGA1: SUCCESS (1.605s)
[193.802235] Starting dynamic subtest: B-VGA1
[195.161913] Dynamic subtest B-VGA1: SUCCESS (1.407s)
[195.165088] Subtest basic-plain-flip: SUCCESS (3.020s)
[195.598751] [107/165] (836s left) kms_force_connector_basic (force-connector-state)
[196.084100] Starting subtest: force-connector-state
[196.347903] Subtest force-connector-state: SUCCESS (0.253s)
[196.780697] [108/165] (834s left) kms_force_connector_basic (force-edid)
[197.249389] Starting subtest: force-edid
[197.335539] Subtest force-edid: SUCCESS (0.086s)
[197.575547] [109/165] (834s left) kms_force_connector_basic (force-load-detect)
[198.036165] Starting subtest: force-load-detect
[198.481783] Subtest force-load-detect: SUCCESS (0.443s)
[198.854622] [110/165] (833s left) kms_force_connector_basic (prune-stale-modes)
[199.314427] Starting subtest: prune-stale-modes
[199.395641] Subtest prune-stale-modes: SUCCESS (0.082s)
[199.632477] [111/165] (832s left) kms_frontbuffer_tracking (basic)
[200.108696] Subtest basic: SKIP (0.000s)
[200.222925] [112/165] (831s left) kms_hdmi_inject (inject-audio)
[200.648133] Subtest inject-audio: SKIP (0.000s)
[200.755793] [113/165] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[201.219357] Starting subtest: compare-crc-sanitycheck-xr24
[201.223323] Starting dynamic subtest: pipe-A-VGA-1
[201.588473] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.365s)
[201.637132] Starting dynamic subtest: pipe-B-VGA-1
[202.076543] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.478s)
[202.080599] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.855s)
[202.386152] [114/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[202.839116] Starting subtest: compare-crc-sanitycheck-nv12
[202.843259] Starting dynamic subtest: pipe-A-VGA-1
[202.852656] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[202.893517] Starting dynamic subtest: pipe-B-VGA-1
[202.899609] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[202.905945] Subtest compare-crc-sanitycheck-nv12: SKIP (0.014s)
[203.001209] [115/165] (829s left) kms_pipe_crc_basic (hang-read-crc)
[203.448989] Starting subtest: hang-read-crc
[203.453797] Starting dynamic subtest: pipe-A-VGA-1
[204.663784] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.209s)
[204.711764] Starting dynamic subtest: pipe-B-VGA-1
[205.952777] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.285s)
[205.955962] Subtest hang-read-crc: SUCCESS (2.504s)
[206.239247] [116/165] (826s left) kms_pipe_crc_basic (nonblocking-crc)
[206.771582] Starting subtest: nonblocking-crc
[206.776442] Starting dynamic subtest: pipe-A-VGA-1
[207.348729] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.573s)
[207.401358] Starting dynamic subtest: pipe-B-VGA-1
[208.007843] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.651s)
[208.012386] Subtest nonblocking-crc: SUCCESS (1.237s)
[208.259291] [117/165] (824s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[208.722204] Starting subtest: nonblocking-crc-frame-sequence
[208.729159] Starting dynamic subtest: pipe-A-VGA-1
[209.275177] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.552s)
[209.317258] Starting dynamic subtest: pipe-B-VGA-1
[209.957616] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.674s)
[209.962290] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.238s)
[210.219683] [118/165] (822s left) kms_pipe_crc_basic (read-crc)
[210.684889] Starting subtest: read-crc
[210.688748] Starting dynamic subtest: pipe-A-VGA-1
[211.183507] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.499s)
[211.236895] Starting dynamic subtest: pipe-B-VGA-1
[211.780684] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.590s)
[211.785434] Subtest read-crc: SUCCESS (1.102s)
[212.067299] [119/165] (820s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[212.524421] Starting subtest: read-crc-frame-sequence
[212.528828] Starting dynamic subtest: pipe-A-VGA-1
[213.024779] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.499s)
[213.074889] Starting dynamic subtest: pipe-B-VGA-1
[213.611631] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.580s)
[213.618168] Subtest read-crc-frame-sequence: SUCCESS (1.090s)
[213.866145] [120/165] (819s left) kms_pm_backlight (basic-brightness)
[214.333261] Subtest basic-brightness: SKIP (0.000s)
[214.439417] [121/165] (818s left) kms_psr (primary_page_flip)
[214.854733] Subtest primary_page_flip: SKIP (0.000s)
[214.952433] [122/165] (818s left) kms_psr (cursor_plane_move)
[215.365184] Subtest cursor_plane_move: SKIP (0.000s)
[215.470451] [123/165] (817s left) kms_psr (sprite_plane_onoff)
[215.879733] Subtest sprite_plane_onoff: SKIP (0.000s)
[215.987768] [124/165] (817s left) kms_psr (primary_mmap_gtt)
[216.408870] Subtest primary_mmap_gtt: SKIP (0.000s)
[216.523374] [125/165] (816s left) kms_setmode (basic-clone-single-crtc)
[216.936720] Starting subtest: basic-clone-single-crtc
[216.947981] Subtest basic-clone-single-crtc: SKIP (0.001s)
[217.080512] [126/165] (816s left) i915_pm_rpm (basic-pci-d3-state)
[228.977164] Subtest basic-pci-d3-state: SKIP (0.000s)
[229.085608] [127/165] (804s left) i915_pm_rpm (basic-rte)
[229.485306] Starting subtest: basic-rte
[240.989237] Subtest basic-rte: SKIP (11.479s)
[241.088343] [128/165] (792s left) i915_pm_rps (basic-api)
[241.581484] Subtest basic-api: SKIP (0.000s)
[241.702456] [129/165] (792s left) prime_self_import (basic-llseek-bad)
[242.091243] Starting subtest: basic-llseek-bad
[242.106219] Subtest basic-llseek-bad: SUCCESS (0.010s)
[242.249570] [130/165] (791s left) prime_self_import (basic-llseek-size)
[242.640464] Starting subtest: basic-llseek-size
[242.658220] Subtest basic-llseek-size: SUCCESS (0.018s)
[242.795484] [131/165] (791s left) prime_self_import (basic-with_fd_dup)
[243.190140] Starting subtest: basic-with_fd_dup
[243.204290] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[243.344619] [132/165] (790s left) prime_self_import (basic-with_one_bo)
[243.727412] Starting subtest: basic-with_one_bo
[243.744126] Subtest basic-with_one_bo: SUCCESS (0.017s)
[243.870134] [133/165] (790s left) prime_self_import (basic-with_one_bo_two_files)
[244.258354] Starting subtest: basic-with_one_bo_two_files
[244.273820] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[244.412109] [134/165] (789s left) prime_self_import (basic-with_two_bos)
[244.810354] Starting subtest: basic-with_two_bos
[244.829609] Subtest basic-with_two_bos: SUCCESS (0.018s)
[244.981756] [135/165] (789s left) prime_vgem (basic-fence-flip)
[245.411789] Starting subtest: basic-fence-flip
[246.016139] Subtest basic-fence-flip: SUCCESS (0.600s)
[246.202254] [136/165] (788s left) prime_vgem (basic-fence-mmap)
[246.633207] Starting subtest: basic-fence-mmap
[246.815869] Subtest basic-fence-mmap: SUCCESS (0.183s)
[246.968436] [137/165] (787s left) prime_vgem (basic-fence-read)
[247.383248] Starting subtest: basic-fence-read
[247.683532] Subtest basic-fence-read: SUCCESS (0.301s)
[247.837582] [138/165] (786s left) prime_vgem (basic-gtt)
[248.267634] Starting subtest: basic-gtt
[248.346441] Subtest basic-gtt: SUCCESS (0.079s)
[248.500966] [139/165] (786s left) prime_vgem (basic-read)
[248.932666] Starting subtest: basic-read
[249.066314] Subtest basic-read: SUCCESS (0.133s)
[249.234796] [140/165] (785s left) prime_vgem (basic-write)
[249.651653] Starting subtest: basic-write
[249.794909] Subtest basic-write: SUCCESS (0.143s)
[249.930598] [141/165] (784s left) vgem_basic (setversion)
[250.333120] Starting subtest: setversion
[250.340205] Subtest setversion: SUCCESS (0.001s)
[250.450578] [142/165] (784s left) vgem_basic (create)
[250.870117] Starting subtest: create
[250.873423] Subtest create: SUCCESS (0.002s)
[250.985273] [143/165] (784s left) vgem_basic (debugfs)
[251.400217] Starting subtest: debugfs
[251.404626] Subtest debugfs: SUCCESS (0.004s)
[251.517421] [144/165] (783s left) vgem_basic (dmabuf-export)
[251.933506] Starting subtest: dmabuf-export
[251.946584] Subtest dmabuf-export: SUCCESS (0.010s)
[252.087248] [145/165] (783s left) vgem_basic (dmabuf-fence)
[252.500540] Starting subtest: dmabuf-fence
[252.504119] Subtest dmabuf-fence: SUCCESS (0.004s)
[252.618949] [146/165] (782s left) vgem_basic (dmabuf-fence-before)
[253.033303] Starting subtest: dmabuf-fence-before
[253.036821] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[253.151761] [147/165] (782s left) vgem_basic (dmabuf-mmap)
[253.568480] Starting subtest: dmabuf-mmap
[253.648174] Subtest dmabuf-mmap: SUCCESS (0.081s)
[253.768291] [148/165] (781s left) vgem_basic (mmap)
[254.185211] Starting subtest: mmap
[254.240798] Subtest mmap: SUCCESS (0.057s)
[254.367566] [149/165] (781s left) vgem_basic (second-client)
[254.786114] Starting subtest: second-client
[254.819541] Subtest second-client: SUCCESS (0.034s)
[254.937321] [150/165] (780s left) vgem_basic (sysfs)
[255.352639] Starting subtest: sysfs
[255.356927] Subtest sysfs: SUCCESS (0.006s)
[255.484791] [151/165] (780s left) core_hotunplug (unbind-rebind)
[256.051206] Starting subtest: unbind-rebind
[260.530388] Subtest unbind-rebind: SUCCESS (4.470s)
[260.695829] [152/165] (775s left) vgem_basic (unload)
[261.131382] Starting subtest: unload
[290.469643] Subtest unload: SUCCESS (29.338s)
[290.729961] [153/165] (745s left) i915_module_load (reload)
[291.130752] Starting subtest: reload
[295.977714] Subtest reload: SUCCESS (4.847s)
[296.133489] [154/165] (739s left) gem_lmem_swapping (basic)
[297.130243] Subtest basic: SKIP (0.000s)
[297.237441] [155/165] (739s left) gem_lmem_swapping (parallel-random-engines)
[297.669913] Subtest parallel-random-engines: SKIP (0.000s)
[297.770551] [156/165] (738s left) gem_lmem_swapping (random-engines)
[298.199366] Subtest random-engines: SKIP (0.000s)
[298.302806] [157/165] (738s left) gem_lmem_swapping (verify-random)
[298.717718] Subtest verify-random: SKIP (0.000s)
[298.819744] [158/165] (737s left) i915_pm_rpm (module-reload)
[310.743299] Subtest module-reload: SKIP (0.000s)
[310.845839] [159/165] (725s left) i915_selftest (live)
[313.022256] Starting subtest: live
[313.025756] Starting dynamic subtest: sanitycheck
[315.348464] Dynamic subtest sanitycheck: SUCCESS (2.327s)
[315.379539] Starting dynamic subtest: uncore
[317.439134] Dynamic subtest uncore: SUCCESS (2.087s)
[317.471868] Starting dynamic subtest: workarounds
[319.824474] Dynamic subtest workarounds: SUCCESS (2.382s)
[319.858525] Starting dynamic subtest: gt_engines
[321.982676] Dynamic subtest gt_engines: SUCCESS (2.154s)
[322.013972] Starting dynamic subtest: gt_timelines
[332.976271] Dynamic subtest gt_timelines: SUCCESS (10.989s)
[333.013591] Starting dynamic subtest: gt_contexts
[335.106931] Dynamic subtest gt_contexts: SUCCESS (2.127s)
[335.139283] Starting dynamic subtest: gt_lrc
[337.182647] Dynamic subtest gt_lrc: SUCCESS (2.072s)
[337.214715] Starting dynamic subtest: gt_mocs
[339.281523] Dynamic subtest gt_mocs: SUCCESS (2.095s)
[339.312575] Starting dynamic subtest: gt_pm
[341.769663] Dynamic subtest gt_pm: SUCCESS (2.483s)
[341.808826] Starting dynamic subtest: gt_heartbeat
[343.917648] Dynamic subtest gt_heartbeat: SUCCESS (2.147s)
[343.949331] Starting dynamic subtest: gt_tlb
[346.011360] Dynamic subtest gt_tlb: SUCCESS (2.090s)
[346.048786] Starting dynamic subtest: requests
[350.718475] Dynamic subtest requests: SUCCESS (4.703s)
[350.755421] Starting dynamic subtest: migrate
[352.799174] Dynamic subtest migrate: SUCCESS (2.076s)
[352.836388] Starting dynamic subtest: active
[354.886154] Dynamic subtest active: SUCCESS (2.083s)
[354.917918] Starting dynamic subtest: objects
[358.010687] Dynamic subtest objects: SUCCESS (3.122s)
[358.041975] Starting dynamic subtest: mman
[370.869843] Dynamic subtest mman: SUCCESS (12.854s)
[370.908417] Starting dynamic subtest: dmabuf
[373.114430] Dynamic subtest dmabuf: SUCCESS (2.241s)
[373.152101] Starting dynamic subtest: vma
[375.257647] Dynamic subtest vma: SUCCESS (2.139s)
[375.294671] Starting dynamic subtest: coherency
[382.319305] Dynamic subtest coherency: SUCCESS (7.056s)
[382.357398] Starting dynamic subtest: gtt
[387.910619] Dynamic subtest gtt: SUCCESS (5.585s)
[387.947343] Starting dynamic subtest: gem
[390.090639] Dynamic subtest gem: SUCCESS (2.176s)
[390.123196] Starting dynamic subtest: evict
[392.154531] Dynamic subtest evict: SUCCESS (2.063s)
[392.193618] Starting dynamic subtest: hugepages
[394.253246] Dynamic subtest hugepages: SUCCESS (2.093s)
[394.285486] Starting dynamic subtest: gem_contexts
[396.336465] Dynamic subtest gem_contexts: SUCCESS (2.080s)
[396.369297] Starting dynamic subtest: client
[398.388517] Dynamic subtest client: SUCCESS (2.048s)
[398.419907] Starting dynamic subtest: gem_migrate
[400.439731] Dynamic subtest gem_migrate: SUCCESS (2.045s)
[400.471289] Starting dynamic subtest: reset
[403.110133] Dynamic subtest reset: SUCCESS (2.668s)
[403.148628] Starting dynamic subtest: memory_region
[405.219401] Dynamic subtest memory_region: SUCCESS (2.103s)
[405.252518] Starting dynamic subtest: hangcheck
[408.366338] Dynamic subtest hangcheck: SUCCESS (3.145s)
[408.403361] Starting dynamic subtest: execlists
[410.441596] Dynamic subtest execlists: SUCCESS (2.070s)
[410.473884] Starting dynamic subtest: ring_submission
[412.547508] Dynamic subtest ring_submission: SUCCESS (2.103s)
[412.584960] Starting dynamic subtest: perf
[414.613816] Dynamic subtest perf: SUCCESS (2.059s)
[414.646324] Starting dynamic subtest: slpc
[416.724598] Dynamic subtest slpc: SUCCESS (2.108s)
[416.769598] Starting dynamic subtest: guc
[418.806655] Dynamic subtest guc: SUCCESS (2.075s)
[418.838441] Starting dynamic subtest: guc_multi_lrc
[420.897403] Dynamic subtest guc_multi_lrc: SUCCESS (2.088s)
[420.935383] Starting dynamic subtest: guc_hang
[422.957186] Dynamic subtest guc_hang: SUCCESS (2.055s)
[422.989589] Starting dynamic subtest: late_gt_pm
[425.018250] Dynamic subtest late_gt_pm: SUCCESS (2.057s)
[425.021422] Subtest live: SUCCESS (112.003s)
[425.118265] [160/165] (611s left) dmabuf (all-tests)
[425.543544] Starting subtest: all-tests
[425.547877] Starting dynamic subtest: sanitycheck
[425.638611] Dynamic subtest sanitycheck: SUCCESS (0.093s)
[425.680640] Starting dynamic subtest: dma_fence
[425.866649] Dynamic subtest dma_fence: SUCCESS (0.223s)
[425.909754] Starting dynamic subtest: dma_fence_chain
[477.993694] Dynamic subtest dma_fence_chain: SUCCESS (52.123s)
[478.032588] Starting dynamic subtest: dma_fence_unwrap
[478.099629] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[478.147909] Starting dynamic subtest: dma_resv
[478.202513] Dynamic subtest dma_resv: SUCCESS (0.101s)
[478.206660] Subtest all-tests: SUCCESS (52.662s)
[478.293278] [161/165] (558s left) i915_suspend (basic-s2idle-without-i915)
[478.677779] Starting subtest: basic-s2idle-without-i915
[500.590548] Subtest basic-s2idle-without-i915: SUCCESS (6.516s)
[502.838339] [162/165] (551s left) i915_suspend (basic-s3-without-i915)
[503.264751] Starting subtest: basic-s3-without-i915
[523.762280] Subtest basic-s3-without-i915: SUCCESS (4.494s)
[528.717390] [163/165] (546s left) gem_exec_suspend (basic-s0)
[529.293860] Starting subtest: basic-S0
[529.297423] Starting dynamic subtest: smem
[550.617967] Dynamic subtest smem: SUCCESS (5.788s)
[550.621808] Subtest basic-S0: SUCCESS (5.793s)
[552.768399] [164/165] (539s left) gem_exec_suspend (basic-s3)
[553.245529] Starting subtest: basic-S3
[553.248950] Starting dynamic subtest: smem
[575.859535] Dynamic subtest smem: SUCCESS (6.189s)
[575.863699] Subtest basic-S3: SUCCESS (6.194s)
[579.093918] [165/165] (532s left) kms_pipe_crc_basic (suspend-read-crc)
[579.547577] Starting subtest: suspend-read-crc
[579.551617] Starting dynamic subtest: pipe-A-VGA-1
[597.633672] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.290s)
[597.696403] Starting dynamic subtest: pipe-B-VGA-1
[615.646802] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.398s)
[615.652774] Subtest suspend-read-crc: SUCCESS (4.702s)
[618.815410] Closing watchdogs
Done.