[32.913682] Initializing watchdogs
[32.913883]   /dev/watchdog0
[32.940685] [001/171] (960s left) i915_module_load (load)
[33.076708] Starting subtest: load
[34.452981] Subtest load: SUCCESS (1.361s)
[34.594660] [002/171] (958s left) core_auth (basic-auth)
[34.756272] Starting subtest: basic-auth
[34.774902] Subtest basic-auth: SUCCESS (0.000s)
[34.850480] [003/171] (958s left) debugfs_test (read_all_entries)
[35.013136] Starting subtest: read_all_entries
[35.031440] Subtest read_all_entries: SUCCESS (0.043s)
[35.135127] [004/171] (958s left) debugfs_test (basic-hwmon)
[35.300377] Starting subtest: basic-hwmon
[35.343047] Subtest basic-hwmon: SKIP (0.000s)
[35.414560] [005/171] (958s left) fbdev (eof)
[35.571604] Starting subtest: eof
[35.590894] Subtest eof: SUCCESS (0.000s)
[35.661207] [006/171] (958s left) fbdev (info)
[35.810646] Starting subtest: info
[35.829407] Subtest info: SUCCESS (0.000s)
[35.902403] [007/171] (957s left) fbdev (nullptr)
[36.050177] Starting subtest: nullptr
[36.069220] Subtest nullptr: SUCCESS (0.000s)
[36.144402] [008/171] (957s left) fbdev (read)
[36.269830] Starting subtest: read
[36.392391] Subtest read: SUCCESS (0.130s)
[36.470467] [009/171] (957s left) fbdev (write)
[36.601068] Starting subtest: write
[36.673899] Subtest write: SUCCESS (0.075s)
[36.750271] [010/171] (957s left) gem_basic (bad-close)
[36.911865] Starting subtest: bad-close
[36.952498] Subtest bad-close: SUCCESS (0.000s)
[37.044856] [011/171] (957s left) gem_basic (create-close)
[37.206504] Starting subtest: create-close
[37.256722] Subtest create-close: SUCCESS (0.000s)
[37.346437] [012/171] (956s left) gem_basic (create-fd-close)
[37.511203] Starting subtest: create-fd-close
[37.557624] Subtest create-fd-close: SUCCESS (0.000s)
[37.657415] [013/171] (956s left) gem_busy (busy@all-engines)
[37.855298] Starting subtest: busy
[37.884293] Starting dynamic subtest: all-engines
[37.909731] Dynamic subtest all-engines: SUCCESS (0.023s)
[37.935241] Subtest busy: SUCCESS (0.023s)
[38.188388] [014/171] (956s left) gem_close_race (basic-process)
[38.397500] Starting subtest: basic-process
[38.422930] Subtest basic-process: SUCCESS (0.037s)
[38.590783] [015/171] (955s left) gem_close_race (basic-threads)
[38.753097] Starting subtest: basic-threads
[39.942579] Subtest basic-threads: SUCCESS (1.202s)
[40.114256] [016/171] (954s left) gem_ctx_create (basic)
[40.292733] Starting subtest: basic
[40.312065] Subtest basic: SUCCESS (0.000s)
[40.453846] [017/171] (954s left) gem_ctx_create (basic-files)
[40.614372] Starting subtest: basic-files
[42.628147] Subtest basic-files: SUCCESS (2.017s)
[42.889102] [018/171] (951s left) gem_ctx_exec (basic)
[43.058593] Starting subtest: basic
[43.078060] Subtest basic: SUCCESS (0.002s)
[43.150933] [019/171] (951s left) gem_exec_basic (basic)
[43.325473] Starting subtest: basic
[43.344433] Starting dynamic subtest: rcs0-smem
[43.366178] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[43.391649] Starting dynamic subtest: bcs0-smem
[43.412779] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[43.437695] Starting dynamic subtest: vcs0-smem
[43.456916] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[43.476155] Subtest basic: SUCCESS (0.001s)
[43.550218] [020/171] (951s left) gem_exec_create (basic)
[43.708690] Starting subtest: basic
[43.727093] Starting dynamic subtest: smem
[45.725476] Dynamic subtest smem: SUCCESS (2.042s)
[45.746145] Subtest basic: SUCCESS (2.042s)
[45.919952] [021/171] (948s left) gem_exec_fence (basic-busy)
[46.178778] Starting subtest: basic-busy
[46.199691] Starting dynamic subtest: rcs0
[46.240151] Dynamic subtest rcs0: SUCCESS (0.025s)
[46.263824] Starting dynamic subtest: bcs0
[46.302196] Dynamic subtest bcs0: SUCCESS (0.016s)
[46.328446] Starting dynamic subtest: vcs0
[46.372682] Dynamic subtest vcs0: SUCCESS (0.031s)
[46.393373] Subtest basic-busy: SUCCESS (0.073s)
[46.800917] [022/171] (948s left) gem_exec_fence (basic-wait)
[47.051892] Starting subtest: basic-wait
[47.073654] Starting dynamic subtest: rcs0
[47.095345] Dynamic subtest rcs0: SUCCESS (0.027s)
[47.122316] Starting dynamic subtest: bcs0
[47.143342] Dynamic subtest bcs0: SUCCESS (0.024s)
[47.166721] Starting dynamic subtest: vcs0
[47.186029] Dynamic subtest vcs0: SUCCESS (0.023s)
[47.205190] Subtest basic-wait: SUCCESS (0.074s)
[47.590078] [023/171] (947s left) gem_exec_fence (basic-await)
[47.846478] Starting subtest: basic-await
[47.866895] Starting dynamic subtest: rcs0
[47.913389] Dynamic subtest rcs0: SUCCESS (0.070s)
[47.936928] Starting dynamic subtest: bcs0
[47.979837] Dynamic subtest bcs0: SUCCESS (0.066s)
[48.012659] Starting dynamic subtest: vcs0
[48.062888] Dynamic subtest vcs0: SUCCESS (0.072s)
[48.083214] Subtest basic-await: SUCCESS (0.208s)
[48.494398] [024/171] (946s left) gem_exec_fence (nb-await)
[48.744377] Starting subtest: nb-await
[48.763411] Starting dynamic subtest: rcs0
[48.805968] Dynamic subtest rcs0: SUCCESS (0.053s)
[48.831275] Starting dynamic subtest: bcs0
[48.853058] Dynamic subtest bcs0: SUCCESS (0.052s)
[48.876757] Starting dynamic subtest: vcs0
[48.916746] Dynamic subtest vcs0: SUCCESS (0.053s)
[48.936154] Subtest nb-await: SUCCESS (0.158s)
[49.357997] [025/171] (945s left) gem_exec_gttfill (basic)
[49.534177] Starting subtest: basic
[51.879292] Subtest basic: SUCCESS (2.369s)
[52.068230] [026/171] (942s left) gem_exec_parallel (engines)
[52.331350] Starting subtest: engines
[52.351424] Starting dynamic subtest: basic
[53.771257] Dynamic subtest basic: SUCCESS (1.473s)
[53.797410] Starting dynamic subtest: contexts
[55.384262] Dynamic subtest contexts: SUCCESS (1.611s)
[55.409849] Starting dynamic subtest: fds
[57.176811] Dynamic subtest fds: SUCCESS (1.792s)
[57.202776] Starting dynamic subtest: userptr
[58.728566] Dynamic subtest userptr: SUCCESS (1.547s)
[58.750601] Subtest engines: SUCCESS (6.423s)
[58.924571] [027/171] (936s left) gem_exec_store (basic)
[59.140573] Starting subtest: basic
[59.159802] Subtest basic: SUCCESS (0.037s)
[59.313540] [028/171] (935s left) gem_flink_basic (bad-flink)
[59.478838] Starting subtest: bad-flink
[59.500842] Subtest bad-flink: SUCCESS (0.000s)
[59.583115] [029/171] (935s left) gem_flink_basic (bad-open)
[59.752491] Starting subtest: bad-open
[59.771658] Subtest bad-open: SUCCESS (0.000s)
[59.842445] [030/171] (935s left) gem_flink_basic (basic)
[60.009134] Starting subtest: basic
[60.027938] Subtest basic: SUCCESS (0.000s)
[60.104979] [031/171] (935s left) gem_flink_basic (double-flink)
[60.265746] Starting subtest: double-flink
[60.288037] Subtest double-flink: SUCCESS (0.000s)
[60.367031] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[60.513878] Starting subtest: flink-lifetime
[60.536090] Subtest flink-lifetime: SUCCESS (0.001s)
[60.611633] [033/171] (934s left) gem_huc_copy (huc-copy)
[60.794983] Subtest huc-copy: SKIP (0.000s)
[60.878687] [034/171] (934s left) gem_linear_blits (basic)
[61.099543] Starting subtest: basic
[61.121032] Subtest basic: SUCCESS (0.005s)
[61.273037] [035/171] (934s left) gem_mmap (basic)
[61.646312] Starting subtest: basic
[61.756045] Subtest basic: SUCCESS (0.000s)
[61.832669] [036/171] (933s left) gem_mmap_gtt (basic)
[62.003367] Starting subtest: basic
[62.025428] Subtest basic: SUCCESS (0.000s)
[62.103692] [037/171] (933s left) gem_render_linear_blits (basic)
[62.268056] Starting subtest: basic
[62.367690] Subtest basic: SUCCESS (0.019s)
[62.445751] [038/171] (933s left) gem_render_tiled_blits (basic)
[62.613193] Starting subtest: basic
[62.737758] Subtest basic: SUCCESS (0.029s)
[62.812336] [039/171] (933s left) gem_ringfill (basic-all)
[63.054321] Starting subtest: basic-all
[64.156196] Subtest basic-all: SUCCESS (1.126s)
[64.271493] [040/171] (931s left) gem_softpin (allocator-basic)
[64.463788] Subtest allocator-basic: SKIP (0.000s)
[64.541974] [041/171] (931s left) gem_softpin (allocator-basic-reserve)
[64.726174] Subtest allocator-basic-reserve: SKIP (0.000s)
[64.805302] [042/171] (931s left) gem_softpin (safe-alignment)
[64.971674] Starting subtest: safe-alignment
[64.992800] Subtest safe-alignment: SUCCESS (0.005s)
[65.069857] [043/171] (931s left) gem_sync (basic-all)
[65.277965] Starting subtest: basic-all
[67.321412] Subtest basic-all: SUCCESS (2.092s)
[67.500404] [044/171] (928s left) gem_sync (basic-each)
[67.700232] Starting subtest: basic-each
[69.743559] Subtest basic-each: SUCCESS (2.087s)
[69.932984] [045/171] (926s left) gem_tiled_blits (basic)
[70.145552] Starting subtest: basic
[70.165349] Subtest basic: SUCCESS (0.011s)
[70.288278] [046/171] (926s left) gem_tiled_fence_blits (basic)
[70.598220] Starting subtest: basic
[70.620436] Subtest basic: SUCCESS (0.006s)
[70.747091] [047/171] (925s left) gem_tiled_pread_basic
[71.162761] [048/171] (925s left) gem_wait (busy@all-engines)
[71.332622] Starting subtest: busy
[71.352433] Starting dynamic subtest: all-engines
[71.846804] Dynamic subtest all-engines: SUCCESS (0.518s)
[71.866821] Subtest busy: SUCCESS (0.518s)
[72.045723] [049/171] (924s left) gem_wait (wait@all-engines)
[72.208882] Starting subtest: wait
[72.227327] Starting dynamic subtest: all-engines
[73.216434] Dynamic subtest all-engines: SUCCESS (1.017s)
[73.237741] Subtest wait: SUCCESS (1.017s)
[73.421848] [050/171] (923s left) i915_getparams_basic (basic-eu-total)
[73.585805] Starting subtest: basic-eu-total
[73.627377] Subtest basic-eu-total: SUCCESS (0.000s)
[73.705565] [051/171] (923s left) i915_getparams_basic (basic-subslice-total)
[73.871954] Starting subtest: basic-subslice-total
[73.914540] Subtest basic-subslice-total: SUCCESS (0.000s)
[73.986576] [052/171] (922s left) i915_hangman (error-state-basic)
[74.166505] Starting subtest: error-state-basic
[74.185533] Subtest error-state-basic: SUCCESS (0.006s)
[74.258488] [053/171] (922s left) i915_pciid
[74.522971] [054/171] (922s left) kms_addfb_basic (addfb25-bad-modifier)
[74.692131] Starting subtest: addfb25-bad-modifier
[74.715120] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[74.850822] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.019136] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.038267] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.113668] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[75.276081] Starting subtest: addfb25-modifier-no-flag
[75.294920] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[75.375253] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[75.535834] Starting subtest: addfb25-x-tiled-legacy
[75.557494] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[75.635028] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[75.802269] Starting subtest: addfb25-x-tiled-mismatch-legacy
[75.823155] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[75.896871] [059/171] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[76.074223] Starting subtest: addfb25-yf-tiled-legacy
[76.093102] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[76.170603] [060/171] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[76.333264] Starting subtest: addfb25-y-tiled-legacy
[76.351937] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[76.431852] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[76.592740] Starting subtest: addfb25-y-tiled-small-legacy
[76.635823] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[76.713198] [062/171] (920s left) kms_addfb_basic (bad-pitch-0)
[76.879438] Starting subtest: bad-pitch-0
[76.898919] Subtest bad-pitch-0: SUCCESS (0.000s)
[76.971815] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024)
[77.137153] Starting subtest: bad-pitch-1024
[77.155977] Subtest bad-pitch-1024: SUCCESS (0.000s)
[77.233965] [064/171] (920s left) kms_addfb_basic (bad-pitch-128)
[77.394983] Starting subtest: bad-pitch-128
[77.417252] Subtest bad-pitch-128: SUCCESS (0.000s)
[77.497371] [065/171] (920s left) kms_addfb_basic (bad-pitch-256)
[77.661992] Starting subtest: bad-pitch-256
[77.682667] Subtest bad-pitch-256: SUCCESS (0.000s)
[77.758509] [066/171] (919s left) kms_addfb_basic (bad-pitch-32)
[77.927204] Starting subtest: bad-pitch-32
[77.946429] Subtest bad-pitch-32: SUCCESS (0.000s)
[78.019571] [067/171] (919s left) kms_addfb_basic (bad-pitch-63)
[78.185037] Starting subtest: bad-pitch-63
[78.204360] Subtest bad-pitch-63: SUCCESS (0.000s)
[78.282248] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536)
[78.442412] Starting subtest: bad-pitch-65536
[78.463744] Subtest bad-pitch-65536: SUCCESS (0.000s)
[78.543215] [069/171] (919s left) kms_addfb_basic (bad-pitch-999)
[78.706560] Starting subtest: bad-pitch-999
[78.727570] Subtest bad-pitch-999: SUCCESS (0.000s)
[78.802573] [070/171] (919s left) kms_addfb_basic (basic)
[78.971133] Starting subtest: basic
[78.990076] Subtest basic: SUCCESS (0.000s)
[79.062508] [071/171] (918s left) kms_addfb_basic (basic-x-tiled-legacy)
[79.209124] Starting subtest: basic-x-tiled-legacy
[79.235606] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[79.313242] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy)
[79.475284] Starting subtest: basic-y-tiled-legacy
[79.494240] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[79.575585] [073/171] (918s left) kms_addfb_basic (bo-too-small)
[79.736957] Starting subtest: bo-too-small
[79.758898] Subtest bo-too-small: SUCCESS (0.000s)
[79.835570] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[80.000535] Starting subtest: bo-too-small-due-to-tiling
[80.021194] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[80.093269] [075/171] (918s left) kms_addfb_basic (clobberred-modifier)
[80.260676] Starting subtest: clobberred-modifier
[80.279863] Subtest clobberred-modifier: SUCCESS (0.000s)
[80.354581] [076/171] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[80.517716] Starting subtest: framebuffer-vs-set-tiling
[80.536740] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.616371] [077/171] (917s left) kms_addfb_basic (invalid-get-prop)
[80.777962] Starting subtest: invalid-get-prop
[80.799923] Subtest invalid-get-prop: SUCCESS (0.000s)
[80.876621] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any)
[81.035467] Starting subtest: invalid-get-prop-any
[81.057339] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[81.158321] [079/171] (917s left) kms_addfb_basic (invalid-set-prop)
[81.346217] Starting subtest: invalid-set-prop
[81.370660] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.466741] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any)
[81.654834] Starting subtest: invalid-set-prop-any
[81.678718] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[81.769697] [081/171] (916s left) kms_addfb_basic (no-handle)
[82.067720] Starting subtest: no-handle
[82.090994] Subtest no-handle: SUCCESS (0.000s)
[82.179268] [082/171] (916s left) kms_addfb_basic (size-max)
[82.374174] Starting subtest: size-max
[82.400131] Subtest size-max: SUCCESS (0.000s)
[82.499197] [083/171] (916s left) kms_addfb_basic (small-bo)
[82.679798] Starting subtest: small-bo
[82.713069] Subtest small-bo: SUCCESS (0.000s)
[82.812268] [084/171] (916s left) kms_addfb_basic (tile-pitch-mismatch)
[82.999683] Starting subtest: tile-pitch-mismatch
[83.026993] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[83.121052] [085/171] (915s left) kms_addfb_basic (too-high)
[83.308645] Starting subtest: too-high
[83.331766] Subtest too-high: SUCCESS (0.001s)
[83.434032] [086/171] (915s left) kms_addfb_basic (too-wide)
[83.616205] Starting subtest: too-wide
[83.639805] Subtest too-wide: SUCCESS (0.000s)
[83.728159] [087/171] (915s left) kms_addfb_basic (unused-handle)
[83.900504] Starting subtest: unused-handle
[83.922530] Subtest unused-handle: SUCCESS (0.000s)
[84.013066] [088/171] (915s left) kms_addfb_basic (unused-modifier)
[84.188898] Starting subtest: unused-modifier
[84.208872] Subtest unused-modifier: SUCCESS (0.000s)
[84.293316] [089/171] (914s left) kms_addfb_basic (unused-offsets)
[84.474840] Starting subtest: unused-offsets
[84.497749] Subtest unused-offsets: SUCCESS (0.000s)
[84.586744] [090/171] (914s left) kms_addfb_basic (unused-pitches)
[84.757358] Starting subtest: unused-pitches
[84.781018] Subtest unused-pitches: SUCCESS (0.000s)
[84.866668] [091/171] (914s left) kms_busy (basic)
[85.042079] Starting subtest: basic
[85.064690] Starting dynamic subtest: flip
[85.659053] Dynamic subtest flip: SUCCESS (0.629s)
[85.683748] Starting dynamic subtest: modeset
[86.151888] Dynamic subtest modeset: SUCCESS (0.497s)
[86.173674] Subtest basic: SUCCESS (1.127s)
[86.316176] [092/171] (913s left) kms_chamelium_hpd (dp-hpd-fast)
[86.550506] Subtest dp-hpd-fast: SKIP (0.000s)
[86.670141] [093/171] (912s left) kms_chamelium_edid (dp-edid-read)
[86.885362] Subtest dp-edid-read: SKIP (0.000s)
[87.009091] [094/171] (912s left) kms_chamelium_frames (dp-crc-fast)
[87.223978] Subtest dp-crc-fast: SKIP (0.000s)
[87.339219] [095/171] (912s left) kms_chamelium_hpd (hdmi-hpd-fast)
[87.547388] Subtest hdmi-hpd-fast: SKIP (0.000s)
[87.670870] [096/171] (912s left) kms_chamelium_edid (hdmi-edid-read)
[87.878473] Subtest hdmi-edid-read: SKIP (0.000s)
[87.995995] [097/171] (911s left) kms_chamelium_frames (hdmi-crc-fast)
[88.201951] Subtest hdmi-crc-fast: SKIP (0.000s)
[88.339670] [098/171] (911s left) kms_chamelium_hpd (vga-hpd-fast)
[88.550157] Subtest vga-hpd-fast: SKIP (0.000s)
[88.689387] [099/171] (911s left) kms_chamelium_edid (vga-edid-read)
[88.896662] Subtest vga-edid-read: SKIP (0.000s)
[89.020927] [100/171] (911s left) kms_prop_blob (basic)
[89.197238] Starting subtest: basic
[89.218674] Subtest basic: SUCCESS (0.000s)
[89.292786] [101/171] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[89.466601] Starting subtest: basic-busy-flip-before-cursor-atomic
[90.391087] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.940s)
[90.553113] [102/171] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[90.718718] Starting subtest: basic-busy-flip-before-cursor-legacy
[91.643632] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.937s)
[91.804621] [103/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[91.969170] Starting subtest: basic-flip-after-cursor-atomic
[92.893354] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.934s)
[93.062840] [104/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[93.227217] Starting subtest: basic-flip-after-cursor-legacy
[94.146015] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.930s)
[94.314936] [105/171] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[94.479733] Starting subtest: basic-flip-after-cursor-varying-size
[95.392943] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s)
[95.549181] [106/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[95.717438] Starting subtest: basic-flip-before-cursor-atomic
[96.630815] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.937s)
[96.799765] [107/171] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[96.971563] Starting subtest: basic-flip-before-cursor-legacy
[97.910807] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.946s)
[98.069643] [108/171] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[98.230491] Starting subtest: basic-flip-before-cursor-varying-size
[99.154113] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.937s)
[99.337466] [109/171] (901s left) kms_flip (basic-flip-vs-dpms)
[99.530639] Starting subtest: basic-flip-vs-dpms
[99.550716] Starting dynamic subtest: A-VGA1
[100.418327] Dynamic subtest A-VGA1: SUCCESS (0.935s)
[100.444697] Starting dynamic subtest: B-VGA1
[101.297027] Dynamic subtest B-VGA1: SUCCESS (0.879s)
[101.322496] Starting dynamic subtest: C-VGA1
[102.187442] Dynamic subtest C-VGA1: SUCCESS (0.877s)
[102.208255] Subtest basic-flip-vs-dpms: SUCCESS (2.694s)
[102.364823] [110/171] (898s left) kms_flip (basic-flip-vs-modeset)
[102.564375] Starting subtest: basic-flip-vs-modeset
[102.586820] Starting dynamic subtest: A-VGA1
[103.375575] Dynamic subtest A-VGA1: SUCCESS (0.851s)
[103.399721] Starting dynamic subtest: B-VGA1
[104.265092] Dynamic subtest B-VGA1: SUCCESS (0.900s)
[104.297533] Starting dynamic subtest: C-VGA1
[105.047725] Dynamic subtest C-VGA1: SUCCESS (0.784s)
[105.073592] Subtest basic-flip-vs-modeset: SUCCESS (2.538s)
[105.215832] [111/171] (895s left) kms_flip (basic-flip-vs-wf_vblank)
[105.414874] Starting subtest: basic-flip-vs-wf_vblank
[105.438061] Starting dynamic subtest: A-VGA1
[106.513739] Dynamic subtest A-VGA1: SUCCESS (1.143s)
[106.543291] Starting dynamic subtest: B-VGA1
[107.646829] Dynamic subtest B-VGA1: SUCCESS (1.125s)
[107.673614] Starting dynamic subtest: C-VGA1
[108.767484] Dynamic subtest C-VGA1: SUCCESS (1.123s)
[108.789138] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.395s)
[108.984096] [112/171] (892s left) kms_flip (basic-plain-flip)
[109.173984] Starting subtest: basic-plain-flip
[109.194842] Starting dynamic subtest: A-VGA1
[109.993265] Dynamic subtest A-VGA1: SUCCESS (0.865s)
[110.023663] Starting dynamic subtest: B-VGA1
[110.831689] Dynamic subtest B-VGA1: SUCCESS (0.838s)
[110.857692] Starting dynamic subtest: C-VGA1
[111.669526] Dynamic subtest C-VGA1: SUCCESS (0.838s)
[111.688422] Subtest basic-plain-flip: SUCCESS (2.544s)
[111.886904] [113/171] (889s left) kms_force_connector_basic (force-connector-state)
[112.065815] Starting subtest: force-connector-state
[112.198510] Subtest force-connector-state: SUCCESS (0.135s)
[112.395198] [114/171] (888s left) kms_force_connector_basic (force-edid)
[112.562431] Starting subtest: force-edid
[112.605971] Subtest force-edid: SUCCESS (0.062s)
[112.745352] [115/171] (888s left) kms_force_connector_basic (force-load-detect)
[112.907866] Starting subtest: force-load-detect
[113.028846] Subtest force-load-detect: SUCCESS (0.144s)
[113.246854] [116/171] (888s left) kms_force_connector_basic (prune-stale-modes)
[113.417078] Starting subtest: prune-stale-modes
[113.436224] Subtest prune-stale-modes: SUCCESS (0.016s)
[113.555663] [117/171] (887s left) kms_frontbuffer_tracking (basic)
[113.795936] Starting subtest: basic
[115.573262] Subtest basic: SUCCESS (1.853s)
[115.680687] [118/171] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[115.856227] Starting subtest: compare-crc-sanitycheck-xr24
[115.877846] Starting dynamic subtest: pipe-A-VGA-1
[116.115317] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.274s)
[116.140490] Starting dynamic subtest: pipe-B-VGA-1
[116.378796] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.267s)
[116.404409] Starting dynamic subtest: pipe-C-VGA-1
[116.666975] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.287s)
[116.686158] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.833s)
[116.848635] [119/171] (884s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[117.017882] Starting subtest: compare-crc-sanitycheck-nv12
[117.038941] Starting dynamic subtest: pipe-A-VGA-1
[117.078473] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[117.105622] Starting dynamic subtest: pipe-B-VGA-1
[117.153351] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[117.179899] Starting dynamic subtest: pipe-C-VGA-1
[117.220841] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s)
[117.260424] Subtest compare-crc-sanitycheck-nv12: SKIP (0.006s)
[117.341834] [120/171] (884s left) kms_pipe_crc_basic (hang-read-crc)
[117.506076] Starting subtest: hang-read-crc
[117.528411] Starting dynamic subtest: pipe-A-VGA-1
[118.260298] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.761s)
[118.285223] Starting dynamic subtest: pipe-B-VGA-1
[119.020495] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.762s)
[119.048099] Starting dynamic subtest: pipe-C-VGA-1
[119.795388] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.772s)
[119.814400] Subtest hang-read-crc: SUCCESS (2.298s)
[119.956893] [121/171] (881s left) kms_pipe_crc_basic (nonblocking-crc)
[120.127624] Starting subtest: nonblocking-crc
[120.149308] Starting dynamic subtest: pipe-A-VGA-1
[120.567989] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.456s)
[120.592577] Starting dynamic subtest: pipe-B-VGA-1
[121.034975] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[121.068688] Starting dynamic subtest: pipe-C-VGA-1
[121.468513] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.452s)
[121.493262] Subtest nonblocking-crc: SUCCESS (1.359s)
[121.639864] [122/171] (880s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[121.833675] Starting subtest: nonblocking-crc-frame-sequence
[121.858618] Starting dynamic subtest: pipe-A-VGA-1
[122.283494] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.450s)
[122.314417] Starting dynamic subtest: pipe-B-VGA-1
[122.725412] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.446s)
[122.756866] Starting dynamic subtest: pipe-C-VGA-1
[123.161513] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.453s)
[123.189126] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.354s)
[123.319115] [123/171] (878s left) kms_pipe_crc_basic (read-crc)
[123.515037] Starting subtest: read-crc
[123.545064] Starting dynamic subtest: pipe-A-VGA-1
[123.869291] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.386s)
[123.906961] Starting dynamic subtest: pipe-B-VGA-1
[124.255558] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[124.281751] Starting dynamic subtest: pipe-C-VGA-1
[124.640316] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.384s)
[124.659354] Subtest read-crc: SUCCESS (1.154s)
[124.805801] [124/171] (877s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[124.975189] Starting subtest: read-crc-frame-sequence
[124.997704] Starting dynamic subtest: pipe-A-VGA-1
[125.346673] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.381s)
[125.372377] Starting dynamic subtest: pipe-B-VGA-1
[125.724825] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[125.750041] Starting dynamic subtest: pipe-C-VGA-1
[126.112712] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.386s)
[126.133242] Subtest read-crc-frame-sequence: SUCCESS (1.151s)
[126.269049] [125/171] (875s left) kms_psr (primary_page_flip)
[126.466055] Subtest primary_page_flip: SKIP (0.000s)
[126.548623] [126/171] (875s left) kms_psr (cursor_plane_move)
[126.717761] Subtest cursor_plane_move: SKIP (0.000s)
[126.799683] [127/171] (875s left) kms_psr (sprite_plane_onoff)
[127.000141] Subtest sprite_plane_onoff: SKIP (0.000s)
[127.075808] [128/171] (875s left) kms_psr (primary_mmap_gtt)
[127.256337] Subtest primary_mmap_gtt: SKIP (0.000s)
[127.332892] [129/171] (875s left) kms_setmode (basic-clone-single-crtc)
[127.510443] Starting subtest: basic-clone-single-crtc
[127.571993] Subtest basic-clone-single-crtc: SKIP (0.000s)
[127.653864] [130/171] (875s left) i915_pm_backlight (basic-brightness)
[127.851028] Subtest basic-brightness: SKIP (0.000s)
[127.928927] [131/171] (874s left) i915_pm_rpm (basic-pci-d3-state)
[139.245596] Subtest basic-pci-d3-state: SKIP (0.000s)
[139.320760] [132/171] (863s left) i915_pm_rpm (basic-rte)
[139.470483] Starting subtest: basic-rte
[150.623891] Subtest basic-rte: SKIP (11.102s)
[150.745043] [133/171] (852s left) i915_pm_rps (basic-api)
[150.896312] Starting subtest: basic-api
[150.917713] Subtest basic-api: SUCCESS (0.002s)
[150.996463] [134/171] (852s left) prime_self_import (basic-llseek-bad)
[151.128686] Starting subtest: basic-llseek-bad
[151.171719] Subtest basic-llseek-bad: SUCCESS (0.001s)
[151.248846] [135/171] (851s left) prime_self_import (basic-llseek-size)
[151.396854] Starting subtest: basic-llseek-size
[151.437559] Subtest basic-llseek-size: SUCCESS (0.002s)
[151.511611] [136/171] (851s left) prime_self_import (basic-with_fd_dup)
[151.657525] Starting subtest: basic-with_fd_dup
[151.695489] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[151.774971] [137/171] (851s left) prime_self_import (basic-with_one_bo)
[151.900603] Starting subtest: basic-with_one_bo
[151.938906] Subtest basic-with_one_bo: SUCCESS (0.002s)
[152.019616] [138/171] (851s left) prime_self_import (basic-with_one_bo_two_files)
[152.143036] Starting subtest: basic-with_one_bo_two_files
[152.183744] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[152.264458] [139/171] (851s left) prime_self_import (basic-with_two_bos)
[152.407545] Starting subtest: basic-with_two_bos
[152.450292] Subtest basic-with_two_bos: SUCCESS (0.002s)
[152.526703] [140/171] (850s left) prime_vgem (basic-fence-flip)
[152.716592] Starting subtest: basic-fence-flip
[152.986725] Subtest basic-fence-flip: SUCCESS (0.314s)
[153.110286] [141/171] (850s left) prime_vgem (basic-fence-mmap)
[153.298045] Starting subtest: basic-fence-mmap
[153.317301] Subtest basic-fence-mmap: SUCCESS (0.025s)
[153.413370] [142/171] (850s left) prime_vgem (basic-fence-read)
[153.594240] Starting subtest: basic-fence-read
[153.616070] Subtest basic-fence-read: SUCCESS (0.040s)
[153.715746] [143/171] (849s left) prime_vgem (basic-gtt)
[153.903175] Starting subtest: basic-gtt
[153.922450] Subtest basic-gtt: SUCCESS (0.013s)
[154.019170] [144/171] (849s left) prime_vgem (basic-read)
[154.182586] Starting subtest: basic-read
[154.201800] Subtest basic-read: SUCCESS (0.017s)
[154.304407] [145/171] (849s left) prime_vgem (basic-write)
[154.491121] Starting subtest: basic-write
[154.512063] Subtest basic-write: SUCCESS (0.020s)
[154.605392] [146/171] (849s left) vgem_basic (setversion)
[154.778995] Starting subtest: setversion
[154.817620] Subtest setversion: SUCCESS (0.000s)
[154.899251] [147/171] (849s left) vgem_basic (create)
[155.047872] Starting subtest: create
[155.070123] Subtest create: SUCCESS (0.000s)
[155.151681] [148/171] (848s left) vgem_basic (debugfs)
[155.326215] Starting subtest: debugfs
[155.348237] Subtest debugfs: SUCCESS (0.001s)
[155.430217] [149/171] (848s left) vgem_basic (dmabuf-export)
[155.598941] Starting subtest: dmabuf-export
[155.637426] Subtest dmabuf-export: SUCCESS (0.002s)
[155.718057] [150/171] (848s left) vgem_basic (dmabuf-fence)
[155.882664] Starting subtest: dmabuf-fence
[155.904526] Subtest dmabuf-fence: SUCCESS (0.001s)
[155.987310] [151/171] (848s left) vgem_basic (dmabuf-fence-before)
[156.154255] Starting subtest: dmabuf-fence-before
[156.175365] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[156.250146] [152/171] (848s left) vgem_basic (dmabuf-mmap)
[156.400222] Starting subtest: dmabuf-mmap
[156.420235] Subtest dmabuf-mmap: SUCCESS (0.015s)
[156.494217] [153/171] (847s left) vgem_basic (mmap)
[156.645544] Starting subtest: mmap
[156.664448] Subtest mmap: SUCCESS (0.009s)
[156.738609] [154/171] (847s left) vgem_basic (second-client)
[156.907203] Starting subtest: second-client
[156.945949] Subtest second-client: SUCCESS (0.033s)
[157.026043] [155/171] (847s left) vgem_basic (sysfs)
[157.188148] Starting subtest: sysfs
[157.209645] Subtest sysfs: SUCCESS (0.001s)
[157.287138] [156/171] (847s left) core_hotunplug (unbind-rebind)
[157.502169] Starting subtest: unbind-rebind
[158.294194] Subtest unbind-rebind: SUCCESS (0.782s)
[158.414396] [157/171] (846s left) vgem_basic (unload)
[158.594841] Starting subtest: unload
[187.698920] Subtest unload: SUCCESS (28.928s)
[187.779991] [158/171] (817s left) i915_module_load (reload)
[187.929111] Starting subtest: reload
[190.018059] Subtest reload: SUCCESS (2.098s)
[190.109339] [159/171] (814s left) gem_lmem_swapping (basic)
[190.304824] Subtest basic: SKIP (0.000s)
[190.385787] [160/171] (814s left) gem_lmem_swapping (parallel-random-engines)
[190.575282] Subtest parallel-random-engines: SKIP (0.000s)
[190.653419] [161/171] (814s left) gem_lmem_swapping (random-engines)
[190.843029] Subtest random-engines: SKIP (0.000s)
[190.916934] [162/171] (814s left) gem_lmem_swapping (verify-random)
[191.107076] Subtest verify-random: SKIP (0.000s)
[191.183344] [163/171] (814s left) i915_pm_rpm (module-reload)
[202.475698] Subtest module-reload: SKIP (0.000s)
[202.556913] [164/171] (802s left) i915_selftest (live)
[203.442625] Starting subtest: live
[203.462368] Starting dynamic subtest: sanitycheck
[204.110143] Dynamic subtest sanitycheck: SUCCESS (0.663s)
[204.139054] Starting dynamic subtest: uncore
[204.743498] Dynamic subtest uncore: SUCCESS (0.636s)
[204.768886] Starting dynamic subtest: workarounds
[205.411775] Dynamic subtest workarounds: SUCCESS (0.667s)
[205.437207] Starting dynamic subtest: gt_engines
[206.056971] Dynamic subtest gt_engines: SUCCESS (0.642s)
[206.084251] Starting dynamic subtest: gt_timelines
[211.329488] Dynamic subtest gt_timelines: SUCCESS (5.274s)
[211.354619] Starting dynamic subtest: gt_contexts
[212.001250] Dynamic subtest gt_contexts: SUCCESS (0.668s)
[212.026873] Starting dynamic subtest: gt_lrc
[212.604395] Dynamic subtest gt_lrc: SUCCESS (0.605s)
[212.632693] Starting dynamic subtest: gt_mocs
[213.217166] Dynamic subtest gt_mocs: SUCCESS (0.610s)
[213.242753] Starting dynamic subtest: gt_pm
[221.926841] Dynamic subtest gt_pm: SUCCESS (8.708s)
[221.955849] Starting dynamic subtest: gt_heartbeat
[222.626340] Dynamic subtest gt_heartbeat: SUCCESS (0.701s)
[222.654450] Starting dynamic subtest: gt_tlb
[223.218678] Dynamic subtest gt_tlb: SUCCESS (0.589s)
[223.244771] Starting dynamic subtest: requests
[228.491239] Dynamic subtest requests: SUCCESS (5.273s)
[228.516847] Starting dynamic subtest: migrate
[229.077078] Dynamic subtest migrate: SUCCESS (0.583s)
[229.105332] Starting dynamic subtest: active
[229.687472] Dynamic subtest active: SUCCESS (0.612s)
[229.713146] Starting dynamic subtest: objects
[230.766208] Dynamic subtest objects: SUCCESS (1.076s)
[230.793614] Starting dynamic subtest: mman
[234.802327] Dynamic subtest mman: SUCCESS (4.037s)
[234.827471] Starting dynamic subtest: dmabuf
[235.457460] Dynamic subtest dmabuf: SUCCESS (0.652s)
[235.484817] Starting dynamic subtest: vma
[236.083465] Dynamic subtest vma: SUCCESS (0.627s)
[236.109438] Starting dynamic subtest: coherency
[237.826488] Dynamic subtest coherency: SUCCESS (1.740s)
[237.853675] Starting dynamic subtest: gtt
[241.694824] Dynamic subtest gtt: SUCCESS (3.868s)
[241.721101] Starting dynamic subtest: gem
[242.369047] Dynamic subtest gem: SUCCESS (0.673s)
[242.397180] Starting dynamic subtest: evict
[242.988093] Dynamic subtest evict: SUCCESS (0.619s)
[243.013485] Starting dynamic subtest: hugepages
[244.694078] Dynamic subtest hugepages: SUCCESS (1.706s)
[244.722316] Starting dynamic subtest: gem_contexts
[248.997172] Dynamic subtest gem_contexts: SUCCESS (4.296s)
[249.029109] Starting dynamic subtest: client
[249.669065] Dynamic subtest client: SUCCESS (0.670s)
[249.700162] Starting dynamic subtest: gem_migrate
[250.259701] Dynamic subtest gem_migrate: SUCCESS (0.593s)
[250.287537] Starting dynamic subtest: reset
[250.905786] Dynamic subtest reset: SUCCESS (0.643s)
[250.936268] Starting dynamic subtest: memory_region
[251.492458] Dynamic subtest memory_region: SUCCESS (0.591s)
[251.518349] Starting dynamic subtest: hangcheck
[264.830358] Dynamic subtest hangcheck: SUCCESS (13.337s)
[264.860132] Starting dynamic subtest: execlists
[265.444183] Dynamic subtest execlists: SUCCESS (0.610s)
[265.472667] Starting dynamic subtest: ring_submission
[266.057585] Dynamic subtest ring_submission: SUCCESS (0.615s)
[266.083227] Starting dynamic subtest: perf
[266.654953] Dynamic subtest perf: SUCCESS (0.594s)
[266.682849] Starting dynamic subtest: slpc
[267.256630] Dynamic subtest slpc: SUCCESS (0.603s)
[267.282192] Starting dynamic subtest: guc
[267.883832] Dynamic subtest guc: SUCCESS (0.625s)
[267.916158] Starting dynamic subtest: guc_multi_lrc
[268.507949] Dynamic subtest guc_multi_lrc: SUCCESS (0.623s)
[268.533834] Starting dynamic subtest: guc_hang
[269.085078] Dynamic subtest guc_hang: SUCCESS (0.576s)
[269.113405] Starting dynamic subtest: late_gt_pm
[269.707126] Dynamic subtest late_gt_pm: SUCCESS (0.622s)
[269.726095] Subtest live: SUCCESS (66.264s)
[269.906363] [165/171] (735s left) dmabuf (all-tests)
[270.045319] Starting subtest: all-tests
[270.064261] Starting dynamic subtest: sanitycheck
[270.130087] Dynamic subtest sanitycheck: SUCCESS (0.087s)
[270.155438] Starting dynamic subtest: dma_fence
[270.305157] Dynamic subtest dma_fence: SUCCESS (0.174s)
[270.328219] Starting dynamic subtest: dma_fence_chain
[282.356060] Dynamic subtest dma_fence_chain: SUCCESS (12.047s)
[282.384252] Starting dynamic subtest: dma_fence_unwrap
[282.426786] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s)
[282.453122] Starting dynamic subtest: dma_resv
[282.498350] Dynamic subtest dma_resv: SUCCESS (0.074s)
[282.517471] Subtest all-tests: SUCCESS (12.456s)
[282.598043] [166/171] (722s left) i915_suspend (basic-s2idle-without-i915)
[282.744898] Starting subtest: basic-s2idle-without-i915
[300.629001] Subtest basic-s2idle-without-i915: SUCCESS (2.583s)
[303.589437] [167/171] (720s left) i915_suspend (basic-s3-without-i915)
[303.736999] Starting subtest: basic-s3-without-i915
[322.461972] Subtest basic-s3-without-i915: SUCCESS (2.188s)
[325.571320] [168/171] (717s left) gem_exec_suspend (basic-s0)
[325.744104] Starting subtest: basic-S0
[325.763446] Starting dynamic subtest: smem
[343.436387] Dynamic subtest smem: SUCCESS (1.830s)
[343.454877] Subtest basic-S0: SUCCESS (1.831s)
[346.657713] [169/171] (715s left) gem_exec_suspend (basic-s3)
[346.814652] Starting subtest: basic-S3
[346.835152] Starting dynamic subtest: smem
[364.280362] Dynamic subtest smem: SUCCESS (1.715s)
[364.300860] Subtest basic-S3: SUCCESS (1.715s)
[367.466097] [170/171] (713s left) kms_chamelium_hpd (common-hpd-after-suspend)
[367.676097] Subtest common-hpd-after-suspend: SKIP (0.000s)
[367.794041] [171/171] (713s left) kms_pipe_crc_basic (suspend-read-crc)
[367.957386] Starting subtest: suspend-read-crc
[367.976657] Starting dynamic subtest: pipe-A-VGA-1
[386.439257] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.802s)
[386.465335] Starting dynamic subtest: pipe-B-VGA-1
[404.449915] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.795s)
[404.478849] Starting dynamic subtest: pipe-C-VGA-1
[422.459768] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.814s)
[422.482894] Subtest suspend-read-crc: SUCCESS (5.416s)
[425.587872] Closing watchdogs
Done.