builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1466821384.53 results: success (0) buildid: 20160624163014 builduid: 7ad6286885064645bf59e70f6c172b27 revision: 0e073f5ca38a002d43e92016ee40d686da4a0534 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.531694) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.554002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.554387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.618748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.619082) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 19:23:05-- 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% 45.8M=0s 2016-06-24 19:23:05 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089797 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.726953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.732292) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017506 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.783594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:04.783948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e073f5ca38a002d43e92016ee40d686da4a0534 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0e073f5ca38a002d43e92016ee40d686da4a0534 --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=d6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 19:23:05,822 truncating revision to first 12 chars 2016-06-24 19:23:05,822 Setting DEBUG logging. 2016-06-24 19:23:05,822 attempt 1/10 2016-06-24 19:23:05,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e073f5ca38a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 19:23:06,143 unpacking tar archive at: mozilla-central-0e073f5ca38a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.492766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.493078) ========= script_repo_revision: 0e073f5ca38a002d43e92016ee40d686da4a0534 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.493486) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.493763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 19:23:05.503557) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-24 19:23:05.503937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:23:06 INFO - MultiFileLogger online at 20160624 19:23:06 in /builds/slave/test 19:23:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:23:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:23:06 INFO - {'append_to_log': False, 19:23:06 INFO - 'base_work_dir': '/builds/slave/test', 19:23:06 INFO - 'blob_upload_branch': 'Firefox', 19:23:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:23:06 INFO - 'branch': 'Firefox', 19:23:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:23:06 INFO - 'config_files': ('talos/linux_config.py',), 19:23:06 INFO - 'default_actions': ('clobber', 19:23:06 INFO - 'read-buildbot-config', 19:23:06 INFO - 'download-and-extract', 19:23:06 INFO - 'populate-webroot', 19:23:06 INFO - 'create-virtualenv', 19:23:06 INFO - 'install', 19:23:06 INFO - 'run-tests'), 19:23:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:23:06 INFO - 'download_minidump_stackwalk': True, 19:23:06 INFO - 'download_symbols': 'ondemand', 19:23:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:23:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:23:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:23:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:23:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:23:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:23:06 INFO - 'installer_path': 'installer.exe', 19:23:06 INFO - 'log_level': 'info', 19:23:06 INFO - 'log_name': 'talos', 19:23:06 INFO - 'log_to_console': True, 19:23:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:23:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:23:06 INFO - 'opt_config_files': (), 19:23:06 INFO - 'pip_index': False, 19:23:06 INFO - 'sps_profile': False, 19:23:06 INFO - 'sps_profile_interval': 0, 19:23:06 INFO - 'suite': 'dromaeojs-e10s', 19:23:06 INFO - 'system_bits': '32', 19:23:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:23:06 INFO - 'title': 'talos-linux64-ix-034', 19:23:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:23:06 INFO - 'use_talos_json': True, 19:23:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:23:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:23:06 INFO - 'work_dir': 'build'} 19:23:06 INFO - ##### 19:23:06 INFO - ##### Running clobber step. 19:23:06 INFO - ##### 19:23:06 INFO - Running pre-action listener: _resource_record_pre_action 19:23:06 INFO - Running main action method: clobber 19:23:06 INFO - rmtree: /builds/slave/test/build 19:23:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:23:07 INFO - Running post-action listener: _resource_record_post_action 19:23:07 INFO - ##### 19:23:07 INFO - ##### Finished clobber step (success) 19:23:07 INFO - ##### 19:23:07 INFO - ##### 19:23:07 INFO - ##### Running read-buildbot-config step. 19:23:07 INFO - ##### 19:23:07 INFO - Running pre-action listener: _resource_record_pre_action 19:23:07 INFO - Running main action method: read_buildbot_config 19:23:07 INFO - Using buildbot properties: 19:23:07 INFO - { 19:23:07 INFO - "project": "", 19:23:07 INFO - "product": "firefox", 19:23:07 INFO - "script_repo_revision": "production", 19:23:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:23:07 INFO - "repository": "", 19:23:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:23:07 INFO - "buildid": "20160624163014", 19:23:07 INFO - "pgo_build": "True", 19:23:07 INFO - "basedir": "/builds/slave/test", 19:23:07 INFO - "buildnumber": 71, 19:23:07 INFO - "slavename": "talos-linux64-ix-034", 19:23:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:23:07 INFO - "platform": "ubuntu64_hw", 19:23:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:23:07 INFO - "branch": "mozilla-central", 19:23:07 INFO - "repo_path": "mozilla-central", 19:23:07 INFO - "revision": "0e073f5ca38a002d43e92016ee40d686da4a0534", 19:23:07 INFO - "stage_platform": "linux64-pgo", 19:23:07 INFO - "builduid": "7ad6286885064645bf59e70f6c172b27", 19:23:07 INFO - "slavebuilddir": "test" 19:23:07 INFO - } 19:23:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:23:07 INFO - Running post-action listener: _resource_record_post_action 19:23:07 INFO - ##### 19:23:07 INFO - ##### Finished read-buildbot-config step (success) 19:23:07 INFO - ##### 19:23:07 INFO - ##### 19:23:07 INFO - ##### Running download-and-extract step. 19:23:07 INFO - ##### 19:23:07 INFO - Running pre-action listener: _resource_record_pre_action 19:23:07 INFO - Running main action method: download_and_extract 19:23:07 INFO - mkdir: /builds/slave/test/build/tests 19:23: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')]} 19:23:07 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:07 INFO - Downloaded 1361 bytes. 19:23:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:23:07 INFO - Using the following test package requirements: 19:23:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:23:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:23:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:23:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'jsshell-linux-x86_64.zip'], 19:23:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:23:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:23:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:23:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:23:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:23:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:23:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:23:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:23: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')]} 19:23:07 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:08 INFO - Downloaded 24279771 bytes. 19:23:08 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'] 19:23:08 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 19:23:10 INFO - Return code: 0 19:23:10 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 19:23:10 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')]} 19:23:10 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:11 INFO - Downloaded 24279771 bytes. 19:23:11 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'] 19:23:11 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 19:23:12 INFO - Return code: 0 19:23:12 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')]} 19:23:12 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:13 INFO - Downloaded 14405188 bytes. 19:23:13 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'] 19:23:13 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 19:23:13 INFO - Return code: 0 19:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:13 INFO - https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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 19:23:15 INFO - Downloaded 60188127 bytes. 19:23:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:15 INFO - mkdir: /builds/slave/test/properties 19:23:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:23:15 INFO - Writing to file /builds/slave/test/properties/build_url 19:23:15 INFO - Contents: 19:23:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:15 INFO - Running post-action listener: _resource_record_post_action 19:23:15 INFO - Running post-action listener: set_extra_try_arguments 19:23:15 INFO - ##### 19:23:15 INFO - ##### Finished download-and-extract step (success) 19:23:15 INFO - ##### 19:23:15 INFO - ##### 19:23:15 INFO - ##### Running populate-webroot step. 19:23:15 INFO - ##### 19:23:15 INFO - Running pre-action listener: _resource_record_pre_action 19:23:15 INFO - Running main action method: populate_webroot 19:23:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:23:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:23:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:23:15 INFO - '--tppagecycles', 19:23:15 INFO - '7'], 19:23:15 INFO - 'tests': ['tsvgm']}}, 19:23:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:23:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:23:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:23:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:23:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['damp', 'tps']}, 19:23:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'tests': ['damp', 'tps']}, 19:23:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['dromaeo_dom']}, 19:23:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:23:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['basic_compositor_video']}, 19:23:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:23:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['a11yr', 19:23:15 INFO - 'ts_paint', 19:23:15 INFO - 'tpaint', 19:23:15 INFO - 'sessionrestore', 19:23:15 INFO - 'sessionrestore_no_auto_restore', 19:23:15 INFO - 'tabpaint']}, 19:23:15 INFO - 'other-e10s': {'tests': ['a11yr', 19:23:15 INFO - 'ts_paint', 19:23:15 INFO - 'tpaint', 19:23:15 INFO - 'sessionrestore', 19:23:15 INFO - 'sessionrestore_no_auto_restore', 19:23:15 INFO - 'tabpaint']}, 19:23:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:23:15 INFO - 'ts_paint', 19:23:15 INFO - 'tpaint', 19:23:15 INFO - 'sessionrestore', 19:23:15 INFO - 'sessionrestore_no_auto_restore', 19:23:15 INFO - 'tabpaint']}, 19:23:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:23:15 INFO - 'ts_paint', 19:23:15 INFO - 'tpaint', 19:23:15 INFO - 'sessionrestore', 19:23:15 INFO - 'sessionrestore_no_auto_restore', 19:23:15 INFO - 'tabpaint']}, 19:23:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['a11yr', 19:23:15 INFO - 'ts_paint', 19:23:15 INFO - 'tpaint', 19:23:15 INFO - 'sessionrestore', 19:23:15 INFO - 'sessionrestore_no_auto_restore', 19:23:15 INFO - 'tabpaint']}, 19:23:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['a11yr', 19:23:15 INFO - 'ts_paint', 19:23:15 INFO - 'tpaint', 19:23:15 INFO - 'sessionrestore', 19:23:15 INFO - 'sessionrestore_no_auto_restore', 19:23:15 INFO - 'tabpaint']}, 19:23:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['tsvgx', 19:23:15 INFO - 'tsvgr_opacity', 19:23:15 INFO - 'tart', 19:23:15 INFO - 'tscrollx', 19:23:15 INFO - 'cart']}, 19:23:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:23:15 INFO - 'tsvgr_opacity', 19:23:15 INFO - 'tart', 19:23:15 INFO - 'tscrollx', 19:23:15 INFO - 'cart']}, 19:23:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'talos_options': ['--disable-e10s'], 19:23:15 INFO - 'tests': ['tp5o']}, 19:23:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'tests': ['tp5o']}, 19:23:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'talos_options': ['--disable-e10s', 19:23:15 INFO - '--xperf_path', 19:23:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:15 INFO - 'tests': ['tp5n']}, 19:23:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:15 INFO - 'talos_options': ['--xperf_path', 19:23:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:15 INFO - 'tests': ['tp5n']}}, 19:23:15 INFO - 'talos.zip': {'path': '', 19:23:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:23:15 INFO - Running post-action listener: _resource_record_post_action 19:23:15 INFO - ##### 19:23:15 INFO - ##### Finished populate-webroot step (success) 19:23:15 INFO - ##### 19:23:15 INFO - ##### 19:23:15 INFO - ##### Running create-virtualenv step. 19:23:15 INFO - ##### 19:23:15 INFO - Running pre-action listener: _resource_record_pre_action 19:23:15 INFO - Running main action method: create_virtualenv 19:23:15 INFO - Creating virtualenv /builds/slave/test/build/venv 19:23:15 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 19:23:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:23:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:23:16 INFO - Using real prefix '/usr' 19:23:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:23:16 INFO - Installing distribute.............................................................................................................................................................................................done. 19:23:18 INFO - Installing pip.................done. 19:23:18 INFO - Return code: 0 19:23:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:23:18 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')]} 19:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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')]} 19:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:18 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 19:23:18 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 19:23:18 INFO - Using env: {'DISPLAY': ':0', 19:23:18 INFO - 'HOME': '/home/cltbld', 19:23:18 INFO - 'LANG': 'en_US.UTF-8', 19:23:18 INFO - 'LANGUAGE': 'en_US:en', 19:23:18 INFO - 'LOGNAME': 'cltbld', 19:23:18 INFO - 'MAIL': '/var/mail/cltbld', 19:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:18 INFO - 'MOZ_NO_REMOTE': '1', 19:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:18 INFO - 'NO_EM_RESTART': '1', 19:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:18 INFO - 'PWD': '/builds/slave/test', 19:23:18 INFO - 'SHELL': '/bin/bash', 19:23:18 INFO - 'SHLVL': '1', 19:23:18 INFO - 'TERM': 'linux', 19:23:18 INFO - 'TMOUT': '86400', 19:23:18 INFO - 'USER': 'cltbld', 19:23:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:18 INFO - '_': '/tools/buildbot/bin/python'} 19:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:18 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 19:23:18 INFO - Cleaning up... 19:23:18 INFO - Return code: 0 19:23:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:23:18 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')]} 19:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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')]} 19:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:18 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:18 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 19:23:18 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 19:23:18 INFO - Using env: {'DISPLAY': ':0', 19:23:18 INFO - 'HOME': '/home/cltbld', 19:23:18 INFO - 'LANG': 'en_US.UTF-8', 19:23:18 INFO - 'LANGUAGE': 'en_US:en', 19:23:18 INFO - 'LOGNAME': 'cltbld', 19:23:18 INFO - 'MAIL': '/var/mail/cltbld', 19:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:18 INFO - 'MOZ_NO_REMOTE': '1', 19:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:18 INFO - 'NO_EM_RESTART': '1', 19:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:18 INFO - 'PWD': '/builds/slave/test', 19:23:18 INFO - 'SHELL': '/bin/bash', 19:23:18 INFO - 'SHLVL': '1', 19:23:18 INFO - 'TERM': 'linux', 19:23:18 INFO - 'TMOUT': '86400', 19:23:18 INFO - 'USER': 'cltbld', 19:23:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:18 INFO - '_': '/tools/buildbot/bin/python'} 19:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:19 INFO - Downloading/unpacking psutil>=3.1.1 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:21 INFO - Installing collected packages: psutil 19:23:21 INFO - Running setup.py install for psutil 19:23:21 INFO - building 'psutil._psutil_linux' extension 19:23:21 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 19:23:21 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 19:23:21 INFO - building 'psutil._psutil_posix' extension 19:23:21 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 19:23:21 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 19:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:21 INFO - Successfully installed psutil 19:23:21 INFO - Cleaning up... 19:23:21 INFO - Return code: 0 19:23:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:23:21 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')]} 19:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:21 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')]} 19:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:21 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:21 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 19:23:21 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 19:23:21 INFO - Using env: {'DISPLAY': ':0', 19:23:21 INFO - 'HOME': '/home/cltbld', 19:23:21 INFO - 'LANG': 'en_US.UTF-8', 19:23:21 INFO - 'LANGUAGE': 'en_US:en', 19:23:21 INFO - 'LOGNAME': 'cltbld', 19:23:21 INFO - 'MAIL': '/var/mail/cltbld', 19:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:21 INFO - 'MOZ_NO_REMOTE': '1', 19:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:21 INFO - 'NO_EM_RESTART': '1', 19:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:21 INFO - 'PWD': '/builds/slave/test', 19:23:21 INFO - 'SHELL': '/bin/bash', 19:23:21 INFO - 'SHLVL': '1', 19:23:21 INFO - 'TERM': 'linux', 19:23:21 INFO - 'TMOUT': '86400', 19:23:21 INFO - 'USER': 'cltbld', 19:23:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:21 INFO - '_': '/tools/buildbot/bin/python'} 19:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:23:23 INFO - Installing collected packages: mozsystemmonitor 19:23:23 INFO - Running setup.py install for mozsystemmonitor 19:23:23 INFO - Successfully installed mozsystemmonitor 19:23:23 INFO - Cleaning up... 19:23:23 INFO - Return code: 0 19:23:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:23:23 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')]} 19:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:23 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')]} 19:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:23 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:23 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 19:23:23 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 19:23:23 INFO - Using env: {'DISPLAY': ':0', 19:23:23 INFO - 'HOME': '/home/cltbld', 19:23:23 INFO - 'LANG': 'en_US.UTF-8', 19:23:23 INFO - 'LANGUAGE': 'en_US:en', 19:23:23 INFO - 'LOGNAME': 'cltbld', 19:23:23 INFO - 'MAIL': '/var/mail/cltbld', 19:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:23 INFO - 'MOZ_NO_REMOTE': '1', 19:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:23 INFO - 'NO_EM_RESTART': '1', 19:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:23 INFO - 'PWD': '/builds/slave/test', 19:23:23 INFO - 'SHELL': '/bin/bash', 19:23:23 INFO - 'SHLVL': '1', 19:23:23 INFO - 'TERM': 'linux', 19:23:23 INFO - 'TMOUT': '86400', 19:23:23 INFO - 'USER': 'cltbld', 19:23:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:23 INFO - '_': '/tools/buildbot/bin/python'} 19:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:24 INFO - Downloading/unpacking jsonschema==2.5.1 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23: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 19:23:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:23:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:23:25 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 19:23:25 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 19:23:25 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 19:23:25 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 19:23:25 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 19:23:25 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 19:23:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:23:26 INFO - warning: no files found matching '*.txt' 19:23:26 INFO - no previously-included directories found matching 'build' 19:23:26 INFO - no previously-included directories found matching 'dist' 19:23:26 INFO - no previously-included directories found matching '.git*' 19:23:26 INFO - Installing collected packages: jsonschema, functools32 19:23:26 INFO - Running setup.py install for functools32 19:23:26 INFO - warning: no files found matching '*.txt' 19:23:26 INFO - no previously-included directories found matching 'build' 19:23:26 INFO - no previously-included directories found matching 'dist' 19:23:26 INFO - no previously-included directories found matching '.git*' 19:23:26 INFO - Successfully installed jsonschema functools32 19:23:26 INFO - Cleaning up... 19:23:26 INFO - Return code: 0 19:23:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:23:26 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')]} 19:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:26 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')]} 19:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:26 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:26 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 19:23:26 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 19:23:26 INFO - Using env: {'DISPLAY': ':0', 19:23:26 INFO - 'HOME': '/home/cltbld', 19:23:26 INFO - 'LANG': 'en_US.UTF-8', 19:23:26 INFO - 'LANGUAGE': 'en_US:en', 19:23:26 INFO - 'LOGNAME': 'cltbld', 19:23:26 INFO - 'MAIL': '/var/mail/cltbld', 19:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:26 INFO - 'MOZ_NO_REMOTE': '1', 19:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:26 INFO - 'NO_EM_RESTART': '1', 19:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:26 INFO - 'PWD': '/builds/slave/test', 19:23:26 INFO - 'SHELL': '/bin/bash', 19:23:26 INFO - 'SHLVL': '1', 19:23:26 INFO - 'TERM': 'linux', 19:23:26 INFO - 'TMOUT': '86400', 19:23:26 INFO - 'USER': 'cltbld', 19:23:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:26 INFO - '_': '/tools/buildbot/bin/python'} 19:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:26 INFO - Downloading/unpacking blobuploader==1.2.4 19:23:26 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 19:23:26 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 19:23:26 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 19:23:26 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 19:23:26 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 19:23:26 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 19:23:28 INFO - Downloading blobuploader-1.2.4.tar.gz 19:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:23:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:23:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 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 19:23:28 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 19:23:29 INFO - Downloading docopt-0.6.1.tar.gz 19:23:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:23:29 INFO - Installing collected packages: blobuploader, requests, docopt 19:23:29 INFO - Running setup.py install for blobuploader 19:23:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:23:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:23:29 INFO - Running setup.py install for requests 19:23:29 INFO - Running setup.py install for docopt 19:23:29 INFO - Successfully installed blobuploader requests docopt 19:23:29 INFO - Cleaning up... 19:23:29 INFO - Return code: 0 19:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:29 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')]} 19:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:29 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')]} 19:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:29 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:29 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 19:23:29 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 19:23:29 INFO - Using env: {'DISPLAY': ':0', 19:23:29 INFO - 'HOME': '/home/cltbld', 19:23:29 INFO - 'LANG': 'en_US.UTF-8', 19:23:29 INFO - 'LANGUAGE': 'en_US:en', 19:23:29 INFO - 'LOGNAME': 'cltbld', 19:23:29 INFO - 'MAIL': '/var/mail/cltbld', 19:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:29 INFO - 'MOZ_NO_REMOTE': '1', 19:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:29 INFO - 'NO_EM_RESTART': '1', 19:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:29 INFO - 'PWD': '/builds/slave/test', 19:23:29 INFO - 'SHELL': '/bin/bash', 19:23:29 INFO - 'SHLVL': '1', 19:23:29 INFO - 'TERM': 'linux', 19:23:29 INFO - 'TMOUT': '86400', 19:23:29 INFO - 'USER': 'cltbld', 19:23:29 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:29 INFO - '_': '/tools/buildbot/bin/python'} 19:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:30 INFO - Running setup.py (path:/tmp/pip-SOigiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:30 INFO - Running setup.py (path:/tmp/pip-1XZAju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:30 INFO - Running setup.py (path:/tmp/pip-j5Ctna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:30 INFO - Running setup.py (path:/tmp/pip-NbCDrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:30 INFO - Running setup.py (path:/tmp/pip-VpBQwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:30 INFO - Running setup.py (path:/tmp/pip-KFq7VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:30 INFO - Running setup.py (path:/tmp/pip-moGTKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:30 INFO - Running setup.py (path:/tmp/pip-wJ0cgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:30 INFO - Running setup.py (path:/tmp/pip-yzkRnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:30 INFO - Running setup.py (path:/tmp/pip-x_DWTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:30 INFO - Running setup.py (path:/tmp/pip-MSL_YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:30 INFO - Running setup.py (path:/tmp/pip-6B1irZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:30 INFO - Running setup.py (path:/tmp/pip-caH2GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:31 INFO - Running setup.py (path:/tmp/pip-3Puv7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:31 INFO - Running setup.py (path:/tmp/pip-asqMNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:31 INFO - Running setup.py (path:/tmp/pip-_r0rIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:31 INFO - Running setup.py (path:/tmp/pip-jVWVsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:23:31 INFO - Running setup.py install for manifestparser 19:23:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:23:31 INFO - Running setup.py install for mozcrash 19:23:31 INFO - Running setup.py install for mozdebug 19:23:31 INFO - Running setup.py install for mozdevice 19:23:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:23:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:31 INFO - Running setup.py install for mozfile 19:23:31 INFO - Running setup.py install for mozhttpd 19:23:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:31 INFO - Running setup.py install for mozinfo 19:23:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for mozInstall 19:23:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for mozleak 19:23:32 INFO - Running setup.py install for mozlog 19:23:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for moznetwork 19:23:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for mozprocess 19:23:32 INFO - Running setup.py install for mozprofile 19:23:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for mozrunner 19:23:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:32 INFO - Running setup.py install for mozscreenshot 19:23:32 INFO - Running setup.py install for moztest 19:23:32 INFO - Running setup.py install for mozversion 19:23:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:33 INFO - Cleaning up... 19:23:33 INFO - Return code: 0 19:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23: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')]} 19:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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')]} 19:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:33 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:33 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 19:23:33 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 19:23:33 INFO - Using env: {'DISPLAY': ':0', 19:23:33 INFO - 'HOME': '/home/cltbld', 19:23:33 INFO - 'LANG': 'en_US.UTF-8', 19:23:33 INFO - 'LANGUAGE': 'en_US:en', 19:23:33 INFO - 'LOGNAME': 'cltbld', 19:23:33 INFO - 'MAIL': '/var/mail/cltbld', 19:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:33 INFO - 'MOZ_NO_REMOTE': '1', 19:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:33 INFO - 'NO_EM_RESTART': '1', 19:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:33 INFO - 'PWD': '/builds/slave/test', 19:23:33 INFO - 'SHELL': '/bin/bash', 19:23:33 INFO - 'SHLVL': '1', 19:23:33 INFO - 'TERM': 'linux', 19:23:33 INFO - 'TMOUT': '86400', 19:23:33 INFO - 'USER': 'cltbld', 19:23:33 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:33 INFO - '_': '/tools/buildbot/bin/python'} 19:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:33 INFO - Running setup.py (path:/tmp/pip-jA4eOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:33 INFO - Running setup.py (path:/tmp/pip-7fcqM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:33 INFO - Running setup.py (path:/tmp/pip-1xVsnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:33 INFO - Running setup.py (path:/tmp/pip-1YCvS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:33 INFO - Running setup.py (path:/tmp/pip-rldPmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:33 INFO - Running setup.py (path:/tmp/pip-QWnZFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:33 INFO - Running setup.py (path:/tmp/pip-T3Urps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:33 INFO - Running setup.py (path:/tmp/pip-fgrg3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:33 INFO - Running setup.py (path:/tmp/pip-G5ugCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:33 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)) 19:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:33 INFO - Running setup.py (path:/tmp/pip-1GSwt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:34 INFO - Running setup.py (path:/tmp/pip-PeNnWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:34 INFO - Running setup.py (path:/tmp/pip-lVCW6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:34 INFO - Running setup.py (path:/tmp/pip-hut0Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:34 INFO - Running setup.py (path:/tmp/pip-BEKPVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:34 INFO - Running setup.py (path:/tmp/pip-FvrBkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:34 INFO - Running setup.py (path:/tmp/pip-hxr2Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:34 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)) 19:23:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:34 INFO - Running setup.py (path:/tmp/pip-SrexC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:34 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)) 19:23:34 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)) 19:23:34 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)) 19:23:34 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)) 19:23:34 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)) 19:23:34 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)) 19:23:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23:34 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 19:23:34 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 19:23:34 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 19:23:34 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 19:23:34 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 19:23:34 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 19:23:36 INFO - Downloading blessings-1.6.tar.gz 19:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:36 INFO - Installing collected packages: blessings 19:23:36 INFO - Running setup.py install for blessings 19:23:36 INFO - Successfully installed blessings 19:23:36 INFO - Cleaning up... 19:23:36 INFO - Return code: 0 19:23:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:36 INFO - Reading from file tmpfile_stdout 19:23:36 INFO - Current package versions: 19:23:36 INFO - argparse == 1.2.1 19:23:36 INFO - blessings == 1.6 19:23:36 INFO - blobuploader == 1.2.4 19:23:36 INFO - docopt == 0.6.1 19:23:36 INFO - functools32 == 3.2.3-2 19:23:36 INFO - jsonschema == 2.5.1 19:23:36 INFO - manifestparser == 1.1 19:23:36 INFO - mozInstall == 1.12 19:23:36 INFO - mozcrash == 0.17 19:23:36 INFO - mozdebug == 0.1 19:23:36 INFO - mozdevice == 0.48 19:23:36 INFO - mozfile == 1.2 19:23:36 INFO - mozhttpd == 0.7 19:23:36 INFO - mozinfo == 0.9 19:23:36 INFO - mozleak == 0.1 19:23:36 INFO - mozlog == 3.2 19:23:36 INFO - moznetwork == 0.27 19:23:36 INFO - mozprocess == 0.22 19:23:36 INFO - mozprofile == 0.28 19:23:36 INFO - mozrunner == 6.11 19:23:36 INFO - mozscreenshot == 0.1 19:23:36 INFO - mozsystemmonitor == 0.3 19:23:36 INFO - moztest == 0.7 19:23:36 INFO - mozversion == 1.4 19:23:36 INFO - psutil == 3.1.1 19:23:36 INFO - requests == 1.2.3 19:23:36 INFO - wsgiref == 0.1.2 19:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:36 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')]} 19:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:36 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')]} 19:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:36 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:36 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 19:23:36 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 19:23:36 INFO - Using env: {'DISPLAY': ':0', 19:23:36 INFO - 'HOME': '/home/cltbld', 19:23:36 INFO - 'LANG': 'en_US.UTF-8', 19:23:36 INFO - 'LANGUAGE': 'en_US:en', 19:23:36 INFO - 'LOGNAME': 'cltbld', 19:23:36 INFO - 'MAIL': '/var/mail/cltbld', 19:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:36 INFO - 'MOZ_NO_REMOTE': '1', 19:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:36 INFO - 'NO_EM_RESTART': '1', 19:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:36 INFO - 'PWD': '/builds/slave/test', 19:23:36 INFO - 'SHELL': '/bin/bash', 19:23:36 INFO - 'SHLVL': '1', 19:23:36 INFO - 'TERM': 'linux', 19:23:36 INFO - 'TMOUT': '86400', 19:23:36 INFO - 'USER': 'cltbld', 19:23:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:36 INFO - '_': '/tools/buildbot/bin/python'} 19:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 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)) 19:23:37 INFO - Cleaning up... 19:23:37 INFO - Return code: 0 19:23:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:37 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:37 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 19:23:37 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 19:23:37 INFO - Using env: {'DISPLAY': ':0', 19:23:37 INFO - 'HOME': '/home/cltbld', 19:23:37 INFO - 'LANG': 'en_US.UTF-8', 19:23:37 INFO - 'LANGUAGE': 'en_US:en', 19:23:37 INFO - 'LOGNAME': 'cltbld', 19:23:37 INFO - 'MAIL': '/var/mail/cltbld', 19:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:37 INFO - 'MOZ_NO_REMOTE': '1', 19:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:37 INFO - 'NO_EM_RESTART': '1', 19:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:37 INFO - 'PWD': '/builds/slave/test', 19:23:37 INFO - 'SHELL': '/bin/bash', 19:23:37 INFO - 'SHLVL': '1', 19:23:37 INFO - 'TERM': 'linux', 19:23:37 INFO - 'TMOUT': '86400', 19:23:37 INFO - 'USER': 'cltbld', 19:23:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:37 INFO - '_': '/tools/buildbot/bin/python'} 19:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:37 INFO - Cleaning up... 19:23:37 INFO - Return code: 0 19:23:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:37 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 0x7f495c30df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', '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 19:23:37 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 19:23:37 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 19:23:37 INFO - Using env: {'DISPLAY': ':0', 19:23:37 INFO - 'HOME': '/home/cltbld', 19:23:37 INFO - 'LANG': 'en_US.UTF-8', 19:23:37 INFO - 'LANGUAGE': 'en_US:en', 19:23:37 INFO - 'LOGNAME': 'cltbld', 19:23:37 INFO - 'MAIL': '/var/mail/cltbld', 19:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:37 INFO - 'MOZ_NO_REMOTE': '1', 19:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:37 INFO - 'NO_EM_RESTART': '1', 19:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:37 INFO - 'PWD': '/builds/slave/test', 19:23:37 INFO - 'SHELL': '/bin/bash', 19:23:37 INFO - 'SHLVL': '1', 19:23:37 INFO - 'TERM': 'linux', 19:23:37 INFO - 'TMOUT': '86400', 19:23:37 INFO - 'USER': 'cltbld', 19:23:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:37 INFO - '_': '/tools/buildbot/bin/python'} 19:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:37 INFO - Downloading/unpacking flake8 19:23:37 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 19:23:37 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 19:23:37 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 19:23:37 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 19:23:37 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 19:23:37 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 19:23:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:23:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:23:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:39 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 19:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:40 INFO - no previously-included directories found matching 'docs/_build' 19:23:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:23:40 INFO - Running setup.py install for pep8 19:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:40 INFO - no previously-included directories found matching 'docs/_build' 19:23:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:23:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:23:40 INFO - Cleaning up... 19:23:40 INFO - Return code: 0 19:23:40 INFO - Running post-action listener: _resource_record_post_action 19:23:40 INFO - Running post-action listener: _start_resource_monitoring 19:23:40 INFO - Starting resource monitoring. 19:23:40 INFO - ##### 19:23:40 INFO - ##### Finished create-virtualenv step (success) 19:23:40 INFO - ##### 19:23:40 INFO - ##### 19:23:40 INFO - ##### Running install step. 19:23:40 INFO - ##### 19:23:40 INFO - Running pre-action listener: _resource_record_pre_action 19:23:40 INFO - Running main action method: install 19:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:40 INFO - Reading from file tmpfile_stdout 19:23:40 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:40 INFO - Reading from file tmpfile_stdout 19:23:40 INFO - Output received: 19:23:40 INFO - Usage: mozinstall [options] installer 19:23:40 INFO - Options: 19:23:40 INFO - -h, --help show this help message and exit 19:23:40 INFO - -d DEST, --destination=DEST 19:23:40 INFO - Directory to install application into. [default: 19:23:40 INFO - "/builds/slave/test"] 19:23:40 INFO - --app=APP Application being installed. [default: firefox] 19:23:40 INFO - mkdir: /builds/slave/test/build/application 19:23:40 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'] 19:23:40 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 19:23:57 INFO - Reading from file tmpfile_stdout 19:23:57 INFO - Output received: 19:23:57 INFO - /builds/slave/test/build/application/firefox/firefox 19:23:57 INFO - Running post-action listener: _resource_record_post_action 19:23:57 INFO - ##### 19:23:57 INFO - ##### Finished install step (success) 19:23:57 INFO - ##### 19:23:57 INFO - ##### 19:23:57 INFO - ##### Running run-tests step. 19:23:57 INFO - ##### 19:23:57 INFO - Running pre-action listener: _resource_record_pre_action 19:23:57 INFO - Running main action method: run_tests 19:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:57 INFO - Python 2.7.3 19:23:57 INFO - Return code: 0 19:23:57 INFO - grabbing minidump binary from tooltool 19:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:57 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 0x22be990>, '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 0x222a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:57 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 19:23:57 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 19:23:57 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 19:23:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:57 INFO - Return code: 0 19:23:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:23:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:23:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:23:58 INFO - Return code: 0 19:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 19:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 19:23:58 INFO - Using env: {'DISPLAY': ':0', 19:23:58 INFO - 'HOME': '/home/cltbld', 19:23:58 INFO - 'LANG': 'en_US.UTF-8', 19:23:58 INFO - 'LANGUAGE': 'en_US:en', 19:23:58 INFO - 'LOGNAME': 'cltbld', 19:23:58 INFO - 'MAIL': '/var/mail/cltbld', 19:23:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:58 INFO - 'MOZ_NO_REMOTE': '1', 19:23:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:58 INFO - 'NO_EM_RESTART': '1', 19:23:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:58 INFO - 'PWD': '/builds/slave/test', 19:23:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:58 INFO - 'SHELL': '/bin/bash', 19:23:58 INFO - 'SHLVL': '1', 19:23:58 INFO - 'TERM': 'linux', 19:23:58 INFO - 'TMOUT': '86400', 19:23:58 INFO - 'USER': 'cltbld', 19:23:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483', 19:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:58 INFO - '_': '/tools/buildbot/bin/python'} 19:23:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 19:23:59 INFO - mozversion application_buildid: 20160624163014 19:23:59 INFO - mozversion application_changeset: 0e073f5ca38a002d43e92016ee40d686da4a0534 19:23:59 INFO - mozversion application_display_name: Nightly 19:23:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:59 INFO - mozversion application_name: Firefox 19:23:59 INFO - mozversion application_remotingname: firefox 19:23:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:23:59 INFO - mozversion application_vendor: Mozilla 19:23:59 INFO - mozversion application_version: 50.0a1 19:23:59 INFO - mozversion platform_buildid: 20160624163014 19:23:59 INFO - mozversion platform_changeset: 0e073f5ca38a002d43e92016ee40d686da4a0534 19:23:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:23:59 INFO - mozversion platform_version: 50.0a1 19:23:59 INFO - using testdate: 1466821439 19:23:59 INFO - actual date: 1466821439 19:23:59 INFO - starting webserver on 'localhost:40241' 19:23:59 INFO - SUITE-START | Running 2 tests 19:23:59 INFO - TEST-START | dromaeo_css 19:23:59 INFO - operating with platform_type : linux_ 19:23:59 INFO - Initialising browser for dromaeo_css test... 19:23:59 INFO - TEST-INFO | started process 20424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpirx2IA/profile http://localhost:40241/getInfo.html) 19:24:03 INFO - PROCESS | 20424 | __metrics Screen width/height:1600/1200 19:24:03 INFO - PROCESS | 20424 | colorDepth:24 19:24:03 INFO - PROCESS | 20424 | Browser inner width/height: 1024/697 19:24:03 INFO - PROCESS | 20424 | __metrics 19:24:04 ERROR - PROCESS | 20424 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:24:05 INFO - TEST-INFO | 20424: exit 0 19:24:05 INFO - Browser initialized. 19:24:05 INFO - Running cycle 1/1 for dromaeo_css test... 19:24:05 INFO - TEST-INFO | started process 20544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpirx2IA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:17 INFO - PROCESS | 20544 | RSS: Main: 184811520 19:24:17 INFO - PROCESS | 20544 | 19:25:06 INFO - PROCESS | 20544 | 1466821506913 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] 19:27:15 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40241/tests/dromaeo/cssquery-ext.html) 19:27:16 INFO - PROCESS | 20544 | RSS: Main: 188047360 19:27:16 INFO - PROCESS | 20544 | 19:30:18 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-ext.html (next: http://localhost:40241/tests/dromaeo/cssquery-jquery.html) 19:30:18 INFO - PROCESS | 20544 | RSS: Main: 187449344 19:30:18 INFO - PROCESS | 20544 | 19:33:20 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40241/tests/dromaeo/cssquery-mootools.html) 19:33:21 INFO - PROCESS | 20544 | RSS: Main: 189825024 19:33:21 INFO - PROCESS | 20544 | 19:36:23 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40241/tests/dromaeo/cssquery-prototype.html) 19:36:23 INFO - PROCESS | 20544 | RSS: Main: 186724352 19:36:23 INFO - PROCESS | 20544 | 19:39:26 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40241/tests/dromaeo/cssquery-yui.html) 19:39:26 INFO - PROCESS | 20544 | RSS: Main: 188825600 19:39:26 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:40241/tests/dromaeo/cssquery-yui.html (next: http://localhost:40241/tests/dromaeo/cssquery-dojo.html) 19:42:29 INFO - PROCESS | 20544 | RSS: Main: 189710336 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | __start_tp_report 19:42:29 INFO - PROCESS | 20544 | _x_x_mozilla_page_load 19:42:29 INFO - PROCESS | 20544 | _x_x_mozilla_page_load_details 19:42:29 INFO - PROCESS | 20544 | |i|pagename|runs| 19:42:29 INFO - PROCESS | 20544 | |0;dojo.html;3106.0526539405478;3145.952810707838;3168.7148156665894;3174.7618928580364;3180.6024246969137;5420;5435.1847222916585;5482.122860342346;5557.749901254443;5563.471470210334;5394.811181608645;5463.5902307327015;5498.752556134974;5517.062099443095;5551.250581171541;4931.65478416511;4956.107900577895;5048.697078175322;5072.315237442935;5125.026245013454;707.3989583781687;4887.2913427552985;4957.454679985217;4993.350864387625;5008.2738002989545;4952;5000.924986125211;5013.623978201649;5015.423226328982;5035;5025.472325405816;5027;5030.320906677625;5038.470960549126;5052.823151189691;4923.729194894279;4939.431965323998;4954.801807927679;4969.304297398367;5002.549770520671;5393.83818485446;5515.696636684981;5522.806701765419;5529.917051244234;5551.139573366135;5690.943090569124;5841.591088623798;5873.060310350324;5897;5902.144189092601;5913.05391137416;5963.880722385571;5986.161937328778;5994.520438364921;6040.365761595013;5540.445955404427;5541.196526503634;5541.972290138524;5548.306461692288;5550.583706222009;5922.02286622711;6004.129401236796;6045.486133678599;6052.727627256784;6065;5798.59409841307;5805.361410244954;5812.709364531756;5819.941800582024;5820.854478637983;5969.582129250997;5974.1934838796205;5993.340732519419;5997.610155339889;5999.910001349983;5852.765889364463;5885.705714714247;5933.970330148408;5940.435658612425;5962.433568810956;5916.437938395846;5950.107483877453;5951.137085122633;5956.55325850563;5958.910616340759;4390.692651514363;4504.81980720774;4517.073999830027;4521.276595744665;4572.702774319725;3909.3940439231396;3926.960730392717;3955.288048151303;3966;3970.68234541236;5479.178123281539;5526.281583394133;5530.336359636869;5568.805091821767;5616.747246373923;5729.197912292282;5921.763129474859;5930.318013428425;5933.6736479493175;5947.672877991666;5608.467195616491;5656.236408084856;5674.77300907959;5701.686407247558;5703.9429605704245;5145.408278047998;5147.665401748949;5154.381474223117;5156.948430515722;5234.398044224963;5937.495312898452;6130.754769809158;6165.691715414211;6195.411435913581;6223.96888015557;5986.102084687332;6060.757569697163;6066.3023752269055;6070.332263451105;6115.052166914135;6100.511959043177;6149.600275982047;6166.290876549254;6213.596116252429;6229.2524897010835;5560.499555040065;5771.076627739541;5790.768369265183;5855.151003104441;5864.589478736448;5949;5959.73181206838;5972.8805423892145;5982.042873140276;5984.281886173513;5748.080307150836;5765.798197063083;5787.884242315215;5801.883962320814;5814.476697097281;5558.666480011212;5717.656940583412;5749.367569567428;5770.798022069207;5782.479576838105;5641.238432811518;5704.971475142764;5709.857253568694;5717.085266357363;5721.141828725725;5822.2140011099655;5822.854428639318;5826.76692932278;5840.8247752567495;5844.064949608042;5503.972480137573;5565.248691426606;5671.688057156731;5671.716414179357;5736.942630573641 19:42:29 INFO - PROCESS | 20544 | |1;ext.html;574.273543966882;608.7412849538946;616.5037145098199;635.1362147479427;649.1593386564399;38504.42243366348;40083.79958100209;43499.565004349985;43633.7818310908;43659.34510982338;43727.78136109315;44355.55644443555;44442.77778611102;44680;44759.552404475944;8934.597943092576;8999.685011024616;9116.544172791368;9125.49809760463;9137.451752894847;8968.372213945026;9048.864267036;9077.63689452421;9083.22792562633;9089.136532029446;9032.593533291018;9071.319651026166;9093.54532273387;9102.77243068922;9105;9015.27877769777;9030.413023153507;9058.637654493845;9071.047540008303;9111.954440227822;8880.289576833902;8938.731838044869;8959.1936725695;8984;9037.593308301142;41988.16023679509;42044;42485.36271955892;42504.57495425037;42509.57490425118;3380.7633465657414;3489.616142224353;3511.877084302063;3678.668919797231;3736.7010639148803;30732;31215.37569248625;31663.366732665447;32105.678943210503;32485.187870303194;4342.392065110887;4403.229434848889;4428.844990425352;4491.6855820092605;4524.6380289576755;317111;318100.9999999977;320439;320668;322677;33540.66459335375;59652.70173649104;60000;60168.983101690355;60334;32211.35577288441;33823.448537903656;33848.1537961548;33898.83050584731;33922.49116263258;15327.923360383127;15347.462838800588;15432.922835385976;15434.228288585526;15498.147601882005;12611.243325400505;12724.681882952815;12767.361631918367;12778.169418987736;12828.35858207086;8199.139090395423;8267.503949763033;8291.751247462586;8331.291840193651;8390.286825619769;3230.5638738769967;3242.4649932761304;3247.8700851965655;3267.9183020424202;3272.9690147603906;1022.831232846572;1066.8293073108266;1106;1146.908247340211;1147.3574798113084;31927.680723192934;32311.676883231336;32388.35223295521;32856.67143328584;33012.339753205284;1090.1769164280918;1100.1913593508764;1111.0556027376826;1151.366748288438;1193.4569770754285;16665.500034998968;17066.658666826595;17210.913945430442;17298.021455065405;17388.130593470276;148072.25963870113;149309.25345373203;150428.24785876;594663;601024;56688.43311566914;56970.145447818315;57113;57217;57398;1289.7807372746656;1318.5121505043003;1335.6460537957448;1350.2978451205317;1355.2681551962028;30861.228469288446;31721.20696982594;31751.682483175795;31879.521807173376;32064.67935320617;50168.74915625399;50923;51232.74383628058;51275;51342;466102;475306;478631;479484;480133;28195.43609127765;28213.548694341276;28377.29056773597;28590;28594.857025714737;48187;48257.5174248253;48829.755851220514;49680;49889.25166122583;40353.79823100983;41252.38121428241;41317.793411032755;41622.583774161874;42420;40609.39085913655;41215.381769274085;41449.37825932553;41774.58225417707;41842.79078604587;37298.627013729514;40512.18975620412;41392.1721565573;41654;44509.33236001527;33182.502262466565;35946;36356;36360.63639363572;36721.08197295089;28169.859150704116;28170.2957426066;28205.43589128165;28422.57366139551;28495.145145645663 19:42:29 INFO - PROCESS | 20544 | |2;jquery.html;383.6470447188588;390.2117722201154;393.08215317234254;395.1346551053195;411.810567139116;13813.654658633539;18051.458456246302;18833.340833070844;19748.111334989924;19858.304959326426;17213.22540485678;17309.653806923852;17524.21141048653;18685.252589896387;19034;5172;5620.747066382012;5787.813498232852;5844.678542680151;5908.1433192187105;5826.417358264161;5854.063349864023;5884.382139875294;5887.528997680175;5896.941030589704;5789.478946894778;5816.680082595455;5824.883502329951;6187.28846182688;6199.659018753967;5782.595218334718;5899.262592175978;6238.00191969285;6278.654673992928;6330.0504924261495;5685.488306052475;5689.089745640719;5714.028615135437;5722.19889215506;5742.454466825645;12612.558560450432;12712.6821829455;12973.41619627119;13131.540396086091;13200.141990770666;2336.9298921032396;2379.7144342678816;2453.7178224504232;2457.619069044301;2849.6437945256844;9200.493972831491;9687.66093186735;9864.062914023156;9913.058259465339;9929.80140397188;1814.319630138698;1860.7022876339856;1877.2209533043906;1941.7378653881685;1981.0886991983562;79606;79850.6007469959;81210;83430.99999999939;85349;10296.07335339823;10426.113780328757;10546.156307495383;10587.84118238227;10737.248392612442;14130.293485325692;14173.362198701083;14195.432182712782;14259.78610320846;14349.928250358682;7578.924210757822;7737.187595302412;7843.098043725045;7952.801179970547;8031.678732850621;7610.885836712454;7691.30778229962;7762.495437796525;7903.170167132484;7993.480423772437;4353.259945809156;4404.383386325917;4410.448693913261;4411.426514553087;4493.236149854532;1930.276146445083;1931.121339790392;1945.4066509714673;1971.0769138738;1993.8305244054418;843.9746807595782;953.2659851914126;1063.962761303366;1077.6012875236213;1089.8692156941058;18145;18279.90860045691;18840.905795471208;18851;18982.525436864187;932.5896605493562;970.3062310448064;983.8376667849725;995.5072239241478;1029.0429900192892;8320.417570769989;10320.741981450374;10628.681139565826;10638.41488718128;10660.41367724767;437674;448221;456776;462844;464076;73094;82838.58580707178;91643.99999999866;94160;94713.79074150987;929.4376901974343;931.5994122527378;966.0677446264389;1001.6944831826363;1003.0420947994647;16663.3334666612;16699.74950375721;17009.319627215267;17338;17822.198001089724;40609;40730.1853962925;41152.58847411488;41576.376354354106;42701.57298426976;52851;53324.46675533195;55583.16625250706;61795.382046178966;62704.68647656732;7377.741779037922;7666.578338191453;7688.269614386624;8175.345972322319;8562.315014798925;9241.353105282566;12344.259344439362;13311.66720831987;13486.325683715579;13558.86441135576;11807.645770626896;11911.523539058688;11977.101717371406;12110.031197504355;12215.75568488643;11809.704757381134;11878.762424751283;12034.819477707666;12053.578124765942;12256.325902075472;11558.826617600575;12050.276983381025;12071.879281207075;12163.878361216275;12372.81440778371;8333.541655209021;8768.95615521944;8820.514871682119;8932.151445612657;8999.055099214751;11407.885921141014;11825.940870295593;12023.4589443477;12250.693732656755;12252.754944900873 19:42:29 INFO - PROCESS | 20544 | |3;mootools.html;1431.5347512058581;1439.877610403116;1551.418218168187;1696.8642508599314;1721.4233231867324;7609.239076092388;8219.301359384452;8368.330533557317;8763.430377025488;8781.604827782758;8465.746027619181;8473.491590504575;8547.487150770958;8561.186687264715;8566.528840913763;2189.2228258968075;2236.7539570647214;2241.4060274027397;2248.2243625949104;2248.898799554024;2245.3264020793777;2247.932562023134;2295.2999335202758;2295.4146692593367;2309.3418375762913;2219.87790671513;2248.291788086756;2253.2001139595454;2265.3090807303765;2279.7720227977234;2187.6171669957776;2207.801297883182;2211.6350802117713;2216.966745498827;2221.6223242048727;2132.7867213278705;2141.796529329711;2149.215536329244;2153.569286142762;2154.2352464874903;8477.915220847774;8592.828143437158;8647.654093836301;8697.304215662794;8704.390692651454;5002.6748261363255;5151.768170432302;5155.278261043457;5158.767855446514;5162.92255616166;3239.724623407013;3318.900432987014;3459.41189997701;3480.251745874624;3500.3524347995703;1066.9626563070333;1080.1466841195447;1090.5419723716059;1092.3664274720643;1094.4473041114265;12422.503099875994;12502.812457813048;12545.74908501834;12557.748845023048;12587;4481.977590112028;4501.707389019703;4597.057603191338;4599.126166028444;4610.423697037871;10319.896801032044;10359.171266298677;10418.791624167474;10453.634122805817;10519.474026298807;4985.252212168131;5005.174146265898;5027.874303142451;5037.546620804145;5046.924296135561;4135.875923722233;4495.707778994355;4588.059447813191;4594.563516465931;4733;3914.9021274467796;3942.3692209246956;4032.737872038308;4042.959570404317;4097.631213190767;1272.2239433945285;1283.5892514395491;1287.3563218390805;1288.4266501406785;1296.9740605187844;964.363520076746;966.9468179250068;973.7127547373542;993.4337427666161;1000.4147573669485;5829.59192856496;5885.234919460443;5899.380565040695;5920.911186332209;6021.126936594169;924.6486335192584;941.4633658814547;944.197432182653;966.4829316315737;1006.4615430744517;4050.6556942659613;4112.629863312316;4121.381792731055;4143.482064741907;4153.397757325171;10515.211359148094;10790.406527641055;10832.891671083345;10860.185486088574;10867.945660271647;10775.191860610328;10956.28784129029;10961.342319460859;10962.232643715022;10976.341419514694;7584.810379740551;7738.883916741253;7824.826276058523;7830.41271904598;7910.604469776488;5783.901058798815;5972.402759723993;5978.885126699388;6057.727402266997;6106.1451396803595;10008.699739007841;10071.848922266025;10213.84679229827;10247.641332553325;10259.640912568024;10009.299349045788;10090;10109.545070471699;10272.948635256776;10409;6929.757458488929;7530.397568194422;7602.353799927068;7643.464957453148;7800.141984381827;8326.542040187847;8361.205685459872;8368.623411946599;8403.495790252604;8433.072362040293;7266.418686504961;7497.662605182889;7554.169041405331;7562.810929726801;7574.204708505748;7378.815529611588;7382.2617738225745;7384.778456646309;7544.962275188589;7553.131389890233;7006.6846991886505;7109.146902371542;7120.359167674934;7122.430205583437;7125.251848555827;5050;5077.949220507748;5108.872278193075;5209.869753256199;5280.20796880471;5114.053900028507;5220.765065571983;5248.8425347239645;5333.839984800462;5368.302120724281 19:42:29 INFO - PROCESS | 20544 | |4;prototype.html;333.8147328232831;335.106940004887;338.81873197839155;343.17980027733734;344.1756992004152;5587.469190426908;5623.156526521024;5652.823662889787;5660.745266463009;5685.744141513632;5480.164145011416;5512.4211957744465;5535.418781027995;5539.806106786264;5568.303962004749;4165.375193720935;4235.639970602487;4317.352397140438;4347.347897815322;4367.847125350613;4290.206311832306;4294;4330.935035974463;4335.6531477481885;4337.913241735163;4254.383114448403;4277.272863613178;4295.506016808075;4321.762303073329;4332.548596220254;4200.789960501963;4269.256270033946;4328.199283132599;4333.479982402132;4339.2623254046575;3735.6637902588895;3777.452269420946;3777.924441511182;3794.7912864792424;3805.7906815125157;5440.374356948962;5463.945360546383;5499.120140777456;5554.50009499147;5558.6942718150485;4950.257461380822;5004.124278251292;5027.296178535008;5042.647014708972;5051.924221136685;5905.29136503618;5921.73352199152;5946.524278057745;5950.196723442366;5997.110910063316;4160.729552579072;4174.351131303119;4190.476190476191;4231.365295205713;4264.6801489888385;5936.782959493294;5980;6076.301225359096;6082.391760823926;6107.633541987495;4311.76285304305;4319.935200971988;4320.827166913351;4334.656256560476;4340.457442819647;4326.221280169537;4356.346548017759;4359.542248063907;4366.986779122395;4386.342048692658;4665.650076244296;4936.111499930047;4958.033183529177;4968.875778105504;4969.726665033458;5897.705114744245;5905.793297234576;5941.346451890288;5954.821355359346;5974.701264936736;1479.8668119869265;1486.5951675666392;1506.7965824613757;1512.4933147395525;1518.8708959738326;965.290511474066;996.4419924842111;1019.3272440189587;1019.8521214423866;1032.3031953431405;5610.579206559524;5621.241132447068;5647.576431767634;5683.943160568424;5749.798757043483;6058.545609079249;6060.878737433589;6066.3023752269055;6075.392460753889;6078.787242446581;5454.290942177491;5687.175359572839;5750.971245143831;5768.423157684198;5794.159846822187;3196.2488815128427;3216.549683044376;3245.9675403245665;3287.605487341534;3305.1406634275263;6163.784267550704;6290.685465726695;6321.494280457552;6344.143540622049;6353.047042943595;6248.781292654735;6263.4362907338555;6280.434760871543;6301.306856245809;6323.241211054611;6056.545759068;6300.653464059521;6355.777547785805;6385.393387628168;6385.48916086712;6087.66517841523;6118.265808103056;6131.294901086432;6164.845878853064;6171.290301615192;5992.221011268682;6089.634621922699;6115.449609535163;6127.601705889103;6154;5947.591225553658;6237.96881015592;6260.530460215411;6290.716917738804;6294.527910406646;4250.638695710899;4251.128518653731;4264;4264.914701705887;4277.8288868444915;5793.248207101593;6107.389261074035;6117.694115294128;6192.256929168529;6221.3156552780065;5919.046714584263;5940.257467816523;5944.49471794885;5953.940460595339;5970.134330522137;5924.555658325557;5961.552883533839;6009.939900600938;6031.858690165103;6032.728527216374;5652.915206271827;5800.970995144998;5836.08195902049;5847.649141051551;5859.974504461788;5933.703314834327;5979.372165922689;6002.219711437485;6036.9094463582205;6069.2716873975405;5673.631213971079;5893.410658934073;5906.881862362815;5912.841812738406;5932.940670593412 19:42:29 INFO - PROCESS | 20544 | |5;yui.html;752.1388010727717;769.1116760142035;772.5673622771246;795.6658203554507;819.3690858039308;15161.469348572802;16372.345106195738;16394.999999999985;16410.17949102546;16464.094474803882;13917;13990.720185596281;14077;14091.224982625952;14126.929365353184;658.3613894522306;774.7791879314397;785.7171418289425;791.5013541468895;793.3335997761878;788.7949133225345;790.2571582712261;795.6340083561569;795.9363250939911;796.5021861336664;846.4624963148415;850.1753299299701;850.8681154421043;851.2466467176563;851.9914800851974;829.9668013279462;841.1336323586715;845.5687599324389;845.7462761171655;846.0270688708005;601.8675891303906;603.7645318325856;604.2296072507544;605.0742364182807;609.9237595300588;12941.611751647466;12947.352632368344;13042.739145217138;13133.474661013548;13175.407106680223;14595.854041459555;14794.186319752409;14944.551663450115;14974.925125374413;15011.474598389004;12450.937745311216;12499.625011249676;12531.373431328488;12663.366831658472;13053.804192937114;3835.1946091320856;3868.7485313454536;3970.0471886746973;4042.939355909664;4064.166845796605;75759.62120189363;76859.61570192114;77421.61289193574;77661.22338776596;79473;11124.944375278072;11165.330080195052;11255.831162532568;11301;11478.368689721978;20101.698474522895;20335.4916127098;20343;20585;20585.279515216895;8426.07313195548;8744.912550874536;8801.47191168532;8813.25087367568;8975.506347150838;4680.672352935262;4770.118953844297;4791.904161916742;4876.414830220326;4880.755962201875;3459.41189997701;3505.386557352453;3531.258435728526;3537.4693795930816;3539.982300088483;588.6938791828311;594.6105301027834;603.1796756411277;604.8064619321863;611.6055144431906;605.6971514242879;655.9147310849654;715.2132654080469;749.6663984526942;752.3153929923852;9315.301352398597;9368.812623747486;9409.858852117224;9936.701898943043;10216.335938163995;608.975640974365;699.0562740300655;717.2074857282731;720.8414148887236;728.9781306560811;4570.428696412949;4861.6353773467135;4926.679765815282;4935.901281974412;4951;111781;112611;112916;113164.43417782859;114846.62454505164;98930.5053474728;99752;100092;100588;100754.4962275184;85240.57379713062;86469.56765216133;88371.55814221017;88386.55806720925;88806.9999999987;8893;8900.465972041698;8918.509481978554;9093.909060909305;9255.120763527455;51829;52722.736386317825;53240.73379633077;53717.73141134269;55348.16977745257;45632.54367456416;56604.433955659915;72756;73227.63386183036;73906.63046684947;11217;12001.1599188056;12021.639350819489;12070.698232544257;12229.93885030569;13328.800067999182;13351.732965340445;13480.5281815136;13523.661908452368;13681.247531385869;12163.817542737042;12561;12661.556845510362;12863.163894346837;12912.677183070498;11261.774764504828;11432.771344572895;11456.94271528637;11542.711432214262;11941.104417168921;11802.232854864405;11814.173007889365;12226.877731222574;12465.626031219077;12756.68108297263;9632.229421646392;9872.358980457571;9893.35693179941;10097.747556310856;10210.387376757419;9891.851622225817;10260.794784104426;10307.690769276935;10338.25063328869;10394.740131496774 19:42:29 INFO - PROCESS | 20544 | __end_tp_report 19:42:29 INFO - PROCESS | 20544 | __start_cc_report 19:42:29 INFO - PROCESS | 20544 | _x_x_mozilla_cycle_collect,359 19:42:29 INFO - PROCESS | 20544 | __end_cc_report 19:42:29 INFO - PROCESS | 20544 | __startTimestamp1466822549970__endTimestamp 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | ------- Summary: start ------- 19:42:29 INFO - PROCESS | 20544 | Number of tests: 6 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | [#0] dojo.html Cycles:165 Average:5463.39 Median:5704.97 stddev:743.42 (13.0%) stddev-sans-first:722.34 19:42:29 INFO - PROCESS | 20544 | Values: 3106.1 3146.0 3168.7 3174.8 3180.6 5420.0 5435.2 5482.1 5557.7 5563.5 5394.8 5463.6 5498.8 5517.1 5551.3 4931.7 4956.1 5048.7 5072.3 5125.0 707.4 4887.3 4957.5 4993.4 5008.3 4952.0 5000.9 5013.6 5015.4 5035.0 5025.5 5027.0 5030.3 5038.5 5052.8 4923.7 4939.4 4954.8 4969.3 5002.5 5393.8 5515.7 5522.8 5529.9 5551.1 5690.9 5841.6 5873.1 5897.0 5902.1 5913.1 5963.9 5986.2 5994.5 6040.4 5540.4 5541.2 5542.0 5548.3 5550.6 5922.0 6004.1 6045.5 6052.7 6065.0 5798.6 5805.4 5812.7 5819.9 5820.9 5969.6 5974.2 5993.3 5997.6 5999.9 5852.8 5885.7 5934.0 5940.4 5962.4 5916.4 5950.1 5951.1 5956.6 5958.9 4390.7 4504.8 4517.1 4521.3 4572.7 3909.4 3927.0 3955.3 3966.0 3970.7 5479.2 5526.3 5530.3 5568.8 5616.7 5729.2 5921.8 5930.3 5933.7 5947.7 5608.5 5656.2 5674.8 5701.7 5703.9 5145.4 5147.7 5154.4 5156.9 5234.4 5937.5 6130.8 6165.7 6195.4 6224.0 5986.1 6060.8 6066.3 6070.3 6115.1 6100.5 6149.6 6166.3 6213.6 6229.3 5560.5 5771.1 5790.8 5855.2 5864.6 5949.0 5959.7 5972.9 5982.0 5984.3 5748.1 5765.8 5787.9 5801.9 5814.5 5558.7 5717.7 5749.4 5770.8 5782.5 5641.2 5705.0 5709.9 5717.1 5721.1 5822.2 5822.9 5826.8 5840.8 5844.1 5504.0 5565.2 5671.7 5671.7 5736.9 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | [#1] ext.html Cycles:180 Average:53460.30 Median:41233.88 stddev:107349.43 (260.3%) stddev-sans-first:107577.13 19:42:29 INFO - PROCESS | 20544 | Values: 574.3 608.7 616.5 635.1 649.2 38504.4 40083.8 43499.6 43633.8 43659.3 43727.8 44355.6 44442.8 44680.0 44759.6 8934.6 8999.7 9116.5 9125.5 9137.5 8968.4 9048.9 9077.6 9083.2 9089.1 9032.6 9071.3 9093.5 9102.8 9105.0 9015.3 9030.4 9058.6 9071.0 9112.0 8880.3 8938.7 8959.2 8984.0 9037.6 41988.2 42044.0 42485.4 42504.6 42509.6 3380.8 3489.6 3511.9 3678.7 3736.7 30732.0 31215.4 31663.4 32105.7 32485.2 4342.4 4403.2 4428.8 4491.7 4524.6 317111.0 318101.0 320439.0 320668.0 322677.0 33540.7 59652.7 60000.0 60169.0 60334.0 32211.4 33823.4 33848.2 33898.8 33922.5 15327.9 15347.5 15432.9 15434.2 15498.1 12611.2 12724.7 12767.4 12778.2 12828.4 8199.1 8267.5 8291.8 8331.3 8390.3 3230.6 3242.5 3247.9 3267.9 3273.0 1022.8 1066.8 1106.0 1146.9 1147.4 31927.7 32311.7 32388.4 32856.7 33012.3 1090.2 1100.2 1111.1 1151.4 1193.5 16665.5 17066.7 17210.9 17298.0 17388.1 148072.3 149309.3 150428.2 594663.0 601024.0 56688.4 56970.1 57113.0 57217.0 57398.0 1289.8 1318.5 1335.6 1350.3 1355.3 30861.2 31721.2 31751.7 31879.5 32064.7 50168.7 50923.0 51232.7 51275.0 51342.0 466102.0 475306.0 478631.0 479484.0 480133.0 28195.4 28213.5 28377.3 28590.0 28594.9 48187.0 48257.5 48829.8 49680.0 49889.3 40353.8 41252.4 41317.8 41622.6 42420.0 40609.4 41215.4 41449.4 41774.6 41842.8 37298.6 40512.2 41392.2 41654.0 44509.3 33182.5 35946.0 36356.0 36360.6 36721.1 28169.9 28170.3 28205.4 28422.6 28495.1 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | [#2] jquery.html Cycles:180 Average:27418.04 Median:20782.20 stddev:75052.11 (361.1%) stddev-sans-first:75235.20 19:42:29 INFO - PROCESS | 20544 | Values: 383.6 390.2 393.1 395.1 411.8 13813.7 18051.5 18833.3 19748.1 19858.3 17213.2 17309.7 17524.2 18685.3 19034.0 5172.0 5620.7 5787.8 5844.7 5908.1 5826.4 5854.1 5884.4 5887.5 5896.9 5789.5 5816.7 5824.9 6187.3 6199.7 5782.6 5899.3 6238.0 6278.7 6330.1 5685.5 5689.1 5714.0 5722.2 5742.5 12612.6 12712.7 12973.4 13131.5 13200.1 2336.9 2379.7 2453.7 2457.6 2849.6 9200.5 9687.7 9864.1 9913.1 9929.8 1814.3 1860.7 1877.2 1941.7 1981.1 79606.0 79850.6 81210.0 83431.0 85349.0 10296.1 10426.1 10546.2 10587.8 10737.2 14130.3 14173.4 14195.4 14259.8 14349.9 7578.9 7737.2 7843.1 7952.8 8031.7 7610.9 7691.3 7762.5 7903.2 7993.5 4353.3 4404.4 4410.4 4411.4 4493.2 1930.3 1931.1 1945.4 1971.1 1993.8 844.0 953.3 1064.0 1077.6 1089.9 18145.0 18279.9 18840.9 18851.0 18982.5 932.6 970.3 983.8 995.5 1029.0 8320.4 10320.7 10628.7 10638.4 10660.4 437674.0 448221.0 456776.0 462844.0 464076.0 73094.0 82838.6 91644.0 94160.0 94713.8 929.4 931.6 966.1 1001.7 1003.0 16663.3 16699.7 17009.3 17338.0 17822.2 40609.0 40730.2 41152.6 41576.4 42701.6 52851.0 53324.5 55583.2 61795.4 62704.7 7377.7 7666.6 7688.3 8175.3 8562.3 9241.4 12344.3 13311.7 13486.3 13558.9 11807.6 11911.5 11977.1 12110.0 12215.8 11809.7 11878.8 12034.8 12053.6 12256.3 11558.8 12050.3 12071.9 12163.9 12372.8 8333.5 8769.0 8820.5 8932.2 8999.1 11407.9 11825.9 12023.5 12250.7 12252.8 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | [#3] mootools.html Cycles:180 Average:5727.52 Median:4544.88 stddev:3286.16 (72.3%) stddev-sans-first:3279.52 19:42:29 INFO - PROCESS | 20544 | Values: 1431.5 1439.9 1551.4 1696.9 1721.4 7609.2 8219.3 8368.3 8763.4 8781.6 8465.7 8473.5 8547.5 8561.2 8566.5 2189.2 2236.8 2241.4 2248.2 2248.9 2245.3 2247.9 2295.3 2295.4 2309.3 2219.9 2248.3 2253.2 2265.3 2279.8 2187.6 2207.8 2211.6 2217.0 2221.6 2132.8 2141.8 2149.2 2153.6 2154.2 8477.9 8592.8 8647.7 8697.3 8704.4 5002.7 5151.8 5155.3 5158.8 5162.9 3239.7 3318.9 3459.4 3480.3 3500.4 1067.0 1080.1 1090.5 1092.4 1094.4 12422.5 12502.8 12545.7 12557.7 12587.0 4482.0 4501.7 4597.1 4599.1 4610.4 10319.9 10359.2 10418.8 10453.6 10519.5 4985.3 5005.2 5027.9 5037.5 5046.9 4135.9 4495.7 4588.1 4594.6 4733.0 3914.9 3942.4 4032.7 4043.0 4097.6 1272.2 1283.6 1287.4 1288.4 1297.0 964.4 966.9 973.7 993.4 1000.4 5829.6 5885.2 5899.4 5920.9 6021.1 924.6 941.5 944.2 966.5 1006.5 4050.7 4112.6 4121.4 4143.5 4153.4 10515.2 10790.4 10832.9 10860.2 10867.9 10775.2 10956.3 10961.3 10962.2 10976.3 7584.8 7738.9 7824.8 7830.4 7910.6 5783.9 5972.4 5978.9 6057.7 6106.1 10008.7 10071.8 10213.8 10247.6 10259.6 10009.3 10090.0 10109.5 10272.9 10409.0 6929.8 7530.4 7602.4 7643.5 7800.1 8326.5 8361.2 8368.6 8403.5 8433.1 7266.4 7497.7 7554.2 7562.8 7574.2 7378.8 7382.3 7384.8 7545.0 7553.1 7006.7 7109.1 7120.4 7122.4 7125.3 5050.0 5077.9 5108.9 5209.9 5280.2 5114.1 5220.8 5248.8 5333.8 5368.3 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | [#4] prototype.html Cycles:180 Average:4976.36 Median:5656.83 stddev:1484.14 (26.2%) stddev-sans-first:1446.82 19:42:29 INFO - PROCESS | 20544 | Values: 333.8 335.1 338.8 343.2 344.2 5587.5 5623.2 5652.8 5660.7 5685.7 5480.2 5512.4 5535.4 5539.8 5568.3 4165.4 4235.6 4317.4 4347.3 4367.8 4290.2 4294.0 4330.9 4335.7 4337.9 4254.4 4277.3 4295.5 4321.8 4332.5 4200.8 4269.3 4328.2 4333.5 4339.3 3735.7 3777.5 3777.9 3794.8 3805.8 5440.4 5463.9 5499.1 5554.5 5558.7 4950.3 5004.1 5027.3 5042.6 5051.9 5905.3 5921.7 5946.5 5950.2 5997.1 4160.7 4174.4 4190.5 4231.4 4264.7 5936.8 5980.0 6076.3 6082.4 6107.6 4311.8 4319.9 4320.8 4334.7 4340.5 4326.2 4356.3 4359.5 4367.0 4386.3 4665.7 4936.1 4958.0 4968.9 4969.7 5897.7 5905.8 5941.3 5954.8 5974.7 1479.9 1486.6 1506.8 1512.5 1518.9 965.3 996.4 1019.3 1019.9 1032.3 5610.6 5621.2 5647.6 5683.9 5749.8 6058.5 6060.9 6066.3 6075.4 6078.8 5454.3 5687.2 5751.0 5768.4 5794.2 3196.2 3216.5 3246.0 3287.6 3305.1 6163.8 6290.7 6321.5 6344.1 6353.0 6248.8 6263.4 6280.4 6301.3 6323.2 6056.5 6300.7 6355.8 6385.4 6385.5 6087.7 6118.3 6131.3 6164.8 6171.3 5992.2 6089.6 6115.4 6127.6 6154.0 5947.6 6238.0 6260.5 6290.7 6294.5 4250.6 4251.1 4264.0 4264.9 4277.8 5793.2 6107.4 6117.7 6192.3 6221.3 5919.0 5940.3 5944.5 5953.9 5970.1 5924.6 5961.6 6009.9 6031.9 6032.7 5652.9 5801.0 5836.1 5847.6 5860.0 5933.7 5979.4 6002.2 6036.9 6069.3 5673.6 5893.4 5906.9 5912.8 5932.9 19:42:29 INFO - PROCESS | 20544 | 19:42:29 INFO - PROCESS | 20544 | [#5] yui.html Cycles:180 Average:20313.19 Median:4869.03 stddev:29693.85 (609.9%) stddev-sans-first:29740.83 19:42:29 INFO - PROCESS | 20544 | Values: 752.1 769.1 772.6 795.7 819.4 15161.5 16372.3 16395.0 16410.2 16464.1 13917.0 13990.7 14077.0 14091.2 14126.9 658.4 774.8 785.7 791.5 793.3 788.8 790.3 795.6 795.9 796.5 846.5 850.2 850.9 851.2 852.0 830.0 841.1 845.6 845.7 846.0 601.9 603.8 604.2 605.1 609.9 12941.6 12947.4 13042.7 13133.5 13175.4 14595.9 14794.2 14944.6 14974.9 15011.5 12450.9 12499.6 12531.4 12663.4 13053.8 3835.2 3868.7 3970.0 4042.9 4064.2 75759.6 76859.6 77421.6 77661.2 79473.0 11124.9 11165.3 11255.8 11301.0 11478.4 20101.7 20335.5 20343.0 20585.0 20585.3 8426.1 8744.9 8801.5 8813.3 8975.5 4680.7 4770.1 4791.9 4876.4 4880.8 3459.4 3505.4 3531.3 3537.5 3540.0 588.7 594.6 603.2 604.8 611.6 605.7 655.9 715.2 749.7 752.3 9315.3 9368.8 9409.9 9936.7 10216.3 609.0 699.1 717.2 720.8 729.0 4570.4 4861.6 4926.7 4935.9 4951.0 111781.0 112611.0 112916.0 113164.4 114846.6 98930.5 99752.0 100092.0 100588.0 100754.5 85240.6 86469.6 88371.6 88386.6 88807.0 8893.0 8900.5 8918.5 9093.9 9255.1 51829.0 52722.7 53240.7 53717.7 55348.2 45632.5 56604.4 72756.0 73227.6 73906.6 11217.0 12001.2 12021.6 12070.7 12229.9 13328.8 13351.7 13480.5 13523.7 13681.2 12163.8 12561.0 12661.6 12863.2 12912.7 11261.8 11432.8 11456.9 11542.7 11941.1 11802.2 11814.2 12226.9 12465.6 12756.7 9632.2 9872.4 9893.4 10097.7 10210.4 9891.9 10260.8 10307.7 10338.3 10394.7 19:42:29 INFO - PROCESS | 20544 | -------- Summary: end -------- 19:42:29 INFO - PROCESS | 20544 | 19:42:30 INFO - TEST-INFO | 20544: exit 0 19:42:30 INFO - TEST-OK | dromaeo_css | took 1111738ms 19:42:30 INFO - TEST-START | kraken 19:42:30 INFO - operating with platform_type : linux_ 19:42:30 INFO - Initialising browser for kraken test... 19:42:30 INFO - TEST-INFO | started process 20782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Z1Jyc/profile http://localhost:40241/getInfo.html) 19:42:35 INFO - PROCESS | 20782 | __metrics Screen width/height:1600/1200 19:42:35 INFO - PROCESS | 20782 | colorDepth:24 19:42:35 INFO - PROCESS | 20782 | Browser inner width/height: 1024/697 19:42:35 INFO - PROCESS | 20782 | __metrics 19:42:36 ERROR - PROCESS | 20782 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:42:37 INFO - TEST-INFO | 20782: exit 0 19:42:37 INFO - Browser initialized. 19:42:37 INFO - Running cycle 1/1 for kraken test... 19:42:37 INFO - TEST-INFO | started process 20904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Z1Jyc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:49 INFO - PROCESS | 20904 | RSS: Main: 185081856 19:42:49 INFO - PROCESS | 20904 | 19:42:51 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:52 INFO - PROCESS | 20904 | RSS: Main: 190357504 19:42:52 INFO - PROCESS | 20904 | 19:42:55 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-dft) 19:42:56 INFO - PROCESS | 20904 | RSS: Main: 190099456 19:42:56 INFO - PROCESS | 20904 | 19:42:58 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-fft) 19:42:59 INFO - PROCESS | 20904 | RSS: Main: 184438784 19:42:59 INFO - PROCESS | 20904 | 19:43:01 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40241/tests/kraken/driver.html?testName=audio-oscillator) 19:43:02 INFO - PROCESS | 20904 | RSS: Main: 185552896 19:43:02 INFO - PROCESS | 20904 | 19:43:04 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:43:05 INFO - PROCESS | 20904 | RSS: Main: 185757696 19:43:05 INFO - PROCESS | 20904 | 19:43:08 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40241/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:08 INFO - PROCESS | 20904 | RSS: Main: 186355712 19:43:08 INFO - PROCESS | 20904 | 19:43:12 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40241/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:12 INFO - PROCESS | 20904 | RSS: Main: 183562240 19:43:12 INFO - PROCESS | 20904 | 19:43:15 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40241/tests/kraken/driver.html?testName=json-parse-financial) 19:43:16 INFO - PROCESS | 20904 | RSS: Main: 184860672 19:43:16 INFO - PROCESS | 20904 | 19:43:17 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:18 INFO - PROCESS | 20904 | RSS: Main: 185257984 19:43:18 INFO - PROCESS | 20904 | 19:43:20 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:20 INFO - PROCESS | 20904 | RSS: Main: 185290752 19:43:20 INFO - PROCESS | 20904 | 19:43:23 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:23 INFO - PROCESS | 20904 | RSS: Main: 185552896 19:43:23 INFO - PROCESS | 20904 | 19:43:26 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:26 INFO - PROCESS | 20904 | RSS: Main: 185880576 19:43:26 INFO - PROCESS | 20904 | 19:43:29 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:30 INFO - PROCESS | 20904 | RSS: Main: 185712640 19:43:30 INFO - PROCESS | 20904 | 19:43:31 INFO - PROCESS | 20904 | Cycle 1(1): loaded http://localhost:40241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40241/tests/kraken/driver.html?testName=ai-astar) 19:43:32 INFO - PROCESS | 20904 | RSS: Main: 186126336 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | __start_tp_report 19:43:32 INFO - PROCESS | 20904 | _x_x_mozilla_page_load 19:43:32 INFO - PROCESS | 20904 | _x_x_mozilla_page_load_details 19:43:32 INFO - PROCESS | 20904 | |i|pagename|runs| 19:43:32 INFO - PROCESS | 20904 | |0;ai-astar;103;111;110;110;111;112;113;110;111;109 19:43:32 INFO - PROCESS | 20904 | |1;audio-beat-detection;164;124;162;176;128;155;156;127;194;127 19:43:32 INFO - PROCESS | 20904 | |2;audio-dft;161;162;164;162;164;167;163;163;164;162 19:43:32 INFO - PROCESS | 20904 | |3;audio-fft;76;76;75;162;79;74;77;75;170;78 19:43:32 INFO - PROCESS | 20904 | |4;audio-oscillator;86;84;144;85;85;85;141;87;85;143 19:43:32 INFO - PROCESS | 20904 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;117;118;118 19:43:32 INFO - PROCESS | 20904 | |6;imaging-darkroom;148;148;149;148;152;149;149;149;148;149 19:43:32 INFO - PROCESS | 20904 | |7;imaging-desaturate;96;97;96;97;96;95;95;96;96;96 19:43:32 INFO - PROCESS | 20904 | |8;json-parse-financial;56;56;56;56;57;58;57;58;57;56 19:43:32 INFO - PROCESS | 20904 | |9;json-stringify-tinderbox;63;64;61;62;66;61;64;61;62;61 19:43:32 INFO - PROCESS | 20904 | |10;stanford-crypto-aes;79;80;79;79;83;79;81;79;93;80 19:43:32 INFO - PROCESS | 20904 | |11;stanford-crypto-ccm;131;138;127;130;118;123;134;139;134;125 19:43:32 INFO - PROCESS | 20904 | |12;stanford-crypto-pbkdf2;168;163;165;161;161;160;161;159;159;160 19:43:32 INFO - PROCESS | 20904 | |13;stanford-crypto-sha256-iterative;61;63;63;70;62;67;65;63;62;62 19:43:32 INFO - PROCESS | 20904 | __end_tp_report 19:43:32 INFO - PROCESS | 20904 | __start_cc_report 19:43:32 INFO - PROCESS | 20904 | _x_x_mozilla_cycle_collect,912 19:43:32 INFO - PROCESS | 20904 | __end_cc_report 19:43:32 INFO - PROCESS | 20904 | __startTimestamp1466822612239__endTimestamp 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | ------- Summary: start ------- 19:43:32 INFO - PROCESS | 20904 | Number of tests: 14 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.71 (2.4%) stddev-sans-first:1.20 19:43:32 INFO - PROCESS | 20904 | Values: 103.0 111.0 110.0 110.0 111.0 112.0 113.0 110.0 111.0 109.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:159.00 stddev:24.07 (15.1%) stddev-sans-first:25.09 19:43:32 INFO - PROCESS | 20904 | Values: 164.0 124.0 162.0 176.0 128.0 155.0 156.0 127.0 194.0 127.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.69 (1.0%) stddev-sans-first:1.59 19:43:32 INFO - PROCESS | 20904 | Values: 161.0 162.0 164.0 162.0 164.0 167.0 163.0 163.0 164.0 162.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:37.92 (49.9%) stddev-sans-first:39.64 19:43:32 INFO - PROCESS | 20904 | Values: 76.0 76.0 75.0 162.0 79.0 74.0 77.0 75.0 170.0 78.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.74 (32.6%) stddev-sans-first:28.77 19:43:32 INFO - PROCESS | 20904 | Values: 86.0 84.0 144.0 85.0 85.0 85.0 141.0 87.0 85.0 143.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:43:32 INFO - PROCESS | 20904 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 19:43:32 INFO - PROCESS | 20904 | Values: 148.0 148.0 149.0 148.0 152.0 149.0 149.0 149.0 148.0 149.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:43:32 INFO - PROCESS | 20904 | Values: 96.0 97.0 96.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 19:43:32 INFO - PROCESS | 20904 | Values: 56.0 56.0 56.0 56.0 57.0 58.0 57.0 58.0 57.0 56.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:1.72 (2.7%) stddev-sans-first:1.81 19:43:32 INFO - PROCESS | 20904 | Values: 63.0 64.0 61.0 62.0 66.0 61.0 64.0 61.0 62.0 61.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:4.34 (5.4%) stddev-sans-first:4.53 19:43:32 INFO - PROCESS | 20904 | Values: 79.0 80.0 79.0 79.0 83.0 79.0 81.0 79.0 93.0 80.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:132.50 stddev:6.71 (5.1%) stddev-sans-first:7.10 19:43:32 INFO - PROCESS | 20904 | Values: 131.0 138.0 127.0 130.0 118.0 123.0 134.0 139.0 134.0 125.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:161.00 stddev:2.87 (1.8%) stddev-sans-first:1.94 19:43:32 INFO - PROCESS | 20904 | Values: 168.0 163.0 165.0 161.0 161.0 160.0 161.0 159.0 159.0 160.0 19:43:32 INFO - PROCESS | 20904 | 19:43:32 INFO - PROCESS | 20904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.00 stddev:2.78 (4.4%) stddev-sans-first:2.76 19:43:32 INFO - PROCESS | 20904 | Values: 61.0 63.0 63.0 70.0 62.0 67.0 65.0 63.0 62.0 62.0 19:43:32 INFO - PROCESS | 20904 | -------- Summary: end -------- 19:43:32 INFO - PROCESS | 20904 | 19:43:33 INFO - TEST-INFO | 20904: exit 0 19:43:33 INFO - TEST-OK | kraken | took 62475ms 19:43:33 INFO - SUITE-END | took 1174s 19:43:33 INFO - Completed test suite (00:19:34) 19:43:33 INFO - javascript benchmark 19:43:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7176.426409643754, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.0526539405478, 3145.952810707838, 3168.7148156665894, 3174.7618928580364, 3180.6024246969137, 5420.0, 5435.1847222916585, 5482.122860342346, 5557.749901254443, 5563.471470210334, 5394.811181608645, 5463.5902307327015, 5498.752556134974, 5517.062099443095, 5551.250581171541, 4931.65478416511, 4956.107900577895, 5048.697078175322, 5072.315237442935, 5125.026245013454, 707.3989583781687, 4887.2913427552985, 4957.454679985217, 4993.350864387625, 5008.2738002989545, 4952.0, 5000.924986125211, 5013.623978201649, 5015.423226328982, 5035.0, 5025.472325405816, 5027.0, 5030.320906677625, 5038.470960549126, 5052.823151189691, 4923.729194894279, 4939.431965323998, 4954.801807927679, 4969.304297398367, 5002.549770520671, 5393.83818485446, 5515.696636684981, 5522.806701765419, 5529.917051244234, 5551.139573366135, 5690.943090569124, 5841.591088623798, 5873.060310350324, 5897.0, 5902.144189092601, 5913.05391137416, 5963.880722385571, 5986.161937328778, 5994.520438364921, 6040.365761595013, 5540.445955404427, 5541.196526503634, 5541.972290138524, 5548.306461692288, 5550.583706222009, 5922.02286622711, 6004.129401236796, 6045.486133678599, 6052.727627256784, 6065.0, 5798.59409841307, 5805.361410244954, 5812.709364531756, 5819.941800582024, 5820.854478637983, 5969.582129250997, 5974.1934838796205, 5993.340732519419, 5997.610155339889, 5999.910001349983, 5852.765889364463, 5885.705714714247, 5933.970330148408, 5940.435658612425, 5962.433568810956, 5916.437938395846, 5950.107483877453, 5951.137085122633, 5956.55325850563, 5958.910616340759, 4390.692651514363, 4504.81980720774, 4517.073999830027, 4521.276595744665, 4572.702774319725, 3909.3940439231396, 3926.960730392717, 3955.288048151303, 3966.0, 3970.68234541236, 5479.178123281539, 5526.281583394133, 5530.336359636869, 5568.805091821767, 5616.747246373923, 5729.197912292282, 5921.763129474859, 5930.318013428425, 5933.6736479493175, 5947.672877991666, 5608.467195616491, 5656.236408084856, 5674.77300907959, 5701.686407247558, 5703.9429605704245, 5145.408278047998, 5147.665401748949, 5154.381474223117, 5156.948430515722, 5234.398044224963, 5937.495312898452, 6130.754769809158, 6165.691715414211, 6195.411435913581, 6223.96888015557, 5986.102084687332, 6060.757569697163, 6066.3023752269055, 6070.332263451105, 6115.052166914135, 6100.511959043177, 6149.600275982047, 6166.290876549254, 6213.596116252429, 6229.2524897010835, 5560.499555040065, 5771.076627739541, 5790.768369265183, 5855.151003104441, 5864.589478736448, 5949.0, 5959.73181206838, 5972.8805423892145, 5982.042873140276, 5984.281886173513, 5748.080307150836, 5765.798197063083, 5787.884242315215, 5801.883962320814, 5814.476697097281, 5558.666480011212, 5717.656940583412, 5749.367569567428, 5770.798022069207, 5782.479576838105, 5641.238432811518, 5704.971475142764, 5709.857253568694, 5717.085266357363, 5721.141828725725, 5822.2140011099655, 5822.854428639318, 5826.76692932278, 5840.8247752567495, 5844.064949608042, 5503.972480137573, 5565.248691426606, 5671.688057156731, 5671.716414179357, 5736.942630573641], "value": 5413.053003422797, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.273543966882, 608.7412849538946, 616.5037145098199, 635.1362147479427, 649.1593386564399, 38504.42243366348, 40083.79958100209, 43499.565004349985, 43633.7818310908, 43659.34510982338, 43727.78136109315, 44355.55644443555, 44442.77778611102, 44680.0, 44759.552404475944, 8934.597943092576, 8999.685011024616, 9116.544172791368, 9125.49809760463, 9137.451752894847, 8968.372213945026, 9048.864267036, 9077.63689452421, 9083.22792562633, 9089.136532029446, 9032.593533291018, 9071.319651026166, 9093.54532273387, 9102.77243068922, 9105.0, 9015.27877769777, 9030.413023153507, 9058.637654493845, 9071.047540008303, 9111.954440227822, 8880.289576833902, 8938.731838044869, 8959.1936725695, 8984.0, 9037.593308301142, 41988.16023679509, 42044.0, 42485.36271955892, 42504.57495425037, 42509.57490425118, 3380.7633465657414, 3489.616142224353, 3511.877084302063, 3678.668919797231, 3736.7010639148803, 30732.0, 31215.37569248625, 31663.366732665447, 32105.678943210503, 32485.187870303194, 4342.392065110887, 4403.229434848889, 4428.844990425352, 4491.6855820092605, 4524.6380289576755, 317111.0, 318100.9999999977, 320439.0, 320668.0, 322677.0, 33540.66459335375, 59652.70173649104, 60000.0, 60168.983101690355, 60334.0, 32211.35577288441, 33823.448537903656, 33848.1537961548, 33898.83050584731, 33922.49116263258, 15327.923360383127, 15347.462838800588, 15432.922835385976, 15434.228288585526, 15498.147601882005, 12611.243325400505, 12724.681882952815, 12767.361631918367, 12778.169418987736, 12828.35858207086, 8199.139090395423, 8267.503949763033, 8291.751247462586, 8331.291840193651, 8390.286825619769, 3230.5638738769967, 3242.4649932761304, 3247.8700851965655, 3267.9183020424202, 3272.9690147603906, 1022.831232846572, 1066.8293073108266, 1106.0, 1146.908247340211, 1147.3574798113084, 31927.680723192934, 32311.676883231336, 32388.35223295521, 32856.67143328584, 33012.339753205284, 1090.1769164280918, 1100.1913593508764, 1111.0556027376826, 1151.366748288438, 1193.4569770754285, 16665.500034998968, 17066.658666826595, 17210.913945430442, 17298.021455065405, 17388.130593470276, 148072.25963870113, 149309.25345373203, 150428.24785876, 594663.0, 601024.0, 56688.43311566914, 56970.145447818315, 57113.0, 57217.0, 57398.0, 1289.7807372746656, 1318.5121505043003, 1335.6460537957448, 1350.2978451205317, 1355.2681551962028, 30861.228469288446, 31721.20696982594, 31751.682483175795, 31879.521807173376, 32064.67935320617, 50168.74915625399, 50923.0, 51232.74383628058, 51275.0, 51342.0, 466102.0, 475306.0, 478631.0, 479484.0, 480133.0, 28195.43609127765, 28213.548694341276, 28377.29056773597, 28590.0, 28594.857025714737, 48187.0, 48257.5174248253, 48829.755851220514, 49680.0, 49889.25166122583, 40353.79823100983, 41252.38121428241, 41317.793411032755, 41622.583774161874, 42420.0, 40609.39085913655, 41215.381769274085, 41449.37825932553, 41774.58225417707, 41842.79078604587, 37298.627013729514, 40512.18975620412, 41392.1721565573, 41654.0, 44509.33236001527, 33182.502262466565, 35946.0, 36356.0, 36360.63639363572, 36721.08197295089, 28169.859150704116, 28170.2957426066, 28205.43589128165, 28422.57366139551, 28495.145145645663], "value": 18689.175805497747, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6470447188588, 390.2117722201154, 393.08215317234254, 395.1346551053195, 411.810567139116, 13813.654658633539, 18051.458456246302, 18833.340833070844, 19748.111334989924, 19858.304959326426, 17213.22540485678, 17309.653806923852, 17524.21141048653, 18685.252589896387, 19034.0, 5172.0, 5620.747066382012, 5787.813498232852, 5844.678542680151, 5908.1433192187105, 5826.417358264161, 5854.063349864023, 5884.382139875294, 5887.528997680175, 5896.941030589704, 5789.478946894778, 5816.680082595455, 5824.883502329951, 6187.28846182688, 6199.659018753967, 5782.595218334718, 5899.262592175978, 6238.00191969285, 6278.654673992928, 6330.0504924261495, 5685.488306052475, 5689.089745640719, 5714.028615135437, 5722.19889215506, 5742.454466825645, 12612.558560450432, 12712.6821829455, 12973.41619627119, 13131.540396086091, 13200.141990770666, 2336.9298921032396, 2379.7144342678816, 2453.7178224504232, 2457.619069044301, 2849.6437945256844, 9200.493972831491, 9687.66093186735, 9864.062914023156, 9913.058259465339, 9929.80140397188, 1814.319630138698, 1860.7022876339856, 1877.2209533043906, 1941.7378653881685, 1981.0886991983562, 79606.0, 79850.6007469959, 81210.0, 83430.99999999939, 85349.0, 10296.07335339823, 10426.113780328757, 10546.156307495383, 10587.84118238227, 10737.248392612442, 14130.293485325692, 14173.362198701083, 14195.432182712782, 14259.78610320846, 14349.928250358682, 7578.924210757822, 7737.187595302412, 7843.098043725045, 7952.801179970547, 8031.678732850621, 7610.885836712454, 7691.30778229962, 7762.495437796525, 7903.170167132484, 7993.480423772437, 4353.259945809156, 4404.383386325917, 4410.448693913261, 4411.426514553087, 4493.236149854532, 1930.276146445083, 1931.121339790392, 1945.4066509714673, 1971.0769138738, 1993.8305244054418, 843.9746807595782, 953.2659851914126, 1063.962761303366, 1077.6012875236213, 1089.8692156941058, 18145.0, 18279.90860045691, 18840.905795471208, 18851.0, 18982.525436864187, 932.5896605493562, 970.3062310448064, 983.8376667849725, 995.5072239241478, 1029.0429900192892, 8320.417570769989, 10320.741981450374, 10628.681139565826, 10638.41488718128, 10660.41367724767, 437674.0, 448221.0, 456776.0, 462844.0, 464076.0, 73094.0, 82838.58580707178, 91643.99999999866, 94160.0, 94713.79074150987, 929.4376901974343, 931.5994122527378, 966.0677446264389, 1001.6944831826363, 1003.0420947994647, 16663.3334666612, 16699.74950375721, 17009.319627215267, 17338.0, 17822.198001089724, 40609.0, 40730.1853962925, 41152.58847411488, 41576.376354354106, 42701.57298426976, 52851.0, 53324.46675533195, 55583.16625250706, 61795.382046178966, 62704.68647656732, 7377.741779037922, 7666.578338191453, 7688.269614386624, 8175.345972322319, 8562.315014798925, 9241.353105282566, 12344.259344439362, 13311.66720831987, 13486.325683715579, 13558.86441135576, 11807.645770626896, 11911.523539058688, 11977.101717371406, 12110.031197504355, 12215.75568488643, 11809.704757381134, 11878.762424751283, 12034.819477707666, 12053.578124765942, 12256.325902075472, 11558.826617600575, 12050.276983381025, 12071.879281207075, 12163.878361216275, 12372.81440778371, 8333.541655209021, 8768.95615521944, 8820.514871682119, 8932.151445612657, 8999.055099214751, 11407.885921141014, 11825.940870295593, 12023.4589443477, 12250.693732656755, 12252.754944900873], "value": 8937.240541600595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.5347512058581, 1439.877610403116, 1551.418218168187, 1696.8642508599314, 1721.4233231867324, 7609.239076092388, 8219.301359384452, 8368.330533557317, 8763.430377025488, 8781.604827782758, 8465.746027619181, 8473.491590504575, 8547.487150770958, 8561.186687264715, 8566.528840913763, 2189.2228258968075, 2236.7539570647214, 2241.4060274027397, 2248.2243625949104, 2248.898799554024, 2245.3264020793777, 2247.932562023134, 2295.2999335202758, 2295.4146692593367, 2309.3418375762913, 2219.87790671513, 2248.291788086756, 2253.2001139595454, 2265.3090807303765, 2279.7720227977234, 2187.6171669957776, 2207.801297883182, 2211.6350802117713, 2216.966745498827, 2221.6223242048727, 2132.7867213278705, 2141.796529329711, 2149.215536329244, 2153.569286142762, 2154.2352464874903, 8477.915220847774, 8592.828143437158, 8647.654093836301, 8697.304215662794, 8704.390692651454, 5002.6748261363255, 5151.768170432302, 5155.278261043457, 5158.767855446514, 5162.92255616166, 3239.724623407013, 3318.900432987014, 3459.41189997701, 3480.251745874624, 3500.3524347995703, 1066.9626563070333, 1080.1466841195447, 1090.5419723716059, 1092.3664274720643, 1094.4473041114265, 12422.503099875994, 12502.812457813048, 12545.74908501834, 12557.748845023048, 12587.0, 4481.977590112028, 4501.707389019703, 4597.057603191338, 4599.126166028444, 4610.423697037871, 10319.896801032044, 10359.171266298677, 10418.791624167474, 10453.634122805817, 10519.474026298807, 4985.252212168131, 5005.174146265898, 5027.874303142451, 5037.546620804145, 5046.924296135561, 4135.875923722233, 4495.707778994355, 4588.059447813191, 4594.563516465931, 4733.0, 3914.9021274467796, 3942.3692209246956, 4032.737872038308, 4042.959570404317, 4097.631213190767, 1272.2239433945285, 1283.5892514395491, 1287.3563218390805, 1288.4266501406785, 1296.9740605187844, 964.363520076746, 966.9468179250068, 973.7127547373542, 993.4337427666161, 1000.4147573669485, 5829.59192856496, 5885.234919460443, 5899.380565040695, 5920.911186332209, 6021.126936594169, 924.6486335192584, 941.4633658814547, 944.197432182653, 966.4829316315737, 1006.4615430744517, 4050.6556942659613, 4112.629863312316, 4121.381792731055, 4143.482064741907, 4153.397757325171, 10515.211359148094, 10790.406527641055, 10832.891671083345, 10860.185486088574, 10867.945660271647, 10775.191860610328, 10956.28784129029, 10961.342319460859, 10962.232643715022, 10976.341419514694, 7584.810379740551, 7738.883916741253, 7824.826276058523, 7830.41271904598, 7910.604469776488, 5783.901058798815, 5972.402759723993, 5978.885126699388, 6057.727402266997, 6106.1451396803595, 10008.699739007841, 10071.848922266025, 10213.84679229827, 10247.641332553325, 10259.640912568024, 10009.299349045788, 10090.0, 10109.545070471699, 10272.948635256776, 10409.0, 6929.757458488929, 7530.397568194422, 7602.353799927068, 7643.464957453148, 7800.141984381827, 8326.542040187847, 8361.205685459872, 8368.623411946599, 8403.495790252604, 8433.072362040293, 7266.418686504961, 7497.662605182889, 7554.169041405331, 7562.810929726801, 7574.204708505748, 7378.815529611588, 7382.2617738225745, 7384.778456646309, 7544.962275188589, 7553.131389890233, 7006.6846991886505, 7109.146902371542, 7120.359167674934, 7122.430205583437, 7125.251848555827, 5050.0, 5077.949220507748, 5108.872278193075, 5209.869753256199, 5280.20796880471, 5114.053900028507, 5220.765065571983, 5248.8425347239645, 5333.839984800462, 5368.302120724281], "value": 4575.705364972011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8147328232831, 335.106940004887, 338.81873197839155, 343.17980027733734, 344.1756992004152, 5587.469190426908, 5623.156526521024, 5652.823662889787, 5660.745266463009, 5685.744141513632, 5480.164145011416, 5512.4211957744465, 5535.418781027995, 5539.806106786264, 5568.303962004749, 4165.375193720935, 4235.639970602487, 4317.352397140438, 4347.347897815322, 4367.847125350613, 4290.206311832306, 4294.0, 4330.935035974463, 4335.6531477481885, 4337.913241735163, 4254.383114448403, 4277.272863613178, 4295.506016808075, 4321.762303073329, 4332.548596220254, 4200.789960501963, 4269.256270033946, 4328.199283132599, 4333.479982402132, 4339.2623254046575, 3735.6637902588895, 3777.452269420946, 3777.924441511182, 3794.7912864792424, 3805.7906815125157, 5440.374356948962, 5463.945360546383, 5499.120140777456, 5554.50009499147, 5558.6942718150485, 4950.257461380822, 5004.124278251292, 5027.296178535008, 5042.647014708972, 5051.924221136685, 5905.29136503618, 5921.73352199152, 5946.524278057745, 5950.196723442366, 5997.110910063316, 4160.729552579072, 4174.351131303119, 4190.476190476191, 4231.365295205713, 4264.6801489888385, 5936.782959493294, 5980.0, 6076.301225359096, 6082.391760823926, 6107.633541987495, 4311.76285304305, 4319.935200971988, 4320.827166913351, 4334.656256560476, 4340.457442819647, 4326.221280169537, 4356.346548017759, 4359.542248063907, 4366.986779122395, 4386.342048692658, 4665.650076244296, 4936.111499930047, 4958.033183529177, 4968.875778105504, 4969.726665033458, 5897.705114744245, 5905.793297234576, 5941.346451890288, 5954.821355359346, 5974.701264936736, 1479.8668119869265, 1486.5951675666392, 1506.7965824613757, 1512.4933147395525, 1518.8708959738326, 965.290511474066, 996.4419924842111, 1019.3272440189587, 1019.8521214423866, 1032.3031953431405, 5610.579206559524, 5621.241132447068, 5647.576431767634, 5683.943160568424, 5749.798757043483, 6058.545609079249, 6060.878737433589, 6066.3023752269055, 6075.392460753889, 6078.787242446581, 5454.290942177491, 5687.175359572839, 5750.971245143831, 5768.423157684198, 5794.159846822187, 3196.2488815128427, 3216.549683044376, 3245.9675403245665, 3287.605487341534, 3305.1406634275263, 6163.784267550704, 6290.685465726695, 6321.494280457552, 6344.143540622049, 6353.047042943595, 6248.781292654735, 6263.4362907338555, 6280.434760871543, 6301.306856245809, 6323.241211054611, 6056.545759068, 6300.653464059521, 6355.777547785805, 6385.393387628168, 6385.48916086712, 6087.66517841523, 6118.265808103056, 6131.294901086432, 6164.845878853064, 6171.290301615192, 5992.221011268682, 6089.634621922699, 6115.449609535163, 6127.601705889103, 6154.0, 5947.591225553658, 6237.96881015592, 6260.530460215411, 6290.716917738804, 6294.527910406646, 4250.638695710899, 4251.128518653731, 4264.0, 4264.914701705887, 4277.8288868444915, 5793.248207101593, 6107.389261074035, 6117.694115294128, 6192.256929168529, 6221.3156552780065, 5919.046714584263, 5940.257467816523, 5944.49471794885, 5953.940460595339, 5970.134330522137, 5924.555658325557, 5961.552883533839, 6009.939900600938, 6031.858690165103, 6032.728527216374, 5652.915206271827, 5800.970995144998, 5836.08195902049, 5847.649141051551, 5859.974504461788, 5933.703314834327, 5979.372165922689, 6002.219711437485, 6036.9094463582205, 6069.2716873975405, 5673.631213971079, 5893.410658934073, 5906.881862362815, 5912.841812738406, 5932.940670593412], "value": 4499.735698435877, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.1388010727717, 769.1116760142035, 772.5673622771246, 795.6658203554507, 819.3690858039308, 15161.469348572802, 16372.345106195738, 16394.999999999985, 16410.17949102546, 16464.094474803882, 13917.0, 13990.720185596281, 14077.0, 14091.224982625952, 14126.929365353184, 658.3613894522306, 774.7791879314397, 785.7171418289425, 791.5013541468895, 793.3335997761878, 788.7949133225345, 790.2571582712261, 795.6340083561569, 795.9363250939911, 796.5021861336664, 846.4624963148415, 850.1753299299701, 850.8681154421043, 851.2466467176563, 851.9914800851974, 829.9668013279462, 841.1336323586715, 845.5687599324389, 845.7462761171655, 846.0270688708005, 601.8675891303906, 603.7645318325856, 604.2296072507544, 605.0742364182807, 609.9237595300588, 12941.611751647466, 12947.352632368344, 13042.739145217138, 13133.474661013548, 13175.407106680223, 14595.854041459555, 14794.186319752409, 14944.551663450115, 14974.925125374413, 15011.474598389004, 12450.937745311216, 12499.625011249676, 12531.373431328488, 12663.366831658472, 13053.804192937114, 3835.1946091320856, 3868.7485313454536, 3970.0471886746973, 4042.939355909664, 4064.166845796605, 75759.62120189363, 76859.61570192114, 77421.61289193574, 77661.22338776596, 79473.0, 11124.944375278072, 11165.330080195052, 11255.831162532568, 11301.0, 11478.368689721978, 20101.698474522895, 20335.4916127098, 20343.0, 20585.0, 20585.279515216895, 8426.07313195548, 8744.912550874536, 8801.47191168532, 8813.25087367568, 8975.506347150838, 4680.672352935262, 4770.118953844297, 4791.904161916742, 4876.414830220326, 4880.755962201875, 3459.41189997701, 3505.386557352453, 3531.258435728526, 3537.4693795930816, 3539.982300088483, 588.6938791828311, 594.6105301027834, 603.1796756411277, 604.8064619321863, 611.6055144431906, 605.6971514242879, 655.9147310849654, 715.2132654080469, 749.6663984526942, 752.3153929923852, 9315.301352398597, 9368.812623747486, 9409.858852117224, 9936.701898943043, 10216.335938163995, 608.975640974365, 699.0562740300655, 717.2074857282731, 720.8414148887236, 728.9781306560811, 4570.428696412949, 4861.6353773467135, 4926.679765815282, 4935.901281974412, 4951.0, 111781.0, 112611.0, 112916.0, 113164.43417782859, 114846.62454505164, 98930.5053474728, 99752.0, 100092.0, 100588.0, 100754.4962275184, 85240.57379713062, 86469.56765216133, 88371.55814221017, 88386.55806720925, 88806.9999999987, 8893.0, 8900.465972041698, 8918.509481978554, 9093.909060909305, 9255.120763527455, 51829.0, 52722.736386317825, 53240.73379633077, 53717.73141134269, 55348.16977745257, 45632.54367456416, 56604.433955659915, 72756.0, 73227.63386183036, 73906.63046684947, 11217.0, 12001.1599188056, 12021.639350819489, 12070.698232544257, 12229.93885030569, 13328.800067999182, 13351.732965340445, 13480.5281815136, 13523.661908452368, 13681.247531385869, 12163.817542737042, 12561.0, 12661.556845510362, 12863.163894346837, 12912.677183070498, 11261.774764504828, 11432.771344572895, 11456.94271528637, 11542.711432214262, 11941.104417168921, 11802.232854864405, 11814.173007889365, 12226.877731222574, 12465.626031219077, 12756.68108297263, 9632.229421646392, 9872.358980457571, 9893.35693179941, 10097.747556310856, 10210.387376757419, 9891.851622225817, 10260.794784104426, 10307.690769276935, 10338.25063328869, 10394.740131496774], "value": 7337.17555844649, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 110.0, 111.0, 112.0, 113.0, 110.0, 111.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 124.0, 162.0, 176.0, 128.0, 155.0, 156.0, 127.0, 194.0, 127.0], "value": 151.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 162.0, 164.0, 167.0, 163.0, 163.0, 164.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 162.0, 79.0, 74.0, 77.0, 75.0, 170.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 144.0, 85.0, 85.0, 85.0, 141.0, 87.0, 85.0, 143.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 152.0, 149.0, 149.0, 149.0, 148.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 58.0, 57.0, 58.0, 57.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 61.0, 62.0, 66.0, 61.0, 64.0, 61.0, 62.0, 61.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 83.0, 79.0, 81.0, 79.0, 93.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 127.0, 130.0, 118.0, 123.0, 134.0, 139.0, 134.0, 125.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 165.0, 161.0, 161.0, 160.0, 161.0, 159.0, 159.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 70.0, 62.0, 67.0, 65.0, 63.0, 62.0, 62.0], "value": 63.8, "unit": "score"}]}]} 19:43:33 INFO - Return code: 0 19:43:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:43:33 ERROR - # TBPL SUCCESS # 19:43:33 INFO - Running post-action listener: _resource_record_post_action 19:43:33 INFO - ##### 19:43:33 INFO - ##### Finished run-tests step (success) 19:43:33 INFO - ##### 19:43:33 INFO - Running post-run listener: _resource_record_post_run 19:43:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 564903936; Read time: 0; Write time: 761680 19:43:33 INFO - TinderboxPrint: CPU usage
13.5% 19:43:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:43:33 INFO - TinderboxPrint: I/O write bytes / time
564,903,936 / 761,680 19:43:33 INFO - TinderboxPrint: CPU idle
8,231.8 (86.5%) 19:43:33 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 19:43:33 INFO - TinderboxPrint: Swap in / out
0 / 0 19:43:33 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 266625024; Read time: 0; Write time: 472720 19:43:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294293504; Read time: 0; Write time: 288312 19:43:34 INFO - Running post-run listener: _upload_blobber_files 19:43:34 INFO - Blob upload gear active. 19:43:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:43: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 19:43: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:43: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:43:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:35 INFO - (blobuploader) - INFO - Done attempting. 19:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:36 INFO - (blobuploader) - INFO - Done attempting. 19:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:43:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:39 INFO - (blobuploader) - INFO - Done attempting. 19:43:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:43:39 INFO - Return code: 0 19:43:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:43:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:43:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3671731e3cc045f3e1d9aa70cebe8af869c2853bdf35cc972ab7106d9516d9a8f4794befe160ab2843e384d0bbf2d1953a91cc2f95b87d9c82e3247caf1ad37f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290478caa08c95bdee65cbde18af8f0dea5f09c992fad998f4535e9da7ccb9c36c6783a1a6ab29db9ce14abcd37a8392453da4ce799635af021c187edc0ae434", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4328537d38fdacd2a4583fedc901a039d5d5c1e56a723213a72cd4a266df71b397fcb6969e912c119857c6e17604d6b7253caa853eef946a721ce651f4ee03fc"} 19:43:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:43:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:43:39 INFO - Contents: 19:43:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3671731e3cc045f3e1d9aa70cebe8af869c2853bdf35cc972ab7106d9516d9a8f4794befe160ab2843e384d0bbf2d1953a91cc2f95b87d9c82e3247caf1ad37f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290478caa08c95bdee65cbde18af8f0dea5f09c992fad998f4535e9da7ccb9c36c6783a1a6ab29db9ce14abcd37a8392453da4ce799635af021c187edc0ae434", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4328537d38fdacd2a4583fedc901a039d5d5c1e56a723213a72cd4a266df71b397fcb6969e912c119857c6e17604d6b7253caa853eef946a721ce651f4ee03fc"} 19:43:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:43:39 INFO - Copying logs to upload dir... 19:43:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:43:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.130471 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-24 19:43:38.651327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:38.655050) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483 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/Firefox/sha512/3671731e3cc045f3e1d9aa70cebe8af869c2853bdf35cc972ab7106d9516d9a8f4794befe160ab2843e384d0bbf2d1953a91cc2f95b87d9c82e3247caf1ad37f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290478caa08c95bdee65cbde18af8f0dea5f09c992fad998f4535e9da7ccb9c36c6783a1a6ab29db9ce14abcd37a8392453da4ce799635af021c187edc0ae434", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4328537d38fdacd2a4583fedc901a039d5d5c1e56a723213a72cd4a266df71b397fcb6969e912c119857c6e17604d6b7253caa853eef946a721ce651f4ee03fc"} build_url:https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/DKzqS7uhThWJ3PbXKf-jVQ/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/Firefox/sha512/3671731e3cc045f3e1d9aa70cebe8af869c2853bdf35cc972ab7106d9516d9a8f4794befe160ab2843e384d0bbf2d1953a91cc2f95b87d9c82e3247caf1ad37f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290478caa08c95bdee65cbde18af8f0dea5f09c992fad998f4535e9da7ccb9c36c6783a1a6ab29db9ce14abcd37a8392453da4ce799635af021c187edc0ae434", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4328537d38fdacd2a4583fedc901a039d5d5c1e56a723213a72cd4a266df71b397fcb6969e912c119857c6e17604d6b7253caa853eef946a721ce651f4ee03fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:38.687989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:38.688436) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1466815533.124475-17657483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 19:43:38.773549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:43:38.774140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 19:43:38.774748) ========= ========= Total master_lag: 0.19 =========