[51.834807] Initializing watchdogs
[51.834958]   /dev/watchdog0
[51.843264] [001/171] (960s left) i915_module_load (load)
[52.249391] Starting subtest: load
[54.372043] Subtest load: SUCCESS (2.111s)
[54.441987] [002/171] (957s left) core_auth (basic-auth)
[54.757679] Starting subtest: basic-auth
[54.759463] Subtest basic-auth: SUCCESS (0.001s)
[54.838766] [003/171] (957s left) debugfs_test (read_all_entries)
[55.000294] Starting subtest: read_all_entries
[55.088718] Subtest read_all_entries: SUCCESS (0.086s)
[55.888652] [004/171] (956s left) debugfs_test (basic-hwmon)
[56.000894] Starting subtest: basic-hwmon
[56.004872] Subtest basic-hwmon: SKIP (0.000s)
[56.608617] [005/171] (955s left) fbdev (eof)
[56.731604] Starting subtest: eof
[56.733217] Subtest eof: SUCCESS (0.000s)
[56.786249] [006/171] (955s left) fbdev (info)
[56.893131] Starting subtest: info
[56.894876] Subtest info: SUCCESS (0.000s)
[56.959961] [007/171] (955s left) fbdev (nullptr)
[57.080865] Starting subtest: nullptr
[57.082684] Subtest nullptr: SUCCESS (0.000s)
[57.136413] [008/171] (955s left) fbdev (read)
[57.247392] Starting subtest: read
[57.457828] Subtest read: SUCCESS (0.210s)
[57.504364] [009/171] (955s left) fbdev (write)
[57.613190] Starting subtest: write
[57.713350] Subtest write: SUCCESS (0.100s)
[57.769977] [010/171] (954s left) gem_basic (bad-close)
[57.876250] Starting subtest: bad-close
[57.881465] Subtest bad-close: SUCCESS (0.000s)
[57.938134] [011/171] (954s left) gem_basic (create-close)
[58.045356] Starting subtest: create-close
[58.048712] Subtest create-close: SUCCESS (0.000s)
[58.118984] [012/171] (954s left) gem_basic (create-fd-close)
[58.231027] Starting subtest: create-fd-close
[58.234639] Subtest create-fd-close: SUCCESS (0.000s)
[58.302158] [013/171] (954s left) gem_busy (busy@all-engines)
[58.434631] Starting subtest: busy
[58.436315] Starting dynamic subtest: all-engines
[58.474376] Dynamic subtest all-engines: SUCCESS (0.043s)
[58.476119] Subtest busy: SUCCESS (0.044s)
[58.800125] [014/171] (953s left) gem_close_race (basic-process)
[58.924211] Starting subtest: basic-process
[58.967312] Subtest basic-process: SUCCESS (0.043s)
[59.155955] [015/171] (953s left) gem_close_race (basic-threads)
[59.279136] Starting subtest: basic-threads
[60.406453] Subtest basic-threads: SUCCESS (1.127s)
[60.582644] [016/171] (952s left) gem_ctx_create (basic)
[60.702430] Starting subtest: basic
[60.704373] Subtest basic: SUCCESS (0.000s)
[60.882972] [017/171] (951s left) gem_ctx_create (basic-files)
[61.003993] Starting subtest: basic-files
[63.022046] Subtest basic-files: SUCCESS (2.019s)
[63.441414] [018/171] (949s left) gem_ctx_exec (basic)
[63.557607] Starting subtest: basic
[63.559306] Subtest basic: SUCCESS (0.001s)
[63.612810] [019/171] (949s left) gem_exec_basic (basic)
[63.730161] Starting subtest: basic
[63.731821] Starting dynamic subtest: rcs0-smem
[63.733498] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[63.741299] Starting dynamic subtest: vcs0-smem
[63.743185] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[63.745091] Subtest basic: SUCCESS (0.002s)
[63.908037] [020/171] (948s left) gem_exec_create (basic)
[64.027202] Starting subtest: basic
[64.029693] Starting dynamic subtest: smem
[66.067383] Dynamic subtest smem: SUCCESS (2.038s)
[66.069335] Subtest basic: SUCCESS (2.040s)
[66.450972] [021/171] (946s left) gem_exec_fence (basic-busy)
[66.687907] Starting subtest: basic-busy
[66.689680] Starting dynamic subtest: rcs0
[66.699912] Dynamic subtest rcs0: SUCCESS (0.015s)
[66.708539] Starting dynamic subtest: vcs0
[66.714333] Dynamic subtest vcs0: SUCCESS (0.013s)
[66.716360] Subtest basic-busy: SUCCESS (0.028s)
[67.203456] [022/171] (945s left) gem_exec_fence (basic-wait)
[67.464653] Starting subtest: basic-wait
[67.466603] Starting dynamic subtest: rcs0
[67.474025] Dynamic subtest rcs0: SUCCESS (0.010s)
[67.482804] Starting dynamic subtest: vcs0
[67.486686] Dynamic subtest vcs0: SUCCESS (0.012s)
[67.488781] Subtest basic-wait: SUCCESS (0.022s)
[67.933802] [023/171] (944s left) gem_exec_fence (basic-await)
[68.176588] Starting subtest: basic-await
[68.178342] Starting dynamic subtest: rcs0
[68.243765] Dynamic subtest rcs0: SUCCESS (0.067s)
[68.253068] Starting dynamic subtest: vcs0
[68.310442] Dynamic subtest vcs0: SUCCESS (0.068s)
[68.312442] Subtest basic-await: SUCCESS (0.136s)
[68.751860] [024/171] (944s left) gem_exec_fence (nb-await)
[68.992117] Starting subtest: nb-await
[68.994551] Starting dynamic subtest: rcs0
[69.046320] Dynamic subtest rcs0: SUCCESS (0.054s)
[69.058170] Starting dynamic subtest: vcs0
[69.103561] Dynamic subtest vcs0: SUCCESS (0.057s)
[69.105675] Subtest nb-await: SUCCESS (0.113s)
[69.548910] [025/171] (943s left) gem_exec_gttfill (basic)
[69.667099] Starting subtest: basic
[77.202760] Subtest basic: SUCCESS (7.535s)
[77.400416] [026/171] (935s left) gem_exec_parallel (engines)
[77.633452] Starting subtest: engines
[77.635519] Starting dynamic subtest: basic
[79.330564] Dynamic subtest basic: SUCCESS (1.697s)
[79.339499] Starting dynamic subtest: contexts
[81.361911] Dynamic subtest contexts: SUCCESS (2.029s)
[81.372693] Starting dynamic subtest: fds
[81.375881] Dynamic subtest fds: SKIP (0.001s)
[81.385963] Starting dynamic subtest: userptr
[83.174268] Dynamic subtest userptr: SUCCESS (1.814s)
[83.176185] Subtest engines: SUCCESS (5.541s)
[83.355706] [027/171] (929s left) gem_exec_store (basic)
[83.478649] Starting subtest: basic
[83.504422] Subtest basic: SUCCESS (0.026s)
[83.687065] [028/171] (929s left) gem_flink_basic (bad-flink)
[83.798709] Starting subtest: bad-flink
[83.800386] Subtest bad-flink: SUCCESS (0.000s)
[83.871065] [029/171] (929s left) gem_flink_basic (bad-open)
[83.981438] Starting subtest: bad-open
[83.983131] Subtest bad-open: SUCCESS (0.000s)
[84.053055] [030/171] (928s left) gem_flink_basic (basic)
[84.158618] Starting subtest: basic
[84.160337] Subtest basic: SUCCESS (0.000s)
[84.235522] [031/171] (928s left) gem_flink_basic (double-flink)
[84.345792] Starting subtest: double-flink
[84.347608] Subtest double-flink: SUCCESS (0.000s)
[84.418978] [032/171] (928s left) gem_flink_basic (flink-lifetime)
[84.524192] Starting subtest: flink-lifetime
[84.527893] Subtest flink-lifetime: SUCCESS (0.002s)
[84.600691] [033/171] (928s left) gem_huc_copy (huc-copy)
[84.711352] Subtest huc-copy: SKIP (0.000s)
[84.738639] [034/171] (928s left) gem_linear_blits (basic)
[84.989266] Starting subtest: basic
[85.002987] Subtest basic: SUCCESS (0.013s)
[85.118128] [035/171] (927s left) gem_mmap (basic)
[85.318856] Starting subtest: basic
[85.327212] Subtest basic: SUCCESS (0.001s)
[85.385806] [036/171] (927s left) gem_mmap_gtt (basic)
[85.494844] Starting subtest: basic
[85.496658] Subtest basic: SUCCESS (0.001s)
[85.552427] [037/171] (927s left) gem_render_linear_blits (basic)
[85.661839] Starting subtest: basic
[85.703096] Subtest basic: SUCCESS (0.039s)
[85.753923] [038/171] (927s left) gem_render_tiled_blits (basic)
[85.862889] Starting subtest: basic
[85.903755] Subtest basic: SUCCESS (0.038s)
[85.933940] [039/171] (927s left) gem_ringfill (basic-all)
[86.099063] Starting subtest: basic-all
[87.206541] Subtest basic-all: SUCCESS (1.108s)
[87.279455] [040/171] (925s left) gem_softpin (allocator-basic)
[87.389982] Subtest allocator-basic: SKIP (0.000s)
[87.462360] [041/171] (925s left) gem_softpin (allocator-basic-reserve)
[87.578981] Subtest allocator-basic-reserve: SKIP (0.000s)
[87.644069] [042/171] (925s left) gem_softpin (safe-alignment)
[87.753141] Starting subtest: safe-alignment
[87.756877] Subtest safe-alignment: SUCCESS (0.006s)
[87.845223] [043/171] (925s left) gem_sync (basic-all)
[87.963457] Starting subtest: basic-all
[90.110629] Subtest basic-all: SUCCESS (2.144s)
[90.289824] [044/171] (922s left) gem_sync (basic-each)
[90.406460] Starting subtest: basic-each
[92.498241] Subtest basic-each: SUCCESS (2.090s)
[92.686175] [045/171] (920s left) gem_tiled_blits (basic)
[92.923956] Starting subtest: basic
[92.947275] Subtest basic: SUCCESS (0.024s)
[93.066105] [046/171] (920s left) gem_tiled_fence_blits (basic)
[93.413098] Starting subtest: basic
[93.426328] Subtest basic: SUCCESS (0.011s)
[93.534332] [047/171] (919s left) gem_tiled_pread_basic
[93.983394] [048/171] (919s left) gem_wait (busy@all-engines)
[94.105608] Starting subtest: busy
[94.107524] Starting dynamic subtest: all-engines
[94.614944] Dynamic subtest all-engines: SUCCESS (0.510s)
[94.616604] Subtest busy: SUCCESS (0.510s)
[94.814371] [049/171] (918s left) gem_wait (wait@all-engines)
[94.934674] Starting subtest: wait
[94.936589] Starting dynamic subtest: all-engines
[95.951889] Dynamic subtest all-engines: SUCCESS (1.017s)
[95.953638] Subtest wait: SUCCESS (1.017s)
[96.162372] [050/171] (917s left) i915_getparams_basic (basic-eu-total)
[96.271267] Starting subtest: basic-eu-total
[96.274716] Subtest basic-eu-total: SUCCESS (0.000s)
[96.345171] [051/171] (917s left) i915_getparams_basic (basic-subslice-total)
[96.451871] Starting subtest: basic-subslice-total
[96.455307] Subtest basic-subslice-total: SUCCESS (0.000s)
[96.529361] [052/171] (916s left) i915_hangman (error-state-basic)
[96.645579] Starting subtest: error-state-basic
[96.655832] Subtest error-state-basic: SUCCESS (0.008s)
[96.695685] [053/171] (916s left) i915_pciid
[96.876523] [054/171] (916s left) kms_addfb_basic (addfb25-bad-modifier)
[97.493193] Starting subtest: addfb25-bad-modifier
[97.494804] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[98.504951] [055/171] (915s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[99.125400] Starting subtest: addfb25-framebuffer-vs-set-tiling
[99.127355] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[99.985289] [056/171] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[100.603902] Starting subtest: addfb25-modifier-no-flag
[100.605654] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[101.479278] [057/171] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[102.168306] Starting subtest: addfb25-x-tiled-legacy
[102.192182] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[103.530894] [058/171] (910s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[104.150080] Starting subtest: addfb25-x-tiled-mismatch-legacy
[104.151699] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[105.008207] [059/171] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.995655] Starting subtest: addfb25-yf-tiled-legacy
[105.997273] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[106.456669] [060/171] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[107.455831] Starting subtest: addfb25-y-tiled-legacy
[107.457478] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[108.152126] [061/171] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[109.143430] Starting subtest: addfb25-y-tiled-small-legacy
[109.146636] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[109.599017] [062/171] (904s left) kms_addfb_basic (bad-pitch-0)
[109.706796] Starting subtest: bad-pitch-0
[109.708403] Subtest bad-pitch-0: SUCCESS (0.000s)
[111.047907] [063/171] (903s left) kms_addfb_basic (bad-pitch-1024)
[111.157036] Starting subtest: bad-pitch-1024
[111.158678] Subtest bad-pitch-1024: SUCCESS (0.000s)
[112.526605] [064/171] (901s left) kms_addfb_basic (bad-pitch-128)
[112.635137] Starting subtest: bad-pitch-128
[112.636772] Subtest bad-pitch-128: SUCCESS (0.000s)
[114.041519] [065/171] (900s left) kms_addfb_basic (bad-pitch-256)
[114.149575] Starting subtest: bad-pitch-256
[114.151251] Subtest bad-pitch-256: SUCCESS (0.000s)
[115.503861] [066/171] (898s left) kms_addfb_basic (bad-pitch-32)
[115.614502] Starting subtest: bad-pitch-32
[115.616193] Subtest bad-pitch-32: SUCCESS (0.000s)
[116.999226] [067/171] (897s left) kms_addfb_basic (bad-pitch-63)
[117.115858] Starting subtest: bad-pitch-63
[117.117462] Subtest bad-pitch-63: SUCCESS (0.000s)
[118.664521] [068/171] (895s left) kms_addfb_basic (bad-pitch-65536)
[118.773550] Starting subtest: bad-pitch-65536
[118.775304] Subtest bad-pitch-65536: SUCCESS (0.001s)
[120.144916] [069/171] (894s left) kms_addfb_basic (bad-pitch-999)
[120.252438] Starting subtest: bad-pitch-999
[120.254237] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.608480] [070/171] (892s left) kms_addfb_basic (basic)
[121.719241] Starting subtest: basic
[121.720897] Subtest basic: SUCCESS (0.000s)
[123.072094] [071/171] (891s left) kms_addfb_basic (basic-x-tiled-legacy)
[124.469193] Starting subtest: basic-x-tiled-legacy
[124.470978] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[124.552426] [072/171] (889s left) kms_addfb_basic (basic-y-tiled-legacy)
[125.949215] Starting subtest: basic-y-tiled-legacy
[125.951061] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[126.033082] [073/171] (888s left) kms_addfb_basic (bo-too-small)
[126.658579] Starting subtest: bo-too-small
[126.660423] Subtest bo-too-small: SUCCESS (0.002s)
[127.530091] [074/171] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[128.153836] Starting subtest: bo-too-small-due-to-tiling
[128.155481] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[129.209762] [075/171] (885s left) kms_addfb_basic (clobberred-modifier)
[129.318988] Starting subtest: clobberred-modifier
[129.320636] Subtest clobberred-modifier: SUCCESS (0.000s)
[130.707030] [076/171] (883s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[132.129289] Starting subtest: framebuffer-vs-set-tiling
[132.131133] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[132.287832] [077/171] (882s left) kms_addfb_basic (invalid-get-prop)
[133.715173] Starting subtest: invalid-get-prop
[133.716896] Subtest invalid-get-prop: SUCCESS (0.000s)
[133.800459] [078/171] (880s left) kms_addfb_basic (invalid-get-prop-any)
[135.214290] Starting subtest: invalid-get-prop-any
[135.216067] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[135.298151] [079/171] (879s left) kms_addfb_basic (invalid-set-prop)
[136.722288] Starting subtest: invalid-set-prop
[136.723998] Subtest invalid-set-prop: SUCCESS (0.000s)
[136.832541] [080/171] (877s left) kms_addfb_basic (invalid-set-prop-any)
[138.267317] Starting subtest: invalid-set-prop-any
[138.269253] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[138.557961] [081/171] (876s left) kms_addfb_basic (no-handle)
[138.667379] Starting subtest: no-handle
[138.669048] Subtest no-handle: SUCCESS (0.000s)
[140.070514] [082/171] (874s left) kms_addfb_basic (size-max)
[140.703227] Starting subtest: size-max
[140.704825] Subtest size-max: SUCCESS (0.000s)
[141.585197] [083/171] (873s left) kms_addfb_basic (small-bo)
[142.232103] Starting subtest: small-bo
[142.233716] Subtest small-bo: SUCCESS (0.000s)
[143.115241] [084/171] (871s left) kms_addfb_basic (tile-pitch-mismatch)
[144.546482] Starting subtest: tile-pitch-mismatch
[144.548299] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[144.645640] [085/171] (870s left) kms_addfb_basic (too-high)
[145.281438] Starting subtest: too-high
[145.283149] Subtest too-high: SUCCESS (0.002s)
[146.158347] [086/171] (868s left) kms_addfb_basic (too-wide)
[146.801127] Starting subtest: too-wide
[146.802762] Subtest too-wide: SUCCESS (0.000s)
[147.689844] [087/171] (867s left) kms_addfb_basic (unused-handle)
[147.804760] Starting subtest: unused-handle
[147.806416] Subtest unused-handle: SUCCESS (0.000s)
[149.419452] [088/171] (865s left) kms_addfb_basic (unused-modifier)
[149.532707] Starting subtest: unused-modifier
[149.537829] Subtest unused-modifier: SUCCESS (0.000s)
[150.966740] [089/171] (863s left) kms_addfb_basic (unused-offsets)
[151.081773] Starting subtest: unused-offsets
[151.083490] Subtest unused-offsets: SUCCESS (0.000s)
[152.513366] [090/171] (862s left) kms_addfb_basic (unused-pitches)
[152.624695] Starting subtest: unused-pitches
[152.628065] Subtest unused-pitches: SUCCESS (0.000s)
[154.043673] [091/171] (860s left) kms_busy (basic)
[154.699307] Starting subtest: basic
[154.701207] Starting dynamic subtest: flip
[155.420967] Dynamic subtest flip: SUCCESS (0.709s)
[155.439500] Starting dynamic subtest: modeset
[156.172043] Dynamic subtest modeset: SUCCESS (0.755s)
[156.173904] Subtest basic: SUCCESS (1.466s)
[156.351158] [092/171] (858s left) kms_chamelium_hpd (dp-hpd-fast)
[157.079391] Subtest dp-hpd-fast: SKIP (0.000s)
[157.213349] [093/171] (857s left) kms_chamelium_edid (dp-edid-read)
[157.936187] Subtest dp-edid-read: SKIP (0.000s)
[158.051915] [094/171] (856s left) kms_chamelium_frames (dp-crc-fast)
[158.793136] Subtest dp-crc-fast: SKIP (0.000s)
[159.141181] [095/171] (855s left) kms_chamelium_hpd (hdmi-hpd-fast)
[159.858026] Subtest hdmi-hpd-fast: SKIP (0.000s)
[159.971344] [096/171] (855s left) kms_chamelium_edid (hdmi-edid-read)
[160.729421] Subtest hdmi-edid-read: SKIP (0.000s)
[160.870415] [097/171] (854s left) kms_chamelium_frames (hdmi-crc-fast)
[161.643491] Subtest hdmi-crc-fast: SKIP (0.000s)
[161.786931] [098/171] (853s left) kms_chamelium_hpd (vga-hpd-fast)
[162.526681] Subtest vga-hpd-fast: SKIP (0.000s)
[162.643497] [099/171] (852s left) kms_chamelium_edid (vga-edid-read)
[163.382488] Subtest vga-edid-read: SKIP (0.000s)
[163.524190] [100/171] (851s left) kms_prop_blob (basic)
[163.644681] Starting subtest: basic
[163.646461] Subtest basic: SUCCESS (0.000s)
[163.713370] [101/171] (851s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[164.388519] Starting subtest: basic-busy-flip-before-cursor-atomic
[165.433340] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.046s)
[165.612211] [102/171] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[166.271598] Starting subtest: basic-busy-flip-before-cursor-legacy
[167.318757] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.049s)
[167.491931] [103/171] (847s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[168.155625] Starting subtest: basic-flip-after-cursor-atomic
[169.176439] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.021s)
[169.729473] [104/171] (845s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[170.393050] Starting subtest: basic-flip-after-cursor-legacy
[171.430972] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.045s)
[171.607429] [105/171] (843s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[172.271575] Starting subtest: basic-flip-after-cursor-varying-size
[173.291719] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.019s)
[173.451058] [106/171] (841s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[174.132762] Starting subtest: basic-flip-before-cursor-atomic
[175.137881] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.043s)
[175.305295] [107/171] (839s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[175.972854] Starting subtest: basic-flip-before-cursor-legacy
[177.008389] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.045s)
[177.180598] [108/171] (838s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[177.840517] Starting subtest: basic-flip-before-cursor-varying-size
[178.906752] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.070s)
[179.056072] [109/171] (836s left) kms_flip (basic-flip-vs-dpms)
[179.554333] Starting subtest: basic-flip-vs-dpms
[179.555921] Starting dynamic subtest: A-VGA1
[180.338967] Dynamic subtest A-VGA1: SUCCESS (0.788s)
[180.352613] Starting dynamic subtest: B-VGA1
[181.017683] Dynamic subtest B-VGA1: SUCCESS (0.676s)
[181.036618] Starting dynamic subtest: A-HDMI-A1
[181.764053] Dynamic subtest A-HDMI-A1: SUCCESS (0.741s)
[181.778706] Starting dynamic subtest: B-HDMI-A1
[182.514475] Dynamic subtest B-HDMI-A1: SUCCESS (0.740s)
[182.516085] Subtest basic-flip-vs-dpms: SUCCESS (2.970s)
[183.102859] [110/171] (832s left) kms_flip (basic-flip-vs-modeset)
[183.608314] Starting subtest: basic-flip-vs-modeset
[183.609911] Starting dynamic subtest: A-VGA1
[184.407806] Dynamic subtest A-VGA1: SUCCESS (0.802s)
[184.424375] Starting dynamic subtest: B-VGA1
[185.045224] Dynamic subtest B-VGA1: SUCCESS (0.638s)
[185.060662] Starting dynamic subtest: A-HDMI-A1
[185.905649] Dynamic subtest A-HDMI-A1: SUCCESS (0.833s)
[185.925473] Starting dynamic subtest: B-HDMI-A1
[186.724953] Dynamic subtest B-HDMI-A1: SUCCESS (0.810s)
[186.726647] Subtest basic-flip-vs-modeset: SUCCESS (3.107s)
[186.884817] [111/171] (828s left) kms_flip (basic-flip-vs-wf_vblank)
[187.385638] Starting subtest: basic-flip-vs-wf_vblank
[187.387252] Starting dynamic subtest: A-VGA1
[188.460943] Dynamic subtest A-VGA1: SUCCESS (1.078s)
[188.479521] Starting dynamic subtest: B-VGA1
[189.460635] Dynamic subtest B-VGA1: SUCCESS (1.002s)
[189.481438] Starting dynamic subtest: A-HDMI-A1
[190.678163] Dynamic subtest A-HDMI-A1: SUCCESS (1.207s)
[190.699581] Starting dynamic subtest: B-HDMI-A1
[191.952841] Dynamic subtest B-HDMI-A1: SUCCESS (1.251s)
[191.959534] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.573s)
[192.218905] [112/171] (823s left) kms_flip (basic-plain-flip)
[192.731065] Starting subtest: basic-plain-flip
[192.732658] Starting dynamic subtest: A-VGA1
[193.529761] Dynamic subtest A-VGA1: SUCCESS (0.803s)
[193.543543] Starting dynamic subtest: B-VGA1
[194.243275] Dynamic subtest B-VGA1: SUCCESS (0.701s)
[194.255609] Starting dynamic subtest: A-HDMI-A1
[195.019239] Dynamic subtest A-HDMI-A1: SUCCESS (0.772s)
[195.039028] Starting dynamic subtest: B-HDMI-A1
[195.836977] Dynamic subtest B-HDMI-A1: SUCCESS (0.809s)
[195.844148] Subtest basic-plain-flip: SUCCESS (3.118s)
[196.480452] [113/171] (818s left) kms_force_connector_basic (force-connector-state)
[196.666785] Starting subtest: force-connector-state
[197.461308] Subtest force-connector-state: SUCCESS (0.793s)
[198.013164] [114/171] (817s left) kms_force_connector_basic (force-edid)
[198.188515] Starting subtest: force-edid
[198.505686] Subtest force-edid: SUCCESS (0.316s)
[198.960221] [115/171] (816s left) kms_force_connector_basic (force-load-detect)
[199.135346] Starting subtest: force-load-detect
[199.350267] Subtest force-load-detect: SUCCESS (0.214s)
[199.905185] [116/171] (815s left) kms_force_connector_basic (prune-stale-modes)
[200.144374] Starting subtest: prune-stale-modes
[200.449593] Subtest prune-stale-modes: SUCCESS (0.297s)
[200.897476] [117/171] (814s left) kms_frontbuffer_tracking (basic)
[202.223490] Starting subtest: basic
[202.433471] Subtest basic: SKIP (0.287s)
[202.454776] [118/171] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[203.111857] Starting subtest: compare-crc-sanitycheck
[203.113602] Starting dynamic subtest: pipe-A-HDMI-A-1
[203.505712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.400s)
[203.520594] Starting dynamic subtest: pipe-B-HDMI-A-1
[203.906473] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.393s)
[203.908078] Subtest compare-crc-sanitycheck: SUCCESS (0.795s)
[204.058475] [119/171] (811s left) kms_pipe_crc_basic (hang-read-crc)
[204.721601] Starting subtest: hang-read-crc
[204.723356] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.772474] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.049s)
[205.787540] Starting dynamic subtest: pipe-B-HDMI-A-1
[206.871206] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.099s)
[206.872880] Subtest hang-read-crc: SUCCESS (2.150s)
[207.412328] [120/171] (808s left) kms_pipe_crc_basic (nonblocking-crc)
[208.085621] Starting subtest: nonblocking-crc
[208.087336] Starting dynamic subtest: pipe-A-HDMI-A-1
[208.639695] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.561s)
[208.655533] Starting dynamic subtest: pipe-B-HDMI-A-1
[209.254918] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.616s)
[209.257413] Subtest nonblocking-crc: SUCCESS (1.179s)
[209.414405] [121/171] (806s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[210.081842] Starting subtest: nonblocking-crc-frame-sequence
[210.083500] Starting dynamic subtest: pipe-A-HDMI-A-1
[210.640407] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.568s)
[210.659567] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.260885] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.620s)
[211.262782] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.189s)
[211.432880] [122/171] (804s left) kms_pipe_crc_basic (read-crc)
[212.096738] Starting subtest: read-crc
[212.098501] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.592462] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.507s)
[212.610878] Starting dynamic subtest: pipe-B-HDMI-A-1
[213.139344] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.546s)
[213.141439] Subtest read-crc: SUCCESS (1.055s)
[213.312797] [123/171] (802s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[213.981765] Starting subtest: read-crc-frame-sequence
[213.983545] Starting dynamic subtest: pipe-A-HDMI-A-1
[214.488673] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.506s)
[214.505470] Starting dynamic subtest: pipe-B-HDMI-A-1
[215.044658] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.556s)
[215.046505] Subtest read-crc-frame-sequence: SUCCESS (1.064s)
[215.198530] [124/171] (800s left) kms_psr (primary_page_flip)
[215.317509] Subtest primary_page_flip: SKIP (0.000s)
[215.353347] [125/171] (800s left) kms_psr (cursor_plane_move)
[215.465173] Subtest cursor_plane_move: SKIP (0.000s)
[215.502720] [126/171] (800s left) kms_psr (sprite_plane_onoff)
[215.617435] Subtest sprite_plane_onoff: SKIP (0.000s)
[215.652389] [127/171] (800s left) kms_psr (primary_mmap_gtt)
[215.766147] Subtest primary_mmap_gtt: SKIP (0.000s)
[215.802318] [128/171] (800s left) kms_setmode (basic-clone-single-crtc)
[215.915054] Starting subtest: basic-clone-single-crtc
[215.919946] Subtest basic-clone-single-crtc: SKIP (0.000s)
[215.979843] [129/171] (799s left) i915_pm_backlight (basic-brightness)
[216.634427] Subtest basic-brightness: SKIP (0.000s)
[216.683834] [130/171] (799s left) i915_pm_rpm (basic-pci-d3-state)
[228.692081] Subtest basic-pci-d3-state: SKIP (0.000s)
[228.926039] [131/171] (786s left) i915_pm_rpm (basic-rte)
[229.036847] Starting subtest: basic-rte
[240.939344] Subtest basic-rte: SKIP (11.885s)
[241.204974] [132/171] (774s left) i915_pm_rps (basic-api)
[241.422996] Subtest basic-api: SKIP (0.000s)
[241.505182] [133/171] (774s left) prime_self_import (basic-llseek-bad)
[241.697477] Starting subtest: basic-llseek-bad
[241.721151] Subtest basic-llseek-bad: SUCCESS (0.002s)
[241.802417] [134/171] (774s left) prime_self_import (basic-llseek-size)
[241.993774] Starting subtest: basic-llseek-size
[242.016606] Subtest basic-llseek-size: SUCCESS (0.003s)
[242.097259] [135/171] (774s left) prime_self_import (basic-with_fd_dup)
[242.276836] Starting subtest: basic-with_fd_dup
[242.338235] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[242.358070] [136/171] (773s left) prime_self_import (basic-with_one_bo)
[242.470231] Starting subtest: basic-with_one_bo
[242.471970] Subtest basic-with_one_bo: SUCCESS (0.003s)
[242.550726] [137/171] (773s left) prime_self_import (basic-with_one_bo_two_files)
[242.663324] Starting subtest: basic-with_one_bo_two_files
[242.665129] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[242.744314] [138/171] (773s left) prime_self_import (basic-with_two_bos)
[242.859731] Starting subtest: basic-with_two_bos
[242.861342] Subtest basic-with_two_bos: SUCCESS (0.003s)
[242.927823] [139/171] (773s left) prime_vgem (basic-fence-flip)
[243.057624] Starting subtest: basic-fence-flip
[244.153661] Subtest basic-fence-flip: SUCCESS (1.093s)
[244.349961] [140/171] (771s left) prime_vgem (basic-fence-mmap)
[244.480734] Starting subtest: basic-fence-mmap
[244.520725] Subtest basic-fence-mmap: SUCCESS (0.036s)
[244.601701] [141/171] (771s left) prime_vgem (basic-fence-read)
[244.732152] Starting subtest: basic-fence-read
[244.793873] Subtest basic-fence-read: SUCCESS (0.061s)
[244.867715] [142/171] (771s left) prime_vgem (basic-gtt)
[244.998517] Starting subtest: basic-gtt
[245.016031] Subtest basic-gtt: SUCCESS (0.017s)
[245.100800] [143/171] (771s left) prime_vgem (basic-read)
[245.230892] Starting subtest: basic-read
[245.259113] Subtest basic-read: SUCCESS (0.027s)
[245.332129] [144/171] (771s left) prime_vgem (basic-write)
[245.463486] Starting subtest: basic-write
[245.493528] Subtest basic-write: SUCCESS (0.031s)
[245.566453] [145/171] (770s left) prime_vgem (basic-userptr)
[245.696286] Starting subtest: basic-userptr
[245.709635] Subtest basic-userptr: SKIP (0.014s)
[245.785964] [146/171] (770s left) vgem_basic (setversion)
[245.905720] Starting subtest: setversion
[245.909568] Subtest setversion: SUCCESS (0.000s)
[245.963997] [147/171] (770s left) vgem_basic (create)
[246.087848] Starting subtest: create
[246.089981] Subtest create: SUCCESS (0.000s)
[246.149099] [148/171] (770s left) vgem_basic (debugfs)
[246.270736] Starting subtest: debugfs
[246.272821] Subtest debugfs: SUCCESS (0.001s)
[246.329811] [149/171] (770s left) vgem_basic (dmabuf-export)
[246.455643] Starting subtest: dmabuf-export
[246.457791] Subtest dmabuf-export: SUCCESS (0.004s)
[246.530979] [150/171] (769s left) vgem_basic (dmabuf-fence)
[246.653651] Starting subtest: dmabuf-fence
[246.655664] Subtest dmabuf-fence: SUCCESS (0.001s)
[246.712715] [151/171] (769s left) vgem_basic (dmabuf-fence-before)
[246.836163] Starting subtest: dmabuf-fence-before
[246.838106] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[246.896632] [152/171] (769s left) vgem_basic (dmabuf-mmap)
[247.019225] Starting subtest: dmabuf-mmap
[247.043741] Subtest dmabuf-mmap: SUCCESS (0.025s)
[247.094951] [153/171] (769s left) vgem_basic (mmap)
[247.220073] Starting subtest: mmap
[247.236370] Subtest mmap: SUCCESS (0.018s)
[247.296112] [154/171] (769s left) vgem_basic (second-client)
[247.419045] Starting subtest: second-client
[247.468072] Subtest second-client: SUCCESS (0.049s)
[247.527655] [155/171] (769s left) vgem_basic (sysfs)
[247.651384] Starting subtest: sysfs
[247.654748] Subtest sysfs: SUCCESS (0.001s)
[247.714059] [156/171] (768s left) core_hotunplug (unbind-rebind)
[247.851133] Starting subtest: unbind-rebind
[249.215537] Subtest unbind-rebind: SUCCESS (1.361s)
[249.247868] [157/171] (767s left) vgem_basic (unload)
[249.399043] Starting subtest: unload
[278.141702] Subtest unload: SUCCESS (28.743s)
[278.248859] [158/171] (738s left) i915_module_load (reload)
[278.360098] Starting subtest: reload
[280.712628] Subtest reload: SUCCESS (2.341s)
[280.732787] [159/171] (735s left) gem_lmem_swapping (basic)
[280.882773] Subtest basic: SKIP (0.000s)
[280.913283] [160/171] (735s left) gem_lmem_swapping (parallel-random-engines)
[281.032152] Subtest parallel-random-engines: SKIP (0.000s)
[281.062747] [161/171] (735s left) gem_lmem_swapping (random-engines)
[281.181399] Subtest random-engines: SKIP (0.000s)
[281.212390] [162/171] (735s left) gem_lmem_swapping (verify-random)
[281.331446] Subtest verify-random: SKIP (0.000s)
[281.361826] [163/171] (735s left) i915_pm_rpm (module-reload)
[293.382885] Subtest module-reload: SKIP (0.000s)
[293.653847] [164/171] (723s left) i915_selftest (live)
[294.362796] Starting subtest: live
[294.365068] Starting dynamic subtest: sanitycheck
[295.098565] Dynamic subtest sanitycheck: SUCCESS (0.736s)
[295.110134] Starting dynamic subtest: uncore
[295.763943] Dynamic subtest uncore: SUCCESS (0.664s)
[295.778761] Starting dynamic subtest: workarounds
[296.468245] Dynamic subtest workarounds: SUCCESS (0.703s)
[296.478578] Starting dynamic subtest: gt_engines
[297.175492] Dynamic subtest gt_engines: SUCCESS (0.706s)
[297.185827] Starting dynamic subtest: gt_timelines
[302.076878] Dynamic subtest gt_timelines: SUCCESS (4.899s)
[302.087028] Starting dynamic subtest: gt_contexts
[302.789618] Dynamic subtest gt_contexts: SUCCESS (0.713s)
[302.800861] Starting dynamic subtest: gt_lrc
[303.485266] Dynamic subtest gt_lrc: SUCCESS (0.695s)
[303.495836] Starting dynamic subtest: gt_mocs
[304.198276] Dynamic subtest gt_mocs: SUCCESS (0.712s)
[304.209573] Starting dynamic subtest: gt_pm
[305.373834] Dynamic subtest gt_pm: SUCCESS (1.174s)
[305.385654] Starting dynamic subtest: gt_heartbeat
[306.096561] Dynamic subtest gt_heartbeat: SUCCESS (0.722s)
[306.107928] Starting dynamic subtest: requests
[310.359863] Dynamic subtest requests: SUCCESS (4.262s)
[310.371178] Starting dynamic subtest: migrate
[311.105526] Dynamic subtest migrate: SUCCESS (0.745s)
[311.116879] Starting dynamic subtest: active
[311.775861] Dynamic subtest active: SUCCESS (0.669s)
[311.783603] Starting dynamic subtest: objects
[313.846076] Dynamic subtest objects: SUCCESS (2.069s)
[313.855779] Starting dynamic subtest: mman
[319.893741] Dynamic subtest mman: SUCCESS (6.046s)
[319.904841] Starting dynamic subtest: dmabuf
[320.600233] Dynamic subtest dmabuf: SUCCESS (0.706s)
[320.609560] Starting dynamic subtest: vma
[321.308480] Dynamic subtest vma: SUCCESS (0.707s)
[321.318553] Starting dynamic subtest: coherency
[323.013196] Dynamic subtest coherency: SUCCESS (1.703s)
[323.024548] Starting dynamic subtest: gtt
[326.891546] Dynamic subtest gtt: SUCCESS (3.877s)
[326.903929] Starting dynamic subtest: gem
[327.655625] Dynamic subtest gem: SUCCESS (0.763s)
[327.667057] Starting dynamic subtest: evict
[328.369498] Dynamic subtest evict: SUCCESS (0.713s)
[328.379570] Starting dynamic subtest: hugepages
[329.059696] Dynamic subtest hugepages: SUCCESS (0.688s)
[329.070834] Starting dynamic subtest: gem_contexts
[332.808500] Dynamic subtest gem_contexts: SUCCESS (3.748s)
[332.817927] Starting dynamic subtest: client
[333.500364] Dynamic subtest client: SUCCESS (0.690s)
[333.510190] Starting dynamic subtest: gem_migrate
[334.197327] Dynamic subtest gem_migrate: SUCCESS (0.696s)
[334.207747] Starting dynamic subtest: reset
[334.963560] Dynamic subtest reset: SUCCESS (0.764s)
[334.973372] Starting dynamic subtest: memory_region
[335.672587] Dynamic subtest memory_region: SUCCESS (0.707s)
[335.684166] Starting dynamic subtest: hangcheck
[337.871190] Dynamic subtest hangcheck: SUCCESS (2.197s)
[337.882068] Starting dynamic subtest: execlists
[338.573262] Dynamic subtest execlists: SUCCESS (0.701s)
[338.583760] Starting dynamic subtest: ring_submission
[339.304042] Dynamic subtest ring_submission: SUCCESS (0.729s)
[339.315219] Starting dynamic subtest: perf
[339.948341] Dynamic subtest perf: SUCCESS (0.644s)
[339.956560] Starting dynamic subtest: slpc
[340.650510] Dynamic subtest slpc: SUCCESS (0.700s)
[340.660448] Starting dynamic subtest: guc
[341.314860] Dynamic subtest guc: SUCCESS (0.663s)
[341.330496] Starting dynamic subtest: guc_multi_lrc
[342.024823] Dynamic subtest guc_multi_lrc: SUCCESS (0.709s)
[342.035600] Starting dynamic subtest: guc_hang
[342.675824] Dynamic subtest guc_hang: SUCCESS (0.650s)
[342.689294] Starting dynamic subtest: late_gt_pm
[343.377732] Dynamic subtest late_gt_pm: SUCCESS (0.700s)
[343.380220] Subtest live: SUCCESS (49.016s)
[343.456258] [165/171] (673s left) dmabuf (all-tests)
[343.582334] Starting subtest: all-tests
[343.584288] Starting dynamic subtest: sanitycheck
[343.609093] Dynamic subtest sanitycheck: SUCCESS (0.024s)
[343.619483] Starting dynamic subtest: dma_fence
[343.750862] Dynamic subtest dma_fence: SUCCESS (0.140s)
[343.768281] Starting dynamic subtest: dma_fence_chain
[360.944159] Dynamic subtest dma_fence_chain: SUCCESS (17.193s)
[360.955662] Starting dynamic subtest: dma_fence_unwrap
[360.966207] Dynamic subtest dma_fence_unwrap: SUCCESS (0.021s)
[360.980845] Starting dynamic subtest: dma_resv
[360.997472] Dynamic subtest dma_resv: SUCCESS (0.026s)
[360.999158] Subtest all-tests: SUCCESS (17.410s)
[361.015197] [166/171] (655s left) i915_suspend (basic-s2idle-without-i915)
[361.122391] Starting subtest: basic-s2idle-without-i915
[379.738111] Subtest basic-s2idle-without-i915: SUCCESS (3.419s)
[382.670943] [167/171] (652s left) i915_suspend (basic-s3-without-i915)
[382.791360] Starting subtest: basic-s3-without-i915
[400.890672] Subtest basic-s3-without-i915: SUCCESS (2.252s)
[408.347704] [168/171] (649s left) gem_exec_suspend (basic-s0)
[408.479415] Starting subtest: basic-S0
[408.482692] Starting dynamic subtest: smem
[426.209439] Dynamic subtest smem: SUCCESS (7.140s)
[426.211124] Subtest basic-S0: SUCCESS (7.141s)
[429.054173] [169/171] (641s left) gem_exec_suspend (basic-s3)
[429.177705] Starting subtest: basic-S3
[429.179713] Starting dynamic subtest: smem
[446.455343] Dynamic subtest smem: SUCCESS (2.110s)
[446.457050] Subtest basic-S3: SUCCESS (2.111s)
[453.631724] [170/171] (639s left) kms_chamelium_hpd (common-hpd-after-suspend)
[454.424732] Subtest common-hpd-after-suspend: SKIP (0.000s)
[454.760955] [171/171] (638s left) kms_pipe_crc_basic (suspend-read-crc)
[455.408845] Starting subtest: suspend-read-crc
[455.410517] Starting dynamic subtest: pipe-A-HDMI-A-1
[472.572823] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.115s)
[472.591387] Starting dynamic subtest: pipe-B-HDMI-A-1
[490.544719] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.128s)
[490.546400] Subtest suspend-read-crc: SUCCESS (4.246s)
[497.920359] Closing watchdogs
Done.