[78.219283] Initializing watchdogs
[78.219658]   /dev/watchdog0
[78.269915] [001/171] (960s left) i915_module_load (load)
[79.045153] Starting subtest: load
[84.723312] Subtest load: SUCCESS (5.682s)
[85.093572] [002/171] (953s left) core_auth (basic-auth)
[86.152202] Starting subtest: basic-auth
[86.185952] Subtest basic-auth: SUCCESS (0.001s)
[86.536981] [003/171] (952s left) debugfs_test (read_all_entries)
[87.287161] Starting subtest: read_all_entries
[87.337344] Subtest read_all_entries: SUCCESS (0.061s)
[87.681559] [004/171] (951s left) debugfs_test (basic-hwmon)
[88.131714] Starting subtest: basic-hwmon
[88.215465] Subtest basic-hwmon: SKIP (0.000s)
[88.368802] [005/171] (951s left) fbdev (eof)
[88.903094] Starting subtest: eof
[88.936587] Subtest eof: SUCCESS (0.000s)
[89.037672] [006/171] (950s left) fbdev (info)
[89.454478] Starting subtest: info
[89.504428] Subtest info: SUCCESS (0.000s)
[89.622391] [007/171] (950s left) fbdev (nullptr)
[89.997880] Starting subtest: nullptr
[90.048081] Subtest nullptr: SUCCESS (0.000s)
[90.165683] [008/171] (950s left) fbdev (read)
[90.540707] Starting subtest: read
[91.040961] Subtest read: SUCCESS (0.550s)
[91.141928] [009/171] (949s left) fbdev (write)
[91.568891] Starting subtest: write
[91.619472] Subtest write: SUCCESS (0.110s)
[91.745412] [010/171] (948s left) gem_basic (bad-close)
[92.154425] Starting subtest: bad-close
[92.254411] Subtest bad-close: SUCCESS (0.000s)
[92.380506] [011/171] (948s left) gem_basic (create-close)
[92.814482] Starting subtest: create-close
[92.898062] Subtest create-close: SUCCESS (0.000s)
[93.007468] [012/171] (947s left) gem_basic (create-fd-close)
[93.366084] Starting subtest: create-fd-close
[93.449649] Subtest create-fd-close: SUCCESS (0.000s)
[93.559097] [013/171] (947s left) gem_busy (busy@all-engines)
[93.985999] Starting subtest: busy
[94.036153] Starting dynamic subtest: all-engines
[94.086309] Dynamic subtest all-engines: SUCCESS (0.027s)
[94.136304] Subtest busy: SUCCESS (0.028s)
[94.295799] [014/171] (946s left) gem_close_race (basic-process)
[94.771502] Starting subtest: basic-process
[94.813226] Subtest basic-process: SUCCESS (0.042s)
[94.964474] [015/171] (946s left) gem_close_race (basic-threads)
[95.407283] Starting subtest: basic-threads
[96.470773] Subtest basic-threads: SUCCESS (1.153s)
[96.672227] [016/171] (944s left) gem_ctx_create (basic)
[97.306170] Starting subtest: basic
[97.348125] Subtest basic: SUCCESS (0.000s)
[97.457544] [017/171] (944s left) gem_ctx_create (basic-files)
[97.857553] Starting subtest: basic-files
[99.854675] Subtest basic-files: SUCCESS (2.014s)
[100.215362] [018/171] (941s left) gem_ctx_exec (basic)
[100.757719] Starting subtest: basic
[100.807862] Subtest basic: SUCCESS (0.001s)
[100.933823] [019/171] (940s left) gem_exec_basic (basic)
[101.367250] Starting subtest: basic
[101.417602] Starting dynamic subtest: rcs0-smem
[101.467770] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[101.526388] Starting dynamic subtest: bcs0-smem
[101.576548] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[101.626644] Starting dynamic subtest: vcs0-smem
[101.668390] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[101.711938] Subtest basic: SUCCESS (0.001s)
[101.820938] [020/171] (940s left) gem_exec_create (basic)
[102.238218] Starting subtest: basic
[102.279986] Starting dynamic subtest: smem
[104.196640] Dynamic subtest smem: SUCCESS (2.036s)
[104.238311] Subtest basic: SUCCESS (2.036s)
[104.389477] [021/171] (937s left) gem_exec_fence (basic-busy)
[105.232568] Subtest basic-busy: SKIP (0.000s)
[105.634716] [022/171] (936s left) gem_exec_fence (basic-wait)
[106.186947] Subtest basic-wait: SKIP (0.000s)
[106.472266] [023/171] (935s left) gem_exec_fence (basic-await)
[107.031426] Subtest basic-await: SKIP (0.000s)
[107.349638] [024/171] (935s left) gem_exec_fence (nb-await)
[107.900713] Subtest nb-await: SKIP (0.000s)
[108.135790] [025/171] (934s left) gem_exec_gttfill (basic)
[108.554231] Starting subtest: basic
[113.386891] Subtest basic: SUCCESS (4.933s)
[113.654550] [026/171] (928s left) gem_exec_parallel (engines)
[115.879788] Starting subtest: engines
[115.921594] Starting dynamic subtest: basic
[117.396603] Dynamic subtest basic: SUCCESS (1.593s)
[117.446720] Starting dynamic subtest: contexts
[119.204825] Dynamic subtest contexts: SUCCESS (1.841s)
[119.255046] Starting dynamic subtest: fds
[121.653882] Dynamic subtest fds: SUCCESS (2.446s)
[121.704104] Starting dynamic subtest: userptr
[123.379313] Dynamic subtest userptr: SUCCESS (1.704s)
[123.420863] Subtest engines: SUCCESS (7.586s)
[123.572543] [027/171] (919s left) gem_exec_store (basic)
[124.148500] Starting subtest: basic
[124.190365] Subtest basic: SUCCESS (0.040s)
[124.309791] [028/171] (918s left) gem_flink_basic (bad-flink)
[124.718927] Starting subtest: bad-flink
[124.760735] Subtest bad-flink: SUCCESS (0.000s)
[124.870123] [029/171] (918s left) gem_flink_basic (bad-open)
[125.228695] Starting subtest: bad-open
[125.270484] Subtest bad-open: SUCCESS (0.000s)
[125.371219] [030/171] (917s left) gem_flink_basic (basic)
[125.705167] Starting subtest: basic
[125.755497] Subtest basic: SUCCESS (0.000s)
[125.873179] [031/171] (917s left) gem_flink_basic (double-flink)
[126.231977] Starting subtest: double-flink
[126.273743] Subtest double-flink: SUCCESS (0.000s)
[126.391590] [032/171] (916s left) gem_flink_basic (flink-lifetime)
[126.868942] Starting subtest: flink-lifetime
[126.910736] Subtest flink-lifetime: SUCCESS (0.001s)
[127.011408] [033/171] (916s left) gem_huc_copy (huc-copy)
[127.454220] Subtest huc-copy: SKIP (0.000s)
[127.571998] [034/171] (916s left) gem_linear_blits (basic)
[128.063851] Starting subtest: basic
[128.131088] Subtest basic: SUCCESS (0.011s)
[128.523718] [035/171] (915s left) gem_mmap (basic)
[130.673178] Starting subtest: basic
[130.882288] Subtest basic: SUCCESS (0.001s)
[130.993379] [036/171] (912s left) gem_mmap_gtt (basic)
[131.443870] Starting subtest: basic
[131.494085] Subtest basic: SUCCESS (0.001s)
[131.678111] [037/171] (912s left) gem_render_linear_blits (basic)
[132.112087] Starting subtest: basic
[132.362639] Subtest basic: SUCCESS (0.027s)
[132.488238] [038/171] (912s left) gem_render_tiled_blits (basic)
[132.964329] Starting subtest: basic
[133.214909] Subtest basic: SUCCESS (0.035s)
[133.324294] [039/171] (911s left) gem_ringfill (basic-all)
[133.934472] Starting subtest: basic-all
[135.018256] Subtest basic-all: SUCCESS (1.186s)
[135.135960] [040/171] (909s left) gem_softpin (allocator-basic)
[135.711353] Subtest allocator-basic: SKIP (0.000s)
[135.828987] [041/171] (909s left) gem_softpin (allocator-basic-reserve)
[136.346253] Subtest allocator-basic-reserve: SKIP (0.000s)
[136.455717] [042/171] (909s left) gem_softpin (safe-alignment)
[136.889463] Starting subtest: safe-alignment
[136.931276] Subtest safe-alignment: SUCCESS (0.007s)
[137.032315] [043/171] (908s left) gem_sync (basic-all)
[137.542991] Starting subtest: basic-all
[139.417612] Subtest basic-all: SUCCESS (2.020s)
[139.577716] [044/171] (906s left) gem_sync (basic-each)
[140.069510] Starting subtest: basic-each
[142.069545] Subtest basic-each: SUCCESS (2.064s)
[142.221184] [045/171] (903s left) gem_tiled_blits (basic)
[142.662842] Starting subtest: basic
[142.704939] Subtest basic: SUCCESS (0.016s)
[143.081099] [046/171] (902s left) gem_tiled_fence_blits (basic)
[145.130634] Starting subtest: basic
[145.197721] Subtest basic: SUCCESS (0.007s)
[145.591745] [047/171] (900s left) gem_tiled_pread_basic
[147.784953] [048/171] (898s left) gem_wait (busy@all-engines)
[148.251962] Starting subtest: busy
[148.293726] Starting dynamic subtest: all-engines
[148.702885] Dynamic subtest all-engines: SUCCESS (0.516s)
[148.744387] Subtest busy: SUCCESS (0.517s)
[148.929242] [049/171] (897s left) gem_wait (wait@all-engines)
[149.337878] Starting subtest: wait
[149.387942] Starting dynamic subtest: all-engines
[150.346455] Dynamic subtest all-engines: SUCCESS (1.019s)
[150.438580] Subtest wait: SUCCESS (1.019s)
[150.582883] [050/171] (895s left) i915_getparams_basic (basic-eu-total)
[151.033615] Starting subtest: basic-eu-total
[151.117230] Subtest basic-eu-total: SUCCESS (0.000s)
[151.226098] [051/171] (895s left) i915_getparams_basic (basic-subslice-total)
[151.660361] Starting subtest: basic-subslice-total
[151.727272] Subtest basic-subslice-total: SUCCESS (0.000s)
[151.828459] [052/171] (894s left) i915_hangman (error-state-basic)
[152.353384] Starting subtest: error-state-basic
[152.437029] Subtest error-state-basic: SUCCESS (0.009s)
[152.738299] [053/171] (894s left) i915_pciid
[153.323460] [054/171] (894s left) kms_addfb_basic (addfb25-bad-modifier)
[153.825189] Starting subtest: addfb25-bad-modifier
[153.900658] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[154.470533] [055/171] (893s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[154.995854] Starting subtest: addfb25-framebuffer-vs-set-tiling
[155.037729] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[155.247978] [056/171] (892s left) kms_addfb_basic (addfb25-modifier-no-flag)
[155.741917] Starting subtest: addfb25-modifier-no-flag
[155.783789] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[156.010906] [057/171] (891s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[156.469582] Starting subtest: addfb25-x-tiled-legacy
[156.511409] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[156.729947] [058/171] (891s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[157.238757] Starting subtest: addfb25-x-tiled-mismatch-legacy
[157.280621] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[157.449179] [059/171] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[157.993175] Starting subtest: addfb25-yf-tiled-legacy
[158.043819] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[158.161481] [060/171] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[158.645770] Starting subtest: addfb25-y-tiled-legacy
[158.687901] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[158.797528] [061/171] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[159.381683] Starting subtest: addfb25-y-tiled-small-legacy
[159.465877] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[159.599979] [062/171] (888s left) kms_addfb_basic (bad-pitch-0)
[160.077105] Starting subtest: bad-pitch-0
[160.118964] Subtest bad-pitch-0: SUCCESS (0.000s)
[160.320861] [063/171] (888s left) kms_addfb_basic (bad-pitch-1024)
[160.721488] Starting subtest: bad-pitch-1024
[160.763389] Subtest bad-pitch-1024: SUCCESS (0.000s)
[160.940414] [064/171] (887s left) kms_addfb_basic (bad-pitch-128)
[161.440537] Starting subtest: bad-pitch-128
[161.482384] Subtest bad-pitch-128: SUCCESS (0.000s)
[161.675930] [065/171] (886s left) kms_addfb_basic (bad-pitch-256)
[162.194539] Starting subtest: bad-pitch-256
[162.236439] Subtest bad-pitch-256: SUCCESS (0.000s)
[162.413518] [066/171] (886s left) kms_addfb_basic (bad-pitch-32)
[162.888658] Starting subtest: bad-pitch-32
[162.922183] Subtest bad-pitch-32: SUCCESS (0.000s)
[163.141124] [067/171] (885s left) kms_addfb_basic (bad-pitch-63)
[163.591320] Starting subtest: bad-pitch-63
[163.641507] Subtest bad-pitch-63: SUCCESS (0.000s)
[163.818072] [068/171] (885s left) kms_addfb_basic (bad-pitch-65536)
[164.303659] Starting subtest: bad-pitch-65536
[164.345497] Subtest bad-pitch-65536: SUCCESS (0.000s)
[164.648118] [069/171] (884s left) kms_addfb_basic (bad-pitch-999)
[165.123509] Starting subtest: bad-pitch-999
[165.173715] Subtest bad-pitch-999: SUCCESS (0.000s)
[165.383754] [070/171] (883s left) kms_addfb_basic (basic)
[165.884221] Starting subtest: basic
[165.926040] Subtest basic: SUCCESS (0.000s)
[166.119393] [071/171] (883s left) kms_addfb_basic (basic-x-tiled-legacy)
[166.605109] Starting subtest: basic-x-tiled-legacy
[166.638653] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[166.815239] [072/171] (882s left) kms_addfb_basic (basic-y-tiled-legacy)
[167.274145] Starting subtest: basic-y-tiled-legacy
[167.315894] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[167.492856] [073/171] (881s left) kms_addfb_basic (bo-too-small)
[168.126946] Starting subtest: bo-too-small
[168.169473] Subtest bo-too-small: SUCCESS (0.000s)
[168.278486] [074/171] (881s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[168.806215] Starting subtest: bo-too-small-due-to-tiling
[168.848450] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[168.974706] [075/171] (880s left) kms_addfb_basic (clobberred-modifier)
[169.491641] Starting subtest: clobberred-modifier
[169.533390] Subtest clobberred-modifier: SUCCESS (0.000s)
[169.710337] [076/171] (879s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[170.210794] Starting subtest: framebuffer-vs-set-tiling
[170.244364] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[170.431237] [077/171] (879s left) kms_addfb_basic (invalid-get-prop)
[170.940090] Starting subtest: invalid-get-prop
[170.981813] Subtest invalid-get-prop: SUCCESS (0.000s)
[171.167123] [078/171] (878s left) kms_addfb_basic (invalid-get-prop-any)
[171.584199] Starting subtest: invalid-get-prop-any
[171.626116] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[171.786369] [079/171] (878s left) kms_addfb_basic (invalid-set-prop)
[172.228456] Starting subtest: invalid-set-prop
[172.262025] Subtest invalid-set-prop: SUCCESS (0.000s)
[172.465688] [080/171] (877s left) kms_addfb_basic (invalid-set-prop-any)
[172.966125] Starting subtest: invalid-set-prop-any
[173.008045] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[173.226593] [081/171] (876s left) kms_addfb_basic (no-handle)
[173.693860] Starting subtest: no-handle
[173.735737] Subtest no-handle: SUCCESS (0.000s)
[173.920848] [082/171] (876s left) kms_addfb_basic (size-max)
[174.530522] Starting subtest: size-max
[174.573696] Subtest size-max: SUCCESS (0.000s)
[174.742600] [083/171] (875s left) kms_addfb_basic (small-bo)
[175.343433] Starting subtest: small-bo
[175.385265] Subtest small-bo: SUCCESS (0.000s)
[175.570551] [084/171] (874s left) kms_addfb_basic (tile-pitch-mismatch)
[176.079318] Starting subtest: tile-pitch-mismatch
[176.129563] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[176.247714] [085/171] (874s left) kms_addfb_basic (too-high)
[176.825534] Starting subtest: too-high
[176.867755] Subtest too-high: SUCCESS (0.001s)
[177.001849] [086/171] (873s left) kms_addfb_basic (too-wide)
[177.603122] Starting subtest: too-wide
[177.653616] Subtest too-wide: SUCCESS (0.000s)
[177.787905] [087/171] (872s left) kms_addfb_basic (unused-handle)
[178.213598] Starting subtest: unused-handle
[178.255408] Subtest unused-handle: SUCCESS (0.000s)
[178.423989] [088/171] (872s left) kms_addfb_basic (unused-modifier)
[178.901114] Starting subtest: unused-modifier
[178.951313] Subtest unused-modifier: SUCCESS (0.000s)
[179.153188] [089/171] (871s left) kms_addfb_basic (unused-offsets)
[179.587031] Starting subtest: unused-offsets
[179.628889] Subtest unused-offsets: SUCCESS (0.000s)
[179.788927] [090/171] (871s left) kms_addfb_basic (unused-pitches)
[180.289614] Starting subtest: unused-pitches
[180.323112] Subtest unused-pitches: SUCCESS (0.000s)
[180.533397] [091/171] (870s left) kms_busy (basic)
[181.278051] Starting subtest: basic
[181.344899] Starting dynamic subtest: flip
[185.544921] Dynamic subtest flip: SUCCESS (4.173s)
[185.628443] Starting dynamic subtest: modeset
[187.642441] Dynamic subtest modeset: SUCCESS (2.197s)
[187.684330] Subtest basic: SUCCESS (6.372s)
[188.553542] [092/171] (862s left) kms_chamelium_hpd (dp-hpd-fast)
[189.539124] Subtest dp-hpd-fast: SKIP (0.000s)
[190.241165] [093/171] (860s left) kms_chamelium_edid (dp-edid-read)
[191.228040] Subtest dp-edid-read: SKIP (0.000s)
[191.921945] [094/171] (859s left) kms_chamelium_frames (dp-crc-fast)
[192.923191] Subtest dp-crc-fast: SKIP (0.000s)
[193.676880] [095/171] (857s left) kms_chamelium_hpd (hdmi-hpd-fast)
[194.578474] Subtest hdmi-hpd-fast: SKIP (0.000s)
[195.238647] [096/171] (856s left) kms_chamelium_edid (hdmi-edid-read)
[196.207059] Subtest hdmi-edid-read: SKIP (0.000s)
[196.852743] [097/171] (854s left) kms_chamelium_frames (hdmi-crc-fast)
[197.787290] Subtest hdmi-crc-fast: SKIP (0.000s)
[198.414426] [098/171] (853s left) kms_chamelium_hpd (vga-hpd-fast)
[199.307908] Subtest vga-hpd-fast: SKIP (0.000s)
[200.129697] [099/171] (851s left) kms_chamelium_edid (vga-edid-read)
[201.080292] Subtest vga-edid-read: SKIP (0.000s)
[201.707492] [100/171] (850s left) kms_prop_blob (basic)
[202.241494] Starting subtest: basic
[202.283258] Subtest basic: SUCCESS (0.000s)
[202.409456] [101/171] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[202.919966] Starting subtest: basic-busy-flip-before-cursor-atomic
[204.112546] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.179s)
[204.856625] [102/171] (847s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[205.382593] Starting subtest: basic-busy-flip-before-cursor-legacy
[206.533120] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.185s)
[207.278992] [103/171] (845s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[207.879227] Starting subtest: basic-flip-after-cursor-atomic
[209.071872] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.188s)
[209.942293] [104/171] (842s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[210.527696] Starting subtest: basic-flip-after-cursor-legacy
[211.736966] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.226s)
[212.431251] [105/171] (840s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[212.964696] Starting subtest: basic-flip-after-cursor-varying-size
[214.182335] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.219s)
[214.994350] [106/171] (837s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[215.586652] Starting subtest: basic-flip-before-cursor-atomic
[216.804165] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.186s)
[217.547512] [107/171] (835s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[218.156836] Starting subtest: basic-flip-before-cursor-legacy
[219.384600] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.220s)
[220.128465] [108/171] (832s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[220.662275] Starting subtest: basic-flip-before-cursor-varying-size
[221.863165] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.176s)
[222.675051] [109/171] (830s left) kms_flip (basic-flip-vs-dpms)
[223.259906] Starting subtest: basic-flip-vs-dpms
[223.310560] Starting dynamic subtest: A-LVDS1
[224.946079] Dynamic subtest A-LVDS1: SUCCESS (1.765s)
[224.996107] Starting dynamic subtest: B-LVDS1
[226.431764] Dynamic subtest B-LVDS1: SUCCESS (1.494s)
[226.481994] Starting dynamic subtest: A-VGA1
[227.146355] Dynamic subtest A-VGA1: SUCCESS (0.715s)
[227.196585] Starting dynamic subtest: B-VGA1
[227.902847] Dynamic subtest B-VGA1: SUCCESS (0.707s)
[227.944699] Subtest basic-flip-vs-dpms: SUCCESS (4.689s)
[228.079451] [110/171] (824s left) kms_flip (basic-flip-vs-modeset)
[228.663653] Starting subtest: basic-flip-vs-modeset
[228.705609] Starting dynamic subtest: A-LVDS1
[230.416765] Dynamic subtest A-LVDS1: SUCCESS (1.782s)
[230.467014] Starting dynamic subtest: B-LVDS1
[231.812598] Dynamic subtest B-LVDS1: SUCCESS (1.417s)
[231.862794] Starting dynamic subtest: A-VGA1
[232.575412] Dynamic subtest A-VGA1: SUCCESS (0.731s)
[232.633966] Starting dynamic subtest: B-VGA1
[233.256130] Dynamic subtest B-VGA1: SUCCESS (0.713s)
[233.298064] Subtest basic-flip-vs-modeset: SUCCESS (4.653s)
[233.692560] [111/171] (819s left) kms_flip (basic-flip-vs-wf_vblank)
[234.193484] Starting subtest: basic-flip-vs-wf_vblank
[234.235390] Starting dynamic subtest: A-LVDS1
[236.188516] Dynamic subtest A-LVDS1: SUCCESS (1.955s)
[236.238857] Starting dynamic subtest: B-LVDS1
[238.073264] Dynamic subtest B-LVDS1: SUCCESS (1.911s)
[238.131990] Starting dynamic subtest: A-VGA1
[239.275328] Dynamic subtest A-VGA1: SUCCESS (1.222s)
[239.325534] Starting dynamic subtest: B-VGA1
[240.234807] Dynamic subtest B-VGA1: SUCCESS (0.964s)
[240.276749] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.063s)
[240.463852] [112/171] (812s left) kms_flip (basic-plain-flip)
[241.039304] Starting subtest: basic-plain-flip
[241.081197] Starting dynamic subtest: A-LVDS1
[242.549193] Dynamic subtest A-LVDS1: SUCCESS (1.490s)
[242.599699] Starting dynamic subtest: B-LVDS1
[244.009162] Dynamic subtest B-LVDS1: SUCCESS (1.513s)
[244.051109] Starting dynamic subtest: A-VGA1
[244.937466] Dynamic subtest A-VGA1: SUCCESS (0.913s)
[244.987654] Starting dynamic subtest: B-VGA1
[245.630125] Dynamic subtest B-VGA1: SUCCESS (0.698s)
[245.671903] Subtest basic-plain-flip: SUCCESS (4.623s)
[246.067287] [113/171] (807s left) kms_force_connector_basic (force-connector-state)
[246.575887] Starting subtest: force-connector-state
[247.043982] Subtest force-connector-state: SUCCESS (0.521s)
[248.150865] [114/171] (805s left) kms_force_connector_basic (force-edid)
[248.741392] Starting subtest: force-edid
[248.858540] Subtest force-edid: SUCCESS (0.233s)
[249.304859] [115/171] (804s left) kms_force_connector_basic (force-load-detect)
[249.780474] Starting subtest: force-load-detect
[250.123628] Subtest force-load-detect: SUCCESS (0.415s)
[250.736097] [116/171] (802s left) kms_force_connector_basic (prune-stale-modes)
[251.211398] Starting subtest: prune-stale-modes
[251.253260] Subtest prune-stale-modes: SUCCESS (0.019s)
[251.608564] [117/171] (802s left) kms_frontbuffer_tracking (basic)
[252.384333] Starting subtest: basic
[254.443102] Subtest basic: SUCCESS (2.216s)
[254.553893] [118/171] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[255.203449] Starting subtest: compare-crc-sanitycheck
[255.245655] Starting dynamic subtest: pipe-A-LVDS-1
[255.746917] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.513s)
[255.805434] Starting dynamic subtest: pipe-B-LVDS-1
[256.617071] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.881s)
[256.658841] Subtest compare-crc-sanitycheck: SUCCESS (1.398s)
[257.555242] [119/171] (796s left) kms_pipe_crc_basic (hang-read-crc)
[258.187840] Starting subtest: hang-read-crc
[258.221434] Starting dynamic subtest: pipe-A-LVDS-1
[260.026843] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.822s)
[260.077112] Starting dynamic subtest: pipe-B-LVDS-1
[262.433250] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.404s)
[262.475104] Subtest hang-read-crc: SUCCESS (4.229s)
[263.162218] [120/171] (790s left) kms_pipe_crc_basic (nonblocking-crc)
[263.702749] Starting subtest: nonblocking-crc
[263.745137] Starting dynamic subtest: pipe-A-LVDS-1
[264.421368] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.682s)
[264.471543] Starting dynamic subtest: pipe-B-LVDS-1
[265.708881] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.293s)
[265.750675] Subtest nonblocking-crc: SUCCESS (1.978s)
[266.462235] [121/171] (787s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[266.961545] Starting subtest: nonblocking-crc-frame-sequence
[267.012057] Starting dynamic subtest: pipe-A-LVDS-1
[267.663434] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.689s)
[267.713657] Starting dynamic subtest: pipe-B-LVDS-1
[268.917525] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.227s)
[268.967724] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.920s)
[269.847066] [122/171] (784s left) kms_pipe_crc_basic (read-crc)
[270.471843] Starting subtest: read-crc
[270.513913] Starting dynamic subtest: pipe-A-LVDS-1
[271.073303] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.599s)
[271.123440] Starting dynamic subtest: pipe-B-LVDS-1
[272.235560] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.175s)
[272.269063] Subtest read-crc: SUCCESS (1.779s)
[272.939246] [123/171] (781s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[273.522440] Starting subtest: read-crc-frame-sequence
[273.564314] Starting dynamic subtest: pipe-A-LVDS-1
[274.115279] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.619s)
[274.165493] Starting dynamic subtest: pipe-B-LVDS-1
[275.327939] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.203s)
[275.369812] Subtest read-crc-frame-sequence: SUCCESS (1.827s)
[276.056528] [124/171] (778s left) kms_psr (primary_page_flip)
[276.580676] Subtest primary_page_flip: SKIP (0.000s)
[276.692165] [125/171] (777s left) kms_psr (cursor_plane_move)
[277.140451] Subtest cursor_plane_move: SKIP (0.000s)
[277.251215] [126/171] (777s left) kms_psr (sprite_plane_onoff)
[277.676959] Subtest sprite_plane_onoff: SKIP (0.000s)
[277.787819] [127/171] (777s left) kms_psr (primary_mmap_gtt)
[278.186682] Subtest primary_mmap_gtt: SKIP (0.000s)
[278.305716] [128/171] (776s left) kms_setmode (basic-clone-single-crtc)
[278.804863] Starting subtest: basic-clone-single-crtc
[278.955116] Subtest basic-clone-single-crtc: SKIP (0.001s)
[279.073815] [129/171] (776s left) i915_pm_backlight (basic-brightness)
[279.732605] Subtest basic-brightness: SKIP (0.000s)
[279.875510] [130/171] (775s left) i915_pm_rpm (basic-pci-d3-state)
[281.862621] Subtest basic-pci-d3-state: SKIP (0.000s)
[282.015798] [131/171] (773s left) i915_pm_rpm (basic-rte)
[282.439136] Starting subtest: basic-rte
[283.848572] Subtest basic-rte: SKIP (1.389s)
[284.050760] [132/171] (771s left) i915_pm_rps (basic-api)
[284.577500] Starting subtest: basic-api
[284.619349] Subtest basic-api: SUCCESS (0.004s)
[284.730203] [133/171] (770s left) prime_self_import (basic-llseek-bad)
[285.220546] Starting subtest: basic-llseek-bad
[285.270650] Subtest basic-llseek-bad: SUCCESS (0.001s)
[285.381693] [134/171] (770s left) prime_self_import (basic-llseek-size)
[285.838789] Starting subtest: basic-llseek-size
[285.880683] Subtest basic-llseek-size: SUCCESS (0.002s)
[285.991351] [135/171] (769s left) prime_self_import (basic-with_fd_dup)
[286.415487] Starting subtest: basic-with_fd_dup
[286.457257] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[286.575892] [136/171] (769s left) prime_self_import (basic-with_one_bo)
[287.042138] Starting subtest: basic-with_one_bo
[287.092307] Subtest basic-with_one_bo: SUCCESS (0.004s)
[287.219255] [137/171] (768s left) prime_self_import (basic-with_one_bo_two_files)
[287.578671] Starting subtest: basic-with_one_bo_two_files
[287.612176] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[287.722480] [138/171] (768s left) prime_self_import (basic-with_two_bos)
[288.171875] Starting subtest: basic-with_two_bos
[288.213758] Subtest basic-with_two_bos: SUCCESS (0.003s)
[288.324500] [139/171] (768s left) prime_vgem (basic-fence-flip)
[288.748100] Starting subtest: basic-fence-flip
[289.007754] Subtest basic-fence-flip: SKIP (0.226s)
[289.167924] [140/171] (767s left) prime_vgem (basic-fence-mmap)
[289.651184] Starting subtest: basic-fence-mmap
[289.695073] Subtest basic-fence-mmap: SUCCESS (0.029s)
[289.829732] [141/171] (766s left) prime_vgem (basic-fence-read)
[290.229584] Starting subtest: basic-fence-read
[290.271830] Subtest basic-fence-read: SUCCESS (0.046s)
[290.440292] [142/171] (766s left) prime_vgem (basic-gtt)
[290.898091] Starting subtest: basic-gtt
[290.940322] Subtest basic-gtt: SUCCESS (0.013s)
[291.118319] [143/171] (765s left) prime_vgem (basic-read)
[291.584163] Starting subtest: basic-read
[291.634312] Subtest basic-read: SUCCESS (0.020s)
[291.812228] [144/171] (765s left) prime_vgem (basic-write)
[292.229184] Starting subtest: basic-write
[292.270952] Subtest basic-write: SUCCESS (0.022s)
[292.423612] [145/171] (764s left) prime_vgem (basic-userptr)
[292.889143] Starting subtest: basic-userptr
[292.973259] Subtest basic-userptr: SKIP (0.081s)
[293.125553] [146/171] (764s left) vgem_basic (setversion)
[293.566238] Starting subtest: setversion
[293.666428] Subtest setversion: SUCCESS (0.000s)
[293.802646] [147/171] (763s left) vgem_basic (create)
[294.209568] Starting subtest: create
[294.259663] Subtest create: SUCCESS (0.000s)
[294.387429] [148/171] (763s left) vgem_basic (debugfs)
[294.785780] Starting subtest: debugfs
[294.827619] Subtest debugfs: SUCCESS (0.001s)
[294.940431] [149/171] (762s left) vgem_basic (dmabuf-export)
[295.313955] Starting subtest: dmabuf-export
[295.355736] Subtest dmabuf-export: SUCCESS (0.002s)
[295.466859] [150/171] (762s left) vgem_basic (dmabuf-fence)
[295.915553] Starting subtest: dmabuf-fence
[295.965706] Subtest dmabuf-fence: SUCCESS (0.001s)
[296.101970] [151/171] (761s left) vgem_basic (dmabuf-fence-before)
[296.508809] Starting subtest: dmabuf-fence-before
[296.558904] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[296.670329] [152/171] (761s left) vgem_basic (dmabuf-mmap)
[297.068495] Starting subtest: dmabuf-mmap
[297.110226] Subtest dmabuf-mmap: SUCCESS (0.019s)
[297.228826] [153/171] (761s left) vgem_basic (mmap)
[297.655311] Starting subtest: mmap
[297.697094] Subtest mmap: SUCCESS (0.011s)
[297.807965] [154/171] (760s left) vgem_basic (second-client)
[298.207188] Starting subtest: second-client
[298.240625] Subtest second-client: SUCCESS (0.049s)
[298.351641] [155/171] (760s left) vgem_basic (sysfs)
[298.742123] Starting subtest: sysfs
[298.775477] Subtest sysfs: SUCCESS (0.001s)
[298.877776] [156/171] (759s left) core_hotunplug (unbind-rebind)
[299.584880] Starting subtest: unbind-rebind
[301.423686] Subtest unbind-rebind: SUCCESS (1.601s)
[302.018411] [157/171] (757s left) vgem_basic (unload)
[302.992079] Starting subtest: unload
[331.799077] Subtest unload: SUCCESS (29.131s)
[331.960780] [158/171] (727s left) i915_module_load (reload)
[332.586291] Starting subtest: reload
[337.456353] Subtest reload: SUCCESS (4.960s)
[337.599509] [159/171] (722s left) gem_lmem_swapping (basic)
[338.469108] Subtest basic: SKIP (0.000s)
[338.580444] [160/171] (721s left) gem_lmem_swapping (parallel-random-engines)
[339.054236] Subtest parallel-random-engines: SKIP (0.000s)
[339.172508] [161/171] (721s left) gem_lmem_swapping (random-engines)
[339.605429] Subtest random-engines: SKIP (0.000s)
[339.724689] [162/171] (720s left) gem_lmem_swapping (verify-random)
[340.148716] Subtest verify-random: SKIP (0.000s)
[340.260244] [163/171] (720s left) i915_pm_rpm (module-reload)
[342.078426] Subtest module-reload: SKIP (0.000s)
[342.190161] [164/171] (718s left) i915_selftest (live)
[343.481112] Starting subtest: live
[343.514597] Starting dynamic subtest: sanitycheck
[344.302192] Dynamic subtest sanitycheck: SUCCESS (0.809s)
[344.352351] Starting dynamic subtest: uncore
[344.996437] Dynamic subtest uncore: SUCCESS (0.701s)
[345.038351] Starting dynamic subtest: workarounds
[345.741142] Dynamic subtest workarounds: SUCCESS (0.739s)
[345.782969] Starting dynamic subtest: gt_engines
[346.470813] Dynamic subtest gt_engines: SUCCESS (0.734s)
[346.512562] Starting dynamic subtest: gt_timelines
[350.665146] Dynamic subtest gt_timelines: SUCCESS (4.191s)
[350.715218] Starting dynamic subtest: gt_contexts
[351.394503] Dynamic subtest gt_contexts: SUCCESS (0.732s)
[351.436314] Starting dynamic subtest: gt_lrc
[352.105775] Dynamic subtest gt_lrc: SUCCESS (0.706s)
[352.155858] Starting dynamic subtest: gt_mocs
[352.808595] Dynamic subtest gt_mocs: SUCCESS (0.703s)
[352.858658] Starting dynamic subtest: gt_pm
[359.430195] Dynamic subtest gt_pm: SUCCESS (6.624s)
[359.480310] Starting dynamic subtest: gt_heartbeat
[360.193157] Dynamic subtest gt_heartbeat: SUCCESS (0.762s)
[360.234961] Starting dynamic subtest: requests
[365.513530] Dynamic subtest requests: SUCCESS (5.327s)
[365.555427] Starting dynamic subtest: migrate
[366.292901] Dynamic subtest migrate: SUCCESS (0.771s)
[366.342965] Starting dynamic subtest: active
[366.995755] Dynamic subtest active: SUCCESS (0.712s)
[367.037555] Starting dynamic subtest: objects
[368.332116] Dynamic subtest objects: SUCCESS (1.335s)
[368.382160] Starting dynamic subtest: mman
[372.895997] Dynamic subtest mman: SUCCESS (4.560s)
[372.937757] Starting dynamic subtest: dmabuf
[373.639798] Dynamic subtest dmabuf: SUCCESS (0.742s)
[373.689799] Starting dynamic subtest: vma
[374.361151] Dynamic subtest vma: SUCCESS (0.729s)
[374.402855] Starting dynamic subtest: coherency
[376.055392] Dynamic subtest coherency: SUCCESS (1.692s)
[376.105520] Starting dynamic subtest: gtt
[380.244405] Dynamic subtest gtt: SUCCESS (4.185s)
[380.294508] Starting dynamic subtest: gem
[381.056058] Dynamic subtest gem: SUCCESS (0.816s)
[381.097754] Starting dynamic subtest: evict
[381.802075] Dynamic subtest evict: SUCCESS (0.743s)
[381.852159] Starting dynamic subtest: hugepages
[383.204788] Dynamic subtest hugepages: SUCCESS (1.406s)
[383.246529] Starting dynamic subtest: gem_contexts
[387.685672] Dynamic subtest gem_contexts: SUCCESS (4.472s)
[387.735865] Starting dynamic subtest: client
[388.405207] Dynamic subtest client: SUCCESS (0.730s)
[388.446989] Starting dynamic subtest: gem_migrate
[389.167577] Dynamic subtest gem_migrate: SUCCESS (0.758s)
[389.217635] Starting dynamic subtest: reset
[390.103940] Dynamic subtest reset: SUCCESS (0.943s)
[390.145639] Starting dynamic subtest: memory_region
[390.856647] Dynamic subtest memory_region: SUCCESS (0.750s)
[390.906700] Starting dynamic subtest: hangcheck
[393.336711] Dynamic subtest hangcheck: SUCCESS (2.480s)
[393.378459] Starting dynamic subtest: execlists
[394.081235] Dynamic subtest execlists: SUCCESS (0.742s)
[394.131320] Starting dynamic subtest: ring_submission
[394.810497] Dynamic subtest ring_submission: SUCCESS (0.729s)
[394.860623] Starting dynamic subtest: perf
[395.554951] Dynamic subtest perf: SUCCESS (0.746s)
[395.604990] Starting dynamic subtest: slpc
[396.265893] Dynamic subtest slpc: SUCCESS (0.710s)
[396.307739] Starting dynamic subtest: guc
[397.011688] Dynamic subtest guc: SUCCESS (0.741s)
[397.061922] Starting dynamic subtest: guc_multi_lrc
[397.731077] Dynamic subtest guc_multi_lrc: SUCCESS (0.717s)
[397.781169] Starting dynamic subtest: guc_hang
[398.508605] Dynamic subtest guc_hang: SUCCESS (0.788s)
[398.550472] Starting dynamic subtest: late_gt_pm
[399.246270] Dynamic subtest late_gt_pm: SUCCESS (0.727s)
[399.288153] Subtest live: SUCCESS (55.782s)
[399.407377] [165/171] (661s left) dmabuf (all-tests)
[400.173099] Starting subtest: all-tests
[400.214846] Starting dynamic subtest: sanitycheck
[400.256696] Dynamic subtest sanitycheck: SUCCESS (0.108s)
[400.307054] Starting dynamic subtest: dma_fence
[400.399031] Dynamic subtest dma_fence: SUCCESS (0.129s)
[400.449144] Starting dynamic subtest: dma_fence_chain
[415.069213] Dynamic subtest dma_fence_chain: SUCCESS (14.719s)
[415.119767] Starting dynamic subtest: dma_fence_unwrap
[415.161562] Dynamic subtest dma_fence_unwrap: SUCCESS (0.023s)
[415.211683] Starting dynamic subtest: dma_resv
[415.253476] Dynamic subtest dma_resv: SUCCESS (0.024s)
[415.295360] Subtest all-tests: SUCCESS (15.009s)
[415.423036] [166/171] (645s left) i915_suspend (basic-s2idle-without-i915)
[415.998456] Starting subtest: basic-s2idle-without-i915
[437.198904] Subtest basic-s2idle-without-i915: SUCCESS (6.483s)
[439.143700] [167/171] (638s left) i915_suspend (basic-s3-without-i915)
[440.060972] Starting subtest: basic-s3-without-i915
[460.437517] Subtest basic-s3-without-i915: SUCCESS (5.828s)
[462.823894] [168/171] (631s left) gem_exec_suspend (basic-s0)
[463.849750] Starting subtest: basic-S0
[463.899902] Starting dynamic subtest: smem
[483.841359] Dynamic subtest smem: SUCCESS (4.443s)
[483.883181] Subtest basic-S0: SUCCESS (4.443s)
[486.769399] [169/171] (626s left) gem_exec_suspend (basic-s3)
[487.319119] Starting subtest: basic-S3
[487.360967] Starting dynamic subtest: smem
[506.013777] Dynamic subtest smem: SUCCESS (4.498s)
[506.055658] Subtest basic-S3: SUCCESS (4.499s)
[508.242539] [170/171] (620s left) kms_chamelium_hpd (common-hpd-after-suspend)
[509.219667] Subtest common-hpd-after-suspend: SKIP (0.000s)
[509.774495] [171/171] (619s left) kms_pipe_crc_basic (suspend-read-crc)
[510.432579] Starting subtest: suspend-read-crc
[510.466083] Starting dynamic subtest: pipe-A-LVDS-1
[529.939996] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.533s)
[529.990254] Starting dynamic subtest: pipe-B-LVDS-1
[551.020344] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.217s)
[551.053862] Subtest suspend-read-crc: SUCCESS (9.755s)
[553.231348] Closing watchdogs
Done.