Console Output

Skipping 3,586 KB.. Full Log
02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_environment_variables_in_secrets [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_environment_services_convert_types_v2 [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_environment_services_convert_types_v3 [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_environment_services_convert_types_invalid [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_environment_network_convert_types [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_environment_external_resource_convert_types [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_service_name_uses_dot [32mPASSED[0m[36m [ 94%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_escaped_interpolation [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_invalid_interpolation [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_missing_no_default [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_with_value [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_missing_with_default [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_with_empty_and_default_value [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_mandatory_values [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_mandatory_no_err_msg [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_mixed_separators [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_unbraced_separators [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_unicode_values [32mPASSED[0m[36m [ 95%][0m

02:09:43 tests/unit/config/interpolation_test.py::test_interpolate_no_fallthrough [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_1 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_2 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_3 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_4 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_5 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_6 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_7 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_circular_imports [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_circular_imports_2 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_circular_imports_3 [32mPASSED[0m[36m [ 96%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_self_imports [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/sort_services_test.py::TestSortService::test_sort_service_dicts_depends_on_self [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::test_parse_extra_hosts_list [32mPASSED[0m[36m      [ 97%][0m

02:09:43 tests/unit/config/types_test.py::test_parse_extra_hosts_dict [32mPASSED[0m[36m      [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_dict [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_simple_target_port [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_complete_port_definition [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_ext_ip_no_published_port [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_repr_published_port_0 [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_port_range [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_port_publish_range [32mPASSED[0m[36m [ 97%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_invalid_port [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestServicePort::test_parse_invalid_publish_range [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_spec_only_one_path [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_spec_internal_and_external [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_spec_with_mode [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_spec_too_many_parts [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_absolute_path_normalized [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_absolute_path_native [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_internal_path_normalized [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_internal_path_native [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_just_drives_normalized [32mPASSED[0m[36m [ 98%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_just_drives_native [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_mixed_notations_normalized [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumeSpec::test_parse_volume_windows_mixed_notations_native [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v1_from_service [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v1_from_container [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v1_invalid [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v2_from_service [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v2_from_service_with_mode [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v2_from_container [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v2_from_container_with_mode [32mPASSED[0m[36m [ 99%][0m

02:09:43 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v2_invalid_type [32mPASSED[0m[36m [ 99%][0m

02:09:44 tests/integration/project_test.py::ProjectTest::test_up_with_network_priorities [32mPASSED[0m[36m [ 23%][0m

02:09:45 tests/integration/project_test.py::ProjectTest::test_up_with_network_static_addresses [32mPASSED[0m[36m [ 23%][0m

02:09:45 tests/integration/project_test.py::ProjectTest::test_up_with_network_static_addresses_missing_subnet [32mPASSED[0m[36m [ 23%][0m

02:09:45 tests/integration/project_test.py::ProjectTest::test_up_with_nvidia_runtime [33mSKIPPED[0m[36m [ 23%][0m

02:09:46 tests/integration/project_test.py::ProjectTest::test_up_with_runtime [32mPASSED[0m[36m [ 23%][0m

02:09:46 tests/integration/project_test.py::ProjectTest::test_volumes_from_container [32mPASSED[0m[36m [ 23%][0m

02:09:46 tests/integration/project_test.py::ProjectTest::test_volumes_from_service [32mPASSED[0m[36m [ 23%][0m

02:09:47 [33mWARNING: You are using pip version 19.1.1, however version 19.2.3 is available.
02:09:47 You should consider upgrading via the 'pip install --upgrade pip' command.[0m
02:09:47 ++ ./script/build/write-git-sha
02:09:47 ++ su -c '/code/.tox/py36/bin/pyinstaller docker-compose.spec' user
02:09:47 148 INFO: PyInstaller: 3.3.1
02:09:47 148 INFO: Python: 3.6.8
02:09:47 149 INFO: Platform: Linux-4.15.0-1045-aws-x86_64-with-debian-9.9
02:09:47 151 INFO: UPX is not available.
02:09:47 153 INFO: Extending PYTHONPATH with paths
02:09:47 ['/code/bin', '/code']
02:09:47 153 INFO: checking Analysis
02:09:47 153 INFO: Building Analysis because out00-Analysis.toc is non existent
02:09:47 153 INFO: Initializing module dependency graph...
02:09:47 155 INFO: Initializing module graph hooks...
02:09:47 156 INFO: Analyzing base_library.zip ...
02:09:47 tests/integration/resilience_test.py::ResilienceTest::test_create_failure [32mPASSED[0m[36m [ 23%][0m

02:09:48 tests/unit/config/types_test.py::TestVolumesFromSpec::test_parse_v2_invalid [32mPASSED[0m[36m [100%][0m

02:09:48 

02:09:48 =================================== FAILURES ===================================

02:09:48 [1m[31m_________ CLITestCase.test_logs_follow_logs_from_restarted_containers __________[0m

02:09:48 [1m[31mtests/acceptance/cli_test.py[0m:2345: in test_logs_follow_logs_from_restarted_containers

02:09:48 [1m    assert result.stdout.count([0m

02:09:48 [1m[31mE   AssertionError: assert 2 == 3[0m

02:09:48 [1m[31mE    +  where 2 = <built-in method count of unicode object at 0x7f136b52a9c0>('logs-restart-composefile_another_1 exited with code 1')[0m

02:09:48 [1m[31mE    +    where <built-in method count of unicode object at 0x7f136b52a9c0> = 'Attaching to logs-restart-composefile_simple_1, logs-restart-composefile_another_1\n[36msimple_1   |[0m hello\n[33ma...-restart-composefile_another_1 exited with code 1\n[0m[36mlogs-restart-composefile_simple_1 exited with code 137\n[0m'.count[0m

02:09:48 [1m[31mE    +      where 'Attaching to logs-restart-composefile_simple_1, logs-restart-composefile_another_1\n[36msimple_1   |[0m hello\n[33ma...-restart-composefile_another_1 exited with code 1\n[0m[36mlogs-restart-composefile_simple_1 exited with code 137\n[0m' = ProcessResult(stdout=u'Attaching to logs-restart-composefile_simple_1, logs-re...rCreating logs-restart-composefile_another_1 ... \x1b[32mdone\x1b[0m\r\x1b[1B').stdout[0m

02:09:48 ----------------------------- Captured stdout call -----------------------------

02:09:48 Running process: 687

02:09:48 Running process: 700

02:09:48 ----------------------------- Captured stderr call -----------------------------

02:09:48 Removing logs-restart-composefile_simple_1  ... 


02:09:48 Removing logs-restart-composefile_another_1 ... 


02:09:48 [2A[2K
Removing logs-restart-composefile_simple_1  ... [32mdone[0m
[2B[1A[2K
Removing logs-restart-composefile_another_1 ... [32mdone[0m
[1B

02:09:48 

02:09:48 ---------- coverage: platform linux2, python 2.7.13-final-0 ----------

02:09:48 Name                              Stmts   Miss Branch BrPart  Cover   Missing

02:09:48 -----------------------------------------------------------------------------

02:09:48 compose/__init__.py                   3      0      0      0   100%

02:09:48 compose/__main__.py                   4      4      0      0     0%   1-6

02:09:48 compose/bundle.py                   134     22     56      3    84%   45, 50-51, 56-57, 75-78, 81, 100-102, 112-118, 124-129, 132, 80->81, 107->112, 131->132

02:09:48 compose/cli/__init__.py               0      0      0      0   100%

02:09:48 compose/cli/colors.py                23      2     10      2    88%   37-38, 36->37, 48->exit

02:09:48 compose/cli/command.py               83     13     22      3    81%   49-59, 97-102, 146, 48->49, 96->97, 143->146

02:09:48 compose/cli/docker_client.py         75      5     24      2    93%   24, 98-99, 107, 123, 106->107, 122->123

02:09:48 compose/cli/docopt_command.py        38      4      8      2    87%   13-14, 29, 35, 28->29, 34->35

02:09:48 compose/cli/errors.py               100     26     34      6    67%   47-48, 62-65, 70-79, 105-106, 123, 125, 127-131, 136, 141-148, 46->47, 61->62, 103->105, 122->123, 124->125, 126->127

02:09:48 compose/cli/formatter.py             34      2      8      1    93%   17-18, 15->17

02:09:48 compose/cli/log_printer.py          144     12     50      5    90%   76, 103, 110-115, 162-164, 173, 226-229, 253, 43->exit, 75->76, 98->103, 171->173, 225->226

02:09:48 compose/cli/main.py                 683     90    286     40    84%   83-84, 86-87, 168, 313, 343-345, 429, 490, 494, 499-500, 510-539, 551, 569-571, 642-643, 681-682, 700, 720-721, 733, 756, 774, 821, 1051, 1061, 1087-1096, 1136-1139, 1147-1151, 1153-1158, 1181, 1203-1232, 1239-1240, 1242-1244, 1259, 1265, 1440, 1458, 1474, 1478-1479, 1490, 1495, 1498, 1524, 1543-1545, 1555, 1566, 60->63, 82->83, 85->86, 167->168, 312->313, 342->343, 428->429, 489->490, 493->494, 504->510, 548->551, 568->569, 640->642, 699->700, 719->720, 732->733, 755->756, 811->821, 813->exit, 1050->1051, 1060->1061, 1146->1147, 1152->1153, 1180->1181, 1238->1239, 1241->1242, 1258->1259, 1264->1265, 1439->1440, 1457->1458, 1473->1474, 1489->1490, 1494->1495, 1497->1498, 1516->exit, 1523->1524, 1537->1545, 1539->1543, 1554->1555, 1564->1566

02:09:48 compose/cli/signals.py               23      0      4      2    93%   36->exit, 43->exit

02:09:48 compose/cli/utils.py                 81     29     18      4    59%   36-45, 53-55, 62-68, 76, 90-103, 111-112, 127-128, 138, 151-154, 88->90, 108->111, 137->138, 150->151

02:09:48 compose/cli/verbose_proxy.py         35     12     10      0    69%   36-39, 42-47, 50-60

02:09:48 compose/config/__init__.py           13      0      0      0   100%

02:09:48 compose/config/config.py            822     29    386     18    95%   266, 277, 600-601, 693, 736, 791-809, 931-932, 938, 958, 961, 1314, 1345, 1391, 265->266, 276->277, 688->692, 692->693, 735->736, 757->exit, 788->791, 915->917, 917->921, 936->938, 957->958, 960->961, 972->981, 994->996, 996->999, 1311->1314, 1344->1345, 1387->1391

02:09:48 compose/config/environment.py        92      7     32      4    91%   41, 94-97, 110, 117, 40->41, 93->94, 109->110, 116->117

02:09:48 compose/config/errors.py             25      2      0      0    92%   36-40

02:09:48 compose/config/interpolation.py     148      7     62      4    94%   66, 148, 196, 222, 227-229, 121->exit, 146->148, 195->196, 221->222

02:09:48 compose/config/serialize.py          92      1     48      2    98%   74, 73->74, 80->83

02:09:48 compose/config/sort_services.py      44      1     18      1    97%   57, 56->57

02:09:48 compose/config/types.py             291     22    112     17    90%   54, 90, 113, 149, 171, 258-259, 267, 286, 301, 363-364, 372-373, 377-378, 441, 445, 486, 493-494, 502, 53->54, 71->79, 89->90, 112->113, 118->exit, 148->149, 170->171, 257->258, 266->267, 285->286, 298->301, 361->366, 440->441, 444->445, 484->489, 485->486, 501->502

02:09:48 compose/config/validation.py        254     14    140     12    92%   219, 249, 299-300, 318-319, 341, 363, 469-471, 496-498, 525, 218->219, 248->249, 289->299, 317->318, 335->338, 338->341, 362->363, 404->377, 425->exit, 467->469, 495->496, 524->525

02:09:48 compose/const.py                     36      0      0      0   100%

02:09:48 compose/container.py                193      8     48      7    94%   98, 105, 151, 153, 262, 265, 297, 320, 97->98, 104->105, 150->151, 152->153, 236->235, 303->exit, 319->320

02:09:48 compose/errors.py                    17      1      0      0    94%   12

02:09:48 compose/network.py                  190     19     92      5    87%   184, 186-200, 206, 224, 226, 183->184, 185->186, 205->206, 223->224, 225->226

02:09:48 compose/parallel.py                 199      2     56      1    99%   187, 326, 325->326

02:09:48 compose/progress_stream.py           79      8     40      9    86%   40, 71, 74, 80, 85, 90-91, 116, 39->40, 42->46, 53->57, 70->71, 73->74, 79->80, 84->85, 89->90, 112->116

02:09:48 compose/project.py                  415     27    166     15    92%   60, 156, 212-213, 254-255, 365, 379-382, 435, 486, 490, 617, 620-623, 744-745, 751-754, 769, 774-777, 780, 801, 57->60, 152->156, 331->333, 362->365, 378->379, 434->435, 485->486, 489->490, 616->617, 619->620, 667->exit, 747->754, 768->769, 773->774, 779->780

02:09:48 compose/service.py                  841     43    376     23    94%   272-273, 294, 412-417, 423-425, 465-466, 480, 483, 501, 568, 613-614, 721, 940-941, 961-962, 1060, 1106, 1161, 1225-1240, 1280, 1319-1323, 1511, 1515, 1671, 217->exit, 270->272, 293->294, 422->423, 464->465, 479->480, 482->483, 500->501, 558->568, 716->721, 939->940, 960->961, 1059->1060, 1105->1106, 1160->1161, 1279->1280, 1316->1319, 1510->1511, 1514->1515, 1563->exit, 1571->1570, 1608->1605, 1670->1671

02:09:48 compose/state.py                      0      0      0      0   100%

02:09:48 compose/timeparse.py                 22      0      4      0   100%

02:09:48 compose/utils.py                    117      7     42      5    92%   26, 75-79, 125, 135, 168, 171, 25->26, 124->125, 134->135, 167->168, 169->171

02:09:48 compose/version.py                    6      0      0      0   100%

02:09:48 compose/volume.py                   126      4     44      3    95%   150, 200, 211-212, 141->150, 199->200, 209->211

02:09:48 -----------------------------------------------------------------------------

02:09:48 TOTAL                              5482    423   2196    196    91%

02:09:48 Coverage HTML written to dir coverage-html

02:09:48 

02:09:48 =========================== short test summary info ============================

02:09:48 XFAIL tests/integration/service_test.py::ServiceTest::test_create_container_with_cpu_rt

02:09:48   not supported by kernel

02:09:48 XFAIL tests/integration/service_test.py::ServiceTest::test_create_container_with_storage_opt

02:09:48   Not supported on most drivers

02:09:48 SKIP [1] tests/unit/cli/errors_test.py:70: Needs pywin32

02:09:48 SKIP [1] tests/unit/config/config_test.py:3738: windows paths

02:09:48 SKIP [1] tests/unit/cli/errors_test.py:80: Needs pywin32

02:09:48 SKIP [1] tests/unit/cli/command_test.py:39: windows separator

02:09:48 SKIP [1] tests/unit/cli/errors_test.py:90: Needs pywin32

02:09:48 SKIP [1] tests/integration/service_test.py:1635: Broken on 1.11.0 - 17.03.0

02:09:48 SKIP [1] /code/tests/integration/testcases.py:166: This daemon does not support the 'nvidia'' runtime

02:09:48 SKIP [1] tests/integration/service_test.py:147: cpu_percent is not supported for Linux

02:09:48 [1m[31m=== 1 failed, 1094 passed, 8 skipped, 2 xfailed, 2 xpassed in 767.72 seconds ===[0m

02:09:48 [31mERROR: InvocationError: '/code/.tox/py27/bin/py.test -v --cov=compose --cov-report html --cov-report term --cov-config=tox.ini --verbose'[0m

02:09:48 ___________________________________ summary ____________________________________

02:09:48 [31mERROR:   py27: commands failed[0m

02:09:48 + on_exit
02:09:48 + [[ 1 != \0 ]]
02:09:48 + docker logs compose-dind-18.09.9-rc1-jenkins-compose-v1.24.0-2
02:09:48 + tail -n 100
02:09:48 time="2019-08-28T02:08:35.462518520Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:35.801450210Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/c9c9aaba28df12fb76cabf3e5f04c9d5e2cbbb1625011c93da8479744e26a895/shim.sock" debug=false pid=18923 
02:09:48 time="2019-08-28T02:08:36.226625703Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/14f498b236e28c7733f93b28e0cb50a53105adc60e61b98c3743749f554ffa7c/shim.sock" debug=false pid=18979 
02:09:48 time="2019-08-28T02:08:36.631497172Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d4844287b731898aebf0f1dfcda1d1129d2f7f984583a8ed9491315c0ab9a10b/shim.sock" debug=false pid=19034 
02:09:48 time="2019-08-28T02:08:37.984670385Z" level=info msg="Container c9c9aaba28df12fb76cabf3e5f04c9d5e2cbbb1625011c93da8479744e26a895 failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:38.065609217Z" level=info msg="shim reaped" id=c9c9aaba28df12fb76cabf3e5f04c9d5e2cbbb1625011c93da8479744e26a895 
02:09:48 time="2019-08-28T02:08:38.075750522Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:38.346105611Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/bb9b6d1bb193ac3b1603b9d089b42ee4aed3d4ece19a28d34913be1d553c2051/shim.sock" debug=false pid=19121 
02:09:48 time="2019-08-28T02:08:38.757218262Z" level=info msg="shim reaped" id=bb9b6d1bb193ac3b1603b9d089b42ee4aed3d4ece19a28d34913be1d553c2051 
02:09:48 time="2019-08-28T02:08:38.769347221Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:38.986289928Z" level=info msg="shim reaped" id=d4844287b731898aebf0f1dfcda1d1129d2f7f984583a8ed9491315c0ab9a10b 
02:09:48 time="2019-08-28T02:08:38.996445467Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:39.225002386Z" level=info msg="shim reaped" id=14f498b236e28c7733f93b28e0cb50a53105adc60e61b98c3743749f554ffa7c 
02:09:48 time="2019-08-28T02:08:39.235101219Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:39.562817304Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d31b7df1ed2383a889ab2dc84e7be1b2901f4c2f11dc970cf9ceffc953f64592/shim.sock" debug=false pid=19260 
02:09:48 time="2019-08-28T02:08:39.970808172Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/f7739fb3d59c2aa963e2a116dced2b2fdfb31df03dab3de0f99bd8147c3f3819/shim.sock" debug=false pid=19317 
02:09:48 time="2019-08-28T02:08:40.388840923Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/3789a61bbd0400c1d0bcfc7a99b6b545b89f4c311fa10fb8e45434419262d24e/shim.sock" debug=false pid=19373 
02:09:48 time="2019-08-28T02:08:41.740205452Z" level=info msg="Container d31b7df1ed2383a889ab2dc84e7be1b2901f4c2f11dc970cf9ceffc953f64592 failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:41.825378203Z" level=info msg="shim reaped" id=d31b7df1ed2383a889ab2dc84e7be1b2901f4c2f11dc970cf9ceffc953f64592 
02:09:48 time="2019-08-28T02:08:41.835659805Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:42.162279998Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/650ad631592675d3522d67538b6ca90345c8ddff4164cd4f177849509dcfd5a7/shim.sock" debug=false pid=19465 
02:09:48 time="2019-08-28T02:08:43.452578618Z" level=info msg="Container f7739fb3d59c2aa963e2a116dced2b2fdfb31df03dab3de0f99bd8147c3f3819 failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:43.537373786Z" level=info msg="shim reaped" id=f7739fb3d59c2aa963e2a116dced2b2fdfb31df03dab3de0f99bd8147c3f3819 
02:09:48 time="2019-08-28T02:08:43.547495348Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:43.798059249Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/3fd42987467600734db13f8cb14b76360f37ba23a8fa25a3898113d202e60193/shim.sock" debug=false pid=19553 
02:09:48 time="2019-08-28T02:08:45.124290749Z" level=info msg="Container 3789a61bbd0400c1d0bcfc7a99b6b545b89f4c311fa10fb8e45434419262d24e failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:45.210086363Z" level=info msg="shim reaped" id=3789a61bbd0400c1d0bcfc7a99b6b545b89f4c311fa10fb8e45434419262d24e 
02:09:48 time="2019-08-28T02:08:45.220226039Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:45.514509896Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/1dfa843242ae62c54d331bbf3d1974b0f637ff673043e51a12d737a1472dd871/shim.sock" debug=false pid=19641 
02:09:48 time="2019-08-28T02:08:45.891805941Z" level=info msg="shim reaped" id=1dfa843242ae62c54d331bbf3d1974b0f637ff673043e51a12d737a1472dd871 
02:09:48 time="2019-08-28T02:08:45.901971255Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:46.109777572Z" level=info msg="shim reaped" id=3fd42987467600734db13f8cb14b76360f37ba23a8fa25a3898113d202e60193 
02:09:48 time="2019-08-28T02:08:46.119900580Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:46.331984365Z" level=info msg="shim reaped" id=650ad631592675d3522d67538b6ca90345c8ddff4164cd4f177849509dcfd5a7 
02:09:48 time="2019-08-28T02:08:46.342138435Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:46.682562614Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/d80661fced667a2527e7d13188625b35397878e06f01b4f6b0b9db5740397d4d/shim.sock" debug=false pid=19777 
02:09:48 time="2019-08-28T02:08:47.095009270Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/ee22a77dc6759c03d19e54570df4379a3f35c25ac0c8bd36a522c73b4dba96da/shim.sock" debug=false pid=19832 
02:09:48 time="2019-08-28T02:08:47.537662088Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/75f3dfb677b905cfd1486d9df8e7aee6dd2c8dbeb1cc6bfbd2731dd73a82682d/shim.sock" debug=false pid=19889 
02:09:48 time="2019-08-28T02:08:47.929591241Z" level=info msg="shim reaped" id=75f3dfb677b905cfd1486d9df8e7aee6dd2c8dbeb1cc6bfbd2731dd73a82682d 
02:09:48 time="2019-08-28T02:08:47.939607087Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:48.156693355Z" level=info msg="shim reaped" id=ee22a77dc6759c03d19e54570df4379a3f35c25ac0c8bd36a522c73b4dba96da 
02:09:48 time="2019-08-28T02:08:48.166820679Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:48.384846781Z" level=info msg="shim reaped" id=d80661fced667a2527e7d13188625b35397878e06f01b4f6b0b9db5740397d4d 
02:09:48 time="2019-08-28T02:08:48.394973559Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:48.718394997Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/55ef4ce4348d9c22d92e7221e045e1e1f867b2a41757453fc968cfdf53043651/shim.sock" debug=false pid=20025 
02:09:48 time="2019-08-28T02:08:49.169378887Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/080d75c8a6b459b109cfd2b35fcdbb2ee3c08bd151ada392a1b9fab4c1b6196c/shim.sock" debug=false pid=20082 
02:09:48 time="2019-08-28T02:08:50.461627640Z" level=info msg="Container 55ef4ce4348d9c22d92e7221e045e1e1f867b2a41757453fc968cfdf53043651 failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:50.541251793Z" level=info msg="shim reaped" id=55ef4ce4348d9c22d92e7221e045e1e1f867b2a41757453fc968cfdf53043651 
02:09:48 time="2019-08-28T02:08:50.551398228Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:50.823312185Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/0c0b26b690f20a931adf7efbae6dffc17649c983e382b2a0b94a2124b258a9a4/shim.sock" debug=false pid=20170 
02:09:48 time="2019-08-28T02:08:51.223112882Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/2eb25582f158c83e8d68efa33a812ed0ce3959f8ea022b5b742179b5158636ac/shim.sock" debug=false pid=20226 
02:09:48 time="2019-08-28T02:08:51.612641924Z" level=info msg="shim reaped" id=2eb25582f158c83e8d68efa33a812ed0ce3959f8ea022b5b742179b5158636ac 
02:09:48 time="2019-08-28T02:08:51.622796849Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:51.844247841Z" level=info msg="shim reaped" id=0c0b26b690f20a931adf7efbae6dffc17649c983e382b2a0b94a2124b258a9a4 
02:09:48 time="2019-08-28T02:08:51.854516471Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:52.097567775Z" level=info msg="shim reaped" id=080d75c8a6b459b109cfd2b35fcdbb2ee3c08bd151ada392a1b9fab4c1b6196c 
02:09:48 time="2019-08-28T02:08:52.107692090Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:52.439641843Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/4d62f298aabd22a9f70fe611a95d3f3fc5bb186d78757898dd44bbd721e75551/shim.sock" debug=false pid=20360 
02:09:48 time="2019-08-28T02:08:52.875697649Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/ca342020de19caebf753d27dbdd114c9ec913616860303f8374757523db2f42d/shim.sock" debug=false pid=20416 
02:09:48 time="2019-08-28T02:08:53.249330649Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/bf1a8a7f5b22fac49865c7d02844145b2503f63331750aa977c4df1ef145fa7b/shim.sock" debug=false pid=20471 
02:09:48 time="2019-08-28T02:08:54.571393924Z" level=info msg="Container bf1a8a7f5b22fac49865c7d02844145b2503f63331750aa977c4df1ef145fa7b failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:54.659206832Z" level=info msg="shim reaped" id=bf1a8a7f5b22fac49865c7d02844145b2503f63331750aa977c4df1ef145fa7b 
02:09:48 time="2019-08-28T02:08:54.669310197Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:55.840906775Z" level=info msg="Container ca342020de19caebf753d27dbdd114c9ec913616860303f8374757523db2f42d failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:55.921346826Z" level=info msg="shim reaped" id=ca342020de19caebf753d27dbdd114c9ec913616860303f8374757523db2f42d 
02:09:48 time="2019-08-28T02:08:55.931485021Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:57.109289845Z" level=info msg="Container 4d62f298aabd22a9f70fe611a95d3f3fc5bb186d78757898dd44bbd721e75551 failed to exit within 1 seconds of signal 15 - using the force"
02:09:48 time="2019-08-28T02:08:57.194235815Z" level=info msg="shim reaped" id=4d62f298aabd22a9f70fe611a95d3f3fc5bb186d78757898dd44bbd721e75551 
02:09:48 time="2019-08-28T02:08:57.204400945Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:57.510856717Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/779217d36d815bfb4cc2c69b3e459045a1d64b17a332c51e4b2c4f467e52baa9/shim.sock" debug=false pid=20623 
02:09:48 time="2019-08-28T02:08:57.938469604Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/beb651eb716a9fbd57b017c944c165ca5a707af30a7cbac627ec1df9d9756c01/shim.sock" debug=false pid=20679 
02:09:48 time="2019-08-28T02:08:58.286843839Z" level=info msg="shim reaped" id=beb651eb716a9fbd57b017c944c165ca5a707af30a7cbac627ec1df9d9756c01 
02:09:48 time="2019-08-28T02:08:58.296984472Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:58.576052307Z" level=info msg="shim reaped" id=779217d36d815bfb4cc2c69b3e459045a1d64b17a332c51e4b2c4f467e52baa9 
02:09:48 time="2019-08-28T02:08:58.586182705Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:08:58.907330450Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/ceda88e6ed919d76dc88e0cc34cf111c000aa41267f845bcb6d8714ab671a3ff/shim.sock" debug=false pid=20791 
02:09:48 time="2019-08-28T02:08:59.339803224Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/fbc28a567613e47319d8da8dd31f72a56afb9524cebaa8e3ae5535cd99160791/shim.sock" debug=false pid=20846 
02:09:48 time="2019-08-28T02:08:59.873344475Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/b661964f8f6a88877e68906b9095ef3fb67ba30b361e712132df7d21f1155abf/shim.sock" debug=false pid=20902 
02:09:48 time="2019-08-28T02:09:00.261607255Z" level=info msg="shim reaped" id=b661964f8f6a88877e68906b9095ef3fb67ba30b361e712132df7d21f1155abf 
02:09:48 time="2019-08-28T02:09:00.271746448Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:09:00.522221771Z" level=info msg="shim reaped" id=fbc28a567613e47319d8da8dd31f72a56afb9524cebaa8e3ae5535cd99160791 
02:09:48 time="2019-08-28T02:09:00.532371127Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:09:00.749579087Z" level=info msg="shim reaped" id=ceda88e6ed919d76dc88e0cc34cf111c000aa41267f845bcb6d8714ab671a3ff 
02:09:48 time="2019-08-28T02:09:00.759755645Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:09:01.250582418Z" level=info msg="Layer sha256:bb76c08977524bffe677977c36db1213865621ea467020d012c5d7fd8af2a61b cleaned up"
02:09:48 time="2019-08-28T02:09:02.166869891Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/6ad2a0fc3bbc6073314280cea2413ff7ccf5fd2cdeda108b974f285e27eccb85/shim.sock" debug=false pid=21049 
02:09:48 time="2019-08-28T02:09:02.532864370Z" level=info msg="shim reaped" id=6ad2a0fc3bbc6073314280cea2413ff7ccf5fd2cdeda108b974f285e27eccb85 
02:09:48 time="2019-08-28T02:09:02.542977485Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:09:02.920100819Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/94884fc27a655c96c1476823e86b6fe723473468494c3c5c3f54bb74d609298c/shim.sock" debug=false pid=21131 
02:09:48 time="2019-08-28T02:09:03.253804893Z" level=info msg="shim reaped" id=94884fc27a655c96c1476823e86b6fe723473468494c3c5c3f54bb74d609298c 
02:09:48 time="2019-08-28T02:09:03.263870870Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:09:03.687329890Z" level=info msg="Layer sha256:bb76c08977524bffe677977c36db1213865621ea467020d012c5d7fd8af2a61b cleaned up"
02:09:48 time="2019-08-28T02:09:04.394720817Z" level=info msg="Layer sha256:bb76c08977524bffe677977c36db1213865621ea467020d012c5d7fd8af2a61b cleaned up"
02:09:48 time="2019-08-28T02:09:05.454807376Z" level=info msg="Layer sha256:bb76c08977524bffe677977c36db1213865621ea467020d012c5d7fd8af2a61b cleaned up"
02:09:48 time="2019-08-28T02:09:06.443988431Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/c3667dc40e0bef7481cef67203b69159728bb7349476b266b24c959c87a5f829/shim.sock" debug=false pid=21249 
02:09:48 time="2019-08-28T02:09:06.452320788Z" level=info msg="shim containerd-shim started" address="/containerd-shim/moby/6b2058aefd0360c7cb27fb87dd2b29d29cef00a11b3cb58f169b20473cc55c04/shim.sock" debug=false pid=21263 
02:09:48 time="2019-08-28T02:09:06.901978624Z" level=info msg="shim reaped" id=6b2058aefd0360c7cb27fb87dd2b29d29cef00a11b3cb58f169b20473cc55c04 
02:09:48 time="2019-08-28T02:09:06.912068358Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 time="2019-08-28T02:09:07.152237558Z" level=info msg="shim reaped" id=c3667dc40e0bef7481cef67203b69159728bb7349476b266b24c959c87a5f829 
02:09:48 time="2019-08-28T02:09:07.162410786Z" level=info msg="ignoring event" module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
02:09:48 + docker rm -vf compose-dind-18.09.9-rc1-jenkins-compose-v1.24.0-2
02:09:48 2822 INFO: running Analysis out00-Analysis.toc
02:09:48 2835 INFO: Caching module hooks...
02:09:48 tests/integration/resilience_test.py::ResilienceTest::test_start_failure [32mPASSED[0m[36m [ 23%][0m

02:09:48 compose-dind-18.09.9-rc1-jenkins-compose-v1.24.0-2
02:09:48 2841 INFO: Analyzing bin/docker-compose
02:09:48 2937 INFO: Processing pre-find module path hook   distutils
02:09:48 2937 INFO: distutils: retargeting to non-venv dir '/usr/local/lib/python3.6/distutils'
02:09:48 3090 INFO: Processing pre-safe import module hook   urllib3.packages.six.moves
02:09:48 [33mWARNING: You are using pip version 19.1.1, however version 19.2.3 is available.
02:09:48 You should consider upgrading via the 'pip install --upgrade pip' command.[0m
02:09:48 ++ ./script/build/write-git-sha
02:09:48 ++ su -c '/code/.tox/py36/bin/pyinstaller docker-compose.spec' user
02:09:48 146 INFO: PyInstaller: 3.3.1
02:09:48 147 INFO: Python: 3.6.8
02:09:48 148 INFO: Platform: Linux-4.15.0-1045-aws-x86_64-with-debian-9.9
02:09:48 150 INFO: UPX is not available.
02:09:48 151 INFO: Extending PYTHONPATH with paths
02:09:48 ['/code/bin', '/code']
02:09:48 151 INFO: checking Analysis
02:09:48 152 INFO: Building Analysis because out00-Analysis.toc is non existent
02:09:48 152 INFO: Initializing module dependency graph...
02:09:48 153 INFO: Initializing module graph hooks...
02:09:48 154 INFO: Analyzing base_library.zip ...
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // withDockerRegistry
[Pipeline] }
[Pipeline] // node
[Pipeline] }
Failed in branch 18.09.9-rc1_py27
02:09:49 Sending interrupt signal to process
02:09:49 Sending interrupt signal to process
02:09:49 tests/integration/resilience_test.py::ResilienceTest::test_successful_recreate Sending interrupt signal to process
02:09:49 Terminated
02:09:49 script returned exit code 143
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // withDockerRegistry
[Pipeline] }
[Pipeline] // node
[Pipeline] }
Failed in branch 18.09.9-rc1_py36
02:09:49 Terminated
02:09:49 script returned exit code 143
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // withDockerRegistry
[Pipeline] }
[Pipeline] // node
02:09:49 Terminated
[Pipeline] }
Failed in branch 19.03.2-rc1_py36
02:09:49 script returned exit code 143
[Pipeline] }
[Pipeline] // stage
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // wrap
[Pipeline] }
[Pipeline] // withDockerRegistry
[Pipeline] }
[Pipeline] // node
[Pipeline] }
Failed in branch 18.09.9-rc1_py37
[Pipeline] // parallel
[Pipeline] End of Pipeline

GitHub has been notified of this commit’s build result

ERROR: script returned exit code 1
Finished: FAILURE