builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1468374922.7 results: success (0) buildid: 20160712160625 builduid: 6c3d3a8e9bc8484dbe262f3f044d5331 revision: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.698542) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.699128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.699445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.734178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.734472) ========= 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=1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 18:55:22-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-07-12 18:55:22 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.866669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.867015) ========= 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=1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.916757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:22.917121) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd3207c8ef3811b55e2073248c6ca39576fcf3a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bd3207c8ef3811b55e2073248c6ca39576fcf3a6 --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=1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 18:55:22,957 truncating revision to first 12 chars 2016-07-12 18:55:22,957 Setting DEBUG logging. 2016-07-12 18:55:22,957 attempt 1/10 2016-07-12 18:55:22,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bd3207c8ef38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 18:55:23,261 unpacking tar archive at: mozilla-aurora-bd3207c8ef38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:23.608404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:23.608744) ========= script_repo_revision: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:23.609174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:23.609475) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 18:55:23.619696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-12 18:55:23.620161) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:55:23 INFO - MultiFileLogger online at 20160712 18:55:23 in /builds/slave/test 18:55:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:55:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:55:23 INFO - {'append_to_log': False, 18:55:23 INFO - 'base_work_dir': '/builds/slave/test', 18:55:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:55:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:55:23 INFO - 'branch': 'Mozilla-Aurora', 18:55:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:55:23 INFO - 'config_files': ('talos/linux_config.py',), 18:55:23 INFO - 'default_actions': ('clobber', 18:55:23 INFO - 'read-buildbot-config', 18:55:23 INFO - 'download-and-extract', 18:55:23 INFO - 'populate-webroot', 18:55:23 INFO - 'create-virtualenv', 18:55:23 INFO - 'install', 18:55:23 INFO - 'run-tests'), 18:55:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:55:23 INFO - 'download_minidump_stackwalk': True, 18:55:23 INFO - 'download_symbols': 'ondemand', 18:55:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:55:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:55:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:55:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:55:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:55:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:55:23 INFO - 'installer_path': 'installer.exe', 18:55:23 INFO - 'log_level': 'info', 18:55:23 INFO - 'log_name': 'talos', 18:55:23 INFO - 'log_to_console': True, 18:55:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:55:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:55:23 INFO - 'opt_config_files': (), 18:55:23 INFO - 'pip_index': False, 18:55:23 INFO - 'sps_profile': False, 18:55:23 INFO - 'sps_profile_interval': 0, 18:55:23 INFO - 'suite': 'dromaeojs-e10s', 18:55:23 INFO - 'system_bits': '32', 18:55:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:55:23 INFO - 'title': 'talos-linux64-ix-027', 18:55:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:55:23 INFO - 'use_talos_json': True, 18:55:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:55:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:55:23 INFO - 'work_dir': 'build'} 18:55:23 INFO - ##### 18:55:23 INFO - ##### Running clobber step. 18:55:23 INFO - ##### 18:55:23 INFO - Running pre-action listener: _resource_record_pre_action 18:55:23 INFO - Running main action method: clobber 18:55:23 INFO - rmtree: /builds/slave/test/build 18:55:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:55:24 INFO - Running post-action listener: _resource_record_post_action 18:55:24 INFO - ##### 18:55:24 INFO - ##### Finished clobber step (success) 18:55:24 INFO - ##### 18:55:24 INFO - ##### 18:55:24 INFO - ##### Running read-buildbot-config step. 18:55:24 INFO - ##### 18:55:24 INFO - Running pre-action listener: _resource_record_pre_action 18:55:24 INFO - Running main action method: read_buildbot_config 18:55:24 INFO - Using buildbot properties: 18:55:24 INFO - { 18:55:24 INFO - "project": "", 18:55:24 INFO - "product": "firefox", 18:55:24 INFO - "script_repo_revision": "production", 18:55:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:55:24 INFO - "repository": "", 18:55:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:55:24 INFO - "buildid": "20160712160625", 18:55:24 INFO - "pgo_build": "True", 18:55:24 INFO - "basedir": "/builds/slave/test", 18:55:24 INFO - "buildnumber": 442, 18:55:24 INFO - "slavename": "talos-linux64-ix-027", 18:55:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:55:24 INFO - "platform": "ubuntu64_hw", 18:55:24 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:55:24 INFO - "branch": "mozilla-aurora", 18:55:24 INFO - "repo_path": "releases/mozilla-aurora", 18:55:24 INFO - "revision": "bd3207c8ef3811b55e2073248c6ca39576fcf3a6", 18:55:24 INFO - "stage_platform": "linux64-pgo", 18:55:24 INFO - "builduid": "6c3d3a8e9bc8484dbe262f3f044d5331", 18:55:24 INFO - "slavebuilddir": "test" 18:55:24 INFO - } 18:55:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:55:24 INFO - Running post-action listener: _resource_record_post_action 18:55:24 INFO - ##### 18:55:24 INFO - ##### Finished read-buildbot-config step (success) 18:55:24 INFO - ##### 18:55:24 INFO - ##### 18:55:24 INFO - ##### Running download-and-extract step. 18:55:24 INFO - ##### 18:55:24 INFO - Running pre-action listener: _resource_record_pre_action 18:55:24 INFO - Running main action method: download_and_extract 18:55:24 INFO - mkdir: /builds/slave/test/build/tests 18:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:24 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:55:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:55:28 INFO - Downloaded 1361 bytes. 18:55:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:55:28 INFO - Using the following test package requirements: 18:55:28 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:55:28 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:55:28 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:55:28 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'jsshell-linux-x86_64.zip'], 18:55:28 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:55:28 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:55:28 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:55:28 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:55:28 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:55:28 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:55:28 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:55:28 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:28 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:39 INFO - Downloaded 24424405 bytes. 18:55:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:40 INFO - Return code: 0 18:55:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:40 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:55:41 INFO - Downloaded 24424405 bytes. 18:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:55:43 INFO - Return code: 0 18:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:43 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:55:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:55:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:55:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:55:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:55:44 INFO - Downloaded 10833369 bytes. 18:55:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:55:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:55:44 INFO - Return code: 0 18:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:44 INFO - https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:55:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:55:46 INFO - Downloaded 62839007 bytes. 18:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:46 INFO - mkdir: /builds/slave/test/properties 18:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:55:46 INFO - Contents: 18:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:55:46 INFO - Running post-action listener: _resource_record_post_action 18:55:46 INFO - Running post-action listener: set_extra_try_arguments 18:55:46 INFO - ##### 18:55:46 INFO - ##### Finished download-and-extract step (success) 18:55:46 INFO - ##### 18:55:46 INFO - ##### 18:55:46 INFO - ##### Running populate-webroot step. 18:55:46 INFO - ##### 18:55:46 INFO - Running pre-action listener: _resource_record_pre_action 18:55:46 INFO - Running main action method: populate_webroot 18:55:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:55:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:55:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:55:46 INFO - '--tppagecycles', 18:55:46 INFO - '7'], 18:55:46 INFO - 'tests': ['tsvgm']}}, 18:55:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:55:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:55:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:55:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:55:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:55:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['damp', 'tps']}, 18:55:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'tests': ['damp', 'tps']}, 18:55:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['dromaeo_dom']}, 18:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:55:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['a11yr', 18:55:46 INFO - 'ts_paint', 18:55:46 INFO - 'tpaint', 18:55:46 INFO - 'sessionrestore', 18:55:46 INFO - 'sessionrestore_no_auto_restore', 18:55:46 INFO - 'tabpaint']}, 18:55:46 INFO - 'other-e10s': {'tests': ['a11yr', 18:55:46 INFO - 'ts_paint', 18:55:46 INFO - 'tpaint', 18:55:46 INFO - 'sessionrestore', 18:55:46 INFO - 'sessionrestore_no_auto_restore', 18:55:46 INFO - 'tabpaint']}, 18:55:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:55:46 INFO - 'ts_paint', 18:55:46 INFO - 'tpaint', 18:55:46 INFO - 'sessionrestore', 18:55:46 INFO - 'sessionrestore_no_auto_restore', 18:55:46 INFO - 'tabpaint']}, 18:55:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:55:46 INFO - 'ts_paint', 18:55:46 INFO - 'tpaint', 18:55:46 INFO - 'sessionrestore', 18:55:46 INFO - 'sessionrestore_no_auto_restore', 18:55:46 INFO - 'tabpaint']}, 18:55:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['a11yr', 18:55:46 INFO - 'ts_paint', 18:55:46 INFO - 'tpaint', 18:55:46 INFO - 'sessionrestore', 18:55:46 INFO - 'sessionrestore_no_auto_restore', 18:55:46 INFO - 'tabpaint']}, 18:55:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['a11yr', 18:55:46 INFO - 'ts_paint', 18:55:46 INFO - 'tpaint', 18:55:46 INFO - 'sessionrestore', 18:55:46 INFO - 'sessionrestore_no_auto_restore', 18:55:46 INFO - 'tabpaint']}, 18:55:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['tsvgx', 18:55:46 INFO - 'tsvgr_opacity', 18:55:46 INFO - 'tart', 18:55:46 INFO - 'tscrollx', 18:55:46 INFO - 'cart']}, 18:55:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:55:46 INFO - 'tsvgr_opacity', 18:55:46 INFO - 'tart', 18:55:46 INFO - 'tscrollx', 18:55:46 INFO - 'cart']}, 18:55:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'talos_options': ['--disable-e10s'], 18:55:46 INFO - 'tests': ['tp5o']}, 18:55:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'tests': ['tp5o']}, 18:55:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'talos_options': ['--disable-e10s', 18:55:46 INFO - '--xperf_path', 18:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:46 INFO - 'tests': ['tp5n']}, 18:55:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:55:46 INFO - 'talos_options': ['--xperf_path', 18:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:55:46 INFO - 'tests': ['tp5n']}}, 18:55:46 INFO - 'talos.zip': {'path': '', 18:55:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:55:46 INFO - Running post-action listener: _resource_record_post_action 18:55:46 INFO - ##### 18:55:46 INFO - ##### Finished populate-webroot step (success) 18:55:46 INFO - ##### 18:55:46 INFO - ##### 18:55:46 INFO - ##### Running create-virtualenv step. 18:55:46 INFO - ##### 18:55:46 INFO - Running pre-action listener: _resource_record_pre_action 18:55:46 INFO - Running main action method: create_virtualenv 18:55:46 INFO - Creating virtualenv /builds/slave/test/build/venv 18:55:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:55:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:55:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:55:47 INFO - Using real prefix '/usr' 18:55:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:55:49 INFO - Installing pip.................done. 18:55:49 INFO - Return code: 0 18:55:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:55:49 INFO - Using env: {'DISPLAY': ':0', 18:55:49 INFO - 'HOME': '/home/cltbld', 18:55:49 INFO - 'LANG': 'en_US.UTF-8', 18:55:49 INFO - 'LANGUAGE': 'en_US:en', 18:55:49 INFO - 'LOGNAME': 'cltbld', 18:55:49 INFO - 'MAIL': '/var/mail/cltbld', 18:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:49 INFO - 'MOZ_NO_REMOTE': '1', 18:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:49 INFO - 'NO_EM_RESTART': '1', 18:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:49 INFO - 'PWD': '/builds/slave/test', 18:55:49 INFO - 'SHELL': '/bin/bash', 18:55:49 INFO - 'SHLVL': '1', 18:55:49 INFO - 'TERM': 'linux', 18:55:49 INFO - 'TMOUT': '86400', 18:55:49 INFO - 'USER': 'cltbld', 18:55:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:49 INFO - '_': '/tools/buildbot/bin/python'} 18:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:55:49 INFO - Cleaning up... 18:55:49 INFO - Return code: 0 18:55:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:49 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:55:49 INFO - Using env: {'DISPLAY': ':0', 18:55:49 INFO - 'HOME': '/home/cltbld', 18:55:49 INFO - 'LANG': 'en_US.UTF-8', 18:55:49 INFO - 'LANGUAGE': 'en_US:en', 18:55:49 INFO - 'LOGNAME': 'cltbld', 18:55:49 INFO - 'MAIL': '/var/mail/cltbld', 18:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:49 INFO - 'MOZ_NO_REMOTE': '1', 18:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:49 INFO - 'NO_EM_RESTART': '1', 18:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:49 INFO - 'PWD': '/builds/slave/test', 18:55:49 INFO - 'SHELL': '/bin/bash', 18:55:49 INFO - 'SHLVL': '1', 18:55:49 INFO - 'TERM': 'linux', 18:55:49 INFO - 'TMOUT': '86400', 18:55:49 INFO - 'USER': 'cltbld', 18:55:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:49 INFO - '_': '/tools/buildbot/bin/python'} 18:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:49 INFO - Downloading/unpacking psutil>=3.1.1 18:55: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 18:55: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 18:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55: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 18:55: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 18:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:51 INFO - Installing collected packages: psutil 18:55:51 INFO - Running setup.py install for psutil 18:55:51 INFO - building 'psutil._psutil_linux' extension 18:55:51 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 18:55:52 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 18:55:52 INFO - building 'psutil._psutil_posix' extension 18:55:52 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 18:55:52 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 18:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:55:52 INFO - Successfully installed psutil 18:55:52 INFO - Cleaning up... 18:55:52 INFO - Return code: 0 18:55:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:52 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:55:52 INFO - Using env: {'DISPLAY': ':0', 18:55:52 INFO - 'HOME': '/home/cltbld', 18:55:52 INFO - 'LANG': 'en_US.UTF-8', 18:55:52 INFO - 'LANGUAGE': 'en_US:en', 18:55:52 INFO - 'LOGNAME': 'cltbld', 18:55:52 INFO - 'MAIL': '/var/mail/cltbld', 18:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:52 INFO - 'MOZ_NO_REMOTE': '1', 18:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:52 INFO - 'NO_EM_RESTART': '1', 18:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:52 INFO - 'PWD': '/builds/slave/test', 18:55:52 INFO - 'SHELL': '/bin/bash', 18:55:52 INFO - 'SHLVL': '1', 18:55:52 INFO - 'TERM': 'linux', 18:55:52 INFO - 'TMOUT': '86400', 18:55:52 INFO - 'USER': 'cltbld', 18:55:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:52 INFO - '_': '/tools/buildbot/bin/python'} 18:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:55: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 18:55: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 18:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55: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 18:55: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 18:55:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:55:54 INFO - Installing collected packages: mozsystemmonitor 18:55:54 INFO - Running setup.py install for mozsystemmonitor 18:55:54 INFO - Successfully installed mozsystemmonitor 18:55:54 INFO - Cleaning up... 18:55:54 INFO - Return code: 0 18:55:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:55:54 INFO - Using env: {'DISPLAY': ':0', 18:55:54 INFO - 'HOME': '/home/cltbld', 18:55:54 INFO - 'LANG': 'en_US.UTF-8', 18:55:54 INFO - 'LANGUAGE': 'en_US:en', 18:55:54 INFO - 'LOGNAME': 'cltbld', 18:55:54 INFO - 'MAIL': '/var/mail/cltbld', 18:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:54 INFO - 'MOZ_NO_REMOTE': '1', 18:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:54 INFO - 'NO_EM_RESTART': '1', 18:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:54 INFO - 'PWD': '/builds/slave/test', 18:55:54 INFO - 'SHELL': '/bin/bash', 18:55:54 INFO - 'SHLVL': '1', 18:55:54 INFO - 'TERM': 'linux', 18:55:54 INFO - 'TMOUT': '86400', 18:55:54 INFO - 'USER': 'cltbld', 18:55:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:54 INFO - '_': '/tools/buildbot/bin/python'} 18:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:54 INFO - Downloading/unpacking jsonschema==2.5.1 18:55:54 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 18:55:54 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 18:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:54 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 18:55:54 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 18:55:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:55:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:55:56 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 18:55:56 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 18:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:56 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 18:55:56 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 18:55:57 INFO - Downloading functools32-3.2.3-2.tar.gz 18:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:55:57 INFO - warning: no files found matching '*.txt' 18:55:57 INFO - no previously-included directories found matching 'build' 18:55:57 INFO - no previously-included directories found matching 'dist' 18:55:57 INFO - no previously-included directories found matching '.git*' 18:55:57 INFO - Installing collected packages: jsonschema, functools32 18:55:57 INFO - Running setup.py install for functools32 18:55:57 INFO - warning: no files found matching '*.txt' 18:55:57 INFO - no previously-included directories found matching 'build' 18:55:57 INFO - no previously-included directories found matching 'dist' 18:55:57 INFO - no previously-included directories found matching '.git*' 18:55:57 INFO - Successfully installed jsonschema functools32 18:55:57 INFO - Cleaning up... 18:55:57 INFO - Return code: 0 18:55:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:55:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:55:57 INFO - Using env: {'DISPLAY': ':0', 18:55:57 INFO - 'HOME': '/home/cltbld', 18:55:57 INFO - 'LANG': 'en_US.UTF-8', 18:55:57 INFO - 'LANGUAGE': 'en_US:en', 18:55:57 INFO - 'LOGNAME': 'cltbld', 18:55:57 INFO - 'MAIL': '/var/mail/cltbld', 18:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:57 INFO - 'MOZ_NO_REMOTE': '1', 18:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:55:57 INFO - 'NO_EM_RESTART': '1', 18:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:57 INFO - 'PWD': '/builds/slave/test', 18:55:57 INFO - 'SHELL': '/bin/bash', 18:55:57 INFO - 'SHLVL': '1', 18:55:57 INFO - 'TERM': 'linux', 18:55:57 INFO - 'TMOUT': '86400', 18:55:57 INFO - 'USER': 'cltbld', 18:55:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:57 INFO - '_': '/tools/buildbot/bin/python'} 18:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:55:57 INFO - Downloading/unpacking blobuploader==1.2.4 18:55: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 18:55: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 18:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55: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 18:55: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 18:55:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:55:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:55: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 18:55: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 18:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:55: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 18:55: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 18:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:00 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 18:56:00 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 18:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:00 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 18:56:00 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 18:56:00 INFO - Downloading docopt-0.6.1.tar.gz 18:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:00 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:00 INFO - Running setup.py install for blobuploader 18:56:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:56:00 INFO - Running setup.py install for requests 18:56:00 INFO - Running setup.py install for docopt 18:56:00 INFO - Successfully installed blobuploader requests docopt 18:56:00 INFO - Cleaning up... 18:56:01 INFO - Return code: 0 18:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:56:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:56:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:01 INFO - Using env: {'DISPLAY': ':0', 18:56:01 INFO - 'HOME': '/home/cltbld', 18:56:01 INFO - 'LANG': 'en_US.UTF-8', 18:56:01 INFO - 'LANGUAGE': 'en_US:en', 18:56:01 INFO - 'LOGNAME': 'cltbld', 18:56:01 INFO - 'MAIL': '/var/mail/cltbld', 18:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:01 INFO - 'MOZ_NO_REMOTE': '1', 18:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:01 INFO - 'NO_EM_RESTART': '1', 18:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:01 INFO - 'PWD': '/builds/slave/test', 18:56:01 INFO - 'SHELL': '/bin/bash', 18:56:01 INFO - 'SHLVL': '1', 18:56:01 INFO - 'TERM': 'linux', 18:56:01 INFO - 'TMOUT': '86400', 18:56:01 INFO - 'USER': 'cltbld', 18:56:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:01 INFO - '_': '/tools/buildbot/bin/python'} 18:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:01 INFO - Running setup.py (path:/tmp/pip-E7jjj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:01 INFO - Running setup.py (path:/tmp/pip-Ci_ZE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:01 INFO - Running setup.py (path:/tmp/pip-MtePCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:01 INFO - Running setup.py (path:/tmp/pip-mckaCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:01 INFO - Running setup.py (path:/tmp/pip-kAm6jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:01 INFO - Running setup.py (path:/tmp/pip-s7rTnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:01 INFO - Running setup.py (path:/tmp/pip-AJGyyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:01 INFO - Running setup.py (path:/tmp/pip-q1Ohpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:01 INFO - Running setup.py (path:/tmp/pip-_ZByVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:01 INFO - Running setup.py (path:/tmp/pip-Y4aD2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:01 INFO - Running setup.py (path:/tmp/pip-kLHRz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:02 INFO - Running setup.py (path:/tmp/pip-7qu3yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:02 INFO - Running setup.py (path:/tmp/pip-irOXG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:02 INFO - Running setup.py (path:/tmp/pip-WXfUQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:02 INFO - Running setup.py (path:/tmp/pip-YrlYjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:02 INFO - Running setup.py (path:/tmp/pip-HT3fyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:02 INFO - Running setup.py (path:/tmp/pip-u0LPBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:02 INFO - Running setup.py install for manifestparser 18:56:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:56:02 INFO - Running setup.py install for mozcrash 18:56:02 INFO - Running setup.py install for mozdebug 18:56:02 INFO - Running setup.py install for mozdevice 18:56:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:56:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:56:02 INFO - Running setup.py install for mozfile 18:56:03 INFO - Running setup.py install for mozhttpd 18:56:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for mozinfo 18:56:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for mozInstall 18:56:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for mozleak 18:56:03 INFO - Running setup.py install for mozlog 18:56:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for moznetwork 18:56:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for mozprocess 18:56:03 INFO - Running setup.py install for mozprofile 18:56:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for mozrunner 18:56:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:56:03 INFO - Running setup.py install for mozscreenshot 18:56:04 INFO - Running setup.py install for moztest 18:56:04 INFO - Running setup.py install for mozversion 18:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:56:04 INFO - Cleaning up... 18:56:04 INFO - Return code: 0 18:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:56:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:56:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:04 INFO - Using env: {'DISPLAY': ':0', 18:56:04 INFO - 'HOME': '/home/cltbld', 18:56:04 INFO - 'LANG': 'en_US.UTF-8', 18:56:04 INFO - 'LANGUAGE': 'en_US:en', 18:56:04 INFO - 'LOGNAME': 'cltbld', 18:56:04 INFO - 'MAIL': '/var/mail/cltbld', 18:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:04 INFO - 'MOZ_NO_REMOTE': '1', 18:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:04 INFO - 'NO_EM_RESTART': '1', 18:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:04 INFO - 'PWD': '/builds/slave/test', 18:56:04 INFO - 'SHELL': '/bin/bash', 18:56:04 INFO - 'SHLVL': '1', 18:56:04 INFO - 'TERM': 'linux', 18:56:04 INFO - 'TMOUT': '86400', 18:56:04 INFO - 'USER': 'cltbld', 18:56:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:04 INFO - '_': '/tools/buildbot/bin/python'} 18:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:04 INFO - Running setup.py (path:/tmp/pip-j23tmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:04 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)) 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:04 INFO - Running setup.py (path:/tmp/pip-Jh3Rdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:04 INFO - Running setup.py (path:/tmp/pip-2I76FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:04 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)) 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:04 INFO - Running setup.py (path:/tmp/pip-5ucuxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:04 INFO - Running setup.py (path:/tmp/pip-gXXXKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:04 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)) 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:04 INFO - Running setup.py (path:/tmp/pip-LhoGmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:04 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)) 18:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:04 INFO - Running setup.py (path:/tmp/pip-696EJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:05 INFO - Running setup.py (path:/tmp/pip-smGPFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:05 INFO - Running setup.py (path:/tmp/pip-QjqJuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:05 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:05 INFO - Running setup.py (path:/tmp/pip-z_jHl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:05 INFO - Running setup.py (path:/tmp/pip-Q0yO3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:05 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:05 INFO - Running setup.py (path:/tmp/pip-H7JQ0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:05 INFO - Running setup.py (path:/tmp/pip-ygJA8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:05 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:05 INFO - Running setup.py (path:/tmp/pip-gflk46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:05 INFO - Running setup.py (path:/tmp/pip-E0IzEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:05 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:05 INFO - Running setup.py (path:/tmp/pip-AWXEHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 18:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:05 INFO - Running setup.py (path:/tmp/pip-97mcAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:05 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)) 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:56:05 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)) 18:56:05 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:56:05 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:56:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:56:05 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 18:56:05 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 18:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:05 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 18:56:05 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 18:56:07 INFO - Downloading blessings-1.6.tar.gz 18:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:56:07 INFO - Installing collected packages: blessings 18:56:07 INFO - Running setup.py install for blessings 18:56:07 INFO - Successfully installed blessings 18:56:07 INFO - Cleaning up... 18:56:07 INFO - Return code: 0 18:56:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:08 INFO - Reading from file tmpfile_stdout 18:56:08 INFO - Current package versions: 18:56:08 INFO - argparse == 1.2.1 18:56:08 INFO - blessings == 1.6 18:56:08 INFO - blobuploader == 1.2.4 18:56:08 INFO - docopt == 0.6.1 18:56:08 INFO - functools32 == 3.2.3-2 18:56:08 INFO - jsonschema == 2.5.1 18:56:08 INFO - manifestparser == 1.1 18:56:08 INFO - mozInstall == 1.12 18:56:08 INFO - mozcrash == 0.17 18:56:08 INFO - mozdebug == 0.1 18:56:08 INFO - mozdevice == 0.48 18:56:08 INFO - mozfile == 1.2 18:56:08 INFO - mozhttpd == 0.7 18:56:08 INFO - mozinfo == 0.9 18:56:08 INFO - mozleak == 0.1 18:56:08 INFO - mozlog == 3.2 18:56:08 INFO - moznetwork == 0.27 18:56:08 INFO - mozprocess == 0.23 18:56:08 INFO - mozprofile == 0.28 18:56:08 INFO - mozrunner == 6.12 18:56:08 INFO - mozscreenshot == 0.1 18:56:08 INFO - mozsystemmonitor == 0.3 18:56:08 INFO - moztest == 0.7 18:56:08 INFO - mozversion == 1.4 18:56:08 INFO - psutil == 3.1.1 18:56:08 INFO - requests == 1.2.3 18:56:08 INFO - wsgiref == 0.1.2 18:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:56:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 18:56:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:56:08 INFO - Using env: {'DISPLAY': ':0', 18:56:08 INFO - 'HOME': '/home/cltbld', 18:56:08 INFO - 'LANG': 'en_US.UTF-8', 18:56:08 INFO - 'LANGUAGE': 'en_US:en', 18:56:08 INFO - 'LOGNAME': 'cltbld', 18:56:08 INFO - 'MAIL': '/var/mail/cltbld', 18:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:08 INFO - 'MOZ_NO_REMOTE': '1', 18:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:08 INFO - 'NO_EM_RESTART': '1', 18:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:08 INFO - 'PWD': '/builds/slave/test', 18:56:08 INFO - 'SHELL': '/bin/bash', 18:56:08 INFO - 'SHLVL': '1', 18:56:08 INFO - 'TERM': 'linux', 18:56:08 INFO - 'TMOUT': '86400', 18:56:08 INFO - 'USER': 'cltbld', 18:56:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:08 INFO - '_': '/tools/buildbot/bin/python'} 18:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 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)) 18:56:08 INFO - Cleaning up... 18:56:08 INFO - Return code: 0 18:56:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:56:08 INFO - Using env: {'DISPLAY': ':0', 18:56:08 INFO - 'HOME': '/home/cltbld', 18:56:08 INFO - 'LANG': 'en_US.UTF-8', 18:56:08 INFO - 'LANGUAGE': 'en_US:en', 18:56:08 INFO - 'LOGNAME': 'cltbld', 18:56:08 INFO - 'MAIL': '/var/mail/cltbld', 18:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:08 INFO - 'MOZ_NO_REMOTE': '1', 18:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:08 INFO - 'NO_EM_RESTART': '1', 18:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:08 INFO - 'PWD': '/builds/slave/test', 18:56:08 INFO - 'SHELL': '/bin/bash', 18:56:08 INFO - 'SHLVL': '1', 18:56:08 INFO - 'TERM': 'linux', 18:56:08 INFO - 'TMOUT': '86400', 18:56:08 INFO - 'USER': 'cltbld', 18:56:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:08 INFO - '_': '/tools/buildbot/bin/python'} 18:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:56:08 INFO - Cleaning up... 18:56:08 INFO - Return code: 0 18:56:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:56:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f23943a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1914020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, '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': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', '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 18:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:56:08 INFO - Using env: {'DISPLAY': ':0', 18:56:08 INFO - 'HOME': '/home/cltbld', 18:56:08 INFO - 'LANG': 'en_US.UTF-8', 18:56:08 INFO - 'LANGUAGE': 'en_US:en', 18:56:08 INFO - 'LOGNAME': 'cltbld', 18:56:08 INFO - 'MAIL': '/var/mail/cltbld', 18:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:08 INFO - 'MOZ_NO_REMOTE': '1', 18:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:08 INFO - 'NO_EM_RESTART': '1', 18:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:08 INFO - 'PWD': '/builds/slave/test', 18:56:08 INFO - 'SHELL': '/bin/bash', 18:56:08 INFO - 'SHLVL': '1', 18:56:08 INFO - 'TERM': 'linux', 18:56:08 INFO - 'TMOUT': '86400', 18:56:08 INFO - 'USER': 'cltbld', 18:56:08 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:08 INFO - '_': '/tools/buildbot/bin/python'} 18:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:08 INFO - Downloading/unpacking flake8 18:56:08 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 18:56:08 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 18:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:08 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 18:56:08 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 18:56:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:56:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:56:10 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 18:56:10 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 18:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:10 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 18:56:10 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 18:56:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:56:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:56:10 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 18:56:10 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 18:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:10 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 18:56:10 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 18:56:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:56:11 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 18:56:11 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 18:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:56:11 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 18:56:11 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 18:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:56:11 INFO - no previously-included directories found matching 'docs/_build' 18:56:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:56:11 INFO - Running setup.py install for pep8 18:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:56:11 INFO - no previously-included directories found matching 'docs/_build' 18:56:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:56:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:56:11 INFO - Cleaning up... 18:56:11 INFO - Return code: 0 18:56:11 INFO - Running post-action listener: _resource_record_post_action 18:56:11 INFO - Running post-action listener: _start_resource_monitoring 18:56:11 INFO - Starting resource monitoring. 18:56:11 INFO - ##### 18:56:11 INFO - ##### Finished create-virtualenv step (success) 18:56:11 INFO - ##### 18:56:11 INFO - ##### 18:56:11 INFO - ##### Running install step. 18:56:11 INFO - ##### 18:56:11 INFO - Running pre-action listener: _resource_record_pre_action 18:56:11 INFO - Running main action method: install 18:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:11 INFO - Reading from file tmpfile_stdout 18:56:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:56:12 INFO - Reading from file tmpfile_stdout 18:56:12 INFO - Output received: 18:56:12 INFO - Usage: mozinstall [options] installer 18:56:12 INFO - Options: 18:56:12 INFO - -h, --help show this help message and exit 18:56:12 INFO - -d DEST, --destination=DEST 18:56:12 INFO - Directory to install application into. [default: 18:56:12 INFO - "/builds/slave/test"] 18:56:12 INFO - --app=APP Application being installed. [default: firefox] 18:56:12 INFO - mkdir: /builds/slave/test/build/application 18:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:56:27 INFO - Reading from file tmpfile_stdout 18:56:27 INFO - Output received: 18:56:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:56:27 INFO - Running post-action listener: _resource_record_post_action 18:56:27 INFO - ##### 18:56:27 INFO - ##### Finished install step (success) 18:56:27 INFO - ##### 18:56:27 INFO - ##### 18:56:27 INFO - ##### Running run-tests step. 18:56:27 INFO - ##### 18:56:27 INFO - Running pre-action listener: _resource_record_pre_action 18:56:27 INFO - Running main action method: run_tests 18:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:56:27 INFO - Python 2.7.3 18:56:27 INFO - Return code: 0 18:56:27 INFO - grabbing minidump binary from tooltool 18:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x19a62e0>, '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 0x1912140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:56:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 18:56:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:56:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 18:56:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:56:27 INFO - Return code: 0 18:56:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:56:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:56:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:56:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:56:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:56:28 INFO - Return code: 0 18:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 18:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 18:56:28 INFO - Using env: {'DISPLAY': ':0', 18:56:28 INFO - 'HOME': '/home/cltbld', 18:56:28 INFO - 'LANG': 'en_US.UTF-8', 18:56:28 INFO - 'LANGUAGE': 'en_US:en', 18:56:28 INFO - 'LOGNAME': 'cltbld', 18:56:28 INFO - 'MAIL': '/var/mail/cltbld', 18:56:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:56:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:28 INFO - 'MOZ_NO_REMOTE': '1', 18:56:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:28 INFO - 'NO_EM_RESTART': '1', 18:56:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:28 INFO - 'PWD': '/builds/slave/test', 18:56:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:56:28 INFO - 'SHELL': '/bin/bash', 18:56:28 INFO - 'SHLVL': '1', 18:56:28 INFO - 'TERM': 'linux', 18:56:28 INFO - 'TMOUT': '86400', 18:56:28 INFO - 'USER': 'cltbld', 18:56:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489', 18:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:28 INFO - '_': '/tools/buildbot/bin/python'} 18:56:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 18:56:28 INFO - mozversion application_buildid: 20160712160625 18:56:28 INFO - mozversion application_changeset: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 18:56:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:56:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:56:28 INFO - mozversion application_name: Firefox 18:56:28 INFO - mozversion application_remotingname: firefox-dev 18:56:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:56:28 INFO - mozversion application_vendor: Mozilla 18:56:28 INFO - mozversion application_version: 49.0a2 18:56:28 INFO - mozversion platform_buildid: 20160712160625 18:56:28 INFO - mozversion platform_changeset: bd3207c8ef3811b55e2073248c6ca39576fcf3a6 18:56:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:56:28 INFO - mozversion platform_version: 49.0a2 18:56:28 INFO - using testdate: 1468374988 18:56:28 INFO - actual date: 1468374988 18:56:28 INFO - starting webserver on 'localhost:56513' 18:56:28 INFO - SUITE-START | Running 2 tests 18:56:28 INFO - TEST-START | dromaeo_css 18:56:28 INFO - operating with platform_type : linux_ 18:56:28 INFO - Initialising browser for dromaeo_css test... 18:56:28 INFO - TEST-INFO | started process 12663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxM46Z/profile http://localhost:56513/getInfo.html) 18:56:33 INFO - PROCESS | 12663 | __metrics Screen width/height:1600/1200 18:56:33 INFO - PROCESS | 12663 | colorDepth:24 18:56:33 INFO - PROCESS | 12663 | Browser inner width/height: 1024/697 18:56:33 INFO - PROCESS | 12663 | __metrics 18:56:34 ERROR - PROCESS | 12663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:56:34 INFO - TEST-INFO | 12663: exit 0 18:56:34 INFO - Browser initialized. 18:56:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:56:34 INFO - TEST-INFO | started process 12790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLxM46Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:46 INFO - PROCESS | 12790 | RSS: Main: 156520448 18:56:46 INFO - PROCESS | 12790 | 18:57:36 INFO - PROCESS | 12790 | 1468375056351 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:59:43 INFO - PROCESS | 12790 | Cycle 1(1): loaded http://localhost:56513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56513/tests/dromaeo/cssquery-ext.html) 18:59:44 INFO - PROCESS | 12790 | RSS: Main: 160657408 18:59:44 INFO - PROCESS | 12790 | 19:02:46 INFO - PROCESS | 12790 | Cycle 1(1): loaded http://localhost:56513/tests/dromaeo/cssquery-ext.html (next: http://localhost:56513/tests/dromaeo/cssquery-jquery.html) 19:02:46 INFO - PROCESS | 12790 | RSS: Main: 158003200 19:02:46 INFO - PROCESS | 12790 | 19:05:48 INFO - PROCESS | 12790 | Cycle 1(1): loaded http://localhost:56513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56513/tests/dromaeo/cssquery-mootools.html) 19:05:49 INFO - PROCESS | 12790 | RSS: Main: 157634560 19:05:49 INFO - PROCESS | 12790 | 19:08:51 INFO - PROCESS | 12790 | Cycle 1(1): loaded http://localhost:56513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56513/tests/dromaeo/cssquery-prototype.html) 19:08:51 INFO - PROCESS | 12790 | RSS: Main: 157073408 19:08:51 INFO - PROCESS | 12790 | 19:11:54 INFO - PROCESS | 12790 | Cycle 1(1): loaded http://localhost:56513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56513/tests/dromaeo/cssquery-yui.html) 19:11:54 INFO - PROCESS | 12790 | RSS: Main: 159072256 19:11:54 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | Cycle 1(1): loaded http://localhost:56513/tests/dromaeo/cssquery-yui.html (next: http://localhost:56513/tests/dromaeo/cssquery-dojo.html) 19:14:57 INFO - PROCESS | 12790 | RSS: Main: 159186944 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | __start_tp_report 19:14:57 INFO - PROCESS | 12790 | _x_x_mozilla_page_load 19:14:57 INFO - PROCESS | 12790 | _x_x_mozilla_page_load_details 19:14:57 INFO - PROCESS | 12790 | |i|pagename|runs| 19:14:57 INFO - PROCESS | 12790 | |0;dojo.html;3186.760992925531;3220.6940340667634;3227.3061291822255;3261.103196620929;3262.005088448024;5011.54896059355;5012.523810238031;5024.020316038374;5034.370703662043;5076.314697515834;5039.899202015958;5048.217526283423;5053.570446512051;5053.772580233889;5062.291279220912;4603.631709463243;4624.213883639789;4674.0651869626045;4681.9063618727605;4729.196036673774;4542.682012259143;4566.931496027546;4679.672422930396;4700.4594471635855;4744.667873248874;4649.790759415834;4666.976665116669;4669.929951050737;4683.484816670163;4698.976505117486;4691.859244222679;4701.177293973558;4727.787249573777;4731.905361892743;4756.001239739659;4462.709923854939;4605.4933957264675;4612.953870461286;4680.765961701902;4739.218029025241;4753.524647535253;4767.856964291077;4783.402074740658;4788.0663270662235;4812.711237325771;5266.131088370415;5268.262443257947;5272.789088436458;5280.973595132038;5307.920381194285;5193.792248310063;5272.6836389816735;5282.81510147143;5312.123499622558;5334.946650533484;5042.873928151789;5063.721495317793;5094.59243260542;5103.336566246401;5134.306868572769;5446.972765136149;5483.232347471358;5489.478499542617;5490.3411590609385;5508.55931525477;5127.051495473349;5196.870078247998;5221.164613661796;5328.467153284718;5329.25390445338;5314.4951229633125;5317.175837745079;5343.919841202385;5344.305240318734;5350.571954243651;5291.312129423227;5308.389535203501;5325.8934821303355;5349.5720342372515;5351.732413379315;5130.769115389742;5281.234221037928;5282.6302158849285;5311.893762124736;5316.096263635114;4294.098239369768;4298.613124818781;4310.784460776948;4321.114171594815;4331.501877284152;3882.2235552889533;3896.493455850778;3905.3165696003653;3915.138669492707;3916.020994751312;5044.218146187347;5123.6925784452305;5139;5162.09663308927;5192.610554208374;5309.814156504503;5355.518003379637;5382.219578161144;5444.700541470257;5444.782208711607;5064.366954130734;5234.528892399626;5237.292965449692;5260.237265596544;5280.498352656491;4709.222978208626;4734.337192793012;4762.904741905212;4774.355462012584;4785.545373189541;5615.747291371898;5658.179563963202;5660.915086273709;5672.8865422691315;5741.88516229673;5189.558887494605;5318.840434786963;5431.266778984866;5431.755570999236;5433.9456605435025;5640.435956404327;5670.319561652628;5675.545956323402;5686;5739.799107031234;5308.57531397495;5314.070037743302;5317.069512835161;5317.813876514303;5321.175217841241;5233.842984710464;5272.077386457431;5272.525472707474;5430.456954304538;5453.263809385682;5219.347581552306;5223;5230.895382092413;5232.058229518723;5238.71187084714;5174.844754657366;5208.765605547684;5217.373915130209;5218.921716174184;5245.89508209826;5075.543201111917;5076.289319495199;5137.563307118788;5156.845294641167;5167.044096841946;5231.13686241781;5257.947420525746;5274.841754747364;5283.2075188722;5303.337082864642;5185.896282074413;5186.455422180617;5190.247414124855;5197.116490196751;5204.2974198484235 19:14:57 INFO - PROCESS | 12790 | |1;ext.html;600.4115966352974;636.5194278319868;646.3762469217211;650.3626446082836;656.074934342577;44757;46473.76763116188;46755.76622116889;49753;49805;47177.76411117948;47717.28424073633;47763.52236477634;47870;47924;9053.773655658595;9170.770730731718;9176.541172941359;9180.632774689004;9196.034416386283;9004.504752238625;9022.233110185642;9028.819423611523;9033.051529589397;9059.592318345658;9037.819243615124;9084.318676099287;9095.95452022739;9097.727068187965;9143.314251431137;8983.820323593523;9005.819883602291;9013.684521041765;9015.684451044215;9049.864252036225;8899.243564297043;8925.419847709878;9012.639494420215;9037;9066.501342426163;44680.55319446829;44951.55048449539;44965.32552011722;45205;45356.546434535565;3770.811459427018;3920.627540383659;3973.245083434167;4002.8598999034893;4218;33455.832720836486;34216.82891585551;34229.6577034229;34337;34341.828290858386;4568.994821139344;4638.211504044287;4643.6285097192485;4660.976695116537;4672.789724462407;356583;357456;357765;358445;359600.9999999974;62485.75028499495;62667.686661566404;62926.68536657379;63107.684461577395;63215.36784632095;39981.2003759929;40813.591864080976;68801.31198687949;68880;69063.65468172728;19061.428157155307;19097.618047639247;19219;19219.51951201231;19288.22847086101;13865.09876858001;13928.651783705489;13975.79036314456;14032.859671403156;14093.71812563743;20591.485212869797;20595.07322170506;20848.791512084685;20853.478663033242;20893.582128357346;7090.6100164491445;7130.429565634737;7141.178764442156;7183.245759195209;7392.778216653509;1044.8067107584968;1104.6465131157952;1105.6019832860163;1118.7818375416716;1152.7291086594644;32452;32501.51247731286;32727.363631818313;33150.83424582861;33423.498647520304;1150.0799360511558;1179.6107284596062;1244.7697176022284;1263.1410640764184;1273.9554115605908;17397.739033914502;17513;17571.73642395365;17695.557611059827;17795.555111122067;477297;483247;878830;897684;997455;62139.689301553204;62506.37493625096;62858.37141628525;62989.37010629927;63325.68337158285;1441.502681574855;1445.913245205291;1453.4767483705857;1455.2360010994312;1463.3195564062976;32287.677123229405;33105.33789324152;33269.83365083256;33519.329613407106;34115.31769364649;53949.46050539601;54546.727266363414;54717.179242312195;54885;54913.450865490835;417295;419582;419712;421719;423832;30458.913228848927;30598.082057538308;30853.537196942514;30939.226519336295;31079.223019424695;43778.124437510436;43856.78071609622;44400.555994439645;50613.24080138875;50713.49286507235;41367.79316103521;42033.46075559772;42279.577204227564;42670.35994460023;42902.78548607237;40947.38578921259;41451.37822932598;41524.792376039135;41851.58148418477;42182.7890860556;42374;42388.576114238465;43205;43687.126257475305;43825.56174438342;35166.648333516336;36265;37067.62932370642;37154.8142259287;37532.81233593814;29002.854985724935;29093;29336.853315733286;29569.704302956696;29745.702542974293 19:14:57 INFO - PROCESS | 12790 | |2;jquery.html;411.9114390406062;412.82661282261455;417.805720340042;427.07112031331843;442.49776503668346;18197.7270340945;19376.128074236676;19948.50128746782;20245;20517.589648207027;18944.810551894476;19338.806611933876;19410.22359105634;19415.708764368545;19683.409497715093;5383.16560933055;5840.211571437844;5857.912131318034;5862.413758624146;5896.616719913192;5652.576056795736;5788.594798364116;5806.854828629276;5811;5859;5804.042333015047;5837.532997360201;5845.853853653672;5847.824565263028;5859.560532960024;5557.749901254453;5826.563007774434;5830.62100963436;5843;5844.152597873306;5219.8434046978655;5222.060029194743;5225.059489291926;5246.449122842085;5256.237845512417;23690.881545592336;24445.144419945216;24769.87615061931;24819.5036099277;24905.750942490526;2580.135654555726;2772.8336299822076;2782.401783616532;3102.922426939322;3322.9833850830832;15066.171360575165;15344.539663809992;15461.92269038659;15491.767623485657;15746.921265393714;2064.1021155797275;2083.458300841792;2124.936251912445;2248.628976218938;2297.2993237062688;55989.160162597596;56368.71815640936;94391.52804235935;101196;104168.47915760372;17212.1393930303;18738.718919216222;18956.905215473835;19081.90459047696;19382.70925936112;34228.82885585606;34375.484367734505;35145.64854351475;35164.47253291203;35211.11972200664;10864.728381790519;11195.216334856483;11238.943805280922;11359.204855660024;11377.54489820398;9539;9544.236461083097;9665.613375464902;9694.563744631509;9707.90292097084;9368.484733339596;9376.343655944018;9427.90572094284;9519.381240219363;9524.380915240487;3665.376885929398;3684.415701248489;3729.941874906862;3733.178700685845;3813.103920578662;1012.9290949633455;1022.7443139215196;1082.2802836113897;1105.2539535813294;1131.524759600953;17978.370757023702;19372.612547748966;19615.803841961682;19739.703904441445;20565.280215192397;1027.7071034755058;1030.5414090729553;1039.8024375368657;1048.6172547020283;1050.0864248104047;11197.552097915992;11254.38100904458;11298.60454884075;11413.372264525531;11493.425328733698;441945;442151;445242;554408;600611;106076;107273;107711.46144269385;108456;111110.44444777725;1099.3074363151322;1099.5491848342142;1134.733337665648;1138.1407037686658;1140.247436691796;18165.81834181641;18392.26430942747;18400.723989140442;18441.72337414913;18656.34702785396;40085.599144008185;44103.558964409945;44735.328970064824;44738.3289250668;46107;55315.72342138264;60921.39078609157;61670.69164654327;62670.37329626645;63017.36982630299;8255.174482551696;8416.663333466593;8505.362097842562;8633.69782057625;8773.254273386834;10134.898651013396;13275.336233188495;13707.794383084061;13762.587122386345;14178.858211417753;11894.821577676516;11933;12089.274643521418;12098.153129280865;12597.370131493572;11862.22895511789;12007.699807504881;12045.277283363026;12117.75764484723;12392.31842248685;12164.695882602651;12488.188267762567;12504.624861254177;12563.874361256636;13131.540396086091;7676.424268179797;7919.16848730898;8181.754547363588;8254.711085112232;8260.380471464545;9417.434953902788;12317.692057698629;12320.199187052813;12351.505939762308;12361 19:14:57 INFO - PROCESS | 12790 | |3;mootools.html;1471.587955372496;1518.0057062623982;1679.7396403557452;1814.4465937888956;1829.268292682926;8238.134995825441;8643.13568643137;8970.102989701027;9535.856962145564;9572.569234384451;8863.734087977371;8865.512396818172;8880.689175878846;8916.509591972439;8958;2339.5905716499587;2369.39580406996;2385.689860318165;2386.069432921162;2393.3179043972473;2330.82518811089;2376.3821406434363;2422.842515236513;2426.963595546068;2432;2384.1059602649007;2395.3891757601873;2396.1373905394044;2422.442838147227;2431.6960379952507;2289.278877153691;2292.151903795598;2313.90744370225;2333.3233362324904;2394.736578976311;2374.2402431222017;2374.8100151987974;2382.988085059581;2400.615901455759;2411.3007227903886;8962.32782541312;9002.549872506414;9032.14194651507;9052.321075919332;9061.50161741104;5316.494932981361;5356.54469370104;5404.3784964728775;5405.27028851104;5423.674579525241;3302.190963214004;3355.882544110969;3380.8309584520675;3396.2698019925588;3451.861925522976;1086.0605576176629;1205.1323047405854;1205.2166092040156;1214.8602910665297;1215.0826126274605;12938.676533086747;13004.804927926089;13030.218186908816;13036.21782693032;13081.86918130816;4609.7695115244105;4653.115907977473;4728;4744.7390393528685;4753.952460475421;10871.293365931348;10889.891101088888;10898.128149748001;10899.1280697544;10909.618163364403;5390.649607775482;5400.054990376669;5419.430959749248;5435.402105768362;5446.1558458439;4366.563343665608;4864.17309057454;4869.440014398318;4987.301777751118;5032.47159048302;4116.176764647083;4120.134771697917;4134.359174327984;4137.54487006429;4191.874243772691;1278.6675464379143;1298.4741179822188;1303.7588046211292;1308.4962289518414;1318.5846458365584;968.4286271100085;984.6849008317413;999.7550600103021;1012.9493525323704;1019.4189312092185;5881.529477641779;6222.595531290452;6250.874982500324;6278.6860656966965;6415.26224484181;453.4128303846527;454.21420941770924;467.7778055423715;468.59232467752594;471.8820294926268;4184.497860256728;4264.978675106605;4298.333758267474;4300.978495107504;4318.5681431856565;11589.6523104307;11766.88233117675;11990.460429280703;12040.698982525508;12073.33596652175;11726.413679316;11796.52813887452;11813.527458901548;11831.112666550043;11851.348175850411;8419.200175983271;8793.164649358301;8793.868091978626;8976.057513961201;9001.954990225007;6103.389661034039;6278;6389.808305750835;6396.584222025554;6421.8073457796345;10469.424181669776;10802.405867677353;10805.189610779065;11002.669919902415;11024.173187011167;10955.068819150461;11144.832827507757;11161.441927903736;11201.775964480828;11300.886991130312;7568.848623027398;8124.715634952749;8193.959030204811;8323.542205178774;8368.163183681827;9307.906920930704;9332.440053596805;9367.672131475365;9383;9432.811343773223;8061.234182752629;8248.54632995167;8472.110428404929;8490.872636910575;8597.140285971604;8042.3968202383885;8104.594770261346;8301.667933282843;8360.790980225544;8393.664253429795;7086.220515743367;7432.665530051053;7485.251474852471;7486.213947535648;7676.80807979805;5051.4695956924;5110.4123025852505;5132.871678208075;5147.5881929446305;5251.973740131275;5183.714895680774;5237.6333656643665;5245.763940622757;5249.422563517934;5298.523132918056 19:14:57 INFO - PROCESS | 12790 | |4;prototype.html;356.7039357333413;364.8905328401479;366.32047551791425;369.6359086299994;372.91795804922907;5052.595792336613;5109.6167787416;5264.789408423659;5316.149416093426;5320.334958130234;5107.974460127703;5144.614153938451;5158.535731784139;5199.142141546649;5200.4019537753165;4166.604172603597;4187.790610469479;4208.852690155845;4225.647792706335;4232.957670423287;3970.4838371011874;4195.559466256045;4223;4244.724092933965;4245.915081698364;4111.342185250361;4141.917161656765;4167.729097608661;4172.895677608054;4185.476815398075;4141.772202528859;4164.12553363794;4171.290880550314;4200.243956087903;4208.410822484854;3734.290484807878;3761.322961866863;3762.322781899257;3763.9435408468894;3769.133099387129;4835.153848076608;4944.53026962438;4951.331570238044;4958.231474121517;4978.5270399312;4692.7653617319;4704.811807527695;4717.150912835688;4739.218029025206;4751.40607424072;5378.731063446851;5401.756920938567;5428.972855135738;5451.182322651594;5458.781648734046;3790.77255364679;4022.9597704022876;4024.8188831502653;4028.2144981728575;4035.8183881725395;5532.446755324476;5589.496945274945;5590.664560126405;5658.122990936411;5659.773609055633;4092.3861420786525;4119.281274358908;4127.731697439657;4127.814248358831;4134.1731653668785;3972.682185425159;4120.979395103065;4159.334506478949;4173.040200753843;4212.620864122244;4619.353290539327;4640.559146881041;4678.485366609671;4689.62483001359;4697.95302046982;5200.479952004845;5447.210154527651;5452.454754524595;5464.23500709901;5467.72661366938;1392.3943084758162;1412.25150670145;1418.89358298126;1420.353739048751;1424.302091974925;925.4909799610188;931.7391130483476;947.5735918836414;948.1750876737283;968.2544440780559;4772.403449568804;4811.171754733179;4864.829730959399;4884.948321704893;4889.877753056131;4965.503449655005;4966.304717339575;5009.423916249605;5025.773840177128;5050.595952323805;4646.79089440976;4718;4822.3464356895765;4826.903461930812;4880.804767809248;2656.990343669393;2657.707652158261;2673.5722284434396;2675.9464810703676;2701.5002224588516;5151.356080489939;5238.5023422774775;5264.263003179558;5295.788168473295;5308.23030660552;4992.675476094042;4997.950020499821;5031.33965791288;5308.487081181845;5750.856228594319;5921.437463440966;5924.407559244041;5934.317553481319;5950.583459157818;5951.732172052268;5584.492187109539;5601.495865372136;5608.327000759935;5619.129034999582;5632;5452.727363631882;5507.394186639546;5555.833325000256;5557.472040156179;5569.721513924369;5868.295804503487;5888.4700376964565;5913.822585322448;5928.4960778334325;5935.436133567477;4044.2922488563795;4153.646940010133;4171.728837625545;4189.706720529533;4198.979005104955;5512.80705175317;5571.582131340085;5584.291618564912;5618.269624948731;5649.47464184676;5518.641288316247;5522.30971128609;5525.226468294361;5531.197976293495;5561.610687251854;5521.751521181476;5524.171374293888;5527.530159936289;5528.944710552843;5529.778808847601;5123.538881500683;5431.293931788842;5436.184572314184;5446.863828404163;5447.155690867922;5437.429069947757;5484.149956756709;5492.1212605982855;5515.862103447446;5531.483175155215;5137.9486205138965;5379.4082650907585;5381.892362152813;5387.138057910715;5437.293151890229 19:14:57 INFO - PROCESS | 12790 | |5;yui.html;634.1027446163679;646.3245908026114;652.4714980865499;659.7855696898506;703.2615753458867;13596.728065438698;14332.211728354936;14344.497942572;14369.784453233184;14525.62006609373;14270.785938210935;14453.349599268033;14460.349284282207;14468.05957612757;14476.855231447682;819.0744458761591;834.3408707121367;847.5804476783969;849.0660273698943;851.0298259983624;836.7657056024292;837.8659414493683;843.2495079379357;846.699421705295;847.1867007672611;891.750309913222;895.1898531828673;897.0267260022883;897.1253028297423;898.6809682562695;886.6497733395337;891.3804905590617;891.5497673674785;893.5621545442687;894.0433735902554;650.1742786660961;650.8958566629317;653.5784419049686;653.6960313454266;656.3338211715113;14599.562013139517;14755.262236888113;14762.261886905719;14786.704265914621;14799.630009249748;12959;12978.221306721533;13026.348682565835;13440.86559134406;14202.92898535511;11817.290962542274;12143.635690929286;12227.633171004883;12237.082218833533;12660.68348291291;3871.9419208711893;3949.940750888739;3955.2287303975736;4037.8788636340664;4083.7549747014978;78030;78592.21407785905;79755;80540.59729701372;80844;10579.62971296001;10607.94696026515;10782.353058816496;10802.297850639683;10944.288621239753;19405.32081377145;20223.191072357236;20228.69656955147;20246.291379801638;20262.088206030763;8643.567821608895;8811.030786613468;8961;9012.41419307743;9035.322350823715;4728.148933192058;4836.226203807374;4859.3682821233015;4868.805247790048;4874.610031197496;3306.454435018243;3411.4200585900458;3417.3677869594203;3423.3153369325737;3463.9826800865835;587.7296443635976;610.8869859076085;611.1413464082971;615.9692015399212;615.9876802463925;733.8495608400265;741.4439170622034;750.2497502497503;755.1466842467976;760.9315161635369;9401;9955.601775928882;10119.797604047877;10163.339382940234;10179.236557258235;633.1452539072216;635.1774452084561;655.5968079630993;710.2152121905324;719.086759815032;4497.865064048084;4587.931181032287;4726.976365118221;4741.83403580873;4802.255650374198;74213;79626.20373796303;102731.4863425693;115951;117763;70169.64915175391;100695.49652251691;103655.4817225909;103707;104716;86239;86831.56584217038;88199;88839.55580222186;90245.09754902367;9288;9376.390534615228;9588.904110958802;9636.373635713657;9660.257048918887;52053.7397313011;52667.73666131645;53312.73343633257;53533.73233133809;54099.459005411016;73654;75255;76945;77284;77324;11873.406329683654;12013.879861201276;12089.75820483603;12184.51261949512;12364.752704946031;13446;13478.74022818778;13486.258255796025;13537.323133843072;13685.863141368856;12688.365581721062;12734.808977865525;12742.936285318514;12839.807402889151;12925.54760583375;12599.748005039664;12734.172278801849;12745.17156384832;12781.16922400041;12905.806412903627;12671.556495522613;12826;12843.100982931479;13044.217346959213;13074.673133171747;10161.79676406453;10171.54228059754;10406.895931040895;10568.207384446043;10847.945760271148;9996.900030999888;10174.23693223026;10212;10264.178865690876;10283.228757843042 19:14:57 INFO - PROCESS | 12790 | __end_tp_report 19:14:57 INFO - PROCESS | 12790 | __start_cc_report 19:14:57 INFO - PROCESS | 12790 | _x_x_mozilla_cycle_collect,336 19:14:57 INFO - PROCESS | 12790 | __end_cc_report 19:14:57 INFO - PROCESS | 12790 | __startTimestamp1468376097344__endTimestamp 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | ------- Summary: start ------- 19:14:57 INFO - PROCESS | 12790 | Number of tests: 6 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | [#0] dojo.html Cycles:165 Average:5024.47 Median:5192.61 stddev:492.92 (9.5%) stddev-sans-first:472.88 19:14:57 INFO - PROCESS | 12790 | Values: 3186.8 3220.7 3227.3 3261.1 3262.0 5011.5 5012.5 5024.0 5034.4 5076.3 5039.9 5048.2 5053.6 5053.8 5062.3 4603.6 4624.2 4674.1 4681.9 4729.2 4542.7 4566.9 4679.7 4700.5 4744.7 4649.8 4667.0 4669.9 4683.5 4699.0 4691.9 4701.2 4727.8 4731.9 4756.0 4462.7 4605.5 4613.0 4680.8 4739.2 4753.5 4767.9 4783.4 4788.1 4812.7 5266.1 5268.3 5272.8 5281.0 5307.9 5193.8 5272.7 5282.8 5312.1 5334.9 5042.9 5063.7 5094.6 5103.3 5134.3 5447.0 5483.2 5489.5 5490.3 5508.6 5127.1 5196.9 5221.2 5328.5 5329.3 5314.5 5317.2 5343.9 5344.3 5350.6 5291.3 5308.4 5325.9 5349.6 5351.7 5130.8 5281.2 5282.6 5311.9 5316.1 4294.1 4298.6 4310.8 4321.1 4331.5 3882.2 3896.5 3905.3 3915.1 3916.0 5044.2 5123.7 5139.0 5162.1 5192.6 5309.8 5355.5 5382.2 5444.7 5444.8 5064.4 5234.5 5237.3 5260.2 5280.5 4709.2 4734.3 4762.9 4774.4 4785.5 5615.7 5658.2 5660.9 5672.9 5741.9 5189.6 5318.8 5431.3 5431.8 5433.9 5640.4 5670.3 5675.5 5686.0 5739.8 5308.6 5314.1 5317.1 5317.8 5321.2 5233.8 5272.1 5272.5 5430.5 5453.3 5219.3 5223.0 5230.9 5232.1 5238.7 5174.8 5208.8 5217.4 5218.9 5245.9 5075.5 5076.3 5137.6 5156.8 5167.0 5231.1 5257.9 5274.8 5283.2 5303.3 5185.9 5186.5 5190.2 5197.1 5204.3 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | [#1] ext.html Cycles:180 Average:66969.52 Median:233110.29 stddev:148281.71 (63.6%) stddev-sans-first:148613.95 19:14:57 INFO - PROCESS | 12790 | Values: 600.4 636.5 646.4 650.4 656.1 44757.0 46473.8 46755.8 49753.0 49805.0 47177.8 47717.3 47763.5 47870.0 47924.0 9053.8 9170.8 9176.5 9180.6 9196.0 9004.5 9022.2 9028.8 9033.1 9059.6 9037.8 9084.3 9096.0 9097.7 9143.3 8983.8 9005.8 9013.7 9015.7 9049.9 8899.2 8925.4 9012.6 9037.0 9066.5 44680.6 44951.6 44965.3 45205.0 45356.5 3770.8 3920.6 3973.2 4002.9 4218.0 33455.8 34216.8 34229.7 34337.0 34341.8 4569.0 4638.2 4643.6 4661.0 4672.8 356583.0 357456.0 357765.0 358445.0 359601.0 62485.8 62667.7 62926.7 63107.7 63215.4 39981.2 40813.6 68801.3 68880.0 69063.7 19061.4 19097.6 19219.0 19219.5 19288.2 13865.1 13928.7 13975.8 14032.9 14093.7 20591.5 20595.1 20848.8 20853.5 20893.6 7090.6 7130.4 7141.2 7183.2 7392.8 1044.8 1104.6 1105.6 1118.8 1152.7 32452.0 32501.5 32727.4 33150.8 33423.5 1150.1 1179.6 1244.8 1263.1 1274.0 17397.7 17513.0 17571.7 17695.6 17795.6 477297.0 483247.0 878830.0 897684.0 997455.0 62139.7 62506.4 62858.4 62989.4 63325.7 1441.5 1445.9 1453.5 1455.2 1463.3 32287.7 33105.3 33269.8 33519.3 34115.3 53949.5 54546.7 54717.2 54885.0 54913.5 417295.0 419582.0 419712.0 421719.0 423832.0 30458.9 30598.1 30853.5 30939.2 31079.2 43778.1 43856.8 44400.6 50613.2 50713.5 41367.8 42033.5 42279.6 42670.4 42902.8 40947.4 41451.4 41524.8 41851.6 42182.8 42374.0 42388.6 43205.0 43687.1 43825.6 35166.6 36265.0 37067.6 37154.8 37532.8 29002.9 29093.0 29336.9 29569.7 29745.7 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | [#2] jquery.html Cycles:180 Average:31194.84 Median:12994.09 stddev:82961.32 (638.5%) stddev-sans-first:83161.85 19:14:57 INFO - PROCESS | 12790 | Values: 411.9 412.8 417.8 427.1 442.5 18197.7 19376.1 19948.5 20245.0 20517.6 18944.8 19338.8 19410.2 19415.7 19683.4 5383.2 5840.2 5857.9 5862.4 5896.6 5652.6 5788.6 5806.9 5811.0 5859.0 5804.0 5837.5 5845.9 5847.8 5859.6 5557.7 5826.6 5830.6 5843.0 5844.2 5219.8 5222.1 5225.1 5246.4 5256.2 23690.9 24445.1 24769.9 24819.5 24905.8 2580.1 2772.8 2782.4 3102.9 3323.0 15066.2 15344.5 15461.9 15491.8 15746.9 2064.1 2083.5 2124.9 2248.6 2297.3 55989.2 56368.7 94391.5 101196.0 104168.5 17212.1 18738.7 18956.9 19081.9 19382.7 34228.8 34375.5 35145.6 35164.5 35211.1 10864.7 11195.2 11238.9 11359.2 11377.5 9539.0 9544.2 9665.6 9694.6 9707.9 9368.5 9376.3 9427.9 9519.4 9524.4 3665.4 3684.4 3729.9 3733.2 3813.1 1012.9 1022.7 1082.3 1105.3 1131.5 17978.4 19372.6 19615.8 19739.7 20565.3 1027.7 1030.5 1039.8 1048.6 1050.1 11197.6 11254.4 11298.6 11413.4 11493.4 441945.0 442151.0 445242.0 554408.0 600611.0 106076.0 107273.0 107711.5 108456.0 111110.4 1099.3 1099.5 1134.7 1138.1 1140.2 18165.8 18392.3 18400.7 18441.7 18656.3 40085.6 44103.6 44735.3 44738.3 46107.0 55315.7 60921.4 61670.7 62670.4 63017.4 8255.2 8416.7 8505.4 8633.7 8773.3 10134.9 13275.3 13707.8 13762.6 14178.9 11894.8 11933.0 12089.3 12098.2 12597.4 11862.2 12007.7 12045.3 12117.8 12392.3 12164.7 12488.2 12504.6 12563.9 13131.5 7676.4 7919.2 8181.8 8254.7 8260.4 9417.4 12317.7 12320.2 12351.5 12361.0 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | [#3] mootools.html Cycles:180 Average:6092.83 Median:4631.44 stddev:3578.88 (77.3%) stddev-sans-first:3572.07 19:14:57 INFO - PROCESS | 12790 | Values: 1471.6 1518.0 1679.7 1814.4 1829.3 8238.1 8643.1 8970.1 9535.9 9572.6 8863.7 8865.5 8880.7 8916.5 8958.0 2339.6 2369.4 2385.7 2386.1 2393.3 2330.8 2376.4 2422.8 2427.0 2432.0 2384.1 2395.4 2396.1 2422.4 2431.7 2289.3 2292.2 2313.9 2333.3 2394.7 2374.2 2374.8 2383.0 2400.6 2411.3 8962.3 9002.5 9032.1 9052.3 9061.5 5316.5 5356.5 5404.4 5405.3 5423.7 3302.2 3355.9 3380.8 3396.3 3451.9 1086.1 1205.1 1205.2 1214.9 1215.1 12938.7 13004.8 13030.2 13036.2 13081.9 4609.8 4653.1 4728.0 4744.7 4754.0 10871.3 10889.9 10898.1 10899.1 10909.6 5390.6 5400.1 5419.4 5435.4 5446.2 4366.6 4864.2 4869.4 4987.3 5032.5 4116.2 4120.1 4134.4 4137.5 4191.9 1278.7 1298.5 1303.8 1308.5 1318.6 968.4 984.7 999.8 1012.9 1019.4 5881.5 6222.6 6250.9 6278.7 6415.3 453.4 454.2 467.8 468.6 471.9 4184.5 4265.0 4298.3 4301.0 4318.6 11589.7 11766.9 11990.5 12040.7 12073.3 11726.4 11796.5 11813.5 11831.1 11851.3 8419.2 8793.2 8793.9 8976.1 9002.0 6103.4 6278.0 6389.8 6396.6 6421.8 10469.4 10802.4 10805.2 11002.7 11024.2 10955.1 11144.8 11161.4 11201.8 11300.9 7568.8 8124.7 8194.0 8323.5 8368.2 9307.9 9332.4 9367.7 9383.0 9432.8 8061.2 8248.5 8472.1 8490.9 8597.1 8042.4 8104.6 8301.7 8360.8 8393.7 7086.2 7432.7 7485.3 7486.2 7676.8 5051.5 5110.4 5132.9 5147.6 5252.0 5183.7 5237.6 5245.8 5249.4 5298.5 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | [#4] prototype.html Cycles:180 Average:4564.32 Median:5028.56 stddev:1316.19 (26.2%) stddev-sans-first:1281.43 19:14:57 INFO - PROCESS | 12790 | Values: 356.7 364.9 366.3 369.6 372.9 5052.6 5109.6 5264.8 5316.1 5320.3 5108.0 5144.6 5158.5 5199.1 5200.4 4166.6 4187.8 4208.9 4225.6 4233.0 3970.5 4195.6 4223.0 4244.7 4245.9 4111.3 4141.9 4167.7 4172.9 4185.5 4141.8 4164.1 4171.3 4200.2 4208.4 3734.3 3761.3 3762.3 3763.9 3769.1 4835.2 4944.5 4951.3 4958.2 4978.5 4692.8 4704.8 4717.2 4739.2 4751.4 5378.7 5401.8 5429.0 5451.2 5458.8 3790.8 4023.0 4024.8 4028.2 4035.8 5532.4 5589.5 5590.7 5658.1 5659.8 4092.4 4119.3 4127.7 4127.8 4134.2 3972.7 4121.0 4159.3 4173.0 4212.6 4619.4 4640.6 4678.5 4689.6 4698.0 5200.5 5447.2 5452.5 5464.2 5467.7 1392.4 1412.3 1418.9 1420.4 1424.3 925.5 931.7 947.6 948.2 968.3 4772.4 4811.2 4864.8 4884.9 4889.9 4965.5 4966.3 5009.4 5025.8 5050.6 4646.8 4718.0 4822.3 4826.9 4880.8 2657.0 2657.7 2673.6 2675.9 2701.5 5151.4 5238.5 5264.3 5295.8 5308.2 4992.7 4998.0 5031.3 5308.5 5750.9 5921.4 5924.4 5934.3 5950.6 5951.7 5584.5 5601.5 5608.3 5619.1 5632.0 5452.7 5507.4 5555.8 5557.5 5569.7 5868.3 5888.5 5913.8 5928.5 5935.4 4044.3 4153.6 4171.7 4189.7 4199.0 5512.8 5571.6 5584.3 5618.3 5649.5 5518.6 5522.3 5525.2 5531.2 5561.6 5521.8 5524.2 5527.5 5528.9 5529.8 5123.5 5431.3 5436.2 5446.9 5447.2 5437.4 5484.1 5492.1 5515.9 5531.5 5137.9 5379.4 5381.9 5387.1 5437.3 19:14:57 INFO - PROCESS | 12790 | 19:14:57 INFO - PROCESS | 12790 | [#5] yui.html Cycles:180 Average:20222.11 Median:4657.45 stddev:29085.70 (624.5%) stddev-sans-first:29130.10 19:14:57 INFO - PROCESS | 12790 | Values: 634.1 646.3 652.5 659.8 703.3 13596.7 14332.2 14344.5 14369.8 14525.6 14270.8 14453.3 14460.3 14468.1 14476.9 819.1 834.3 847.6 849.1 851.0 836.8 837.9 843.2 846.7 847.2 891.8 895.2 897.0 897.1 898.7 886.6 891.4 891.5 893.6 894.0 650.2 650.9 653.6 653.7 656.3 14599.6 14755.3 14762.3 14786.7 14799.6 12959.0 12978.2 13026.3 13440.9 14202.9 11817.3 12143.6 12227.6 12237.1 12660.7 3871.9 3949.9 3955.2 4037.9 4083.8 78030.0 78592.2 79755.0 80540.6 80844.0 10579.6 10607.9 10782.4 10802.3 10944.3 19405.3 20223.2 20228.7 20246.3 20262.1 8643.6 8811.0 8961.0 9012.4 9035.3 4728.1 4836.2 4859.4 4868.8 4874.6 3306.5 3411.4 3417.4 3423.3 3464.0 587.7 610.9 611.1 616.0 616.0 733.8 741.4 750.2 755.1 760.9 9401.0 9955.6 10119.8 10163.3 10179.2 633.1 635.2 655.6 710.2 719.1 4497.9 4587.9 4727.0 4741.8 4802.3 74213.0 79626.2 102731.5 115951.0 117763.0 70169.6 100695.5 103655.5 103707.0 104716.0 86239.0 86831.6 88199.0 88839.6 90245.1 9288.0 9376.4 9588.9 9636.4 9660.3 52053.7 52667.7 53312.7 53533.7 54099.5 73654.0 75255.0 76945.0 77284.0 77324.0 11873.4 12013.9 12089.8 12184.5 12364.8 13446.0 13478.7 13486.3 13537.3 13685.9 12688.4 12734.8 12742.9 12839.8 12925.5 12599.7 12734.2 12745.2 12781.2 12905.8 12671.6 12826.0 12843.1 13044.2 13074.7 10161.8 10171.5 10406.9 10568.2 10847.9 9996.9 10174.2 10212.0 10264.2 10283.2 19:14:57 INFO - PROCESS | 12790 | -------- Summary: end -------- 19:14:57 INFO - PROCESS | 12790 | 19:14:58 INFO - TEST-INFO | 12790: exit 0 19:14:58 INFO - TEST-OK | dromaeo_css | took 1109129ms 19:14:58 INFO - TEST-START | kraken 19:14:58 INFO - operating with platform_type : linux_ 19:14:58 INFO - Initialising browser for kraken test... 19:14:58 INFO - TEST-INFO | started process 13036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6NRfsR/profile http://localhost:56513/getInfo.html) 19:15:02 INFO - PROCESS | 13036 | __metrics Screen width/height:1600/1200 19:15:02 INFO - PROCESS | 13036 | colorDepth:24 19:15:02 INFO - PROCESS | 13036 | Browser inner width/height: 1024/697 19:15:02 INFO - PROCESS | 13036 | __metrics 19:15:03 ERROR - PROCESS | 13036 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:15:03 INFO - TEST-INFO | 13036: exit 0 19:15:03 INFO - Browser initialized. 19:15:03 INFO - Running cycle 1/1 for kraken test... 19:15:03 INFO - TEST-INFO | started process 13161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6NRfsR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:15 INFO - PROCESS | 13161 | RSS: Main: 156409856 19:15:15 INFO - PROCESS | 13161 | 19:15:18 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56513/tests/kraken/driver.html?testName=audio-beat-detection) 19:15:18 INFO - PROCESS | 13161 | RSS: Main: 161878016 19:15:18 INFO - PROCESS | 13161 | 19:15:21 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56513/tests/kraken/driver.html?testName=audio-dft) 19:15:22 INFO - PROCESS | 13161 | RSS: Main: 161202176 19:15:22 INFO - PROCESS | 13161 | 19:15:25 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56513/tests/kraken/driver.html?testName=audio-fft) 19:15:25 INFO - PROCESS | 13161 | RSS: Main: 162545664 19:15:25 INFO - PROCESS | 13161 | 19:15:27 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56513/tests/kraken/driver.html?testName=audio-oscillator) 19:15:28 INFO - PROCESS | 13161 | RSS: Main: 161677312 19:15:28 INFO - PROCESS | 13161 | 19:15:30 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:15:31 INFO - PROCESS | 13161 | RSS: Main: 161845248 19:15:31 INFO - PROCESS | 13161 | 19:15:34 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56513/tests/kraken/driver.html?testName=imaging-darkroom) 19:15:34 INFO - PROCESS | 13161 | RSS: Main: 161497088 19:15:34 INFO - PROCESS | 13161 | 19:15:38 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56513/tests/kraken/driver.html?testName=imaging-desaturate) 19:15:38 INFO - PROCESS | 13161 | RSS: Main: 161804288 19:15:38 INFO - PROCESS | 13161 | 19:15:41 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56513/tests/kraken/driver.html?testName=json-parse-financial) 19:15:42 INFO - PROCESS | 13161 | RSS: Main: 161234944 19:15:42 INFO - PROCESS | 13161 | 19:15:44 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:15:44 INFO - PROCESS | 13161 | RSS: Main: 161259520 19:15:44 INFO - PROCESS | 13161 | 19:15:46 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:15:47 INFO - PROCESS | 13161 | RSS: Main: 161439744 19:15:47 INFO - PROCESS | 13161 | 19:15:49 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:15:49 INFO - PROCESS | 13161 | RSS: Main: 161976320 19:15:49 INFO - PROCESS | 13161 | 19:15:52 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:15:52 INFO - PROCESS | 13161 | RSS: Main: 162078720 19:15:52 INFO - PROCESS | 13161 | 19:15:55 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:15:56 INFO - PROCESS | 13161 | RSS: Main: 162205696 19:15:56 INFO - PROCESS | 13161 | 19:15:57 INFO - PROCESS | 13161 | Cycle 1(1): loaded http://localhost:56513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56513/tests/kraken/driver.html?testName=ai-astar) 19:15:58 INFO - PROCESS | 13161 | RSS: Main: 162488320 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | __start_tp_report 19:15:58 INFO - PROCESS | 13161 | _x_x_mozilla_page_load 19:15:58 INFO - PROCESS | 13161 | _x_x_mozilla_page_load_details 19:15:58 INFO - PROCESS | 13161 | |i|pagename|runs| 19:15:58 INFO - PROCESS | 13161 | |0;ai-astar;110;105;110;110;111;111;111;108;110;108 19:15:58 INFO - PROCESS | 13161 | |1;audio-beat-detection;156;126;153;175;128;155;148;138;186;128 19:15:58 INFO - PROCESS | 13161 | |2;audio-dft;166;162;162;163;160;163;159;161;161;161 19:15:58 INFO - PROCESS | 13161 | |3;audio-fft;74;75;75;181;76;75;74;76;159;76 19:15:58 INFO - PROCESS | 13161 | |4;audio-oscillator;85;84;142;84;85;86;145;85;85;154 19:15:58 INFO - PROCESS | 13161 | |5;imaging-gaussian-blur;121;118;117;117;118;118;118;118;118;117 19:15:58 INFO - PROCESS | 13161 | |6;imaging-darkroom;147;149;147;146;148;147;147;147;147;148 19:15:58 INFO - PROCESS | 13161 | |7;imaging-desaturate;100;97;95;98;96;96;96;96;96;96 19:15:58 INFO - PROCESS | 13161 | |8;json-parse-financial;60;58;58;58;65;62;58;58;60;58 19:15:58 INFO - PROCESS | 13161 | |9;json-stringify-tinderbox;60;61;60;60;60;60;59;60;59;60 19:15:58 INFO - PROCESS | 13161 | |10;stanford-crypto-aes;79;77;78;79;78;83;78;78;102;79 19:15:58 INFO - PROCESS | 13161 | |11;stanford-crypto-ccm;137;122;134;119;133;127;124;135;137;122 19:15:58 INFO - PROCESS | 13161 | |12;stanford-crypto-pbkdf2;157;155;161;157;157;166;155;154;154;155 19:15:58 INFO - PROCESS | 13161 | |13;stanford-crypto-sha256-iterative;62;63;63;64;64;62;63;61;62;60 19:15:58 INFO - PROCESS | 13161 | __end_tp_report 19:15:58 INFO - PROCESS | 13161 | __start_cc_report 19:15:58 INFO - PROCESS | 13161 | _x_x_mozilla_cycle_collect,871 19:15:58 INFO - PROCESS | 13161 | __end_cc_report 19:15:58 INFO - PROCESS | 13161 | __startTimestamp1468376158211__endTimestamp 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | ------- Summary: start ------- 19:15:58 INFO - PROCESS | 13161 | Number of tests: 14 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.90 (1.7%) stddev-sans-first:2.00 19:15:58 INFO - PROCESS | 13161 | Values: 110.0 105.0 110.0 110.0 111.0 111.0 111.0 108.0 110.0 108.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:154.00 stddev:20.22 (13.1%) stddev-sans-first:21.30 19:15:58 INFO - PROCESS | 13161 | Values: 156.0 126.0 153.0 175.0 128.0 155.0 148.0 138.0 186.0 128.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.93 (1.2%) stddev-sans-first:1.32 19:15:58 INFO - PROCESS | 13161 | Values: 166.0 162.0 162.0 163.0 160.0 163.0 159.0 161.0 161.0 161.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:40.34 (53.8%) stddev-sans-first:42.13 19:15:58 INFO - PROCESS | 13161 | Values: 74.0 75.0 75.0 181.0 76.0 75.0 74.0 76.0 159.0 76.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:30.17 (35.5%) stddev-sans-first:31.25 19:15:58 INFO - PROCESS | 13161 | Values: 85.0 84.0 142.0 84.0 85.0 86.0 145.0 85.0 85.0 154.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.15 (1.0%) stddev-sans-first:0.50 19:15:58 INFO - PROCESS | 13161 | Values: 121.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 19:15:58 INFO - PROCESS | 13161 | Values: 147.0 149.0 147.0 146.0 148.0 147.0 147.0 147.0 147.0 148.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:0.83 19:15:58 INFO - PROCESS | 13161 | Values: 100.0 97.0 95.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:2.37 (4.0%) stddev-sans-first:2.51 19:15:58 INFO - PROCESS | 13161 | Values: 60.0 58.0 58.0 58.0 65.0 62.0 58.0 58.0 60.0 58.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 19:15:58 INFO - PROCESS | 13161 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 59.0 60.0 59.0 60.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:78.50 stddev:7.52 (9.6%) stddev-sans-first:7.94 19:15:58 INFO - PROCESS | 13161 | Values: 79.0 77.0 78.0 79.0 78.0 83.0 78.0 78.0 102.0 79.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:133.50 stddev:6.93 (5.2%) stddev-sans-first:6.72 19:15:58 INFO - PROCESS | 13161 | Values: 137.0 122.0 134.0 119.0 133.0 127.0 124.0 135.0 137.0 122.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:157.00 stddev:3.75 (2.4%) stddev-sans-first:3.98 19:15:58 INFO - PROCESS | 13161 | Values: 157.0 155.0 161.0 157.0 157.0 166.0 155.0 154.0 154.0 155.0 19:15:58 INFO - PROCESS | 13161 | 19:15:58 INFO - PROCESS | 13161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 19:15:58 INFO - PROCESS | 13161 | Values: 62.0 63.0 63.0 64.0 64.0 62.0 63.0 61.0 62.0 60.0 19:15:58 INFO - PROCESS | 13161 | -------- Summary: end -------- 19:15:58 INFO - PROCESS | 13161 | 19:15:59 INFO - TEST-INFO | 13161: exit 0 19:15:59 INFO - TEST-OK | kraken | took 61133ms 19:15:59 INFO - SUITE-END | took 1170s 19:15:59 INFO - Completed test suite (00:19:30) 19:15:59 INFO - javascript benchmark 19:15:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7394.790948046205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.760992925531, 3220.6940340667634, 3227.3061291822255, 3261.103196620929, 3262.005088448024, 5011.54896059355, 5012.523810238031, 5024.020316038374, 5034.370703662043, 5076.314697515834, 5039.899202015958, 5048.217526283423, 5053.570446512051, 5053.772580233889, 5062.291279220912, 4603.631709463243, 4624.213883639789, 4674.0651869626045, 4681.9063618727605, 4729.196036673774, 4542.682012259143, 4566.931496027546, 4679.672422930396, 4700.4594471635855, 4744.667873248874, 4649.790759415834, 4666.976665116669, 4669.929951050737, 4683.484816670163, 4698.976505117486, 4691.859244222679, 4701.177293973558, 4727.787249573777, 4731.905361892743, 4756.001239739659, 4462.709923854939, 4605.4933957264675, 4612.953870461286, 4680.765961701902, 4739.218029025241, 4753.524647535253, 4767.856964291077, 4783.402074740658, 4788.0663270662235, 4812.711237325771, 5266.131088370415, 5268.262443257947, 5272.789088436458, 5280.973595132038, 5307.920381194285, 5193.792248310063, 5272.6836389816735, 5282.81510147143, 5312.123499622558, 5334.946650533484, 5042.873928151789, 5063.721495317793, 5094.59243260542, 5103.336566246401, 5134.306868572769, 5446.972765136149, 5483.232347471358, 5489.478499542617, 5490.3411590609385, 5508.55931525477, 5127.051495473349, 5196.870078247998, 5221.164613661796, 5328.467153284718, 5329.25390445338, 5314.4951229633125, 5317.175837745079, 5343.919841202385, 5344.305240318734, 5350.571954243651, 5291.312129423227, 5308.389535203501, 5325.8934821303355, 5349.5720342372515, 5351.732413379315, 5130.769115389742, 5281.234221037928, 5282.6302158849285, 5311.893762124736, 5316.096263635114, 4294.098239369768, 4298.613124818781, 4310.784460776948, 4321.114171594815, 4331.501877284152, 3882.2235552889533, 3896.493455850778, 3905.3165696003653, 3915.138669492707, 3916.020994751312, 5044.218146187347, 5123.6925784452305, 5139.0, 5162.09663308927, 5192.610554208374, 5309.814156504503, 5355.518003379637, 5382.219578161144, 5444.700541470257, 5444.782208711607, 5064.366954130734, 5234.528892399626, 5237.292965449692, 5260.237265596544, 5280.498352656491, 4709.222978208626, 4734.337192793012, 4762.904741905212, 4774.355462012584, 4785.545373189541, 5615.747291371898, 5658.179563963202, 5660.915086273709, 5672.8865422691315, 5741.88516229673, 5189.558887494605, 5318.840434786963, 5431.266778984866, 5431.755570999236, 5433.9456605435025, 5640.435956404327, 5670.319561652628, 5675.545956323402, 5686.0, 5739.799107031234, 5308.57531397495, 5314.070037743302, 5317.069512835161, 5317.813876514303, 5321.175217841241, 5233.842984710464, 5272.077386457431, 5272.525472707474, 5430.456954304538, 5453.263809385682, 5219.347581552306, 5223.0, 5230.895382092413, 5232.058229518723, 5238.71187084714, 5174.844754657366, 5208.765605547684, 5217.373915130209, 5218.921716174184, 5245.89508209826, 5075.543201111917, 5076.289319495199, 5137.563307118788, 5156.845294641167, 5167.044096841946, 5231.13686241781, 5257.947420525746, 5274.841754747364, 5283.2075188722, 5303.337082864642, 5185.896282074413, 5186.455422180617, 5190.247414124855, 5197.116490196751, 5204.2974198484235], "value": 4996.953567726174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.4115966352974, 636.5194278319868, 646.3762469217211, 650.3626446082836, 656.074934342577, 44757.0, 46473.76763116188, 46755.76622116889, 49753.0, 49805.0, 47177.76411117948, 47717.28424073633, 47763.52236477634, 47870.0, 47924.0, 9053.773655658595, 9170.770730731718, 9176.541172941359, 9180.632774689004, 9196.034416386283, 9004.504752238625, 9022.233110185642, 9028.819423611523, 9033.051529589397, 9059.592318345658, 9037.819243615124, 9084.318676099287, 9095.95452022739, 9097.727068187965, 9143.314251431137, 8983.820323593523, 9005.819883602291, 9013.684521041765, 9015.684451044215, 9049.864252036225, 8899.243564297043, 8925.419847709878, 9012.639494420215, 9037.0, 9066.501342426163, 44680.55319446829, 44951.55048449539, 44965.32552011722, 45205.0, 45356.546434535565, 3770.811459427018, 3920.627540383659, 3973.245083434167, 4002.8598999034893, 4218.0, 33455.832720836486, 34216.82891585551, 34229.6577034229, 34337.0, 34341.828290858386, 4568.994821139344, 4638.211504044287, 4643.6285097192485, 4660.976695116537, 4672.789724462407, 356583.0, 357456.0, 357765.0, 358445.0, 359600.9999999974, 62485.75028499495, 62667.686661566404, 62926.68536657379, 63107.684461577395, 63215.36784632095, 39981.2003759929, 40813.591864080976, 68801.31198687949, 68880.0, 69063.65468172728, 19061.428157155307, 19097.618047639247, 19219.0, 19219.51951201231, 19288.22847086101, 13865.09876858001, 13928.651783705489, 13975.79036314456, 14032.859671403156, 14093.71812563743, 20591.485212869797, 20595.07322170506, 20848.791512084685, 20853.478663033242, 20893.582128357346, 7090.6100164491445, 7130.429565634737, 7141.178764442156, 7183.245759195209, 7392.778216653509, 1044.8067107584968, 1104.6465131157952, 1105.6019832860163, 1118.7818375416716, 1152.7291086594644, 32452.0, 32501.51247731286, 32727.363631818313, 33150.83424582861, 33423.498647520304, 1150.0799360511558, 1179.6107284596062, 1244.7697176022284, 1263.1410640764184, 1273.9554115605908, 17397.739033914502, 17513.0, 17571.73642395365, 17695.557611059827, 17795.555111122067, 477297.0, 483247.0, 878830.0, 897684.0, 997455.0, 62139.689301553204, 62506.37493625096, 62858.37141628525, 62989.37010629927, 63325.68337158285, 1441.502681574855, 1445.913245205291, 1453.4767483705857, 1455.2360010994312, 1463.3195564062976, 32287.677123229405, 33105.33789324152, 33269.83365083256, 33519.329613407106, 34115.31769364649, 53949.46050539601, 54546.727266363414, 54717.179242312195, 54885.0, 54913.450865490835, 417295.0, 419582.0, 419712.0, 421719.0, 423832.0, 30458.913228848927, 30598.082057538308, 30853.537196942514, 30939.226519336295, 31079.223019424695, 43778.124437510436, 43856.78071609622, 44400.555994439645, 50613.24080138875, 50713.49286507235, 41367.79316103521, 42033.46075559772, 42279.577204227564, 42670.35994460023, 42902.78548607237, 40947.38578921259, 41451.37822932598, 41524.792376039135, 41851.58148418477, 42182.7890860556, 42374.0, 42388.576114238465, 43205.0, 43687.126257475305, 43825.56174438342, 35166.648333516336, 36265.0, 37067.62932370642, 37154.8142259287, 37532.81233593814, 29002.854985724935, 29093.0, 29336.853315733286, 29569.704302956696, 29745.702542974293], "value": 21255.90803551579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.9114390406062, 412.82661282261455, 417.805720340042, 427.07112031331843, 442.49776503668346, 18197.7270340945, 19376.128074236676, 19948.50128746782, 20245.0, 20517.589648207027, 18944.810551894476, 19338.806611933876, 19410.22359105634, 19415.708764368545, 19683.409497715093, 5383.16560933055, 5840.211571437844, 5857.912131318034, 5862.413758624146, 5896.616719913192, 5652.576056795736, 5788.594798364116, 5806.854828629276, 5811.0, 5859.0, 5804.042333015047, 5837.532997360201, 5845.853853653672, 5847.824565263028, 5859.560532960024, 5557.749901254453, 5826.563007774434, 5830.62100963436, 5843.0, 5844.152597873306, 5219.8434046978655, 5222.060029194743, 5225.059489291926, 5246.449122842085, 5256.237845512417, 23690.881545592336, 24445.144419945216, 24769.87615061931, 24819.5036099277, 24905.750942490526, 2580.135654555726, 2772.8336299822076, 2782.401783616532, 3102.922426939322, 3322.9833850830832, 15066.171360575165, 15344.539663809992, 15461.92269038659, 15491.767623485657, 15746.921265393714, 2064.1021155797275, 2083.458300841792, 2124.936251912445, 2248.628976218938, 2297.2993237062688, 55989.160162597596, 56368.71815640936, 94391.52804235935, 101196.0, 104168.47915760372, 17212.1393930303, 18738.718919216222, 18956.905215473835, 19081.90459047696, 19382.70925936112, 34228.82885585606, 34375.484367734505, 35145.64854351475, 35164.47253291203, 35211.11972200664, 10864.728381790519, 11195.216334856483, 11238.943805280922, 11359.204855660024, 11377.54489820398, 9539.0, 9544.236461083097, 9665.613375464902, 9694.563744631509, 9707.90292097084, 9368.484733339596, 9376.343655944018, 9427.90572094284, 9519.381240219363, 9524.380915240487, 3665.376885929398, 3684.415701248489, 3729.941874906862, 3733.178700685845, 3813.103920578662, 1012.9290949633455, 1022.7443139215196, 1082.2802836113897, 1105.2539535813294, 1131.524759600953, 17978.370757023702, 19372.612547748966, 19615.803841961682, 19739.703904441445, 20565.280215192397, 1027.7071034755058, 1030.5414090729553, 1039.8024375368657, 1048.6172547020283, 1050.0864248104047, 11197.552097915992, 11254.38100904458, 11298.60454884075, 11413.372264525531, 11493.425328733698, 441945.0, 442151.0, 445242.0, 554408.0, 600611.0, 106076.0, 107273.0, 107711.46144269385, 108456.0, 111110.44444777725, 1099.3074363151322, 1099.5491848342142, 1134.733337665648, 1138.1407037686658, 1140.247436691796, 18165.81834181641, 18392.26430942747, 18400.723989140442, 18441.72337414913, 18656.34702785396, 40085.599144008185, 44103.558964409945, 44735.328970064824, 44738.3289250668, 46107.0, 55315.72342138264, 60921.39078609157, 61670.69164654327, 62670.37329626645, 63017.36982630299, 8255.174482551696, 8416.663333466593, 8505.362097842562, 8633.69782057625, 8773.254273386834, 10134.898651013396, 13275.336233188495, 13707.794383084061, 13762.587122386345, 14178.858211417753, 11894.821577676516, 11933.0, 12089.274643521418, 12098.153129280865, 12597.370131493572, 11862.22895511789, 12007.699807504881, 12045.277283363026, 12117.75764484723, 12392.31842248685, 12164.695882602651, 12488.188267762567, 12504.624861254177, 12563.874361256636, 13131.540396086091, 7676.424268179797, 7919.16848730898, 8181.754547363588, 8254.711085112232, 8260.380471464545, 9417.434953902788, 12317.692057698629, 12320.199187052813, 12351.505939762308, 12361.0], "value": 10533.310467842328, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.587955372496, 1518.0057062623982, 1679.7396403557452, 1814.4465937888956, 1829.268292682926, 8238.134995825441, 8643.13568643137, 8970.102989701027, 9535.856962145564, 9572.569234384451, 8863.734087977371, 8865.512396818172, 8880.689175878846, 8916.509591972439, 8958.0, 2339.5905716499587, 2369.39580406996, 2385.689860318165, 2386.069432921162, 2393.3179043972473, 2330.82518811089, 2376.3821406434363, 2422.842515236513, 2426.963595546068, 2432.0, 2384.1059602649007, 2395.3891757601873, 2396.1373905394044, 2422.442838147227, 2431.6960379952507, 2289.278877153691, 2292.151903795598, 2313.90744370225, 2333.3233362324904, 2394.736578976311, 2374.2402431222017, 2374.8100151987974, 2382.988085059581, 2400.615901455759, 2411.3007227903886, 8962.32782541312, 9002.549872506414, 9032.14194651507, 9052.321075919332, 9061.50161741104, 5316.494932981361, 5356.54469370104, 5404.3784964728775, 5405.27028851104, 5423.674579525241, 3302.190963214004, 3355.882544110969, 3380.8309584520675, 3396.2698019925588, 3451.861925522976, 1086.0605576176629, 1205.1323047405854, 1205.2166092040156, 1214.8602910665297, 1215.0826126274605, 12938.676533086747, 13004.804927926089, 13030.218186908816, 13036.21782693032, 13081.86918130816, 4609.7695115244105, 4653.115907977473, 4728.0, 4744.7390393528685, 4753.952460475421, 10871.293365931348, 10889.891101088888, 10898.128149748001, 10899.1280697544, 10909.618163364403, 5390.649607775482, 5400.054990376669, 5419.430959749248, 5435.402105768362, 5446.1558458439, 4366.563343665608, 4864.17309057454, 4869.440014398318, 4987.301777751118, 5032.47159048302, 4116.176764647083, 4120.134771697917, 4134.359174327984, 4137.54487006429, 4191.874243772691, 1278.6675464379143, 1298.4741179822188, 1303.7588046211292, 1308.4962289518414, 1318.5846458365584, 968.4286271100085, 984.6849008317413, 999.7550600103021, 1012.9493525323704, 1019.4189312092185, 5881.529477641779, 6222.595531290452, 6250.874982500324, 6278.6860656966965, 6415.26224484181, 453.4128303846527, 454.21420941770924, 467.7778055423715, 468.59232467752594, 471.8820294926268, 4184.497860256728, 4264.978675106605, 4298.333758267474, 4300.978495107504, 4318.5681431856565, 11589.6523104307, 11766.88233117675, 11990.460429280703, 12040.698982525508, 12073.33596652175, 11726.413679316, 11796.52813887452, 11813.527458901548, 11831.112666550043, 11851.348175850411, 8419.200175983271, 8793.164649358301, 8793.868091978626, 8976.057513961201, 9001.954990225007, 6103.389661034039, 6278.0, 6389.808305750835, 6396.584222025554, 6421.8073457796345, 10469.424181669776, 10802.405867677353, 10805.189610779065, 11002.669919902415, 11024.173187011167, 10955.068819150461, 11144.832827507757, 11161.441927903736, 11201.775964480828, 11300.886991130312, 7568.848623027398, 8124.715634952749, 8193.959030204811, 8323.542205178774, 8368.163183681827, 9307.906920930704, 9332.440053596805, 9367.672131475365, 9383.0, 9432.811343773223, 8061.234182752629, 8248.54632995167, 8472.110428404929, 8490.872636910575, 8597.140285971604, 8042.3968202383885, 8104.594770261346, 8301.667933282843, 8360.790980225544, 8393.664253429795, 7086.220515743367, 7432.665530051053, 7485.251474852471, 7486.213947535648, 7676.80807979805, 5051.4695956924, 5110.4123025852505, 5132.871678208075, 5147.5881929446305, 5251.973740131275, 5183.714895680774, 5237.6333656643665, 5245.763940622757, 5249.422563517934, 5298.523132918056], "value": 4747.051504106254, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.7039357333413, 364.8905328401479, 366.32047551791425, 369.6359086299994, 372.91795804922907, 5052.595792336613, 5109.6167787416, 5264.789408423659, 5316.149416093426, 5320.334958130234, 5107.974460127703, 5144.614153938451, 5158.535731784139, 5199.142141546649, 5200.4019537753165, 4166.604172603597, 4187.790610469479, 4208.852690155845, 4225.647792706335, 4232.957670423287, 3970.4838371011874, 4195.559466256045, 4223.0, 4244.724092933965, 4245.915081698364, 4111.342185250361, 4141.917161656765, 4167.729097608661, 4172.895677608054, 4185.476815398075, 4141.772202528859, 4164.12553363794, 4171.290880550314, 4200.243956087903, 4208.410822484854, 3734.290484807878, 3761.322961866863, 3762.322781899257, 3763.9435408468894, 3769.133099387129, 4835.153848076608, 4944.53026962438, 4951.331570238044, 4958.231474121517, 4978.5270399312, 4692.7653617319, 4704.811807527695, 4717.150912835688, 4739.218029025206, 4751.40607424072, 5378.731063446851, 5401.756920938567, 5428.972855135738, 5451.182322651594, 5458.781648734046, 3790.77255364679, 4022.9597704022876, 4024.8188831502653, 4028.2144981728575, 4035.8183881725395, 5532.446755324476, 5589.496945274945, 5590.664560126405, 5658.122990936411, 5659.773609055633, 4092.3861420786525, 4119.281274358908, 4127.731697439657, 4127.814248358831, 4134.1731653668785, 3972.682185425159, 4120.979395103065, 4159.334506478949, 4173.040200753843, 4212.620864122244, 4619.353290539327, 4640.559146881041, 4678.485366609671, 4689.62483001359, 4697.95302046982, 5200.479952004845, 5447.210154527651, 5452.454754524595, 5464.23500709901, 5467.72661366938, 1392.3943084758162, 1412.25150670145, 1418.89358298126, 1420.353739048751, 1424.302091974925, 925.4909799610188, 931.7391130483476, 947.5735918836414, 948.1750876737283, 968.2544440780559, 4772.403449568804, 4811.171754733179, 4864.829730959399, 4884.948321704893, 4889.877753056131, 4965.503449655005, 4966.304717339575, 5009.423916249605, 5025.773840177128, 5050.595952323805, 4646.79089440976, 4718.0, 4822.3464356895765, 4826.903461930812, 4880.804767809248, 2656.990343669393, 2657.707652158261, 2673.5722284434396, 2675.9464810703676, 2701.5002224588516, 5151.356080489939, 5238.5023422774775, 5264.263003179558, 5295.788168473295, 5308.23030660552, 4992.675476094042, 4997.950020499821, 5031.33965791288, 5308.487081181845, 5750.856228594319, 5921.437463440966, 5924.407559244041, 5934.317553481319, 5950.583459157818, 5951.732172052268, 5584.492187109539, 5601.495865372136, 5608.327000759935, 5619.129034999582, 5632.0, 5452.727363631882, 5507.394186639546, 5555.833325000256, 5557.472040156179, 5569.721513924369, 5868.295804503487, 5888.4700376964565, 5913.822585322448, 5928.4960778334325, 5935.436133567477, 4044.2922488563795, 4153.646940010133, 4171.728837625545, 4189.706720529533, 4198.979005104955, 5512.80705175317, 5571.582131340085, 5584.291618564912, 5618.269624948731, 5649.47464184676, 5518.641288316247, 5522.30971128609, 5525.226468294361, 5531.197976293495, 5561.610687251854, 5521.751521181476, 5524.171374293888, 5527.530159936289, 5528.944710552843, 5529.778808847601, 5123.538881500683, 5431.293931788842, 5436.184572314184, 5446.863828404163, 5447.155690867922, 5437.429069947757, 5484.149956756709, 5492.1212605982855, 5515.862103447446, 5531.483175155215, 5137.9486205138965, 5379.4082650907585, 5381.892362152813, 5387.138057910715, 5437.293151890229], "value": 4156.84861181137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.1027446163679, 646.3245908026114, 652.4714980865499, 659.7855696898506, 703.2615753458867, 13596.728065438698, 14332.211728354936, 14344.497942572, 14369.784453233184, 14525.62006609373, 14270.785938210935, 14453.349599268033, 14460.349284282207, 14468.05957612757, 14476.855231447682, 819.0744458761591, 834.3408707121367, 847.5804476783969, 849.0660273698943, 851.0298259983624, 836.7657056024292, 837.8659414493683, 843.2495079379357, 846.699421705295, 847.1867007672611, 891.750309913222, 895.1898531828673, 897.0267260022883, 897.1253028297423, 898.6809682562695, 886.6497733395337, 891.3804905590617, 891.5497673674785, 893.5621545442687, 894.0433735902554, 650.1742786660961, 650.8958566629317, 653.5784419049686, 653.6960313454266, 656.3338211715113, 14599.562013139517, 14755.262236888113, 14762.261886905719, 14786.704265914621, 14799.630009249748, 12959.0, 12978.221306721533, 13026.348682565835, 13440.86559134406, 14202.92898535511, 11817.290962542274, 12143.635690929286, 12227.633171004883, 12237.082218833533, 12660.68348291291, 3871.9419208711893, 3949.940750888739, 3955.2287303975736, 4037.8788636340664, 4083.7549747014978, 78030.0, 78592.21407785905, 79755.0, 80540.59729701372, 80844.0, 10579.62971296001, 10607.94696026515, 10782.353058816496, 10802.297850639683, 10944.288621239753, 19405.32081377145, 20223.191072357236, 20228.69656955147, 20246.291379801638, 20262.088206030763, 8643.567821608895, 8811.030786613468, 8961.0, 9012.41419307743, 9035.322350823715, 4728.148933192058, 4836.226203807374, 4859.3682821233015, 4868.805247790048, 4874.610031197496, 3306.454435018243, 3411.4200585900458, 3417.3677869594203, 3423.3153369325737, 3463.9826800865835, 587.7296443635976, 610.8869859076085, 611.1413464082971, 615.9692015399212, 615.9876802463925, 733.8495608400265, 741.4439170622034, 750.2497502497503, 755.1466842467976, 760.9315161635369, 9401.0, 9955.601775928882, 10119.797604047877, 10163.339382940234, 10179.236557258235, 633.1452539072216, 635.1774452084561, 655.5968079630993, 710.2152121905324, 719.086759815032, 4497.865064048084, 4587.931181032287, 4726.976365118221, 4741.83403580873, 4802.255650374198, 74213.0, 79626.20373796303, 102731.4863425693, 115951.0, 117763.0, 70169.64915175391, 100695.49652251691, 103655.4817225909, 103707.0, 104716.0, 86239.0, 86831.56584217038, 88199.0, 88839.55580222186, 90245.09754902367, 9288.0, 9376.390534615228, 9588.904110958802, 9636.373635713657, 9660.257048918887, 52053.7397313011, 52667.73666131645, 53312.73343633257, 53533.73233133809, 54099.459005411016, 73654.0, 75255.0, 76945.0, 77284.0, 77324.0, 11873.406329683654, 12013.879861201276, 12089.75820483603, 12184.51261949512, 12364.752704946031, 13446.0, 13478.74022818778, 13486.258255796025, 13537.323133843072, 13685.863141368856, 12688.365581721062, 12734.808977865525, 12742.936285318514, 12839.807402889151, 12925.54760583375, 12599.748005039664, 12734.172278801849, 12745.17156384832, 12781.16922400041, 12905.806412903627, 12671.556495522613, 12826.0, 12843.100982931479, 13044.217346959213, 13074.673133171747, 10161.79676406453, 10171.54228059754, 10406.895931040895, 10568.207384446043, 10847.945760271148, 9996.900030999888, 10174.23693223026, 10212.0, 10264.178865690876, 10283.228757843042], "value": 7405.708318382142, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 111.0, 111.0, 111.0, 108.0, 110.0, 108.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 153.0, 175.0, 128.0, 155.0, 148.0, 138.0, 186.0, 128.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 163.0, 160.0, 163.0, 159.0, 161.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 181.0, 76.0, 75.0, 74.0, 76.0, 159.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 142.0, 84.0, 85.0, 86.0, 145.0, 85.0, 85.0, 154.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 95.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 58.0, 65.0, 62.0, 58.0, 58.0, 60.0, 58.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 79.0, 78.0, 83.0, 78.0, 78.0, 102.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 122.0, 134.0, 119.0, 133.0, 127.0, 124.0, 135.0, 137.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 161.0, 157.0, 157.0, 166.0, 155.0, 154.0, 154.0, 155.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 64.0, 62.0, 63.0, 61.0, 62.0, 60.0], "value": 62.4, "unit": "score"}]}]} 19:15:59 INFO - Return code: 0 19:15:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:15:59 ERROR - # TBPL SUCCESS # 19:15:59 INFO - Running post-action listener: _resource_record_post_action 19:15:59 INFO - ##### 19:15:59 INFO - ##### Finished run-tests step (success) 19:15:59 INFO - ##### 19:15:59 INFO - Running post-run listener: _resource_record_post_run 19:15:59 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 299008; Write bytes: 504115200; Read time: 52; Write time: 367136 19:15:59 INFO - TinderboxPrint: CPU usage
13.4% 19:15:59 INFO - TinderboxPrint: I/O read bytes / time
299,008 / 52 19:15:59 INFO - TinderboxPrint: I/O write bytes / time
504,115,200 / 367,136 19:15:59 INFO - TinderboxPrint: CPU idle
8,203.8 (86.6%) 19:15:59 INFO - TinderboxPrint: CPU user
1,211.2 (12.8%) 19:15:59 INFO - TinderboxPrint: Swap in / out
0 / 0 19:15:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244588544; Read time: 0; Write time: 224468 19:15:59 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 299008; Write bytes: 252669952; Read time: 52; Write time: 142016 19:16:00 INFO - Running post-run listener: _upload_blobber_files 19:16:00 INFO - Blob upload gear active. 19:16:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:16:00 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 19:16:00 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:16:00 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:16:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:16:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:16:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:04 INFO - (blobuploader) - INFO - Done attempting. 19:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:04 INFO - (blobuploader) - INFO - Done attempting. 19:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:05 INFO - (blobuploader) - INFO - Done attempting. 19:16:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:16:05 INFO - Return code: 0 19:16:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:16:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:16:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e5d5af0a0d8654e8c13abc2d038ca94fb1f33609a5ee94ee7b4e83e741f3926c498189febca745c450147f7731f1ea90cfdd682a32415cefded80b88b197ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/331736cb527d7092c14a4509cd255ed9d366139330a7020e3aa072dbb6f01ed4f46f7253691dbd4a4f4714291b9a46501ac2398e2154122c94a69a2a0efbf4c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b36ed65f0790da12ee4006c446462bc14544624acc192b918be909104cd6df6aeae83a6569d6af23420b90219ae063b3d913188cb2a81bdcfee0869b04d786ca"} 19:16:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:16:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:16:05 INFO - Contents: 19:16:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e5d5af0a0d8654e8c13abc2d038ca94fb1f33609a5ee94ee7b4e83e741f3926c498189febca745c450147f7731f1ea90cfdd682a32415cefded80b88b197ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/331736cb527d7092c14a4509cd255ed9d366139330a7020e3aa072dbb6f01ed4f46f7253691dbd4a4f4714291b9a46501ac2398e2154122c94a69a2a0efbf4c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b36ed65f0790da12ee4006c446462bc14544624acc192b918be909104cd6df6aeae83a6569d6af23420b90219ae063b3d913188cb2a81bdcfee0869b04d786ca"} 19:16:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:16:05 INFO - Copying logs to upload dir... 19:16:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:16:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.139362 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-12 19:16:05.784411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:16:05.787513) ========= 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=1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e5d5af0a0d8654e8c13abc2d038ca94fb1f33609a5ee94ee7b4e83e741f3926c498189febca745c450147f7731f1ea90cfdd682a32415cefded80b88b197ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/331736cb527d7092c14a4509cd255ed9d366139330a7020e3aa072dbb6f01ed4f46f7253691dbd4a4f4714291b9a46501ac2398e2154122c94a69a2a0efbf4c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b36ed65f0790da12ee4006c446462bc14544624acc192b918be909104cd6df6aeae83a6569d6af23420b90219ae063b3d913188cb2a81bdcfee0869b04d786ca"} build_url:https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/Nn3JUOTFQjyO9V21Tv3zsA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82e5d5af0a0d8654e8c13abc2d038ca94fb1f33609a5ee94ee7b4e83e741f3926c498189febca745c450147f7731f1ea90cfdd682a32415cefded80b88b197ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/331736cb527d7092c14a4509cd255ed9d366139330a7020e3aa072dbb6f01ed4f46f7253691dbd4a4f4714291b9a46501ac2398e2154122c94a69a2a0efbf4c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b36ed65f0790da12ee4006c446462bc14544624acc192b918be909104cd6df6aeae83a6569d6af23420b90219ae063b3d913188cb2a81bdcfee0869b04d786ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 19:16:05.813302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:16:05.813700) ========= 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=1f5564757af27664ca02d71f000001b0-1468374782.888171-181528489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 19:16:05.899260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:16:05.899661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 19:16:05.900010) ========= ========= Total master_lag: 0.18 =========