builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1465600659.29 results: success (0) buildid: 20160610160226 builduid: 4d0fcd2486d24ec2a0961f41b22160ce revision: fb3a694a5c432916d9414b698efe1ffd0d461db1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.286952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.287485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.287818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.367556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.367907) ========= 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=826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 16:17:40-- 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% 41.5M=0s 2016-06-10 16:17:40 (41.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.292686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.680428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.680783) ========= 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=826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.732860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:39.733689) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb3a694a5c432916d9414b698efe1ffd0d461db1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fb3a694a5c432916d9414b698efe1ffd0d461db1 --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=826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 16:17:40,885 truncating revision to first 12 chars 2016-06-10 16:17:40,885 Setting DEBUG logging. 2016-06-10 16:17:40,885 attempt 1/10 2016-06-10 16:17:40,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb3a694a5c43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 16:17:41,210 unpacking tar archive at: fx-team-fb3a694a5c43/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:40.403253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:40.403705) ========= script_repo_revision: fb3a694a5c432916d9414b698efe1ffd0d461db1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:40.404367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:40.404838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 16:17:40.427685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-10 16:17:40.428008) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:17:41 INFO - MultiFileLogger online at 20160610 16:17:41 in /builds/slave/test 16:17:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:17:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:17:41 INFO - {'append_to_log': False, 16:17:41 INFO - 'base_work_dir': '/builds/slave/test', 16:17:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:17:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:17:41 INFO - 'branch': 'Fx-Team-Non-PGO', 16:17:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:17:41 INFO - 'config_files': ('talos/linux_config.py',), 16:17:41 INFO - 'default_actions': ('clobber', 16:17:41 INFO - 'read-buildbot-config', 16:17:41 INFO - 'download-and-extract', 16:17:41 INFO - 'populate-webroot', 16:17:41 INFO - 'create-virtualenv', 16:17:41 INFO - 'install', 16:17:41 INFO - 'run-tests'), 16:17:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:17:41 INFO - 'download_minidump_stackwalk': True, 16:17:41 INFO - 'download_symbols': 'ondemand', 16:17:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:17:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:17:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:17:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:17:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:17:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:17:41 INFO - 'installer_path': 'installer.exe', 16:17:41 INFO - 'log_level': 'info', 16:17:41 INFO - 'log_name': 'talos', 16:17:41 INFO - 'log_to_console': True, 16:17:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:17:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:17:41 INFO - 'opt_config_files': (), 16:17:41 INFO - 'pip_index': False, 16:17:41 INFO - 'sps_profile': False, 16:17:41 INFO - 'sps_profile_interval': 0, 16:17:41 INFO - 'suite': 'dromaeojs-e10s', 16:17:41 INFO - 'system_bits': '32', 16:17:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:17:41 INFO - 'title': 'talos-linux64-ix-052', 16:17:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:17:41 INFO - 'use_talos_json': True, 16:17:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:17:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:17:41 INFO - 'work_dir': 'build'} 16:17:41 INFO - ##### 16:17:41 INFO - ##### Running clobber step. 16:17:41 INFO - ##### 16:17:41 INFO - Running pre-action listener: _resource_record_pre_action 16:17:41 INFO - Running main action method: clobber 16:17:41 INFO - rmtree: /builds/slave/test/build 16:17:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:17:42 INFO - Running post-action listener: _resource_record_post_action 16:17:42 INFO - ##### 16:17:42 INFO - ##### Finished clobber step (success) 16:17:42 INFO - ##### 16:17:42 INFO - ##### 16:17:42 INFO - ##### Running read-buildbot-config step. 16:17:42 INFO - ##### 16:17:42 INFO - Running pre-action listener: _resource_record_pre_action 16:17:42 INFO - Running main action method: read_buildbot_config 16:17:42 INFO - Using buildbot properties: 16:17:42 INFO - { 16:17:42 INFO - "project": "", 16:17:42 INFO - "product": "firefox", 16:17:42 INFO - "script_repo_revision": "production", 16:17:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:17:42 INFO - "repository": "", 16:17:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:17:42 INFO - "buildid": "20160610160226", 16:17:42 INFO - "pgo_build": "False", 16:17:42 INFO - "basedir": "/builds/slave/test", 16:17:42 INFO - "buildnumber": 1582, 16:17:42 INFO - "slavename": "talos-linux64-ix-052", 16:17:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:17:42 INFO - "platform": "ubuntu64_hw", 16:17:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:17:42 INFO - "branch": "fx-team", 16:17:42 INFO - "repo_path": "integration/fx-team", 16:17:42 INFO - "revision": "fb3a694a5c432916d9414b698efe1ffd0d461db1", 16:17:42 INFO - "stage_platform": "linux64", 16:17:42 INFO - "builduid": "4d0fcd2486d24ec2a0961f41b22160ce", 16:17:42 INFO - "slavebuilddir": "test" 16:17:42 INFO - } 16:17:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:17:42 INFO - Running post-action listener: _resource_record_post_action 16:17:42 INFO - ##### 16:17:42 INFO - ##### Finished read-buildbot-config step (success) 16:17:42 INFO - ##### 16:17:42 INFO - ##### 16:17:42 INFO - ##### Running download-and-extract step. 16:17:42 INFO - ##### 16:17:42 INFO - Running pre-action listener: _resource_record_pre_action 16:17:42 INFO - Running main action method: download_and_extract 16:17:42 INFO - mkdir: /builds/slave/test/build/tests 16:17:42 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')]} 16:17:42 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:17:53 INFO - Downloaded 1361 bytes. 16:17:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:17:53 INFO - Using the following test package requirements: 16:17:53 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:17:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:17:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'jsshell-linux-x86_64.zip'], 16:17:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:17:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:17:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:17:53 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:17:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:17:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:17:53 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:17:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:17:53 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')]} 16:17:53 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:17:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:17:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:04 INFO - Downloaded 22891786 bytes. 16:18:04 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'] 16:18:04 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 16:18:05 INFO - Return code: 0 16:18:05 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 16:18:05 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')]} 16:18:05 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:06 INFO - Downloaded 22891786 bytes. 16:18:06 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'] 16:18:06 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 16:18:07 INFO - Return code: 0 16:18:07 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')]} 16:18:07 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:08 INFO - Downloaded 10833377 bytes. 16:18:08 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'] 16:18:08 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 16:18:09 INFO - Return code: 0 16:18: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')]} 16:18:09 INFO - https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:18:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5-K0JJYSkWcIZFN3kDXow/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 16:18:10 INFO - Downloaded 55397943 bytes. 16:18:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:10 INFO - mkdir: /builds/slave/test/properties 16:18:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:10 INFO - Contents: 16:18:10 INFO - build_url:https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:18:11 INFO - Running post-action listener: _resource_record_post_action 16:18:11 INFO - Running post-action listener: set_extra_try_arguments 16:18:11 INFO - ##### 16:18:11 INFO - ##### Finished download-and-extract step (success) 16:18:11 INFO - ##### 16:18:11 INFO - ##### 16:18:11 INFO - ##### Running populate-webroot step. 16:18:11 INFO - ##### 16:18:11 INFO - Running pre-action listener: _resource_record_pre_action 16:18:11 INFO - Running main action method: populate_webroot 16:18:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:11 INFO - '--tppagecycles', 16:18:11 INFO - '7'], 16:18:11 INFO - 'tests': ['tsvgm']}}, 16:18:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['damp', 'tps']}, 16:18:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'tests': ['damp', 'tps']}, 16:18:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['dromaeo_dom']}, 16:18:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['a11yr', 16:18:11 INFO - 'ts_paint', 16:18:11 INFO - 'tpaint', 16:18:11 INFO - 'sessionrestore', 16:18:11 INFO - 'sessionrestore_no_auto_restore', 16:18:11 INFO - 'tabpaint']}, 16:18:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:11 INFO - 'ts_paint', 16:18:11 INFO - 'tpaint', 16:18:11 INFO - 'sessionrestore', 16:18:11 INFO - 'sessionrestore_no_auto_restore', 16:18:11 INFO - 'tabpaint']}, 16:18:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:11 INFO - 'ts_paint', 16:18:11 INFO - 'tpaint', 16:18:11 INFO - 'sessionrestore', 16:18:11 INFO - 'sessionrestore_no_auto_restore', 16:18:11 INFO - 'tabpaint']}, 16:18:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:11 INFO - 'ts_paint', 16:18:11 INFO - 'tpaint', 16:18:11 INFO - 'sessionrestore', 16:18:11 INFO - 'sessionrestore_no_auto_restore', 16:18:11 INFO - 'tabpaint']}, 16:18:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['a11yr', 16:18:11 INFO - 'ts_paint', 16:18:11 INFO - 'tpaint', 16:18:11 INFO - 'sessionrestore', 16:18:11 INFO - 'sessionrestore_no_auto_restore', 16:18:11 INFO - 'tabpaint']}, 16:18:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['a11yr', 16:18:11 INFO - 'ts_paint', 16:18:11 INFO - 'tpaint', 16:18:11 INFO - 'sessionrestore', 16:18:11 INFO - 'sessionrestore_no_auto_restore', 16:18:11 INFO - 'tabpaint']}, 16:18:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['tsvgx', 16:18:11 INFO - 'tsvgr_opacity', 16:18:11 INFO - 'tart', 16:18:11 INFO - 'tscrollx', 16:18:11 INFO - 'cart']}, 16:18:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:11 INFO - 'tsvgr_opacity', 16:18:11 INFO - 'tart', 16:18:11 INFO - 'tscrollx', 16:18:11 INFO - 'cart']}, 16:18:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'talos_options': ['--disable-e10s'], 16:18:11 INFO - 'tests': ['tp5o']}, 16:18:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'tests': ['tp5o']}, 16:18:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'talos_options': ['--disable-e10s', 16:18:11 INFO - '--xperf_path', 16:18:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:11 INFO - 'tests': ['tp5n']}, 16:18:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:11 INFO - 'talos_options': ['--xperf_path', 16:18:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:11 INFO - 'tests': ['tp5n']}}, 16:18:11 INFO - 'talos.zip': {'path': '', 16:18:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:11 INFO - Running post-action listener: _resource_record_post_action 16:18:11 INFO - ##### 16:18:11 INFO - ##### Finished populate-webroot step (success) 16:18:11 INFO - ##### 16:18:11 INFO - ##### 16:18:11 INFO - ##### Running create-virtualenv step. 16:18:11 INFO - ##### 16:18:11 INFO - Running pre-action listener: _resource_record_pre_action 16:18:11 INFO - Running main action method: create_virtualenv 16:18:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:11 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 16:18:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:11 INFO - Using real prefix '/usr' 16:18:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:14 INFO - Installing pip.................done. 16:18:14 INFO - Return code: 0 16:18:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18: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', 'pip>=1.5'] in /builds/slave/test/build 16:18: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 pip>=1.5 16:18:14 INFO - Using env: {'DISPLAY': ':0', 16:18:14 INFO - 'HOME': '/home/cltbld', 16:18:14 INFO - 'LANG': 'en_US.UTF-8', 16:18:14 INFO - 'LANGUAGE': 'en_US:en', 16:18:14 INFO - 'LOGNAME': 'cltbld', 16:18:14 INFO - 'MAIL': '/var/mail/cltbld', 16:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:14 INFO - 'MOZ_NO_REMOTE': '1', 16:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:14 INFO - 'NO_EM_RESTART': '1', 16:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:14 INFO - 'PWD': '/builds/slave/test', 16:18:14 INFO - 'SHELL': '/bin/bash', 16:18:14 INFO - 'SHLVL': '1', 16:18:14 INFO - 'TERM': 'linux', 16:18:14 INFO - 'TMOUT': '86400', 16:18:14 INFO - 'USER': 'cltbld', 16:18:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:14 INFO - '_': '/tools/buildbot/bin/python'} 16:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:14 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 16:18:14 INFO - Cleaning up... 16:18:14 INFO - Return code: 0 16:18:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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', '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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:18: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 psutil>=3.1.1 16:18:14 INFO - Using env: {'DISPLAY': ':0', 16:18:14 INFO - 'HOME': '/home/cltbld', 16:18:14 INFO - 'LANG': 'en_US.UTF-8', 16:18:14 INFO - 'LANGUAGE': 'en_US:en', 16:18:14 INFO - 'LOGNAME': 'cltbld', 16:18:14 INFO - 'MAIL': '/var/mail/cltbld', 16:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:14 INFO - 'MOZ_NO_REMOTE': '1', 16:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:14 INFO - 'NO_EM_RESTART': '1', 16:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:14 INFO - 'PWD': '/builds/slave/test', 16:18:14 INFO - 'SHELL': '/bin/bash', 16:18:14 INFO - 'SHLVL': '1', 16:18:14 INFO - 'TERM': 'linux', 16:18:14 INFO - 'TMOUT': '86400', 16:18:14 INFO - 'USER': 'cltbld', 16:18:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:14 INFO - '_': '/tools/buildbot/bin/python'} 16:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:14 INFO - Downloading/unpacking psutil>=3.1.1 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:18:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:16 INFO - Installing collected packages: psutil 16:18:16 INFO - Running setup.py install for psutil 16:18:16 INFO - building 'psutil._psutil_linux' extension 16:18:16 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 16:18:16 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 16:18:16 INFO - building 'psutil._psutil_posix' extension 16:18:16 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 16:18:17 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 16:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:17 INFO - Successfully installed psutil 16:18:17 INFO - Cleaning up... 16:18:17 INFO - Return code: 0 16:18:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:18:17 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')]} 16:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:17 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')]} 16:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:17 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:17 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 16:18:17 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 16:18:17 INFO - Using env: {'DISPLAY': ':0', 16:18:17 INFO - 'HOME': '/home/cltbld', 16:18:17 INFO - 'LANG': 'en_US.UTF-8', 16:18:17 INFO - 'LANGUAGE': 'en_US:en', 16:18:17 INFO - 'LOGNAME': 'cltbld', 16:18:17 INFO - 'MAIL': '/var/mail/cltbld', 16:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:17 INFO - 'MOZ_NO_REMOTE': '1', 16:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:17 INFO - 'NO_EM_RESTART': '1', 16:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:17 INFO - 'PWD': '/builds/slave/test', 16:18:17 INFO - 'SHELL': '/bin/bash', 16:18:17 INFO - 'SHLVL': '1', 16:18:17 INFO - 'TERM': 'linux', 16:18:17 INFO - 'TMOUT': '86400', 16:18:17 INFO - 'USER': 'cltbld', 16:18:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:17 INFO - '_': '/tools/buildbot/bin/python'} 16:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:18:17 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 16:18:17 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 16:18:17 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 16:18:17 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 16:18:17 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 16:18:17 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 16:18:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:18:19 INFO - Installing collected packages: mozsystemmonitor 16:18:19 INFO - Running setup.py install for mozsystemmonitor 16:18:19 INFO - Successfully installed mozsystemmonitor 16:18:19 INFO - Cleaning up... 16:18:19 INFO - Return code: 0 16:18:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:18:19 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')]} 16:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:19 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')]} 16:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:19 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:19 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 16:18:19 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 16:18:19 INFO - Using env: {'DISPLAY': ':0', 16:18:19 INFO - 'HOME': '/home/cltbld', 16:18:19 INFO - 'LANG': 'en_US.UTF-8', 16:18:19 INFO - 'LANGUAGE': 'en_US:en', 16:18:19 INFO - 'LOGNAME': 'cltbld', 16:18:19 INFO - 'MAIL': '/var/mail/cltbld', 16:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:19 INFO - 'MOZ_NO_REMOTE': '1', 16:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:19 INFO - 'NO_EM_RESTART': '1', 16:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:19 INFO - 'PWD': '/builds/slave/test', 16:18:19 INFO - 'SHELL': '/bin/bash', 16:18:19 INFO - 'SHLVL': '1', 16:18:19 INFO - 'TERM': 'linux', 16:18:19 INFO - 'TMOUT': '86400', 16:18:19 INFO - 'USER': 'cltbld', 16:18:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:19 INFO - '_': '/tools/buildbot/bin/python'} 16:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:19 INFO - Downloading/unpacking jsonschema==2.5.1 16:18:19 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 16:18:19 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 16:18:19 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 16:18:19 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 16:18:19 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 16:18:19 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 16:18:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:18:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:18:21 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 16:18:21 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 16:18:21 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 16:18:21 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 16:18:21 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 16:18:21 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 16:18:21 INFO - Downloading functools32-3.2.3-2.tar.gz 16:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:18:21 INFO - warning: no files found matching '*.txt' 16:18:21 INFO - no previously-included directories found matching 'build' 16:18:21 INFO - no previously-included directories found matching 'dist' 16:18:21 INFO - no previously-included directories found matching '.git*' 16:18:21 INFO - Installing collected packages: jsonschema, functools32 16:18:22 INFO - Running setup.py install for functools32 16:18:22 INFO - warning: no files found matching '*.txt' 16:18:22 INFO - no previously-included directories found matching 'build' 16:18:22 INFO - no previously-included directories found matching 'dist' 16:18:22 INFO - no previously-included directories found matching '.git*' 16:18:22 INFO - Successfully installed jsonschema functools32 16:18:22 INFO - Cleaning up... 16:18:22 INFO - Return code: 0 16:18:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:18:22 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')]} 16:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:22 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')]} 16:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:22 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:22 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 16:18:22 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 16:18:22 INFO - Using env: {'DISPLAY': ':0', 16:18:22 INFO - 'HOME': '/home/cltbld', 16:18:22 INFO - 'LANG': 'en_US.UTF-8', 16:18:22 INFO - 'LANGUAGE': 'en_US:en', 16:18:22 INFO - 'LOGNAME': 'cltbld', 16:18:22 INFO - 'MAIL': '/var/mail/cltbld', 16:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:22 INFO - 'MOZ_NO_REMOTE': '1', 16:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:22 INFO - 'NO_EM_RESTART': '1', 16:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:22 INFO - 'PWD': '/builds/slave/test', 16:18:22 INFO - 'SHELL': '/bin/bash', 16:18:22 INFO - 'SHLVL': '1', 16:18:22 INFO - 'TERM': 'linux', 16:18:22 INFO - 'TMOUT': '86400', 16:18:22 INFO - 'USER': 'cltbld', 16:18:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:22 INFO - '_': '/tools/buildbot/bin/python'} 16:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:22 INFO - Downloading/unpacking blobuploader==1.2.4 16:18:22 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 16:18:22 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 16:18:22 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 16:18:22 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 16:18:22 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 16:18:22 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 16:18:24 INFO - Downloading blobuploader-1.2.4.tar.gz 16:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:18:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:18:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 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 16:18:24 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 16:18:25 INFO - Downloading docopt-0.6.1.tar.gz 16:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:18:25 INFO - Installing collected packages: blobuploader, requests, docopt 16:18:25 INFO - Running setup.py install for blobuploader 16:18:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:18:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:18:25 INFO - Running setup.py install for requests 16:18:25 INFO - Running setup.py install for docopt 16:18:25 INFO - Successfully installed blobuploader requests docopt 16:18:25 INFO - Cleaning up... 16:18:25 INFO - Return code: 0 16:18:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:25 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')]} 16:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:25 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')]} 16:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:25 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:25 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 16:18:25 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 16:18:25 INFO - Using env: {'DISPLAY': ':0', 16:18:25 INFO - 'HOME': '/home/cltbld', 16:18:25 INFO - 'LANG': 'en_US.UTF-8', 16:18:25 INFO - 'LANGUAGE': 'en_US:en', 16:18:25 INFO - 'LOGNAME': 'cltbld', 16:18:25 INFO - 'MAIL': '/var/mail/cltbld', 16:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:25 INFO - 'MOZ_NO_REMOTE': '1', 16:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:25 INFO - 'NO_EM_RESTART': '1', 16:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:25 INFO - 'PWD': '/builds/slave/test', 16:18:25 INFO - 'SHELL': '/bin/bash', 16:18:25 INFO - 'SHLVL': '1', 16:18:25 INFO - 'TERM': 'linux', 16:18:25 INFO - 'TMOUT': '86400', 16:18:25 INFO - 'USER': 'cltbld', 16:18:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:25 INFO - '_': '/tools/buildbot/bin/python'} 16:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:25 INFO - Running setup.py (path:/tmp/pip-mSOEm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:25 INFO - Running setup.py (path:/tmp/pip-cbkcWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:26 INFO - Running setup.py (path:/tmp/pip-2jEpOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:26 INFO - Running setup.py (path:/tmp/pip-pAZ9JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:26 INFO - Running setup.py (path:/tmp/pip-mTjaPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:26 INFO - Running setup.py (path:/tmp/pip-xOd1DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:26 INFO - Running setup.py (path:/tmp/pip-zJCtoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:26 INFO - Running setup.py (path:/tmp/pip-vnMfIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:26 INFO - Running setup.py (path:/tmp/pip-ZYaFU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:26 INFO - Running setup.py (path:/tmp/pip-IjWIR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:26 INFO - Running setup.py (path:/tmp/pip-xYDhfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:26 INFO - Running setup.py (path:/tmp/pip-ChqVGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:26 INFO - Running setup.py (path:/tmp/pip-BNUmpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:26 INFO - Running setup.py (path:/tmp/pip-yXh6Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:26 INFO - Running setup.py (path:/tmp/pip-4cmXel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:26 INFO - Running setup.py (path:/tmp/pip-ia2Psa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:27 INFO - Running setup.py (path:/tmp/pip-9xpcgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:18:27 INFO - Running setup.py install for manifestparser 16:18:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozcrash 16:18:27 INFO - Running setup.py install for mozdebug 16:18:27 INFO - Running setup.py install for mozdevice 16:18:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozfile 16:18:27 INFO - Running setup.py install for mozhttpd 16:18:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozinfo 16:18:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozInstall 16:18:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:18:27 INFO - Running setup.py install for mozleak 16:18:28 INFO - Running setup.py install for mozlog 16:18:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for moznetwork 16:18:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for mozprocess 16:18:28 INFO - Running setup.py install for mozprofile 16:18:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for mozrunner 16:18:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Running setup.py install for mozscreenshot 16:18:28 INFO - Running setup.py install for moztest 16:18:28 INFO - Running setup.py install for mozversion 16:18:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:18:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:18:28 INFO - Cleaning up... 16:18:28 INFO - Return code: 0 16:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:28 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:28 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 16:18:28 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 16:18:28 INFO - Using env: {'DISPLAY': ':0', 16:18:28 INFO - 'HOME': '/home/cltbld', 16:18:28 INFO - 'LANG': 'en_US.UTF-8', 16:18:28 INFO - 'LANGUAGE': 'en_US:en', 16:18:28 INFO - 'LOGNAME': 'cltbld', 16:18:28 INFO - 'MAIL': '/var/mail/cltbld', 16:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:28 INFO - 'MOZ_NO_REMOTE': '1', 16:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:28 INFO - 'NO_EM_RESTART': '1', 16:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:28 INFO - 'PWD': '/builds/slave/test', 16:18:28 INFO - 'SHELL': '/bin/bash', 16:18:28 INFO - 'SHLVL': '1', 16:18:28 INFO - 'TERM': 'linux', 16:18:28 INFO - 'TMOUT': '86400', 16:18:28 INFO - 'USER': 'cltbld', 16:18:28 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:28 INFO - '_': '/tools/buildbot/bin/python'} 16:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:29 INFO - Running setup.py (path:/tmp/pip-lCn9eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:29 INFO - Running setup.py (path:/tmp/pip-ZIVyJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:29 INFO - Running setup.py (path:/tmp/pip-VgwrSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:29 INFO - Running setup.py (path:/tmp/pip-FRQT3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:29 INFO - Running setup.py (path:/tmp/pip-fPl5uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:29 INFO - Running setup.py (path:/tmp/pip-CohccH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:29 INFO - Running setup.py (path:/tmp/pip-KjIx5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:29 INFO - Running setup.py (path:/tmp/pip-05vp6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:29 INFO - Running setup.py (path:/tmp/pip-cnvHzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:29 INFO - Running setup.py (path:/tmp/pip-AhvsZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:29 INFO - Running setup.py (path:/tmp/pip-gAHBeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:29 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)) 16:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:29 INFO - Running setup.py (path:/tmp/pip-X6jZOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:30 INFO - Running setup.py (path:/tmp/pip-6Nh_75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:30 INFO - Running setup.py (path:/tmp/pip-y4tc9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:30 INFO - Running setup.py (path:/tmp/pip-y00eK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:30 INFO - Running setup.py (path:/tmp/pip-QhooRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:30 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)) 16:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:30 INFO - Running setup.py (path:/tmp/pip-TdN25W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:30 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)) 16:18:30 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)) 16:18:30 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)) 16:18:30 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)) 16:18:30 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)) 16:18:30 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)) 16:18:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:18:30 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 16:18:30 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 16:18:30 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 16:18:30 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 16:18:30 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 16:18:30 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 16:18:32 INFO - Downloading blessings-1.6.tar.gz 16:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:18:32 INFO - Installing collected packages: blessings 16:18:32 INFO - Running setup.py install for blessings 16:18:32 INFO - Successfully installed blessings 16:18:32 INFO - Cleaning up... 16:18:32 INFO - Return code: 0 16:18:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:18:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:32 INFO - Reading from file tmpfile_stdout 16:18:32 INFO - Current package versions: 16:18:32 INFO - argparse == 1.2.1 16:18:32 INFO - blessings == 1.6 16:18:32 INFO - blobuploader == 1.2.4 16:18:32 INFO - docopt == 0.6.1 16:18:32 INFO - functools32 == 3.2.3-2 16:18:32 INFO - jsonschema == 2.5.1 16:18:32 INFO - manifestparser == 1.1 16:18:32 INFO - mozInstall == 1.12 16:18:32 INFO - mozcrash == 0.17 16:18:32 INFO - mozdebug == 0.1 16:18:32 INFO - mozdevice == 0.48 16:18:32 INFO - mozfile == 1.2 16:18:32 INFO - mozhttpd == 0.7 16:18:32 INFO - mozinfo == 0.9 16:18:32 INFO - mozleak == 0.1 16:18:32 INFO - mozlog == 3.2 16:18:32 INFO - moznetwork == 0.27 16:18:32 INFO - mozprocess == 0.22 16:18:32 INFO - mozprofile == 0.28 16:18:32 INFO - mozrunner == 6.11 16:18:32 INFO - mozscreenshot == 0.1 16:18:32 INFO - mozsystemmonitor == 0.3 16:18:32 INFO - moztest == 0.7 16:18:32 INFO - mozversion == 1.4 16:18:32 INFO - psutil == 3.1.1 16:18:32 INFO - requests == 1.2.3 16:18:32 INFO - wsgiref == 0.1.2 16:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:32 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')]} 16:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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')]} 16:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:32 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 16:18:32 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 16:18:32 INFO - Using env: {'DISPLAY': ':0', 16:18:32 INFO - 'HOME': '/home/cltbld', 16:18:32 INFO - 'LANG': 'en_US.UTF-8', 16:18:32 INFO - 'LANGUAGE': 'en_US:en', 16:18:32 INFO - 'LOGNAME': 'cltbld', 16:18:32 INFO - 'MAIL': '/var/mail/cltbld', 16:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:32 INFO - 'MOZ_NO_REMOTE': '1', 16:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:32 INFO - 'NO_EM_RESTART': '1', 16:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:32 INFO - 'PWD': '/builds/slave/test', 16:18:32 INFO - 'SHELL': '/bin/bash', 16:18:32 INFO - 'SHLVL': '1', 16:18:32 INFO - 'TERM': 'linux', 16:18:32 INFO - 'TMOUT': '86400', 16:18:32 INFO - 'USER': 'cltbld', 16:18:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:32 INFO - '_': '/tools/buildbot/bin/python'} 16:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 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)) 16:18:32 INFO - Cleaning up... 16:18:32 INFO - Return code: 0 16:18:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:18:32 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')]} 16:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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')]} 16:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:32 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:32 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 16:18:32 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 16:18:32 INFO - Using env: {'DISPLAY': ':0', 16:18:32 INFO - 'HOME': '/home/cltbld', 16:18:32 INFO - 'LANG': 'en_US.UTF-8', 16:18:32 INFO - 'LANGUAGE': 'en_US:en', 16:18:32 INFO - 'LOGNAME': 'cltbld', 16:18:32 INFO - 'MAIL': '/var/mail/cltbld', 16:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:32 INFO - 'MOZ_NO_REMOTE': '1', 16:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:32 INFO - 'NO_EM_RESTART': '1', 16:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:32 INFO - 'PWD': '/builds/slave/test', 16:18:32 INFO - 'SHELL': '/bin/bash', 16:18:32 INFO - 'SHLVL': '1', 16:18:32 INFO - 'TERM': 'linux', 16:18:32 INFO - 'TMOUT': '86400', 16:18:32 INFO - 'USER': 'cltbld', 16:18:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:32 INFO - '_': '/tools/buildbot/bin/python'} 16:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:18:33 INFO - Cleaning up... 16:18:33 INFO - Return code: 0 16:18:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:18:33 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')]} 16:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:33 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')]} 16:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:33 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 0x7f88a8c4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b50020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, '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': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', '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 16:18:33 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 16:18:33 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 16:18:33 INFO - Using env: {'DISPLAY': ':0', 16:18:33 INFO - 'HOME': '/home/cltbld', 16:18:33 INFO - 'LANG': 'en_US.UTF-8', 16:18:33 INFO - 'LANGUAGE': 'en_US:en', 16:18:33 INFO - 'LOGNAME': 'cltbld', 16:18:33 INFO - 'MAIL': '/var/mail/cltbld', 16:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:33 INFO - 'MOZ_NO_REMOTE': '1', 16:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:33 INFO - 'NO_EM_RESTART': '1', 16:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:33 INFO - 'PWD': '/builds/slave/test', 16:18:33 INFO - 'SHELL': '/bin/bash', 16:18:33 INFO - 'SHLVL': '1', 16:18:33 INFO - 'TERM': 'linux', 16:18:33 INFO - 'TMOUT': '86400', 16:18:33 INFO - 'USER': 'cltbld', 16:18:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:33 INFO - '_': '/tools/buildbot/bin/python'} 16:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:33 INFO - Downloading/unpacking flake8 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:18:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:18:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 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 16:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:18:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:18:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:18:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:18:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:18:35 INFO - no previously-included directories found matching 'docs/_build' 16:18:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:18:36 INFO - Running setup.py install for pep8 16:18:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:18:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:18:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:18:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:18:36 INFO - no previously-included directories found matching 'docs/_build' 16:18:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:18:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:18:36 INFO - Cleaning up... 16:18:36 INFO - Return code: 0 16:18:36 INFO - Running post-action listener: _resource_record_post_action 16:18:36 INFO - Running post-action listener: _start_resource_monitoring 16:18:36 INFO - Starting resource monitoring. 16:18:36 INFO - ##### 16:18:36 INFO - ##### Finished create-virtualenv step (success) 16:18:36 INFO - ##### 16:18:36 INFO - ##### 16:18:36 INFO - ##### Running install step. 16:18:36 INFO - ##### 16:18:36 INFO - Running pre-action listener: _resource_record_pre_action 16:18:36 INFO - Running main action method: install 16:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:36 INFO - Reading from file tmpfile_stdout 16:18:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:18:36 INFO - Reading from file tmpfile_stdout 16:18:36 INFO - Output received: 16:18:36 INFO - Usage: mozinstall [options] installer 16:18:36 INFO - Options: 16:18:36 INFO - -h, --help show this help message and exit 16:18:36 INFO - -d DEST, --destination=DEST 16:18:36 INFO - Directory to install application into. [default: 16:18:36 INFO - "/builds/slave/test"] 16:18:36 INFO - --app=APP Application being installed. [default: firefox] 16:18:36 INFO - mkdir: /builds/slave/test/build/application 16:18:36 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'] 16:18:36 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 16:18:52 INFO - Reading from file tmpfile_stdout 16:18:52 INFO - Output received: 16:18:52 INFO - /builds/slave/test/build/application/firefox/firefox 16:18:52 INFO - Running post-action listener: _resource_record_post_action 16:18:52 INFO - ##### 16:18:52 INFO - ##### Finished install step (success) 16:18:52 INFO - ##### 16:18:52 INFO - ##### 16:18:52 INFO - ##### Running run-tests step. 16:18:52 INFO - ##### 16:18:52 INFO - Running pre-action listener: _resource_record_pre_action 16:18:52 INFO - Running main action method: run_tests 16:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:18:52 INFO - Python 2.7.3 16:18:52 INFO - Return code: 0 16:18:52 INFO - grabbing minidump binary from tooltool 16:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:52 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 0x2be22e0>, '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 0x2b4e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:18:52 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 16:18:52 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 16:18:52 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 16:18:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:18:52 INFO - Return code: 0 16:18:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:18:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:18:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:18:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:18:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:18:53 INFO - Return code: 0 16:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 16:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 16:18:53 INFO - Using env: {'DISPLAY': ':0', 16:18:53 INFO - 'HOME': '/home/cltbld', 16:18:53 INFO - 'LANG': 'en_US.UTF-8', 16:18:53 INFO - 'LANGUAGE': 'en_US:en', 16:18:53 INFO - 'LOGNAME': 'cltbld', 16:18:53 INFO - 'MAIL': '/var/mail/cltbld', 16:18:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:18:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:53 INFO - 'MOZ_NO_REMOTE': '1', 16:18:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:53 INFO - 'NO_EM_RESTART': '1', 16:18:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:53 INFO - 'PWD': '/builds/slave/test', 16:18:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:18:53 INFO - 'SHELL': '/bin/bash', 16:18:53 INFO - 'SHLVL': '1', 16:18:53 INFO - 'TERM': 'linux', 16:18:53 INFO - 'TMOUT': '86400', 16:18:53 INFO - 'USER': 'cltbld', 16:18:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580', 16:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:53 INFO - '_': '/tools/buildbot/bin/python'} 16:18:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 16:18:53 INFO - mozversion application_buildid: 20160610160226 16:18:53 INFO - mozversion application_changeset: fb3a694a5c432916d9414b698efe1ffd0d461db1 16:18:53 INFO - mozversion application_display_name: Nightly 16:18:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:18:53 INFO - mozversion application_name: Firefox 16:18:53 INFO - mozversion application_remotingname: firefox 16:18:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:18:53 INFO - mozversion application_vendor: Mozilla 16:18:53 INFO - mozversion application_version: 50.0a1 16:18:53 INFO - mozversion platform_buildid: 20160610160226 16:18:53 INFO - mozversion platform_changeset: fb3a694a5c432916d9414b698efe1ffd0d461db1 16:18:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:18:53 INFO - mozversion platform_version: 50.0a1 16:18:53 INFO - using testdate: 1465600733 16:18:53 INFO - actual date: 1465600733 16:18:53 INFO - starting webserver on 'localhost:57490' 16:18:53 INFO - SUITE-START | Running 2 tests 16:18:53 INFO - TEST-START | dromaeo_css 16:18:53 INFO - operating with platform_type : linux_ 16:18:53 INFO - Initialising browser for dromaeo_css test... 16:18:53 INFO - TEST-INFO | started process 32305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMrwn5d/profile http://localhost:57490/getInfo.html) 16:18:58 INFO - PROCESS | 32305 | __metrics Screen width/height:1600/1200 16:18:58 INFO - PROCESS | 32305 | colorDepth:24 16:18:58 INFO - PROCESS | 32305 | Browser inner width/height: 1024/697 16:18:58 INFO - PROCESS | 32305 | __metrics 16:18:58 ERROR - PROCESS | 32305 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:18:59 INFO - TEST-INFO | 32305: exit 0 16:18:59 INFO - Browser initialized. 16:18:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:18:59 INFO - TEST-INFO | started process 32425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMrwn5d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:11 INFO - PROCESS | 32425 | RSS: Main: 186335232 16:19:11 INFO - PROCESS | 32425 | 16:20:01 INFO - PROCESS | 32425 | 1465600801361 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] 16:22:13 INFO - PROCESS | 32425 | Cycle 1(1): loaded http://localhost:57490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57490/tests/dromaeo/cssquery-ext.html) 16:22:14 INFO - PROCESS | 32425 | RSS: Main: 188354560 16:22:14 INFO - PROCESS | 32425 | 16:25:16 INFO - PROCESS | 32425 | Cycle 1(1): loaded http://localhost:57490/tests/dromaeo/cssquery-ext.html (next: http://localhost:57490/tests/dromaeo/cssquery-jquery.html) 16:25:17 INFO - PROCESS | 32425 | RSS: Main: 187998208 16:25:17 INFO - PROCESS | 32425 | 16:28:18 INFO - PROCESS | 32425 | Cycle 1(1): loaded http://localhost:57490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57490/tests/dromaeo/cssquery-mootools.html) 16:28:19 INFO - PROCESS | 32425 | RSS: Main: 189145088 16:28:19 INFO - PROCESS | 32425 | 16:31:21 INFO - PROCESS | 32425 | Cycle 1(1): loaded http://localhost:57490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57490/tests/dromaeo/cssquery-prototype.html) 16:31:22 INFO - PROCESS | 32425 | RSS: Main: 186949632 16:31:22 INFO - PROCESS | 32425 | 16:34:24 INFO - PROCESS | 32425 | Cycle 1(1): loaded http://localhost:57490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57490/tests/dromaeo/cssquery-yui.html) 16:34:25 INFO - PROCESS | 32425 | RSS: Main: 188637184 16:34:25 INFO - PROCESS | 32425 | 16:37:27 INFO - PROCESS | 32425 | Cycle 1(1): loaded http://localhost:57490/tests/dromaeo/cssquery-yui.html (next: http://localhost:57490/tests/dromaeo/cssquery-dojo.html) 16:37:28 INFO - PROCESS | 32425 | RSS: Main: 189784064 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | __start_tp_report 16:37:28 INFO - PROCESS | 32425 | _x_x_mozilla_page_load 16:37:28 INFO - PROCESS | 32425 | _x_x_mozilla_page_load_details 16:37:28 INFO - PROCESS | 32425 | |i|pagename|runs| 16:37:28 INFO - PROCESS | 32425 | |0;dojo.html;2605.4528549004713;2651.496215719014;2657.6943651480087;2658.481596088761;2665.0139448404093;4695.600873925716;4705.976470117649;4726.763661816913;4834.105690447261;4855.344528488662;4667.043256132493;4802.399700037496;4805.567498925096;4811.2783082537635;4875.512448755123;4328.523862375128;4408.889777755549;4469.3296005599095;4491.977540112295;4493.191225579394;558.7420512021353;4339.848105316315;4404.823807047715;4425.358323043157;4483.5964763171305;4400.977995110004;4410.977945110254;4446.044100518404;4456.153330867125;4492.101579684044;4352.455943007124;4444.266695995157;4465.352523884018;4474.9776251118865;4492.66305027121;4340.826366945318;4377.7592232427205;4390.626796722282;4436.334549817553;4443.044745379759;4765.880852978668;4775.9761201194115;4784.521547845223;4793.904121917542;4832.44426890905;5024.62315326352;5075.441701412841;5081.923771143436;5117.309163262987;5130.53825155734;5157.277981082651;5189.922151167735;5210.739463026872;5232.947670523322;5246.160614301732;4862.7325497097645;4869;4870.902581948341;4876.366072410599;4918.827841025547;5091.465396133427;5222.869428264248;5343.519083282523;5346.652467589594;5348.759305831247;5004;5035.597152227813;5052.090623687772;5058.418281897629;5109.259157422153;5128.589712822965;5128.743562821844;5141.177411614199;5155.304033955368;5181.3782346118705;4910.165271903785;4983.878627308899;5038.3198268234055;5089.109405854035;5096.694198348111;4994.126027945095;5043;5055.772490237948;5074.517920797518;5109.20807274873;4279.165562715303;4290.313549832012;4295.9570404295555;4320.913581728348;4330.069035157457;3704.814759262026;3722.2927643747603;3736.551613806361;3755.7746535207975;3794.032521707002;4465.754383508938;4470.061287129739;4489.932651010237;4516.277395616686;4524.23088075028;5102.387713474407;5139.922901156411;5176.456472070454;5188.558972487305;5230.241614965808;4376.474823021258;4433.490148632884;4436.578525040116;4467.597916187558;4482.170798402306;4573.039661671086;4582.564656357641;4593.517680643551;4613.953860461353;4615.423072115986;4856.417229932431;4871.561559459666;4891.29076283944;4897.90204195907;4916.164252077084;5015.799368025238;5068;5118.948810511847;5140.948590514047;5204.0892843752945;4821.975890120527;4834.395700537433;4854.514548545118;4863.124637565272;4912.336834527293;5098.439171691185;5098.46466121052;5098.847034588968;5105.821296254613;5150.871228219325;5044.394672639307;5176.844694659016;5226.216067589892;5237.16205407133;5252.789888404421;5064.037832811754;5074.3657042869645;5076.873078173076;5081.3902331718955;5142.8971420572125;4853.2720091985075;5086.771095300646;5095.337606111182;5096.23556466533;5104.770285337095;4793.808247670054;4833.73414462208;4888.6577939543895;4896.290037944549;4935.950640493549;4980.153373926369;5046.571041461517;5058.974705126451;5064.772085256099;5097.974510127426;4953.72754498506;4954.405471343462;4957.281194226889;4969.279454479152;5008.574271186844 16:37:28 INFO - PROCESS | 32425 | |1;ext.html;542.8585351591053;584.9824505264844;585.1632166002618;602.5330368964052;610.7556977209118;35024.64975350246;38157.80921095398;38222.23555528888;38251.42622860659;38374.232515349744;38738.22523549527;39134.8043259784;39139.41290880639;39229.60770392295;39256;7648.082230132378;7771.611419429034;7783.299503044725;7786.610669466532;7805.531668099904;7701.576413297266;7787.18234585366;7790.805229869242;7793.610319484032;7797.103333116707;7780.299773020427;7812.375009999215;7824.178461261571;7847.843043139133;7862.921370786276;7776.53340799551;7787.922120778805;7807.570583617899;7830.608469576527;7835.725749598793;7715.267049630333;7770.222977702241;7778.416618753616;7796.844063118762;7810.101838288612;38133.427998580046;38136.42795358072;38351.42472862909;38481.615183848364;38490.80754596237;3177.602799650044;3193.2495863472063;3259.6414394416597;3457.170279133015;3752.287065457582;29665.70334296651;30093.247668808235;30187.245318866986;30372.696273037207;30797.692023079708;3219.96780032199;3248.740100791955;3261.1031966209243;3278.60656721195;3336.4161271777584;188878;189185;189778;190448.0477597617;191157;31046.844765776477;32808.34383312368;53939.730301348245;54471.45528544743;55097;33586.664133358354;33601.66398335985;33707.66292337095;33789.66210337865;33895.49156762651;11928.880711192951;11935.940320298516;11949.522019119138;11953.641390758292;11974.58088966882;11255.155863310285;11351.205415620827;11370;11413;11438.313701177956;7833.5691536966015;7906.130325664172;7911.169327220674;7977.48146370484;8028.397870159762;3062.9540556891666;3104.3946430445844;3107.1144723753623;3162.067190178903;3169.508726147451;851.3231980575457;895.9148880856309;896.4352457951579;957.5643082397493;993.5529011944653;28011;28493.578045865917;28794.28014299659;28795.28011799722;28954.420911581652;888.6312180445173;934.0985948559672;936.1714882329188;963.2438535749403;985.9507024648739;14608.123512589278;14686.192259425621;14738;14936.103833770008;15070.773938390932;391073;438449;449800;450162;734530;50189.74905125451;50454.49545504571;50765.49234507682;50933.236001460005;50946.23580646293;1201.375284851872;1213.538855235005;1221.8900298973135;1222.6821026533166;1223.2660403757675;28280.43439131247;29119.7088029117;29627;29975.550366744952;30061.54907676343;44229.33655995227;44730;44802.77598612117;44891;44899;272388;274782;275123;275271;276500;25308.49383012366;26056.73943260543;26341.07806226773;26357.60463593086;26483.470330593667;43086;43179.568204317555;43421.34867977046;43472.34791478194;44893.326600101675;36622.63377366299;37091;37272.62727372692;37368;37631.62368376281;36273.89946660504;37385.62614373821;37495.81252093722;37823.43264850974;37954.43068354032;35432.46851297284;36599.81700091482;36715.26569468649;37053.629463705016;37061.62938370582;31875;32776.83611581927;33127;33389;33401.33197335991;25621.10326138576;25913.870430647727;26108;26365.472690546467;26460.7353926466 16:37:28 INFO - PROCESS | 32425 | |2;jquery.html;371.6692143991848;374.2757763727187;379.75885312826347;386.4821139672838;391.6044794757294;15589;16269.267882945267;17300.653986920253;17367.91316043421;17388.56528586786;16083.989501312335;16408.425705100322;17246.482605521822;17297.82702172978;17318.134093295346;5040.3951525816865;5164.328637277149;5178.66338687986;5192.818251361203;5253.9737301313635;3684.3552378333684;5177.58579313654;5841.269841269841;6159.815205543819;6166.290876549209;6203.286622038456;6212.192414986045;6219.471344935686;6228.439440450358;6233.2208473940755;5086.135356989321;5422.267993820843;5427.755750991195;5508.476694713996;5509.972450137724;5119.948800511985;5310;5310.601704872111;5353.678779273256;5363.973180134113;12227.266364018098;12327.075469339836;12353.444095015746;17359.739603905953;20027.1989120435;1813.5375479252707;1870.6071724937779;1916.875403098794;1974.2991238110408;2009.6382651122792;9106.63573457061;9283.860742088875;9377.202937750299;9388.530573471367;9640.228781697448;1661.4849396687066;1731.5584525945928;1782.073321872619;1815.9818401815944;1823.5988082621802;65339;68273;68845.65577172131;69644.65177674181;70042.2995770046;9865.901340986498;9873.111419972238;10046.598136074621;10059.44673042975;10120.392776433437;13909;14042.508512202025;14098.718025639635;14109.647258818612;14115.435382584581;7163.247858974837;7339.302766237306;7457.85084298311;7670.041244844395;7700.691972321044;6551.836204094936;6580.341965803477;6689.364510371507;7007.509474336747;7015.403690686247;4274.914501709948;4296.377025331372;4346.326319420495;4348.760818154969;4382.671299652475;1665.9416920407728;1724.7240441529295;1786.4015554789032;1859.1633764805892;1880.4546681462496;728.3735987051132;806.2381049907898;822.7367242482349;838.3963546246692;870.6038752367657;13519.188848669111;15472.845271547141;15548.144852033247;15575.61060973462;15844.841551584337;783.9216078392229;797.5932274539911;822.296936119621;832.3216578488513;846.0735494633367;9115.90884091164;9150.954245228864;9160;9174.403663761834;9241.676541321021;301357;305345;305378;408840;411573;81373.59313203515;81441.59279203566;81610.59194703988;82548;83977;928.4754113925745;943.8631398447187;944.8913374961967;967.685502211784;968.7239136845965;14426.927865360605;15269.160196188872;15363.15502647365;15559.766603501183;15920.442784502487;34859;35193.82403087968;35717.46423803697;36104.45843312405;36879.63120368762;49289.26066108939;49633;50414.49585504245;50431;51248.23127653163;7325.4872158948365;7847.5683837387205;7932.920670793449;7992.880106798519;7997.320227780471;10256.743581410525;11769.646910592695;11788.29270243788;12096.758064838477;12222.388880555758;9441.489361702095;9915.801683966425;10293.43386113771;10406;10498.212634052325;10076.143527800219;10197.286189966928;10284.794304114026;10335.276530642783;10531.368117912949;10254.743631409274;10263.58945642166;10458.843117353397;10501.264911456125;10652.09457196147;6557.114789503356;6913.343232392915;7798.610069496616;7827.882581761164;7996.680132794856;9637.42175469474;10573.471326433493;10603;10626.84059739089;10681.679549613524 16:37:28 INFO - PROCESS | 32425 | |3;mootools.html;1346.690261239915;1363.7408892310461;1400.9159450432974;1585.2470076713569;1630.567899506631;6837.111175547185;7534.736284230053;7556.093268807744;8035.758927232185;8036.799080023003;7526.849463010736;7734.187910269411;7745.496542724719;7784.065912090543;7841.725539606115;2167.4906396996735;2206.481476852938;2206.9889650551727;2218.5341078373563;2220.3449982255192;2163.3185546552863;2182.6507758758603;2211.2481756202887;2227.164813195052;2230.130249202812;2206.9889650551804;2207.39296693409;2212.5685491329195;2220.2562141682474;2234.4078819112947;2114.143771772435;2117.28012475759;2119.3641907427786;2124.4051665533675;2130.8614940028847;2027.4525878013;2055.054674849571;2060.6702927531674;2064.0711679744177;2067.5658111796542;7726.381889448887;7743.341815945651;7780.610969451504;7835.529868207926;7847.215278472164;4572.748498832563;4696.600788932945;4699.694519856233;4774.689645173087;4835.323054772335;2899.594056832045;2981.3739114785703;3014.261505931039;3016.1856298799203;3017.5775391445213;914.9908500914972;934.6261495401826;935.1209862729013;952.4285428742768;959.3380567408466;10580.947095264552;10583.470826458646;10625.362478251329;10632.468376581217;10647.467626618638;4254;4308.224519586442;4358.084802191512;4366.279563871989;4390.517043125254;9075.818483630423;9091.090890910857;9100.135487128713;9108.681196158102;9138.68014619485;4719.858404247878;4748.074125545554;4799.232122860326;4805.014971930816;4827.275908613736;3768.6231376862092;4111.342185250405;4250.808713607895;4385.495667998157;4408.404865343202;3678.834452449593;3705.351563476435;3826.3686491728554;3836.8873026821907;3850.0567360996733;1205.9457324420246;1246.7693476706838;1249.2129958126322;1261.243254047564;1265.6835791052238;824.3075816314325;827.7392621324263;835.0814104485017;835.0855812884881;843.4644001059249;5136.203888397305;5460.918086228709;5579.7489112990015;5656.830295091154;5712.257406537124;835.7534527314457;840.2185967050701;884.9026607073217;894.6600291889041;910.7723069232692;3546.6098729139776;3546.66306700863;3615.07815507044;3655.8354874030733;3708.981455092707;9431.434113953184;9705.223582113555;9759.902400976041;9794.510274486247;9862.45756483386;9606.183474404754;9614.086661767122;9629.422234665803;9653.420794752337;9737.464439455898;6876.69054892531;7145.249748776304;7178.5692858428665;7324.67038983247;7390.371818395497;5369.248305237348;5586.469285417878;5598.384177740527;5664.065429204135;5794.304683438015;8668.133186681282;8670.913290867264;8748.868766968373;8802.559872006246;8894.866577001221;8575.442596231225;9041.23149532297;9047.592858321259;9049;9087.909120908706;6202.906956395567;6636.767713130017;6782.626955517494;6843.110395648534;6940.09778728762;7657.004589403342;7658.578778167254;7691.346235570039;7728.92271077282;7731;6685.933140668531;6862.176538815374;6987.510874238755;7010.614416207158;7087.539309944837;6740.62926539045;6742.8651426972165;6838.863222735617;6919.654017299215;6923.4807389447;5569.66582005081;5815.534757219328;6272.874542509033;6352.682365881595;6359.904601431075;4495.640348772155;4574.473935497461;4586.610138138296;4613.3771940787565;4638.373819534319;4672.719636821802;4683.929741053955;4717.150912835723;4736.952630473651;4737.644676649196 16:37:28 INFO - PROCESS | 32425 | |4;prototype.html;296.88718287050915;305.5630448458704;310.3637543036775;311.3290858200577;311.85342888842234;4844.346013288205;4947.455779864212;4960.701133746054;5051.696898186111;5060.468650791665;4946.480619534951;4986.601071914247;5001.899962000767;5010.3737032870895;5027.824026159085;3906.8279516145185;3916.4516967624413;3959.554762511677;3970.8411663533498;3971.98014009931;3829.157585331223;3863.8454461821493;3931.3709806430975;3943.467631869704;3959.78221197834;3856.7465573688523;3877.806109694518;3891.462872165493;3897.2400381925536;3899.337112690835;3888.4556162137324;3890.8521986014193;3894.435306880501;3900.726949113549;3906.2187562487616;3319.96680033199;3449.344624521333;3470.6182319945037;3475.4613034979366;3477.556813922219;4839.249916262985;4890.339804126433;4894.559489645913;4903.469501958584;4910.263460480956;4521.344405061248;4527.750973696446;4532.4787649420405;4533.818647254106;4541.546705054384;5006.899862002776;5228.8692782680355;5234.22586029405;5254.65844720092;5255.6363927086695;3817.8091095445116;3826.5459125532398;3828.636279553438;3835.4822099016833;3841.442990766351;5499.835004949858;5515.889682206333;5525.723713814293;5529.336479622471;5568.220449137124;3742.925141497155;3983.820728067244;3989;3990.82041308136;4009.4587230724064;4007.2185923745174;4013.8795836124964;4014.3777714454304;4022.959770402317;4032;4508.07584445188;4511.5262897395305;4516.570925762047;4524.75569218461;4530.433695788027;5246.291750613695;5250.317458730341;5278.81226723984;5291.497307755757;5330.786768529216;1367.699106196635;1405.3113974152795;1411.3014058041335;1412.4420853762706;1412.7527682655493;886.822635472908;908.4367692030983;917.2111983694018;923.3610341643637;930.2279158203498;4045.3527435610163;4128.587141285908;4138.8344466221015;4143.544210136883;4152.875413737533;4720.575148236675;4733.573978341966;4750.857474275777;4751.263554149113;4797.280407938837;4128.855490057894;4133.904515303447;4160.251154792106;4166.395872598517;4176.665866730655;2413.5277480736736;2541.809364297685;2573.6139579062915;2591.883365248568;2596.766291033778;4486.685931984795;4511.826924999458;4525.691897132486;4535.569120933506;4537.570665240439;4847.927281090787;4849.539293767087;4851.587615052689;4875.488073752276;4901.436334821541;4195.6250831194975;4559.316102584705;4564.497905230422;4567.2464043432465;4582.33556134352;4794;4806.807727690853;4821.035792841516;4828.754629097487;4832.758362081952;4654.511276315938;4694.835680751294;4728.59806916416;4734.17151998392;4763.476017638126;4561.224591819465;4784.258439941815;5213.608979326642;5217.982493413748;5221.269022336952;3548.9290214195057;3694.9815250923575;3812.9428058579697;3877.6897848171516;3893.7274390792372;5385.3268341457315;5385.380681221553;5397.190421436816;5401.351837779334;5430.864228394322;5202.921956170585;5204.1673332266655;5238.140460136597;5253.632245742761;5266.657667251617;5156.845294641167;5207.3751149862255;5222.843314700565;5270.130428479258;5309.734513274244;5128.358955130609;5146.305248791515;5156.819511317086;5164.605556499649;5227.2420499028185;5257.158854583248;5280.735963201748;5282.075636763628;5288.471152884681;5310.840674779763;4945.925811112764;5137.357830271216;5176.4305926348825;5178.663386879841;5180.523550788158 16:37:28 INFO - PROCESS | 32425 | |5;yui.html;642.4218203616745;643.8197304754669;658.9275179730225;727.6943683652867;731.7585196885028;12651.746965060693;13244.602661920133;13612.455501779918;13657.726845463085;13664.453421863125;11912.880871191286;11956.222845515036;12093.455794489248;12146.27122372656;12403.937980310086;621.6456619726757;753.7098217186395;777.5878784244331;779.7037125892153;780.332815442794;776.7242628866755;778.1168373895613;778.155701064343;781.2460975158971;782.9899429735663;818.5293456262643;819.2831272636444;821.5358322547771;824.7278398128633;825.3685930263354;817.0807841178674;818.2145140664938;820.4257020085934;820.6512232301308;821.6836517940576;601.6119602856177;601.8675891303906;602.0728078758706;602.4698265526353;604.0305309977467;12956.48174073036;12961.351932403437;13026;13083.869161308361;13121.343932803416;13057.347132643425;13461.394237259346;13544;13617.455301787917;13702;10692.625758098508;10761;10774.353538787698;10829.945850270777;10951.123910087173;3368.090615533792;3392.7625066245373;3408.437607794711;3495.213576945167;3498.6501349865066;54213;54674.72662636701;54978.17532737012;55031.72484137554;57729;10437;10447.373157610567;10476.423796691255;10580.20648451354;10680.839787403194;19307.4207773767;19571.51071223231;19576.314828980918;19648.60702785936;19983.800161998486;7089.326513981164;7165.104361954755;7167.820804479826;7227.457940654472;7336.413086953031;3756.8685096022054;3867.961320386816;3871.496705428276;3876.9612303877166;3922.8234729437245;2955.1725516855313;3088.474959256932;3088.845557722105;3093.0102367242266;3095.2880837407524;470.3532642616402;479.61630695444205;480.2939678672346;482.97826597803186;486.8369096352691;485.03720115570565;554.2784926013255;561.7724821447321;592.3661682000219;596.713577482802;7769.423558897202;7801.141874393812;8084.514929104273;8198.15541503157;8290.336773058261;493.65444189067796;531.9335083114611;547.7015026810398;625.6402568523117;628.7893555658814;3631.382664946965;3713.1830997180577;3816.103215744298;3899.7075219358094;4072.490938632671;83679.58160209282;88254.55872720595;88383.55808220917;88990.55504722435;90587.54706226426;76639.61680191563;81972.59013704893;82653.58673206596;82728.17271827205;83360;57347.42652573421;71953.64023179955;73384.63307683427;73515.63242183755;74293.62853185808;7446.292602202782;7487.513311634726;7526.5860377679755;7679.769606911802;7786.844263114593;33646.495302569994;43315.78342108395;44192.33711494395;44665;44961;59787.40212597818;61587;62033.37966620276;62047;62102.37897620966;9523.047695230422;10400.843987340348;10590.523426445674;10604.204684648528;10636.41499717523;10762.677119686421;10822.188335874998;11382.715432114263;11622.360770157384;11994.340311282964;10220.284580079324;10451.529681164213;10478.79042419132;10564.207684423545;10708.839367409339;10628.52171652262;10918.890811091787;11009.229353945468;11044.116470682166;11087.168462365516;8880.067592902653;9875.209983201183;9918.355306905316;9995.500224988577;10047.648332308334;8246.587670616565;8304.750857474286;8367.707130250412;8601.956990215009;8714.433561818461;8578.742637720878;9304.395214311047;9367.110124538158;9541.904580954379;9595.808083838423 16:37:28 INFO - PROCESS | 32425 | __end_tp_report 16:37:28 INFO - PROCESS | 32425 | __start_cc_report 16:37:28 INFO - PROCESS | 32425 | _x_x_mozilla_cycle_collect,377 16:37:28 INFO - PROCESS | 32425 | __end_cc_report 16:37:28 INFO - PROCESS | 32425 | __startTimestamp1465601848120__endTimestamp 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | ------- Summary: start ------- 16:37:28 INFO - PROCESS | 32425 | Number of tests: 6 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | [#0] dojo.html Cycles:165 Average:4727.20 Median:4888.66 stddev:603.10 (12.3%) stddev-sans-first:581.52 16:37:28 INFO - PROCESS | 32425 | Values: 2605.5 2651.5 2657.7 2658.5 2665.0 4695.6 4706.0 4726.8 4834.1 4855.3 4667.0 4802.4 4805.6 4811.3 4875.5 4328.5 4408.9 4469.3 4492.0 4493.2 558.7 4339.8 4404.8 4425.4 4483.6 4401.0 4411.0 4446.0 4456.2 4492.1 4352.5 4444.3 4465.4 4475.0 4492.7 4340.8 4377.8 4390.6 4436.3 4443.0 4765.9 4776.0 4784.5 4793.9 4832.4 5024.6 5075.4 5081.9 5117.3 5130.5 5157.3 5189.9 5210.7 5232.9 5246.2 4862.7 4869.0 4870.9 4876.4 4918.8 5091.5 5222.9 5343.5 5346.7 5348.8 5004.0 5035.6 5052.1 5058.4 5109.3 5128.6 5128.7 5141.2 5155.3 5181.4 4910.2 4983.9 5038.3 5089.1 5096.7 4994.1 5043.0 5055.8 5074.5 5109.2 4279.2 4290.3 4296.0 4320.9 4330.1 3704.8 3722.3 3736.6 3755.8 3794.0 4465.8 4470.1 4489.9 4516.3 4524.2 5102.4 5139.9 5176.5 5188.6 5230.2 4376.5 4433.5 4436.6 4467.6 4482.2 4573.0 4582.6 4593.5 4614.0 4615.4 4856.4 4871.6 4891.3 4897.9 4916.2 5015.8 5068.0 5118.9 5140.9 5204.1 4822.0 4834.4 4854.5 4863.1 4912.3 5098.4 5098.5 5098.8 5105.8 5150.9 5044.4 5176.8 5226.2 5237.2 5252.8 5064.0 5074.4 5076.9 5081.4 5142.9 4853.3 5086.8 5095.3 5096.2 5104.8 4793.8 4833.7 4888.7 4896.3 4936.0 4980.2 5046.6 5059.0 5064.8 5098.0 4953.7 4954.4 4957.3 4969.3 5008.6 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | [#1] ext.html Cycles:180 Average:46489.74 Median:37320.31 stddev:93947.55 (251.7%) stddev-sans-first:94147.76 16:37:28 INFO - PROCESS | 32425 | Values: 542.9 585.0 585.2 602.5 610.8 35024.6 38157.8 38222.2 38251.4 38374.2 38738.2 39134.8 39139.4 39229.6 39256.0 7648.1 7771.6 7783.3 7786.6 7805.5 7701.6 7787.2 7790.8 7793.6 7797.1 7780.3 7812.4 7824.2 7847.8 7862.9 7776.5 7787.9 7807.6 7830.6 7835.7 7715.3 7770.2 7778.4 7796.8 7810.1 38133.4 38136.4 38351.4 38481.6 38490.8 3177.6 3193.2 3259.6 3457.2 3752.3 29665.7 30093.2 30187.2 30372.7 30797.7 3220.0 3248.7 3261.1 3278.6 3336.4 188878.0 189185.0 189778.0 190448.0 191157.0 31046.8 32808.3 53939.7 54471.5 55097.0 33586.7 33601.7 33707.7 33789.7 33895.5 11928.9 11935.9 11949.5 11953.6 11974.6 11255.2 11351.2 11370.0 11413.0 11438.3 7833.6 7906.1 7911.2 7977.5 8028.4 3063.0 3104.4 3107.1 3162.1 3169.5 851.3 895.9 896.4 957.6 993.6 28011.0 28493.6 28794.3 28795.3 28954.4 888.6 934.1 936.2 963.2 986.0 14608.1 14686.2 14738.0 14936.1 15070.8 391073.0 438449.0 449800.0 450162.0 734530.0 50189.7 50454.5 50765.5 50933.2 50946.2 1201.4 1213.5 1221.9 1222.7 1223.3 28280.4 29119.7 29627.0 29975.6 30061.5 44229.3 44730.0 44802.8 44891.0 44899.0 272388.0 274782.0 275123.0 275271.0 276500.0 25308.5 26056.7 26341.1 26357.6 26483.5 43086.0 43179.6 43421.3 43472.3 44893.3 36622.6 37091.0 37272.6 37368.0 37631.6 36273.9 37385.6 37495.8 37823.4 37954.4 35432.5 36599.8 36715.3 37053.6 37061.6 31875.0 32776.8 33127.0 33389.0 33401.3 25621.1 25913.9 26108.0 26365.5 26460.7 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | [#2] jquery.html Cycles:180 Average:22978.76 Median:26835.97 stddev:58304.49 (217.3%) stddev-sans-first:58443.34 16:37:28 INFO - PROCESS | 32425 | Values: 371.7 374.3 379.8 386.5 391.6 15589.0 16269.3 17300.7 17367.9 17388.6 16084.0 16408.4 17246.5 17297.8 17318.1 5040.4 5164.3 5178.7 5192.8 5254.0 3684.4 5177.6 5841.3 6159.8 6166.3 6203.3 6212.2 6219.5 6228.4 6233.2 5086.1 5422.3 5427.8 5508.5 5510.0 5119.9 5310.0 5310.6 5353.7 5364.0 12227.3 12327.1 12353.4 17359.7 20027.2 1813.5 1870.6 1916.9 1974.3 2009.6 9106.6 9283.9 9377.2 9388.5 9640.2 1661.5 1731.6 1782.1 1816.0 1823.6 65339.0 68273.0 68845.7 69644.7 70042.3 9865.9 9873.1 10046.6 10059.4 10120.4 13909.0 14042.5 14098.7 14109.6 14115.4 7163.2 7339.3 7457.9 7670.0 7700.7 6551.8 6580.3 6689.4 7007.5 7015.4 4274.9 4296.4 4346.3 4348.8 4382.7 1665.9 1724.7 1786.4 1859.2 1880.5 728.4 806.2 822.7 838.4 870.6 13519.2 15472.8 15548.1 15575.6 15844.8 783.9 797.6 822.3 832.3 846.1 9115.9 9151.0 9160.0 9174.4 9241.7 301357.0 305345.0 305378.0 408840.0 411573.0 81373.6 81441.6 81610.6 82548.0 83977.0 928.5 943.9 944.9 967.7 968.7 14426.9 15269.2 15363.2 15559.8 15920.4 34859.0 35193.8 35717.5 36104.5 36879.6 49289.3 49633.0 50414.5 50431.0 51248.2 7325.5 7847.6 7932.9 7992.9 7997.3 10256.7 11769.6 11788.3 12096.8 12222.4 9441.5 9915.8 10293.4 10406.0 10498.2 10076.1 10197.3 10284.8 10335.3 10531.4 10254.7 10263.6 10458.8 10501.3 10652.1 6557.1 6913.3 7798.6 7827.9 7996.7 9637.4 10573.5 10603.0 10626.8 10681.7 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | [#3] mootools.html Cycles:180 Average:5173.69 Median:5592.43 stddev:2865.51 (51.2%) stddev-sans-first:2859.12 16:37:28 INFO - PROCESS | 32425 | Values: 1346.7 1363.7 1400.9 1585.2 1630.6 6837.1 7534.7 7556.1 8035.8 8036.8 7526.8 7734.2 7745.5 7784.1 7841.7 2167.5 2206.5 2207.0 2218.5 2220.3 2163.3 2182.7 2211.2 2227.2 2230.1 2207.0 2207.4 2212.6 2220.3 2234.4 2114.1 2117.3 2119.4 2124.4 2130.9 2027.5 2055.1 2060.7 2064.1 2067.6 7726.4 7743.3 7780.6 7835.5 7847.2 4572.7 4696.6 4699.7 4774.7 4835.3 2899.6 2981.4 3014.3 3016.2 3017.6 915.0 934.6 935.1 952.4 959.3 10580.9 10583.5 10625.4 10632.5 10647.5 4254.0 4308.2 4358.1 4366.3 4390.5 9075.8 9091.1 9100.1 9108.7 9138.7 4719.9 4748.1 4799.2 4805.0 4827.3 3768.6 4111.3 4250.8 4385.5 4408.4 3678.8 3705.4 3826.4 3836.9 3850.1 1205.9 1246.8 1249.2 1261.2 1265.7 824.3 827.7 835.1 835.1 843.5 5136.2 5460.9 5579.7 5656.8 5712.3 835.8 840.2 884.9 894.7 910.8 3546.6 3546.7 3615.1 3655.8 3709.0 9431.4 9705.2 9759.9 9794.5 9862.5 9606.2 9614.1 9629.4 9653.4 9737.5 6876.7 7145.2 7178.6 7324.7 7390.4 5369.2 5586.5 5598.4 5664.1 5794.3 8668.1 8670.9 8748.9 8802.6 8894.9 8575.4 9041.2 9047.6 9049.0 9087.9 6202.9 6636.8 6782.6 6843.1 6940.1 7657.0 7658.6 7691.3 7728.9 7731.0 6685.9 6862.2 6987.5 7010.6 7087.5 6740.6 6742.9 6838.9 6919.7 6923.5 5569.7 5815.5 6272.9 6352.7 6359.9 4495.6 4574.5 4586.6 4613.4 4638.4 4672.7 4683.9 4717.2 4737.0 4737.6 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | [#4] prototype.html Cycles:180 Average:4238.20 Median:4618.42 stddev:1212.07 (26.2%) stddev-sans-first:1178.82 16:37:28 INFO - PROCESS | 32425 | Values: 296.9 305.6 310.4 311.3 311.9 4844.3 4947.5 4960.7 5051.7 5060.5 4946.5 4986.6 5001.9 5010.4 5027.8 3906.8 3916.5 3959.6 3970.8 3972.0 3829.2 3863.8 3931.4 3943.5 3959.8 3856.7 3877.8 3891.5 3897.2 3899.3 3888.5 3890.9 3894.4 3900.7 3906.2 3320.0 3449.3 3470.6 3475.5 3477.6 4839.2 4890.3 4894.6 4903.5 4910.3 4521.3 4527.8 4532.5 4533.8 4541.5 5006.9 5228.9 5234.2 5254.7 5255.6 3817.8 3826.5 3828.6 3835.5 3841.4 5499.8 5515.9 5525.7 5529.3 5568.2 3742.9 3983.8 3989.0 3990.8 4009.5 4007.2 4013.9 4014.4 4023.0 4032.0 4508.1 4511.5 4516.6 4524.8 4530.4 5246.3 5250.3 5278.8 5291.5 5330.8 1367.7 1405.3 1411.3 1412.4 1412.8 886.8 908.4 917.2 923.4 930.2 4045.4 4128.6 4138.8 4143.5 4152.9 4720.6 4733.6 4750.9 4751.3 4797.3 4128.9 4133.9 4160.3 4166.4 4176.7 2413.5 2541.8 2573.6 2591.9 2596.8 4486.7 4511.8 4525.7 4535.6 4537.6 4847.9 4849.5 4851.6 4875.5 4901.4 4195.6 4559.3 4564.5 4567.2 4582.3 4794.0 4806.8 4821.0 4828.8 4832.8 4654.5 4694.8 4728.6 4734.2 4763.5 4561.2 4784.3 5213.6 5218.0 5221.3 3548.9 3695.0 3812.9 3877.7 3893.7 5385.3 5385.4 5397.2 5401.4 5430.9 5202.9 5204.2 5238.1 5253.6 5266.7 5156.8 5207.4 5222.8 5270.1 5309.7 5128.4 5146.3 5156.8 5164.6 5227.2 5257.2 5280.7 5282.1 5288.5 5310.8 4945.9 5137.4 5176.4 5178.7 5180.5 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - PROCESS | 32425 | [#5] yui.html Cycles:180 Average:16807.31 Median:27762.94 stddev:23667.29 (85.2%) stddev-sans-first:23702.56 16:37:28 INFO - PROCESS | 32425 | Values: 642.4 643.8 658.9 727.7 731.8 12651.7 13244.6 13612.5 13657.7 13664.5 11912.9 11956.2 12093.5 12146.3 12403.9 621.6 753.7 777.6 779.7 780.3 776.7 778.1 778.2 781.2 783.0 818.5 819.3 821.5 824.7 825.4 817.1 818.2 820.4 820.7 821.7 601.6 601.9 602.1 602.5 604.0 12956.5 12961.4 13026.0 13083.9 13121.3 13057.3 13461.4 13544.0 13617.5 13702.0 10692.6 10761.0 10774.4 10829.9 10951.1 3368.1 3392.8 3408.4 3495.2 3498.7 54213.0 54674.7 54978.2 55031.7 57729.0 10437.0 10447.4 10476.4 10580.2 10680.8 19307.4 19571.5 19576.3 19648.6 19983.8 7089.3 7165.1 7167.8 7227.5 7336.4 3756.9 3868.0 3871.5 3877.0 3922.8 2955.2 3088.5 3088.8 3093.0 3095.3 470.4 479.6 480.3 483.0 486.8 485.0 554.3 561.8 592.4 596.7 7769.4 7801.1 8084.5 8198.2 8290.3 493.7 531.9 547.7 625.6 628.8 3631.4 3713.2 3816.1 3899.7 4072.5 83679.6 88254.6 88383.6 88990.6 90587.5 76639.6 81972.6 82653.6 82728.2 83360.0 57347.4 71953.6 73384.6 73515.6 74293.6 7446.3 7487.5 7526.6 7679.8 7786.8 33646.5 43315.8 44192.3 44665.0 44961.0 59787.4 61587.0 62033.4 62047.0 62102.4 9523.0 10400.8 10590.5 10604.2 10636.4 10762.7 10822.2 11382.7 11622.4 11994.3 10220.3 10451.5 10478.8 10564.2 10708.8 10628.5 10918.9 11009.2 11044.1 11087.2 8880.1 9875.2 9918.4 9995.5 10047.6 8246.6 8304.8 8367.7 8602.0 8714.4 8578.7 9304.4 9367.1 9541.9 9595.8 16:37:28 INFO - PROCESS | 32425 | -------- Summary: end -------- 16:37:28 INFO - PROCESS | 32425 | 16:37:28 INFO - TEST-INFO | 32425: exit 0 16:37:28 INFO - TEST-OK | dromaeo_css | took 1115176ms 16:37:28 INFO - TEST-START | kraken 16:37:28 INFO - operating with platform_type : linux_ 16:37:28 INFO - Initialising browser for kraken test... 16:37:28 INFO - TEST-INFO | started process 32658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSQKE2L/profile http://localhost:57490/getInfo.html) 16:37:33 INFO - PROCESS | 32658 | __metrics Screen width/height:1600/1200 16:37:33 INFO - PROCESS | 32658 | colorDepth:24 16:37:33 INFO - PROCESS | 32658 | Browser inner width/height: 1024/697 16:37:33 INFO - PROCESS | 32658 | __metrics 16:37:33 ERROR - PROCESS | 32658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:37:34 INFO - TEST-INFO | 32658: exit 0 16:37:34 INFO - Browser initialized. 16:37:34 INFO - Running cycle 1/1 for kraken test... 16:37:34 INFO - TEST-INFO | started process 308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSQKE2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:46 INFO - PROCESS | 308 | RSS: Main: 186380288 16:37:46 INFO - PROCESS | 308 | 16:37:49 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57490/tests/kraken/driver.html?testName=audio-beat-detection) 16:37:50 INFO - PROCESS | 308 | RSS: Main: 191221760 16:37:50 INFO - PROCESS | 308 | 16:37:53 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57490/tests/kraken/driver.html?testName=audio-dft) 16:37:54 INFO - PROCESS | 308 | RSS: Main: 190877696 16:37:54 INFO - PROCESS | 308 | 16:37:56 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57490/tests/kraken/driver.html?testName=audio-fft) 16:37:57 INFO - PROCESS | 308 | RSS: Main: 186662912 16:37:57 INFO - PROCESS | 308 | 16:37:59 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57490/tests/kraken/driver.html?testName=audio-oscillator) 16:38:00 INFO - PROCESS | 308 | RSS: Main: 187543552 16:38:00 INFO - PROCESS | 308 | 16:38:02 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:03 INFO - PROCESS | 308 | RSS: Main: 187867136 16:38:03 INFO - PROCESS | 308 | 16:38:06 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57490/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:07 INFO - PROCESS | 308 | RSS: Main: 188260352 16:38:07 INFO - PROCESS | 308 | 16:38:10 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57490/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:11 INFO - PROCESS | 308 | RSS: Main: 184950784 16:38:11 INFO - PROCESS | 308 | 16:38:14 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57490/tests/kraken/driver.html?testName=json-parse-financial) 16:38:14 INFO - PROCESS | 308 | RSS: Main: 186945536 16:38:14 INFO - PROCESS | 308 | 16:38:16 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:38:17 INFO - PROCESS | 308 | RSS: Main: 187576320 16:38:17 INFO - PROCESS | 308 | 16:38:19 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:38:19 INFO - PROCESS | 308 | RSS: Main: 187293696 16:38:19 INFO - PROCESS | 308 | 16:38:21 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:38:22 INFO - PROCESS | 308 | RSS: Main: 187822080 16:38:22 INFO - PROCESS | 308 | 16:38:25 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:38:26 INFO - PROCESS | 308 | RSS: Main: 187838464 16:38:26 INFO - PROCESS | 308 | 16:38:29 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:38:29 INFO - PROCESS | 308 | RSS: Main: 187371520 16:38:29 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | Cycle 1(1): loaded http://localhost:57490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57490/tests/kraken/driver.html?testName=ai-astar) 16:38:31 INFO - PROCESS | 308 | RSS: Main: 188305408 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | __start_tp_report 16:38:31 INFO - PROCESS | 308 | _x_x_mozilla_page_load 16:38:31 INFO - PROCESS | 308 | _x_x_mozilla_page_load_details 16:38:31 INFO - PROCESS | 308 | |i|pagename|runs| 16:38:31 INFO - PROCESS | 308 | |0;ai-astar;113;108;113;114;115;115;115;114;114;114 16:38:31 INFO - PROCESS | 308 | |1;audio-beat-detection;169;131;157;179;132;159;152;134;199;137 16:38:31 INFO - PROCESS | 308 | |2;audio-dft;162;167;167;168;163;163;161;164;160;164 16:38:31 INFO - PROCESS | 308 | |3;audio-fft;75;76;76;159;77;78;75;75;156;79 16:38:31 INFO - PROCESS | 308 | |4;audio-oscillator;87;87;142;86;86;87;136;86;90;135 16:38:31 INFO - PROCESS | 308 | |5;imaging-gaussian-blur;121;118;119;118;117;118;117;118;117;117 16:38:31 INFO - PROCESS | 308 | |6;imaging-darkroom;148;148;148;148;149;148;146;148;149;147 16:38:31 INFO - PROCESS | 308 | |7;imaging-desaturate;95;96;96;95;96;95;95;95;96;95 16:38:31 INFO - PROCESS | 308 | |8;json-parse-financial;62;61;63;62;62;63;64;63;63;62 16:38:31 INFO - PROCESS | 308 | |9;json-stringify-tinderbox;65;66;66;66;67;65;66;71;66;66 16:38:31 INFO - PROCESS | 308 | |10;stanford-crypto-aes;85;84;84;83;91;85;84;85;110;87 16:38:31 INFO - PROCESS | 308 | |11;stanford-crypto-ccm;134;147;144;145;134;141;133;150;139;152 16:38:31 INFO - PROCESS | 308 | |12;stanford-crypto-pbkdf2;171;170;169;172;168;173;171;175;168;174 16:38:31 INFO - PROCESS | 308 | |13;stanford-crypto-sha256-iterative;71;70;70;71;69;70;69;70;68;68 16:38:31 INFO - PROCESS | 308 | __end_tp_report 16:38:31 INFO - PROCESS | 308 | __start_cc_report 16:38:31 INFO - PROCESS | 308 | _x_x_mozilla_cycle_collect,983 16:38:31 INFO - PROCESS | 308 | __end_cc_report 16:38:31 INFO - PROCESS | 308 | __startTimestamp1465601911727__endTimestamp 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | ------- Summary: start ------- 16:38:31 INFO - PROCESS | 308 | Number of tests: 14 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:2.07 (1.8%) stddev-sans-first:2.19 16:38:31 INFO - PROCESS | 308 | Values: 113.0 108.0 113.0 114.0 115.0 115.0 115.0 114.0 114.0 114.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:158.00 stddev:22.62 (14.3%) stddev-sans-first:23.41 16:38:31 INFO - PROCESS | 308 | Values: 169.0 131.0 157.0 179.0 132.0 159.0 152.0 134.0 199.0 137.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.69 (1.6%) stddev-sans-first:2.76 16:38:31 INFO - PROCESS | 308 | Values: 162.0 167.0 167.0 168.0 163.0 163.0 161.0 164.0 160.0 164.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:34.24 (45.1%) stddev-sans-first:35.72 16:38:31 INFO - PROCESS | 308 | Values: 75.0 76.0 76.0 159.0 77.0 78.0 75.0 75.0 156.0 79.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:86.50 stddev:24.57 (28.4%) stddev-sans-first:25.43 16:38:31 INFO - PROCESS | 308 | Values: 87.0 87.0 142.0 86.0 86.0 87.0 136.0 86.0 90.0 135.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.25 (1.1%) stddev-sans-first:0.71 16:38:31 INFO - PROCESS | 308 | Values: 121.0 118.0 119.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 16:38:31 INFO - PROCESS | 308 | Values: 148.0 148.0 148.0 148.0 149.0 148.0 146.0 148.0 149.0 147.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:38:31 INFO - PROCESS | 308 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 16:38:31 INFO - PROCESS | 308 | Values: 62.0 61.0 63.0 62.0 62.0 63.0 64.0 63.0 63.0 62.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:1.71 (2.6%) stddev-sans-first:1.74 16:38:31 INFO - PROCESS | 308 | Values: 65.0 66.0 66.0 66.0 67.0 65.0 66.0 71.0 66.0 66.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:8.12 (9.6%) stddev-sans-first:8.55 16:38:31 INFO - PROCESS | 308 | Values: 85.0 84.0 84.0 83.0 91.0 85.0 84.0 85.0 110.0 87.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:144.50 stddev:6.84 (4.7%) stddev-sans-first:6.63 16:38:31 INFO - PROCESS | 308 | Values: 134.0 147.0 144.0 145.0 134.0 141.0 133.0 150.0 139.0 152.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.50 stddev:2.42 (1.4%) stddev-sans-first:2.57 16:38:31 INFO - PROCESS | 308 | Values: 171.0 170.0 169.0 172.0 168.0 173.0 171.0 175.0 168.0 174.0 16:38:31 INFO - PROCESS | 308 | 16:38:31 INFO - PROCESS | 308 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:1.01 16:38:31 INFO - PROCESS | 308 | Values: 71.0 70.0 70.0 71.0 69.0 70.0 69.0 70.0 68.0 68.0 16:38:31 INFO - PROCESS | 308 | -------- Summary: end -------- 16:38:31 INFO - PROCESS | 308 | 16:38:32 INFO - TEST-INFO | 308: exit 0 16:38:33 INFO - TEST-OK | kraken | took 64107ms 16:38:33 INFO - SUITE-END | took 1179s 16:38:33 INFO - Completed test suite (00:19:39) 16:38:33 INFO - javascript benchmark 16:38:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6323.881273873657, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.4528549004713, 2651.496215719014, 2657.6943651480087, 2658.481596088761, 2665.0139448404093, 4695.600873925716, 4705.976470117649, 4726.763661816913, 4834.105690447261, 4855.344528488662, 4667.043256132493, 4802.399700037496, 4805.567498925096, 4811.2783082537635, 4875.512448755123, 4328.523862375128, 4408.889777755549, 4469.3296005599095, 4491.977540112295, 4493.191225579394, 558.7420512021353, 4339.848105316315, 4404.823807047715, 4425.358323043157, 4483.5964763171305, 4400.977995110004, 4410.977945110254, 4446.044100518404, 4456.153330867125, 4492.101579684044, 4352.455943007124, 4444.266695995157, 4465.352523884018, 4474.9776251118865, 4492.66305027121, 4340.826366945318, 4377.7592232427205, 4390.626796722282, 4436.334549817553, 4443.044745379759, 4765.880852978668, 4775.9761201194115, 4784.521547845223, 4793.904121917542, 4832.44426890905, 5024.62315326352, 5075.441701412841, 5081.923771143436, 5117.309163262987, 5130.53825155734, 5157.277981082651, 5189.922151167735, 5210.739463026872, 5232.947670523322, 5246.160614301732, 4862.7325497097645, 4869.0, 4870.902581948341, 4876.366072410599, 4918.827841025547, 5091.465396133427, 5222.869428264248, 5343.519083282523, 5346.652467589594, 5348.759305831247, 5004.0, 5035.597152227813, 5052.090623687772, 5058.418281897629, 5109.259157422153, 5128.589712822965, 5128.743562821844, 5141.177411614199, 5155.304033955368, 5181.3782346118705, 4910.165271903785, 4983.878627308899, 5038.3198268234055, 5089.109405854035, 5096.694198348111, 4994.126027945095, 5043.0, 5055.772490237948, 5074.517920797518, 5109.20807274873, 4279.165562715303, 4290.313549832012, 4295.9570404295555, 4320.913581728348, 4330.069035157457, 3704.814759262026, 3722.2927643747603, 3736.551613806361, 3755.7746535207975, 3794.032521707002, 4465.754383508938, 4470.061287129739, 4489.932651010237, 4516.277395616686, 4524.23088075028, 5102.387713474407, 5139.922901156411, 5176.456472070454, 5188.558972487305, 5230.241614965808, 4376.474823021258, 4433.490148632884, 4436.578525040116, 4467.597916187558, 4482.170798402306, 4573.039661671086, 4582.564656357641, 4593.517680643551, 4613.953860461353, 4615.423072115986, 4856.417229932431, 4871.561559459666, 4891.29076283944, 4897.90204195907, 4916.164252077084, 5015.799368025238, 5068.0, 5118.948810511847, 5140.948590514047, 5204.0892843752945, 4821.975890120527, 4834.395700537433, 4854.514548545118, 4863.124637565272, 4912.336834527293, 5098.439171691185, 5098.46466121052, 5098.847034588968, 5105.821296254613, 5150.871228219325, 5044.394672639307, 5176.844694659016, 5226.216067589892, 5237.16205407133, 5252.789888404421, 5064.037832811754, 5074.3657042869645, 5076.873078173076, 5081.3902331718955, 5142.8971420572125, 4853.2720091985075, 5086.771095300646, 5095.337606111182, 5096.23556466533, 5104.770285337095, 4793.808247670054, 4833.73414462208, 4888.6577939543895, 4896.290037944549, 4935.950640493549, 4980.153373926369, 5046.571041461517, 5058.974705126451, 5064.772085256099, 5097.974510127426, 4953.72754498506, 4954.405471343462, 4957.281194226889, 4969.279454479152, 5008.574271186844], "value": 4689.896239129269, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.8585351591053, 584.9824505264844, 585.1632166002618, 602.5330368964052, 610.7556977209118, 35024.64975350246, 38157.80921095398, 38222.23555528888, 38251.42622860659, 38374.232515349744, 38738.22523549527, 39134.8043259784, 39139.41290880639, 39229.60770392295, 39256.0, 7648.082230132378, 7771.611419429034, 7783.299503044725, 7786.610669466532, 7805.531668099904, 7701.576413297266, 7787.18234585366, 7790.805229869242, 7793.610319484032, 7797.103333116707, 7780.299773020427, 7812.375009999215, 7824.178461261571, 7847.843043139133, 7862.921370786276, 7776.53340799551, 7787.922120778805, 7807.570583617899, 7830.608469576527, 7835.725749598793, 7715.267049630333, 7770.222977702241, 7778.416618753616, 7796.844063118762, 7810.101838288612, 38133.427998580046, 38136.42795358072, 38351.42472862909, 38481.615183848364, 38490.80754596237, 3177.602799650044, 3193.2495863472063, 3259.6414394416597, 3457.170279133015, 3752.287065457582, 29665.70334296651, 30093.247668808235, 30187.245318866986, 30372.696273037207, 30797.692023079708, 3219.96780032199, 3248.740100791955, 3261.1031966209243, 3278.60656721195, 3336.4161271777584, 188878.0, 189185.0, 189778.0, 190448.0477597617, 191157.0, 31046.844765776477, 32808.34383312368, 53939.730301348245, 54471.45528544743, 55097.0, 33586.664133358354, 33601.66398335985, 33707.66292337095, 33789.66210337865, 33895.49156762651, 11928.880711192951, 11935.940320298516, 11949.522019119138, 11953.641390758292, 11974.58088966882, 11255.155863310285, 11351.205415620827, 11370.0, 11413.0, 11438.313701177956, 7833.5691536966015, 7906.130325664172, 7911.169327220674, 7977.48146370484, 8028.397870159762, 3062.9540556891666, 3104.3946430445844, 3107.1144723753623, 3162.067190178903, 3169.508726147451, 851.3231980575457, 895.9148880856309, 896.4352457951579, 957.5643082397493, 993.5529011944653, 28011.0, 28493.578045865917, 28794.28014299659, 28795.28011799722, 28954.420911581652, 888.6312180445173, 934.0985948559672, 936.1714882329188, 963.2438535749403, 985.9507024648739, 14608.123512589278, 14686.192259425621, 14738.0, 14936.103833770008, 15070.773938390932, 391073.0, 438449.0, 449800.0, 450162.0, 734530.0, 50189.74905125451, 50454.49545504571, 50765.49234507682, 50933.236001460005, 50946.23580646293, 1201.375284851872, 1213.538855235005, 1221.8900298973135, 1222.6821026533166, 1223.2660403757675, 28280.43439131247, 29119.7088029117, 29627.0, 29975.550366744952, 30061.54907676343, 44229.33655995227, 44730.0, 44802.77598612117, 44891.0, 44899.0, 272388.0, 274782.0, 275123.0, 275271.0, 276500.0, 25308.49383012366, 26056.73943260543, 26341.07806226773, 26357.60463593086, 26483.470330593667, 43086.0, 43179.568204317555, 43421.34867977046, 43472.34791478194, 44893.326600101675, 36622.63377366299, 37091.0, 37272.62727372692, 37368.0, 37631.62368376281, 36273.89946660504, 37385.62614373821, 37495.81252093722, 37823.43264850974, 37954.43068354032, 35432.46851297284, 36599.81700091482, 36715.26569468649, 37053.629463705016, 37061.62938370582, 31875.0, 32776.83611581927, 33127.0, 33389.0, 33401.33197335991, 25621.10326138576, 25913.870430647727, 26108.0, 26365.472690546467, 26460.7353926466], "value": 16460.082362525492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.6692143991848, 374.2757763727187, 379.75885312826347, 386.4821139672838, 391.6044794757294, 15589.0, 16269.267882945267, 17300.653986920253, 17367.91316043421, 17388.56528586786, 16083.989501312335, 16408.425705100322, 17246.482605521822, 17297.82702172978, 17318.134093295346, 5040.3951525816865, 5164.328637277149, 5178.66338687986, 5192.818251361203, 5253.9737301313635, 3684.3552378333684, 5177.58579313654, 5841.269841269841, 6159.815205543819, 6166.290876549209, 6203.286622038456, 6212.192414986045, 6219.471344935686, 6228.439440450358, 6233.2208473940755, 5086.135356989321, 5422.267993820843, 5427.755750991195, 5508.476694713996, 5509.972450137724, 5119.948800511985, 5310.0, 5310.601704872111, 5353.678779273256, 5363.973180134113, 12227.266364018098, 12327.075469339836, 12353.444095015746, 17359.739603905953, 20027.1989120435, 1813.5375479252707, 1870.6071724937779, 1916.875403098794, 1974.2991238110408, 2009.6382651122792, 9106.63573457061, 9283.860742088875, 9377.202937750299, 9388.530573471367, 9640.228781697448, 1661.4849396687066, 1731.5584525945928, 1782.073321872619, 1815.9818401815944, 1823.5988082621802, 65339.0, 68273.0, 68845.65577172131, 69644.65177674181, 70042.2995770046, 9865.901340986498, 9873.111419972238, 10046.598136074621, 10059.44673042975, 10120.392776433437, 13909.0, 14042.508512202025, 14098.718025639635, 14109.647258818612, 14115.435382584581, 7163.247858974837, 7339.302766237306, 7457.85084298311, 7670.041244844395, 7700.691972321044, 6551.836204094936, 6580.341965803477, 6689.364510371507, 7007.509474336747, 7015.403690686247, 4274.914501709948, 4296.377025331372, 4346.326319420495, 4348.760818154969, 4382.671299652475, 1665.9416920407728, 1724.7240441529295, 1786.4015554789032, 1859.1633764805892, 1880.4546681462496, 728.3735987051132, 806.2381049907898, 822.7367242482349, 838.3963546246692, 870.6038752367657, 13519.188848669111, 15472.845271547141, 15548.144852033247, 15575.61060973462, 15844.841551584337, 783.9216078392229, 797.5932274539911, 822.296936119621, 832.3216578488513, 846.0735494633367, 9115.90884091164, 9150.954245228864, 9160.0, 9174.403663761834, 9241.676541321021, 301357.0, 305345.0, 305378.0, 408840.0, 411573.0, 81373.59313203515, 81441.59279203566, 81610.59194703988, 82548.0, 83977.0, 928.4754113925745, 943.8631398447187, 944.8913374961967, 967.685502211784, 968.7239136845965, 14426.927865360605, 15269.160196188872, 15363.15502647365, 15559.766603501183, 15920.442784502487, 34859.0, 35193.82403087968, 35717.46423803697, 36104.45843312405, 36879.63120368762, 49289.26066108939, 49633.0, 50414.49585504245, 50431.0, 51248.23127653163, 7325.4872158948365, 7847.5683837387205, 7932.920670793449, 7992.880106798519, 7997.320227780471, 10256.743581410525, 11769.646910592695, 11788.29270243788, 12096.758064838477, 12222.388880555758, 9441.489361702095, 9915.801683966425, 10293.43386113771, 10406.0, 10498.212634052325, 10076.143527800219, 10197.286189966928, 10284.794304114026, 10335.276530642783, 10531.368117912949, 10254.743631409274, 10263.58945642166, 10458.843117353397, 10501.264911456125, 10652.09457196147, 6557.114789503356, 6913.343232392915, 7798.610069496616, 7827.882581761164, 7996.680132794856, 9637.42175469474, 10573.471326433493, 10603.0, 10626.84059739089, 10681.679549613524], "value": 8095.257547267912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.690261239915, 1363.7408892310461, 1400.9159450432974, 1585.2470076713569, 1630.567899506631, 6837.111175547185, 7534.736284230053, 7556.093268807744, 8035.758927232185, 8036.799080023003, 7526.849463010736, 7734.187910269411, 7745.496542724719, 7784.065912090543, 7841.725539606115, 2167.4906396996735, 2206.481476852938, 2206.9889650551727, 2218.5341078373563, 2220.3449982255192, 2163.3185546552863, 2182.6507758758603, 2211.2481756202887, 2227.164813195052, 2230.130249202812, 2206.9889650551804, 2207.39296693409, 2212.5685491329195, 2220.2562141682474, 2234.4078819112947, 2114.143771772435, 2117.28012475759, 2119.3641907427786, 2124.4051665533675, 2130.8614940028847, 2027.4525878013, 2055.054674849571, 2060.6702927531674, 2064.0711679744177, 2067.5658111796542, 7726.381889448887, 7743.341815945651, 7780.610969451504, 7835.529868207926, 7847.215278472164, 4572.748498832563, 4696.600788932945, 4699.694519856233, 4774.689645173087, 4835.323054772335, 2899.594056832045, 2981.3739114785703, 3014.261505931039, 3016.1856298799203, 3017.5775391445213, 914.9908500914972, 934.6261495401826, 935.1209862729013, 952.4285428742768, 959.3380567408466, 10580.947095264552, 10583.470826458646, 10625.362478251329, 10632.468376581217, 10647.467626618638, 4254.0, 4308.224519586442, 4358.084802191512, 4366.279563871989, 4390.517043125254, 9075.818483630423, 9091.090890910857, 9100.135487128713, 9108.681196158102, 9138.68014619485, 4719.858404247878, 4748.074125545554, 4799.232122860326, 4805.014971930816, 4827.275908613736, 3768.6231376862092, 4111.342185250405, 4250.808713607895, 4385.495667998157, 4408.404865343202, 3678.834452449593, 3705.351563476435, 3826.3686491728554, 3836.8873026821907, 3850.0567360996733, 1205.9457324420246, 1246.7693476706838, 1249.2129958126322, 1261.243254047564, 1265.6835791052238, 824.3075816314325, 827.7392621324263, 835.0814104485017, 835.0855812884881, 843.4644001059249, 5136.203888397305, 5460.918086228709, 5579.7489112990015, 5656.830295091154, 5712.257406537124, 835.7534527314457, 840.2185967050701, 884.9026607073217, 894.6600291889041, 910.7723069232692, 3546.6098729139776, 3546.66306700863, 3615.07815507044, 3655.8354874030733, 3708.981455092707, 9431.434113953184, 9705.223582113555, 9759.902400976041, 9794.510274486247, 9862.45756483386, 9606.183474404754, 9614.086661767122, 9629.422234665803, 9653.420794752337, 9737.464439455898, 6876.69054892531, 7145.249748776304, 7178.5692858428665, 7324.67038983247, 7390.371818395497, 5369.248305237348, 5586.469285417878, 5598.384177740527, 5664.065429204135, 5794.304683438015, 8668.133186681282, 8670.913290867264, 8748.868766968373, 8802.559872006246, 8894.866577001221, 8575.442596231225, 9041.23149532297, 9047.592858321259, 9049.0, 9087.909120908706, 6202.906956395567, 6636.767713130017, 6782.626955517494, 6843.110395648534, 6940.09778728762, 7657.004589403342, 7658.578778167254, 7691.346235570039, 7728.92271077282, 7731.0, 6685.933140668531, 6862.176538815374, 6987.510874238755, 7010.614416207158, 7087.539309944837, 6740.62926539045, 6742.8651426972165, 6838.863222735617, 6919.654017299215, 6923.4807389447, 5569.66582005081, 5815.534757219328, 6272.874542509033, 6352.682365881595, 6359.904601431075, 4495.640348772155, 4574.473935497461, 4586.610138138296, 4613.3771940787565, 4638.373819534319, 4672.719636821802, 4683.929741053955, 4717.150912835723, 4736.952630473651, 4737.644676649196], "value": 4177.192015583954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.88718287050915, 305.5630448458704, 310.3637543036775, 311.3290858200577, 311.85342888842234, 4844.346013288205, 4947.455779864212, 4960.701133746054, 5051.696898186111, 5060.468650791665, 4946.480619534951, 4986.601071914247, 5001.899962000767, 5010.3737032870895, 5027.824026159085, 3906.8279516145185, 3916.4516967624413, 3959.554762511677, 3970.8411663533498, 3971.98014009931, 3829.157585331223, 3863.8454461821493, 3931.3709806430975, 3943.467631869704, 3959.78221197834, 3856.7465573688523, 3877.806109694518, 3891.462872165493, 3897.2400381925536, 3899.337112690835, 3888.4556162137324, 3890.8521986014193, 3894.435306880501, 3900.726949113549, 3906.2187562487616, 3319.96680033199, 3449.344624521333, 3470.6182319945037, 3475.4613034979366, 3477.556813922219, 4839.249916262985, 4890.339804126433, 4894.559489645913, 4903.469501958584, 4910.263460480956, 4521.344405061248, 4527.750973696446, 4532.4787649420405, 4533.818647254106, 4541.546705054384, 5006.899862002776, 5228.8692782680355, 5234.22586029405, 5254.65844720092, 5255.6363927086695, 3817.8091095445116, 3826.5459125532398, 3828.636279553438, 3835.4822099016833, 3841.442990766351, 5499.835004949858, 5515.889682206333, 5525.723713814293, 5529.336479622471, 5568.220449137124, 3742.925141497155, 3983.820728067244, 3989.0, 3990.82041308136, 4009.4587230724064, 4007.2185923745174, 4013.8795836124964, 4014.3777714454304, 4022.959770402317, 4032.0, 4508.07584445188, 4511.5262897395305, 4516.570925762047, 4524.75569218461, 4530.433695788027, 5246.291750613695, 5250.317458730341, 5278.81226723984, 5291.497307755757, 5330.786768529216, 1367.699106196635, 1405.3113974152795, 1411.3014058041335, 1412.4420853762706, 1412.7527682655493, 886.822635472908, 908.4367692030983, 917.2111983694018, 923.3610341643637, 930.2279158203498, 4045.3527435610163, 4128.587141285908, 4138.8344466221015, 4143.544210136883, 4152.875413737533, 4720.575148236675, 4733.573978341966, 4750.857474275777, 4751.263554149113, 4797.280407938837, 4128.855490057894, 4133.904515303447, 4160.251154792106, 4166.395872598517, 4176.665866730655, 2413.5277480736736, 2541.809364297685, 2573.6139579062915, 2591.883365248568, 2596.766291033778, 4486.685931984795, 4511.826924999458, 4525.691897132486, 4535.569120933506, 4537.570665240439, 4847.927281090787, 4849.539293767087, 4851.587615052689, 4875.488073752276, 4901.436334821541, 4195.6250831194975, 4559.316102584705, 4564.497905230422, 4567.2464043432465, 4582.33556134352, 4794.0, 4806.807727690853, 4821.035792841516, 4828.754629097487, 4832.758362081952, 4654.511276315938, 4694.835680751294, 4728.59806916416, 4734.17151998392, 4763.476017638126, 4561.224591819465, 4784.258439941815, 5213.608979326642, 5217.982493413748, 5221.269022336952, 3548.9290214195057, 3694.9815250923575, 3812.9428058579697, 3877.6897848171516, 3893.7274390792372, 5385.3268341457315, 5385.380681221553, 5397.190421436816, 5401.351837779334, 5430.864228394322, 5202.921956170585, 5204.1673332266655, 5238.140460136597, 5253.632245742761, 5266.657667251617, 5156.845294641167, 5207.3751149862255, 5222.843314700565, 5270.130428479258, 5309.734513274244, 5128.358955130609, 5146.305248791515, 5156.819511317086, 5164.605556499649, 5227.2420499028185, 5257.158854583248, 5280.735963201748, 5282.075636763628, 5288.471152884681, 5310.840674779763, 4945.925811112764, 5137.357830271216, 5176.4305926348825, 5178.663386879841, 5180.523550788158], "value": 3859.8416235925506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.4218203616745, 643.8197304754669, 658.9275179730225, 727.6943683652867, 731.7585196885028, 12651.746965060693, 13244.602661920133, 13612.455501779918, 13657.726845463085, 13664.453421863125, 11912.880871191286, 11956.222845515036, 12093.455794489248, 12146.27122372656, 12403.937980310086, 621.6456619726757, 753.7098217186395, 777.5878784244331, 779.7037125892153, 780.332815442794, 776.7242628866755, 778.1168373895613, 778.155701064343, 781.2460975158971, 782.9899429735663, 818.5293456262643, 819.2831272636444, 821.5358322547771, 824.7278398128633, 825.3685930263354, 817.0807841178674, 818.2145140664938, 820.4257020085934, 820.6512232301308, 821.6836517940576, 601.6119602856177, 601.8675891303906, 602.0728078758706, 602.4698265526353, 604.0305309977467, 12956.48174073036, 12961.351932403437, 13026.0, 13083.869161308361, 13121.343932803416, 13057.347132643425, 13461.394237259346, 13544.0, 13617.455301787917, 13702.0, 10692.625758098508, 10761.0, 10774.353538787698, 10829.945850270777, 10951.123910087173, 3368.090615533792, 3392.7625066245373, 3408.437607794711, 3495.213576945167, 3498.6501349865066, 54213.0, 54674.72662636701, 54978.17532737012, 55031.72484137554, 57729.0, 10437.0, 10447.373157610567, 10476.423796691255, 10580.20648451354, 10680.839787403194, 19307.4207773767, 19571.51071223231, 19576.314828980918, 19648.60702785936, 19983.800161998486, 7089.326513981164, 7165.104361954755, 7167.820804479826, 7227.457940654472, 7336.413086953031, 3756.8685096022054, 3867.961320386816, 3871.496705428276, 3876.9612303877166, 3922.8234729437245, 2955.1725516855313, 3088.474959256932, 3088.845557722105, 3093.0102367242266, 3095.2880837407524, 470.3532642616402, 479.61630695444205, 480.2939678672346, 482.97826597803186, 486.8369096352691, 485.03720115570565, 554.2784926013255, 561.7724821447321, 592.3661682000219, 596.713577482802, 7769.423558897202, 7801.141874393812, 8084.514929104273, 8198.15541503157, 8290.336773058261, 493.65444189067796, 531.9335083114611, 547.7015026810398, 625.6402568523117, 628.7893555658814, 3631.382664946965, 3713.1830997180577, 3816.103215744298, 3899.7075219358094, 4072.490938632671, 83679.58160209282, 88254.55872720595, 88383.55808220917, 88990.55504722435, 90587.54706226426, 76639.61680191563, 81972.59013704893, 82653.58673206596, 82728.17271827205, 83360.0, 57347.42652573421, 71953.64023179955, 73384.63307683427, 73515.63242183755, 74293.62853185808, 7446.292602202782, 7487.513311634726, 7526.5860377679755, 7679.769606911802, 7786.844263114593, 33646.495302569994, 43315.78342108395, 44192.33711494395, 44665.0, 44961.0, 59787.40212597818, 61587.0, 62033.37966620276, 62047.0, 62102.37897620966, 9523.047695230422, 10400.843987340348, 10590.523426445674, 10604.204684648528, 10636.41499717523, 10762.677119686421, 10822.188335874998, 11382.715432114263, 11622.360770157384, 11994.340311282964, 10220.284580079324, 10451.529681164213, 10478.79042419132, 10564.207684423545, 10708.839367409339, 10628.52171652262, 10918.890811091787, 11009.229353945468, 11044.116470682166, 11087.168462365516, 8880.067592902653, 9875.209983201183, 9918.355306905316, 9995.500224988577, 10047.648332308334, 8246.587670616565, 8304.750857474286, 8367.707130250412, 8601.956990215009, 8714.433561818461, 8578.742637720878, 9304.395214311047, 9367.110124538158, 9541.904580954379, 9595.808083838423], "value": 6347.123322304572, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 131.0, 157.0, 179.0, 132.0, 159.0, 152.0, 134.0, 199.0, 137.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 167.0, 168.0, 163.0, 163.0, 161.0, 164.0, 160.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 159.0, 77.0, 78.0, 75.0, 75.0, 156.0, 79.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 142.0, 86.0, 86.0, 87.0, 136.0, 86.0, 90.0, 135.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 146.0, 148.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 66.0, 71.0, 66.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 91.0, 85.0, 84.0, 85.0, 110.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 147.0, 144.0, 145.0, 134.0, 141.0, 133.0, 150.0, 139.0, 152.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 169.0, 172.0, 168.0, 173.0, 171.0, 175.0, 168.0, 174.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 71.0, 69.0, 70.0, 69.0, 70.0, 68.0, 68.0], "value": 69.6, "unit": "score"}]}]} 16:38:33 INFO - Return code: 0 16:38:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:38:33 ERROR - # TBPL SUCCESS # 16:38:33 INFO - Running post-action listener: _resource_record_post_action 16:38:33 INFO - ##### 16:38:33 INFO - ##### Finished run-tests step (success) 16:38:33 INFO - ##### 16:38:33 INFO - Running post-run listener: _resource_record_post_run 16:38:33 INFO - Total resource usage - Wall time: 1197s; CPU: 14.0%; Read bytes: 0; Write bytes: 535728128; Read time: 0; Write time: 499136 16:38:33 INFO - TinderboxPrint: CPU usage
13.5% 16:38:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:38:33 INFO - TinderboxPrint: I/O write bytes / time
535,728,128 / 499,136 16:38:33 INFO - TinderboxPrint: CPU idle
8,256.9 (86.5%) 16:38:33 INFO - TinderboxPrint: CPU user
1,234.7 (12.9%) 16:38:33 INFO - TinderboxPrint: Swap in / out
0 / 0 16:38:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237957120; Read time: 0; Write time: 275432 16:38:33 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 0; Write bytes: 291311616; Read time: 0; Write time: 222636 16:38:34 INFO - Running post-run listener: _upload_blobber_files 16:38:34 INFO - Blob upload gear active. 16:38:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:38:34 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 16:38:34 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:38:34 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:38:34 INFO - (blobuploader) - INFO - Open directory for files ... 16:38:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:38:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:35 INFO - (blobuploader) - INFO - Done attempting. 16:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:38 INFO - (blobuploader) - INFO - Done attempting. 16:38:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:38:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:38:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:38:39 INFO - (blobuploader) - INFO - Done attempting. 16:38:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:38:39 INFO - Return code: 0 16:38:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:38:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:38:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af98cb589eddc21d46425536f8ef3d5a309c7d72010888e46c06ea9713fe0ffab05f607e49f899e1613cbfea2d6060e849717da4665505e2ed732af2bfbd4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385f29f5515b08a0c9e5b6b23cac9c9a00a2078d2ab98d8f711bb69bbf31d4feb55dd9041f5abcb7e7a9de8e120aee95b8a1d339045171bb77a4801d8169ff8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7337164a2341bc3338e6b28289db2b70ed47f693f1a07fda18b6e9f64ecb8f42ec050d5bd6c9573021b2a398b7ffff00ab1b15849c5811e212329a47473e6d5"} 16:38:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:38:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:38:39 INFO - Contents: 16:38:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af98cb589eddc21d46425536f8ef3d5a309c7d72010888e46c06ea9713fe0ffab05f607e49f899e1613cbfea2d6060e849717da4665505e2ed732af2bfbd4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385f29f5515b08a0c9e5b6b23cac9c9a00a2078d2ab98d8f711bb69bbf31d4feb55dd9041f5abcb7e7a9de8e120aee95b8a1d339045171bb77a4801d8169ff8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7337164a2341bc3338e6b28289db2b70ed47f693f1a07fda18b6e9f64ecb8f42ec050d5bd6c9573021b2a398b7ffff00ab1b15849c5811e212329a47473e6d5"} 16:38:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:38:39 INFO - Copying logs to upload dir... 16:38:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:38:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.071253 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-10 16:38:38.508703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:38.511992) ========= 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=826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580 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/Fx-Team-Non-PGO/sha512/af98cb589eddc21d46425536f8ef3d5a309c7d72010888e46c06ea9713fe0ffab05f607e49f899e1613cbfea2d6060e849717da4665505e2ed732af2bfbd4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385f29f5515b08a0c9e5b6b23cac9c9a00a2078d2ab98d8f711bb69bbf31d4feb55dd9041f5abcb7e7a9de8e120aee95b8a1d339045171bb77a4801d8169ff8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7337164a2341bc3338e6b28289db2b70ed47f693f1a07fda18b6e9f64ecb8f42ec050d5bd6c9573021b2a398b7ffff00ab1b15849c5811e212329a47473e6d5"} build_url:https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/d5-K0JJYSkWcIZFN3kDXow/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/Fx-Team-Non-PGO/sha512/af98cb589eddc21d46425536f8ef3d5a309c7d72010888e46c06ea9713fe0ffab05f607e49f899e1613cbfea2d6060e849717da4665505e2ed732af2bfbd4f63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/385f29f5515b08a0c9e5b6b23cac9c9a00a2078d2ab98d8f711bb69bbf31d4feb55dd9041f5abcb7e7a9de8e120aee95b8a1d339045171bb77a4801d8169ff8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a7337164a2341bc3338e6b28289db2b70ed47f693f1a07fda18b6e9f64ecb8f42ec050d5bd6c9573021b2a398b7ffff00ab1b15849c5811e212329a47473e6d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:38.536998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:38.537322) ========= 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=826874ccc97bd7bf541b4875000001d5-1465599555.664144-161526580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 16:38:38.620440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 16:38:38.620765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 16:38:38.621045) ========= ========= Total master_lag: 0.17 =========