[76.363403] Initializing watchdogs
[76.363791]   /dev/watchdog0
[76.413836] [001/171] (960s left) i915_module_load (load)
[77.265074] Starting subtest: load
[81.747637] Subtest load: SUCCESS (4.526s)
[82.157999] [002/171] (955s left) core_auth (basic-auth)
[83.403475] Starting subtest: basic-auth
[83.495627] Subtest basic-auth: SUCCESS (0.001s)
[83.896796] [003/171] (953s left) debugfs_test (read_all_entries)
[84.598188] Starting subtest: read_all_entries
[84.640050] Subtest read_all_entries: SUCCESS (0.046s)
[84.967465] [004/171] (953s left) debugfs_test (basic-hwmon)
[85.426951] Starting subtest: basic-hwmon
[85.494068] Subtest basic-hwmon: SKIP (0.000s)
[85.664280] [005/171] (952s left) fbdev (eof)
[86.190438] Starting subtest: eof
[86.232402] Subtest eof: SUCCESS (0.000s)
[86.341839] [006/171] (951s left) fbdev (info)
[86.717673] Starting subtest: info
[86.759476] Subtest info: SUCCESS (0.000s)
[86.860695] [007/171] (951s left) fbdev (nullptr)
[87.294757] Starting subtest: nullptr
[87.336560] Subtest nullptr: SUCCESS (0.000s)
[87.454221] [008/171] (951s left) fbdev (read)
[87.888370] Starting subtest: read
[88.305787] Subtest read: SUCCESS (0.534s)
[88.415364] [009/171] (950s left) fbdev (write)
[88.801182] Starting subtest: write
[88.842986] Subtest write: SUCCESS (0.131s)
[88.952692] [010/171] (949s left) gem_basic (bad-close)
[89.369939] Starting subtest: bad-close
[89.453566] Subtest bad-close: SUCCESS (0.000s)
[89.563304] [011/171] (949s left) gem_basic (create-close)
[89.963819] Starting subtest: create-close
[90.047537] Subtest create-close: SUCCESS (0.000s)
[90.156973] [012/171] (949s left) gem_basic (create-fd-close)
[90.566148] Starting subtest: create-fd-close
[90.666402] Subtest create-fd-close: SUCCESS (0.000s)
[90.793846] [013/171] (948s left) gem_busy (busy@all-engines)
[91.311817] Starting subtest: busy
[91.353588] Starting dynamic subtest: all-engines
[91.395620] Dynamic subtest all-engines: SUCCESS (0.036s)
[91.437539] Subtest busy: SUCCESS (0.036s)
[91.647608] [014/171] (947s left) gem_close_race (basic-process)
[92.181818] Starting subtest: basic-process
[92.223413] Subtest basic-process: SUCCESS (0.046s)
[92.391907] [015/171] (947s left) gem_close_race (basic-threads)
[92.792391] Starting subtest: basic-threads
[93.831838] Subtest basic-threads: SUCCESS (1.149s)
[94.033666] [016/171] (945s left) gem_ctx_create (basic)
[94.584757] Starting subtest: basic
[94.626586] Subtest basic: SUCCESS (0.000s)
[94.794283] [017/171] (945s left) gem_ctx_create (basic-files)
[95.253942] Starting subtest: basic-files
[97.252949] Subtest basic-files: SUCCESS (2.012s)
[97.445917] [018/171] (942s left) gem_ctx_exec (basic)
[97.914306] Starting subtest: basic
[97.956260] Subtest basic: SUCCESS (0.001s)
[98.065743] [019/171] (942s left) gem_exec_basic (basic)
[98.466206] Starting subtest: basic
[98.499847] Starting dynamic subtest: rcs0-smem
[98.533637] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[98.575417] Starting dynamic subtest: bcs0-smem
[98.608941] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[98.650768] Starting dynamic subtest: vcs0-smem
[98.684301] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[98.717770] Subtest basic: SUCCESS (0.001s)
[98.810651] [020/171] (941s left) gem_exec_create (basic)
[99.329821] Starting subtest: basic
[99.371610] Starting dynamic subtest: smem
[101.298362] Dynamic subtest smem: SUCCESS (2.039s)
[101.340311] Subtest basic: SUCCESS (2.039s)
[101.475263] [021/171] (938s left) gem_exec_fence (basic-busy)
[102.519228] Subtest basic-busy: SKIP (0.000s)
[102.954865] [022/171] (937s left) gem_exec_fence (basic-wait)
[103.508206] Subtest basic-wait: SKIP (0.000s)
[103.760068] [023/171] (936s left) gem_exec_fence (basic-await)
[104.378291] Subtest basic-await: SKIP (0.000s)
[104.655112] [024/171] (936s left) gem_exec_fence (nb-await)
[105.223348] Subtest nb-await: SKIP (0.000s)
[105.483095] [025/171] (935s left) gem_exec_gttfill (basic)
[105.908879] Starting subtest: basic
[110.789866] Subtest basic: SUCCESS (5.017s)
[111.007804] [026/171] (929s left) gem_exec_parallel (engines)
[112.976584] Starting subtest: engines
[113.018406] Starting dynamic subtest: basic
[114.553213] Dynamic subtest basic: SUCCESS (1.620s)
[114.603433] Starting dynamic subtest: contexts
[116.380017] Dynamic subtest contexts: SUCCESS (1.879s)
[116.430301] Starting dynamic subtest: fds
[118.841027] Dynamic subtest fds: SUCCESS (2.465s)
[118.883149] Starting dynamic subtest: userptr
[120.551652] Dynamic subtest userptr: SUCCESS (1.655s)
[120.584854] Subtest engines: SUCCESS (7.621s)
[120.728397] [027/171] (920s left) gem_exec_store (basic)
[121.415245] Starting subtest: basic
[121.465401] Subtest basic: SUCCESS (0.037s)
[121.591477] [028/171] (919s left) gem_flink_basic (bad-flink)
[122.008952] Starting subtest: bad-flink
[122.050865] Subtest bad-flink: SUCCESS (0.000s)
[122.160273] [029/171] (919s left) gem_flink_basic (bad-open)
[122.561426] Starting subtest: bad-open
[122.603324] Subtest bad-open: SUCCESS (0.000s)
[122.712600] [030/171] (918s left) gem_flink_basic (basic)
[123.097227] Starting subtest: basic
[123.139203] Subtest basic: SUCCESS (0.000s)
[123.248281] [031/171] (918s left) gem_flink_basic (double-flink)
[123.640875] Starting subtest: double-flink
[123.682909] Subtest double-flink: SUCCESS (0.000s)
[123.794244] [032/171] (918s left) gem_flink_basic (flink-lifetime)
[124.152980] Starting subtest: flink-lifetime
[124.195459] Subtest flink-lifetime: SUCCESS (0.001s)
[124.296202] [033/171] (917s left) gem_huc_copy (huc-copy)
[124.755429] Subtest huc-copy: SKIP (0.000s)
[124.864663] [034/171] (917s left) gem_linear_blits (basic)
[125.257282] Starting subtest: basic
[125.291357] Subtest basic: SUCCESS (0.009s)
[125.667507] [035/171] (916s left) gem_mmap (basic)
[127.744645] Starting subtest: basic
[127.978782] Subtest basic: SUCCESS (0.001s)
[128.089851] [036/171] (914s left) gem_mmap_gtt (basic)
[128.565797] Starting subtest: basic
[128.607732] Subtest basic: SUCCESS (0.001s)
[128.767333] [037/171] (914s left) gem_render_linear_blits (basic)
[129.159683] Starting subtest: basic
[129.368847] Subtest basic: SUCCESS (0.026s)
[129.477955] [038/171] (913s left) gem_render_tiled_blits (basic)
[129.896166] Starting subtest: basic
[130.138622] Subtest basic: SUCCESS (0.037s)
[130.247955] [039/171] (913s left) gem_ringfill (basic-all)
[130.850420] Starting subtest: basic-all
[131.868371] Subtest basic-all: SUCCESS (1.199s)
[131.978237] [040/171] (911s left) gem_softpin (allocator-basic)
[132.496222] Subtest allocator-basic: SKIP (0.000s)
[132.597311] [041/171] (911s left) gem_softpin (allocator-basic-reserve)
[133.048439] Subtest allocator-basic-reserve: SKIP (0.000s)
[133.166072] [042/171] (910s left) gem_softpin (safe-alignment)
[133.583741] Starting subtest: safe-alignment
[133.625658] Subtest safe-alignment: SUCCESS (0.007s)
[133.726707] [043/171] (910s left) gem_sync (basic-all)
[134.295982] Starting subtest: basic-all
[136.222887] Subtest basic-all: SUCCESS (2.094s)
[136.432592] [044/171] (907s left) gem_sync (basic-each)
[136.933540] Starting subtest: basic-each
[138.935573] Subtest basic-each: SUCCESS (2.080s)
[139.095537] [045/171] (905s left) gem_tiled_blits (basic)
[139.621777] Starting subtest: basic
[139.697085] Subtest basic: SUCCESS (0.019s)
[140.073456] [046/171] (904s left) gem_tiled_fence_blits (basic)
[142.144073] Starting subtest: basic
[142.261115] Subtest basic: SUCCESS (0.010s)
[142.687587] [047/171] (901s left) gem_tiled_pread_basic
[144.907549] [048/171] (899s left) gem_wait (busy@all-engines)
[145.332922] Starting subtest: busy
[145.374772] Starting dynamic subtest: all-engines
[145.784279] Dynamic subtest all-engines: SUCCESS (0.514s)
[145.825856] Subtest busy: SUCCESS (0.515s)
[145.985819] [049/171] (898s left) gem_wait (wait@all-engines)
[146.495223] Starting subtest: wait
[146.536989] Starting dynamic subtest: all-engines
[147.440072] Dynamic subtest all-engines: SUCCESS (1.019s)
[147.481574] Subtest wait: SUCCESS (1.019s)
[147.641641] [050/171] (897s left) i915_getparams_basic (basic-eu-total)
[148.092709] Starting subtest: basic-eu-total
[148.184513] Subtest basic-eu-total: SUCCESS (0.000s)
[148.302547] [051/171] (896s left) i915_getparams_basic (basic-subslice-total)
[148.745202] Starting subtest: basic-subslice-total
[148.828882] Subtest basic-subslice-total: SUCCESS (0.000s)
[148.946837] [052/171] (896s left) i915_hangman (error-state-basic)
[149.514233] Starting subtest: error-state-basic
[149.589293] Subtest error-state-basic: SUCCESS (0.007s)
[149.874291] [053/171] (895s left) i915_pciid
[150.461340] [054/171] (895s left) kms_addfb_basic (addfb25-bad-modifier)
[151.004386] Starting subtest: addfb25-bad-modifier
[151.121078] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[151.641488] [055/171] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[152.100941] Starting subtest: addfb25-framebuffer-vs-set-tiling
[152.134457] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[152.288472] [056/171] (893s left) kms_addfb_basic (addfb25-modifier-no-flag)
[152.756109] Starting subtest: addfb25-modifier-no-flag
[152.797993] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[152.966723] [057/171] (893s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[153.467743] Starting subtest: addfb25-x-tiled-legacy
[153.517979] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[153.678591] [058/171] (892s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[154.171124] Starting subtest: addfb25-x-tiled-mismatch-legacy
[154.204725] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[154.349968] [059/171] (892s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[154.926834] Starting subtest: addfb25-yf-tiled-legacy
[154.977460] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[155.128842] [060/171] (891s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[155.755480] Starting subtest: addfb25-y-tiled-legacy
[155.797787] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[155.932448] [061/171] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[156.494257] Starting subtest: addfb25-y-tiled-small-legacy
[156.578365] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[156.704731] [062/171] (889s left) kms_addfb_basic (bad-pitch-0)
[157.197241] Starting subtest: bad-pitch-0
[157.239177] Subtest bad-pitch-0: SUCCESS (0.000s)
[157.432735] [063/171] (889s left) kms_addfb_basic (bad-pitch-1024)
[157.908933] Starting subtest: bad-pitch-1024
[157.950900] Subtest bad-pitch-1024: SUCCESS (0.000s)
[158.136130] [064/171] (888s left) kms_addfb_basic (bad-pitch-128)
[158.605673] Starting subtest: bad-pitch-128
[158.656066] Subtest bad-pitch-128: SUCCESS (0.000s)
[158.858192] [065/171] (887s left) kms_addfb_basic (bad-pitch-256)
[159.258975] Starting subtest: bad-pitch-256
[159.300977] Subtest bad-pitch-256: SUCCESS (0.000s)
[159.444690] [066/171] (887s left) kms_addfb_basic (bad-pitch-32)
[159.895556] Starting subtest: bad-pitch-32
[159.929481] Subtest bad-pitch-32: SUCCESS (0.000s)
[160.099768] [067/171] (886s left) kms_addfb_basic (bad-pitch-63)
[160.584070] Starting subtest: bad-pitch-63
[160.625914] Subtest bad-pitch-63: SUCCESS (0.000s)
[160.794536] [068/171] (886s left) kms_addfb_basic (bad-pitch-65536)
[161.270461] Starting subtest: bad-pitch-65536
[161.312397] Subtest bad-pitch-65536: SUCCESS (0.000s)
[161.506145] [069/171] (885s left) kms_addfb_basic (bad-pitch-999)
[161.948821] Starting subtest: bad-pitch-999
[161.982422] Subtest bad-pitch-999: SUCCESS (0.000s)
[162.395616] [070/171] (884s left) kms_addfb_basic (basic)
[162.879791] Starting subtest: basic
[162.921690] Subtest basic: SUCCESS (0.000s)
[163.098816] [071/171] (884s left) kms_addfb_basic (basic-x-tiled-legacy)
[163.566256] Starting subtest: basic-x-tiled-legacy
[163.608195] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[163.809971] [072/171] (883s left) kms_addfb_basic (basic-y-tiled-legacy)
[164.221084] Starting subtest: basic-y-tiled-legacy
[164.263048] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[164.398491] [073/171] (883s left) kms_addfb_basic (bo-too-small)
[164.966473] Starting subtest: bo-too-small
[165.008614] Subtest bo-too-small: SUCCESS (0.000s)
[165.135136] [074/171] (882s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[165.628096] Starting subtest: bo-too-small-due-to-tiling
[165.670398] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[165.796781] [075/171] (881s left) kms_addfb_basic (clobberred-modifier)
[166.274310] Starting subtest: clobberred-modifier
[166.307921] Subtest clobberred-modifier: SUCCESS (0.000s)
[166.526909] [076/171] (881s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[166.985958] Starting subtest: framebuffer-vs-set-tiling
[167.036321] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[167.187822] [077/171] (880s left) kms_addfb_basic (invalid-get-prop)
[167.638863] Starting subtest: invalid-get-prop
[167.680838] Subtest invalid-get-prop: SUCCESS (0.000s)
[167.849471] [078/171] (880s left) kms_addfb_basic (invalid-get-prop-any)
[168.326979] Starting subtest: invalid-get-prop-any
[168.360524] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[168.546125] [079/171] (879s left) kms_addfb_basic (invalid-set-prop)
[169.021893] Starting subtest: invalid-set-prop
[169.072153] Subtest invalid-set-prop: SUCCESS (0.000s)
[169.257693] [080/171] (878s left) kms_addfb_basic (invalid-set-prop-any)
[169.708368] Starting subtest: invalid-set-prop-any
[169.750360] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[169.994239] [081/171] (878s left) kms_addfb_basic (no-handle)
[170.488568] Starting subtest: no-handle
[170.538833] Subtest no-handle: SUCCESS (0.000s)
[170.732603] [082/171] (877s left) kms_addfb_basic (size-max)
[171.326232] Starting subtest: size-max
[171.368492] Subtest size-max: SUCCESS (0.000s)
[171.486618] [083/171] (877s left) kms_addfb_basic (small-bo)
[172.021326] Starting subtest: small-bo
[172.054899] Subtest small-bo: SUCCESS (0.000s)
[172.258734] [084/171] (876s left) kms_addfb_basic (tile-pitch-mismatch)
[172.826558] Starting subtest: tile-pitch-mismatch
[172.868374] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[173.146147] [085/171] (875s left) kms_addfb_basic (too-high)
[173.755862] Starting subtest: too-high
[173.798214] Subtest too-high: SUCCESS (0.001s)
[173.932820] [086/171] (874s left) kms_addfb_basic (too-wide)
[174.519105] Starting subtest: too-wide
[174.561268] Subtest too-wide: SUCCESS (0.000s)
[174.662762] [087/171] (874s left) kms_addfb_basic (unused-handle)
[175.238560] Starting subtest: unused-handle
[175.280404] Subtest unused-handle: SUCCESS (0.000s)
[175.440720] [088/171] (873s left) kms_addfb_basic (unused-modifier)
[175.900019] Starting subtest: unused-modifier
[175.933517] Subtest unused-modifier: SUCCESS (0.000s)
[176.144194] [089/171] (872s left) kms_addfb_basic (unused-offsets)
[176.669803] Starting subtest: unused-offsets
[176.713418] Subtest unused-offsets: SUCCESS (0.000s)
[176.882278] [090/171] (872s left) kms_addfb_basic (unused-pitches)
[177.282990] Starting subtest: unused-pitches
[177.324852] Subtest unused-pitches: SUCCESS (0.000s)
[177.543643] [091/171] (871s left) kms_busy (basic)
[178.237455] Starting subtest: basic
[178.279329] Starting dynamic subtest: flip
[182.476641] Dynamic subtest flip: SUCCESS (4.318s)
[182.518599] Starting dynamic subtest: modeset
[184.767102] Dynamic subtest modeset: SUCCESS (2.341s)
[184.809054] Subtest basic: SUCCESS (6.660s)
[185.698343] [092/171] (863s left) kms_chamelium_hpd (dp-hpd-fast)
[186.725672] Subtest dp-hpd-fast: SKIP (0.000s)
[187.470795] [093/171] (861s left) kms_chamelium_edid (dp-edid-read)
[188.339843] Subtest dp-edid-read: SKIP (0.000s)
[189.011462] [094/171] (860s left) kms_chamelium_frames (dp-crc-fast)
[190.038438] Subtest dp-crc-fast: SKIP (0.000s)
[190.632931] [095/171] (858s left) kms_chamelium_hpd (hdmi-hpd-fast)
[191.593065] Subtest hdmi-hpd-fast: SKIP (0.000s)
[192.272764] [096/171] (857s left) kms_chamelium_edid (hdmi-edid-read)
[193.216726] Subtest hdmi-edid-read: SKIP (0.000s)
[193.878138] [097/171] (855s left) kms_chamelium_frames (hdmi-crc-fast)
[194.846808] Subtest hdmi-crc-fast: SKIP (0.000s)
[195.451170] [098/171] (854s left) kms_chamelium_hpd (vga-hpd-fast)
[196.378450] Subtest vga-hpd-fast: SKIP (0.000s)
[197.149084] [099/171] (852s left) kms_chamelium_edid (vga-edid-read)
[198.035994] Subtest vga-edid-read: SKIP (0.000s)
[198.764841] [100/171] (851s left) kms_prop_blob (basic)
[199.349156] Starting subtest: basic
[199.390986] Subtest basic: SUCCESS (0.000s)
[199.509193] [101/171] (850s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[200.127271] Starting subtest: basic-busy-flip-before-cursor-atomic
[201.314247] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.205s)
[202.092598] [102/171] (848s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[202.676890] Starting subtest: basic-busy-flip-before-cursor-legacy
[203.896078] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.220s)
[204.590984] [103/171] (846s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[205.193746] Starting subtest: basic-flip-after-cursor-atomic
[206.420978] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.213s)
[207.183092] [104/171] (843s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[207.842353] Starting subtest: basic-flip-after-cursor-legacy
[209.011084] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.174s)
[209.984314] [105/171] (840s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[210.593612] Starting subtest: basic-flip-after-cursor-varying-size
[211.829167] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.227s)
[212.599430] [106/171] (838s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[213.118422] Starting subtest: basic-flip-before-cursor-atomic
[214.320599] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.222s)
[215.065687] [107/171] (835s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[215.666907] Starting subtest: basic-flip-before-cursor-legacy
[216.835409] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.187s)
[217.573766] [108/171] (833s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[218.174840] Starting subtest: basic-flip-before-cursor-varying-size
[219.368716] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.191s)
[220.080541] [109/171] (831s left) kms_flip (basic-flip-vs-dpms)
[220.547823] Starting subtest: basic-flip-vs-dpms
[220.581215] Starting dynamic subtest: A-LVDS1
[222.287837] Dynamic subtest A-LVDS1: SUCCESS (1.743s)
[222.338161] Starting dynamic subtest: B-LVDS1
[223.758565] Dynamic subtest B-LVDS1: SUCCESS (1.508s)
[223.800434] Starting dynamic subtest: A-VGA1
[224.482533] Dynamic subtest A-VGA1: SUCCESS (0.701s)
[224.524580] Starting dynamic subtest: B-VGA1
[225.204151] Dynamic subtest B-VGA1: SUCCESS (0.700s)
[225.246084] Subtest basic-flip-vs-dpms: SUCCESS (4.659s)
[225.458591] [110/171] (825s left) kms_flip (basic-flip-vs-modeset)
[225.968226] Starting subtest: basic-flip-vs-modeset
[226.001853] Starting dynamic subtest: A-LVDS1
[227.665104] Dynamic subtest A-LVDS1: SUCCESS (1.730s)
[227.715368] Starting dynamic subtest: B-LVDS1
[229.046693] Dynamic subtest B-LVDS1: SUCCESS (1.404s)
[229.096808] Starting dynamic subtest: A-VGA1
[229.802018] Dynamic subtest A-VGA1: SUCCESS (0.733s)
[229.845641] Starting dynamic subtest: B-VGA1
[230.508943] Dynamic subtest B-VGA1: SUCCESS (0.714s)
[230.550917] Subtest basic-flip-vs-modeset: SUCCESS (4.587s)
[230.962830] [111/171] (820s left) kms_flip (basic-flip-vs-wf_vblank)
[231.474353] Starting subtest: basic-flip-vs-wf_vblank
[231.508019] Starting dynamic subtest: A-LVDS1
[233.203095] Dynamic subtest A-LVDS1: SUCCESS (1.764s)
[233.253246] Starting dynamic subtest: B-LVDS1
[235.014729] Dynamic subtest B-LVDS1: SUCCESS (1.810s)
[235.065019] Starting dynamic subtest: A-VGA1
[236.219661] Dynamic subtest A-VGA1: SUCCESS (1.205s)
[236.261626] Starting dynamic subtest: B-VGA1
[237.205522] Dynamic subtest B-VGA1: SUCCESS (0.966s)
[237.247251] Subtest basic-flip-vs-wf_vblank: SUCCESS (5.754s)
[237.434332] [112/171] (814s left) kms_flip (basic-plain-flip)
[238.050983] Starting subtest: basic-plain-flip
[238.092933] Starting dynamic subtest: A-LVDS1
[239.537243] Dynamic subtest A-LVDS1: SUCCESS (1.547s)
[239.579194] Starting dynamic subtest: B-LVDS1
[241.075267] Dynamic subtest B-LVDS1: SUCCESS (1.477s)
[241.125462] Starting dynamic subtest: A-VGA1
[241.960980] Dynamic subtest A-VGA1: SUCCESS (0.930s)
[242.011299] Starting dynamic subtest: B-VGA1
[242.654575] Dynamic subtest B-VGA1: SUCCESS (0.706s)
[242.688232] Subtest basic-plain-flip: SUCCESS (4.667s)
[243.102413] [113/171] (808s left) kms_force_connector_basic (force-connector-state)
[243.578719] Starting subtest: force-connector-state
[244.005567] Subtest force-connector-state: SUCCESS (0.537s)
[245.079143] [114/171] (806s left) kms_force_connector_basic (force-edid)
[245.613989] Starting subtest: force-edid
[245.747482] Subtest force-edid: SUCCESS (0.220s)
[246.219989] [115/171] (805s left) kms_force_connector_basic (force-load-detect)
[246.669255] Starting subtest: force-load-detect
[246.987137] Subtest force-load-detect: SUCCESS (0.403s)
[248.070869] [116/171] (804s left) kms_force_connector_basic (prune-stale-modes)
[248.586811] Starting subtest: prune-stale-modes
[248.637076] Subtest prune-stale-modes: SUCCESS (0.024s)
[249.008477] [117/171] (803s left) kms_frontbuffer_tracking (basic)
[249.643829] Starting subtest: basic
[251.780212] Subtest basic: SUCCESS (2.203s)
[251.899581] [118/171] (800s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[252.558350] Starting subtest: compare-crc-sanitycheck
[252.608565] Starting dynamic subtest: pipe-A-LVDS-1
[253.051748] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.500s)
[253.110363] Starting dynamic subtest: pipe-B-LVDS-1
[253.962774] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.895s)
[254.004735] Subtest compare-crc-sanitycheck: SUCCESS (1.398s)
[254.878334] [119/171] (797s left) kms_pipe_crc_basic (hang-read-crc)
[255.461785] Starting subtest: hang-read-crc
[255.504108] Starting dynamic subtest: pipe-A-LVDS-1
[257.351289] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.868s)
[257.394970] Starting dynamic subtest: pipe-B-LVDS-1
[259.751938] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.407s)
[259.785556] Subtest hang-read-crc: SUCCESS (4.277s)
[260.489416] [120/171] (792s left) kms_pipe_crc_basic (nonblocking-crc)
[261.124867] Starting subtest: nonblocking-crc
[261.167452] Starting dynamic subtest: pipe-A-LVDS-1
[261.810767] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.681s)
[261.861086] Starting dynamic subtest: pipe-B-LVDS-1
[263.139557] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.303s)
[263.181447] Subtest nonblocking-crc: SUCCESS (1.987s)
[263.869050] [121/171] (788s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[264.580092] Starting subtest: nonblocking-crc-frame-sequence
[264.622187] Starting dynamic subtest: pipe-A-LVDS-1
[265.257346] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.682s)
[265.307618] Starting dynamic subtest: pipe-B-LVDS-1
[266.561222] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.275s)
[266.611581] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.959s)
[267.460166] [122/171] (785s left) kms_pipe_crc_basic (read-crc)
[267.976247] Starting subtest: read-crc
[268.010119] Starting dynamic subtest: pipe-A-LVDS-1
[268.603905] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.623s)
[268.645814] Starting dynamic subtest: pipe-B-LVDS-1
[269.909043] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.227s)
[269.950873] Subtest read-crc: SUCCESS (1.852s)
[270.605326] [123/171] (782s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[271.297372] Starting subtest: read-crc-frame-sequence
[271.339484] Starting dynamic subtest: pipe-A-LVDS-1
[271.907929] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.621s)
[271.958251] Starting dynamic subtest: pipe-B-LVDS-1
[273.171583] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.223s)
[273.255162] Subtest read-crc-frame-sequence: SUCCESS (1.847s)
[273.884429] [124/171] (779s left) kms_psr (primary_page_flip)
[274.542315] Subtest primary_page_flip: SKIP (0.000s)
[274.670315] [125/171] (778s left) kms_psr (cursor_plane_move)
[275.202743] Subtest cursor_plane_move: SKIP (0.000s)
[275.313943] [126/171] (777s left) kms_psr (sprite_plane_onoff)
[275.838177] Subtest sprite_plane_onoff: SKIP (0.000s)
[275.965832] [127/171] (777s left) kms_psr (primary_mmap_gtt)
[276.400343] Subtest primary_mmap_gtt: SKIP (0.000s)
[276.511515] [128/171] (777s left) kms_setmode (basic-clone-single-crtc)
[276.960959] Starting subtest: basic-clone-single-crtc
[277.061423] Subtest basic-clone-single-crtc: SKIP (0.001s)
[277.164469] [129/171] (776s left) i915_pm_backlight (basic-brightness)
[277.856136] Subtest basic-brightness: SKIP (0.000s)
[278.010488] [130/171] (775s left) i915_pm_rpm (basic-pci-d3-state)
[280.005787] Subtest basic-pci-d3-state: SKIP (0.000s)
[280.125951] [131/171] (773s left) i915_pm_rpm (basic-rte)
[280.524481] Starting subtest: basic-rte
[281.994401] Subtest basic-rte: SKIP (1.390s)
[282.206356] [132/171] (772s left) i915_pm_rps (basic-api)
[282.773930] Starting subtest: basic-api
[282.815749] Subtest basic-api: SUCCESS (0.004s)
[282.926177] [133/171] (771s left) prime_self_import (basic-llseek-bad)
[283.359183] Starting subtest: basic-llseek-bad
[283.400955] Subtest basic-llseek-bad: SUCCESS (0.001s)
[283.510792] [134/171] (771s left) prime_self_import (basic-llseek-size)
[283.936441] Starting subtest: basic-llseek-size
[283.978272] Subtest basic-llseek-size: SUCCESS (0.003s)
[284.098092] [135/171] (770s left) prime_self_import (basic-with_fd_dup)
[284.488604] Starting subtest: basic-with_fd_dup
[284.538798] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[284.666749] [136/171] (770s left) prime_self_import (basic-with_one_bo)
[285.065737] Starting subtest: basic-with_one_bo
[285.107595] Subtest basic-with_one_bo: SUCCESS (0.003s)
[285.236031] [137/171] (769s left) prime_self_import (basic-with_one_bo_two_files)
[285.652841] Starting subtest: basic-with_one_bo_two_files
[285.703075] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[285.822752] [138/171] (769s left) prime_self_import (basic-with_two_bos)
[286.221856] Starting subtest: basic-with_two_bos
[286.263710] Subtest basic-with_two_bos: SUCCESS (0.002s)
[286.374689] [139/171] (769s left) prime_vgem (basic-fence-flip)
[286.857028] Starting subtest: basic-fence-flip
[287.091885] Subtest basic-fence-flip: SKIP (0.217s)
[287.278200] [140/171] (768s left) prime_vgem (basic-fence-mmap)
[287.720779] Starting subtest: basic-fence-mmap
[287.754750] Subtest basic-fence-mmap: SUCCESS (0.027s)
[287.966417] [141/171] (767s left) prime_vgem (basic-fence-read)
[288.357537] Starting subtest: basic-fence-read
[288.399480] Subtest basic-fence-read: SUCCESS (0.049s)
[288.552519] [142/171] (767s left) prime_vgem (basic-gtt)
[288.959769] Starting subtest: basic-gtt
[289.001544] Subtest basic-gtt: SUCCESS (0.013s)
[289.154774] [143/171] (766s left) prime_vgem (basic-read)
[289.561973] Starting subtest: basic-read
[289.603814] Subtest basic-read: SUCCESS (0.019s)
[289.756572] [144/171] (766s left) prime_vgem (basic-write)
[290.199397] Starting subtest: basic-write
[290.241217] Subtest basic-write: SUCCESS (0.023s)
[290.402472] [145/171] (766s left) prime_vgem (basic-userptr)
[290.893202] Starting subtest: basic-userptr
[290.960616] Subtest basic-userptr: SKIP (0.132s)
[291.096602] [146/171] (765s left) vgem_basic (setversion)
[291.545963] Starting subtest: setversion
[291.629689] Subtest setversion: SUCCESS (0.000s)
[291.740500] [147/171] (764s left) vgem_basic (create)
[292.148159] Starting subtest: create
[292.189937] Subtest create: SUCCESS (0.001s)
[292.307931] [148/171] (764s left) vgem_basic (debugfs)
[292.791996] Starting subtest: debugfs
[292.827175] Subtest debugfs: SUCCESS (0.000s)
[292.980090] [149/171] (763s left) vgem_basic (dmabuf-export)
[293.437441] Starting subtest: dmabuf-export
[293.487578] Subtest dmabuf-export: SUCCESS (0.002s)
[293.614595] [150/171] (763s left) vgem_basic (dmabuf-fence)
[294.139781] Starting subtest: dmabuf-fence
[294.181585] Subtest dmabuf-fence: SUCCESS (0.001s)
[294.293227] [151/171] (762s left) vgem_basic (dmabuf-fence-before)
[294.741819] Starting subtest: dmabuf-fence-before
[294.783703] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[294.876761] [152/171] (762s left) vgem_basic (dmabuf-mmap)
[295.369461] Starting subtest: dmabuf-mmap
[295.469604] Subtest dmabuf-mmap: SUCCESS (0.019s)
[295.582258] [153/171] (761s left) vgem_basic (mmap)
[295.973179] Starting subtest: mmap
[296.023380] Subtest mmap: SUCCESS (0.014s)
[296.151203] [154/171] (761s left) vgem_basic (second-client)
[296.683832] Starting subtest: second-client
[296.725663] Subtest second-client: SUCCESS (0.048s)
[296.886864] [155/171] (760s left) vgem_basic (sysfs)
[297.302758] Starting subtest: sysfs
[297.336304] Subtest sysfs: SUCCESS (0.001s)
[297.489201] [156/171] (760s left) core_hotunplug (unbind-rebind)
[298.263445] Starting subtest: unbind-rebind
[300.013076] Subtest unbind-rebind: SUCCESS (1.572s)
[300.631719] [157/171] (758s left) vgem_basic (unload)
[301.799712] Starting subtest: unload
[330.604275] Subtest unload: SUCCESS (29.038s)
[330.765319] [158/171] (728s left) i915_module_load (reload)
[331.248221] Starting subtest: reload
[334.880797] Subtest reload: SUCCESS (3.667s)
[335.026342] [159/171] (724s left) gem_lmem_swapping (basic)
[336.036544] Subtest basic: SKIP (0.000s)
[336.147547] [160/171] (723s left) gem_lmem_swapping (parallel-random-engines)
[336.689061] Subtest parallel-random-engines: SKIP (0.000s)
[336.808876] [161/171] (722s left) gem_lmem_swapping (random-engines)
[337.241113] Subtest random-engines: SKIP (0.000s)
[337.350718] [162/171] (722s left) gem_lmem_swapping (verify-random)
[337.852996] Subtest verify-random: SKIP (0.000s)
[337.964089] [163/171] (721s left) i915_pm_rpm (module-reload)
[339.925111] Subtest module-reload: SKIP (0.000s)
[340.060956] [164/171] (719s left) i915_selftest (live)
[341.562576] Starting subtest: live
[341.596223] Starting dynamic subtest: sanitycheck
[342.334752] Dynamic subtest sanitycheck: SUCCESS (0.763s)
[342.384921] Starting dynamic subtest: uncore
[343.054717] Dynamic subtest uncore: SUCCESS (0.728s)
[343.096494] Starting dynamic subtest: workarounds
[343.768089] Dynamic subtest workarounds: SUCCESS (0.705s)
[343.818209] Starting dynamic subtest: gt_engines
[344.479791] Dynamic subtest gt_engines: SUCCESS (0.717s)
[344.521757] Starting dynamic subtest: gt_timelines
[348.628308] Dynamic subtest gt_timelines: SUCCESS (4.142s)
[348.678546] Starting dynamic subtest: gt_contexts
[349.375136] Dynamic subtest gt_contexts: SUCCESS (0.745s)
[349.417045] Starting dynamic subtest: gt_lrc
[350.095532] Dynamic subtest gt_lrc: SUCCESS (0.713s)
[350.145678] Starting dynamic subtest: gt_mocs
[350.792038] Dynamic subtest gt_mocs: SUCCESS (0.697s)
[350.833875] Starting dynamic subtest: gt_pm
[357.493030] Dynamic subtest gt_pm: SUCCESS (6.699s)
[357.543325] Starting dynamic subtest: gt_heartbeat
[358.240162] Dynamic subtest gt_heartbeat: SUCCESS (0.746s)
[358.282141] Starting dynamic subtest: requests
[363.599300] Dynamic subtest requests: SUCCESS (5.355s)
[363.641096] Starting dynamic subtest: migrate
[364.295926] Dynamic subtest migrate: SUCCESS (0.698s)
[364.346149] Starting dynamic subtest: active
[365.040924] Dynamic subtest active: SUCCESS (0.740s)
[365.082764] Starting dynamic subtest: objects
[366.461841] Dynamic subtest objects: SUCCESS (1.418s)
[366.503747] Starting dynamic subtest: mman
[371.088429] Dynamic subtest mman: SUCCESS (4.632s)
[371.130309] Starting dynamic subtest: dmabuf
[371.790287] Dynamic subtest dmabuf: SUCCESS (0.698s)
[371.840383] Starting dynamic subtest: vma
[372.512459] Dynamic subtest vma: SUCCESS (0.718s)
[372.554291] Starting dynamic subtest: coherency
[374.107882] Dynamic subtest coherency: SUCCESS (1.592s)
[374.149636] Starting dynamic subtest: gtt
[378.343237] Dynamic subtest gtt: SUCCESS (4.234s)
[378.385153] Starting dynamic subtest: gem
[379.272378] Dynamic subtest gem: SUCCESS (0.929s)
[379.322588] Starting dynamic subtest: evict
[380.019092] Dynamic subtest evict: SUCCESS (0.746s)
[380.060970] Starting dynamic subtest: hugepages
[381.381598] Dynamic subtest hugepages: SUCCESS (1.360s)
[381.431893] Starting dynamic subtest: gem_contexts
[385.859125] Dynamic subtest gem_contexts: SUCCESS (4.469s)
[385.909297] Starting dynamic subtest: client
[386.570811] Dynamic subtest client: SUCCESS (0.719s)
[386.612642] Starting dynamic subtest: gem_migrate
[387.307642] Dynamic subtest gem_migrate: SUCCESS (0.731s)
[387.349446] Starting dynamic subtest: reset
[388.313337] Dynamic subtest reset: SUCCESS (1.009s)
[388.355086] Starting dynamic subtest: memory_region
[389.066597] Dynamic subtest memory_region: SUCCESS (0.749s)
[389.108444] Starting dynamic subtest: hangcheck
[391.432294] Dynamic subtest hangcheck: SUCCESS (2.364s)
[391.474177] Starting dynamic subtest: execlists
[392.160736] Dynamic subtest execlists: SUCCESS (0.724s)
[392.553315] Starting dynamic subtest: ring_submission
[392.879366] Dynamic subtest ring_submission: SUCCESS (0.713s)
[392.929547] Starting dynamic subtest: perf
[393.618090] Dynamic subtest perf: SUCCESS (0.746s)
[393.659900] Starting dynamic subtest: slpc
[394.338087] Dynamic subtest slpc: SUCCESS (0.715s)
[394.388217] Starting dynamic subtest: guc
[395.049398] Dynamic subtest guc: SUCCESS (0.710s)
[395.099566] Starting dynamic subtest: guc_multi_lrc
[395.787621] Dynamic subtest guc_multi_lrc: SUCCESS (0.739s)
[395.887863] Starting dynamic subtest: guc_hang
[396.590946] Dynamic subtest guc_hang: SUCCESS (0.794s)
[396.641113] Starting dynamic subtest: late_gt_pm
[397.286195] Dynamic subtest late_gt_pm: SUCCESS (0.707s)
[397.319715] Subtest live: SUCCESS (55.697s)
[397.524570] [165/171] (662s left) dmabuf (all-tests)
[398.315642] Starting subtest: all-tests
[398.357411] Starting dynamic subtest: sanitycheck
[398.399349] Dynamic subtest sanitycheck: SUCCESS (0.176s)
[398.441496] Starting dynamic subtest: dma_fence
[398.533540] Dynamic subtest dma_fence: SUCCESS (0.137s)
[398.583670] Starting dynamic subtest: dma_fence_chain
[412.559734] Dynamic subtest dma_fence_chain: SUCCESS (14.047s)
[412.610199] Starting dynamic subtest: dma_fence_unwrap
[412.652087] Dynamic subtest dma_fence_unwrap: SUCCESS (0.018s)
[412.693886] Starting dynamic subtest: dma_resv
[412.727425] Dynamic subtest dma_resv: SUCCESS (0.022s)
[412.760904] Subtest all-tests: SUCCESS (14.407s)
[412.887988] [166/171] (647s left) i915_suspend (basic-s2idle-without-i915)
[413.413121] Starting subtest: basic-s2idle-without-i915
[434.289947] Subtest basic-s2idle-without-i915: SUCCESS (6.691s)
[436.501998] [167/171] (640s left) i915_suspend (basic-s3-without-i915)
[437.319336] Starting subtest: basic-s3-without-i915
[457.501076] Subtest basic-s3-without-i915: SUCCESS (5.833s)
[459.439267] [168/171] (633s left) gem_exec_suspend (basic-s0)
[460.647377] Starting subtest: basic-S0
[460.732787] Starting dynamic subtest: smem
[480.827188] Dynamic subtest smem: SUCCESS (4.428s)
[480.902526] Subtest basic-S0: SUCCESS (4.429s)
[482.864738] [169/171] (627s left) gem_exec_suspend (basic-s3)
[483.615481] Starting subtest: basic-S3
[483.657336] Starting dynamic subtest: smem
[502.894070] Dynamic subtest smem: SUCCESS (4.468s)
[502.936034] Subtest basic-S3: SUCCESS (4.469s)
[505.055901] [170/171] (622s left) kms_chamelium_hpd (common-hpd-after-suspend)
[506.118091] Subtest common-hpd-after-suspend: SKIP (0.000s)
[506.731298] [171/171] (621s left) kms_pipe_crc_basic (suspend-read-crc)
[507.397937] Starting subtest: suspend-read-crc
[507.431950] Starting dynamic subtest: pipe-A-LVDS-1
[526.941223] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.556s)
[526.991592] Starting dynamic subtest: pipe-B-LVDS-1
[547.877300] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.283s)
[547.919321] Subtest suspend-read-crc: SUCCESS (9.842s)
[550.432568] Closing watchdogs
Done.