builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1504744990.42 results: success (0) revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.416556) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.417233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.417661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.436205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.436536) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 17:43:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.5M=0s 2017-09-06 17:43:10 (41.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.572974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.573330) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014852 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:10.623905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 17:43:10.624266) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d8e238b811d3dc74515065ae8cab6c74baf0295f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev d8e238b811d3dc74515065ae8cab6c74baf0295f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 17:43:10,677 truncating revision to first 12 chars 2017-09-06 17:43:10,677 Setting DEBUG logging. 2017-09-06 17:43:10,677 attempt 1/10 2017-09-06 17:43:10,677 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d8e238b811d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 17:43:12,038 unpacking tar archive at: mozilla-central-d8e238b811d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.710446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-06 17:43:12.352944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:12.353277) ========= script_repo_revision: d8e238b811d3dc74515065ae8cab6c74baf0295f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:12.353698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:12.353971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 17:43:12.366391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-06 17:43:12.366670) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:43:12 INFO - MultiFileLogger online at 20170906 17:43:12 in /builds/slave/test 17:43:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:43:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:12 INFO - {'append_to_log': False, 17:43:12 INFO - 'base_work_dir': '/builds/slave/test', 17:43:12 INFO - 'blob_upload_branch': 'Firefox', 17:43:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:12 INFO - 'branch': 'Firefox', 17:43:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:12 INFO - 'code_coverage': False, 17:43:12 INFO - 'config_files': ('talos/linux_config.py',), 17:43:12 INFO - 'default_actions': ('clobber', 17:43:12 INFO - 'read-buildbot-config', 17:43:12 INFO - 'download-and-extract', 17:43:12 INFO - 'populate-webroot', 17:43:12 INFO - 'create-virtualenv', 17:43:12 INFO - 'install', 17:43:12 INFO - 'setup-mitmproxy', 17:43:12 INFO - 'run-tests'), 17:43:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:12 INFO - 'disable_ccov_upload': False, 17:43:12 INFO - 'disable_stylo': False, 17:43:12 INFO - 'download_minidump_stackwalk': True, 17:43:12 INFO - 'download_symbols': 'ondemand', 17:43:12 INFO - 'enable_stylo': False, 17:43:12 INFO - 'enable_webrender': False, 17:43:12 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:43:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:12 INFO - 'gecko_profile': False, 17:43:12 INFO - 'gecko_profile_interval': 0, 17:43:12 INFO - 'installer_path': 'installer.exe', 17:43:12 INFO - 'log_level': 'info', 17:43:12 INFO - 'log_name': 'talos', 17:43:12 INFO - 'log_to_console': True, 17:43:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:43:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:43:12 INFO - 'opt_config_files': (), 17:43:12 INFO - 'pip_index': False, 17:43:12 INFO - 'suite': 'dromaeojs-e10s', 17:43:12 INFO - 'system_bits': '32', 17:43:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:12 INFO - 'title': 'talos-linux64-ix-061', 17:43:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:12 INFO - 'use_talos_json': True, 17:43:12 INFO - 'verify': 'False', 17:43:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:12 INFO - 'work_dir': 'build'} 17:43:12 INFO - [mozharness: 2017-09-07 00:43:12.565562Z] Running clobber step. 17:43:12 INFO - Running pre-action listener: _resource_record_pre_action 17:43:12 INFO - Running main action method: clobber 17:43:12 INFO - rmtree: /builds/slave/test/build 17:43:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:13 INFO - Running post-action listener: _resource_record_post_action 17:43:13 INFO - [mozharness: 2017-09-07 00:43:13.589734Z] Finished clobber step (success) 17:43:13 INFO - [mozharness: 2017-09-07 00:43:13.589830Z] Running read-buildbot-config step. 17:43:13 INFO - Running pre-action listener: _resource_record_pre_action 17:43:13 INFO - Running main action method: read_buildbot_config 17:43:13 INFO - Using buildbot properties: 17:43:13 INFO - { 17:43:13 INFO - "project": "", 17:43:13 INFO - "product": "firefox", 17:43:13 INFO - "who": "kwierso@gmail.com", 17:43:13 INFO - "installer_path": "public/build/target.tar.bz2", 17:43:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:43:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:43:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:43:13 INFO - "stage_platform": "linux64-pgo", 17:43:13 INFO - "basedir": "/builds/slave/test", 17:43:13 INFO - "buildnumber": 161, 17:43:13 INFO - "platform": "ubuntu64_hw", 17:43:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:43:13 INFO - "slavebuilddir": "test", 17:43:13 INFO - "taskId": "Nwi-61RSQCOeUgIDS6tv3Q", 17:43:13 INFO - "branch": "mozilla-central", 17:43:13 INFO - "script_repo_revision": "production", 17:43:13 INFO - "revision": "d8e238b811d3dc74515065ae8cab6c74baf0295f", 17:43:13 INFO - "slavename": "talos-linux64-ix-061", 17:43:13 INFO - "repo_path": "mozilla-central" 17:43:13 INFO - } 17:43:13 INFO - Finding installer, test and symbols from parent task. 17:43:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nwi-61RSQCOeUgIDS6tv3Q'}, attempt #1 17:43:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nwi-61RSQCOeUgIDS6tv3Q'}, attempt #1 17:43:14 INFO - Task dependencies: ccxe2CkMRWeKQ6akbP-iGA 17:43:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA'}, attempt #1 17:43:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 17:43:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json 17:43:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - [mozharness: 2017-09-07 00:43:15.015519Z] Finished read-buildbot-config step (success) 17:43:15 INFO - [mozharness: 2017-09-07 00:43:15.015734Z] Running download-and-extract step. 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: download_and_extract 17:43:15 INFO - mkdir: /builds/slave/test/build/tests 17:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:15 INFO - trying https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json 17:43:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:43:15 INFO - Downloaded 989 bytes. 17:43:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:43:15 INFO - Using the following test package requirements: 17:43:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:43:15 INFO - u'common': [u'target.common.tests.zip'], 17:43:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:43:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:43:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:43:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:43:15 INFO - u'mozbase': [u'target.common.tests.zip'], 17:43:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:43:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:43:15 INFO - u'web-platform': [u'target.common.tests.zip', 17:43:15 INFO - u'target.web-platform.tests.tar.gz'], 17:43:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:43:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:43:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip 17:43:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:43:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip into memory 17:43:16 INFO - Content-Length response header: 55692002 17:43:16 INFO - Bytes received: 55692002 17:43:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:43:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip 17:43:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:43:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.common.tests.zip into memory 17:43:28 INFO - Content-Length response header: 55692002 17:43:28 INFO - Bytes received: 55692002 17:43:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.talos.tests.zip 17:43:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:43:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.talos.tests.zip into memory 17:43:41 INFO - Content-Length response header: 14496665 17:43:41 INFO - Bytes received: 14496665 17:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:41 INFO - trying https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 17:43:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:43:43 INFO - Downloaded 63485315 bytes. 17:43:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 17:43:43 INFO - mkdir: /builds/slave/test/properties 17:43:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:43 INFO - Contents: 17:43:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 17:43:43 INFO - Running post-action listener: _resource_record_post_action 17:43:43 INFO - Running post-action listener: find_tests_for_verification 17:43:43 INFO - Running post-action listener: set_extra_try_arguments 17:43:43 INFO - [mozharness: 2017-09-07 00:43:43.188453Z] Finished download-and-extract step (success) 17:43:43 INFO - [mozharness: 2017-09-07 00:43:43.188547Z] Running populate-webroot step. 17:43:43 INFO - Running pre-action listener: _resource_record_pre_action 17:43:43 INFO - Running main action method: populate_webroot 17:43:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['tresize', 17:43:43 INFO - 'tcanvasmark']}, 17:43:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['dromaeo_css', 17:43:43 INFO - 'kraken']}, 17:43:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'tests': ['damp', 'tps']}, 17:43:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['damp', 'tps']}, 17:43:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['dromaeo_dom']}, 17:43:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:43:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['basic_compositor_video', 17:43:43 INFO - 'glvideo']}, 17:43:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:43:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['ts_paint_webext', 17:43:43 INFO - 'tp5o_webext']}, 17:43:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:43 INFO - 'ts_paint', 17:43:43 INFO - 'tpaint', 17:43:43 INFO - 'sessionrestore', 17:43:43 INFO - 'sessionrestore_many_windows', 17:43:43 INFO - 'sessionrestore_no_auto_restore', 17:43:43 INFO - 'tabpaint']}, 17:43:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['a11yr', 17:43:43 INFO - 'ts_paint', 17:43:43 INFO - 'tpaint', 17:43:43 INFO - 'sessionrestore', 17:43:43 INFO - 'sessionrestore_many_windows', 17:43:43 INFO - 'sessionrestore_no_auto_restore', 17:43:43 INFO - 'tabpaint']}, 17:43:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:43:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:43:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['bloom_basic_singleton']}, 17:43:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['bloom_basic']}, 17:43:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:43 INFO - 'tsvgr_opacity', 17:43:43 INFO - 'tart', 17:43:43 INFO - 'tscrollx', 17:43:43 INFO - 'tsvg_static']}, 17:43:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['tsvgx', 17:43:43 INFO - 'tsvgr_opacity', 17:43:43 INFO - 'tart', 17:43:43 INFO - 'tscrollx', 17:43:43 INFO - 'tsvg_static']}, 17:43:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:43:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'talos_options': ['--disable-stylo'], 17:43:43 INFO - 'tests': ['tp5o']}, 17:43:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:43:43 INFO - 'talos_options': ['--mitmproxy', 17:43:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:43:43 INFO - '--firstNonBlankPaint'], 17:43:43 INFO - 'tests': ['tp6_google', 17:43:43 INFO - 'tp6_youtube', 17:43:43 INFO - 'tp6_amazon', 17:43:43 INFO - 'tp6_facebook']}, 17:43:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:43:43 INFO - 'talos_options': ['--disable-stylo', 17:43:43 INFO - '--mitmproxy', 17:43:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:43:43 INFO - '--firstNonBlankPaint'], 17:43:43 INFO - 'tests': ['tp6_google', 17:43:43 INFO - 'tp6_youtube', 17:43:43 INFO - 'tp6_amazon', 17:43:43 INFO - 'tp6_facebook']}, 17:43:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:43:43 INFO - 'talos_options': ['--stylo-threads=1', 17:43:43 INFO - '--mitmproxy', 17:43:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:43:43 INFO - '--firstNonBlankPaint'], 17:43:43 INFO - 'tests': ['tp6_google', 17:43:43 INFO - 'tp6_youtube', 17:43:43 INFO - 'tp6_amazon', 17:43:43 INFO - 'tp6_facebook']}, 17:43:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'talos_options': ['--xperf_path', 17:43:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:43 INFO - 'tests': ['tp5n']}, 17:43:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:43:43 INFO - 'talos_options': ['--disable-stylo', 17:43:43 INFO - '--xperf_path', 17:43:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:43 INFO - 'tests': ['tp5n']}}} 17:43:43 INFO - Running post-action listener: _resource_record_post_action 17:43:43 INFO - [mozharness: 2017-09-07 00:43:43.203535Z] Finished populate-webroot step (success) 17:43:43 INFO - [mozharness: 2017-09-07 00:43:43.203624Z] Running create-virtualenv step. 17:43:43 INFO - Running pre-action listener: _resource_record_pre_action 17:43:43 INFO - Running main action method: create_virtualenv 17:43:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:43:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:43:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:43:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:43 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:44 INFO - Installing pip...............done. 17:43:44 INFO - Return code: 0 17:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:43:44 INFO - Reading from file tmpfile_stdout 17:43:44 INFO - Output received: 17:43:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:43:44 INFO - Using env: {'DISPLAY': ':0', 17:43:44 INFO - 'HOME': '/home/cltbld', 17:43:44 INFO - 'LANG': 'en_US.UTF-8', 17:43:44 INFO - 'LANGUAGE': 'en_US:en', 17:43:44 INFO - 'LOGNAME': 'cltbld', 17:43:44 INFO - 'MAIL': '/var/mail/cltbld', 17:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:44 INFO - 'MOZ_NO_REMOTE': '1', 17:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:44 INFO - 'NO_EM_RESTART': '1', 17:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:44 INFO - 'PWD': '/builds/slave/test', 17:43:44 INFO - 'SHELL': '/bin/bash', 17:43:44 INFO - 'SHLVL': '1', 17:43:44 INFO - 'TERM': 'linux', 17:43:44 INFO - 'TMOUT': '86400', 17:43:44 INFO - 'USER': 'cltbld', 17:43:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:44 INFO - '_': '/tools/buildbot/bin/python'} 17:43:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:43:45 INFO - Downloading/unpacking pip>=1.5 17:43:45 INFO - Running setup.py egg_info for package pip 17:43:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:43:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:43:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:43:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:43:45 INFO - Installing collected packages: pip 17:43:45 INFO - Found existing installation: pip 1.1 17:43:45 INFO - Uninstalling pip: 17:43:45 INFO - Successfully uninstalled pip 17:43:45 INFO - Running setup.py install for pip 17:43:45 INFO - warning: no files found matching 'pip/cacert.pem' 17:43:45 INFO - warning: no files found matching '*.html' under directory 'docs' 17:43:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:43:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:43:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:43:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:43:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:43:45 INFO - Successfully installed pip 17:43:45 INFO - Cleaning up... 17:43:45 INFO - Return code: 0 17:43:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:43:45 INFO - Using env: {'DISPLAY': ':0', 17:43:45 INFO - 'HOME': '/home/cltbld', 17:43:45 INFO - 'LANG': 'en_US.UTF-8', 17:43:45 INFO - 'LANGUAGE': 'en_US:en', 17:43:45 INFO - 'LOGNAME': 'cltbld', 17:43:45 INFO - 'MAIL': '/var/mail/cltbld', 17:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:45 INFO - 'MOZ_NO_REMOTE': '1', 17:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:45 INFO - 'NO_EM_RESTART': '1', 17:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:45 INFO - 'PWD': '/builds/slave/test', 17:43:45 INFO - 'SHELL': '/bin/bash', 17:43:45 INFO - 'SHLVL': '1', 17:43:45 INFO - 'TERM': 'linux', 17:43:45 INFO - 'TMOUT': '86400', 17:43:45 INFO - 'USER': 'cltbld', 17:43:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:45 INFO - '_': '/tools/buildbot/bin/python'} 17:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:45 INFO - Downloading/unpacking psutil>=3.1.1 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:46 INFO - Installing collected packages: psutil 17:43:46 INFO - Running setup.py install for psutil 17:43:46 INFO - building 'psutil._psutil_linux' extension 17:43:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:43:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:43:47 INFO - building 'psutil._psutil_posix' extension 17:43:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:43:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:47 INFO - Successfully installed psutil 17:43:47 INFO - Cleaning up... 17:43:47 INFO - Return code: 0 17:43:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:43:47 INFO - Using env: {'DISPLAY': ':0', 17:43:47 INFO - 'HOME': '/home/cltbld', 17:43:47 INFO - 'LANG': 'en_US.UTF-8', 17:43:47 INFO - 'LANGUAGE': 'en_US:en', 17:43:47 INFO - 'LOGNAME': 'cltbld', 17:43:47 INFO - 'MAIL': '/var/mail/cltbld', 17:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:47 INFO - 'MOZ_NO_REMOTE': '1', 17:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:47 INFO - 'NO_EM_RESTART': '1', 17:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:47 INFO - 'PWD': '/builds/slave/test', 17:43:47 INFO - 'SHELL': '/bin/bash', 17:43:47 INFO - 'SHLVL': '1', 17:43:47 INFO - 'TERM': 'linux', 17:43:47 INFO - 'TMOUT': '86400', 17:43:47 INFO - 'USER': 'cltbld', 17:43:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:47 INFO - '_': '/tools/buildbot/bin/python'} 17:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:43:48 INFO - Installing collected packages: mozsystemmonitor 17:43:48 INFO - Running setup.py install for mozsystemmonitor 17:43:48 INFO - Successfully installed mozsystemmonitor 17:43:48 INFO - Cleaning up... 17:43:48 INFO - Return code: 0 17:43:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:43:48 INFO - Using env: {'DISPLAY': ':0', 17:43:48 INFO - 'HOME': '/home/cltbld', 17:43:48 INFO - 'LANG': 'en_US.UTF-8', 17:43:48 INFO - 'LANGUAGE': 'en_US:en', 17:43:48 INFO - 'LOGNAME': 'cltbld', 17:43:48 INFO - 'MAIL': '/var/mail/cltbld', 17:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:48 INFO - 'MOZ_NO_REMOTE': '1', 17:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:48 INFO - 'NO_EM_RESTART': '1', 17:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:48 INFO - 'PWD': '/builds/slave/test', 17:43:48 INFO - 'SHELL': '/bin/bash', 17:43:48 INFO - 'SHLVL': '1', 17:43:48 INFO - 'TERM': 'linux', 17:43:48 INFO - 'TMOUT': '86400', 17:43:48 INFO - 'USER': 'cltbld', 17:43:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:48 INFO - '_': '/tools/buildbot/bin/python'} 17:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:49 INFO - Downloading/unpacking jsonschema==2.5.1 17:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:50 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:50 INFO - warning: no files found matching '*.txt' 17:43:50 INFO - no previously-included directories found matching 'build' 17:43:50 INFO - no previously-included directories found matching 'dist' 17:43:50 INFO - no previously-included directories found matching '.git*' 17:43:50 INFO - Installing collected packages: jsonschema, functools32 17:43:50 INFO - Running setup.py install for functools32 17:43:50 INFO - warning: no files found matching '*.txt' 17:43:50 INFO - no previously-included directories found matching 'build' 17:43:50 INFO - no previously-included directories found matching 'dist' 17:43:50 INFO - no previously-included directories found matching '.git*' 17:43:50 INFO - Successfully installed jsonschema functools32 17:43:50 INFO - Cleaning up... 17:43:50 INFO - Return code: 0 17:43:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:43:50 INFO - Using env: {'DISPLAY': ':0', 17:43:50 INFO - 'HOME': '/home/cltbld', 17:43:50 INFO - 'LANG': 'en_US.UTF-8', 17:43:50 INFO - 'LANGUAGE': 'en_US:en', 17:43:50 INFO - 'LOGNAME': 'cltbld', 17:43:50 INFO - 'MAIL': '/var/mail/cltbld', 17:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:50 INFO - 'MOZ_NO_REMOTE': '1', 17:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:50 INFO - 'NO_EM_RESTART': '1', 17:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:50 INFO - 'PWD': '/builds/slave/test', 17:43:50 INFO - 'SHELL': '/bin/bash', 17:43:50 INFO - 'SHLVL': '1', 17:43:50 INFO - 'TERM': 'linux', 17:43:50 INFO - 'TMOUT': '86400', 17:43:50 INFO - 'USER': 'cltbld', 17:43:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:50 INFO - '_': '/tools/buildbot/bin/python'} 17:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:43:50 INFO - Cleaning up... 17:43:50 INFO - Return code: 0 17:43:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:50 INFO - Using env: {'DISPLAY': ':0', 17:43:50 INFO - 'HOME': '/home/cltbld', 17:43:50 INFO - 'LANG': 'en_US.UTF-8', 17:43:50 INFO - 'LANGUAGE': 'en_US:en', 17:43:50 INFO - 'LOGNAME': 'cltbld', 17:43:50 INFO - 'MAIL': '/var/mail/cltbld', 17:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:50 INFO - 'MOZ_NO_REMOTE': '1', 17:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:50 INFO - 'NO_EM_RESTART': '1', 17:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:50 INFO - 'PWD': '/builds/slave/test', 17:43:50 INFO - 'SHELL': '/bin/bash', 17:43:50 INFO - 'SHLVL': '1', 17:43:50 INFO - 'TERM': 'linux', 17:43:50 INFO - 'TMOUT': '86400', 17:43:50 INFO - 'USER': 'cltbld', 17:43:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:50 INFO - '_': '/tools/buildbot/bin/python'} 17:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - Downloading docopt-0.6.1.tar.gz 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:52 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:52 INFO - Running setup.py install for blobuploader 17:43:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:52 INFO - Running setup.py install for requests 17:43:53 INFO - Running setup.py install for docopt 17:43:53 INFO - Successfully installed blobuploader requests docopt 17:43:53 INFO - Cleaning up... 17:43:53 INFO - Return code: 0 17:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:53 INFO - Using env: {'DISPLAY': ':0', 17:43:53 INFO - 'HOME': '/home/cltbld', 17:43:53 INFO - 'LANG': 'en_US.UTF-8', 17:43:53 INFO - 'LANGUAGE': 'en_US:en', 17:43:53 INFO - 'LOGNAME': 'cltbld', 17:43:53 INFO - 'MAIL': '/var/mail/cltbld', 17:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:53 INFO - 'MOZ_NO_REMOTE': '1', 17:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:53 INFO - 'NO_EM_RESTART': '1', 17:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:53 INFO - 'PWD': '/builds/slave/test', 17:43:53 INFO - 'SHELL': '/bin/bash', 17:43:53 INFO - 'SHLVL': '1', 17:43:53 INFO - 'TERM': 'linux', 17:43:53 INFO - 'TMOUT': '86400', 17:43:53 INFO - 'USER': 'cltbld', 17:43:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:53 INFO - '_': '/tools/buildbot/bin/python'} 17:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:53 INFO - Running setup.py (path:/tmp/pip-h_iG1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:53 INFO - Running setup.py (path:/tmp/pip-RlLXgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:53 INFO - Running setup.py (path:/tmp/pip-6UK9aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:53 INFO - Running setup.py (path:/tmp/pip-c1qFuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:53 INFO - Running setup.py (path:/tmp/pip-3SEkMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:53 INFO - Running setup.py (path:/tmp/pip-vxVqhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:53 INFO - Running setup.py (path:/tmp/pip-TfeVL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:53 INFO - Running setup.py (path:/tmp/pip-WwufnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:54 INFO - Running setup.py (path:/tmp/pip-sv09XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:54 INFO - Running setup.py (path:/tmp/pip-cFE6Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:54 INFO - Running setup.py (path:/tmp/pip-JmnihV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:54 INFO - Running setup.py (path:/tmp/pip-t82XRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:54 INFO - Running setup.py (path:/tmp/pip-Ui3IOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:54 INFO - Running setup.py (path:/tmp/pip-F0xKqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:54 INFO - Running setup.py (path:/tmp/pip-PgeG_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:54 INFO - Running setup.py (path:/tmp/pip-aIQkN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:54 INFO - Running setup.py (path:/tmp/pip-OzL3kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:54 INFO - Running setup.py install for manifestparser 17:43:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Running setup.py install for mozcrash 17:43:54 INFO - Running setup.py install for mozdebug 17:43:54 INFO - Running setup.py install for mozdevice 17:43:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozfile 17:43:55 INFO - Running setup.py install for mozhttpd 17:43:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozinfo 17:43:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozInstall 17:43:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozleak 17:43:55 INFO - Running setup.py install for mozlog 17:43:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for moznetwork 17:43:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozprocess 17:43:55 INFO - Running setup.py install for mozprofile 17:43:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Running setup.py install for mozrunner 17:43:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Running setup.py install for mozscreenshot 17:43:56 INFO - Running setup.py install for moztest 17:43:56 INFO - Running setup.py install for mozversion 17:43:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:56 INFO - Cleaning up... 17:43:56 INFO - Return code: 0 17:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:56 INFO - Using env: {'DISPLAY': ':0', 17:43:56 INFO - 'HOME': '/home/cltbld', 17:43:56 INFO - 'LANG': 'en_US.UTF-8', 17:43:56 INFO - 'LANGUAGE': 'en_US:en', 17:43:56 INFO - 'LOGNAME': 'cltbld', 17:43:56 INFO - 'MAIL': '/var/mail/cltbld', 17:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:56 INFO - 'MOZ_NO_REMOTE': '1', 17:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:56 INFO - 'NO_EM_RESTART': '1', 17:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:56 INFO - 'PWD': '/builds/slave/test', 17:43:56 INFO - 'SHELL': '/bin/bash', 17:43:56 INFO - 'SHLVL': '1', 17:43:56 INFO - 'TERM': 'linux', 17:43:56 INFO - 'TMOUT': '86400', 17:43:56 INFO - 'USER': 'cltbld', 17:43:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:56 INFO - '_': '/tools/buildbot/bin/python'} 17:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:56 INFO - Running setup.py (path:/tmp/pip-QmVOXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:56 INFO - Running setup.py (path:/tmp/pip-3G1Vqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:56 INFO - Running setup.py (path:/tmp/pip-efDMM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:56 INFO - Running setup.py (path:/tmp/pip-aPlfpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:56 INFO - Running setup.py (path:/tmp/pip-98nlEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:57 INFO - Running setup.py (path:/tmp/pip-AYJAXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:57 INFO - Running setup.py (path:/tmp/pip-5RlUxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:57 INFO - Running setup.py (path:/tmp/pip-sPA5ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:57 INFO - Running setup.py (path:/tmp/pip-RDBy2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:57 INFO - Running setup.py (path:/tmp/pip-tInhPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:57 INFO - Running setup.py (path:/tmp/pip-AEPLlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:57 INFO - Running setup.py (path:/tmp/pip-VM3cLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:57 INFO - Running setup.py (path:/tmp/pip-CG603Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:57 INFO - Running setup.py (path:/tmp/pip-iDndWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:57 INFO - Running setup.py (path:/tmp/pip-_oYZKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:57 INFO - Running setup.py (path:/tmp/pip-fincu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:57 INFO - Running setup.py (path:/tmp/pip-76C4WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:58 INFO - Downloading blessings-1.6.tar.gz 17:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:59 INFO - Installing collected packages: blessings 17:43:59 INFO - Running setup.py install for blessings 17:43:59 INFO - Successfully installed blessings 17:43:59 INFO - Cleaning up... 17:43:59 INFO - Return code: 0 17:43:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:59 INFO - Reading from file tmpfile_stdout 17:43:59 INFO - Current package versions: 17:43:59 INFO - argparse == 1.2.1 17:43:59 INFO - blessings == 1.6 17:43:59 INFO - blobuploader == 1.2.4 17:43:59 INFO - docopt == 0.6.1 17:43:59 INFO - functools32 == 3.2.3-2 17:43:59 INFO - jsonschema == 2.5.1 17:43:59 INFO - manifestparser == 1.1 17:43:59 INFO - mozInstall == 1.13 17:43:59 INFO - mozcrash == 1.0 17:43:59 INFO - mozdebug == 0.1 17:43:59 INFO - mozdevice == 0.51 17:43:59 INFO - mozfile == 1.2 17:43:59 INFO - mozhttpd == 0.7 17:43:59 INFO - mozinfo == 0.10 17:43:59 INFO - mozleak == 0.1 17:43:59 INFO - mozlog == 3.5 17:43:59 INFO - moznetwork == 0.27 17:43:59 INFO - mozprocess == 0.25 17:43:59 INFO - mozprofile == 0.28 17:43:59 INFO - mozrunner == 6.13 17:43:59 INFO - mozscreenshot == 0.1 17:43:59 INFO - mozsystemmonitor == 0.3 17:43:59 INFO - moztest == 0.8 17:43:59 INFO - mozversion == 1.4 17:43:59 INFO - psutil == 3.1.1 17:43:59 INFO - requests == 1.2.3 17:43:59 INFO - wsgiref == 0.1.2 17:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:59 INFO - Using env: {'DISPLAY': ':0', 17:43:59 INFO - 'HOME': '/home/cltbld', 17:43:59 INFO - 'LANG': 'en_US.UTF-8', 17:43:59 INFO - 'LANGUAGE': 'en_US:en', 17:43:59 INFO - 'LOGNAME': 'cltbld', 17:43:59 INFO - 'MAIL': '/var/mail/cltbld', 17:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:59 INFO - 'MOZ_NO_REMOTE': '1', 17:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:59 INFO - 'NO_EM_RESTART': '1', 17:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:59 INFO - 'PWD': '/builds/slave/test', 17:43:59 INFO - 'SHELL': '/bin/bash', 17:43:59 INFO - 'SHLVL': '1', 17:43:59 INFO - 'TERM': 'linux', 17:43:59 INFO - 'TMOUT': '86400', 17:43:59 INFO - 'USER': 'cltbld', 17:43:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:59 INFO - '_': '/tools/buildbot/bin/python'} 17:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:43:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:00 INFO - Installing collected packages: simplejson 17:44:00 INFO - Running setup.py install for simplejson 17:44:00 INFO - building 'simplejson._speedups' extension 17:44:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:44:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:44:01 INFO - Successfully installed simplejson 17:44:01 INFO - Cleaning up... 17:44:01 INFO - Return code: 0 17:44:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1532a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:01 INFO - Using env: {'DISPLAY': ':0', 17:44:01 INFO - 'HOME': '/home/cltbld', 17:44:01 INFO - 'LANG': 'en_US.UTF-8', 17:44:01 INFO - 'LANGUAGE': 'en_US:en', 17:44:01 INFO - 'LOGNAME': 'cltbld', 17:44:01 INFO - 'MAIL': '/var/mail/cltbld', 17:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:01 INFO - 'MOZ_NO_REMOTE': '1', 17:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:01 INFO - 'NO_EM_RESTART': '1', 17:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:01 INFO - 'PWD': '/builds/slave/test', 17:44:01 INFO - 'SHELL': '/bin/bash', 17:44:01 INFO - 'SHLVL': '1', 17:44:01 INFO - 'TERM': 'linux', 17:44:01 INFO - 'TMOUT': '86400', 17:44:01 INFO - 'USER': 'cltbld', 17:44:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:01 INFO - '_': '/tools/buildbot/bin/python'} 17:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:02 INFO - Cleaning up... 17:44:02 INFO - Return code: 0 17:44:02 INFO - Running post-action listener: _resource_record_post_action 17:44:02 INFO - Running post-action listener: _start_resource_monitoring 17:44:02 INFO - Starting resource monitoring. 17:44:02 INFO - [mozharness: 2017-09-07 00:44:02.111501Z] Finished create-virtualenv step (success) 17:44:02 INFO - [mozharness: 2017-09-07 00:44:02.112039Z] Running install step. 17:44:02 INFO - Running pre-action listener: _resource_record_pre_action 17:44:02 INFO - Running main action method: install 17:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:02 INFO - Reading from file tmpfile_stdout 17:44:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:02 INFO - Reading from file tmpfile_stdout 17:44:02 INFO - Output received: 17:44:02 INFO - Usage: mozinstall [options] installer 17:44:02 INFO - Options: 17:44:02 INFO - -h, --help show this help message and exit 17:44:02 INFO - -d DEST, --destination=DEST 17:44:02 INFO - Directory to install application into. [default: 17:44:02 INFO - "/builds/slave/test"] 17:44:02 INFO - --app=APP Application being installed. [default: firefox] 17:44:02 INFO - mkdir: /builds/slave/test/build/application 17:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:44:18 INFO - Reading from file tmpfile_stdout 17:44:18 INFO - Output received: 17:44:18 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:18 INFO - Running post-action listener: _resource_record_post_action 17:44:18 INFO - [mozharness: 2017-09-07 00:44:18.814556Z] Finished install step (success) 17:44:18 INFO - [mozharness: 2017-09-07 00:44:18.814899Z] Running setup-mitmproxy step. 17:44:18 INFO - Running pre-action listener: _resource_record_pre_action 17:44:18 INFO - Running main action method: setup_mitmproxy 17:44:18 INFO - Skipping: mitmproxy is not required 17:44:18 INFO - Running post-action listener: _resource_record_post_action 17:44:18 INFO - [mozharness: 2017-09-07 00:44:18.816521Z] Finished setup-mitmproxy step (success) 17:44:18 INFO - [mozharness: 2017-09-07 00:44:18.816829Z] Running run-tests step. 17:44:18 INFO - Running pre-action listener: _resource_record_pre_action 17:44:18 INFO - Running pre-action listener: _set_gcov_prefix 17:44:18 INFO - Running main action method: run_tests 17:44:18 WARNING - Try message not found. 17:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:18 INFO - Python 2.7.3 17:44:18 INFO - Return code: 0 17:44:18 INFO - grabbing minidump binary from tooltool 17:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1530f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:44:18 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:44:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:44:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:18 INFO - Return code: 0 17:44:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:18 INFO - ENV: RUST_BACKTRACE is now full 17:44:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:44:18 INFO - Using env: {'DISPLAY': ':0', 17:44:18 INFO - 'HOME': '/home/cltbld', 17:44:18 INFO - 'LANG': 'en_US.UTF-8', 17:44:18 INFO - 'LANGUAGE': 'en_US:en', 17:44:18 INFO - 'LOGNAME': 'cltbld', 17:44:18 INFO - 'MAIL': '/var/mail/cltbld', 17:44:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:18 INFO - 'MOZ_NO_REMOTE': '1', 17:44:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:18 INFO - 'NO_EM_RESTART': '1', 17:44:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:18 INFO - 'PWD': '/builds/slave/test', 17:44:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:18 INFO - 'RUST_BACKTRACE': 'full', 17:44:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:44:18 INFO - 'SHELL': '/bin/bash', 17:44:18 INFO - 'SHLVL': '1', 17:44:18 INFO - 'TERM': 'linux', 17:44:18 INFO - 'TMOUT': '86400', 17:44:18 INFO - 'USER': 'cltbld', 17:44:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:18 INFO - '_': '/tools/buildbot/bin/python'} 17:44:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:44:19 INFO - mozversion application_buildid: 20170906225137 17:44:19 INFO - mozversion application_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 17:44:19 INFO - mozversion application_display_name: Nightly 17:44:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:19 INFO - mozversion application_name: Firefox 17:44:19 INFO - mozversion application_remotingname: firefox 17:44:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:44:19 INFO - mozversion application_vendor: Mozilla 17:44:19 INFO - mozversion application_version: 57.0a1 17:44:19 INFO - mozversion platform_buildid: 20170906225137 17:44:19 INFO - mozversion platform_changeset: d8e238b811d3dc74515065ae8cab6c74baf0295f 17:44:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:44:19 INFO - mozversion platform_version: 57.0a1 17:44:19 INFO - using testdate: 1504745059 17:44:19 INFO - actual date: 1504745059 17:44:19 INFO - starting webserver on 'localhost:42409' 17:44:19 INFO - SUITE-START | Running 2 tests 17:44:19 INFO - TEST-START | dromaeo_css 17:44:19 INFO - Initialising browser for dromaeo_css test... 17:44:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42409/getInfo.html -profile /tmp/tmpEoM85R/profile 17:44:19 INFO - TEST-INFO | started process 9618 (/builds/slave/test/build/application/firefox/firefox http://localhost:42409/getInfo.html) 17:44:25 INFO - TEST-INFO | 9618: exit 0 17:44:25 INFO - Browser initialized. 17:44:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:25 INFO - Using env: {'DISPLAY': ':0', 17:44:25 INFO - 'HOME': '/home/cltbld', 17:44:25 INFO - 'JSGC_DISABLE_POISONING': '1', 17:44:25 INFO - 'LANG': 'en_US.UTF-8', 17:44:25 INFO - 'LANGUAGE': 'en_US:en', 17:44:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:44:25 INFO - 'LOGNAME': 'cltbld', 17:44:25 INFO - 'MAIL': '/var/mail/cltbld', 17:44:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:25 INFO - 'MOZ_CRASHREPORTER': '1', 17:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:44:25 INFO - 'MOZ_NO_REMOTE': '1', 17:44:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:25 INFO - 'NO_EM_RESTART': '1', 17:44:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:25 INFO - 'PWD': '/builds/slave/test', 17:44:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:25 INFO - 'RUST_BACKTRACE': 'full', 17:44:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:44:25 INFO - 'SHELL': '/bin/bash', 17:44:25 INFO - 'SHLVL': '1', 17:44:25 INFO - 'TERM': 'linux', 17:44:25 INFO - 'TMOUT': '86400', 17:44:25 INFO - 'USER': 'cltbld', 17:44:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 17:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:25 INFO - '_': '/tools/buildbot/bin/python'} 17:44:25 INFO - TEST-INFO | started process 9819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEoM85R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:26 INFO - PID 9819 | 17:44:26 INFO - PID 9819 | (/builds/slave/test/build/application/firefox/firefox:9872): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:44:26 INFO - PID 9819 | 17:44:36 INFO - PID 9819 | RSS: Main: 160612352 17:44:36 INFO - PID 9819 | 17:47:33 INFO - PID 9819 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42409/tests/dromaeo/cssquery-ext.html) 17:47:34 INFO - PID 9819 | RSS: Main: 167505920 17:47:34 INFO - PID 9819 | 17:50:35 INFO - PID 9819 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-ext.html (next: http://localhost:42409/tests/dromaeo/cssquery-jquery.html) 17:50:36 INFO - PID 9819 | RSS: Main: 164298752 17:50:36 INFO - PID 9819 | 17:53:38 INFO - PID 9819 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42409/tests/dromaeo/cssquery-mootools.html) 17:53:38 INFO - PID 9819 | RSS: Main: 166715392 17:53:38 INFO - PID 9819 | 17:56:40 INFO - PID 9819 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42409/tests/dromaeo/cssquery-prototype.html) 17:56:40 INFO - PID 9819 | RSS: Main: 165269504 17:56:40 INFO - PID 9819 | 17:59:43 INFO - PID 9819 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42409/tests/dromaeo/cssquery-yui.html) 17:59:44 INFO - PID 9819 | RSS: Main: 166457344 17:59:44 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | Cycle 1(1): loaded http://localhost:42409/tests/dromaeo/cssquery-yui.html (next: http://localhost:42409/tests/dromaeo/cssquery-dojo.html) 18:02:46 INFO - PID 9819 | RSS: Main: 169226240 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | __start_tp_report 18:02:46 INFO - PID 9819 | _x_x_mozilla_page_load 18:02:46 INFO - PID 9819 | _x_x_mozilla_page_load_details 18:02:46 INFO - PID 9819 | |i|pagename|runs| 18:02:46 INFO - PID 9819 | |0;dojo.html;3832.635899589538;3881.8447262109516;3912.5109361329824;3920.6863450923893;3921.843126274949;6358.300586935434;6368.6178829270275;6380.202474690664;6382.5532212745065;6444.452221561167;6323.430891219789;6351.650659213741;6384.329645387237;6390;6390.872182556346;5707.686077265748;5728.398518155596;5777.0756678931375;5782.045962416196;5794.942050579503;5720.971395143039;5781.161731548944;5792.768289268445;5802;5803.767849286023;5524.254225679522;5670.432956704338;5748.511376533;5754.712264386764;5768.625039372428;5687.345955215162;5700.629459085146;5777.480026797609;5783.88432231353;5785.710714464302;5671.291088613923;5682.772689092431;5685.687287199203;5713.657180569179;5759.078547432433;6298.4646305064125;6340.809775706736;6345.809625711236;6366.808995730135;6371.713272902684;6888.448924086111;6902.171739391255;6952.721891124349;6953.860922781567;6960.617166055865;6877.3810357068105;6905.654717264167;6922.7923162305215;6925.203601585832;6926.168859736814;6438.034294855809;6457.4188323050685;6472.385123413268;6478.384553467413;6478.838029049264;7081.468889833283;7082.256363081905;7106.147262328554;7191.280871912767;7219.566825990458;6793.830154246183;6849.2465828758795;6899.103116594811;6902.723891044302;6910.896336554955;6954.965225173943;6985.615791131435;7041.823954401181;7050.330218629222;7068.081149450539;6824.590524568542;6854.485913556503;6883.690233939485;6937.132858392701;7000.2999700030605;6802.285759995129;6814.795556133324;6902.275261097613;6902.378785909293;6903.240643529208;5043.722595257223;5067.087924173684;5123.333966584395;5123.410807757155;5132.6150538709;4596.379488768974;4596.908061838744;4608.700434471749;4623.491415944243;4656.720596764205;6323.715432805443;6367.235931688227;6400.455961243347;6431.356864313625;6472.611643301417;6959.130108736408;6972.860542789116;6989.161300643956;6991.615461149584;6996.755113571001;6412.775552855627;6485.092087107809;6496.902546461807;6500.739970401226;6503.544751867324;5547.833564993057;5552.91670624941;5568.387477377485;5628.127640215773;5634.802781902614;7014.719411223596;7053.68258428372;7080.92919070813;7090.290970902868;7171.103612048494;6911.447084233249;6955.234924158237;6956.095707557985;6960.686769095403;6986.336298051677;7099.538529995534;7104.467164962752;7112.395446387115;7181.174164971095;7200.675969581277;6752.426043786333;6872.587644741132;6908.3437073477935;6976.790696279119;6991.580505169706;6724.562903411263;6974.860502790018;6999.090118284794;7005.334493223136;7007.334303241184;6690.565113267622;6711.362420570038;6750.729970801113;6758.662066896537;6796.830079248059;6678.933210668026;6688.197416310074;6693.196816382066;6769.492288078315;6781.2879647638265;6572.4084832365315;6654.567453115532;6668.733250670113;6762.49281303914;6775;6728.226253980855;6743.5953842769595;6786.981952707133;6801.8639627206185;6814.318568143146;6575.901361479486;6578.407943285128;6656.434203092597;6659.234188068241;6672.599644021374 18:02:46 INFO - PID 9819 | |1;ext.html;865.845976042402;899.9595018224179;914.1315750037464;948.6442584030989;950.7195377363677;41017.38473922894;41965.37051944219;42006;42024.57975420245;42072.78963605185;39283.21433571334;39611;39621.60378396215;39624.603753962525;39641;7180.640967951607;7284.089488813898;7292.16140143885;7296.087989001375;7297.708091676353;7207.38737207338;7298.087739032621;7303.415726741874;7311.41508679307;7312.963435182816;7281.708731650728;7312.2687731226715;7914.881276780853;8129.309008734235;8129.796755081111;8001.23988221121;8052.798680032987;8060.073091594483;8061.234182752659;8063.153368896269;7665.271799179069;7854.293113619745;7895.052593688737;7903;7907.406944479187;39746;40103.7994810027;40150.79924600358;40163;40174.59825401738;3690.335739566877;3726.5341832270965;3743.1390780120723;3744.850205991757;3745.662890339855;32348.353032939445;32545.349093018245;32559.511607325672;32563.51154732681;32653;5436.320459942507;5454.863628409282;5483.725813709339;5487.368952570426;5500.944990550083;200933;202737;203516;206033;216796;48334.516654833;48419;48507.272390914164;48528.5147148524;48720.051197952394;50982.235266471034;51002.74498627483;51094.48905510972;51402.74298628483;51493.227601586004;15470.149141797308;15552;15703.450379236672;15724.842751572567;15960.680786384208;12985;12991.675208119872;13006.089573729938;13014.21914685122;13023.674408139872;14132.364043618061;14152.929235353757;14153.150810951376;14158.929205353907;14168.787468187986;5617.297837770278;5670.461306175906;5699.800506982236;5707.34365547959;5829.242198514166;1085.2023762534532;1092.8688557373166;1104.640991677708;1114.5486078138367;1123.1913022623698;23369.883150584137;23939.521209575712;23955.198179177445;24259.636105458434;32179.839100804813;1201.2792324605166;1205.951761929513;1210.3282678113555;1218.707510197564;1219.4207751318054;13057.738845223043;13063.085584009028;13158.539451119164;13220.579562379378;13260.53588124411;292639;292969;295155;295721;296511;52040.739796300775;52409.2138617921;52543.73728131411;52569.737151313995;52579;1487.4570781664615;1505.1947208243537;1506.5179142674458;1517.7495713207197;1543.8456154384696;23849.52300954006;29918.401631967674;30330.241743956576;30920.69079309178;31286.843565782026;52972.735136324074;52997;53032.73483632557;53040;53319.200211997624;251263;255310;255322;255656;255988;36162.095947600465;37287.44068839024;37389.626103738614;37498.62501375061;37560;43817;44784.77607611941;45301.77349113365;45633.31550026686;45914.540854591025;33637.663623363456;34100.82949585236;34448.311033778686;34498.31003379868;34625;33750.66249337475;33772.662273376955;33825.830870845486;34459.13852153616;34469;38606.42090368703;38906.416403754534;38919;41721.79139104285;42451.787741061096;33931;34114.14714632154;34878.65121348754;34980.65019349876;35217.47173792446;24749.876250618632;25503.744962550878;26853.865730671223;27119;27284.317892052062 18:02:46 INFO - PID 9819 | |2;jquery.html;578.9478946894778;585.7949717598839;588.8763359694462;591.9496842768365;606.4572207873953;14942.477013304537;22043.448913777145;22869.771302286972;22874;22940.770592294073;25122.37194070149;25538.361540961487;25565.872170639122;25591.232263032092;25747.356316092108;6702.631355275458;6836.145481814773;6840.247572766992;6846.212685541152;6849.691763870638;6052.394760523956;6658.13444252249;6664.500162487809;6665.466762659;6759.797206083801;6619.834504137411;6621.768238111667;6622.337766223387;6629.867402651944;6638.668066596675;6584.473242140617;6616.437602803743;6618.271990081087;6620.867582648344;6621.801345959629;6173.228346456693;6182.536309776785;6197.628142311431;6198.659073750942;6209.534284928648;28856.567151492534;28899.855500722362;29354.853225733947;30243.848780755954;30495.390092198253;2269.795718385337;2319.8376113672048;2322.419395151195;2325.383773300077;2327.5461285049423;19780.70328945067;20499.590008199903;20517.58964820695;20521.692174617394;20573.8971305144;2472.208893154191;2518.798496120324;2560.129555950967;2610.973890261111;2620.868956552184;152623;155720;156082;156148;156249.21875390664;14577.635559110895;15561.221938903009;15961.44134955271;16018.679626407407;16135.919320403558;24374.26877193687;24930.750692493206;25033.749662503506;25124.24627261185;25275.87362063178;10297.433641149659;10367;10381.325213861075;10547.84178237327;10638.734031649115;9350.205232555172;9370.29722770795;9401.90598094024;9463.90536094644;9492.810143797085;9480.288978326653;9712.465814380277;9776.480467031863;10258.307379282334;10297.639582614573;2759.379139693593;2791.595218693278;2876.5397536394494;2886.639170103737;2910.7962442629237;1024.446798728693;1049.7323182588543;1052.7947050325267;1054.5360041581832;1055.7888422315568;20762.48093797667;20894.268700595407;21011.159553617683;21282;21748.238811641833;1120.6021862238788;1120.7254222715324;1121.971950701239;1126.1947707389093;1134.3307448605362;11112.333260004425;11299;11357.943210283896;11406.37264950419;11467.08263338931;550705;577436;581759;583752;596380;131700;137292;137658;138629;138638;1268.7652784234947;1280.8270883430619;1329.0630105775406;1332.8333958255218;1336.171573624359;22436.102555898233;22651.43371415728;22698.886505568025;22726.09095636156;22861.65707514422;61855;62690;63075.36924630695;64522.03216951843;65194.34805651883;77658.6117069411;77769.61115194387;77815.22184778079;78037;78460;15343.923280383528;15610.297536610653;15779.447719329768;15823.762643560585;15832.92083539621;23866.40333991664;24349.513009739352;24450.63324050105;24616.138435154684;24624.753752462246;19667.311644092388;19670.11484483173;19711.112999914752;20094.69857952161;20128.29550965709;17092.658146837242;17502;17627.471175864746;17789.911050444665;18248.543786405447;19077.71383429222;19770;19804.40586782399;19810.900945495756;20098.296559620343;15269.236538172825;15291.388344466097;15348.616284592528;15363.769543457081;15406.922965385102;19254.363379112932;19331;19462.416127516197;19695.310664126686;19702.704459433407 18:02:46 INFO - PID 9819 | |3;mootools.html;1359.870812272834;1394.4770710983382;1412.1315391034511;1417.9078359906612;1437.381925771918;16653.417130400423;16655.083970381624;17281.48155555332;17281.654366912684;17324.740128898076;17442.651146977052;17615.82384176158;17799.73300400495;17846.82153178471;17856.64286714268;2723.128598848369;2747.5466548019654;2753.4630747004344;2760.627315312427;2767.059199872043;2676.745709157627;2716.3209197700576;2744.341358074058;2749.917502474929;2755.8070935034557;2646.907358242462;2657.428652839639;2661;2679.571268597015;2687.3819021625036;2647.7749391301763;2691.6769987601515;2709.2143278449225;2712.2676877243034;2714.5249581323287;2639.0367515856574;2644.775194108503;2658.401859581598;2660.906868259621;2671.0784779251126;16643.50069497917;16743.07913064781;16775.32898684051;16786.244618992176;16789.496315110566;7477.962610186914;7793.142754297023;7805.5706936118495;7819.530828150329;7830.2952734254195;4941.802327906879;5056.393232812049;5067.949320506785;5178.4562620924635;5192.065428222918;2108.694239335288;2115.2808045264683;2122.61792877282;2129.1483406637467;2165.783421657837;29894.85052574723;30174.54738178929;30294.84852575723;30303.848480757457;30327.512336081192;6309.211348581427;6456.806295811133;6457.352485481024;6469.902951455732;6605.339466053356;19454.5136371589;19464.513387165433;19478.02609869501;19478.513037174183;19489.317873874345;7552.697892084255;7555.16893141754;7558.433117516099;7560.546367217985;7561.886571701429;5202.633039892135;5943.732532036069;5997.850053748692;6009.939900600938;6873.725050998004;5098.59211263098;5285.07511185541;5287.23335116406;5326.174442961347;5353.0899747043095;1438.4030627289558;1440.7262620102147;1445.9878085340304;1471.0438215160018;1474.366022610288;905.8595917632778;913.6071489259682;923.7182659288846;928.4800511713327;933.6125507914139;7838.608069596611;7851.72518961845;7897.842043159219;7951.483153594998;9555.23558115349;1019.5564929255797;1040.2250323509033;1045.289203341735;1047.9826334306429;1070.218740319571;5314.97342513285;5315.867103322448;5358.196270559447;5375.408705042442;5461.0716178248995;23676.52646947086;23979.52040959206;25025.37436564064;25038.37404064913;25081.372965676004;23740.406489837547;23842.854143127202;24240.272791816275;24580.877095614407;24706.25881223566;12117.27296362221;12180.939095304644;12364.752704945851;12516.249025058343;12539.74920501603;9258.35191536613;9688.12806847387;9718.271129665161;9773.462459564793;10063.798724025624;20802.58394832125;21123.26068587592;21163.365099047052;21194.894025529775;21522.246721364678;21667.241646542294;22033.559328813655;22117;22183.778162218816;22407.21574744876;13060.346982651019;13269.004824637997;13420.932895335462;13432.932835335761;13445.798313025116;15095.094294342374;15128.470503532324;15186.164760938254;15191.088534687955;15202.847971520143;11846.763064738485;11847.407629618658;12077.637670869888;12183.147179697336;12403.503859845505;11173.72065698364;11210.991010809066;11266;11500.25248358854;11569.19015668895;10704.785904281714;10838.620648277272;10844.728881778019;10849.132069434585;10852.45737713127;7973.601319934096;8131.634076466691;8190.467619604707;8214.219649133323;8242.958785206036;8110.351171906352;8193.139720329518;8231.09457959612;8234.835303293781;8268.917310826815 18:02:46 INFO - PID 9819 | |4;prototype.html;525.8948210357927;531.3703261634965;544.0560627311617;546.363486538183;548.9643173193742;6198.504119670427;6264.21697287839;6283.685815709219;6305.716242769075;6386;6214.502839772818;6229.968850155743;6254.405831446005;6291.40231677991;6302.243730752316;5121.12940800063;5139.280500729891;5150.562202212816;5164.122099243138;5166.302549155872;4844.975775121137;5089.422279093475;5133.307003554528;5148.382194136709;5167.638265321429;4870.975645121769;4917.385326834145;4954.2568614707725;4958.727270000149;4965.205567109263;4911.7544122793715;4932.038252540756;4935.19865249185;4937.8271760488215;4980.12847751642;4476.776161191928;4479.507254202035;4495.707778994355;4508.571685689854;4554.929591545984;6176.227971503562;6184.443400093968;6246.782392250731;6257.843553911143;6276.937230627726;5710.828675139753;5802.448767367136;5850;5900.675462849542;5918.3785702501045;6547.836304092388;6558.803235902883;6638.900416493757;6645.734170633169;6683.465322774166;5040.924386134211;5052.191649336125;5070.29015937769;5107.20838270065;5117.795288188468;6766.69549870257;6769.72921083161;6934.410575101122;7035;7103.0578029193775;5017.272495488207;5056.519630635084;5091.898162036812;5116.283720279164;5174.24973378858;5230.790768369298;5237.973810131001;5254.632175747661;5261.921071183935;5267.525922666979;5777.508911742549;5811.680357580373;5817;5819.6508209507565;5826.854328641818;6658.667066646648;6677.1319728435965;6759.628220447824;6763.898541521881;6774.72901083961;1796.2096677461875;1803.6392721455761;1816.1917946513674;1821.3443160462223;1823.6899727046434;1259.7165637731437;1268.8413948256468;1277.6997405609675;1280.8206851040861;1297.8961683065331;6205.379462053758;6288.717007734663;6293.056041593706;6295.307516173218;6417.550771446047;6643.368879956396;6647.700853461606;6669;6764.526483146231;6791.4906382021545;6086.573939824169;6261.123442718023;6263.713744483231;6322.683865806691;6344.49244060474;3566.286742651428;3600.063983364344;3603.819809009539;3615.168511242429;3627.6735093841153;7038.894416583756;7055.753048643272;7062.894056589155;7073.82315442118;7078.433725301964;6938.653067346713;6972.79081627552;7002.179433347366;7104.964475177694;7109.075820143348;6923.480738944499;7038.788836334918;7057.18842333128;7078.362947334662;7132.251113633098;6683.498737594603;6690.29751876046;6740.224874139537;6763.883959146686;6828.146481689789;6658.368699668612;6713.885126185236;6717.596944183365;6783.423409010092;6814.829629259109;6948.51360404787;6977.162740471176;7007.248187953011;7036.718531258693;7145.249748776304;5161.664491808171;5198;5205.557527610195;5209.6874187548865;5221.138512145453;6608.768693095719;6726.865462690621;6736;6828.760993365208;6845.178578570603;6405.327440618855;6466.612003279818;6504.38208370204;6601.768938087144;6602.702878370389;6562.934370656232;6589.27517973013;6600.669966501559;6611.933880661132;6643.7674681385915;6551.70517326731;6557;6573.671316434064;6596.340365963365;6652.301508341748;6621.801345959629;6646.966765166143;6672.766453174116;6721.630310332978;6745.494087943522;6416.775412860714;6459.5478316519275;6519.152510173647;6533.150690410216;6551.836204094936 18:02:46 INFO - PID 9819 | |5;yui.html;983.9950800245994;984.694744629165;1004.5579944824282;1008.7226012846471;1020.1023099672287;17003.14984250787;20022.29921952732;20655.483612909647;20666.89666551667;20704.171833126693;18686.53283667909;18756.718649220238;18868.81131188688;19457.805421945777;21328.57342853142;1049.574922156524;1060.7295139739356;1063.0220197418355;1063.8989296016866;1063.952122154501;1040.1990467340142;1078.423043671636;1089.0525243038567;1089.2429761315889;1089.3028461784425;1146.9369184694838;1151.5393842462997;1151.6545036489063;1152.0610702277618;1152.5793085523765;1134.5915470430639;1143.616888342398;1151.2459339132881;1152.804023316034;1154.261272785418;840.5671079394117;840.9663613455455;841.4068082002174;841.8442588121156;843.7047033538274;19410.611787764166;19694.31069912546;19869.80130198694;19898.20407183711;20032.399028029184;23263.18578849749;23280.65079023816;23545.175918842757;23652.881735591385;23837.642435363483;18777.342793002317;19204.13581388841;19365.903170484056;19528.31650892212;19715.014249287622;4198.244316023115;4222.831086756526;4224.176285624305;4224.598663126998;4224.9155016899485;146709.26645366813;146877.26561367232;147490;149179.25410372988;149606;17447.21487533064;17996.55008624795;18154.818451815314;18234.179461924246;18278.817211827976;33586.48860801221;33587.16032099168;33648.99053028413;33844.66155338464;34590.65409345875;9144.3598948073;9261.583228754587;9268.95365523168;9278.257739380833;9280.071992800666;4654.557817007379;4846.491118432585;4874.025194960951;4881.267809828483;4882.145624515695;6036.63780173191;6138.478229350555;6146.7233974471255;6171.753129874754;6288.213973253343;1165.8834116588444;1186.4779497021284;1197.1739499745322;1198.898093662031;1204.783139034982;717.218232126984;744.9962750186214;757.7764559454974;762.5196126440308;771.8494893495714;12895.419706113247;13297;14230.928845355707;14412.279386030657;14519.637009074646;749.8162950077266;757.2238455582961;757.7347928225078;764.4381379685926;766.9271419215165;6473.255575608771;6485.6108633482145;6495.545311828221;6547.476201903836;6565.146530951041;130998;131470;133065.33467332795;133211;136021.31989340187;120298;120966;120966.39516802535;121022;126491;103773.48113259385;104642;106777.46611267049;107219;112099.43950280196;11653.825192621947;11703.414829258674;11859.932606065495;11866.703332416759;12053.216540924812;51676.74161629168;51813.74093129661;52110.73944630404;52806.207906880656;53731.462685372644;65865;67792.98310525445;67894;69030;69750.30249697641;14552.781708274597;14731.852681473049;14751.041182323115;14758.631034223801;14858.257087145816;19463.318783842496;19688.507787304858;19740.70388944138;19758;19889.104990275184;16125.838741612903;16305.184740763152;16389.688824893743;16502.504924852274;16531.752023719415;17460;17487.82512174862;17532.561685957953;17553.12234388301;17663.20515576828;15701.685966280382;15885.841141588437;15934.760978585098;16095.114768687834;16099.67800644004;14269.42922283097;14430;14521.346539405964;14646.121232725643;14747.55757327282;12876;12929.482820687068;12963.351832408152;13072.542461013818;13185.868141318464 18:02:46 INFO - PID 9819 | __end_tp_report 18:02:46 INFO - PID 9819 | __start_cc_report 18:02:46 INFO - PID 9819 | _x_x_mozilla_cycle_collect,342 18:02:46 INFO - PID 9819 | __end_cc_report 18:02:46 INFO - PID 9819 | __startTimestamp1504746166355__endTimestamp 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | ------- Summary: start ------- 18:02:46 INFO - PID 9819 | Number of tests: 6 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | [#0] dojo.html Cycles:165 Average:6379.06 Median:6672.60 stddev:760.28 (11.4%) stddev-sans-first:735.90 18:02:46 INFO - PID 9819 | Values: 3832.6 3881.8 3912.5 3920.7 3921.8 6358.3 6368.6 6380.2 6382.6 6444.5 6323.4 6351.7 6384.3 6390.0 6390.9 5707.7 5728.4 5777.1 5782.0 5794.9 5721.0 5781.2 5792.8 5802.0 5803.8 5524.3 5670.4 5748.5 5754.7 5768.6 5687.3 5700.6 5777.5 5783.9 5785.7 5671.3 5682.8 5685.7 5713.7 5759.1 6298.5 6340.8 6345.8 6366.8 6371.7 6888.4 6902.2 6952.7 6953.9 6960.6 6877.4 6905.7 6922.8 6925.2 6926.2 6438.0 6457.4 6472.4 6478.4 6478.8 7081.5 7082.3 7106.1 7191.3 7219.6 6793.8 6849.2 6899.1 6902.7 6910.9 6955.0 6985.6 7041.8 7050.3 7068.1 6824.6 6854.5 6883.7 6937.1 7000.3 6802.3 6814.8 6902.3 6902.4 6903.2 5043.7 5067.1 5123.3 5123.4 5132.6 4596.4 4596.9 4608.7 4623.5 4656.7 6323.7 6367.2 6400.5 6431.4 6472.6 6959.1 6972.9 6989.2 6991.6 6996.8 6412.8 6485.1 6496.9 6500.7 6503.5 5547.8 5552.9 5568.4 5628.1 5634.8 7014.7 7053.7 7080.9 7090.3 7171.1 6911.4 6955.2 6956.1 6960.7 6986.3 7099.5 7104.5 7112.4 7181.2 7200.7 6752.4 6872.6 6908.3 6976.8 6991.6 6724.6 6974.9 6999.1 7005.3 7007.3 6690.6 6711.4 6750.7 6758.7 6796.8 6678.9 6688.2 6693.2 6769.5 6781.3 6572.4 6654.6 6668.7 6762.5 6775.0 6728.2 6743.6 6787.0 6801.9 6814.3 6575.9 6578.4 6656.4 6659.2 6672.6 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | [#1] ext.html Cycles:180 Average:42632.37 Median:3743.99 stddev:66258.66 (1769.7%) stddev-sans-first:66370.31 18:02:46 INFO - PID 9819 | Values: 865.8 900.0 914.1 948.6 950.7 41017.4 41965.4 42006.0 42024.6 42072.8 39283.2 39611.0 39621.6 39624.6 39641.0 7180.6 7284.1 7292.2 7296.1 7297.7 7207.4 7298.1 7303.4 7311.4 7313.0 7281.7 7312.3 7914.9 8129.3 8129.8 8001.2 8052.8 8060.1 8061.2 8063.2 7665.3 7854.3 7895.1 7903.0 7907.4 39746.0 40103.8 40150.8 40163.0 40174.6 3690.3 3726.5 3743.1 3744.9 3745.7 32348.4 32545.3 32559.5 32563.5 32653.0 5436.3 5454.9 5483.7 5487.4 5500.9 200933.0 202737.0 203516.0 206033.0 216796.0 48334.5 48419.0 48507.3 48528.5 48720.1 50982.2 51002.7 51094.5 51402.7 51493.2 15470.1 15552.0 15703.5 15724.8 15960.7 12985.0 12991.7 13006.1 13014.2 13023.7 14132.4 14152.9 14153.2 14158.9 14168.8 5617.3 5670.5 5699.8 5707.3 5829.2 1085.2 1092.9 1104.6 1114.5 1123.2 23369.9 23939.5 23955.2 24259.6 32179.8 1201.3 1206.0 1210.3 1218.7 1219.4 13057.7 13063.1 13158.5 13220.6 13260.5 292639.0 292969.0 295155.0 295721.0 296511.0 52040.7 52409.2 52543.7 52569.7 52579.0 1487.5 1505.2 1506.5 1517.7 1543.8 23849.5 29918.4 30330.2 30920.7 31286.8 52972.7 52997.0 53032.7 53040.0 53319.2 251263.0 255310.0 255322.0 255656.0 255988.0 36162.1 37287.4 37389.6 37498.6 37560.0 43817.0 44784.8 45301.8 45633.3 45914.5 33637.7 34100.8 34448.3 34498.3 34625.0 33750.7 33772.7 33825.8 34459.1 34469.0 38606.4 38906.4 38919.0 41721.8 42451.8 33931.0 34114.1 34878.7 34980.7 35217.5 24749.9 25503.7 26853.9 27119.0 27284.3 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | [#2] jquery.html Cycles:180 Average:39176.97 Median:22871.89 stddev:97377.10 (425.8%) stddev-sans-first:97607.14 18:02:46 INFO - PID 9819 | Values: 578.9 585.8 588.9 591.9 606.5 14942.5 22043.4 22869.8 22874.0 22940.8 25122.4 25538.4 25565.9 25591.2 25747.4 6702.6 6836.1 6840.2 6846.2 6849.7 6052.4 6658.1 6664.5 6665.5 6759.8 6619.8 6621.8 6622.3 6629.9 6638.7 6584.5 6616.4 6618.3 6620.9 6621.8 6173.2 6182.5 6197.6 6198.7 6209.5 28856.6 28899.9 29354.9 30243.8 30495.4 2269.8 2319.8 2322.4 2325.4 2327.5 19780.7 20499.6 20517.6 20521.7 20573.9 2472.2 2518.8 2560.1 2611.0 2620.9 152623.0 155720.0 156082.0 156148.0 156249.2 14577.6 15561.2 15961.4 16018.7 16135.9 24374.3 24930.8 25033.7 25124.2 25275.9 10297.4 10367.0 10381.3 10547.8 10638.7 9350.2 9370.3 9401.9 9463.9 9492.8 9480.3 9712.5 9776.5 10258.3 10297.6 2759.4 2791.6 2876.5 2886.6 2910.8 1024.4 1049.7 1052.8 1054.5 1055.8 20762.5 20894.3 21011.2 21282.0 21748.2 1120.6 1120.7 1122.0 1126.2 1134.3 11112.3 11299.0 11357.9 11406.4 11467.1 550705.0 577436.0 581759.0 583752.0 596380.0 131700.0 137292.0 137658.0 138629.0 138638.0 1268.8 1280.8 1329.1 1332.8 1336.2 22436.1 22651.4 22698.9 22726.1 22861.7 61855.0 62690.0 63075.4 64522.0 65194.3 77658.6 77769.6 77815.2 78037.0 78460.0 15343.9 15610.3 15779.4 15823.8 15832.9 23866.4 24349.5 24450.6 24616.1 24624.8 19667.3 19670.1 19711.1 20094.7 20128.3 17092.7 17502.0 17627.5 17789.9 18248.5 19077.7 19770.0 19804.4 19810.9 20098.3 15269.2 15291.4 15348.6 15363.8 15406.9 19254.4 19331.0 19462.4 19695.3 19702.7 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | [#3] mootools.html Cycles:180 Average:10179.91 Median:13860.20 stddev:7737.16 (55.8%) stddev-sans-first:7730.49 18:02:46 INFO - PID 9819 | Values: 1359.9 1394.5 1412.1 1417.9 1437.4 16653.4 16655.1 17281.5 17281.7 17324.7 17442.7 17615.8 17799.7 17846.8 17856.6 2723.1 2747.5 2753.5 2760.6 2767.1 2676.7 2716.3 2744.3 2749.9 2755.8 2646.9 2657.4 2661.0 2679.6 2687.4 2647.8 2691.7 2709.2 2712.3 2714.5 2639.0 2644.8 2658.4 2660.9 2671.1 16643.5 16743.1 16775.3 16786.2 16789.5 7478.0 7793.1 7805.6 7819.5 7830.3 4941.8 5056.4 5067.9 5178.5 5192.1 2108.7 2115.3 2122.6 2129.1 2165.8 29894.9 30174.5 30294.8 30303.8 30327.5 6309.2 6456.8 6457.4 6469.9 6605.3 19454.5 19464.5 19478.0 19478.5 19489.3 7552.7 7555.2 7558.4 7560.5 7561.9 5202.6 5943.7 5997.9 6009.9 6873.7 5098.6 5285.1 5287.2 5326.2 5353.1 1438.4 1440.7 1446.0 1471.0 1474.4 905.9 913.6 923.7 928.5 933.6 7838.6 7851.7 7897.8 7951.5 9555.2 1019.6 1040.2 1045.3 1048.0 1070.2 5315.0 5315.9 5358.2 5375.4 5461.1 23676.5 23979.5 25025.4 25038.4 25081.4 23740.4 23842.9 24240.3 24580.9 24706.3 12117.3 12180.9 12364.8 12516.2 12539.7 9258.4 9688.1 9718.3 9773.5 10063.8 20802.6 21123.3 21163.4 21194.9 21522.2 21667.2 22033.6 22117.0 22183.8 22407.2 13060.3 13269.0 13420.9 13432.9 13445.8 15095.1 15128.5 15186.2 15191.1 15202.8 11846.8 11847.4 12077.6 12183.1 12403.5 11173.7 11211.0 11266.0 11500.3 11569.2 10704.8 10838.6 10844.7 10849.1 10852.5 7973.6 8131.6 8190.5 8214.2 8243.0 8110.4 8193.1 8231.1 8234.8 8268.9 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | [#4] prototype.html Cycles:180 Average:5657.25 Median:6290.06 stddev:1590.70 (25.3%) stddev-sans-first:1547.83 18:02:46 INFO - PID 9819 | Values: 525.9 531.4 544.1 546.4 549.0 6198.5 6264.2 6283.7 6305.7 6386.0 6214.5 6230.0 6254.4 6291.4 6302.2 5121.1 5139.3 5150.6 5164.1 5166.3 4845.0 5089.4 5133.3 5148.4 5167.6 4871.0 4917.4 4954.3 4958.7 4965.2 4911.8 4932.0 4935.2 4937.8 4980.1 4476.8 4479.5 4495.7 4508.6 4554.9 6176.2 6184.4 6246.8 6257.8 6276.9 5710.8 5802.4 5850.0 5900.7 5918.4 6547.8 6558.8 6638.9 6645.7 6683.5 5040.9 5052.2 5070.3 5107.2 5117.8 6766.7 6769.7 6934.4 7035.0 7103.1 5017.3 5056.5 5091.9 5116.3 5174.2 5230.8 5238.0 5254.6 5261.9 5267.5 5777.5 5811.7 5817.0 5819.7 5826.9 6658.7 6677.1 6759.6 6763.9 6774.7 1796.2 1803.6 1816.2 1821.3 1823.7 1259.7 1268.8 1277.7 1280.8 1297.9 6205.4 6288.7 6293.1 6295.3 6417.6 6643.4 6647.7 6669.0 6764.5 6791.5 6086.6 6261.1 6263.7 6322.7 6344.5 3566.3 3600.1 3603.8 3615.2 3627.7 7038.9 7055.8 7062.9 7073.8 7078.4 6938.7 6972.8 7002.2 7105.0 7109.1 6923.5 7038.8 7057.2 7078.4 7132.3 6683.5 6690.3 6740.2 6763.9 6828.1 6658.4 6713.9 6717.6 6783.4 6814.8 6948.5 6977.2 7007.2 7036.7 7145.2 5161.7 5198.0 5205.6 5209.7 5221.1 6608.8 6726.9 6736.0 6828.8 6845.2 6405.3 6466.6 6504.4 6601.8 6602.7 6562.9 6589.3 6600.7 6611.9 6643.8 6551.7 6557.0 6573.7 6596.3 6652.3 6621.8 6647.0 6672.8 6721.6 6745.5 6416.8 6459.5 6519.2 6533.2 6551.8 18:02:46 INFO - PID 9819 | 18:02:46 INFO - PID 9819 | [#5] yui.html Cycles:180 Average:26706.96 Median:18075.68 stddev:38665.68 (213.9%) stddev-sans-first:38725.90 18:02:46 INFO - PID 9819 | Values: 984.0 984.7 1004.6 1008.7 1020.1 17003.1 20022.3 20655.5 20666.9 20704.2 18686.5 18756.7 18868.8 19457.8 21328.6 1049.6 1060.7 1063.0 1063.9 1064.0 1040.2 1078.4 1089.1 1089.2 1089.3 1146.9 1151.5 1151.7 1152.1 1152.6 1134.6 1143.6 1151.2 1152.8 1154.3 840.6 841.0 841.4 841.8 843.7 19410.6 19694.3 19869.8 19898.2 20032.4 23263.2 23280.7 23545.2 23652.9 23837.6 18777.3 19204.1 19365.9 19528.3 19715.0 4198.2 4222.8 4224.2 4224.6 4224.9 146709.3 146877.3 147490.0 149179.3 149606.0 17447.2 17996.6 18154.8 18234.2 18278.8 33586.5 33587.2 33649.0 33844.7 34590.7 9144.4 9261.6 9269.0 9278.3 9280.1 4654.6 4846.5 4874.0 4881.3 4882.1 6036.6 6138.5 6146.7 6171.8 6288.2 1165.9 1186.5 1197.2 1198.9 1204.8 717.2 745.0 757.8 762.5 771.8 12895.4 13297.0 14230.9 14412.3 14519.6 749.8 757.2 757.7 764.4 766.9 6473.3 6485.6 6495.5 6547.5 6565.1 130998.0 131470.0 133065.3 133211.0 136021.3 120298.0 120966.0 120966.4 121022.0 126491.0 103773.5 104642.0 106777.5 107219.0 112099.4 11653.8 11703.4 11859.9 11866.7 12053.2 51676.7 51813.7 52110.7 52806.2 53731.5 65865.0 67793.0 67894.0 69030.0 69750.3 14552.8 14731.9 14751.0 14758.6 14858.3 19463.3 19688.5 19740.7 19758.0 19889.1 16125.8 16305.2 16389.7 16502.5 16531.8 17460.0 17487.8 17532.6 17553.1 17663.2 15701.7 15885.8 15934.8 16095.1 16099.7 14269.4 14430.0 14521.3 14646.1 14747.6 12876.0 12929.5 12963.4 13072.5 13185.9 18:02:46 INFO - PID 9819 | -------- Summary: end -------- 18:02:46 INFO - PID 9819 | 18:02:47 INFO - TEST-INFO | 9819: exit 0 18:02:47 INFO - TEST-OK | dromaeo_css | took 1107860ms 18:02:47 INFO - TEST-START | kraken 18:02:47 INFO - Initialising browser for kraken test... 18:02:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42409/getInfo.html -profile /tmp/tmpu5fM9x/profile 18:02:47 INFO - TEST-INFO | started process 10202 (/builds/slave/test/build/application/firefox/firefox http://localhost:42409/getInfo.html) 18:02:52 INFO - TEST-INFO | 10202: exit 0 18:02:52 INFO - Browser initialized. 18:02:52 INFO - Running cycle 1/1 for kraken test... 18:02:52 INFO - Using env: {'DISPLAY': ':0', 18:02:52 INFO - 'HOME': '/home/cltbld', 18:02:52 INFO - 'JSGC_DISABLE_POISONING': '1', 18:02:52 INFO - 'LANG': 'en_US.UTF-8', 18:02:52 INFO - 'LANGUAGE': 'en_US:en', 18:02:52 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:02:52 INFO - 'LOGNAME': 'cltbld', 18:02:52 INFO - 'MAIL': '/var/mail/cltbld', 18:02:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:02:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:02:52 INFO - 'MOZ_CRASHREPORTER': '1', 18:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:52 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:02:52 INFO - 'MOZ_NO_REMOTE': '1', 18:02:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:02:52 INFO - 'NO_EM_RESTART': '1', 18:02:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:52 INFO - 'PWD': '/builds/slave/test', 18:02:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:02:52 INFO - 'RUST_BACKTRACE': 'full', 18:02:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:02:52 INFO - 'SHELL': '/bin/bash', 18:02:52 INFO - 'SHLVL': '1', 18:02:52 INFO - 'TERM': 'linux', 18:02:52 INFO - 'TMOUT': '86400', 18:02:52 INFO - 'USER': 'cltbld', 18:02:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408', 18:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:52 INFO - '_': '/tools/buildbot/bin/python'} 18:02:52 INFO - TEST-INFO | started process 10404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu5fM9x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:53 INFO - PID 10404 | 18:02:53 INFO - PID 10404 | (/builds/slave/test/build/application/firefox/firefox:10456): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:02:53 INFO - PID 10404 | 18:03:04 INFO - PID 10404 | RSS: Main: 163844096 18:03:04 INFO - PID 10404 | 18:03:06 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:07 INFO - PID 10404 | RSS: Main: 169771008 18:03:07 INFO - PID 10404 | 18:03:10 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-dft) 18:03:10 INFO - PID 10404 | RSS: Main: 174350336 18:03:10 INFO - PID 10404 | 18:03:13 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-fft) 18:03:14 INFO - PID 10404 | RSS: Main: 167182336 18:03:14 INFO - PID 10404 | 18:03:16 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42409/tests/kraken/driver.html?testName=audio-oscillator) 18:03:17 INFO - PID 10404 | RSS: Main: 168472576 18:03:17 INFO - PID 10404 | 18:03:19 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:19 INFO - PID 10404 | RSS: Main: 168751104 18:03:19 INFO - PID 10404 | 18:03:22 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42409/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:23 INFO - PID 10404 | RSS: Main: 170135552 18:03:23 INFO - PID 10404 | 18:03:26 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42409/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:27 INFO - PID 10404 | RSS: Main: 171892736 18:03:27 INFO - PID 10404 | 18:03:30 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42409/tests/kraken/driver.html?testName=json-parse-financial) 18:03:30 INFO - PID 10404 | RSS: Main: 170364928 18:03:30 INFO - PID 10404 | 18:03:32 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:32 INFO - PID 10404 | RSS: Main: 169725952 18:03:32 INFO - PID 10404 | 18:03:34 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:35 INFO - PID 10404 | RSS: Main: 169893888 18:03:35 INFO - PID 10404 | 18:03:37 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:37 INFO - PID 10404 | RSS: Main: 166965248 18:03:37 INFO - PID 10404 | 18:03:40 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:41 INFO - PID 10404 | RSS: Main: 166596608 18:03:41 INFO - PID 10404 | 18:03:43 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:03:44 INFO - PID 10404 | RSS: Main: 167145472 18:03:44 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | Cycle 1(1): loaded http://localhost:42409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42409/tests/kraken/driver.html?testName=ai-astar) 18:03:46 INFO - PID 10404 | RSS: Main: 169095168 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | __start_tp_report 18:03:46 INFO - PID 10404 | _x_x_mozilla_page_load 18:03:46 INFO - PID 10404 | _x_x_mozilla_page_load_details 18:03:46 INFO - PID 10404 | |i|pagename|runs| 18:03:46 INFO - PID 10404 | |0;ai-astar;97;112;98;105;104;106;106;103;105;108 18:03:46 INFO - PID 10404 | |1;audio-beat-detection;138;113;143;180;121;142;142;126;172;116 18:03:46 INFO - PID 10404 | |2;audio-dft;163;166;163;160;161;164;169;161;162;163 18:03:46 INFO - PID 10404 | |3;audio-fft;74;73;75;174;75;74;73;74;160;73 18:03:46 INFO - PID 10404 | |4;audio-oscillator;77;78;140;78;78;78;125;78;78;125 18:03:46 INFO - PID 10404 | |5;imaging-gaussian-blur;114;114;115;114;113;114;114;114;113;114 18:03:46 INFO - PID 10404 | |6;imaging-darkroom;151;150;152;149;148;150;149;151;149;151 18:03:46 INFO - PID 10404 | |7;imaging-desaturate;93;94;94;94;95;95;94;93;94;94 18:03:46 INFO - PID 10404 | |8;json-parse-financial;48;49;51;46;44;46;44;44;45;46 18:03:46 INFO - PID 10404 | |9;json-stringify-tinderbox;37;37;37;37;36;36;37;37;37;37 18:03:46 INFO - PID 10404 | |10;stanford-crypto-aes;73;78;72;73;73;72;71;73;71;73 18:03:46 INFO - PID 10404 | |11;stanford-crypto-ccm;114;114;113;113;117;123;108;112;111;154 18:03:46 INFO - PID 10404 | |12;stanford-crypto-pbkdf2;158;156;157;151;158;154;159;153;153;155 18:03:46 INFO - PID 10404 | |13;stanford-crypto-sha256-iterative;60;62;59;59;59;59;64;62;58;58 18:03:46 INFO - PID 10404 | __end_tp_report 18:03:46 INFO - PID 10404 | __start_cc_report 18:03:46 INFO - PID 10404 | _x_x_mozilla_cycle_collect,891 18:03:46 INFO - PID 10404 | __end_cc_report 18:03:46 INFO - PID 10404 | __startTimestamp1504746226308__endTimestamp 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | ------- Summary: start ------- 18:03:46 INFO - PID 10404 | Number of tests: 14 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#0] ai-astar Cycles:10 Average:104.40 Median:107.00 stddev:4.40 (4.1%) stddev-sans-first:3.77 18:03:46 INFO - PID 10404 | Values: 97.0 112.0 98.0 105.0 104.0 106.0 106.0 103.0 105.0 108.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:142.00 stddev:22.37 (15.8%) stddev-sans-first:23.72 18:03:46 INFO - PID 10404 | Values: 138.0 113.0 143.0 180.0 121.0 142.0 142.0 126.0 172.0 116.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.66 (1.6%) stddev-sans-first:2.82 18:03:46 INFO - PID 10404 | Values: 163.0 166.0 163.0 160.0 161.0 164.0 169.0 161.0 162.0 163.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.00 stddev:39.41 (53.3%) stddev-sans-first:41.23 18:03:46 INFO - PID 10404 | Values: 74.0 73.0 75.0 174.0 75.0 74.0 73.0 74.0 160.0 73.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:78.00 stddev:25.52 (32.7%) stddev-sans-first:26.36 18:03:46 INFO - PID 10404 | Values: 77.0 78.0 140.0 78.0 78.0 78.0 125.0 78.0 78.0 125.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:03:46 INFO - PID 10404 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 113.0 114.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 18:03:46 INFO - PID 10404 | Values: 151.0 150.0 152.0 149.0 148.0 150.0 149.0 151.0 149.0 151.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 18:03:46 INFO - PID 10404 | Values: 93.0 94.0 94.0 94.0 95.0 95.0 94.0 93.0 94.0 94.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#8] json-parse-financial Cycles:10 Average:46.30 Median:46.00 stddev:2.36 (5.1%) stddev-sans-first:2.42 18:03:46 INFO - PID 10404 | Values: 48.0 49.0 51.0 46.0 44.0 46.0 44.0 44.0 45.0 46.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 18:03:46 INFO - PID 10404 | Values: 37.0 37.0 37.0 37.0 36.0 36.0 37.0 37.0 37.0 37.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:1.97 (2.7%) stddev-sans-first:2.09 18:03:46 INFO - PID 10404 | Values: 73.0 78.0 72.0 73.0 73.0 72.0 71.0 73.0 71.0 73.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:114.00 stddev:13.29 (11.7%) stddev-sans-first:14.02 18:03:46 INFO - PID 10404 | Values: 114.0 114.0 113.0 113.0 117.0 123.0 108.0 112.0 111.0 154.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.50 stddev:2.63 (1.7%) stddev-sans-first:2.62 18:03:46 INFO - PID 10404 | Values: 158.0 156.0 157.0 151.0 158.0 154.0 159.0 153.0 153.0 155.0 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:59.50 stddev:2.00 (3.4%) stddev-sans-first:2.12 18:03:46 INFO - PID 10404 | Values: 60.0 62.0 59.0 59.0 59.0 59.0 64.0 62.0 58.0 58.0 18:03:46 INFO - PID 10404 | -------- Summary: end -------- 18:03:46 INFO - PID 10404 | 18:03:46 INFO - PID 10404 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:03:47 INFO - TEST-INFO | 10404: exit 0 18:03:47 INFO - TEST-OK | kraken | took 60262ms 18:03:47 INFO - SUITE-END | took 1168s 18:03:47 INFO - Completed test suite (00:19:28) 18:03:47 INFO - javascript benchmark 18:03:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8990.679365915777, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3832.635899589538, 3881.8447262109516, 3912.5109361329824, 3920.6863450923893, 3921.843126274949, 6358.300586935434, 6368.6178829270275, 6380.202474690664, 6382.5532212745065, 6444.452221561167, 6323.430891219789, 6351.650659213741, 6384.329645387237, 6390.0, 6390.872182556346, 5707.686077265748, 5728.398518155596, 5777.0756678931375, 5782.045962416196, 5794.942050579503, 5720.971395143039, 5781.161731548944, 5792.768289268445, 5802.0, 5803.767849286023, 5524.254225679522, 5670.432956704338, 5748.511376533, 5754.712264386764, 5768.625039372428, 5687.345955215162, 5700.629459085146, 5777.480026797609, 5783.88432231353, 5785.710714464302, 5671.291088613923, 5682.772689092431, 5685.687287199203, 5713.657180569179, 5759.078547432433, 6298.4646305064125, 6340.809775706736, 6345.809625711236, 6366.808995730135, 6371.713272902684, 6888.448924086111, 6902.171739391255, 6952.721891124349, 6953.860922781567, 6960.617166055865, 6877.3810357068105, 6905.654717264167, 6922.7923162305215, 6925.203601585832, 6926.168859736814, 6438.034294855809, 6457.4188323050685, 6472.385123413268, 6478.384553467413, 6478.838029049264, 7081.468889833283, 7082.256363081905, 7106.147262328554, 7191.280871912767, 7219.566825990458, 6793.830154246183, 6849.2465828758795, 6899.103116594811, 6902.723891044302, 6910.896336554955, 6954.965225173943, 6985.615791131435, 7041.823954401181, 7050.330218629222, 7068.081149450539, 6824.590524568542, 6854.485913556503, 6883.690233939485, 6937.132858392701, 7000.2999700030605, 6802.285759995129, 6814.795556133324, 6902.275261097613, 6902.378785909293, 6903.240643529208, 5043.722595257223, 5067.087924173684, 5123.333966584395, 5123.410807757155, 5132.6150538709, 4596.379488768974, 4596.908061838744, 4608.700434471749, 4623.491415944243, 4656.720596764205, 6323.715432805443, 6367.235931688227, 6400.455961243347, 6431.356864313625, 6472.611643301417, 6959.130108736408, 6972.860542789116, 6989.161300643956, 6991.615461149584, 6996.755113571001, 6412.775552855627, 6485.092087107809, 6496.902546461807, 6500.739970401226, 6503.544751867324, 5547.833564993057, 5552.91670624941, 5568.387477377485, 5628.127640215773, 5634.802781902614, 7014.719411223596, 7053.68258428372, 7080.92919070813, 7090.290970902868, 7171.103612048494, 6911.447084233249, 6955.234924158237, 6956.095707557985, 6960.686769095403, 6986.336298051677, 7099.538529995534, 7104.467164962752, 7112.395446387115, 7181.174164971095, 7200.675969581277, 6752.426043786333, 6872.587644741132, 6908.3437073477935, 6976.790696279119, 6991.580505169706, 6724.562903411263, 6974.860502790018, 6999.090118284794, 7005.334493223136, 7007.334303241184, 6690.565113267622, 6711.362420570038, 6750.729970801113, 6758.662066896537, 6796.830079248059, 6678.933210668026, 6688.197416310074, 6693.196816382066, 6769.492288078315, 6781.2879647638265, 6572.4084832365315, 6654.567453115532, 6668.733250670113, 6762.49281303914, 6775.0, 6728.226253980855, 6743.5953842769595, 6786.981952707133, 6801.8639627206185, 6814.318568143146, 6575.901361479486, 6578.407943285128, 6656.434203092597, 6659.234188068241, 6672.599644021374], "value": 6326.876590736382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.845976042402, 899.9595018224179, 914.1315750037464, 948.6442584030989, 950.7195377363677, 41017.38473922894, 41965.37051944219, 42006.0, 42024.57975420245, 42072.78963605185, 39283.21433571334, 39611.0, 39621.60378396215, 39624.603753962525, 39641.0, 7180.640967951607, 7284.089488813898, 7292.16140143885, 7296.087989001375, 7297.708091676353, 7207.38737207338, 7298.087739032621, 7303.415726741874, 7311.41508679307, 7312.963435182816, 7281.708731650728, 7312.2687731226715, 7914.881276780853, 8129.309008734235, 8129.796755081111, 8001.23988221121, 8052.798680032987, 8060.073091594483, 8061.234182752659, 8063.153368896269, 7665.271799179069, 7854.293113619745, 7895.052593688737, 7903.0, 7907.406944479187, 39746.0, 40103.7994810027, 40150.79924600358, 40163.0, 40174.59825401738, 3690.335739566877, 3726.5341832270965, 3743.1390780120723, 3744.850205991757, 3745.662890339855, 32348.353032939445, 32545.349093018245, 32559.511607325672, 32563.51154732681, 32653.0, 5436.320459942507, 5454.863628409282, 5483.725813709339, 5487.368952570426, 5500.944990550083, 200933.0, 202737.0, 203516.0, 206033.0, 216796.0, 48334.516654833, 48419.0, 48507.272390914164, 48528.5147148524, 48720.051197952394, 50982.235266471034, 51002.74498627483, 51094.48905510972, 51402.74298628483, 51493.227601586004, 15470.149141797308, 15552.0, 15703.450379236672, 15724.842751572567, 15960.680786384208, 12985.0, 12991.675208119872, 13006.089573729938, 13014.21914685122, 13023.674408139872, 14132.364043618061, 14152.929235353757, 14153.150810951376, 14158.929205353907, 14168.787468187986, 5617.297837770278, 5670.461306175906, 5699.800506982236, 5707.34365547959, 5829.242198514166, 1085.2023762534532, 1092.8688557373166, 1104.640991677708, 1114.5486078138367, 1123.1913022623698, 23369.883150584137, 23939.521209575712, 23955.198179177445, 24259.636105458434, 32179.839100804813, 1201.2792324605166, 1205.951761929513, 1210.3282678113555, 1218.707510197564, 1219.4207751318054, 13057.738845223043, 13063.085584009028, 13158.539451119164, 13220.579562379378, 13260.53588124411, 292639.0, 292969.0, 295155.0, 295721.0, 296511.0, 52040.739796300775, 52409.2138617921, 52543.73728131411, 52569.737151313995, 52579.0, 1487.4570781664615, 1505.1947208243537, 1506.5179142674458, 1517.7495713207197, 1543.8456154384696, 23849.52300954006, 29918.401631967674, 30330.241743956576, 30920.69079309178, 31286.843565782026, 52972.735136324074, 52997.0, 53032.73483632557, 53040.0, 53319.200211997624, 251263.0, 255310.0, 255322.0, 255656.0, 255988.0, 36162.095947600465, 37287.44068839024, 37389.626103738614, 37498.62501375061, 37560.0, 43817.0, 44784.77607611941, 45301.77349113365, 45633.31550026686, 45914.540854591025, 33637.663623363456, 34100.82949585236, 34448.311033778686, 34498.31003379868, 34625.0, 33750.66249337475, 33772.662273376955, 33825.830870845486, 34459.13852153616, 34469.0, 38606.42090368703, 38906.416403754534, 38919.0, 41721.79139104285, 42451.787741061096, 33931.0, 34114.14714632154, 34878.65121348754, 34980.65019349876, 35217.47173792446, 24749.876250618632, 25503.744962550878, 26853.865730671223, 27119.0, 27284.317892052062], "value": 18265.145696851832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9478946894778, 585.7949717598839, 588.8763359694462, 591.9496842768365, 606.4572207873953, 14942.477013304537, 22043.448913777145, 22869.771302286972, 22874.0, 22940.770592294073, 25122.37194070149, 25538.361540961487, 25565.872170639122, 25591.232263032092, 25747.356316092108, 6702.631355275458, 6836.145481814773, 6840.247572766992, 6846.212685541152, 6849.691763870638, 6052.394760523956, 6658.13444252249, 6664.500162487809, 6665.466762659, 6759.797206083801, 6619.834504137411, 6621.768238111667, 6622.337766223387, 6629.867402651944, 6638.668066596675, 6584.473242140617, 6616.437602803743, 6618.271990081087, 6620.867582648344, 6621.801345959629, 6173.228346456693, 6182.536309776785, 6197.628142311431, 6198.659073750942, 6209.534284928648, 28856.567151492534, 28899.855500722362, 29354.853225733947, 30243.848780755954, 30495.390092198253, 2269.795718385337, 2319.8376113672048, 2322.419395151195, 2325.383773300077, 2327.5461285049423, 19780.70328945067, 20499.590008199903, 20517.58964820695, 20521.692174617394, 20573.8971305144, 2472.208893154191, 2518.798496120324, 2560.129555950967, 2610.973890261111, 2620.868956552184, 152623.0, 155720.0, 156082.0, 156148.0, 156249.21875390664, 14577.635559110895, 15561.221938903009, 15961.44134955271, 16018.679626407407, 16135.919320403558, 24374.26877193687, 24930.750692493206, 25033.749662503506, 25124.24627261185, 25275.87362063178, 10297.433641149659, 10367.0, 10381.325213861075, 10547.84178237327, 10638.734031649115, 9350.205232555172, 9370.29722770795, 9401.90598094024, 9463.90536094644, 9492.810143797085, 9480.288978326653, 9712.465814380277, 9776.480467031863, 10258.307379282334, 10297.639582614573, 2759.379139693593, 2791.595218693278, 2876.5397536394494, 2886.639170103737, 2910.7962442629237, 1024.446798728693, 1049.7323182588543, 1052.7947050325267, 1054.5360041581832, 1055.7888422315568, 20762.48093797667, 20894.268700595407, 21011.159553617683, 21282.0, 21748.238811641833, 1120.6021862238788, 1120.7254222715324, 1121.971950701239, 1126.1947707389093, 1134.3307448605362, 11112.333260004425, 11299.0, 11357.943210283896, 11406.37264950419, 11467.08263338931, 550705.0, 577436.0, 581759.0, 583752.0, 596380.0, 131700.0, 137292.0, 137658.0, 138629.0, 138638.0, 1268.7652784234947, 1280.8270883430619, 1329.0630105775406, 1332.8333958255218, 1336.171573624359, 22436.102555898233, 22651.43371415728, 22698.886505568025, 22726.09095636156, 22861.65707514422, 61855.0, 62690.0, 63075.36924630695, 64522.03216951843, 65194.34805651883, 77658.6117069411, 77769.61115194387, 77815.22184778079, 78037.0, 78460.0, 15343.923280383528, 15610.297536610653, 15779.447719329768, 15823.762643560585, 15832.92083539621, 23866.40333991664, 24349.513009739352, 24450.63324050105, 24616.138435154684, 24624.753752462246, 19667.311644092388, 19670.11484483173, 19711.112999914752, 20094.69857952161, 20128.29550965709, 17092.658146837242, 17502.0, 17627.471175864746, 17789.911050444665, 18248.543786405447, 19077.71383429222, 19770.0, 19804.40586782399, 19810.900945495756, 20098.296559620343, 15269.236538172825, 15291.388344466097, 15348.616284592528, 15363.769543457081, 15406.922965385102, 19254.363379112932, 19331.0, 19462.416127516197, 19695.310664126686, 19702.704459433407], "value": 12734.224407791231, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.870812272834, 1394.4770710983382, 1412.1315391034511, 1417.9078359906612, 1437.381925771918, 16653.417130400423, 16655.083970381624, 17281.48155555332, 17281.654366912684, 17324.740128898076, 17442.651146977052, 17615.82384176158, 17799.73300400495, 17846.82153178471, 17856.64286714268, 2723.128598848369, 2747.5466548019654, 2753.4630747004344, 2760.627315312427, 2767.059199872043, 2676.745709157627, 2716.3209197700576, 2744.341358074058, 2749.917502474929, 2755.8070935034557, 2646.907358242462, 2657.428652839639, 2661.0, 2679.571268597015, 2687.3819021625036, 2647.7749391301763, 2691.6769987601515, 2709.2143278449225, 2712.2676877243034, 2714.5249581323287, 2639.0367515856574, 2644.775194108503, 2658.401859581598, 2660.906868259621, 2671.0784779251126, 16643.50069497917, 16743.07913064781, 16775.32898684051, 16786.244618992176, 16789.496315110566, 7477.962610186914, 7793.142754297023, 7805.5706936118495, 7819.530828150329, 7830.2952734254195, 4941.802327906879, 5056.393232812049, 5067.949320506785, 5178.4562620924635, 5192.065428222918, 2108.694239335288, 2115.2808045264683, 2122.61792877282, 2129.1483406637467, 2165.783421657837, 29894.85052574723, 30174.54738178929, 30294.84852575723, 30303.848480757457, 30327.512336081192, 6309.211348581427, 6456.806295811133, 6457.352485481024, 6469.902951455732, 6605.339466053356, 19454.5136371589, 19464.513387165433, 19478.02609869501, 19478.513037174183, 19489.317873874345, 7552.697892084255, 7555.16893141754, 7558.433117516099, 7560.546367217985, 7561.886571701429, 5202.633039892135, 5943.732532036069, 5997.850053748692, 6009.939900600938, 6873.725050998004, 5098.59211263098, 5285.07511185541, 5287.23335116406, 5326.174442961347, 5353.0899747043095, 1438.4030627289558, 1440.7262620102147, 1445.9878085340304, 1471.0438215160018, 1474.366022610288, 905.8595917632778, 913.6071489259682, 923.7182659288846, 928.4800511713327, 933.6125507914139, 7838.608069596611, 7851.72518961845, 7897.842043159219, 7951.483153594998, 9555.23558115349, 1019.5564929255797, 1040.2250323509033, 1045.289203341735, 1047.9826334306429, 1070.218740319571, 5314.97342513285, 5315.867103322448, 5358.196270559447, 5375.408705042442, 5461.0716178248995, 23676.52646947086, 23979.52040959206, 25025.37436564064, 25038.37404064913, 25081.372965676004, 23740.406489837547, 23842.854143127202, 24240.272791816275, 24580.877095614407, 24706.25881223566, 12117.27296362221, 12180.939095304644, 12364.752704945851, 12516.249025058343, 12539.74920501603, 9258.35191536613, 9688.12806847387, 9718.271129665161, 9773.462459564793, 10063.798724025624, 20802.58394832125, 21123.26068587592, 21163.365099047052, 21194.894025529775, 21522.246721364678, 21667.241646542294, 22033.559328813655, 22117.0, 22183.778162218816, 22407.21574744876, 13060.346982651019, 13269.004824637997, 13420.932895335462, 13432.932835335761, 13445.798313025116, 15095.094294342374, 15128.470503532324, 15186.164760938254, 15191.088534687955, 15202.847971520143, 11846.763064738485, 11847.407629618658, 12077.637670869888, 12183.147179697336, 12403.503859845505, 11173.72065698364, 11210.991010809066, 11266.0, 11500.25248358854, 11569.19015668895, 10704.785904281714, 10838.620648277272, 10844.728881778019, 10849.132069434585, 10852.45737713127, 7973.601319934096, 8131.634076466691, 8190.467619604707, 8214.219649133323, 8242.958785206036, 8110.351171906352, 8193.139720329518, 8231.09457959612, 8234.835303293781, 8268.917310826815], "value": 7036.299482284984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.8948210357927, 531.3703261634965, 544.0560627311617, 546.363486538183, 548.9643173193742, 6198.504119670427, 6264.21697287839, 6283.685815709219, 6305.716242769075, 6386.0, 6214.502839772818, 6229.968850155743, 6254.405831446005, 6291.40231677991, 6302.243730752316, 5121.12940800063, 5139.280500729891, 5150.562202212816, 5164.122099243138, 5166.302549155872, 4844.975775121137, 5089.422279093475, 5133.307003554528, 5148.382194136709, 5167.638265321429, 4870.975645121769, 4917.385326834145, 4954.2568614707725, 4958.727270000149, 4965.205567109263, 4911.7544122793715, 4932.038252540756, 4935.19865249185, 4937.8271760488215, 4980.12847751642, 4476.776161191928, 4479.507254202035, 4495.707778994355, 4508.571685689854, 4554.929591545984, 6176.227971503562, 6184.443400093968, 6246.782392250731, 6257.843553911143, 6276.937230627726, 5710.828675139753, 5802.448767367136, 5850.0, 5900.675462849542, 5918.3785702501045, 6547.836304092388, 6558.803235902883, 6638.900416493757, 6645.734170633169, 6683.465322774166, 5040.924386134211, 5052.191649336125, 5070.29015937769, 5107.20838270065, 5117.795288188468, 6766.69549870257, 6769.72921083161, 6934.410575101122, 7035.0, 7103.0578029193775, 5017.272495488207, 5056.519630635084, 5091.898162036812, 5116.283720279164, 5174.24973378858, 5230.790768369298, 5237.973810131001, 5254.632175747661, 5261.921071183935, 5267.525922666979, 5777.508911742549, 5811.680357580373, 5817.0, 5819.6508209507565, 5826.854328641818, 6658.667066646648, 6677.1319728435965, 6759.628220447824, 6763.898541521881, 6774.72901083961, 1796.2096677461875, 1803.6392721455761, 1816.1917946513674, 1821.3443160462223, 1823.6899727046434, 1259.7165637731437, 1268.8413948256468, 1277.6997405609675, 1280.8206851040861, 1297.8961683065331, 6205.379462053758, 6288.717007734663, 6293.056041593706, 6295.307516173218, 6417.550771446047, 6643.368879956396, 6647.700853461606, 6669.0, 6764.526483146231, 6791.4906382021545, 6086.573939824169, 6261.123442718023, 6263.713744483231, 6322.683865806691, 6344.49244060474, 3566.286742651428, 3600.063983364344, 3603.819809009539, 3615.168511242429, 3627.6735093841153, 7038.894416583756, 7055.753048643272, 7062.894056589155, 7073.82315442118, 7078.433725301964, 6938.653067346713, 6972.79081627552, 7002.179433347366, 7104.964475177694, 7109.075820143348, 6923.480738944499, 7038.788836334918, 7057.18842333128, 7078.362947334662, 7132.251113633098, 6683.498737594603, 6690.29751876046, 6740.224874139537, 6763.883959146686, 6828.146481689789, 6658.368699668612, 6713.885126185236, 6717.596944183365, 6783.423409010092, 6814.829629259109, 6948.51360404787, 6977.162740471176, 7007.248187953011, 7036.718531258693, 7145.249748776304, 5161.664491808171, 5198.0, 5205.557527610195, 5209.6874187548865, 5221.138512145453, 6608.768693095719, 6726.865462690621, 6736.0, 6828.760993365208, 6845.178578570603, 6405.327440618855, 6466.612003279818, 6504.38208370204, 6601.768938087144, 6602.702878370389, 6562.934370656232, 6589.27517973013, 6600.669966501559, 6611.933880661132, 6643.7674681385915, 6551.70517326731, 6557.0, 6573.671316434064, 6596.340365963365, 6652.301508341748, 6621.801345959629, 6646.966765166143, 6672.766453174116, 6721.630310332978, 6745.494087943522, 6416.775412860714, 6459.5478316519275, 6519.152510173647, 6533.150690410216, 6551.836204094936], "value": 5193.449891585416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [983.9950800245994, 984.694744629165, 1004.5579944824282, 1008.7226012846471, 1020.1023099672287, 17003.14984250787, 20022.29921952732, 20655.483612909647, 20666.89666551667, 20704.171833126693, 18686.53283667909, 18756.718649220238, 18868.81131188688, 19457.805421945777, 21328.57342853142, 1049.574922156524, 1060.7295139739356, 1063.0220197418355, 1063.8989296016866, 1063.952122154501, 1040.1990467340142, 1078.423043671636, 1089.0525243038567, 1089.2429761315889, 1089.3028461784425, 1146.9369184694838, 1151.5393842462997, 1151.6545036489063, 1152.0610702277618, 1152.5793085523765, 1134.5915470430639, 1143.616888342398, 1151.2459339132881, 1152.804023316034, 1154.261272785418, 840.5671079394117, 840.9663613455455, 841.4068082002174, 841.8442588121156, 843.7047033538274, 19410.611787764166, 19694.31069912546, 19869.80130198694, 19898.20407183711, 20032.399028029184, 23263.18578849749, 23280.65079023816, 23545.175918842757, 23652.881735591385, 23837.642435363483, 18777.342793002317, 19204.13581388841, 19365.903170484056, 19528.31650892212, 19715.014249287622, 4198.244316023115, 4222.831086756526, 4224.176285624305, 4224.598663126998, 4224.9155016899485, 146709.26645366813, 146877.26561367232, 147490.0, 149179.25410372988, 149606.0, 17447.21487533064, 17996.55008624795, 18154.818451815314, 18234.179461924246, 18278.817211827976, 33586.48860801221, 33587.16032099168, 33648.99053028413, 33844.66155338464, 34590.65409345875, 9144.3598948073, 9261.583228754587, 9268.95365523168, 9278.257739380833, 9280.071992800666, 4654.557817007379, 4846.491118432585, 4874.025194960951, 4881.267809828483, 4882.145624515695, 6036.63780173191, 6138.478229350555, 6146.7233974471255, 6171.753129874754, 6288.213973253343, 1165.8834116588444, 1186.4779497021284, 1197.1739499745322, 1198.898093662031, 1204.783139034982, 717.218232126984, 744.9962750186214, 757.7764559454974, 762.5196126440308, 771.8494893495714, 12895.419706113247, 13297.0, 14230.928845355707, 14412.279386030657, 14519.637009074646, 749.8162950077266, 757.2238455582961, 757.7347928225078, 764.4381379685926, 766.9271419215165, 6473.255575608771, 6485.6108633482145, 6495.545311828221, 6547.476201903836, 6565.146530951041, 130998.0, 131470.0, 133065.33467332795, 133211.0, 136021.31989340187, 120298.0, 120966.0, 120966.39516802535, 121022.0, 126491.0, 103773.48113259385, 104642.0, 106777.46611267049, 107219.0, 112099.43950280196, 11653.825192621947, 11703.414829258674, 11859.932606065495, 11866.703332416759, 12053.216540924812, 51676.74161629168, 51813.74093129661, 52110.73944630404, 52806.207906880656, 53731.462685372644, 65865.0, 67792.98310525445, 67894.0, 69030.0, 69750.30249697641, 14552.781708274597, 14731.852681473049, 14751.041182323115, 14758.631034223801, 14858.257087145816, 19463.318783842496, 19688.507787304858, 19740.70388944138, 19758.0, 19889.104990275184, 16125.838741612903, 16305.184740763152, 16389.688824893743, 16502.504924852274, 16531.752023719415, 17460.0, 17487.82512174862, 17532.561685957953, 17553.12234388301, 17663.20515576828, 15701.685966280382, 15885.841141588437, 15934.760978585098, 16095.114768687834, 16099.67800644004, 14269.42922283097, 14430.0, 14521.346539405964, 14646.121232725643, 14747.55757327282, 12876.0, 12929.482820687068, 12963.351832408152, 13072.542461013818, 13185.868141318464], "value": 9820.724707513973, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 112.0, 98.0, 105.0, 104.0, 106.0, 106.0, 103.0, 105.0, 108.0], "value": 104.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 113.0, 143.0, 180.0, 121.0, 142.0, 142.0, 126.0, 172.0, 116.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 160.0, 161.0, 164.0, 169.0, 161.0, 162.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 174.0, 75.0, 74.0, 73.0, 74.0, 160.0, 73.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 140.0, 78.0, 78.0, 78.0, 125.0, 78.0, 78.0, 125.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 149.0, 148.0, 150.0, 149.0, 151.0, 149.0, 151.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 51.0, 46.0, 44.0, 46.0, 44.0, 44.0, 45.0, 46.0], "value": 46.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 36.0, 36.0, 37.0, 37.0, 37.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 72.0, 73.0, 73.0, 72.0, 71.0, 73.0, 71.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 117.0, 123.0, 108.0, 112.0, 111.0, 154.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 157.0, 151.0, 158.0, 154.0, 159.0, 153.0, 153.0, 155.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 59.0, 59.0, 59.0, 59.0, 64.0, 62.0, 58.0, 58.0], "value": 60.0, "unit": "score"}]}]} 18:03:47 INFO - Return code: 0 18:03:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:03:47 INFO - # TBPL SUCCESS # 18:03:47 INFO - Running post-action listener: _package_coverage_data 18:03:47 INFO - Running post-action listener: _resource_record_post_action 18:03:47 INFO - [mozharness: 2017-09-07 01:03:47.593857Z] Finished run-tests step (success) 18:03:47 INFO - Running post-run listener: _resource_record_post_run 18:03:47 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 401428480; Read time: 0; Write time: 357692 18:03:47 INFO - TinderboxPrint: CPU usage
13.1% 18:03:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:03:47 INFO - TinderboxPrint: I/O write bytes / time
401,428,480 / 357,692 18:03:47 INFO - TinderboxPrint: CPU idle
8,211.9 (86.9%) 18:03:47 INFO - TinderboxPrint: CPU user
1,184.2 (12.5%) 18:03:47 INFO - TinderboxPrint: Swap in / out
0 / 0 18:03:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121114624; Read time: 0; Write time: 123708 18:03:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:03:47 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 279883776; Read time: 0; Write time: 233960 18:03:48 INFO - Running post-run listener: _upload_blobber_files 18:03:48 INFO - Blob upload gear active. 18:03:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:03:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:03:48 INFO - (blobuploader) - INFO - Open directory for files ... 18:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:03:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:49 INFO - (blobuploader) - INFO - Done attempting. 18:03:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:03:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:50 INFO - (blobuploader) - INFO - Done attempting. 18:03:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:03:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:57 INFO - (blobuploader) - INFO - Done attempting. 18:03:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:03:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:03:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:58 INFO - (blobuploader) - INFO - Done attempting. 18:03:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:03:58 INFO - Return code: 0 18:03:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:03:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:03:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca79d07a56da31a3ea5043ae1a89a6ae92db98a662217e82010543a13bab0762da32ab009d79848b9082a15ce9f455377e46044630da2ae521c863d4c209fc0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/822483aa6a0fb1c357b4962b81a253ab939090337651e80b475ecd4bdaec34ab81e8512c474bf25d54f529cf3d301230812a9b3fbe2e17fbf1bec0ab2c8d8404", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f44abcff573c3fce5d3600dc24f53dd91efe69f8b5985f01b6885b7e7231e5e7f180bd1317221dd36a3eb8a6027800cf37f86d330ba70cf26aa015d42bc722f5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b736b0ad327fbdea012f2360eb9b11dd2260f5757d28d0edad24058bfa7f775a24df2efbc0d4d14753833592e7e3728cfa837a05db8b335ec33d194d0eebee6"} 18:03:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:03:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:03:58 INFO - Contents: 18:03:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca79d07a56da31a3ea5043ae1a89a6ae92db98a662217e82010543a13bab0762da32ab009d79848b9082a15ce9f455377e46044630da2ae521c863d4c209fc0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/822483aa6a0fb1c357b4962b81a253ab939090337651e80b475ecd4bdaec34ab81e8512c474bf25d54f529cf3d301230812a9b3fbe2e17fbf1bec0ab2c8d8404", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f44abcff573c3fce5d3600dc24f53dd91efe69f8b5985f01b6885b7e7231e5e7f180bd1317221dd36a3eb8a6027800cf37f86d330ba70cf26aa015d42bc722f5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b736b0ad327fbdea012f2360eb9b11dd2260f5757d28d0edad24058bfa7f775a24df2efbc0d4d14753833592e7e3728cfa837a05db8b335ec33d194d0eebee6"} 18:03:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:03:58 INFO - Copying logs to upload dir... 18:03:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:03:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.512986 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-06 18:03:58.932030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 18:03:58.935817) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca79d07a56da31a3ea5043ae1a89a6ae92db98a662217e82010543a13bab0762da32ab009d79848b9082a15ce9f455377e46044630da2ae521c863d4c209fc0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/822483aa6a0fb1c357b4962b81a253ab939090337651e80b475ecd4bdaec34ab81e8512c474bf25d54f529cf3d301230812a9b3fbe2e17fbf1bec0ab2c8d8404", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f44abcff573c3fce5d3600dc24f53dd91efe69f8b5985f01b6885b7e7231e5e7f180bd1317221dd36a3eb8a6027800cf37f86d330ba70cf26aa015d42bc722f5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b736b0ad327fbdea012f2360eb9b11dd2260f5757d28d0edad24058bfa7f775a24df2efbc0d4d14753833592e7e3728cfa837a05db8b335ec33d194d0eebee6"} build_url:https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/ccxe2CkMRWeKQ6akbP-iGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bca79d07a56da31a3ea5043ae1a89a6ae92db98a662217e82010543a13bab0762da32ab009d79848b9082a15ce9f455377e46044630da2ae521c863d4c209fc0", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/822483aa6a0fb1c357b4962b81a253ab939090337651e80b475ecd4bdaec34ab81e8512c474bf25d54f529cf3d301230812a9b3fbe2e17fbf1bec0ab2c8d8404", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f44abcff573c3fce5d3600dc24f53dd91efe69f8b5985f01b6885b7e7231e5e7f180bd1317221dd36a3eb8a6027800cf37f86d330ba70cf26aa015d42bc722f5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b736b0ad327fbdea012f2360eb9b11dd2260f5757d28d0edad24058bfa7f775a24df2efbc0d4d14753833592e7e3728cfa837a05db8b335ec33d194d0eebee6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 18:03:58.963602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:03:58.963917) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1504744989.632915-213072408 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 18:03:59.047473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 18:03:59.047797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 18:03:59.048080) ========= ========= Total master_lag: 0.22 =========