[36.701888] Initializing watchdogs
[36.702128]   /dev/watchdog0
[36.727371] [001/171] (960s left) i915_module_load (load)
[36.866159] Starting subtest: load
[38.302784] Subtest load: SUCCESS (1.421s)
[38.411361] [002/171] (958s left) core_auth (basic-auth)
[38.609190] Starting subtest: basic-auth
[38.630617] Subtest basic-auth: SUCCESS (0.000s)
[38.703522] [003/171] (958s left) debugfs_test (read_all_entries)
[38.893169] Starting subtest: read_all_entries
[38.913840] Subtest read_all_entries: SUCCESS (0.049s)
[39.012185] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.177669] Starting subtest: basic-hwmon
[39.215470] Subtest basic-hwmon: SKIP (0.000s)
[39.295093] [005/171] (958s left) fbdev (eof)
[39.446245] Starting subtest: eof
[39.468193] Subtest eof: SUCCESS (0.000s)
[39.565318] [006/171] (957s left) fbdev (info)
[39.713081] Starting subtest: info
[39.734377] Subtest info: SUCCESS (0.000s)
[39.827745] [007/171] (957s left) fbdev (nullptr)
[39.958649] Starting subtest: nullptr
[39.979960] Subtest nullptr: SUCCESS (0.000s)
[40.070184] [008/171] (957s left) fbdev (read)
[40.196717] Starting subtest: read
[40.321124] Subtest read: SUCCESS (0.129s)
[40.416488] [009/171] (957s left) fbdev (write)
[40.546154] Starting subtest: write
[40.609841] Subtest write: SUCCESS (0.067s)
[40.714624] [010/171] (957s left) gem_basic (bad-close)
[40.862675] Starting subtest: bad-close
[40.905914] Subtest bad-close: SUCCESS (0.000s)
[40.997764] [011/171] (956s left) gem_basic (create-close)
[41.168564] Starting subtest: create-close
[41.207284] Subtest create-close: SUCCESS (0.000s)
[41.284600] [012/171] (956s left) gem_basic (create-fd-close)
[41.452598] Starting subtest: create-fd-close
[41.496177] Subtest create-fd-close: SUCCESS (0.000s)
[41.589117] [013/171] (956s left) gem_busy (busy@all-engines)
[41.764481] Starting subtest: busy
[41.783535] Starting dynamic subtest: all-engines
[41.802358] Dynamic subtest all-engines: SUCCESS (0.028s)
[41.821380] Subtest busy: SUCCESS (0.028s)
[42.103472] [014/171] (955s left) gem_close_race (basic-process)
[42.259156] Starting subtest: basic-process
[42.280444] Subtest basic-process: SUCCESS (0.040s)
[42.457207] [015/171] (955s left) gem_close_race (basic-threads)
[42.622625] Starting subtest: basic-threads
[43.756039] Subtest basic-threads: SUCCESS (1.150s)
[43.946784] [016/171] (954s left) gem_ctx_create (basic)
[44.120151] Starting subtest: basic
[44.139938] Subtest basic: SUCCESS (0.000s)
[44.283082] [017/171] (953s left) gem_ctx_create (basic-files)
[44.441043] Starting subtest: basic-files
[46.458256] Subtest basic-files: SUCCESS (2.014s)
[46.741902] [018/171] (951s left) gem_ctx_exec (basic)
[46.953854] Starting subtest: basic
[46.979499] Subtest basic: SUCCESS (0.003s)
[47.074309] [019/171] (951s left) gem_exec_basic (basic)
[47.261772] Starting subtest: basic
[47.284638] Starting dynamic subtest: rcs0-smem
[47.307433] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[47.344078] Starting dynamic subtest: bcs0-smem
[47.369862] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[47.399957] Starting dynamic subtest: vcs0-smem
[47.428042] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[47.452186] Subtest basic: SUCCESS (0.002s)
[47.552560] [020/171] (950s left) gem_exec_create (basic)
[47.752909] Starting subtest: basic
[47.775676] Starting dynamic subtest: smem
[49.764783] Dynamic subtest smem: SUCCESS (2.046s)
[49.790640] Subtest basic: SUCCESS (2.046s)
[49.968528] [021/171] (948s left) gem_exec_fence (basic-busy)
[50.251623] Starting subtest: basic-busy
[50.280771] Starting dynamic subtest: rcs0
[50.333816] Dynamic subtest rcs0: SUCCESS (0.027s)
[50.365166] Starting dynamic subtest: bcs0
[50.416706] Dynamic subtest bcs0: SUCCESS (0.022s)
[50.444382] Starting dynamic subtest: vcs0
[50.500511] Dynamic subtest vcs0: SUCCESS (0.026s)
[50.527470] Subtest basic-busy: SUCCESS (0.076s)
[50.882978] [022/171] (947s left) gem_exec_fence (basic-wait)
[51.160950] Starting subtest: basic-wait
[51.187951] Starting dynamic subtest: rcs0
[51.213281] Dynamic subtest rcs0: SUCCESS (0.024s)
[51.247982] Starting dynamic subtest: bcs0
[51.277608] Dynamic subtest bcs0: SUCCESS (0.020s)
[51.309169] Starting dynamic subtest: vcs0
[51.335256] Dynamic subtest vcs0: SUCCESS (0.029s)
[51.357174] Subtest basic-wait: SUCCESS (0.073s)
[51.681677] [023/171] (947s left) gem_exec_fence (basic-await)
[51.935587] Starting subtest: basic-await
[51.957292] Starting dynamic subtest: rcs0
[52.004178] Dynamic subtest rcs0: SUCCESS (0.068s)
[52.028983] Starting dynamic subtest: bcs0
[52.070688] Dynamic subtest bcs0: SUCCESS (0.067s)
[52.142240] Starting dynamic subtest: vcs0
[52.162167] Dynamic subtest vcs0: SUCCESS (0.083s)
[52.183480] Subtest basic-await: SUCCESS (0.218s)
[52.607759] [024/171] (946s left) gem_exec_fence (nb-await)
[52.856193] Starting subtest: nb-await
[52.875728] Starting dynamic subtest: rcs0
[52.914226] Dynamic subtest rcs0: SUCCESS (0.053s)
[52.938689] Starting dynamic subtest: bcs0
[52.981850] Dynamic subtest bcs0: SUCCESS (0.053s)
[53.007086] Starting dynamic subtest: vcs0
[53.027486] Dynamic subtest vcs0: SUCCESS (0.052s)
[53.046930] Subtest nb-await: SUCCESS (0.158s)
[53.473113] [025/171] (945s left) gem_exec_gttfill (basic)
[53.641532] Starting subtest: basic
[55.676319] Subtest basic: SUCCESS (2.063s)
[55.876490] [026/171] (943s left) gem_exec_parallel (engines)
[56.132506] Starting subtest: engines
[56.153726] Starting dynamic subtest: basic
[57.535661] Dynamic subtest basic: SUCCESS (1.431s)
[57.560523] Starting dynamic subtest: contexts
[59.103617] Dynamic subtest contexts: SUCCESS (1.565s)
[59.130797] Starting dynamic subtest: fds
[60.917540] Dynamic subtest fds: SUCCESS (1.814s)
[60.945368] Starting dynamic subtest: userptr
[62.399240] Dynamic subtest userptr: SUCCESS (1.483s)
[62.418340] Subtest engines: SUCCESS (6.295s)
[62.591962] [027/171] (936s left) gem_exec_store (basic)
[62.831222] Starting subtest: basic
[62.850516] Subtest basic: SUCCESS (0.037s)
[62.974560] [028/171] (936s left) gem_flink_basic (bad-flink)
[63.143444] Starting subtest: bad-flink
[63.165397] Subtest bad-flink: SUCCESS (0.000s)
[63.239859] [029/171] (935s left) gem_flink_basic (bad-open)
[63.409703] Starting subtest: bad-open
[63.429467] Subtest bad-open: SUCCESS (0.000s)
[63.502639] [030/171] (935s left) gem_flink_basic (basic)
[63.652616] Starting subtest: basic
[63.672041] Subtest basic: SUCCESS (0.000s)
[63.746997] [031/171] (935s left) gem_flink_basic (double-flink)
[63.894255] Starting subtest: double-flink
[63.913153] Subtest double-flink: SUCCESS (0.000s)
[63.990377] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[64.164165] Starting subtest: flink-lifetime
[64.185665] Subtest flink-lifetime: SUCCESS (0.001s)
[64.264563] [033/171] (935s left) gem_huc_copy (huc-copy)
[64.432543] Subtest huc-copy: SKIP (0.000s)
[64.509533] [034/171] (934s left) gem_linear_blits (basic)
[64.730108] Starting subtest: basic
[64.750086] Subtest basic: SUCCESS (0.005s)
[64.879602] [035/171] (934s left) gem_mmap (basic)
[65.140889] Starting subtest: basic
[65.246918] Subtest basic: SUCCESS (0.000s)
[65.319103] [036/171] (934s left) gem_mmap_gtt (basic)
[65.491850] Starting subtest: basic
[65.511321] Subtest basic: SUCCESS (0.000s)
[65.589192] [037/171] (934s left) gem_render_linear_blits (basic)
[65.752126] Starting subtest: basic
[65.858366] Subtest basic: SUCCESS (0.016s)
[65.931423] [038/171] (933s left) gem_render_tiled_blits (basic)
[66.087820] Starting subtest: basic
[66.211048] Subtest basic: SUCCESS (0.022s)
[66.285812] [039/171] (933s left) gem_ringfill (basic-all)
[66.538822] Starting subtest: basic-all
[67.619042] Subtest basic-all: SUCCESS (1.110s)
[67.715941] [040/171] (932s left) gem_softpin (allocator-basic)
[67.909541] Subtest allocator-basic: SKIP (0.000s)
[68.003856] [041/171] (931s left) gem_softpin (allocator-basic-reserve)
[68.186822] Subtest allocator-basic-reserve: SKIP (0.000s)
[68.289753] [042/171] (931s left) gem_softpin (safe-alignment)
[68.504691] Starting subtest: safe-alignment
[68.524115] Subtest safe-alignment: SUCCESS (0.005s)
[68.597742] [043/171] (931s left) gem_sync (basic-all)
[68.806243] Starting subtest: basic-all
[70.889900] Subtest basic-all: SUCCESS (2.126s)
[71.078178] [044/171] (928s left) gem_sync (basic-each)
[71.289062] Starting subtest: basic-each
[73.339802] Subtest basic-each: SUCCESS (2.079s)
[73.498477] [045/171] (926s left) gem_tiled_blits (basic)
[73.714621] Starting subtest: basic
[73.737150] Subtest basic: SUCCESS (0.010s)
[73.863337] [046/171] (926s left) gem_tiled_fence_blits (basic)
[74.162206] Starting subtest: basic
[74.182373] Subtest basic: SUCCESS (0.007s)
[74.313263] [047/171] (925s left) gem_tiled_pread_basic
[74.723346] [048/171] (925s left) gem_wait (busy@all-engines)
[74.904612] Starting subtest: busy
[74.939834] Starting dynamic subtest: all-engines
[75.411935] Dynamic subtest all-engines: SUCCESS (0.522s)
[75.438020] Subtest busy: SUCCESS (0.522s)
[75.639377] [049/171] (924s left) gem_wait (wait@all-engines)
[76.123967] Starting subtest: wait
[76.151395] Starting dynamic subtest: all-engines
[76.832554] Dynamic subtest all-engines: SUCCESS (1.018s)
[76.856656] Subtest wait: SUCCESS (1.018s)
[77.045621] [050/171] (923s left) i915_getparams_basic (basic-eu-total)
[77.227782] Starting subtest: basic-eu-total
[77.276614] Subtest basic-eu-total: SUCCESS (0.000s)
[77.371840] [051/171] (923s left) i915_getparams_basic (basic-subslice-total)
[77.541974] Starting subtest: basic-subslice-total
[77.593558] Subtest basic-subslice-total: SUCCESS (0.000s)
[77.692573] [052/171] (922s left) i915_hangman (error-state-basic)
[77.888616] Starting subtest: error-state-basic
[77.914315] Subtest error-state-basic: SUCCESS (0.004s)
[78.002701] [053/171] (922s left) i915_pciid
[78.332866] [054/171] (922s left) kms_addfb_basic (addfb25-bad-modifier)
[78.531983] Starting subtest: addfb25-bad-modifier
[78.561260] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[78.730590] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[78.898771] Starting subtest: addfb25-framebuffer-vs-set-tiling
[78.917942] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[78.999513] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[79.162169] Starting subtest: addfb25-modifier-no-flag
[79.183788] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[79.265552] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[79.431470] Starting subtest: addfb25-x-tiled-legacy
[79.452851] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[79.526770] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[79.696618] Starting subtest: addfb25-x-tiled-mismatch-legacy
[79.715910] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[79.790644] [059/171] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[79.956097] Starting subtest: addfb25-yf-tiled-legacy
[79.974999] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[80.057805] [060/171] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[80.220123] Starting subtest: addfb25-y-tiled-legacy
[80.241811] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[80.321925] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[80.488110] Starting subtest: addfb25-y-tiled-small-legacy
[80.527398] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[80.611797] [062/171] (920s left) kms_addfb_basic (bad-pitch-0)
[80.775261] Starting subtest: bad-pitch-0
[80.793938] Subtest bad-pitch-0: SUCCESS (0.000s)
[80.877656] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024)
[81.038938] Starting subtest: bad-pitch-1024
[81.060977] Subtest bad-pitch-1024: SUCCESS (0.000s)
[81.138497] [064/171] (920s left) kms_addfb_basic (bad-pitch-128)
[81.284294] Starting subtest: bad-pitch-128
[81.306360] Subtest bad-pitch-128: SUCCESS (0.000s)
[81.382410] [065/171] (920s left) kms_addfb_basic (bad-pitch-256)
[81.551688] Starting subtest: bad-pitch-256
[81.571024] Subtest bad-pitch-256: SUCCESS (0.000s)
[81.644264] [066/171] (919s left) kms_addfb_basic (bad-pitch-32)
[81.809565] Starting subtest: bad-pitch-32
[81.828854] Subtest bad-pitch-32: SUCCESS (0.000s)
[81.908531] [067/171] (919s left) kms_addfb_basic (bad-pitch-63)
[82.071975] Starting subtest: bad-pitch-63
[82.093545] Subtest bad-pitch-63: SUCCESS (0.000s)
[82.173186] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536)
[82.337545] Starting subtest: bad-pitch-65536
[82.358418] Subtest bad-pitch-65536: SUCCESS (0.000s)
[82.435839] [069/171] (919s left) kms_addfb_basic (bad-pitch-999)
[82.606101] Starting subtest: bad-pitch-999
[82.625097] Subtest bad-pitch-999: SUCCESS (0.000s)
[82.699387] [070/171] (919s left) kms_addfb_basic (basic)
[82.849374] Starting subtest: basic
[82.868674] Subtest basic: SUCCESS (0.000s)
[82.945563] [071/171] (918s left) kms_addfb_basic (basic-x-tiled-legacy)
[83.109748] Starting subtest: basic-x-tiled-legacy
[83.128588] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[83.209996] [072/171] (918s left) kms_addfb_basic (basic-y-tiled-legacy)
[83.374485] Starting subtest: basic-y-tiled-legacy
[83.396360] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[83.472930] [073/171] (918s left) kms_addfb_basic (bo-too-small)
[83.639275] Starting subtest: bo-too-small
[83.660365] Subtest bo-too-small: SUCCESS (0.000s)
[83.733326] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[83.907955] Starting subtest: bo-too-small-due-to-tiling
[83.927396] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[84.003982] [075/171] (918s left) kms_addfb_basic (clobberred-modifier)
[84.163835] Starting subtest: clobberred-modifier
[84.182628] Subtest clobberred-modifier: SUCCESS (0.000s)
[84.262961] [076/171] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[84.425133] Starting subtest: framebuffer-vs-set-tiling
[84.446526] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[84.524713] [077/171] (917s left) kms_addfb_basic (invalid-get-prop)
[84.688260] Starting subtest: invalid-get-prop
[84.709623] Subtest invalid-get-prop: SUCCESS (0.000s)
[84.784588] [078/171] (917s left) kms_addfb_basic (invalid-get-prop-any)
[84.952491] Starting subtest: invalid-get-prop-any
[84.971235] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[85.048309] [079/171] (917s left) kms_addfb_basic (invalid-set-prop)
[85.212196] Starting subtest: invalid-set-prop
[85.231091] Subtest invalid-set-prop: SUCCESS (0.000s)
[85.311665] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any)
[85.472711] Starting subtest: invalid-set-prop-any
[85.494494] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[85.571689] [081/171] (916s left) kms_addfb_basic (no-handle)
[85.739383] Starting subtest: no-handle
[85.760435] Subtest no-handle: SUCCESS (0.000s)
[85.835055] [082/171] (916s left) kms_addfb_basic (size-max)
[86.006038] Starting subtest: size-max
[86.025353] Subtest size-max: SUCCESS (0.000s)
[86.101056] [083/171] (916s left) kms_addfb_basic (small-bo)
[86.265152] Starting subtest: small-bo
[86.284053] Subtest small-bo: SUCCESS (0.000s)
[86.365238] [084/171] (916s left) kms_addfb_basic (tile-pitch-mismatch)
[86.526268] Starting subtest: tile-pitch-mismatch
[86.548042] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[86.624112] [085/171] (916s left) kms_addfb_basic (too-high)
[86.789838] Starting subtest: too-high
[86.811131] Subtest too-high: SUCCESS (0.001s)
[86.883844] [086/171] (915s left) kms_addfb_basic (too-wide)
[87.059449] Starting subtest: too-wide
[87.079183] Subtest too-wide: SUCCESS (0.000s)
[87.156130] [087/171] (915s left) kms_addfb_basic (unused-handle)
[87.319442] Starting subtest: unused-handle
[87.338166] Subtest unused-handle: SUCCESS (0.000s)
[87.417670] [088/171] (915s left) kms_addfb_basic (unused-modifier)
[87.579569] Starting subtest: unused-modifier
[87.601084] Subtest unused-modifier: SUCCESS (0.000s)
[87.678465] [089/171] (915s left) kms_addfb_basic (unused-offsets)
[87.846436] Starting subtest: unused-offsets
[87.867460] Subtest unused-offsets: SUCCESS (0.000s)
[87.940616] [090/171] (915s left) kms_addfb_basic (unused-pitches)
[88.109518] Starting subtest: unused-pitches
[88.128846] Subtest unused-pitches: SUCCESS (0.000s)
[88.205089] [091/171] (914s left) kms_busy (basic)
[88.385833] Starting subtest: basic
[88.406874] Starting dynamic subtest: flip
[89.030148] Dynamic subtest flip: SUCCESS (0.667s)
[89.058048] Starting dynamic subtest: modeset
[89.587118] Dynamic subtest modeset: SUCCESS (0.557s)
[89.605636] Subtest basic: SUCCESS (1.225s)
[89.765147] [092/171] (913s left) kms_chamelium_hpd (dp-hpd-fast)
[89.976908] Subtest dp-hpd-fast: SKIP (0.000s)
[90.106187] [093/171] (913s left) kms_chamelium_edid (dp-edid-read)
[90.310403] Subtest dp-edid-read: SKIP (0.000s)
[90.449751] [094/171] (912s left) kms_chamelium_frames (dp-crc-fast)
[90.686387] Subtest dp-crc-fast: SKIP (0.000s)
[90.830166] [095/171] (912s left) kms_chamelium_hpd (hdmi-hpd-fast)
[91.061535] Subtest hdmi-hpd-fast: SKIP (0.000s)
[91.201256] [096/171] (912s left) kms_chamelium_edid (hdmi-edid-read)
[91.445137] Subtest hdmi-edid-read: SKIP (0.000s)
[91.590540] [097/171] (912s left) kms_chamelium_frames (hdmi-crc-fast)
[91.815089] Subtest hdmi-crc-fast: SKIP (0.000s)
[91.942686] [098/171] (911s left) kms_chamelium_hpd (vga-hpd-fast)
[92.159728] Subtest vga-hpd-fast: SKIP (0.000s)
[92.281240] [099/171] (911s left) kms_chamelium_edid (vga-edid-read)
[92.498770] Subtest vga-edid-read: SKIP (0.000s)
[92.628620] [100/171] (911s left) kms_prop_blob (basic)
[92.813634] Starting subtest: basic
[92.835767] Subtest basic: SUCCESS (0.000s)
[92.914822] [101/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[93.090361] Starting subtest: basic-busy-flip-before-cursor-atomic
[94.011134] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.936s)
[94.178690] [102/171] (909s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[94.339309] Starting subtest: basic-busy-flip-before-cursor-legacy
[95.264225] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.936s)
[95.431192] [103/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[95.592119] Starting subtest: basic-flip-after-cursor-atomic
[96.513568] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.935s)
[96.683672] [104/171] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[96.848808] Starting subtest: basic-flip-after-cursor-legacy
[97.762527] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.934s)
[97.936210] [105/171] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[98.104054] Starting subtest: basic-flip-after-cursor-varying-size
[99.014254] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s)
[99.187058] [106/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[99.353815] Starting subtest: basic-flip-before-cursor-atomic
[100.275987] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.935s)
[100.449645] [107/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[100.614838] Starting subtest: basic-flip-before-cursor-legacy
[101.536155] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.930s)
[101.708376] [108/171] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[101.869614] Starting subtest: basic-flip-before-cursor-varying-size
[102.808740] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.954s)
[102.980167] [109/171] (901s left) kms_flip (basic-flip-vs-dpms)
[103.171069] Starting subtest: basic-flip-vs-dpms
[103.189872] Starting dynamic subtest: A-VGA1
[104.060348] Dynamic subtest A-VGA1: SUCCESS (0.937s)
[104.087556] Starting dynamic subtest: B-VGA1
[104.958320] Dynamic subtest B-VGA1: SUCCESS (0.887s)
[104.983197] Starting dynamic subtest: C-VGA1
[105.839873] Dynamic subtest C-VGA1: SUCCESS (0.888s)
[105.858733] Subtest basic-flip-vs-dpms: SUCCESS (2.716s)
[106.031137] [110/171] (898s left) kms_flip (basic-flip-vs-modeset)
[106.219674] Starting subtest: basic-flip-vs-modeset
[106.239185] Starting dynamic subtest: A-VGA1
[107.049861] Dynamic subtest A-VGA1: SUCCESS (0.866s)
[107.076060] Starting dynamic subtest: B-VGA1
[107.847338] Dynamic subtest B-VGA1: SUCCESS (0.796s)
[107.871725] Starting dynamic subtest: C-VGA1
[108.639049] Dynamic subtest C-VGA1: SUCCESS (0.791s)
[108.657650] Subtest basic-flip-vs-modeset: SUCCESS (2.456s)
[108.806265] [111/171] (896s left) kms_flip (basic-flip-vs-wf_vblank)
[108.994118] Starting subtest: basic-flip-vs-wf_vblank
[109.013125] Starting dynamic subtest: A-VGA1
[110.090861] Dynamic subtest A-VGA1: SUCCESS (1.143s)
[110.114893] Starting dynamic subtest: B-VGA1
[111.216049] Dynamic subtest B-VGA1: SUCCESS (1.125s)
[111.240357] Starting dynamic subtest: C-VGA1
[112.340300] Dynamic subtest C-VGA1: SUCCESS (1.123s)
[112.358820] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.396s)
[112.587684] [112/171] (892s left) kms_flip (basic-plain-flip)
[112.786788] Starting subtest: basic-plain-flip
[112.808970] Starting dynamic subtest: A-VGA1
[113.594076] Dynamic subtest A-VGA1: SUCCESS (0.859s)
[113.624668] Starting dynamic subtest: B-VGA1
[114.435118] Dynamic subtest B-VGA1: SUCCESS (0.839s)
[114.464354] Starting dynamic subtest: C-VGA1
[115.276130] Dynamic subtest C-VGA1: SUCCESS (0.839s)
[115.297297] Subtest basic-plain-flip: SUCCESS (2.542s)
[115.504118] [113/171] (889s left) kms_force_connector_basic (force-connector-state)
[115.693227] Starting subtest: force-connector-state
[115.840404] Subtest force-connector-state: SUCCESS (0.147s)
[116.033719] [114/171] (889s left) kms_force_connector_basic (force-edid)
[116.206908] Starting subtest: force-edid
[116.256164] Subtest force-edid: SUCCESS (0.067s)
[116.385441] [115/171] (888s left) kms_force_connector_basic (force-load-detect)
[116.570129] Starting subtest: force-load-detect
[116.699845] Subtest force-load-detect: SUCCESS (0.156s)
[116.928246] [116/171] (888s left) kms_force_connector_basic (prune-stale-modes)
[117.104594] Starting subtest: prune-stale-modes
[117.128272] Subtest prune-stale-modes: SUCCESS (0.016s)
[117.243375] [117/171] (888s left) kms_frontbuffer_tracking (basic)
[117.524203] Starting subtest: basic
[119.274380] Subtest basic: SUCCESS (1.862s)
[119.418882] [118/171] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[119.587786] Starting subtest: compare-crc-sanitycheck-xr24
[119.609320] Starting dynamic subtest: pipe-A-VGA-1
[119.846180] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.268s)
[119.873792] Starting dynamic subtest: pipe-B-VGA-1
[120.116054] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.267s)
[120.142589] Starting dynamic subtest: pipe-C-VGA-1
[120.391689] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.273s)
[120.411987] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.810s)
[120.556998] [119/171] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[120.719748] Starting subtest: compare-crc-sanitycheck-nv12
[120.741499] Starting dynamic subtest: pipe-A-VGA-1
[120.785260] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[120.812190] Starting dynamic subtest: pipe-B-VGA-1
[120.851166] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[120.876121] Starting dynamic subtest: pipe-C-VGA-1
[120.917836] Dynamic subtest pipe-C-VGA-1: SKIP (0.000s)
[120.961480] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[121.038359] [120/171] (884s left) kms_pipe_crc_basic (hang-read-crc)
[121.210066] Starting subtest: hang-read-crc
[121.229435] Starting dynamic subtest: pipe-A-VGA-1
[121.947730] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.759s)
[121.975192] Starting dynamic subtest: pipe-B-VGA-1
[122.720552] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.765s)
[122.745430] Starting dynamic subtest: pipe-C-VGA-1
[123.498837] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.775s)
[123.519505] Subtest hang-read-crc: SUCCESS (2.302s)
[123.654963] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc)
[123.819650] Starting subtest: nonblocking-crc
[123.841737] Starting dynamic subtest: pipe-A-VGA-1
[124.257277] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.445s)
[124.283604] Starting dynamic subtest: pipe-B-VGA-1
[124.703448] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.448s)
[124.728620] Starting dynamic subtest: pipe-C-VGA-1
[125.160208] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.453s)
[125.181426] Subtest nonblocking-crc: SUCCESS (1.350s)
[125.315574] [122/171] (880s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[125.481953] Starting subtest: nonblocking-crc-frame-sequence
[125.501181] Starting dynamic subtest: pipe-A-VGA-1
[125.916831] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.446s)
[125.944806] Starting dynamic subtest: pipe-B-VGA-1
[126.370305] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[126.394917] Starting dynamic subtest: pipe-C-VGA-1
[126.818362] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.455s)
[126.838200] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.351s)
[126.983947] [123/171] (878s left) kms_pipe_crc_basic (read-crc)
[127.154061] Starting subtest: read-crc
[127.173676] Starting dynamic subtest: pipe-A-VGA-1
[127.528578] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.390s)
[127.556319] Starting dynamic subtest: pipe-B-VGA-1
[127.912733] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.383s)
[127.940212] Starting dynamic subtest: pipe-C-VGA-1
[128.307628] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.388s)
[128.326413] Subtest read-crc: SUCCESS (1.164s)
[128.465392] [124/171] (877s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[128.630276] Starting subtest: read-crc-frame-sequence
[128.651789] Starting dynamic subtest: pipe-A-VGA-1
[128.998982] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.378s)
[129.024846] Starting dynamic subtest: pipe-B-VGA-1
[129.377142] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.382s)
[129.402407] Starting dynamic subtest: pipe-C-VGA-1
[129.767236] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.388s)
[129.788109] Subtest read-crc-frame-sequence: SUCCESS (1.152s)
[129.941691] [125/171] (876s left) kms_psr (primary_page_flip)
[130.134839] Subtest primary_page_flip: SKIP (0.000s)
[130.216082] [126/171] (876s left) kms_psr (cursor_plane_move)
[130.401741] Subtest cursor_plane_move: SKIP (0.000s)
[130.481918] [127/171] (875s left) kms_psr (sprite_plane_onoff)
[130.650480] Subtest sprite_plane_onoff: SKIP (0.000s)
[130.727792] [128/171] (875s left) kms_psr (primary_mmap_gtt)
[130.923955] Subtest primary_mmap_gtt: SKIP (0.000s)
[131.017132] [129/171] (875s left) kms_setmode (basic-clone-single-crtc)
[131.191882] Starting subtest: basic-clone-single-crtc
[131.262027] Subtest basic-clone-single-crtc: SKIP (0.000s)
[131.358767] [130/171] (875s left) i915_pm_backlight (basic-brightness)
[131.576484] Subtest basic-brightness: SKIP (0.000s)
[131.674635] [131/171] (874s left) i915_pm_rpm (basic-pci-d3-state)
[143.214087] Subtest basic-pci-d3-state: SKIP (0.000s)
[143.292416] [132/171] (863s left) i915_pm_rpm (basic-rte)
[143.441143] Starting subtest: basic-rte
[154.609575] Subtest basic-rte: SKIP (11.111s)
[154.729322] [133/171] (852s left) i915_pm_rps (basic-api)
[154.899420] Starting subtest: basic-api
[154.921148] Subtest basic-api: SUCCESS (0.002s)
[155.022369] [134/171] (851s left) prime_self_import (basic-llseek-bad)
[155.175253] Starting subtest: basic-llseek-bad
[155.217965] Subtest basic-llseek-bad: SUCCESS (0.001s)
[155.293425] [135/171] (851s left) prime_self_import (basic-llseek-size)
[155.447638] Starting subtest: basic-llseek-size
[155.486428] Subtest basic-llseek-size: SUCCESS (0.002s)
[155.563742] [136/171] (851s left) prime_self_import (basic-with_fd_dup)
[155.709603] Starting subtest: basic-with_fd_dup
[155.748318] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[155.851894] [137/171] (851s left) prime_self_import (basic-with_one_bo)
[155.995037] Starting subtest: basic-with_one_bo
[156.038471] Subtest basic-with_one_bo: SUCCESS (0.002s)
[156.115667] [138/171] (851s left) prime_self_import (basic-with_one_bo_two_files)
[156.264508] Starting subtest: basic-with_one_bo_two_files
[156.305632] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[156.380113] [139/171] (850s left) prime_self_import (basic-with_two_bos)
[156.530767] Starting subtest: basic-with_two_bos
[156.569043] Subtest basic-with_two_bos: SUCCESS (0.002s)
[156.648749] [140/171] (850s left) prime_vgem (basic-fence-flip)
[156.846967] Starting subtest: basic-fence-flip
[157.134033] Subtest basic-fence-flip: SUCCESS (0.329s)
[157.251461] [141/171] (850s left) prime_vgem (basic-fence-mmap)
[157.435869] Starting subtest: basic-fence-mmap
[157.458149] Subtest basic-fence-mmap: SUCCESS (0.026s)
[157.558413] [142/171] (849s left) prime_vgem (basic-fence-read)
[157.747968] Starting subtest: basic-fence-read
[157.767605] Subtest basic-fence-read: SUCCESS (0.040s)
[157.865956] [143/171] (849s left) prime_vgem (basic-gtt)
[158.030851] Starting subtest: basic-gtt
[158.051279] Subtest basic-gtt: SUCCESS (0.012s)
[158.154278] [144/171] (849s left) prime_vgem (basic-read)
[158.343064] Starting subtest: basic-read
[158.363358] Subtest basic-read: SUCCESS (0.017s)
[158.458320] [145/171] (849s left) prime_vgem (basic-write)
[158.626379] Starting subtest: basic-write
[158.645710] Subtest basic-write: SUCCESS (0.018s)
[158.748525] [146/171] (848s left) vgem_basic (setversion)
[158.944446] Starting subtest: setversion
[158.986633] Subtest setversion: SUCCESS (0.000s)
[159.060893] [147/171] (848s left) vgem_basic (create)
[159.212449] Starting subtest: create
[159.232468] Subtest create: SUCCESS (0.000s)
[159.308915] [148/171] (848s left) vgem_basic (debugfs)
[159.475994] Starting subtest: debugfs
[159.494924] Subtest debugfs: SUCCESS (0.001s)
[159.582614] [149/171] (848s left) vgem_basic (dmabuf-export)
[159.745215] Starting subtest: dmabuf-export
[159.788948] Subtest dmabuf-export: SUCCESS (0.002s)
[159.867750] [150/171] (848s left) vgem_basic (dmabuf-fence)
[160.038963] Starting subtest: dmabuf-fence
[160.059677] Subtest dmabuf-fence: SUCCESS (0.001s)
[160.133881] [151/171] (847s left) vgem_basic (dmabuf-fence-before)
[160.302977] Starting subtest: dmabuf-fence-before
[160.322606] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[160.404341] [152/171] (847s left) vgem_basic (dmabuf-mmap)
[160.568738] Starting subtest: dmabuf-mmap
[160.590841] Subtest dmabuf-mmap: SUCCESS (0.015s)
[160.673714] [153/171] (847s left) vgem_basic (mmap)
[160.850838] Starting subtest: mmap
[160.872339] Subtest mmap: SUCCESS (0.011s)
[160.949352] [154/171] (847s left) vgem_basic (second-client)
[161.121274] Starting subtest: second-client
[161.159921] Subtest second-client: SUCCESS (0.033s)
[161.238873] [155/171] (847s left) vgem_basic (sysfs)
[161.405890] Starting subtest: sysfs
[161.426692] Subtest sysfs: SUCCESS (0.000s)
[161.508365] [156/171] (846s left) core_hotunplug (unbind-rebind)
[161.721947] Starting subtest: unbind-rebind
[162.494607] Subtest unbind-rebind: SUCCESS (0.781s)
[162.592621] [157/171] (845s left) vgem_basic (unload)
[162.725161] Starting subtest: unload
[191.850233] Subtest unload: SUCCESS (28.939s)
[191.930538] [158/171] (816s left) i915_module_load (reload)
[192.079311] Starting subtest: reload
[194.204219] Subtest reload: SUCCESS (2.120s)
[194.297850] [159/171] (814s left) gem_lmem_swapping (basic)
[194.500033] Subtest basic: SKIP (0.000s)
[194.574917] [160/171] (814s left) gem_lmem_swapping (parallel-random-engines)
[194.761231] Subtest parallel-random-engines: SKIP (0.000s)
[194.841977] [161/171] (814s left) gem_lmem_swapping (random-engines)
[195.027479] Subtest random-engines: SKIP (0.000s)
[195.107509] [162/171] (813s left) gem_lmem_swapping (verify-random)
[195.277098] Subtest verify-random: SKIP (0.000s)
[195.354911] [163/171] (813s left) i915_pm_rpm (module-reload)
[206.664573] Subtest module-reload: SKIP (0.000s)
[206.738201] [164/171] (802s left) i915_selftest (live)
[207.641287] Starting subtest: live
[207.662750] Starting dynamic subtest: sanitycheck
[208.303114] Dynamic subtest sanitycheck: SUCCESS (0.664s)
[208.328507] Starting dynamic subtest: uncore
[208.910987] Dynamic subtest uncore: SUCCESS (0.604s)
[208.939143] Starting dynamic subtest: workarounds
[209.607776] Dynamic subtest workarounds: SUCCESS (0.698s)
[209.633382] Starting dynamic subtest: gt_engines
[210.272791] Dynamic subtest gt_engines: SUCCESS (0.657s)
[210.301864] Starting dynamic subtest: gt_timelines
[215.648326] Dynamic subtest gt_timelines: SUCCESS (5.380s)
[215.673853] Starting dynamic subtest: gt_contexts
[216.354080] Dynamic subtest gt_contexts: SUCCESS (0.704s)
[216.379743] Starting dynamic subtest: gt_lrc
[217.002158] Dynamic subtest gt_lrc: SUCCESS (0.643s)
[217.031097] Starting dynamic subtest: gt_mocs
[217.599133] Dynamic subtest gt_mocs: SUCCESS (0.599s)
[217.624427] Starting dynamic subtest: gt_pm
[225.964652] Dynamic subtest gt_pm: SUCCESS (8.361s)
[225.996518] Starting dynamic subtest: gt_heartbeat
[226.685314] Dynamic subtest gt_heartbeat: SUCCESS (0.719s)
[226.713024] Starting dynamic subtest: gt_tlb
[227.322784] Dynamic subtest gt_tlb: SUCCESS (0.638s)
[227.348562] Starting dynamic subtest: requests
[232.598535] Dynamic subtest requests: SUCCESS (5.274s)
[232.629154] Starting dynamic subtest: migrate
[233.221146] Dynamic subtest migrate: SUCCESS (0.620s)
[233.248114] Starting dynamic subtest: active
[233.851366] Dynamic subtest active: SUCCESS (0.629s)
[233.878447] Starting dynamic subtest: objects
[234.900644] Dynamic subtest objects: SUCCESS (1.048s)
[234.926433] Starting dynamic subtest: mman
[238.938093] Dynamic subtest mman: SUCCESS (4.037s)
[238.966089] Starting dynamic subtest: dmabuf
[239.630754] Dynamic subtest dmabuf: SUCCESS (0.690s)
[239.656493] Starting dynamic subtest: vma
[240.257198] Dynamic subtest vma: SUCCESS (0.616s)
[240.285351] Starting dynamic subtest: coherency
[242.064453] Dynamic subtest coherency: SUCCESS (1.814s)
[242.089952] Starting dynamic subtest: gtt
[246.007442] Dynamic subtest gtt: SUCCESS (3.942s)
[246.033169] Starting dynamic subtest: gem
[246.718466] Dynamic subtest gem: SUCCESS (0.709s)
[246.744424] Starting dynamic subtest: evict
[247.377053] Dynamic subtest evict: SUCCESS (0.654s)
[247.404482] Starting dynamic subtest: hugepages
[249.100456] Dynamic subtest hugepages: SUCCESS (1.724s)
[249.126627] Starting dynamic subtest: gem_contexts
[253.509798] Dynamic subtest gem_contexts: SUCCESS (4.407s)
[253.535544] Starting dynamic subtest: client
[254.149196] Dynamic subtest client: SUCCESS (0.635s)
[254.177119] Starting dynamic subtest: gem_migrate
[254.753513] Dynamic subtest gem_migrate: SUCCESS (0.605s)
[254.779286] Starting dynamic subtest: reset
[255.381429] Dynamic subtest reset: SUCCESS (0.623s)
[255.409163] Starting dynamic subtest: memory_region
[256.022253] Dynamic subtest memory_region: SUCCESS (0.642s)
[256.047664] Starting dynamic subtest: hangcheck
[269.385051] Dynamic subtest hangcheck: SUCCESS (13.359s)
[269.412038] Starting dynamic subtest: execlists
[270.029805] Dynamic subtest execlists: SUCCESS (0.645s)
[270.057085] Starting dynamic subtest: ring_submission
[270.676512] Dynamic subtest ring_submission: SUCCESS (0.642s)
[270.703865] Starting dynamic subtest: perf
[271.306252] Dynamic subtest perf: SUCCESS (0.630s)
[271.333368] Starting dynamic subtest: slpc
[271.889096] Dynamic subtest slpc: SUCCESS (0.573s)
[271.915544] Starting dynamic subtest: guc
[272.492536] Dynamic subtest guc: SUCCESS (0.610s)
[272.523526] Starting dynamic subtest: guc_multi_lrc
[273.130738] Dynamic subtest guc_multi_lrc: SUCCESS (0.636s)
[273.169194] Starting dynamic subtest: guc_hang
[273.754144] Dynamic subtest guc_hang: SUCCESS (0.611s)
[273.788355] Starting dynamic subtest: late_gt_pm
[274.385889] Dynamic subtest late_gt_pm: SUCCESS (0.632s)
[274.411859] Subtest live: SUCCESS (66.739s)
[274.638242] [165/171] (734s left) dmabuf (all-tests)
[274.827355] Starting subtest: all-tests
[274.853888] Starting dynamic subtest: sanitycheck
[274.910896] Dynamic subtest sanitycheck: SUCCESS (0.087s)
[274.943303] Starting dynamic subtest: dma_fence
[275.097406] Dynamic subtest dma_fence: SUCCESS (0.183s)
[275.128859] Starting dynamic subtest: dma_fence_chain
[287.023975] Dynamic subtest dma_fence_chain: SUCCESS (11.863s)
[287.051691] Starting dynamic subtest: dma_fence_unwrap
[287.072999] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s)
[287.098587] Starting dynamic subtest: dma_resv
[287.118145] Dynamic subtest dma_resv: SUCCESS (0.073s)
[287.137685] Subtest all-tests: SUCCESS (12.281s)
[287.214881] [166/171] (722s left) i915_suspend (basic-s2idle-without-i915)
[287.371228] Starting subtest: basic-s2idle-without-i915
[305.262058] Subtest basic-s2idle-without-i915: SUCCESS (2.293s)
[308.078915] [167/171] (719s left) i915_suspend (basic-s3-without-i915)
[308.226771] Starting subtest: basic-s3-without-i915
[327.262145] Subtest basic-s3-without-i915: SUCCESS (2.076s)
[330.271589] [168/171] (717s left) gem_exec_suspend (basic-s0)
[330.454394] Starting subtest: basic-S0
[330.473743] Starting dynamic subtest: smem
[347.141735] Dynamic subtest smem: SUCCESS (1.548s)
[347.163347] Subtest basic-S0: SUCCESS (1.549s)
[350.183139] [169/171] (715s left) gem_exec_suspend (basic-s3)
[350.350777] Starting subtest: basic-S3
[350.371237] Starting dynamic subtest: smem
[369.061185] Dynamic subtest smem: SUCCESS (1.568s)
[369.082687] Subtest basic-S3: SUCCESS (1.569s)
[372.270539] [170/171] (713s left) kms_chamelium_hpd (common-hpd-after-suspend)
[372.534285] Subtest common-hpd-after-suspend: SKIP (0.000s)
[372.648656] [171/171] (713s left) kms_pipe_crc_basic (suspend-read-crc)
[372.814179] Starting subtest: suspend-read-crc
[372.832643] Starting dynamic subtest: pipe-A-VGA-1
[392.211654] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.643s)
[392.236388] Starting dynamic subtest: pipe-B-VGA-1
[411.219547] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.677s)
[411.246888] Starting dynamic subtest: pipe-C-VGA-1
[430.227558] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.684s)
[430.245824] Subtest suspend-read-crc: SUCCESS (5.009s)
[433.357831] Closing watchdogs
Done.