builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1466731940.9 results: success (0) buildid: 20160623153957 builduid: 02231051309d41b7af0207931e61474f revision: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:20.902201) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:20.902665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:20.902969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.004827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.005239) ========= 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=5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 18:32:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-23 18:32:21 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.182807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.183177) ========= 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=5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021371 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.240075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.240534) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c --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 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c --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=5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 18:32:21,962 truncating revision to first 12 chars 2016-06-23 18:32:21,962 Setting DEBUG logging. 2016-06-23 18:32:21,963 attempt 1/10 2016-06-23 18:32:21,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/75ff1ecbcb09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 18:32:22,285 unpacking tar archive at: mozilla-aurora-75ff1ecbcb09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696354 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.953868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.954145) ========= script_repo_revision: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.954520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.954786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 18:32:21.963819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-23 18:32:21.964111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:32:22 INFO - MultiFileLogger online at 20160623 18:32:22 in /builds/slave/test 18:32:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:32:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:32:22 INFO - {'append_to_log': False, 18:32:22 INFO - 'base_work_dir': '/builds/slave/test', 18:32:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:32:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:32:22 INFO - 'branch': 'Mozilla-Aurora', 18:32:22 INFO - 'buildbot_json_path': 'buildprops.json', 18:32:22 INFO - 'config_files': ('talos/linux_config.py',), 18:32:22 INFO - 'default_actions': ('clobber', 18:32:22 INFO - 'read-buildbot-config', 18:32:22 INFO - 'download-and-extract', 18:32:22 INFO - 'populate-webroot', 18:32:22 INFO - 'create-virtualenv', 18:32:22 INFO - 'install', 18:32:22 INFO - 'run-tests'), 18:32:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:32:22 INFO - 'download_minidump_stackwalk': True, 18:32:22 INFO - 'download_symbols': 'ondemand', 18:32:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:32:22 INFO - 'tooltool.py': '/tools/tooltool.py', 18:32:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:32:22 INFO - '/tools/misc-python/virtualenv.py')}, 18:32:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:32:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:32:22 INFO - 'installer_path': 'installer.exe', 18:32:22 INFO - 'log_level': 'info', 18:32:22 INFO - 'log_name': 'talos', 18:32:22 INFO - 'log_to_console': True, 18:32:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:32:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:32:22 INFO - 'opt_config_files': (), 18:32:22 INFO - 'pip_index': False, 18:32:22 INFO - 'sps_profile': False, 18:32:22 INFO - 'sps_profile_interval': 0, 18:32:22 INFO - 'suite': 'dromaeojs-e10s', 18:32:22 INFO - 'system_bits': '32', 18:32:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:32:22 INFO - 'title': 'talos-linux64-ix-039', 18:32:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:32:22 INFO - 'use_talos_json': True, 18:32:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:32:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:32:22 INFO - 'work_dir': 'build'} 18:32:22 INFO - ##### 18:32:22 INFO - ##### Running clobber step. 18:32:22 INFO - ##### 18:32:22 INFO - Running pre-action listener: _resource_record_pre_action 18:32:22 INFO - Running main action method: clobber 18:32:22 INFO - rmtree: /builds/slave/test/build 18:32:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:32:23 INFO - Running post-action listener: _resource_record_post_action 18:32:23 INFO - ##### 18:32:23 INFO - ##### Finished clobber step (success) 18:32:23 INFO - ##### 18:32:23 INFO - ##### 18:32:23 INFO - ##### Running read-buildbot-config step. 18:32:23 INFO - ##### 18:32:23 INFO - Running pre-action listener: _resource_record_pre_action 18:32:23 INFO - Running main action method: read_buildbot_config 18:32:23 INFO - Using buildbot properties: 18:32:23 INFO - { 18:32:23 INFO - "project": "", 18:32:23 INFO - "product": "firefox", 18:32:23 INFO - "script_repo_revision": "production", 18:32:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:32:23 INFO - "repository": "", 18:32:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:32:23 INFO - "buildid": "20160623153957", 18:32:23 INFO - "pgo_build": "True", 18:32:23 INFO - "basedir": "/builds/slave/test", 18:32:23 INFO - "buildnumber": 369, 18:32:23 INFO - "slavename": "talos-linux64-ix-039", 18:32:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:32:23 INFO - "platform": "ubuntu64_hw", 18:32:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:32:23 INFO - "branch": "mozilla-aurora", 18:32:23 INFO - "repo_path": "releases/mozilla-aurora", 18:32:23 INFO - "revision": "75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c", 18:32:23 INFO - "stage_platform": "linux64-pgo", 18:32:23 INFO - "builduid": "02231051309d41b7af0207931e61474f", 18:32:23 INFO - "slavebuilddir": "test" 18:32:23 INFO - } 18:32:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:32:23 INFO - Running post-action listener: _resource_record_post_action 18:32:23 INFO - ##### 18:32:23 INFO - ##### Finished read-buildbot-config step (success) 18:32:23 INFO - ##### 18:32:23 INFO - ##### 18:32:23 INFO - ##### Running download-and-extract step. 18:32:23 INFO - ##### 18:32:23 INFO - Running pre-action listener: _resource_record_pre_action 18:32:23 INFO - Running main action method: download_and_extract 18:32:23 INFO - mkdir: /builds/slave/test/build/tests 18:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:23 INFO - https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:32:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:32:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:32:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:32:34 INFO - Downloaded 1361 bytes. 18:32:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:32:34 INFO - Using the following test package requirements: 18:32:34 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:32:34 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:32:34 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:32:34 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'jsshell-linux-x86_64.zip'], 18:32:34 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:32:34 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:32:34 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:32:34 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:32:34 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:32:34 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:32:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:32:34 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:34 INFO - https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:32:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:32:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:32:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:32:40 INFO - Downloaded 24516325 bytes. 18:32:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:32:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:32:42 INFO - Return code: 0 18:32:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:42 INFO - https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:32:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:32:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:32:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:32:46 INFO - Downloaded 24516325 bytes. 18:32:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:32:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:32:47 INFO - Return code: 0 18:32: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')]} 18:32:47 INFO - https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:32:48 INFO - Downloaded 10833369 bytes. 18:32:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:32:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:32:48 INFO - Return code: 0 18:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:48 INFO - https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:32:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:32:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:32:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:32:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:32:52 INFO - Downloaded 63616608 bytes. 18:32:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:32:52 INFO - mkdir: /builds/slave/test/properties 18:32:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:32:52 INFO - Writing to file /builds/slave/test/properties/build_url 18:32:52 INFO - Contents: 18:32:52 INFO - build_url:https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:32:53 INFO - Running post-action listener: _resource_record_post_action 18:32:53 INFO - Running post-action listener: set_extra_try_arguments 18:32:53 INFO - ##### 18:32:53 INFO - ##### Finished download-and-extract step (success) 18:32:53 INFO - ##### 18:32:53 INFO - ##### 18:32:53 INFO - ##### Running populate-webroot step. 18:32:53 INFO - ##### 18:32:53 INFO - Running pre-action listener: _resource_record_pre_action 18:32:53 INFO - Running main action method: populate_webroot 18:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:32:53 INFO - '--tppagecycles', 18:32:53 INFO - '7'], 18:32:53 INFO - 'tests': ['tsvgm']}}, 18:32:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:32:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:32:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:32:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['damp', 'tps']}, 18:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'tests': ['damp', 'tps']}, 18:32:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['dromaeo_dom']}, 18:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:32:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['a11yr', 18:32:53 INFO - 'ts_paint', 18:32:53 INFO - 'tpaint', 18:32:53 INFO - 'sessionrestore', 18:32:53 INFO - 'sessionrestore_no_auto_restore', 18:32:53 INFO - 'tabpaint']}, 18:32:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:32:53 INFO - 'ts_paint', 18:32:53 INFO - 'tpaint', 18:32:53 INFO - 'sessionrestore', 18:32:53 INFO - 'sessionrestore_no_auto_restore', 18:32:53 INFO - 'tabpaint']}, 18:32:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:32:53 INFO - 'ts_paint', 18:32:53 INFO - 'tpaint', 18:32:53 INFO - 'sessionrestore', 18:32:53 INFO - 'sessionrestore_no_auto_restore', 18:32:53 INFO - 'tabpaint']}, 18:32:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:32:53 INFO - 'ts_paint', 18:32:53 INFO - 'tpaint', 18:32:53 INFO - 'sessionrestore', 18:32:53 INFO - 'sessionrestore_no_auto_restore', 18:32:53 INFO - 'tabpaint']}, 18:32:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['a11yr', 18:32:53 INFO - 'ts_paint', 18:32:53 INFO - 'tpaint', 18:32:53 INFO - 'sessionrestore', 18:32:53 INFO - 'sessionrestore_no_auto_restore', 18:32:53 INFO - 'tabpaint']}, 18:32:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['a11yr', 18:32:53 INFO - 'ts_paint', 18:32:53 INFO - 'tpaint', 18:32:53 INFO - 'sessionrestore', 18:32:53 INFO - 'sessionrestore_no_auto_restore', 18:32:53 INFO - 'tabpaint']}, 18:32:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['tsvgx', 18:32:53 INFO - 'tsvgr_opacity', 18:32:53 INFO - 'tart', 18:32:53 INFO - 'tscrollx', 18:32:53 INFO - 'cart']}, 18:32:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:32:53 INFO - 'tsvgr_opacity', 18:32:53 INFO - 'tart', 18:32:53 INFO - 'tscrollx', 18:32:53 INFO - 'cart']}, 18:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'talos_options': ['--disable-e10s'], 18:32:53 INFO - 'tests': ['tp5o']}, 18:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'tests': ['tp5o']}, 18:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'talos_options': ['--disable-e10s', 18:32:53 INFO - '--xperf_path', 18:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:53 INFO - 'tests': ['tp5n']}, 18:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:32:53 INFO - 'talos_options': ['--xperf_path', 18:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:32:53 INFO - 'tests': ['tp5n']}}, 18:32:53 INFO - 'talos.zip': {'path': '', 18:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:32:53 INFO - Running post-action listener: _resource_record_post_action 18:32:53 INFO - ##### 18:32:53 INFO - ##### Finished populate-webroot step (success) 18:32:53 INFO - ##### 18:32:53 INFO - ##### 18:32:53 INFO - ##### Running create-virtualenv step. 18:32:53 INFO - ##### 18:32:53 INFO - Running pre-action listener: _resource_record_pre_action 18:32:53 INFO - Running main action method: create_virtualenv 18:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:32:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:32:53 INFO - Using real prefix '/usr' 18:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:32:53 INFO - Installing distribute.............................................................................................................................................................................................done. 18:32:55 INFO - Installing pip.................done. 18:32:55 INFO - Return code: 0 18:32:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:32:55 INFO - Using env: {'DISPLAY': ':0', 18:32:55 INFO - 'HOME': '/home/cltbld', 18:32:55 INFO - 'LANG': 'en_US.UTF-8', 18:32:55 INFO - 'LANGUAGE': 'en_US:en', 18:32:55 INFO - 'LOGNAME': 'cltbld', 18:32:55 INFO - 'MAIL': '/var/mail/cltbld', 18:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:55 INFO - 'MOZ_NO_REMOTE': '1', 18:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:55 INFO - 'NO_EM_RESTART': '1', 18:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:55 INFO - 'PWD': '/builds/slave/test', 18:32:55 INFO - 'SHELL': '/bin/bash', 18:32:55 INFO - 'SHLVL': '1', 18:32:55 INFO - 'TERM': 'linux', 18:32:55 INFO - 'TMOUT': '86400', 18:32:55 INFO - 'USER': 'cltbld', 18:32:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:55 INFO - '_': '/tools/buildbot/bin/python'} 18:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:32:55 INFO - Cleaning up... 18:32:55 INFO - Return code: 0 18:32:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:32:55 INFO - Using env: {'DISPLAY': ':0', 18:32:55 INFO - 'HOME': '/home/cltbld', 18:32:55 INFO - 'LANG': 'en_US.UTF-8', 18:32:55 INFO - 'LANGUAGE': 'en_US:en', 18:32:55 INFO - 'LOGNAME': 'cltbld', 18:32:55 INFO - 'MAIL': '/var/mail/cltbld', 18:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:55 INFO - 'MOZ_NO_REMOTE': '1', 18:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:55 INFO - 'NO_EM_RESTART': '1', 18:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:55 INFO - 'PWD': '/builds/slave/test', 18:32:55 INFO - 'SHELL': '/bin/bash', 18:32:55 INFO - 'SHLVL': '1', 18:32:55 INFO - 'TERM': 'linux', 18:32:55 INFO - 'TMOUT': '86400', 18:32:55 INFO - 'USER': 'cltbld', 18:32:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:55 INFO - '_': '/tools/buildbot/bin/python'} 18:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:56 INFO - Downloading/unpacking psutil>=3.1.1 18:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:58 INFO - Installing collected packages: psutil 18:32:58 INFO - Running setup.py install for psutil 18:32:58 INFO - building 'psutil._psutil_linux' extension 18:32:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:32:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:32:58 INFO - building 'psutil._psutil_posix' extension 18:32:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:32:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:32:58 INFO - Successfully installed psutil 18:32:58 INFO - Cleaning up... 18:32:58 INFO - Return code: 0 18:32:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:32:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:32:58 INFO - Using env: {'DISPLAY': ':0', 18:32:58 INFO - 'HOME': '/home/cltbld', 18:32:58 INFO - 'LANG': 'en_US.UTF-8', 18:32:58 INFO - 'LANGUAGE': 'en_US:en', 18:32:58 INFO - 'LOGNAME': 'cltbld', 18:32:58 INFO - 'MAIL': '/var/mail/cltbld', 18:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:58 INFO - 'MOZ_NO_REMOTE': '1', 18:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:58 INFO - 'NO_EM_RESTART': '1', 18:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:58 INFO - 'PWD': '/builds/slave/test', 18:32:58 INFO - 'SHELL': '/bin/bash', 18:32:58 INFO - 'SHLVL': '1', 18:32:58 INFO - 'TERM': 'linux', 18:32:58 INFO - 'TMOUT': '86400', 18:32:58 INFO - 'USER': 'cltbld', 18:32:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:58 INFO - '_': '/tools/buildbot/bin/python'} 18:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:32:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:32:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:32:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:00 INFO - Installing collected packages: mozsystemmonitor 18:33:00 INFO - Running setup.py install for mozsystemmonitor 18:33:00 INFO - Successfully installed mozsystemmonitor 18:33:00 INFO - Cleaning up... 18:33:00 INFO - Return code: 0 18:33:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:33:00 INFO - Using env: {'DISPLAY': ':0', 18:33:00 INFO - 'HOME': '/home/cltbld', 18:33:00 INFO - 'LANG': 'en_US.UTF-8', 18:33:00 INFO - 'LANGUAGE': 'en_US:en', 18:33:00 INFO - 'LOGNAME': 'cltbld', 18:33:00 INFO - 'MAIL': '/var/mail/cltbld', 18:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:00 INFO - 'MOZ_NO_REMOTE': '1', 18:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:00 INFO - 'NO_EM_RESTART': '1', 18:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:00 INFO - 'PWD': '/builds/slave/test', 18:33:00 INFO - 'SHELL': '/bin/bash', 18:33:00 INFO - 'SHLVL': '1', 18:33:00 INFO - 'TERM': 'linux', 18:33:00 INFO - 'TMOUT': '86400', 18:33:00 INFO - 'USER': 'cltbld', 18:33:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:00 INFO - '_': '/tools/buildbot/bin/python'} 18:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:01 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:03 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:03 INFO - warning: no files found matching '*.txt' 18:33:03 INFO - no previously-included directories found matching 'build' 18:33:03 INFO - no previously-included directories found matching 'dist' 18:33:03 INFO - no previously-included directories found matching '.git*' 18:33:03 INFO - Installing collected packages: jsonschema, functools32 18:33:03 INFO - Running setup.py install for functools32 18:33:03 INFO - warning: no files found matching '*.txt' 18:33:03 INFO - no previously-included directories found matching 'build' 18:33:03 INFO - no previously-included directories found matching 'dist' 18:33:03 INFO - no previously-included directories found matching '.git*' 18:33:03 INFO - Successfully installed jsonschema functools32 18:33:03 INFO - Cleaning up... 18:33:03 INFO - Return code: 0 18:33:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:33:03 INFO - Using env: {'DISPLAY': ':0', 18:33:03 INFO - 'HOME': '/home/cltbld', 18:33:03 INFO - 'LANG': 'en_US.UTF-8', 18:33:03 INFO - 'LANGUAGE': 'en_US:en', 18:33:03 INFO - 'LOGNAME': 'cltbld', 18:33:03 INFO - 'MAIL': '/var/mail/cltbld', 18:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:03 INFO - 'MOZ_NO_REMOTE': '1', 18:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:03 INFO - 'NO_EM_RESTART': '1', 18:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:03 INFO - 'PWD': '/builds/slave/test', 18:33:03 INFO - 'SHELL': '/bin/bash', 18:33:03 INFO - 'SHLVL': '1', 18:33:03 INFO - 'TERM': 'linux', 18:33:03 INFO - 'TMOUT': '86400', 18:33:03 INFO - 'USER': 'cltbld', 18:33:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:03 INFO - '_': '/tools/buildbot/bin/python'} 18:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:06 INFO - Downloading docopt-0.6.1.tar.gz 18:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:06 INFO - Running setup.py install for blobuploader 18:33:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:06 INFO - Running setup.py install for requests 18:33:06 INFO - Running setup.py install for docopt 18:33:06 INFO - Successfully installed blobuploader requests docopt 18:33:06 INFO - Cleaning up... 18:33:06 INFO - Return code: 0 18:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:33:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:06 INFO - Using env: {'DISPLAY': ':0', 18:33:06 INFO - 'HOME': '/home/cltbld', 18:33:06 INFO - 'LANG': 'en_US.UTF-8', 18:33:06 INFO - 'LANGUAGE': 'en_US:en', 18:33:06 INFO - 'LOGNAME': 'cltbld', 18:33:06 INFO - 'MAIL': '/var/mail/cltbld', 18:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:06 INFO - 'MOZ_NO_REMOTE': '1', 18:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:06 INFO - 'NO_EM_RESTART': '1', 18:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:06 INFO - 'PWD': '/builds/slave/test', 18:33:06 INFO - 'SHELL': '/bin/bash', 18:33:06 INFO - 'SHLVL': '1', 18:33:06 INFO - 'TERM': 'linux', 18:33:06 INFO - 'TMOUT': '86400', 18:33:06 INFO - 'USER': 'cltbld', 18:33:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:06 INFO - '_': '/tools/buildbot/bin/python'} 18:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:07 INFO - Running setup.py (path:/tmp/pip-tdTVk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:07 INFO - Running setup.py (path:/tmp/pip-eK0CA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:07 INFO - Running setup.py (path:/tmp/pip-S8teKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:07 INFO - Running setup.py (path:/tmp/pip-kxnwk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:07 INFO - Running setup.py (path:/tmp/pip-WgA1m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:07 INFO - Running setup.py (path:/tmp/pip-z6miom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:07 INFO - Running setup.py (path:/tmp/pip-c9Ooo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:07 INFO - Running setup.py (path:/tmp/pip-LS2NkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:07 INFO - Running setup.py (path:/tmp/pip-rVGfqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:07 INFO - Running setup.py (path:/tmp/pip-a_iFdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:07 INFO - Running setup.py (path:/tmp/pip-8K632w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:07 INFO - Running setup.py (path:/tmp/pip-0DPFqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:08 INFO - Running setup.py (path:/tmp/pip-zB5PPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:08 INFO - Running setup.py (path:/tmp/pip-B62E2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:08 INFO - Running setup.py (path:/tmp/pip-2C0YZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:08 INFO - Running setup.py (path:/tmp/pip-eEWHyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:08 INFO - Running setup.py (path:/tmp/pip-H6DGXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:08 INFO - Running setup.py install for manifestparser 18:33:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:08 INFO - Running setup.py install for mozcrash 18:33:08 INFO - Running setup.py install for mozdebug 18:33:08 INFO - Running setup.py install for mozdevice 18:33:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:08 INFO - Running setup.py install for mozfile 18:33:08 INFO - Running setup.py install for mozhttpd 18:33:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for mozinfo 18:33:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for mozInstall 18:33:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for mozleak 18:33:09 INFO - Running setup.py install for mozlog 18:33:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for moznetwork 18:33:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for mozprocess 18:33:09 INFO - Running setup.py install for mozprofile 18:33:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for mozrunner 18:33:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:09 INFO - Running setup.py install for mozscreenshot 18:33:09 INFO - Running setup.py install for moztest 18:33:10 INFO - Running setup.py install for mozversion 18:33:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:10 INFO - Cleaning up... 18:33:10 INFO - Return code: 0 18:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:10 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 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:10 INFO - Using env: {'DISPLAY': ':0', 18:33:10 INFO - 'HOME': '/home/cltbld', 18:33:10 INFO - 'LANG': 'en_US.UTF-8', 18:33:10 INFO - 'LANGUAGE': 'en_US:en', 18:33:10 INFO - 'LOGNAME': 'cltbld', 18:33:10 INFO - 'MAIL': '/var/mail/cltbld', 18:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:10 INFO - 'MOZ_NO_REMOTE': '1', 18:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:10 INFO - 'NO_EM_RESTART': '1', 18:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:10 INFO - 'PWD': '/builds/slave/test', 18:33:10 INFO - 'SHELL': '/bin/bash', 18:33:10 INFO - 'SHLVL': '1', 18:33:10 INFO - 'TERM': 'linux', 18:33:10 INFO - 'TMOUT': '86400', 18:33:10 INFO - 'USER': 'cltbld', 18:33:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:10 INFO - '_': '/tools/buildbot/bin/python'} 18:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:10 INFO - Running setup.py (path:/tmp/pip-2YwQco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:10 INFO - Running setup.py (path:/tmp/pip-ZbasCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:10 INFO - Running setup.py (path:/tmp/pip-DCFL2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:10 INFO - Running setup.py (path:/tmp/pip-pOTxWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:10 INFO - Running setup.py (path:/tmp/pip-dL5bxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:10 INFO - Running setup.py (path:/tmp/pip-RtXsb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:10 INFO - Running setup.py (path:/tmp/pip-j2p1Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:10 INFO - Running setup.py (path:/tmp/pip-8_WHmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:10 INFO - Running setup.py (path:/tmp/pip-aQIxij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:11 INFO - Running setup.py (path:/tmp/pip-knn2G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:11 INFO - Running setup.py (path:/tmp/pip-Hpu8Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:11 INFO - Running setup.py (path:/tmp/pip-pVW2Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:11 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)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:11 INFO - Running setup.py (path:/tmp/pip-AGTLav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:11 INFO - Running setup.py (path:/tmp/pip-RUUaTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:11 INFO - Running setup.py (path:/tmp/pip-zqt5Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:11 INFO - Running setup.py (path:/tmp/pip-nDKpoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:11 INFO - Running setup.py (path:/tmp/pip-GMJo5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:33:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:13 INFO - Downloading blessings-1.6.tar.gz 18:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:33:13 INFO - Installing collected packages: blessings 18:33:13 INFO - Running setup.py install for blessings 18:33:13 INFO - Successfully installed blessings 18:33:13 INFO - Cleaning up... 18:33:13 INFO - Return code: 0 18:33:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:13 INFO - Reading from file tmpfile_stdout 18:33:13 INFO - Current package versions: 18:33:13 INFO - argparse == 1.2.1 18:33:13 INFO - blessings == 1.6 18:33:13 INFO - blobuploader == 1.2.4 18:33:13 INFO - docopt == 0.6.1 18:33:13 INFO - functools32 == 3.2.3-2 18:33:13 INFO - jsonschema == 2.5.1 18:33:13 INFO - manifestparser == 1.1 18:33:13 INFO - mozInstall == 1.12 18:33:13 INFO - mozcrash == 0.17 18:33:13 INFO - mozdebug == 0.1 18:33:13 INFO - mozdevice == 0.48 18:33:13 INFO - mozfile == 1.2 18:33:13 INFO - mozhttpd == 0.7 18:33:13 INFO - mozinfo == 0.9 18:33:13 INFO - mozleak == 0.1 18:33:13 INFO - mozlog == 3.2 18:33:13 INFO - moznetwork == 0.27 18:33:13 INFO - mozprocess == 0.22 18:33:13 INFO - mozprofile == 0.28 18:33:13 INFO - mozrunner == 6.11 18:33:13 INFO - mozscreenshot == 0.1 18:33:13 INFO - mozsystemmonitor == 0.3 18:33:13 INFO - moztest == 0.7 18:33:13 INFO - mozversion == 1.4 18:33:13 INFO - psutil == 3.1.1 18:33:13 INFO - requests == 1.2.3 18:33:13 INFO - wsgiref == 0.1.2 18:33:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:33:13 INFO - Using env: {'DISPLAY': ':0', 18:33:13 INFO - 'HOME': '/home/cltbld', 18:33:13 INFO - 'LANG': 'en_US.UTF-8', 18:33:13 INFO - 'LANGUAGE': 'en_US:en', 18:33:13 INFO - 'LOGNAME': 'cltbld', 18:33:13 INFO - 'MAIL': '/var/mail/cltbld', 18:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:13 INFO - 'MOZ_NO_REMOTE': '1', 18:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:13 INFO - 'NO_EM_RESTART': '1', 18:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:13 INFO - 'PWD': '/builds/slave/test', 18:33:13 INFO - 'SHELL': '/bin/bash', 18:33:13 INFO - 'SHLVL': '1', 18:33:13 INFO - 'TERM': 'linux', 18:33:13 INFO - 'TMOUT': '86400', 18:33:13 INFO - 'USER': 'cltbld', 18:33:13 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:13 INFO - '_': '/tools/buildbot/bin/python'} 18:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:33:14 INFO - Cleaning up... 18:33:14 INFO - Return code: 0 18:33:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:33:14 INFO - Using env: {'DISPLAY': ':0', 18:33:14 INFO - 'HOME': '/home/cltbld', 18:33:14 INFO - 'LANG': 'en_US.UTF-8', 18:33:14 INFO - 'LANGUAGE': 'en_US:en', 18:33:14 INFO - 'LOGNAME': 'cltbld', 18:33:14 INFO - 'MAIL': '/var/mail/cltbld', 18:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:14 INFO - 'MOZ_NO_REMOTE': '1', 18:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:14 INFO - 'NO_EM_RESTART': '1', 18:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:14 INFO - 'PWD': '/builds/slave/test', 18:33:14 INFO - 'SHELL': '/bin/bash', 18:33:14 INFO - 'SHLVL': '1', 18:33:14 INFO - 'TERM': 'linux', 18:33:14 INFO - 'TMOUT': '86400', 18:33:14 INFO - 'USER': 'cltbld', 18:33:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:14 INFO - '_': '/tools/buildbot/bin/python'} 18:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:33:14 INFO - Cleaning up... 18:33:14 INFO - Return code: 0 18:33:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f35d28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, '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': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:33:14 INFO - Using env: {'DISPLAY': ':0', 18:33:14 INFO - 'HOME': '/home/cltbld', 18:33:14 INFO - 'LANG': 'en_US.UTF-8', 18:33:14 INFO - 'LANGUAGE': 'en_US:en', 18:33:14 INFO - 'LOGNAME': 'cltbld', 18:33:14 INFO - 'MAIL': '/var/mail/cltbld', 18:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:14 INFO - 'MOZ_NO_REMOTE': '1', 18:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:14 INFO - 'NO_EM_RESTART': '1', 18:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:14 INFO - 'PWD': '/builds/slave/test', 18:33:14 INFO - 'SHELL': '/bin/bash', 18:33:14 INFO - 'SHLVL': '1', 18:33:14 INFO - 'TERM': 'linux', 18:33:14 INFO - 'TMOUT': '86400', 18:33:14 INFO - 'USER': 'cltbld', 18:33:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:14 INFO - '_': '/tools/buildbot/bin/python'} 18:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:14 INFO - Downloading/unpacking flake8 18:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:33:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:33:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:33:17 INFO - no previously-included directories found matching 'docs/_build' 18:33:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:33:17 INFO - Running setup.py install for pep8 18:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:33:17 INFO - no previously-included directories found matching 'docs/_build' 18:33:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:33:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:33:17 INFO - Cleaning up... 18:33:17 INFO - Return code: 0 18:33:17 INFO - Running post-action listener: _resource_record_post_action 18:33:17 INFO - Running post-action listener: _start_resource_monitoring 18:33:17 INFO - Starting resource monitoring. 18:33:17 INFO - ##### 18:33:17 INFO - ##### Finished create-virtualenv step (success) 18:33:17 INFO - ##### 18:33:17 INFO - ##### 18:33:17 INFO - ##### Running install step. 18:33:17 INFO - ##### 18:33:17 INFO - Running pre-action listener: _resource_record_pre_action 18:33:17 INFO - Running main action method: install 18:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:17 INFO - Reading from file tmpfile_stdout 18:33:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:33:17 INFO - Reading from file tmpfile_stdout 18:33:17 INFO - Output received: 18:33:17 INFO - Usage: mozinstall [options] installer 18:33:17 INFO - Options: 18:33:17 INFO - -h, --help show this help message and exit 18:33:17 INFO - -d DEST, --destination=DEST 18:33:17 INFO - Directory to install application into. [default: 18:33:17 INFO - "/builds/slave/test"] 18:33:17 INFO - --app=APP Application being installed. [default: firefox] 18:33:17 INFO - mkdir: /builds/slave/test/build/application 18:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:33:33 INFO - Reading from file tmpfile_stdout 18:33:33 INFO - Output received: 18:33:33 INFO - /builds/slave/test/build/application/firefox/firefox 18:33:33 INFO - Running post-action listener: _resource_record_post_action 18:33:33 INFO - ##### 18:33:33 INFO - ##### Finished install step (success) 18:33:33 INFO - ##### 18:33:33 INFO - ##### 18:33:33 INFO - ##### Running run-tests step. 18:33:33 INFO - ##### 18:33:33 INFO - Running pre-action listener: _resource_record_pre_action 18:33:33 INFO - Running main action method: run_tests 18:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:33:33 INFO - Python 2.7.3 18:33:33 INFO - Return code: 0 18:33:33 INFO - grabbing minidump binary from tooltool 18:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:33:33 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 0x1cc61c0>, '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 0x1cc70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:33:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:33:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:33:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:33:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:33:33 INFO - Return code: 0 18:33:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:33:34 INFO - Return code: 0 18:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:33:34 INFO - Using env: {'DISPLAY': ':0', 18:33:34 INFO - 'HOME': '/home/cltbld', 18:33:34 INFO - 'LANG': 'en_US.UTF-8', 18:33:34 INFO - 'LANGUAGE': 'en_US:en', 18:33:34 INFO - 'LOGNAME': 'cltbld', 18:33:34 INFO - 'MAIL': '/var/mail/cltbld', 18:33:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:33:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:34 INFO - 'MOZ_NO_REMOTE': '1', 18:33:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:34 INFO - 'NO_EM_RESTART': '1', 18:33:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:34 INFO - 'PWD': '/builds/slave/test', 18:33:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:33:34 INFO - 'SHELL': '/bin/bash', 18:33:34 INFO - 'SHLVL': '1', 18:33:34 INFO - 'TERM': 'linux', 18:33:34 INFO - 'TMOUT': '86400', 18:33:34 INFO - 'USER': 'cltbld', 18:33:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585', 18:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:34 INFO - '_': '/tools/buildbot/bin/python'} 18:33:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:33:34 INFO - mozversion application_buildid: 20160623153957 18:33:34 INFO - mozversion application_changeset: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c 18:33:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:33:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:33:34 INFO - mozversion application_name: Firefox 18:33:34 INFO - mozversion application_remotingname: firefox-dev 18:33:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:33:34 INFO - mozversion application_vendor: Mozilla 18:33:34 INFO - mozversion application_version: 49.0a2 18:33:34 INFO - mozversion platform_buildid: 20160623153957 18:33:34 INFO - mozversion platform_changeset: 75ff1ecbcb094e2887ad3486fd2e40e33fe01b4c 18:33:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:33:34 INFO - mozversion platform_version: 49.0a2 18:33:34 INFO - using testdate: 1466732014 18:33:34 INFO - actual date: 1466732014 18:33:34 INFO - starting webserver on 'localhost:41997' 18:33:34 INFO - SUITE-START | Running 2 tests 18:33:34 INFO - TEST-START | dromaeo_css 18:33:34 INFO - operating with platform_type : linux_ 18:33:34 INFO - Initialising browser for dromaeo_css test... 18:33:34 INFO - TEST-INFO | started process 8423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmnpgT2/profile http://localhost:41997/getInfo.html) 18:33:39 INFO - PROCESS | 8423 | __metrics Screen width/height:1600/1200 18:33:39 INFO - PROCESS | 8423 | colorDepth:24 18:33:39 INFO - PROCESS | 8423 | Browser inner width/height: 1024/697 18:33:39 INFO - PROCESS | 8423 | __metrics 18:33:40 ERROR - PROCESS | 8423 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:33:41 INFO - TEST-INFO | 8423: exit 0 18:33:41 INFO - Browser initialized. 18:33:41 INFO - Running cycle 1/1 for dromaeo_css test... 18:33:41 INFO - TEST-INFO | started process 8553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmnpgT2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:33:53 INFO - PROCESS | 8553 | RSS: Main: 156450816 18:33:53 INFO - PROCESS | 8553 | 18:34:42 INFO - PROCESS | 8553 | 1466732082913 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:36:50 INFO - PROCESS | 8553 | Cycle 1(1): loaded http://localhost:41997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41997/tests/dromaeo/cssquery-ext.html) 18:36:52 INFO - PROCESS | 8553 | RSS: Main: 160178176 18:36:52 INFO - PROCESS | 8553 | 18:39:54 INFO - PROCESS | 8553 | Cycle 1(1): loaded http://localhost:41997/tests/dromaeo/cssquery-ext.html (next: http://localhost:41997/tests/dromaeo/cssquery-jquery.html) 18:39:54 INFO - PROCESS | 8553 | RSS: Main: 158035968 18:39:54 INFO - PROCESS | 8553 | 18:42:56 INFO - PROCESS | 8553 | Cycle 1(1): loaded http://localhost:41997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41997/tests/dromaeo/cssquery-mootools.html) 18:42:56 INFO - PROCESS | 8553 | RSS: Main: 157540352 18:42:56 INFO - PROCESS | 8553 | 18:45:58 INFO - PROCESS | 8553 | Cycle 1(1): loaded http://localhost:41997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41997/tests/dromaeo/cssquery-prototype.html) 18:45:59 INFO - PROCESS | 8553 | RSS: Main: 157560832 18:45:59 INFO - PROCESS | 8553 | 18:49:01 INFO - PROCESS | 8553 | Cycle 1(1): loaded http://localhost:41997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41997/tests/dromaeo/cssquery-yui.html) 18:49:02 INFO - PROCESS | 8553 | RSS: Main: 159506432 18:49:02 INFO - PROCESS | 8553 | 18:52:04 INFO - PROCESS | 8553 | Cycle 1(1): loaded http://localhost:41997/tests/dromaeo/cssquery-yui.html (next: http://localhost:41997/tests/dromaeo/cssquery-dojo.html) 18:52:04 INFO - PROCESS | 8553 | RSS: Main: 159870976 18:52:04 INFO - PROCESS | 8553 | 18:52:04 INFO - PROCESS | 8553 | __start_tp_report 18:52:04 INFO - PROCESS | 8553 | _x_x_mozilla_page_load 18:52:04 INFO - PROCESS | 8553 | _x_x_mozilla_page_load_details 18:52:04 INFO - PROCESS | 8553 | |i|pagename|runs| 18:52:05 INFO - PROCESS | 8553 | |0;dojo.html;3411.4541673332265;3469.8785542506016;3516.630753770854;3521.1901262709575;3521.7182625389974;5723.713814309283;5795.913061304083;5851.590388672789;5857.6778277194735;5888.970555147218;5856.297244330686;5901;5942.762289508414;5975.910361344583;5976.491998180149;5290.074237008527;5352.652077614962;5387.865303367408;5406.83779486616;5415.079436495806;5168.405633352157;5181.481851814826;5443.510084092451;5445.863853403657;5471.069918113911;5253.4746525347355;5327.041132596131;5347.144456886899;5360.222767698681;5374.892502149954;5323.441038690939;5346.4118946915805;5405.297311349539;5412.07994640912;5414.945850541483;5323.946760532383;5348.51863332298;5351.304330437058;5354.812581559627;5397.2443857859935;5387.084195686703;5437.673739575598;5443.292371991655;5601.467860553241;5612.298462692163;6229.6573688447115;6262.279837818618;6266.091416744546;6292.056191571255;6299.181106456177;6307.0539419087045;6335.461485773669;6338.334474880117;6346;6347.968260158716;5596.132599447093;5819.359870414251;5830.62100963436;5910.113482977587;5910.379410161957;6430.453411459985;6489.026646003137;6493.026046093029;6495.967520162369;6509.44669703071;6234.37656234382;6240.625562466266;6241.625502469776;6245.500359971192;6245.96877015612;5955.67243801595;6143.542582966849;6229.688515574203;6237;6320.178376810985;6224.595401298901;6239.1577137085915;6254.061890716338;6263.9664455364355;6264.279607845065;6204.81385558425;6264;6266.404691554295;6278.811635650938;6281.466075383643;4571.428571428572;4712.95287047132;4753.667243293005;4781.402324709411;4783.258594917794;4276.743395396286;4285.035866929916;4287.528371879091;4289.613934745826;4312.116016216668;5961.463468287789;6036.245469316335;6099.420555047263;6104.4505994460715;6117.816465506042;6027.517798576104;6278.6546739929745;6327.715252813635;6403.423691867662;6405.167328247298;6017.578769486094;6099.390060993954;6129.816105516842;6138.6623735694075;6144.0476726106635;5167.044096842096;5364.302640656768;5494.1758736189095;5498.8075417361;5503.889922201533;6573.83565410859;6658.766943156967;6706.5640733352175;6707.094542236736;6717.966410167918;6395;6443.806685799434;6451.935480645321;6462;6464.191976003;6280.403361680633;6445.581037232565;6466.805995820133;6693.799186024427;6706.295838937037;6206.224221972254;6219.533534984804;6226.968865155645;6231.314555398993;6231.875362492816;6290.370962903673;6329.810105696836;6337.96831015842;6341.143945567474;6366.331535188924;5929.495992840657;6131.478824299985;6144.631322120687;6151.169592105009;6159.661218632839;6158.846028849314;6179.660118693515;6199.628022318675;6207.503399727921;6227.377262273736;6063.211782468251;6072.90890636632;6094.268687757498;6124.969375153096;6125.387461253839;5974.103884417372;6117.188044311343;6127.556056270746;6200.906986395298;6284.874302514016;6082.60463069899;6113.327533971171;6115.755369785159;6134.6625935573975;6145.324014358506 18:52:05 INFO - PROCESS | 8553 | |1;ext.html;588.602693182102;642.1972534332085;655.8524332025295;662.0896267632007;674.8211723893166;40315;44812.3278150828;44907.55092449079;45016.09967800642;45027;45207.77396113015;45273;45462.7726861366;45686.314705279365;45727.771361143234;9000.95499522503;9115.68095116671;9119.270458363348;9122.589483473259;9146.176844084031;9005.099490051009;9090.681826136086;9091.909080909172;9111.908880911205;9112.043235460247;9127.315451341143;9159.954200228989;9200.631974721004;9203.355765096447;9203.723888283363;9046.638134474613;9048.683296084606;9082.273418126568;9138.497382643918;9172.578250371136;8941.687040953535;9040.502772347518;9044.050374710692;9047.773805654846;9069.863952040725;41523.792381038205;42083.57916420827;42127.78936105331;42134.36798448026;42154.57845421537;3735.794531300777;3933;4010.0776821330965;4132.793360331972;4309.095090031097;34281;34314.48528272053;34334;34705.479417808754;35150.472742908874;4321.351797230409;4342.435483387139;4365.607095361433;4372.672049596261;4470.821167153343;390809;393303;394728;394827;395913;61485.385146147964;61502.38497614967;61714;61891.690541547;61942;39163.216735665126;39600.40599391011;40002.19995600072;41738;66368.33631663719;19541.120649570803;19713.112909919088;19727.40817775469;19742.802571974386;19743.703844442345;15075.020123691926;15159.317830697644;15176.089434633957;15231.238438078051;15244.23778811055;20862.895685521475;21018.579628407653;21066.47333816667;21106.261280855095;21117;7628.618569071524;7741.625981320536;7871.448998570159;7946.364290856717;8067.757967260992;1111.2332490581634;1122.4443900269418;1158.9710257243469;1190.297724342642;1288.0790234982032;33254.66745332516;33262.50106248408;33409.16477088044;33602.495962560584;33848.66151338455;1179.899708524785;1194.6296648039136;1229.8032314829584;1236.5981056156786;1315.3291821171272;17489.30042798299;17560.29758809633;17581;17719.379821706178;17843;602609;919993;939285;994485;1008903;59152.40847591469;60178.39821601728;60293;60313.09530357048;60386;1478.6672998575234;1513.2055670772932;1517.8937474376687;1525.5118362124015;1525.5347119128994;30890;31843.522347164348;31898;31953.36093278075;32640.020799376056;50706.2394064082;51272.23091653553;51325.23012154746;51611.22583161331;51643;394153;396870;397393;397780;399583;29339.559906601844;29466.558001629564;29717.108486745434;29729.405411892072;29738.702612973593;47564.762176188895;48409.75795121002;48839;49174;49884.25173622471;40560.79719601383;40654.59345406508;41124.588754113276;41154.79422602868;41182.176356473305;39286;39667.60332396639;40021.79989100036;40047;40226.19547608973;40365;41148;41300.793496032325;41695.37456938209;42162.78918605387;35591.28817423689;35960;36317;36417.635823642486;36875;27500;28018.579721303788;28490;28814.279643008253;28837.134885953456 18:52:05 INFO - PROCESS | 8553 | |2;jquery.html;432.36874163720967;438.6291350967813;440.04510212838136;443.7093703624125;443.8845900065984;19543.315983940563;19930.60138797225;20452.488687782814;21045.368638940858;21060.262890798826;19200.83186274263;19232.423027309167;19571.70642440361;19905.800941990576;20148.597028059467;5772.191893134954;5912.704364781765;5962.463378295953;5990.341062483145;6007.6996150192535;5659.6321239119325;5854.560907931901;5856.882862342751;5875.412458754133;5886.440788125121;5806.65160090396;5818.185454036438;5826.883462330751;5837.503812175949;5872.236609240814;5619.072852979253;5784.971075144639;5820.563457740665;5831.183634291224;5849.093390524433;5119.180931051052;5132.204508301219;5139.203423469368;5146.459621739701;5157.355330583677;23620.881895590413;24461.38846528833;24558.50882982348;24621.63067553988;24760.87619561891;2451.705795304575;2602.9479410411877;2808.9438211235865;3250.3986762448785;3271.6728327167093;14876.181810000446;15220.847791522054;15336.693266134727;15393.769093463607;15634.921825390915;2003.9599208015904;2014.617222727677;2056.856020078595;2082.1567265257595;2090.9163633454646;56128.71935640296;56798;57441;81079.59460202721;84178;10603.94698026505;10766.300190487593;10829.35023898553;10847.620333288298;10970.506327215295;14899.925500372428;14964.850351496563;14994.775078373834;15000.849991500163;15014.174220417983;8650.95674521636;8803.119688031145;8840.292776577988;8913.242374398249;8918.152775486318;8795.384323097449;8834.116588341114;8849.159329863782;8886.73339799807;8917.42036767608;6625.204975402886;6644.368784965421;6672.332766723289;6720.1599800025;6768.018637297564;1891.3758459708263;2059.4897175186293;2067.2557879163487;2069.2343832781667;2120.141342756186;980.7057882635181;1069.2099394711736;1098.780243951197;1111.0889070961734;1186.5135294529202;19858.50353741168;20219.898900505697;20284.898575507028;20404.387868363974;20610.572599180334;1089.722120859176;1107.9778404432027;1125.8198688209848;1160.5415860735131;1173.7769823733463;11526;11546.076313894868;11687.357195354338;11736.530538778525;11978.880211197951;516197;516736;527136;529288;536563;85933;87325;89705;90007.54996225108;90375.54812225897;1042.5464922758624;1063.5745701719375;1066.898644628759;1077.590515604081;1078.3314345106085;18556.721649175004;18598.907005464887;18703.625927481648;18759.15583798705;18792.530186744894;40289.19421611493;40530.79734601308;40815;40933;42348;54410;55156.44843551674;57021.714891425276;57030;57568.424315757984;8611.741647750578;8808.735737927873;8821.514816685143;8894.911050889408;9044.186023257938;13227.47090116423;13294;13301.534446294334;13429.865701342862;13560.86439135596;11486.885131148581;11754.647360579196;11829.881701182878;11852.525898963944;12033.939830300793;11680.240784348991;11725.589604363806;11755.647330580096;11867.228630139014;11944.880551194377;11902.40487975615;11965.700857478285;12062.879371206176;12191.573294934635;12229.571964981184;8619.82760344802;8713.695020674246;8776.91223087761;8913.153250441197;9012.954935225544;11209.943950280523;11365.431728413712;11637.185397022466;11854.466549005143;11865.228760130563 18:52:05 INFO - PROCESS | 8553 | |3;mootools.html;1580.0519688187085;1600;1779.848712859407;1897.7153426985942;1930.9227630894766;9344.719658410242;9640.276979226568;9907.900920990787;10021.398716077041;10045.296829221948;10021.649242276522;10065.245106616996;10118;10214.029667181625;10218.182545396368;2513.195777351248;2545.707243666974;2551.9362015949655;2552.515022145786;2556.1053631229106;2474.6906636670415;2485.428351479161;2494.837835540693;2497.6378425128346;2509.8870550825163;2491.48924470484;2494.7505249475;2498.6376975338567;2504.211173480348;2507.8369905956056;2390.5696974544576;2396.6524853896176;2407.9759202408104;2414.95170096598;2417.3714834143075;2459.483508463207;2466.580681284186;2469.086438017945;2482.5779617465073;2513.1329691256487;9810.558524866397;9917.65288214909;9923.702288931272;9932.354396964247;9937.801243975153;5755.625884317506;5886;5919.496842768327;5967.701614919237;5974.163617093611;3570.1610121621397;3647.4528820676846;3690.6493883081066;3694.408894576855;3749.925001499982;1233.7655845389347;1274.4838340472124;1277.6933535951398;2265.677680377626;2297.3911913342977;13641.181529108186;13710.588682339545;13754.449822007007;13820;13951.441942322295;4732.621390288768;4802;4835.637327200404;4850.296706977469;4920.4095508538485;10864.511097000654;10921.836172457419;10930.234883558074;10944.781104377867;10964.232503724823;5715.31416230055;5717.742701578356;5758.395368486333;5774.480296773227;5790.247267855236;4545.659075569345;5241.449647786927;5302;5354.839354819362;5371.033214021436;4092.4679791627495;4154.065335299533;4164.083901541656;4179.393987871742;4226.535081141072;1219.4878151176526;1271.1927925767204;1275.2476039136768;1278.6291975327238;1282.2562913510142;975.23444096384;1033.4471057984092;1033.8035773203067;1059.433203236265;1062.2776511971779;6110.633361998294;6189.938100619026;6277.5605707600025;6292.748290068437;6309;493.93084968104495;498.4467241362085;499.8825276060123;506.92396140579206;512.6104160837716;4327.17783621111;4346.348047792793;4348.9130217396105;4356.455443069616;4376.190404775127;12040.096992725581;12376.381180940916;12420;12429.12996090265;12516.74966500665;12191.14661973671;12196.512139514498;12270.509179632714;12275.447604857804;12313.630591082281;8669.263112635497;8963.058878817761;8964.820703585892;9141.497217652959;9267.212286955684;6451.741930322734;6603.207615086028;6621.238557565942;6657.900131497934;6663;10828.675139745821;11350.432478375884;11358.772824543628;11431.657050288504;11447.313161210353;11316.830247546459;11435.428228588704;11522.308661480338;11527.135464840003;11615.128865334964;8410.201030902055;8532.530710810965;8618.525981071101;8687.826243475221;8881;9511.857322140311;9515.714528564155;9542.33203675736;9564.856527151958;9587.280953928344;8280.544570048705;8347.874781878398;8405.369597280107;8420.15798420153;8540.572971351532;8171.346292296483;8238.958805205935;8267.751967440987;8348.039975402906;8358.080611132893;7433.368163705929;7516.436267280085;7521.022267105242;7555.584442855476;7597.6201189941385;5358.223057656696;5358.839234822962;5406.891862162814;5531.834044978657;5571.052921003358;5560.527355174855;5642.097264437671;5653.265075540154;5670.8015219467125;5686.687232202268 18:52:05 INFO - PROCESS | 8553 | |4;prototype.html;352.79714164355494;357.7477878095942;361.35317781171705;363.7853666336864;365.9304732100902;5861.912071318929;5881.411858814116;5885.058390657496;5936.851578710534;5938.88122237556;5673.886522269562;5729.140628905666;5730.3123625165035;5741.712914354276;5797.884042319151;4517.864464066075;4524.054656497705;4527.275635898257;4548.522405147445;4554.931676024862;4497.168023915569;4515.390422292981;4522.886927826798;4535.185925629758;4553.931691024637;4445.177642136199;4519.706219095765;4535.070310586339;4538.818447262122;4541.682082254243;4493.438320209973;4507.616852567536;4510.481294651091;4510.842120525782;4539.659525535598;3971.3050216212046;4001.679865610773;4011.7592944423136;4029.7582145071387;4033.556308806029;5573.777048918038;5617.466340697627;5618.494335509824;5627.803026894039;5676.687782171979;4967.571558101145;5112.974435127838;5121.206213036948;5138.614603904722;5145.202493613496;6023.879522409571;6107.4197951194565;6107.5419343548965;6124.112003759475;6163.969180154116;4080.4083407905687;4346.239408103569;4362.149380870732;4375.2124617568825;4402.163588918095;6198.34917333678;6233.657148856811;6266.749330026793;6323.93676063238;6365.236171659384;4394.802233899482;4425.982024134467;4448.377227188196;4460.57261676267;4465.59809617136;4464.352668862996;4487.282034874404;4494.685372023927;4495.123450927038;4513.571210734975;4906.215005599159;5130.255713057503;5133.435322114565;5147.536721695065;5189.896202076013;6008.789692360747;6037;6086.786962456293;6092.360302168208;6106.603070800473;1550.325608360367;1553.130247061649;1564.6792407556425;1572.127469254552;1577.6213708709827;961.2694352292308;992.1963209800085;999.160705007797;1005.9538080396452;1010.161565900301;5219.243209734643;5246.924380501988;5284.260203571503;5294.523492885659;5303.621058524811;5575.107982722745;5584.804531841366;5647.632903861236;5666.263385759825;5692.288463942007;5318.989541817798;5370.194470829407;5568.303962004749;6026.035834266497;6043.244594425697;3382.374260761767;3384.5600071990484;3406.4379377402947;3410.1815564264894;3411.556497655289;6272.7381761483775;6610.900836487456;6622.106015687917;6658.167729033871;6711.966440167768;6377.74489020434;6416.973284274493;6455.644939528371;6456.61182845681;6486.67566621667;6398.520110991787;6554.344565543408;6580.407763301326;6616.4376028037195;6632.336766323329;6255.499560035095;6299.275583307978;6307.896118179208;6352.538916049242;6394.200724909387;5919.7040147991565;6172.444479996821;6219.875602488016;6222.688865556795;6253.843653908689;6376.840578985562;6520.445762110274;6541.771038013647;6549.624578838498;6553.770618028346;4462.48681401643;4520.717037895842;4525.79633916468;4531.184386810406;4537.523560026149;6125.387461253839;6307.432331090224;6323.4625056868845;6323.7786677466065;6347.714352854225;6137.202163718688;6164.291106522807;6166.907496387647;6183;6203.627782333075;5947.494462970696;6161.44546990755;6169.598976066542;6170.963582017834;6227.501799856092;6020.51835853122;6026.879462410815;6036.607620504653;6067.54493412987;6072.696365181635;6112.786052488142;6158.784442544489;6227.595206311576;6230.314665386713;6272.184616000073;5826.650400975955;6069.666168360783;6076.020206764576;6093.268807743099;6148.907766383597 18:52:05 INFO - PROCESS | 8553 | |5;yui.html;756.1946526948799;793.8928244686965;822.5147163173726;824.4846970643347;874.720089571337;14083;15296.235188240598;15835.524934251962;16610.418635347763;16891.324347026104;16296.185190740445;16400.097994610293;16505;16517.752233716503;16565.25456354464;874.5845723281454;902.0528445132617;904.1365495951384;907.2424525521197;908.7773495493614;887.4985633117268;895.3463971300954;895.6865097215988;896.7399454158286;898.2185498616213;926.4395041000199;926.7914719188162;928.2713070239829;929.5816882402912;931.7950050988771;914.4558987402552;922.5848368234322;924.246738907788;925.3198898809403;925.4632313258294;670.8960111182774;672.3343889549311;674.8650269945981;677.089314871502;678.220046946016;16341.83658163415;16406.425775097814;16488.752668709858;16544.66910661792;16582.419615313407;14550.854491455162;14582.562523124217;14816.555503334917;15061.849381506263;15090.849091509164;13116.27860467674;13538.59384218475;14321.427142914272;14358.210298433582;14509.709805803825;4092.815823287959;4126;4144.461220041375;4148.896277593084;4154.584541545852;66480.66759666218;66879;82173;84303;84438.5778071118;12372.938135309267;12499.93750031244;12568.81146782799;12707.618771436872;12773.744525109445;22969;23093.884530577576;23262.3021309361;23342.29973100776;23468.413289667555;8950.283977281802;9128.726138215865;9257.074292570689;9326.72019839406;9365.391249568893;5089.9745501273;5184.7926082956255;5234.450382709837;5248.05535003703;5408.107662235687;3853.4412510185866;3868.516435445569;3930.7248492605245;3962.32640451124;3975.900602484903;689.6310473896441;695.6452209373256;698.671624336561;700.3066963705996;723.2658851265969;687.1101923009714;740.5038624121852;825.4180802534199;852.0967774159411;869.4348673362365;10341.689749307532;10477.9476102619;10675.946620266848;10830;10870.402127882884;689.4174422612884;707.264444977218;781.909236614919;857.7126662567985;869.8086420987372;5044.218146187347;5144.7942082316285;5164.225366195025;5175.7153356564995;5186.844394668166;97586;99272.50363748135;101211;120812.39593801975;121089.39455302666;96186;98897;99226;100381.49809251053;100811.49594252129;93437.5328123355;93456;93545;93860.53069734608;96099;10624.681259562225;10841.241113122005;10923.56305747793;11094.112471002461;11225.60710375133;46254.537454625024;51138.48861511486;52478.737606311726;52638;53284.73357633187;75318.62340688262;80661;81074.59462702648;81582.59208703919;82260;13537.323133843072;13900.096493727875;13989.300534973007;14227.573172804832;14228;15544.30050647701;16133.435329763872;16189.514314570582;16333.183340833148;16590.75113873269;14887.10677359362;14953.102813831205;15026.474073407378;15165;15418.229088545751;15185.468508602145;15387.61530961735;15398.769018464956;15998.600034998752;16335.346586136422;14630.414783408545;14943.476978305707;15045.247737613294;15311.4688531146;15403.69192616119;11879.58421455245;11933.641990740292;12173.634790955932;12797.29614871191;13215.471381145031;11975.401229938643;12550.121491495873;12574.685632859251;12690.555830545887;12844.871551284368 18:52:05 INFO - PROCESS | 8553 | __end_tp_report 18:52:05 INFO - PROCESS | 8553 | __start_cc_report 18:52:05 INFO - PROCESS | 8553 | _x_x_mozilla_cycle_collect,335 18:52:05 INFO - PROCESS | 8553 | __end_cc_report 18:52:05 INFO - PROCESS | 8553 | __startTimestamp1466733124994__endTimestamp 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | ------- Summary: start ------- 18:52:05 INFO - PROCESS | 8553 | Number of tests: 6 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | [#0] dojo.html Cycles:165 Average:5850.52 Median:6117.82 stddev:675.39 (11.0%) stddev-sans-first:649.79 18:52:05 INFO - PROCESS | 8553 | Values: 3411.5 3469.9 3516.6 3521.2 3521.7 5723.7 5795.9 5851.6 5857.7 5889.0 5856.3 5901.0 5942.8 5975.9 5976.5 5290.1 5352.7 5387.9 5406.8 5415.1 5168.4 5181.5 5443.5 5445.9 5471.1 5253.5 5327.0 5347.1 5360.2 5374.9 5323.4 5346.4 5405.3 5412.1 5414.9 5323.9 5348.5 5351.3 5354.8 5397.2 5387.1 5437.7 5443.3 5601.5 5612.3 6229.7 6262.3 6266.1 6292.1 6299.2 6307.1 6335.5 6338.3 6346.0 6348.0 5596.1 5819.4 5830.6 5910.1 5910.4 6430.5 6489.0 6493.0 6496.0 6509.4 6234.4 6240.6 6241.6 6245.5 6246.0 5955.7 6143.5 6229.7 6237.0 6320.2 6224.6 6239.2 6254.1 6264.0 6264.3 6204.8 6264.0 6266.4 6278.8 6281.5 4571.4 4713.0 4753.7 4781.4 4783.3 4276.7 4285.0 4287.5 4289.6 4312.1 5961.5 6036.2 6099.4 6104.5 6117.8 6027.5 6278.7 6327.7 6403.4 6405.2 6017.6 6099.4 6129.8 6138.7 6144.0 5167.0 5364.3 5494.2 5498.8 5503.9 6573.8 6658.8 6706.6 6707.1 6718.0 6395.0 6443.8 6451.9 6462.0 6464.2 6280.4 6445.6 6466.8 6693.8 6706.3 6206.2 6219.5 6227.0 6231.3 6231.9 6290.4 6329.8 6338.0 6341.1 6366.3 5929.5 6131.5 6144.6 6151.2 6159.7 6158.8 6179.7 6199.6 6207.5 6227.4 6063.2 6072.9 6094.3 6125.0 6125.4 5974.1 6117.2 6127.6 6200.9 6284.9 6082.6 6113.3 6115.8 6134.7 6145.3 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | [#1] ext.html Cycles:180 Average:70523.75 Median:40889.59 stddev:166053.94 (406.1%) stddev-sans-first:166436.74 18:52:05 INFO - PROCESS | 8553 | Values: 588.6 642.2 655.9 662.1 674.8 40315.0 44812.3 44907.6 45016.1 45027.0 45207.8 45273.0 45462.8 45686.3 45727.8 9001.0 9115.7 9119.3 9122.6 9146.2 9005.1 9090.7 9091.9 9111.9 9112.0 9127.3 9160.0 9200.6 9203.4 9203.7 9046.6 9048.7 9082.3 9138.5 9172.6 8941.7 9040.5 9044.1 9047.8 9069.9 41523.8 42083.6 42127.8 42134.4 42154.6 3735.8 3933.0 4010.1 4132.8 4309.1 34281.0 34314.5 34334.0 34705.5 35150.5 4321.4 4342.4 4365.6 4372.7 4470.8 390809.0 393303.0 394728.0 394827.0 395913.0 61485.4 61502.4 61714.0 61891.7 61942.0 39163.2 39600.4 40002.2 41738.0 66368.3 19541.1 19713.1 19727.4 19742.8 19743.7 15075.0 15159.3 15176.1 15231.2 15244.2 20862.9 21018.6 21066.5 21106.3 21117.0 7628.6 7741.6 7871.4 7946.4 8067.8 1111.2 1122.4 1159.0 1190.3 1288.1 33254.7 33262.5 33409.2 33602.5 33848.7 1179.9 1194.6 1229.8 1236.6 1315.3 17489.3 17560.3 17581.0 17719.4 17843.0 602609.0 919993.0 939285.0 994485.0 1008903.0 59152.4 60178.4 60293.0 60313.1 60386.0 1478.7 1513.2 1517.9 1525.5 1525.5 30890.0 31843.5 31898.0 31953.4 32640.0 50706.2 51272.2 51325.2 51611.2 51643.0 394153.0 396870.0 397393.0 397780.0 399583.0 29339.6 29466.6 29717.1 29729.4 29738.7 47564.8 48409.8 48839.0 49174.0 49884.3 40560.8 40654.6 41124.6 41154.8 41182.2 39286.0 39667.6 40021.8 40047.0 40226.2 40365.0 41148.0 41300.8 41695.4 42162.8 35591.3 35960.0 36317.0 36417.6 36875.0 27500.0 28018.6 28490.0 28814.3 28837.1 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | [#2] jquery.html Cycles:180 Average:29893.48 Median:13456.55 stddev:86073.78 (639.6%) stddev-sans-first:86286.81 18:52:05 INFO - PROCESS | 8553 | Values: 432.4 438.6 440.0 443.7 443.9 19543.3 19930.6 20452.5 21045.4 21060.3 19200.8 19232.4 19571.7 19905.8 20148.6 5772.2 5912.7 5962.5 5990.3 6007.7 5659.6 5854.6 5856.9 5875.4 5886.4 5806.7 5818.2 5826.9 5837.5 5872.2 5619.1 5785.0 5820.6 5831.2 5849.1 5119.2 5132.2 5139.2 5146.5 5157.4 23620.9 24461.4 24558.5 24621.6 24760.9 2451.7 2602.9 2808.9 3250.4 3271.7 14876.2 15220.8 15336.7 15393.8 15634.9 2004.0 2014.6 2056.9 2082.2 2090.9 56128.7 56798.0 57441.0 81079.6 84178.0 10603.9 10766.3 10829.4 10847.6 10970.5 14899.9 14964.9 14994.8 15000.8 15014.2 8651.0 8803.1 8840.3 8913.2 8918.2 8795.4 8834.1 8849.2 8886.7 8917.4 6625.2 6644.4 6672.3 6720.2 6768.0 1891.4 2059.5 2067.3 2069.2 2120.1 980.7 1069.2 1098.8 1111.1 1186.5 19858.5 20219.9 20284.9 20404.4 20610.6 1089.7 1108.0 1125.8 1160.5 1173.8 11526.0 11546.1 11687.4 11736.5 11978.9 516197.0 516736.0 527136.0 529288.0 536563.0 85933.0 87325.0 89705.0 90007.5 90375.5 1042.5 1063.6 1066.9 1077.6 1078.3 18556.7 18598.9 18703.6 18759.2 18792.5 40289.2 40530.8 40815.0 40933.0 42348.0 54410.0 55156.4 57021.7 57030.0 57568.4 8611.7 8808.7 8821.5 8894.9 9044.2 13227.5 13294.0 13301.5 13429.9 13560.9 11486.9 11754.6 11829.9 11852.5 12033.9 11680.2 11725.6 11755.6 11867.2 11944.9 11902.4 11965.7 12062.9 12191.6 12229.6 8619.8 8713.7 8776.9 8913.2 9013.0 11209.9 11365.4 11637.2 11854.5 11865.2 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | [#3] mootools.html Cycles:180 Average:6379.67 Median:4276.86 stddev:3723.82 (87.1%) stddev-sans-first:3716.80 18:52:05 INFO - PROCESS | 8553 | Values: 1580.1 1600.0 1779.8 1897.7 1930.9 9344.7 9640.3 9907.9 10021.4 10045.3 10021.6 10065.2 10118.0 10214.0 10218.2 2513.2 2545.7 2551.9 2552.5 2556.1 2474.7 2485.4 2494.8 2497.6 2509.9 2491.5 2494.8 2498.6 2504.2 2507.8 2390.6 2396.7 2408.0 2415.0 2417.4 2459.5 2466.6 2469.1 2482.6 2513.1 9810.6 9917.7 9923.7 9932.4 9937.8 5755.6 5886.0 5919.5 5967.7 5974.2 3570.2 3647.5 3690.6 3694.4 3749.9 1233.8 1274.5 1277.7 2265.7 2297.4 13641.2 13710.6 13754.4 13820.0 13951.4 4732.6 4802.0 4835.6 4850.3 4920.4 10864.5 10921.8 10930.2 10944.8 10964.2 5715.3 5717.7 5758.4 5774.5 5790.2 4545.7 5241.4 5302.0 5354.8 5371.0 4092.5 4154.1 4164.1 4179.4 4226.5 1219.5 1271.2 1275.2 1278.6 1282.3 975.2 1033.4 1033.8 1059.4 1062.3 6110.6 6189.9 6277.6 6292.7 6309.0 493.9 498.4 499.9 506.9 512.6 4327.2 4346.3 4348.9 4356.5 4376.2 12040.1 12376.4 12420.0 12429.1 12516.7 12191.1 12196.5 12270.5 12275.4 12313.6 8669.3 8963.1 8964.8 9141.5 9267.2 6451.7 6603.2 6621.2 6657.9 6663.0 10828.7 11350.4 11358.8 11431.7 11447.3 11316.8 11435.4 11522.3 11527.1 11615.1 8410.2 8532.5 8618.5 8687.8 8881.0 9511.9 9515.7 9542.3 9564.9 9587.3 8280.5 8347.9 8405.4 8420.2 8540.6 8171.3 8239.0 8267.8 8348.0 8358.1 7433.4 7516.4 7521.0 7555.6 7597.6 5358.2 5358.8 5406.9 5531.8 5571.1 5560.5 5642.1 5653.3 5670.8 5686.7 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | [#4] prototype.html Cycles:180 Average:5113.50 Median:5710.71 stddev:1511.85 (26.5%) stddev-sans-first:1473.26 18:52:05 INFO - PROCESS | 8553 | Values: 352.8 357.7 361.4 363.8 365.9 5861.9 5881.4 5885.1 5936.9 5938.9 5673.9 5729.1 5730.3 5741.7 5797.9 4517.9 4524.1 4527.3 4548.5 4554.9 4497.2 4515.4 4522.9 4535.2 4553.9 4445.2 4519.7 4535.1 4538.8 4541.7 4493.4 4507.6 4510.5 4510.8 4539.7 3971.3 4001.7 4011.8 4029.8 4033.6 5573.8 5617.5 5618.5 5627.8 5676.7 4967.6 5113.0 5121.2 5138.6 5145.2 6023.9 6107.4 6107.5 6124.1 6164.0 4080.4 4346.2 4362.1 4375.2 4402.2 6198.3 6233.7 6266.7 6323.9 6365.2 4394.8 4426.0 4448.4 4460.6 4465.6 4464.4 4487.3 4494.7 4495.1 4513.6 4906.2 5130.3 5133.4 5147.5 5189.9 6008.8 6037.0 6086.8 6092.4 6106.6 1550.3 1553.1 1564.7 1572.1 1577.6 961.3 992.2 999.2 1006.0 1010.2 5219.2 5246.9 5284.3 5294.5 5303.6 5575.1 5584.8 5647.6 5666.3 5692.3 5319.0 5370.2 5568.3 6026.0 6043.2 3382.4 3384.6 3406.4 3410.2 3411.6 6272.7 6610.9 6622.1 6658.2 6712.0 6377.7 6417.0 6455.6 6456.6 6486.7 6398.5 6554.3 6580.4 6616.4 6632.3 6255.5 6299.3 6307.9 6352.5 6394.2 5919.7 6172.4 6219.9 6222.7 6253.8 6376.8 6520.4 6541.8 6549.6 6553.8 4462.5 4520.7 4525.8 4531.2 4537.5 6125.4 6307.4 6323.5 6323.8 6347.7 6137.2 6164.3 6166.9 6183.0 6203.6 5947.5 6161.4 6169.6 6171.0 6227.5 6020.5 6026.9 6036.6 6067.5 6072.7 6112.8 6158.8 6227.6 6230.3 6272.2 5826.7 6069.7 6076.0 6093.3 6148.9 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - PROCESS | 8553 | [#5] yui.html Cycles:180 Average:21670.76 Median:4109.41 stddev:30066.24 (731.6%) stddev-sans-first:30109.57 18:52:05 INFO - PROCESS | 8553 | Values: 756.2 793.9 822.5 824.5 874.7 14083.0 15296.2 15835.5 16610.4 16891.3 16296.2 16400.1 16505.0 16517.8 16565.3 874.6 902.1 904.1 907.2 908.8 887.5 895.3 895.7 896.7 898.2 926.4 926.8 928.3 929.6 931.8 914.5 922.6 924.2 925.3 925.5 670.9 672.3 674.9 677.1 678.2 16341.8 16406.4 16488.8 16544.7 16582.4 14550.9 14582.6 14816.6 15061.8 15090.8 13116.3 13538.6 14321.4 14358.2 14509.7 4092.8 4126.0 4144.5 4148.9 4154.6 66480.7 66879.0 82173.0 84303.0 84438.6 12372.9 12499.9 12568.8 12707.6 12773.7 22969.0 23093.9 23262.3 23342.3 23468.4 8950.3 9128.7 9257.1 9326.7 9365.4 5090.0 5184.8 5234.5 5248.1 5408.1 3853.4 3868.5 3930.7 3962.3 3975.9 689.6 695.6 698.7 700.3 723.3 687.1 740.5 825.4 852.1 869.4 10341.7 10477.9 10675.9 10830.0 10870.4 689.4 707.3 781.9 857.7 869.8 5044.2 5144.8 5164.2 5175.7 5186.8 97586.0 99272.5 101211.0 120812.4 121089.4 96186.0 98897.0 99226.0 100381.5 100811.5 93437.5 93456.0 93545.0 93860.5 96099.0 10624.7 10841.2 10923.6 11094.1 11225.6 46254.5 51138.5 52478.7 52638.0 53284.7 75318.6 80661.0 81074.6 81582.6 82260.0 13537.3 13900.1 13989.3 14227.6 14228.0 15544.3 16133.4 16189.5 16333.2 16590.8 14887.1 14953.1 15026.5 15165.0 15418.2 15185.5 15387.6 15398.8 15998.6 16335.3 14630.4 14943.5 15045.2 15311.5 15403.7 11879.6 11933.6 12173.6 12797.3 13215.5 11975.4 12550.1 12574.7 12690.6 12844.9 18:52:05 INFO - PROCESS | 8553 | -------- Summary: end -------- 18:52:05 INFO - PROCESS | 8553 | 18:52:05 INFO - TEST-INFO | 8553: exit 0 18:52:05 INFO - TEST-OK | dromaeo_css | took 1110814ms 18:52:05 INFO - TEST-START | kraken 18:52:05 INFO - operating with platform_type : linux_ 18:52:05 INFO - Initialising browser for kraken test... 18:52:05 INFO - TEST-INFO | started process 8795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyOPAPx/profile http://localhost:41997/getInfo.html) 18:52:10 INFO - PROCESS | 8795 | __metrics Screen width/height:1600/1200 18:52:10 INFO - PROCESS | 8795 | colorDepth:24 18:52:10 INFO - PROCESS | 8795 | Browser inner width/height: 1024/697 18:52:10 INFO - PROCESS | 8795 | __metrics 18:52:11 ERROR - PROCESS | 8795 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:52:11 INFO - TEST-INFO | 8795: exit 0 18:52:11 INFO - Browser initialized. 18:52:11 INFO - Running cycle 1/1 for kraken test... 18:52:11 INFO - TEST-INFO | started process 8924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyOPAPx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:23 INFO - PROCESS | 8924 | RSS: Main: 156102656 18:52:23 INFO - PROCESS | 8924 | 18:52:26 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41997/tests/kraken/driver.html?testName=audio-beat-detection) 18:52:27 INFO - PROCESS | 8924 | RSS: Main: 161300480 18:52:27 INFO - PROCESS | 8924 | 18:52:29 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41997/tests/kraken/driver.html?testName=audio-dft) 18:52:30 INFO - PROCESS | 8924 | RSS: Main: 160927744 18:52:30 INFO - PROCESS | 8924 | 18:52:33 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41997/tests/kraken/driver.html?testName=audio-fft) 18:52:33 INFO - PROCESS | 8924 | RSS: Main: 162553856 18:52:33 INFO - PROCESS | 8924 | 18:52:35 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41997/tests/kraken/driver.html?testName=audio-oscillator) 18:52:36 INFO - PROCESS | 8924 | RSS: Main: 161337344 18:52:36 INFO - PROCESS | 8924 | 18:52:38 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:52:39 INFO - PROCESS | 8924 | RSS: Main: 161275904 18:52:39 INFO - PROCESS | 8924 | 18:52:42 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41997/tests/kraken/driver.html?testName=imaging-darkroom) 18:52:43 INFO - PROCESS | 8924 | RSS: Main: 161402880 18:52:43 INFO - PROCESS | 8924 | 18:52:46 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41997/tests/kraken/driver.html?testName=imaging-desaturate) 18:52:47 INFO - PROCESS | 8924 | RSS: Main: 162131968 18:52:47 INFO - PROCESS | 8924 | 18:52:49 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41997/tests/kraken/driver.html?testName=json-parse-financial) 18:52:50 INFO - PROCESS | 8924 | RSS: Main: 162095104 18:52:50 INFO - PROCESS | 8924 | 18:52:52 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:52:52 INFO - PROCESS | 8924 | RSS: Main: 161247232 18:52:52 INFO - PROCESS | 8924 | 18:52:54 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:52:55 INFO - PROCESS | 8924 | RSS: Main: 161517568 18:52:55 INFO - PROCESS | 8924 | 18:52:57 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:52:57 INFO - PROCESS | 8924 | RSS: Main: 161832960 18:52:57 INFO - PROCESS | 8924 | 18:53:00 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:00 INFO - PROCESS | 8924 | RSS: Main: 162349056 18:53:00 INFO - PROCESS | 8924 | 18:53:03 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:04 INFO - PROCESS | 8924 | RSS: Main: 162058240 18:53:04 INFO - PROCESS | 8924 | 18:53:05 INFO - PROCESS | 8924 | Cycle 1(1): loaded http://localhost:41997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41997/tests/kraken/driver.html?testName=ai-astar) 18:53:06 INFO - PROCESS | 8924 | RSS: Main: 162705408 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | __start_tp_report 18:53:06 INFO - PROCESS | 8924 | _x_x_mozilla_page_load 18:53:06 INFO - PROCESS | 8924 | _x_x_mozilla_page_load_details 18:53:06 INFO - PROCESS | 8924 | |i|pagename|runs| 18:53:06 INFO - PROCESS | 8924 | |0;ai-astar;110;103;112;111;111;109;108;109;111;107 18:53:06 INFO - PROCESS | 8924 | |1;audio-beat-detection;157;123;152;178;125;154;151;129;181;130 18:53:06 INFO - PROCESS | 8924 | |2;audio-dft;162;163;162;163;162;162;160;163;163;163 18:53:06 INFO - PROCESS | 8924 | |3;audio-fft;77;76;75;172;76;75;74;75;172;75 18:53:06 INFO - PROCESS | 8924 | |4;audio-oscillator;86;86;164;85;85;85;151;85;84;137 18:53:06 INFO - PROCESS | 8924 | |5;imaging-gaussian-blur;117;118;117;119;119;118;118;119;118;118 18:53:06 INFO - PROCESS | 8924 | |6;imaging-darkroom;147;146;147;147;146;147;149;147;147;147 18:53:06 INFO - PROCESS | 8924 | |7;imaging-desaturate;95;95;96;95;96;95;95;95;96;96 18:53:06 INFO - PROCESS | 8924 | |8;json-parse-financial;50;52;51;51;59;52;52;52;51;51 18:53:06 INFO - PROCESS | 8924 | |9;json-stringify-tinderbox;59;60;60;60;60;61;60;60;64;61 18:53:06 INFO - PROCESS | 8924 | |10;stanford-crypto-aes;76;77;76;75;82;77;81;77;107;77 18:53:06 INFO - PROCESS | 8924 | |11;stanford-crypto-ccm;120;127;125;130;133;122;120;120;132;124 18:53:06 INFO - PROCESS | 8924 | |12;stanford-crypto-pbkdf2;157;151;151;153;154;153;152;157;149;151 18:53:06 INFO - PROCESS | 8924 | |13;stanford-crypto-sha256-iterative;71;67;62;62;63;65;61;61;61;59 18:53:06 INFO - PROCESS | 8924 | __end_tp_report 18:53:06 INFO - PROCESS | 8924 | __start_cc_report 18:53:06 INFO - PROCESS | 8924 | _x_x_mozilla_cycle_collect,892 18:53:06 INFO - PROCESS | 8924 | __end_cc_report 18:53:06 INFO - PROCESS | 8924 | __startTimestamp1466733186087__endTimestamp 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | ------- Summary: start ------- 18:53:06 INFO - PROCESS | 8924 | Number of tests: 14 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:2.64 (2.4%) stddev-sans-first:2.78 18:53:06 INFO - PROCESS | 8924 | Values: 110.0 103.0 112.0 111.0 111.0 109.0 108.0 109.0 111.0 107.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.00 stddev:21.00 (13.7%) stddev-sans-first:22.02 18:53:06 INFO - PROCESS | 8924 | Values: 157.0 123.0 152.0 178.0 125.0 154.0 151.0 129.0 181.0 130.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 18:53:06 INFO - PROCESS | 8924 | Values: 162.0 163.0 162.0 163.0 162.0 162.0 160.0 163.0 163.0 163.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:40.75 (54.3%) stddev-sans-first:42.71 18:53:06 INFO - PROCESS | 8924 | Values: 77.0 76.0 75.0 172.0 76.0 75.0 74.0 75.0 172.0 75.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:85.00 stddev:32.29 (38.0%) stddev-sans-first:33.52 18:53:06 INFO - PROCESS | 8924 | Values: 86.0 86.0 164.0 85.0 85.0 85.0 151.0 85.0 84.0 137.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 18:53:06 INFO - PROCESS | 8924 | Values: 117.0 118.0 117.0 119.0 119.0 118.0 118.0 119.0 118.0 118.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 18:53:06 INFO - PROCESS | 8924 | Values: 147.0 146.0 147.0 147.0 146.0 147.0 149.0 147.0 147.0 147.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:53:06 INFO - PROCESS | 8924 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:2.51 (4.8%) stddev-sans-first:2.55 18:53:06 INFO - PROCESS | 8924 | Values: 50.0 52.0 51.0 51.0 59.0 52.0 52.0 52.0 51.0 51.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:1.35 (2.3%) stddev-sans-first:1.32 18:53:06 INFO - PROCESS | 8924 | Values: 59.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 64.0 61.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:77.00 stddev:9.57 (12.4%) stddev-sans-first:10.01 18:53:06 INFO - PROCESS | 8924 | Values: 76.0 77.0 76.0 75.0 82.0 77.0 81.0 77.0 107.0 77.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.00 stddev:5.01 (4.0%) stddev-sans-first:4.94 18:53:06 INFO - PROCESS | 8924 | Values: 120.0 127.0 125.0 130.0 133.0 122.0 120.0 120.0 132.0 124.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:153.00 stddev:2.62 (1.7%) stddev-sans-first:2.29 18:53:06 INFO - PROCESS | 8924 | Values: 157.0 151.0 151.0 153.0 154.0 153.0 152.0 157.0 149.0 151.0 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - PROCESS | 8924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:62.50 stddev:3.55 (5.7%) stddev-sans-first:2.40 18:53:06 INFO - PROCESS | 8924 | Values: 71.0 67.0 62.0 62.0 63.0 65.0 61.0 61.0 61.0 59.0 18:53:06 INFO - PROCESS | 8924 | -------- Summary: end -------- 18:53:06 INFO - PROCESS | 8924 | 18:53:06 INFO - TEST-INFO | 8924: exit 0 18:53:07 INFO - TEST-OK | kraken | took 61379ms 18:53:07 INFO - SUITE-END | took 1172s 18:53:07 INFO - Completed test suite (00:19:32) 18:53:07 INFO - javascript benchmark 18:53:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7805.561842265666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3411.4541673332265, 3469.8785542506016, 3516.630753770854, 3521.1901262709575, 3521.7182625389974, 5723.713814309283, 5795.913061304083, 5851.590388672789, 5857.6778277194735, 5888.970555147218, 5856.297244330686, 5901.0, 5942.762289508414, 5975.910361344583, 5976.491998180149, 5290.074237008527, 5352.652077614962, 5387.865303367408, 5406.83779486616, 5415.079436495806, 5168.405633352157, 5181.481851814826, 5443.510084092451, 5445.863853403657, 5471.069918113911, 5253.4746525347355, 5327.041132596131, 5347.144456886899, 5360.222767698681, 5374.892502149954, 5323.441038690939, 5346.4118946915805, 5405.297311349539, 5412.07994640912, 5414.945850541483, 5323.946760532383, 5348.51863332298, 5351.304330437058, 5354.812581559627, 5397.2443857859935, 5387.084195686703, 5437.673739575598, 5443.292371991655, 5601.467860553241, 5612.298462692163, 6229.6573688447115, 6262.279837818618, 6266.091416744546, 6292.056191571255, 6299.181106456177, 6307.0539419087045, 6335.461485773669, 6338.334474880117, 6346.0, 6347.968260158716, 5596.132599447093, 5819.359870414251, 5830.62100963436, 5910.113482977587, 5910.379410161957, 6430.453411459985, 6489.026646003137, 6493.026046093029, 6495.967520162369, 6509.44669703071, 6234.37656234382, 6240.625562466266, 6241.625502469776, 6245.500359971192, 6245.96877015612, 5955.67243801595, 6143.542582966849, 6229.688515574203, 6237.0, 6320.178376810985, 6224.595401298901, 6239.1577137085915, 6254.061890716338, 6263.9664455364355, 6264.279607845065, 6204.81385558425, 6264.0, 6266.404691554295, 6278.811635650938, 6281.466075383643, 4571.428571428572, 4712.95287047132, 4753.667243293005, 4781.402324709411, 4783.258594917794, 4276.743395396286, 4285.035866929916, 4287.528371879091, 4289.613934745826, 4312.116016216668, 5961.463468287789, 6036.245469316335, 6099.420555047263, 6104.4505994460715, 6117.816465506042, 6027.517798576104, 6278.6546739929745, 6327.715252813635, 6403.423691867662, 6405.167328247298, 6017.578769486094, 6099.390060993954, 6129.816105516842, 6138.6623735694075, 6144.0476726106635, 5167.044096842096, 5364.302640656768, 5494.1758736189095, 5498.8075417361, 5503.889922201533, 6573.83565410859, 6658.766943156967, 6706.5640733352175, 6707.094542236736, 6717.966410167918, 6395.0, 6443.806685799434, 6451.935480645321, 6462.0, 6464.191976003, 6280.403361680633, 6445.581037232565, 6466.805995820133, 6693.799186024427, 6706.295838937037, 6206.224221972254, 6219.533534984804, 6226.968865155645, 6231.314555398993, 6231.875362492816, 6290.370962903673, 6329.810105696836, 6337.96831015842, 6341.143945567474, 6366.331535188924, 5929.495992840657, 6131.478824299985, 6144.631322120687, 6151.169592105009, 6159.661218632839, 6158.846028849314, 6179.660118693515, 6199.628022318675, 6207.503399727921, 6227.377262273736, 6063.211782468251, 6072.90890636632, 6094.268687757498, 6124.969375153096, 6125.387461253839, 5974.103884417372, 6117.188044311343, 6127.556056270746, 6200.906986395298, 6284.874302514016, 6082.60463069899, 6113.327533971171, 6115.755369785159, 6134.6625935573975, 6145.324014358506], "value": 5805.200509975744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.602693182102, 642.1972534332085, 655.8524332025295, 662.0896267632007, 674.8211723893166, 40315.0, 44812.3278150828, 44907.55092449079, 45016.09967800642, 45027.0, 45207.77396113015, 45273.0, 45462.7726861366, 45686.314705279365, 45727.771361143234, 9000.95499522503, 9115.68095116671, 9119.270458363348, 9122.589483473259, 9146.176844084031, 9005.099490051009, 9090.681826136086, 9091.909080909172, 9111.908880911205, 9112.043235460247, 9127.315451341143, 9159.954200228989, 9200.631974721004, 9203.355765096447, 9203.723888283363, 9046.638134474613, 9048.683296084606, 9082.273418126568, 9138.497382643918, 9172.578250371136, 8941.687040953535, 9040.502772347518, 9044.050374710692, 9047.773805654846, 9069.863952040725, 41523.792381038205, 42083.57916420827, 42127.78936105331, 42134.36798448026, 42154.57845421537, 3735.794531300777, 3933.0, 4010.0776821330965, 4132.793360331972, 4309.095090031097, 34281.0, 34314.48528272053, 34334.0, 34705.479417808754, 35150.472742908874, 4321.351797230409, 4342.435483387139, 4365.607095361433, 4372.672049596261, 4470.821167153343, 390809.0, 393303.0, 394728.0, 394827.0, 395913.0, 61485.385146147964, 61502.38497614967, 61714.0, 61891.690541547, 61942.0, 39163.216735665126, 39600.40599391011, 40002.19995600072, 41738.0, 66368.33631663719, 19541.120649570803, 19713.112909919088, 19727.40817775469, 19742.802571974386, 19743.703844442345, 15075.020123691926, 15159.317830697644, 15176.089434633957, 15231.238438078051, 15244.23778811055, 20862.895685521475, 21018.579628407653, 21066.47333816667, 21106.261280855095, 21117.0, 7628.618569071524, 7741.625981320536, 7871.448998570159, 7946.364290856717, 8067.757967260992, 1111.2332490581634, 1122.4443900269418, 1158.9710257243469, 1190.297724342642, 1288.0790234982032, 33254.66745332516, 33262.50106248408, 33409.16477088044, 33602.495962560584, 33848.66151338455, 1179.899708524785, 1194.6296648039136, 1229.8032314829584, 1236.5981056156786, 1315.3291821171272, 17489.30042798299, 17560.29758809633, 17581.0, 17719.379821706178, 17843.0, 602609.0, 919993.0, 939285.0, 994485.0, 1008903.0, 59152.40847591469, 60178.39821601728, 60293.0, 60313.09530357048, 60386.0, 1478.6672998575234, 1513.2055670772932, 1517.8937474376687, 1525.5118362124015, 1525.5347119128994, 30890.0, 31843.522347164348, 31898.0, 31953.36093278075, 32640.020799376056, 50706.2394064082, 51272.23091653553, 51325.23012154746, 51611.22583161331, 51643.0, 394153.0, 396870.0, 397393.0, 397780.0, 399583.0, 29339.559906601844, 29466.558001629564, 29717.108486745434, 29729.405411892072, 29738.702612973593, 47564.762176188895, 48409.75795121002, 48839.0, 49174.0, 49884.25173622471, 40560.79719601383, 40654.59345406508, 41124.588754113276, 41154.79422602868, 41182.176356473305, 39286.0, 39667.60332396639, 40021.79989100036, 40047.0, 40226.19547608973, 40365.0, 41148.0, 41300.793496032325, 41695.37456938209, 42162.78918605387, 35591.28817423689, 35960.0, 36317.0, 36417.635823642486, 36875.0, 27500.0, 28018.579721303788, 28490.0, 28814.279643008253, 28837.134885953456], "value": 21138.5591889572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.36874163720967, 438.6291350967813, 440.04510212838136, 443.7093703624125, 443.8845900065984, 19543.315983940563, 19930.60138797225, 20452.488687782814, 21045.368638940858, 21060.262890798826, 19200.83186274263, 19232.423027309167, 19571.70642440361, 19905.800941990576, 20148.597028059467, 5772.191893134954, 5912.704364781765, 5962.463378295953, 5990.341062483145, 6007.6996150192535, 5659.6321239119325, 5854.560907931901, 5856.882862342751, 5875.412458754133, 5886.440788125121, 5806.65160090396, 5818.185454036438, 5826.883462330751, 5837.503812175949, 5872.236609240814, 5619.072852979253, 5784.971075144639, 5820.563457740665, 5831.183634291224, 5849.093390524433, 5119.180931051052, 5132.204508301219, 5139.203423469368, 5146.459621739701, 5157.355330583677, 23620.881895590413, 24461.38846528833, 24558.50882982348, 24621.63067553988, 24760.87619561891, 2451.705795304575, 2602.9479410411877, 2808.9438211235865, 3250.3986762448785, 3271.6728327167093, 14876.181810000446, 15220.847791522054, 15336.693266134727, 15393.769093463607, 15634.921825390915, 2003.9599208015904, 2014.617222727677, 2056.856020078595, 2082.1567265257595, 2090.9163633454646, 56128.71935640296, 56798.0, 57441.0, 81079.59460202721, 84178.0, 10603.94698026505, 10766.300190487593, 10829.35023898553, 10847.620333288298, 10970.506327215295, 14899.925500372428, 14964.850351496563, 14994.775078373834, 15000.849991500163, 15014.174220417983, 8650.95674521636, 8803.119688031145, 8840.292776577988, 8913.242374398249, 8918.152775486318, 8795.384323097449, 8834.116588341114, 8849.159329863782, 8886.73339799807, 8917.42036767608, 6625.204975402886, 6644.368784965421, 6672.332766723289, 6720.1599800025, 6768.018637297564, 1891.3758459708263, 2059.4897175186293, 2067.2557879163487, 2069.2343832781667, 2120.141342756186, 980.7057882635181, 1069.2099394711736, 1098.780243951197, 1111.0889070961734, 1186.5135294529202, 19858.50353741168, 20219.898900505697, 20284.898575507028, 20404.387868363974, 20610.572599180334, 1089.722120859176, 1107.9778404432027, 1125.8198688209848, 1160.5415860735131, 1173.7769823733463, 11526.0, 11546.076313894868, 11687.357195354338, 11736.530538778525, 11978.880211197951, 516197.0, 516736.0, 527136.0, 529288.0, 536563.0, 85933.0, 87325.0, 89705.0, 90007.54996225108, 90375.54812225897, 1042.5464922758624, 1063.5745701719375, 1066.898644628759, 1077.590515604081, 1078.3314345106085, 18556.721649175004, 18598.907005464887, 18703.625927481648, 18759.15583798705, 18792.530186744894, 40289.19421611493, 40530.79734601308, 40815.0, 40933.0, 42348.0, 54410.0, 55156.44843551674, 57021.714891425276, 57030.0, 57568.424315757984, 8611.741647750578, 8808.735737927873, 8821.514816685143, 8894.911050889408, 9044.186023257938, 13227.47090116423, 13294.0, 13301.534446294334, 13429.865701342862, 13560.86439135596, 11486.885131148581, 11754.647360579196, 11829.881701182878, 11852.525898963944, 12033.939830300793, 11680.240784348991, 11725.589604363806, 11755.647330580096, 11867.228630139014, 11944.880551194377, 11902.40487975615, 11965.700857478285, 12062.879371206176, 12191.573294934635, 12229.571964981184, 8619.82760344802, 8713.695020674246, 8776.91223087761, 8913.153250441197, 9012.954935225544, 11209.943950280523, 11365.431728413712, 11637.185397022466, 11854.466549005143, 11865.228760130563], "value": 9705.6413127656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.0519688187085, 1600.0, 1779.848712859407, 1897.7153426985942, 1930.9227630894766, 9344.719658410242, 9640.276979226568, 9907.900920990787, 10021.398716077041, 10045.296829221948, 10021.649242276522, 10065.245106616996, 10118.0, 10214.029667181625, 10218.182545396368, 2513.195777351248, 2545.707243666974, 2551.9362015949655, 2552.515022145786, 2556.1053631229106, 2474.6906636670415, 2485.428351479161, 2494.837835540693, 2497.6378425128346, 2509.8870550825163, 2491.48924470484, 2494.7505249475, 2498.6376975338567, 2504.211173480348, 2507.8369905956056, 2390.5696974544576, 2396.6524853896176, 2407.9759202408104, 2414.95170096598, 2417.3714834143075, 2459.483508463207, 2466.580681284186, 2469.086438017945, 2482.5779617465073, 2513.1329691256487, 9810.558524866397, 9917.65288214909, 9923.702288931272, 9932.354396964247, 9937.801243975153, 5755.625884317506, 5886.0, 5919.496842768327, 5967.701614919237, 5974.163617093611, 3570.1610121621397, 3647.4528820676846, 3690.6493883081066, 3694.408894576855, 3749.925001499982, 1233.7655845389347, 1274.4838340472124, 1277.6933535951398, 2265.677680377626, 2297.3911913342977, 13641.181529108186, 13710.588682339545, 13754.449822007007, 13820.0, 13951.441942322295, 4732.621390288768, 4802.0, 4835.637327200404, 4850.296706977469, 4920.4095508538485, 10864.511097000654, 10921.836172457419, 10930.234883558074, 10944.781104377867, 10964.232503724823, 5715.31416230055, 5717.742701578356, 5758.395368486333, 5774.480296773227, 5790.247267855236, 4545.659075569345, 5241.449647786927, 5302.0, 5354.839354819362, 5371.033214021436, 4092.4679791627495, 4154.065335299533, 4164.083901541656, 4179.393987871742, 4226.535081141072, 1219.4878151176526, 1271.1927925767204, 1275.2476039136768, 1278.6291975327238, 1282.2562913510142, 975.23444096384, 1033.4471057984092, 1033.8035773203067, 1059.433203236265, 1062.2776511971779, 6110.633361998294, 6189.938100619026, 6277.5605707600025, 6292.748290068437, 6309.0, 493.93084968104495, 498.4467241362085, 499.8825276060123, 506.92396140579206, 512.6104160837716, 4327.17783621111, 4346.348047792793, 4348.9130217396105, 4356.455443069616, 4376.190404775127, 12040.096992725581, 12376.381180940916, 12420.0, 12429.12996090265, 12516.74966500665, 12191.14661973671, 12196.512139514498, 12270.509179632714, 12275.447604857804, 12313.630591082281, 8669.263112635497, 8963.058878817761, 8964.820703585892, 9141.497217652959, 9267.212286955684, 6451.741930322734, 6603.207615086028, 6621.238557565942, 6657.900131497934, 6663.0, 10828.675139745821, 11350.432478375884, 11358.772824543628, 11431.657050288504, 11447.313161210353, 11316.830247546459, 11435.428228588704, 11522.308661480338, 11527.135464840003, 11615.128865334964, 8410.201030902055, 8532.530710810965, 8618.525981071101, 8687.826243475221, 8881.0, 9511.857322140311, 9515.714528564155, 9542.33203675736, 9564.856527151958, 9587.280953928344, 8280.544570048705, 8347.874781878398, 8405.369597280107, 8420.15798420153, 8540.572971351532, 8171.346292296483, 8238.958805205935, 8267.751967440987, 8348.039975402906, 8358.080611132893, 7433.368163705929, 7516.436267280085, 7521.022267105242, 7555.584442855476, 7597.6201189941385, 5358.223057656696, 5358.839234822962, 5406.891862162814, 5531.834044978657, 5571.052921003358, 5560.527355174855, 5642.097264437671, 5653.265075540154, 5670.8015219467125, 5686.687232202268], "value": 5000.4621614472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.79714164355494, 357.7477878095942, 361.35317781171705, 363.7853666336864, 365.9304732100902, 5861.912071318929, 5881.411858814116, 5885.058390657496, 5936.851578710534, 5938.88122237556, 5673.886522269562, 5729.140628905666, 5730.3123625165035, 5741.712914354276, 5797.884042319151, 4517.864464066075, 4524.054656497705, 4527.275635898257, 4548.522405147445, 4554.931676024862, 4497.168023915569, 4515.390422292981, 4522.886927826798, 4535.185925629758, 4553.931691024637, 4445.177642136199, 4519.706219095765, 4535.070310586339, 4538.818447262122, 4541.682082254243, 4493.438320209973, 4507.616852567536, 4510.481294651091, 4510.842120525782, 4539.659525535598, 3971.3050216212046, 4001.679865610773, 4011.7592944423136, 4029.7582145071387, 4033.556308806029, 5573.777048918038, 5617.466340697627, 5618.494335509824, 5627.803026894039, 5676.687782171979, 4967.571558101145, 5112.974435127838, 5121.206213036948, 5138.614603904722, 5145.202493613496, 6023.879522409571, 6107.4197951194565, 6107.5419343548965, 6124.112003759475, 6163.969180154116, 4080.4083407905687, 4346.239408103569, 4362.149380870732, 4375.2124617568825, 4402.163588918095, 6198.34917333678, 6233.657148856811, 6266.749330026793, 6323.93676063238, 6365.236171659384, 4394.802233899482, 4425.982024134467, 4448.377227188196, 4460.57261676267, 4465.59809617136, 4464.352668862996, 4487.282034874404, 4494.685372023927, 4495.123450927038, 4513.571210734975, 4906.215005599159, 5130.255713057503, 5133.435322114565, 5147.536721695065, 5189.896202076013, 6008.789692360747, 6037.0, 6086.786962456293, 6092.360302168208, 6106.603070800473, 1550.325608360367, 1553.130247061649, 1564.6792407556425, 1572.127469254552, 1577.6213708709827, 961.2694352292308, 992.1963209800085, 999.160705007797, 1005.9538080396452, 1010.161565900301, 5219.243209734643, 5246.924380501988, 5284.260203571503, 5294.523492885659, 5303.621058524811, 5575.107982722745, 5584.804531841366, 5647.632903861236, 5666.263385759825, 5692.288463942007, 5318.989541817798, 5370.194470829407, 5568.303962004749, 6026.035834266497, 6043.244594425697, 3382.374260761767, 3384.5600071990484, 3406.4379377402947, 3410.1815564264894, 3411.556497655289, 6272.7381761483775, 6610.900836487456, 6622.106015687917, 6658.167729033871, 6711.966440167768, 6377.74489020434, 6416.973284274493, 6455.644939528371, 6456.61182845681, 6486.67566621667, 6398.520110991787, 6554.344565543408, 6580.407763301326, 6616.4376028037195, 6632.336766323329, 6255.499560035095, 6299.275583307978, 6307.896118179208, 6352.538916049242, 6394.200724909387, 5919.7040147991565, 6172.444479996821, 6219.875602488016, 6222.688865556795, 6253.843653908689, 6376.840578985562, 6520.445762110274, 6541.771038013647, 6549.624578838498, 6553.770618028346, 4462.48681401643, 4520.717037895842, 4525.79633916468, 4531.184386810406, 4537.523560026149, 6125.387461253839, 6307.432331090224, 6323.4625056868845, 6323.7786677466065, 6347.714352854225, 6137.202163718688, 6164.291106522807, 6166.907496387647, 6183.0, 6203.627782333075, 5947.494462970696, 6161.44546990755, 6169.598976066542, 6170.963582017834, 6227.501799856092, 6020.51835853122, 6026.879462410815, 6036.607620504653, 6067.54493412987, 6072.696365181635, 6112.786052488142, 6158.784442544489, 6227.595206311576, 6230.314665386713, 6272.184616000073, 5826.650400975955, 6069.666168360783, 6076.020206764576, 6093.268807743099, 6148.907766383597], "value": 4629.590283121677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.1946526948799, 793.8928244686965, 822.5147163173726, 824.4846970643347, 874.720089571337, 14083.0, 15296.235188240598, 15835.524934251962, 16610.418635347763, 16891.324347026104, 16296.185190740445, 16400.097994610293, 16505.0, 16517.752233716503, 16565.25456354464, 874.5845723281454, 902.0528445132617, 904.1365495951384, 907.2424525521197, 908.7773495493614, 887.4985633117268, 895.3463971300954, 895.6865097215988, 896.7399454158286, 898.2185498616213, 926.4395041000199, 926.7914719188162, 928.2713070239829, 929.5816882402912, 931.7950050988771, 914.4558987402552, 922.5848368234322, 924.246738907788, 925.3198898809403, 925.4632313258294, 670.8960111182774, 672.3343889549311, 674.8650269945981, 677.089314871502, 678.220046946016, 16341.83658163415, 16406.425775097814, 16488.752668709858, 16544.66910661792, 16582.419615313407, 14550.854491455162, 14582.562523124217, 14816.555503334917, 15061.849381506263, 15090.849091509164, 13116.27860467674, 13538.59384218475, 14321.427142914272, 14358.210298433582, 14509.709805803825, 4092.815823287959, 4126.0, 4144.461220041375, 4148.896277593084, 4154.584541545852, 66480.66759666218, 66879.0, 82173.0, 84303.0, 84438.5778071118, 12372.938135309267, 12499.93750031244, 12568.81146782799, 12707.618771436872, 12773.744525109445, 22969.0, 23093.884530577576, 23262.3021309361, 23342.29973100776, 23468.413289667555, 8950.283977281802, 9128.726138215865, 9257.074292570689, 9326.72019839406, 9365.391249568893, 5089.9745501273, 5184.7926082956255, 5234.450382709837, 5248.05535003703, 5408.107662235687, 3853.4412510185866, 3868.516435445569, 3930.7248492605245, 3962.32640451124, 3975.900602484903, 689.6310473896441, 695.6452209373256, 698.671624336561, 700.3066963705996, 723.2658851265969, 687.1101923009714, 740.5038624121852, 825.4180802534199, 852.0967774159411, 869.4348673362365, 10341.689749307532, 10477.9476102619, 10675.946620266848, 10830.0, 10870.402127882884, 689.4174422612884, 707.264444977218, 781.909236614919, 857.7126662567985, 869.8086420987372, 5044.218146187347, 5144.7942082316285, 5164.225366195025, 5175.7153356564995, 5186.844394668166, 97586.0, 99272.50363748135, 101211.0, 120812.39593801975, 121089.39455302666, 96186.0, 98897.0, 99226.0, 100381.49809251053, 100811.49594252129, 93437.5328123355, 93456.0, 93545.0, 93860.53069734608, 96099.0, 10624.681259562225, 10841.241113122005, 10923.56305747793, 11094.112471002461, 11225.60710375133, 46254.537454625024, 51138.48861511486, 52478.737606311726, 52638.0, 53284.73357633187, 75318.62340688262, 80661.0, 81074.59462702648, 81582.59208703919, 82260.0, 13537.323133843072, 13900.096493727875, 13989.300534973007, 14227.573172804832, 14228.0, 15544.30050647701, 16133.435329763872, 16189.514314570582, 16333.183340833148, 16590.75113873269, 14887.10677359362, 14953.102813831205, 15026.474073407378, 15165.0, 15418.229088545751, 15185.468508602145, 15387.61530961735, 15398.769018464956, 15998.600034998752, 16335.346586136422, 14630.414783408545, 14943.476978305707, 15045.247737613294, 15311.4688531146, 15403.69192616119, 11879.58421455245, 11933.641990740292, 12173.634790955932, 12797.29614871191, 13215.471381145031, 11975.401229938643, 12550.121491495873, 12574.685632859251, 12690.555830545887, 12844.871551284368], "value": 8201.921304091788, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 112.0, 111.0, 111.0, 109.0, 108.0, 109.0, 111.0, 107.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 152.0, 178.0, 125.0, 154.0, 151.0, 129.0, 181.0, 130.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 162.0, 162.0, 160.0, 163.0, 163.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 172.0, 76.0, 75.0, 74.0, 75.0, 172.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 164.0, 85.0, 85.0, 85.0, 151.0, 85.0, 84.0, 137.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 119.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 149.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 51.0, 51.0, 59.0, 52.0, 52.0, 52.0, 51.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 64.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 75.0, 82.0, 77.0, 81.0, 77.0, 107.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 127.0, 125.0, 130.0, 133.0, 122.0, 120.0, 120.0, 132.0, 124.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 151.0, 151.0, 153.0, 154.0, 153.0, 152.0, 157.0, 149.0, 151.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 62.0, 62.0, 63.0, 65.0, 61.0, 61.0, 61.0, 59.0], "value": 63.2, "unit": "score"}]}]} 18:53:07 INFO - Return code: 0 18:53:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:07 ERROR - # TBPL SUCCESS # 18:53:07 INFO - Running post-action listener: _resource_record_post_action 18:53:07 INFO - ##### 18:53:07 INFO - ##### Finished run-tests step (success) 18:53:07 INFO - ##### 18:53:07 INFO - Running post-run listener: _resource_record_post_run 18:53:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500666368; Read time: 32; Write time: 617256 18:53:07 INFO - TinderboxPrint: CPU usage
13.4% 18:53:07 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 18:53:07 INFO - TinderboxPrint: I/O write bytes / time
500,666,368 / 617,256 18:53:07 INFO - TinderboxPrint: CPU idle
8,215.5 (86.6%) 18:53:07 INFO - TinderboxPrint: CPU user
1,211.3 (12.8%) 18:53:07 INFO - TinderboxPrint: Swap in / out
0 / 0 18:53:07 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 248868864; Read time: 0; Write time: 420276 18:53:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251211776; Read time: 32; Write time: 196972 18:53:08 INFO - Running post-run listener: _upload_blobber_files 18:53:08 INFO - Blob upload gear active. 18:53:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:53:08 INFO - (blobuploader) - INFO - Open directory for files ... 18:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:11 INFO - (blobuploader) - INFO - Done attempting. 18:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:53:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:12 INFO - (blobuploader) - INFO - Done attempting. 18:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:13 INFO - (blobuploader) - INFO - Done attempting. 18:53:13 INFO - (blobuploader) - INFO - Iteration through files over. 18:53:13 INFO - Return code: 0 18:53:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:53:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:53:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb542a0693924918c4d939331684cd749a1b6b4076f3ee19a582071e133207ea96e4496dbf125631dbec881c15664b14fdf4a1150c30a88b93aacee5dde1a5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/964c7e258787f8070239c660806fcbab10e5119cd05004af339cfc5b12d1b6fcea8828c5db1210ded87b003dd65fa55e8d12ab1056551682e64740f59bb90871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3abfd0d051a863dabf8b7fa6b7fd496ad9fb4d40dd55f1ccc276d02ac35a3b35802033310e3643946c339e75e7941971e94ab65b961109049dc52d6b2a4e6e"} 18:53:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:53:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:53:13 INFO - Contents: 18:53:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb542a0693924918c4d939331684cd749a1b6b4076f3ee19a582071e133207ea96e4496dbf125631dbec881c15664b14fdf4a1150c30a88b93aacee5dde1a5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/964c7e258787f8070239c660806fcbab10e5119cd05004af339cfc5b12d1b6fcea8828c5db1210ded87b003dd65fa55e8d12ab1056551682e64740f59bb90871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3abfd0d051a863dabf8b7fa6b7fd496ad9fb4d40dd55f1ccc276d02ac35a3b35802033310e3643946c339e75e7941971e94ab65b961109049dc52d6b2a4e6e"} 18:53:13 INFO - Running post-run listener: copy_logs_to_upload_dir 18:53:13 INFO - Copying logs to upload dir... 18:53:13 INFO - mkdir: /builds/slave/test/build/upload/logs 18:53:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.977841 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-23 18:53:12.956104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 18:53:12.959733) ========= 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=5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb542a0693924918c4d939331684cd749a1b6b4076f3ee19a582071e133207ea96e4496dbf125631dbec881c15664b14fdf4a1150c30a88b93aacee5dde1a5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/964c7e258787f8070239c660806fcbab10e5119cd05004af339cfc5b12d1b6fcea8828c5db1210ded87b003dd65fa55e8d12ab1056551682e64740f59bb90871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3abfd0d051a863dabf8b7fa6b7fd496ad9fb4d40dd55f1ccc276d02ac35a3b35802033310e3643946c339e75e7941971e94ab65b961109049dc52d6b2a4e6e"} build_url:https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/X82IipV2SDSmHa5so94y8Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb542a0693924918c4d939331684cd749a1b6b4076f3ee19a582071e133207ea96e4496dbf125631dbec881c15664b14fdf4a1150c30a88b93aacee5dde1a5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/964c7e258787f8070239c660806fcbab10e5119cd05004af339cfc5b12d1b6fcea8828c5db1210ded87b003dd65fa55e8d12ab1056551682e64740f59bb90871", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3abfd0d051a863dabf8b7fa6b7fd496ad9fb4d40dd55f1ccc276d02ac35a3b35802033310e3643946c339e75e7941971e94ab65b961109049dc52d6b2a4e6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 18:53:12.986557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:53:12.987064) ========= 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=5bd038846534b2fdfa68eeae000001e2-1466730306.659577-279564585 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004379 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 18:53:13.071606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 18:53:13.072037) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 18:53:13.072561) ========= ========= Total master_lag: 0.18 =========