builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1465504504.7 results: success (0) buildid: 20160609031135 builduid: b7e12a9c3411425faa1664d3e023b6f5 revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:04.698492) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:04.698885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:04.699160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:04.743903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-06-09 13:35:04.744197) ========= 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=d2a8c569965ab8367867b893000001a1-1465503998.136908-810460531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 13:35:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-06-09 13:35:10 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=5.573758 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-06-09 13:35:10.338860) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:10.339490) ========= 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=d2a8c569965ab8367867b893000001a1-1465503998.136908-810460531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019212 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:10.394176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:10.394934) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 --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=d2a8c569965ab8367867b893000001a1-1465503998.136908-810460531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 13:35:10,514 truncating revision to first 12 chars 2016-06-09 13:35:10,514 Setting DEBUG logging. 2016-06-09 13:35:10,514 attempt 1/10 2016-06-09 13:35:10,514 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1ae7a82e2b1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 13:35:10,829 unpacking tar archive at: mozilla-aurora-1ae7a82e2b1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674036 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:11.085227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:11.085674) ========= script_repo_revision: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:11.086500) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:11.086787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 13:35:11.096699) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-09 13:35:11.097093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1465503998.136908-810460531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:35:11 INFO - MultiFileLogger online at 20160609 13:35:11 in /builds/slave/test 13:35:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:35:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:35:11 INFO - {'append_to_log': False, 13:35:11 INFO - 'base_work_dir': '/builds/slave/test', 13:35:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:35:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:35:11 INFO - 'branch': 'Mozilla-Aurora', 13:35:11 INFO - 'buildbot_json_path': 'buildprops.json', 13:35:11 INFO - 'config_files': ('talos/linux_config.py',), 13:35:11 INFO - 'default_actions': ('clobber', 13:35:11 INFO - 'read-buildbot-config', 13:35:11 INFO - 'download-and-extract', 13:35:11 INFO - 'populate-webroot', 13:35:11 INFO - 'create-virtualenv', 13:35:11 INFO - 'install', 13:35:11 INFO - 'run-tests'), 13:35:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:35:11 INFO - 'download_minidump_stackwalk': True, 13:35:11 INFO - 'download_symbols': 'ondemand', 13:35:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:35:11 INFO - 'tooltool.py': '/tools/tooltool.py', 13:35:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:35:11 INFO - '/tools/misc-python/virtualenv.py')}, 13:35:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:35:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:35:11 INFO - 'installer_path': 'installer.exe', 13:35:11 INFO - 'log_level': 'info', 13:35:11 INFO - 'log_name': 'talos', 13:35:11 INFO - 'log_to_console': True, 13:35:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:35:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:35:11 INFO - 'opt_config_files': (), 13:35:11 INFO - 'pip_index': False, 13:35:11 INFO - 'sps_profile': False, 13:35:11 INFO - 'sps_profile_interval': 0, 13:35:11 INFO - 'suite': 'dromaeojs', 13:35:11 INFO - 'system_bits': '32', 13:35:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:35:11 INFO - 'title': 'talos-linux64-ix-043', 13:35:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:35:11 INFO - 'use_talos_json': True, 13:35:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:35:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:35:11 INFO - 'work_dir': 'build'} 13:35:11 INFO - ##### 13:35:11 INFO - ##### Running clobber step. 13:35:11 INFO - ##### 13:35:11 INFO - Running pre-action listener: _resource_record_pre_action 13:35:11 INFO - Running main action method: clobber 13:35:11 INFO - rmtree: /builds/slave/test/build 13:35:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:35:11 INFO - Running post-action listener: _resource_record_post_action 13:35:11 INFO - ##### 13:35:11 INFO - ##### Finished clobber step (success) 13:35:11 INFO - ##### 13:35:11 INFO - ##### 13:35:11 INFO - ##### Running read-buildbot-config step. 13:35:11 INFO - ##### 13:35:11 INFO - Running pre-action listener: _resource_record_pre_action 13:35:11 INFO - Running main action method: read_buildbot_config 13:35:11 INFO - Using buildbot properties: 13:35:11 INFO - { 13:35:11 INFO - "project": "", 13:35:11 INFO - "product": "firefox", 13:35:11 INFO - "script_repo_revision": "production", 13:35:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:35:11 INFO - "repository": "", 13:35:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:35:11 INFO - "buildid": "20160609031135", 13:35:11 INFO - "pgo_build": "True", 13:35:11 INFO - "basedir": "/builds/slave/test", 13:35:11 INFO - "buildnumber": 377, 13:35:11 INFO - "slavename": "talos-linux64-ix-043", 13:35:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:35:11 INFO - "platform": "ubuntu64_hw", 13:35:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:35:11 INFO - "branch": "mozilla-aurora", 13:35:11 INFO - "repo_path": "releases/mozilla-aurora", 13:35:11 INFO - "revision": "1ae7a82e2b1d2b18ccfa9a578040b46c774bc501", 13:35:11 INFO - "stage_platform": "linux64-pgo", 13:35:11 INFO - "builduid": "b7e12a9c3411425faa1664d3e023b6f5", 13:35:11 INFO - "slavebuilddir": "test" 13:35:11 INFO - } 13:35:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 13:35:11 INFO - Running post-action listener: _resource_record_post_action 13:35:11 INFO - ##### 13:35:11 INFO - ##### Finished read-buildbot-config step (success) 13:35:11 INFO - ##### 13:35:11 INFO - ##### 13:35:11 INFO - ##### Running download-and-extract step. 13:35:11 INFO - ##### 13:35:11 INFO - Running pre-action listener: _resource_record_pre_action 13:35:11 INFO - Running main action method: download_and_extract 13:35:11 INFO - mkdir: /builds/slave/test/build/tests 13:35:11 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')]} 13:35:11 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:35:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:35:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:35:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:35:13 INFO - Downloaded 1361 bytes. 13:35:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 13:35:13 INFO - Using the following test package requirements: 13:35:13 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:35:13 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:35:13 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:35:13 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'jsshell-linux-x86_64.zip'], 13:35:13 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:35:13 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 13:35:13 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:35:13 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:35:13 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:35:13 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:13 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:35:13 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:35: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')]} 13:35:13 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:35:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:35:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:35:15 INFO - Downloaded 24472728 bytes. 13:35:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:35:17 INFO - Return code: 0 13:35:17 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:17 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 13:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:35:23 INFO - Downloaded 24472728 bytes. 13:35:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:35:24 INFO - Return code: 0 13:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:24 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:35:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:35:25 INFO - Downloaded 10833369 bytes. 13:35:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:35:26 INFO - Return code: 0 13:35: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')]} 13:35:26 INFO - https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:35:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:35:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:35:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:35:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:35:29 INFO - Downloaded 63540841 bytes. 13:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:35:29 INFO - mkdir: /builds/slave/test/properties 13:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 13:35:29 INFO - Contents: 13:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 13:35:29 INFO - Running post-action listener: _resource_record_post_action 13:35:29 INFO - Running post-action listener: set_extra_try_arguments 13:35:29 INFO - ##### 13:35:29 INFO - ##### Finished download-and-extract step (success) 13:35:29 INFO - ##### 13:35:29 INFO - ##### 13:35:29 INFO - ##### Running populate-webroot step. 13:35:29 INFO - ##### 13:35:29 INFO - Running pre-action listener: _resource_record_pre_action 13:35:29 INFO - Running main action method: populate_webroot 13:35:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:35:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:35:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:35:29 INFO - '--tppagecycles', 13:35:29 INFO - '7'], 13:35:29 INFO - 'tests': ['tsvgm']}}, 13:35:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:35:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:35:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:35:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:35:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['damp', 'tps']}, 13:35:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'tests': ['damp', 'tps']}, 13:35:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['dromaeo_dom']}, 13:35:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:35:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['a11yr', 13:35:29 INFO - 'ts_paint', 13:35:29 INFO - 'tpaint', 13:35:29 INFO - 'sessionrestore', 13:35:29 INFO - 'sessionrestore_no_auto_restore', 13:35:29 INFO - 'tabpaint']}, 13:35:29 INFO - 'other-e10s': {'tests': ['a11yr', 13:35:29 INFO - 'ts_paint', 13:35:29 INFO - 'tpaint', 13:35:29 INFO - 'sessionrestore', 13:35:29 INFO - 'sessionrestore_no_auto_restore', 13:35:29 INFO - 'tabpaint']}, 13:35:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:35:29 INFO - 'ts_paint', 13:35:29 INFO - 'tpaint', 13:35:29 INFO - 'sessionrestore', 13:35:29 INFO - 'sessionrestore_no_auto_restore', 13:35:29 INFO - 'tabpaint']}, 13:35:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:35:29 INFO - 'ts_paint', 13:35:29 INFO - 'tpaint', 13:35:29 INFO - 'sessionrestore', 13:35:29 INFO - 'sessionrestore_no_auto_restore', 13:35:29 INFO - 'tabpaint']}, 13:35:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['a11yr', 13:35:29 INFO - 'ts_paint', 13:35:29 INFO - 'tpaint', 13:35:29 INFO - 'sessionrestore', 13:35:29 INFO - 'sessionrestore_no_auto_restore', 13:35:29 INFO - 'tabpaint']}, 13:35:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['a11yr', 13:35:29 INFO - 'ts_paint', 13:35:29 INFO - 'tpaint', 13:35:29 INFO - 'sessionrestore', 13:35:29 INFO - 'sessionrestore_no_auto_restore', 13:35:29 INFO - 'tabpaint']}, 13:35:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['tsvgx', 13:35:29 INFO - 'tsvgr_opacity', 13:35:29 INFO - 'tart', 13:35:29 INFO - 'tscrollx', 13:35:29 INFO - 'cart']}, 13:35:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:35:29 INFO - 'tsvgr_opacity', 13:35:29 INFO - 'tart', 13:35:29 INFO - 'tscrollx', 13:35:29 INFO - 'cart']}, 13:35:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'talos_options': ['--disable-e10s'], 13:35:29 INFO - 'tests': ['tp5o']}, 13:35:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'tests': ['tp5o']}, 13:35:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'talos_options': ['--disable-e10s', 13:35:29 INFO - '--xperf_path', 13:35:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:29 INFO - 'tests': ['tp5n']}, 13:35:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:29 INFO - 'talos_options': ['--xperf_path', 13:35:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:29 INFO - 'tests': ['tp5n']}}, 13:35:29 INFO - 'talos.zip': {'path': '', 13:35:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:35:29 INFO - Running post-action listener: _resource_record_post_action 13:35:29 INFO - ##### 13:35:29 INFO - ##### Finished populate-webroot step (success) 13:35:29 INFO - ##### 13:35:29 INFO - ##### 13:35:29 INFO - ##### Running create-virtualenv step. 13:35:29 INFO - ##### 13:35:29 INFO - Running pre-action listener: _resource_record_pre_action 13:35:29 INFO - Running main action method: create_virtualenv 13:35:29 INFO - Creating virtualenv /builds/slave/test/build/venv 13:35:29 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 13:35:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:35:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:35:29 INFO - Using real prefix '/usr' 13:35:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:35:30 INFO - Installing distribute.............................................................................................................................................................................................done. 13:35:32 INFO - Installing pip.................done. 13:35:32 INFO - Return code: 0 13:35:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:35:32 INFO - Using env: {'DISPLAY': ':0', 13:35:32 INFO - 'HOME': '/home/cltbld', 13:35:32 INFO - 'LANG': 'en_US.UTF-8', 13:35:32 INFO - 'LANGUAGE': 'en_US:en', 13:35:32 INFO - 'LOGNAME': 'cltbld', 13:35:32 INFO - 'MAIL': '/var/mail/cltbld', 13:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:32 INFO - 'MOZ_NO_REMOTE': '1', 13:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:32 INFO - 'NO_EM_RESTART': '1', 13:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:32 INFO - 'PWD': '/builds/slave/test', 13:35:32 INFO - 'SHELL': '/bin/bash', 13:35:32 INFO - 'SHLVL': '1', 13:35:32 INFO - 'TERM': 'linux', 13:35:32 INFO - 'TMOUT': '86400', 13:35:32 INFO - 'USER': 'cltbld', 13:35:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:32 INFO - '_': '/tools/buildbot/bin/python'} 13:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:32 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 13:35:32 INFO - Cleaning up... 13:35:32 INFO - Return code: 0 13:35:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:35:32 INFO - Using env: {'DISPLAY': ':0', 13:35:32 INFO - 'HOME': '/home/cltbld', 13:35:32 INFO - 'LANG': 'en_US.UTF-8', 13:35:32 INFO - 'LANGUAGE': 'en_US:en', 13:35:32 INFO - 'LOGNAME': 'cltbld', 13:35:32 INFO - 'MAIL': '/var/mail/cltbld', 13:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:32 INFO - 'MOZ_NO_REMOTE': '1', 13:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:32 INFO - 'NO_EM_RESTART': '1', 13:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:32 INFO - 'PWD': '/builds/slave/test', 13:35:32 INFO - 'SHELL': '/bin/bash', 13:35:32 INFO - 'SHLVL': '1', 13:35:32 INFO - 'TERM': 'linux', 13:35:32 INFO - 'TMOUT': '86400', 13:35:32 INFO - 'USER': 'cltbld', 13:35:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:32 INFO - '_': '/tools/buildbot/bin/python'} 13:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:32 INFO - Downloading/unpacking psutil>=3.1.1 13:35:32 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 13:35:32 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 13:35:32 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 13:35:32 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 13:35:32 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 13:35:32 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 13:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:35:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:34 INFO - Installing collected packages: psutil 13:35:34 INFO - Running setup.py install for psutil 13:35:34 INFO - building 'psutil._psutil_linux' extension 13:35:34 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 13:35:35 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 13:35:35 INFO - building 'psutil._psutil_posix' extension 13:35:35 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 13:35:35 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 13:35:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:35:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:35:35 INFO - Successfully installed psutil 13:35:35 INFO - Cleaning up... 13:35:35 INFO - Return code: 0 13:35:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:35 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:35 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 13:35:35 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 13:35:35 INFO - Using env: {'DISPLAY': ':0', 13:35:35 INFO - 'HOME': '/home/cltbld', 13:35:35 INFO - 'LANG': 'en_US.UTF-8', 13:35:35 INFO - 'LANGUAGE': 'en_US:en', 13:35:35 INFO - 'LOGNAME': 'cltbld', 13:35:35 INFO - 'MAIL': '/var/mail/cltbld', 13:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:35 INFO - 'MOZ_NO_REMOTE': '1', 13:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:35 INFO - 'NO_EM_RESTART': '1', 13:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:35 INFO - 'PWD': '/builds/slave/test', 13:35:35 INFO - 'SHELL': '/bin/bash', 13:35:35 INFO - 'SHLVL': '1', 13:35:35 INFO - 'TERM': 'linux', 13:35:35 INFO - 'TMOUT': '86400', 13:35:35 INFO - 'USER': 'cltbld', 13:35:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:35 INFO - '_': '/tools/buildbot/bin/python'} 13:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:35:37 INFO - Installing collected packages: mozsystemmonitor 13:35:37 INFO - Running setup.py install for mozsystemmonitor 13:35:37 INFO - Successfully installed mozsystemmonitor 13:35:37 INFO - Cleaning up... 13:35:37 INFO - Return code: 0 13:35:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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')]} 13:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35: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==2.5.1'] in /builds/slave/test/build 13:35: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==2.5.1 13:35:37 INFO - Using env: {'DISPLAY': ':0', 13:35:37 INFO - 'HOME': '/home/cltbld', 13:35:37 INFO - 'LANG': 'en_US.UTF-8', 13:35:37 INFO - 'LANGUAGE': 'en_US:en', 13:35:37 INFO - 'LOGNAME': 'cltbld', 13:35:37 INFO - 'MAIL': '/var/mail/cltbld', 13:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:37 INFO - 'MOZ_NO_REMOTE': '1', 13:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:37 INFO - 'NO_EM_RESTART': '1', 13:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:37 INFO - 'PWD': '/builds/slave/test', 13:35:37 INFO - 'SHELL': '/bin/bash', 13:35:37 INFO - 'SHLVL': '1', 13:35:37 INFO - 'TERM': 'linux', 13:35:37 INFO - 'TMOUT': '86400', 13:35:37 INFO - 'USER': 'cltbld', 13:35:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:37 INFO - '_': '/tools/buildbot/bin/python'} 13:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:35:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35: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 13:35:39 INFO - Downloading functools32-3.2.3-2.tar.gz 13:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:35:40 INFO - warning: no files found matching '*.txt' 13:35:40 INFO - no previously-included directories found matching 'build' 13:35:40 INFO - no previously-included directories found matching 'dist' 13:35:40 INFO - no previously-included directories found matching '.git*' 13:35:40 INFO - Installing collected packages: jsonschema, functools32 13:35:40 INFO - Running setup.py install for functools32 13:35:40 INFO - warning: no files found matching '*.txt' 13:35:40 INFO - no previously-included directories found matching 'build' 13:35:40 INFO - no previously-included directories found matching 'dist' 13:35:40 INFO - no previously-included directories found matching '.git*' 13:35:40 INFO - Successfully installed jsonschema functools32 13:35:40 INFO - Cleaning up... 13:35:40 INFO - Return code: 0 13:35:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:40 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:40 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 13:35:40 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 13:35:40 INFO - Using env: {'DISPLAY': ':0', 13:35:40 INFO - 'HOME': '/home/cltbld', 13:35:40 INFO - 'LANG': 'en_US.UTF-8', 13:35:40 INFO - 'LANGUAGE': 'en_US:en', 13:35:40 INFO - 'LOGNAME': 'cltbld', 13:35:40 INFO - 'MAIL': '/var/mail/cltbld', 13:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:40 INFO - 'MOZ_NO_REMOTE': '1', 13:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:40 INFO - 'NO_EM_RESTART': '1', 13:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:40 INFO - 'PWD': '/builds/slave/test', 13:35:40 INFO - 'SHELL': '/bin/bash', 13:35:40 INFO - 'SHLVL': '1', 13:35:40 INFO - 'TERM': 'linux', 13:35:40 INFO - 'TMOUT': '86400', 13:35:40 INFO - 'USER': 'cltbld', 13:35:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:40 INFO - '_': '/tools/buildbot/bin/python'} 13:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:40 INFO - Downloading/unpacking blobuploader==1.2.4 13:35:40 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 13:35:40 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 13:35:40 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 13:35:40 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 13:35:40 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 13:35:40 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 13:35:42 INFO - Downloading blobuploader-1.2.4.tar.gz 13:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:35:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:35:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 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 13:35:42 INFO - Downloading docopt-0.6.1.tar.gz 13:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:35:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:35:43 INFO - Running setup.py install for blobuploader 13:35:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:35:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:35:43 INFO - Running setup.py install for requests 13:35:43 INFO - Running setup.py install for docopt 13:35:43 INFO - Successfully installed blobuploader requests docopt 13:35:43 INFO - Cleaning up... 13:35:43 INFO - Return code: 0 13:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:43 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:43 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 13:35:43 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 13:35:43 INFO - Using env: {'DISPLAY': ':0', 13:35:43 INFO - 'HOME': '/home/cltbld', 13:35:43 INFO - 'LANG': 'en_US.UTF-8', 13:35:43 INFO - 'LANGUAGE': 'en_US:en', 13:35:43 INFO - 'LOGNAME': 'cltbld', 13:35:43 INFO - 'MAIL': '/var/mail/cltbld', 13:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:43 INFO - 'MOZ_NO_REMOTE': '1', 13:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:43 INFO - 'NO_EM_RESTART': '1', 13:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:43 INFO - 'PWD': '/builds/slave/test', 13:35:43 INFO - 'SHELL': '/bin/bash', 13:35:43 INFO - 'SHLVL': '1', 13:35:43 INFO - 'TERM': 'linux', 13:35:43 INFO - 'TMOUT': '86400', 13:35:43 INFO - 'USER': 'cltbld', 13:35:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:43 INFO - '_': '/tools/buildbot/bin/python'} 13:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:43 INFO - Running setup.py (path:/tmp/pip-jOf7S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:43 INFO - Running setup.py (path:/tmp/pip-ZtGk68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:44 INFO - Running setup.py (path:/tmp/pip-PRXUs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:44 INFO - Running setup.py (path:/tmp/pip-riSXB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:44 INFO - Running setup.py (path:/tmp/pip-sZPkWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:44 INFO - Running setup.py (path:/tmp/pip-IyppcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:44 INFO - Running setup.py (path:/tmp/pip-g2H3dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:44 INFO - Running setup.py (path:/tmp/pip-RegjPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:44 INFO - Running setup.py (path:/tmp/pip-7am3AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:44 INFO - Running setup.py (path:/tmp/pip-_XiEzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:44 INFO - Running setup.py (path:/tmp/pip-S9Vg47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:44 INFO - Running setup.py (path:/tmp/pip-as342P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:44 INFO - Running setup.py (path:/tmp/pip-prM_bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:45 INFO - Running setup.py (path:/tmp/pip-rxZIUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:45 INFO - Running setup.py (path:/tmp/pip-ANQuh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:45 INFO - Running setup.py (path:/tmp/pip-yhi97s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:45 INFO - Running setup.py (path:/tmp/pip-8kdNoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:35:45 INFO - Running setup.py install for manifestparser 13:35:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:35:45 INFO - Running setup.py install for mozcrash 13:35:45 INFO - Running setup.py install for mozdebug 13:35:45 INFO - Running setup.py install for mozdevice 13:35:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:35:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:35:45 INFO - Running setup.py install for mozfile 13:35:45 INFO - Running setup.py install for mozhttpd 13:35:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:35:45 INFO - Running setup.py install for mozinfo 13:35:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Running setup.py install for mozInstall 13:35:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Running setup.py install for mozleak 13:35:46 INFO - Running setup.py install for mozlog 13:35:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Running setup.py install for moznetwork 13:35:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Running setup.py install for mozprocess 13:35:46 INFO - Running setup.py install for mozprofile 13:35:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Running setup.py install for mozrunner 13:35:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:35:46 INFO - Running setup.py install for mozscreenshot 13:35:46 INFO - Running setup.py install for moztest 13:35:47 INFO - Running setup.py install for mozversion 13:35:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:35:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:35:47 INFO - Cleaning up... 13:35:47 INFO - Return code: 0 13:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:47 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')]} 13:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:47 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')]} 13:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:47 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:47 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 13:35:47 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 13:35:47 INFO - Using env: {'DISPLAY': ':0', 13:35:47 INFO - 'HOME': '/home/cltbld', 13:35:47 INFO - 'LANG': 'en_US.UTF-8', 13:35:47 INFO - 'LANGUAGE': 'en_US:en', 13:35:47 INFO - 'LOGNAME': 'cltbld', 13:35:47 INFO - 'MAIL': '/var/mail/cltbld', 13:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:47 INFO - 'MOZ_NO_REMOTE': '1', 13:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:47 INFO - 'NO_EM_RESTART': '1', 13:35:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:47 INFO - 'PWD': '/builds/slave/test', 13:35:47 INFO - 'SHELL': '/bin/bash', 13:35:47 INFO - 'SHLVL': '1', 13:35:47 INFO - 'TERM': 'linux', 13:35:47 INFO - 'TMOUT': '86400', 13:35:47 INFO - 'USER': 'cltbld', 13:35:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:47 INFO - '_': '/tools/buildbot/bin/python'} 13:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:47 INFO - Running setup.py (path:/tmp/pip-rBiB30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:47 INFO - Running setup.py (path:/tmp/pip-PfndSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:47 INFO - Running setup.py (path:/tmp/pip-3x4OeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:47 INFO - Running setup.py (path:/tmp/pip-5qSfZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:47 INFO - Running setup.py (path:/tmp/pip-NLtlcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:47 INFO - Running setup.py (path:/tmp/pip-dfKiNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:47 INFO - Running setup.py (path:/tmp/pip-MI8qqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:47 INFO - Running setup.py (path:/tmp/pip-AwOqla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:47 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)) 13:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:47 INFO - Running setup.py (path:/tmp/pip-yInwYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:48 INFO - Running setup.py (path:/tmp/pip-XnbOSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:48 INFO - Running setup.py (path:/tmp/pip-IXzLIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:48 INFO - Running setup.py (path:/tmp/pip-m4934d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:48 INFO - Running setup.py (path:/tmp/pip-XFKT2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:48 INFO - Running setup.py (path:/tmp/pip-4FYTau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:48 INFO - Running setup.py (path:/tmp/pip-amd7G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:48 INFO - Running setup.py (path:/tmp/pip-dwPp5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:48 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)) 13:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:48 INFO - Running setup.py (path:/tmp/pip-YkEkKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:48 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)) 13:35:48 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)) 13:35:48 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)) 13:35:48 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)) 13:35:48 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)) 13:35:48 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)) 13:35:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:35:48 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 13:35:48 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 13:35:48 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 13:35:48 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 13:35:48 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 13:35:48 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 13:35:50 INFO - Downloading blessings-1.6.tar.gz 13:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:35:50 INFO - Installing collected packages: blessings 13:35:50 INFO - Running setup.py install for blessings 13:35:50 INFO - Successfully installed blessings 13:35:50 INFO - Cleaning up... 13:35:50 INFO - Return code: 0 13:35:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:35:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:50 INFO - Reading from file tmpfile_stdout 13:35:50 INFO - Current package versions: 13:35:50 INFO - argparse == 1.2.1 13:35:50 INFO - blessings == 1.6 13:35:50 INFO - blobuploader == 1.2.4 13:35:50 INFO - docopt == 0.6.1 13:35:50 INFO - functools32 == 3.2.3-2 13:35:50 INFO - jsonschema == 2.5.1 13:35:50 INFO - manifestparser == 1.1 13:35:50 INFO - mozInstall == 1.12 13:35:50 INFO - mozcrash == 0.17 13:35:50 INFO - mozdebug == 0.1 13:35:50 INFO - mozdevice == 0.48 13:35:50 INFO - mozfile == 1.2 13:35:50 INFO - mozhttpd == 0.7 13:35:50 INFO - mozinfo == 0.9 13:35:50 INFO - mozleak == 0.1 13:35:50 INFO - mozlog == 3.2 13:35:50 INFO - moznetwork == 0.27 13:35:50 INFO - mozprocess == 0.22 13:35:50 INFO - mozprofile == 0.28 13:35:50 INFO - mozrunner == 6.11 13:35:50 INFO - mozscreenshot == 0.1 13:35:50 INFO - mozsystemmonitor == 0.3 13:35:50 INFO - moztest == 0.7 13:35:50 INFO - mozversion == 1.4 13:35:50 INFO - psutil == 3.1.1 13:35:50 INFO - requests == 1.2.3 13:35:50 INFO - wsgiref == 0.1.2 13:35:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:50 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:50 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 13:35:50 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 13:35:50 INFO - Using env: {'DISPLAY': ':0', 13:35:50 INFO - 'HOME': '/home/cltbld', 13:35:50 INFO - 'LANG': 'en_US.UTF-8', 13:35:50 INFO - 'LANGUAGE': 'en_US:en', 13:35:50 INFO - 'LOGNAME': 'cltbld', 13:35:50 INFO - 'MAIL': '/var/mail/cltbld', 13:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:50 INFO - 'MOZ_NO_REMOTE': '1', 13:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:50 INFO - 'NO_EM_RESTART': '1', 13:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:50 INFO - 'PWD': '/builds/slave/test', 13:35:50 INFO - 'SHELL': '/bin/bash', 13:35:50 INFO - 'SHLVL': '1', 13:35:50 INFO - 'TERM': 'linux', 13:35:50 INFO - 'TMOUT': '86400', 13:35:50 INFO - 'USER': 'cltbld', 13:35:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:50 INFO - '_': '/tools/buildbot/bin/python'} 13:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 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)) 13:35:51 INFO - Cleaning up... 13:35:51 INFO - Return code: 0 13:35:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:35:51 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')]} 13:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:51 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')]} 13:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:51 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:51 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 13:35:51 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 13:35:51 INFO - Using env: {'DISPLAY': ':0', 13:35:51 INFO - 'HOME': '/home/cltbld', 13:35:51 INFO - 'LANG': 'en_US.UTF-8', 13:35:51 INFO - 'LANGUAGE': 'en_US:en', 13:35:51 INFO - 'LOGNAME': 'cltbld', 13:35:51 INFO - 'MAIL': '/var/mail/cltbld', 13:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:51 INFO - 'MOZ_NO_REMOTE': '1', 13:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:51 INFO - 'NO_EM_RESTART': '1', 13:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:51 INFO - 'PWD': '/builds/slave/test', 13:35:51 INFO - 'SHELL': '/bin/bash', 13:35:51 INFO - 'SHLVL': '1', 13:35:51 INFO - 'TERM': 'linux', 13:35:51 INFO - 'TMOUT': '86400', 13:35:51 INFO - 'USER': 'cltbld', 13:35:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:51 INFO - '_': '/tools/buildbot/bin/python'} 13:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:35:51 INFO - Cleaning up... 13:35:51 INFO - Return code: 0 13:35:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:35:51 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')]} 13:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:51 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')]} 13:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:51 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 0x7f92f0693f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2575020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', '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 13:35:51 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 13:35:51 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 13:35:51 INFO - Using env: {'DISPLAY': ':0', 13:35:51 INFO - 'HOME': '/home/cltbld', 13:35:51 INFO - 'LANG': 'en_US.UTF-8', 13:35:51 INFO - 'LANGUAGE': 'en_US:en', 13:35:51 INFO - 'LOGNAME': 'cltbld', 13:35:51 INFO - 'MAIL': '/var/mail/cltbld', 13:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:51 INFO - 'MOZ_NO_REMOTE': '1', 13:35:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:51 INFO - 'NO_EM_RESTART': '1', 13:35:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:51 INFO - 'PWD': '/builds/slave/test', 13:35:51 INFO - 'SHELL': '/bin/bash', 13:35:51 INFO - 'SHLVL': '1', 13:35:51 INFO - 'TERM': 'linux', 13:35:51 INFO - 'TMOUT': '86400', 13:35:51 INFO - 'USER': 'cltbld', 13:35:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:51 INFO - '_': '/tools/buildbot/bin/python'} 13:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:51 INFO - Downloading/unpacking flake8 13:35:51 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 13:35:51 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 13:35:51 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 13:35:51 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 13:35:51 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 13:35:51 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 13:35:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:35:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:35:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:53 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 13:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:35:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:35:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:35:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:35:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:35:54 INFO - no previously-included directories found matching 'docs/_build' 13:35:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:35:54 INFO - Running setup.py install for pep8 13:35:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:35:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:35:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:35:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:35:54 INFO - no previously-included directories found matching 'docs/_build' 13:35:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:35:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:35:54 INFO - Cleaning up... 13:35:54 INFO - Return code: 0 13:35:54 INFO - Running post-action listener: _resource_record_post_action 13:35:54 INFO - Running post-action listener: _start_resource_monitoring 13:35:54 INFO - Starting resource monitoring. 13:35:54 INFO - ##### 13:35:54 INFO - ##### Finished create-virtualenv step (success) 13:35:54 INFO - ##### 13:35:54 INFO - ##### 13:35:54 INFO - ##### Running install step. 13:35:54 INFO - ##### 13:35:54 INFO - Running pre-action listener: _resource_record_pre_action 13:35:54 INFO - Running main action method: install 13:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:54 INFO - Reading from file tmpfile_stdout 13:35:54 INFO - Detecting whether we're running mozinstall >=1.0... 13:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:35:54 INFO - Reading from file tmpfile_stdout 13:35:54 INFO - Output received: 13:35:54 INFO - Usage: mozinstall [options] installer 13:35:54 INFO - Options: 13:35:54 INFO - -h, --help show this help message and exit 13:35:54 INFO - -d DEST, --destination=DEST 13:35:54 INFO - Directory to install application into. [default: 13:35:54 INFO - "/builds/slave/test"] 13:35:54 INFO - --app=APP Application being installed. [default: firefox] 13:35:54 INFO - mkdir: /builds/slave/test/build/application 13:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:36:10 INFO - Reading from file tmpfile_stdout 13:36:10 INFO - Output received: 13:36:10 INFO - /builds/slave/test/build/application/firefox/firefox 13:36:10 INFO - Running post-action listener: _resource_record_post_action 13:36:10 INFO - ##### 13:36:10 INFO - ##### Finished install step (success) 13:36:10 INFO - ##### 13:36:10 INFO - ##### 13:36:10 INFO - ##### Running run-tests step. 13:36:10 INFO - ##### 13:36:10 INFO - Running pre-action listener: _resource_record_pre_action 13:36:10 INFO - Running main action method: run_tests 13:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:10 INFO - Python 2.7.3 13:36:10 INFO - Return code: 0 13:36:10 INFO - grabbing minidump binary from tooltool 13:36: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')]} 13:36:10 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 0x26072e0>, '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 0x2573140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25735d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:10 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 13:36:10 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 13:36:10 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 13:36:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:10 INFO - Return code: 0 13:36:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:36:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:36:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:36:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:36:11 INFO - Return code: 0 13:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:36:11 INFO - Using env: {'DISPLAY': ':0', 13:36:11 INFO - 'HOME': '/home/cltbld', 13:36:11 INFO - 'LANG': 'en_US.UTF-8', 13:36:11 INFO - 'LANGUAGE': 'en_US:en', 13:36:11 INFO - 'LOGNAME': 'cltbld', 13:36:11 INFO - 'MAIL': '/var/mail/cltbld', 13:36:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:11 INFO - 'MOZ_NO_REMOTE': '1', 13:36:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:11 INFO - 'NO_EM_RESTART': '1', 13:36:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:11 INFO - 'PWD': '/builds/slave/test', 13:36:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:11 INFO - 'SHELL': '/bin/bash', 13:36:11 INFO - 'SHLVL': '1', 13:36:11 INFO - 'TERM': 'linux', 13:36:11 INFO - 'TMOUT': '86400', 13:36:11 INFO - 'USER': 'cltbld', 13:36:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465503998.136908-810460531', 13:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:11 INFO - '_': '/tools/buildbot/bin/python'} 13:36:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:36:11 INFO - mozversion application_buildid: 20160609031135 13:36:11 INFO - mozversion application_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:36:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:36:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:11 INFO - mozversion application_name: Firefox 13:36:11 INFO - mozversion application_remotingname: firefox-dev 13:36:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:36:11 INFO - mozversion application_vendor: Mozilla 13:36:11 INFO - mozversion application_version: 49.0a2 13:36:11 INFO - mozversion platform_buildid: 20160609031135 13:36:11 INFO - mozversion platform_changeset: 1ae7a82e2b1d2b18ccfa9a578040b46c774bc501 13:36:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:36:11 INFO - mozversion platform_version: 49.0a2 13:36:11 INFO - using testdate: 1465504571 13:36:11 INFO - actual date: 1465504571 13:36:11 INFO - starting webserver on 'localhost:50087' 13:36:11 INFO - SUITE-START | Running 2 tests 13:36:11 INFO - TEST-START | dromaeo_css 13:36:11 INFO - operating with platform_type : linux_ 13:36:11 INFO - Initialising browser for dromaeo_css test... 13:36:11 INFO - TEST-INFO | started process 14142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYp2f6/profile http://localhost:50087/getInfo.html) 13:36:15 INFO - PROCESS | 14142 | __metrics Screen width/height:1600/1200 13:36:15 INFO - PROCESS | 14142 | colorDepth:24 13:36:15 INFO - PROCESS | 14142 | Browser inner width/height: 1024/697 13:36:15 INFO - PROCESS | 14142 | __metrics 13:36:17 ERROR - PROCESS | 14142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:36:17 INFO - PROCESS | 14142 | console.error: PushService: 13:36:17 INFO - PROCESS | 14142 | stateChangeProcessEnqueue: Error transitioning state 13:36:17 INFO - PROCESS | 14142 | UnknownError 13:36:18 INFO - TEST-INFO | 14142: exit 0 13:36:18 INFO - Browser initialized. 13:36:18 INFO - Running cycle 1/1 for dromaeo_css test... 13:36:18 INFO - TEST-INFO | started process 14233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYp2f6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:30 INFO - PROCESS | 14233 | RSS: Main: 145661952 13:36:30 INFO - PROCESS | 14233 | 13:37:21 INFO - PROCESS | 14233 | 1465504641398 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] 13:39:29 INFO - PROCESS | 14233 | Cycle 1(1): loaded http://localhost:50087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50087/tests/dromaeo/cssquery-ext.html) 13:39:30 INFO - PROCESS | 14233 | RSS: Main: 248868864 13:39:30 INFO - PROCESS | 14233 | 13:42:33 INFO - PROCESS | 14233 | Cycle 1(1): loaded http://localhost:50087/tests/dromaeo/cssquery-ext.html (next: http://localhost:50087/tests/dromaeo/cssquery-jquery.html) 13:42:33 INFO - PROCESS | 14233 | RSS: Main: 232009728 13:42:33 INFO - PROCESS | 14233 | 13:45:35 INFO - PROCESS | 14233 | Cycle 1(1): loaded http://localhost:50087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50087/tests/dromaeo/cssquery-mootools.html) 13:45:36 INFO - PROCESS | 14233 | RSS: Main: 220688384 13:45:36 INFO - PROCESS | 14233 | 13:48:38 INFO - PROCESS | 14233 | Cycle 1(1): loaded http://localhost:50087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50087/tests/dromaeo/cssquery-prototype.html) 13:48:38 INFO - PROCESS | 14233 | RSS: Main: 222928896 13:48:38 INFO - PROCESS | 14233 | 13:51:41 INFO - PROCESS | 14233 | Cycle 1(1): loaded http://localhost:50087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50087/tests/dromaeo/cssquery-yui.html) 13:51:41 INFO - PROCESS | 14233 | RSS: Main: 209838080 13:51:41 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | Cycle 1(1): loaded http://localhost:50087/tests/dromaeo/cssquery-yui.html (next: http://localhost:50087/tests/dromaeo/cssquery-dojo.html) 13:54:44 INFO - PROCESS | 14233 | RSS: Main: 258027520 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | __start_tp_report 13:54:44 INFO - PROCESS | 14233 | _x_x_mozilla_page_load 13:54:44 INFO - PROCESS | 14233 | _x_x_mozilla_page_load_details 13:54:44 INFO - PROCESS | 14233 | |i|pagename|runs| 13:54:44 INFO - PROCESS | 14233 | |0;dojo.html;3319.319539494403;3350.9832450837744;3353.5975682918047;3372.477266023764;3406.795592264464;5500.972495137524;5645.096784514473;5671.461211184941;5678.346990096145;5692.459216374448;5537.1140617501205;5567.66594004359;5594.440555944404;5600.6079574429805;5615.719214039302;4994.775235114428;5022.296878437012;5028.044671512419;5045.470225626312;5088.771005304751;5081.923771143436;5147.8455646330485;5148.6395952283165;5149.613778966574;5150.356205474316;5028.7737051832755;5064.088464076464;5082.263071854579;5094.668846524983;5104.464031276718;5127.641065125443;5147.202183661539;5169.612279079084;5180.585553155738;5205.791768329263;5010.173321401964;5067.949320506785;5070.2141168119;5091.79632814687;5132.076226279269;5531.944680553183;5543.695096769676;5566.944330556724;5596.496315331599;5609.074502707049;6117.4779379467245;6138.447539721446;6138.47822935051;6139.631622102688;6148.354422785588;6030.155778191057;6077.726502307407;6088.6042407243385;6123.969380153071;6150.66171360575;5689.459501347406;5729.0260655688635;5733.455321744427;5739.426057394269;5746.138079288056;5982.282126144803;6206.689665516707;6222.502199824004;6224.719887604978;6226.968865155736;5890.9410905891245;5945.791897283574;5946.70266486674;6036.909446358308;6047.0929360596265;6105.267367915879;6106.603070800384;6108.860595101983;6125.264968203844;6127.969360153171;5859.384764599741;5945.762169513171;6039.094135879565;6049.153118563405;6050.878982420327;5993.31076926159;6053.606515576474;6063;6067.848303792441;6110.4195101466175;4603.470600880874;4611.054733779567;4616.699914505546;4618.607418369476;4641.234196357631;4062.878113656536;4066.2883995300704;4087.141700242923;4130.070734084807;4138.296489596776;5745.511631511285;5761.85595360111;5785.421457854265;5785.971070144622;5798.420157984252;6020.367861374581;6061.151438798572;6066.4540191382985;6077.848053798691;6092.329843717188;5651.237082993825;5660.971695141498;5671.2060311556415;5771.451712087345;5774.2782152230975;5187.766550505161;5195.246689230116;5201.375834899836;5203.505666961632;5208.114620514521;6266.686665666698;6271.247450305992;6271.937280627227;6278.30938596754;6285.151504546919;5963.224780778471;5989.46094851448;6024.518038556993;6052.425019623129;6053.969730151321;6262.624242545462;6270.122182894307;6300.117983482408;6302.527310451643;6317.842053948504;6006.459418652343;6008.81973540777;6009.188759517409;6020.39796020412;6044.274687037584;5914.940850591439;6024.969875150597;6048.092786082123;6073.119397687222;6133.233345831771;5938.910916336345;5991.7603295867675;6003.489703375088;6005;6005.159277701038;5922.437368449991;5961.284645842353;5980.073088671263;5997.70011499432;6004.519638429003;5649.576281778801;5725.227094342211;5747.971260143672;5758.280214973129;5789.1605717171615;5884.440978107073;5941.465268125889;5941.702914854326;5943.702814859326;5953.732082056405;5675.602707810579;5795.217645617956;5800.651960882361;5808.332041815245;5808.796692115756 13:54:44 INFO - PROCESS | 14233 | |1;ext.html;597.3220394851844;646.689588997281;650.3204151661514;653.2552889705734;663.3366633366632;33958.49062264068;46274.305885411704;46801.76599117008;46955.29567056493;46960.765196174056;48557.757211213895;49091;49171.262431063566;49183.50816491834;49185.754071229596;8504.532250726208;9081;9277.536123193848;9278.257739380868;10933.507992140372;10618.946905265462;11051.115910727123;11057.612983545578;11059.391733454657;11065.170112241574;11124.443777811117;11189.384583847885;11198.888011119867;11201.103911687087;11206.663800086011;8570.442921210102;11010.669679909615;11136.554537818478;11335.716607084807;11351.091912646969;10716.517756700967;11147.888521114766;11159.442027898654;11173.832392514038;11177.770445251015;46554.06891862178;47007;47100;47140.29289560625;47320.763396183145;3654.14127679995;3671.6511931366476;3680;3683.226522430293;3698.0939669780805;35576.644233557854;35907.64092359095;36326.27347453062;36331.818340908394;36732.26535469302;4492.326151077332;4498.302763071729;4598.26427771555;4620.422447194101;4700.553447422523;385669;386221;389472;389714;390040;39165.80417097896;40495.59504404977;71056.289437106;72022;72054;41978.79010604927;42010.579894200666;42211.1557768849;42234.57765422368;42246.57753422488;16458.259378328003;16697.248623811956;16703.248353824107;16704.24830882589;16709.415170468976;12017.158798883995;13241;13390.330483475787;13406.664833379244;13713;9324.393914395543;9434.622615095319;9436.386634868712;9465.90534094664;9502.144806967406;3552.5204097446513;3577.58857731359;3586.7668601540818;3634.6547078027547;3654.8903532894055;1060.7878424315168;1089.3028461784463;1147.5524545427122;1174.3775798826637;1180.3508070561156;33716.15709607279;34236;34511.82744086314;34546.48180277298;34763.65236347655;1144.456383217965;1226.2519862883635;1248.4818800197816;1257.4404390046525;1258.6098309524077;17767.644647106987;18095.276188952295;18179.54551136232;18238;18284.17721202549;159317.20341398218;159875;161509;161853;161921.19039404727;62624;63363.683181583794;63403;63406;63470.36529634737;1346.865313468665;1420.971580568383;1447.486142419447;1464.1142109023888;1472.4404726203975;33291.500627490124;34572.82713586416;34973.65026349704;34992.65007349894;35267;52633.473665262856;53131;53234.20148697695;53327.73336133295;53411.4658853422;420424;420464;421953;423068;423682;27763.44473110486;31781.364372711952;32711.182220443727;33054.338913222084;33145.17137071592;50802;51621.48378516317;52580.737096314275;52733.7363313181;53036;43024;43073;43351.78324108359;43444.348334775634;43815.56184438115;43516.78241608771;43542.78228608837;43596;44335.33496997483;44638.77680611576;43546.78226608974;43570;43657.781711091244;44264;44451.11097778091;38334.23331533298;39040.41439378355;39135.804320979354;39592;39635.80182099071;29225.85387073051;29696.703032970257;29718.4121268788;29779.702202977693;30043.248918777204 13:54:44 INFO - PROCESS | 14233 | |2;jquery.html;407.95104587449504;425.4023097547946;429.64983538416186;432.8052376430607;433.2245280947105;18911.81088189118;20483.18067277311;20531.486712832186;20702.482437939023;21544.784552154473;19674.213031478725;19956.700649490234;20254.59490810183;20605.690914636292;20651.483712907186;5655.4061823508555;5871.207387002764;5909.586328956974;5912.260967379078;5914.024186009303;4338;5135.409427915782;5849.210356601847;6590.373914478141;6605.768798092044;6532.836679083037;6600.174978127734;6623.635700036496;6646.867062658768;6655.667216639173;6381.553291269613;6514.44627206688;6523.380278873499;6564.1138446309615;6568.310327415625;3937.1338305572726;5493.615446918678;5714.371419143891;5796.536277097822;5818.796342128047;23657.171998980124;23876.164334248217;23990.520189596285;24169.758302416925;24419;2493.339265094751;2495;2550.4006558458746;2807;2956.9260768480744;10028.348157369821;10247.897521024768;10615.46922653872;14337.139771613736;15534.689306213926;1993.5115896605425;2029.553498230387;2051.0360130738527;2057.753069631639;2105.9262925797525;67643.66178169126;68629.96031746031;80201;83353;85578.57210713907;11098.778024439465;11483.885161148448;11584.362860042778;11726.061915046776;11796.94101529487;16326.510204693877;16430.096344701156;16498.34006639721;16509.83490165107;16532;8168.469049511763;8316.542590157478;8357.498550087013;8414.200650938152;8489.533075680896;7837.451378403571;7924.167962363984;7924.76225713218;8011.319037881729;8021.478603890729;4942.654014218971;5028.296038554606;5061.620378471555;5101.132807422747;5132.332796736475;1946.2117842273901;2035.5725297687354;2056.187805816694;2069.3481553310658;2078.3557097299886;926.6525053105086;1017.399734156851;1049.1187402581868;1072.1529991306936;1113.0761467981556;19448.513787155152;20048.59902801936;20179.899100504404;20437.89781051085;20493.180272788923;1013.1843865688045;1030.1810061001522;1031.231732359397;1056.3292309383596;1060.226034994443;10832.67501974942;11245.437728113562;11304.03915667161;11436;11468.598599048993;365816;369323;373203;476775;493863;98053.50973245088;103138.48430757948;105392.47303763432;105590.47204764081;107886;1054.2198772907993;1071.1591400750374;1090.5910283643475;1097.3306283167262;1104.6630777612745;17909.19408626641;18018.36935707244;18365.90817045906;18378.356757513422;18441.506610127213;44082.33876491919;44474.555254448336;44630.55369446264;44695;44782.3282650767;61436;61477;62130.689346554784;64127.35872641214;64569.35430645821;8654.913450865412;8836.381453298207;9045.728628141167;9125.498097604695;9133.132352426508;9993.850092248767;13370.532031379244;13452.260125693181;13635.931820341231;13650.317484125953;11674.533018679158;11873.346965916957;11890.702732431759;11909.344986025852;12376;11189.552417903193;11473.885261147281;11906.702332441759;12204.32876191818;12260.26438413698;12177.573784917486;12207.206531575419;12276.938615306866;12290.139690221598;12588.685282867635;8830.161134692195;8900.866487002571;8910.688125915562;8954.28365730753;9203.539823008956;11981.400929953294;12008.459619316976;12104.27374357506;12223.75552488963;12251.448684809027 13:54:44 INFO - PROCESS | 14233 | |3;mootools.html;1389.159558467128;1562.7108984837803;1593.872490200784;1770.6989811732005;1892.82964533192;8744.693935712252;8909.643614255421;8926.285897128231;9130;9142.085791420855;8928.107189281069;9155.725328240163;9419.43483390997;9422.811543769121;9427.1986881115;2231.8102961248314;2390.414348484615;2474.938126546833;2481.9131330403393;2540.0220914947786;2489.5394352044927;2495.0394098272113;2502.461970676304;2504.511620234046;2511.1462102885016;2434.294054724128;2456.336789066951;2461.4584791345965;2462.113639089926;2463.6550882876413;2166.8916554172306;2408.3015925381533;2478.21936090131;2478.24413553866;2493.2270995991303;2428.1865575032384;2436.476157626119;2443.780059794627;2451.6935383077116;2454.349597356702;9213;9260.722178334661;9290.1174388433;9303.209227215628;9316.580753866092;5582.469665381823;5672;5677.772889084432;5688.11834165705;5695.544356451515;3379.290349026707;3437.415639341318;3454.084667563098;3522.4011917974008;3534.416821224495;1112.8942750438696;1145.587588468151;1147.925384849982;1161.680537852089;1164.992281676344;13789.241591712453;14061.156330620195;14078.155310681392;14087.084339517898;14098.92950535251;4947.777350019258;4962.106820772296;4989.052080104769;5174.818881339135;5210.47895210476;11667.6499705009;11696.590619328283;11710.297382156927;11712;11717;5098.643094983316;5731.742071606787;5732.05421105513;5740.856478587985;5742.913856292159;5068.6451948364;5161.122609156452;5224.92162617561;5246.23929530216;5247.291615631917;4358.738475691469;4369.4101296325225;4376.934345984812;4381.16757816014;4471.150481408522;1350.770369037266;1373.6085215713474;1384.3286006286942;1398.5524632117624;1398.8810951069272;1037.2376303416982;1037.5123691864812;1044.1490185498794;1051.0540513537876;1053.6522947427331;6019.668918209453;6152.630842149485;6159.476444502267;6224.719887605069;6321.841953951096;509.6101482365993;509.8011775407594;515.9458256882973;1013.2350075692805;1051.3113910388709;4404.119176164716;4421.945137157108;4459.509453960127;4484.1255955088445;4493.640508759291;11858.88141118595;12239.877601224052;12253.387330633434;12254.81617775734;12278.877211227951;11992.340421276738;12056.397180140957;12152.149349545623;12166.270023798601;12172.20880642773;8844.513551754715;9030.548472576345;9171.220446262143;9172.220361269234;9188.356815023018;6490.383413575702;6607.744528539562;6640.966795165993;6681.398674119353;6698.095757072928;10893.618723344962;11064.723381915195;11256.268342557707;11343;11384.829227561428;11307.773844522899;11319;11541.192116551762;11623.418829058344;11664.94167529157;7811.765647030598;8107.716229931924;8310.168983101641;8407.789805254917;8567.228949394585;9091.59087841062;9093.090690931118;9128.863067053866;9150.954245228731;9165.404248723811;8100.2304781045705;8239.670413183405;8245.13426090252;8304.875426868723;8454.239118479367;7976.840463190588;7979.601019949096;7988.760337189894;8026.2375074370175;8097.595120243846;7260.801967675275;7348.926510734825;7355.742549010759;7540.434467415075;7544.849103017799;5385.192221166856;5411.431799661136;5476.849861529124;5520.1443776214755;5569.220309156803;5467.343918729778;5486.31421072366;5548.472895074961;5550.5282051026115;5761.107028410603 13:54:44 INFO - PROCESS | 14233 | |4;prototype.html;355.7794167616077;356.6006073198018;365.9505966694496;367.18118595531945;370.3833117858765;5344.946550534493;5508.9173662395;5572.442755724425;5644.153376993453;5657.773689052438;5515.172724091388;5551.195076713874;5564.916526252109;5566;5591.608587398884;4309.245881970651;4315.956840431587;4320.438343015404;4341.826326946918;4374.628156606692;4216.156768646268;4271.722338048033;4335.934960975588;4339.370791235269;4344.870333713242;4235.644593730008;4235.703500754948;4276.2516559601945;4282.8008157715885;4307.483102027761;4257.446531950842;4269.231538323101;4273.529911709709;4275.824148359211;4286.76422796746;3547.5742910850604;3793.2034272802744;3798.829052692608;3799.5440547134244;3803.003423202813;5288.391834938954;5289.735513224324;5334.866628334284;5335.359756829205;5336;4912.189488734354;4914.385701787277;4922.286268491049;4923.532264434873;4941.20940649498;5572;5772.365039845614;5798.636790661406;5801.506871915893;5814.854628634275;4090.5091389033505;4136.8138433770555;4145.8963525911795;4147.460830092069;4148.709590328678;5934.1692163097205;5949.9702501487645;5968.194293770329;5984.8753692438995;6013.909791353133;4033.4756481657196;4219.240536703362;4230.70385073042;4245.087306229176;4247.23549761046;4257.87226383209;4280.91438171241;4286.464191976003;4288.5711428857485;4304.677149213821;4844.75776211188;4879.512048795092;4886.315915771795;4910.078503290536;4931.767058235441;5608.803691870765;5740.138979153077;5750.1949727038245;5759.6832174229985;5775.451332123442;1439.2947455746819;1458.5915943535827;1474.9115053096848;1476.6898951220148;1482.7627579587215;932.7807965128189;934.0052843721551;944.6976967370375;946.588234118147;947.8056998315329;5050.924236136461;5062.633089065932;5118.820841270538;5146.066741957124;5152.458991805881;5358.732063396815;5363.141897296414;5389.51494365509;5392.892142157135;5425.891482170335;5055.216441451581;5078.984203159383;5096.413912400048;5286.762095705702;5769.711514424262;3123.515855042472;3134.670859559759;3142.575752273414;3162.9367412652077;3180.5865237518974;6062.302835174011;6205.627662340184;6213.65824879636;6218.160548326008;6238.220222472191;6006.939930600725;6007.519398448114;6065.939340606537;6070.605410648293;6088.665123418255;6102.52847596724;6160.815175544741;6176.505879529716;6186.505079593621;6216.844578885473;5649.774009039593;5987;6002.56895957138;6004.789832355847;6018.3680713524445;5882.7058647066615;5921.3782552831335;5936.940630593812;5966.70166491665;5974.970125149346;5972.522198224218;6166.242620853035;6194.287656919512;6231.594946328474;6273.745250949737;4272.188284225987;4295.625399872011;4302.118065796567;4323.589259020388;4330.17726631939;6016.398360163948;6018.789342372996;6022.156898034191;6042.969785151222;6062;5651.88696226065;5804.361520232856;5858.88681150597;5927.288725352985;5945.494632956247;5778.94221057784;5794.2177805997335;5800.738966746591;5802.404338806862;5817.854553636193;5703.771849125988;5720.598453378949;5732.856678582902;5734.05388110957;5766.798162064308;5586.553075754011;5780.21967034445;5840.532757379315;5850.7074646266665;5856.648601083949;5701.743421545957;5722.140304401003;5728.677367126973;5737.540996720336;5760.683162425939 13:54:44 INFO - PROCESS | 14233 | |5;yui.html;758.1698040645491;807.2936180841764;820.7578764264541;839.3033781960972;879.3141349747195;14986.550403487885;17385;17433.651326973486;17437.30250789967;17438.651226975453;14795.26023698816;14821.851781482183;14846.109233446;14856.55430337089;14889.106653600791;720.6576875983918;842.7429633961655;844.6199210355334;886.5079880666227;889.7953470701742;878.8637761147032;879.6965047058754;884.0319849764497;884.5002573545926;884.7213127864702;758.9089309282894;889.9599518021705;930.2790337488433;931.0549791961165;931.2131249094505;915.50562696144;916.3493919317226;916.9403988740744;917.1241464401547;917.2386918857333;676.2932735291632;677.1772296659533;677.4546490075487;677.5257319876057;677.6611694152923;16987.49037528864;17045.573860653458;17095.658086838193;17118;17120.74318885218;15082.622934426618;15123;15149.469768558047;15231.162286074261;15306.005109667836;12636;12708.745825083446;12850.357482125857;14636.487722929647;15163.62090947724;4784.449788274358;4959.504049595012;5035.59715222785;5039.84880453587;5071.974640126776;82416.58791706063;82886.58556707238;83739.5813020931;84463;85403;12076.698082548006;12120.454579543766;12169.817452738216;12350.135490515577;12398.25610463357;21301;21508.677369839465;22220.55558888813;22221.888890555445;23219.419514512272;9069.77325566866;9217.76955576116;9309.860352094589;9341.719748407559;9588.808223835484;4884.291777692286;4937.644433819436;5007.599392048627;5012.072766538202;5183.352080989876;4081.9387709184384;4208.9688026433105;4290.592393722592;4474.7762611869275;4478.283474644041;694.531191445772;738.1732459645232;777.945543811939;785.6346798738614;799.6641410607559;686.2588404523103;693.2132030145821;734.6454612965433;758.6093162021564;802.9518228906285;10665.9466702666;10992.120630349553;11083.50124244411;11089.33463992163;11241.494132764044;604.7036951893629;671.1811589860363;674.6930146783202;711.3810984443464;733.5561984998999;5019.14674505335;5206.8958620828125;5237.162054071407;5254.65844720092;5268.28878101459;53256.20115698268;53616.463835361144;53721;97994.5100274494;99988.50005749924;95265;101779.49110254401;102424;102685;105141;85604.57197714096;88427.557862209;92667;92973.53513232525;93077.5346123265;10391.688249352532;10689.470871191714;10782.137429005505;10791.082757965662;10896.61861834832;45008.549914500436;45339;51185.36363953784;51897.22154167766;55170.72414637901;75586.62206688931;76580;79003.60498197473;79335;80556.59721701354;13427.19436833793;13942.860571394562;13983.300834958009;14323.713525729636;14510.274486275433;14605.707885842012;15232.695346093238;15299.77050344268;15910.7613385797;16044.759328609847;14079.859201407855;14499.85500144985;15352.769708454605;15407.61480962985;15568.455104071303;14884;15033.849661503245;15330.693386131992;15381.15403652765;15678.843211568195;14371.92814035923;14431.49489767853;14615.123092614052;15131.848681513044;15228.390864365301;11432.371219583003;11464.484098215433;11749.29504229749;12159.75680486403;12378.133530652767;12284.201526900722;12503.249805011728;12534;12534.185277956904;12628 13:54:44 INFO - PROCESS | 14233 | __end_tp_report 13:54:44 INFO - PROCESS | 14233 | __start_cc_report 13:54:44 INFO - PROCESS | 14233 | _x_x_mozilla_cycle_collect,850 13:54:44 INFO - PROCESS | 14233 | __end_cc_report 13:54:44 INFO - PROCESS | 14233 | __startTimestamp1465505684832__endTimestamp 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | ------- Summary: start ------- 13:54:44 INFO - PROCESS | 14233 | Number of tests: 6 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | [#0] dojo.html Cycles:165 Average:5618.44 Median:5800.65 stddev:642.49 (11.1%) stddev-sans-first:618.63 13:54:44 INFO - PROCESS | 14233 | Values: 3319.3 3351.0 3353.6 3372.5 3406.8 5501.0 5645.1 5671.5 5678.3 5692.5 5537.1 5567.7 5594.4 5600.6 5615.7 4994.8 5022.3 5028.0 5045.5 5088.8 5081.9 5147.8 5148.6 5149.6 5150.4 5028.8 5064.1 5082.3 5094.7 5104.5 5127.6 5147.2 5169.6 5180.6 5205.8 5010.2 5067.9 5070.2 5091.8 5132.1 5531.9 5543.7 5566.9 5596.5 5609.1 6117.5 6138.4 6138.5 6139.6 6148.4 6030.2 6077.7 6088.6 6124.0 6150.7 5689.5 5729.0 5733.5 5739.4 5746.1 5982.3 6206.7 6222.5 6224.7 6227.0 5890.9 5945.8 5946.7 6036.9 6047.1 6105.3 6106.6 6108.9 6125.3 6128.0 5859.4 5945.8 6039.1 6049.2 6050.9 5993.3 6053.6 6063.0 6067.8 6110.4 4603.5 4611.1 4616.7 4618.6 4641.2 4062.9 4066.3 4087.1 4130.1 4138.3 5745.5 5761.9 5785.4 5786.0 5798.4 6020.4 6061.2 6066.5 6077.8 6092.3 5651.2 5661.0 5671.2 5771.5 5774.3 5187.8 5195.2 5201.4 5203.5 5208.1 6266.7 6271.2 6271.9 6278.3 6285.2 5963.2 5989.5 6024.5 6052.4 6054.0 6262.6 6270.1 6300.1 6302.5 6317.8 6006.5 6008.8 6009.2 6020.4 6044.3 5914.9 6025.0 6048.1 6073.1 6133.2 5938.9 5991.8 6003.5 6005.0 6005.2 5922.4 5961.3 5980.1 5997.7 6004.5 5649.6 5725.2 5748.0 5758.3 5789.2 5884.4 5941.5 5941.7 5943.7 5953.7 5675.6 5795.2 5800.7 5808.3 5808.8 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | [#1] ext.html Cycles:180 Average:51243.23 Median:21016.16 stddev:90940.47 (432.7%) stddev-sans-first:91116.08 13:54:44 INFO - PROCESS | 14233 | Values: 597.3 646.7 650.3 653.3 663.3 33958.5 46274.3 46801.8 46955.3 46960.8 48557.8 49091.0 49171.3 49183.5 49185.8 8504.5 9081.0 9277.5 9278.3 10933.5 10618.9 11051.1 11057.6 11059.4 11065.2 11124.4 11189.4 11198.9 11201.1 11206.7 8570.4 11010.7 11136.6 11335.7 11351.1 10716.5 11147.9 11159.4 11173.8 11177.8 46554.1 47007.0 47100.0 47140.3 47320.8 3654.1 3671.7 3680.0 3683.2 3698.1 35576.6 35907.6 36326.3 36331.8 36732.3 4492.3 4498.3 4598.3 4620.4 4700.6 385669.0 386221.0 389472.0 389714.0 390040.0 39165.8 40495.6 71056.3 72022.0 72054.0 41978.8 42010.6 42211.2 42234.6 42246.6 16458.3 16697.2 16703.2 16704.2 16709.4 12017.2 13241.0 13390.3 13406.7 13713.0 9324.4 9434.6 9436.4 9465.9 9502.1 3552.5 3577.6 3586.8 3634.7 3654.9 1060.8 1089.3 1147.6 1174.4 1180.4 33716.2 34236.0 34511.8 34546.5 34763.7 1144.5 1226.3 1248.5 1257.4 1258.6 17767.6 18095.3 18179.5 18238.0 18284.2 159317.2 159875.0 161509.0 161853.0 161921.2 62624.0 63363.7 63403.0 63406.0 63470.4 1346.9 1421.0 1447.5 1464.1 1472.4 33291.5 34572.8 34973.7 34992.7 35267.0 52633.5 53131.0 53234.2 53327.7 53411.5 420424.0 420464.0 421953.0 423068.0 423682.0 27763.4 31781.4 32711.2 33054.3 33145.2 50802.0 51621.5 52580.7 52733.7 53036.0 43024.0 43073.0 43351.8 43444.3 43815.6 43516.8 43542.8 43596.0 44335.3 44638.8 43546.8 43570.0 43657.8 44264.0 44451.1 38334.2 39040.4 39135.8 39592.0 39635.8 29225.9 29696.7 29718.4 29779.7 30043.2 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | [#2] jquery.html Cycles:180 Average:27756.30 Median:11825.36 stddev:69966.45 (591.7%) stddev-sans-first:70132.59 13:54:44 INFO - PROCESS | 14233 | Values: 408.0 425.4 429.6 432.8 433.2 18911.8 20483.2 20531.5 20702.5 21544.8 19674.2 19956.7 20254.6 20605.7 20651.5 5655.4 5871.2 5909.6 5912.3 5914.0 4338.0 5135.4 5849.2 6590.4 6605.8 6532.8 6600.2 6623.6 6646.9 6655.7 6381.6 6514.4 6523.4 6564.1 6568.3 3937.1 5493.6 5714.4 5796.5 5818.8 23657.2 23876.2 23990.5 24169.8 24419.0 2493.3 2495.0 2550.4 2807.0 2956.9 10028.3 10247.9 10615.5 14337.1 15534.7 1993.5 2029.6 2051.0 2057.8 2105.9 67643.7 68630.0 80201.0 83353.0 85578.6 11098.8 11483.9 11584.4 11726.1 11796.9 16326.5 16430.1 16498.3 16509.8 16532.0 8168.5 8316.5 8357.5 8414.2 8489.5 7837.5 7924.2 7924.8 8011.3 8021.5 4942.7 5028.3 5061.6 5101.1 5132.3 1946.2 2035.6 2056.2 2069.3 2078.4 926.7 1017.4 1049.1 1072.2 1113.1 19448.5 20048.6 20179.9 20437.9 20493.2 1013.2 1030.2 1031.2 1056.3 1060.2 10832.7 11245.4 11304.0 11436.0 11468.6 365816.0 369323.0 373203.0 476775.0 493863.0 98053.5 103138.5 105392.5 105590.5 107886.0 1054.2 1071.2 1090.6 1097.3 1104.7 17909.2 18018.4 18365.9 18378.4 18441.5 44082.3 44474.6 44630.6 44695.0 44782.3 61436.0 61477.0 62130.7 64127.4 64569.4 8654.9 8836.4 9045.7 9125.5 9133.1 9993.9 13370.5 13452.3 13635.9 13650.3 11674.5 11873.3 11890.7 11909.3 12376.0 11189.6 11473.9 11906.7 12204.3 12260.3 12177.6 12207.2 12276.9 12290.1 12588.7 8830.2 8900.9 8910.7 8954.3 9203.5 11981.4 12008.5 12104.3 12223.8 12251.4 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | [#3] mootools.html Cycles:180 Average:6282.58 Median:4488.88 stddev:3685.95 (82.1%) stddev-sans-first:3677.95 13:54:44 INFO - PROCESS | 14233 | Values: 1389.2 1562.7 1593.9 1770.7 1892.8 8744.7 8909.6 8926.3 9130.0 9142.1 8928.1 9155.7 9419.4 9422.8 9427.2 2231.8 2390.4 2474.9 2481.9 2540.0 2489.5 2495.0 2502.5 2504.5 2511.1 2434.3 2456.3 2461.5 2462.1 2463.7 2166.9 2408.3 2478.2 2478.2 2493.2 2428.2 2436.5 2443.8 2451.7 2454.3 9213.0 9260.7 9290.1 9303.2 9316.6 5582.5 5672.0 5677.8 5688.1 5695.5 3379.3 3437.4 3454.1 3522.4 3534.4 1112.9 1145.6 1147.9 1161.7 1165.0 13789.2 14061.2 14078.2 14087.1 14098.9 4947.8 4962.1 4989.1 5174.8 5210.5 11667.6 11696.6 11710.3 11712.0 11717.0 5098.6 5731.7 5732.1 5740.9 5742.9 5068.6 5161.1 5224.9 5246.2 5247.3 4358.7 4369.4 4376.9 4381.2 4471.2 1350.8 1373.6 1384.3 1398.6 1398.9 1037.2 1037.5 1044.1 1051.1 1053.7 6019.7 6152.6 6159.5 6224.7 6321.8 509.6 509.8 515.9 1013.2 1051.3 4404.1 4421.9 4459.5 4484.1 4493.6 11858.9 12239.9 12253.4 12254.8 12278.9 11992.3 12056.4 12152.1 12166.3 12172.2 8844.5 9030.5 9171.2 9172.2 9188.4 6490.4 6607.7 6641.0 6681.4 6698.1 10893.6 11064.7 11256.3 11343.0 11384.8 11307.8 11319.0 11541.2 11623.4 11664.9 7811.8 8107.7 8310.2 8407.8 8567.2 9091.6 9093.1 9128.9 9151.0 9165.4 8100.2 8239.7 8245.1 8304.9 8454.2 7976.8 7979.6 7988.8 8026.2 8097.6 7260.8 7348.9 7355.7 7540.4 7544.8 5385.2 5411.4 5476.8 5520.1 5569.2 5467.3 5486.3 5548.5 5550.5 5761.1 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | [#4] prototype.html Cycles:180 Average:4848.51 Median:5512.05 stddev:1430.58 (26.0%) stddev-sans-first:1394.29 13:54:44 INFO - PROCESS | 14233 | Values: 355.8 356.6 366.0 367.2 370.4 5344.9 5508.9 5572.4 5644.2 5657.8 5515.2 5551.2 5564.9 5566.0 5591.6 4309.2 4316.0 4320.4 4341.8 4374.6 4216.2 4271.7 4335.9 4339.4 4344.9 4235.6 4235.7 4276.3 4282.8 4307.5 4257.4 4269.2 4273.5 4275.8 4286.8 3547.6 3793.2 3798.8 3799.5 3803.0 5288.4 5289.7 5334.9 5335.4 5336.0 4912.2 4914.4 4922.3 4923.5 4941.2 5572.0 5772.4 5798.6 5801.5 5814.9 4090.5 4136.8 4145.9 4147.5 4148.7 5934.2 5950.0 5968.2 5984.9 6013.9 4033.5 4219.2 4230.7 4245.1 4247.2 4257.9 4280.9 4286.5 4288.6 4304.7 4844.8 4879.5 4886.3 4910.1 4931.8 5608.8 5740.1 5750.2 5759.7 5775.5 1439.3 1458.6 1474.9 1476.7 1482.8 932.8 934.0 944.7 946.6 947.8 5050.9 5062.6 5118.8 5146.1 5152.5 5358.7 5363.1 5389.5 5392.9 5425.9 5055.2 5079.0 5096.4 5286.8 5769.7 3123.5 3134.7 3142.6 3162.9 3180.6 6062.3 6205.6 6213.7 6218.2 6238.2 6006.9 6007.5 6065.9 6070.6 6088.7 6102.5 6160.8 6176.5 6186.5 6216.8 5649.8 5987.0 6002.6 6004.8 6018.4 5882.7 5921.4 5936.9 5966.7 5975.0 5972.5 6166.2 6194.3 6231.6 6273.7 4272.2 4295.6 4302.1 4323.6 4330.2 6016.4 6018.8 6022.2 6043.0 6062.0 5651.9 5804.4 5858.9 5927.3 5945.5 5778.9 5794.2 5800.7 5802.4 5817.9 5703.8 5720.6 5732.9 5734.1 5766.8 5586.6 5780.2 5840.5 5850.7 5856.6 5701.7 5722.1 5728.7 5737.5 5760.7 13:54:44 INFO - PROCESS | 14233 | 13:54:44 INFO - PROCESS | 14233 | [#5] yui.html Cycles:180 Average:20663.54 Median:25061.72 stddev:28014.15 (111.8%) stddev-sans-first:28052.86 13:54:44 INFO - PROCESS | 14233 | Values: 758.2 807.3 820.8 839.3 879.3 14986.6 17385.0 17433.7 17437.3 17438.7 14795.3 14821.9 14846.1 14856.6 14889.1 720.7 842.7 844.6 886.5 889.8 878.9 879.7 884.0 884.5 884.7 758.9 890.0 930.3 931.1 931.2 915.5 916.3 916.9 917.1 917.2 676.3 677.2 677.5 677.5 677.7 16987.5 17045.6 17095.7 17118.0 17120.7 15082.6 15123.0 15149.5 15231.2 15306.0 12636.0 12708.7 12850.4 14636.5 15163.6 4784.4 4959.5 5035.6 5039.8 5072.0 82416.6 82886.6 83739.6 84463.0 85403.0 12076.7 12120.5 12169.8 12350.1 12398.3 21301.0 21508.7 22220.6 22221.9 23219.4 9069.8 9217.8 9309.9 9341.7 9588.8 4884.3 4937.6 5007.6 5012.1 5183.4 4081.9 4209.0 4290.6 4474.8 4478.3 694.5 738.2 777.9 785.6 799.7 686.3 693.2 734.6 758.6 803.0 10665.9 10992.1 11083.5 11089.3 11241.5 604.7 671.2 674.7 711.4 733.6 5019.1 5206.9 5237.2 5254.7 5268.3 53256.2 53616.5 53721.0 97994.5 99988.5 95265.0 101779.5 102424.0 102685.0 105141.0 85604.6 88427.6 92667.0 92973.5 93077.5 10391.7 10689.5 10782.1 10791.1 10896.6 45008.5 45339.0 51185.4 51897.2 55170.7 75586.6 76580.0 79003.6 79335.0 80556.6 13427.2 13942.9 13983.3 14323.7 14510.3 14605.7 15232.7 15299.8 15910.8 16044.8 14079.9 14499.9 15352.8 15407.6 15568.5 14884.0 15033.8 15330.7 15381.2 15678.8 14371.9 14431.5 14615.1 15131.8 15228.4 11432.4 11464.5 11749.3 12159.8 12378.1 12284.2 12503.2 12534.0 12534.2 12628.0 13:54:44 INFO - PROCESS | 14233 | -------- Summary: end -------- 13:54:44 INFO - PROCESS | 14233 | 13:54:45 INFO - TEST-INFO | 14233: exit 0 13:54:45 INFO - TEST-OK | dromaeo_css | took 1113742ms 13:54:45 INFO - TEST-START | kraken 13:54:45 INFO - operating with platform_type : linux_ 13:54:45 INFO - Initialising browser for kraken test... 13:54:45 INFO - TEST-INFO | started process 14426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGX7LMn/profile http://localhost:50087/getInfo.html) 13:54:49 INFO - PROCESS | 14426 | __metrics Screen width/height:1600/1200 13:54:49 INFO - PROCESS | 14426 | colorDepth:24 13:54:49 INFO - PROCESS | 14426 | Browser inner width/height: 1024/697 13:54:49 INFO - PROCESS | 14426 | __metrics 13:54:50 ERROR - PROCESS | 14426 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:54:50 INFO - PROCESS | 14426 | console.error: PushService: 13:54:50 INFO - PROCESS | 14426 | stateChangeProcessEnqueue: Error transitioning state 13:54:50 INFO - PROCESS | 14426 | UnknownError 13:54:51 INFO - TEST-INFO | 14426: exit 0 13:54:51 INFO - Browser initialized. 13:54:51 INFO - Running cycle 1/1 for kraken test... 13:54:51 INFO - TEST-INFO | started process 14519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGX7LMn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:03 INFO - PROCESS | 14519 | RSS: Main: 148213760 13:55:03 INFO - PROCESS | 14519 | 13:55:05 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50087/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:06 INFO - PROCESS | 14519 | RSS: Main: 197976064 13:55:06 INFO - PROCESS | 14519 | 13:55:09 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50087/tests/kraken/driver.html?testName=audio-dft) 13:55:09 INFO - PROCESS | 14519 | RSS: Main: 195461120 13:55:09 INFO - PROCESS | 14519 | 13:55:12 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50087/tests/kraken/driver.html?testName=audio-fft) 13:55:13 INFO - PROCESS | 14519 | RSS: Main: 282112000 13:55:13 INFO - PROCESS | 14519 | 13:55:15 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50087/tests/kraken/driver.html?testName=audio-oscillator) 13:55:15 INFO - PROCESS | 14519 | RSS: Main: 191254528 13:55:15 INFO - PROCESS | 14519 | 13:55:18 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:55:18 INFO - PROCESS | 14519 | RSS: Main: 191733760 13:55:18 INFO - PROCESS | 14519 | 13:55:21 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50087/tests/kraken/driver.html?testName=imaging-darkroom) 13:55:22 INFO - PROCESS | 14519 | RSS: Main: 226365440 13:55:22 INFO - PROCESS | 14519 | 13:55:25 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50087/tests/kraken/driver.html?testName=imaging-desaturate) 13:55:26 INFO - PROCESS | 14519 | RSS: Main: 225726464 13:55:26 INFO - PROCESS | 14519 | 13:55:29 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50087/tests/kraken/driver.html?testName=json-parse-financial) 13:55:29 INFO - PROCESS | 14519 | RSS: Main: 226091008 13:55:29 INFO - PROCESS | 14519 | 13:55:31 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:55:31 INFO - PROCESS | 14519 | RSS: Main: 204562432 13:55:31 INFO - PROCESS | 14519 | 13:55:33 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:55:34 INFO - PROCESS | 14519 | RSS: Main: 206635008 13:55:34 INFO - PROCESS | 14519 | 13:55:36 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:55:36 INFO - PROCESS | 14519 | RSS: Main: 212193280 13:55:36 INFO - PROCESS | 14519 | 13:55:39 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:55:39 INFO - PROCESS | 14519 | RSS: Main: 213901312 13:55:39 INFO - PROCESS | 14519 | 13:55:42 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:55:43 INFO - PROCESS | 14519 | RSS: Main: 213504000 13:55:43 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | Cycle 1(1): loaded http://localhost:50087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50087/tests/kraken/driver.html?testName=ai-astar) 13:55:44 INFO - PROCESS | 14519 | RSS: Main: 255836160 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | __start_tp_report 13:55:44 INFO - PROCESS | 14519 | _x_x_mozilla_page_load 13:55:44 INFO - PROCESS | 14519 | _x_x_mozilla_page_load_details 13:55:44 INFO - PROCESS | 14519 | |i|pagename|runs| 13:55:44 INFO - PROCESS | 14519 | |0;ai-astar;109;103;110;110;109;109;111;111;111;109 13:55:44 INFO - PROCESS | 14519 | |1;audio-beat-detection;161;123;128;191;124;124;153;124;187;132 13:55:44 INFO - PROCESS | 14519 | |2;audio-dft;160;161;162;161;161;160;163;160;160;162 13:55:44 INFO - PROCESS | 14519 | |3;audio-fft;76;75;76;111;75;76;74;75;98;74 13:55:44 INFO - PROCESS | 14519 | |4;audio-oscillator;85;84;116;83;85;83;120;83;84;129 13:55:44 INFO - PROCESS | 14519 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 13:55:44 INFO - PROCESS | 14519 | |6;imaging-darkroom;145;146;145;146;146;146;146;146;146;147 13:55:44 INFO - PROCESS | 14519 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;94 13:55:44 INFO - PROCESS | 14519 | |8;json-parse-financial;51;50;52;51;51;56;52;52;50;51 13:55:44 INFO - PROCESS | 14519 | |9;json-stringify-tinderbox;60;60;59;59;60;59;60;60;59;62 13:55:44 INFO - PROCESS | 14519 | |10;stanford-crypto-aes;76;76;77;75;77;78;76;77;103;75 13:55:44 INFO - PROCESS | 14519 | |11;stanford-crypto-ccm;118;119;117;132;127;123;126;121;130;126 13:55:44 INFO - PROCESS | 14519 | |12;stanford-crypto-pbkdf2;153;151;157;152;163;152;151;152;151;149 13:55:44 INFO - PROCESS | 14519 | |13;stanford-crypto-sha256-iterative;63;60;61;62;62;64;64;61;59;63 13:55:44 INFO - PROCESS | 14519 | __end_tp_report 13:55:44 INFO - PROCESS | 14519 | __start_cc_report 13:55:44 INFO - PROCESS | 14519 | _x_x_mozilla_cycle_collect,1573 13:55:44 INFO - PROCESS | 14519 | __end_cc_report 13:55:44 INFO - PROCESS | 14519 | __startTimestamp1465505744889__endTimestamp 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | ------- Summary: start ------- 13:55:44 INFO - PROCESS | 14519 | Number of tests: 14 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.35 (2.1%) stddev-sans-first:2.49 13:55:44 INFO - PROCESS | 14519 | Values: 109.0 103.0 110.0 110.0 109.0 109.0 111.0 111.0 111.0 109.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:142.50 stddev:26.80 (18.8%) stddev-sans-first:27.77 13:55:44 INFO - PROCESS | 14519 | Values: 161.0 123.0 128.0 191.0 124.0 124.0 153.0 124.0 187.0 132.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 13:55:44 INFO - PROCESS | 14519 | Values: 160.0 161.0 162.0 161.0 161.0 160.0 163.0 160.0 160.0 162.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:12.78 (16.9%) stddev-sans-first:13.43 13:55:44 INFO - PROCESS | 14519 | Values: 76.0 75.0 76.0 111.0 75.0 76.0 74.0 75.0 98.0 74.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:83.50 stddev:18.55 (22.2%) stddev-sans-first:19.30 13:55:44 INFO - PROCESS | 14519 | Values: 85.0 84.0 116.0 83.0 85.0 83.0 120.0 83.0 84.0 129.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:55:44 INFO - PROCESS | 14519 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 13:55:44 INFO - PROCESS | 14519 | Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:55:44 INFO - PROCESS | 14519 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:1.71 (3.3%) stddev-sans-first:1.80 13:55:44 INFO - PROCESS | 14519 | Values: 51.0 50.0 52.0 51.0 51.0 56.0 52.0 52.0 50.0 51.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 13:55:44 INFO - PROCESS | 14519 | Values: 60.0 60.0 59.0 59.0 60.0 59.0 60.0 60.0 59.0 62.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:76.50 stddev:8.49 (11.1%) stddev-sans-first:8.93 13:55:44 INFO - PROCESS | 14519 | Values: 76.0 76.0 77.0 75.0 77.0 78.0 76.0 77.0 103.0 75.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:126.00 stddev:5.13 (4.1%) stddev-sans-first:4.98 13:55:44 INFO - PROCESS | 14519 | Values: 118.0 119.0 117.0 132.0 127.0 123.0 126.0 121.0 130.0 126.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:152.00 stddev:4.04 (2.7%) stddev-sans-first:4.28 13:55:44 INFO - PROCESS | 14519 | Values: 153.0 151.0 157.0 152.0 163.0 152.0 151.0 152.0 151.0 149.0 13:55:44 INFO - PROCESS | 14519 | 13:55:44 INFO - PROCESS | 14519 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.50 stddev:1.66 (2.7%) stddev-sans-first:1.72 13:55:44 INFO - PROCESS | 14519 | Values: 63.0 60.0 61.0 62.0 62.0 64.0 64.0 61.0 59.0 63.0 13:55:44 INFO - PROCESS | 14519 | -------- Summary: end -------- 13:55:44 INFO - PROCESS | 14519 | 13:55:45 INFO - TEST-INFO | 14519: exit 0 13:55:45 INFO - TEST-OK | kraken | took 60300ms 13:55:45 INFO - SUITE-END | took 1174s 13:55:46 INFO - Completed test suite (00:19:34) 13:55:46 INFO - javascript benchmark 13:55:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.319539494403, 3350.9832450837744, 3353.5975682918047, 3372.477266023764, 3406.795592264464, 5500.972495137524, 5645.096784514473, 5671.461211184941, 5678.346990096145, 5692.459216374448, 5537.1140617501205, 5567.66594004359, 5594.440555944404, 5600.6079574429805, 5615.719214039302, 4994.775235114428, 5022.296878437012, 5028.044671512419, 5045.470225626312, 5088.771005304751, 5081.923771143436, 5147.8455646330485, 5148.6395952283165, 5149.613778966574, 5150.356205474316, 5028.7737051832755, 5064.088464076464, 5082.263071854579, 5094.668846524983, 5104.464031276718, 5127.641065125443, 5147.202183661539, 5169.612279079084, 5180.585553155738, 5205.791768329263, 5010.173321401964, 5067.949320506785, 5070.2141168119, 5091.79632814687, 5132.076226279269, 5531.944680553183, 5543.695096769676, 5566.944330556724, 5596.496315331599, 5609.074502707049, 6117.4779379467245, 6138.447539721446, 6138.47822935051, 6139.631622102688, 6148.354422785588, 6030.155778191057, 6077.726502307407, 6088.6042407243385, 6123.969380153071, 6150.66171360575, 5689.459501347406, 5729.0260655688635, 5733.455321744427, 5739.426057394269, 5746.138079288056, 5982.282126144803, 6206.689665516707, 6222.502199824004, 6224.719887604978, 6226.968865155736, 5890.9410905891245, 5945.791897283574, 5946.70266486674, 6036.909446358308, 6047.0929360596265, 6105.267367915879, 6106.603070800384, 6108.860595101983, 6125.264968203844, 6127.969360153171, 5859.384764599741, 5945.762169513171, 6039.094135879565, 6049.153118563405, 6050.878982420327, 5993.31076926159, 6053.606515576474, 6063.0, 6067.848303792441, 6110.4195101466175, 4603.470600880874, 4611.054733779567, 4616.699914505546, 4618.607418369476, 4641.234196357631, 4062.878113656536, 4066.2883995300704, 4087.141700242923, 4130.070734084807, 4138.296489596776, 5745.511631511285, 5761.85595360111, 5785.421457854265, 5785.971070144622, 5798.420157984252, 6020.367861374581, 6061.151438798572, 6066.4540191382985, 6077.848053798691, 6092.329843717188, 5651.237082993825, 5660.971695141498, 5671.2060311556415, 5771.451712087345, 5774.2782152230975, 5187.766550505161, 5195.246689230116, 5201.375834899836, 5203.505666961632, 5208.114620514521, 6266.686665666698, 6271.247450305992, 6271.937280627227, 6278.30938596754, 6285.151504546919, 5963.224780778471, 5989.46094851448, 6024.518038556993, 6052.425019623129, 6053.969730151321, 6262.624242545462, 6270.122182894307, 6300.117983482408, 6302.527310451643, 6317.842053948504, 6006.459418652343, 6008.81973540777, 6009.188759517409, 6020.39796020412, 6044.274687037584, 5914.940850591439, 6024.969875150597, 6048.092786082123, 6073.119397687222, 6133.233345831771, 5938.910916336345, 5991.7603295867675, 6003.489703375088, 6005.0, 6005.159277701038, 5922.437368449991, 5961.284645842353, 5980.073088671263, 5997.70011499432, 6004.519638429003, 5649.576281778801, 5725.227094342211, 5747.971260143672, 5758.280214973129, 5789.1605717171615, 5884.440978107073, 5941.465268125889, 5941.702914854326, 5943.702814859326, 5953.732082056405, 5675.602707810579, 5795.217645617956, 5800.651960882361, 5808.332041815245, 5808.796692115756], "value": 5575.365750334573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.3220394851844, 646.689588997281, 650.3204151661514, 653.2552889705734, 663.3366633366632, 33958.49062264068, 46274.305885411704, 46801.76599117008, 46955.29567056493, 46960.765196174056, 48557.757211213895, 49091.0, 49171.262431063566, 49183.50816491834, 49185.754071229596, 8504.532250726208, 9081.0, 9277.536123193848, 9278.257739380868, 10933.507992140372, 10618.946905265462, 11051.115910727123, 11057.612983545578, 11059.391733454657, 11065.170112241574, 11124.443777811117, 11189.384583847885, 11198.888011119867, 11201.103911687087, 11206.663800086011, 8570.442921210102, 11010.669679909615, 11136.554537818478, 11335.716607084807, 11351.091912646969, 10716.517756700967, 11147.888521114766, 11159.442027898654, 11173.832392514038, 11177.770445251015, 46554.06891862178, 47007.0, 47100.0, 47140.29289560625, 47320.763396183145, 3654.14127679995, 3671.6511931366476, 3680.0, 3683.226522430293, 3698.0939669780805, 35576.644233557854, 35907.64092359095, 36326.27347453062, 36331.818340908394, 36732.26535469302, 4492.326151077332, 4498.302763071729, 4598.26427771555, 4620.422447194101, 4700.553447422523, 385669.0, 386221.0, 389472.0, 389714.0, 390040.0, 39165.80417097896, 40495.59504404977, 71056.289437106, 72022.0, 72054.0, 41978.79010604927, 42010.579894200666, 42211.1557768849, 42234.57765422368, 42246.57753422488, 16458.259378328003, 16697.248623811956, 16703.248353824107, 16704.24830882589, 16709.415170468976, 12017.158798883995, 13241.0, 13390.330483475787, 13406.664833379244, 13713.0, 9324.393914395543, 9434.622615095319, 9436.386634868712, 9465.90534094664, 9502.144806967406, 3552.5204097446513, 3577.58857731359, 3586.7668601540818, 3634.6547078027547, 3654.8903532894055, 1060.7878424315168, 1089.3028461784463, 1147.5524545427122, 1174.3775798826637, 1180.3508070561156, 33716.15709607279, 34236.0, 34511.82744086314, 34546.48180277298, 34763.65236347655, 1144.456383217965, 1226.2519862883635, 1248.4818800197816, 1257.4404390046525, 1258.6098309524077, 17767.644647106987, 18095.276188952295, 18179.54551136232, 18238.0, 18284.17721202549, 159317.20341398218, 159875.0, 161509.0, 161853.0, 161921.19039404727, 62624.0, 63363.683181583794, 63403.0, 63406.0, 63470.36529634737, 1346.865313468665, 1420.971580568383, 1447.486142419447, 1464.1142109023888, 1472.4404726203975, 33291.500627490124, 34572.82713586416, 34973.65026349704, 34992.65007349894, 35267.0, 52633.473665262856, 53131.0, 53234.20148697695, 53327.73336133295, 53411.4658853422, 420424.0, 420464.0, 421953.0, 423068.0, 423682.0, 27763.44473110486, 31781.364372711952, 32711.182220443727, 33054.338913222084, 33145.17137071592, 50802.0, 51621.48378516317, 52580.737096314275, 52733.7363313181, 53036.0, 43024.0, 43073.0, 43351.78324108359, 43444.348334775634, 43815.56184438115, 43516.78241608771, 43542.78228608837, 43596.0, 44335.33496997483, 44638.77680611576, 43546.78226608974, 43570.0, 43657.781711091244, 44264.0, 44451.11097778091, 38334.23331533298, 39040.41439378355, 39135.804320979354, 39592.0, 39635.80182099071, 29225.85387073051, 29696.703032970257, 29718.4121268788, 29779.702202977693, 30043.248918777204], "value": 19938.650345745973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.95104587449504, 425.4023097547946, 429.64983538416186, 432.8052376430607, 433.2245280947105, 18911.81088189118, 20483.18067277311, 20531.486712832186, 20702.482437939023, 21544.784552154473, 19674.213031478725, 19956.700649490234, 20254.59490810183, 20605.690914636292, 20651.483712907186, 5655.4061823508555, 5871.207387002764, 5909.586328956974, 5912.260967379078, 5914.024186009303, 4338.0, 5135.409427915782, 5849.210356601847, 6590.373914478141, 6605.768798092044, 6532.836679083037, 6600.174978127734, 6623.635700036496, 6646.867062658768, 6655.667216639173, 6381.553291269613, 6514.44627206688, 6523.380278873499, 6564.1138446309615, 6568.310327415625, 3937.1338305572726, 5493.615446918678, 5714.371419143891, 5796.536277097822, 5818.796342128047, 23657.171998980124, 23876.164334248217, 23990.520189596285, 24169.758302416925, 24419.0, 2493.339265094751, 2495.0, 2550.4006558458746, 2807.0, 2956.9260768480744, 10028.348157369821, 10247.897521024768, 10615.46922653872, 14337.139771613736, 15534.689306213926, 1993.5115896605425, 2029.553498230387, 2051.0360130738527, 2057.753069631639, 2105.9262925797525, 67643.66178169126, 68629.96031746031, 80201.0, 83353.0, 85578.57210713907, 11098.778024439465, 11483.885161148448, 11584.362860042778, 11726.061915046776, 11796.94101529487, 16326.510204693877, 16430.096344701156, 16498.34006639721, 16509.83490165107, 16532.0, 8168.469049511763, 8316.542590157478, 8357.498550087013, 8414.200650938152, 8489.533075680896, 7837.451378403571, 7924.167962363984, 7924.76225713218, 8011.319037881729, 8021.478603890729, 4942.654014218971, 5028.296038554606, 5061.620378471555, 5101.132807422747, 5132.332796736475, 1946.2117842273901, 2035.5725297687354, 2056.187805816694, 2069.3481553310658, 2078.3557097299886, 926.6525053105086, 1017.399734156851, 1049.1187402581868, 1072.1529991306936, 1113.0761467981556, 19448.513787155152, 20048.59902801936, 20179.899100504404, 20437.89781051085, 20493.180272788923, 1013.1843865688045, 1030.1810061001522, 1031.231732359397, 1056.3292309383596, 1060.226034994443, 10832.67501974942, 11245.437728113562, 11304.03915667161, 11436.0, 11468.598599048993, 365816.0, 369323.0, 373203.0, 476775.0, 493863.0, 98053.50973245088, 103138.48430757948, 105392.47303763432, 105590.47204764081, 107886.0, 1054.2198772907993, 1071.1591400750374, 1090.5910283643475, 1097.3306283167262, 1104.6630777612745, 17909.19408626641, 18018.36935707244, 18365.90817045906, 18378.356757513422, 18441.506610127213, 44082.33876491919, 44474.555254448336, 44630.55369446264, 44695.0, 44782.3282650767, 61436.0, 61477.0, 62130.689346554784, 64127.35872641214, 64569.35430645821, 8654.913450865412, 8836.381453298207, 9045.728628141167, 9125.498097604695, 9133.132352426508, 9993.850092248767, 13370.532031379244, 13452.260125693181, 13635.931820341231, 13650.317484125953, 11674.533018679158, 11873.346965916957, 11890.702732431759, 11909.344986025852, 12376.0, 11189.552417903193, 11473.885261147281, 11906.702332441759, 12204.32876191818, 12260.26438413698, 12177.573784917486, 12207.206531575419, 12276.938615306866, 12290.139690221598, 12588.685282867635, 8830.161134692195, 8900.866487002571, 8910.688125915562, 8954.28365730753, 9203.539823008956, 11981.400929953294, 12008.459619316976, 12104.27374357506, 12223.75552488963, 12251.448684809027], "value": 9644.88228398939, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.159558467128, 1562.7108984837803, 1593.872490200784, 1770.6989811732005, 1892.82964533192, 8744.693935712252, 8909.643614255421, 8926.285897128231, 9130.0, 9142.085791420855, 8928.107189281069, 9155.725328240163, 9419.43483390997, 9422.811543769121, 9427.1986881115, 2231.8102961248314, 2390.414348484615, 2474.938126546833, 2481.9131330403393, 2540.0220914947786, 2489.5394352044927, 2495.0394098272113, 2502.461970676304, 2504.511620234046, 2511.1462102885016, 2434.294054724128, 2456.336789066951, 2461.4584791345965, 2462.113639089926, 2463.6550882876413, 2166.8916554172306, 2408.3015925381533, 2478.21936090131, 2478.24413553866, 2493.2270995991303, 2428.1865575032384, 2436.476157626119, 2443.780059794627, 2451.6935383077116, 2454.349597356702, 9213.0, 9260.722178334661, 9290.1174388433, 9303.209227215628, 9316.580753866092, 5582.469665381823, 5672.0, 5677.772889084432, 5688.11834165705, 5695.544356451515, 3379.290349026707, 3437.415639341318, 3454.084667563098, 3522.4011917974008, 3534.416821224495, 1112.8942750438696, 1145.587588468151, 1147.925384849982, 1161.680537852089, 1164.992281676344, 13789.241591712453, 14061.156330620195, 14078.155310681392, 14087.084339517898, 14098.92950535251, 4947.777350019258, 4962.106820772296, 4989.052080104769, 5174.818881339135, 5210.47895210476, 11667.6499705009, 11696.590619328283, 11710.297382156927, 11712.0, 11717.0, 5098.643094983316, 5731.742071606787, 5732.05421105513, 5740.856478587985, 5742.913856292159, 5068.6451948364, 5161.122609156452, 5224.92162617561, 5246.23929530216, 5247.291615631917, 4358.738475691469, 4369.4101296325225, 4376.934345984812, 4381.16757816014, 4471.150481408522, 1350.770369037266, 1373.6085215713474, 1384.3286006286942, 1398.5524632117624, 1398.8810951069272, 1037.2376303416982, 1037.5123691864812, 1044.1490185498794, 1051.0540513537876, 1053.6522947427331, 6019.668918209453, 6152.630842149485, 6159.476444502267, 6224.719887605069, 6321.841953951096, 509.6101482365993, 509.8011775407594, 515.9458256882973, 1013.2350075692805, 1051.3113910388709, 4404.119176164716, 4421.945137157108, 4459.509453960127, 4484.1255955088445, 4493.640508759291, 11858.88141118595, 12239.877601224052, 12253.387330633434, 12254.81617775734, 12278.877211227951, 11992.340421276738, 12056.397180140957, 12152.149349545623, 12166.270023798601, 12172.20880642773, 8844.513551754715, 9030.548472576345, 9171.220446262143, 9172.220361269234, 9188.356815023018, 6490.383413575702, 6607.744528539562, 6640.966795165993, 6681.398674119353, 6698.095757072928, 10893.618723344962, 11064.723381915195, 11256.268342557707, 11343.0, 11384.829227561428, 11307.773844522899, 11319.0, 11541.192116551762, 11623.418829058344, 11664.94167529157, 7811.765647030598, 8107.716229931924, 8310.168983101641, 8407.789805254917, 8567.228949394585, 9091.59087841062, 9093.090690931118, 9128.863067053866, 9150.954245228731, 9165.404248723811, 8100.2304781045705, 8239.670413183405, 8245.13426090252, 8304.875426868723, 8454.239118479367, 7976.840463190588, 7979.601019949096, 7988.760337189894, 8026.2375074370175, 8097.595120243846, 7260.801967675275, 7348.926510734825, 7355.742549010759, 7540.434467415075, 7544.849103017799, 5385.192221166856, 5411.431799661136, 5476.849861529124, 5520.1443776214755, 5569.220309156803, 5467.343918729778, 5486.31421072366, 5548.472895074961, 5550.5282051026115, 5761.107028410603], "value": 4944.133737024189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.7794167616077, 356.6006073198018, 365.9505966694496, 367.18118595531945, 370.3833117858765, 5344.946550534493, 5508.9173662395, 5572.442755724425, 5644.153376993453, 5657.773689052438, 5515.172724091388, 5551.195076713874, 5564.916526252109, 5566.0, 5591.608587398884, 4309.245881970651, 4315.956840431587, 4320.438343015404, 4341.826326946918, 4374.628156606692, 4216.156768646268, 4271.722338048033, 4335.934960975588, 4339.370791235269, 4344.870333713242, 4235.644593730008, 4235.703500754948, 4276.2516559601945, 4282.8008157715885, 4307.483102027761, 4257.446531950842, 4269.231538323101, 4273.529911709709, 4275.824148359211, 4286.76422796746, 3547.5742910850604, 3793.2034272802744, 3798.829052692608, 3799.5440547134244, 3803.003423202813, 5288.391834938954, 5289.735513224324, 5334.866628334284, 5335.359756829205, 5336.0, 4912.189488734354, 4914.385701787277, 4922.286268491049, 4923.532264434873, 4941.20940649498, 5572.0, 5772.365039845614, 5798.636790661406, 5801.506871915893, 5814.854628634275, 4090.5091389033505, 4136.8138433770555, 4145.8963525911795, 4147.460830092069, 4148.709590328678, 5934.1692163097205, 5949.9702501487645, 5968.194293770329, 5984.8753692438995, 6013.909791353133, 4033.4756481657196, 4219.240536703362, 4230.70385073042, 4245.087306229176, 4247.23549761046, 4257.87226383209, 4280.91438171241, 4286.464191976003, 4288.5711428857485, 4304.677149213821, 4844.75776211188, 4879.512048795092, 4886.315915771795, 4910.078503290536, 4931.767058235441, 5608.803691870765, 5740.138979153077, 5750.1949727038245, 5759.6832174229985, 5775.451332123442, 1439.2947455746819, 1458.5915943535827, 1474.9115053096848, 1476.6898951220148, 1482.7627579587215, 932.7807965128189, 934.0052843721551, 944.6976967370375, 946.588234118147, 947.8056998315329, 5050.924236136461, 5062.633089065932, 5118.820841270538, 5146.066741957124, 5152.458991805881, 5358.732063396815, 5363.141897296414, 5389.51494365509, 5392.892142157135, 5425.891482170335, 5055.216441451581, 5078.984203159383, 5096.413912400048, 5286.762095705702, 5769.711514424262, 3123.515855042472, 3134.670859559759, 3142.575752273414, 3162.9367412652077, 3180.5865237518974, 6062.302835174011, 6205.627662340184, 6213.65824879636, 6218.160548326008, 6238.220222472191, 6006.939930600725, 6007.519398448114, 6065.939340606537, 6070.605410648293, 6088.665123418255, 6102.52847596724, 6160.815175544741, 6176.505879529716, 6186.505079593621, 6216.844578885473, 5649.774009039593, 5987.0, 6002.56895957138, 6004.789832355847, 6018.3680713524445, 5882.7058647066615, 5921.3782552831335, 5936.940630593812, 5966.70166491665, 5974.970125149346, 5972.522198224218, 6166.242620853035, 6194.287656919512, 6231.594946328474, 6273.745250949737, 4272.188284225987, 4295.625399872011, 4302.118065796567, 4323.589259020388, 4330.17726631939, 6016.398360163948, 6018.789342372996, 6022.156898034191, 6042.969785151222, 6062.0, 5651.88696226065, 5804.361520232856, 5858.88681150597, 5927.288725352985, 5945.494632956247, 5778.94221057784, 5794.2177805997335, 5800.738966746591, 5802.404338806862, 5817.854553636193, 5703.771849125988, 5720.598453378949, 5732.856678582902, 5734.05388110957, 5766.798162064308, 5586.553075754011, 5780.21967034445, 5840.532757379315, 5850.7074646266665, 5856.648601083949, 5701.743421545957, 5722.140304401003, 5728.677367126973, 5737.540996720336, 5760.683162425939], "value": 4395.467661880003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.1698040645491, 807.2936180841764, 820.7578764264541, 839.3033781960972, 879.3141349747195, 14986.550403487885, 17385.0, 17433.651326973486, 17437.30250789967, 17438.651226975453, 14795.26023698816, 14821.851781482183, 14846.109233446, 14856.55430337089, 14889.106653600791, 720.6576875983918, 842.7429633961655, 844.6199210355334, 886.5079880666227, 889.7953470701742, 878.8637761147032, 879.6965047058754, 884.0319849764497, 884.5002573545926, 884.7213127864702, 758.9089309282894, 889.9599518021705, 930.2790337488433, 931.0549791961165, 931.2131249094505, 915.50562696144, 916.3493919317226, 916.9403988740744, 917.1241464401547, 917.2386918857333, 676.2932735291632, 677.1772296659533, 677.4546490075487, 677.5257319876057, 677.6611694152923, 16987.49037528864, 17045.573860653458, 17095.658086838193, 17118.0, 17120.74318885218, 15082.622934426618, 15123.0, 15149.469768558047, 15231.162286074261, 15306.005109667836, 12636.0, 12708.745825083446, 12850.357482125857, 14636.487722929647, 15163.62090947724, 4784.449788274358, 4959.504049595012, 5035.59715222785, 5039.84880453587, 5071.974640126776, 82416.58791706063, 82886.58556707238, 83739.5813020931, 84463.0, 85403.0, 12076.698082548006, 12120.454579543766, 12169.817452738216, 12350.135490515577, 12398.25610463357, 21301.0, 21508.677369839465, 22220.55558888813, 22221.888890555445, 23219.419514512272, 9069.77325566866, 9217.76955576116, 9309.860352094589, 9341.719748407559, 9588.808223835484, 4884.291777692286, 4937.644433819436, 5007.599392048627, 5012.072766538202, 5183.352080989876, 4081.9387709184384, 4208.9688026433105, 4290.592393722592, 4474.7762611869275, 4478.283474644041, 694.531191445772, 738.1732459645232, 777.945543811939, 785.6346798738614, 799.6641410607559, 686.2588404523103, 693.2132030145821, 734.6454612965433, 758.6093162021564, 802.9518228906285, 10665.9466702666, 10992.120630349553, 11083.50124244411, 11089.33463992163, 11241.494132764044, 604.7036951893629, 671.1811589860363, 674.6930146783202, 711.3810984443464, 733.5561984998999, 5019.14674505335, 5206.8958620828125, 5237.162054071407, 5254.65844720092, 5268.28878101459, 53256.20115698268, 53616.463835361144, 53721.0, 97994.5100274494, 99988.50005749924, 95265.0, 101779.49110254401, 102424.0, 102685.0, 105141.0, 85604.57197714096, 88427.557862209, 92667.0, 92973.53513232525, 93077.5346123265, 10391.688249352532, 10689.470871191714, 10782.137429005505, 10791.082757965662, 10896.61861834832, 45008.549914500436, 45339.0, 51185.36363953784, 51897.22154167766, 55170.72414637901, 75586.62206688931, 76580.0, 79003.60498197473, 79335.0, 80556.59721701354, 13427.19436833793, 13942.860571394562, 13983.300834958009, 14323.713525729636, 14510.274486275433, 14605.707885842012, 15232.695346093238, 15299.77050344268, 15910.7613385797, 16044.759328609847, 14079.859201407855, 14499.85500144985, 15352.769708454605, 15407.61480962985, 15568.455104071303, 14884.0, 15033.849661503245, 15330.693386131992, 15381.15403652765, 15678.843211568195, 14371.92814035923, 14431.49489767853, 14615.123092614052, 15131.848681513044, 15228.390864365301, 11432.371219583003, 11464.484098215433, 11749.29504229749, 12159.75680486403, 12378.133530652767, 12284.201526900722, 12503.249805011728, 12534.0, 12534.185277956904, 12628.0], "value": 8064.964073816467, "unit": "score"}], "name": "dromaeo_css", "value": 7568.342540894365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 110.0, 110.0, 109.0, 109.0, 111.0, 111.0, 111.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 128.0, 191.0, 124.0, 124.0, 153.0, 124.0, 187.0, 132.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 163.0, 160.0, 160.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 111.0, 75.0, 76.0, 74.0, 75.0, 98.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 116.0, 83.0, 85.0, 83.0, 120.0, 83.0, 84.0, 129.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 51.0, 51.0, 56.0, 52.0, 52.0, 50.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 62.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 75.0, 77.0, 78.0, 76.0, 77.0, 103.0, 75.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 132.0, 127.0, 123.0, 126.0, 121.0, 130.0, 126.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 157.0, 152.0, 163.0, 152.0, 151.0, 152.0, 151.0, 149.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 61.0, 62.0, 62.0, 64.0, 64.0, 61.0, 59.0, 63.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1477.8000000000002, "alertThreshold": 2.0}]} 13:55:46 INFO - Return code: 0 13:55:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:55:46 ERROR - # TBPL SUCCESS # 13:55:46 INFO - Running post-action listener: _resource_record_post_action 13:55:46 INFO - ##### 13:55:46 INFO - ##### Finished run-tests step (success) 13:55:46 INFO - ##### 13:55:46 INFO - Running post-run listener: _resource_record_post_run 13:55:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 504938496; Read time: 28; Write time: 494380 13:55:46 INFO - TinderboxPrint: CPU usage
13.1% 13:55:46 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 13:55:46 INFO - TinderboxPrint: I/O write bytes / time
504,938,496 / 494,380 13:55:46 INFO - TinderboxPrint: CPU idle
8,260.4 (86.9%) 13:55:46 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 13:55:46 INFO - TinderboxPrint: Swap in / out
0 / 0 13:55:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 172605440; Read time: 0; Write time: 234984 13:55:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251965440; Read time: 28; Write time: 204848 13:55:46 INFO - Running post-run listener: _upload_blobber_files 13:55:46 INFO - Blob upload gear active. 13:55:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:55:46 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 13:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:55:47 INFO - (blobuploader) - INFO - Open directory for files ... 13:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:55:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:51 INFO - (blobuploader) - INFO - Done attempting. 13:55:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:55:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:52 INFO - (blobuploader) - INFO - Done attempting. 13:55:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:55:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:52 INFO - (blobuploader) - INFO - Done attempting. 13:55:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:55:52 INFO - Return code: 0 13:55:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:55:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:55:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd12d05efec96405ff38657b02834dbb91723634a05968ce28874f82d5c78fc45c5543bfba5b262b118c6dbf27f9161aa7f8fc39cb9293a0fe4714bac3cd71f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb60a1ed724138fe3d91a35c093ee8a7daf20d0d766dc4f0fa5ad564d5c37b4a755209c43e0870152fcc3ee1ad6eafb0efe48f08028aa389b3536c5c5336aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1186454a4874f247b180aa234d1d06de33bb60b34bddff716b95ac2314ac479dcb73213ce9247ea2618f004c7db9eaba9aab5379627b7897f2b298e8e27cd1c"} 13:55:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:55:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:55:52 INFO - Contents: 13:55:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd12d05efec96405ff38657b02834dbb91723634a05968ce28874f82d5c78fc45c5543bfba5b262b118c6dbf27f9161aa7f8fc39cb9293a0fe4714bac3cd71f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb60a1ed724138fe3d91a35c093ee8a7daf20d0d766dc4f0fa5ad564d5c37b4a755209c43e0870152fcc3ee1ad6eafb0efe48f08028aa389b3536c5c5336aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1186454a4874f247b180aa234d1d06de33bb60b34bddff716b95ac2314ac479dcb73213ce9247ea2618f004c7db9eaba9aab5379627b7897f2b298e8e27cd1c"} 13:55:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:55:52 INFO - Copying logs to upload dir... 13:55:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:55:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.635019 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-09 13:55:52.763279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:52.770669) ========= 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=d2a8c569965ab8367867b893000001a1-1465503998.136908-810460531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd12d05efec96405ff38657b02834dbb91723634a05968ce28874f82d5c78fc45c5543bfba5b262b118c6dbf27f9161aa7f8fc39cb9293a0fe4714bac3cd71f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb60a1ed724138fe3d91a35c093ee8a7daf20d0d766dc4f0fa5ad564d5c37b4a755209c43e0870152fcc3ee1ad6eafb0efe48f08028aa389b3536c5c5336aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1186454a4874f247b180aa234d1d06de33bb60b34bddff716b95ac2314ac479dcb73213ce9247ea2618f004c7db9eaba9aab5379627b7897f2b298e8e27cd1c"} build_url:https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/aS_SGGOHRgSh112hQHj3Sg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd12d05efec96405ff38657b02834dbb91723634a05968ce28874f82d5c78fc45c5543bfba5b262b118c6dbf27f9161aa7f8fc39cb9293a0fe4714bac3cd71f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbb60a1ed724138fe3d91a35c093ee8a7daf20d0d766dc4f0fa5ad564d5c37b4a755209c43e0870152fcc3ee1ad6eafb0efe48f08028aa389b3536c5c5336aff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a1186454a4874f247b180aa234d1d06de33bb60b34bddff716b95ac2314ac479dcb73213ce9247ea2618f004c7db9eaba9aab5379627b7897f2b298e8e27cd1c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:52.798692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:52.799014) ========= 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=d2a8c569965ab8367867b893000001a1-1465503998.136908-810460531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 13:55:52.879991) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 13:55:52.882342) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 13:55:52.882671) ========= ========= Total master_lag: 0.20 =========