builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1469846397.05 results: success (0) buildid: 20160729170826 builduid: 5bb96b5f7e074e778445d151ad800bd4 revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.050798) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.051213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.051554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.071252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.071546) ========= 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=920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 19:39:57-- 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% 37.9M=0s 2016-07-29 19:39:57 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.202499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.202834) ========= 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=920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.253864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:57.254198) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 589e1f984537e280ff84591e94afdc3c5bfe2710 --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 589e1f984537e280ff84591e94afdc3c5bfe2710 --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=920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 19:39:57,401 truncating revision to first 12 chars 2016-07-29 19:39:57,401 Setting DEBUG logging. 2016-07-29 19:39:57,401 attempt 1/10 2016-07-29 19:39:57,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/589e1f984537?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 19:39:57,843 unpacking tar archive at: mozilla-aurora-589e1f984537/testing/mozharness/ program finished with exit code 0 elapsedTime=0.754045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:58.021284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:58.021577) ========= script_repo_revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:58.021947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:58.022351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 19:39:58.031191) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-29 19:39:58.031515) ========= /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=920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:39:58 INFO - MultiFileLogger online at 20160729 19:39:58 in /builds/slave/test 19:39:58 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 19:39:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:39:58 INFO - {'append_to_log': False, 19:39:58 INFO - 'base_work_dir': '/builds/slave/test', 19:39:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:39:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:39:58 INFO - 'branch': 'Mozilla-Aurora', 19:39:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:39:58 INFO - 'config_files': ('talos/linux_config.py',), 19:39:58 INFO - 'default_actions': ('clobber', 19:39:58 INFO - 'read-buildbot-config', 19:39:58 INFO - 'download-and-extract', 19:39:58 INFO - 'populate-webroot', 19:39:58 INFO - 'create-virtualenv', 19:39:58 INFO - 'install', 19:39:58 INFO - 'run-tests'), 19:39:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:39:58 INFO - 'download_minidump_stackwalk': True, 19:39:58 INFO - 'download_symbols': 'ondemand', 19:39:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:39:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:39:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:39:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:39:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:39:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:39:58 INFO - 'installer_path': 'installer.exe', 19:39:58 INFO - 'log_level': 'info', 19:39:58 INFO - 'log_name': 'talos', 19:39:58 INFO - 'log_to_console': True, 19:39:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:39:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:39:58 INFO - 'opt_config_files': (), 19:39:58 INFO - 'pip_index': False, 19:39:58 INFO - 'sps_profile': False, 19:39:58 INFO - 'sps_profile_interval': 0, 19:39:58 INFO - 'suite': 'dromaeojs-e10s', 19:39:58 INFO - 'system_bits': '32', 19:39:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:39:58 INFO - 'title': 'talos-linux64-ix-053', 19:39:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:39:58 INFO - 'use_talos_json': True, 19:39:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:39:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:39:58 INFO - 'work_dir': 'build'} 19:39:58 INFO - ##### 19:39:58 INFO - ##### Running clobber step. 19:39:58 INFO - ##### 19:39:58 INFO - Running pre-action listener: _resource_record_pre_action 19:39:58 INFO - Running main action method: clobber 19:39:58 INFO - rmtree: /builds/slave/test/build 19:39:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:39:58 INFO - Running post-action listener: _resource_record_post_action 19:39:58 INFO - ##### 19:39:58 INFO - ##### Finished clobber step (success) 19:39:58 INFO - ##### 19:39:58 INFO - ##### 19:39:58 INFO - ##### Running read-buildbot-config step. 19:39:58 INFO - ##### 19:39:58 INFO - Running pre-action listener: _resource_record_pre_action 19:39:58 INFO - Running main action method: read_buildbot_config 19:39:58 INFO - Using buildbot properties: 19:39:58 INFO - { 19:39:58 INFO - "project": "", 19:39:58 INFO - "product": "firefox", 19:39:58 INFO - "script_repo_revision": "production", 19:39:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:39:58 INFO - "repository": "", 19:39:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:39:58 INFO - "buildid": "20160729170826", 19:39:58 INFO - "pgo_build": "True", 19:39:58 INFO - "basedir": "/builds/slave/test", 19:39:58 INFO - "buildnumber": 476, 19:39:58 INFO - "slavename": "talos-linux64-ix-053", 19:39:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:39:58 INFO - "platform": "ubuntu64_hw", 19:39:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:39:58 INFO - "branch": "mozilla-aurora", 19:39:58 INFO - "repo_path": "releases/mozilla-aurora", 19:39:58 INFO - "revision": "589e1f984537e280ff84591e94afdc3c5bfe2710", 19:39:58 INFO - "stage_platform": "linux64-pgo", 19:39:58 INFO - "builduid": "5bb96b5f7e074e778445d151ad800bd4", 19:39:58 INFO - "slavebuilddir": "test" 19:39:58 INFO - } 19:39:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 19:39:58 INFO - Running post-action listener: _resource_record_post_action 19:39:58 INFO - ##### 19:39:58 INFO - ##### Finished read-buildbot-config step (success) 19:39:58 INFO - ##### 19:39:58 INFO - ##### 19:39:58 INFO - ##### Running download-and-extract step. 19:39:58 INFO - ##### 19:39:58 INFO - Running pre-action listener: _resource_record_pre_action 19:39:58 INFO - Running main action method: download_and_extract 19:39:58 INFO - mkdir: /builds/slave/test/build/tests 19:39: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')]} 19:39:58 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:39:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 19:39:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 19:39:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:39:59 INFO - Downloaded 1361 bytes. 19:39:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 19:39:59 INFO - Using the following test package requirements: 19:39:59 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 19:39:59 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:39:59 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:39:59 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'jsshell-linux-x86_64.zip'], 19:39:59 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:39:59 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 19:39:59 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:39:59 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:39:59 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:39:59 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 19:39:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:39:59 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:39:59 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:39:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:39:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:39:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:01 INFO - Downloaded 24496939 bytes. 19:40:01 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'] 19:40:01 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 19:40:02 INFO - Return code: 0 19:40:02 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 19:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:02 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:40:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 19:40:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:06 INFO - Downloaded 24496939 bytes. 19:40:06 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'] 19:40:06 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 19:40:08 INFO - Return code: 0 19:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:08 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 19:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 19:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:09 INFO - Downloaded 10833369 bytes. 19:40:09 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'] 19:40:09 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 19:40:09 INFO - Return code: 0 19:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:09 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 19:40:12 INFO - Downloaded 63648271 bytes. 19:40:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:40:12 INFO - mkdir: /builds/slave/test/properties 19:40:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:40:12 INFO - Writing to file /builds/slave/test/properties/build_url 19:40:12 INFO - Contents: 19:40:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 19:40:13 INFO - Running post-action listener: _resource_record_post_action 19:40:13 INFO - Running post-action listener: set_extra_try_arguments 19:40:13 INFO - ##### 19:40:13 INFO - ##### Finished download-and-extract step (success) 19:40:13 INFO - ##### 19:40:13 INFO - ##### 19:40:13 INFO - ##### Running populate-webroot step. 19:40:13 INFO - ##### 19:40:13 INFO - Running pre-action listener: _resource_record_pre_action 19:40:13 INFO - Running main action method: populate_webroot 19:40:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:13 INFO - '--tppagecycles', 19:40:13 INFO - '7'], 19:40:13 INFO - 'tests': ['tsvgm']}}, 19:40:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:40:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:40:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:40:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['damp', 'tps']}, 19:40:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'tests': ['damp', 'tps']}, 19:40:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['dromaeo_dom']}, 19:40:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['a11yr', 19:40:13 INFO - 'ts_paint', 19:40:13 INFO - 'tpaint', 19:40:13 INFO - 'sessionrestore', 19:40:13 INFO - 'sessionrestore_no_auto_restore', 19:40:13 INFO - 'tabpaint']}, 19:40:13 INFO - 'other-e10s': {'tests': ['a11yr', 19:40:13 INFO - 'ts_paint', 19:40:13 INFO - 'tpaint', 19:40:13 INFO - 'sessionrestore', 19:40:13 INFO - 'sessionrestore_no_auto_restore', 19:40:13 INFO - 'tabpaint']}, 19:40:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:40:13 INFO - 'ts_paint', 19:40:13 INFO - 'tpaint', 19:40:13 INFO - 'sessionrestore', 19:40:13 INFO - 'sessionrestore_no_auto_restore', 19:40:13 INFO - 'tabpaint']}, 19:40:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:40:13 INFO - 'ts_paint', 19:40:13 INFO - 'tpaint', 19:40:13 INFO - 'sessionrestore', 19:40:13 INFO - 'sessionrestore_no_auto_restore', 19:40:13 INFO - 'tabpaint']}, 19:40:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['a11yr', 19:40:13 INFO - 'ts_paint', 19:40:13 INFO - 'tpaint', 19:40:13 INFO - 'sessionrestore', 19:40:13 INFO - 'sessionrestore_no_auto_restore', 19:40:13 INFO - 'tabpaint']}, 19:40:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['a11yr', 19:40:13 INFO - 'ts_paint', 19:40:13 INFO - 'tpaint', 19:40:13 INFO - 'sessionrestore', 19:40:13 INFO - 'sessionrestore_no_auto_restore', 19:40:13 INFO - 'tabpaint']}, 19:40:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['tsvgx', 19:40:13 INFO - 'tsvgr_opacity', 19:40:13 INFO - 'tart', 19:40:13 INFO - 'tscrollx', 19:40:13 INFO - 'cart']}, 19:40:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:40:13 INFO - 'tsvgr_opacity', 19:40:13 INFO - 'tart', 19:40:13 INFO - 'tscrollx', 19:40:13 INFO - 'cart']}, 19:40:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'talos_options': ['--disable-e10s'], 19:40:13 INFO - 'tests': ['tp5o']}, 19:40:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'tests': ['tp5o']}, 19:40:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'talos_options': ['--disable-e10s', 19:40:13 INFO - '--xperf_path', 19:40:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:13 INFO - 'tests': ['tp5n']}, 19:40:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:13 INFO - 'talos_options': ['--xperf_path', 19:40:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:13 INFO - 'tests': ['tp5n']}}, 19:40:13 INFO - 'talos.zip': {'path': '', 19:40:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:13 INFO - Running post-action listener: _resource_record_post_action 19:40:13 INFO - ##### 19:40:13 INFO - ##### Finished populate-webroot step (success) 19:40:13 INFO - ##### 19:40:13 INFO - ##### 19:40:13 INFO - ##### Running create-virtualenv step. 19:40:13 INFO - ##### 19:40:13 INFO - Running pre-action listener: _resource_record_pre_action 19:40:13 INFO - Running main action method: create_virtualenv 19:40:13 INFO - Creating virtualenv /builds/slave/test/build/venv 19:40:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:40:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:40:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:13 INFO - Using real prefix '/usr' 19:40:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:40:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:40:15 INFO - Installing pip.................done. 19:40:15 INFO - Return code: 0 19:40:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:15 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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:40:15 INFO - Using env: {'DISPLAY': ':0', 19:40:15 INFO - 'HOME': '/home/cltbld', 19:40:15 INFO - 'LANG': 'en_US.UTF-8', 19:40:15 INFO - 'LANGUAGE': 'en_US:en', 19:40:15 INFO - 'LOGNAME': 'cltbld', 19:40:15 INFO - 'MAIL': '/var/mail/cltbld', 19:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:15 INFO - 'MOZ_NO_REMOTE': '1', 19:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:15 INFO - 'NO_EM_RESTART': '1', 19:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:15 INFO - 'PWD': '/builds/slave/test', 19:40:15 INFO - 'SHELL': '/bin/bash', 19:40:15 INFO - 'SHLVL': '1', 19:40:15 INFO - 'TERM': 'linux', 19:40:15 INFO - 'TMOUT': '86400', 19:40:15 INFO - 'USER': 'cltbld', 19:40:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:15 INFO - '_': '/tools/buildbot/bin/python'} 19:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:40:15 INFO - Cleaning up... 19:40:15 INFO - Return code: 0 19:40:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:15 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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:40:15 INFO - Using env: {'DISPLAY': ':0', 19:40:15 INFO - 'HOME': '/home/cltbld', 19:40:15 INFO - 'LANG': 'en_US.UTF-8', 19:40:15 INFO - 'LANGUAGE': 'en_US:en', 19:40:15 INFO - 'LOGNAME': 'cltbld', 19:40:15 INFO - 'MAIL': '/var/mail/cltbld', 19:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:15 INFO - 'MOZ_NO_REMOTE': '1', 19:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:15 INFO - 'NO_EM_RESTART': '1', 19:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:15 INFO - 'PWD': '/builds/slave/test', 19:40:15 INFO - 'SHELL': '/bin/bash', 19:40:15 INFO - 'SHLVL': '1', 19:40:15 INFO - 'TERM': 'linux', 19:40:15 INFO - 'TMOUT': '86400', 19:40:15 INFO - 'USER': 'cltbld', 19:40:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:15 INFO - '_': '/tools/buildbot/bin/python'} 19:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:16 INFO - Downloading/unpacking psutil>=3.1.1 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40: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 19:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:40:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:18 INFO - Installing collected packages: psutil 19:40:18 INFO - Running setup.py install for psutil 19:40:18 INFO - building 'psutil._psutil_linux' extension 19:40:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:40:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:40:18 INFO - building 'psutil._psutil_posix' extension 19:40:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:40:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:40:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:18 INFO - Successfully installed psutil 19:40:18 INFO - Cleaning up... 19:40:18 INFO - Return code: 0 19:40:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:40:18 INFO - Using env: {'DISPLAY': ':0', 19:40:18 INFO - 'HOME': '/home/cltbld', 19:40:18 INFO - 'LANG': 'en_US.UTF-8', 19:40:18 INFO - 'LANGUAGE': 'en_US:en', 19:40:18 INFO - 'LOGNAME': 'cltbld', 19:40:18 INFO - 'MAIL': '/var/mail/cltbld', 19:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:18 INFO - 'MOZ_NO_REMOTE': '1', 19:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:18 INFO - 'NO_EM_RESTART': '1', 19:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:18 INFO - 'PWD': '/builds/slave/test', 19:40:18 INFO - 'SHELL': '/bin/bash', 19:40:18 INFO - 'SHLVL': '1', 19:40:18 INFO - 'TERM': 'linux', 19:40:18 INFO - 'TMOUT': '86400', 19:40:18 INFO - 'USER': 'cltbld', 19:40:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:18 INFO - '_': '/tools/buildbot/bin/python'} 19:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:40:20 INFO - Installing collected packages: mozsystemmonitor 19:40:20 INFO - Running setup.py install for mozsystemmonitor 19:40:20 INFO - Successfully installed mozsystemmonitor 19:40:20 INFO - Cleaning up... 19:40:21 INFO - Return code: 0 19:40:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:40:21 INFO - Using env: {'DISPLAY': ':0', 19:40:21 INFO - 'HOME': '/home/cltbld', 19:40:21 INFO - 'LANG': 'en_US.UTF-8', 19:40:21 INFO - 'LANGUAGE': 'en_US:en', 19:40:21 INFO - 'LOGNAME': 'cltbld', 19:40:21 INFO - 'MAIL': '/var/mail/cltbld', 19:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:21 INFO - 'MOZ_NO_REMOTE': '1', 19:40:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:21 INFO - 'NO_EM_RESTART': '1', 19:40:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:21 INFO - 'PWD': '/builds/slave/test', 19:40:21 INFO - 'SHELL': '/bin/bash', 19:40:21 INFO - 'SHLVL': '1', 19:40:21 INFO - 'TERM': 'linux', 19:40:21 INFO - 'TMOUT': '86400', 19:40:21 INFO - 'USER': 'cltbld', 19:40:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:21 INFO - '_': '/tools/buildbot/bin/python'} 19:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:21 INFO - Downloading/unpacking jsonschema==2.5.1 19:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:40:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:23 INFO - Downloading functools32-3.2.3-2.tar.gz 19:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:40:23 INFO - warning: no files found matching '*.txt' 19:40:23 INFO - no previously-included directories found matching 'build' 19:40:23 INFO - no previously-included directories found matching 'dist' 19:40:23 INFO - no previously-included directories found matching '.git*' 19:40:23 INFO - Installing collected packages: jsonschema, functools32 19:40:23 INFO - Running setup.py install for functools32 19:40:23 INFO - warning: no files found matching '*.txt' 19:40:23 INFO - no previously-included directories found matching 'build' 19:40:23 INFO - no previously-included directories found matching 'dist' 19:40:23 INFO - no previously-included directories found matching '.git*' 19:40:23 INFO - Successfully installed jsonschema functools32 19:40:23 INFO - Cleaning up... 19:40:23 INFO - Return code: 0 19:40:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:40:23 INFO - Using env: {'DISPLAY': ':0', 19:40:23 INFO - 'HOME': '/home/cltbld', 19:40:23 INFO - 'LANG': 'en_US.UTF-8', 19:40:23 INFO - 'LANGUAGE': 'en_US:en', 19:40:23 INFO - 'LOGNAME': 'cltbld', 19:40:23 INFO - 'MAIL': '/var/mail/cltbld', 19:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:23 INFO - 'MOZ_NO_REMOTE': '1', 19:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:23 INFO - 'NO_EM_RESTART': '1', 19:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:23 INFO - 'PWD': '/builds/slave/test', 19:40:23 INFO - 'SHELL': '/bin/bash', 19:40:23 INFO - 'SHLVL': '1', 19:40:23 INFO - 'TERM': 'linux', 19:40:23 INFO - 'TMOUT': '86400', 19:40:23 INFO - 'USER': 'cltbld', 19:40:23 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:23 INFO - '_': '/tools/buildbot/bin/python'} 19:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:23 INFO - Downloading/unpacking blobuploader==1.2.4 19:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:25 INFO - Downloading blobuploader-1.2.4.tar.gz 19:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:40:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:40:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:26 INFO - Downloading docopt-0.6.1.tar.gz 19:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:40:26 INFO - Installing collected packages: blobuploader, requests, docopt 19:40:26 INFO - Running setup.py install for blobuploader 19:40:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:40:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:40:26 INFO - Running setup.py install for requests 19:40:26 INFO - Running setup.py install for docopt 19:40:26 INFO - Successfully installed blobuploader requests docopt 19:40:26 INFO - Cleaning up... 19:40:27 INFO - Return code: 0 19:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:27 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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:40:27 INFO - Using env: {'DISPLAY': ':0', 19:40:27 INFO - 'HOME': '/home/cltbld', 19:40:27 INFO - 'LANG': 'en_US.UTF-8', 19:40:27 INFO - 'LANGUAGE': 'en_US:en', 19:40:27 INFO - 'LOGNAME': 'cltbld', 19:40:27 INFO - 'MAIL': '/var/mail/cltbld', 19:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:27 INFO - 'MOZ_NO_REMOTE': '1', 19:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:27 INFO - 'NO_EM_RESTART': '1', 19:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:27 INFO - 'PWD': '/builds/slave/test', 19:40:27 INFO - 'SHELL': '/bin/bash', 19:40:27 INFO - 'SHLVL': '1', 19:40:27 INFO - 'TERM': 'linux', 19:40:27 INFO - 'TMOUT': '86400', 19:40:27 INFO - 'USER': 'cltbld', 19:40:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:27 INFO - '_': '/tools/buildbot/bin/python'} 19:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:27 INFO - Running setup.py (path:/tmp/pip-ePfPGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:27 INFO - Running setup.py (path:/tmp/pip-WbHhEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:27 INFO - Running setup.py (path:/tmp/pip-T5KxgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:27 INFO - Running setup.py (path:/tmp/pip-Luv3Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:27 INFO - Running setup.py (path:/tmp/pip-3uWRbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:27 INFO - Running setup.py (path:/tmp/pip-R0vaaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:27 INFO - Running setup.py (path:/tmp/pip-xgV4aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:27 INFO - Running setup.py (path:/tmp/pip-6VLyQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:27 INFO - Running setup.py (path:/tmp/pip-iORhxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:27 INFO - Running setup.py (path:/tmp/pip-UzHYpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:27 INFO - Running setup.py (path:/tmp/pip-AZXiWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:28 INFO - Running setup.py (path:/tmp/pip-zZtatO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:28 INFO - Running setup.py (path:/tmp/pip-pNBC04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:28 INFO - Running setup.py (path:/tmp/pip-1P7YYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:28 INFO - Running setup.py (path:/tmp/pip-0cApdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:28 INFO - Running setup.py (path:/tmp/pip-eacjdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:28 INFO - Running setup.py (path:/tmp/pip-NOq3UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:40:28 INFO - Running setup.py install for manifestparser 19:40:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:40:28 INFO - Running setup.py install for mozcrash 19:40:28 INFO - Running setup.py install for mozdebug 19:40:28 INFO - Running setup.py install for mozdevice 19:40:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:40:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:40:28 INFO - Running setup.py install for mozfile 19:40:28 INFO - Running setup.py install for mozhttpd 19:40:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for mozinfo 19:40:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for mozInstall 19:40:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for mozleak 19:40:29 INFO - Running setup.py install for mozlog 19:40:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for moznetwork 19:40:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for mozprocess 19:40:29 INFO - Running setup.py install for mozprofile 19:40:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for mozrunner 19:40:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:40:29 INFO - Running setup.py install for mozscreenshot 19:40:30 INFO - Running setup.py install for moztest 19:40:30 INFO - Running setup.py install for mozversion 19:40:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:40:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:40:30 INFO - Cleaning up... 19:40:30 INFO - Return code: 0 19:40:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:30 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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:40:30 INFO - Using env: {'DISPLAY': ':0', 19:40:30 INFO - 'HOME': '/home/cltbld', 19:40:30 INFO - 'LANG': 'en_US.UTF-8', 19:40:30 INFO - 'LANGUAGE': 'en_US:en', 19:40:30 INFO - 'LOGNAME': 'cltbld', 19:40:30 INFO - 'MAIL': '/var/mail/cltbld', 19:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:30 INFO - 'MOZ_NO_REMOTE': '1', 19:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:30 INFO - 'NO_EM_RESTART': '1', 19:40:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:30 INFO - 'PWD': '/builds/slave/test', 19:40:30 INFO - 'SHELL': '/bin/bash', 19:40:30 INFO - 'SHLVL': '1', 19:40:30 INFO - 'TERM': 'linux', 19:40:30 INFO - 'TMOUT': '86400', 19:40:30 INFO - 'USER': 'cltbld', 19:40:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:30 INFO - '_': '/tools/buildbot/bin/python'} 19:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:40:30 INFO - Running setup.py (path:/tmp/pip-gvNZdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:40:30 INFO - Running setup.py (path:/tmp/pip-q40kmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:40:30 INFO - Running setup.py (path:/tmp/pip-rLeMtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:40:30 INFO - Running setup.py (path:/tmp/pip-4YtZ_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:40:30 INFO - Running setup.py (path:/tmp/pip-Ospvf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:40:30 INFO - Running setup.py (path:/tmp/pip-WosTtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:40:30 INFO - Running setup.py (path:/tmp/pip-8GJ43V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:40:30 INFO - Running setup.py (path:/tmp/pip-GbY_qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:40:31 INFO - Running setup.py (path:/tmp/pip-loTqrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:40:31 INFO - Running setup.py (path:/tmp/pip-J2aojd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:40:31 INFO - Running setup.py (path:/tmp/pip-Ga2OPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:40:31 INFO - Running setup.py (path:/tmp/pip-bXQH8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:40:31 INFO - Running setup.py (path:/tmp/pip-AHco_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:40:31 INFO - Running setup.py (path:/tmp/pip-Ur2tsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:31 INFO - Running setup.py (path:/tmp/pip-uW6iuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:40:31 INFO - Running setup.py (path:/tmp/pip-Weiqmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:40:31 INFO - Running setup.py (path:/tmp/pip-VwEIuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:40:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:34 INFO - Downloading blessings-1.6.tar.gz 19:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:40:34 INFO - Installing collected packages: blessings 19:40:34 INFO - Running setup.py install for blessings 19:40:34 INFO - Successfully installed blessings 19:40:34 INFO - Cleaning up... 19:40:34 INFO - Return code: 0 19:40:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:35 INFO - Reading from file tmpfile_stdout 19:40:35 INFO - Current package versions: 19:40:35 INFO - argparse == 1.2.1 19:40:35 INFO - blessings == 1.6 19:40:35 INFO - blobuploader == 1.2.4 19:40:35 INFO - docopt == 0.6.1 19:40:35 INFO - functools32 == 3.2.3-2 19:40:35 INFO - jsonschema == 2.5.1 19:40:35 INFO - manifestparser == 1.1 19:40:35 INFO - mozInstall == 1.12 19:40:35 INFO - mozcrash == 0.17 19:40:35 INFO - mozdebug == 0.1 19:40:35 INFO - mozdevice == 0.48 19:40:35 INFO - mozfile == 1.2 19:40:35 INFO - mozhttpd == 0.7 19:40:35 INFO - mozinfo == 0.9 19:40:35 INFO - mozleak == 0.1 19:40:35 INFO - mozlog == 3.2 19:40:35 INFO - moznetwork == 0.27 19:40:35 INFO - mozprocess == 0.23 19:40:35 INFO - mozprofile == 0.28 19:40:35 INFO - mozrunner == 6.12 19:40:35 INFO - mozscreenshot == 0.1 19:40:35 INFO - mozsystemmonitor == 0.3 19:40:35 INFO - moztest == 0.7 19:40:35 INFO - mozversion == 1.4 19:40:35 INFO - psutil == 3.1.1 19:40:35 INFO - requests == 1.2.3 19:40:35 INFO - wsgiref == 0.1.2 19:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:35 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 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:40:35 INFO - Using env: {'DISPLAY': ':0', 19:40:35 INFO - 'HOME': '/home/cltbld', 19:40:35 INFO - 'LANG': 'en_US.UTF-8', 19:40:35 INFO - 'LANGUAGE': 'en_US:en', 19:40:35 INFO - 'LOGNAME': 'cltbld', 19:40:35 INFO - 'MAIL': '/var/mail/cltbld', 19:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:35 INFO - 'MOZ_NO_REMOTE': '1', 19:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:35 INFO - 'NO_EM_RESTART': '1', 19:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:35 INFO - 'PWD': '/builds/slave/test', 19:40:35 INFO - 'SHELL': '/bin/bash', 19:40:35 INFO - 'SHLVL': '1', 19:40:35 INFO - 'TERM': 'linux', 19:40:35 INFO - 'TMOUT': '86400', 19:40:35 INFO - 'USER': 'cltbld', 19:40:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:35 INFO - '_': '/tools/buildbot/bin/python'} 19:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:40:35 INFO - Cleaning up... 19:40:35 INFO - Return code: 0 19:40:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:40:35 INFO - Using env: {'DISPLAY': ':0', 19:40:35 INFO - 'HOME': '/home/cltbld', 19:40:35 INFO - 'LANG': 'en_US.UTF-8', 19:40:35 INFO - 'LANGUAGE': 'en_US:en', 19:40:35 INFO - 'LOGNAME': 'cltbld', 19:40:35 INFO - 'MAIL': '/var/mail/cltbld', 19:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:35 INFO - 'MOZ_NO_REMOTE': '1', 19:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:35 INFO - 'NO_EM_RESTART': '1', 19:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:35 INFO - 'PWD': '/builds/slave/test', 19:40:35 INFO - 'SHELL': '/bin/bash', 19:40:35 INFO - 'SHLVL': '1', 19:40:35 INFO - 'TERM': 'linux', 19:40:35 INFO - 'TMOUT': '86400', 19:40:35 INFO - 'USER': 'cltbld', 19:40:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:35 INFO - '_': '/tools/buildbot/bin/python'} 19:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:40:35 INFO - Cleaning up... 19:40:35 INFO - Return code: 0 19:40:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c955e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1014020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, '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': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:40:35 INFO - Using env: {'DISPLAY': ':0', 19:40:35 INFO - 'HOME': '/home/cltbld', 19:40:35 INFO - 'LANG': 'en_US.UTF-8', 19:40:35 INFO - 'LANGUAGE': 'en_US:en', 19:40:35 INFO - 'LOGNAME': 'cltbld', 19:40:35 INFO - 'MAIL': '/var/mail/cltbld', 19:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:35 INFO - 'MOZ_NO_REMOTE': '1', 19:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:35 INFO - 'NO_EM_RESTART': '1', 19:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:35 INFO - 'PWD': '/builds/slave/test', 19:40:35 INFO - 'SHELL': '/bin/bash', 19:40:35 INFO - 'SHLVL': '1', 19:40:35 INFO - 'TERM': 'linux', 19:40:35 INFO - 'TMOUT': '86400', 19:40:35 INFO - 'USER': 'cltbld', 19:40:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:35 INFO - '_': '/tools/buildbot/bin/python'} 19:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:35 INFO - Downloading/unpacking flake8 19:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:40:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:40:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:40:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:40:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:40:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:40:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:40:38 INFO - no previously-included directories found matching 'docs/_build' 19:40:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:40:38 INFO - Running setup.py install for pep8 19:40:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:40:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:40:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:40:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:40:38 INFO - no previously-included directories found matching 'docs/_build' 19:40:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:40:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:40:38 INFO - Cleaning up... 19:40:38 INFO - Return code: 0 19:40:38 INFO - Running post-action listener: _resource_record_post_action 19:40:38 INFO - Running post-action listener: _start_resource_monitoring 19:40:38 INFO - Starting resource monitoring. 19:40:38 INFO - ##### 19:40:38 INFO - ##### Finished create-virtualenv step (success) 19:40:38 INFO - ##### 19:40:38 INFO - ##### 19:40:38 INFO - ##### Running install step. 19:40:38 INFO - ##### 19:40:38 INFO - Running pre-action listener: _resource_record_pre_action 19:40:38 INFO - Running main action method: install 19:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:38 INFO - Reading from file tmpfile_stdout 19:40:38 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:38 INFO - Reading from file tmpfile_stdout 19:40:38 INFO - Output received: 19:40:38 INFO - Usage: mozinstall [options] installer 19:40:38 INFO - Options: 19:40:38 INFO - -h, --help show this help message and exit 19:40:38 INFO - -d DEST, --destination=DEST 19:40:38 INFO - Directory to install application into. [default: 19:40:38 INFO - "/builds/slave/test"] 19:40:38 INFO - --app=APP Application being installed. [default: firefox] 19:40:38 INFO - mkdir: /builds/slave/test/build/application 19:40:38 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'] 19:40:38 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 19:40:54 INFO - Reading from file tmpfile_stdout 19:40:54 INFO - Output received: 19:40:54 INFO - /builds/slave/test/build/application/firefox/firefox 19:40:54 INFO - Running post-action listener: _resource_record_post_action 19:40:54 INFO - ##### 19:40:54 INFO - ##### Finished install step (success) 19:40:54 INFO - ##### 19:40:54 INFO - ##### 19:40:54 INFO - ##### Running run-tests step. 19:40:54 INFO - ##### 19:40:54 INFO - Running pre-action listener: _resource_record_pre_action 19:40:54 INFO - Running main action method: run_tests 19:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:54 INFO - Python 2.7.3 19:40:54 INFO - Return code: 0 19:40:54 INFO - grabbing minidump binary from tooltool 19:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:54 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 0x10a62e0>, '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 0x1012140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:40:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:40:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:40:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:54 INFO - Return code: 0 19:40:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:40:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:40:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:40:55 INFO - Return code: 0 19:40:55 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/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:40:55 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/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:40:55 INFO - Using env: {'DISPLAY': ':0', 19:40:55 INFO - 'HOME': '/home/cltbld', 19:40:55 INFO - 'LANG': 'en_US.UTF-8', 19:40:55 INFO - 'LANGUAGE': 'en_US:en', 19:40:55 INFO - 'LOGNAME': 'cltbld', 19:40:55 INFO - 'MAIL': '/var/mail/cltbld', 19:40:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:55 INFO - 'MOZ_NO_REMOTE': '1', 19:40:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:55 INFO - 'NO_EM_RESTART': '1', 19:40:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:55 INFO - 'PWD': '/builds/slave/test', 19:40:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:55 INFO - 'SHELL': '/bin/bash', 19:40:55 INFO - 'SHLVL': '1', 19:40:55 INFO - 'TERM': 'linux', 19:40:55 INFO - 'TMOUT': '86400', 19:40:55 INFO - 'USER': 'cltbld', 19:40:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628', 19:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:55 INFO - '_': '/tools/buildbot/bin/python'} 19:40:55 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/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:40:55 INFO - mozversion application_buildid: 20160729170826 19:40:55 INFO - mozversion application_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 19:40:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:40:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:55 INFO - mozversion application_name: Firefox 19:40:55 INFO - mozversion application_remotingname: firefox-dev 19:40:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:40:55 INFO - mozversion application_vendor: Mozilla 19:40:55 INFO - mozversion application_version: 49.0a2 19:40:55 INFO - mozversion platform_buildid: 20160729170826 19:40:55 INFO - mozversion platform_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 19:40:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:40:55 INFO - mozversion platform_version: 49.0a2 19:40:55 INFO - using testdate: 1469846455 19:40:55 INFO - actual date: 1469846455 19:40:55 INFO - starting webserver on 'localhost:58895' 19:40:55 INFO - SUITE-START | Running 2 tests 19:40:55 INFO - TEST-START | dromaeo_css 19:40:55 INFO - operating with platform_type : linux_ 19:40:55 INFO - Initialising browser for dromaeo_css test... 19:40:55 INFO - TEST-INFO | started process 7338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWxKzY/profile http://localhost:58895/getInfo.html) 19:41:00 INFO - PROCESS | 7338 | __metrics Screen width/height:1600/1200 19:41:00 INFO - PROCESS | 7338 | colorDepth:24 19:41:00 INFO - PROCESS | 7338 | Browser inner width/height: 1024/697 19:41:00 INFO - PROCESS | 7338 | __metrics 19:41:01 ERROR - PROCESS | 7338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:41:02 INFO - TEST-INFO | 7338: exit 0 19:41:02 INFO - Browser initialized. 19:41:02 INFO - Running cycle 1/1 for dromaeo_css test... 19:41:02 INFO - TEST-INFO | started process 7467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiWxKzY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:14 INFO - PROCESS | 7467 | RSS: Main: 156073984 19:41:14 INFO - PROCESS | 7467 | 19:42:03 INFO - PROCESS | 7467 | 1469846523770 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:44:11 INFO - PROCESS | 7467 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58895/tests/dromaeo/cssquery-ext.html) 19:44:12 INFO - PROCESS | 7467 | RSS: Main: 160157696 19:44:12 INFO - PROCESS | 7467 | 19:47:14 INFO - PROCESS | 7467 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-ext.html (next: http://localhost:58895/tests/dromaeo/cssquery-jquery.html) 19:47:15 INFO - PROCESS | 7467 | RSS: Main: 157904896 19:47:15 INFO - PROCESS | 7467 | 19:50:17 INFO - PROCESS | 7467 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58895/tests/dromaeo/cssquery-mootools.html) 19:50:17 INFO - PROCESS | 7467 | RSS: Main: 157585408 19:50:17 INFO - PROCESS | 7467 | 19:53:19 INFO - PROCESS | 7467 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58895/tests/dromaeo/cssquery-prototype.html) 19:53:19 INFO - PROCESS | 7467 | RSS: Main: 156991488 19:53:19 INFO - PROCESS | 7467 | 19:56:22 INFO - PROCESS | 7467 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58895/tests/dromaeo/cssquery-yui.html) 19:56:22 INFO - PROCESS | 7467 | RSS: Main: 158945280 19:56:22 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-yui.html (next: http://localhost:58895/tests/dromaeo/cssquery-dojo.html) 19:59:25 INFO - PROCESS | 7467 | RSS: Main: 159526912 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | __start_tp_report 19:59:25 INFO - PROCESS | 7467 | _x_x_mozilla_page_load 19:59:25 INFO - PROCESS | 7467 | _x_x_mozilla_page_load_details 19:59:25 INFO - PROCESS | 7467 | |i|pagename|runs| 19:59:25 INFO - PROCESS | 7467 | |0;dojo.html;3388.932221355573;3407.659234076591;3427.674370934762;3434.4676575130848;3436.2783815398775;5604.887902241952;5648.802291919778;5690.061139911914;5700.37295897452;5727.828165155052;5657.547396208303;5714.685692286923;5744.109663002231;5751.597388182819;5757.827265182041;5150.819721309755;5190.403103643072;5236.895262094756;5267.209918512215;5288.709120998344;5087.821926232583;5145.6398052136365;5275.340582427197;5286.867828304285;5291.259223708684;5202.505761952609;5207.895842083156;5210.583153347742;5232.790688372461;5262.368515778112;5213.504717051893;5248.5013923677;5260.579153667697;5265.341832270966;5298.390685071227;5042.84871453857;5112.105381558213;5183.2743415921805;5237.266782650432;5242.580593552507;5565.749541270612;5584.6090773645865;5599.8880022399735;5615.831525054255;5671.744771485293;6058.273007239115;6095.817125486243;6107.297660769024;6117.296510901258;6129.478994285491;5883.17635531026;6006.369331220203;6195.31851496335;6198.597091189104;6209.037599172136;5622.859428514279;5704.344000439961;5704.743286552073;5707.885842283131;5740.7703691852275;6207.689615519206;6208.689565521706;6213.1922850029205;6218.22272215973;6223.875522489525;5862.648241105548;5870.765169393177;5872.060470324727;5968.045112781934;5969.134475501028;6026.367231440723;6037.184980027728;6044.1840351552855;6062.545309101835;6070.028795392716;5925.229720136441;5978.730957106941;6014.0678194879865;6015.939840601538;6027.246594175728;5878.5297176225795;5990.131430942576;6011.248593925759;6032.4570788629235;6037.215162028908;4643.9783247685455;4656.720596764205;4658.068386322681;4660.673752837269;4684.976575117103;4171.874843754692;4183.184279065614;4185.372194170899;4208.8316467340965;4222.239996800606;5744.741486633028;5799.9130013049835;5816.854578635483;5876.236089308362;5885.793997210077;5984.431479009487;6032.607880487754;6033.456988871023;6050.6672133032225;6087.208662873887;5841.123831425235;5843;5849;5852.887951289242;5856.385079566669;5074.847754567369;5139.280500729901;5156.793728250903;5170.965806838647;5193.324867767166;6352.745890164341;6353.5870168438905;6354.682265886687;6361.173047503888;6363.840903977438;5972.223610930551;6117.510599152146;6120.969395152996;6124.571280010535;6143.109249158936;6275.905861412174;6276.372362763687;6299.811005669837;6421.422072013541;6434.517411194086;6001.519878409629;6021.126936594257;6057.697115144313;6057.757689692539;6061.636301821728;5897.9115313271195;6067.635941843503;6179.783707570394;6191.071339299141;6191.597546159485;5904.5866789326055;5992.580519363602;5994.820155395345;5997.820065398045;6009.098635204754;5930.377310382521;6009.819705408845;6015.097735339734;6015.6691381974415;6027.156198132353;5765.077587585966;5794.739236734273;5794.797182098607;5856.326522449973;5872.0898260769645;5985.431384018511;5993.011153159679;6019.428154325332;6042.033274676207;6055.364186760326;5837.3870743571315;5878.706064696663;5883.646981181143;5886.470217680429;5888.823335299948 19:59:25 INFO - PROCESS | 7467 | |1;ext.html;600.8047384600006;638.4955884850967;664.6477366995488;664.9202095748514;665.6239224837966;45569.544304556985;47344.52655473448;47734.80662983423;50464.49535504644;50769.23846142302;48643;49196.2620560691;49231.26153107706;49243.75378123104;49249.261261081025;9143.405678630901;9259.212966897821;9323.673671421502;9348.298877584175;9354.579043943006;9155.038720934306;9172;9185;9225.077492250755;9226.953865230664;9262.861057084148;9298.488583127924;9319.90680093197;9333.06669333068;9376.015518370576;9164.312676549285;9265.907340926571;9274.258059355236;9282.396644218172;9324.207442367408;9080.228180604656;9108.59011344491;9111.544422778834;9153.496557689325;9183.770405739842;44526.33210501845;44759.32861007087;45121.323180151994;45145;45379.54620453786;3823.655870971626;3843.8078096095364;3865.5168103987003;3879.612038796126;4054.7972601370107;33946.1513462163;34573.654263457545;34585.48121778175;34940.30119397623;35001.474977875354;4498.932516012263;4632.510063111856;4667.696599721041;4669.929951050703;4780.856574302777;375761;377692.1115394433;378899;379680;381222;68387.31612683908;68928.31071689219;68953.3104668957;69047.3095269051;69092.30907690858;39459;40529.392059119135;40671.59328406737;42484.57515424868;42542.57457425448;17809.109544522722;17990.460286191435;18102.366417175337;18133.18400671973;18204.180811863233;13801.240931748649;13801.309934503235;13837;13861.930690346686;13958.232297223547;21029.15883364648;21043.579128417347;21132.260370886946;21223.575528489342;21262.893685531475;7472.17806041335;7567.356774674105;7587.924120758832;7605.239476052461;7698.384129269645;1090.4765712458066;1104.6023431564631;1139.0944199361527;1216.92698438094;1234.6296111166794;31884.202894927814;32233.67766322307;32902;32919.67080329214;32952;1154.549725607014;1169.2633640806237;1174.5888938871326;1214.4170798017;1241.5716577780652;17106.401275955282;17139.97160170394;17193.65612687739;17227.569310767332;17514.21186046631;467436;1001361;1047849;1061454;1068720;61420.69289653612;62225.37774622196;62731.686341568;62737.37262627407;62836.37163628397;1469.3241109089724;1487.4422091715608;1504.4884739188728;1513.3719506404939;1537.7308970930267;32167;32783.50824737678;33097.17257068593;33291.33417331591;34086.31827363389;54047.18929215986;54519.18221226764;54787;54868;54940;454191;456803;456856;459067;461065;30217.546736798526;30704;30891.845540772152;31552.526712099796;31568.210794730316;52723.736381317845;52926.206106909194;53394;53765.46234537604;54725.179122313995;45509.772451137535;45829.08341833078;46308.30537541872;46738.766306168254;46762.29856552086;45145.09709805851;45409;45878.31182532198;45929.540704592524;46165.769171155276;43992.12015759603;44828;45234;45240;45532;38040.809795950845;38657.613423865405;38895.6110438892;40078.59921400749;40483.39274910938;29961;30135.547966780956;30154.547681784352;30325.241868953453;30802.69197308088 19:59:25 INFO - PROCESS | 7467 | |2;jquery.html;411.664493437848;411.83938264077017;414.46533971177183;423.41357220249944;434.63924942297893;18469.53826154345;19451.124699388525;19554.608907821854;19908.800911990875;20033.19867205314;18498.445046648587;18895.811041889578;19039.428817135507;19152.616947661074;19228.42314730557;5363.597730170223;5686.488216060554;5711.828645140652;5711.971440142794;5713.971430142864;5522.585806064541;5633.0987042073275;5700.942990570104;5716.657000579979;5725.055365864649;5663.442553297856;5676.971615141919;5688.516476099516;5707.258056452676;5726.799562015331;5402.8919421611345;5636.070048442002;5653.8586535336535;5667.234923285345;5714.857128571777;5065.366829146356;5067.467915868854;5073.518015788494;5085.949140508622;5093.312402825645;16568.337266509327;20978.0559874806;21813.23653672114;21897.343079707633;22021.66967495489;2213.922512712047;2344.4021774447406;2606.543854825417;2730.6859711133275;2745.6567929008875;9868.555914983843;10046.598136074548;10111.595536178544;10119;10321;2039.0518408939765;2042.7548694156649;2101.1280318667737;2109.98945005274;2119.173522326294;69226;72691.636541818;72701;75218.62390688066;77728;10642.787144257072;11175.273607215506;11237.943810280896;11336;11491.310521368745;15856.365745370056;15862.682746345008;15934.36262549485;15953.680926381407;15956.76064859028;8407.084050930349;8419.873701894476;8537.829243415097;8569.700060497853;8794.824103517894;7679.654415551202;7697.268759467842;8485.32117430604;8608.311335093178;8655.13448655142;4821.614270858393;4912.754362281943;4931.457539670633;4957.925631115536;4984.675996060245;1980.4157773456866;2053.147943603418;2072.896355182265;2082.7500699915804;2095.287602215254;960.6925783749273;1021.2289721260549;1022.9539670714687;1034.6999370182564;1051.2273478992934;17913.7312940306;17925.7311140333;18574.721379179322;18594.81405185958;18618.44144675662;1030.108955753268;1060.1995493402433;1071.566015763617;1096.983545246822;1125.1673761416494;9117.77205569866;10367.481625918674;10423.895761042293;10510.369377837354;10591.788164236672;506388;517279;529453;537399;542841;89781.55109224412;92411;92688.53655731678;93878.53060734653;98935;478.90661321042063;500.8797888506732;501.38830626635445;502.2115279011989;503.1999121396996;10705.518251678537;11088.889111109109;11090.833637495605;11345.773084538429;11471;35972.82013589915;42161.156776863674;42467.1506569873;42492;44749.32876006928;57738.7113064432;58864.70567647134;58999.41000589939;59152.704236478545;59566.70216648889;8563.272121869712;8593.097724738813;8625.39622226438;8637.69768058115;8761.036286008406;9451.669191578261;12403.441845117171;12883.677908052374;13016.674583135497;13286.468541258242;11555;11581.305121692725;11599.130065244972;11653.359065251492;11725.237859539102;11008;11070.446477675923;11075.833862491907;11399.772004560029;11572.18994670365;6799.932000680128;8672.609732562176;11907.82138267944;11923.82114268304;12335.876641233832;8348.457350272212;8785.736427907173;9020.503872287087;9037.186653201243;9154;10815.783684326112;11887.583934562595;11910.880891191324;11946.522139114339;11947.940260298643 19:59:25 INFO - PROCESS | 7467 | |3;mootools.html;1552.666176771994;1570.207045442052;1777.2979673029154;1895.7914629390757;1906.9618607627847;8286.295664868494;8950.597223124958;8961.91038089619;9741.464219467935;9746;9169.449833010023;9394.201492873097;9426.151646351827;9436.575354109065;9442.10300021497;2387.0451819272257;2420.4070002849326;2423.660687503751;2427.672264244331;2428.611422172453;2407.3981504623844;2413.3001429585397;2433.744456832034;2438.085717855804;2458.1150785717127;2402.6396040593877;2427;2438;2455.815813813962;2463.359526523099;2332.6617640442128;2340.414896275931;2376.66726658268;2377.8929948152377;2392.306231192952;2406;2423.3578101803037;2436.4517983453757;2438.4147804526965;2451.681281433402;9404.90595094047;9418.058194180596;9422.246220302359;9499.145076943109;9506.429614223169;5420.13277875538;5564.1931919871395;5603.691796951166;5613.129964855454;5617.719114044322;3425.8287085645866;3471.94792078119;3523.6476352364816;3541.8937431877084;3549.0949807798847;1079.3685693869097;1091.1489038549944;1134.9148813838913;1143.5254369436757;1154.3881742676394;13385.999999999902;13532.32338383077;13564.728705425836;13582.049256552045;13588.184708917397;4687.484376718558;4773.737444440589;4844.539768721966;4845.176320025604;4860.6111511079025;11171.944140279247;11234.606788762354;11343.773124537463;11353.602623908124;11381.203315767982;5507.476789704971;5567.693776842312;5574.358948720949;5575.776968921197;5583.972080139573;4486.147631949919;4993.650444468925;5058.9494105058475;5141.511556402136;5150.4334523202415;4271.188474189894;4301;4373.825046998148;4402.207602631493;4408.360787685831;1335.679436935148;1362.9727405451836;1365.6654119740726;1366.5831921263912;1370.9383077761524;1069.2622090757352;1084.3710647824244;1095.39205740813;1105.6130354375905;1115.8995690387903;6710.932890671128;6735.663216839139;6764.898526522106;6766.69549870257;6909.343612356818;388.6074569012536;390.2390338839275;392.42901578203646;396.0850435494018;400.0977795072094;4597.7011494252765;4642.303654451792;4647.883802904955;4662.323963025342;4669.41632295963;11362.772744545064;11679.591214307458;11680.240784348991;11686.240394374508;11740.530378784924;11008.944955275172;11438.542458301741;11455.427228638702;11559.595414160463;11606.941965290289;8856.468611883307;9052.140046695553;9058.682946096988;9081.364304498753;9123.81752364949;6652.401283884474;6748.7300507979135;6848.931510684829;6874.12357907921;6913.9974703668695;10928.50821713009;11035.72410689707;11055.668329949793;11079.612213572485;11352.262102963281;10965.451727413438;11209.047230985458;11323.207375483636;11402.20184587071;11406.258593191416;7476.439267054884;8170.632321545426;8369.539675317916;8644.09237030128;8756.605952732016;9320.906790932004;9352.392094513834;9376.156145946625;9430.10414010668;9437.292203084933;8340.04089529712;8491.715702610914;8505.489670619536;8561.957190214009;8568.057513673366;8367.372447066617;8376.958115209385;8393.916060839314;8444.40889137779;8469.788255293666;7646.541207527566;7666.731664391719;7727.729529466442;7742.535447873146;7744.8451030980195;5651.802186923438;5854.2389489366105;5934.109883517507;5956.37458066914;5995.850103747442;5677.3471050829685;5758.942410575841;5766.884662306814;5799.681017544076;5826.096954971986 19:59:25 INFO - PROCESS | 7467 | |4;prototype.html;317.24337455169416;327.8917957074166;330.39537646107624;335.5486870159636;337.3202995963134;5518.889622207554;5645.802396916109;5694.316681998155;5771.682557459338;5791.59458837881;5655.886882262353;5667.716614169285;5677.687727175004;5683.005474042046;5698.601097923147;4416.410092366754;4426.822927082929;4438.156750217465;4440.400545926291;4450.821967121327;4155.33514637658;4393.85759702478;4399.2301347264265;4442.244818380883;4451.6406304658585;4310.52584215736;4335.978320108395;4338.544452832454;4342.565743425664;4343.435353404053;4324.286492728696;4373.387725718402;4382.167388196249;4388.626966707818;4408.691391602589;3765.9811700941596;3824.8852534424013;3839.1361943562756;3845.384738441836;3860.5560360558334;5398.973005134989;5441.755121019524;5463.028643934001;5474.343078830566;5512.641678290898;4925.950740492585;4950.504949505057;4973.378327709001;4979.10376132296;4981.476944920767;5791.623544469596;5881.206037184968;5898.557608179403;5918.496927761145;5925.600131946569;4165.541790403053;4204.894877628053;4206.116715489751;4206.621404073648;4224.324108142713;6187.845303867394;6201.162843016225;6205.410486003822;6206.162168107338;6216.658083805389;4176.60322269384;4243.448351714257;4272.465941757218;4273.786310684515;4302.870913872589;4282.978585107055;4304.806283717177;4305.569443055732;4308.332208507686;4308.353746937984;4950.108980383494;4971.900561988812;4978.253262010728;4991.401031876126;4994.300797888299;5634.394197653649;5756.301890942182;5907.957401938005;5978.432048955342;5994.610350327215;1495.8952873298765;1509.433962264151;1510.7507261301762;1511.3727802961866;1515.772634104871;924.1820988425158;941.7975135345933;947.5641205045756;954.4082668745283;954.4511905654276;5174.24973378858;5203.583713302926;5209.134975763315;5212.895742085213;5248.947510524922;5387.703676297763;5426.511613954763;5452.263944367539;5483.314585676791;5512.125877201691;5141.562967147759;5163.870903227375;5184.637075404686;5312.362516497968;5313.282706834605;2957.4676558219726;2960.5937179839834;2977.5558853955813;2983.9552406713915;2990.8504574771173;5573.247611572467;5607.43925607436;5666.320041595035;5686.914696279559;5702.45826646468;5156.303898973665;5568.582356323292;5577;5583.218349431083;5642.4075472075665;5661.745221465044;5715.399883012307;5717.628354156966;5727.5990680652785;5772.711364431846;5067.619928505451;5412.78348866041;5471.932973070213;5518.2826232589505;5519.185215540184;5423.5932305076485;5435.483629055233;5440.123157510652;5479.2602998594675;5482.725863706719;5593.713445907382;5643.689597072036;5650.604457687922;5652.293463317085;5707.800226992202;3870.3807390817333;3877.747946383476;3922.7839369794315;4179.937300940427;4226.344916537942;5972.163897054503;6101.054336577838;6122.816315510542;6161.4146656067605;6189.473894718999;6018.608790428608;6043.3352331244405;6056;6074.36219196978;6102;5935.228420305332;5970.223870896755;5980.192673988956;6020.668863212565;6052.273727152769;5632.943670563406;5920.585559011;5938.73275702603;5971.343152253336;5975.281247032676;5991.221141251609;6034.275886893425;6066.817995460143;6075.756969721162;6145.600535965148;5623.240862483676;5851.180834683233;5917.970410148094;5927.555433342603;5936.5844390892225 19:59:25 INFO - PROCESS | 7467 | |5;yui.html;770.9069875288591;794.6821271491402;899.1592860675269;915.7481692534557;919.8482250428677;16566.585835354108;16968.830311696896;17312.913435432838;17389.217485213165;17400.30398784047;15533.922330388361;15579.143147126932;15629.21853907303;15652.0608763474;15738.84261157388;727.4834867244263;854.3763052971335;868.665563757953;880.3749337970049;884.3500027479797;863.3352318714586;868.8957325120995;876.9649214031463;878.0824038879355;879.5690111845182;922.8846394200725;927.2026057590467;928.7120992492315;929.6281487405024;936.0732874454276;926.7868390270276;931.0828833598899;931.9580618872201;933.785229397239;933.9719808405758;674.527830518634;675.8073948924533;678.5589366911497;679.6669631880393;681.5433659448181;15763.605909852231;15801.209939502978;15837.208139592974;15849.52451426459;15880.444184453605;15613.719759620371;15992.600184995352;16306.184690765414;16406.753898691528;16516.091614961173;13007.349632518431;13183.209007459584;13195.2742599157;13276.137051091648;13310.401031953585;4061.4643564454773;4123.773192474413;4134.545200028025;4139.77231252281;4159.875203743893;75077.62461187714;78093.48579313888;78461.60769196175;78768.60615696885;79080.60459697664;12728.299943503196;12738.299393533445;12870.420831062625;12990;13177.934110329386;24322.148724794548;24411.145609903924;24494.510109797706;24509.877450612632;24953.750462495507;8832.337574681924;8843.207698957194;9112.726618201465;9148.039455857039;9331.113544213289;5142.897142057138;5258.6581872178185;5280.419153893069;5330.440303768049;5379.946200538023;3636.090977255686;3756.042209236627;3823.9808800956375;3830.0807806126886;3830.138218900725;633.2179757998867;639.6290151711996;647.3526473526474;648.8896887529131;664.7706541243264;811.5333683132222;821.5974172655356;848.6944699908152;849.9660013599511;857.2927334948693;10020.073851949204;10774.138068954464;10824.837627435594;10927.180461465421;10928.398938058324;732.6959311885614;844.7972486603171;856.07543852639;856.5545916123581;878.4597472554333;5235.240890070994;5240.842774716764;5322.600804939568;5325.680459172462;5441.891162176814;74022;76871;77047.61476192583;77494;79020.60489697629;87967.56016220005;99847.50076249572;102190;102518.48740756248;102832.48583757033;90188.09811901928;90901.54549227344;91365.54317228371;91730.54134729283;92067;10096.545655445376;10117;10154.847677284994;10269.84595231087;10301.124404425407;50899.49100509095;52541.47458525366;52954.735226323624;53122;54830.45169548254;68375;69164;69910.71650625441;79103;79506;13853.861461385257;14004.789928150882;14052.367643455864;14381.7842732357;14700.191489468181;16035.679286413973;16115.113668748332;16654.833451665814;16694.916525417782;17076.829231707525;14907.329170187151;15494;15553.533393998197;15599.922000389925;16058.036517808969;14710;14774.261286935396;14903.403863845324;15223.92388038097;16083.839161608234;14817.777733334224;14991.775123373376;15423.537293881202;15617;15644.530664080095;12014.159008869296;12319.815202772144;12452.252864828139;13000.219986800823;13237.470501179845;12569.560065397667;12879.356032198166;12928.98081235983;13082.215067096005;13088.411021503865 19:59:25 INFO - PROCESS | 7467 | __end_tp_report 19:59:25 INFO - PROCESS | 7467 | __start_cc_report 19:59:25 INFO - PROCESS | 7467 | _x_x_mozilla_cycle_collect,361 19:59:25 INFO - PROCESS | 7467 | __end_cc_report 19:59:25 INFO - PROCESS | 7467 | __startTimestamp1469847565567__endTimestamp 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | ------- Summary: start ------- 19:59:25 INFO - PROCESS | 7467 | Number of tests: 6 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | [#0] dojo.html Cycles:165 Average:5663.85 Median:5876.24 stddev:623.16 (10.6%) stddev-sans-first:598.97 19:59:25 INFO - PROCESS | 7467 | Values: 3388.9 3407.7 3427.7 3434.5 3436.3 5604.9 5648.8 5690.1 5700.4 5727.8 5657.5 5714.7 5744.1 5751.6 5757.8 5150.8 5190.4 5236.9 5267.2 5288.7 5087.8 5145.6 5275.3 5286.9 5291.3 5202.5 5207.9 5210.6 5232.8 5262.4 5213.5 5248.5 5260.6 5265.3 5298.4 5042.8 5112.1 5183.3 5237.3 5242.6 5565.7 5584.6 5599.9 5615.8 5671.7 6058.3 6095.8 6107.3 6117.3 6129.5 5883.2 6006.4 6195.3 6198.6 6209.0 5622.9 5704.3 5704.7 5707.9 5740.8 6207.7 6208.7 6213.2 6218.2 6223.9 5862.6 5870.8 5872.1 5968.0 5969.1 6026.4 6037.2 6044.2 6062.5 6070.0 5925.2 5978.7 6014.1 6015.9 6027.2 5878.5 5990.1 6011.2 6032.5 6037.2 4644.0 4656.7 4658.1 4660.7 4685.0 4171.9 4183.2 4185.4 4208.8 4222.2 5744.7 5799.9 5816.9 5876.2 5885.8 5984.4 6032.6 6033.5 6050.7 6087.2 5841.1 5843.0 5849.0 5852.9 5856.4 5074.8 5139.3 5156.8 5171.0 5193.3 6352.7 6353.6 6354.7 6361.2 6363.8 5972.2 6117.5 6121.0 6124.6 6143.1 6275.9 6276.4 6299.8 6421.4 6434.5 6001.5 6021.1 6057.7 6057.8 6061.6 5897.9 6067.6 6179.8 6191.1 6191.6 5904.6 5992.6 5994.8 5997.8 6009.1 5930.4 6009.8 6015.1 6015.7 6027.2 5765.1 5794.7 5794.8 5856.3 5872.1 5985.4 5993.0 6019.4 6042.0 6055.4 5837.4 5878.7 5883.6 5886.5 5888.8 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | [#1] ext.html Cycles:180 Average:73983.07 Median:45145.05 stddev:176172.29 (390.2%) stddev-sans-first:176580.34 19:59:25 INFO - PROCESS | 7467 | Values: 600.8 638.5 664.6 664.9 665.6 45569.5 47344.5 47734.8 50464.5 50769.2 48643.0 49196.3 49231.3 49243.8 49249.3 9143.4 9259.2 9323.7 9348.3 9354.6 9155.0 9172.0 9185.0 9225.1 9227.0 9262.9 9298.5 9319.9 9333.1 9376.0 9164.3 9265.9 9274.3 9282.4 9324.2 9080.2 9108.6 9111.5 9153.5 9183.8 44526.3 44759.3 45121.3 45145.0 45379.5 3823.7 3843.8 3865.5 3879.6 4054.8 33946.2 34573.7 34585.5 34940.3 35001.5 4498.9 4632.5 4667.7 4669.9 4780.9 375761.0 377692.1 378899.0 379680.0 381222.0 68387.3 68928.3 68953.3 69047.3 69092.3 39459.0 40529.4 40671.6 42484.6 42542.6 17809.1 17990.5 18102.4 18133.2 18204.2 13801.2 13801.3 13837.0 13861.9 13958.2 21029.2 21043.6 21132.3 21223.6 21262.9 7472.2 7567.4 7587.9 7605.2 7698.4 1090.5 1104.6 1139.1 1216.9 1234.6 31884.2 32233.7 32902.0 32919.7 32952.0 1154.5 1169.3 1174.6 1214.4 1241.6 17106.4 17140.0 17193.7 17227.6 17514.2 467436.0 1001361.0 1047849.0 1061454.0 1068720.0 61420.7 62225.4 62731.7 62737.4 62836.4 1469.3 1487.4 1504.5 1513.4 1537.7 32167.0 32783.5 33097.2 33291.3 34086.3 54047.2 54519.2 54787.0 54868.0 54940.0 454191.0 456803.0 456856.0 459067.0 461065.0 30217.5 30704.0 30891.8 31552.5 31568.2 52723.7 52926.2 53394.0 53765.5 54725.2 45509.8 45829.1 46308.3 46738.8 46762.3 45145.1 45409.0 45878.3 45929.5 46165.8 43992.1 44828.0 45234.0 45240.0 45532.0 38040.8 38657.6 38895.6 40078.6 40483.4 29961.0 30135.5 30154.5 30325.2 30802.7 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | [#2] jquery.html Cycles:180 Average:29548.75 Median:411.75 stddev:86661.55 (21047.0%) stddev-sans-first:86877.04 19:59:25 INFO - PROCESS | 7467 | Values: 411.7 411.8 414.5 423.4 434.6 18469.5 19451.1 19554.6 19908.8 20033.2 18498.4 18895.8 19039.4 19152.6 19228.4 5363.6 5686.5 5711.8 5712.0 5714.0 5522.6 5633.1 5700.9 5716.7 5725.1 5663.4 5677.0 5688.5 5707.3 5726.8 5402.9 5636.1 5653.9 5667.2 5714.9 5065.4 5067.5 5073.5 5085.9 5093.3 16568.3 20978.1 21813.2 21897.3 22021.7 2213.9 2344.4 2606.5 2730.7 2745.7 9868.6 10046.6 10111.6 10119.0 10321.0 2039.1 2042.8 2101.1 2110.0 2119.2 69226.0 72691.6 72701.0 75218.6 77728.0 10642.8 11175.3 11237.9 11336.0 11491.3 15856.4 15862.7 15934.4 15953.7 15956.8 8407.1 8419.9 8537.8 8569.7 8794.8 7679.7 7697.3 8485.3 8608.3 8655.1 4821.6 4912.8 4931.5 4957.9 4984.7 1980.4 2053.1 2072.9 2082.8 2095.3 960.7 1021.2 1023.0 1034.7 1051.2 17913.7 17925.7 18574.7 18594.8 18618.4 1030.1 1060.2 1071.6 1097.0 1125.2 9117.8 10367.5 10423.9 10510.4 10591.8 506388.0 517279.0 529453.0 537399.0 542841.0 89781.6 92411.0 92688.5 93878.5 98935.0 478.9 500.9 501.4 502.2 503.2 10705.5 11088.9 11090.8 11345.8 11471.0 35972.8 42161.2 42467.2 42492.0 44749.3 57738.7 58864.7 58999.4 59152.7 59566.7 8563.3 8593.1 8625.4 8637.7 8761.0 9451.7 12403.4 12883.7 13016.7 13286.5 11555.0 11581.3 11599.1 11653.4 11725.2 11008.0 11070.4 11075.8 11399.8 11572.2 6799.9 8672.6 11907.8 11923.8 12335.9 8348.5 8785.7 9020.5 9037.2 9154.0 10815.8 11887.6 11910.9 11946.5 11947.9 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | [#3] mootools.html Cycles:180 Average:6275.16 Median:4541.92 stddev:3621.74 (79.7%) stddev-sans-first:3614.51 19:59:25 INFO - PROCESS | 7467 | Values: 1552.7 1570.2 1777.3 1895.8 1907.0 8286.3 8950.6 8961.9 9741.5 9746.0 9169.4 9394.2 9426.2 9436.6 9442.1 2387.0 2420.4 2423.7 2427.7 2428.6 2407.4 2413.3 2433.7 2438.1 2458.1 2402.6 2427.0 2438.0 2455.8 2463.4 2332.7 2340.4 2376.7 2377.9 2392.3 2406.0 2423.4 2436.5 2438.4 2451.7 9404.9 9418.1 9422.2 9499.1 9506.4 5420.1 5564.2 5603.7 5613.1 5617.7 3425.8 3471.9 3523.6 3541.9 3549.1 1079.4 1091.1 1134.9 1143.5 1154.4 13386.0 13532.3 13564.7 13582.0 13588.2 4687.5 4773.7 4844.5 4845.2 4860.6 11171.9 11234.6 11343.8 11353.6 11381.2 5507.5 5567.7 5574.4 5575.8 5584.0 4486.1 4993.7 5058.9 5141.5 5150.4 4271.2 4301.0 4373.8 4402.2 4408.4 1335.7 1363.0 1365.7 1366.6 1370.9 1069.3 1084.4 1095.4 1105.6 1115.9 6710.9 6735.7 6764.9 6766.7 6909.3 388.6 390.2 392.4 396.1 400.1 4597.7 4642.3 4647.9 4662.3 4669.4 11362.8 11679.6 11680.2 11686.2 11740.5 11008.9 11438.5 11455.4 11559.6 11606.9 8856.5 9052.1 9058.7 9081.4 9123.8 6652.4 6748.7 6848.9 6874.1 6914.0 10928.5 11035.7 11055.7 11079.6 11352.3 10965.5 11209.0 11323.2 11402.2 11406.3 7476.4 8170.6 8369.5 8644.1 8756.6 9320.9 9352.4 9376.2 9430.1 9437.3 8340.0 8491.7 8505.5 8562.0 8568.1 8367.4 8377.0 8393.9 8444.4 8469.8 7646.5 7666.7 7727.7 7742.5 7744.8 5651.8 5854.2 5934.1 5956.4 5995.9 5677.3 5758.9 5766.9 5799.7 5826.1 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | [#4] prototype.html Cycles:180 Average:4827.43 Median:5457.65 stddev:1414.18 (25.9%) stddev-sans-first:1377.04 19:59:25 INFO - PROCESS | 7467 | Values: 317.2 327.9 330.4 335.5 337.3 5518.9 5645.8 5694.3 5771.7 5791.6 5655.9 5667.7 5677.7 5683.0 5698.6 4416.4 4426.8 4438.2 4440.4 4450.8 4155.3 4393.9 4399.2 4442.2 4451.6 4310.5 4336.0 4338.5 4342.6 4343.4 4324.3 4373.4 4382.2 4388.6 4408.7 3766.0 3824.9 3839.1 3845.4 3860.6 5399.0 5441.8 5463.0 5474.3 5512.6 4926.0 4950.5 4973.4 4979.1 4981.5 5791.6 5881.2 5898.6 5918.5 5925.6 4165.5 4204.9 4206.1 4206.6 4224.3 6187.8 6201.2 6205.4 6206.2 6216.7 4176.6 4243.4 4272.5 4273.8 4302.9 4283.0 4304.8 4305.6 4308.3 4308.4 4950.1 4971.9 4978.3 4991.4 4994.3 5634.4 5756.3 5908.0 5978.4 5994.6 1495.9 1509.4 1510.8 1511.4 1515.8 924.2 941.8 947.6 954.4 954.5 5174.2 5203.6 5209.1 5212.9 5248.9 5387.7 5426.5 5452.3 5483.3 5512.1 5141.6 5163.9 5184.6 5312.4 5313.3 2957.5 2960.6 2977.6 2984.0 2990.9 5573.2 5607.4 5666.3 5686.9 5702.5 5156.3 5568.6 5577.0 5583.2 5642.4 5661.7 5715.4 5717.6 5727.6 5772.7 5067.6 5412.8 5471.9 5518.3 5519.2 5423.6 5435.5 5440.1 5479.3 5482.7 5593.7 5643.7 5650.6 5652.3 5707.8 3870.4 3877.7 3922.8 4179.9 4226.3 5972.2 6101.1 6122.8 6161.4 6189.5 6018.6 6043.3 6056.0 6074.4 6102.0 5935.2 5970.2 5980.2 6020.7 6052.3 5632.9 5920.6 5938.7 5971.3 5975.3 5991.2 6034.3 6066.8 6075.8 6145.6 5623.2 5851.2 5918.0 5927.6 5936.6 19:59:25 INFO - PROCESS | 7467 | 19:59:25 INFO - PROCESS | 7467 | [#5] yui.html Cycles:180 Average:20683.93 Median:4137.16 stddev:27376.09 (661.7%) stddev-sans-first:27412.05 19:59:25 INFO - PROCESS | 7467 | Values: 770.9 794.7 899.2 915.7 919.8 16566.6 16968.8 17312.9 17389.2 17400.3 15533.9 15579.1 15629.2 15652.1 15738.8 727.5 854.4 868.7 880.4 884.4 863.3 868.9 877.0 878.1 879.6 922.9 927.2 928.7 929.6 936.1 926.8 931.1 932.0 933.8 934.0 674.5 675.8 678.6 679.7 681.5 15763.6 15801.2 15837.2 15849.5 15880.4 15613.7 15992.6 16306.2 16406.8 16516.1 13007.3 13183.2 13195.3 13276.1 13310.4 4061.5 4123.8 4134.5 4139.8 4159.9 75077.6 78093.5 78461.6 78768.6 79080.6 12728.3 12738.3 12870.4 12990.0 13177.9 24322.1 24411.1 24494.5 24509.9 24953.8 8832.3 8843.2 9112.7 9148.0 9331.1 5142.9 5258.7 5280.4 5330.4 5379.9 3636.1 3756.0 3824.0 3830.1 3830.1 633.2 639.6 647.4 648.9 664.8 811.5 821.6 848.7 850.0 857.3 10020.1 10774.1 10824.8 10927.2 10928.4 732.7 844.8 856.1 856.6 878.5 5235.2 5240.8 5322.6 5325.7 5441.9 74022.0 76871.0 77047.6 77494.0 79020.6 87967.6 99847.5 102190.0 102518.5 102832.5 90188.1 90901.5 91365.5 91730.5 92067.0 10096.5 10117.0 10154.8 10269.8 10301.1 50899.5 52541.5 52954.7 53122.0 54830.5 68375.0 69164.0 69910.7 79103.0 79506.0 13853.9 14004.8 14052.4 14381.8 14700.2 16035.7 16115.1 16654.8 16694.9 17076.8 14907.3 15494.0 15553.5 15599.9 16058.0 14710.0 14774.3 14903.4 15223.9 16083.8 14817.8 14991.8 15423.5 15617.0 15644.5 12014.2 12319.8 12452.3 13000.2 13237.5 12569.6 12879.4 12929.0 13082.2 13088.4 19:59:25 INFO - PROCESS | 7467 | -------- Summary: end -------- 19:59:25 INFO - PROCESS | 7467 | 19:59:26 INFO - TEST-INFO | 7467: exit 0 19:59:26 INFO - TEST-OK | dromaeo_css | took 1110291ms 19:59:26 INFO - TEST-START | kraken 19:59:26 INFO - operating with platform_type : linux_ 19:59:26 INFO - Initialising browser for kraken test... 19:59:26 INFO - TEST-INFO | started process 7711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6UQmk/profile http://localhost:58895/getInfo.html) 19:59:30 INFO - PROCESS | 7711 | __metrics Screen width/height:1600/1200 19:59:30 INFO - PROCESS | 7711 | colorDepth:24 19:59:30 INFO - PROCESS | 7711 | Browser inner width/height: 1024/697 19:59:30 INFO - PROCESS | 7711 | __metrics 19:59:31 ERROR - PROCESS | 7711 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:59:32 INFO - TEST-INFO | 7711: exit 0 19:59:32 INFO - Browser initialized. 19:59:32 INFO - Running cycle 1/1 for kraken test... 19:59:32 INFO - TEST-INFO | started process 7842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6UQmk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:44 INFO - PROCESS | 7842 | RSS: Main: 155955200 19:59:44 INFO - PROCESS | 7842 | 19:59:46 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:47 INFO - PROCESS | 7842 | RSS: Main: 161398784 19:59:47 INFO - PROCESS | 7842 | 19:59:50 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-dft) 19:59:50 INFO - PROCESS | 7842 | RSS: Main: 160792576 19:59:50 INFO - PROCESS | 7842 | 19:59:53 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-fft) 19:59:54 INFO - PROCESS | 7842 | RSS: Main: 161419264 19:59:54 INFO - PROCESS | 7842 | 19:59:56 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-oscillator) 19:59:57 INFO - PROCESS | 7842 | RSS: Main: 160587776 19:59:57 INFO - PROCESS | 7842 | 19:59:59 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:59 INFO - PROCESS | 7842 | RSS: Main: 160866304 19:59:59 INFO - PROCESS | 7842 | 20:00:02 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58895/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:03 INFO - PROCESS | 7842 | RSS: Main: 160116736 20:00:03 INFO - PROCESS | 7842 | 20:00:06 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58895/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:07 INFO - PROCESS | 7842 | RSS: Main: 161320960 20:00:07 INFO - PROCESS | 7842 | 20:00:10 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58895/tests/kraken/driver.html?testName=json-parse-financial) 20:00:11 INFO - PROCESS | 7842 | RSS: Main: 161210368 20:00:11 INFO - PROCESS | 7842 | 20:00:12 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:13 INFO - PROCESS | 7842 | RSS: Main: 160768000 20:00:13 INFO - PROCESS | 7842 | 20:00:14 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:15 INFO - PROCESS | 7842 | RSS: Main: 160886784 20:00:15 INFO - PROCESS | 7842 | 20:00:17 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:18 INFO - PROCESS | 7842 | RSS: Main: 161112064 20:00:18 INFO - PROCESS | 7842 | 20:00:20 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:21 INFO - PROCESS | 7842 | RSS: Main: 161722368 20:00:21 INFO - PROCESS | 7842 | 20:00:24 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:24 INFO - PROCESS | 7842 | RSS: Main: 161153024 20:00:24 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58895/tests/kraken/driver.html?testName=ai-astar) 20:00:26 INFO - PROCESS | 7842 | RSS: Main: 161861632 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | __start_tp_report 20:00:26 INFO - PROCESS | 7842 | _x_x_mozilla_page_load 20:00:26 INFO - PROCESS | 7842 | _x_x_mozilla_page_load_details 20:00:26 INFO - PROCESS | 7842 | |i|pagename|runs| 20:00:26 INFO - PROCESS | 7842 | |0;ai-astar;111;106;111;110;112;111;110;111;112;110 20:00:26 INFO - PROCESS | 7842 | |1;audio-beat-detection;154;125;154;175;133;151;151;130;179;126 20:00:26 INFO - PROCESS | 7842 | |2;audio-dft;163;162;160;160;160;162;162;162;162;161 20:00:26 INFO - PROCESS | 7842 | |3;audio-fft;75;75;76;174;76;76;75;74;170;76 20:00:26 INFO - PROCESS | 7842 | |4;audio-oscillator;84;84;145;85;88;84;139;84;83;149 20:00:26 INFO - PROCESS | 7842 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;118;118;118 20:00:26 INFO - PROCESS | 7842 | |6;imaging-darkroom;147;146;146;147;146;147;148;148;147;149 20:00:26 INFO - PROCESS | 7842 | |7;imaging-desaturate;95;95;95;95;95;96;99;96;95;95 20:00:26 INFO - PROCESS | 7842 | |8;json-parse-financial;51;52;52;55;52;66;53;52;52;52 20:00:26 INFO - PROCESS | 7842 | |9;json-stringify-tinderbox;61;62;61;61;61;61;60;60;61;61 20:00:26 INFO - PROCESS | 7842 | |10;stanford-crypto-aes;77;77;77;78;77;80;80;84;111;78 20:00:26 INFO - PROCESS | 7842 | |11;stanford-crypto-ccm;123;118;119;118;123;117;121;123;124;120 20:00:26 INFO - PROCESS | 7842 | |12;stanford-crypto-pbkdf2;158;161;163;153;154;164;157;158;155;160 20:00:26 INFO - PROCESS | 7842 | |13;stanford-crypto-sha256-iterative;62;65;63;64;67;63;62;62;63;66 20:00:26 INFO - PROCESS | 7842 | __end_tp_report 20:00:26 INFO - PROCESS | 7842 | __start_cc_report 20:00:26 INFO - PROCESS | 7842 | _x_x_mozilla_cycle_collect,867 20:00:26 INFO - PROCESS | 7842 | __end_cc_report 20:00:26 INFO - PROCESS | 7842 | __startTimestamp1469847626642__endTimestamp 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | ------- Summary: start ------- 20:00:26 INFO - PROCESS | 7842 | Number of tests: 14 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.71 (1.5%) stddev-sans-first:1.80 20:00:26 INFO - PROCESS | 7842 | Values: 111.0 106.0 111.0 110.0 112.0 111.0 110.0 111.0 112.0 110.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.50 stddev:19.27 (12.6%) stddev-sans-first:20.31 20:00:26 INFO - PROCESS | 7842 | Values: 154.0 125.0 154.0 175.0 133.0 151.0 151.0 130.0 179.0 126.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 20:00:26 INFO - PROCESS | 7842 | Values: 163.0 162.0 160.0 160.0 160.0 162.0 162.0 162.0 162.0 161.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:40.76 (54.0%) stddev-sans-first:42.60 20:00:26 INFO - PROCESS | 7842 | Values: 75.0 75.0 76.0 174.0 76.0 76.0 75.0 74.0 170.0 76.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.00 (34.5%) stddev-sans-first:29.97 20:00:26 INFO - PROCESS | 7842 | Values: 84.0 84.0 145.0 85.0 88.0 84.0 139.0 84.0 83.0 149.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:00:26 INFO - PROCESS | 7842 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 20:00:26 INFO - PROCESS | 7842 | Values: 147.0 146.0 146.0 147.0 146.0 147.0 148.0 148.0 147.0 149.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 20:00:26 INFO - PROCESS | 7842 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 99.0 96.0 95.0 95.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:52.00 stddev:4.45 (8.6%) stddev-sans-first:4.61 20:00:26 INFO - PROCESS | 7842 | Values: 51.0 52.0 52.0 55.0 52.0 66.0 53.0 52.0 52.0 52.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 20:00:26 INFO - PROCESS | 7842 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 61.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:78.00 stddev:10.46 (13.4%) stddev-sans-first:10.94 20:00:26 INFO - PROCESS | 7842 | Values: 77.0 77.0 77.0 78.0 77.0 80.0 80.0 84.0 111.0 78.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:122.00 stddev:2.55 (2.1%) stddev-sans-first:2.55 20:00:26 INFO - PROCESS | 7842 | Values: 123.0 118.0 119.0 118.0 123.0 117.0 121.0 123.0 124.0 120.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:3.71 (2.3%) stddev-sans-first:3.94 20:00:26 INFO - PROCESS | 7842 | Values: 158.0 161.0 163.0 153.0 154.0 164.0 157.0 158.0 155.0 160.0 20:00:26 INFO - PROCESS | 7842 | 20:00:26 INFO - PROCESS | 7842 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.77 (2.8%) stddev-sans-first:1.76 20:00:26 INFO - PROCESS | 7842 | Values: 62.0 65.0 63.0 64.0 67.0 63.0 62.0 62.0 63.0 66.0 20:00:26 INFO - PROCESS | 7842 | -------- Summary: end -------- 20:00:26 INFO - PROCESS | 7842 | 20:00:27 INFO - TEST-INFO | 7842: exit 0 20:00:27 INFO - TEST-OK | kraken | took 61341ms 20:00:27 INFO - SUITE-END | took 1171s 20:00:27 INFO - Completed test suite (00:19:31) 20:00:27 INFO - javascript benchmark 20:00:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7576.563135932958, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.932221355573, 3407.659234076591, 3427.674370934762, 3434.4676575130848, 3436.2783815398775, 5604.887902241952, 5648.802291919778, 5690.061139911914, 5700.37295897452, 5727.828165155052, 5657.547396208303, 5714.685692286923, 5744.109663002231, 5751.597388182819, 5757.827265182041, 5150.819721309755, 5190.403103643072, 5236.895262094756, 5267.209918512215, 5288.709120998344, 5087.821926232583, 5145.6398052136365, 5275.340582427197, 5286.867828304285, 5291.259223708684, 5202.505761952609, 5207.895842083156, 5210.583153347742, 5232.790688372461, 5262.368515778112, 5213.504717051893, 5248.5013923677, 5260.579153667697, 5265.341832270966, 5298.390685071227, 5042.84871453857, 5112.105381558213, 5183.2743415921805, 5237.266782650432, 5242.580593552507, 5565.749541270612, 5584.6090773645865, 5599.8880022399735, 5615.831525054255, 5671.744771485293, 6058.273007239115, 6095.817125486243, 6107.297660769024, 6117.296510901258, 6129.478994285491, 5883.17635531026, 6006.369331220203, 6195.31851496335, 6198.597091189104, 6209.037599172136, 5622.859428514279, 5704.344000439961, 5704.743286552073, 5707.885842283131, 5740.7703691852275, 6207.689615519206, 6208.689565521706, 6213.1922850029205, 6218.22272215973, 6223.875522489525, 5862.648241105548, 5870.765169393177, 5872.060470324727, 5968.045112781934, 5969.134475501028, 6026.367231440723, 6037.184980027728, 6044.1840351552855, 6062.545309101835, 6070.028795392716, 5925.229720136441, 5978.730957106941, 6014.0678194879865, 6015.939840601538, 6027.246594175728, 5878.5297176225795, 5990.131430942576, 6011.248593925759, 6032.4570788629235, 6037.215162028908, 4643.9783247685455, 4656.720596764205, 4658.068386322681, 4660.673752837269, 4684.976575117103, 4171.874843754692, 4183.184279065614, 4185.372194170899, 4208.8316467340965, 4222.239996800606, 5744.741486633028, 5799.9130013049835, 5816.854578635483, 5876.236089308362, 5885.793997210077, 5984.431479009487, 6032.607880487754, 6033.456988871023, 6050.6672133032225, 6087.208662873887, 5841.123831425235, 5843.0, 5849.0, 5852.887951289242, 5856.385079566669, 5074.847754567369, 5139.280500729901, 5156.793728250903, 5170.965806838647, 5193.324867767166, 6352.745890164341, 6353.5870168438905, 6354.682265886687, 6361.173047503888, 6363.840903977438, 5972.223610930551, 6117.510599152146, 6120.969395152996, 6124.571280010535, 6143.109249158936, 6275.905861412174, 6276.372362763687, 6299.811005669837, 6421.422072013541, 6434.517411194086, 6001.519878409629, 6021.126936594257, 6057.697115144313, 6057.757689692539, 6061.636301821728, 5897.9115313271195, 6067.635941843503, 6179.783707570394, 6191.071339299141, 6191.597546159485, 5904.5866789326055, 5992.580519363602, 5994.820155395345, 5997.820065398045, 6009.098635204754, 5930.377310382521, 6009.819705408845, 6015.097735339734, 6015.6691381974415, 6027.156198132353, 5765.077587585966, 5794.739236734273, 5794.797182098607, 5856.326522449973, 5872.0898260769645, 5985.431384018511, 5993.011153159679, 6019.428154325332, 6042.033274676207, 6055.364186760326, 5837.3870743571315, 5878.706064696663, 5883.646981181143, 5886.470217680429, 5888.823335299948], "value": 5623.660401913974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.8047384600006, 638.4955884850967, 664.6477366995488, 664.9202095748514, 665.6239224837966, 45569.544304556985, 47344.52655473448, 47734.80662983423, 50464.49535504644, 50769.23846142302, 48643.0, 49196.2620560691, 49231.26153107706, 49243.75378123104, 49249.261261081025, 9143.405678630901, 9259.212966897821, 9323.673671421502, 9348.298877584175, 9354.579043943006, 9155.038720934306, 9172.0, 9185.0, 9225.077492250755, 9226.953865230664, 9262.861057084148, 9298.488583127924, 9319.90680093197, 9333.06669333068, 9376.015518370576, 9164.312676549285, 9265.907340926571, 9274.258059355236, 9282.396644218172, 9324.207442367408, 9080.228180604656, 9108.59011344491, 9111.544422778834, 9153.496557689325, 9183.770405739842, 44526.33210501845, 44759.32861007087, 45121.323180151994, 45145.0, 45379.54620453786, 3823.655870971626, 3843.8078096095364, 3865.5168103987003, 3879.612038796126, 4054.7972601370107, 33946.1513462163, 34573.654263457545, 34585.48121778175, 34940.30119397623, 35001.474977875354, 4498.932516012263, 4632.510063111856, 4667.696599721041, 4669.929951050703, 4780.856574302777, 375761.0, 377692.1115394433, 378899.0, 379680.0, 381222.0, 68387.31612683908, 68928.31071689219, 68953.3104668957, 69047.3095269051, 69092.30907690858, 39459.0, 40529.392059119135, 40671.59328406737, 42484.57515424868, 42542.57457425448, 17809.109544522722, 17990.460286191435, 18102.366417175337, 18133.18400671973, 18204.180811863233, 13801.240931748649, 13801.309934503235, 13837.0, 13861.930690346686, 13958.232297223547, 21029.15883364648, 21043.579128417347, 21132.260370886946, 21223.575528489342, 21262.893685531475, 7472.17806041335, 7567.356774674105, 7587.924120758832, 7605.239476052461, 7698.384129269645, 1090.4765712458066, 1104.6023431564631, 1139.0944199361527, 1216.92698438094, 1234.6296111166794, 31884.202894927814, 32233.67766322307, 32902.0, 32919.67080329214, 32952.0, 1154.549725607014, 1169.2633640806237, 1174.5888938871326, 1214.4170798017, 1241.5716577780652, 17106.401275955282, 17139.97160170394, 17193.65612687739, 17227.569310767332, 17514.21186046631, 467436.0, 1001361.0, 1047849.0, 1061454.0, 1068720.0, 61420.69289653612, 62225.37774622196, 62731.686341568, 62737.37262627407, 62836.37163628397, 1469.3241109089724, 1487.4422091715608, 1504.4884739188728, 1513.3719506404939, 1537.7308970930267, 32167.0, 32783.50824737678, 33097.17257068593, 33291.33417331591, 34086.31827363389, 54047.18929215986, 54519.18221226764, 54787.0, 54868.0, 54940.0, 454191.0, 456803.0, 456856.0, 459067.0, 461065.0, 30217.546736798526, 30704.0, 30891.845540772152, 31552.526712099796, 31568.210794730316, 52723.736381317845, 52926.206106909194, 53394.0, 53765.46234537604, 54725.179122313995, 45509.772451137535, 45829.08341833078, 46308.30537541872, 46738.766306168254, 46762.29856552086, 45145.09709805851, 45409.0, 45878.31182532198, 45929.540704592524, 46165.769171155276, 43992.12015759603, 44828.0, 45234.0, 45240.0, 45532.0, 38040.809795950845, 38657.613423865405, 38895.6110438892, 40078.59921400749, 40483.39274910938, 29961.0, 30135.547966780956, 30154.547681784352, 30325.241868953453, 30802.69197308088], "value": 21707.76096528473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.664493437848, 411.83938264077017, 414.46533971177183, 423.41357220249944, 434.63924942297893, 18469.53826154345, 19451.124699388525, 19554.608907821854, 19908.800911990875, 20033.19867205314, 18498.445046648587, 18895.811041889578, 19039.428817135507, 19152.616947661074, 19228.42314730557, 5363.597730170223, 5686.488216060554, 5711.828645140652, 5711.971440142794, 5713.971430142864, 5522.585806064541, 5633.0987042073275, 5700.942990570104, 5716.657000579979, 5725.055365864649, 5663.442553297856, 5676.971615141919, 5688.516476099516, 5707.258056452676, 5726.799562015331, 5402.8919421611345, 5636.070048442002, 5653.8586535336535, 5667.234923285345, 5714.857128571777, 5065.366829146356, 5067.467915868854, 5073.518015788494, 5085.949140508622, 5093.312402825645, 16568.337266509327, 20978.0559874806, 21813.23653672114, 21897.343079707633, 22021.66967495489, 2213.922512712047, 2344.4021774447406, 2606.543854825417, 2730.6859711133275, 2745.6567929008875, 9868.555914983843, 10046.598136074548, 10111.595536178544, 10119.0, 10321.0, 2039.0518408939765, 2042.7548694156649, 2101.1280318667737, 2109.98945005274, 2119.173522326294, 69226.0, 72691.636541818, 72701.0, 75218.62390688066, 77728.0, 10642.787144257072, 11175.273607215506, 11237.943810280896, 11336.0, 11491.310521368745, 15856.365745370056, 15862.682746345008, 15934.36262549485, 15953.680926381407, 15956.76064859028, 8407.084050930349, 8419.873701894476, 8537.829243415097, 8569.700060497853, 8794.824103517894, 7679.654415551202, 7697.268759467842, 8485.32117430604, 8608.311335093178, 8655.13448655142, 4821.614270858393, 4912.754362281943, 4931.457539670633, 4957.925631115536, 4984.675996060245, 1980.4157773456866, 2053.147943603418, 2072.896355182265, 2082.7500699915804, 2095.287602215254, 960.6925783749273, 1021.2289721260549, 1022.9539670714687, 1034.6999370182564, 1051.2273478992934, 17913.7312940306, 17925.7311140333, 18574.721379179322, 18594.81405185958, 18618.44144675662, 1030.108955753268, 1060.1995493402433, 1071.566015763617, 1096.983545246822, 1125.1673761416494, 9117.77205569866, 10367.481625918674, 10423.895761042293, 10510.369377837354, 10591.788164236672, 506388.0, 517279.0, 529453.0, 537399.0, 542841.0, 89781.55109224412, 92411.0, 92688.53655731678, 93878.53060734653, 98935.0, 478.90661321042063, 500.8797888506732, 501.38830626635445, 502.2115279011989, 503.1999121396996, 10705.518251678537, 11088.889111109109, 11090.833637495605, 11345.773084538429, 11471.0, 35972.82013589915, 42161.156776863674, 42467.1506569873, 42492.0, 44749.32876006928, 57738.7113064432, 58864.70567647134, 58999.41000589939, 59152.704236478545, 59566.70216648889, 8563.272121869712, 8593.097724738813, 8625.39622226438, 8637.69768058115, 8761.036286008406, 9451.669191578261, 12403.441845117171, 12883.677908052374, 13016.674583135497, 13286.468541258242, 11555.0, 11581.305121692725, 11599.130065244972, 11653.359065251492, 11725.237859539102, 11008.0, 11070.446477675923, 11075.833862491907, 11399.772004560029, 11572.18994670365, 6799.932000680128, 8672.609732562176, 11907.82138267944, 11923.82114268304, 12335.876641233832, 8348.457350272212, 8785.736427907173, 9020.503872287087, 9037.186653201243, 9154.0, 10815.783684326112, 11887.583934562595, 11910.880891191324, 11946.522139114339, 11947.940260298643], "value": 8924.51836985261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1552.666176771994, 1570.207045442052, 1777.2979673029154, 1895.7914629390757, 1906.9618607627847, 8286.295664868494, 8950.597223124958, 8961.91038089619, 9741.464219467935, 9746.0, 9169.449833010023, 9394.201492873097, 9426.151646351827, 9436.575354109065, 9442.10300021497, 2387.0451819272257, 2420.4070002849326, 2423.660687503751, 2427.672264244331, 2428.611422172453, 2407.3981504623844, 2413.3001429585397, 2433.744456832034, 2438.085717855804, 2458.1150785717127, 2402.6396040593877, 2427.0, 2438.0, 2455.815813813962, 2463.359526523099, 2332.6617640442128, 2340.414896275931, 2376.66726658268, 2377.8929948152377, 2392.306231192952, 2406.0, 2423.3578101803037, 2436.4517983453757, 2438.4147804526965, 2451.681281433402, 9404.90595094047, 9418.058194180596, 9422.246220302359, 9499.145076943109, 9506.429614223169, 5420.13277875538, 5564.1931919871395, 5603.691796951166, 5613.129964855454, 5617.719114044322, 3425.8287085645866, 3471.94792078119, 3523.6476352364816, 3541.8937431877084, 3549.0949807798847, 1079.3685693869097, 1091.1489038549944, 1134.9148813838913, 1143.5254369436757, 1154.3881742676394, 13385.999999999902, 13532.32338383077, 13564.728705425836, 13582.049256552045, 13588.184708917397, 4687.484376718558, 4773.737444440589, 4844.539768721966, 4845.176320025604, 4860.6111511079025, 11171.944140279247, 11234.606788762354, 11343.773124537463, 11353.602623908124, 11381.203315767982, 5507.476789704971, 5567.693776842312, 5574.358948720949, 5575.776968921197, 5583.972080139573, 4486.147631949919, 4993.650444468925, 5058.9494105058475, 5141.511556402136, 5150.4334523202415, 4271.188474189894, 4301.0, 4373.825046998148, 4402.207602631493, 4408.360787685831, 1335.679436935148, 1362.9727405451836, 1365.6654119740726, 1366.5831921263912, 1370.9383077761524, 1069.2622090757352, 1084.3710647824244, 1095.39205740813, 1105.6130354375905, 1115.8995690387903, 6710.932890671128, 6735.663216839139, 6764.898526522106, 6766.69549870257, 6909.343612356818, 388.6074569012536, 390.2390338839275, 392.42901578203646, 396.0850435494018, 400.0977795072094, 4597.7011494252765, 4642.303654451792, 4647.883802904955, 4662.323963025342, 4669.41632295963, 11362.772744545064, 11679.591214307458, 11680.240784348991, 11686.240394374508, 11740.530378784924, 11008.944955275172, 11438.542458301741, 11455.427228638702, 11559.595414160463, 11606.941965290289, 8856.468611883307, 9052.140046695553, 9058.682946096988, 9081.364304498753, 9123.81752364949, 6652.401283884474, 6748.7300507979135, 6848.931510684829, 6874.12357907921, 6913.9974703668695, 10928.50821713009, 11035.72410689707, 11055.668329949793, 11079.612213572485, 11352.262102963281, 10965.451727413438, 11209.047230985458, 11323.207375483636, 11402.20184587071, 11406.258593191416, 7476.439267054884, 8170.632321545426, 8369.539675317916, 8644.09237030128, 8756.605952732016, 9320.906790932004, 9352.392094513834, 9376.156145946625, 9430.10414010668, 9437.292203084933, 8340.04089529712, 8491.715702610914, 8505.489670619536, 8561.957190214009, 8568.057513673366, 8367.372447066617, 8376.958115209385, 8393.916060839314, 8444.40889137779, 8469.788255293666, 7646.541207527566, 7666.731664391719, 7727.729529466442, 7742.535447873146, 7744.8451030980195, 5651.802186923438, 5854.2389489366105, 5934.109883517507, 5956.37458066914, 5995.850103747442, 5677.3471050829685, 5758.942410575841, 5766.884662306814, 5799.681017544076, 5826.096954971986], "value": 4880.981432667155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.24337455169416, 327.8917957074166, 330.39537646107624, 335.5486870159636, 337.3202995963134, 5518.889622207554, 5645.802396916109, 5694.316681998155, 5771.682557459338, 5791.59458837881, 5655.886882262353, 5667.716614169285, 5677.687727175004, 5683.005474042046, 5698.601097923147, 4416.410092366754, 4426.822927082929, 4438.156750217465, 4440.400545926291, 4450.821967121327, 4155.33514637658, 4393.85759702478, 4399.2301347264265, 4442.244818380883, 4451.6406304658585, 4310.52584215736, 4335.978320108395, 4338.544452832454, 4342.565743425664, 4343.435353404053, 4324.286492728696, 4373.387725718402, 4382.167388196249, 4388.626966707818, 4408.691391602589, 3765.9811700941596, 3824.8852534424013, 3839.1361943562756, 3845.384738441836, 3860.5560360558334, 5398.973005134989, 5441.755121019524, 5463.028643934001, 5474.343078830566, 5512.641678290898, 4925.950740492585, 4950.504949505057, 4973.378327709001, 4979.10376132296, 4981.476944920767, 5791.623544469596, 5881.206037184968, 5898.557608179403, 5918.496927761145, 5925.600131946569, 4165.541790403053, 4204.894877628053, 4206.116715489751, 4206.621404073648, 4224.324108142713, 6187.845303867394, 6201.162843016225, 6205.410486003822, 6206.162168107338, 6216.658083805389, 4176.60322269384, 4243.448351714257, 4272.465941757218, 4273.786310684515, 4302.870913872589, 4282.978585107055, 4304.806283717177, 4305.569443055732, 4308.332208507686, 4308.353746937984, 4950.108980383494, 4971.900561988812, 4978.253262010728, 4991.401031876126, 4994.300797888299, 5634.394197653649, 5756.301890942182, 5907.957401938005, 5978.432048955342, 5994.610350327215, 1495.8952873298765, 1509.433962264151, 1510.7507261301762, 1511.3727802961866, 1515.772634104871, 924.1820988425158, 941.7975135345933, 947.5641205045756, 954.4082668745283, 954.4511905654276, 5174.24973378858, 5203.583713302926, 5209.134975763315, 5212.895742085213, 5248.947510524922, 5387.703676297763, 5426.511613954763, 5452.263944367539, 5483.314585676791, 5512.125877201691, 5141.562967147759, 5163.870903227375, 5184.637075404686, 5312.362516497968, 5313.282706834605, 2957.4676558219726, 2960.5937179839834, 2977.5558853955813, 2983.9552406713915, 2990.8504574771173, 5573.247611572467, 5607.43925607436, 5666.320041595035, 5686.914696279559, 5702.45826646468, 5156.303898973665, 5568.582356323292, 5577.0, 5583.218349431083, 5642.4075472075665, 5661.745221465044, 5715.399883012307, 5717.628354156966, 5727.5990680652785, 5772.711364431846, 5067.619928505451, 5412.78348866041, 5471.932973070213, 5518.2826232589505, 5519.185215540184, 5423.5932305076485, 5435.483629055233, 5440.123157510652, 5479.2602998594675, 5482.725863706719, 5593.713445907382, 5643.689597072036, 5650.604457687922, 5652.293463317085, 5707.800226992202, 3870.3807390817333, 3877.747946383476, 3922.7839369794315, 4179.937300940427, 4226.344916537942, 5972.163897054503, 6101.054336577838, 6122.816315510542, 6161.4146656067605, 6189.473894718999, 6018.608790428608, 6043.3352331244405, 6056.0, 6074.36219196978, 6102.0, 5935.228420305332, 5970.223870896755, 5980.192673988956, 6020.668863212565, 6052.273727152769, 5632.943670563406, 5920.585559011, 5938.73275702603, 5971.343152253336, 5975.281247032676, 5991.221141251609, 6034.275886893425, 6066.817995460143, 6075.756969721162, 6145.600535965148, 5623.240862483676, 5851.180834683233, 5917.970410148094, 5927.555433342603, 5936.5844390892225], "value": 4370.815595102361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.9069875288591, 794.6821271491402, 899.1592860675269, 915.7481692534557, 919.8482250428677, 16566.585835354108, 16968.830311696896, 17312.913435432838, 17389.217485213165, 17400.30398784047, 15533.922330388361, 15579.143147126932, 15629.21853907303, 15652.0608763474, 15738.84261157388, 727.4834867244263, 854.3763052971335, 868.665563757953, 880.3749337970049, 884.3500027479797, 863.3352318714586, 868.8957325120995, 876.9649214031463, 878.0824038879355, 879.5690111845182, 922.8846394200725, 927.2026057590467, 928.7120992492315, 929.6281487405024, 936.0732874454276, 926.7868390270276, 931.0828833598899, 931.9580618872201, 933.785229397239, 933.9719808405758, 674.527830518634, 675.8073948924533, 678.5589366911497, 679.6669631880393, 681.5433659448181, 15763.605909852231, 15801.209939502978, 15837.208139592974, 15849.52451426459, 15880.444184453605, 15613.719759620371, 15992.600184995352, 16306.184690765414, 16406.753898691528, 16516.091614961173, 13007.349632518431, 13183.209007459584, 13195.2742599157, 13276.137051091648, 13310.401031953585, 4061.4643564454773, 4123.773192474413, 4134.545200028025, 4139.77231252281, 4159.875203743893, 75077.62461187714, 78093.48579313888, 78461.60769196175, 78768.60615696885, 79080.60459697664, 12728.299943503196, 12738.299393533445, 12870.420831062625, 12990.0, 13177.934110329386, 24322.148724794548, 24411.145609903924, 24494.510109797706, 24509.877450612632, 24953.750462495507, 8832.337574681924, 8843.207698957194, 9112.726618201465, 9148.039455857039, 9331.113544213289, 5142.897142057138, 5258.6581872178185, 5280.419153893069, 5330.440303768049, 5379.946200538023, 3636.090977255686, 3756.042209236627, 3823.9808800956375, 3830.0807806126886, 3830.138218900725, 633.2179757998867, 639.6290151711996, 647.3526473526474, 648.8896887529131, 664.7706541243264, 811.5333683132222, 821.5974172655356, 848.6944699908152, 849.9660013599511, 857.2927334948693, 10020.073851949204, 10774.138068954464, 10824.837627435594, 10927.180461465421, 10928.398938058324, 732.6959311885614, 844.7972486603171, 856.07543852639, 856.5545916123581, 878.4597472554333, 5235.240890070994, 5240.842774716764, 5322.600804939568, 5325.680459172462, 5441.891162176814, 74022.0, 76871.0, 77047.61476192583, 77494.0, 79020.60489697629, 87967.56016220005, 99847.50076249572, 102190.0, 102518.48740756248, 102832.48583757033, 90188.09811901928, 90901.54549227344, 91365.54317228371, 91730.54134729283, 92067.0, 10096.545655445376, 10117.0, 10154.847677284994, 10269.84595231087, 10301.124404425407, 50899.49100509095, 52541.47458525366, 52954.735226323624, 53122.0, 54830.45169548254, 68375.0, 69164.0, 69910.71650625441, 79103.0, 79506.0, 13853.861461385257, 14004.789928150882, 14052.367643455864, 14381.7842732357, 14700.191489468181, 16035.679286413973, 16115.113668748332, 16654.833451665814, 16694.916525417782, 17076.829231707525, 14907.329170187151, 15494.0, 15553.533393998197, 15599.922000389925, 16058.036517808969, 14710.0, 14774.261286935396, 14903.403863845324, 15223.92388038097, 16083.839161608234, 14817.777733334224, 14991.775123373376, 15423.537293881202, 15617.0, 15644.530664080095, 12014.159008869296, 12319.815202772144, 12452.252864828139, 13000.219986800823, 13237.470501179845, 12569.560065397667, 12879.356032198166, 12928.98081235983, 13082.215067096005, 13088.411021503865], "value": 8137.692348818048, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 110.0, 112.0, 111.0, 110.0, 111.0, 112.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 154.0, 175.0, 133.0, 151.0, 151.0, 130.0, 179.0, 126.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 160.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 174.0, 76.0, 76.0, 75.0, 74.0, 170.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 145.0, 85.0, 88.0, 84.0, 139.0, 84.0, 83.0, 149.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 99.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 55.0, 52.0, 66.0, 53.0, 52.0, 52.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 78.0, 77.0, 80.0, 80.0, 84.0, 111.0, 78.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 118.0, 119.0, 118.0, 123.0, 117.0, 121.0, 123.0, 124.0, 120.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 163.0, 153.0, 154.0, 164.0, 157.0, 158.0, 155.0, 160.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 64.0, 67.0, 63.0, 62.0, 62.0, 63.0, 66.0], "value": 63.7, "unit": "score"}]}]} 20:00:27 INFO - Return code: 0 20:00:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:00:27 ERROR - # TBPL SUCCESS # 20:00:27 INFO - Running post-action listener: _resource_record_post_action 20:00:27 INFO - ##### 20:00:27 INFO - ##### Finished run-tests step (success) 20:00:27 INFO - ##### 20:00:27 INFO - Running post-run listener: _resource_record_post_run 20:00:28 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 432275456; Read time: 0; Write time: 390916 20:00:28 INFO - TinderboxPrint: CPU usage
13.4% 20:00:28 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:00:28 INFO - TinderboxPrint: I/O write bytes / time
432,275,456 / 390,916 20:00:28 INFO - TinderboxPrint: CPU idle
8,211.4 (86.6%) 20:00:28 INFO - TinderboxPrint: CPU user
1,217.3 (12.8%) 20:00:28 INFO - TinderboxPrint: Swap in / out
0 / 0 20:00:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 181919744; Read time: 0; Write time: 210752 20:00:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 250355712; Read time: 0; Write time: 180164 20:00:28 INFO - Running post-run listener: _upload_blobber_files 20:00:28 INFO - Blob upload gear active. 20:00:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:28 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 20:00:28 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'] 20:00:28 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 20:00:28 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:00:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:00:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:29 INFO - (blobuploader) - INFO - Done attempting. 20:00:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:00:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:00:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:30 INFO - (blobuploader) - INFO - Done attempting. 20:00:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:00:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:00:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:33 INFO - (blobuploader) - INFO - Done attempting. 20:00:33 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:33 INFO - Return code: 0 20:00:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/689c0bcb8bda7348b46f2a4b34e11ca8786a6b70721205e561206f5cf5acedc6e7d13143c0f843b45411fc517f6ffc8ded1dfb8f3c5479dcac35804146dc99f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6da4910cbb82fe3d6b8e435c1c0fa6c4e77cdcedf4d9a2d3710648c1df7185e0fc3ee4fcd8c6a027751fb724b93c8dd6a83c224d5791474aa97dc9a55078eccf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af9af4cd0fc1059c8321d3059c87a481b868bc0ec986fd6b8cfffb946b3db4476478f385aa442c1de74a1666f5d9c34eb88151a9b4497f209a1a5c5668da36e9"} 20:00:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:33 INFO - Contents: 20:00:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/689c0bcb8bda7348b46f2a4b34e11ca8786a6b70721205e561206f5cf5acedc6e7d13143c0f843b45411fc517f6ffc8ded1dfb8f3c5479dcac35804146dc99f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6da4910cbb82fe3d6b8e435c1c0fa6c4e77cdcedf4d9a2d3710648c1df7185e0fc3ee4fcd8c6a027751fb724b93c8dd6a83c224d5791474aa97dc9a55078eccf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af9af4cd0fc1059c8321d3059c87a481b868bc0ec986fd6b8cfffb946b3db4476478f385aa442c1de74a1666f5d9c34eb88151a9b4497f209a1a5c5668da36e9"} 20:00:33 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:33 INFO - Copying logs to upload dir... 20:00:33 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.613282 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-29 20:00:33.653283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 20:00:33.656784) ========= 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=920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628 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/689c0bcb8bda7348b46f2a4b34e11ca8786a6b70721205e561206f5cf5acedc6e7d13143c0f843b45411fc517f6ffc8ded1dfb8f3c5479dcac35804146dc99f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6da4910cbb82fe3d6b8e435c1c0fa6c4e77cdcedf4d9a2d3710648c1df7185e0fc3ee4fcd8c6a027751fb724b93c8dd6a83c224d5791474aa97dc9a55078eccf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af9af4cd0fc1059c8321d3059c87a481b868bc0ec986fd6b8cfffb946b3db4476478f385aa442c1de74a1666f5d9c34eb88151a9b4497f209a1a5c5668da36e9"} build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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/689c0bcb8bda7348b46f2a4b34e11ca8786a6b70721205e561206f5cf5acedc6e7d13143c0f843b45411fc517f6ffc8ded1dfb8f3c5479dcac35804146dc99f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6da4910cbb82fe3d6b8e435c1c0fa6c4e77cdcedf4d9a2d3710648c1df7185e0fc3ee4fcd8c6a027751fb724b93c8dd6a83c224d5791474aa97dc9a55078eccf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af9af4cd0fc1059c8321d3059c87a481b868bc0ec986fd6b8cfffb946b3db4476478f385aa442c1de74a1666f5d9c34eb88151a9b4497f209a1a5c5668da36e9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 20:00:33.682165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:00:33.682495) ========= 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=920470bf432669ad7e3a5387000001ca-1469846267.333327-536586628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 20:00:33.766202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 20:00:33.766535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 20:00:33.766839) ========= ========= Total master_lag: 0.16 =========