builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1469873394.83 results: success (0) buildid: 20160729170826 builduid: 5bb96b5f7e074e778445d151ad800bd4 revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.831204) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.832115) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.832797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.846018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.846576) ========= 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=8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:09:55-- 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% 33.5M=0s 2016-07-30 03:09:55 (33.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.938316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.939005) ========= 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=8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:54.991322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:09:54.992108) ========= 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=8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:09:55,415 truncating revision to first 12 chars 2016-07-30 03:09:55,415 Setting DEBUG logging. 2016-07-30 03:09:55,415 attempt 1/10 2016-07-30 03:09:55,416 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-30 03:09:56,181 unpacking tar archive at: mozilla-aurora-589e1f984537/testing/mozharness/ program finished with exit code 0 elapsedTime=1.103639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:09:56.116165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:56.116564) ========= script_repo_revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:56.117061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:56.117375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:56.128486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-30 03:09:56.129027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:56 INFO - MultiFileLogger online at 20160730 03:09:56 in /builds/slave/test 03:09:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:09:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:56 INFO - {'append_to_log': False, 03:09:56 INFO - 'base_work_dir': '/builds/slave/test', 03:09:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:09:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:56 INFO - 'branch': 'Mozilla-Aurora', 03:09:56 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:56 INFO - 'config_files': ('talos/linux_config.py',), 03:09:56 INFO - 'default_actions': ('clobber', 03:09:56 INFO - 'read-buildbot-config', 03:09:56 INFO - 'download-and-extract', 03:09:56 INFO - 'populate-webroot', 03:09:56 INFO - 'create-virtualenv', 03:09:56 INFO - 'install', 03:09:56 INFO - 'run-tests'), 03:09:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:56 INFO - 'download_minidump_stackwalk': True, 03:09:56 INFO - 'download_symbols': 'ondemand', 03:09:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:56 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:56 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:56 INFO - 'installer_path': 'installer.exe', 03:09:56 INFO - 'log_level': 'info', 03:09:56 INFO - 'log_name': 'talos', 03:09:56 INFO - 'log_to_console': True, 03:09:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:56 INFO - 'opt_config_files': (), 03:09:56 INFO - 'pip_index': False, 03:09:56 INFO - 'sps_profile': False, 03:09:56 INFO - 'sps_profile_interval': 0, 03:09:56 INFO - 'suite': 'dromaeojs', 03:09:56 INFO - 'system_bits': '32', 03:09:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:56 INFO - 'title': 'talos-linux64-ix-038', 03:09:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:56 INFO - 'use_talos_json': True, 03:09:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:56 INFO - 'work_dir': 'build'} 03:09:56 INFO - ##### 03:09:56 INFO - ##### Running clobber step. 03:09:56 INFO - ##### 03:09:56 INFO - Running pre-action listener: _resource_record_pre_action 03:09:56 INFO - Running main action method: clobber 03:09:56 INFO - rmtree: /builds/slave/test/build 03:09:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:57 INFO - Running post-action listener: _resource_record_post_action 03:09:57 INFO - ##### 03:09:57 INFO - ##### Finished clobber step (success) 03:09:57 INFO - ##### 03:09:57 INFO - ##### 03:09:57 INFO - ##### Running read-buildbot-config step. 03:09:57 INFO - ##### 03:09:57 INFO - Running pre-action listener: _resource_record_pre_action 03:09:57 INFO - Running main action method: read_buildbot_config 03:09:57 INFO - Using buildbot properties: 03:09:57 INFO - { 03:09:57 INFO - "project": "", 03:09:57 INFO - "product": "firefox", 03:09:57 INFO - "script_repo_revision": "production", 03:09:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:09:57 INFO - "repository": "", 03:09:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:09:57 INFO - "buildid": "20160729170826", 03:09:57 INFO - "pgo_build": "True", 03:09:57 INFO - "basedir": "/builds/slave/test", 03:09:57 INFO - "buildnumber": 433, 03:09:57 INFO - "slavename": "talos-linux64-ix-038", 03:09:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:09:57 INFO - "platform": "ubuntu64_hw", 03:09:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:09:57 INFO - "branch": "mozilla-aurora", 03:09:57 INFO - "repo_path": "releases/mozilla-aurora", 03:09:57 INFO - "revision": "589e1f984537e280ff84591e94afdc3c5bfe2710", 03:09:57 INFO - "stage_platform": "linux64-pgo", 03:09:57 INFO - "builduid": "5bb96b5f7e074e778445d151ad800bd4", 03:09:57 INFO - "slavebuilddir": "test" 03:09:57 INFO - } 03:09:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:09:57 INFO - Running post-action listener: _resource_record_post_action 03:09:57 INFO - ##### 03:09:57 INFO - ##### Finished read-buildbot-config step (success) 03:09:57 INFO - ##### 03:09:57 INFO - ##### 03:09:57 INFO - ##### Running download-and-extract step. 03:09:57 INFO - ##### 03:09:57 INFO - Running pre-action listener: _resource_record_pre_action 03:09:57 INFO - Running main action method: download_and_extract 03:09:57 INFO - mkdir: /builds/slave/test/build/tests 03:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:57 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 03:09:57 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 03:09:57 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 03:09:57 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 03:09:57 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 03:09:57 INFO - Downloaded 1361 bytes. 03:09:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:09:57 INFO - Using the following test package requirements: 03:09:57 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:09:57 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:09:57 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:09:57 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'jsshell-linux-x86_64.zip'], 03:09:57 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:09:57 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:09:57 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:09:57 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:09:57 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:09:57 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:09:57 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:09:57 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:57 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 03:09:57 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 03:09:57 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 03:09:57 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 03:09:57 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 03:09:58 INFO - Downloaded 24496939 bytes. 03:09:58 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'] 03:09:58 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 03:09:59 INFO - Return code: 0 03:09:59 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 03:09: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')]} 03:09: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 03:09: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 03:09: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 03:09: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 03:09: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 03:10:01 INFO - Downloaded 24496939 bytes. 03:10: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'] 03:10: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 03:10:03 INFO - Return code: 0 03:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:03 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 03:10:03 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 03:10:03 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 03:10:03 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 03:10:03 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 03:10:04 INFO - Downloaded 10833369 bytes. 03:10:04 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'] 03:10:04 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 03:10:04 INFO - Return code: 0 03:10:04 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')]} 03:10:04 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 03:10:04 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 03:10:04 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 03:10:04 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 03:10:04 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 03:10:05 INFO - Downloaded 63648271 bytes. 03:10:05 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 03:10:05 INFO - mkdir: /builds/slave/test/properties 03:10:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:05 INFO - Contents: 03:10:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:10:06 INFO - Running post-action listener: _resource_record_post_action 03:10:06 INFO - Running post-action listener: set_extra_try_arguments 03:10:06 INFO - ##### 03:10:06 INFO - ##### Finished download-and-extract step (success) 03:10:06 INFO - ##### 03:10:06 INFO - ##### 03:10:06 INFO - ##### Running populate-webroot step. 03:10:06 INFO - ##### 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: populate_webroot 03:10:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:06 INFO - '--tppagecycles', 03:10:06 INFO - '7'], 03:10:06 INFO - 'tests': ['tsvgm']}}, 03:10:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:10:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:10:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:10:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['damp', 'tps']}, 03:10:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'tests': ['damp', 'tps']}, 03:10:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['dromaeo_dom']}, 03:10:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['a11yr', 03:10:06 INFO - 'ts_paint', 03:10:06 INFO - 'tpaint', 03:10:06 INFO - 'sessionrestore', 03:10:06 INFO - 'sessionrestore_no_auto_restore', 03:10:06 INFO - 'tabpaint']}, 03:10:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tsvgx', 03:10:06 INFO - 'tsvgr_opacity', 03:10:06 INFO - 'tart', 03:10:06 INFO - 'tscrollx', 03:10:06 INFO - 'cart']}, 03:10:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:10:06 INFO - 'tsvgr_opacity', 03:10:06 INFO - 'tart', 03:10:06 INFO - 'tscrollx', 03:10:06 INFO - 'cart']}, 03:10:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s'], 03:10:06 INFO - 'tests': ['tp5o']}, 03:10:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'tests': ['tp5o']}, 03:10:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'talos_options': ['--disable-e10s', 03:10:06 INFO - '--xperf_path', 03:10:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:06 INFO - 'tests': ['tp5n']}, 03:10:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:06 INFO - 'talos_options': ['--xperf_path', 03:10:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:06 INFO - 'tests': ['tp5n']}}, 03:10:06 INFO - 'talos.zip': {'path': '', 03:10:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:06 INFO - Running post-action listener: _resource_record_post_action 03:10:06 INFO - ##### 03:10:06 INFO - ##### Finished populate-webroot step (success) 03:10:06 INFO - ##### 03:10:06 INFO - ##### 03:10:06 INFO - ##### Running create-virtualenv step. 03:10:06 INFO - ##### 03:10:06 INFO - Running pre-action listener: _resource_record_pre_action 03:10:06 INFO - Running main action method: create_virtualenv 03:10:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:10:06 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 03:10:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:10:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:06 INFO - Using real prefix '/usr' 03:10:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:10:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:09 INFO - Installing pip.................done. 03:10:09 INFO - Return code: 0 03:10:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:09 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:09 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 03:10:09 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 03:10:09 INFO - Using env: {'DISPLAY': ':0', 03:10:09 INFO - 'HOME': '/home/cltbld', 03:10:09 INFO - 'LANG': 'en_US.UTF-8', 03:10:09 INFO - 'LANGUAGE': 'en_US:en', 03:10:09 INFO - 'LOGNAME': 'cltbld', 03:10:09 INFO - 'MAIL': '/var/mail/cltbld', 03:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:09 INFO - 'MOZ_NO_REMOTE': '1', 03:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:09 INFO - 'NO_EM_RESTART': '1', 03:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:09 INFO - 'PWD': '/builds/slave/test', 03:10:09 INFO - 'SHELL': '/bin/bash', 03:10:09 INFO - 'SHLVL': '1', 03:10:09 INFO - 'TERM': 'linux', 03:10:09 INFO - 'TMOUT': '86400', 03:10:09 INFO - 'USER': 'cltbld', 03:10:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:09 INFO - '_': '/tools/buildbot/bin/python'} 03:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:09 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 03:10:09 INFO - Cleaning up... 03:10:09 INFO - Return code: 0 03:10:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:09 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:09 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 03:10:09 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 03:10:09 INFO - Using env: {'DISPLAY': ':0', 03:10:09 INFO - 'HOME': '/home/cltbld', 03:10:09 INFO - 'LANG': 'en_US.UTF-8', 03:10:09 INFO - 'LANGUAGE': 'en_US:en', 03:10:09 INFO - 'LOGNAME': 'cltbld', 03:10:09 INFO - 'MAIL': '/var/mail/cltbld', 03:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:09 INFO - 'MOZ_NO_REMOTE': '1', 03:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:09 INFO - 'NO_EM_RESTART': '1', 03:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:09 INFO - 'PWD': '/builds/slave/test', 03:10:09 INFO - 'SHELL': '/bin/bash', 03:10:09 INFO - 'SHLVL': '1', 03:10:09 INFO - 'TERM': 'linux', 03:10:09 INFO - 'TMOUT': '86400', 03:10:09 INFO - 'USER': 'cltbld', 03:10:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:09 INFO - '_': '/tools/buildbot/bin/python'} 03:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:09 INFO - Downloading/unpacking psutil>=3.1.1 03:10:09 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 03:10:09 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 03:10:09 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 03:10:09 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 03:10:09 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 03:10:09 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 03:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:11 INFO - Installing collected packages: psutil 03:10:11 INFO - Running setup.py install for psutil 03:10:11 INFO - building 'psutil._psutil_linux' extension 03:10:11 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 03:10:11 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 03:10:11 INFO - building 'psutil._psutil_posix' extension 03:10:11 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 03:10:11 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 03:10:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:12 INFO - Successfully installed psutil 03:10:12 INFO - Cleaning up... 03:10:12 INFO - Return code: 0 03:10:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:12 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:12 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 03:10:12 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 03:10:12 INFO - Using env: {'DISPLAY': ':0', 03:10:12 INFO - 'HOME': '/home/cltbld', 03:10:12 INFO - 'LANG': 'en_US.UTF-8', 03:10:12 INFO - 'LANGUAGE': 'en_US:en', 03:10:12 INFO - 'LOGNAME': 'cltbld', 03:10:12 INFO - 'MAIL': '/var/mail/cltbld', 03:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:12 INFO - 'MOZ_NO_REMOTE': '1', 03:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:12 INFO - 'NO_EM_RESTART': '1', 03:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:12 INFO - 'PWD': '/builds/slave/test', 03:10:12 INFO - 'SHELL': '/bin/bash', 03:10:12 INFO - 'SHLVL': '1', 03:10:12 INFO - 'TERM': 'linux', 03:10:12 INFO - 'TMOUT': '86400', 03:10:12 INFO - 'USER': 'cltbld', 03:10:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:12 INFO - '_': '/tools/buildbot/bin/python'} 03:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:10:12 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 03:10:12 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 03:10:12 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 03:10:12 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 03:10:12 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 03:10:12 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 03:10:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:10:14 INFO - Installing collected packages: mozsystemmonitor 03:10:14 INFO - Running setup.py install for mozsystemmonitor 03:10:14 INFO - Successfully installed mozsystemmonitor 03:10:14 INFO - Cleaning up... 03:10:14 INFO - Return code: 0 03:10:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:10:14 INFO - Using env: {'DISPLAY': ':0', 03:10:14 INFO - 'HOME': '/home/cltbld', 03:10:14 INFO - 'LANG': 'en_US.UTF-8', 03:10:14 INFO - 'LANGUAGE': 'en_US:en', 03:10:14 INFO - 'LOGNAME': 'cltbld', 03:10:14 INFO - 'MAIL': '/var/mail/cltbld', 03:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:14 INFO - 'MOZ_NO_REMOTE': '1', 03:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:14 INFO - 'NO_EM_RESTART': '1', 03:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:14 INFO - 'PWD': '/builds/slave/test', 03:10:14 INFO - 'SHELL': '/bin/bash', 03:10:14 INFO - 'SHLVL': '1', 03:10:14 INFO - 'TERM': 'linux', 03:10:14 INFO - 'TMOUT': '86400', 03:10:14 INFO - 'USER': 'cltbld', 03:10:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:14 INFO - '_': '/tools/buildbot/bin/python'} 03:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:16 INFO - warning: no files found matching '*.txt' 03:10:16 INFO - no previously-included directories found matching 'build' 03:10:16 INFO - no previously-included directories found matching 'dist' 03:10:16 INFO - no previously-included directories found matching '.git*' 03:10:16 INFO - Installing collected packages: jsonschema, functools32 03:10:16 INFO - Running setup.py install for functools32 03:10:16 INFO - warning: no files found matching '*.txt' 03:10:16 INFO - no previously-included directories found matching 'build' 03:10:16 INFO - no previously-included directories found matching 'dist' 03:10:16 INFO - no previously-included directories found matching '.git*' 03:10:16 INFO - Successfully installed jsonschema functools32 03:10:16 INFO - Cleaning up... 03:10:16 INFO - Return code: 0 03:10:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10:16 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')]} 03:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:16 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')]} 03:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:16 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:16 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 03:10:16 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 03:10:16 INFO - Using env: {'DISPLAY': ':0', 03:10:16 INFO - 'HOME': '/home/cltbld', 03:10:16 INFO - 'LANG': 'en_US.UTF-8', 03:10:16 INFO - 'LANGUAGE': 'en_US:en', 03:10:16 INFO - 'LOGNAME': 'cltbld', 03:10:16 INFO - 'MAIL': '/var/mail/cltbld', 03:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:16 INFO - 'MOZ_NO_REMOTE': '1', 03:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:16 INFO - 'NO_EM_RESTART': '1', 03:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:16 INFO - 'PWD': '/builds/slave/test', 03:10:16 INFO - 'SHELL': '/bin/bash', 03:10:16 INFO - 'SHLVL': '1', 03:10:16 INFO - 'TERM': 'linux', 03:10:16 INFO - 'TMOUT': '86400', 03:10:16 INFO - 'USER': 'cltbld', 03:10:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:16 INFO - '_': '/tools/buildbot/bin/python'} 03:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:19 INFO - Downloading docopt-0.6.1.tar.gz 03:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:19 INFO - Running setup.py install for blobuploader 03:10:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:19 INFO - Running setup.py install for requests 03:10:20 INFO - Running setup.py install for docopt 03:10:20 INFO - Successfully installed blobuploader requests docopt 03:10:20 INFO - Cleaning up... 03:10:20 INFO - Return code: 0 03:10:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:20 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')]} 03:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:20 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')]} 03:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:20 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:20 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 03:10:20 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 03:10:20 INFO - Using env: {'DISPLAY': ':0', 03:10:20 INFO - 'HOME': '/home/cltbld', 03:10:20 INFO - 'LANG': 'en_US.UTF-8', 03:10:20 INFO - 'LANGUAGE': 'en_US:en', 03:10:20 INFO - 'LOGNAME': 'cltbld', 03:10:20 INFO - 'MAIL': '/var/mail/cltbld', 03:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:20 INFO - 'MOZ_NO_REMOTE': '1', 03:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:20 INFO - 'NO_EM_RESTART': '1', 03:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:20 INFO - 'PWD': '/builds/slave/test', 03:10:20 INFO - 'SHELL': '/bin/bash', 03:10:20 INFO - 'SHLVL': '1', 03:10:20 INFO - 'TERM': 'linux', 03:10:20 INFO - 'TMOUT': '86400', 03:10:20 INFO - 'USER': 'cltbld', 03:10:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:20 INFO - '_': '/tools/buildbot/bin/python'} 03:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:20 INFO - Running setup.py (path:/tmp/pip-5fenGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:20 INFO - Running setup.py (path:/tmp/pip-6DhG9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:20 INFO - Running setup.py (path:/tmp/pip-zYf6zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:20 INFO - Running setup.py (path:/tmp/pip-ssJRsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:20 INFO - Running setup.py (path:/tmp/pip-c_HLiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:20 INFO - Running setup.py (path:/tmp/pip-7uMvg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:21 INFO - Running setup.py (path:/tmp/pip-DwsM98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:21 INFO - Running setup.py (path:/tmp/pip-Us1Kg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:21 INFO - Running setup.py (path:/tmp/pip-ypdXpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:21 INFO - Running setup.py (path:/tmp/pip-O6iijY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:21 INFO - Running setup.py (path:/tmp/pip-CB6VNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:21 INFO - Running setup.py (path:/tmp/pip-u8M49B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:21 INFO - Running setup.py (path:/tmp/pip-DQZY4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:21 INFO - Running setup.py (path:/tmp/pip-Ouzen_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:21 INFO - Running setup.py (path:/tmp/pip-mRFEbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:21 INFO - Running setup.py (path:/tmp/pip-Eacsll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:21 INFO - Running setup.py (path:/tmp/pip-N8VgcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:21 INFO - Running setup.py install for manifestparser 03:10:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:21 INFO - Running setup.py install for mozcrash 03:10:22 INFO - Running setup.py install for mozdebug 03:10:22 INFO - Running setup.py install for mozdevice 03:10:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Running setup.py install for mozfile 03:10:22 INFO - Running setup.py install for mozhttpd 03:10:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Running setup.py install for mozinfo 03:10:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Running setup.py install for mozInstall 03:10:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Running setup.py install for mozleak 03:10:22 INFO - Running setup.py install for mozlog 03:10:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Running setup.py install for moznetwork 03:10:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:22 INFO - Running setup.py install for mozprocess 03:10:23 INFO - Running setup.py install for mozprofile 03:10:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:23 INFO - Running setup.py install for mozrunner 03:10:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:23 INFO - Running setup.py install for mozscreenshot 03:10:23 INFO - Running setup.py install for moztest 03:10:23 INFO - Running setup.py install for mozversion 03:10:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:23 INFO - Cleaning up... 03:10:23 INFO - Return code: 0 03:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:23 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:23 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 03:10:23 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 03:10:23 INFO - Using env: {'DISPLAY': ':0', 03:10:23 INFO - 'HOME': '/home/cltbld', 03:10:23 INFO - 'LANG': 'en_US.UTF-8', 03:10:23 INFO - 'LANGUAGE': 'en_US:en', 03:10:23 INFO - 'LOGNAME': 'cltbld', 03:10:23 INFO - 'MAIL': '/var/mail/cltbld', 03:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:23 INFO - 'MOZ_NO_REMOTE': '1', 03:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:23 INFO - 'NO_EM_RESTART': '1', 03:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:23 INFO - 'PWD': '/builds/slave/test', 03:10:23 INFO - 'SHELL': '/bin/bash', 03:10:23 INFO - 'SHLVL': '1', 03:10:23 INFO - 'TERM': 'linux', 03:10:23 INFO - 'TMOUT': '86400', 03:10:23 INFO - 'USER': 'cltbld', 03:10:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:23 INFO - '_': '/tools/buildbot/bin/python'} 03:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:23 INFO - Running setup.py (path:/tmp/pip-w3pdM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:23 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)) 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:23 INFO - Running setup.py (path:/tmp/pip-izwrRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:23 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)) 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:23 INFO - Running setup.py (path:/tmp/pip-iljHWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:24 INFO - Running setup.py (path:/tmp/pip-4UgNjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:24 INFO - Running setup.py (path:/tmp/pip-hbADxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:24 INFO - Running setup.py (path:/tmp/pip-umV0cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:24 INFO - Running setup.py (path:/tmp/pip-xlHCj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:24 INFO - Running setup.py (path:/tmp/pip-SloAhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:24 INFO - Running setup.py (path:/tmp/pip-aiklKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:24 INFO - Running setup.py (path:/tmp/pip-O4GXdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:24 INFO - Running setup.py (path:/tmp/pip-kt3hlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:24 INFO - Running setup.py (path:/tmp/pip-SiVL0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:24 INFO - Running setup.py (path:/tmp/pip-l9Lpwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:24 INFO - Running setup.py (path:/tmp/pip-DdFNnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:24 INFO - Running setup.py (path:/tmp/pip-J5bQ8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:24 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)) 03:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:24 INFO - Running setup.py (path:/tmp/pip-Rdu4LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:25 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)) 03:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:25 INFO - Running setup.py (path:/tmp/pip-BHYJUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:25 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)) 03:10:25 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)) 03:10:25 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)) 03:10:25 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)) 03:10:25 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)) 03:10:25 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)) 03:10:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:26 INFO - Downloading blessings-1.6.tar.gz 03:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:27 INFO - Installing collected packages: blessings 03:10:27 INFO - Running setup.py install for blessings 03:10:27 INFO - Successfully installed blessings 03:10:27 INFO - Cleaning up... 03:10:27 INFO - Return code: 0 03:10:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:27 INFO - Reading from file tmpfile_stdout 03:10:27 INFO - Current package versions: 03:10:27 INFO - argparse == 1.2.1 03:10:27 INFO - blessings == 1.6 03:10:27 INFO - blobuploader == 1.2.4 03:10:27 INFO - docopt == 0.6.1 03:10:27 INFO - functools32 == 3.2.3-2 03:10:27 INFO - jsonschema == 2.5.1 03:10:27 INFO - manifestparser == 1.1 03:10:27 INFO - mozInstall == 1.12 03:10:27 INFO - mozcrash == 0.17 03:10:27 INFO - mozdebug == 0.1 03:10:27 INFO - mozdevice == 0.48 03:10:27 INFO - mozfile == 1.2 03:10:27 INFO - mozhttpd == 0.7 03:10:27 INFO - mozinfo == 0.9 03:10:27 INFO - mozleak == 0.1 03:10:27 INFO - mozlog == 3.2 03:10:27 INFO - moznetwork == 0.27 03:10:27 INFO - mozprocess == 0.23 03:10:27 INFO - mozprofile == 0.28 03:10:27 INFO - mozrunner == 6.12 03:10:27 INFO - mozscreenshot == 0.1 03:10:27 INFO - mozsystemmonitor == 0.3 03:10:27 INFO - moztest == 0.7 03:10:27 INFO - mozversion == 1.4 03:10:27 INFO - psutil == 3.1.1 03:10:27 INFO - requests == 1.2.3 03:10:27 INFO - wsgiref == 0.1.2 03:10:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:27 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:27 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 03:10:27 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 03:10:27 INFO - Using env: {'DISPLAY': ':0', 03:10:27 INFO - 'HOME': '/home/cltbld', 03:10:27 INFO - 'LANG': 'en_US.UTF-8', 03:10:27 INFO - 'LANGUAGE': 'en_US:en', 03:10:27 INFO - 'LOGNAME': 'cltbld', 03:10:27 INFO - 'MAIL': '/var/mail/cltbld', 03:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:27 INFO - 'MOZ_NO_REMOTE': '1', 03:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:27 INFO - 'NO_EM_RESTART': '1', 03:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:27 INFO - 'PWD': '/builds/slave/test', 03:10:27 INFO - 'SHELL': '/bin/bash', 03:10:27 INFO - 'SHLVL': '1', 03:10:27 INFO - 'TERM': 'linux', 03:10:27 INFO - 'TMOUT': '86400', 03:10:27 INFO - 'USER': 'cltbld', 03:10:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:27 INFO - '_': '/tools/buildbot/bin/python'} 03:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 INFO - Cleaning up... 03:10:27 INFO - Return code: 0 03:10:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:27 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:27 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 03:10:27 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 03:10:27 INFO - Using env: {'DISPLAY': ':0', 03:10:27 INFO - 'HOME': '/home/cltbld', 03:10:27 INFO - 'LANG': 'en_US.UTF-8', 03:10:27 INFO - 'LANGUAGE': 'en_US:en', 03:10:27 INFO - 'LOGNAME': 'cltbld', 03:10:27 INFO - 'MAIL': '/var/mail/cltbld', 03:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:27 INFO - 'MOZ_NO_REMOTE': '1', 03:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:27 INFO - 'NO_EM_RESTART': '1', 03:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:27 INFO - 'PWD': '/builds/slave/test', 03:10:27 INFO - 'SHELL': '/bin/bash', 03:10:27 INFO - 'SHLVL': '1', 03:10:27 INFO - 'TERM': 'linux', 03:10:27 INFO - 'TMOUT': '86400', 03:10:27 INFO - 'USER': 'cltbld', 03:10:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:27 INFO - '_': '/tools/buildbot/bin/python'} 03:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:27 INFO - Cleaning up... 03:10:27 INFO - Return code: 0 03:10:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:27 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 0x7f6f9d8aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, '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': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', '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 03:10:27 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 03:10:27 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 03:10:27 INFO - Using env: {'DISPLAY': ':0', 03:10:27 INFO - 'HOME': '/home/cltbld', 03:10:27 INFO - 'LANG': 'en_US.UTF-8', 03:10:27 INFO - 'LANGUAGE': 'en_US:en', 03:10:27 INFO - 'LOGNAME': 'cltbld', 03:10:27 INFO - 'MAIL': '/var/mail/cltbld', 03:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:27 INFO - 'MOZ_NO_REMOTE': '1', 03:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:27 INFO - 'NO_EM_RESTART': '1', 03:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:27 INFO - 'PWD': '/builds/slave/test', 03:10:27 INFO - 'SHELL': '/bin/bash', 03:10:27 INFO - 'SHLVL': '1', 03:10:27 INFO - 'TERM': 'linux', 03:10:27 INFO - 'TMOUT': '86400', 03:10:27 INFO - 'USER': 'cltbld', 03:10:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:27 INFO - '_': '/tools/buildbot/bin/python'} 03:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:28 INFO - Downloading/unpacking flake8 03:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:10:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:10:29 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 03:10:29 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 03:10:29 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 03:10:29 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 03:10:29 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 03:10:29 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 03:10:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:10:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:30 INFO - no previously-included directories found matching 'docs/_build' 03:10:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:10:30 INFO - Running setup.py install for pep8 03:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:30 INFO - no previously-included directories found matching 'docs/_build' 03:10:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:10:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:10:30 INFO - Cleaning up... 03:10:30 INFO - Return code: 0 03:10:30 INFO - Running post-action listener: _resource_record_post_action 03:10:30 INFO - Running post-action listener: _start_resource_monitoring 03:10:30 INFO - Starting resource monitoring. 03:10:30 INFO - ##### 03:10:30 INFO - ##### Finished create-virtualenv step (success) 03:10:30 INFO - ##### 03:10:30 INFO - ##### 03:10:30 INFO - ##### Running install step. 03:10:30 INFO - ##### 03:10:30 INFO - Running pre-action listener: _resource_record_pre_action 03:10:30 INFO - Running main action method: install 03:10:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:31 INFO - Reading from file tmpfile_stdout 03:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:31 INFO - Reading from file tmpfile_stdout 03:10:31 INFO - Output received: 03:10:31 INFO - Usage: mozinstall [options] installer 03:10:31 INFO - Options: 03:10:31 INFO - -h, --help show this help message and exit 03:10:31 INFO - -d DEST, --destination=DEST 03:10:31 INFO - Directory to install application into. [default: 03:10:31 INFO - "/builds/slave/test"] 03:10:31 INFO - --app=APP Application being installed. [default: firefox] 03:10:31 INFO - mkdir: /builds/slave/test/build/application 03:10:31 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'] 03:10:31 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 03:10:48 INFO - Reading from file tmpfile_stdout 03:10:48 INFO - Output received: 03:10:48 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:48 INFO - Running post-action listener: _resource_record_post_action 03:10:48 INFO - ##### 03:10:48 INFO - ##### Finished install step (success) 03:10:48 INFO - ##### 03:10:48 INFO - ##### 03:10:48 INFO - ##### Running run-tests step. 03:10:48 INFO - ##### 03:10:48 INFO - Running pre-action listener: _resource_record_pre_action 03:10:48 INFO - Running main action method: run_tests 03:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:48 INFO - Python 2.7.3 03:10:48 INFO - Return code: 0 03:10:48 INFO - grabbing minidump binary from tooltool 03:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:48 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 0xed31c0>, '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 0xed40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:48 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 03:10:48 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 03:10:48 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 03:10:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:48 INFO - Return code: 0 03:10:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:10:49 INFO - Return code: 0 03:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:10:49 INFO - Using env: {'DISPLAY': ':0', 03:10:49 INFO - 'HOME': '/home/cltbld', 03:10:49 INFO - 'LANG': 'en_US.UTF-8', 03:10:49 INFO - 'LANGUAGE': 'en_US:en', 03:10:49 INFO - 'LOGNAME': 'cltbld', 03:10:49 INFO - 'MAIL': '/var/mail/cltbld', 03:10:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:49 INFO - 'MOZ_NO_REMOTE': '1', 03:10:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:49 INFO - 'NO_EM_RESTART': '1', 03:10:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:49 INFO - 'PWD': '/builds/slave/test', 03:10:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:49 INFO - 'SHELL': '/bin/bash', 03:10:49 INFO - 'SHLVL': '1', 03:10:49 INFO - 'TERM': 'linux', 03:10:49 INFO - 'TMOUT': '86400', 03:10:49 INFO - 'USER': 'cltbld', 03:10:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788', 03:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:49 INFO - '_': '/tools/buildbot/bin/python'} 03:10:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:10:50 INFO - mozversion application_buildid: 20160729170826 03:10:50 INFO - mozversion application_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 03:10:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:10:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:50 INFO - mozversion application_name: Firefox 03:10:50 INFO - mozversion application_remotingname: firefox-dev 03:10:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:10:50 INFO - mozversion application_vendor: Mozilla 03:10:50 INFO - mozversion application_version: 49.0a2 03:10:50 INFO - mozversion platform_buildid: 20160729170826 03:10:50 INFO - mozversion platform_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 03:10:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:10:50 INFO - mozversion platform_version: 49.0a2 03:10:50 INFO - using testdate: 1469873450 03:10:50 INFO - actual date: 1469873450 03:10:50 INFO - starting webserver on 'localhost:55675' 03:10:50 INFO - SUITE-START | Running 2 tests 03:10:50 INFO - TEST-START | dromaeo_css 03:10:50 INFO - operating with platform_type : linux_ 03:10:50 INFO - Initialising browser for dromaeo_css test... 03:10:50 INFO - TEST-INFO | started process 19219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQYfY02/profile http://localhost:55675/getInfo.html) 03:10:54 INFO - PROCESS | 19219 | __metrics Screen width/height:1600/1200 03:10:54 INFO - PROCESS | 19219 | colorDepth:24 03:10:54 INFO - PROCESS | 19219 | Browser inner width/height: 1024/697 03:10:54 INFO - PROCESS | 19219 | __metrics 03:10:56 INFO - PROCESS | 19219 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:10:56 ERROR - PROCESS | 19219 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:10:57 INFO - TEST-INFO | 19219: exit 0 03:10:57 INFO - Browser initialized. 03:10:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:57 INFO - TEST-INFO | started process 19309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQYfY02/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:08 INFO - PROCESS | 19309 | RSS: Main: 148373504 03:11:08 INFO - PROCESS | 19309 | 03:12:00 INFO - PROCESS | 19309 | 1469873520146 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] 03:14:08 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55675/tests/dromaeo/cssquery-ext.html) 03:14:09 INFO - PROCESS | 19309 | RSS: Main: 255868928 03:14:09 INFO - PROCESS | 19309 | 03:17:11 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55675/tests/dromaeo/cssquery-ext.html (next: http://localhost:55675/tests/dromaeo/cssquery-jquery.html) 03:17:12 INFO - PROCESS | 19309 | RSS: Main: 228085760 03:17:12 INFO - PROCESS | 19309 | 03:20:14 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55675/tests/dromaeo/cssquery-mootools.html) 03:20:14 INFO - PROCESS | 19309 | RSS: Main: 227745792 03:20:14 INFO - PROCESS | 19309 | 03:23:16 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55675/tests/dromaeo/cssquery-prototype.html) 03:23:17 INFO - PROCESS | 19309 | RSS: Main: 227012608 03:23:17 INFO - PROCESS | 19309 | 03:26:19 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55675/tests/dromaeo/cssquery-yui.html) 03:26:20 INFO - PROCESS | 19309 | RSS: Main: 216612864 03:26:20 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | Cycle 1(1): loaded http://localhost:55675/tests/dromaeo/cssquery-yui.html (next: http://localhost:55675/tests/dromaeo/cssquery-dojo.html) 03:29:23 INFO - PROCESS | 19309 | RSS: Main: 261505024 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | __start_tp_report 03:29:23 INFO - PROCESS | 19309 | _x_x_mozilla_page_load 03:29:23 INFO - PROCESS | 19309 | _x_x_mozilla_page_load_details 03:29:23 INFO - PROCESS | 19309 | |i|pagename|runs| 03:29:23 INFO - PROCESS | 19309 | |0;dojo.html;3315.983420082899;3343.582052243468;3344.1806757344452;3359.210585512404;3368.983155084224;5452.482014208649;5508.807191748289;5525.11598144297;5531.363893152288;5555.277813884194;5474.452554744524;5543.057680194366;5548.167774833777;5548.9722551387285;5588.944110558893;4907.631927605444;4990.925136122952;5030.773615187325;5070.797168113271;5104.03023425548;4840.9515904840855;4961.107000739866;4997.225430058346;5002.574781143607;5010.398752149747;4907.0921879452235;4932.210846264598;4932.408111026682;4959.032988567231;5019.498050194969;5043.041822053798;5054.646174767768;5072.34059572257;5075.340205773263;5085.186370180791;4843.66094373394;4873.439554451248;4902.632302577321;5004.9749751251375;5013.448520662724;5306.814261500867;5372.301600791911;5384.811531596375;5387.218853266255;5389.703566303851;5882.6764527950945;5933.169356290123;5933.9406605934255;5939.495142912858;5940;5790.36306006339;5883.411658834125;5904.7342869570975;5955.791547295824;5982.760689572412;5510.201020851954;5566.582506312043;5570.554355651539;5576.386597474275;5585.190147428641;5772.105323674753;6050.334463209044;6060.636361818217;6062.575619706667;6066.696665166724;5713.05734553794;5731.885362292731;5739.426057394227;5863.091220860688;5867.853303667357;5924.7926322578505;5927.73325200367;5929.644221346733;5947.524198064145;5952.226210592596;5699.515541178963;5791.594588378773;5872.677002764804;5885.117232415172;5887.381824908409;5636.689982050944;5844.357120716718;5846.473817356373;5852.561057920673;5891.351951285355;4531;4534.478534968455;4538.682292239511;4551.635869130461;4561.840335588238;3970;3978.1645854370327;4025.7383270087353;4069.918601627951;4106.240345536085;5520.1167813149705;5538.723063846872;5538.9169162462595;5545.916811247835;5546.833594992157;5840.561957853093;5851.882962340729;5870.882582348329;5872.794452194153;5912.438318359835;5402.567794576425;5517.034518959166;5561.63849349791;5581.10702287632;5660.433956604389;5050.49495050492;5070.9858028394465;5083.288339632454;5086.059079070384;5093.821716239914;5956.910646340309;6118.908216376758;6189.381061893775;6191.288001879841;6198.380161983766;5803.129530570448;5819.970900145641;5825.883482330414;5910.320313164041;5926.792562260473;6175;6194.721237544231;6197.783077592263;6199.94600917854;6204;5530.668159910419;5691.288588926384;5829.271341082364;5830.125481177857;5836.737346819488;5753.05074662676;5867.031939729897;5868.413158684098;5874.295084589877;5909.55678324136;5726.541876649775;5742.483176514133;5747.5689323300085;5753.8561535961935;5759.280089988752;5450.645708029124;5670.319561652628;5703.030484817508;5705.4579814917515;5711.971440142773;5646.209530665792;5676.9432305678065;5677.801276955287;5696.003199440164;5718.228039214653;5762.1068734346245;5782.537397008314;5818.796342128006;5823.82528524145;5828.504577110993;5483.588730845282;5494.36814766307;5530.723463826712;5553.194786755817;5584.4136365681015 03:29:23 INFO - PROCESS | 19309 | |1;ext.html;621.5121129913019;658.8748137853811;667.2860039757461;668.4084585142149;676.9593824370537;33309.167270818245;45702;46422.76788616052;46524;46553.999999999956;48531.27203091948;49216.50783492164;49260;49375;49378.25932611005;8383.329333653324;9009.189172974448;9192.172704456598;9194.31042671799;10829.620963266287;10514.789704205912;10619.41593212373;10996.725081872937;11002.779944401107;11005.504752286126;11085.778284434347;11193.496292666809;11195.496202670858;11199.160062995308;11214.439278036107;8173.427860049799;8415.747527574182;8424.53665048422;10752.892471075267;10965;10571.94714026425;10962.616308429167;10964.122870170368;10972.506237219344;10974.451277436096;45227;45714.77142614299;45783.313250301275;45810;45840.5415945843;3694.5751238607368;3724.3296206682785;3782.375907975181;3800.7339486235696;3825.579186289534;35111.4733279001;35486.29027419463;35845.28309433797;36077.81961090204;36197.63802361969;4421.204183247014;4562.520935301812;4582.266837306049;4609.953900460986;4854.514548545152;389456;391195.99999999715;392031;393460;393784;69043.65478172677;70336.6483167591;70389;70417.2958270421;70431.64784176047;39380.21239575192;40894.38658420126;40895.38656920149;43137.35293970593;75153.62423187958;17210.741838872425;17253.223604937808;17260.223289951984;17360.39238626642;17364.218610162574;12082.456289466994;13502.459901604023;14375.92812035954;14385.92807035979;14556.927215364067;22696.773032269466;22738.294627902975;22864.428389290402;22882.542349153257;22924.656130158062;7962.402819788539;8112.472689275178;8271.379646526535;8306.958465207636;8446;1050.3435352904435;1054.7943151085617;1114.2311804854623;1164.5109054197258;1177.9234349767237;34761.478577821355;37537.49850006024;37846.24307513834;38393.42409863854;38687.806560967016;1130.553431394611;1164.8427462292482;1174.5712814822527;1192.6839387562302;1197.1320792425422;17390.913045434692;17779.911100444675;18063.187156577722;18200.544986375447;18233.452996409862;575838;588218;588986;589708;590362;63429.68285158544;64568.677156613914;64848.35151648518;64863.35136648668;64887.67556162189;1329.6875234319928;1413.3078180441044;1425.4796999095463;1427.3220220395228;1432.9856701432852;28799.85600071986;34144.65855341415;34403.65596344005;36911.26177476489;37503.43744843775;61815.6909215451;62062.689686551275;62439.37560624335;62544.68727656332;62662.686686566274;431843;432614;434746;435381;435508;39346.803265983486;46233.76883115563;47161;47374.763126184145;47923.76038119787;52962.73518632382;53361.19958200708;53383.73308133434;54034.45965540294;54377.456225437236;44159.77920110379;44607.55392446164;44679.776601116784;45404.54595454003;45463.77268113638;43509.56490435182;44485.77757111194;44928.32607510825;44932.77533612311;45325.546744532134;42879;43586.782066089465;43847.12305753803;44401.33397999097;44717.77641111904;36725.44911826271;40170.39744403895;40524;40711.79644101761;40856;29879;31276.530852036783;31766.523502147025;32078.19804504906;32302.192445188117 03:29:23 INFO - PROCESS | 19309 | |2;jquery.html;417.2427044913484;419.2139737991266;420.8316673330667;433.2483141749065;438.4782109289945;18678.90660546697;19750.506237344074;20389.49026274344;21084.051217695203;21090.261840835574;19603;19697.90151049243;19882.204711811548;20102.296419625316;20189.19243230269;5756.338021127561;5943.049112142058;5975.014122669754;5992.280926288851;5997;4189.350650649154;4315.762633055181;5796.855078623026;5893.764249430039;6593.274739778621;6546.279909210007;6649.268580456146;6666.333366663343;6690.76582319619;6699.665016749143;6409.775657851953;6517.055027021079;6629.668516574152;6644.103046088789;6653.068570400148;3835.5397352317623;5460.781568737246;5808.680522571257;5845.327787304472;5851.32709738377;23632.29103126909;23735.1692690755;23743.762562374326;23753.287401377987;23927.162549310866;2565.615157726337;2603.47930413918;3021.350409661933;3163.398954198718;3209.2137426330464;14106;14108.506202282973;14456.49402270926;14947.925260373628;15114.924425377912;2011.8893460859647;2015.8790472571693;2127.6702111172795;2132.2004248406847;2154.91380344786;54993.45006549923;70875.64562177156;72960;74948.62525687391;81508.9999999994;10061.798764024825;10581.62964296246;10991.780164396827;11068.501917413736;11428.714282143013;15961.521154365388;15964.201789910458;16032.438864639915;16041.358345666044;16103;8233.958830205811;8395.53824539644;8432.831343373098;8483.703070392507;8512.233898949124;8031.237032481905;8177.754667359989;8213.671453141807;8333.083360830304;8358.874616880752;6842.93157068423;6949.583025018515;6972.58164510131;7025.192102908129;7048;1985.811347921945;1987.4534503011498;2018.4550171453918;2026.7608232718587;2054.7020682001025;987.9308448408542;1055.8099542082498;1056.8678915135608;1094.9452527373758;1112.1436493899653;18507.629847403245;19695.507612309808;19769.703454448194;19970.70043949342;20297.391078267676;1060.1783617696346;1060.8514807926897;1073.3023534702506;1083.4907593431076;1097.3306283167262;11068.778624427627;11514.827277590843;11549.480273387719;11581;11742.88257117435;538083;554473;567491;574949;575756;64492;79970.60014700006;83253.16746832576;83424.58287708522;84084.15915840886;490.1765034741597;503.63234838568053;1156.1386766858743;1197.4312201704295;1200.7538454616783;10780.892191077988;10801.783964320512;11393.487293071998;11397.772044558897;11496.770064598828;38687;38868.416973744854;38984.80507597444;39302.41046384249;39679;51875.48124518707;54287.45712542824;57700.13449798172;57867.71066144642;59027;8905.198532132139;9019.188273055457;9049.276057915482;9115;9142.405743626909;10092.84860727075;12940.676483087998;13055.086143969831;13238.205707657571;13355.399007044512;11481.598144064918;11483.770324593628;11594.652160434864;11817.468213930566;11907;11428.25716328436;11533.365664888512;11585.478653460446;11606.24559403636;11806.409679515818;11126.554937802397;11395.772084558428;11689.649310520697;11718.121140914294;11911.106667000184;8454.57727113654;8796.560171991503;8925.642974281216;8934.151255630704;9194.26445884341;11220.326780393203;11307.943460282646;11389.943050284695;11400.315981041163;11502 03:29:23 INFO - PROCESS | 19309 | |3;mootools.html;1378.882794962428;1548.4735190035387;1560.485039936821;1765.752794608755;1914.2917120665365;8885.64457421703;9230.16928476437;9268.99999999999;9522.381045232056;9540.6660766873;9274.443533388001;9471.905280947189;9478.099580539854;9478.66824661137;9489.95255023724;1997.1811557261526;2357.9056837726557;2419.927402177929;2431.7811396974225;2461.089396923141;2328.313147621447;2334.1830359374253;2338.088145623208;2338.7193536775526;2339.8830058497006;2393.5930891748444;2446.987765061181;2449.5223431430877;2450.0689737899575;2450.779429851313;1948.1720268885667;2322.4077860145726;2385.0340612052146;2394.640803879432;2396.3050715292543;2334.8015418689433;2356.045801450415;2365.9171928982405;2368.4078980254935;2372.9169479068323;9426.764330891714;9452.291078169095;9475;9483.857742133874;9484.810303793955;5231.843044708665;5314.734263286859;5329.120695085307;5341.4658534146665;5347.385050719178;3285.4250506161566;3312.9171770705684;3327.633960264369;3333.2000319923286;3450.7584469087174;1050.6742909698019;1053.3890343600692;1069.5080263078994;1102.0742576236;1105.7788442311569;13276.336183190802;13298.335083245896;13310.733785324239;13343.599692009255;13353.799693004612;4478.932816007762;4655.580997710223;4716.95283047172;4758.643101767381;4779.976100119547;11195.4962026709;11209.215354925076;11228;11234.662960111209;11244.325340479434;4904.975475122602;5358.732063396815;5420.214068959979;5421.810236641699;5430.239766432703;4533.773311334486;4605.03294308199;4607.976960115178;4944.752762361867;5061.848144555669;4236.322188449833;4260.169266992969;4274.4870615525715;4323.6757243206885;4384.145091707151;1288.2335010668637;1304.5760127958451;1309.1752196116386;1312.9868701313055;1317.1899281941728;943.7970836270235;1013.0376142664351;1019.5208252121491;1062.1874266186219;1075.9085477734325;6547.886859233941;6673.065770792093;6678.9332106679285;6746.257911629717;6779.694913728894;388.3902273430743;389.59676734579574;393.5297319702985;427.3098945203474;431.1076072529833;4501.662375321864;4590.793414296365;4676.579107880307;4714.740689262055;4745.928811067837;11585.536578536932;11882.465289062013;11931.821022684666;11932.284062956076;11940.88059119415;11260.94369528147;11466.140039496904;11585.246958947642;11873.465694043789;11891.167618266638;8350.707725229588;8423.326133909273;8463.957680211559;8501.53241571707;8510.872336914952;6291.370862913672;6533.901991470227;6606.174228221473;6631.635260060743;6655.534112612071;10068.14420774213;10382.169426446017;10455.63405280842;10482.266241363031;10586.947065264625;10483.580656773644;10608.628697995533;10687.5190616424;10705.785884282115;10707.464626768475;8033.437659364022;8370.246677798783;8398.622062007347;8408.159184081787;8636.740897773077;9267.073292670948;9290.814183716422;9301.209397201043;9325;9348.53257337144;8502.702405415781;8504.914950850412;8512.106228845882;8542.701005464778;8607.956960215159;8220.177982201732;8304.211099945496;8363.95818020906;8412;8502;7544.509606875536;7615.809604759704;7618.352440042437;7630.7710768677025;7632.274933881273;5681.375048744718;5828.0966450200285;5875.911861321998;5940.405959404025;5971.373005834499;5841.211436456194;5893.675847828411;5920.585559010828;6027.21646185993;6032.969835150796 03:29:23 INFO - PROCESS | 19309 | |4;prototype.html;330.7601988558296;330.86765293882445;335.506804996655;341.30203733365266;344.45575989935907;5364.168553874146;5394.379646340672;5426.620136590431;5446.2647542581735;5450.563954883604;5077.466865979074;5166.793328266875;5290.576753859692;5334.1732031535175;5351.892962140764;4191.7484950903045;4203.4325366075645;4207.873763787091;4223.450951376317;4245.426867372896;4179.164167166564;4233.576642335757;4239.491261048678;4251.256030194719;4257.425247591582;4000.7397669734087;4117.711760176789;4125.308623464381;4212.578742125794;4230.7038507304505;4221.910154473525;4254.574542545752;4265.957340426587;4273.444452221207;4274.914501709964;3810.314143454177;3812.7140464464997;3814.5231846019246;3814.6757525610356;3816.542014958223;5082.593392528589;5182.922256166161;5185.714785686786;5226.608004399685;5274.498922602346;4814.6870453420415;4816.710997340171;4824.228123500258;4825.445073816521;4835.540623640749;5591.329040515164;5604.41153678866;5604.439556044404;5622.943770562283;5668.603197776158;4047.494063242095;4121.423000779893;4124.175164967019;4136.751794892316;4146.357314616239;5733.541316694655;5798.855028624276;5809.506191973687;5827.4755272025295;5847.44449277318;4186.706930514834;4187.602177793105;4193.161367726406;4200.369944508348;4224.5353011168745;4099.733517321364;4260.765657888845;4266.616004559604;4281.914361712748;4296.011917259048;4791.425028996473;4800.423949126058;4814.446338671028;4821.951780482221;4828.493008234155;5655.293088363955;5671.659700417906;5706.3722990471015;5743.569232307594;5747.224124743189;1402.2708191740237;1440.2438719672045;1472.8821694264648;1476.6825132596543;1481.3408033425237;1007.2495990487134;1026.958921643126;1027.4708525109575;1030.5620111452602;1034.2294990232326;5435.537979271806;5471.644343117764;5504.422035686275;5516.503514683698;5516.779328826882;5773.134029895466;5780.71096445176;5781.855453613609;5821;5837.7664893404635;5251.267081862976;5526.198701188305;5570.749316280777;5583.357913839879;5596.593464810171;3062.3109800294756;3072.7695422843376;3088.382323535302;3109.16052665779;3124.9375212427885;6079.240094988127;6124.418180272867;6138.662373569497;6140.631562106288;6223.284322302902;5623.409541998113;5952;5957.165996760457;6018.969905150446;6030.246219222598;6151.692415379213;6160.10678451631;6185;6188.350223226496;6196.907046394217;5485.61600687964;5840.445157710011;5858.853528661817;5895.0524737631185;5983.34183239852;5749.246479823694;5760.164776107525;5773.422657734361;5796.188533605383;5828.417158284137;5792.1022241550945;6129.570930035033;6133.3866613338305;6190.566660333733;6194.907076393768;4047.57500462459;4074.714769966074;4077.368007958771;4093.304138296437;4111.259973204852;5877.441643043904;5884.529237661062;5888.793892213752;5889.970550147222;5929.318128415288;5452.645578037414;5519.613627046068;5713.22871412354;5725.280491766544;5746.2529871116485;5675.545956323402;5679.870048731726;5684.943150568607;5697.7436015380235;5698.686572238566;5370.355557333145;5547.861303467445;5629.3244810621345;5662.867426514631;5688.40271771458;5757.165211044459;5770.114942528736;5776.393478684678;5784.768609255582;5793.710314484343;5572.414896435978;5585.916211256916;5658.886822263614;5679.261695979496;5682.176084467812 03:29:23 INFO - PROCESS | 19309 | |5;yui.html;771.729894536912;787.822739883526;793.472340893306;840.3613253927014;913.6299798581568;15946.521604351874;16828.74756878648;17375.391861284843;18388.448346549623;18443.815561844378;16723.749143762852;16810.579735506617;16868;16895.83104168958;16913;718.838261391188;845.1295165979052;866.9219770220678;877.0703054761941;879.6701237036111;877.0308808766285;884.4869975414276;884.8451520983834;884.9469031858077;885.1635204731531;916.5783739479847;924.6994726713812;925.2921515040999;925.3013974449282;925.9768505787342;757.2654525110606;888.4891187567175;917.7797328641145;920.6547544670749;922.3543519536317;674.0563211503885;675.1021141881287;675.2234929830685;675.3415419965544;675.5136301862651;16025.679486410207;16044.51866443997;16113.516594502184;16115.435959741353;16118.11350375729;14833.554993350217;15255.313510892036;15256.466023689229;15293.847061529354;15364.231788410534;13316;13333.599992000256;13378.197308161542;14330.925180611495;14346.64133396663;4177.164567086595;4192.259526507248;4206.158768246363;4210.59999300066;4267.146570685875;75291;76812.61593692051;77452;77559.22440775632;77569.22430775677;11317.71705707364;12041.157119001586;12108.394580270951;12118.69703257408;12178.57374991871;22589.661155082686;22601.208957686402;22603.43491412728;22625.660615090786;22649.2072777452;8808;8869.11308869108;9140.63437462494;9158.587863546156;9171.35800493959;5172.224166375074;5232.895342093137;5342.305500285016;5372.462753724674;5499.890002199933;3695.5750088740137;3781.0736369589076;3787.450819631138;3798.4492248623797;3811.866584669523;645.3095188148636;649.1852724830308;657.1227411405827;679.2663922963188;680.0717021265937;694.6006046523169;717.47982712533;814.6130587970785;830.6303694855732;872.0843114729508;10742.516586753614;11008.284461509977;11091.611793587186;11460.255083419552;11490.942545287387;769.1424062170639;788.2157253532772;788.8580055589935;812.3501199040744;831.3556993330096;5141.76862041209;5210.843674689765;5348.3125924376245;5424.511793938565;5558.471945165203;69578;72887.2711272891;88812;115195.42402287935;121309;93567.53216233876;98990.50504747574;100801.49599251957;100898.49550752199;102560;86917.56541217254;87727;87915.56042219748;88010.99999999872;88846.55576722075;10353;10385.22110841705;10581.259311848406;10615.734606634896;10634.946825265824;52011.47988520218;52600;52613.473865262386;53433.46566534285;54909.725451374085;74852;75400.62299688466;75538.24461755532;77952.61023694846;78150;13004;14150.716985660023;14180.645483862574;14447.711045779235;14649.780253295996;16039.278232479799;16384.426545071343;16960.491185264462;17440.21519031672;17648.73526897072;15352.462663806713;16274.837251627332;16512.66974660476;16609.16954152312;16747.33010679559;15813.288402021706;16022.439214627431;16302.184890755652;16442.342306307615;16545.014598248286;12704.872951270369;12984.480620775441;13326.466941322238;14763.114213147246;15007;12643.93678031604;12991.41538630745;13229;13259.602211933658;13323.800142997668;12754.936225318814;12832.55086071983;12853.228806271654;12856.292903890377;13232.338383081 03:29:23 INFO - PROCESS | 19309 | __end_tp_report 03:29:23 INFO - PROCESS | 19309 | __start_cc_report 03:29:23 INFO - PROCESS | 19309 | _x_x_mozilla_cycle_collect,951 03:29:23 INFO - PROCESS | 19309 | __end_cc_report 03:29:23 INFO - PROCESS | 19309 | __startTimestamp1469874563354__endTimestamp 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | ------- Summary: start ------- 03:29:23 INFO - PROCESS | 19309 | Number of tests: 6 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | [#0] dojo.html Cycles:165 Average:5461.96 Median:5646.21 stddev:603.03 (10.7%) stddev-sans-first:580.91 03:29:23 INFO - PROCESS | 19309 | Values: 3316.0 3343.6 3344.2 3359.2 3369.0 5452.5 5508.8 5525.1 5531.4 5555.3 5474.5 5543.1 5548.2 5549.0 5588.9 4907.6 4990.9 5030.8 5070.8 5104.0 4841.0 4961.1 4997.2 5002.6 5010.4 4907.1 4932.2 4932.4 4959.0 5019.5 5043.0 5054.6 5072.3 5075.3 5085.2 4843.7 4873.4 4902.6 5005.0 5013.4 5306.8 5372.3 5384.8 5387.2 5389.7 5882.7 5933.2 5933.9 5939.5 5940.0 5790.4 5883.4 5904.7 5955.8 5982.8 5510.2 5566.6 5570.6 5576.4 5585.2 5772.1 6050.3 6060.6 6062.6 6066.7 5713.1 5731.9 5739.4 5863.1 5867.9 5924.8 5927.7 5929.6 5947.5 5952.2 5699.5 5791.6 5872.7 5885.1 5887.4 5636.7 5844.4 5846.5 5852.6 5891.4 4531.0 4534.5 4538.7 4551.6 4561.8 3970.0 3978.2 4025.7 4069.9 4106.2 5520.1 5538.7 5538.9 5545.9 5546.8 5840.6 5851.9 5870.9 5872.8 5912.4 5402.6 5517.0 5561.6 5581.1 5660.4 5050.5 5071.0 5083.3 5086.1 5093.8 5956.9 6118.9 6189.4 6191.3 6198.4 5803.1 5820.0 5825.9 5910.3 5926.8 6175.0 6194.7 6197.8 6199.9 6204.0 5530.7 5691.3 5829.3 5830.1 5836.7 5753.1 5867.0 5868.4 5874.3 5909.6 5726.5 5742.5 5747.6 5753.9 5759.3 5450.6 5670.3 5703.0 5705.5 5712.0 5646.2 5676.9 5677.8 5696.0 5718.2 5762.1 5782.5 5818.8 5823.8 5828.5 5483.6 5494.4 5530.7 5553.2 5584.4 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | [#1] ext.html Cycles:180 Average:65326.17 Median:40875.19 stddev:126597.20 (309.7%) stddev-sans-first:126859.12 03:29:23 INFO - PROCESS | 19309 | Values: 621.5 658.9 667.3 668.4 677.0 33309.2 45702.0 46422.8 46524.0 46554.0 48531.3 49216.5 49260.0 49375.0 49378.3 8383.3 9009.2 9192.2 9194.3 10829.6 10514.8 10619.4 10996.7 11002.8 11005.5 11085.8 11193.5 11195.5 11199.2 11214.4 8173.4 8415.7 8424.5 10752.9 10965.0 10571.9 10962.6 10964.1 10972.5 10974.5 45227.0 45714.8 45783.3 45810.0 45840.5 3694.6 3724.3 3782.4 3800.7 3825.6 35111.5 35486.3 35845.3 36077.8 36197.6 4421.2 4562.5 4582.3 4610.0 4854.5 389456.0 391196.0 392031.0 393460.0 393784.0 69043.7 70336.6 70389.0 70417.3 70431.6 39380.2 40894.4 40895.4 43137.4 75153.6 17210.7 17253.2 17260.2 17360.4 17364.2 12082.5 13502.5 14375.9 14385.9 14556.9 22696.8 22738.3 22864.4 22882.5 22924.7 7962.4 8112.5 8271.4 8307.0 8446.0 1050.3 1054.8 1114.2 1164.5 1177.9 34761.5 37537.5 37846.2 38393.4 38687.8 1130.6 1164.8 1174.6 1192.7 1197.1 17390.9 17779.9 18063.2 18200.5 18233.5 575838.0 588218.0 588986.0 589708.0 590362.0 63429.7 64568.7 64848.4 64863.4 64887.7 1329.7 1413.3 1425.5 1427.3 1433.0 28799.9 34144.7 34403.7 36911.3 37503.4 61815.7 62062.7 62439.4 62544.7 62662.7 431843.0 432614.0 434746.0 435381.0 435508.0 39346.8 46233.8 47161.0 47374.8 47923.8 52962.7 53361.2 53383.7 54034.5 54377.5 44159.8 44607.6 44679.8 45404.5 45463.8 43509.6 44485.8 44928.3 44932.8 45325.5 42879.0 43586.8 43847.1 44401.3 44717.8 36725.4 40170.4 40524.0 40711.8 40856.0 29879.0 31276.5 31766.5 32078.2 32302.2 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | [#2] jquery.html Cycles:180 Average:30434.86 Median:23840.22 stddev:91972.29 (385.8%) stddev-sans-first:92202.68 03:29:23 INFO - PROCESS | 19309 | Values: 417.2 419.2 420.8 433.2 438.5 18678.9 19750.5 20389.5 21084.1 21090.3 19603.0 19697.9 19882.2 20102.3 20189.2 5756.3 5943.0 5975.0 5992.3 5997.0 4189.4 4315.8 5796.9 5893.8 6593.3 6546.3 6649.3 6666.3 6690.8 6699.7 6409.8 6517.1 6629.7 6644.1 6653.1 3835.5 5460.8 5808.7 5845.3 5851.3 23632.3 23735.2 23743.8 23753.3 23927.2 2565.6 2603.5 3021.4 3163.4 3209.2 14106.0 14108.5 14456.5 14947.9 15114.9 2011.9 2015.9 2127.7 2132.2 2154.9 54993.5 70875.6 72960.0 74948.6 81509.0 10061.8 10581.6 10991.8 11068.5 11428.7 15961.5 15964.2 16032.4 16041.4 16103.0 8234.0 8395.5 8432.8 8483.7 8512.2 8031.2 8177.8 8213.7 8333.1 8358.9 6842.9 6949.6 6972.6 7025.2 7048.0 1985.8 1987.5 2018.5 2026.8 2054.7 987.9 1055.8 1056.9 1094.9 1112.1 18507.6 19695.5 19769.7 19970.7 20297.4 1060.2 1060.9 1073.3 1083.5 1097.3 11068.8 11514.8 11549.5 11581.0 11742.9 538083.0 554473.0 567491.0 574949.0 575756.0 64492.0 79970.6 83253.2 83424.6 84084.2 490.2 503.6 1156.1 1197.4 1200.8 10780.9 10801.8 11393.5 11397.8 11496.8 38687.0 38868.4 38984.8 39302.4 39679.0 51875.5 54287.5 57700.1 57867.7 59027.0 8905.2 9019.2 9049.3 9115.0 9142.4 10092.8 12940.7 13055.1 13238.2 13355.4 11481.6 11483.8 11594.7 11817.5 11907.0 11428.3 11533.4 11585.5 11606.2 11806.4 11126.6 11395.8 11689.6 11718.1 11911.1 8454.6 8796.6 8925.6 8934.2 9194.3 11220.3 11307.9 11389.9 11400.3 11502.0 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | [#3] mootools.html Cycles:180 Average:6178.61 Median:4517.72 stddev:3597.77 (79.6%) stddev-sans-first:3589.78 03:29:23 INFO - PROCESS | 19309 | Values: 1378.9 1548.5 1560.5 1765.8 1914.3 8885.6 9230.2 9269.0 9522.4 9540.7 9274.4 9471.9 9478.1 9478.7 9490.0 1997.2 2357.9 2419.9 2431.8 2461.1 2328.3 2334.2 2338.1 2338.7 2339.9 2393.6 2447.0 2449.5 2450.1 2450.8 1948.2 2322.4 2385.0 2394.6 2396.3 2334.8 2356.0 2365.9 2368.4 2372.9 9426.8 9452.3 9475.0 9483.9 9484.8 5231.8 5314.7 5329.1 5341.5 5347.4 3285.4 3312.9 3327.6 3333.2 3450.8 1050.7 1053.4 1069.5 1102.1 1105.8 13276.3 13298.3 13310.7 13343.6 13353.8 4478.9 4655.6 4717.0 4758.6 4780.0 11195.5 11209.2 11228.0 11234.7 11244.3 4905.0 5358.7 5420.2 5421.8 5430.2 4533.8 4605.0 4608.0 4944.8 5061.8 4236.3 4260.2 4274.5 4323.7 4384.1 1288.2 1304.6 1309.2 1313.0 1317.2 943.8 1013.0 1019.5 1062.2 1075.9 6547.9 6673.1 6678.9 6746.3 6779.7 388.4 389.6 393.5 427.3 431.1 4501.7 4590.8 4676.6 4714.7 4745.9 11585.5 11882.5 11931.8 11932.3 11940.9 11260.9 11466.1 11585.2 11873.5 11891.2 8350.7 8423.3 8464.0 8501.5 8510.9 6291.4 6533.9 6606.2 6631.6 6655.5 10068.1 10382.2 10455.6 10482.3 10586.9 10483.6 10608.6 10687.5 10705.8 10707.5 8033.4 8370.2 8398.6 8408.2 8636.7 9267.1 9290.8 9301.2 9325.0 9348.5 8502.7 8504.9 8512.1 8542.7 8608.0 8220.2 8304.2 8364.0 8412.0 8502.0 7544.5 7615.8 7618.4 7630.8 7632.3 5681.4 5828.1 5875.9 5940.4 5971.4 5841.2 5893.7 5920.6 6027.2 6033.0 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | [#4] prototype.html Cycles:180 Average:4797.95 Median:5440.90 stddev:1410.20 (25.9%) stddev-sans-first:1373.71 03:29:23 INFO - PROCESS | 19309 | Values: 330.8 330.9 335.5 341.3 344.5 5364.2 5394.4 5426.6 5446.3 5450.6 5077.5 5166.8 5290.6 5334.2 5351.9 4191.7 4203.4 4207.9 4223.5 4245.4 4179.2 4233.6 4239.5 4251.3 4257.4 4000.7 4117.7 4125.3 4212.6 4230.7 4221.9 4254.6 4266.0 4273.4 4274.9 3810.3 3812.7 3814.5 3814.7 3816.5 5082.6 5182.9 5185.7 5226.6 5274.5 4814.7 4816.7 4824.2 4825.4 4835.5 5591.3 5604.4 5604.4 5622.9 5668.6 4047.5 4121.4 4124.2 4136.8 4146.4 5733.5 5798.9 5809.5 5827.5 5847.4 4186.7 4187.6 4193.2 4200.4 4224.5 4099.7 4260.8 4266.6 4281.9 4296.0 4791.4 4800.4 4814.4 4822.0 4828.5 5655.3 5671.7 5706.4 5743.6 5747.2 1402.3 1440.2 1472.9 1476.7 1481.3 1007.2 1027.0 1027.5 1030.6 1034.2 5435.5 5471.6 5504.4 5516.5 5516.8 5773.1 5780.7 5781.9 5821.0 5837.8 5251.3 5526.2 5570.7 5583.4 5596.6 3062.3 3072.8 3088.4 3109.2 3124.9 6079.2 6124.4 6138.7 6140.6 6223.3 5623.4 5952.0 5957.2 6019.0 6030.2 6151.7 6160.1 6185.0 6188.4 6196.9 5485.6 5840.4 5858.9 5895.1 5983.3 5749.2 5760.2 5773.4 5796.2 5828.4 5792.1 6129.6 6133.4 6190.6 6194.9 4047.6 4074.7 4077.4 4093.3 4111.3 5877.4 5884.5 5888.8 5890.0 5929.3 5452.6 5519.6 5713.2 5725.3 5746.3 5675.5 5679.9 5684.9 5697.7 5698.7 5370.4 5547.9 5629.3 5662.9 5688.4 5757.2 5770.1 5776.4 5784.8 5793.7 5572.4 5585.9 5658.9 5679.3 5682.2 03:29:23 INFO - PROCESS | 19309 | 03:29:23 INFO - PROCESS | 19309 | [#5] yui.html Cycles:180 Average:21137.18 Median:4184.71 stddev:28549.48 (682.2%) stddev-sans-first:28588.61 03:29:23 INFO - PROCESS | 19309 | Values: 771.7 787.8 793.5 840.4 913.6 15946.5 16828.7 17375.4 18388.4 18443.8 16723.7 16810.6 16868.0 16895.8 16913.0 718.8 845.1 866.9 877.1 879.7 877.0 884.5 884.8 884.9 885.2 916.6 924.7 925.3 925.3 926.0 757.3 888.5 917.8 920.7 922.4 674.1 675.1 675.2 675.3 675.5 16025.7 16044.5 16113.5 16115.4 16118.1 14833.6 15255.3 15256.5 15293.8 15364.2 13316.0 13333.6 13378.2 14330.9 14346.6 4177.2 4192.3 4206.2 4210.6 4267.1 75291.0 76812.6 77452.0 77559.2 77569.2 11317.7 12041.2 12108.4 12118.7 12178.6 22589.7 22601.2 22603.4 22625.7 22649.2 8808.0 8869.1 9140.6 9158.6 9171.4 5172.2 5232.9 5342.3 5372.5 5499.9 3695.6 3781.1 3787.5 3798.4 3811.9 645.3 649.2 657.1 679.3 680.1 694.6 717.5 814.6 830.6 872.1 10742.5 11008.3 11091.6 11460.3 11490.9 769.1 788.2 788.9 812.4 831.4 5141.8 5210.8 5348.3 5424.5 5558.5 69578.0 72887.3 88812.0 115195.4 121309.0 93567.5 98990.5 100801.5 100898.5 102560.0 86917.6 87727.0 87915.6 88011.0 88846.6 10353.0 10385.2 10581.3 10615.7 10634.9 52011.5 52600.0 52613.5 53433.5 54909.7 74852.0 75400.6 75538.2 77952.6 78150.0 13004.0 14150.7 14180.6 14447.7 14649.8 16039.3 16384.4 16960.5 17440.2 17648.7 15352.5 16274.8 16512.7 16609.2 16747.3 15813.3 16022.4 16302.2 16442.3 16545.0 12704.9 12984.5 13326.5 14763.1 15007.0 12643.9 12991.4 13229.0 13259.6 13323.8 12754.9 12832.6 12853.2 12856.3 13232.3 03:29:23 INFO - PROCESS | 19309 | -------- Summary: end -------- 03:29:23 INFO - PROCESS | 19309 | 03:29:24 INFO - TEST-INFO | 19309: exit 0 03:29:24 INFO - TEST-OK | dromaeo_css | took 1114049ms 03:29:24 INFO - TEST-START | kraken 03:29:24 INFO - operating with platform_type : linux_ 03:29:24 INFO - Initialising browser for kraken test... 03:29:24 INFO - TEST-INFO | started process 19499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVTbbk0/profile http://localhost:55675/getInfo.html) 03:29:28 INFO - PROCESS | 19499 | __metrics Screen width/height:1600/1200 03:29:28 INFO - PROCESS | 19499 | colorDepth:24 03:29:28 INFO - PROCESS | 19499 | Browser inner width/height: 1024/697 03:29:28 INFO - PROCESS | 19499 | __metrics 03:29:30 INFO - PROCESS | 19499 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:29:30 ERROR - PROCESS | 19499 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:29:30 INFO - TEST-INFO | 19499: exit 0 03:29:30 INFO - Browser initialized. 03:29:30 INFO - Running cycle 1/1 for kraken test... 03:29:30 INFO - TEST-INFO | started process 19590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVTbbk0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:42 INFO - PROCESS | 19590 | RSS: Main: 145326080 03:29:42 INFO - PROCESS | 19590 | 03:29:45 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55675/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:46 INFO - PROCESS | 19590 | RSS: Main: 194842624 03:29:46 INFO - PROCESS | 19590 | 03:29:48 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55675/tests/kraken/driver.html?testName=audio-dft) 03:29:49 INFO - PROCESS | 19590 | RSS: Main: 193355776 03:29:49 INFO - PROCESS | 19590 | 03:29:52 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55675/tests/kraken/driver.html?testName=audio-fft) 03:29:52 INFO - PROCESS | 19590 | RSS: Main: 279429120 03:29:52 INFO - PROCESS | 19590 | 03:29:54 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55675/tests/kraken/driver.html?testName=audio-oscillator) 03:29:55 INFO - PROCESS | 19590 | RSS: Main: 188338176 03:29:55 INFO - PROCESS | 19590 | 03:29:57 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:58 INFO - PROCESS | 19590 | RSS: Main: 188633088 03:29:58 INFO - PROCESS | 19590 | 03:30:01 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55675/tests/kraken/driver.html?testName=imaging-darkroom) 03:30:01 INFO - PROCESS | 19590 | RSS: Main: 223252480 03:30:01 INFO - PROCESS | 19590 | 03:30:05 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55675/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:05 INFO - PROCESS | 19590 | RSS: Main: 223100928 03:30:05 INFO - PROCESS | 19590 | 03:30:08 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55675/tests/kraken/driver.html?testName=json-parse-financial) 03:30:09 INFO - PROCESS | 19590 | RSS: Main: 223277056 03:30:09 INFO - PROCESS | 19590 | 03:30:10 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:11 INFO - PROCESS | 19590 | RSS: Main: 201338880 03:30:11 INFO - PROCESS | 19590 | 03:30:12 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:13 INFO - PROCESS | 19590 | RSS: Main: 203563008 03:30:13 INFO - PROCESS | 19590 | 03:30:15 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:16 INFO - PROCESS | 19590 | RSS: Main: 208437248 03:30:16 INFO - PROCESS | 19590 | 03:30:18 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:30:19 INFO - PROCESS | 19590 | RSS: Main: 214458368 03:30:19 INFO - PROCESS | 19590 | 03:30:21 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:22 INFO - PROCESS | 19590 | RSS: Main: 213401600 03:30:22 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | Cycle 1(1): loaded http://localhost:55675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55675/tests/kraken/driver.html?testName=ai-astar) 03:30:24 INFO - PROCESS | 19590 | RSS: Main: 255971328 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | __start_tp_report 03:30:24 INFO - PROCESS | 19590 | _x_x_mozilla_page_load 03:30:24 INFO - PROCESS | 19590 | _x_x_mozilla_page_load_details 03:30:24 INFO - PROCESS | 19590 | |i|pagename|runs| 03:30:24 INFO - PROCESS | 19590 | |0;ai-astar;111;103;109;109;111;110;111;110;109;110 03:30:24 INFO - PROCESS | 19590 | |1;audio-beat-detection;151;125;124;167;124;124;154;125;162;123 03:30:24 INFO - PROCESS | 19590 | |2;audio-dft;160;161;159;161;160;170;160;160;162;163 03:30:24 INFO - PROCESS | 19590 | |3;audio-fft;75;74;75;118;74;75;74;75;99;75 03:30:24 INFO - PROCESS | 19590 | |4;audio-oscillator;83;84;109;84;86;84;126;84;85;128 03:30:24 INFO - PROCESS | 19590 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;117;116;117 03:30:24 INFO - PROCESS | 19590 | |6;imaging-darkroom;149;146;147;146;147;146;146;146;146;145 03:30:24 INFO - PROCESS | 19590 | |7;imaging-desaturate;95;95;94;95;94;94;94;95;95;95 03:30:24 INFO - PROCESS | 19590 | |8;json-parse-financial;50;53;51;52;50;50;52;51;50;51 03:30:24 INFO - PROCESS | 19590 | |9;json-stringify-tinderbox;60;60;60;60;61;61;60;61;60;60 03:30:24 INFO - PROCESS | 19590 | |10;stanford-crypto-aes;78;80;78;76;77;78;78;80;113;77 03:30:24 INFO - PROCESS | 19590 | |11;stanford-crypto-ccm;129;116;115;117;123;119;119;118;122;118 03:30:24 INFO - PROCESS | 19590 | |12;stanford-crypto-pbkdf2;153;154;153;157;153;158;153;153;153;150 03:30:24 INFO - PROCESS | 19590 | |13;stanford-crypto-sha256-iterative;61;60;62;65;63;60;61;61;59;63 03:30:24 INFO - PROCESS | 19590 | __end_tp_report 03:30:24 INFO - PROCESS | 19590 | __start_cc_report 03:30:24 INFO - PROCESS | 19590 | _x_x_mozilla_cycle_collect,1613 03:30:24 INFO - PROCESS | 19590 | __end_cc_report 03:30:24 INFO - PROCESS | 19590 | __startTimestamp1469874624434__endTimestamp 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | ------- Summary: start ------- 03:30:24 INFO - PROCESS | 19590 | Number of tests: 14 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.36 (2.1%) stddev-sans-first:2.42 03:30:24 INFO - PROCESS | 19590 | Values: 111.0 103.0 109.0 109.0 111.0 110.0 111.0 110.0 109.0 110.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:138.00 stddev:18.24 (13.2%) stddev-sans-first:18.72 03:30:24 INFO - PROCESS | 19590 | Values: 151.0 125.0 124.0 167.0 124.0 124.0 154.0 125.0 162.0 123.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:3.17 (2.0%) stddev-sans-first:3.31 03:30:24 INFO - PROCESS | 19590 | Values: 160.0 161.0 159.0 161.0 160.0 170.0 160.0 160.0 162.0 163.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.98 (20.0%) stddev-sans-first:15.70 03:30:24 INFO - PROCESS | 19590 | Values: 75.0 74.0 75.0 118.0 74.0 75.0 74.0 75.0 99.0 75.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:18.42 (21.9%) stddev-sans-first:18.99 03:30:24 INFO - PROCESS | 19590 | Values: 83.0 84.0 109.0 84.0 86.0 84.0 126.0 84.0 85.0 128.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:30:24 INFO - PROCESS | 19590 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:0.60 03:30:24 INFO - PROCESS | 19590 | Values: 149.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:30:24 INFO - PROCESS | 19590 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.05 (2.1%) stddev-sans-first:1.05 03:30:24 INFO - PROCESS | 19590 | Values: 50.0 53.0 51.0 52.0 50.0 50.0 52.0 51.0 50.0 51.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:30:24 INFO - PROCESS | 19590 | Values: 60.0 60.0 60.0 60.0 61.0 61.0 60.0 61.0 60.0 60.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:78.00 stddev:11.14 (14.3%) stddev-sans-first:11.74 03:30:24 INFO - PROCESS | 19590 | Values: 78.0 80.0 78.0 76.0 77.0 78.0 78.0 80.0 113.0 77.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.00 stddev:4.12 (3.5%) stddev-sans-first:2.60 03:30:24 INFO - PROCESS | 19590 | Values: 129.0 116.0 115.0 117.0 123.0 119.0 119.0 118.0 122.0 118.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:153.00 stddev:2.26 (1.5%) stddev-sans-first:2.39 03:30:24 INFO - PROCESS | 19590 | Values: 153.0 154.0 153.0 157.0 153.0 158.0 153.0 153.0 153.0 150.0 03:30:24 INFO - PROCESS | 19590 | 03:30:24 INFO - PROCESS | 19590 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.78 (2.9%) stddev-sans-first:1.88 03:30:24 INFO - PROCESS | 19590 | Values: 61.0 60.0 62.0 65.0 63.0 60.0 61.0 61.0 59.0 63.0 03:30:24 INFO - PROCESS | 19590 | -------- Summary: end -------- 03:30:24 INFO - PROCESS | 19590 | 03:30:25 INFO - TEST-INFO | 19590: exit 0 03:30:25 INFO - TEST-OK | kraken | took 61390ms 03:30:25 INFO - SUITE-END | took 1175s 03:30:25 INFO - Completed test suite (00:19:35) 03:30:25 INFO - javascript benchmark 03:30:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3315.983420082899, 3343.582052243468, 3344.1806757344452, 3359.210585512404, 3368.983155084224, 5452.482014208649, 5508.807191748289, 5525.11598144297, 5531.363893152288, 5555.277813884194, 5474.452554744524, 5543.057680194366, 5548.167774833777, 5548.9722551387285, 5588.944110558893, 4907.631927605444, 4990.925136122952, 5030.773615187325, 5070.797168113271, 5104.03023425548, 4840.9515904840855, 4961.107000739866, 4997.225430058346, 5002.574781143607, 5010.398752149747, 4907.0921879452235, 4932.210846264598, 4932.408111026682, 4959.032988567231, 5019.498050194969, 5043.041822053798, 5054.646174767768, 5072.34059572257, 5075.340205773263, 5085.186370180791, 4843.66094373394, 4873.439554451248, 4902.632302577321, 5004.9749751251375, 5013.448520662724, 5306.814261500867, 5372.301600791911, 5384.811531596375, 5387.218853266255, 5389.703566303851, 5882.6764527950945, 5933.169356290123, 5933.9406605934255, 5939.495142912858, 5940.0, 5790.36306006339, 5883.411658834125, 5904.7342869570975, 5955.791547295824, 5982.760689572412, 5510.201020851954, 5566.582506312043, 5570.554355651539, 5576.386597474275, 5585.190147428641, 5772.105323674753, 6050.334463209044, 6060.636361818217, 6062.575619706667, 6066.696665166724, 5713.05734553794, 5731.885362292731, 5739.426057394227, 5863.091220860688, 5867.853303667357, 5924.7926322578505, 5927.73325200367, 5929.644221346733, 5947.524198064145, 5952.226210592596, 5699.515541178963, 5791.594588378773, 5872.677002764804, 5885.117232415172, 5887.381824908409, 5636.689982050944, 5844.357120716718, 5846.473817356373, 5852.561057920673, 5891.351951285355, 4531.0, 4534.478534968455, 4538.682292239511, 4551.635869130461, 4561.840335588238, 3970.0, 3978.1645854370327, 4025.7383270087353, 4069.918601627951, 4106.240345536085, 5520.1167813149705, 5538.723063846872, 5538.9169162462595, 5545.916811247835, 5546.833594992157, 5840.561957853093, 5851.882962340729, 5870.882582348329, 5872.794452194153, 5912.438318359835, 5402.567794576425, 5517.034518959166, 5561.63849349791, 5581.10702287632, 5660.433956604389, 5050.49495050492, 5070.9858028394465, 5083.288339632454, 5086.059079070384, 5093.821716239914, 5956.910646340309, 6118.908216376758, 6189.381061893775, 6191.288001879841, 6198.380161983766, 5803.129530570448, 5819.970900145641, 5825.883482330414, 5910.320313164041, 5926.792562260473, 6175.0, 6194.721237544231, 6197.783077592263, 6199.94600917854, 6204.0, 5530.668159910419, 5691.288588926384, 5829.271341082364, 5830.125481177857, 5836.737346819488, 5753.05074662676, 5867.031939729897, 5868.413158684098, 5874.295084589877, 5909.55678324136, 5726.541876649775, 5742.483176514133, 5747.5689323300085, 5753.8561535961935, 5759.280089988752, 5450.645708029124, 5670.319561652628, 5703.030484817508, 5705.4579814917515, 5711.971440142773, 5646.209530665792, 5676.9432305678065, 5677.801276955287, 5696.003199440164, 5718.228039214653, 5762.1068734346245, 5782.537397008314, 5818.796342128006, 5823.82528524145, 5828.504577110993, 5483.588730845282, 5494.36814766307, 5530.723463826712, 5553.194786755817, 5584.4136365681015], "value": 5423.47389975017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.5121129913019, 658.8748137853811, 667.2860039757461, 668.4084585142149, 676.9593824370537, 33309.167270818245, 45702.0, 46422.76788616052, 46524.0, 46553.999999999956, 48531.27203091948, 49216.50783492164, 49260.0, 49375.0, 49378.25932611005, 8383.329333653324, 9009.189172974448, 9192.172704456598, 9194.31042671799, 10829.620963266287, 10514.789704205912, 10619.41593212373, 10996.725081872937, 11002.779944401107, 11005.504752286126, 11085.778284434347, 11193.496292666809, 11195.496202670858, 11199.160062995308, 11214.439278036107, 8173.427860049799, 8415.747527574182, 8424.53665048422, 10752.892471075267, 10965.0, 10571.94714026425, 10962.616308429167, 10964.122870170368, 10972.506237219344, 10974.451277436096, 45227.0, 45714.77142614299, 45783.313250301275, 45810.0, 45840.5415945843, 3694.5751238607368, 3724.3296206682785, 3782.375907975181, 3800.7339486235696, 3825.579186289534, 35111.4733279001, 35486.29027419463, 35845.28309433797, 36077.81961090204, 36197.63802361969, 4421.204183247014, 4562.520935301812, 4582.266837306049, 4609.953900460986, 4854.514548545152, 389456.0, 391195.99999999715, 392031.0, 393460.0, 393784.0, 69043.65478172677, 70336.6483167591, 70389.0, 70417.2958270421, 70431.64784176047, 39380.21239575192, 40894.38658420126, 40895.38656920149, 43137.35293970593, 75153.62423187958, 17210.741838872425, 17253.223604937808, 17260.223289951984, 17360.39238626642, 17364.218610162574, 12082.456289466994, 13502.459901604023, 14375.92812035954, 14385.92807035979, 14556.927215364067, 22696.773032269466, 22738.294627902975, 22864.428389290402, 22882.542349153257, 22924.656130158062, 7962.402819788539, 8112.472689275178, 8271.379646526535, 8306.958465207636, 8446.0, 1050.3435352904435, 1054.7943151085617, 1114.2311804854623, 1164.5109054197258, 1177.9234349767237, 34761.478577821355, 37537.49850006024, 37846.24307513834, 38393.42409863854, 38687.806560967016, 1130.553431394611, 1164.8427462292482, 1174.5712814822527, 1192.6839387562302, 1197.1320792425422, 17390.913045434692, 17779.911100444675, 18063.187156577722, 18200.544986375447, 18233.452996409862, 575838.0, 588218.0, 588986.0, 589708.0, 590362.0, 63429.68285158544, 64568.677156613914, 64848.35151648518, 64863.35136648668, 64887.67556162189, 1329.6875234319928, 1413.3078180441044, 1425.4796999095463, 1427.3220220395228, 1432.9856701432852, 28799.85600071986, 34144.65855341415, 34403.65596344005, 36911.26177476489, 37503.43744843775, 61815.6909215451, 62062.689686551275, 62439.37560624335, 62544.68727656332, 62662.686686566274, 431843.0, 432614.0, 434746.0, 435381.0, 435508.0, 39346.803265983486, 46233.76883115563, 47161.0, 47374.763126184145, 47923.76038119787, 52962.73518632382, 53361.19958200708, 53383.73308133434, 54034.45965540294, 54377.456225437236, 44159.77920110379, 44607.55392446164, 44679.776601116784, 45404.54595454003, 45463.77268113638, 43509.56490435182, 44485.77757111194, 44928.32607510825, 44932.77533612311, 45325.546744532134, 42879.0, 43586.782066089465, 43847.12305753803, 44401.33397999097, 44717.77641111904, 36725.44911826271, 40170.39744403895, 40524.0, 40711.79644101761, 40856.0, 29879.0, 31276.530852036783, 31766.523502147025, 32078.19804504906, 32302.192445188117], "value": 22244.86332191281, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.2427044913484, 419.2139737991266, 420.8316673330667, 433.2483141749065, 438.4782109289945, 18678.90660546697, 19750.506237344074, 20389.49026274344, 21084.051217695203, 21090.261840835574, 19603.0, 19697.90151049243, 19882.204711811548, 20102.296419625316, 20189.19243230269, 5756.338021127561, 5943.049112142058, 5975.014122669754, 5992.280926288851, 5997.0, 4189.350650649154, 4315.762633055181, 5796.855078623026, 5893.764249430039, 6593.274739778621, 6546.279909210007, 6649.268580456146, 6666.333366663343, 6690.76582319619, 6699.665016749143, 6409.775657851953, 6517.055027021079, 6629.668516574152, 6644.103046088789, 6653.068570400148, 3835.5397352317623, 5460.781568737246, 5808.680522571257, 5845.327787304472, 5851.32709738377, 23632.29103126909, 23735.1692690755, 23743.762562374326, 23753.287401377987, 23927.162549310866, 2565.615157726337, 2603.47930413918, 3021.350409661933, 3163.398954198718, 3209.2137426330464, 14106.0, 14108.506202282973, 14456.49402270926, 14947.925260373628, 15114.924425377912, 2011.8893460859647, 2015.8790472571693, 2127.6702111172795, 2132.2004248406847, 2154.91380344786, 54993.45006549923, 70875.64562177156, 72960.0, 74948.62525687391, 81508.9999999994, 10061.798764024825, 10581.62964296246, 10991.780164396827, 11068.501917413736, 11428.714282143013, 15961.521154365388, 15964.201789910458, 16032.438864639915, 16041.358345666044, 16103.0, 8233.958830205811, 8395.53824539644, 8432.831343373098, 8483.703070392507, 8512.233898949124, 8031.237032481905, 8177.754667359989, 8213.671453141807, 8333.083360830304, 8358.874616880752, 6842.93157068423, 6949.583025018515, 6972.58164510131, 7025.192102908129, 7048.0, 1985.811347921945, 1987.4534503011498, 2018.4550171453918, 2026.7608232718587, 2054.7020682001025, 987.9308448408542, 1055.8099542082498, 1056.8678915135608, 1094.9452527373758, 1112.1436493899653, 18507.629847403245, 19695.507612309808, 19769.703454448194, 19970.70043949342, 20297.391078267676, 1060.1783617696346, 1060.8514807926897, 1073.3023534702506, 1083.4907593431076, 1097.3306283167262, 11068.778624427627, 11514.827277590843, 11549.480273387719, 11581.0, 11742.88257117435, 538083.0, 554473.0, 567491.0, 574949.0, 575756.0, 64492.0, 79970.60014700006, 83253.16746832576, 83424.58287708522, 84084.15915840886, 490.1765034741597, 503.63234838568053, 1156.1386766858743, 1197.4312201704295, 1200.7538454616783, 10780.892191077988, 10801.783964320512, 11393.487293071998, 11397.772044558897, 11496.770064598828, 38687.0, 38868.416973744854, 38984.80507597444, 39302.41046384249, 39679.0, 51875.48124518707, 54287.45712542824, 57700.13449798172, 57867.71066144642, 59027.0, 8905.198532132139, 9019.188273055457, 9049.276057915482, 9115.0, 9142.405743626909, 10092.84860727075, 12940.676483087998, 13055.086143969831, 13238.205707657571, 13355.399007044512, 11481.598144064918, 11483.770324593628, 11594.652160434864, 11817.468213930566, 11907.0, 11428.25716328436, 11533.365664888512, 11585.478653460446, 11606.24559403636, 11806.409679515818, 11126.554937802397, 11395.772084558428, 11689.649310520697, 11718.121140914294, 11911.106667000184, 8454.57727113654, 8796.560171991503, 8925.642974281216, 8934.151255630704, 9194.26445884341, 11220.326780393203, 11307.943460282646, 11389.943050284695, 11400.315981041163, 11502.0], "value": 9481.32462856177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.882794962428, 1548.4735190035387, 1560.485039936821, 1765.752794608755, 1914.2917120665365, 8885.64457421703, 9230.16928476437, 9268.99999999999, 9522.381045232056, 9540.6660766873, 9274.443533388001, 9471.905280947189, 9478.099580539854, 9478.66824661137, 9489.95255023724, 1997.1811557261526, 2357.9056837726557, 2419.927402177929, 2431.7811396974225, 2461.089396923141, 2328.313147621447, 2334.1830359374253, 2338.088145623208, 2338.7193536775526, 2339.8830058497006, 2393.5930891748444, 2446.987765061181, 2449.5223431430877, 2450.0689737899575, 2450.779429851313, 1948.1720268885667, 2322.4077860145726, 2385.0340612052146, 2394.640803879432, 2396.3050715292543, 2334.8015418689433, 2356.045801450415, 2365.9171928982405, 2368.4078980254935, 2372.9169479068323, 9426.764330891714, 9452.291078169095, 9475.0, 9483.857742133874, 9484.810303793955, 5231.843044708665, 5314.734263286859, 5329.120695085307, 5341.4658534146665, 5347.385050719178, 3285.4250506161566, 3312.9171770705684, 3327.633960264369, 3333.2000319923286, 3450.7584469087174, 1050.6742909698019, 1053.3890343600692, 1069.5080263078994, 1102.0742576236, 1105.7788442311569, 13276.336183190802, 13298.335083245896, 13310.733785324239, 13343.599692009255, 13353.799693004612, 4478.932816007762, 4655.580997710223, 4716.95283047172, 4758.643101767381, 4779.976100119547, 11195.4962026709, 11209.215354925076, 11228.0, 11234.662960111209, 11244.325340479434, 4904.975475122602, 5358.732063396815, 5420.214068959979, 5421.810236641699, 5430.239766432703, 4533.773311334486, 4605.03294308199, 4607.976960115178, 4944.752762361867, 5061.848144555669, 4236.322188449833, 4260.169266992969, 4274.4870615525715, 4323.6757243206885, 4384.145091707151, 1288.2335010668637, 1304.5760127958451, 1309.1752196116386, 1312.9868701313055, 1317.1899281941728, 943.7970836270235, 1013.0376142664351, 1019.5208252121491, 1062.1874266186219, 1075.9085477734325, 6547.886859233941, 6673.065770792093, 6678.9332106679285, 6746.257911629717, 6779.694913728894, 388.3902273430743, 389.59676734579574, 393.5297319702985, 427.3098945203474, 431.1076072529833, 4501.662375321864, 4590.793414296365, 4676.579107880307, 4714.740689262055, 4745.928811067837, 11585.536578536932, 11882.465289062013, 11931.821022684666, 11932.284062956076, 11940.88059119415, 11260.94369528147, 11466.140039496904, 11585.246958947642, 11873.465694043789, 11891.167618266638, 8350.707725229588, 8423.326133909273, 8463.957680211559, 8501.53241571707, 8510.872336914952, 6291.370862913672, 6533.901991470227, 6606.174228221473, 6631.635260060743, 6655.534112612071, 10068.14420774213, 10382.169426446017, 10455.63405280842, 10482.266241363031, 10586.947065264625, 10483.580656773644, 10608.628697995533, 10687.5190616424, 10705.785884282115, 10707.464626768475, 8033.437659364022, 8370.246677798783, 8398.622062007347, 8408.159184081787, 8636.740897773077, 9267.073292670948, 9290.814183716422, 9301.209397201043, 9325.0, 9348.53257337144, 8502.702405415781, 8504.914950850412, 8512.106228845882, 8542.701005464778, 8607.956960215159, 8220.177982201732, 8304.211099945496, 8363.95818020906, 8412.0, 8502.0, 7544.509606875536, 7615.809604759704, 7618.352440042437, 7630.7710768677025, 7632.274933881273, 5681.375048744718, 5828.0966450200285, 5875.911861321998, 5940.405959404025, 5971.373005834499, 5841.211436456194, 5893.675847828411, 5920.585559010828, 6027.21646185993, 6032.969835150796], "value": 4783.3703283124905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7601988558296, 330.86765293882445, 335.506804996655, 341.30203733365266, 344.45575989935907, 5364.168553874146, 5394.379646340672, 5426.620136590431, 5446.2647542581735, 5450.563954883604, 5077.466865979074, 5166.793328266875, 5290.576753859692, 5334.1732031535175, 5351.892962140764, 4191.7484950903045, 4203.4325366075645, 4207.873763787091, 4223.450951376317, 4245.426867372896, 4179.164167166564, 4233.576642335757, 4239.491261048678, 4251.256030194719, 4257.425247591582, 4000.7397669734087, 4117.711760176789, 4125.308623464381, 4212.578742125794, 4230.7038507304505, 4221.910154473525, 4254.574542545752, 4265.957340426587, 4273.444452221207, 4274.914501709964, 3810.314143454177, 3812.7140464464997, 3814.5231846019246, 3814.6757525610356, 3816.542014958223, 5082.593392528589, 5182.922256166161, 5185.714785686786, 5226.608004399685, 5274.498922602346, 4814.6870453420415, 4816.710997340171, 4824.228123500258, 4825.445073816521, 4835.540623640749, 5591.329040515164, 5604.41153678866, 5604.439556044404, 5622.943770562283, 5668.603197776158, 4047.494063242095, 4121.423000779893, 4124.175164967019, 4136.751794892316, 4146.357314616239, 5733.541316694655, 5798.855028624276, 5809.506191973687, 5827.4755272025295, 5847.44449277318, 4186.706930514834, 4187.602177793105, 4193.161367726406, 4200.369944508348, 4224.5353011168745, 4099.733517321364, 4260.765657888845, 4266.616004559604, 4281.914361712748, 4296.011917259048, 4791.425028996473, 4800.423949126058, 4814.446338671028, 4821.951780482221, 4828.493008234155, 5655.293088363955, 5671.659700417906, 5706.3722990471015, 5743.569232307594, 5747.224124743189, 1402.2708191740237, 1440.2438719672045, 1472.8821694264648, 1476.6825132596543, 1481.3408033425237, 1007.2495990487134, 1026.958921643126, 1027.4708525109575, 1030.5620111452602, 1034.2294990232326, 5435.537979271806, 5471.644343117764, 5504.422035686275, 5516.503514683698, 5516.779328826882, 5773.134029895466, 5780.71096445176, 5781.855453613609, 5821.0, 5837.7664893404635, 5251.267081862976, 5526.198701188305, 5570.749316280777, 5583.357913839879, 5596.593464810171, 3062.3109800294756, 3072.7695422843376, 3088.382323535302, 3109.16052665779, 3124.9375212427885, 6079.240094988127, 6124.418180272867, 6138.662373569497, 6140.631562106288, 6223.284322302902, 5623.409541998113, 5952.0, 5957.165996760457, 6018.969905150446, 6030.246219222598, 6151.692415379213, 6160.10678451631, 6185.0, 6188.350223226496, 6196.907046394217, 5485.61600687964, 5840.445157710011, 5858.853528661817, 5895.0524737631185, 5983.34183239852, 5749.246479823694, 5760.164776107525, 5773.422657734361, 5796.188533605383, 5828.417158284137, 5792.1022241550945, 6129.570930035033, 6133.3866613338305, 6190.566660333733, 6194.907076393768, 4047.57500462459, 4074.714769966074, 4077.368007958771, 4093.304138296437, 4111.259973204852, 5877.441643043904, 5884.529237661062, 5888.793892213752, 5889.970550147222, 5929.318128415288, 5452.645578037414, 5519.613627046068, 5713.22871412354, 5725.280491766544, 5746.2529871116485, 5675.545956323402, 5679.870048731726, 5684.943150568607, 5697.7436015380235, 5698.686572238566, 5370.355557333145, 5547.861303467445, 5629.3244810621345, 5662.867426514631, 5688.40271771458, 5757.165211044459, 5770.114942528736, 5776.393478684678, 5784.768609255582, 5793.710314484343, 5572.414896435978, 5585.916211256916, 5658.886822263614, 5679.261695979496, 5682.176084467812], "value": 4351.486636372515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.729894536912, 787.822739883526, 793.472340893306, 840.3613253927014, 913.6299798581568, 15946.521604351874, 16828.74756878648, 17375.391861284843, 18388.448346549623, 18443.815561844378, 16723.749143762852, 16810.579735506617, 16868.0, 16895.83104168958, 16913.0, 718.838261391188, 845.1295165979052, 866.9219770220678, 877.0703054761941, 879.6701237036111, 877.0308808766285, 884.4869975414276, 884.8451520983834, 884.9469031858077, 885.1635204731531, 916.5783739479847, 924.6994726713812, 925.2921515040999, 925.3013974449282, 925.9768505787342, 757.2654525110606, 888.4891187567175, 917.7797328641145, 920.6547544670749, 922.3543519536317, 674.0563211503885, 675.1021141881287, 675.2234929830685, 675.3415419965544, 675.5136301862651, 16025.679486410207, 16044.51866443997, 16113.516594502184, 16115.435959741353, 16118.11350375729, 14833.554993350217, 15255.313510892036, 15256.466023689229, 15293.847061529354, 15364.231788410534, 13316.0, 13333.599992000256, 13378.197308161542, 14330.925180611495, 14346.64133396663, 4177.164567086595, 4192.259526507248, 4206.158768246363, 4210.59999300066, 4267.146570685875, 75291.0, 76812.61593692051, 77452.0, 77559.22440775632, 77569.22430775677, 11317.71705707364, 12041.157119001586, 12108.394580270951, 12118.69703257408, 12178.57374991871, 22589.661155082686, 22601.208957686402, 22603.43491412728, 22625.660615090786, 22649.2072777452, 8808.0, 8869.11308869108, 9140.63437462494, 9158.587863546156, 9171.35800493959, 5172.224166375074, 5232.895342093137, 5342.305500285016, 5372.462753724674, 5499.890002199933, 3695.5750088740137, 3781.0736369589076, 3787.450819631138, 3798.4492248623797, 3811.866584669523, 645.3095188148636, 649.1852724830308, 657.1227411405827, 679.2663922963188, 680.0717021265937, 694.6006046523169, 717.47982712533, 814.6130587970785, 830.6303694855732, 872.0843114729508, 10742.516586753614, 11008.284461509977, 11091.611793587186, 11460.255083419552, 11490.942545287387, 769.1424062170639, 788.2157253532772, 788.8580055589935, 812.3501199040744, 831.3556993330096, 5141.76862041209, 5210.843674689765, 5348.3125924376245, 5424.511793938565, 5558.471945165203, 69578.0, 72887.2711272891, 88812.0, 115195.42402287935, 121309.0, 93567.53216233876, 98990.50504747574, 100801.49599251957, 100898.49550752199, 102560.0, 86917.56541217254, 87727.0, 87915.56042219748, 88010.99999999872, 88846.55576722075, 10353.0, 10385.22110841705, 10581.259311848406, 10615.734606634896, 10634.946825265824, 52011.47988520218, 52600.0, 52613.473865262386, 53433.46566534285, 54909.725451374085, 74852.0, 75400.62299688466, 75538.24461755532, 77952.61023694846, 78150.0, 13004.0, 14150.716985660023, 14180.645483862574, 14447.711045779235, 14649.780253295996, 16039.278232479799, 16384.426545071343, 16960.491185264462, 17440.21519031672, 17648.73526897072, 15352.462663806713, 16274.837251627332, 16512.66974660476, 16609.16954152312, 16747.33010679559, 15813.288402021706, 16022.439214627431, 16302.184890755652, 16442.342306307615, 16545.014598248286, 12704.872951270369, 12984.480620775441, 13326.466941322238, 14763.114213147246, 15007.0, 12643.93678031604, 12991.41538630745, 13229.0, 13259.602211933658, 13323.800142997668, 12754.936225318814, 12832.55086071983, 12853.228806271654, 12856.292903890377, 13232.338383081], "value": 8160.766402993428, "unit": "score"}], "name": "dromaeo_css", "value": 7610.636100241818, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 109.0, 109.0, 111.0, 110.0, 111.0, 110.0, 109.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 124.0, 167.0, 124.0, 124.0, 154.0, 125.0, 162.0, 123.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 161.0, 160.0, 170.0, 160.0, 160.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 118.0, 74.0, 75.0, 74.0, 75.0, 99.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 84.0, 86.0, 84.0, 126.0, 84.0, 85.0, 128.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 51.0, 52.0, 50.0, 50.0, 52.0, 51.0, 50.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 78.0, 76.0, 77.0, 78.0, 78.0, 80.0, 113.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 116.0, 115.0, 117.0, 123.0, 119.0, 119.0, 118.0, 122.0, 118.0], "value": 119.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 153.0, 157.0, 153.0, 158.0, 153.0, 153.0, 153.0, 150.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 65.0, 63.0, 60.0, 61.0, 61.0, 59.0, 63.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1470.6999999999998, "alertThreshold": 2.0}]} 03:30:25 INFO - Return code: 0 03:30:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:30:25 ERROR - # TBPL SUCCESS # 03:30:25 INFO - Running post-action listener: _resource_record_post_action 03:30:25 INFO - ##### 03:30:25 INFO - ##### Finished run-tests step (success) 03:30:25 INFO - ##### 03:30:25 INFO - Running post-run listener: _resource_record_post_run 03:30:25 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513007616; Read time: 12; Write time: 1452036 03:30:25 INFO - TinderboxPrint: CPU usage
13.1% 03:30:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:30:25 INFO - TinderboxPrint: I/O write bytes / time
513,007,616 / 1,452,036 03:30:25 INFO - TinderboxPrint: CPU idle
8,277.3 (86.9%) 03:30:25 INFO - TinderboxPrint: CPU user
1,194.0 (12.5%) 03:30:25 INFO - TinderboxPrint: Swap in / out
0 / 0 03:30:25 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 264802304; Read time: 0; Write time: 902304 03:30:25 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 244252672; Read time: 12; Write time: 548964 03:30:26 INFO - Running post-run listener: _upload_blobber_files 03:30:26 INFO - Blob upload gear active. 03:30:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:26 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 03:30:26 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'] 03:30:26 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 03:30:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:27 INFO - (blobuploader) - INFO - Done attempting. 03:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:31 INFO - (blobuploader) - INFO - Done attempting. 03:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:32 INFO - (blobuploader) - INFO - Done attempting. 03:30:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:32 INFO - Return code: 0 03:30:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5498aa3167da9e9578493d7380119ae46ee1a6cc367b07427db2136dfe6532ec8ba5de65c11e8b7d4f337055c9d398b51401711bd32de3ee621997bceda6e3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37d0d84ecbb65887d090ebd4ddca34890f78807a8a7fbad0eb60fd654a514f7132c8d9079e484558fcbc3fa0edef6d025e2b795a44e89e4e9199df6e5d7e5780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fda7fda1f34d87d10eaaf40b786a9b1f764a46ee8df640950d1fb7efc4bac37ab497f05ccaf237ee425235a2a869e0fee85be88996e6846088bed977ee5f123"} 03:30:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:32 INFO - Contents: 03:30:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5498aa3167da9e9578493d7380119ae46ee1a6cc367b07427db2136dfe6532ec8ba5de65c11e8b7d4f337055c9d398b51401711bd32de3ee621997bceda6e3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37d0d84ecbb65887d090ebd4ddca34890f78807a8a7fbad0eb60fd654a514f7132c8d9079e484558fcbc3fa0edef6d025e2b795a44e89e4e9199df6e5d7e5780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fda7fda1f34d87d10eaaf40b786a9b1f764a46ee8df640950d1fb7efc4bac37ab497f05ccaf237ee425235a2a869e0fee85be88996e6846088bed977ee5f123"} 03:30:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:32 INFO - Copying logs to upload dir... 03:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.874470 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-30 03:30:32.023514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:32.027317) ========= 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=8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5498aa3167da9e9578493d7380119ae46ee1a6cc367b07427db2136dfe6532ec8ba5de65c11e8b7d4f337055c9d398b51401711bd32de3ee621997bceda6e3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37d0d84ecbb65887d090ebd4ddca34890f78807a8a7fbad0eb60fd654a514f7132c8d9079e484558fcbc3fa0edef6d025e2b795a44e89e4e9199df6e5d7e5780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fda7fda1f34d87d10eaaf40b786a9b1f764a46ee8df640950d1fb7efc4bac37ab497f05ccaf237ee425235a2a869e0fee85be88996e6846088bed977ee5f123"} 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.011300 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5498aa3167da9e9578493d7380119ae46ee1a6cc367b07427db2136dfe6532ec8ba5de65c11e8b7d4f337055c9d398b51401711bd32de3ee621997bceda6e3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/37d0d84ecbb65887d090ebd4ddca34890f78807a8a7fbad0eb60fd654a514f7132c8d9079e484558fcbc3fa0edef6d025e2b795a44e89e4e9199df6e5d7e5780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fda7fda1f34d87d10eaaf40b786a9b1f764a46ee8df640950d1fb7efc4bac37ab497f05ccaf237ee425235a2a869e0fee85be88996e6846088bed977ee5f123"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:32.052148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:32.052440) ========= 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=8783db0840cc980e80bb0bd400000236-1469873394.509888-2130823788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:32.138940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:30:32.139248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:30:32.139601) ========= ========= Total master_lag: 0.18 =========