builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1467092313.0 results: success (0) buildid: 20160627193059 builduid: a0049d866ef34702b10d0c6e3b2f3f51 revision: ff3138a7b682cb02dae61c0dca0f327886c57e84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.002322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.002773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.003213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.049989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.050348) ========= 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=62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 22:38:33-- 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% 42.7M=0s 2016-06-27 22:38:33 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072738 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.147738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.148108) ========= 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=62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014166 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:33.209401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 22:38:33.209901) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ff3138a7b682cb02dae61c0dca0f327886c57e84 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ff3138a7b682cb02dae61c0dca0f327886c57e84 --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=62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 22:38:33,532 truncating revision to first 12 chars 2016-06-27 22:38:33,532 Setting DEBUG logging. 2016-06-27 22:38:33,532 attempt 1/10 2016-06-27 22:38:33,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ff3138a7b682?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 22:38:34,994 unpacking tar archive at: mozilla-inbound-ff3138a7b682/testing/mozharness/ program finished with exit code 0 elapsedTime=1.807703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 22:38:35.033405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:35.033755) ========= script_repo_revision: ff3138a7b682cb02dae61c0dca0f327886c57e84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:35.034236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:35.034542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 22:38:35.045444) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 22:38:35.045756) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:38:35 INFO - MultiFileLogger online at 20160627 22:38:35 in /builds/slave/test 22:38:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:38:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:38:35 INFO - {'append_to_log': False, 22:38:35 INFO - 'base_work_dir': '/builds/slave/test', 22:38:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:38:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:38:35 INFO - 'branch': 'Mozilla-Inbound', 22:38:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:38:35 INFO - 'config_files': ('talos/linux_config.py',), 22:38:35 INFO - 'default_actions': ('clobber', 22:38:35 INFO - 'read-buildbot-config', 22:38:35 INFO - 'download-and-extract', 22:38:35 INFO - 'populate-webroot', 22:38:35 INFO - 'create-virtualenv', 22:38:35 INFO - 'install', 22:38:35 INFO - 'run-tests'), 22:38:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:38:35 INFO - 'download_minidump_stackwalk': True, 22:38:35 INFO - 'download_symbols': 'ondemand', 22:38:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:38:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:38:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:38:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:38:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:38:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:38:35 INFO - 'installer_path': 'installer.exe', 22:38:35 INFO - 'log_level': 'info', 22:38:35 INFO - 'log_name': 'talos', 22:38:35 INFO - 'log_to_console': True, 22:38:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:38:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:38:35 INFO - 'opt_config_files': (), 22:38:35 INFO - 'pip_index': False, 22:38:35 INFO - 'sps_profile': False, 22:38:35 INFO - 'sps_profile_interval': 0, 22:38:35 INFO - 'suite': 'dromaeojs-e10s', 22:38:35 INFO - 'system_bits': '32', 22:38:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:38:35 INFO - 'title': 'talos-linux64-ix-018', 22:38:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:38:35 INFO - 'use_talos_json': True, 22:38:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:38:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:38:35 INFO - 'work_dir': 'build'} 22:38:35 INFO - ##### 22:38:35 INFO - ##### Running clobber step. 22:38:35 INFO - ##### 22:38:35 INFO - Running pre-action listener: _resource_record_pre_action 22:38:35 INFO - Running main action method: clobber 22:38:35 INFO - rmtree: /builds/slave/test/build 22:38:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:38:35 INFO - Running post-action listener: _resource_record_post_action 22:38:35 INFO - ##### 22:38:35 INFO - ##### Finished clobber step (success) 22:38:35 INFO - ##### 22:38:35 INFO - ##### 22:38:35 INFO - ##### Running read-buildbot-config step. 22:38:35 INFO - ##### 22:38:35 INFO - Running pre-action listener: _resource_record_pre_action 22:38:35 INFO - Running main action method: read_buildbot_config 22:38:35 INFO - Using buildbot properties: 22:38:35 INFO - { 22:38:35 INFO - "project": "", 22:38:35 INFO - "product": "firefox", 22:38:35 INFO - "script_repo_revision": "production", 22:38:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:38:35 INFO - "repository": "", 22:38:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:38:35 INFO - "buildid": "20160627193059", 22:38:35 INFO - "pgo_build": "True", 22:38:35 INFO - "basedir": "/builds/slave/test", 22:38:35 INFO - "buildnumber": 1226, 22:38:35 INFO - "slavename": "talos-linux64-ix-018", 22:38:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:38:35 INFO - "platform": "ubuntu64_hw", 22:38:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:38:35 INFO - "branch": "mozilla-inbound", 22:38:35 INFO - "repo_path": "integration/mozilla-inbound", 22:38:35 INFO - "revision": "ff3138a7b682cb02dae61c0dca0f327886c57e84", 22:38:35 INFO - "stage_platform": "linux64-pgo", 22:38:35 INFO - "builduid": "a0049d866ef34702b10d0c6e3b2f3f51", 22:38:35 INFO - "slavebuilddir": "test" 22:38:35 INFO - } 22:38:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:38:35 INFO - Running post-action listener: _resource_record_post_action 22:38:35 INFO - ##### 22:38:35 INFO - ##### Finished read-buildbot-config step (success) 22:38:35 INFO - ##### 22:38:35 INFO - ##### 22:38:35 INFO - ##### Running download-and-extract step. 22:38:35 INFO - ##### 22:38:35 INFO - Running pre-action listener: _resource_record_pre_action 22:38:35 INFO - Running main action method: download_and_extract 22:38:35 INFO - mkdir: /builds/slave/test/build/tests 22:38:35 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')]} 22:38:35 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:38:37 INFO - Downloaded 1361 bytes. 22:38:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:38:37 INFO - Using the following test package requirements: 22:38:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:38:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:38:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:38:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'jsshell-linux-x86_64.zip'], 22:38:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:38:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:38:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:38:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:38:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:38:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:38:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:38:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:38:37 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')]} 22:38:37 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:38:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:38:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:38:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:38:38 INFO - Downloaded 24282915 bytes. 22:38:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:38:39 INFO - Return code: 0 22:38:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:38:39 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')]} 22:38:39 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:38:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:38:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:38:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:38:47 INFO - Downloaded 24282915 bytes. 22:38:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:38:48 INFO - Return code: 0 22:38:48 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')]} 22:38:48 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:38:50 INFO - Downloaded 14405240 bytes. 22:38:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:38:50 INFO - Return code: 0 22:38:50 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')]} 22:38:50 INFO - https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:38:51 INFO - Downloaded 60297917 bytes. 22:38:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:38:51 INFO - mkdir: /builds/slave/test/properties 22:38:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:38:51 INFO - Writing to file /builds/slave/test/properties/build_url 22:38:51 INFO - Contents: 22:38:51 INFO - build_url:https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:38:52 INFO - Running post-action listener: _resource_record_post_action 22:38:52 INFO - Running post-action listener: set_extra_try_arguments 22:38:52 INFO - ##### 22:38:52 INFO - ##### Finished download-and-extract step (success) 22:38:52 INFO - ##### 22:38:52 INFO - ##### 22:38:52 INFO - ##### Running populate-webroot step. 22:38:52 INFO - ##### 22:38:52 INFO - Running pre-action listener: _resource_record_pre_action 22:38:52 INFO - Running main action method: populate_webroot 22:38:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:38:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:38:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:38:52 INFO - '--tppagecycles', 22:38:52 INFO - '7'], 22:38:52 INFO - 'tests': ['tsvgm']}}, 22:38:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:38:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:38:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:38:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:38:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['damp', 'tps']}, 22:38:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'tests': ['damp', 'tps']}, 22:38:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['dromaeo_dom']}, 22:38:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:38:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['basic_compositor_video']}, 22:38:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:38:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['a11yr', 22:38:52 INFO - 'ts_paint', 22:38:52 INFO - 'tpaint', 22:38:52 INFO - 'sessionrestore', 22:38:52 INFO - 'sessionrestore_no_auto_restore', 22:38:52 INFO - 'tabpaint']}, 22:38:52 INFO - 'other-e10s': {'tests': ['a11yr', 22:38:52 INFO - 'ts_paint', 22:38:52 INFO - 'tpaint', 22:38:52 INFO - 'sessionrestore', 22:38:52 INFO - 'sessionrestore_no_auto_restore', 22:38:52 INFO - 'tabpaint']}, 22:38:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:38:52 INFO - 'ts_paint', 22:38:52 INFO - 'tpaint', 22:38:52 INFO - 'sessionrestore', 22:38:52 INFO - 'sessionrestore_no_auto_restore', 22:38:52 INFO - 'tabpaint']}, 22:38:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:38:52 INFO - 'ts_paint', 22:38:52 INFO - 'tpaint', 22:38:52 INFO - 'sessionrestore', 22:38:52 INFO - 'sessionrestore_no_auto_restore', 22:38:52 INFO - 'tabpaint']}, 22:38:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['a11yr', 22:38:52 INFO - 'ts_paint', 22:38:52 INFO - 'tpaint', 22:38:52 INFO - 'sessionrestore', 22:38:52 INFO - 'sessionrestore_no_auto_restore', 22:38:52 INFO - 'tabpaint']}, 22:38:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['a11yr', 22:38:52 INFO - 'ts_paint', 22:38:52 INFO - 'tpaint', 22:38:52 INFO - 'sessionrestore', 22:38:52 INFO - 'sessionrestore_no_auto_restore', 22:38:52 INFO - 'tabpaint']}, 22:38:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['tsvgx', 22:38:52 INFO - 'tsvgr_opacity', 22:38:52 INFO - 'tart', 22:38:52 INFO - 'tscrollx', 22:38:52 INFO - 'cart']}, 22:38:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:38:52 INFO - 'tsvgr_opacity', 22:38:52 INFO - 'tart', 22:38:52 INFO - 'tscrollx', 22:38:52 INFO - 'cart']}, 22:38:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'talos_options': ['--disable-e10s'], 22:38:52 INFO - 'tests': ['tp5o']}, 22:38:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'tests': ['tp5o']}, 22:38:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'talos_options': ['--disable-e10s', 22:38:52 INFO - '--xperf_path', 22:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:52 INFO - 'tests': ['tp5n']}, 22:38:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:52 INFO - 'talos_options': ['--xperf_path', 22:38:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:52 INFO - 'tests': ['tp5n']}}, 22:38:52 INFO - 'talos.zip': {'path': '', 22:38:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:38:52 INFO - Running post-action listener: _resource_record_post_action 22:38:52 INFO - ##### 22:38:52 INFO - ##### Finished populate-webroot step (success) 22:38:52 INFO - ##### 22:38:52 INFO - ##### 22:38:52 INFO - ##### Running create-virtualenv step. 22:38:52 INFO - ##### 22:38:52 INFO - Running pre-action listener: _resource_record_pre_action 22:38:52 INFO - Running main action method: create_virtualenv 22:38:52 INFO - Creating virtualenv /builds/slave/test/build/venv 22:38:52 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 22:38:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:38:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:38:52 INFO - Using real prefix '/usr' 22:38:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:38:53 INFO - Installing distribute.............................................................................................................................................................................................done. 22:38:55 INFO - Installing pip.................done. 22:38:55 INFO - Return code: 0 22:38:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:38:55 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')]} 22:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 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')]} 22:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:38:55 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 22:38:55 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 22:38:55 INFO - Using env: {'DISPLAY': ':0', 22:38:55 INFO - 'HOME': '/home/cltbld', 22:38:55 INFO - 'LANG': 'en_US.UTF-8', 22:38:55 INFO - 'LANGUAGE': 'en_US:en', 22:38:55 INFO - 'LOGNAME': 'cltbld', 22:38:55 INFO - 'MAIL': '/var/mail/cltbld', 22:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:55 INFO - 'MOZ_NO_REMOTE': '1', 22:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:55 INFO - 'NO_EM_RESTART': '1', 22:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:55 INFO - 'PWD': '/builds/slave/test', 22:38:55 INFO - 'SHELL': '/bin/bash', 22:38:55 INFO - 'SHLVL': '1', 22:38:55 INFO - 'TERM': 'linux', 22:38:55 INFO - 'TMOUT': '86400', 22:38:55 INFO - 'USER': 'cltbld', 22:38:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:55 INFO - '_': '/tools/buildbot/bin/python'} 22:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:55 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 22:38:55 INFO - Cleaning up... 22:38:55 INFO - Return code: 0 22:38:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:38:55 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')]} 22:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 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')]} 22:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:38:55 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 22:38:55 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 22:38:55 INFO - Using env: {'DISPLAY': ':0', 22:38:55 INFO - 'HOME': '/home/cltbld', 22:38:55 INFO - 'LANG': 'en_US.UTF-8', 22:38:55 INFO - 'LANGUAGE': 'en_US:en', 22:38:55 INFO - 'LOGNAME': 'cltbld', 22:38:55 INFO - 'MAIL': '/var/mail/cltbld', 22:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:55 INFO - 'MOZ_NO_REMOTE': '1', 22:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:55 INFO - 'NO_EM_RESTART': '1', 22:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:55 INFO - 'PWD': '/builds/slave/test', 22:38:55 INFO - 'SHELL': '/bin/bash', 22:38:55 INFO - 'SHLVL': '1', 22:38:55 INFO - 'TERM': 'linux', 22:38:55 INFO - 'TMOUT': '86400', 22:38:55 INFO - 'USER': 'cltbld', 22:38:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:55 INFO - '_': '/tools/buildbot/bin/python'} 22:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:55 INFO - Downloading/unpacking psutil>=3.1.1 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:38:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:57 INFO - Installing collected packages: psutil 22:38:57 INFO - Running setup.py install for psutil 22:38:57 INFO - building 'psutil._psutil_linux' extension 22:38:57 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 22:38:57 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 22:38:57 INFO - building 'psutil._psutil_posix' extension 22:38:57 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 22:38:58 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 22:38:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:58 INFO - Successfully installed psutil 22:38:58 INFO - Cleaning up... 22:38:58 INFO - Return code: 0 22:38:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:38:58 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')]} 22:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:58 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')]} 22:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:58 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:38:58 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 22:38:58 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 22:38:58 INFO - Using env: {'DISPLAY': ':0', 22:38:58 INFO - 'HOME': '/home/cltbld', 22:38:58 INFO - 'LANG': 'en_US.UTF-8', 22:38:58 INFO - 'LANGUAGE': 'en_US:en', 22:38:58 INFO - 'LOGNAME': 'cltbld', 22:38:58 INFO - 'MAIL': '/var/mail/cltbld', 22:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:58 INFO - 'MOZ_NO_REMOTE': '1', 22:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:58 INFO - 'NO_EM_RESTART': '1', 22:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:58 INFO - 'PWD': '/builds/slave/test', 22:38:58 INFO - 'SHELL': '/bin/bash', 22:38:58 INFO - 'SHLVL': '1', 22:38:58 INFO - 'TERM': 'linux', 22:38:58 INFO - 'TMOUT': '86400', 22:38:58 INFO - 'USER': 'cltbld', 22:38:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:58 INFO - '_': '/tools/buildbot/bin/python'} 22:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:38:58 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 22:38:58 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 22:38:58 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 22:38:58 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 22:38:58 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 22:38:58 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 22:39:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:39:00 INFO - Installing collected packages: mozsystemmonitor 22:39:00 INFO - Running setup.py install for mozsystemmonitor 22:39:00 INFO - Successfully installed mozsystemmonitor 22:39:00 INFO - Cleaning up... 22:39:00 INFO - Return code: 0 22:39:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:39:00 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')]} 22:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:00 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')]} 22:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:00 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:00 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 22:39:00 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 22:39:00 INFO - Using env: {'DISPLAY': ':0', 22:39:00 INFO - 'HOME': '/home/cltbld', 22:39:00 INFO - 'LANG': 'en_US.UTF-8', 22:39:00 INFO - 'LANGUAGE': 'en_US:en', 22:39:00 INFO - 'LOGNAME': 'cltbld', 22:39:00 INFO - 'MAIL': '/var/mail/cltbld', 22:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:00 INFO - 'MOZ_NO_REMOTE': '1', 22:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:00 INFO - 'NO_EM_RESTART': '1', 22:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:00 INFO - 'PWD': '/builds/slave/test', 22:39:00 INFO - 'SHELL': '/bin/bash', 22:39:00 INFO - 'SHLVL': '1', 22:39:00 INFO - 'TERM': 'linux', 22:39:00 INFO - 'TMOUT': '86400', 22:39:00 INFO - 'USER': 'cltbld', 22:39:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:00 INFO - '_': '/tools/buildbot/bin/python'} 22:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:00 INFO - Downloading/unpacking jsonschema==2.5.1 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:39:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:39:02 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 22:39:02 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 22:39:02 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 22:39:02 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 22:39:02 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 22:39:02 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 22:39:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:39:02 INFO - warning: no files found matching '*.txt' 22:39:02 INFO - no previously-included directories found matching 'build' 22:39:02 INFO - no previously-included directories found matching 'dist' 22:39:02 INFO - no previously-included directories found matching '.git*' 22:39:02 INFO - Installing collected packages: jsonschema, functools32 22:39:02 INFO - Running setup.py install for functools32 22:39:03 INFO - warning: no files found matching '*.txt' 22:39:03 INFO - no previously-included directories found matching 'build' 22:39:03 INFO - no previously-included directories found matching 'dist' 22:39:03 INFO - no previously-included directories found matching '.git*' 22:39:03 INFO - Successfully installed jsonschema functools32 22:39:03 INFO - Cleaning up... 22:39:03 INFO - Return code: 0 22:39:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:39:03 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')]} 22:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:03 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')]} 22:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:03 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:03 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 22:39:03 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 22:39:03 INFO - Using env: {'DISPLAY': ':0', 22:39:03 INFO - 'HOME': '/home/cltbld', 22:39:03 INFO - 'LANG': 'en_US.UTF-8', 22:39:03 INFO - 'LANGUAGE': 'en_US:en', 22:39:03 INFO - 'LOGNAME': 'cltbld', 22:39:03 INFO - 'MAIL': '/var/mail/cltbld', 22:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:03 INFO - 'MOZ_NO_REMOTE': '1', 22:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:03 INFO - 'NO_EM_RESTART': '1', 22:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:03 INFO - 'PWD': '/builds/slave/test', 22:39:03 INFO - 'SHELL': '/bin/bash', 22:39:03 INFO - 'SHLVL': '1', 22:39:03 INFO - 'TERM': 'linux', 22:39:03 INFO - 'TMOUT': '86400', 22:39:03 INFO - 'USER': 'cltbld', 22:39:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:03 INFO - '_': '/tools/buildbot/bin/python'} 22:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:03 INFO - Downloading/unpacking blobuploader==1.2.4 22:39:03 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 22:39:03 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 22:39:03 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 22:39:03 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 22:39:03 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 22:39:03 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 22:39:05 INFO - Downloading blobuploader-1.2.4.tar.gz 22:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:39:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:39:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:05 INFO - Downloading docopt-0.6.1.tar.gz 22:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:39:05 INFO - Installing collected packages: blobuploader, requests, docopt 22:39:05 INFO - Running setup.py install for blobuploader 22:39:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:39:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:39:06 INFO - Running setup.py install for requests 22:39:06 INFO - Running setup.py install for docopt 22:39:06 INFO - Successfully installed blobuploader requests docopt 22:39:06 INFO - Cleaning up... 22:39:06 INFO - Return code: 0 22:39:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:06 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')]} 22:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:06 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')]} 22:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:06 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:06 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 22:39:06 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 22:39:06 INFO - Using env: {'DISPLAY': ':0', 22:39:06 INFO - 'HOME': '/home/cltbld', 22:39:06 INFO - 'LANG': 'en_US.UTF-8', 22:39:06 INFO - 'LANGUAGE': 'en_US:en', 22:39:06 INFO - 'LOGNAME': 'cltbld', 22:39:06 INFO - 'MAIL': '/var/mail/cltbld', 22:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:06 INFO - 'MOZ_NO_REMOTE': '1', 22:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:06 INFO - 'NO_EM_RESTART': '1', 22:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:06 INFO - 'PWD': '/builds/slave/test', 22:39:06 INFO - 'SHELL': '/bin/bash', 22:39:06 INFO - 'SHLVL': '1', 22:39:06 INFO - 'TERM': 'linux', 22:39:06 INFO - 'TMOUT': '86400', 22:39:06 INFO - 'USER': 'cltbld', 22:39:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:06 INFO - '_': '/tools/buildbot/bin/python'} 22:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:06 INFO - Running setup.py (path:/tmp/pip-YqsOx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:06 INFO - Running setup.py (path:/tmp/pip-XKaNMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:06 INFO - Running setup.py (path:/tmp/pip-AU6s2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:07 INFO - Running setup.py (path:/tmp/pip-PwLVdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:07 INFO - Running setup.py (path:/tmp/pip-eugEG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:07 INFO - Running setup.py (path:/tmp/pip-xnWydm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:07 INFO - Running setup.py (path:/tmp/pip-KLddNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:07 INFO - Running setup.py (path:/tmp/pip-Bt3fJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:07 INFO - Running setup.py (path:/tmp/pip-R5THF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:07 INFO - Running setup.py (path:/tmp/pip-GGFEfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:07 INFO - Running setup.py (path:/tmp/pip-HHBJB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:07 INFO - Running setup.py (path:/tmp/pip-cqI54U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:07 INFO - Running setup.py (path:/tmp/pip-268171-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:07 INFO - Running setup.py (path:/tmp/pip-gFdZEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:07 INFO - Running setup.py (path:/tmp/pip-AAE4_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:07 INFO - Running setup.py (path:/tmp/pip-FfcRvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:07 INFO - Running setup.py (path:/tmp/pip-sobUzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:39:08 INFO - Running setup.py install for manifestparser 22:39:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Running setup.py install for mozcrash 22:39:08 INFO - Running setup.py install for mozdebug 22:39:08 INFO - Running setup.py install for mozdevice 22:39:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Running setup.py install for mozfile 22:39:08 INFO - Running setup.py install for mozhttpd 22:39:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Running setup.py install for mozinfo 22:39:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Running setup.py install for mozInstall 22:39:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:39:08 INFO - Running setup.py install for mozleak 22:39:08 INFO - Running setup.py install for mozlog 22:39:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Running setup.py install for moznetwork 22:39:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Running setup.py install for mozprocess 22:39:09 INFO - Running setup.py install for mozprofile 22:39:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Running setup.py install for mozrunner 22:39:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Running setup.py install for mozscreenshot 22:39:09 INFO - Running setup.py install for moztest 22:39:09 INFO - Running setup.py install for mozversion 22:39:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:39:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:39:09 INFO - Cleaning up... 22:39:09 INFO - Return code: 0 22:39:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:09 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')]} 22:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:09 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')]} 22:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:09 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:09 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 22:39:09 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 22:39:09 INFO - Using env: {'DISPLAY': ':0', 22:39:09 INFO - 'HOME': '/home/cltbld', 22:39:09 INFO - 'LANG': 'en_US.UTF-8', 22:39:09 INFO - 'LANGUAGE': 'en_US:en', 22:39:09 INFO - 'LOGNAME': 'cltbld', 22:39:09 INFO - 'MAIL': '/var/mail/cltbld', 22:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:09 INFO - 'MOZ_NO_REMOTE': '1', 22:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:09 INFO - 'NO_EM_RESTART': '1', 22:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:09 INFO - 'PWD': '/builds/slave/test', 22:39:09 INFO - 'SHELL': '/bin/bash', 22:39:09 INFO - 'SHLVL': '1', 22:39:09 INFO - 'TERM': 'linux', 22:39:09 INFO - 'TMOUT': '86400', 22:39:09 INFO - 'USER': 'cltbld', 22:39:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:09 INFO - '_': '/tools/buildbot/bin/python'} 22:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:10 INFO - Running setup.py (path:/tmp/pip-3gsVTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:10 INFO - Running setup.py (path:/tmp/pip-Re8dJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:10 INFO - Running setup.py (path:/tmp/pip-o7nRma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:10 INFO - Running setup.py (path:/tmp/pip-Lq_6ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:10 INFO - Running setup.py (path:/tmp/pip-shwHpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:10 INFO - Running setup.py (path:/tmp/pip-QygmqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:10 INFO - Running setup.py (path:/tmp/pip-9dg3_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:10 INFO - Running setup.py (path:/tmp/pip-twUWjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:10 INFO - Running setup.py (path:/tmp/pip-Sa8tNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:10 INFO - Running setup.py (path:/tmp/pip-La9IQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:10 INFO - Running setup.py (path:/tmp/pip-f5HtDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:10 INFO - Running setup.py (path:/tmp/pip-bu14P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:10 INFO - Running setup.py (path:/tmp/pip-kRPzUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:10 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)) 22:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:10 INFO - Running setup.py (path:/tmp/pip-iTynUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:11 INFO - Running setup.py (path:/tmp/pip-jP9TtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:11 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)) 22:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:11 INFO - Running setup.py (path:/tmp/pip-C0e3yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:11 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)) 22:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:11 INFO - Running setup.py (path:/tmp/pip-mz0312-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:11 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)) 22:39:11 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)) 22:39:11 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)) 22:39:11 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)) 22:39:11 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)) 22:39:11 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)) 22:39:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:13 INFO - Downloading blessings-1.6.tar.gz 22:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:39:13 INFO - Installing collected packages: blessings 22:39:13 INFO - Running setup.py install for blessings 22:39:13 INFO - Successfully installed blessings 22:39:13 INFO - Cleaning up... 22:39:13 INFO - Return code: 0 22:39:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:39:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:13 INFO - Reading from file tmpfile_stdout 22:39:13 INFO - Current package versions: 22:39:13 INFO - argparse == 1.2.1 22:39:13 INFO - blessings == 1.6 22:39:13 INFO - blobuploader == 1.2.4 22:39:13 INFO - docopt == 0.6.1 22:39:13 INFO - functools32 == 3.2.3-2 22:39:13 INFO - jsonschema == 2.5.1 22:39:13 INFO - manifestparser == 1.1 22:39:13 INFO - mozInstall == 1.12 22:39:13 INFO - mozcrash == 0.17 22:39:13 INFO - mozdebug == 0.1 22:39:13 INFO - mozdevice == 0.48 22:39:13 INFO - mozfile == 1.2 22:39:13 INFO - mozhttpd == 0.7 22:39:13 INFO - mozinfo == 0.9 22:39:13 INFO - mozleak == 0.1 22:39:13 INFO - mozlog == 3.2 22:39:13 INFO - moznetwork == 0.27 22:39:13 INFO - mozprocess == 0.22 22:39:13 INFO - mozprofile == 0.28 22:39:13 INFO - mozrunner == 6.11 22:39:13 INFO - mozscreenshot == 0.1 22:39:13 INFO - mozsystemmonitor == 0.3 22:39:13 INFO - moztest == 0.7 22:39:13 INFO - mozversion == 1.4 22:39:13 INFO - psutil == 3.1.1 22:39:13 INFO - requests == 1.2.3 22:39:13 INFO - wsgiref == 0.1.2 22:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:13 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')]} 22:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:13 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')]} 22:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:13 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:13 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 22:39:13 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 22:39:13 INFO - Using env: {'DISPLAY': ':0', 22:39:13 INFO - 'HOME': '/home/cltbld', 22:39:13 INFO - 'LANG': 'en_US.UTF-8', 22:39:13 INFO - 'LANGUAGE': 'en_US:en', 22:39:13 INFO - 'LOGNAME': 'cltbld', 22:39:13 INFO - 'MAIL': '/var/mail/cltbld', 22:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:13 INFO - 'MOZ_NO_REMOTE': '1', 22:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:13 INFO - 'NO_EM_RESTART': '1', 22:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:13 INFO - 'PWD': '/builds/slave/test', 22:39:13 INFO - 'SHELL': '/bin/bash', 22:39:13 INFO - 'SHLVL': '1', 22:39:13 INFO - 'TERM': 'linux', 22:39:13 INFO - 'TMOUT': '86400', 22:39:13 INFO - 'USER': 'cltbld', 22:39:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:13 INFO - '_': '/tools/buildbot/bin/python'} 22:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 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)) 22:39:13 INFO - Cleaning up... 22:39:13 INFO - Return code: 0 22:39:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:39:13 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')]} 22:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:13 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')]} 22:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:13 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:13 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 22:39:13 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 22:39:13 INFO - Using env: {'DISPLAY': ':0', 22:39:13 INFO - 'HOME': '/home/cltbld', 22:39:13 INFO - 'LANG': 'en_US.UTF-8', 22:39:13 INFO - 'LANGUAGE': 'en_US:en', 22:39:13 INFO - 'LOGNAME': 'cltbld', 22:39:13 INFO - 'MAIL': '/var/mail/cltbld', 22:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:13 INFO - 'MOZ_NO_REMOTE': '1', 22:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:13 INFO - 'NO_EM_RESTART': '1', 22:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:13 INFO - 'PWD': '/builds/slave/test', 22:39:13 INFO - 'SHELL': '/bin/bash', 22:39:13 INFO - 'SHLVL': '1', 22:39:13 INFO - 'TERM': 'linux', 22:39:13 INFO - 'TMOUT': '86400', 22:39:13 INFO - 'USER': 'cltbld', 22:39:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:13 INFO - '_': '/tools/buildbot/bin/python'} 22:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:39:14 INFO - Cleaning up... 22:39:14 INFO - Return code: 0 22:39:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:39:14 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')]} 22:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:14 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')]} 22:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:14 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 0x7f2c0b151f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2444480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, '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': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', '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 22:39:14 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 22:39:14 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 22:39:14 INFO - Using env: {'DISPLAY': ':0', 22:39:14 INFO - 'HOME': '/home/cltbld', 22:39:14 INFO - 'LANG': 'en_US.UTF-8', 22:39:14 INFO - 'LANGUAGE': 'en_US:en', 22:39:14 INFO - 'LOGNAME': 'cltbld', 22:39:14 INFO - 'MAIL': '/var/mail/cltbld', 22:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:14 INFO - 'MOZ_NO_REMOTE': '1', 22:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:14 INFO - 'NO_EM_RESTART': '1', 22:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:14 INFO - 'PWD': '/builds/slave/test', 22:39:14 INFO - 'SHELL': '/bin/bash', 22:39:14 INFO - 'SHLVL': '1', 22:39:14 INFO - 'TERM': 'linux', 22:39:14 INFO - 'TMOUT': '86400', 22:39:14 INFO - 'USER': 'cltbld', 22:39:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:14 INFO - '_': '/tools/buildbot/bin/python'} 22:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:14 INFO - Downloading/unpacking flake8 22:39:14 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 22:39:14 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 22:39:14 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 22:39:14 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 22:39:14 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 22:39:14 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 22:39:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:39:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:39:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 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 22:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:39:16 INFO - no previously-included directories found matching 'docs/_build' 22:39:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:39:17 INFO - Running setup.py install for pep8 22:39:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:39:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:39:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:39:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:39:17 INFO - no previously-included directories found matching 'docs/_build' 22:39:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:39:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:39:17 INFO - Cleaning up... 22:39:17 INFO - Return code: 0 22:39:17 INFO - Running post-action listener: _resource_record_post_action 22:39:17 INFO - Running post-action listener: _start_resource_monitoring 22:39:17 INFO - Starting resource monitoring. 22:39:17 INFO - ##### 22:39:17 INFO - ##### Finished create-virtualenv step (success) 22:39:17 INFO - ##### 22:39:17 INFO - ##### 22:39:17 INFO - ##### Running install step. 22:39:17 INFO - ##### 22:39:17 INFO - Running pre-action listener: _resource_record_pre_action 22:39:17 INFO - Running main action method: install 22:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:17 INFO - Reading from file tmpfile_stdout 22:39:17 INFO - Detecting whether we're running mozinstall >=1.0... 22:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:39:17 INFO - Reading from file tmpfile_stdout 22:39:17 INFO - Output received: 22:39:17 INFO - Usage: mozinstall [options] installer 22:39:17 INFO - Options: 22:39:17 INFO - -h, --help show this help message and exit 22:39:17 INFO - -d DEST, --destination=DEST 22:39:17 INFO - Directory to install application into. [default: 22:39:17 INFO - "/builds/slave/test"] 22:39:17 INFO - --app=APP Application being installed. [default: firefox] 22:39:17 INFO - mkdir: /builds/slave/test/build/application 22:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:39:34 INFO - Reading from file tmpfile_stdout 22:39:34 INFO - Output received: 22:39:34 INFO - /builds/slave/test/build/application/firefox/firefox 22:39:34 INFO - Running post-action listener: _resource_record_post_action 22:39:34 INFO - ##### 22:39:34 INFO - ##### Finished install step (success) 22:39:34 INFO - ##### 22:39:34 INFO - ##### 22:39:34 INFO - ##### Running run-tests step. 22:39:34 INFO - ##### 22:39:34 INFO - Running pre-action listener: _resource_record_pre_action 22:39:34 INFO - Running main action method: run_tests 22:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:39:34 INFO - Python 2.7.3 22:39:34 INFO - Return code: 0 22:39:34 INFO - grabbing minidump binary from tooltool 22:39:34 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')]} 22:39:34 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 0x24d36f0>, '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 0x24d45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d4aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:39:34 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 22:39:34 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 22:39:34 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 22:39:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:39:34 INFO - Return code: 0 22:39:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:39:35 INFO - Return code: 0 22:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 22:39:35 INFO - Using env: {'DISPLAY': ':0', 22:39:35 INFO - 'HOME': '/home/cltbld', 22:39:35 INFO - 'LANG': 'en_US.UTF-8', 22:39:35 INFO - 'LANGUAGE': 'en_US:en', 22:39:35 INFO - 'LOGNAME': 'cltbld', 22:39:35 INFO - 'MAIL': '/var/mail/cltbld', 22:39:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:39:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:35 INFO - 'MOZ_NO_REMOTE': '1', 22:39:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:35 INFO - 'NO_EM_RESTART': '1', 22:39:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:35 INFO - 'PWD': '/builds/slave/test', 22:39:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:39:35 INFO - 'SHELL': '/bin/bash', 22:39:35 INFO - 'SHLVL': '1', 22:39:35 INFO - 'TERM': 'linux', 22:39:35 INFO - 'TMOUT': '86400', 22:39:35 INFO - 'USER': 'cltbld', 22:39:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064', 22:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:35 INFO - '_': '/tools/buildbot/bin/python'} 22:39:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:39:35 INFO - mozversion application_buildid: 20160627193059 22:39:35 INFO - mozversion application_changeset: ff3138a7b682cb02dae61c0dca0f327886c57e84 22:39:35 INFO - mozversion application_display_name: Nightly 22:39:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:39:35 INFO - mozversion application_name: Firefox 22:39:35 INFO - mozversion application_remotingname: firefox 22:39:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:39:35 INFO - mozversion application_vendor: Mozilla 22:39:35 INFO - mozversion application_version: 50.0a1 22:39:35 INFO - mozversion platform_buildid: 20160627193059 22:39:35 INFO - mozversion platform_changeset: ff3138a7b682cb02dae61c0dca0f327886c57e84 22:39:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:39:35 INFO - mozversion platform_version: 50.0a1 22:39:35 INFO - using testdate: 1467092375 22:39:35 INFO - actual date: 1467092375 22:39:35 INFO - starting webserver on 'localhost:42910' 22:39:35 INFO - SUITE-START | Running 2 tests 22:39:35 INFO - TEST-START | dromaeo_css 22:39:35 INFO - operating with platform_type : linux_ 22:39:35 INFO - Initialising browser for dromaeo_css test... 22:39:35 INFO - TEST-INFO | started process 3736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaNiku4/profile http://localhost:42910/getInfo.html) 22:39:40 INFO - PROCESS | 3736 | __metrics Screen width/height:1600/1200 22:39:40 INFO - PROCESS | 3736 | colorDepth:24 22:39:40 INFO - PROCESS | 3736 | Browser inner width/height: 1024/697 22:39:40 INFO - PROCESS | 3736 | __metrics 22:39:40 ERROR - PROCESS | 3736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:39:41 INFO - TEST-INFO | 3736: exit 0 22:39:41 INFO - Browser initialized. 22:39:41 INFO - Running cycle 1/1 for dromaeo_css test... 22:39:41 INFO - TEST-INFO | started process 3856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaNiku4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:53 INFO - PROCESS | 3856 | RSS: Main: 167280640 22:39:53 INFO - PROCESS | 3856 | 22:40:42 INFO - PROCESS | 3856 | 1467092442965 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] 22:42:51 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:42910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42910/tests/dromaeo/cssquery-ext.html) 22:42:52 INFO - PROCESS | 3856 | RSS: Main: 170942464 22:42:52 INFO - PROCESS | 3856 | 22:45:54 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:42910/tests/dromaeo/cssquery-ext.html (next: http://localhost:42910/tests/dromaeo/cssquery-jquery.html) 22:45:55 INFO - PROCESS | 3856 | RSS: Main: 170438656 22:45:55 INFO - PROCESS | 3856 | 22:48:56 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:42910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42910/tests/dromaeo/cssquery-mootools.html) 22:48:57 INFO - PROCESS | 3856 | RSS: Main: 171241472 22:48:57 INFO - PROCESS | 3856 | 22:51:59 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:42910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42910/tests/dromaeo/cssquery-prototype.html) 22:51:59 INFO - PROCESS | 3856 | RSS: Main: 168697856 22:51:59 INFO - PROCESS | 3856 | 22:55:02 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:42910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42910/tests/dromaeo/cssquery-yui.html) 22:55:02 INFO - PROCESS | 3856 | RSS: Main: 170758144 22:55:02 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | Cycle 1(1): loaded http://localhost:42910/tests/dromaeo/cssquery-yui.html (next: http://localhost:42910/tests/dromaeo/cssquery-dojo.html) 22:58:05 INFO - PROCESS | 3856 | RSS: Main: 171335680 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | __start_tp_report 22:58:05 INFO - PROCESS | 3856 | _x_x_mozilla_page_load 22:58:05 INFO - PROCESS | 3856 | _x_x_mozilla_page_load_details 22:58:05 INFO - PROCESS | 3856 | |i|pagename|runs| 22:58:05 INFO - PROCESS | 3856 | |0;dojo.html;3143.669914658961;3170.4134735074026;3188.601424821897;3196.3127927495584;3205.567248421464;5414.539764120054;5437.075697131488;5485.835424937253;5512;5516.062269414199;5418.322709661293;5481.780728770845;5497.422770609079;5550.195221692852;5595.38450770416;4966.776495057722;4985.925211121836;5096.974515127419;5141.511556402136;5176.120059589879;720.7454305806344;5083.389993200821;5125.103106956286;5138.665986710852;5157.71632560209;5048.974755126201;5066.037452883958;5070.771815268304;5084.745762711868;5106.617003724736;4986.925196122061;5092.337996060525;5094.2103973884105;5105.387353517564;5127.897442051175;5011.498850114996;5024.246363045536;5026.2711906773675;5055.064813009605;5055.140626093536;5504.4495550444635;5507.4767897050115;5520.558355331564;5536.307961504812;5576.832695019115;5763.769449222026;5765.567582431292;5824.679642619654;5907.261592300963;5917.852053698649;5899.646021238696;5948.107783832416;5989.5507836911975;6001.279846418414;6002.429769171922;5517.862053448655;5524.475174858382;5530.198121272433;5532.474414930575;5535.169724541311;5865.120231965239;5999.370066143079;6010.699465026732;6026.939730602726;6043.36544662804;5797.304323481209;5802.071668533099;5810.360860305363;5845.649261044351;5892.234009578813;5925.703714814242;5928.525717942554;5928.911066334009;5938.673372964442;5946.524278057745;5790.392008839011;5804.2744656917885;5827.912581311284;5840.941590584125;5861.677607731615;5745.540356771448;5774.711264436762;5792.594518383673;5836.037053886146;5884.9705751470965;4427.712198707074;4440.666949978699;4448.733076015449;4459.888502787457;4498.032922921588;3966.2860685076384;3981.422693709396;3998.8800335989968;4002.6197511236387;4059.9594004060173;5664.433556644302;5686;5689.175069614883;5691.231683722727;5731.942680573141;5962.403759624003;6042.909356359658;6046.18376519173;6053.424924632153;6066.848328791815;5483.369412517532;5634.267545219095;5680.147977803363;5694.402087780806;5699.2590963174525;5027.949720502748;5028.296038554532;5030.572401345927;5035.924461133086;5050.191969284897;6231.4391704746795;6231.470325022424;6231.906521402183;6232.626042437469;6237.03325984464;5887.381824908409;5887.4406931341455;5921.467067963904;5950.761969521171;5974.9402505974385;6066.636001839904;6109.419605137505;6123.08153776937;6123.908141377794;6142.232220972379;5686.943130568641;5833;5836.766529338779;5839.182514447895;5842.328132264844;5812.3025236971835;5886.558508111823;5903.881922361443;5929.703514824328;5944.702764861653;5751.166080918159;5782.566307527037;5783.797567085132;5790.189373487631;5790.971045144747;5622.465865742748;5705.4579814917515;5763.106718458645;5774.9133762994425;5775.826725198251;5617.915731263953;5654.095344744986;5698;5722.456366645162;5801.738921748447;5809.070548712186;5832.24180856486;5847.7368518417625;5851.561132915133;5859.824205273849;5612.775488980558;5633.380328163817;5739.9139012914;5750.913736293875;5756.712164391847 22:58:05 INFO - PROCESS | 3856 | |1;ext.html;585.9619124756894;614.0298328640748;641.7689631732576;643.536653609401;654.054890682963;42794.358084628715;44055.33916991248;44060;44304.77847610762;48543.27185092226;45745.08509829801;46357.30464043042;46587.30119048217;46668.29997550039;46699.533004669946;8990.640374385017;9146.542672866364;9146.817063658722;9149.725508234764;9162.037986011474;9048.819023619524;9058.27533797298;9090.27277817773;9121.771955701095;9125.817483650322;9075.36472446929;9078.591463384164;9120.224780893632;9132.041135680758;9151.405158664698;8993.910060899372;9072.183503484684;9085.591148398338;9112.635494580209;9136.725898223063;8886.86669699955;8917.509536975464;8919.464832110029;8958.283337332998;8963.83470148883;41488.1702365951;41710.37434438486;41897.162056758694;41902.580974190474;41912;3527.753057285991;3642.5993140754495;3723.3670276053135;3783.6027217142077;3796.6013568575177;32619.85830495945;33130;33316.83341583301;33392.33215335704;33410.66589334124;4252.896524170977;4325.610695037431;4344.239758042361;4419.359192917042;4527.524609915978;358666;359636;360759;361704;361779;62045.37954620396;62553.68723156355;62674;62711.372886270554;62843.685781571716;65479.67260163669;66363;66388.6680566594;66425;66581.33418665848;15315.31081101353;15753.054816711034;15790.447334343473;16101.516954491384;16205.837941620668;12586.118971671895;12702.110852240254;12765.042621803403;12834.935825321001;12835.743285134431;19578.30873717519;19691.704624430644;19715.309964151187;19793;19803.900980495295;7243.275672432715;7416.184219735825;7573.810654733566;7616.23837616234;7646.885296720554;1004.4124187350482;1039.4542864995938;1123.1464087293716;1139.0773473486338;1160.5473865192582;32917.67082329194;33551;33670.663293367244;33808;33893.49159762605;1165.6677846813786;1177.8881006304387;1209.0508950473836;1211.9333436661068;1243.160866415166;16819.91590042042;17307.826921730873;17451.214695338742;17454.825451745575;17511.299548017938;536714;538521;541461;542481;542696;59862.70068649629;60093.69484678297;60118.09822852661;60257;60342.094868577005;1333.7599232138114;1390.860913908601;1395.0513650717407;1398.7831886057677;1398.881095106907;31537;32032.35935281328;32354;32409.18977025499;32603.836980814944;51712.74143629258;51778.74110629423;52140.739296303276;52174;52263;415345;415843;416860;417581;421062;28818.855905721175;28935;29317.120486385444;29398.559021614266;29494.410111797213;48385.516144838104;48585.5141448581;49096.75451622719;49433.25850112323;49499.752501237264;41402.79298603608;42098.368524471545;42262.57737422586;42407.36880763124;42801.785991069846;42339.57660423356;42622.57377426186;42713.786431067645;42892.35661465018;43313.783431082644;35971.82014089913;40968.79515602403;41227.79386103051;41808.3728744063;42163.36754948617;35685.28629427449;38057.619423806515;38266.426003610526;38457;38719.902407806745;23249.883750581816;23630.29109126729;24725.43677672509;25006.624900626142;28180.85909570439 22:58:05 INFO - PROCESS | 3856 | |2;jquery.html;383.57806412945746;389.5928754451598;391.47346818529076;399.71420434389404;409.19797197492915;18566.90716546417;18945.43163705091;19831.60336793265;19873.503162420948;19952.50118747032;18317.450476485694;18360.540986475313;18363.72454413185;18661.16024778885;18673.06634668268;5631.099024156126;5659.51894089003;5851.678157701324;5876.529877609781;5898.528117750569;5738.684372359518;5793.884122317572;5815.331236907747;5836.416358364172;5851.414858514136;5531.419200983879;5772.538196944234;5783.479486846183;5788.710564471759;5802.216700745409;5726.45598668128;5755.25181726375;5765.913511297334;5772.740226689809;5796.855078623026;4997.825076122354;5103.923441148386;5300.284461597674;5323.627346085776;5368.62419630626;13328.400221990034;13425.66435839102;13511.391987360592;19898.50253743668;22167.667484987738;2291.9083236670513;2319.52449747803;2490.2778194323623;2775.403288293027;2928.5636469877513;9848.409095454295;9870.506474676238;10369.48152592375;10390.948045259802;12526.248425094433;1948.133080779054;1964.803519648038;1968.1340210307562;1991.4224874786294;2049.477383267272;81095.5945220276;82876;83777.58111209466;85495;86479.13520864774;10752.40861752611;10925.508352124174;10926.399048052433;10931.781364372668;11060.949209825054;14974.17642029677;15027;15129;15137.470188543348;15148;7771.145174030852;7900.288973992253;7934.4691612233155;7940.880886786703;7962.761117166494;7613.809654758676;7616.428767842434;7637.961810190914;7777.961110194413;7784.338331241908;4560.338750881104;4587.587117159405;4593.26507758757;4750.14497390473;4819.349387832668;1914.5405102775512;1997.1611922992379;2006.1774672384545;2010.5375763574168;2013.0538646835964;901.4456109492614;961.1589858873485;967.0474582536197;982.5038355630361;1015.1067060986285;18075.27698892056;19154.138063787163;19224.134913928905;19247.711284330748;19606.70589941152;987.6641941739842;993.7863359377768;1014.9594016239415;1036.9533370998172;1038.7247379444452;8911.465312081296;10413.323133996266;10769;10804;10825.242233043611;337467;344740;345716;473037;474056;60344.09483857745;82290.58854705688;88813.55593222122;89191.66212506818;96367;978.574320170728;998.173342782706;1044.2951008069674;1052.7420781908481;1059.2108878885126;17224.569385765455;17533.561660958578;17578.73631895497;17846.375376861746;18102.637947241245;39432.6056739429;41824.79087604542;42250.36624450574;43037.56962430335;43644.78177609092;57046.7147664259;58978;59107.113393299995;59316;59644.70177649084;7408.888866667112;7592.81017974555;7695.92304076952;8696.304295656206;9173.266138708754;9474.905250947679;11851.940740296242;13052.934735326262;13308.201507909556;13420.597382078553;11941.16411851162;12017.63947081589;12034.277943323428;12202.816957745463;12206.344158683482;11535.480903359201;11706.648800535997;11756.58851940178;11784.941075294568;11969.64091077269;6544.705488252945;11717.941410292893;11915.570131584265;12200.389980501117;12223.572174973833;8433.578321083798;8690.130986901258;8886.025114634136;8914.153155450222;8963.686270980485;8855.51294678773;10853;10916.890831091587;11243.60647377338;11453.141014423785 22:58:05 INFO - PROCESS | 3856 | |3;mootools.html;1456.5120684570672;1474.2776039740525;1607.2686927448005;1734.3322820714022;1738.5740493579076;7718.266764657348;8215.75352739418;8454.450460720065;8854.937407511099;8867.955660221705;8369.623366948486;8693.826123477527;8788.428752131107;8797.340199485032;8808.955955220215;2248.876311802846;2257.16484900587;2267.818574514035;2276.4081338851934;2286.6684330772027;2259.243153543565;2279.2364557873134;2315.235972129202;2316.4672125411166;2321.1411777642297;2249.3701763506247;2276.1009401286483;2278.3734473019886;2292.8280378971563;2300.620397634388;2223.67756675282;2233.932982010542;2256.0524579676576;2258.8644681319092;2259.017327462559;2251.3808702606916;2258.7967082962614;2265.750767415583;2272.1479445208047;2281.589313923493;8768.605412756442;8776.078511756237;8847.73456796297;8864.601092950832;8896.110388961117;5006.824761133379;5094.821681241176;5142.1772516397195;5155.74221288934;5155.819546315898;3049.878004879802;3136.9843150784327;3261.119497735598;3263.167892187501;3275;1141.5034460009922;1146.2148428326539;1166.1720178673067;1180.1797750563362;1181.7813704464702;11855.762884742344;11866.406679666068;11879.168458207843;11930.343831089287;11955.342456164908;4306.332518459643;4310.6335961443;4429.15845989261;4444.888877778017;4451.9554804451545;10054.64808731691;10115.797684046278;10124.54439550222;10155.339902906288;10171.7457063574;5043.117454445457;5068.4424713281505;5072.82245121419;5073.289739436482;5074.746262686851;4180.832766689298;4543.363929049936;4646.606018194528;4693.296005599187;4706.223473126965;3866.729328947003;3879.7866117363815;3895.7078219133114;3982.880513584597;3983.3270026588903;1221.859486159103;1244.7448273103992;1251.2930194440112;1253.2918900821007;1256.3341429042623;845.9594698520854;880.5201165364764;886.4636894678755;921.1939552891221;939.7650587353162;5674.177244299636;5795.565332600072;5797.942020579824;5880.323762767336;5920.259967504062;930.15356026016;935.9532023398802;949.1931857920712;955.4458414119794;983.1397527163732;4000.6999475038906;4003;4028.738132021409;4076.9184616307507;4100.0774825664585;10656.733581660366;10919.181061420426;10925.726856828644;11026.228164028442;11044.558217671203;10779.083777878812;10823.080038196842;10824.13406927444;10870.891291087146;10909.727256818644;7659.693612255559;8101.959490202511;8182.427230093956;8239;8246.958765206136;5875.148103525051;5936.7922122725495;6011.128386384037;6122.418370254819;6129.141920131275;9906.851397228904;9967.850482242628;10246.795064098826;10300.639477618248;10388.948055259676;10178.694639160836;10230.386176829414;10339.63811266602;10366.06705396518;10451.790964180826;6955.930440695731;7653;7803.258690424401;7933.642986065525;7985.960070199611;8629.741107766777;8678.305735541267;8714.215720585178;8721.171488708562;8758.343124265579;7617.200193979553;7712.460127791001;7765.068191816792;7917.960410197912;7960.283574478325;7558.168601453725;7622.9237707622215;7662.0422447194105;7773.1060927994;7796.142424333432;6785.287544807724;6824.761133360308;6844.041834143323;6854.657267136524;6864.347886950732;4981.3026176334615;5029.06962211992;5082.4409314976065;5161.354830646169;5168.715720635401;5145.845624631267;5180;5218.947810521998;5225.6603320784025;5236.266922630911 22:58:05 INFO - PROCESS | 3856 | |4;prototype.html;324.46139408581746;333.62967106511775;334.6736931491796;338.8360980033584;342.0968642783052;5619.4380561943835;5709.628874123185;5764.394738552454;5806;5820.417958204177;5654.858628534278;5682.573806964484;5695.345035320939;5696.857578560538;5724.484796368326;4392.516823149451;4428.512863585003;4447.688661793676;4461.24158892989;4464.6428285737065;4012.759234445928;4328;4337.978310108445;4357.651387888961;4367.45406824147;4315.287977483711;4318.136372725452;4337.306031035035;4362.781860906942;4365.039691267916;4336.934945975797;4352.804123814436;4357.3899654048455;4369.235383807837;4373.343998400233;3754.718396120302;3807.143392736612;3835.0987517933263;3836.5971572984713;3843.26977874203;5538.363088244863;5541.030319694078;5552.3892371839065;5577.972110139423;5608.579356548275;5008.398992120969;5022.146235140035;5022.949770502285;5023.874403139914;5034.622403319766;5729.682173100168;5884.323302820188;5896.64620122794;5902.793402230945;5918.957959503964;4130.586941305875;4161;4169.708120431571;4172.582741725833;4185;5918.786648737042;6078.784243151344;6081.574289799716;6102.542309326774;6161.845953851145;4247.915041699149;4255.297875850512;4267.253230684618;4270.7010509264055;4276.593723596254;4321.243782338078;4336.718113322624;4364.323529852878;4372.781360932005;4378.737275763465;5005.824796132118;5016.974915125401;5023.924641130386;5062.164742817394;5063.873403164876;5716.685582292931;5902.557308201816;5912.374097123239;5914.645121292736;5915;1477.697072100217;1501.1368463133742;1504.8871334649946;1505.4580351073605;1508.2081906998694;906.5331354352513;930.3998920696113;940.8024314893812;949.5110018340561;957.9808403832023;5076.487138866285;5104.923426148611;5681.289838770153;5756.30924289088;5795.9420405796245;6048.909266361008;6151.876962460726;6178.876422471525;6187.5149964009215;6196.659183744938;5653.971730141323;5814.215080964101;5837.357890632027;5849.912251316234;5859.091840764689;3250.6749325067776;3256.397566450214;3273.541704161419;3291.8847840325475;3296.8186749728516;6325.841853953596;6327.620342779356;6329.708551553259;6396.880545904448;6415.230172379344;6139.293981192131;6254.34329395416;6294.653794041372;6295.181626388632;6371.139896114058;6410.557624534443;6422.775202867877;6439.967800160969;6456.451201647818;6457.418832305115;5955.749292648592;6158.476529494864;6210.347913469202;6220.409061139185;6239.1577137085915;6126.387361263838;6151.753929842936;6169.784057557964;6191.81424557264;6198.783042593487;6247.937520624918;6335.859545281894;6374.968125159345;6395.296517383177;6414.717056588795;4226.36604509326;4226.556211597738;4254.298040823353;4256.553061928576;4288.126954940135;6170.81487555374;6172.629642221481;6202.596831205957;6235.46998505114;6245.781397651061;5570.303712035996;5919.792807251725;5947.126655103629;5993.250843644544;6007.317950973735;5887.409539802473;5934.554908381802;5941.346451890202;5951.55363347742;5979.970100149471;5661.179129026351;5856.970715146397;5880.529867533117;5905.616134951214;5933.1396947443245;5970.731317090655;5996.490298324691;6004;6025.909611355745;6053.757849685963;5772.451617096537;5905.553139480855;5911.054231322968;5913.852153696192;5975.908432048922 22:58:05 INFO - PROCESS | 3856 | |5;yui.html;687.8933765266379;763.1338430880949;792.5165648954139;798.8801679748038;801.8676918308479;14643;14672.779908301383;15046.62383440416;15059.472918447857;15087.924560377196;13648.38582263798;13952.162870227794;13953.44186232552;13974.580762577114;13978.09142405743;669.8760729265077;786.4337676872642;789.100425514912;807.4509333653143;809.9473534220257;804.8792681097824;805.8227190018187;808.292743849132;810.1331575214523;811.1158836867813;844.8943882014748;845.0366582096415;846.7544412120509;850.4259624753298;852.6674596907211;842.3513894301415;844.4215712237076;845.2308399356587;845.3406343052429;845.378646694682;614.4807637546311;616.6207782213951;617.5245061302817;618.4032408725601;619.2290598205218;14598.781018284733;14610.050346727536;14644.194569298685;14646.780298295535;14690.926545367312;15018.624534386618;15048.774268385983;15262;15442.845571544365;15545;11906.285622862655;12237.571684991071;12271.263724176579;12302.630921072383;12853.100282980195;3631.5823680276576;3631.8728844490315;3705.6479634434686;3709.55485341758;3733.2346868891814;77972;79354;79674.20325796783;79779.60110199412;79852.20147798564;10313;10453.482749510233;10833.404162771123;11151.888481115247;11877.762444751057;19897.104630291673;20241.190352386035;20257.493562661053;20280.492987675425;20310.390688279374;8200.138985406566;8200.564901142396;8257.174282571696;8280.213379728915;8331.916680833236;4727.196376615983;4813.133635945494;4815.566599006106;4893.266010098442;4930.433000204951;3265.4938484534937;3389.2035371687634;3391.6608339165887;3403.149212696826;3408;658.4732214228598;664.5979182594557;670.6747227594612;671.2716702377877;672.4721093941331;614.1954040207343;622.9159063526456;684.2678334182377;750.4709180028067;758.1546575568202;9113.633528751403;9457;9647.083527064917;9705.708828735009;10039.533967804517;704.6476761619191;725.1153592617104;727.6834576959039;738.103204606395;746.4103358346845;4527.524609915978;4699.835505757351;4722.291656251589;4788.569028787356;4811.807527698923;96434.51782741041;108164;116465.41767291109;116814;119036;84301.15698843056;99768.51273180045;100090;100831.49584252032;101292.49353753185;65223.673881631235;66802.33197668155;87034.56482717546;88166;90190;9675.177609902956;9689.854652180364;9928.652497162564;9962.78670697259;10225.642102526375;49607.25589116094;49870.75064624654;50275.49724502708;51148.488515114375;52257.7387113062;68129.3187068123;69697;73443;78417.60791196008;79531.20468795238;12952.158109722837;13107.672308192372;13169.275689836768;13469.057165998285;13612.25132617676;14623.415063397344;14646.560603181922;14919.477818276308;15055.698886022437;15215.239238038275;12905.548305809252;12999.740005199654;13116.147450416074;13221.140625859289;13513.662158446117;12393.62819115428;12831.230126192459;12875.163114397534;12890.806637900627;12916;12310.384480776105;12398;13160.802587960996;13357.866421336052;13850.930745346612;11471.369074700971;11707.180497365443;11930;12337.876621234032;12641.494340226656;9207.168743484142;9868.950655246677;9955.502224888582;9969.95315491892;10024.348417352849 22:58:05 INFO - PROCESS | 3856 | __end_tp_report 22:58:05 INFO - PROCESS | 3856 | __start_cc_report 22:58:05 INFO - PROCESS | 3856 | _x_x_mozilla_cycle_collect,339 22:58:05 INFO - PROCESS | 3856 | __end_cc_report 22:58:05 INFO - PROCESS | 3856 | __startTimestamp1467093485680__endTimestamp 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | ------- Summary: start ------- 22:58:05 INFO - PROCESS | 3856 | Number of tests: 6 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | [#0] dojo.html Cycles:165 Average:5469.50 Median:5731.94 stddev:729.95 (12.7%) stddev-sans-first:709.02 22:58:05 INFO - PROCESS | 3856 | Values: 3143.7 3170.4 3188.6 3196.3 3205.6 5414.5 5437.1 5485.8 5512.0 5516.1 5418.3 5481.8 5497.4 5550.2 5595.4 4966.8 4985.9 5097.0 5141.5 5176.1 720.7 5083.4 5125.1 5138.7 5157.7 5049.0 5066.0 5070.8 5084.7 5106.6 4986.9 5092.3 5094.2 5105.4 5127.9 5011.5 5024.2 5026.3 5055.1 5055.1 5504.4 5507.5 5520.6 5536.3 5576.8 5763.8 5765.6 5824.7 5907.3 5917.9 5899.6 5948.1 5989.6 6001.3 6002.4 5517.9 5524.5 5530.2 5532.5 5535.2 5865.1 5999.4 6010.7 6026.9 6043.4 5797.3 5802.1 5810.4 5845.6 5892.2 5925.7 5928.5 5928.9 5938.7 5946.5 5790.4 5804.3 5827.9 5840.9 5861.7 5745.5 5774.7 5792.6 5836.0 5885.0 4427.7 4440.7 4448.7 4459.9 4498.0 3966.3 3981.4 3998.9 4002.6 4060.0 5664.4 5686.0 5689.2 5691.2 5731.9 5962.4 6042.9 6046.2 6053.4 6066.8 5483.4 5634.3 5680.1 5694.4 5699.3 5027.9 5028.3 5030.6 5035.9 5050.2 6231.4 6231.5 6231.9 6232.6 6237.0 5887.4 5887.4 5921.5 5950.8 5974.9 6066.6 6109.4 6123.1 6123.9 6142.2 5686.9 5833.0 5836.8 5839.2 5842.3 5812.3 5886.6 5903.9 5929.7 5944.7 5751.2 5782.6 5783.8 5790.2 5791.0 5622.5 5705.5 5763.1 5774.9 5775.8 5617.9 5654.1 5698.0 5722.5 5801.7 5809.1 5832.2 5847.7 5851.6 5859.8 5612.8 5633.4 5739.9 5750.9 5756.7 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | [#1] ext.html Cycles:180 Average:60784.79 Median:231612.68 stddev:118074.10 (51.0%) stddev-sans-first:118318.82 22:58:05 INFO - PROCESS | 3856 | Values: 586.0 614.0 641.8 643.5 654.1 42794.4 44055.3 44060.0 44304.8 48543.3 45745.1 46357.3 46587.3 46668.3 46699.5 8990.6 9146.5 9146.8 9149.7 9162.0 9048.8 9058.3 9090.3 9121.8 9125.8 9075.4 9078.6 9120.2 9132.0 9151.4 8993.9 9072.2 9085.6 9112.6 9136.7 8886.9 8917.5 8919.5 8958.3 8963.8 41488.2 41710.4 41897.2 41902.6 41912.0 3527.8 3642.6 3723.4 3783.6 3796.6 32619.9 33130.0 33316.8 33392.3 33410.7 4252.9 4325.6 4344.2 4419.4 4527.5 358666.0 359636.0 360759.0 361704.0 361779.0 62045.4 62553.7 62674.0 62711.4 62843.7 65479.7 66363.0 66388.7 66425.0 66581.3 15315.3 15753.1 15790.4 16101.5 16205.8 12586.1 12702.1 12765.0 12834.9 12835.7 19578.3 19691.7 19715.3 19793.0 19803.9 7243.3 7416.2 7573.8 7616.2 7646.9 1004.4 1039.5 1123.1 1139.1 1160.5 32917.7 33551.0 33670.7 33808.0 33893.5 1165.7 1177.9 1209.1 1211.9 1243.2 16819.9 17307.8 17451.2 17454.8 17511.3 536714.0 538521.0 541461.0 542481.0 542696.0 59862.7 60093.7 60118.1 60257.0 60342.1 1333.8 1390.9 1395.1 1398.8 1398.9 31537.0 32032.4 32354.0 32409.2 32603.8 51712.7 51778.7 52140.7 52174.0 52263.0 415345.0 415843.0 416860.0 417581.0 421062.0 28818.9 28935.0 29317.1 29398.6 29494.4 48385.5 48585.5 49096.8 49433.3 49499.8 41402.8 42098.4 42262.6 42407.4 42801.8 42339.6 42622.6 42713.8 42892.4 43313.8 35971.8 40968.8 41227.8 41808.4 42163.4 35685.3 38057.6 38266.4 38457.0 38719.9 23249.9 23630.3 24725.4 25006.6 28180.9 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | [#2] jquery.html Cycles:180 Average:25951.96 Median:390.53 stddev:66575.91 (17047.4%) stddev-sans-first:66734.99 22:58:05 INFO - PROCESS | 3856 | Values: 383.6 389.6 391.5 399.7 409.2 18566.9 18945.4 19831.6 19873.5 19952.5 18317.5 18360.5 18363.7 18661.2 18673.1 5631.1 5659.5 5851.7 5876.5 5898.5 5738.7 5793.9 5815.3 5836.4 5851.4 5531.4 5772.5 5783.5 5788.7 5802.2 5726.5 5755.3 5765.9 5772.7 5796.9 4997.8 5103.9 5300.3 5323.6 5368.6 13328.4 13425.7 13511.4 19898.5 22167.7 2291.9 2319.5 2490.3 2775.4 2928.6 9848.4 9870.5 10369.5 10390.9 12526.2 1948.1 1964.8 1968.1 1991.4 2049.5 81095.6 82876.0 83777.6 85495.0 86479.1 10752.4 10925.5 10926.4 10931.8 11060.9 14974.2 15027.0 15129.0 15137.5 15148.0 7771.1 7900.3 7934.5 7940.9 7962.8 7613.8 7616.4 7638.0 7778.0 7784.3 4560.3 4587.6 4593.3 4750.1 4819.3 1914.5 1997.2 2006.2 2010.5 2013.1 901.4 961.2 967.0 982.5 1015.1 18075.3 19154.1 19224.1 19247.7 19606.7 987.7 993.8 1015.0 1037.0 1038.7 8911.5 10413.3 10769.0 10804.0 10825.2 337467.0 344740.0 345716.0 473037.0 474056.0 60344.1 82290.6 88813.6 89191.7 96367.0 978.6 998.2 1044.3 1052.7 1059.2 17224.6 17533.6 17578.7 17846.4 18102.6 39432.6 41824.8 42250.4 43037.6 43644.8 57046.7 58978.0 59107.1 59316.0 59644.7 7408.9 7592.8 7695.9 8696.3 9173.3 9474.9 11851.9 13052.9 13308.2 13420.6 11941.2 12017.6 12034.3 12202.8 12206.3 11535.5 11706.6 11756.6 11784.9 11969.6 6544.7 11717.9 11915.6 12200.4 12223.6 8433.6 8690.1 8886.0 8914.2 8963.7 8855.5 10853.0 10916.9 11243.6 11453.1 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | [#3] mootools.html Cycles:180 Average:5738.10 Median:4669.95 stddev:3283.66 (70.3%) stddev-sans-first:3277.11 22:58:05 INFO - PROCESS | 3856 | Values: 1456.5 1474.3 1607.3 1734.3 1738.6 7718.3 8215.8 8454.5 8854.9 8868.0 8369.6 8693.8 8788.4 8797.3 8809.0 2248.9 2257.2 2267.8 2276.4 2286.7 2259.2 2279.2 2315.2 2316.5 2321.1 2249.4 2276.1 2278.4 2292.8 2300.6 2223.7 2233.9 2256.1 2258.9 2259.0 2251.4 2258.8 2265.8 2272.1 2281.6 8768.6 8776.1 8847.7 8864.6 8896.1 5006.8 5094.8 5142.2 5155.7 5155.8 3049.9 3137.0 3261.1 3263.2 3275.0 1141.5 1146.2 1166.2 1180.2 1181.8 11855.8 11866.4 11879.2 11930.3 11955.3 4306.3 4310.6 4429.2 4444.9 4452.0 10054.6 10115.8 10124.5 10155.3 10171.7 5043.1 5068.4 5072.8 5073.3 5074.7 4180.8 4543.4 4646.6 4693.3 4706.2 3866.7 3879.8 3895.7 3982.9 3983.3 1221.9 1244.7 1251.3 1253.3 1256.3 846.0 880.5 886.5 921.2 939.8 5674.2 5795.6 5797.9 5880.3 5920.3 930.2 936.0 949.2 955.4 983.1 4000.7 4003.0 4028.7 4076.9 4100.1 10656.7 10919.2 10925.7 11026.2 11044.6 10779.1 10823.1 10824.1 10870.9 10909.7 7659.7 8102.0 8182.4 8239.0 8247.0 5875.1 5936.8 6011.1 6122.4 6129.1 9906.9 9967.9 10246.8 10300.6 10388.9 10178.7 10230.4 10339.6 10366.1 10451.8 6955.9 7653.0 7803.3 7933.6 7986.0 8629.7 8678.3 8714.2 8721.2 8758.3 7617.2 7712.5 7765.1 7918.0 7960.3 7558.2 7622.9 7662.0 7773.1 7796.1 6785.3 6824.8 6844.0 6854.7 6864.3 4981.3 5029.1 5082.4 5161.4 5168.7 5145.8 5180.0 5218.9 5225.7 5236.3 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | [#4] prototype.html Cycles:180 Average:5003.97 Median:5760.35 stddev:1503.92 (26.1%) stddev-sans-first:1466.55 22:58:05 INFO - PROCESS | 3856 | Values: 324.5 333.6 334.7 338.8 342.1 5619.4 5709.6 5764.4 5806.0 5820.4 5654.9 5682.6 5695.3 5696.9 5724.5 4392.5 4428.5 4447.7 4461.2 4464.6 4012.8 4328.0 4338.0 4357.7 4367.5 4315.3 4318.1 4337.3 4362.8 4365.0 4336.9 4352.8 4357.4 4369.2 4373.3 3754.7 3807.1 3835.1 3836.6 3843.3 5538.4 5541.0 5552.4 5578.0 5608.6 5008.4 5022.1 5022.9 5023.9 5034.6 5729.7 5884.3 5896.6 5902.8 5919.0 4130.6 4161.0 4169.7 4172.6 4185.0 5918.8 6078.8 6081.6 6102.5 6161.8 4247.9 4255.3 4267.3 4270.7 4276.6 4321.2 4336.7 4364.3 4372.8 4378.7 5005.8 5017.0 5023.9 5062.2 5063.9 5716.7 5902.6 5912.4 5914.6 5915.0 1477.7 1501.1 1504.9 1505.5 1508.2 906.5 930.4 940.8 949.5 958.0 5076.5 5104.9 5681.3 5756.3 5795.9 6048.9 6151.9 6178.9 6187.5 6196.7 5654.0 5814.2 5837.4 5849.9 5859.1 3250.7 3256.4 3273.5 3291.9 3296.8 6325.8 6327.6 6329.7 6396.9 6415.2 6139.3 6254.3 6294.7 6295.2 6371.1 6410.6 6422.8 6440.0 6456.5 6457.4 5955.7 6158.5 6210.3 6220.4 6239.2 6126.4 6151.8 6169.8 6191.8 6198.8 6247.9 6335.9 6375.0 6395.3 6414.7 4226.4 4226.6 4254.3 4256.6 4288.1 6170.8 6172.6 6202.6 6235.5 6245.8 5570.3 5919.8 5947.1 5993.3 6007.3 5887.4 5934.6 5941.3 5951.6 5980.0 5661.2 5857.0 5880.5 5905.6 5933.1 5970.7 5996.5 6004.0 6025.9 6053.8 5772.5 5905.6 5911.1 5913.9 5975.9 22:58:05 INFO - PROCESS | 3856 | 22:58:05 INFO - PROCESS | 3856 | [#5] yui.html Cycles:180 Average:20391.01 Median:4812.47 stddev:29331.44 (609.5%) stddev-sans-first:29376.42 22:58:05 INFO - PROCESS | 3856 | Values: 687.9 763.1 792.5 798.9 801.9 14643.0 14672.8 15046.6 15059.5 15087.9 13648.4 13952.2 13953.4 13974.6 13978.1 669.9 786.4 789.1 807.5 809.9 804.9 805.8 808.3 810.1 811.1 844.9 845.0 846.8 850.4 852.7 842.4 844.4 845.2 845.3 845.4 614.5 616.6 617.5 618.4 619.2 14598.8 14610.1 14644.2 14646.8 14690.9 15018.6 15048.8 15262.0 15442.8 15545.0 11906.3 12237.6 12271.3 12302.6 12853.1 3631.6 3631.9 3705.6 3709.6 3733.2 77972.0 79354.0 79674.2 79779.6 79852.2 10313.0 10453.5 10833.4 11151.9 11877.8 19897.1 20241.2 20257.5 20280.5 20310.4 8200.1 8200.6 8257.2 8280.2 8331.9 4727.2 4813.1 4815.6 4893.3 4930.4 3265.5 3389.2 3391.7 3403.1 3408.0 658.5 664.6 670.7 671.3 672.5 614.2 622.9 684.3 750.5 758.2 9113.6 9457.0 9647.1 9705.7 10039.5 704.6 725.1 727.7 738.1 746.4 4527.5 4699.8 4722.3 4788.6 4811.8 96434.5 108164.0 116465.4 116814.0 119036.0 84301.2 99768.5 100090.0 100831.5 101292.5 65223.7 66802.3 87034.6 88166.0 90190.0 9675.2 9689.9 9928.7 9962.8 10225.6 49607.3 49870.8 50275.5 51148.5 52257.7 68129.3 69697.0 73443.0 78417.6 79531.2 12952.2 13107.7 13169.3 13469.1 13612.3 14623.4 14646.6 14919.5 15055.7 15215.2 12905.5 12999.7 13116.1 13221.1 13513.7 12393.6 12831.2 12875.2 12890.8 12916.0 12310.4 12398.0 13160.8 13357.9 13850.9 11471.4 11707.2 11930.0 12337.9 12641.5 9207.2 9869.0 9955.5 9970.0 10024.3 22:58:05 INFO - PROCESS | 3856 | -------- Summary: end -------- 22:58:05 INFO - PROCESS | 3856 | 22:58:06 INFO - TEST-INFO | 3856: exit 0 22:58:06 INFO - TEST-OK | dromaeo_css | took 1110557ms 22:58:06 INFO - TEST-START | kraken 22:58:06 INFO - operating with platform_type : linux_ 22:58:06 INFO - Initialising browser for kraken test... 22:58:06 INFO - TEST-INFO | started process 4084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8o8ZQh/profile http://localhost:42910/getInfo.html) 22:58:10 INFO - PROCESS | 4084 | __metrics Screen width/height:1600/1200 22:58:10 INFO - PROCESS | 4084 | colorDepth:24 22:58:10 INFO - PROCESS | 4084 | Browser inner width/height: 1024/697 22:58:10 INFO - PROCESS | 4084 | __metrics 22:58:11 ERROR - PROCESS | 4084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 22:58:12 INFO - TEST-INFO | 4084: exit 0 22:58:12 INFO - Browser initialized. 22:58:12 INFO - Running cycle 1/1 for kraken test... 22:58:12 INFO - TEST-INFO | started process 4204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8o8ZQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:23 INFO - PROCESS | 4204 | RSS: Main: 167608320 22:58:23 INFO - PROCESS | 4204 | 22:58:26 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42910/tests/kraken/driver.html?testName=audio-beat-detection) 22:58:27 INFO - PROCESS | 4204 | RSS: Main: 172814336 22:58:27 INFO - PROCESS | 4204 | 22:58:29 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42910/tests/kraken/driver.html?testName=audio-dft) 22:58:30 INFO - PROCESS | 4204 | RSS: Main: 172539904 22:58:30 INFO - PROCESS | 4204 | 22:58:33 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42910/tests/kraken/driver.html?testName=audio-fft) 22:58:34 INFO - PROCESS | 4204 | RSS: Main: 167436288 22:58:34 INFO - PROCESS | 4204 | 22:58:36 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42910/tests/kraken/driver.html?testName=audio-oscillator) 22:58:36 INFO - PROCESS | 4204 | RSS: Main: 168181760 22:58:36 INFO - PROCESS | 4204 | 22:58:38 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:58:39 INFO - PROCESS | 4204 | RSS: Main: 168566784 22:58:39 INFO - PROCESS | 4204 | 22:58:42 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42910/tests/kraken/driver.html?testName=imaging-darkroom) 22:58:43 INFO - PROCESS | 4204 | RSS: Main: 168374272 22:58:43 INFO - PROCESS | 4204 | 22:58:46 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42910/tests/kraken/driver.html?testName=imaging-desaturate) 22:58:47 INFO - PROCESS | 4204 | RSS: Main: 169517056 22:58:47 INFO - PROCESS | 4204 | 22:58:50 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42910/tests/kraken/driver.html?testName=json-parse-financial) 22:58:50 INFO - PROCESS | 4204 | RSS: Main: 168538112 22:58:50 INFO - PROCESS | 4204 | 22:58:52 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:58:53 INFO - PROCESS | 4204 | RSS: Main: 168677376 22:58:53 INFO - PROCESS | 4204 | 22:58:54 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:58:55 INFO - PROCESS | 4204 | RSS: Main: 168919040 22:58:55 INFO - PROCESS | 4204 | 22:58:57 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:58:58 INFO - PROCESS | 4204 | RSS: Main: 169320448 22:58:58 INFO - PROCESS | 4204 | 22:59:00 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:59:01 INFO - PROCESS | 4204 | RSS: Main: 169504768 22:59:01 INFO - PROCESS | 4204 | 22:59:04 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:59:04 INFO - PROCESS | 4204 | RSS: Main: 169336832 22:59:04 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | Cycle 1(1): loaded http://localhost:42910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42910/tests/kraken/driver.html?testName=ai-astar) 22:59:06 INFO - PROCESS | 4204 | RSS: Main: 170397696 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | __start_tp_report 22:59:06 INFO - PROCESS | 4204 | _x_x_mozilla_page_load 22:59:06 INFO - PROCESS | 4204 | _x_x_mozilla_page_load_details 22:59:06 INFO - PROCESS | 4204 | |i|pagename|runs| 22:59:06 INFO - PROCESS | 4204 | |0;ai-astar;101;111;104;117;112;110;113;111;110;110 22:59:06 INFO - PROCESS | 4204 | |1;audio-beat-detection;158;129;153;180;135;159;159;127;181;127 22:59:06 INFO - PROCESS | 4204 | |2;audio-dft;161;169;160;162;161;164;175;162;161;161 22:59:06 INFO - PROCESS | 4204 | |3;audio-fft;75;76;75;159;76;74;75;75;164;77 22:59:06 INFO - PROCESS | 4204 | |4;audio-oscillator;85;85;149;84;87;85;141;86;84;143 22:59:06 INFO - PROCESS | 4204 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;126;117 22:59:06 INFO - PROCESS | 4204 | |6;imaging-darkroom;146;147;148;146;147;146;147;146;147;147 22:59:06 INFO - PROCESS | 4204 | |7;imaging-desaturate;95;96;95;96;95;95;96;96;95;97 22:59:06 INFO - PROCESS | 4204 | |8;json-parse-financial;53;54;55;53;54;56;54;58;55;55 22:59:06 INFO - PROCESS | 4204 | |9;json-stringify-tinderbox;61;61;61;61;62;62;61;62;61;63 22:59:06 INFO - PROCESS | 4204 | |10;stanford-crypto-aes;79;78;82;81;80;80;79;86;131;79 22:59:06 INFO - PROCESS | 4204 | |11;stanford-crypto-ccm;137;122;122;137;136;120;139;125;129;123 22:59:06 INFO - PROCESS | 4204 | |12;stanford-crypto-pbkdf2;160;160;164;160;162;160;159;157;159;161 22:59:06 INFO - PROCESS | 4204 | |13;stanford-crypto-sha256-iterative;65;63;66;63;68;64;64;62;63;62 22:59:06 INFO - PROCESS | 4204 | __end_tp_report 22:59:06 INFO - PROCESS | 4204 | __start_cc_report 22:59:06 INFO - PROCESS | 4204 | _x_x_mozilla_cycle_collect,897 22:59:06 INFO - PROCESS | 4204 | __end_cc_report 22:59:06 INFO - PROCESS | 4204 | __startTimestamp1467093546772__endTimestamp 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | ------- Summary: start ------- 22:59:06 INFO - PROCESS | 4204 | Number of tests: 14 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:4.48 (4.0%) stddev-sans-first:3.41 22:59:06 INFO - PROCESS | 4204 | Values: 101.0 111.0 104.0 117.0 112.0 110.0 113.0 111.0 110.0 110.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:158.50 stddev:20.58 (13.0%) stddev-sans-first:21.67 22:59:06 INFO - PROCESS | 4204 | Values: 158.0 129.0 153.0 180.0 135.0 159.0 159.0 127.0 181.0 127.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.00 stddev:4.77 (2.9%) stddev-sans-first:4.96 22:59:06 INFO - PROCESS | 4204 | Values: 161.0 169.0 160.0 162.0 161.0 164.0 175.0 162.0 161.0 161.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:36.34 (48.5%) stddev-sans-first:37.98 22:59:06 INFO - PROCESS | 4204 | Values: 75.0 76.0 75.0 159.0 76.0 74.0 75.0 75.0 164.0 77.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:85.00 stddev:28.67 (33.7%) stddev-sans-first:29.67 22:59:06 INFO - PROCESS | 4204 | Values: 85.0 85.0 149.0 84.0 87.0 85.0 141.0 86.0 84.0 143.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.00 stddev:2.85 (2.4%) stddev-sans-first:3.00 22:59:06 INFO - PROCESS | 4204 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 126.0 117.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 22:59:06 INFO - PROCESS | 4204 | Values: 146.0 147.0 148.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 22:59:06 INFO - PROCESS | 4204 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 97.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.45 22:59:06 INFO - PROCESS | 4204 | Values: 53.0 54.0 55.0 53.0 54.0 56.0 54.0 58.0 55.0 55.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 22:59:06 INFO - PROCESS | 4204 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 61.0 63.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:80.00 stddev:16.15 (20.2%) stddev-sans-first:16.95 22:59:06 INFO - PROCESS | 4204 | Values: 79.0 78.0 82.0 81.0 80.0 80.0 79.0 86.0 131.0 79.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:132.50 stddev:7.51 (5.7%) stddev-sans-first:7.39 22:59:06 INFO - PROCESS | 4204 | Values: 137.0 122.0 122.0 137.0 136.0 120.0 139.0 125.0 129.0 123.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:1.87 (1.2%) stddev-sans-first:1.99 22:59:06 INFO - PROCESS | 4204 | Values: 160.0 160.0 164.0 160.0 162.0 160.0 159.0 157.0 159.0 161.0 22:59:06 INFO - PROCESS | 4204 | 22:59:06 INFO - PROCESS | 4204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.89 (2.9%) stddev-sans-first:1.96 22:59:06 INFO - PROCESS | 4204 | Values: 65.0 63.0 66.0 63.0 68.0 64.0 64.0 62.0 63.0 62.0 22:59:06 INFO - PROCESS | 4204 | -------- Summary: end -------- 22:59:06 INFO - PROCESS | 4204 | 22:59:07 INFO - TEST-INFO | 4204: exit 0 22:59:07 INFO - TEST-OK | kraken | took 61355ms 22:59:07 INFO - SUITE-END | took 1171s 22:59:07 INFO - Completed test suite (00:19:32) 22:59:07 INFO - javascript benchmark 22:59:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7328.594253701891, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.669914658961, 3170.4134735074026, 3188.601424821897, 3196.3127927495584, 3205.567248421464, 5414.539764120054, 5437.075697131488, 5485.835424937253, 5512.0, 5516.062269414199, 5418.322709661293, 5481.780728770845, 5497.422770609079, 5550.195221692852, 5595.38450770416, 4966.776495057722, 4985.925211121836, 5096.974515127419, 5141.511556402136, 5176.120059589879, 720.7454305806344, 5083.389993200821, 5125.103106956286, 5138.665986710852, 5157.71632560209, 5048.974755126201, 5066.037452883958, 5070.771815268304, 5084.745762711868, 5106.617003724736, 4986.925196122061, 5092.337996060525, 5094.2103973884105, 5105.387353517564, 5127.897442051175, 5011.498850114996, 5024.246363045536, 5026.2711906773675, 5055.064813009605, 5055.140626093536, 5504.4495550444635, 5507.4767897050115, 5520.558355331564, 5536.307961504812, 5576.832695019115, 5763.769449222026, 5765.567582431292, 5824.679642619654, 5907.261592300963, 5917.852053698649, 5899.646021238696, 5948.107783832416, 5989.5507836911975, 6001.279846418414, 6002.429769171922, 5517.862053448655, 5524.475174858382, 5530.198121272433, 5532.474414930575, 5535.169724541311, 5865.120231965239, 5999.370066143079, 6010.699465026732, 6026.939730602726, 6043.36544662804, 5797.304323481209, 5802.071668533099, 5810.360860305363, 5845.649261044351, 5892.234009578813, 5925.703714814242, 5928.525717942554, 5928.911066334009, 5938.673372964442, 5946.524278057745, 5790.392008839011, 5804.2744656917885, 5827.912581311284, 5840.941590584125, 5861.677607731615, 5745.540356771448, 5774.711264436762, 5792.594518383673, 5836.037053886146, 5884.9705751470965, 4427.712198707074, 4440.666949978699, 4448.733076015449, 4459.888502787457, 4498.032922921588, 3966.2860685076384, 3981.422693709396, 3998.8800335989968, 4002.6197511236387, 4059.9594004060173, 5664.433556644302, 5686.0, 5689.175069614883, 5691.231683722727, 5731.942680573141, 5962.403759624003, 6042.909356359658, 6046.18376519173, 6053.424924632153, 6066.848328791815, 5483.369412517532, 5634.267545219095, 5680.147977803363, 5694.402087780806, 5699.2590963174525, 5027.949720502748, 5028.296038554532, 5030.572401345927, 5035.924461133086, 5050.191969284897, 6231.4391704746795, 6231.470325022424, 6231.906521402183, 6232.626042437469, 6237.03325984464, 5887.381824908409, 5887.4406931341455, 5921.467067963904, 5950.761969521171, 5974.9402505974385, 6066.636001839904, 6109.419605137505, 6123.08153776937, 6123.908141377794, 6142.232220972379, 5686.943130568641, 5833.0, 5836.766529338779, 5839.182514447895, 5842.328132264844, 5812.3025236971835, 5886.558508111823, 5903.881922361443, 5929.703514824328, 5944.702764861653, 5751.166080918159, 5782.566307527037, 5783.797567085132, 5790.189373487631, 5790.971045144747, 5622.465865742748, 5705.4579814917515, 5763.106718458645, 5774.9133762994425, 5775.826725198251, 5617.915731263953, 5654.095344744986, 5698.0, 5722.456366645162, 5801.738921748447, 5809.070548712186, 5832.24180856486, 5847.7368518417625, 5851.561132915133, 5859.824205273849, 5612.775488980558, 5633.380328163817, 5739.9139012914, 5750.913736293875, 5756.712164391847], "value": 5422.038901264796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9619124756894, 614.0298328640748, 641.7689631732576, 643.536653609401, 654.054890682963, 42794.358084628715, 44055.33916991248, 44060.0, 44304.77847610762, 48543.27185092226, 45745.08509829801, 46357.30464043042, 46587.30119048217, 46668.29997550039, 46699.533004669946, 8990.640374385017, 9146.542672866364, 9146.817063658722, 9149.725508234764, 9162.037986011474, 9048.819023619524, 9058.27533797298, 9090.27277817773, 9121.771955701095, 9125.817483650322, 9075.36472446929, 9078.591463384164, 9120.224780893632, 9132.041135680758, 9151.405158664698, 8993.910060899372, 9072.183503484684, 9085.591148398338, 9112.635494580209, 9136.725898223063, 8886.86669699955, 8917.509536975464, 8919.464832110029, 8958.283337332998, 8963.83470148883, 41488.1702365951, 41710.37434438486, 41897.162056758694, 41902.580974190474, 41912.0, 3527.753057285991, 3642.5993140754495, 3723.3670276053135, 3783.6027217142077, 3796.6013568575177, 32619.85830495945, 33130.0, 33316.83341583301, 33392.33215335704, 33410.66589334124, 4252.896524170977, 4325.610695037431, 4344.239758042361, 4419.359192917042, 4527.524609915978, 358666.0, 359636.0, 360759.0, 361704.0, 361779.0, 62045.37954620396, 62553.68723156355, 62674.0, 62711.372886270554, 62843.685781571716, 65479.67260163669, 66363.0, 66388.6680566594, 66425.0, 66581.33418665848, 15315.31081101353, 15753.054816711034, 15790.447334343473, 16101.516954491384, 16205.837941620668, 12586.118971671895, 12702.110852240254, 12765.042621803403, 12834.935825321001, 12835.743285134431, 19578.30873717519, 19691.704624430644, 19715.309964151187, 19793.0, 19803.900980495295, 7243.275672432715, 7416.184219735825, 7573.810654733566, 7616.23837616234, 7646.885296720554, 1004.4124187350482, 1039.4542864995938, 1123.1464087293716, 1139.0773473486338, 1160.5473865192582, 32917.67082329194, 33551.0, 33670.663293367244, 33808.0, 33893.49159762605, 1165.6677846813786, 1177.8881006304387, 1209.0508950473836, 1211.9333436661068, 1243.160866415166, 16819.91590042042, 17307.826921730873, 17451.214695338742, 17454.825451745575, 17511.299548017938, 536714.0, 538521.0, 541461.0, 542481.0, 542696.0, 59862.70068649629, 60093.69484678297, 60118.09822852661, 60257.0, 60342.094868577005, 1333.7599232138114, 1390.860913908601, 1395.0513650717407, 1398.7831886057677, 1398.881095106907, 31537.0, 32032.35935281328, 32354.0, 32409.18977025499, 32603.836980814944, 51712.74143629258, 51778.74110629423, 52140.739296303276, 52174.0, 52263.0, 415345.0, 415843.0, 416860.0, 417581.0, 421062.0, 28818.855905721175, 28935.0, 29317.120486385444, 29398.559021614266, 29494.410111797213, 48385.516144838104, 48585.5141448581, 49096.75451622719, 49433.25850112323, 49499.752501237264, 41402.79298603608, 42098.368524471545, 42262.57737422586, 42407.36880763124, 42801.785991069846, 42339.57660423356, 42622.57377426186, 42713.786431067645, 42892.35661465018, 43313.783431082644, 35971.82014089913, 40968.79515602403, 41227.79386103051, 41808.3728744063, 42163.36754948617, 35685.28629427449, 38057.619423806515, 38266.426003610526, 38457.0, 38719.902407806745, 23249.883750581816, 23630.29109126729, 24725.43677672509, 25006.624900626142, 28180.85909570439], "value": 20570.782352211194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.57806412945746, 389.5928754451598, 391.47346818529076, 399.71420434389404, 409.19797197492915, 18566.90716546417, 18945.43163705091, 19831.60336793265, 19873.503162420948, 19952.50118747032, 18317.450476485694, 18360.540986475313, 18363.72454413185, 18661.16024778885, 18673.06634668268, 5631.099024156126, 5659.51894089003, 5851.678157701324, 5876.529877609781, 5898.528117750569, 5738.684372359518, 5793.884122317572, 5815.331236907747, 5836.416358364172, 5851.414858514136, 5531.419200983879, 5772.538196944234, 5783.479486846183, 5788.710564471759, 5802.216700745409, 5726.45598668128, 5755.25181726375, 5765.913511297334, 5772.740226689809, 5796.855078623026, 4997.825076122354, 5103.923441148386, 5300.284461597674, 5323.627346085776, 5368.62419630626, 13328.400221990034, 13425.66435839102, 13511.391987360592, 19898.50253743668, 22167.667484987738, 2291.9083236670513, 2319.52449747803, 2490.2778194323623, 2775.403288293027, 2928.5636469877513, 9848.409095454295, 9870.506474676238, 10369.48152592375, 10390.948045259802, 12526.248425094433, 1948.133080779054, 1964.803519648038, 1968.1340210307562, 1991.4224874786294, 2049.477383267272, 81095.5945220276, 82876.0, 83777.58111209466, 85495.0, 86479.13520864774, 10752.40861752611, 10925.508352124174, 10926.399048052433, 10931.781364372668, 11060.949209825054, 14974.17642029677, 15027.0, 15129.0, 15137.470188543348, 15148.0, 7771.145174030852, 7900.288973992253, 7934.4691612233155, 7940.880886786703, 7962.761117166494, 7613.809654758676, 7616.428767842434, 7637.961810190914, 7777.961110194413, 7784.338331241908, 4560.338750881104, 4587.587117159405, 4593.26507758757, 4750.14497390473, 4819.349387832668, 1914.5405102775512, 1997.1611922992379, 2006.1774672384545, 2010.5375763574168, 2013.0538646835964, 901.4456109492614, 961.1589858873485, 967.0474582536197, 982.5038355630361, 1015.1067060986285, 18075.27698892056, 19154.138063787163, 19224.134913928905, 19247.711284330748, 19606.70589941152, 987.6641941739842, 993.7863359377768, 1014.9594016239415, 1036.9533370998172, 1038.7247379444452, 8911.465312081296, 10413.323133996266, 10769.0, 10804.0, 10825.242233043611, 337467.0, 344740.0, 345716.0, 473037.0, 474056.0, 60344.09483857745, 82290.58854705688, 88813.55593222122, 89191.66212506818, 96367.0, 978.574320170728, 998.173342782706, 1044.2951008069674, 1052.7420781908481, 1059.2108878885126, 17224.569385765455, 17533.561660958578, 17578.73631895497, 17846.375376861746, 18102.637947241245, 39432.6056739429, 41824.79087604542, 42250.36624450574, 43037.56962430335, 43644.78177609092, 57046.7147664259, 58978.0, 59107.113393299995, 59316.0, 59644.70177649084, 7408.888866667112, 7592.81017974555, 7695.92304076952, 8696.304295656206, 9173.266138708754, 9474.905250947679, 11851.940740296242, 13052.934735326262, 13308.201507909556, 13420.597382078553, 11941.16411851162, 12017.63947081589, 12034.277943323428, 12202.816957745463, 12206.344158683482, 11535.480903359201, 11706.648800535997, 11756.58851940178, 11784.941075294568, 11969.64091077269, 6544.705488252945, 11717.941410292893, 11915.570131584265, 12200.389980501117, 12223.572174973833, 8433.578321083798, 8690.130986901258, 8886.025114634136, 8914.153155450222, 8963.686270980485, 8855.51294678773, 10853.0, 10916.890831091587, 11243.60647377338, 11453.141014423785], "value": 9009.472002095528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.5120684570672, 1474.2776039740525, 1607.2686927448005, 1734.3322820714022, 1738.5740493579076, 7718.266764657348, 8215.75352739418, 8454.450460720065, 8854.937407511099, 8867.955660221705, 8369.623366948486, 8693.826123477527, 8788.428752131107, 8797.340199485032, 8808.955955220215, 2248.876311802846, 2257.16484900587, 2267.818574514035, 2276.4081338851934, 2286.6684330772027, 2259.243153543565, 2279.2364557873134, 2315.235972129202, 2316.4672125411166, 2321.1411777642297, 2249.3701763506247, 2276.1009401286483, 2278.3734473019886, 2292.8280378971563, 2300.620397634388, 2223.67756675282, 2233.932982010542, 2256.0524579676576, 2258.8644681319092, 2259.017327462559, 2251.3808702606916, 2258.7967082962614, 2265.750767415583, 2272.1479445208047, 2281.589313923493, 8768.605412756442, 8776.078511756237, 8847.73456796297, 8864.601092950832, 8896.110388961117, 5006.824761133379, 5094.821681241176, 5142.1772516397195, 5155.74221288934, 5155.819546315898, 3049.878004879802, 3136.9843150784327, 3261.119497735598, 3263.167892187501, 3275.0, 1141.5034460009922, 1146.2148428326539, 1166.1720178673067, 1180.1797750563362, 1181.7813704464702, 11855.762884742344, 11866.406679666068, 11879.168458207843, 11930.343831089287, 11955.342456164908, 4306.332518459643, 4310.6335961443, 4429.15845989261, 4444.888877778017, 4451.9554804451545, 10054.64808731691, 10115.797684046278, 10124.54439550222, 10155.339902906288, 10171.7457063574, 5043.117454445457, 5068.4424713281505, 5072.82245121419, 5073.289739436482, 5074.746262686851, 4180.832766689298, 4543.363929049936, 4646.606018194528, 4693.296005599187, 4706.223473126965, 3866.729328947003, 3879.7866117363815, 3895.7078219133114, 3982.880513584597, 3983.3270026588903, 1221.859486159103, 1244.7448273103992, 1251.2930194440112, 1253.2918900821007, 1256.3341429042623, 845.9594698520854, 880.5201165364764, 886.4636894678755, 921.1939552891221, 939.7650587353162, 5674.177244299636, 5795.565332600072, 5797.942020579824, 5880.323762767336, 5920.259967504062, 930.15356026016, 935.9532023398802, 949.1931857920712, 955.4458414119794, 983.1397527163732, 4000.6999475038906, 4003.0, 4028.738132021409, 4076.9184616307507, 4100.0774825664585, 10656.733581660366, 10919.181061420426, 10925.726856828644, 11026.228164028442, 11044.558217671203, 10779.083777878812, 10823.080038196842, 10824.13406927444, 10870.891291087146, 10909.727256818644, 7659.693612255559, 8101.959490202511, 8182.427230093956, 8239.0, 8246.958765206136, 5875.148103525051, 5936.7922122725495, 6011.128386384037, 6122.418370254819, 6129.141920131275, 9906.851397228904, 9967.850482242628, 10246.795064098826, 10300.639477618248, 10388.948055259676, 10178.694639160836, 10230.386176829414, 10339.63811266602, 10366.06705396518, 10451.790964180826, 6955.930440695731, 7653.0, 7803.258690424401, 7933.642986065525, 7985.960070199611, 8629.741107766777, 8678.305735541267, 8714.215720585178, 8721.171488708562, 8758.343124265579, 7617.200193979553, 7712.460127791001, 7765.068191816792, 7917.960410197912, 7960.283574478325, 7558.168601453725, 7622.9237707622215, 7662.0422447194105, 7773.1060927994, 7796.142424333432, 6785.287544807724, 6824.761133360308, 6844.041834143323, 6854.657267136524, 6864.347886950732, 4981.3026176334615, 5029.06962211992, 5082.4409314976065, 5161.354830646169, 5168.715720635401, 5145.845624631267, 5180.0, 5218.947810521998, 5225.6603320784025, 5236.266922630911], "value": 4580.167269202568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.46139408581746, 333.62967106511775, 334.6736931491796, 338.8360980033584, 342.0968642783052, 5619.4380561943835, 5709.628874123185, 5764.394738552454, 5806.0, 5820.417958204177, 5654.858628534278, 5682.573806964484, 5695.345035320939, 5696.857578560538, 5724.484796368326, 4392.516823149451, 4428.512863585003, 4447.688661793676, 4461.24158892989, 4464.6428285737065, 4012.759234445928, 4328.0, 4337.978310108445, 4357.651387888961, 4367.45406824147, 4315.287977483711, 4318.136372725452, 4337.306031035035, 4362.781860906942, 4365.039691267916, 4336.934945975797, 4352.804123814436, 4357.3899654048455, 4369.235383807837, 4373.343998400233, 3754.718396120302, 3807.143392736612, 3835.0987517933263, 3836.5971572984713, 3843.26977874203, 5538.363088244863, 5541.030319694078, 5552.3892371839065, 5577.972110139423, 5608.579356548275, 5008.398992120969, 5022.146235140035, 5022.949770502285, 5023.874403139914, 5034.622403319766, 5729.682173100168, 5884.323302820188, 5896.64620122794, 5902.793402230945, 5918.957959503964, 4130.586941305875, 4161.0, 4169.708120431571, 4172.582741725833, 4185.0, 5918.786648737042, 6078.784243151344, 6081.574289799716, 6102.542309326774, 6161.845953851145, 4247.915041699149, 4255.297875850512, 4267.253230684618, 4270.7010509264055, 4276.593723596254, 4321.243782338078, 4336.718113322624, 4364.323529852878, 4372.781360932005, 4378.737275763465, 5005.824796132118, 5016.974915125401, 5023.924641130386, 5062.164742817394, 5063.873403164876, 5716.685582292931, 5902.557308201816, 5912.374097123239, 5914.645121292736, 5915.0, 1477.697072100217, 1501.1368463133742, 1504.8871334649946, 1505.4580351073605, 1508.2081906998694, 906.5331354352513, 930.3998920696113, 940.8024314893812, 949.5110018340561, 957.9808403832023, 5076.487138866285, 5104.923426148611, 5681.289838770153, 5756.30924289088, 5795.9420405796245, 6048.909266361008, 6151.876962460726, 6178.876422471525, 6187.5149964009215, 6196.659183744938, 5653.971730141323, 5814.215080964101, 5837.357890632027, 5849.912251316234, 5859.091840764689, 3250.6749325067776, 3256.397566450214, 3273.541704161419, 3291.8847840325475, 3296.8186749728516, 6325.841853953596, 6327.620342779356, 6329.708551553259, 6396.880545904448, 6415.230172379344, 6139.293981192131, 6254.34329395416, 6294.653794041372, 6295.181626388632, 6371.139896114058, 6410.557624534443, 6422.775202867877, 6439.967800160969, 6456.451201647818, 6457.418832305115, 5955.749292648592, 6158.476529494864, 6210.347913469202, 6220.409061139185, 6239.1577137085915, 6126.387361263838, 6151.753929842936, 6169.784057557964, 6191.81424557264, 6198.783042593487, 6247.937520624918, 6335.859545281894, 6374.968125159345, 6395.296517383177, 6414.717056588795, 4226.36604509326, 4226.556211597738, 4254.298040823353, 4256.553061928576, 4288.126954940135, 6170.81487555374, 6172.629642221481, 6202.596831205957, 6235.46998505114, 6245.781397651061, 5570.303712035996, 5919.792807251725, 5947.126655103629, 5993.250843644544, 6007.317950973735, 5887.409539802473, 5934.554908381802, 5941.346451890202, 5951.55363347742, 5979.970100149471, 5661.179129026351, 5856.970715146397, 5880.529867533117, 5905.616134951214, 5933.1396947443245, 5970.731317090655, 5996.490298324691, 6004.0, 6025.909611355745, 6053.757849685963, 5772.451617096537, 5905.553139480855, 5911.054231322968, 5913.852153696192, 5975.908432048922], "value": 4513.340225128508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.8933765266379, 763.1338430880949, 792.5165648954139, 798.8801679748038, 801.8676918308479, 14643.0, 14672.779908301383, 15046.62383440416, 15059.472918447857, 15087.924560377196, 13648.38582263798, 13952.162870227794, 13953.44186232552, 13974.580762577114, 13978.09142405743, 669.8760729265077, 786.4337676872642, 789.100425514912, 807.4509333653143, 809.9473534220257, 804.8792681097824, 805.8227190018187, 808.292743849132, 810.1331575214523, 811.1158836867813, 844.8943882014748, 845.0366582096415, 846.7544412120509, 850.4259624753298, 852.6674596907211, 842.3513894301415, 844.4215712237076, 845.2308399356587, 845.3406343052429, 845.378646694682, 614.4807637546311, 616.6207782213951, 617.5245061302817, 618.4032408725601, 619.2290598205218, 14598.781018284733, 14610.050346727536, 14644.194569298685, 14646.780298295535, 14690.926545367312, 15018.624534386618, 15048.774268385983, 15262.0, 15442.845571544365, 15545.0, 11906.285622862655, 12237.571684991071, 12271.263724176579, 12302.630921072383, 12853.100282980195, 3631.5823680276576, 3631.8728844490315, 3705.6479634434686, 3709.55485341758, 3733.2346868891814, 77972.0, 79354.0, 79674.20325796783, 79779.60110199412, 79852.20147798564, 10313.0, 10453.482749510233, 10833.404162771123, 11151.888481115247, 11877.762444751057, 19897.104630291673, 20241.190352386035, 20257.493562661053, 20280.492987675425, 20310.390688279374, 8200.138985406566, 8200.564901142396, 8257.174282571696, 8280.213379728915, 8331.916680833236, 4727.196376615983, 4813.133635945494, 4815.566599006106, 4893.266010098442, 4930.433000204951, 3265.4938484534937, 3389.2035371687634, 3391.6608339165887, 3403.149212696826, 3408.0, 658.4732214228598, 664.5979182594557, 670.6747227594612, 671.2716702377877, 672.4721093941331, 614.1954040207343, 622.9159063526456, 684.2678334182377, 750.4709180028067, 758.1546575568202, 9113.633528751403, 9457.0, 9647.083527064917, 9705.708828735009, 10039.533967804517, 704.6476761619191, 725.1153592617104, 727.6834576959039, 738.103204606395, 746.4103358346845, 4527.524609915978, 4699.835505757351, 4722.291656251589, 4788.569028787356, 4811.807527698923, 96434.51782741041, 108164.0, 116465.41767291109, 116814.0, 119036.0, 84301.15698843056, 99768.51273180045, 100090.0, 100831.49584252032, 101292.49353753185, 65223.673881631235, 66802.33197668155, 87034.56482717546, 88166.0, 90190.0, 9675.177609902956, 9689.854652180364, 9928.652497162564, 9962.78670697259, 10225.642102526375, 49607.25589116094, 49870.75064624654, 50275.49724502708, 51148.488515114375, 52257.7387113062, 68129.3187068123, 69697.0, 73443.0, 78417.60791196008, 79531.20468795238, 12952.158109722837, 13107.672308192372, 13169.275689836768, 13469.057165998285, 13612.25132617676, 14623.415063397344, 14646.560603181922, 14919.477818276308, 15055.698886022437, 15215.239238038275, 12905.548305809252, 12999.740005199654, 13116.147450416074, 13221.140625859289, 13513.662158446117, 12393.62819115428, 12831.230126192459, 12875.163114397534, 12890.806637900627, 12916.0, 12310.384480776105, 12398.0, 13160.802587960996, 13357.866421336052, 13850.930745346612, 11471.369074700971, 11707.180497365443, 11930.0, 12337.876621234032, 12641.494340226656, 9207.168743484142, 9868.950655246677, 9955.502224888582, 9969.95315491892, 10024.348417352849], "value": 7457.422572328794, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 104.0, 117.0, 112.0, 110.0, 113.0, 111.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 153.0, 180.0, 135.0, 159.0, 159.0, 127.0, 181.0, 127.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 169.0, 160.0, 162.0, 161.0, 164.0, 175.0, 162.0, 161.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 159.0, 76.0, 74.0, 75.0, 75.0, 164.0, 77.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 149.0, 84.0, 87.0, 85.0, 141.0, 86.0, 84.0, 143.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 126.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 53.0, 54.0, 56.0, 54.0, 58.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 63.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 82.0, 81.0, 80.0, 80.0, 79.0, 86.0, 131.0, 79.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 122.0, 122.0, 137.0, 136.0, 120.0, 139.0, 125.0, 129.0, 123.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 164.0, 160.0, 162.0, 160.0, 159.0, 157.0, 159.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 63.0, 68.0, 64.0, 64.0, 62.0, 63.0, 62.0], "value": 64.0, "unit": "score"}]}]} 22:59:08 INFO - Return code: 0 22:59:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:59:08 ERROR - # TBPL SUCCESS # 22:59:08 INFO - Running post-action listener: _resource_record_post_action 22:59:08 INFO - ##### 22:59:08 INFO - ##### Finished run-tests step (success) 22:59:08 INFO - ##### 22:59:08 INFO - Running post-run listener: _resource_record_post_run 22:59:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555229184; Read time: 20; Write time: 584616 22:59:08 INFO - TinderboxPrint: CPU usage
13.5% 22:59:08 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 22:59:08 INFO - TinderboxPrint: I/O write bytes / time
555,229,184 / 584,616 22:59:08 INFO - TinderboxPrint: CPU idle
8,216.2 (86.5%) 22:59:08 INFO - TinderboxPrint: CPU user
1,224.1 (12.9%) 22:59:08 INFO - TinderboxPrint: Swap in / out
0 / 0 22:59:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256679936; Read time: 0; Write time: 313712 22:59:08 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297963520; Read time: 20; Write time: 270896 22:59:08 INFO - Running post-run listener: _upload_blobber_files 22:59:08 INFO - Blob upload gear active. 22:59:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:59:08 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 22:59:08 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:59:08 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:59:09 INFO - (blobuploader) - INFO - Open directory for files ... 22:59:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:59:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:10 INFO - (blobuploader) - INFO - Done attempting. 22:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:59:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:10 INFO - (blobuploader) - INFO - Done attempting. 22:59:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:59:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:14 INFO - (blobuploader) - INFO - Done attempting. 22:59:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:59:14 INFO - Return code: 0 22:59:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:59:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:59:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c420c800a8da41c71663345710f0077cb1d146eaf2988355c7cbf73038fb198569555e7d7e627cc2a82950a2bb627a143bd434211ecb794d246cbfa7bc0cae03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d7ec31a34e4a680c3f9e333c1d726c9b6d81495a684fa32c23814657c4503c77ac23a285ffe6acf937b75713dacb8a490ab4b8cea91ccc0cc3fef2076d5631b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1199990bcd3c02e9ec8843064e912728b664fd061897e46e49fda9288a4c26fa83b62c219f47ce5014a576fcccdf3e55a84d5d3d82151a628a47df3c878e8f2"} 22:59:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:59:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:59:14 INFO - Contents: 22:59:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c420c800a8da41c71663345710f0077cb1d146eaf2988355c7cbf73038fb198569555e7d7e627cc2a82950a2bb627a143bd434211ecb794d246cbfa7bc0cae03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d7ec31a34e4a680c3f9e333c1d726c9b6d81495a684fa32c23814657c4503c77ac23a285ffe6acf937b75713dacb8a490ab4b8cea91ccc0cc3fef2076d5631b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1199990bcd3c02e9ec8843064e912728b664fd061897e46e49fda9288a4c26fa83b62c219f47ce5014a576fcccdf3e55a84d5d3d82151a628a47df3c878e8f2"} 22:59:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:59:14 INFO - Copying logs to upload dir... 22:59:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:59:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.171996 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-27 22:59:14.238995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 22:59:14.242550) ========= 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=62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064 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-Inbound/sha512/c420c800a8da41c71663345710f0077cb1d146eaf2988355c7cbf73038fb198569555e7d7e627cc2a82950a2bb627a143bd434211ecb794d246cbfa7bc0cae03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d7ec31a34e4a680c3f9e333c1d726c9b6d81495a684fa32c23814657c4503c77ac23a285ffe6acf937b75713dacb8a490ab4b8cea91ccc0cc3fef2076d5631b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1199990bcd3c02e9ec8843064e912728b664fd061897e46e49fda9288a4c26fa83b62c219f47ce5014a576fcccdf3e55a84d5d3d82151a628a47df3c878e8f2"} build_url:https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/MRJRiv3TTda6-5NjVKtD1w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c420c800a8da41c71663345710f0077cb1d146eaf2988355c7cbf73038fb198569555e7d7e627cc2a82950a2bb627a143bd434211ecb794d246cbfa7bc0cae03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d7ec31a34e4a680c3f9e333c1d726c9b6d81495a684fa32c23814657c4503c77ac23a285ffe6acf937b75713dacb8a490ab4b8cea91ccc0cc3fef2076d5631b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1199990bcd3c02e9ec8843064e912728b664fd061897e46e49fda9288a4c26fa83b62c219f47ce5014a576fcccdf3e55a84d5d3d82151a628a47df3c878e8f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 22:59:14.268795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:59:14.269192) ========= 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=62c568580acbfdaac3eec7be000001dc-1467085774.597717-2114559064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 22:59:14.353578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 22:59:14.353971) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 22:59:14.354316) ========= ========= Total master_lag: 0.20 =========