[35.082822] Initializing watchdogs
[35.083001]   /dev/watchdog0
[35.090260] [001/171] (960s left) i915_module_load (load)
[35.452253] Starting subtest: load
[36.927815] Subtest load: SUCCESS (1.477s)
[36.967943] [002/171] (958s left) core_auth (basic-auth)
[37.100679] Starting subtest: basic-auth
[37.101829] Subtest basic-auth: SUCCESS (0.001s)
[37.169053] [003/171] (958s left) debugfs_test (read_all_entries)
[37.325523] Starting subtest: read_all_entries
[37.402783] Subtest read_all_entries: SUCCESS (0.075s)
[37.543921] [004/171] (958s left) debugfs_test (basic-hwmon)
[37.725962] Starting subtest: basic-hwmon
[37.728208] Subtest basic-hwmon: SKIP (0.000s)
[37.821705] [005/171] (957s left) fbdev (eof)
[37.948857] Starting subtest: eof
[37.949826] Subtest eof: SUCCESS (0.000s)
[38.006932] [006/171] (957s left) fbdev (info)
[38.127701] Starting subtest: info
[38.128872] Subtest info: SUCCESS (0.000s)
[38.193258] [007/171] (957s left) fbdev (nullptr)
[38.316926] Starting subtest: nullptr
[38.317903] Subtest nullptr: SUCCESS (0.000s)
[38.374188] [008/171] (957s left) fbdev (read)
[38.501168] Starting subtest: read
[38.732282] Subtest read: SUCCESS (0.230s)
[38.792528] [009/171] (956s left) fbdev (write)
[38.919252] Starting subtest: write
[39.041976] Subtest write: SUCCESS (0.122s)
[39.093750] [010/171] (956s left) gem_basic (bad-close)
[39.217231] Starting subtest: bad-close
[39.220085] Subtest bad-close: SUCCESS (0.000s)
[39.278367] [011/171] (956s left) gem_basic (create-close)
[39.402222] Starting subtest: create-close
[39.404450] Subtest create-close: SUCCESS (0.000s)
[39.477958] [012/171] (956s left) gem_basic (create-fd-close)
[39.601332] Starting subtest: create-fd-close
[39.603688] Subtest create-fd-close: SUCCESS (0.000s)
[39.680727] [013/171] (956s left) gem_busy (busy@all-engines)
[39.820486] Starting subtest: busy
[39.821958] Starting dynamic subtest: all-engines
[39.845640] Dynamic subtest all-engines: SUCCESS (0.025s)
[39.846778] Subtest busy: SUCCESS (0.025s)
[40.163629] [014/171] (955s left) gem_close_race (basic-process)
[40.318825] Starting subtest: basic-process
[40.370238] Subtest basic-process: SUCCESS (0.052s)
[40.549496] [015/171] (955s left) gem_close_race (basic-threads)
[40.707717] Starting subtest: basic-threads
[41.836366] Subtest basic-threads: SUCCESS (1.129s)
[42.020677] [016/171] (953s left) gem_ctx_create (basic)
[42.150823] Subtest basic: SKIP (0.000s)
[42.171768] [017/171] (953s left) gem_ctx_create (basic-files)
[42.299336] Subtest basic-files: SKIP (0.000s)
[42.341119] [018/171] (953s left) gem_ctx_exec (basic)
[42.469266] Subtest basic: SKIP (0.000s)
[42.543261] [019/171] (953s left) gem_exec_basic (basic)
[42.672894] Starting subtest: basic
[42.673976] Starting dynamic subtest: rcs0-smem
[42.675145] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[42.676240] Subtest basic: SUCCESS (0.001s)
[42.858267] [020/171] (953s left) gem_exec_create (basic)
[42.990652] Starting subtest: basic
[42.991779] Starting dynamic subtest: smem
[45.026354] Dynamic subtest smem: SUCCESS (2.037s)
[45.027529] Subtest basic: SUCCESS (2.038s)
[45.215643] [021/171] (950s left) gem_exec_fence (basic-busy)
[45.470447] Starting subtest: basic-busy
[45.471535] Starting dynamic subtest: rcs0
[45.481147] Dynamic subtest rcs0: SUCCESS (0.012s)
[45.482281] Subtest basic-busy: SUCCESS (0.013s)
[45.967544] [022/171] (950s left) gem_exec_fence (basic-wait)
[46.228594] Starting subtest: basic-wait
[46.229687] Starting dynamic subtest: rcs0
[46.242172] Dynamic subtest rcs0: SUCCESS (0.016s)
[46.243327] Subtest basic-wait: SUCCESS (0.016s)
[46.687371] [023/171] (949s left) gem_exec_fence (basic-await)
[46.945705] Starting subtest: basic-await
[46.946798] Starting dynamic subtest: rcs0
[47.007653] Dynamic subtest rcs0: SUCCESS (0.062s)
[47.009049] Subtest basic-await: SUCCESS (0.063s)
[47.439503] [024/171] (948s left) gem_exec_fence (nb-await)
[47.694837] Starting subtest: nb-await
[47.695967] Starting dynamic subtest: rcs0
[47.746219] Dynamic subtest rcs0: SUCCESS (0.053s)
[47.747373] Subtest nb-await: SUCCESS (0.053s)
[48.193065] [025/171] (947s left) gem_exec_gttfill (basic)
[48.329052] Starting subtest: basic
[51.688332] Subtest basic: SUCCESS (3.359s)
[51.875466] [026/171] (944s left) gem_exec_parallel (engines)
[52.125939] Starting subtest: engines
[52.127063] Starting dynamic subtest: basic
[53.918371] Dynamic subtest basic: SUCCESS (1.795s)
[53.927123] Starting dynamic subtest: contexts
[53.930384] Dynamic subtest contexts: SKIP (0.001s)
[53.937593] Starting dynamic subtest: fds
[53.939680] Dynamic subtest fds: SKIP (0.000s)
[53.946843] Starting dynamic subtest: userptr
[55.785468] Dynamic subtest userptr: SUCCESS (1.865s)
[55.786790] Subtest engines: SUCCESS (3.663s)
[55.971967] [027/171] (940s left) gem_exec_store (basic)
[56.141208] Starting subtest: basic
[56.159782] Subtest basic: SUCCESS (0.018s)
[56.351386] [028/171] (939s left) gem_flink_basic (bad-flink)
[56.556549] Starting subtest: bad-flink
[56.557646] Subtest bad-flink: SUCCESS (0.000s)
[56.622390] [029/171] (939s left) gem_flink_basic (bad-open)
[56.759401] Starting subtest: bad-open
[56.760558] Subtest bad-open: SUCCESS (0.000s)
[56.837383] [030/171] (939s left) gem_flink_basic (basic)
[56.958728] Starting subtest: basic
[56.959845] Subtest basic: SUCCESS (0.000s)
[57.022241] [031/171] (939s left) gem_flink_basic (double-flink)
[57.145023] Starting subtest: double-flink
[57.146179] Subtest double-flink: SUCCESS (0.000s)
[57.223431] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[57.344794] Starting subtest: flink-lifetime
[57.345830] Subtest flink-lifetime: SUCCESS (0.001s)
[57.424504] [033/171] (938s left) gem_huc_copy (huc-copy)
[57.570100] Subtest huc-copy: SKIP (0.000s)
[57.611204] [034/171] (938s left) gem_linear_blits (basic)
[57.986386] Starting subtest: basic
[57.996736] Subtest basic: SUCCESS (0.012s)
[58.109827] [035/171] (938s left) gem_mmap (basic)
[58.351075] Starting subtest: basic
[58.357238] Subtest basic: SUCCESS (0.001s)
[58.428405] [036/171] (937s left) gem_mmap_gtt (basic)
[58.553676] Starting subtest: basic
[58.554797] Subtest basic: SUCCESS (0.001s)
[58.631053] [037/171] (937s left) gem_render_linear_blits (basic)
[58.756629] Starting subtest: basic
[58.803462] Subtest basic: SUCCESS (0.049s)
[58.847364] [038/171] (937s left) gem_render_tiled_blits (basic)
[58.972069] Starting subtest: basic
[59.017187] Subtest basic: SUCCESS (0.041s)
[59.066790] [039/171] (937s left) gem_ringfill (basic-all)
[59.212451] Starting subtest: basic-all
[60.318930] Subtest basic-all: SUCCESS (1.106s)
[60.384662] [040/171] (936s left) gem_softpin (allocator-basic)
[60.511029] Subtest allocator-basic: SKIP (0.000s)
[60.584593] [041/171] (935s left) gem_softpin (allocator-basic-reserve)
[60.711526] Subtest allocator-basic-reserve: SKIP (0.000s)
[60.769804] [042/171] (935s left) gem_softpin (safe-alignment)
[60.897979] Starting subtest: safe-alignment
[60.899143] Subtest safe-alignment: SUCCESS (0.006s)
[60.969568] [043/171] (935s left) gem_sync (basic-all)
[61.106533] Starting subtest: basic-all
[63.145596] Subtest basic-all: SUCCESS (2.038s)
[63.328422] [044/171] (933s left) gem_sync (basic-each)
[63.464048] Starting subtest: basic-each
[65.572261] Subtest basic-each: SUCCESS (2.109s)
[65.754254] [045/171] (930s left) gem_tiled_blits (basic)
[66.181194] Starting subtest: basic
[66.200361] Subtest basic: SUCCESS (0.021s)
[66.320437] [046/171] (930s left) gem_tiled_fence_blits (basic)
[66.844436] Starting subtest: basic
[66.858339] Subtest basic: SUCCESS (0.013s)
[66.959957] [047/171] (929s left) gem_tiled_pread_basic
[67.443333] [048/171] (929s left) gem_wait (busy@all-engines)
[67.585610] Starting subtest: busy
[67.589324] Starting dynamic subtest: all-engines
[68.095118] Dynamic subtest all-engines: SUCCESS (0.511s)
[68.096176] Subtest busy: SUCCESS (0.511s)
[68.296405] [049/171] (928s left) gem_wait (wait@all-engines)
[68.435086] Starting subtest: wait
[68.437977] Starting dynamic subtest: all-engines
[69.449175] Dynamic subtest all-engines: SUCCESS (1.014s)
[69.450225] Subtest wait: SUCCESS (1.015s)
[69.652440] [050/171] (926s left) i915_getparams_basic (basic-eu-total)
[69.774660] Starting subtest: basic-eu-total
[69.776896] Subtest basic-eu-total: SUCCESS (0.000s)
[69.834336] [051/171] (926s left) i915_getparams_basic (basic-subslice-total)
[69.955869] Starting subtest: basic-subslice-total
[69.959832] Subtest basic-subslice-total: SUCCESS (0.000s)
[70.018330] [052/171] (926s left) i915_hangman (error-state-basic)
[70.147905] Starting subtest: error-state-basic
[70.252341] Subtest error-state-basic: SUCCESS (0.108s)
[70.309293] [053/171] (926s left) i915_pciid
[70.506971] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[70.630499] Starting subtest: addfb25-bad-modifier
[70.632777] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[70.741003] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[70.868986] Starting subtest: addfb25-framebuffer-vs-set-tiling
[70.870155] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[70.976176] [056/171] (925s left) kms_addfb_basic (addfb25-modifier-no-flag)
[71.099799] Starting subtest: addfb25-modifier-no-flag
[71.101824] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.210382] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.338263] Starting subtest: addfb25-x-tiled-legacy
[71.339375] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.443154] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.568428] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.569573] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[71.661658] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[71.820828] Starting subtest: addfb25-yf-tiled-legacy
[71.822754] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[71.894804] [060/171] (924s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[72.037185] Starting subtest: addfb25-y-tiled-legacy
[72.038365] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[72.111793] [061/171] (924s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.255259] Starting subtest: addfb25-y-tiled-small-legacy
[72.257708] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[72.329146] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[72.450817] Starting subtest: bad-pitch-0
[72.452083] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.562930] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[72.689984] Starting subtest: bad-pitch-1024
[72.691088] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.781585] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[72.903775] Starting subtest: bad-pitch-128
[72.904931] Subtest bad-pitch-128: SUCCESS (0.000s)
[73.014278] [065/171] (923s left) kms_addfb_basic (bad-pitch-256)
[73.138191] Starting subtest: bad-pitch-256
[73.139275] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.233554] [066/171] (923s left) kms_addfb_basic (bad-pitch-32)
[73.354190] Starting subtest: bad-pitch-32
[73.355249] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.467116] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[73.594447] Starting subtest: bad-pitch-63
[73.595616] Subtest bad-pitch-63: SUCCESS (0.000s)
[73.701546] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[73.828709] Starting subtest: bad-pitch-65536
[73.829948] Subtest bad-pitch-65536: SUCCESS (0.000s)
[73.934608] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[74.061452] Starting subtest: bad-pitch-999
[74.062668] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.153521] [070/171] (922s left) kms_addfb_basic (basic)
[74.280371] Starting subtest: basic
[74.281545] Subtest basic: SUCCESS (0.000s)
[74.387225] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[74.514291] Starting subtest: basic-x-tiled-legacy
[74.515408] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[74.621377] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[74.749363] Starting subtest: basic-y-tiled-legacy
[74.750441] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[74.856010] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[75.016606] Starting subtest: bo-too-small
[75.017759] Subtest bo-too-small: SUCCESS (0.001s)
[75.088205] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.232423] Starting subtest: bo-too-small-due-to-tiling
[75.233581] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[75.306260] [075/171] (921s left) kms_addfb_basic (clobberred-modifier)
[75.433330] Starting subtest: clobberred-modifier
[75.434500] Subtest clobberred-modifier: SUCCESS (0.000s)
[75.540629] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[75.669403] Starting subtest: framebuffer-vs-set-tiling
[75.670646] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.774940] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[75.901750] Starting subtest: invalid-get-prop
[75.902818] Subtest invalid-get-prop: SUCCESS (0.000s)
[75.993347] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[76.120206] Starting subtest: invalid-get-prop-any
[76.121274] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.227534] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[76.354345] Starting subtest: invalid-set-prop
[76.355379] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.462949] [080/171] (920s left) kms_addfb_basic (invalid-set-prop-any)
[76.588162] Starting subtest: invalid-set-prop-any
[76.589270] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[76.694954] [081/171] (920s left) kms_addfb_basic (no-handle)
[76.821765] Starting subtest: no-handle
[76.823480] Subtest no-handle: SUCCESS (0.000s)
[76.913228] [082/171] (920s left) kms_addfb_basic (size-max)
[77.071462] Starting subtest: size-max
[77.072591] Subtest size-max: SUCCESS (0.000s)
[77.145452] [083/171] (920s left) kms_addfb_basic (small-bo)
[77.303985] Starting subtest: small-bo
[77.305195] Subtest small-bo: SUCCESS (0.001s)
[77.380780] [084/171] (919s left) kms_addfb_basic (tile-pitch-mismatch)
[77.508933] Starting subtest: tile-pitch-mismatch
[77.510069] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[77.614139] [085/171] (919s left) kms_addfb_basic (too-high)
[77.755742] Starting subtest: too-high
[77.756893] Subtest too-high: SUCCESS (0.001s)
[77.831283] [086/171] (919s left) kms_addfb_basic (too-wide)
[77.973980] Starting subtest: too-wide
[77.975392] Subtest too-wide: SUCCESS (0.000s)
[78.049358] [087/171] (919s left) kms_addfb_basic (unused-handle)
[78.176880] Starting subtest: unused-handle
[78.177995] Subtest unused-handle: SUCCESS (0.000s)
[78.283528] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[78.408367] Starting subtest: unused-modifier
[78.409490] Subtest unused-modifier: SUCCESS (0.000s)
[78.501556] [089/171] (918s left) kms_addfb_basic (unused-offsets)
[78.627363] Starting subtest: unused-offsets
[78.628511] Subtest unused-offsets: SUCCESS (0.000s)
[78.719122] [090/171] (918s left) kms_addfb_basic (unused-pitches)
[78.845333] Starting subtest: unused-pitches
[78.846454] Subtest unused-pitches: SUCCESS (0.000s)
[78.937214] [091/171] (918s left) kms_busy (basic)
[79.098176] Starting subtest: basic
[79.100676] Starting dynamic subtest: flip
[79.702038] Dynamic subtest flip: SUCCESS (0.599s)
[79.740889] Starting dynamic subtest: modeset
[79.746362] Dynamic subtest modeset: SKIP (0.000s)
[79.747419] Subtest basic: SUCCESS (0.603s)
[79.811799] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[79.966044] Subtest dp-hpd-fast: SKIP (0.000s)
[80.010602] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[80.169056] Subtest dp-edid-read: SKIP (0.000s)
[80.211924] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[80.367414] Subtest dp-crc-fast: SKIP (0.000s)
[80.395730] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[80.551167] Subtest hdmi-hpd-fast: SKIP (0.000s)
[80.597593] [096/171] (917s left) kms_chamelium_edid (hdmi-edid-read)
[80.754254] Subtest hdmi-edid-read: SKIP (0.000s)
[80.796829] [097/171] (916s left) kms_chamelium_frames (hdmi-crc-fast)
[80.934414] Subtest hdmi-crc-fast: SKIP (0.000s)
[80.980302] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[81.139278] Subtest vga-hpd-fast: SKIP (0.000s)
[81.181382] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[81.336796] Subtest vga-edid-read: SKIP (0.000s)
[81.382128] [100/171] (916s left) kms_prop_blob (basic)
[81.505872] Starting subtest: basic
[81.506993] Subtest basic: SUCCESS (0.000s)
[81.566547] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[81.721348] Starting subtest: basic-busy-flip-before-cursor-atomic
[81.725467] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.003s)
[81.797367] [102/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[81.957564] Starting subtest: basic-busy-flip-before-cursor-legacy
[82.946432] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.989s)
[83.052752] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.212735] Starting subtest: basic-flip-after-cursor-atomic
[83.214957] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[83.284947] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[83.443529] Starting subtest: basic-flip-after-cursor-legacy
[84.459968] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.012s)
[84.575196] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[84.732710] Starting subtest: basic-flip-after-cursor-varying-size
[85.742672] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.010s)
[85.864784] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.021891] Starting subtest: basic-flip-before-cursor-atomic
[86.024218] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.097676] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.256915] Starting subtest: basic-flip-before-cursor-legacy
[87.261769] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.003s)
[87.374491] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[87.533616] Starting subtest: basic-flip-before-cursor-varying-size
[88.538828] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.004s)
[88.651520] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[88.791549] Starting subtest: basic-flip-vs-dpms
[88.792715] Starting dynamic subtest: A-VGA1
[90.025096] Dynamic subtest A-VGA1: SUCCESS (1.228s)
[90.035864] Starting dynamic subtest: B-VGA1
[91.228377] Dynamic subtest B-VGA1: SUCCESS (1.208s)
[91.229435] Subtest basic-flip-vs-dpms: SUCCESS (2.437s)
[91.377387] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[91.534698] Starting subtest: basic-flip-vs-modeset
[91.536029] Starting dynamic subtest: A-VGA1
[92.811945] Dynamic subtest A-VGA1: SUCCESS (1.268s)
[92.828984] Starting dynamic subtest: B-VGA1
[94.017447] Dynamic subtest B-VGA1: SUCCESS (1.193s)
[94.018560] Subtest basic-flip-vs-modeset: SUCCESS (2.472s)
[94.209129] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[94.368414] Starting subtest: basic-flip-vs-wf_vblank
[94.369589] Starting dynamic subtest: A-VGA1
[95.958131] Dynamic subtest A-VGA1: SUCCESS (1.582s)
[95.983039] Starting dynamic subtest: B-VGA1
[97.493037] Dynamic subtest B-VGA1: SUCCESS (1.515s)
[97.494021] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.121s)
[97.654114] [112/171] (900s left) kms_flip (basic-plain-flip)
[97.811366] Starting subtest: basic-plain-flip
[97.812459] Starting dynamic subtest: A-VGA1
[99.082039] Dynamic subtest A-VGA1: SUCCESS (1.262s)
[99.105352] Starting dynamic subtest: B-VGA1
[100.317695] Dynamic subtest B-VGA1: SUCCESS (1.213s)
[100.318810] Subtest basic-plain-flip: SUCCESS (2.501s)
[100.486245] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[100.693317] Starting subtest: force-connector-state
[100.901165] Subtest force-connector-state: SUCCESS (0.208s)
[101.177320] [114/171] (896s left) kms_force_connector_basic (force-edid)
[101.350106] Starting subtest: force-edid
[101.469358] Subtest force-edid: SUCCESS (0.120s)
[101.643474] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[101.818917] Starting subtest: force-load-detect
[102.011857] Subtest force-load-detect: SUCCESS (0.190s)
[102.229626] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[102.437229] Starting subtest: prune-stale-modes
[102.538931] Subtest prune-stale-modes: SUCCESS (0.100s)
[102.716354] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[102.874730] Subtest basic: SKIP (0.000s)
[102.918228] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[103.074652] Starting subtest: compare-crc-sanitycheck-xr24
[103.075855] Starting dynamic subtest: pipe-A-VGA-1
[103.385113] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.300s)
[103.405909] Starting dynamic subtest: pipe-B-VGA-1
[103.741442] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.332s)
[103.742588] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.666s)
[103.866802] [119/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[104.024850] Starting subtest: compare-crc-sanitycheck-nv12
[104.025958] Starting dynamic subtest: pipe-A-VGA-1
[104.028159] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[104.038906] Starting dynamic subtest: pipe-B-VGA-1
[104.041592] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[104.043742] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[104.100043] [120/171] (894s left) kms_pipe_crc_basic (hang-read-crc)
[104.258967] Starting subtest: hang-read-crc
[104.260201] Starting dynamic subtest: pipe-A-VGA-1
[105.151375] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.891s)
[105.161844] Starting dynamic subtest: pipe-B-VGA-1
[106.057302] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.905s)
[106.058579] Subtest hang-read-crc: SUCCESS (1.799s)
[106.173897] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc)
[106.334102] Starting subtest: nonblocking-crc
[106.336318] Starting dynamic subtest: pipe-A-VGA-1
[106.818561] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[106.832460] Starting dynamic subtest: pipe-B-VGA-1
[107.361318] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.541s)
[107.362506] Subtest nonblocking-crc: SUCCESS (1.027s)
[107.478917] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[107.638868] Starting subtest: nonblocking-crc-frame-sequence
[107.641204] Starting dynamic subtest: pipe-A-VGA-1
[108.117520] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.477s)
[108.134919] Starting dynamic subtest: pipe-B-VGA-1
[108.655515] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.535s)
[108.656663] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.017s)
[108.780353] [123/171] (889s left) kms_pipe_crc_basic (read-crc)
[108.940498] Starting subtest: read-crc
[108.942884] Starting dynamic subtest: pipe-A-VGA-1
[109.339685] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.396s)
[109.350845] Starting dynamic subtest: pipe-B-VGA-1
[109.749587] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.410s)
[109.750788] Subtest read-crc: SUCCESS (0.809s)
[109.854960] [124/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[110.013345] Starting subtest: read-crc-frame-sequence
[110.016967] Starting dynamic subtest: pipe-A-VGA-1
[110.425168] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.408s)
[110.437927] Starting dynamic subtest: pipe-B-VGA-1
[110.874558] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.449s)
[110.876267] Subtest read-crc-frame-sequence: SUCCESS (0.861s)
[110.978166] [125/171] (887s left) kms_psr (primary_page_flip)
[111.104403] Subtest primary_page_flip: SKIP (0.000s)
[111.148251] [126/171] (887s left) kms_psr (cursor_plane_move)
[111.274424] Subtest cursor_plane_move: SKIP (0.000s)
[111.317160] [127/171] (886s left) kms_psr (sprite_plane_onoff)
[111.439826] Subtest sprite_plane_onoff: SKIP (0.000s)
[111.482916] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[111.605382] Subtest primary_mmap_gtt: SKIP (0.000s)
[111.633555] [129/171] (886s left) kms_setmode (basic-clone-single-crtc)
[111.756869] Starting subtest: basic-clone-single-crtc
[111.760094] Subtest basic-clone-single-crtc: SKIP (0.000s)
[111.831144] [130/171] (886s left) i915_pm_backlight (basic-brightness)
[111.990916] Subtest basic-brightness: SKIP (0.000s)
[112.034635] [131/171] (886s left) i915_pm_rpm (basic-pci-d3-state)
[123.358177] Subtest basic-pci-d3-state: SKIP (0.000s)
[123.391576] [132/171] (875s left) i915_pm_rpm (basic-rte)
[123.511043] Starting subtest: basic-rte
[134.704706] Subtest basic-rte: SKIP (11.179s)
[134.732230] [133/171] (863s left) i915_pm_rps (basic-api)
[134.860844] Subtest basic-api: SKIP (0.000s)
[134.898193] [134/171] (863s left) prime_self_import (basic-llseek-bad)
[135.020209] Starting subtest: basic-llseek-bad
[135.022459] Subtest basic-llseek-bad: SUCCESS (0.002s)
[135.095217] [135/171] (863s left) prime_self_import (basic-llseek-size)
[135.216415] Starting subtest: basic-llseek-size
[135.218725] Subtest basic-llseek-size: SUCCESS (0.003s)
[135.298060] [136/171] (863s left) prime_self_import (basic-with_fd_dup)
[135.419671] Starting subtest: basic-with_fd_dup
[135.421877] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[135.497061] [137/171] (863s left) prime_self_import (basic-with_one_bo)
[135.619929] Starting subtest: basic-with_one_bo
[135.622271] Subtest basic-with_one_bo: SUCCESS (0.004s)
[135.700725] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[135.819514] Starting subtest: basic-with_one_bo_two_files
[135.821820] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[135.898855] [139/171] (862s left) prime_self_import (basic-with_two_bos)
[136.018877] Starting subtest: basic-with_two_bos
[136.022296] Subtest basic-with_two_bos: SUCCESS (0.004s)
[136.099048] [140/171] (862s left) prime_vgem (basic-fence-flip)
[136.231191] Starting subtest: basic-fence-flip
[136.626920] Subtest basic-fence-flip: SUCCESS (0.399s)
[136.719263] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[136.850259] Starting subtest: basic-fence-mmap
[136.884160] Subtest basic-fence-mmap: SUCCESS (0.038s)
[136.953276] [142/171] (861s left) prime_vgem (basic-fence-read)
[137.083247] Starting subtest: basic-fence-read
[137.144286] Subtest basic-fence-read: SUCCESS (0.063s)
[137.220471] [143/171] (861s left) prime_vgem (basic-gtt)
[137.352054] Starting subtest: basic-gtt
[137.364568] Subtest basic-gtt: SUCCESS (0.017s)
[137.436974] [144/171] (861s left) prime_vgem (basic-read)
[137.569328] Starting subtest: basic-read
[137.593494] Subtest basic-read: SUCCESS (0.029s)
[137.670765] [145/171] (861s left) prime_vgem (basic-write)
[137.804234] Starting subtest: basic-write
[137.829247] Subtest basic-write: SUCCESS (0.031s)
[137.906218] [146/171] (860s left) vgem_basic (setversion)
[138.030245] Starting subtest: setversion
[138.032528] Subtest setversion: SUCCESS (0.000s)
[138.091617] [147/171] (860s left) vgem_basic (create)
[138.231852] Starting subtest: create
[138.233118] Subtest create: SUCCESS (0.000s)
[138.290367] [148/171] (860s left) vgem_basic (debugfs)
[138.415441] Starting subtest: debugfs
[138.416630] Subtest debugfs: SUCCESS (0.000s)
[138.474135] [149/171] (860s left) vgem_basic (dmabuf-export)
[138.601295] Starting subtest: dmabuf-export
[138.603535] Subtest dmabuf-export: SUCCESS (0.002s)
[138.674909] [150/171] (860s left) vgem_basic (dmabuf-fence)
[138.800591] Starting subtest: dmabuf-fence
[138.801829] Subtest dmabuf-fence: SUCCESS (0.001s)
[138.858177] [151/171] (859s left) vgem_basic (dmabuf-fence-before)
[138.983725] Starting subtest: dmabuf-fence-before
[138.984789] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[139.044859] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[139.168523] Starting subtest: dmabuf-mmap
[139.186914] Subtest dmabuf-mmap: SUCCESS (0.021s)
[139.246727] [153/171] (859s left) vgem_basic (mmap)
[139.368136] Starting subtest: mmap
[139.381986] Subtest mmap: SUCCESS (0.015s)
[139.444580] [154/171] (859s left) vgem_basic (second-client)
[139.568323] Starting subtest: second-client
[139.618182] Subtest second-client: SUCCESS (0.050s)
[139.679006] [155/171] (859s left) vgem_basic (sysfs)
[139.805257] Starting subtest: sysfs
[139.806409] Subtest sysfs: SUCCESS (0.001s)
[139.863060] [156/171] (859s left) core_hotunplug (unbind-rebind)
[140.035774] Starting subtest: unbind-rebind
[140.768147] Subtest unbind-rebind: SUCCESS (0.732s)
[140.803747] [157/171] (858s left) vgem_basic (unload)
[140.974683] Starting subtest: unload
[169.914379] Subtest unload: SUCCESS (28.937s)
[170.013838] [158/171] (828s left) i915_module_load (reload)
[170.136337] Starting subtest: reload
[172.047087] Subtest reload: SUCCESS (1.909s)
[172.075663] [159/171] (826s left) gem_lmem_swapping (basic)
[172.244894] Subtest basic: SKIP (0.000s)
[172.273333] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[172.436238] Subtest parallel-random-engines: SKIP (0.000s)
[172.482471] [161/171] (826s left) gem_lmem_swapping (random-engines)
[172.677472] Subtest random-engines: SKIP (0.000s)
[172.708095] [162/171] (826s left) gem_lmem_swapping (verify-random)
[172.834697] Subtest verify-random: SKIP (0.000s)
[172.877305] [163/171] (826s left) i915_pm_rpm (module-reload)
[184.209646] Subtest module-reload: SKIP (0.000s)
[184.231045] [164/171] (814s left) i915_selftest (live)
[185.021036] Starting subtest: live
[185.023593] Starting dynamic subtest: sanitycheck
[185.707304] Dynamic subtest sanitycheck: SUCCESS (0.686s)
[185.717297] Starting dynamic subtest: uncore
[186.359720] Dynamic subtest uncore: SUCCESS (0.652s)
[186.369682] Starting dynamic subtest: workarounds
[187.035051] Dynamic subtest workarounds: SUCCESS (0.674s)
[187.044668] Starting dynamic subtest: gt_engines
[187.654846] Dynamic subtest gt_engines: SUCCESS (0.619s)
[187.664318] Starting dynamic subtest: gt_timelines
[190.511973] Dynamic subtest gt_timelines: SUCCESS (2.855s)
[190.520694] Starting dynamic subtest: gt_contexts
[191.187524] Dynamic subtest gt_contexts: SUCCESS (0.676s)
[191.196972] Starting dynamic subtest: gt_lrc
[191.839847] Dynamic subtest gt_lrc: SUCCESS (0.651s)
[191.849522] Starting dynamic subtest: gt_mocs
[192.469646] Dynamic subtest gt_mocs: SUCCESS (0.629s)
[192.479278] Starting dynamic subtest: gt_pm
[193.618050] Dynamic subtest gt_pm: SUCCESS (1.147s)
[193.627268] Starting dynamic subtest: gt_heartbeat
[194.283436] Dynamic subtest gt_heartbeat: SUCCESS (0.666s)
[194.293871] Starting dynamic subtest: gt_tlb
[194.920681] Dynamic subtest gt_tlb: SUCCESS (0.636s)
[194.929093] Starting dynamic subtest: requests
[198.116173] Dynamic subtest requests: SUCCESS (3.194s)
[198.123636] Starting dynamic subtest: migrate
[198.742917] Dynamic subtest migrate: SUCCESS (0.627s)
[198.751542] Starting dynamic subtest: active
[199.420131] Dynamic subtest active: SUCCESS (0.675s)
[199.428610] Starting dynamic subtest: objects
[200.403609] Dynamic subtest objects: SUCCESS (0.983s)
[200.412447] Starting dynamic subtest: mman
[205.255411] Dynamic subtest mman: SUCCESS (4.852s)
[205.265433] Starting dynamic subtest: dmabuf
[205.989939] Dynamic subtest dmabuf: SUCCESS (0.732s)
[205.999330] Starting dynamic subtest: vma
[206.657730] Dynamic subtest vma: SUCCESS (0.668s)
[206.667823] Starting dynamic subtest: coherency
[208.422580] Dynamic subtest coherency: SUCCESS (1.763s)
[208.431564] Starting dynamic subtest: gtt
[212.649836] Dynamic subtest gtt: SUCCESS (4.226s)
[212.659092] Starting dynamic subtest: gem
[213.321253] Dynamic subtest gem: SUCCESS (0.671s)
[213.334032] Starting dynamic subtest: evict
[213.977762] Dynamic subtest evict: SUCCESS (0.657s)
[213.987246] Starting dynamic subtest: hugepages
[214.617592] Dynamic subtest hugepages: SUCCESS (0.639s)
[214.626819] Starting dynamic subtest: gem_contexts
[215.265078] Dynamic subtest gem_contexts: SUCCESS (0.647s)
[215.275912] Starting dynamic subtest: client
[215.930659] Dynamic subtest client: SUCCESS (0.664s)
[215.940105] Starting dynamic subtest: gem_migrate
[216.591085] Dynamic subtest gem_migrate: SUCCESS (0.659s)
[216.599897] Starting dynamic subtest: reset
[217.567182] Dynamic subtest reset: SUCCESS (0.974s)
[217.576180] Starting dynamic subtest: memory_region
[218.185688] Dynamic subtest memory_region: SUCCESS (0.619s)
[218.196033] Starting dynamic subtest: hangcheck
[219.900175] Dynamic subtest hangcheck: SUCCESS (1.712s)
[219.909333] Starting dynamic subtest: execlists
[220.569553] Dynamic subtest execlists: SUCCESS (0.670s)
[220.579764] Starting dynamic subtest: ring_submission
[221.220879] Dynamic subtest ring_submission: SUCCESS (0.650s)
[221.231753] Starting dynamic subtest: perf
[221.880669] Dynamic subtest perf: SUCCESS (0.659s)
[221.890577] Starting dynamic subtest: slpc
[222.511968] Dynamic subtest slpc: SUCCESS (0.630s)
[222.521045] Starting dynamic subtest: guc
[223.180781] Dynamic subtest guc: SUCCESS (0.668s)
[223.190725] Starting dynamic subtest: guc_multi_lrc
[223.821585] Dynamic subtest guc_multi_lrc: SUCCESS (0.640s)
[223.830969] Starting dynamic subtest: guc_hang
[224.447964] Dynamic subtest guc_hang: SUCCESS (0.625s)
[224.457646] Starting dynamic subtest: late_gt_pm
[225.083663] Dynamic subtest late_gt_pm: SUCCESS (0.635s)
[225.084903] Subtest live: SUCCESS (40.063s)
[225.229576] [165/171] (773s left) dmabuf (all-tests)
[225.360203] Starting subtest: all-tests
[225.361267] Starting dynamic subtest: sanitycheck
[225.415902] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[225.425912] Starting dynamic subtest: dma_fence
[225.596907] Dynamic subtest dma_fence: SUCCESS (0.179s)
[225.607989] Starting dynamic subtest: dma_fence_chain
[243.160256] Dynamic subtest dma_fence_chain: SUCCESS (17.562s)
[243.172593] Starting dynamic subtest: dma_fence_unwrap
[243.219456] Dynamic subtest dma_fence_unwrap: SUCCESS (0.061s)
[243.233386] Starting dynamic subtest: dma_resv
[243.292041] Dynamic subtest dma_resv: SUCCESS (0.070s)
[243.293190] Subtest all-tests: SUCCESS (17.936s)
[243.312714] [166/171] (755s left) i915_suspend (basic-s2idle-without-i915)
[243.431568] Starting subtest: basic-s2idle-without-i915
[261.477227] Subtest basic-s2idle-without-i915: SUCCESS (18.045s)
[263.952657] [167/171] (737s left) i915_suspend (basic-s3-without-i915)
[264.083856] Starting subtest: basic-s3-without-i915
[281.294704] Subtest basic-s3-without-i915: SUCCESS (2.340s)
[283.875681] [168/171] (735s left) gem_exec_suspend (basic-s0)
[284.017260] Starting subtest: basic-S0
[284.020858] Starting dynamic subtest: smem
[301.103286] Dynamic subtest smem: SUCCESS (17.084s)
[301.104343] Subtest basic-S0: SUCCESS (17.087s)
[305.888351] [169/171] (717s left) gem_exec_suspend (basic-s3)
[306.023663] Starting subtest: basic-S3
[306.024884] Starting dynamic subtest: smem
[323.888454] Dynamic subtest smem: SUCCESS (1.836s)
[323.889504] Subtest basic-S3: SUCCESS (1.837s)
[329.081193] [170/171] (715s left) kms_chamelium_hpd (common-hpd-after-suspend)
[329.233143] Subtest common-hpd-after-suspend: SKIP (0.000s)
[329.276629] [171/171] (715s left) kms_pipe_crc_basic (suspend-read-crc)
[329.434579] Starting subtest: suspend-read-crc
[329.435802] Starting dynamic subtest: pipe-A-VGA-1
[347.037860] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.779s)
[347.056089] Starting dynamic subtest: pipe-B-VGA-1
[364.958089] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.741s)
[364.959364] Subtest suspend-read-crc: SUCCESS (3.531s)
[370.090861] Closing watchdogs
Done.