[51.030846] Initializing watchdogs
[51.030999]   /dev/watchdog0
[51.039066] [001/171] (960s left) i915_module_load (load)
[51.424660] Starting subtest: load
[53.390471] Subtest load: SUCCESS (1.964s)
[53.436248] [002/171] (958s left) core_auth (basic-auth)
[53.860294] Starting subtest: basic-auth
[53.862127] Subtest basic-auth: SUCCESS (0.002s)
[53.926383] [003/171] (957s left) debugfs_test (read_all_entries)
[54.052884] Starting subtest: read_all_entries
[54.104513] Subtest read_all_entries: SUCCESS (0.051s)
[55.089976] [004/171] (956s left) debugfs_test (basic-hwmon)
[55.219864] Starting subtest: basic-hwmon
[55.223296] Subtest basic-hwmon: SKIP (0.000s)
[56.204380] [005/171] (955s left) fbdev (eof)
[56.331267] Starting subtest: eof
[56.332868] Subtest eof: SUCCESS (0.000s)
[56.387211] [006/171] (955s left) fbdev (info)
[56.508218] Starting subtest: info
[56.509896] Subtest info: SUCCESS (0.000s)
[56.569874] [007/171] (955s left) fbdev (nullptr)
[56.697105] Starting subtest: nullptr
[56.698793] Subtest nullptr: SUCCESS (0.000s)
[56.757506] [008/171] (954s left) fbdev (read)
[56.880049] Starting subtest: read
[57.085442] Subtest read: SUCCESS (0.205s)
[57.140431] [009/171] (954s left) fbdev (write)
[57.263100] Starting subtest: write
[57.363392] Subtest write: SUCCESS (0.100s)
[57.422687] [010/171] (954s left) gem_basic (bad-close)
[57.545640] Starting subtest: bad-close
[57.548870] Subtest bad-close: SUCCESS (0.000s)
[57.621813] [011/171] (954s left) gem_basic (create-close)
[57.744931] Starting subtest: create-close
[57.749337] Subtest create-close: SUCCESS (0.000s)
[57.820987] [012/171] (953s left) gem_basic (create-fd-close)
[57.942716] Starting subtest: create-fd-close
[57.947545] Subtest create-fd-close: SUCCESS (0.000s)
[58.020204] [013/171] (953s left) gem_busy (busy@all-engines)
[58.157045] Starting subtest: busy
[58.158886] Starting dynamic subtest: all-engines
[58.191075] Dynamic subtest all-engines: SUCCESS (0.033s)
[58.192928] Subtest busy: SUCCESS (0.034s)
[58.550968] [014/171] (953s left) gem_close_race (basic-process)
[58.689776] Starting subtest: basic-process
[58.737354] Subtest basic-process: SUCCESS (0.048s)
[58.920432] [015/171] (952s left) gem_close_race (basic-threads)
[59.080169] Starting subtest: basic-threads
[60.207907] Subtest basic-threads: SUCCESS (1.130s)
[60.400832] [016/171] (951s left) gem_ctx_create (basic)
[60.539545] Starting subtest: basic
[60.541472] Subtest basic: SUCCESS (0.000s)
[60.717177] [017/171] (951s left) gem_ctx_create (basic-files)
[60.848899] Starting subtest: basic-files
[62.872642] Subtest basic-files: SUCCESS (2.024s)
[63.244314] [018/171] (948s left) gem_ctx_exec (basic)
[63.371117] Starting subtest: basic
[63.372785] Subtest basic: SUCCESS (0.001s)
[63.447644] [019/171] (948s left) gem_exec_basic (basic)
[63.575643] Starting subtest: basic
[63.577299] Starting dynamic subtest: rcs0-smem
[63.579263] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[63.587197] Starting dynamic subtest: vcs0-smem
[63.589104] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[63.591055] Subtest basic: SUCCESS (0.001s)
[63.760512] [020/171] (948s left) gem_exec_create (basic)
[63.893125] Starting subtest: basic
[63.895062] Starting dynamic subtest: smem
[65.939196] Dynamic subtest smem: SUCCESS (2.045s)
[65.941199] Subtest basic: SUCCESS (2.046s)
[66.123102] [021/171] (945s left) gem_exec_fence (basic-busy)
[66.380683] Starting subtest: basic-busy
[66.382450] Starting dynamic subtest: rcs0
[66.395042] Dynamic subtest rcs0: SUCCESS (0.015s)
[66.406384] Starting dynamic subtest: vcs0
[66.412187] Dynamic subtest vcs0: SUCCESS (0.017s)
[66.414092] Subtest basic-busy: SUCCESS (0.032s)
[66.921405] [022/171] (945s left) gem_exec_fence (basic-wait)
[67.182111] Starting subtest: basic-wait
[67.183829] Starting dynamic subtest: rcs0
[67.193895] Dynamic subtest rcs0: SUCCESS (0.013s)
[67.202884] Starting dynamic subtest: vcs0
[67.206757] Dynamic subtest vcs0: SUCCESS (0.012s)
[67.208560] Subtest basic-wait: SUCCESS (0.026s)
[67.668155] [023/171] (944s left) gem_exec_fence (basic-await)
[67.922303] Starting subtest: basic-await
[67.923984] Starting dynamic subtest: rcs0
[67.992955] Dynamic subtest rcs0: SUCCESS (0.072s)
[68.001311] Starting dynamic subtest: vcs0
[68.063479] Dynamic subtest vcs0: SUCCESS (0.071s)
[68.065523] Subtest basic-await: SUCCESS (0.143s)
[68.518896] [024/171] (943s left) gem_exec_fence (nb-await)
[68.774389] Starting subtest: nb-await
[68.777515] Starting dynamic subtest: rcs0
[68.827485] Dynamic subtest rcs0: SUCCESS (0.053s)
[68.838455] Starting dynamic subtest: vcs0
[68.881803] Dynamic subtest vcs0: SUCCESS (0.054s)
[68.883808] Subtest nb-await: SUCCESS (0.108s)
[69.331396] [025/171] (942s left) gem_exec_gttfill (basic)
[69.463255] Starting subtest: basic
[76.971629] Subtest basic: SUCCESS (7.508s)
[77.147332] [026/171] (934s left) gem_exec_parallel (engines)
[77.370401] Starting subtest: engines
[77.373892] Starting dynamic subtest: basic
[79.157971] Dynamic subtest basic: SUCCESS (1.788s)
[79.167145] Starting dynamic subtest: contexts
[81.201044] Dynamic subtest contexts: SUCCESS (2.041s)
[81.210270] Starting dynamic subtest: fds
[81.213431] Dynamic subtest fds: SKIP (0.001s)
[81.222337] Starting dynamic subtest: userptr
[83.056197] Dynamic subtest userptr: SUCCESS (1.855s)
[83.058072] Subtest engines: SUCCESS (5.686s)
[83.240884] [027/171] (928s left) gem_exec_store (basic)
[83.381172] Starting subtest: basic
[83.410334] Subtest basic: SUCCESS (0.029s)
[83.586762] [028/171] (928s left) gem_flink_basic (bad-flink)
[83.710875] Starting subtest: bad-flink
[83.712657] Subtest bad-flink: SUCCESS (0.000s)
[83.790753] [029/171] (928s left) gem_flink_basic (bad-open)
[83.910947] Starting subtest: bad-open
[83.912709] Subtest bad-open: SUCCESS (0.000s)
[83.987062] [030/171] (928s left) gem_flink_basic (basic)
[84.107299] Starting subtest: basic
[84.108991] Subtest basic: SUCCESS (0.000s)
[84.185186] [031/171] (928s left) gem_flink_basic (double-flink)
[84.331828] Starting subtest: double-flink
[84.333673] Subtest double-flink: SUCCESS (0.000s)
[84.403294] [032/171] (927s left) gem_flink_basic (flink-lifetime)
[84.526782] Starting subtest: flink-lifetime
[84.528409] Subtest flink-lifetime: SUCCESS (0.001s)
[84.602914] [033/171] (927s left) gem_huc_copy (huc-copy)
[84.728176] Subtest huc-copy: SKIP (0.000s)
[84.751834] [034/171] (927s left) gem_linear_blits (basic)
[84.998784] Starting subtest: basic
[85.012148] Subtest basic: SUCCESS (0.012s)
[85.138368] [035/171] (927s left) gem_mmap (basic)
[85.353707] Starting subtest: basic
[85.362184] Subtest basic: SUCCESS (0.001s)
[85.434524] [036/171] (926s left) gem_mmap_gtt (basic)
[85.559529] Starting subtest: basic
[85.561294] Subtest basic: SUCCESS (0.001s)
[85.637684] [037/171] (926s left) gem_render_linear_blits (basic)
[85.760368] Starting subtest: basic
[85.800981] Subtest basic: SUCCESS (0.039s)
[85.853689] [038/171] (926s left) gem_render_tiled_blits (basic)
[85.977671] Starting subtest: basic
[86.013787] Subtest basic: SUCCESS (0.034s)
[86.049828] [039/171] (926s left) gem_ringfill (basic-all)
[86.224471] Starting subtest: basic-all
[87.338317] Subtest basic-all: SUCCESS (1.115s)
[87.412584] [040/171] (924s left) gem_softpin (allocator-basic)
[87.558964] Subtest allocator-basic: SKIP (0.000s)
[87.632605] [041/171] (924s left) gem_softpin (allocator-basic-reserve)
[87.787102] Subtest allocator-basic-reserve: SKIP (0.000s)
[87.864204] [042/171] (924s left) gem_softpin (safe-alignment)
[88.096557] Starting subtest: safe-alignment
[88.104730] Subtest safe-alignment: SUCCESS (0.009s)
[88.206693] [043/171] (924s left) gem_sync (basic-all)
[88.420297] Starting subtest: basic-all
[90.581145] Subtest basic-all: SUCCESS (2.163s)
[90.773168] [044/171] (921s left) gem_sync (basic-each)
[90.905228] Starting subtest: basic-each
[93.015264] Subtest basic-each: SUCCESS (2.109s)
[93.203164] [045/171] (919s left) gem_tiled_blits (basic)
[93.448186] Starting subtest: basic
[93.470685] Subtest basic: SUCCESS (0.022s)
[93.586109] [046/171] (918s left) gem_tiled_fence_blits (basic)
[93.929032] Starting subtest: basic
[93.939150] Subtest basic: SUCCESS (0.011s)
[94.051436] [047/171] (918s left) gem_tiled_pread_basic
[94.500060] [048/171] (918s left) gem_wait (busy@all-engines)
[94.639728] Starting subtest: busy
[94.642108] Starting dynamic subtest: all-engines
[95.148609] Dynamic subtest all-engines: SUCCESS (0.508s)
[95.150302] Subtest busy: SUCCESS (0.508s)
[95.363407] [049/171] (917s left) gem_wait (wait@all-engines)
[95.506495] Starting subtest: wait
[95.508414] Starting dynamic subtest: all-engines
[96.523077] Dynamic subtest all-engines: SUCCESS (1.019s)
[96.524906] Subtest wait: SUCCESS (1.019s)
[96.727495] [050/171] (915s left) i915_getparams_basic (basic-eu-total)
[96.848068] Starting subtest: basic-eu-total
[96.852111] Subtest basic-eu-total: SUCCESS (0.000s)
[96.911936] [051/171] (915s left) i915_getparams_basic (basic-subslice-total)
[97.031789] Starting subtest: basic-subslice-total
[97.034956] Subtest basic-subslice-total: SUCCESS (0.000s)
[97.111651] [052/171] (915s left) i915_hangman (error-state-basic)
[97.238761] Starting subtest: error-state-basic
[97.248362] Subtest error-state-basic: SUCCESS (0.010s)
[97.296850] [053/171] (915s left) i915_pciid
[97.492452] [054/171] (915s left) kms_addfb_basic (addfb25-bad-modifier)
[97.615120] Starting subtest: addfb25-bad-modifier
[97.617467] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[98.620949] [055/171] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[98.747989] Starting subtest: addfb25-framebuffer-vs-set-tiling
[98.749749] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[99.735596] [056/171] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[99.859840] Starting subtest: addfb25-modifier-no-flag
[99.861541] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[100.832917] [057/171] (911s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[100.958863] Starting subtest: addfb25-x-tiled-legacy
[100.960570] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[101.930053] [058/171] (910s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[102.056099] Starting subtest: addfb25-x-tiled-mismatch-legacy
[102.057762] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[103.028507] [059/171] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[103.673456] Starting subtest: addfb25-yf-tiled-legacy
[103.675353] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[104.159789] [060/171] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[104.802989] Starting subtest: addfb25-y-tiled-legacy
[104.805244] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[105.290917] [061/171] (907s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.930731] Starting subtest: addfb25-y-tiled-small-legacy
[105.934235] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[106.406206] [062/171] (906s left) kms_addfb_basic (bad-pitch-0)
[106.528905] Starting subtest: bad-pitch-0
[106.530604] Subtest bad-pitch-0: SUCCESS (0.000s)
[107.502947] [063/171] (905s left) kms_addfb_basic (bad-pitch-1024)
[107.627036] Starting subtest: bad-pitch-1024
[107.628674] Subtest bad-pitch-1024: SUCCESS (0.000s)
[108.618093] [064/171] (904s left) kms_addfb_basic (bad-pitch-128)
[108.740522] Starting subtest: bad-pitch-128
[108.742281] Subtest bad-pitch-128: SUCCESS (0.000s)
[109.731819] [065/171] (903s left) kms_addfb_basic (bad-pitch-256)
[109.853860] Starting subtest: bad-pitch-256
[109.855759] Subtest bad-pitch-256: SUCCESS (0.000s)
[110.829607] [066/171] (902s left) kms_addfb_basic (bad-pitch-32)
[110.951310] Starting subtest: bad-pitch-32
[110.952966] Subtest bad-pitch-32: SUCCESS (0.000s)
[111.927315] [067/171] (901s left) kms_addfb_basic (bad-pitch-63)
[112.050476] Starting subtest: bad-pitch-63
[112.052208] Subtest bad-pitch-63: SUCCESS (0.000s)
[113.024974] [068/171] (900s left) kms_addfb_basic (bad-pitch-65536)
[113.150684] Starting subtest: bad-pitch-65536
[113.152373] Subtest bad-pitch-65536: SUCCESS (0.000s)
[114.122913] [069/171] (898s left) kms_addfb_basic (bad-pitch-999)
[114.246082] Starting subtest: bad-pitch-999
[114.247727] Subtest bad-pitch-999: SUCCESS (0.000s)
[115.254087] [070/171] (897s left) kms_addfb_basic (basic)
[115.377984] Starting subtest: basic
[115.379700] Subtest basic: SUCCESS (0.000s)
[116.369031] [071/171] (896s left) kms_addfb_basic (basic-x-tiled-legacy)
[116.496769] Starting subtest: basic-x-tiled-legacy
[116.498462] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[117.465368] [072/171] (895s left) kms_addfb_basic (basic-y-tiled-legacy)
[117.591837] Starting subtest: basic-y-tiled-legacy
[117.593593] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[118.580213] [073/171] (894s left) kms_addfb_basic (bo-too-small)
[119.230142] Starting subtest: bo-too-small
[119.231966] Subtest bo-too-small: SUCCESS (0.001s)
[119.695462] [074/171] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[120.344818] Starting subtest: bo-too-small-due-to-tiling
[120.347100] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[120.826453] [075/171] (892s left) kms_addfb_basic (clobberred-modifier)
[120.949655] Starting subtest: clobberred-modifier
[120.951386] Subtest clobberred-modifier: SUCCESS (0.000s)
[121.940844] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[122.069000] Starting subtest: framebuffer-vs-set-tiling
[122.070711] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[123.071782] [077/171] (890s left) kms_addfb_basic (invalid-get-prop)
[123.197322] Starting subtest: invalid-get-prop
[123.199086] Subtest invalid-get-prop: SUCCESS (0.000s)
[124.186877] [078/171] (889s left) kms_addfb_basic (invalid-get-prop-any)
[124.310580] Starting subtest: invalid-get-prop-any
[124.312377] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[125.317598] [079/171] (887s left) kms_addfb_basic (invalid-set-prop)
[125.441915] Starting subtest: invalid-set-prop
[125.443673] Subtest invalid-set-prop: SUCCESS (0.000s)
[126.448474] [080/171] (886s left) kms_addfb_basic (invalid-set-prop-any)
[126.574248] Starting subtest: invalid-set-prop-any
[126.575881] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[127.597211] [081/171] (885s left) kms_addfb_basic (no-handle)
[127.720766] Starting subtest: no-handle
[127.722613] Subtest no-handle: SUCCESS (0.000s)
[128.744115] [082/171] (884s left) kms_addfb_basic (size-max)
[129.402108] Starting subtest: size-max
[129.403933] Subtest size-max: SUCCESS (0.000s)
[129.875134] [083/171] (883s left) kms_addfb_basic (small-bo)
[130.529568] Starting subtest: small-bo
[130.531459] Subtest small-bo: SUCCESS (0.000s)
[131.006192] [084/171] (882s left) kms_addfb_basic (tile-pitch-mismatch)
[131.133315] Starting subtest: tile-pitch-mismatch
[131.134942] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[132.137227] [085/171] (881s left) kms_addfb_basic (too-high)
[132.792309] Starting subtest: too-high
[132.794445] Subtest too-high: SUCCESS (0.001s)
[133.284957] [086/171] (880s left) kms_addfb_basic (too-wide)
[133.957295] Starting subtest: too-wide
[133.959095] Subtest too-wide: SUCCESS (0.000s)
[134.432712] [087/171] (879s left) kms_addfb_basic (unused-handle)
[134.561052] Starting subtest: unused-handle
[134.562794] Subtest unused-handle: SUCCESS (0.000s)
[135.563534] [088/171] (877s left) kms_addfb_basic (unused-modifier)
[135.690079] Starting subtest: unused-modifier
[135.691688] Subtest unused-modifier: SUCCESS (0.000s)
[136.694839] [089/171] (876s left) kms_addfb_basic (unused-offsets)
[136.821734] Starting subtest: unused-offsets
[136.823378] Subtest unused-offsets: SUCCESS (0.000s)
[137.843044] [090/171] (875s left) kms_addfb_basic (unused-pitches)
[137.966842] Starting subtest: unused-pitches
[137.968786] Subtest unused-pitches: SUCCESS (0.000s)
[138.973303] [091/171] (874s left) kms_busy (basic)
[139.649210] Starting subtest: basic
[139.650962] Starting dynamic subtest: flip
[140.385664] Dynamic subtest flip: SUCCESS (0.734s)
[140.402759] Starting dynamic subtest: modeset
[141.165892] Dynamic subtest modeset: SUCCESS (0.780s)
[141.168373] Subtest basic: SUCCESS (1.519s)
[141.723103] [092/171] (871s left) kms_chamelium_hpd (dp-hpd-fast)
[142.502085] Subtest dp-hpd-fast: SKIP (0.000s)
[142.846544] [093/171] (870s left) kms_chamelium_edid (dp-edid-read)
[143.672973] Subtest dp-edid-read: SKIP (0.000s)
[143.997357] [094/171] (869s left) kms_chamelium_frames (dp-crc-fast)
[144.759061] Subtest dp-crc-fast: SKIP (0.000s)
[145.117057] [095/171] (868s left) kms_chamelium_hpd (hdmi-hpd-fast)
[145.861935] Subtest hdmi-hpd-fast: SKIP (0.000s)
[146.196503] [096/171] (867s left) kms_chamelium_edid (hdmi-edid-read)
[147.023996] Subtest hdmi-edid-read: SKIP (0.000s)
[147.398488] [097/171] (866s left) kms_chamelium_frames (hdmi-crc-fast)
[148.298269] Subtest hdmi-crc-fast: SKIP (0.000s)
[148.646610] [098/171] (865s left) kms_chamelium_hpd (vga-hpd-fast)
[149.440706] Subtest vga-hpd-fast: SKIP (0.000s)
[149.817837] [099/171] (864s left) kms_chamelium_edid (vga-edid-read)
[150.612810] Subtest vga-edid-read: SKIP (0.000s)
[150.975442] [100/171] (862s left) kms_prop_blob (basic)
[151.105987] Starting subtest: basic
[151.107991] Subtest basic: SUCCESS (0.000s)
[151.171817] [101/171] (862s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[151.860019] Starting subtest: basic-busy-flip-before-cursor-atomic
[152.925571] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.061s)
[153.462461] [102/171] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[154.150605] Starting subtest: basic-busy-flip-before-cursor-legacy
[155.195322] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.047s)
[155.757686] [103/171] (858s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[156.443873] Starting subtest: basic-flip-after-cursor-atomic
[157.490991] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.046s)
[158.063560] [104/171] (855s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[158.831626] Starting subtest: basic-flip-after-cursor-legacy
[159.865287] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.033s)
[160.422532] [105/171] (853s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[161.092679] Starting subtest: basic-flip-after-cursor-varying-size
[162.145219] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.060s)
[162.694255] [106/171] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[163.386684] Starting subtest: basic-flip-before-cursor-atomic
[164.413319] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.032s)
[164.969675] [107/171] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[165.653669] Starting subtest: basic-flip-before-cursor-legacy
[166.706903] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.053s)
[167.247585] [108/171] (846s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[167.937688] Starting subtest: basic-flip-before-cursor-varying-size
[168.987101] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.057s)
[169.532582] [109/171] (844s left) kms_flip (basic-flip-vs-dpms)
[170.060243] Starting subtest: basic-flip-vs-dpms
[170.061878] Starting dynamic subtest: A-VGA1
[170.879125] Dynamic subtest A-VGA1: SUCCESS (0.823s)
[170.897567] Starting dynamic subtest: B-VGA1
[171.601513] Dynamic subtest B-VGA1: SUCCESS (0.714s)
[171.620339] Starting dynamic subtest: A-HDMI-A1
[172.383913] Dynamic subtest A-HDMI-A1: SUCCESS (0.775s)
[172.399541] Starting dynamic subtest: B-HDMI-A1
[173.165686] Dynamic subtest B-HDMI-A1: SUCCESS (0.780s)
[173.167376] Subtest basic-flip-vs-dpms: SUCCESS (3.106s)
[173.751180] [110/171] (840s left) kms_flip (basic-flip-vs-modeset)
[174.280221] Starting subtest: basic-flip-vs-modeset
[174.281847] Starting dynamic subtest: A-VGA1
[175.080309] Dynamic subtest A-VGA1: SUCCESS (0.803s)
[175.093902] Starting dynamic subtest: B-VGA1
[175.750761] Dynamic subtest B-VGA1: SUCCESS (0.672s)
[175.766681] Starting dynamic subtest: A-HDMI-A1
[176.479663] Dynamic subtest A-HDMI-A1: SUCCESS (0.723s)
[176.497619] Starting dynamic subtest: B-HDMI-A1
[177.209930] Dynamic subtest B-HDMI-A1: SUCCESS (0.722s)
[177.211598] Subtest basic-flip-vs-modeset: SUCCESS (2.930s)
[177.772028] [111/171] (836s left) kms_flip (basic-flip-vs-wf_vblank)
[178.303259] Starting subtest: basic-flip-vs-wf_vblank
[178.304900] Starting dynamic subtest: A-VGA1
[179.398403] Dynamic subtest A-VGA1: SUCCESS (1.098s)
[179.414604] Starting dynamic subtest: B-VGA1
[180.404206] Dynamic subtest B-VGA1: SUCCESS (1.005s)
[180.420627] Starting dynamic subtest: A-HDMI-A1
[181.637082] Dynamic subtest A-HDMI-A1: SUCCESS (1.227s)
[181.651472] Starting dynamic subtest: B-HDMI-A1
[182.923282] Dynamic subtest B-HDMI-A1: SUCCESS (1.275s)
[182.924919] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.611s)
[183.548556] [112/171] (830s left) kms_flip (basic-plain-flip)
[184.065474] Starting subtest: basic-plain-flip
[184.067111] Starting dynamic subtest: A-VGA1
[184.878670] Dynamic subtest A-VGA1: SUCCESS (0.817s)
[184.892666] Starting dynamic subtest: B-VGA1
[185.608406] Dynamic subtest B-VGA1: SUCCESS (0.708s)
[185.632456] Starting dynamic subtest: A-HDMI-A1
[186.347172] Dynamic subtest A-HDMI-A1: SUCCESS (0.740s)
[186.363669] Starting dynamic subtest: B-HDMI-A1
[187.175099] Dynamic subtest B-HDMI-A1: SUCCESS (0.813s)
[187.176753] Subtest basic-plain-flip: SUCCESS (3.115s)
[187.814486] [113/171] (826s left) kms_force_connector_basic (force-connector-state)
[188.009406] Starting subtest: force-connector-state
[188.847698] Subtest force-connector-state: SUCCESS (0.837s)
[189.617612] [114/171] (824s left) kms_force_connector_basic (force-edid)
[189.810589] Starting subtest: force-edid
[190.137265] Subtest force-edid: SUCCESS (0.328s)
[190.814553] [115/171] (823s left) kms_force_connector_basic (force-load-detect)
[191.007986] Starting subtest: force-load-detect
[191.230548] Subtest force-load-detect: SUCCESS (0.221s)
[191.778163] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes)
[191.970504] Starting subtest: prune-stale-modes
[192.293063] Subtest prune-stale-modes: SUCCESS (0.323s)
[192.975755] [117/171] (821s left) kms_frontbuffer_tracking (basic)
[193.685277] Starting subtest: basic
[193.978765] Subtest basic: SKIP (0.288s)
[194.473055] [118/171] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[195.152645] Starting subtest: compare-crc-sanitycheck
[195.154478] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.534602] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.379s)
[195.552735] Starting dynamic subtest: pipe-B-HDMI-A-1
[195.988405] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.435s)
[195.990096] Subtest compare-crc-sanitycheck: SUCCESS (0.830s)
[196.527632] [119/171] (817s left) kms_pipe_crc_basic (hang-read-crc)
[197.206693] Starting subtest: hang-read-crc
[197.208379] Starting dynamic subtest: pipe-A-HDMI-A-1
[198.269870] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.067s)
[198.291682] Starting dynamic subtest: pipe-B-HDMI-A-1
[199.430568] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.156s)
[199.432397] Subtest hang-read-crc: SUCCESS (2.229s)
[199.995861] [120/171] (814s left) kms_pipe_crc_basic (nonblocking-crc)
[200.684216] Starting subtest: nonblocking-crc
[200.685890] Starting dynamic subtest: pipe-A-HDMI-A-1
[201.254425] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.574s)
[201.271595] Starting dynamic subtest: pipe-B-HDMI-A-1
[201.898943] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.642s)
[201.900859] Subtest nonblocking-crc: SUCCESS (1.220s)
[202.488228] [121/171] (811s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[203.211942] Starting subtest: nonblocking-crc-frame-sequence
[203.273149] Starting dynamic subtest: pipe-A-HDMI-A-1
[203.732409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.558s)
[203.750628] Starting dynamic subtest: pipe-B-HDMI-A-1
[204.379382] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.645s)
[204.381531] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.207s)
[204.922448] [122/171] (809s left) kms_pipe_crc_basic (read-crc)
[205.617631] Starting subtest: read-crc
[205.619743] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.113810] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.502s)
[206.132615] Starting dynamic subtest: pipe-B-HDMI-A-1
[206.688567] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.570s)
[206.690309] Subtest read-crc: SUCCESS (1.079s)
[207.235268] [123/171] (807s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[207.919611] Starting subtest: read-crc-frame-sequence
[207.921460] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.408878] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.493s)
[208.426616] Starting dynamic subtest: pipe-B-HDMI-A-1
[208.986926] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.575s)
[208.988860] Subtest read-crc-frame-sequence: SUCCESS (1.073s)
[209.530252] [124/171] (805s left) kms_psr (primary_page_flip)
[209.663197] Subtest primary_page_flip: SKIP (0.000s)
[209.699430] [125/171] (804s left) kms_psr (cursor_plane_move)
[209.835679] Subtest cursor_plane_move: SKIP (0.000s)
[209.899269] [126/171] (804s left) kms_psr (sprite_plane_onoff)
[210.025457] Subtest sprite_plane_onoff: SKIP (0.000s)
[210.065570] [127/171] (804s left) kms_psr (primary_mmap_gtt)
[210.194230] Subtest primary_mmap_gtt: SKIP (0.000s)
[210.231750] [128/171] (804s left) kms_setmode (basic-clone-single-crtc)
[210.361205] Starting subtest: basic-clone-single-crtc
[210.366330] Subtest basic-clone-single-crtc: SKIP (0.001s)
[210.427761] [129/171] (804s left) i915_pm_backlight (basic-brightness)
[211.095653] Subtest basic-brightness: SKIP (0.000s)
[211.379434] [130/171] (803s left) i915_pm_rpm (basic-pci-d3-state)
[223.400268] Subtest basic-pci-d3-state: SKIP (0.000s)
[223.671655] [131/171] (791s left) i915_pm_rpm (basic-rte)
[223.797210] Starting subtest: basic-rte
[235.701550] Subtest basic-rte: SKIP (11.887s)
[235.966618] [132/171] (778s left) i915_pm_rps (basic-api)
[236.098625] Subtest basic-api: SKIP (0.000s)
[236.151487] [133/171] (778s left) prime_self_import (basic-llseek-bad)
[236.273277] Starting subtest: basic-llseek-bad
[236.275282] Subtest basic-llseek-bad: SUCCESS (0.002s)
[236.363743] [134/171] (778s left) prime_self_import (basic-llseek-size)
[236.488422] Starting subtest: basic-llseek-size
[236.490791] Subtest basic-llseek-size: SUCCESS (0.003s)
[236.561167] [135/171] (778s left) prime_self_import (basic-with_fd_dup)
[236.682522] Starting subtest: basic-with_fd_dup
[236.684386] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[236.763253] [136/171] (778s left) prime_self_import (basic-with_one_bo)
[236.888341] Starting subtest: basic-with_one_bo
[236.889992] Subtest basic-with_one_bo: SUCCESS (0.003s)
[236.966926] [137/171] (777s left) prime_self_import (basic-with_one_bo_two_files)
[237.089972] Starting subtest: basic-with_one_bo_two_files
[237.091696] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[237.161864] [138/171] (777s left) prime_self_import (basic-with_two_bos)
[237.284349] Starting subtest: basic-with_two_bos
[237.286141] Subtest basic-with_two_bos: SUCCESS (0.003s)
[237.359278] [139/171] (777s left) prime_vgem (basic-fence-flip)
[237.507895] Starting subtest: basic-fence-flip
[238.584721] Subtest basic-fence-flip: SUCCESS (1.077s)
[239.179755] [140/171] (775s left) prime_vgem (basic-fence-mmap)
[239.328317] Starting subtest: basic-fence-mmap
[239.368865] Subtest basic-fence-mmap: SUCCESS (0.040s)
[239.446593] [141/171] (775s left) prime_vgem (basic-fence-read)
[239.573810] Starting subtest: basic-fence-read
[239.641209] Subtest basic-fence-read: SUCCESS (0.067s)
[239.714502] [142/171] (775s left) prime_vgem (basic-gtt)
[239.863026] Starting subtest: basic-gtt
[239.881587] Subtest basic-gtt: SUCCESS (0.018s)
[239.964452] [143/171] (775s left) prime_vgem (basic-read)
[240.113465] Starting subtest: basic-read
[240.137139] Subtest basic-read: SUCCESS (0.030s)
[240.213770] [144/171] (774s left) prime_vgem (basic-write)
[240.340597] Starting subtest: basic-write
[240.370866] Subtest basic-write: SUCCESS (0.031s)
[240.447478] [145/171] (774s left) prime_vgem (basic-userptr)
[240.591447] Starting subtest: basic-userptr
[240.605762] Subtest basic-userptr: SKIP (0.013s)
[240.683540] [146/171] (774s left) vgem_basic (setversion)
[240.817259] Starting subtest: setversion
[240.821246] Subtest setversion: SUCCESS (0.000s)
[240.880626] [147/171] (774s left) vgem_basic (create)
[241.016846] Starting subtest: create
[241.019028] Subtest create: SUCCESS (0.000s)
[241.080140] [148/171] (774s left) vgem_basic (debugfs)
[241.217482] Starting subtest: debugfs
[241.219621] Subtest debugfs: SUCCESS (0.001s)
[241.278988] [149/171] (773s left) vgem_basic (dmabuf-export)
[241.421771] Starting subtest: dmabuf-export
[241.423803] Subtest dmabuf-export: SUCCESS (0.004s)
[241.493439] [150/171] (773s left) vgem_basic (dmabuf-fence)
[241.632164] Starting subtest: dmabuf-fence
[241.634213] Subtest dmabuf-fence: SUCCESS (0.002s)
[241.692816] [151/171] (773s left) vgem_basic (dmabuf-fence-before)
[241.833083] Starting subtest: dmabuf-fence-before
[241.835248] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[241.893765] [152/171] (773s left) vgem_basic (dmabuf-mmap)
[242.032685] Starting subtest: dmabuf-mmap
[242.054843] Subtest dmabuf-mmap: SUCCESS (0.024s)
[242.111580] [153/171] (773s left) vgem_basic (mmap)
[242.247232] Starting subtest: mmap
[242.265542] Subtest mmap: SUCCESS (0.018s)
[242.326636] [154/171] (772s left) vgem_basic (second-client)
[242.463712] Starting subtest: second-client
[242.513083] Subtest second-client: SUCCESS (0.049s)
[242.576978] [155/171] (772s left) vgem_basic (sysfs)
[242.713128] Starting subtest: sysfs
[242.715065] Subtest sysfs: SUCCESS (0.002s)
[242.776139] [156/171] (772s left) core_hotunplug (unbind-rebind)
[242.964935] Starting subtest: unbind-rebind
[244.423790] Subtest unbind-rebind: SUCCESS (1.422s)
[244.526233] [157/171] (770s left) vgem_basic (unload)
[244.762216] Starting subtest: unload
[273.677363] Subtest unload: SUCCESS (28.949s)
[273.788827] [158/171] (741s left) i915_module_load (reload)
[273.911329] Starting subtest: reload
[276.592054] Subtest reload: SUCCESS (2.677s)
[276.647920] [159/171] (738s left) gem_lmem_swapping (basic)
[276.926579] Subtest basic: SKIP (0.000s)
[276.966690] [160/171] (738s left) gem_lmem_swapping (parallel-random-engines)
[277.098639] Subtest parallel-random-engines: SKIP (0.000s)
[277.133313] [161/171] (738s left) gem_lmem_swapping (random-engines)
[277.265482] Subtest random-engines: SKIP (0.000s)
[277.301596] [162/171] (738s left) gem_lmem_swapping (verify-random)
[277.429918] Subtest verify-random: SKIP (0.000s)
[277.468948] [163/171] (738s left) i915_pm_rpm (module-reload)
[289.501288] Subtest module-reload: SKIP (0.000s)
[289.774855] [164/171] (725s left) i915_selftest (live)
[290.673155] Starting subtest: live
[290.675880] Starting dynamic subtest: sanitycheck
[291.480089] Dynamic subtest sanitycheck: SUCCESS (0.807s)
[291.488944] Starting dynamic subtest: uncore
[292.192189] Dynamic subtest uncore: SUCCESS (0.711s)
[292.199971] Starting dynamic subtest: workarounds
[292.941465] Dynamic subtest workarounds: SUCCESS (0.748s)
[292.951141] Starting dynamic subtest: gt_engines
[293.675747] Dynamic subtest gt_engines: SUCCESS (0.733s)
[293.686821] Starting dynamic subtest: gt_timelines
[298.734092] Dynamic subtest gt_timelines: SUCCESS (5.057s)
[298.745702] Starting dynamic subtest: gt_contexts
[299.475112] Dynamic subtest gt_contexts: SUCCESS (0.739s)
[299.486174] Starting dynamic subtest: gt_lrc
[300.282083] Dynamic subtest gt_lrc: SUCCESS (0.806s)
[300.294194] Starting dynamic subtest: gt_mocs
[301.052125] Dynamic subtest gt_mocs: SUCCESS (0.768s)
[301.063499] Starting dynamic subtest: gt_pm
[302.270042] Dynamic subtest gt_pm: SUCCESS (1.216s)
[302.281389] Starting dynamic subtest: gt_heartbeat
[303.042100] Dynamic subtest gt_heartbeat: SUCCESS (0.770s)
[303.053932] Starting dynamic subtest: gt_tlb
[303.797999] Dynamic subtest gt_tlb: SUCCESS (0.754s)
[303.809181] Starting dynamic subtest: requests
[308.122243] Dynamic subtest requests: SUCCESS (4.322s)
[308.133695] Starting dynamic subtest: migrate
[308.838422] Dynamic subtest migrate: SUCCESS (0.715s)
[308.848128] Starting dynamic subtest: active
[309.564596] Dynamic subtest active: SUCCESS (0.725s)
[309.575841] Starting dynamic subtest: objects
[311.706975] Dynamic subtest objects: SUCCESS (2.140s)
[311.719182] Starting dynamic subtest: mman
[317.731902] Dynamic subtest mman: SUCCESS (6.023s)
[317.743864] Starting dynamic subtest: dmabuf
[318.482526] Dynamic subtest dmabuf: SUCCESS (0.749s)
[318.492702] Starting dynamic subtest: vma
[319.183219] Dynamic subtest vma: SUCCESS (0.699s)
[319.191412] Starting dynamic subtest: coherency
[320.998039] Dynamic subtest coherency: SUCCESS (1.812s)
[321.009170] Starting dynamic subtest: gtt
[325.062098] Dynamic subtest gtt: SUCCESS (4.064s)
[325.074000] Starting dynamic subtest: gem
[325.922998] Dynamic subtest gem: SUCCESS (0.860s)
[325.935714] Starting dynamic subtest: evict
[326.720186] Dynamic subtest evict: SUCCESS (0.796s)
[326.731316] Starting dynamic subtest: hugepages
[327.469481] Dynamic subtest hugepages: SUCCESS (0.748s)
[327.478099] Starting dynamic subtest: gem_contexts
[331.341289] Dynamic subtest gem_contexts: SUCCESS (3.871s)
[331.352043] Starting dynamic subtest: client
[332.052528] Dynamic subtest client: SUCCESS (0.710s)
[332.064787] Starting dynamic subtest: gem_migrate
[332.769456] Dynamic subtest gem_migrate: SUCCESS (0.716s)
[332.777933] Starting dynamic subtest: reset
[333.680097] Dynamic subtest reset: SUCCESS (0.909s)
[333.691472] Starting dynamic subtest: memory_region
[334.442132] Dynamic subtest memory_region: SUCCESS (0.760s)
[334.454513] Starting dynamic subtest: hangcheck
[336.747081] Dynamic subtest hangcheck: SUCCESS (2.304s)
[336.758916] Starting dynamic subtest: execlists
[337.544109] Dynamic subtest execlists: SUCCESS (0.795s)
[337.556435] Starting dynamic subtest: ring_submission
[338.269183] Dynamic subtest ring_submission: SUCCESS (0.724s)
[338.280897] Starting dynamic subtest: perf
[338.971056] Dynamic subtest perf: SUCCESS (0.701s)
[338.982894] Starting dynamic subtest: slpc
[339.716670] Dynamic subtest slpc: SUCCESS (0.744s)
[339.728173] Starting dynamic subtest: guc
[340.469968] Dynamic subtest guc: SUCCESS (0.752s)
[340.482416] Starting dynamic subtest: guc_multi_lrc
[341.189232] Dynamic subtest guc_multi_lrc: SUCCESS (0.718s)
[341.201202] Starting dynamic subtest: guc_hang
[341.913153] Dynamic subtest guc_hang: SUCCESS (0.723s)
[341.925161] Starting dynamic subtest: late_gt_pm
[342.678366] Dynamic subtest late_gt_pm: SUCCESS (0.764s)
[342.680401] Subtest live: SUCCESS (52.006s)
[342.825395] [165/171] (672s left) dmabuf (all-tests)
[342.966779] Starting subtest: all-tests
[342.968644] Starting dynamic subtest: sanitycheck
[343.018681] Dynamic subtest sanitycheck: SUCCESS (0.058s)
[343.030796] Starting dynamic subtest: dma_fence
[343.195548] Dynamic subtest dma_fence: SUCCESS (0.176s)
[343.214177] Starting dynamic subtest: dma_fence_chain
[360.275099] Dynamic subtest dma_fence_chain: SUCCESS (17.077s)
[360.288863] Starting dynamic subtest: dma_fence_unwrap
[360.330450] Dynamic subtest dma_fence_unwrap: SUCCESS (0.053s)
[360.344465] Starting dynamic subtest: dma_resv
[360.397463] Dynamic subtest dma_resv: SUCCESS (0.067s)
[360.399795] Subtest all-tests: SUCCESS (17.438s)
[360.422908] [166/171] (655s left) i915_suspend (basic-s2idle-without-i915)
[360.544736] Starting subtest: basic-s2idle-without-i915
[380.215887] Subtest basic-s2idle-without-i915: SUCCESS (3.600s)
[382.382172] [167/171] (651s left) i915_suspend (basic-s3-without-i915)
[382.517082] Starting subtest: basic-s3-without-i915
[400.400051] Subtest basic-s3-without-i915: SUCCESS (2.562s)
[406.947217] [168/171] (648s left) gem_exec_suspend (basic-s0)
[407.109607] Starting subtest: basic-S0
[407.113051] Starting dynamic subtest: smem
[424.543778] Dynamic subtest smem: SUCCESS (7.172s)
[424.545458] Subtest basic-S0: SUCCESS (7.173s)
[427.728123] [169/171] (640s left) gem_exec_suspend (basic-s3)
[427.864891] Starting subtest: basic-S3
[427.867318] Starting dynamic subtest: smem
[444.736629] Dynamic subtest smem: SUCCESS (1.998s)
[444.738274] Subtest basic-S3: SUCCESS (1.999s)
[452.926733] [170/171] (638s left) kms_chamelium_hpd (common-hpd-after-suspend)
[453.713990] Subtest common-hpd-after-suspend: SKIP (0.000s)
[454.077167] [171/171] (637s left) kms_pipe_crc_basic (suspend-read-crc)
[454.772479] Starting subtest: suspend-read-crc
[454.775495] Starting dynamic subtest: pipe-A-HDMI-A-1
[471.965275] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.125s)
[471.986779] Starting dynamic subtest: pipe-B-HDMI-A-1
[489.931690] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.146s)
[489.933947] Subtest suspend-read-crc: SUCCESS (4.277s)
[496.851782] Closing watchdogs
Done.