builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1467117798.41 results: success (0) buildid: 20160628030238 builduid: eb78cd90ad314f479880762a4f649e02 revision: d87b76177b2f5cf0839d73becebb614ab8a9ef7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.413707) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.414088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.414403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.448116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.448421) ========= 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=41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 05:43:18-- 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% 71.0M=0s 2016-06-28 05:43:18 (71.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.555373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.555687) ========= 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=41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.604900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:18.605255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d87b76177b2f5cf0839d73becebb614ab8a9ef7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d87b76177b2f5cf0839d73becebb614ab8a9ef7f --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=41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 05:43:18,807 truncating revision to first 12 chars 2016-06-28 05:43:18,807 Setting DEBUG logging. 2016-06-28 05:43:18,807 attempt 1/10 2016-06-28 05:43:18,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d87b76177b2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 05:43:19,129 unpacking tar archive at: mozilla-central-d87b76177b2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:19.278910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:19.279307) ========= script_repo_revision: d87b76177b2f5cf0839d73becebb614ab8a9ef7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:19.279703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:19.279980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 05:43:19.300943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-28 05:43:19.301209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:19 INFO - MultiFileLogger online at 20160628 05:43:19 in /builds/slave/test 05:43:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:43:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:43:19 INFO - {'append_to_log': False, 05:43:19 INFO - 'base_work_dir': '/builds/slave/test', 05:43:19 INFO - 'blob_upload_branch': 'Firefox', 05:43:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:43:19 INFO - 'branch': 'Firefox', 05:43:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:19 INFO - 'config_files': ('talos/linux_config.py',), 05:43:19 INFO - 'default_actions': ('clobber', 05:43:19 INFO - 'read-buildbot-config', 05:43:19 INFO - 'download-and-extract', 05:43:19 INFO - 'populate-webroot', 05:43:19 INFO - 'create-virtualenv', 05:43:19 INFO - 'install', 05:43:19 INFO - 'run-tests'), 05:43:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:19 INFO - 'download_minidump_stackwalk': True, 05:43:19 INFO - 'download_symbols': 'ondemand', 05:43:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:19 INFO - 'installer_path': 'installer.exe', 05:43:19 INFO - 'log_level': 'info', 05:43:19 INFO - 'log_name': 'talos', 05:43:19 INFO - 'log_to_console': True, 05:43:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:19 INFO - 'opt_config_files': (), 05:43:19 INFO - 'pip_index': False, 05:43:19 INFO - 'sps_profile': False, 05:43:19 INFO - 'sps_profile_interval': 0, 05:43:19 INFO - 'suite': 'dromaeojs-e10s', 05:43:19 INFO - 'system_bits': '32', 05:43:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:19 INFO - 'title': 'talos-linux64-ix-024', 05:43:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:19 INFO - 'use_talos_json': True, 05:43:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:43:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:19 INFO - 'work_dir': 'build'} 05:43:19 INFO - ##### 05:43:19 INFO - ##### Running clobber step. 05:43:19 INFO - ##### 05:43:19 INFO - Running pre-action listener: _resource_record_pre_action 05:43:19 INFO - Running main action method: clobber 05:43:19 INFO - rmtree: /builds/slave/test/build 05:43:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:43:20 INFO - Running post-action listener: _resource_record_post_action 05:43:20 INFO - ##### 05:43:20 INFO - ##### Finished clobber step (success) 05:43:20 INFO - ##### 05:43:20 INFO - ##### 05:43:20 INFO - ##### Running read-buildbot-config step. 05:43:20 INFO - ##### 05:43:20 INFO - Running pre-action listener: _resource_record_pre_action 05:43:20 INFO - Running main action method: read_buildbot_config 05:43:20 INFO - Using buildbot properties: 05:43:20 INFO - { 05:43:20 INFO - "project": "", 05:43:20 INFO - "product": "firefox", 05:43:20 INFO - "script_repo_revision": "production", 05:43:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:43:20 INFO - "repository": "", 05:43:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:43:20 INFO - "buildid": "20160628030238", 05:43:20 INFO - "stage_platform": "linux64-pgo", 05:43:20 INFO - "basedir": "/builds/slave/test", 05:43:20 INFO - "nightly_build": "True", 05:43:20 INFO - "buildnumber": 73, 05:43:20 INFO - "slavename": "talos-linux64-ix-024", 05:43:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:43:20 INFO - "platform": "ubuntu64_hw", 05:43:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:20 INFO - "branch": "mozilla-central", 05:43:20 INFO - "repo_path": "mozilla-central", 05:43:20 INFO - "revision": "d87b76177b2f5cf0839d73becebb614ab8a9ef7f", 05:43:20 INFO - "pgo_build": "True", 05:43:20 INFO - "builduid": "eb78cd90ad314f479880762a4f649e02", 05:43:20 INFO - "slavebuilddir": "test" 05:43:20 INFO - } 05:43:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:43:20 INFO - Running post-action listener: _resource_record_post_action 05:43:20 INFO - ##### 05:43:20 INFO - ##### Finished read-buildbot-config step (success) 05:43:20 INFO - ##### 05:43:20 INFO - ##### 05:43:20 INFO - ##### Running download-and-extract step. 05:43:20 INFO - ##### 05:43:20 INFO - Running pre-action listener: _resource_record_pre_action 05:43:20 INFO - Running main action method: download_and_extract 05:43:20 INFO - mkdir: /builds/slave/test/build/tests 05:43: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')]} 05:43:20 INFO - https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:43:35 INFO - Downloaded 1361 bytes. 05:43:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:43:35 INFO - Using the following test package requirements: 05:43:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:43:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'jsshell-linux-x86_64.zip'], 05:43:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:35 INFO - https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:44 INFO - Downloaded 24279638 bytes. 05:43:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:43:46 INFO - Return code: 0 05:43:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:43:46 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')]} 05:43:46 INFO - https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:43:47 INFO - Downloaded 24279638 bytes. 05:43:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:43:48 INFO - Return code: 0 05:43: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')]} 05:43:48 INFO - https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:43:49 INFO - Downloaded 14405240 bytes. 05:43:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:43:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:43:50 INFO - Return code: 0 05:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:50 INFO - https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:43:51 INFO - Downloaded 60306508 bytes. 05:43:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:51 INFO - mkdir: /builds/slave/test/properties 05:43:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:51 INFO - Contents: 05:43:51 INFO - build_url:https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:43:52 INFO - Running post-action listener: _resource_record_post_action 05:43:52 INFO - Running post-action listener: set_extra_try_arguments 05:43:52 INFO - ##### 05:43:52 INFO - ##### Finished download-and-extract step (success) 05:43:52 INFO - ##### 05:43:52 INFO - ##### 05:43:52 INFO - ##### Running populate-webroot step. 05:43:52 INFO - ##### 05:43:52 INFO - Running pre-action listener: _resource_record_pre_action 05:43:52 INFO - Running main action method: populate_webroot 05:43:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:52 INFO - '--tppagecycles', 05:43:52 INFO - '7'], 05:43:52 INFO - 'tests': ['tsvgm']}}, 05:43:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:43:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['damp', 'tps']}, 05:43:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'tests': ['damp', 'tps']}, 05:43:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['dromaeo_dom']}, 05:43:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['basic_compositor_video']}, 05:43:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:43:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore', 05:43:52 INFO - 'tabpaint']}, 05:43:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore', 05:43:52 INFO - 'tabpaint']}, 05:43:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore', 05:43:52 INFO - 'tabpaint']}, 05:43:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore', 05:43:52 INFO - 'tabpaint']}, 05:43:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore', 05:43:52 INFO - 'tabpaint']}, 05:43:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['a11yr', 05:43:52 INFO - 'ts_paint', 05:43:52 INFO - 'tpaint', 05:43:52 INFO - 'sessionrestore', 05:43:52 INFO - 'sessionrestore_no_auto_restore', 05:43:52 INFO - 'tabpaint']}, 05:43:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['tsvgx', 05:43:52 INFO - 'tsvgr_opacity', 05:43:52 INFO - 'tart', 05:43:52 INFO - 'tscrollx', 05:43:52 INFO - 'cart']}, 05:43:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:52 INFO - 'tsvgr_opacity', 05:43:52 INFO - 'tart', 05:43:52 INFO - 'tscrollx', 05:43:52 INFO - 'cart']}, 05:43:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--disable-e10s'], 05:43:52 INFO - 'tests': ['tp5o']}, 05:43:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'tests': ['tp5o']}, 05:43:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--disable-e10s', 05:43:52 INFO - '--xperf_path', 05:43:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:52 INFO - 'tests': ['tp5n']}, 05:43:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:52 INFO - 'talos_options': ['--xperf_path', 05:43:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:52 INFO - 'tests': ['tp5n']}}, 05:43:52 INFO - 'talos.zip': {'path': '', 05:43:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:52 INFO - Running post-action listener: _resource_record_post_action 05:43:52 INFO - ##### 05:43:52 INFO - ##### Finished populate-webroot step (success) 05:43:52 INFO - ##### 05:43:52 INFO - ##### 05:43:52 INFO - ##### Running create-virtualenv step. 05:43:52 INFO - ##### 05:43:52 INFO - Running pre-action listener: _resource_record_pre_action 05:43:52 INFO - Running main action method: create_virtualenv 05:43:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:52 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 05:43:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:43:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:52 INFO - Using real prefix '/usr' 05:43:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:54 INFO - Installing pip.................done. 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 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 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:43:54 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 05:43:54 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 05:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:43:55 INFO - Cleaning up... 05:43:55 INFO - Return code: 0 05:43:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:43:55 INFO - Using env: {'DISPLAY': ':0', 05:43:55 INFO - 'HOME': '/home/cltbld', 05:43:55 INFO - 'LANG': 'en_US.UTF-8', 05:43:55 INFO - 'LANGUAGE': 'en_US:en', 05:43:55 INFO - 'LOGNAME': 'cltbld', 05:43:55 INFO - 'MAIL': '/var/mail/cltbld', 05:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:55 INFO - 'MOZ_NO_REMOTE': '1', 05:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:55 INFO - 'NO_EM_RESTART': '1', 05:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:55 INFO - 'PWD': '/builds/slave/test', 05:43:55 INFO - 'SHELL': '/bin/bash', 05:43:55 INFO - 'SHLVL': '1', 05:43:55 INFO - 'TERM': 'linux', 05:43:55 INFO - 'TMOUT': '86400', 05:43:55 INFO - 'USER': 'cltbld', 05:43:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:55 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Downloading/unpacking psutil>=3.1.1 05:43:55 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 05:43:55 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 05:43:55 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 05:43:55 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 05:43:55 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 05:43:55 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 05:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:57 INFO - Installing collected packages: psutil 05:43:57 INFO - Running setup.py install for psutil 05:43:57 INFO - building 'psutil._psutil_linux' extension 05:43:57 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 05:43:57 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 05:43:57 INFO - building 'psutil._psutil_posix' extension 05:43:57 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 05:43:57 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 05:43:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:57 INFO - Successfully installed psutil 05:43:57 INFO - Cleaning up... 05:43:57 INFO - Return code: 0 05:43:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43: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')]} 05:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:57 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 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:43:57 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 05:43:57 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 05:43:57 INFO - Using env: {'DISPLAY': ':0', 05:43:57 INFO - 'HOME': '/home/cltbld', 05:43:57 INFO - 'LANG': 'en_US.UTF-8', 05:43:57 INFO - 'LANGUAGE': 'en_US:en', 05:43:57 INFO - 'LOGNAME': 'cltbld', 05:43:57 INFO - 'MAIL': '/var/mail/cltbld', 05:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:57 INFO - 'MOZ_NO_REMOTE': '1', 05:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:57 INFO - 'NO_EM_RESTART': '1', 05:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:57 INFO - 'PWD': '/builds/slave/test', 05:43:57 INFO - 'SHELL': '/bin/bash', 05:43:57 INFO - 'SHLVL': '1', 05:43:57 INFO - 'TERM': 'linux', 05:43:57 INFO - 'TMOUT': '86400', 05:43:57 INFO - 'USER': 'cltbld', 05:43:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:57 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:59 INFO - Installing collected packages: mozsystemmonitor 05:43:59 INFO - Running setup.py install for mozsystemmonitor 05:44:00 INFO - Successfully installed mozsystemmonitor 05:44:00 INFO - Cleaning up... 05:44:00 INFO - Return code: 0 05:44:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:44:00 INFO - Using env: {'DISPLAY': ':0', 05:44:00 INFO - 'HOME': '/home/cltbld', 05:44:00 INFO - 'LANG': 'en_US.UTF-8', 05:44:00 INFO - 'LANGUAGE': 'en_US:en', 05:44:00 INFO - 'LOGNAME': 'cltbld', 05:44:00 INFO - 'MAIL': '/var/mail/cltbld', 05:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:00 INFO - 'MOZ_NO_REMOTE': '1', 05:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:00 INFO - 'NO_EM_RESTART': '1', 05:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:00 INFO - 'PWD': '/builds/slave/test', 05:44:00 INFO - 'SHELL': '/bin/bash', 05:44:00 INFO - 'SHLVL': '1', 05:44:00 INFO - 'TERM': 'linux', 05:44:00 INFO - 'TMOUT': '86400', 05:44:00 INFO - 'USER': 'cltbld', 05:44:00 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:00 INFO - '_': '/tools/buildbot/bin/python'} 05:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:44:00 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 05:44:00 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 05:44:00 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 05:44:00 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 05:44:00 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 05:44:00 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 05:44:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:02 INFO - warning: no files found matching '*.txt' 05:44:02 INFO - no previously-included directories found matching 'build' 05:44:02 INFO - no previously-included directories found matching 'dist' 05:44:02 INFO - no previously-included directories found matching '.git*' 05:44:02 INFO - Installing collected packages: jsonschema, functools32 05:44:02 INFO - Running setup.py install for functools32 05:44:02 INFO - warning: no files found matching '*.txt' 05:44:02 INFO - no previously-included directories found matching 'build' 05:44:02 INFO - no previously-included directories found matching 'dist' 05:44:02 INFO - no previously-included directories found matching '.git*' 05:44:02 INFO - Successfully installed jsonschema functools32 05:44:02 INFO - Cleaning up... 05:44:02 INFO - Return code: 0 05:44:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:02 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 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:02 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 05:44:02 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 05:44:02 INFO - Using env: {'DISPLAY': ':0', 05:44:02 INFO - 'HOME': '/home/cltbld', 05:44:02 INFO - 'LANG': 'en_US.UTF-8', 05:44:02 INFO - 'LANGUAGE': 'en_US:en', 05:44:02 INFO - 'LOGNAME': 'cltbld', 05:44:02 INFO - 'MAIL': '/var/mail/cltbld', 05:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:02 INFO - 'MOZ_NO_REMOTE': '1', 05:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:02 INFO - 'NO_EM_RESTART': '1', 05:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:02 INFO - 'PWD': '/builds/slave/test', 05:44:02 INFO - 'SHELL': '/bin/bash', 05:44:02 INFO - 'SHLVL': '1', 05:44:02 INFO - 'TERM': 'linux', 05:44:02 INFO - 'TMOUT': '86400', 05:44:02 INFO - 'USER': 'cltbld', 05:44:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:02 INFO - '_': '/tools/buildbot/bin/python'} 05:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:04 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 05:44:04 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 05:44:04 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 05:44:04 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 05:44:04 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 05:44:04 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 05:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:44:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:05 INFO - Downloading docopt-0.6.1.tar.gz 05:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:05 INFO - Running setup.py install for blobuploader 05:44:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:44:05 INFO - Running setup.py install for requests 05:44:05 INFO - Running setup.py install for docopt 05:44:06 INFO - Successfully installed blobuploader requests docopt 05:44:06 INFO - Cleaning up... 05:44:06 INFO - Return code: 0 05:44:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:06 INFO - Using env: {'DISPLAY': ':0', 05:44:06 INFO - 'HOME': '/home/cltbld', 05:44:06 INFO - 'LANG': 'en_US.UTF-8', 05:44:06 INFO - 'LANGUAGE': 'en_US:en', 05:44:06 INFO - 'LOGNAME': 'cltbld', 05:44:06 INFO - 'MAIL': '/var/mail/cltbld', 05:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:06 INFO - 'MOZ_NO_REMOTE': '1', 05:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:06 INFO - 'NO_EM_RESTART': '1', 05:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:06 INFO - 'PWD': '/builds/slave/test', 05:44:06 INFO - 'SHELL': '/bin/bash', 05:44:06 INFO - 'SHLVL': '1', 05:44:06 INFO - 'TERM': 'linux', 05:44:06 INFO - 'TMOUT': '86400', 05:44:06 INFO - 'USER': 'cltbld', 05:44:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:06 INFO - '_': '/tools/buildbot/bin/python'} 05:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:06 INFO - Running setup.py (path:/tmp/pip-d1ttuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:06 INFO - Running setup.py (path:/tmp/pip-fySnTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:06 INFO - Running setup.py (path:/tmp/pip-CNRWz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:06 INFO - Running setup.py (path:/tmp/pip-8DKBbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:06 INFO - Running setup.py (path:/tmp/pip-cMYgTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:06 INFO - Running setup.py (path:/tmp/pip-SPxodC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:06 INFO - Running setup.py (path:/tmp/pip-ewYXaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:06 INFO - Running setup.py (path:/tmp/pip-FdbNBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:06 INFO - Running setup.py (path:/tmp/pip-7okD94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:07 INFO - Running setup.py (path:/tmp/pip-qwoDok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:07 INFO - Running setup.py (path:/tmp/pip-OqL1ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:07 INFO - Running setup.py (path:/tmp/pip-eudEty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:07 INFO - Running setup.py (path:/tmp/pip-_JETXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:07 INFO - Running setup.py (path:/tmp/pip-VKif3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:07 INFO - Running setup.py (path:/tmp/pip-EGgN_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:07 INFO - Running setup.py (path:/tmp/pip-IZP2bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:07 INFO - Running setup.py (path:/tmp/pip-i1O7HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:07 INFO - Running setup.py install for manifestparser 05:44:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:44:07 INFO - Running setup.py install for mozcrash 05:44:07 INFO - Running setup.py install for mozdebug 05:44:07 INFO - Running setup.py install for mozdevice 05:44:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for mozfile 05:44:08 INFO - Running setup.py install for mozhttpd 05:44:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for mozinfo 05:44:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for mozInstall 05:44:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for mozleak 05:44:08 INFO - Running setup.py install for mozlog 05:44:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for moznetwork 05:44:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for mozprocess 05:44:08 INFO - Running setup.py install for mozprofile 05:44:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:44:08 INFO - Running setup.py install for mozrunner 05:44:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:44:09 INFO - Running setup.py install for mozscreenshot 05:44:09 INFO - Running setup.py install for moztest 05:44:09 INFO - Running setup.py install for mozversion 05:44:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:44:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:09 INFO - Cleaning up... 05:44:09 INFO - Return code: 0 05:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:09 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 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:09 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 05:44:09 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 05:44:09 INFO - Using env: {'DISPLAY': ':0', 05:44:09 INFO - 'HOME': '/home/cltbld', 05:44:09 INFO - 'LANG': 'en_US.UTF-8', 05:44:09 INFO - 'LANGUAGE': 'en_US:en', 05:44:09 INFO - 'LOGNAME': 'cltbld', 05:44:09 INFO - 'MAIL': '/var/mail/cltbld', 05:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:09 INFO - 'MOZ_NO_REMOTE': '1', 05:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:09 INFO - 'NO_EM_RESTART': '1', 05:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:09 INFO - 'PWD': '/builds/slave/test', 05:44:09 INFO - 'SHELL': '/bin/bash', 05:44:09 INFO - 'SHLVL': '1', 05:44:09 INFO - 'TERM': 'linux', 05:44:09 INFO - 'TMOUT': '86400', 05:44:09 INFO - 'USER': 'cltbld', 05:44:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:09 INFO - '_': '/tools/buildbot/bin/python'} 05:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:09 INFO - Running setup.py (path:/tmp/pip-yhemF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:09 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)) 05:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:09 INFO - Running setup.py (path:/tmp/pip-s2sb6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:09 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)) 05:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:09 INFO - Running setup.py (path:/tmp/pip-TWDhgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:09 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)) 05:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:09 INFO - Running setup.py (path:/tmp/pip-x1L1oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:09 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)) 05:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:09 INFO - Running setup.py (path:/tmp/pip-Vj7IOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:09 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)) 05:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:09 INFO - Running setup.py (path:/tmp/pip-FO16AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:10 INFO - Running setup.py (path:/tmp/pip-pf6VjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:10 INFO - Running setup.py (path:/tmp/pip-HLMPti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:10 INFO - Running setup.py (path:/tmp/pip-xVqxLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:10 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)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:10 INFO - Running setup.py (path:/tmp/pip-G2M2xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:10 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)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:10 INFO - Running setup.py (path:/tmp/pip-8Rl05P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:10 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)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:10 INFO - Running setup.py (path:/tmp/pip-TfabeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:10 INFO - Running setup.py (path:/tmp/pip-K4PNTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:10 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)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:10 INFO - Running setup.py (path:/tmp/pip-O1n2ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:10 INFO - Running setup.py (path:/tmp/pip-_Yyj0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:10 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)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:10 INFO - Running setup.py (path:/tmp/pip-W5oZnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:10 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)) 05:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:10 INFO - Running setup.py (path:/tmp/pip-8MXOM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:10 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)) 05:44:10 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)) 05:44:10 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)) 05:44:10 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)) 05:44:10 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)) 05:44:10 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)) 05:44:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:10 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 05:44:10 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 05:44:10 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 05:44:10 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 05:44:10 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 05:44:10 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 05:44:12 INFO - Downloading blessings-1.6.tar.gz 05:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:12 INFO - Installing collected packages: blessings 05:44:12 INFO - Running setup.py install for blessings 05:44:12 INFO - Successfully installed blessings 05:44:12 INFO - Cleaning up... 05:44:13 INFO - Return code: 0 05:44:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:13 INFO - Reading from file tmpfile_stdout 05:44:13 INFO - Current package versions: 05:44:13 INFO - argparse == 1.2.1 05:44:13 INFO - blessings == 1.6 05:44:13 INFO - blobuploader == 1.2.4 05:44:13 INFO - docopt == 0.6.1 05:44:13 INFO - functools32 == 3.2.3-2 05:44:13 INFO - jsonschema == 2.5.1 05:44:13 INFO - manifestparser == 1.1 05:44:13 INFO - mozInstall == 1.12 05:44:13 INFO - mozcrash == 0.17 05:44:13 INFO - mozdebug == 0.1 05:44:13 INFO - mozdevice == 0.48 05:44:13 INFO - mozfile == 1.2 05:44:13 INFO - mozhttpd == 0.7 05:44:13 INFO - mozinfo == 0.9 05:44:13 INFO - mozleak == 0.1 05:44:13 INFO - mozlog == 3.2 05:44:13 INFO - moznetwork == 0.27 05:44:13 INFO - mozprocess == 0.22 05:44:13 INFO - mozprofile == 0.28 05:44:13 INFO - mozrunner == 6.11 05:44:13 INFO - mozscreenshot == 0.1 05:44:13 INFO - mozsystemmonitor == 0.3 05:44:13 INFO - moztest == 0.7 05:44:13 INFO - mozversion == 1.4 05:44:13 INFO - psutil == 3.1.1 05:44:13 INFO - requests == 1.2.3 05:44:13 INFO - wsgiref == 0.1.2 05:44:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:13 INFO - Using env: {'DISPLAY': ':0', 05:44:13 INFO - 'HOME': '/home/cltbld', 05:44:13 INFO - 'LANG': 'en_US.UTF-8', 05:44:13 INFO - 'LANGUAGE': 'en_US:en', 05:44:13 INFO - 'LOGNAME': 'cltbld', 05:44:13 INFO - 'MAIL': '/var/mail/cltbld', 05:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:13 INFO - 'MOZ_NO_REMOTE': '1', 05:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:13 INFO - 'NO_EM_RESTART': '1', 05:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:13 INFO - 'PWD': '/builds/slave/test', 05:44:13 INFO - 'SHELL': '/bin/bash', 05:44:13 INFO - 'SHLVL': '1', 05:44:13 INFO - 'TERM': 'linux', 05:44:13 INFO - 'TMOUT': '86400', 05:44:13 INFO - 'USER': 'cltbld', 05:44:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:13 INFO - '_': '/tools/buildbot/bin/python'} 05:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 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)) 05:44:13 INFO - Cleaning up... 05:44:13 INFO - Return code: 0 05:44:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:13 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 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:13 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 05:44:13 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 05:44:13 INFO - Using env: {'DISPLAY': ':0', 05:44:13 INFO - 'HOME': '/home/cltbld', 05:44:13 INFO - 'LANG': 'en_US.UTF-8', 05:44:13 INFO - 'LANGUAGE': 'en_US:en', 05:44:13 INFO - 'LOGNAME': 'cltbld', 05:44:13 INFO - 'MAIL': '/var/mail/cltbld', 05:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:13 INFO - 'MOZ_NO_REMOTE': '1', 05:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:13 INFO - 'NO_EM_RESTART': '1', 05:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:13 INFO - 'PWD': '/builds/slave/test', 05:44:13 INFO - 'SHELL': '/bin/bash', 05:44:13 INFO - 'SHLVL': '1', 05:44:13 INFO - 'TERM': 'linux', 05:44:13 INFO - 'TMOUT': '86400', 05:44:13 INFO - 'USER': 'cltbld', 05:44:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:13 INFO - '_': '/tools/buildbot/bin/python'} 05:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:44:13 INFO - Cleaning up... 05:44:13 INFO - Return code: 0 05:44:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:13 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 0x7f4bbfe67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, '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': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', '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 05:44:13 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 05:44:13 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 05:44:13 INFO - Using env: {'DISPLAY': ':0', 05:44:13 INFO - 'HOME': '/home/cltbld', 05:44:13 INFO - 'LANG': 'en_US.UTF-8', 05:44:13 INFO - 'LANGUAGE': 'en_US:en', 05:44:13 INFO - 'LOGNAME': 'cltbld', 05:44:13 INFO - 'MAIL': '/var/mail/cltbld', 05:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:13 INFO - 'MOZ_NO_REMOTE': '1', 05:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:13 INFO - 'NO_EM_RESTART': '1', 05:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:13 INFO - 'PWD': '/builds/slave/test', 05:44:13 INFO - 'SHELL': '/bin/bash', 05:44:13 INFO - 'SHLVL': '1', 05:44:13 INFO - 'TERM': 'linux', 05:44:13 INFO - 'TMOUT': '86400', 05:44:13 INFO - 'USER': 'cltbld', 05:44:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:13 INFO - '_': '/tools/buildbot/bin/python'} 05:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:13 INFO - Downloading/unpacking flake8 05:44:13 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 05:44:13 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 05:44:13 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 05:44:13 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 05:44:13 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 05:44:13 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 05:44:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 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 05:44:15 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 05:44:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:16 INFO - no previously-included directories found matching 'docs/_build' 05:44:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:16 INFO - Running setup.py install for pep8 05:44:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:16 INFO - no previously-included directories found matching 'docs/_build' 05:44:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:44:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:16 INFO - Cleaning up... 05:44:16 INFO - Return code: 0 05:44:16 INFO - Running post-action listener: _resource_record_post_action 05:44:16 INFO - Running post-action listener: _start_resource_monitoring 05:44:16 INFO - Starting resource monitoring. 05:44:16 INFO - ##### 05:44:16 INFO - ##### Finished create-virtualenv step (success) 05:44:16 INFO - ##### 05:44:16 INFO - ##### 05:44:16 INFO - ##### Running install step. 05:44:16 INFO - ##### 05:44:16 INFO - Running pre-action listener: _resource_record_pre_action 05:44:16 INFO - Running main action method: install 05:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:16 INFO - Reading from file tmpfile_stdout 05:44:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:44:17 INFO - Reading from file tmpfile_stdout 05:44:17 INFO - Output received: 05:44:17 INFO - Usage: mozinstall [options] installer 05:44:17 INFO - Options: 05:44:17 INFO - -h, --help show this help message and exit 05:44:17 INFO - -d DEST, --destination=DEST 05:44:17 INFO - Directory to install application into. [default: 05:44:17 INFO - "/builds/slave/test"] 05:44:17 INFO - --app=APP Application being installed. [default: firefox] 05:44:17 INFO - mkdir: /builds/slave/test/build/application 05:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:44:34 INFO - Reading from file tmpfile_stdout 05:44:34 INFO - Output received: 05:44:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:34 INFO - Running post-action listener: _resource_record_post_action 05:44:34 INFO - ##### 05:44:34 INFO - ##### Finished install step (success) 05:44:34 INFO - ##### 05:44:34 INFO - ##### 05:44:34 INFO - ##### Running run-tests step. 05:44:34 INFO - ##### 05:44:34 INFO - Running pre-action listener: _resource_record_pre_action 05:44:34 INFO - Running main action method: run_tests 05:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:34 INFO - Python 2.7.3 05:44:34 INFO - Return code: 0 05:44:34 INFO - grabbing minidump binary from tooltool 05:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:34 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 0x21ed6f0>, '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 0x21ee5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21eeaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:34 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 05:44:34 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 05:44:34 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 05:44:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:34 INFO - Return code: 0 05:44:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:44:35 INFO - Return code: 0 05:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:44:35 INFO - Using env: {'DISPLAY': ':0', 05:44:35 INFO - 'HOME': '/home/cltbld', 05:44:35 INFO - 'LANG': 'en_US.UTF-8', 05:44:35 INFO - 'LANGUAGE': 'en_US:en', 05:44:35 INFO - 'LOGNAME': 'cltbld', 05:44:35 INFO - 'MAIL': '/var/mail/cltbld', 05:44:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:35 INFO - 'MOZ_NO_REMOTE': '1', 05:44:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:35 INFO - 'NO_EM_RESTART': '1', 05:44:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:35 INFO - 'PWD': '/builds/slave/test', 05:44:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:35 INFO - 'SHELL': '/bin/bash', 05:44:35 INFO - 'SHLVL': '1', 05:44:35 INFO - 'TERM': 'linux', 05:44:35 INFO - 'TMOUT': '86400', 05:44:35 INFO - 'USER': 'cltbld', 05:44:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145', 05:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:35 INFO - '_': '/tools/buildbot/bin/python'} 05:44:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:44:35 INFO - mozversion application_buildid: 20160628030238 05:44:35 INFO - mozversion application_changeset: d87b76177b2f5cf0839d73becebb614ab8a9ef7f 05:44:35 INFO - mozversion application_display_name: Nightly 05:44:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:35 INFO - mozversion application_name: Firefox 05:44:35 INFO - mozversion application_remotingname: firefox 05:44:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:35 INFO - mozversion application_vendor: Mozilla 05:44:35 INFO - mozversion application_version: 50.0a1 05:44:35 INFO - mozversion platform_buildid: 20160628030238 05:44:35 INFO - mozversion platform_changeset: d87b76177b2f5cf0839d73becebb614ab8a9ef7f 05:44:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:35 INFO - mozversion platform_version: 50.0a1 05:44:35 INFO - using testdate: 1467117875 05:44:35 INFO - actual date: 1467117875 05:44:35 INFO - starting webserver on 'localhost:58985' 05:44:35 INFO - SUITE-START | Running 2 tests 05:44:35 INFO - TEST-START | dromaeo_css 05:44:35 INFO - operating with platform_type : linux_ 05:44:35 INFO - Initialising browser for dromaeo_css test... 05:44:35 INFO - TEST-INFO | started process 17585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtNRYF/profile http://localhost:58985/getInfo.html) 05:44:40 INFO - PROCESS | 17585 | __metrics Screen width/height:1600/1200 05:44:40 INFO - PROCESS | 17585 | colorDepth:24 05:44:40 INFO - PROCESS | 17585 | Browser inner width/height: 1024/697 05:44:40 INFO - PROCESS | 17585 | __metrics 05:44:40 ERROR - PROCESS | 17585 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:44:41 INFO - TEST-INFO | 17585: exit 0 05:44:41 INFO - Browser initialized. 05:44:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:44:41 INFO - TEST-INFO | started process 17704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtNRYF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:53 INFO - PROCESS | 17704 | RSS: Main: 185139200 05:44:53 INFO - PROCESS | 17704 | 05:45:43 INFO - PROCESS | 17704 | 1467117943325 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] 05:47:51 INFO - PROCESS | 17704 | Cycle 1(1): loaded http://localhost:58985/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58985/tests/dromaeo/cssquery-ext.html) 05:47:52 INFO - PROCESS | 17704 | RSS: Main: 188014592 05:47:52 INFO - PROCESS | 17704 | 05:50:54 INFO - PROCESS | 17704 | Cycle 1(1): loaded http://localhost:58985/tests/dromaeo/cssquery-ext.html (next: http://localhost:58985/tests/dromaeo/cssquery-jquery.html) 05:50:55 INFO - PROCESS | 17704 | RSS: Main: 187207680 05:50:55 INFO - PROCESS | 17704 | 05:53:57 INFO - PROCESS | 17704 | Cycle 1(1): loaded http://localhost:58985/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58985/tests/dromaeo/cssquery-mootools.html) 05:53:57 INFO - PROCESS | 17704 | RSS: Main: 188370944 05:53:57 INFO - PROCESS | 17704 | 05:56:59 INFO - PROCESS | 17704 | Cycle 1(1): loaded http://localhost:58985/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58985/tests/dromaeo/cssquery-prototype.html) 05:57:00 INFO - PROCESS | 17704 | RSS: Main: 186220544 05:57:00 INFO - PROCESS | 17704 | 06:00:02 INFO - PROCESS | 17704 | Cycle 1(1): loaded http://localhost:58985/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58985/tests/dromaeo/cssquery-yui.html) 06:00:03 INFO - PROCESS | 17704 | RSS: Main: 188551168 06:00:03 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | Cycle 1(1): loaded http://localhost:58985/tests/dromaeo/cssquery-yui.html (next: http://localhost:58985/tests/dromaeo/cssquery-dojo.html) 06:03:05 INFO - PROCESS | 17704 | RSS: Main: 189267968 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | __start_tp_report 06:03:05 INFO - PROCESS | 17704 | _x_x_mozilla_page_load 06:03:05 INFO - PROCESS | 17704 | _x_x_mozilla_page_load_details 06:03:05 INFO - PROCESS | 17704 | |i|pagename|runs| 06:03:05 INFO - PROCESS | 17704 | |0;dojo.html;3059.7246247837697;3082.7996180248297;3100.4264211120944;3109.471389863723;3120.9063728088167;5314.176302673082;5345.465453454657;5376.11294136467;5424.620276580641;5424.945750542493;5345.973270133653;5362.544183744377;5424.5117939385445;5459.808906688267;5521.337439507255;4841.588464980472;4874.780634871439;4919.557239848413;5018.924716129261;5022.899542009158;4882;5004.024215278022;5050.46970068143;5051.7726702298305;5052.368453943257;4848.127337079324;4871.537203965618;4874.2201247800185;4894.363732714742;4981.352424184851;4913.115639184945;4913.828016019422;4917.704937703749;4926.679765815211;4931.186354251544;4837.588804951583;4870.172070747982;4883.780229889663;4920.876978075541;4935.185694360426;5285.180796976475;5345.625806193568;5381.515663590257;5427;5443.918341224885;5829.446202610745;5867.178594996704;5871;5877.471027607493;5881.500072493843;5918.40815918409;5921.644701317935;5921.644701317935;5921.674307913063;5924.5260379169995;5330.227117068003;5453.15476101201;5499.807506737245;5505.559555235612;5512.062949298589;5960.314563825129;5972.283326000907;5978.491828194565;5981.611195272293;5994.37059108796;5558.416366281563;5760.6255593386295;5773.336066352339;5780.1907732917425;5784.681842498703;5683.403242659544;5687.914681279784;5737.684427356536;5747.942520574741;5764.13537969308;5589.469000444951;5593.300837395325;5708.743106560215;5731.742071606787;5749.88500229993;5685.403032681592;5721.456461636138;5731.541476681856;5735.340435849847;5739.713014349266;4313.525512193656;4333.436653235122;4340.435743353407;4383.189110014658;4386.232409328419;3904.90237744053;3912.8239229234755;3915.040815000343;3947.4276229946495;3953.743006704555;5482.835514934558;5518.089515229942;5533.6403133796175;5556.861078473071;5567.832965011056;5784.971075144682;5807.5644326675665;5846.093855452412;5890.852728681817;5947.464728174485;5546.667199968015;5569.387367389584;5586.301712285965;5588.888222235532;5597.608167428322;4884.535969082932;4915.139850526144;4953.628477864175;4989.501049895054;5038.470960549163;5958.433948774859;5966;6007.36922623127;6036;6093.756249750049;5766.971165144148;5784;5784.305883294031;5784.595078344475;5789.8263052108505;5835.124731290341;5919.437653422918;5960.254968128984;5974.492168165754;5991.910121348096;5755.079187330174;5774.249347584787;5775.566832487664;5776.826695199151;5799.159121927381;5870.911936321044;5876.647401155773;5884.941150588439;5889.204957330706;5911.290645122613;5524.447555244444;5577.553795696415;5616.438356164351;5639.492445679908;5648.745806438638;5473.753681084281;5612.691301978431;5624.718764061862;5626.85932851682;5643.097104463266;5551.139573366135;5564.666120032811;5564.888702226014;5568.888622227451;5614.9719251403485;5590.832275031756;5634.380218176079;5684.147377893184;5722.113072473773;5722.713864306685;5579.721013949205;5620.578456615688;5624.550035997192;5629.324481062299;5629.887402252014 06:03:05 INFO - PROCESS | 17704 | |1;ext.html;573.4924591736312;603.2700432476703;608.770284026267;634.1090767471702;637.4135795068537;39699;42922;43070.99999999996;43075.569244307546;43136;43519;43929.12141757171;44015.55984440155;44100.3384949226;44231.55768442315;8762.342824288173;8808;8876.733697989072;8888.111188881125;8921.509316987564;8626.439281446717;8708.129187081304;8723.738287851344;8726.214640682338;8751.3436492263;8817.29461643067;8851.77870553238;8877.46735195887;8879;8895.822083558325;8819.426737262058;8839.425437346616;8844.38089333747;8889.066648001964;8891.288696904232;8755.912440875574;8845.159709827556;8849.247813935823;8858.114188581154;8865.778355541099;39551.20897582061;40024.59975400238;40170.39744403836;40284.194316113804;40514.59485405138;2810.271891322922;3388;3452.2922800825772;3492.9301413971834;3522;31154.221144471343;31260.531092033638;31330.843345783353;31653;32510.674893251;4145.046639272954;4146.232946904832;4149.6265336119595;4151.294279972381;4323.502797178302;293561.0643893555;294546;295035;295509;298230;34313.14217144541;34397.48403773946;34452;34453.655463445546;35787.4631880522;36476;36493.817530912704;36630.81684591613;36647.81676091656;36702.8164859174;15428.614284642974;15440.768388474182;15519.991200571927;15538.766918496232;15550;13042.608721738363;13116.409761560753;13167.27579983091;13230.536931207362;13258.40337184829;8255;8297.8340433191;8349.248567628943;8370.8325833483;8385.790355241046;3203.279262165994;3219.4205043092;3232.7090561849545;3253.560769296115;3294.7199488043784;989.5200827598609;1010.1312870930993;1026.296986564191;1035.4977835749655;1093.6554985179644;32635.673643263737;32714.345713085604;32913.506297405555;32928.17679557982;33225.66774332274;1114.4483480676954;1119.4850368830266;1138.5445821671233;1169.3393232823598;1190.3036723516839;16816.579585510215;17212.82787172112;17213.827861721475;17227.82772172287;17265.482035538953;554190;602334;607475;610738;613679;57736.422635773946;58171;58681;61331.693341533006;61638.69180654068;1406.2195481507656;1406.627243780399;1418.0215651200638;1432.8996970211986;1434.8421673616103;31399;34090.65909340875;34172.48741268833;34358;34431.31137377188;51175.744121280644;51462.684179211275;51503.227451589;51828.74085629548;51854.22218666798;466423;466956;471953.96322258486;472228;474437;44613.10773784571;44940.55059449495;45056.549434505236;45839.08321833478;46163.30755038744;48969.2654610174;49235.75382123067;49376.75311623419;50639.746801265755;50677.49322506728;41350.37974430326;41700.58299416967;42218.155636887706;42729;43003;40957.33052447497;41310.38034429426;41422.58577414187;42059;42156.57843421649;41344;41893.58106418897;42000.789996049825;42419.7879010603;42858.571414285456;35842.64157358497;38183.236335273694;38426.23147536978;39178.6082139175;39308.03459827055;28473.572896406156;28765;28819.855900721202;28847.717850554152;29073.273168170967 06:03:05 INFO - PROCESS | 17704 | |2;jquery.html;378.60814057450534;380.5927657406575;388.10154492350205;405.55794184339067;405.963463288304;18408;20299.391018269438;20384;20409.897950510265;20453.590928181427;18779;18875.433736987878;19537.804621953775;19552.92458914759;19649.607007859835;5609.691466969305;5699.886002279952;5754.539636829044;5766.654000759968;5810.157527158581;5550.306211723535;5604.8318550443555;5661.264035675356;5676.914846277309;5676.92138493687;5399.865003374927;5662.17898404731;5664.971675141639;5698.344690360599;5706.058500347438;5731.083026715705;5737.39757325479;5763.942360576382;5829.5044921181325;5854.063349864023;5611.158326251054;5623.465770751813;5626.352969408529;5630.831075067755;5642.6614403135945;13792.586222413243;16168.11075390853;21434.24980125688;22957.311280661608;22964.540709185723;2246.1127854497545;2250.5836420262303;2263.7283525976986;2311.526137141882;2401.3156250468533;9576.712698619052;9728.610855565768;9903.653372131941;10211.948940255252;14607.196604186765;1912.4358314297315;1957.5791204890875;1974.6445639784833;1993.9202431902706;2037.7758446570865;52970.906563399934;78877.60561197158;79826;79834;80531.5973420135;10299.948500257451;10488.73778155537;10565.260431769857;10571.62999295021;10610.204234682275;14805;15139.318730657147;15179.544613661608;15200.239988000776;15237;7783.532988020737;7884.881726774103;7929.444938854225;7930.722424715223;8120.878186827203;7594.696212151452;7709.807254818562;7710.884336734954;7765.72819951299;7775.533467991939;4523.105212663898;4560.019595786922;4704.9529504704515;4708.364370809897;4752.738599377068;1932.6424611446928;1963.577830766392;1983.9008049597462;1990;2035.6844689073218;931.0828833598899;945.2957546627669;998.6404894238068;1013.4679293371039;1016.1565900302879;18955.431337059912;18973.33593324227;19632.411027669194;19763.802361976483;20315;962.5908988679784;972.4262685015875;978.6232300564334;1005.2561104782409;1006.3609607899036;10528.157747380192;10658.467076646137;10925.289856159325;11015.449227538591;11076.169287303484;438071;451714;488207;500943;504404;73266.63366683133;96684.51657741667;99831;100708.49645751725;101681;1028.783955369366;1047.450088703437;1048.8741351037925;1059.8940105989338;1062.7980683670232;17413.303467861144;17568.472945811645;18082.367117150836;18142.183601738216;18171.818281817013;41317.793411033956;43415;43639.781801090794;44446.333304999804;44583.999999998705;58718.41281587129;59073.40926590679;63955.680221598595;64165.67917160384;64477.677611611645;8431.831363372576;8449.02836173848;8533.701320454004;8593.355498337525;8778.604962776819;9483.952580237055;13376.398062087424;13576.660583485493;13720.65698357549;13922.930385348414;9794.21646268311;9886.456244906312;11167.441627918734;11304.265222760494;11456.82814757796;10240.334378265687;11184.105271578417;11518.94240528792;11787.882121178678;11874;11611.361375124448;11770.58802941893;11928.940355298168;12107.152499324962;12115.939420302842;8341.45780524264;8345.916540834514;8604.65581376763;8708;8923.955380223057;11738;11776.234544754563;11955.820662689892;12030.338331391857;12032.75934481323 06:03:05 INFO - PROCESS | 17704 | |3;mootools.html;1473.0719646622629;1484.510111663151;1576.5979675182834;1717.5448506145865;1719.1404297851066;7128.536645118077;8166.59167041647;8313.41806073575;8866.645334186633;8886.644534218623;8489;8534.530600816952;8592.957035214831;8597.871031934526;8605.182507661777;2193.3419974007816;2229.8104661103825;2233.519793244452;2236;2238.8432809703327;2253.695751073609;2266.3427605994243;2271.341311019802;2275.419767959168;2289.6222123349626;2205.195103787114;2243.4839986803045;2245.7305123385136;2253.4253765289827;2280.6921065656175;2194.0455901682817;2194.7914948079906;2194.967075493869;2210.999999999992;2221.1226565506695;2221.6556433752635;2271.7841805028497;2278.8746618936116;2279.452931296477;2282.08716513396;8521.57392130391;8556.74329770108;8591.3556483264;8605.225529702295;8681.435706679045;4923.606111511071;4951.801927922915;4973.179425394842;5025.899482010339;5030.773615187325;3162.478191098466;3203.9038828835173;3301.0756988043145;3318.4026875162463;3367.562216911786;1047.0994944347856;1047.994760026195;1066.2003497376968;1072.1583556907867;1079.0234837472021;11292.378919159524;11312.717182070513;11355.489002994886;11400.25898316615;11406.31562106268;4349.956500435019;4356.433663623772;4401.163778882003;4430.911381772346;4449.132419178294;9732.610695572239;9738.074882886114;9739.805203896025;9759.756006099904;9771.853422198672;5012.799488020439;5070.645054846199;5078.949210507922;5079.593632509391;5085.440601533828;4220.620144187038;4598.241290187082;4673.252279635242;4685.461171965199;4766.761661916959;3819.3316169670197;3879.0690234343556;3961.4057891315956;4008.8596899108393;4036.253293140778;1228.0789407944042;1239.2688313894846;1239.7706424311532;1242.105683907585;1259.137490818792;938.77000134966;942.0673533202081;950.2160717408166;952.3904700991371;963.710886733977;5506.284183056177;5565.471280228372;5687.260656114761;5930.525557955353;5978.790742323998;439.85264936246074;452.2853890852511;454.8112533298644;457.91757483652594;465.4159030416805;4066.532348779869;4106.527749308808;4146.5024197096545;4149.419081328617;4183.330667093251;10101.848472272923;10597.84103238452;10669.466526673636;10693.144548436107;10701.304415212986;10392.688219353431;10407.53166107527;10424.374537527772;10433.686989390331;10468.842967355344;7727.92272077272;7777.922220777833;7805.37556995439;7853.253940875607;7951.363890888831;5903.704814759159;5941.554383421347;5975.193348898017;5980.491658208927;6102.023676211785;9479.810403792024;9631.71104866855;9828.754281143028;9895.604175832887;9901.851472228067;9464.716058518256;9791.804163916539;9800.852987205055;9851.753706157404;9912.306138570519;7068.787936361918;7710.460267781202;7717.691292348243;7737.381009519338;7842.372610191057;8269.917300826915;8279.544625045439;8328.791780205544;8349.83300334002;8369.330453563822;7572.545647261182;7604.505707129019;7617.961910190414;7845.764627061198;7933.048034235929;7431.256874312526;7477.476576639583;7556.924430755622;7636.80907977305;7763.340116089969;6551.377619126175;6660.467162627075;6693.732250709917;6707.966460167668;6732.225794033749;4943.7033777972;4949.554540091409;5064.41759197697;5079.974600126976;5139.743012849417;4899.093667671492;5046.318746969112;5070.543651071422;5092.439831618593;5111.846644600668 06:03:05 INFO - PROCESS | 17704 | |4;prototype.html;308.2294264339152;311.834727594375;313.4811886328128;314.5941735161642;315.298460924443;5471.863203419916;5552.500274975251;5644.520215781658;5648.01159797036;5662.942011313886;5484.2596249506305;5516.503514683678;5522.5760028782215;5616.438356164382;5644.379118296984;4235.597618226264;4289;4328.7402755834755;4334.869953901372;4339.327404252346;4245.877061469266;4263.4883813942215;4264.616184543391;4280.229558679436;4280.807363668627;4206.915861682764;4235.915281694364;4254.383114448403;4270.444842170514;4275.337322714984;4013.5986401359924;4080.449139366207;4197;4255.468066491689;4306.289462238727;3625.7099432045375;3629.165291982859;3633.4739409448093;3655;3661.963380366189;5374.140137577969;5381.13901775714;5405.2973313406155;5410.864728381822;5435.809746658848;4681.344611754357;4806.879828004293;4837.129316722989;4851.320815085891;4889.119958407486;5727.339071669211;5732.3407808101765;5773.307203135609;5790.913136302959;5796.304443466769;4067.3695577185586;4090.836366545335;4096.651784598283;4125.092479654471;4132.202491916026;5769.798057068025;6014.819555413301;6041.637501749865;6054.303755068179;6158.56890017699;4053.9594604054173;4090.1615168890307;4102.666633344175;4117.094239267356;4123.587641235852;4080.285949958805;4120.75275483472;4143.709940304149;4149.149424367997;4176.791160441966;4521.547845215518;4755.548222918817;4854.466008739036;4868.367112275381;4868.440129385166;5820.854478638068;5821.505172060338;5833.5707751600285;5851.561132914963;5881.911771323434;1408.204364534035;1429.0568224971469;1431.191376872064;1437.9928100359432;1440.1934916446824;866.8531181819478;896.8251590416576;899.5232526760827;908.255230710824;920.1350730313484;4919.3358896549225;5004.224345226496;5011.949880501221;5052.57053150479;5084.059449001947;5207.244949482304;5244.816431424882;5296.443873393316;5335.386430560535;5337.839864804062;5010.622078928324;5010.624203184776;5017.37282839645;5320.946790532045;5686.886262274731;3194.9041528754174;3197.648258691542;3230.967690323114;3242.400155971153;3252.8210948398064;6131.080337949344;6267.310595834455;6267.9373206268265;6319.399657032574;6324.450509625171;6147.44672979425;6150.538709596709;6150.938490615036;6155.599886007395;6224.75504899013;6147.323794382614;6203.4416902479;6222.160008398808;6240.344763799826;6244.219472565929;5694.572907031907;5942.881142377215;5977.758340622267;6002.849928751816;6021.307549631673;5920.230370051866;5946;5962.731677074456;5964.7912323068485;5979.5814292999075;6017.157597936205;6180.907286390798;6232.25212974446;6252.374762523711;6283.622982621057;4032.2338755636333;4051.432799408144;4072.6945479088595;4074.307367747431;4077.4699289092227;5974.7453034863165;5988.293336399105;6020.668863212565;6028.698565071817;6052.182955300978;5604.495595396434;5820.952228598893;5828.883422331445;5845.327787304344;5905.372109411443;5821.214136091573;5829.892320459099;5848;5852.7658893643775;5865.530757539302;5308.840734777963;5799.681017544076;5800.24596802413;5804.593678442638;5823.767049317979;5861.706914654335;5868.823935281948;5920.970395147997;5942.286925568959;5953.880922381441;5672.43275672446;5728.942710573007;5744.827655170351;5788.21859049023;5795.942040579709 06:03:05 INFO - PROCESS | 17704 | |5;yui.html;664.9468042556593;716.0619588339273;717.6519388096772;734.5739471106758;734.742840005998;14507.782383264246;15186.544403667907;15400.61498462539;15407.075575465451;15415;15242.390304387838;15401;15424.691506169898;15441.69116617667;15478.148701821423;768.3584207187006;781.6716978868875;792.9524228546277;797.5214871077366;807.2734538914965;810.9837803243931;811.4441607498852;811.5739236900615;811.8213992921577;813.7762115418278;838;841.7727213652311;843.8692002739585;844.9873251901226;846.124261389459;839.6851180807197;840.7309660908512;841.6296829395108;843.4264700003995;844.6325848255967;607.7933502609134;613.1783410230269;615.1111643674892;616.165096294519;616.6577549460048;14928.402863885432;14929.104253744701;14949.551513454613;14968.401263949429;15034.699306013928;14480.855191448161;14768.778468322984;14905.925470372687;14999.475018374305;15107.169105699182;12191.39043047853;12376.62870113898;12396.690082747913;12654;12953.158044727063;3949.3483575210057;3968.4245784361397;3972.8410863565423;4107.732997355162;4125.278076336629;75611;77245;77806.22193778046;77882;79646;11488.770224595628;11490.253133546294;11646.825297620542;11718.355490447937;12007.03943684503;21014.159433622484;21066.157353705985;21143.682844757343;21228.78771212299;21391;7923.801904952422;7958.602069896482;8372.246497815104;8509.787255318666;8762.299016078698;4767.952320476751;4867.634927380461;4871.585915197248;4926.58124059459;5053.317802096743;3350.3801796667694;3453.6546345365264;3471.5834099908175;3474.3225071111397;3474.6004209515722;568.8947544704243;585.689584520205;585.9803941142382;597.1132867691475;601.4977493792645;687.965601719912;724.2974314914629;732.3884556395363;735.2353552305542;740.2449501508431;9677.37097088687;10034.849477257847;10085.69742907714;10134.215811848664;10140.645077422254;725.1117381208084;729.8905164225408;737.4469148138896;738.0810890441328;741.1328745367932;4734.479207287196;4863.003084367696;4926.8768280793265;4944.233643785219;4987.518721917124;110495;115490.4225478884;117146.41426792982;117854;119280.40359798145;95833.52083239538;97085;97868;98442.5077874606;98559;83118;84061;84770.57614711887;86157.56921215354;88762;9085;9089.954550227207;9197.446533694276;9254.444733316022;9288.489133097473;49964;50104.49895501144;50354.244686329;50963.177761667284;51971;43310.350344745486;43494.13011739684;44328;73128.26871731428;75988;12047.638570842888;12082.154249202471;12229.3273869938;12263.93868030654;12399.194052386567;12257.325847078497;12980.415881285177;13530.797038044635;13615.18308901469;13907.58277251684;12684.682882927631;12767.361631918182;13187.802182967454;13196.538121165713;13412.731745364843;11712.70718232051;11734.589289374831;12304.692382690146;12502.374881256083;12626.494940202288;12051.698707532381;12339.444724987578;12343.629691109281;12438.875611243771;12544.87455125437;10096.899031009889;10423;10566.31318964265;10583.047525722723;10606.946965265124;9697.224222062077;9929.602815887283;10625;10692.358458492516;10769 06:03:05 INFO - PROCESS | 17704 | __end_tp_report 06:03:05 INFO - PROCESS | 17704 | __start_cc_report 06:03:05 INFO - PROCESS | 17704 | _x_x_mozilla_cycle_collect,356 06:03:05 INFO - PROCESS | 17704 | __end_cc_report 06:03:05 INFO - PROCESS | 17704 | __startTimestamp1467118985869__endTimestamp 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | ------- Summary: start ------- 06:03:05 INFO - PROCESS | 17704 | Number of tests: 6 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | [#0] dojo.html Cycles:165 Average:5383.25 Median:5588.89 stddev:625.87 (11.2%) stddev-sans-first:600.66 06:03:05 INFO - PROCESS | 17704 | Values: 3059.7 3082.8 3100.4 3109.5 3120.9 5314.2 5345.5 5376.1 5424.6 5424.9 5346.0 5362.5 5424.5 5459.8 5521.3 4841.6 4874.8 4919.6 5018.9 5022.9 4882.0 5004.0 5050.5 5051.8 5052.4 4848.1 4871.5 4874.2 4894.4 4981.4 4913.1 4913.8 4917.7 4926.7 4931.2 4837.6 4870.2 4883.8 4920.9 4935.2 5285.2 5345.6 5381.5 5427.0 5443.9 5829.4 5867.2 5871.0 5877.5 5881.5 5918.4 5921.6 5921.6 5921.7 5924.5 5330.2 5453.2 5499.8 5505.6 5512.1 5960.3 5972.3 5978.5 5981.6 5994.4 5558.4 5760.6 5773.3 5780.2 5784.7 5683.4 5687.9 5737.7 5747.9 5764.1 5589.5 5593.3 5708.7 5731.7 5749.9 5685.4 5721.5 5731.5 5735.3 5739.7 4313.5 4333.4 4340.4 4383.2 4386.2 3904.9 3912.8 3915.0 3947.4 3953.7 5482.8 5518.1 5533.6 5556.9 5567.8 5785.0 5807.6 5846.1 5890.9 5947.5 5546.7 5569.4 5586.3 5588.9 5597.6 4884.5 4915.1 4953.6 4989.5 5038.5 5958.4 5966.0 6007.4 6036.0 6093.8 5767.0 5784.0 5784.3 5784.6 5789.8 5835.1 5919.4 5960.3 5974.5 5991.9 5755.1 5774.2 5775.6 5776.8 5799.2 5870.9 5876.6 5884.9 5889.2 5911.3 5524.4 5577.6 5616.4 5639.5 5648.7 5473.8 5612.7 5624.7 5626.9 5643.1 5551.1 5564.7 5564.9 5568.9 5615.0 5590.8 5634.4 5684.1 5722.1 5722.7 5579.7 5620.6 5624.6 5629.3 5629.9 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | [#1] ext.html Cycles:180 Average:60322.21 Median:4145.64 stddev:125723.31 (3032.7%) stddev-sans-first:125995.97 06:03:05 INFO - PROCESS | 17704 | Values: 573.5 603.3 608.8 634.1 637.4 39699.0 42922.0 43071.0 43075.6 43136.0 43519.0 43929.1 44015.6 44100.3 44231.6 8762.3 8808.0 8876.7 8888.1 8921.5 8626.4 8708.1 8723.7 8726.2 8751.3 8817.3 8851.8 8877.5 8879.0 8895.8 8819.4 8839.4 8844.4 8889.1 8891.3 8755.9 8845.2 8849.2 8858.1 8865.8 39551.2 40024.6 40170.4 40284.2 40514.6 2810.3 3388.0 3452.3 3492.9 3522.0 31154.2 31260.5 31330.8 31653.0 32510.7 4145.0 4146.2 4149.6 4151.3 4323.5 293561.1 294546.0 295035.0 295509.0 298230.0 34313.1 34397.5 34452.0 34453.7 35787.5 36476.0 36493.8 36630.8 36647.8 36702.8 15428.6 15440.8 15520.0 15538.8 15550.0 13042.6 13116.4 13167.3 13230.5 13258.4 8255.0 8297.8 8349.2 8370.8 8385.8 3203.3 3219.4 3232.7 3253.6 3294.7 989.5 1010.1 1026.3 1035.5 1093.7 32635.7 32714.3 32913.5 32928.2 33225.7 1114.4 1119.5 1138.5 1169.3 1190.3 16816.6 17212.8 17213.8 17227.8 17265.5 554190.0 602334.0 607475.0 610738.0 613679.0 57736.4 58171.0 58681.0 61331.7 61638.7 1406.2 1406.6 1418.0 1432.9 1434.8 31399.0 34090.7 34172.5 34358.0 34431.3 51175.7 51462.7 51503.2 51828.7 51854.2 466423.0 466956.0 471954.0 472228.0 474437.0 44613.1 44940.6 45056.5 45839.1 46163.3 48969.3 49235.8 49376.8 50639.7 50677.5 41350.4 41700.6 42218.2 42729.0 43003.0 40957.3 41310.4 41422.6 42059.0 42156.6 41344.0 41893.6 42000.8 42419.8 42858.6 35842.6 38183.2 38426.2 39178.6 39308.0 28473.6 28765.0 28819.9 28847.7 29073.3 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | [#2] jquery.html Cycles:180 Average:28573.17 Median:379.60 stddev:78850.86 (20772.1%) stddev-sans-first:79043.64 06:03:05 INFO - PROCESS | 17704 | Values: 378.6 380.6 388.1 405.6 406.0 18408.0 20299.4 20384.0 20409.9 20453.6 18779.0 18875.4 19537.8 19552.9 19649.6 5609.7 5699.9 5754.5 5766.7 5810.2 5550.3 5604.8 5661.3 5676.9 5676.9 5399.9 5662.2 5665.0 5698.3 5706.1 5731.1 5737.4 5763.9 5829.5 5854.1 5611.2 5623.5 5626.4 5630.8 5642.7 13792.6 16168.1 21434.2 22957.3 22964.5 2246.1 2250.6 2263.7 2311.5 2401.3 9576.7 9728.6 9903.7 10211.9 14607.2 1912.4 1957.6 1974.6 1993.9 2037.8 52970.9 78877.6 79826.0 79834.0 80531.6 10299.9 10488.7 10565.3 10571.6 10610.2 14805.0 15139.3 15179.5 15200.2 15237.0 7783.5 7884.9 7929.4 7930.7 8120.9 7594.7 7709.8 7710.9 7765.7 7775.5 4523.1 4560.0 4705.0 4708.4 4752.7 1932.6 1963.6 1983.9 1990.0 2035.7 931.1 945.3 998.6 1013.5 1016.2 18955.4 18973.3 19632.4 19763.8 20315.0 962.6 972.4 978.6 1005.3 1006.4 10528.2 10658.5 10925.3 11015.4 11076.2 438071.0 451714.0 488207.0 500943.0 504404.0 73266.6 96684.5 99831.0 100708.5 101681.0 1028.8 1047.5 1048.9 1059.9 1062.8 17413.3 17568.5 18082.4 18142.2 18171.8 41317.8 43415.0 43639.8 44446.3 44584.0 58718.4 59073.4 63955.7 64165.7 64477.7 8431.8 8449.0 8533.7 8593.4 8778.6 9484.0 13376.4 13576.7 13720.7 13922.9 9794.2 9886.5 11167.4 11304.3 11456.8 10240.3 11184.1 11518.9 11787.9 11874.0 11611.4 11770.6 11928.9 12107.2 12115.9 8341.5 8345.9 8604.7 8708.0 8924.0 11738.0 11776.2 11955.8 12030.3 12032.8 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | [#3] mootools.html Cycles:180 Average:5594.95 Median:4992.99 stddev:3164.85 (63.4%) stddev-sans-first:3158.57 06:03:05 INFO - PROCESS | 17704 | Values: 1473.1 1484.5 1576.6 1717.5 1719.1 7128.5 8166.6 8313.4 8866.6 8886.6 8489.0 8534.5 8593.0 8597.9 8605.2 2193.3 2229.8 2233.5 2236.0 2238.8 2253.7 2266.3 2271.3 2275.4 2289.6 2205.2 2243.5 2245.7 2253.4 2280.7 2194.0 2194.8 2195.0 2211.0 2221.1 2221.7 2271.8 2278.9 2279.5 2282.1 8521.6 8556.7 8591.4 8605.2 8681.4 4923.6 4951.8 4973.2 5025.9 5030.8 3162.5 3203.9 3301.1 3318.4 3367.6 1047.1 1048.0 1066.2 1072.2 1079.0 11292.4 11312.7 11355.5 11400.3 11406.3 4350.0 4356.4 4401.2 4430.9 4449.1 9732.6 9738.1 9739.8 9759.8 9771.9 5012.8 5070.6 5078.9 5079.6 5085.4 4220.6 4598.2 4673.3 4685.5 4766.8 3819.3 3879.1 3961.4 4008.9 4036.3 1228.1 1239.3 1239.8 1242.1 1259.1 938.8 942.1 950.2 952.4 963.7 5506.3 5565.5 5687.3 5930.5 5978.8 439.9 452.3 454.8 457.9 465.4 4066.5 4106.5 4146.5 4149.4 4183.3 10101.8 10597.8 10669.5 10693.1 10701.3 10392.7 10407.5 10424.4 10433.7 10468.8 7727.9 7777.9 7805.4 7853.3 7951.4 5903.7 5941.6 5975.2 5980.5 6102.0 9479.8 9631.7 9828.8 9895.6 9901.9 9464.7 9791.8 9800.9 9851.8 9912.3 7068.8 7710.5 7717.7 7737.4 7842.4 8269.9 8279.5 8328.8 8349.8 8369.3 7572.5 7604.5 7618.0 7845.8 7933.0 7431.3 7477.5 7556.9 7636.8 7763.3 6551.4 6660.5 6693.7 6708.0 6732.2 4943.7 4949.6 5064.4 5080.0 5139.7 4899.1 5046.3 5070.5 5092.4 5111.8 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | [#4] prototype.html Cycles:180 Average:4830.31 Median:5478.06 stddev:1461.69 (26.7%) stddev-sans-first:1425.83 06:03:05 INFO - PROCESS | 17704 | Values: 308.2 311.8 313.5 314.6 315.3 5471.9 5552.5 5644.5 5648.0 5662.9 5484.3 5516.5 5522.6 5616.4 5644.4 4235.6 4289.0 4328.7 4334.9 4339.3 4245.9 4263.5 4264.6 4280.2 4280.8 4206.9 4235.9 4254.4 4270.4 4275.3 4013.6 4080.4 4197.0 4255.5 4306.3 3625.7 3629.2 3633.5 3655.0 3662.0 5374.1 5381.1 5405.3 5410.9 5435.8 4681.3 4806.9 4837.1 4851.3 4889.1 5727.3 5732.3 5773.3 5790.9 5796.3 4067.4 4090.8 4096.7 4125.1 4132.2 5769.8 6014.8 6041.6 6054.3 6158.6 4054.0 4090.2 4102.7 4117.1 4123.6 4080.3 4120.8 4143.7 4149.1 4176.8 4521.5 4755.5 4854.5 4868.4 4868.4 5820.9 5821.5 5833.6 5851.6 5881.9 1408.2 1429.1 1431.2 1438.0 1440.2 866.9 896.8 899.5 908.3 920.1 4919.3 5004.2 5011.9 5052.6 5084.1 5207.2 5244.8 5296.4 5335.4 5337.8 5010.6 5010.6 5017.4 5320.9 5686.9 3194.9 3197.6 3231.0 3242.4 3252.8 6131.1 6267.3 6267.9 6319.4 6324.5 6147.4 6150.5 6150.9 6155.6 6224.8 6147.3 6203.4 6222.2 6240.3 6244.2 5694.6 5942.9 5977.8 6002.8 6021.3 5920.2 5946.0 5962.7 5964.8 5979.6 6017.2 6180.9 6232.3 6252.4 6283.6 4032.2 4051.4 4072.7 4074.3 4077.5 5974.7 5988.3 6020.7 6028.7 6052.2 5604.5 5821.0 5828.9 5845.3 5905.4 5821.2 5829.9 5848.0 5852.8 5865.5 5308.8 5799.7 5800.2 5804.6 5823.8 5861.7 5868.8 5921.0 5942.3 5953.9 5672.4 5728.9 5744.8 5788.2 5795.9 06:03:05 INFO - PROCESS | 17704 | 06:03:05 INFO - PROCESS | 17704 | [#5] yui.html Cycles:180 Average:20120.67 Median:4751.22 stddev:29275.94 (616.2%) stddev-sans-first:29321.62 06:03:05 INFO - PROCESS | 17704 | Values: 664.9 716.1 717.7 734.6 734.7 14507.8 15186.5 15400.6 15407.1 15415.0 15242.4 15401.0 15424.7 15441.7 15478.1 768.4 781.7 793.0 797.5 807.3 811.0 811.4 811.6 811.8 813.8 838.0 841.8 843.9 845.0 846.1 839.7 840.7 841.6 843.4 844.6 607.8 613.2 615.1 616.2 616.7 14928.4 14929.1 14949.6 14968.4 15034.7 14480.9 14768.8 14905.9 14999.5 15107.2 12191.4 12376.6 12396.7 12654.0 12953.2 3949.3 3968.4 3972.8 4107.7 4125.3 75611.0 77245.0 77806.2 77882.0 79646.0 11488.8 11490.3 11646.8 11718.4 12007.0 21014.2 21066.2 21143.7 21228.8 21391.0 7923.8 7958.6 8372.2 8509.8 8762.3 4768.0 4867.6 4871.6 4926.6 5053.3 3350.4 3453.7 3471.6 3474.3 3474.6 568.9 585.7 586.0 597.1 601.5 688.0 724.3 732.4 735.2 740.2 9677.4 10034.8 10085.7 10134.2 10140.6 725.1 729.9 737.4 738.1 741.1 4734.5 4863.0 4926.9 4944.2 4987.5 110495.0 115490.4 117146.4 117854.0 119280.4 95833.5 97085.0 97868.0 98442.5 98559.0 83118.0 84061.0 84770.6 86157.6 88762.0 9085.0 9090.0 9197.4 9254.4 9288.5 49964.0 50104.5 50354.2 50963.2 51971.0 43310.4 43494.1 44328.0 73128.3 75988.0 12047.6 12082.2 12229.3 12263.9 12399.2 12257.3 12980.4 13530.8 13615.2 13907.6 12684.7 12767.4 13187.8 13196.5 13412.7 11712.7 11734.6 12304.7 12502.4 12626.5 12051.7 12339.4 12343.6 12438.9 12544.9 10096.9 10423.0 10566.3 10583.0 10606.9 9697.2 9929.6 10625.0 10692.4 10769.0 06:03:05 INFO - PROCESS | 17704 | -------- Summary: end -------- 06:03:05 INFO - PROCESS | 17704 | 06:03:06 INFO - TEST-INFO | 17704: exit 0 06:03:06 INFO - TEST-OK | dromaeo_css | took 1111310ms 06:03:06 INFO - TEST-START | kraken 06:03:06 INFO - operating with platform_type : linux_ 06:03:06 INFO - Initialising browser for kraken test... 06:03:06 INFO - TEST-INFO | started process 17939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnxLEU/profile http://localhost:58985/getInfo.html) 06:03:11 INFO - PROCESS | 17939 | __metrics Screen width/height:1600/1200 06:03:11 INFO - PROCESS | 17939 | colorDepth:24 06:03:11 INFO - PROCESS | 17939 | Browser inner width/height: 1024/697 06:03:11 INFO - PROCESS | 17939 | __metrics 06:03:12 ERROR - PROCESS | 17939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 06:03:13 INFO - TEST-INFO | 17939: exit 0 06:03:13 INFO - Browser initialized. 06:03:13 INFO - Running cycle 1/1 for kraken test... 06:03:13 INFO - TEST-INFO | started process 18057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplnxLEU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:25 INFO - PROCESS | 18057 | RSS: Main: 185798656 06:03:25 INFO - PROCESS | 18057 | 06:03:27 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58985/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:28 INFO - PROCESS | 18057 | RSS: Main: 190984192 06:03:28 INFO - PROCESS | 18057 | 06:03:31 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58985/tests/kraken/driver.html?testName=audio-dft) 06:03:31 INFO - PROCESS | 18057 | RSS: Main: 190222336 06:03:31 INFO - PROCESS | 18057 | 06:03:34 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58985/tests/kraken/driver.html?testName=audio-fft) 06:03:35 INFO - PROCESS | 18057 | RSS: Main: 184856576 06:03:35 INFO - PROCESS | 18057 | 06:03:37 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58985/tests/kraken/driver.html?testName=audio-oscillator) 06:03:38 INFO - PROCESS | 18057 | RSS: Main: 185659392 06:03:38 INFO - PROCESS | 18057 | 06:03:40 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58985/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:41 INFO - PROCESS | 18057 | RSS: Main: 185794560 06:03:41 INFO - PROCESS | 18057 | 06:03:44 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58985/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:44 INFO - PROCESS | 18057 | RSS: Main: 186445824 06:03:44 INFO - PROCESS | 18057 | 06:03:48 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58985/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:48 INFO - PROCESS | 18057 | RSS: Main: 184545280 06:03:48 INFO - PROCESS | 18057 | 06:03:51 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58985/tests/kraken/driver.html?testName=json-parse-financial) 06:03:52 INFO - PROCESS | 18057 | RSS: Main: 184987648 06:03:52 INFO - PROCESS | 18057 | 06:03:54 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58985/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:54 INFO - PROCESS | 18057 | RSS: Main: 185212928 06:03:54 INFO - PROCESS | 18057 | 06:03:56 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:57 INFO - PROCESS | 18057 | RSS: Main: 185524224 06:03:57 INFO - PROCESS | 18057 | 06:03:59 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:59 INFO - PROCESS | 18057 | RSS: Main: 186404864 06:03:59 INFO - PROCESS | 18057 | 06:04:02 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:03 INFO - PROCESS | 18057 | RSS: Main: 186740736 06:04:03 INFO - PROCESS | 18057 | 06:04:05 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:06 INFO - PROCESS | 18057 | RSS: Main: 186204160 06:04:06 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | Cycle 1(1): loaded http://localhost:58985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58985/tests/kraken/driver.html?testName=ai-astar) 06:04:08 INFO - PROCESS | 18057 | RSS: Main: 187203584 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | __start_tp_report 06:04:08 INFO - PROCESS | 18057 | _x_x_mozilla_page_load 06:04:08 INFO - PROCESS | 18057 | _x_x_mozilla_page_load_details 06:04:08 INFO - PROCESS | 18057 | |i|pagename|runs| 06:04:08 INFO - PROCESS | 18057 | |0;ai-astar;105;111;104;110;111;111;114;112;111;109 06:04:08 INFO - PROCESS | 18057 | |1;audio-beat-detection;150;125;155;186;128;159;160;127;188;127 06:04:08 INFO - PROCESS | 18057 | |2;audio-dft;162;163;164;163;166;169;184;163;162;162 06:04:08 INFO - PROCESS | 18057 | |3;audio-fft;76;76;75;157;78;76;75;77;166;75 06:04:08 INFO - PROCESS | 18057 | |4;audio-oscillator;86;86;154;86;87;87;138;87;85;145 06:04:08 INFO - PROCESS | 18057 | |5;imaging-gaussian-blur;117;117;117;118;122;118;117;118;118;118 06:04:08 INFO - PROCESS | 18057 | |6;imaging-darkroom;147;147;148;147;146;147;148;149;147;148 06:04:08 INFO - PROCESS | 18057 | |7;imaging-desaturate;96;95;95;96;97;95;95;96;95;96 06:04:08 INFO - PROCESS | 18057 | |8;json-parse-financial;57;56;54;54;57;55;53;55;54;53 06:04:08 INFO - PROCESS | 18057 | |9;json-stringify-tinderbox;62;62;61;62;62;60;61;60;61;61 06:04:08 INFO - PROCESS | 18057 | |10;stanford-crypto-aes;79;79;79;80;79;79;80;81;98;80 06:04:08 INFO - PROCESS | 18057 | |11;stanford-crypto-ccm;125;126;126;126;125;131;124;128;139;127 06:04:08 INFO - PROCESS | 18057 | |12;stanford-crypto-pbkdf2;157;156;160;159;156;156;157;157;162;162 06:04:08 INFO - PROCESS | 18057 | |13;stanford-crypto-sha256-iterative;67;63;63;65;62;62;64;62;63;67 06:04:08 INFO - PROCESS | 18057 | __end_tp_report 06:04:08 INFO - PROCESS | 18057 | __start_cc_report 06:04:08 INFO - PROCESS | 18057 | _x_x_mozilla_cycle_collect,883 06:04:08 INFO - PROCESS | 18057 | __end_cc_report 06:04:08 INFO - PROCESS | 18057 | __startTimestamp1467119048265__endTimestamp 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | ------- Summary: start ------- 06:04:08 INFO - PROCESS | 18057 | Number of tests: 14 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.08 (2.8%) stddev-sans-first:2.74 06:04:08 INFO - PROCESS | 18057 | Values: 105.0 111.0 104.0 110.0 111.0 111.0 114.0 112.0 111.0 109.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:157.00 stddev:23.83 (15.2%) stddev-sans-first:25.27 06:04:08 INFO - PROCESS | 18057 | Values: 150.0 125.0 155.0 186.0 128.0 159.0 160.0 127.0 188.0 127.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#2] audio-dft Cycles:10 Average:165.80 Median:163.50 stddev:6.76 (4.1%) stddev-sans-first:7.03 06:04:08 INFO - PROCESS | 18057 | Values: 162.0 163.0 164.0 163.0 166.0 169.0 184.0 163.0 162.0 162.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.12 (47.5%) stddev-sans-first:37.78 06:04:08 INFO - PROCESS | 18057 | Values: 76.0 76.0 75.0 157.0 78.0 76.0 75.0 77.0 166.0 75.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:86.00 stddev:28.94 (33.6%) stddev-sans-first:29.94 06:04:08 INFO - PROCESS | 18057 | Values: 86.0 86.0 154.0 86.0 87.0 87.0 138.0 87.0 85.0 145.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.49 (1.3%) stddev-sans-first:1.54 06:04:08 INFO - PROCESS | 18057 | Values: 117.0 117.0 117.0 118.0 122.0 118.0 117.0 118.0 118.0 118.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 06:04:08 INFO - PROCESS | 18057 | Values: 147.0 147.0 148.0 147.0 146.0 147.0 148.0 149.0 147.0 148.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 06:04:08 INFO - PROCESS | 18057 | Values: 96.0 95.0 95.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.48 (2.7%) stddev-sans-first:1.33 06:04:08 INFO - PROCESS | 18057 | Values: 57.0 56.0 54.0 54.0 57.0 55.0 53.0 55.0 54.0 53.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.78 06:04:08 INFO - PROCESS | 18057 | Values: 62.0 62.0 61.0 62.0 62.0 60.0 61.0 60.0 61.0 61.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:5.87 (7.3%) stddev-sans-first:6.16 06:04:08 INFO - PROCESS | 18057 | Values: 79.0 79.0 79.0 80.0 79.0 79.0 80.0 81.0 98.0 80.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:126.50 stddev:4.42 (3.5%) stddev-sans-first:4.58 06:04:08 INFO - PROCESS | 18057 | Values: 125.0 126.0 126.0 126.0 125.0 131.0 124.0 128.0 139.0 127.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:2.39 (1.5%) stddev-sans-first:2.50 06:04:08 INFO - PROCESS | 18057 | Values: 157.0 156.0 160.0 159.0 156.0 156.0 157.0 157.0 162.0 162.0 06:04:08 INFO - PROCESS | 18057 | 06:04:08 INFO - PROCESS | 18057 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.93 (3.0%) stddev-sans-first:1.67 06:04:08 INFO - PROCESS | 18057 | Values: 67.0 63.0 63.0 65.0 62.0 62.0 64.0 62.0 63.0 67.0 06:04:08 INFO - PROCESS | 18057 | -------- Summary: end -------- 06:04:08 INFO - PROCESS | 18057 | 06:04:09 INFO - TEST-INFO | 18057: exit 0 06:04:09 INFO - TEST-OK | kraken | took 62601ms 06:04:09 INFO - SUITE-END | took 1173s 06:04:09 INFO - Completed test suite (00:19:34) 06:04:09 INFO - javascript benchmark 06:04:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7136.760657258954, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.7246247837697, 3082.7996180248297, 3100.4264211120944, 3109.471389863723, 3120.9063728088167, 5314.176302673082, 5345.465453454657, 5376.11294136467, 5424.620276580641, 5424.945750542493, 5345.973270133653, 5362.544183744377, 5424.5117939385445, 5459.808906688267, 5521.337439507255, 4841.588464980472, 4874.780634871439, 4919.557239848413, 5018.924716129261, 5022.899542009158, 4882.0, 5004.024215278022, 5050.46970068143, 5051.7726702298305, 5052.368453943257, 4848.127337079324, 4871.537203965618, 4874.2201247800185, 4894.363732714742, 4981.352424184851, 4913.115639184945, 4913.828016019422, 4917.704937703749, 4926.679765815211, 4931.186354251544, 4837.588804951583, 4870.172070747982, 4883.780229889663, 4920.876978075541, 4935.185694360426, 5285.180796976475, 5345.625806193568, 5381.515663590257, 5427.0, 5443.918341224885, 5829.446202610745, 5867.178594996704, 5871.0, 5877.471027607493, 5881.500072493843, 5918.40815918409, 5921.644701317935, 5921.644701317935, 5921.674307913063, 5924.5260379169995, 5330.227117068003, 5453.15476101201, 5499.807506737245, 5505.559555235612, 5512.062949298589, 5960.314563825129, 5972.283326000907, 5978.491828194565, 5981.611195272293, 5994.37059108796, 5558.416366281563, 5760.6255593386295, 5773.336066352339, 5780.1907732917425, 5784.681842498703, 5683.403242659544, 5687.914681279784, 5737.684427356536, 5747.942520574741, 5764.13537969308, 5589.469000444951, 5593.300837395325, 5708.743106560215, 5731.742071606787, 5749.88500229993, 5685.403032681592, 5721.456461636138, 5731.541476681856, 5735.340435849847, 5739.713014349266, 4313.525512193656, 4333.436653235122, 4340.435743353407, 4383.189110014658, 4386.232409328419, 3904.90237744053, 3912.8239229234755, 3915.040815000343, 3947.4276229946495, 3953.743006704555, 5482.835514934558, 5518.089515229942, 5533.6403133796175, 5556.861078473071, 5567.832965011056, 5784.971075144682, 5807.5644326675665, 5846.093855452412, 5890.852728681817, 5947.464728174485, 5546.667199968015, 5569.387367389584, 5586.301712285965, 5588.888222235532, 5597.608167428322, 4884.535969082932, 4915.139850526144, 4953.628477864175, 4989.501049895054, 5038.470960549163, 5958.433948774859, 5966.0, 6007.36922623127, 6036.0, 6093.756249750049, 5766.971165144148, 5784.0, 5784.305883294031, 5784.595078344475, 5789.8263052108505, 5835.124731290341, 5919.437653422918, 5960.254968128984, 5974.492168165754, 5991.910121348096, 5755.079187330174, 5774.249347584787, 5775.566832487664, 5776.826695199151, 5799.159121927381, 5870.911936321044, 5876.647401155773, 5884.941150588439, 5889.204957330706, 5911.290645122613, 5524.447555244444, 5577.553795696415, 5616.438356164351, 5639.492445679908, 5648.745806438638, 5473.753681084281, 5612.691301978431, 5624.718764061862, 5626.85932851682, 5643.097104463266, 5551.139573366135, 5564.666120032811, 5564.888702226014, 5568.888622227451, 5614.9719251403485, 5590.832275031756, 5634.380218176079, 5684.147377893184, 5722.113072473773, 5722.713864306685, 5579.721013949205, 5620.578456615688, 5624.550035997192, 5629.324481062299, 5629.887402252014], "value": 5339.706998996244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4924591736312, 603.2700432476703, 608.770284026267, 634.1090767471702, 637.4135795068537, 39699.0, 42922.0, 43070.99999999996, 43075.569244307546, 43136.0, 43519.0, 43929.12141757171, 44015.55984440155, 44100.3384949226, 44231.55768442315, 8762.342824288173, 8808.0, 8876.733697989072, 8888.111188881125, 8921.509316987564, 8626.439281446717, 8708.129187081304, 8723.738287851344, 8726.214640682338, 8751.3436492263, 8817.29461643067, 8851.77870553238, 8877.46735195887, 8879.0, 8895.822083558325, 8819.426737262058, 8839.425437346616, 8844.38089333747, 8889.066648001964, 8891.288696904232, 8755.912440875574, 8845.159709827556, 8849.247813935823, 8858.114188581154, 8865.778355541099, 39551.20897582061, 40024.59975400238, 40170.39744403836, 40284.194316113804, 40514.59485405138, 2810.271891322922, 3388.0, 3452.2922800825772, 3492.9301413971834, 3522.0, 31154.221144471343, 31260.531092033638, 31330.843345783353, 31653.0, 32510.674893251, 4145.046639272954, 4146.232946904832, 4149.6265336119595, 4151.294279972381, 4323.502797178302, 293561.0643893555, 294546.0, 295035.0, 295509.0, 298230.0, 34313.14217144541, 34397.48403773946, 34452.0, 34453.655463445546, 35787.4631880522, 36476.0, 36493.817530912704, 36630.81684591613, 36647.81676091656, 36702.8164859174, 15428.614284642974, 15440.768388474182, 15519.991200571927, 15538.766918496232, 15550.0, 13042.608721738363, 13116.409761560753, 13167.27579983091, 13230.536931207362, 13258.40337184829, 8255.0, 8297.8340433191, 8349.248567628943, 8370.8325833483, 8385.790355241046, 3203.279262165994, 3219.4205043092, 3232.7090561849545, 3253.560769296115, 3294.7199488043784, 989.5200827598609, 1010.1312870930993, 1026.296986564191, 1035.4977835749655, 1093.6554985179644, 32635.673643263737, 32714.345713085604, 32913.506297405555, 32928.17679557982, 33225.66774332274, 1114.4483480676954, 1119.4850368830266, 1138.5445821671233, 1169.3393232823598, 1190.3036723516839, 16816.579585510215, 17212.82787172112, 17213.827861721475, 17227.82772172287, 17265.482035538953, 554190.0, 602334.0, 607475.0, 610738.0, 613679.0, 57736.422635773946, 58171.0, 58681.0, 61331.693341533006, 61638.69180654068, 1406.2195481507656, 1406.627243780399, 1418.0215651200638, 1432.8996970211986, 1434.8421673616103, 31399.0, 34090.65909340875, 34172.48741268833, 34358.0, 34431.31137377188, 51175.744121280644, 51462.684179211275, 51503.227451589, 51828.74085629548, 51854.22218666798, 466423.0, 466956.0, 471953.96322258486, 472228.0, 474437.0, 44613.10773784571, 44940.55059449495, 45056.549434505236, 45839.08321833478, 46163.30755038744, 48969.2654610174, 49235.75382123067, 49376.75311623419, 50639.746801265755, 50677.49322506728, 41350.37974430326, 41700.58299416967, 42218.155636887706, 42729.0, 43003.0, 40957.33052447497, 41310.38034429426, 41422.58577414187, 42059.0, 42156.57843421649, 41344.0, 41893.58106418897, 42000.789996049825, 42419.7879010603, 42858.571414285456, 35842.64157358497, 38183.236335273694, 38426.23147536978, 39178.6082139175, 39308.03459827055, 28473.572896406156, 28765.0, 28819.855900721202, 28847.717850554152, 29073.273168170967], "value": 19019.091003497695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.60814057450534, 380.5927657406575, 388.10154492350205, 405.55794184339067, 405.963463288304, 18408.0, 20299.391018269438, 20384.0, 20409.897950510265, 20453.590928181427, 18779.0, 18875.433736987878, 19537.804621953775, 19552.92458914759, 19649.607007859835, 5609.691466969305, 5699.886002279952, 5754.539636829044, 5766.654000759968, 5810.157527158581, 5550.306211723535, 5604.8318550443555, 5661.264035675356, 5676.914846277309, 5676.92138493687, 5399.865003374927, 5662.17898404731, 5664.971675141639, 5698.344690360599, 5706.058500347438, 5731.083026715705, 5737.39757325479, 5763.942360576382, 5829.5044921181325, 5854.063349864023, 5611.158326251054, 5623.465770751813, 5626.352969408529, 5630.831075067755, 5642.6614403135945, 13792.586222413243, 16168.11075390853, 21434.24980125688, 22957.311280661608, 22964.540709185723, 2246.1127854497545, 2250.5836420262303, 2263.7283525976986, 2311.526137141882, 2401.3156250468533, 9576.712698619052, 9728.610855565768, 9903.653372131941, 10211.948940255252, 14607.196604186765, 1912.4358314297315, 1957.5791204890875, 1974.6445639784833, 1993.9202431902706, 2037.7758446570865, 52970.906563399934, 78877.60561197158, 79826.0, 79834.0, 80531.5973420135, 10299.948500257451, 10488.73778155537, 10565.260431769857, 10571.62999295021, 10610.204234682275, 14805.0, 15139.318730657147, 15179.544613661608, 15200.239988000776, 15237.0, 7783.532988020737, 7884.881726774103, 7929.444938854225, 7930.722424715223, 8120.878186827203, 7594.696212151452, 7709.807254818562, 7710.884336734954, 7765.72819951299, 7775.533467991939, 4523.105212663898, 4560.019595786922, 4704.9529504704515, 4708.364370809897, 4752.738599377068, 1932.6424611446928, 1963.577830766392, 1983.9008049597462, 1990.0, 2035.6844689073218, 931.0828833598899, 945.2957546627669, 998.6404894238068, 1013.4679293371039, 1016.1565900302879, 18955.431337059912, 18973.33593324227, 19632.411027669194, 19763.802361976483, 20315.0, 962.5908988679784, 972.4262685015875, 978.6232300564334, 1005.2561104782409, 1006.3609607899036, 10528.157747380192, 10658.467076646137, 10925.289856159325, 11015.449227538591, 11076.169287303484, 438071.0, 451714.0, 488207.0, 500943.0, 504404.0, 73266.63366683133, 96684.51657741667, 99831.0, 100708.49645751725, 101681.0, 1028.783955369366, 1047.450088703437, 1048.8741351037925, 1059.8940105989338, 1062.7980683670232, 17413.303467861144, 17568.472945811645, 18082.367117150836, 18142.183601738216, 18171.818281817013, 41317.793411033956, 43415.0, 43639.781801090794, 44446.333304999804, 44583.999999998705, 58718.41281587129, 59073.40926590679, 63955.680221598595, 64165.67917160384, 64477.677611611645, 8431.831363372576, 8449.02836173848, 8533.701320454004, 8593.355498337525, 8778.604962776819, 9483.952580237055, 13376.398062087424, 13576.660583485493, 13720.65698357549, 13922.930385348414, 9794.21646268311, 9886.456244906312, 11167.441627918734, 11304.265222760494, 11456.82814757796, 10240.334378265687, 11184.105271578417, 11518.94240528792, 11787.882121178678, 11874.0, 11611.361375124448, 11770.58802941893, 11928.940355298168, 12107.152499324962, 12115.939420302842, 8341.45780524264, 8345.916540834514, 8604.65581376763, 8708.0, 8923.955380223057, 11738.0, 11776.234544754563, 11955.820662689892, 12030.338331391857, 12032.75934481323], "value": 9163.115010776113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.0719646622629, 1484.510111663151, 1576.5979675182834, 1717.5448506145865, 1719.1404297851066, 7128.536645118077, 8166.59167041647, 8313.41806073575, 8866.645334186633, 8886.644534218623, 8489.0, 8534.530600816952, 8592.957035214831, 8597.871031934526, 8605.182507661777, 2193.3419974007816, 2229.8104661103825, 2233.519793244452, 2236.0, 2238.8432809703327, 2253.695751073609, 2266.3427605994243, 2271.341311019802, 2275.419767959168, 2289.6222123349626, 2205.195103787114, 2243.4839986803045, 2245.7305123385136, 2253.4253765289827, 2280.6921065656175, 2194.0455901682817, 2194.7914948079906, 2194.967075493869, 2210.999999999992, 2221.1226565506695, 2221.6556433752635, 2271.7841805028497, 2278.8746618936116, 2279.452931296477, 2282.08716513396, 8521.57392130391, 8556.74329770108, 8591.3556483264, 8605.225529702295, 8681.435706679045, 4923.606111511071, 4951.801927922915, 4973.179425394842, 5025.899482010339, 5030.773615187325, 3162.478191098466, 3203.9038828835173, 3301.0756988043145, 3318.4026875162463, 3367.562216911786, 1047.0994944347856, 1047.994760026195, 1066.2003497376968, 1072.1583556907867, 1079.0234837472021, 11292.378919159524, 11312.717182070513, 11355.489002994886, 11400.25898316615, 11406.31562106268, 4349.956500435019, 4356.433663623772, 4401.163778882003, 4430.911381772346, 4449.132419178294, 9732.610695572239, 9738.074882886114, 9739.805203896025, 9759.756006099904, 9771.853422198672, 5012.799488020439, 5070.645054846199, 5078.949210507922, 5079.593632509391, 5085.440601533828, 4220.620144187038, 4598.241290187082, 4673.252279635242, 4685.461171965199, 4766.761661916959, 3819.3316169670197, 3879.0690234343556, 3961.4057891315956, 4008.8596899108393, 4036.253293140778, 1228.0789407944042, 1239.2688313894846, 1239.7706424311532, 1242.105683907585, 1259.137490818792, 938.77000134966, 942.0673533202081, 950.2160717408166, 952.3904700991371, 963.710886733977, 5506.284183056177, 5565.471280228372, 5687.260656114761, 5930.525557955353, 5978.790742323998, 439.85264936246074, 452.2853890852511, 454.8112533298644, 457.91757483652594, 465.4159030416805, 4066.532348779869, 4106.527749308808, 4146.5024197096545, 4149.419081328617, 4183.330667093251, 10101.848472272923, 10597.84103238452, 10669.466526673636, 10693.144548436107, 10701.304415212986, 10392.688219353431, 10407.53166107527, 10424.374537527772, 10433.686989390331, 10468.842967355344, 7727.92272077272, 7777.922220777833, 7805.37556995439, 7853.253940875607, 7951.363890888831, 5903.704814759159, 5941.554383421347, 5975.193348898017, 5980.491658208927, 6102.023676211785, 9479.810403792024, 9631.71104866855, 9828.754281143028, 9895.604175832887, 9901.851472228067, 9464.716058518256, 9791.804163916539, 9800.852987205055, 9851.753706157404, 9912.306138570519, 7068.787936361918, 7710.460267781202, 7717.691292348243, 7737.381009519338, 7842.372610191057, 8269.917300826915, 8279.544625045439, 8328.791780205544, 8349.83300334002, 8369.330453563822, 7572.545647261182, 7604.505707129019, 7617.961910190414, 7845.764627061198, 7933.048034235929, 7431.256874312526, 7477.476576639583, 7556.924430755622, 7636.80907977305, 7763.340116089969, 6551.377619126175, 6660.467162627075, 6693.732250709917, 6707.966460167668, 6732.225794033749, 4943.7033777972, 4949.554540091409, 5064.41759197697, 5079.974600126976, 5139.743012849417, 4899.093667671492, 5046.318746969112, 5070.543651071422, 5092.439831618593, 5111.846644600668], "value": 4415.737109481857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.2294264339152, 311.834727594375, 313.4811886328128, 314.5941735161642, 315.298460924443, 5471.863203419916, 5552.500274975251, 5644.520215781658, 5648.01159797036, 5662.942011313886, 5484.2596249506305, 5516.503514683678, 5522.5760028782215, 5616.438356164382, 5644.379118296984, 4235.597618226264, 4289.0, 4328.7402755834755, 4334.869953901372, 4339.327404252346, 4245.877061469266, 4263.4883813942215, 4264.616184543391, 4280.229558679436, 4280.807363668627, 4206.915861682764, 4235.915281694364, 4254.383114448403, 4270.444842170514, 4275.337322714984, 4013.5986401359924, 4080.449139366207, 4197.0, 4255.468066491689, 4306.289462238727, 3625.7099432045375, 3629.165291982859, 3633.4739409448093, 3655.0, 3661.963380366189, 5374.140137577969, 5381.13901775714, 5405.2973313406155, 5410.864728381822, 5435.809746658848, 4681.344611754357, 4806.879828004293, 4837.129316722989, 4851.320815085891, 4889.119958407486, 5727.339071669211, 5732.3407808101765, 5773.307203135609, 5790.913136302959, 5796.304443466769, 4067.3695577185586, 4090.836366545335, 4096.651784598283, 4125.092479654471, 4132.202491916026, 5769.798057068025, 6014.819555413301, 6041.637501749865, 6054.303755068179, 6158.56890017699, 4053.9594604054173, 4090.1615168890307, 4102.666633344175, 4117.094239267356, 4123.587641235852, 4080.285949958805, 4120.75275483472, 4143.709940304149, 4149.149424367997, 4176.791160441966, 4521.547845215518, 4755.548222918817, 4854.466008739036, 4868.367112275381, 4868.440129385166, 5820.854478638068, 5821.505172060338, 5833.5707751600285, 5851.561132914963, 5881.911771323434, 1408.204364534035, 1429.0568224971469, 1431.191376872064, 1437.9928100359432, 1440.1934916446824, 866.8531181819478, 896.8251590416576, 899.5232526760827, 908.255230710824, 920.1350730313484, 4919.3358896549225, 5004.224345226496, 5011.949880501221, 5052.57053150479, 5084.059449001947, 5207.244949482304, 5244.816431424882, 5296.443873393316, 5335.386430560535, 5337.839864804062, 5010.622078928324, 5010.624203184776, 5017.37282839645, 5320.946790532045, 5686.886262274731, 3194.9041528754174, 3197.648258691542, 3230.967690323114, 3242.400155971153, 3252.8210948398064, 6131.080337949344, 6267.310595834455, 6267.9373206268265, 6319.399657032574, 6324.450509625171, 6147.44672979425, 6150.538709596709, 6150.938490615036, 6155.599886007395, 6224.75504899013, 6147.323794382614, 6203.4416902479, 6222.160008398808, 6240.344763799826, 6244.219472565929, 5694.572907031907, 5942.881142377215, 5977.758340622267, 6002.849928751816, 6021.307549631673, 5920.230370051866, 5946.0, 5962.731677074456, 5964.7912323068485, 5979.5814292999075, 6017.157597936205, 6180.907286390798, 6232.25212974446, 6252.374762523711, 6283.622982621057, 4032.2338755636333, 4051.432799408144, 4072.6945479088595, 4074.307367747431, 4077.4699289092227, 5974.7453034863165, 5988.293336399105, 6020.668863212565, 6028.698565071817, 6052.182955300978, 5604.495595396434, 5820.952228598893, 5828.883422331445, 5845.327787304344, 5905.372109411443, 5821.214136091573, 5829.892320459099, 5848.0, 5852.7658893643775, 5865.530757539302, 5308.840734777963, 5799.681017544076, 5800.24596802413, 5804.593678442638, 5823.767049317979, 5861.706914654335, 5868.823935281948, 5920.970395147997, 5942.286925568959, 5953.880922381441, 5672.43275672446, 5728.942710573007, 5744.827655170351, 5788.21859049023, 5795.942040579709], "value": 4350.278724099676, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.9468042556593, 716.0619588339273, 717.6519388096772, 734.5739471106758, 734.742840005998, 14507.782383264246, 15186.544403667907, 15400.61498462539, 15407.075575465451, 15415.0, 15242.390304387838, 15401.0, 15424.691506169898, 15441.69116617667, 15478.148701821423, 768.3584207187006, 781.6716978868875, 792.9524228546277, 797.5214871077366, 807.2734538914965, 810.9837803243931, 811.4441607498852, 811.5739236900615, 811.8213992921577, 813.7762115418278, 838.0, 841.7727213652311, 843.8692002739585, 844.9873251901226, 846.124261389459, 839.6851180807197, 840.7309660908512, 841.6296829395108, 843.4264700003995, 844.6325848255967, 607.7933502609134, 613.1783410230269, 615.1111643674892, 616.165096294519, 616.6577549460048, 14928.402863885432, 14929.104253744701, 14949.551513454613, 14968.401263949429, 15034.699306013928, 14480.855191448161, 14768.778468322984, 14905.925470372687, 14999.475018374305, 15107.169105699182, 12191.39043047853, 12376.62870113898, 12396.690082747913, 12654.0, 12953.158044727063, 3949.3483575210057, 3968.4245784361397, 3972.8410863565423, 4107.732997355162, 4125.278076336629, 75611.0, 77245.0, 77806.22193778046, 77882.0, 79646.0, 11488.770224595628, 11490.253133546294, 11646.825297620542, 11718.355490447937, 12007.03943684503, 21014.159433622484, 21066.157353705985, 21143.682844757343, 21228.78771212299, 21391.0, 7923.801904952422, 7958.602069896482, 8372.246497815104, 8509.787255318666, 8762.299016078698, 4767.952320476751, 4867.634927380461, 4871.585915197248, 4926.58124059459, 5053.317802096743, 3350.3801796667694, 3453.6546345365264, 3471.5834099908175, 3474.3225071111397, 3474.6004209515722, 568.8947544704243, 585.689584520205, 585.9803941142382, 597.1132867691475, 601.4977493792645, 687.965601719912, 724.2974314914629, 732.3884556395363, 735.2353552305542, 740.2449501508431, 9677.37097088687, 10034.849477257847, 10085.69742907714, 10134.215811848664, 10140.645077422254, 725.1117381208084, 729.8905164225408, 737.4469148138896, 738.0810890441328, 741.1328745367932, 4734.479207287196, 4863.003084367696, 4926.8768280793265, 4944.233643785219, 4987.518721917124, 110495.0, 115490.4225478884, 117146.41426792982, 117854.0, 119280.40359798145, 95833.52083239538, 97085.0, 97868.0, 98442.5077874606, 98559.0, 83118.0, 84061.0, 84770.57614711887, 86157.56921215354, 88762.0, 9085.0, 9089.954550227207, 9197.446533694276, 9254.444733316022, 9288.489133097473, 49964.0, 50104.49895501144, 50354.244686329, 50963.177761667284, 51971.0, 43310.350344745486, 43494.13011739684, 44328.0, 73128.26871731428, 75988.0, 12047.638570842888, 12082.154249202471, 12229.3273869938, 12263.93868030654, 12399.194052386567, 12257.325847078497, 12980.415881285177, 13530.797038044635, 13615.18308901469, 13907.58277251684, 12684.682882927631, 12767.361631918182, 13187.802182967454, 13196.538121165713, 13412.731745364843, 11712.70718232051, 11734.589289374831, 12304.692382690146, 12502.374881256083, 12626.494940202288, 12051.698707532381, 12339.444724987578, 12343.629691109281, 12438.875611243771, 12544.87455125437, 10096.899031009889, 10423.0, 10566.31318964265, 10583.047525722723, 10606.946965265124, 9697.224222062077, 9929.602815887283, 10625.0, 10692.358458492516, 10769.0], "value": 7390.823008238958, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 104.0, 110.0, 111.0, 111.0, 114.0, 112.0, 111.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 155.0, 186.0, 128.0, 159.0, 160.0, 127.0, 188.0, 127.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 166.0, 169.0, 184.0, 163.0, 162.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 157.0, 78.0, 76.0, 75.0, 77.0, 166.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 154.0, 86.0, 87.0, 87.0, 138.0, 87.0, 85.0, 145.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 122.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 149.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 54.0, 57.0, 55.0, 53.0, 55.0, 54.0, 53.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 79.0, 79.0, 80.0, 81.0, 98.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 126.0, 126.0, 125.0, 131.0, 124.0, 128.0, 139.0, 127.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 160.0, 159.0, 156.0, 156.0, 157.0, 157.0, 162.0, 162.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 65.0, 62.0, 62.0, 64.0, 62.0, 63.0, 67.0], "value": 63.8, "unit": "score"}]}]} 06:04:09 INFO - Return code: 0 06:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:04:09 ERROR - # TBPL SUCCESS # 06:04:09 INFO - Running post-action listener: _resource_record_post_action 06:04:09 INFO - ##### 06:04:09 INFO - ##### Finished run-tests step (success) 06:04:09 INFO - ##### 06:04:09 INFO - Running post-run listener: _resource_record_post_run 06:04:09 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 552292352; Read time: 0; Write time: 400172 06:04:09 INFO - TinderboxPrint: CPU usage
13.5% 06:04:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:04:09 INFO - TinderboxPrint: I/O write bytes / time
552,292,352 / 400,172 06:04:09 INFO - TinderboxPrint: CPU idle
8,227.1 (86.5%) 06:04:09 INFO - TinderboxPrint: CPU user
1,225.0 (12.9%) 06:04:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:04:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256540672; Read time: 0; Write time: 198776 06:04:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289247232; Read time: 0; Write time: 200288 06:04:10 INFO - Running post-run listener: _upload_blobber_files 06:04:10 INFO - Blob upload gear active. 06:04:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:04:10 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 06:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:11 INFO - (blobuploader) - INFO - Done attempting. 06:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:14 INFO - (blobuploader) - INFO - Done attempting. 06:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:15 INFO - (blobuploader) - INFO - Done attempting. 06:04:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:15 INFO - Return code: 0 06:04:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:04:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927e9a4eef8e7616cfb5c127aa4b6fbf527c8f2da3de40d0a0e8e6445c1ef51578ca9dc63d4a763152ff3e0057c12d546a8e6409b3e70e5e6da187916ac251b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de388c39238678dcbd1969f7c91d6f943b0addd406d73628591daa5b0efaa0c44ccc5684bdf44f1079b9fd0a26acac066a1f2c57dfe5a87da07c3b0cea1dbe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e02806db38946361acfd514b580626ded976ca7b21f4efa4f1d813b0b35140d959539554f036929d0e609ad301d042813a5ddefea0a9919a4d948ecef64b50e"} 06:04:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:04:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:04:15 INFO - Contents: 06:04:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927e9a4eef8e7616cfb5c127aa4b6fbf527c8f2da3de40d0a0e8e6445c1ef51578ca9dc63d4a763152ff3e0057c12d546a8e6409b3e70e5e6da187916ac251b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de388c39238678dcbd1969f7c91d6f943b0addd406d73628591daa5b0efaa0c44ccc5684bdf44f1079b9fd0a26acac066a1f2c57dfe5a87da07c3b0cea1dbe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e02806db38946361acfd514b580626ded976ca7b21f4efa4f1d813b0b35140d959539554f036929d0e609ad301d042813a5ddefea0a9919a4d948ecef64b50e"} 06:04:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:15 INFO - Copying logs to upload dir... 06:04:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:04:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.001327 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-28 06:04:15.317736) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 06:04:15.321645) ========= 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=41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927e9a4eef8e7616cfb5c127aa4b6fbf527c8f2da3de40d0a0e8e6445c1ef51578ca9dc63d4a763152ff3e0057c12d546a8e6409b3e70e5e6da187916ac251b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de388c39238678dcbd1969f7c91d6f943b0addd406d73628591daa5b0efaa0c44ccc5684bdf44f1079b9fd0a26acac066a1f2c57dfe5a87da07c3b0cea1dbe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e02806db38946361acfd514b580626ded976ca7b21f4efa4f1d813b0b35140d959539554f036929d0e609ad301d042813a5ddefea0a9919a4d948ecef64b50e"} build_url:https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/XaTFfyiVQVONZrWAfSb4kw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/927e9a4eef8e7616cfb5c127aa4b6fbf527c8f2da3de40d0a0e8e6445c1ef51578ca9dc63d4a763152ff3e0057c12d546a8e6409b3e70e5e6da187916ac251b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0de388c39238678dcbd1969f7c91d6f943b0addd406d73628591daa5b0efaa0c44ccc5684bdf44f1079b9fd0a26acac066a1f2c57dfe5a87da07c3b0cea1dbe5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e02806db38946361acfd514b580626ded976ca7b21f4efa4f1d813b0b35140d959539554f036929d0e609ad301d042813a5ddefea0a9919a4d948ecef64b50e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 06:04:15.346815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 06:04:15.347160) ========= 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=41a7e32711b8e08598a63237000001d6-1467117569.295004-664872145 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 06:04:15.431188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 06:04:15.431512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 06:04:15.431804) ========= ========= Total master_lag: 0.17 =========