[48.035489] Initializing watchdogs
[48.035895]   /dev/watchdog0
[48.055594] [001/165] (960s left) i915_module_load (load)
[48.315654] Starting subtest: load
[51.881293] Subtest load: SUCCESS (3.564s)
[51.986645] [002/165] (956s left) core_auth (basic-auth)
[52.498575] Starting subtest: basic-auth
[52.521962] Subtest basic-auth: SUCCESS (0.013s)
[52.712641] [003/165] (956s left) debugfs_test (read_all_entries)
[53.033654] Starting subtest: read_all_entries
[53.211950] Subtest read_all_entries: SUCCESS (0.179s)
[53.741969] [004/165] (955s left) debugfs_test (basic-hwmon)
[53.982097] Starting subtest: basic-hwmon
[53.988924] Subtest basic-hwmon: SKIP (0.000s)
[54.493742] [005/165] (954s left) fbdev (eof)
[54.730560] Starting subtest: eof
[54.739046] Subtest eof: SUCCESS (0.008s)
[54.868783] [006/165] (954s left) fbdev (info)
[55.242755] Starting subtest: info
[55.248114] Subtest info: SUCCESS (0.000s)
[55.406275] [007/165] (953s left) fbdev (nullptr)
[55.827971] Starting subtest: nullptr
[55.832557] Subtest nullptr: SUCCESS (0.000s)
[55.981395] [008/165] (953s left) fbdev (read)
[56.461559] Starting subtest: read
[58.818034] Subtest read: SUCCESS (2.348s)
[58.902317] [009/165] (950s left) fbdev (write)
[59.133059] Starting subtest: write
[60.198093] Subtest write: SUCCESS (1.062s)
[60.274163] [010/165] (949s left) gem_basic (bad-close)
[60.493728] Starting subtest: bad-close
[60.501550] Subtest bad-close: SUCCESS (0.000s)
[60.598367] [011/165] (948s left) gem_basic (create-close)
[60.828595] Starting subtest: create-close
[60.832585] Subtest create-close: SUCCESS (0.000s)
[60.928349] [012/165] (948s left) gem_basic (create-fd-close)
[61.152832] Starting subtest: create-fd-close
[61.159205] Subtest create-fd-close: SUCCESS (0.000s)
[61.269697] [013/165] (948s left) gem_busy (busy@all-engines)
[61.639677] Starting subtest: busy
[61.641476] Starting dynamic subtest: all-engines
[61.847481] Dynamic subtest all-engines: SUCCESS (0.209s)
[61.848927] Subtest busy: SUCCESS (0.211s)
[62.262947] [014/165] (947s left) gem_close_race (basic-process)
[62.563871] Starting subtest: basic-process
[62.706215] Subtest basic-process: SUCCESS (0.141s)
[62.944452] [015/165] (946s left) gem_close_race (basic-threads)
[63.275912] Starting subtest: basic-threads
[64.535565] Subtest basic-threads: SUCCESS (1.260s)
[64.767069] [016/165] (944s left) gem_ctx_create (basic)
[65.035583] Starting subtest: basic
[65.038517] Subtest basic: SUCCESS (0.000s)
[65.260184] [017/165] (944s left) gem_ctx_create (basic-files)
[65.557565] Starting subtest: basic-files
[67.619078] Subtest basic-files: SUCCESS (2.061s)
[67.929444] [018/165] (941s left) gem_ctx_exec (basic)
[68.174838] Starting subtest: basic
[68.188851] Subtest basic: SUCCESS (0.013s)
[68.293669] [019/165] (941s left) gem_exec_basic (basic)
[68.545995] Starting subtest: basic
[68.548503] Starting dynamic subtest: rcs0-smem
[68.552596] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[68.576506] Starting dynamic subtest: bcs0-smem
[68.578545] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[68.596405] Starting dynamic subtest: vcs0-smem
[68.597927] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[68.615578] Starting dynamic subtest: vecs0-smem
[68.617129] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[68.618520] Subtest basic: SUCCESS (0.017s)
[68.796659] [020/165] (941s left) gem_exec_create (basic)
[69.059365] Starting subtest: basic
[69.063941] Starting dynamic subtest: smem
[71.148139] Dynamic subtest smem: SUCCESS (2.087s)
[71.151885] Subtest basic: SUCCESS (2.088s)
[71.384190] [021/165] (938s left) gem_exec_fence (basic-busy)
[71.819731] Starting subtest: basic-busy
[71.821529] Starting dynamic subtest: rcs0
[71.839127] Dynamic subtest rcs0: SUCCESS (0.024s)
[71.877456] Starting dynamic subtest: bcs0
[71.886097] Dynamic subtest bcs0: SUCCESS (0.025s)
[71.919131] Starting dynamic subtest: vcs0
[71.921654] Dynamic subtest vcs0: SUCCESS (0.021s)
[71.938456] Starting dynamic subtest: vecs0
[71.941078] Dynamic subtest vecs0: SUCCESS (0.023s)
[71.942429] Subtest basic-busy: SUCCESS (0.095s)
[72.745576] [022/165] (937s left) gem_exec_fence (basic-wait)
[73.205637] Starting subtest: basic-wait
[73.207662] Starting dynamic subtest: rcs0
[73.225536] Dynamic subtest rcs0: SUCCESS (0.022s)
[73.270270] Starting dynamic subtest: bcs0
[73.274930] Dynamic subtest bcs0: SUCCESS (0.026s)
[73.328942] Starting dynamic subtest: vcs0
[73.332591] Dynamic subtest vcs0: SUCCESS (0.029s)
[73.367652] Starting dynamic subtest: vecs0
[73.370200] Dynamic subtest vecs0: SUCCESS (0.035s)
[73.371842] Subtest basic-wait: SUCCESS (0.117s)
[73.981203] [023/165] (935s left) gem_exec_fence (basic-await)
[74.406372] Starting subtest: basic-await
[74.408239] Starting dynamic subtest: rcs0
[74.595689] Dynamic subtest rcs0: SUCCESS (0.188s)
[74.619608] Starting dynamic subtest: bcs0
[74.777528] Dynamic subtest bcs0: SUCCESS (0.181s)
[74.799979] Starting dynamic subtest: vcs0
[74.955426] Dynamic subtest vcs0: SUCCESS (0.178s)
[74.977585] Starting dynamic subtest: vecs0
[75.136790] Dynamic subtest vecs0: SUCCESS (0.181s)
[75.138713] Subtest basic-await: SUCCESS (0.734s)
[75.808896] [024/165] (934s left) gem_exec_fence (nb-await)
[76.237362] Starting subtest: nb-await
[76.240238] Starting dynamic subtest: rcs0
[76.320208] Dynamic subtest rcs0: SUCCESS (0.083s)
[76.345710] Starting dynamic subtest: bcs0
[76.400688] Dynamic subtest bcs0: SUCCESS (0.082s)
[76.424647] Starting dynamic subtest: vcs0
[76.489211] Dynamic subtest vcs0: SUCCESS (0.083s)
[76.510402] Starting dynamic subtest: vecs0
[76.574983] Dynamic subtest vecs0: SUCCESS (0.089s)
[76.576744] Subtest nb-await: SUCCESS (0.340s)
[77.222494] [025/165] (932s left) gem_exec_gttfill (basic)
[77.494060] Starting subtest: basic
[79.370531] Subtest basic: SKIP (1.860s)
[79.619483] [026/165] (930s left) gem_exec_parallel (engines)
[80.055759] Starting subtest: engines
[80.058142] Starting dynamic subtest: basic
[84.968831] Dynamic subtest basic: SUCCESS (4.919s)
[84.994903] Starting dynamic subtest: contexts
[93.536833] Dynamic subtest contexts: SUCCESS (8.564s)
[93.574941] Starting dynamic subtest: fds
[106.571147] Dynamic subtest fds: SUCCESS (13.037s)
[106.601463] Starting dynamic subtest: userptr
[111.969994] Dynamic subtest userptr: SUCCESS (5.399s)
[111.971852] Subtest engines: SUCCESS (31.921s)
[112.241157] [027/165] (898s left) gem_exec_store (basic)
[112.516492] Starting subtest: basic
[112.585496] Subtest basic: SUCCESS (0.071s)
[112.823555] [028/165] (897s left) gem_flink_basic (bad-flink)
[113.061303] Starting subtest: bad-flink
[113.063866] Subtest bad-flink: SUCCESS (0.000s)
[113.163382] [029/165] (897s left) gem_flink_basic (bad-open)
[113.381493] Starting subtest: bad-open
[113.384678] Subtest bad-open: SUCCESS (0.000s)
[113.484542] [030/165] (896s left) gem_flink_basic (basic)
[113.706160] Starting subtest: basic
[113.707650] Subtest basic: SUCCESS (0.000s)
[113.817547] [031/165] (896s left) gem_flink_basic (double-flink)
[114.048480] Starting subtest: double-flink
[114.050612] Subtest double-flink: SUCCESS (0.000s)
[114.145627] [032/165] (896s left) gem_flink_basic (flink-lifetime)
[114.373836] Starting subtest: flink-lifetime
[114.376091] Subtest flink-lifetime: SUCCESS (0.005s)
[114.480167] [033/165] (896s left) gem_huc_copy (huc-copy)
[114.719950] Subtest huc-copy: SKIP (0.000s)
[114.788404] [034/165] (895s left) gem_linear_blits (basic)
[115.355669] Subtest basic: SKIP (0.000s)
[115.496304] [035/165] (895s left) gem_mmap (basic)
[115.878062] Starting subtest: basic
[115.891163] Subtest basic: SUCCESS (0.001s)
[115.983529] [036/165] (894s left) gem_mmap_gtt (basic)
[116.210619] Starting subtest: basic
[116.212403] Subtest basic: SUCCESS (0.003s)
[116.306240] [037/165] (894s left) gem_render_linear_blits (basic)
[116.544850] Starting subtest: basic
[116.659279] Subtest basic: SUCCESS (0.107s)
[116.739424] [038/165] (894s left) gem_render_tiled_blits (basic)
[116.979301] Starting subtest: basic
[117.114178] Subtest basic: SUCCESS (0.124s)
[117.188394] [039/165] (893s left) gem_ringfill (basic-all)
[117.622600] Starting subtest: basic-all
[118.911057] Subtest basic-all: SUCCESS (1.281s)
[119.014877] [040/165] (891s left) gem_softpin (allocator-basic)
[119.260504] Starting subtest: allocator-basic
[119.560058] Subtest allocator-basic: SUCCESS (0.295s)
[119.731560] [041/165] (891s left) gem_softpin (allocator-basic-reserve)
[119.965701] Starting subtest: allocator-basic-reserve
[120.274202] Subtest allocator-basic-reserve: SUCCESS (0.291s)
[120.416153] [042/165] (890s left) gem_softpin (safe-alignment)
[120.660517] Starting subtest: safe-alignment
[120.710089] Subtest safe-alignment: SUCCESS (0.048s)
[120.836909] [043/165] (890s left) gem_sync (basic-all)
[121.119820] Starting subtest: basic-all
[123.840475] Subtest basic-all: SUCCESS (2.722s)
[124.080194] [044/165] (887s left) gem_sync (basic-each)
[124.351582] Starting subtest: basic-each
[127.171761] Subtest basic-each: SUCCESS (2.821s)
[127.416046] [045/165] (883s left) gem_tiled_blits (basic)
[127.919283] Subtest basic: SKIP (0.000s)
[128.004288] [046/165] (883s left) gem_tiled_fence_blits (basic)
[128.651254] Starting subtest: basic
[128.703143] Subtest basic: SUCCESS (0.052s)
[128.867139] [047/165] (882s left) gem_tiled_pread_basic
[130.080591] [048/165] (881s left) gem_wait (busy@all-engines)
[130.379256] Starting subtest: busy
[130.382662] Starting dynamic subtest: all-engines
[130.905097] Dynamic subtest all-engines: SUCCESS (0.527s)
[130.907525] Subtest busy: SUCCESS (0.528s)
[131.216849] [049/165] (880s left) gem_wait (wait@all-engines)
[131.518596] Starting subtest: wait
[131.520376] Starting dynamic subtest: all-engines
[132.566722] Dynamic subtest all-engines: SUCCESS (1.046s)
[132.568298] Subtest wait: SUCCESS (1.047s)
[132.879790] [050/165] (878s left) i915_getparams_basic (basic-eu-total)
[133.110084] Starting subtest: basic-eu-total
[133.113451] Subtest basic-eu-total: SUCCESS (0.000s)
[133.214191] [051/165] (878s left) i915_getparams_basic (basic-subslice-total)
[133.439286] Starting subtest: basic-subslice-total
[133.442994] Subtest basic-subslice-total: SUCCESS (0.000s)
[133.547268] [052/165] (878s left) i915_hangman (error-state-basic)
[133.814656] Starting subtest: error-state-basic
[133.846433] Subtest error-state-basic: SUCCESS (0.024s)
[133.955830] [053/165] (877s left) i915_pciid
[134.281567] [054/165] (877s left) kms_addfb_basic (addfb25-4-tiled)
[134.926785] Starting subtest: addfb25-4-tiled
[134.929679] Subtest addfb25-4-tiled: SUCCESS (0.003s)
[135.032629] [055/165] (876s left) kms_addfb_basic (addfb25-bad-modifier)
[135.264205] Starting subtest: addfb25-bad-modifier
[135.265892] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[135.800156] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[136.033975] Starting subtest: addfb25-framebuffer-vs-set-tiling
[136.036962] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[136.564740] [057/165] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[136.801628] Starting subtest: addfb25-modifier-no-flag
[136.803309] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[137.351106] [058/165] (874s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[137.578522] Starting subtest: addfb25-x-tiled-legacy
[137.580950] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[138.135917] [059/165] (873s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[138.365116] Starting subtest: addfb25-x-tiled-mismatch-legacy
[138.367973] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[138.899267] [060/165] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[139.556759] Starting subtest: addfb25-yf-tiled-legacy
[139.559201] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[139.664658] [061/165] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[140.340921] Starting subtest: addfb25-y-tiled-legacy
[140.344588] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[140.448592] [062/165] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[141.121063] Starting subtest: addfb25-y-tiled-small-legacy
[141.125552] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[141.215053] [063/165] (871s left) kms_addfb_basic (bad-pitch-0)
[141.504651] Starting subtest: bad-pitch-0
[141.507313] Subtest bad-pitch-0: SUCCESS (0.000s)
[142.065722] [064/165] (870s left) kms_addfb_basic (bad-pitch-1024)
[142.295296] Starting subtest: bad-pitch-1024
[142.299071] Subtest bad-pitch-1024: SUCCESS (0.000s)
[142.814779] [065/165] (869s left) kms_addfb_basic (bad-pitch-128)
[143.041104] Starting subtest: bad-pitch-128
[143.042926] Subtest bad-pitch-128: SUCCESS (0.000s)
[143.565500] [066/165] (868s left) kms_addfb_basic (bad-pitch-256)
[143.798109] Starting subtest: bad-pitch-256
[143.799635] Subtest bad-pitch-256: SUCCESS (0.000s)
[144.334487] [067/165] (868s left) kms_addfb_basic (bad-pitch-32)
[144.561487] Starting subtest: bad-pitch-32
[144.563456] Subtest bad-pitch-32: SUCCESS (0.000s)
[145.098719] [068/165] (867s left) kms_addfb_basic (bad-pitch-63)
[145.324764] Starting subtest: bad-pitch-63
[145.327315] Subtest bad-pitch-63: SUCCESS (0.000s)
[145.865121] [069/165] (866s left) kms_addfb_basic (bad-pitch-65536)
[146.100458] Starting subtest: bad-pitch-65536
[146.103339] Subtest bad-pitch-65536: SUCCESS (0.001s)
[146.615672] [070/165] (865s left) kms_addfb_basic (bad-pitch-999)
[146.848926] Starting subtest: bad-pitch-999
[146.855105] Subtest bad-pitch-999: SUCCESS (0.000s)
[147.397606] [071/165] (865s left) kms_addfb_basic (basic)
[147.624314] Starting subtest: basic
[147.627163] Subtest basic: SUCCESS (0.000s)
[148.148998] [072/165] (864s left) kms_addfb_basic (basic-x-tiled-legacy)
[148.378324] Starting subtest: basic-x-tiled-legacy
[148.380967] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[148.915026] [073/165] (863s left) kms_addfb_basic (basic-y-tiled-legacy)
[149.145915] Starting subtest: basic-y-tiled-legacy
[149.147952] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[149.663937] [074/165] (863s left) kms_addfb_basic (bo-too-small)
[150.305666] Starting subtest: bo-too-small
[150.309225] Subtest bo-too-small: SUCCESS (0.001s)
[150.413917] [075/165] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[151.084101] Starting subtest: bo-too-small-due-to-tiling
[151.090412] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[151.198486] [076/165] (861s left) kms_addfb_basic (clobberred-modifier)
[151.427662] Starting subtest: clobberred-modifier
[151.430984] Subtest clobberred-modifier: SUCCESS (0.000s)
[151.950490] [077/165] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[152.180941] Starting subtest: framebuffer-vs-set-tiling
[152.184567] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[152.733123] [078/165] (860s left) kms_addfb_basic (invalid-get-prop)
[152.964531] Starting subtest: invalid-get-prop
[152.967182] Subtest invalid-get-prop: SUCCESS (0.000s)
[153.481536] [079/165] (859s left) kms_addfb_basic (invalid-get-prop-any)
[153.711736] Starting subtest: invalid-get-prop-any
[153.717125] Subtest invalid-get-prop-any: SUCCESS (0.002s)
[154.247991] [080/165] (858s left) kms_addfb_basic (invalid-set-prop)
[154.477713] Starting subtest: invalid-set-prop
[154.479880] Subtest invalid-set-prop: SUCCESS (0.000s)
[155.013855] [081/165] (858s left) kms_addfb_basic (invalid-set-prop-any)
[155.240177] Starting subtest: invalid-set-prop-any
[155.243141] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[155.764876] [082/165] (857s left) kms_addfb_basic (no-handle)
[155.999265] Starting subtest: no-handle
[156.001035] Subtest no-handle: SUCCESS (0.000s)
[156.547692] [083/165] (856s left) kms_addfb_basic (size-max)
[157.193966] Starting subtest: size-max
[157.196573] Subtest size-max: SUCCESS (0.000s)
[157.299626] [084/165] (856s left) kms_addfb_basic (small-bo)
[157.962258] Starting subtest: small-bo
[157.966586] Subtest small-bo: SUCCESS (0.000s)
[158.082592] [085/165] (855s left) kms_addfb_basic (tile-pitch-mismatch)
[158.312678] Starting subtest: tile-pitch-mismatch
[158.314519] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[158.864486] [086/165] (854s left) kms_addfb_basic (too-high)
[159.516095] Starting subtest: too-high
[159.532369] Subtest too-high: SUCCESS (0.005s)
[159.632041] [087/165] (853s left) kms_addfb_basic (too-wide)
[160.291929] Starting subtest: too-wide
[160.293717] Subtest too-wide: SUCCESS (0.000s)
[160.398031] [088/165] (853s left) kms_addfb_basic (unused-handle)
[160.623292] Starting subtest: unused-handle
[160.625933] Subtest unused-handle: SUCCESS (0.000s)
[161.146637] [089/165] (852s left) kms_addfb_basic (unused-modifier)
[161.370392] Starting subtest: unused-modifier
[161.374558] Subtest unused-modifier: SUCCESS (0.000s)
[161.882929] [090/165] (851s left) kms_addfb_basic (unused-offsets)
[162.110526] Starting subtest: unused-offsets
[162.113106] Subtest unused-offsets: SUCCESS (0.000s)
[162.648852] [091/165] (851s left) kms_addfb_basic (unused-pitches)
[162.867356] Starting subtest: unused-pitches
[162.872646] Subtest unused-pitches: SUCCESS (0.000s)
[163.414797] [092/165] (850s left) kms_busy (basic)
[164.067979] Starting subtest: basic
[164.074750] Starting dynamic subtest: flip
[165.233122] Dynamic subtest flip: SUCCESS (1.141s)
[165.292174] Starting dynamic subtest: modeset
[167.474052] Dynamic subtest modeset: SUCCESS (2.240s)
[167.478076] Subtest basic: SUCCESS (3.390s)
[168.030355] [093/165] (845s left) kms_prop_blob (basic)
[168.259605] Starting subtest: basic
[168.263438] Subtest basic: SUCCESS (0.000s)
[168.360611] [094/165] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[169.055408] Starting subtest: basic-busy-flip-before-cursor-atomic
[170.279642] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.222s)
[170.753891] [095/165] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[171.448980] Starting subtest: basic-busy-flip-before-cursor-legacy
[172.729433] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.268s)
[173.239682] [096/165] (840s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[173.920384] Starting subtest: basic-flip-after-cursor-atomic
[175.119095] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.201s)
[175.611709] [097/165] (838s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[176.277275] Starting subtest: basic-flip-after-cursor-legacy
[177.468121] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.194s)
[177.969332] [098/165] (836s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[178.644583] Starting subtest: basic-flip-after-cursor-varying-size
[179.810088] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.167s)
[180.300522] [099/165] (833s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[180.965445] Starting subtest: basic-flip-before-cursor-atomic
[182.128073] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.172s)
[182.683424] [100/165] (831s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[183.386960] Starting subtest: basic-flip-before-cursor-legacy
[184.560549] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.171s)
[185.120597] [101/165] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[185.806096] Starting subtest: basic-flip-before-cursor-varying-size
[187.003558] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.197s)
[187.440772] [102/165] (826s left) kms_dsc (dsc-basic)
[188.112160] Subtest dsc-basic: SKIP (0.000s)
[188.180592] [103/165] (826s left) kms_flip (basic-flip-vs-dpms)
[188.647470] Starting subtest: basic-flip-vs-dpms
[188.663315] Starting dynamic subtest: C-HDMI-A2
[191.522595] Dynamic subtest C-HDMI-A2: SUCCESS (2.856s)
[191.534122] Subtest basic-flip-vs-dpms: SUCCESS (2.884s)
[192.051414] [104/165] (822s left) kms_flip (basic-flip-vs-modeset)
[192.516131] Starting subtest: basic-flip-vs-modeset
[192.536401] Starting dynamic subtest: C-HDMI-A2
[195.111898] Dynamic subtest C-HDMI-A2: SUCCESS (2.564s)
[195.120047] Subtest basic-flip-vs-modeset: SUCCESS (2.589s)
[195.701709] [105/165] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[196.178204] Starting subtest: basic-flip-vs-wf_vblank
[196.195109] Starting dynamic subtest: C-HDMI-A2
[199.021939] Dynamic subtest C-HDMI-A2: SUCCESS (2.825s)
[199.028729] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.849s)
[199.185581] [106/165] (815s left) kms_flip (basic-plain-flip)
[199.673440] Starting subtest: basic-plain-flip
[199.690592] Starting dynamic subtest: C-HDMI-A2
[202.328049] Dynamic subtest C-HDMI-A2: SUCCESS (2.625s)
[202.335061] Subtest basic-plain-flip: SUCCESS (2.649s)
[202.475727] [107/165] (812s left) kms_force_connector_basic (force-connector-state)
[202.836918] Starting subtest: force-connector-state
[203.702790] Subtest force-connector-state: SUCCESS (0.866s)
[205.053179] [108/165] (809s left) kms_force_connector_basic (force-edid)
[205.439523] Starting subtest: force-edid
[205.551478] Subtest force-edid: SUCCESS (0.102s)
[206.334814] [109/165] (808s left) kms_force_connector_basic (force-load-detect)
[206.704261] Starting subtest: force-load-detect
[206.712296] Subtest force-load-detect: SKIP (0.000s)
[207.234837] [110/165] (807s left) kms_force_connector_basic (prune-stale-modes)
[207.617647] Starting subtest: prune-stale-modes
[207.732880] Subtest prune-stale-modes: SUCCESS (0.106s)
[208.517660] [111/165] (806s left) kms_frontbuffer_tracking (basic)
[209.238099] Starting subtest: basic
[213.450938] Subtest basic: SUCCESS (4.214s)
[213.569149] [112/165] (801s left) kms_hdmi_inject (inject-audio)
[213.916158] Starting subtest: inject-audio
[214.466409] Subtest inject-audio: FAIL (0.499s)
[215.361194] [113/165] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[216.106369] Starting subtest: compare-crc-sanitycheck-xr24
[216.107902] Starting dynamic subtest: pipe-C-HDMI-A-2
[216.695778] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.576s)
[216.699592] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.591s)
[217.219415] [114/165] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[217.919716] Starting subtest: compare-crc-sanitycheck-nv12
[217.921606] Starting dynamic subtest: pipe-C-HDMI-A-2
[217.930234] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[217.937565] Subtest compare-crc-sanitycheck-nv12: SKIP (0.011s)
[218.036224] [115/165] (797s left) kms_pipe_crc_basic (hang-read-crc)
[218.747732] Starting subtest: hang-read-crc
[218.762192] Starting dynamic subtest: pipe-C-HDMI-A-2
[220.328248] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.569s)
[220.334247] Subtest hang-read-crc: SUCCESS (1.584s)
[220.788889] [116/165] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[221.492604] Starting subtest: nonblocking-crc
[221.496486] Starting dynamic subtest: pipe-C-HDMI-A-2
[222.214912] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.724s)
[222.220876] Subtest nonblocking-crc: SUCCESS (0.737s)
[222.741684] [117/165] (792s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[223.440516] Starting subtest: nonblocking-crc-frame-sequence
[223.446681] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.172890] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.722s)
[224.176349] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.735s)
[224.707488] [118/165] (790s left) kms_pipe_crc_basic (read-crc)
[225.411507] Starting subtest: read-crc
[225.417850] Starting dynamic subtest: pipe-C-HDMI-A-2
[226.065101] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.647s)
[226.068789] Subtest read-crc: SUCCESS (0.663s)
[226.569661] [119/165] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[227.285703] Starting subtest: read-crc-frame-sequence
[227.289196] Starting dynamic subtest: pipe-C-HDMI-A-2
[227.969140] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.680s)
[227.970829] Subtest read-crc-frame-sequence: SUCCESS (0.691s)
[228.427650] [120/165] (786s left) kms_pm_backlight (basic-brightness)
[229.101487] Subtest basic-brightness: SKIP (0.000s)
[229.196890] [121/165] (786s left) kms_pm_rpm (basic-pci-d3-state)
[231.553190] Starting subtest: basic-pci-d3-state
[231.906447] Subtest basic-pci-d3-state: SUCCESS (0.340s)
[232.231474] [122/165] (783s left) kms_pm_rpm (basic-rte)
[232.460197] Starting subtest: basic-rte
[234.893545] Subtest basic-rte: SUCCESS (2.428s)
[235.976954] [123/165] (779s left) kms_psr (primary_page_flip)
[236.216686] Subtest primary_page_flip: SKIP (0.000s)
[236.295664] [124/165] (779s left) kms_psr (cursor_plane_move)
[236.530154] Subtest cursor_plane_move: SKIP (0.000s)
[236.617655] [125/165] (779s left) kms_psr (sprite_plane_onoff)
[236.863932] Subtest sprite_plane_onoff: SKIP (0.000s)
[236.944583] [126/165] (778s left) kms_psr (primary_mmap_gtt)
[237.178507] Subtest primary_mmap_gtt: SKIP (0.000s)
[237.246348] [127/165] (778s left) kms_setmode (basic-clone-single-crtc)
[237.481821] Starting subtest: basic-clone-single-crtc
[237.489965] Subtest basic-clone-single-crtc: SKIP (0.001s)
[237.608086] [128/165] (778s left) i915_pm_rps (basic-api)
[237.860164] Starting subtest: basic-api
[237.873718] Subtest basic-api: SUCCESS (0.015s)
[237.994830] [129/165] (777s left) prime_self_import (basic-llseek-bad)
[238.215938] Starting subtest: basic-llseek-bad
[238.226710] Subtest basic-llseek-bad: SUCCESS (0.012s)
[238.339841] [130/165] (777s left) prime_self_import (basic-llseek-size)
[238.560087] Starting subtest: basic-llseek-size
[238.568742] Subtest basic-llseek-size: SUCCESS (0.012s)
[238.683631] [131/165] (777s left) prime_self_import (basic-with_fd_dup)
[238.909980] Starting subtest: basic-with_fd_dup
[238.929812] Subtest basic-with_fd_dup: SUCCESS (0.023s)
[239.036501] [132/165] (777s left) prime_self_import (basic-with_one_bo)
[239.263961] Starting subtest: basic-with_one_bo
[239.278803] Subtest basic-with_one_bo: SUCCESS (0.011s)
[239.378849] [133/165] (776s left) prime_self_import (basic-with_one_bo_two_files)
[239.606829] Starting subtest: basic-with_one_bo_two_files
[239.620317] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[239.737496] [134/165] (776s left) prime_self_import (basic-with_two_bos)
[239.966725] Starting subtest: basic-with_two_bos
[239.979630] Subtest basic-with_two_bos: SUCCESS (0.011s)
[240.085958] [135/165] (776s left) prime_vgem (basic-fence-flip)
[240.353106] Starting subtest: basic-fence-flip
[241.178145] Subtest basic-fence-flip: SKIP (0.815s)
[241.350696] [136/165] (775s left) prime_vgem (basic-fence-mmap)
[241.618568] Starting subtest: basic-fence-mmap
[241.729310] Subtest basic-fence-mmap: SUCCESS (0.109s)
[241.857465] [137/165] (774s left) prime_vgem (basic-fence-read)
[242.116356] Starting subtest: basic-fence-read
[242.304997] Subtest basic-fence-read: SUCCESS (0.186s)
[242.419839] [138/165] (774s left) prime_vgem (basic-gtt)
[242.670809] Starting subtest: basic-gtt
[242.720918] Subtest basic-gtt: SUCCESS (0.050s)
[242.866583] [139/165] (773s left) prime_vgem (basic-read)
[243.115141] Starting subtest: basic-read
[243.201216] Subtest basic-read: SUCCESS (0.082s)
[243.322478] [140/165] (773s left) prime_vgem (basic-write)
[243.586880] Starting subtest: basic-write
[243.687698] Subtest basic-write: SUCCESS (0.099s)
[243.806877] [141/165] (772s left) vgem_basic (setversion)
[244.055305] Starting subtest: setversion
[244.059367] Subtest setversion: SUCCESS (0.000s)
[244.150121] [142/165] (772s left) vgem_basic (create)
[244.378227] Starting subtest: create
[244.383894] Subtest create: SUCCESS (0.003s)
[244.487261] [143/165] (772s left) vgem_basic (debugfs)
[244.714048] Starting subtest: debugfs
[244.717952] Subtest debugfs: SUCCESS (0.002s)
[244.803565] [144/165] (772s left) vgem_basic (dmabuf-export)
[245.051968] Starting subtest: dmabuf-export
[245.064547] Subtest dmabuf-export: SUCCESS (0.009s)
[245.167147] [145/165] (771s left) vgem_basic (dmabuf-fence)
[245.402057] Starting subtest: dmabuf-fence
[245.403792] Subtest dmabuf-fence: SUCCESS (0.004s)
[245.484411] [146/165] (771s left) vgem_basic (dmabuf-fence-before)
[245.732817] Starting subtest: dmabuf-fence-before
[245.738746] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[245.842471] [147/165] (771s left) vgem_basic (dmabuf-mmap)
[246.082771] Starting subtest: dmabuf-mmap
[246.134088] Subtest dmabuf-mmap: SUCCESS (0.047s)
[246.218210] [148/165] (770s left) vgem_basic (mmap)
[246.449602] Starting subtest: mmap
[246.480351] Subtest mmap: SUCCESS (0.032s)
[246.571309] [149/165] (770s left) vgem_basic (second-client)
[246.818248] Starting subtest: second-client
[246.849066] Subtest second-client: SUCCESS (0.031s)
[246.945441] [150/165] (770s left) vgem_basic (sysfs)
[247.184574] Starting subtest: sysfs
[247.186139] Subtest sysfs: SUCCESS (0.002s)
[247.294543] [151/165] (770s left) core_hotunplug (unbind-rebind)
[247.630314] Starting subtest: unbind-rebind
[252.429164] Subtest unbind-rebind: SUCCESS (4.797s)
[252.549817] [152/165] (764s left) vgem_basic (unload)
[252.805363] Starting subtest: unload
[281.941945] Subtest unload: SUCCESS (29.132s)
[282.140826] [153/165] (735s left) i915_module_load (reload)
[282.367614] Starting subtest: reload
[287.018225] Subtest reload: SUCCESS (4.649s)
[287.122962] [154/165] (730s left) gem_lmem_swapping (basic)
[287.722064] Subtest basic: SKIP (0.000s)
[287.873896] [155/165] (729s left) gem_lmem_swapping (parallel-random-engines)
[288.194719] Subtest parallel-random-engines: SKIP (0.000s)
[288.283520] [156/165] (729s left) gem_lmem_swapping (random-engines)
[288.531505] Subtest random-engines: SKIP (0.000s)
[288.613348] [157/165] (729s left) gem_lmem_swapping (verify-random)
[288.861999] Subtest verify-random: SKIP (0.000s)
[288.928342] [158/165] (729s left) i915_pm_rpm (module-reload)
[291.682608] Starting subtest: module-reload
[304.055469] Subtest module-reload: SUCCESS (12.377s)
[304.131431] [159/165] (713s left) i915_selftest (live)
[304.389663] Starting subtest: live
[304.391644] Starting dynamic subtest: sanitycheck
[306.074692] Dynamic subtest sanitycheck: SUCCESS (1.682s)
[306.138967] Starting dynamic subtest: uncore
[307.941349] Dynamic subtest uncore: SUCCESS (1.858s)
[307.962588] Starting dynamic subtest: workarounds
[309.914706] Dynamic subtest workarounds: SUCCESS (1.966s)
[309.933694] Starting dynamic subtest: gt_engines
[312.165676] Dynamic subtest gt_engines: SUCCESS (2.246s)
[312.184462] Starting dynamic subtest: gt_timelines
[340.264134] Dynamic subtest gt_timelines: SUCCESS (28.094s)
[340.283308] Starting dynamic subtest: gt_contexts
[342.267288] Dynamic subtest gt_contexts: SUCCESS (1.998s)
[342.289573] Starting dynamic subtest: gt_lrc
[347.444678] Dynamic subtest gt_lrc: SUCCESS (5.172s)
[347.463479] Starting dynamic subtest: gt_mocs
[349.265327] Dynamic subtest gt_mocs: SUCCESS (1.817s)
[349.284227] Starting dynamic subtest: gt_pm
[352.224574] Dynamic subtest gt_pm: SUCCESS (2.955s)
[352.244034] Starting dynamic subtest: gt_heartbeat
[354.117773] Dynamic subtest gt_heartbeat: SUCCESS (1.891s)
[354.142999] Starting dynamic subtest: gt_tlb
[356.335130] Dynamic subtest gt_tlb: SUCCESS (2.206s)
[356.354086] Starting dynamic subtest: requests
[364.762994] Dynamic subtest requests: SUCCESS (8.425s)
[364.782099] Starting dynamic subtest: migrate
[370.058749] Dynamic subtest migrate: SUCCESS (5.291s)
[370.077858] Starting dynamic subtest: active
[371.924943] Dynamic subtest active: SUCCESS (1.862s)
[371.945300] Starting dynamic subtest: objects
[375.673945] Dynamic subtest objects: SUCCESS (3.744s)
[375.693395] Starting dynamic subtest: mman
[386.025356] Dynamic subtest mman: SUCCESS (10.347s)
[386.044474] Starting dynamic subtest: dmabuf
[388.064501] Dynamic subtest dmabuf: SUCCESS (2.035s)
[388.084275] Starting dynamic subtest: vma
[389.912332] Dynamic subtest vma: SUCCESS (1.846s)
[389.974294] Starting dynamic subtest: coherency
[395.276324] Dynamic subtest coherency: SUCCESS (5.356s)
[395.295466] Starting dynamic subtest: gtt
[404.601347] Dynamic subtest gtt: SUCCESS (9.319s)
[404.623438] Starting dynamic subtest: gem
[407.316869] Dynamic subtest gem: SUCCESS (2.713s)
[407.335920] Starting dynamic subtest: evict
[415.271310] Dynamic subtest evict: SUCCESS (7.950s)
[415.292274] Starting dynamic subtest: hugepages
[417.583477] Dynamic subtest hugepages: SUCCESS (2.312s)
[417.607214] Starting dynamic subtest: gem_contexts
[441.772602] Dynamic subtest gem_contexts: SUCCESS (24.177s)
[441.791632] Starting dynamic subtest: client
[443.615379] Dynamic subtest client: SUCCESS (1.840s)
[443.636490] Starting dynamic subtest: gem_migrate
[445.413061] Dynamic subtest gem_migrate: SUCCESS (1.795s)
[445.432498] Starting dynamic subtest: reset
[455.049575] Dynamic subtest reset: SUCCESS (9.633s)
[455.073987] Starting dynamic subtest: memory_region
[456.789887] Dynamic subtest memory_region: SUCCESS (1.734s)
[456.823812] Starting dynamic subtest: hangcheck
[481.961431] Dynamic subtest hangcheck: SUCCESS (25.163s)
[481.986719] Starting dynamic subtest: execlists
[493.548688] Dynamic subtest execlists: SUCCESS (11.578s)
[493.567796] Starting dynamic subtest: ring_submission
[495.307511] Dynamic subtest ring_submission: SUCCESS (1.757s)
[495.356547] Starting dynamic subtest: perf
[497.564912] Dynamic subtest perf: SUCCESS (2.247s)
[497.586515] Starting dynamic subtest: slpc
[499.359823] Dynamic subtest slpc: SUCCESS (1.790s)
[499.379588] Starting dynamic subtest: guc
[501.202433] Dynamic subtest guc: SUCCESS (1.838s)
[501.233683] Starting dynamic subtest: guc_multi_lrc
[503.046054] Dynamic subtest guc_multi_lrc: SUCCESS (1.834s)
[503.070049] Starting dynamic subtest: guc_hang
[504.852458] Dynamic subtest guc_hang: SUCCESS (1.804s)
[504.872171] Starting dynamic subtest: late_gt_pm
[506.785339] Dynamic subtest late_gt_pm: SUCCESS (1.925s)
[506.787254] Subtest live: SUCCESS (202.399s)
[506.849423] [160/165] (511s left) dmabuf (all-tests)
[507.088279] Starting subtest: all-tests
[507.092628] Starting dynamic subtest: sanitycheck
[507.162299] Dynamic subtest sanitycheck: SUCCESS (0.074s)
[507.211073] Starting dynamic subtest: dma_fence
[507.353185] Dynamic subtest dma_fence: SUCCESS (0.182s)
[507.385096] Starting dynamic subtest: dma_fence_chain
[538.299477] Dynamic subtest dma_fence_chain: SUCCESS (30.933s)
[538.326133] Starting dynamic subtest: dma_fence_unwrap
[538.359900] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[538.400586] Starting dynamic subtest: dma_resv
[538.436086] Dynamic subtest dma_resv: SUCCESS (0.068s)
[538.444094] Subtest all-tests: SUCCESS (31.358s)
[538.498806] [161/165] (479s left) i915_suspend (basic-s2idle-without-i915)
[538.725985] Starting subtest: basic-s2idle-without-i915
[562.275890] Subtest basic-s2idle-without-i915: SUCCESS (8.538s)
[568.325266] [162/165] (470s left) i915_suspend (basic-s3-without-i915)
[568.557396] Starting subtest: basic-s3-without-i915
[590.255364] Subtest basic-s3-without-i915: SUCCESS (6.750s)
[593.831446] [163/165] (462s left) gem_exec_suspend (basic-s0)
[594.134342] Starting subtest: basic-S0
[594.136573] Starting dynamic subtest: smem
[618.057733] Dynamic subtest smem: SUCCESS (9.035s)
[618.064463] Subtest basic-S0: SUCCESS (9.042s)
[623.303603] [164/165] (453s left) gem_exec_suspend (basic-s3)
[623.577004] Starting subtest: basic-S3
[623.580559] Starting dynamic subtest: smem
[648.657862] Dynamic subtest smem: SUCCESS (9.513s)
[648.660676] Subtest basic-S3: SUCCESS (9.518s)
[650.889502] [165/165] (443s left) kms_pipe_crc_basic (suspend-read-crc)
[651.584764] Starting subtest: suspend-read-crc
[651.593170] Starting dynamic subtest: pipe-C-HDMI-A-2
[673.010708] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.574s)
[673.016932] Subtest suspend-read-crc: SUCCESS (5.594s)
[678.416503] Closing watchdogs
Done.