builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1466428047.36 results: success (0) buildid: 20160620045124 builduid: 1842b206cb124bd084fdfe287ce4c5bc revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.359185) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.360091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.360860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.377557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.378196) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 06:07:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-06-20 06:07:28 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.516624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.517517) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:27.568202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 06:07:27.568621) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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 3c5025f98e561a20e24d97c91a9e4e0ec28015ea --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=e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 06:07:28,252 truncating revision to first 12 chars 2016-06-20 06:07:28,252 Setting DEBUG logging. 2016-06-20 06:07:28,252 attempt 1/10 2016-06-20 06:07:28,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3c5025f98e56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 06:07:29,301 unpacking tar archive at: mozilla-central-3c5025f98e56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 06:07:28.954875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:28.955621) ========= script_repo_revision: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:28.956541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:28.957163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 06:07:28.968820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-20 06:07:28.969435) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:07:29 INFO - MultiFileLogger online at 20160620 06:07:29 in /builds/slave/test 06:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:07:29 INFO - {'append_to_log': False, 06:07:29 INFO - 'base_work_dir': '/builds/slave/test', 06:07:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:07:29 INFO - 'branch': 'Firefox-Non-PGO', 06:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:07:29 INFO - 'config_files': ('talos/linux_config.py',), 06:07:29 INFO - 'default_actions': ('clobber', 06:07:29 INFO - 'read-buildbot-config', 06:07:29 INFO - 'download-and-extract', 06:07:29 INFO - 'populate-webroot', 06:07:29 INFO - 'create-virtualenv', 06:07:29 INFO - 'install', 06:07:29 INFO - 'run-tests'), 06:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:07:29 INFO - 'download_minidump_stackwalk': True, 06:07:29 INFO - 'download_symbols': 'ondemand', 06:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:07:29 INFO - 'installer_path': 'installer.exe', 06:07:29 INFO - 'log_level': 'info', 06:07:29 INFO - 'log_name': 'talos', 06:07:29 INFO - 'log_to_console': True, 06:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:07:29 INFO - 'opt_config_files': (), 06:07:29 INFO - 'pip_index': False, 06:07:29 INFO - 'sps_profile': False, 06:07:29 INFO - 'sps_profile_interval': 0, 06:07:29 INFO - 'suite': 'dromaeojs-e10s', 06:07:29 INFO - 'system_bits': '32', 06:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:07:29 INFO - 'title': 'talos-linux64-ix-067', 06:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:07:29 INFO - 'use_talos_json': True, 06:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:07:29 INFO - 'work_dir': 'build'} 06:07:29 INFO - ##### 06:07:29 INFO - ##### Running clobber step. 06:07:29 INFO - ##### 06:07:29 INFO - Running pre-action listener: _resource_record_pre_action 06:07:29 INFO - Running main action method: clobber 06:07:29 INFO - rmtree: /builds/slave/test/build 06:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:07:30 INFO - Running post-action listener: _resource_record_post_action 06:07:30 INFO - ##### 06:07:30 INFO - ##### Finished clobber step (success) 06:07:30 INFO - ##### 06:07:30 INFO - ##### 06:07:30 INFO - ##### Running read-buildbot-config step. 06:07:30 INFO - ##### 06:07:30 INFO - Running pre-action listener: _resource_record_pre_action 06:07:30 INFO - Running main action method: read_buildbot_config 06:07:30 INFO - Using buildbot properties: 06:07:30 INFO - { 06:07:30 INFO - "project": "", 06:07:30 INFO - "product": "firefox", 06:07:30 INFO - "script_repo_revision": "production", 06:07:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:07:30 INFO - "repository": "", 06:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:07:30 INFO - "buildid": "20160620045124", 06:07:30 INFO - "pgo_build": "False", 06:07:30 INFO - "basedir": "/builds/slave/test", 06:07:30 INFO - "buildnumber": 377, 06:07:30 INFO - "slavename": "talos-linux64-ix-067", 06:07:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:07:30 INFO - "platform": "ubuntu64_hw", 06:07:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:07:30 INFO - "branch": "mozilla-central", 06:07:30 INFO - "repo_path": "mozilla-central", 06:07:30 INFO - "revision": "3c5025f98e561a20e24d97c91a9e4e0ec28015ea", 06:07:30 INFO - "stage_platform": "linux64", 06:07:30 INFO - "builduid": "1842b206cb124bd084fdfe287ce4c5bc", 06:07:30 INFO - "slavebuilddir": "test" 06:07:30 INFO - } 06:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:07:30 INFO - Running post-action listener: _resource_record_post_action 06:07:30 INFO - ##### 06:07:30 INFO - ##### Finished read-buildbot-config step (success) 06:07:30 INFO - ##### 06:07:30 INFO - ##### 06:07:30 INFO - ##### Running download-and-extract step. 06:07:30 INFO - ##### 06:07:30 INFO - Running pre-action listener: _resource_record_pre_action 06:07:30 INFO - Running main action method: download_and_extract 06:07:30 INFO - mkdir: /builds/slave/test/build/tests 06:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:30 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:31 INFO - Downloaded 1361 bytes. 06:07:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:07:31 INFO - Using the following test package requirements: 06:07:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:07:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:07:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'jsshell-linux-x86_64.zip'], 06:07:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:07:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:07:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:07:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:07:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:07:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:07:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:07:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:07:31 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')]} 06:07:31 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:32 INFO - Downloaded 22654924 bytes. 06:07:32 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'] 06:07:32 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 06:07:33 INFO - Return code: 0 06:07:33 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 06:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:33 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:34 INFO - Downloaded 22654924 bytes. 06:07:34 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'] 06:07:34 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 06:07:36 INFO - Return code: 0 06:07:36 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')]} 06:07:36 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:37 INFO - Downloaded 14405384 bytes. 06:07:37 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'] 06:07:37 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 06:07:37 INFO - Return code: 0 06:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:37 INFO - https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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 06:07:38 INFO - Downloaded 56228410 bytes. 06:07:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:07:38 INFO - mkdir: /builds/slave/test/properties 06:07:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:07:38 INFO - Writing to file /builds/slave/test/properties/build_url 06:07:38 INFO - Contents: 06:07:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:07:39 INFO - Running post-action listener: _resource_record_post_action 06:07:39 INFO - Running post-action listener: set_extra_try_arguments 06:07:39 INFO - ##### 06:07:39 INFO - ##### Finished download-and-extract step (success) 06:07:39 INFO - ##### 06:07:39 INFO - ##### 06:07:39 INFO - ##### Running populate-webroot step. 06:07:39 INFO - ##### 06:07:39 INFO - Running pre-action listener: _resource_record_pre_action 06:07:39 INFO - Running main action method: populate_webroot 06:07:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:07:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:07:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:07:39 INFO - '--tppagecycles', 06:07:39 INFO - '7'], 06:07:39 INFO - 'tests': ['tsvgm']}}, 06:07:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:07:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:07:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:07:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:07:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['damp', 'tps']}, 06:07:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'tests': ['damp', 'tps']}, 06:07:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['dromaeo_dom']}, 06:07:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:07:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['basic_compositor_video']}, 06:07:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:07:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['a11yr', 06:07:39 INFO - 'ts_paint', 06:07:39 INFO - 'tpaint', 06:07:39 INFO - 'sessionrestore', 06:07:39 INFO - 'sessionrestore_no_auto_restore', 06:07:39 INFO - 'tabpaint']}, 06:07:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:07:39 INFO - 'ts_paint', 06:07:39 INFO - 'tpaint', 06:07:39 INFO - 'sessionrestore', 06:07:39 INFO - 'sessionrestore_no_auto_restore', 06:07:39 INFO - 'tabpaint']}, 06:07:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:07:39 INFO - 'ts_paint', 06:07:39 INFO - 'tpaint', 06:07:39 INFO - 'sessionrestore', 06:07:39 INFO - 'sessionrestore_no_auto_restore', 06:07:39 INFO - 'tabpaint']}, 06:07:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:07:39 INFO - 'ts_paint', 06:07:39 INFO - 'tpaint', 06:07:39 INFO - 'sessionrestore', 06:07:39 INFO - 'sessionrestore_no_auto_restore', 06:07:39 INFO - 'tabpaint']}, 06:07:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['a11yr', 06:07:39 INFO - 'ts_paint', 06:07:39 INFO - 'tpaint', 06:07:39 INFO - 'sessionrestore', 06:07:39 INFO - 'sessionrestore_no_auto_restore', 06:07:39 INFO - 'tabpaint']}, 06:07:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['a11yr', 06:07:39 INFO - 'ts_paint', 06:07:39 INFO - 'tpaint', 06:07:39 INFO - 'sessionrestore', 06:07:39 INFO - 'sessionrestore_no_auto_restore', 06:07:39 INFO - 'tabpaint']}, 06:07:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['tsvgx', 06:07:39 INFO - 'tsvgr_opacity', 06:07:39 INFO - 'tart', 06:07:39 INFO - 'tscrollx', 06:07:39 INFO - 'cart']}, 06:07:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:07:39 INFO - 'tsvgr_opacity', 06:07:39 INFO - 'tart', 06:07:39 INFO - 'tscrollx', 06:07:39 INFO - 'cart']}, 06:07:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'talos_options': ['--disable-e10s'], 06:07:39 INFO - 'tests': ['tp5o']}, 06:07:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'tests': ['tp5o']}, 06:07:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'talos_options': ['--disable-e10s', 06:07:39 INFO - '--xperf_path', 06:07:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:39 INFO - 'tests': ['tp5n']}, 06:07:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:39 INFO - 'talos_options': ['--xperf_path', 06:07:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:39 INFO - 'tests': ['tp5n']}}, 06:07:39 INFO - 'talos.zip': {'path': '', 06:07:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:07:39 INFO - Running post-action listener: _resource_record_post_action 06:07:39 INFO - ##### 06:07:39 INFO - ##### Finished populate-webroot step (success) 06:07:39 INFO - ##### 06:07:39 INFO - ##### 06:07:39 INFO - ##### Running create-virtualenv step. 06:07:39 INFO - ##### 06:07:39 INFO - Running pre-action listener: _resource_record_pre_action 06:07:39 INFO - Running main action method: create_virtualenv 06:07:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:07:39 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 06:07:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:07:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:07:39 INFO - Using real prefix '/usr' 06:07:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:07:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:07:42 INFO - Installing pip.................done. 06:07:42 INFO - Return code: 0 06:07:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:42 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:42 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 06:07:42 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 06:07:42 INFO - Using env: {'DISPLAY': ':0', 06:07:42 INFO - 'HOME': '/home/cltbld', 06:07:42 INFO - 'LANG': 'en_US.UTF-8', 06:07:42 INFO - 'LANGUAGE': 'en_US:en', 06:07:42 INFO - 'LOGNAME': 'cltbld', 06:07:42 INFO - 'MAIL': '/var/mail/cltbld', 06:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:42 INFO - 'MOZ_NO_REMOTE': '1', 06:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:42 INFO - 'NO_EM_RESTART': '1', 06:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:42 INFO - 'PWD': '/builds/slave/test', 06:07:42 INFO - 'SHELL': '/bin/bash', 06:07:42 INFO - 'SHLVL': '1', 06:07:42 INFO - 'TERM': 'linux', 06:07:42 INFO - 'TMOUT': '86400', 06:07:42 INFO - 'USER': 'cltbld', 06:07:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:42 INFO - '_': '/tools/buildbot/bin/python'} 06:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:42 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 06:07:42 INFO - Cleaning up... 06:07:42 INFO - Return code: 0 06:07:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:42 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:42 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 06:07:42 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 06:07:42 INFO - Using env: {'DISPLAY': ':0', 06:07:42 INFO - 'HOME': '/home/cltbld', 06:07:42 INFO - 'LANG': 'en_US.UTF-8', 06:07:42 INFO - 'LANGUAGE': 'en_US:en', 06:07:42 INFO - 'LOGNAME': 'cltbld', 06:07:42 INFO - 'MAIL': '/var/mail/cltbld', 06:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:42 INFO - 'MOZ_NO_REMOTE': '1', 06:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:42 INFO - 'NO_EM_RESTART': '1', 06:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:42 INFO - 'PWD': '/builds/slave/test', 06:07:42 INFO - 'SHELL': '/bin/bash', 06:07:42 INFO - 'SHLVL': '1', 06:07:42 INFO - 'TERM': 'linux', 06:07:42 INFO - 'TMOUT': '86400', 06:07:42 INFO - 'USER': 'cltbld', 06:07:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:42 INFO - '_': '/tools/buildbot/bin/python'} 06:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:42 INFO - Downloading/unpacking psutil>=3.1.1 06:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:07:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:44 INFO - Installing collected packages: psutil 06:07:44 INFO - Running setup.py install for psutil 06:07:44 INFO - building 'psutil._psutil_linux' extension 06:07:44 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 06:07:44 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 06:07:44 INFO - building 'psutil._psutil_posix' extension 06:07:44 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 06:07:44 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 06:07:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:45 INFO - Successfully installed psutil 06:07:45 INFO - Cleaning up... 06:07:45 INFO - Return code: 0 06:07:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:07:45 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')]} 06:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:45 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')]} 06:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:45 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:45 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 06:07:45 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 06:07:45 INFO - Using env: {'DISPLAY': ':0', 06:07:45 INFO - 'HOME': '/home/cltbld', 06:07:45 INFO - 'LANG': 'en_US.UTF-8', 06:07:45 INFO - 'LANGUAGE': 'en_US:en', 06:07:45 INFO - 'LOGNAME': 'cltbld', 06:07:45 INFO - 'MAIL': '/var/mail/cltbld', 06:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:45 INFO - 'MOZ_NO_REMOTE': '1', 06:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:45 INFO - 'NO_EM_RESTART': '1', 06:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:45 INFO - 'PWD': '/builds/slave/test', 06:07:45 INFO - 'SHELL': '/bin/bash', 06:07:45 INFO - 'SHLVL': '1', 06:07:45 INFO - 'TERM': 'linux', 06:07:45 INFO - 'TMOUT': '86400', 06:07:45 INFO - 'USER': 'cltbld', 06:07:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:45 INFO - '_': '/tools/buildbot/bin/python'} 06:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:45 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 06:07:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:07:47 INFO - Installing collected packages: mozsystemmonitor 06:07:47 INFO - Running setup.py install for mozsystemmonitor 06:07:47 INFO - Successfully installed mozsystemmonitor 06:07:47 INFO - Cleaning up... 06:07:47 INFO - Return code: 0 06:07:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:47 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 06:07:47 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 06:07:47 INFO - Using env: {'DISPLAY': ':0', 06:07:47 INFO - 'HOME': '/home/cltbld', 06:07:47 INFO - 'LANG': 'en_US.UTF-8', 06:07:47 INFO - 'LANGUAGE': 'en_US:en', 06:07:47 INFO - 'LOGNAME': 'cltbld', 06:07:47 INFO - 'MAIL': '/var/mail/cltbld', 06:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:47 INFO - 'MOZ_NO_REMOTE': '1', 06:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:47 INFO - 'NO_EM_RESTART': '1', 06:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:47 INFO - 'PWD': '/builds/slave/test', 06:07:47 INFO - 'SHELL': '/bin/bash', 06:07:47 INFO - 'SHLVL': '1', 06:07:47 INFO - 'TERM': 'linux', 06:07:47 INFO - 'TMOUT': '86400', 06:07:47 INFO - 'USER': 'cltbld', 06:07:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:47 INFO - '_': '/tools/buildbot/bin/python'} 06:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:47 INFO - Downloading/unpacking jsonschema==2.5.1 06:07:47 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 06:07:47 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 06:07:47 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 06:07:47 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 06:07:47 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 06:07:47 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 06:07:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:07:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:07:49 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 06:07:49 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 06:07:49 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 06:07:49 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 06:07:49 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 06:07:49 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 06:07:49 INFO - Downloading functools32-3.2.3-2.tar.gz 06:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:07:49 INFO - warning: no files found matching '*.txt' 06:07:49 INFO - no previously-included directories found matching 'build' 06:07:49 INFO - no previously-included directories found matching 'dist' 06:07:49 INFO - no previously-included directories found matching '.git*' 06:07:49 INFO - Installing collected packages: jsonschema, functools32 06:07:49 INFO - Running setup.py install for functools32 06:07:49 INFO - warning: no files found matching '*.txt' 06:07:49 INFO - no previously-included directories found matching 'build' 06:07:49 INFO - no previously-included directories found matching 'dist' 06:07:49 INFO - no previously-included directories found matching '.git*' 06:07:49 INFO - Successfully installed jsonschema functools32 06:07:49 INFO - Cleaning up... 06:07:49 INFO - Return code: 0 06:07:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:07:49 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')]} 06:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:49 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')]} 06:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:49 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:49 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 06:07:49 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 06:07:49 INFO - Using env: {'DISPLAY': ':0', 06:07:49 INFO - 'HOME': '/home/cltbld', 06:07:49 INFO - 'LANG': 'en_US.UTF-8', 06:07:49 INFO - 'LANGUAGE': 'en_US:en', 06:07:49 INFO - 'LOGNAME': 'cltbld', 06:07:49 INFO - 'MAIL': '/var/mail/cltbld', 06:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:50 INFO - 'MOZ_NO_REMOTE': '1', 06:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:50 INFO - 'NO_EM_RESTART': '1', 06:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:50 INFO - 'PWD': '/builds/slave/test', 06:07:50 INFO - 'SHELL': '/bin/bash', 06:07:50 INFO - 'SHLVL': '1', 06:07:50 INFO - 'TERM': 'linux', 06:07:50 INFO - 'TMOUT': '86400', 06:07:50 INFO - 'USER': 'cltbld', 06:07:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:50 INFO - '_': '/tools/buildbot/bin/python'} 06:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:07:50 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 06:07:50 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 06:07:50 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 06:07:50 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 06:07:50 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 06:07:50 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 06:07:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:07:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:07:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 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 06:07:52 INFO - Downloading docopt-0.6.1.tar.gz 06:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:07:53 INFO - Installing collected packages: blobuploader, requests, docopt 06:07:53 INFO - Running setup.py install for blobuploader 06:07:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:07:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:07:53 INFO - Running setup.py install for requests 06:07:53 INFO - Running setup.py install for docopt 06:07:53 INFO - Successfully installed blobuploader requests docopt 06:07:53 INFO - Cleaning up... 06:07:53 INFO - Return code: 0 06:07:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:53 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')]} 06:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:53 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')]} 06:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:53 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:53 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 06:07:53 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 06:07:53 INFO - Using env: {'DISPLAY': ':0', 06:07:53 INFO - 'HOME': '/home/cltbld', 06:07:53 INFO - 'LANG': 'en_US.UTF-8', 06:07:53 INFO - 'LANGUAGE': 'en_US:en', 06:07:53 INFO - 'LOGNAME': 'cltbld', 06:07:53 INFO - 'MAIL': '/var/mail/cltbld', 06:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:53 INFO - 'MOZ_NO_REMOTE': '1', 06:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:53 INFO - 'NO_EM_RESTART': '1', 06:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:53 INFO - 'PWD': '/builds/slave/test', 06:07:53 INFO - 'SHELL': '/bin/bash', 06:07:53 INFO - 'SHLVL': '1', 06:07:53 INFO - 'TERM': 'linux', 06:07:53 INFO - 'TMOUT': '86400', 06:07:53 INFO - 'USER': 'cltbld', 06:07:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:53 INFO - '_': '/tools/buildbot/bin/python'} 06:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:53 INFO - Running setup.py (path:/tmp/pip-FmdTJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:53 INFO - Running setup.py (path:/tmp/pip-Y4plBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:54 INFO - Running setup.py (path:/tmp/pip-ip1Deq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:54 INFO - Running setup.py (path:/tmp/pip-AUIdQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:54 INFO - Running setup.py (path:/tmp/pip-1xmnjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:54 INFO - Running setup.py (path:/tmp/pip-GnoqKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:54 INFO - Running setup.py (path:/tmp/pip-fay8FE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:54 INFO - Running setup.py (path:/tmp/pip-0Btgyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:54 INFO - Running setup.py (path:/tmp/pip-Ceyt88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:54 INFO - Running setup.py (path:/tmp/pip-owmUKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:54 INFO - Running setup.py (path:/tmp/pip-ZIgd00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:54 INFO - Running setup.py (path:/tmp/pip-1B4lgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:54 INFO - Running setup.py (path:/tmp/pip-7695Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:54 INFO - Running setup.py (path:/tmp/pip-hvqjw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:54 INFO - Running setup.py (path:/tmp/pip-ULDXD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:54 INFO - Running setup.py (path:/tmp/pip-wMngr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:55 INFO - Running setup.py (path:/tmp/pip-cU31hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:07:55 INFO - Running setup.py install for manifestparser 06:07:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Running setup.py install for mozcrash 06:07:55 INFO - Running setup.py install for mozdebug 06:07:55 INFO - Running setup.py install for mozdevice 06:07:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Running setup.py install for mozfile 06:07:55 INFO - Running setup.py install for mozhttpd 06:07:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Running setup.py install for mozinfo 06:07:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Running setup.py install for mozInstall 06:07:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:07:55 INFO - Running setup.py install for mozleak 06:07:55 INFO - Running setup.py install for mozlog 06:07:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Running setup.py install for moznetwork 06:07:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Running setup.py install for mozprocess 06:07:56 INFO - Running setup.py install for mozprofile 06:07:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Running setup.py install for mozrunner 06:07:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Running setup.py install for mozscreenshot 06:07:56 INFO - Running setup.py install for moztest 06:07:56 INFO - Running setup.py install for mozversion 06:07:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:07:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:07:56 INFO - Cleaning up... 06:07:56 INFO - Return code: 0 06:07:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:56 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')]} 06:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:56 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')]} 06:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:56 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:07:56 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 06:07:56 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 06:07:56 INFO - Using env: {'DISPLAY': ':0', 06:07:56 INFO - 'HOME': '/home/cltbld', 06:07:56 INFO - 'LANG': 'en_US.UTF-8', 06:07:56 INFO - 'LANGUAGE': 'en_US:en', 06:07:56 INFO - 'LOGNAME': 'cltbld', 06:07:56 INFO - 'MAIL': '/var/mail/cltbld', 06:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:56 INFO - 'MOZ_NO_REMOTE': '1', 06:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:07:56 INFO - 'NO_EM_RESTART': '1', 06:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:56 INFO - 'PWD': '/builds/slave/test', 06:07:56 INFO - 'SHELL': '/bin/bash', 06:07:56 INFO - 'SHLVL': '1', 06:07:56 INFO - 'TERM': 'linux', 06:07:56 INFO - 'TMOUT': '86400', 06:07:56 INFO - 'USER': 'cltbld', 06:07:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:56 INFO - '_': '/tools/buildbot/bin/python'} 06:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:57 INFO - Running setup.py (path:/tmp/pip-cXy60d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:57 INFO - Running setup.py (path:/tmp/pip-Upg2zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:57 INFO - Running setup.py (path:/tmp/pip-Hv9tTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:57 INFO - Running setup.py (path:/tmp/pip-pZ30_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:57 INFO - Running setup.py (path:/tmp/pip-EUngOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:57 INFO - Running setup.py (path:/tmp/pip-zvxd1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:57 INFO - Running setup.py (path:/tmp/pip-zHTyIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:57 INFO - Running setup.py (path:/tmp/pip-DNyyMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:57 INFO - Running setup.py (path:/tmp/pip-A82KVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:57 INFO - Running setup.py (path:/tmp/pip-VL2E0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:57 INFO - Running setup.py (path:/tmp/pip-9py8fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:57 INFO - Running setup.py (path:/tmp/pip-KZXkDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:57 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)) 06:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:57 INFO - Running setup.py (path:/tmp/pip-_69H8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:58 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)) 06:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:58 INFO - Running setup.py (path:/tmp/pip-1ZlgxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:58 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)) 06:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:58 INFO - Running setup.py (path:/tmp/pip-K9E3ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:58 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)) 06:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:58 INFO - Running setup.py (path:/tmp/pip-nZAcGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:58 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)) 06:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:58 INFO - Running setup.py (path:/tmp/pip-6TPmH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:58 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)) 06:07:58 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)) 06:07:58 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)) 06:07:58 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)) 06:07:58 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)) 06:07:58 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)) 06:07:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:08:00 INFO - Downloading blessings-1.6.tar.gz 06:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:08:00 INFO - Installing collected packages: blessings 06:08:00 INFO - Running setup.py install for blessings 06:08:00 INFO - Successfully installed blessings 06:08:00 INFO - Cleaning up... 06:08:00 INFO - Return code: 0 06:08:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:08:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:00 INFO - Reading from file tmpfile_stdout 06:08:00 INFO - Current package versions: 06:08:00 INFO - argparse == 1.2.1 06:08:00 INFO - blessings == 1.6 06:08:00 INFO - blobuploader == 1.2.4 06:08:00 INFO - docopt == 0.6.1 06:08:00 INFO - functools32 == 3.2.3-2 06:08:00 INFO - jsonschema == 2.5.1 06:08:00 INFO - manifestparser == 1.1 06:08:00 INFO - mozInstall == 1.12 06:08:00 INFO - mozcrash == 0.17 06:08:00 INFO - mozdebug == 0.1 06:08:00 INFO - mozdevice == 0.48 06:08:00 INFO - mozfile == 1.2 06:08:00 INFO - mozhttpd == 0.7 06:08:00 INFO - mozinfo == 0.9 06:08:00 INFO - mozleak == 0.1 06:08:00 INFO - mozlog == 3.2 06:08:00 INFO - moznetwork == 0.27 06:08:00 INFO - mozprocess == 0.22 06:08:00 INFO - mozprofile == 0.28 06:08:00 INFO - mozrunner == 6.11 06:08:00 INFO - mozscreenshot == 0.1 06:08:00 INFO - mozsystemmonitor == 0.3 06:08:00 INFO - moztest == 0.7 06:08:00 INFO - mozversion == 1.4 06:08:00 INFO - psutil == 3.1.1 06:08:00 INFO - requests == 1.2.3 06:08:00 INFO - wsgiref == 0.1.2 06:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:00 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:08:00 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 06:08:00 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 06:08:00 INFO - Using env: {'DISPLAY': ':0', 06:08:00 INFO - 'HOME': '/home/cltbld', 06:08:00 INFO - 'LANG': 'en_US.UTF-8', 06:08:00 INFO - 'LANGUAGE': 'en_US:en', 06:08:00 INFO - 'LOGNAME': 'cltbld', 06:08:00 INFO - 'MAIL': '/var/mail/cltbld', 06:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:00 INFO - 'MOZ_NO_REMOTE': '1', 06:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:00 INFO - 'NO_EM_RESTART': '1', 06:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:00 INFO - 'PWD': '/builds/slave/test', 06:08:00 INFO - 'SHELL': '/bin/bash', 06:08:00 INFO - 'SHLVL': '1', 06:08:00 INFO - 'TERM': 'linux', 06:08:00 INFO - 'TMOUT': '86400', 06:08:00 INFO - 'USER': 'cltbld', 06:08:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:00 INFO - '_': '/tools/buildbot/bin/python'} 06:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 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)) 06:08:00 INFO - Cleaning up... 06:08:00 INFO - Return code: 0 06:08:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:08: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')]} 06:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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')]} 06:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:08: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'] in /builds/slave/test/build 06:08: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 06:08:00 INFO - Using env: {'DISPLAY': ':0', 06:08:00 INFO - 'HOME': '/home/cltbld', 06:08:00 INFO - 'LANG': 'en_US.UTF-8', 06:08:00 INFO - 'LANGUAGE': 'en_US:en', 06:08:00 INFO - 'LOGNAME': 'cltbld', 06:08:00 INFO - 'MAIL': '/var/mail/cltbld', 06:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:00 INFO - 'MOZ_NO_REMOTE': '1', 06:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:00 INFO - 'NO_EM_RESTART': '1', 06:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:00 INFO - 'PWD': '/builds/slave/test', 06:08:00 INFO - 'SHELL': '/bin/bash', 06:08:00 INFO - 'SHLVL': '1', 06:08:00 INFO - 'TERM': 'linux', 06:08:00 INFO - 'TMOUT': '86400', 06:08:00 INFO - 'USER': 'cltbld', 06:08:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:00 INFO - '_': '/tools/buildbot/bin/python'} 06:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:08:01 INFO - Cleaning up... 06:08:01 INFO - Return code: 0 06:08:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:08:01 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')]} 06:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:01 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')]} 06:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:08:01 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 0x7fa2c134ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ee020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', '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 06:08:01 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 06:08:01 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 06:08:01 INFO - Using env: {'DISPLAY': ':0', 06:08:01 INFO - 'HOME': '/home/cltbld', 06:08:01 INFO - 'LANG': 'en_US.UTF-8', 06:08:01 INFO - 'LANGUAGE': 'en_US:en', 06:08:01 INFO - 'LOGNAME': 'cltbld', 06:08:01 INFO - 'MAIL': '/var/mail/cltbld', 06:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:01 INFO - 'MOZ_NO_REMOTE': '1', 06:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:01 INFO - 'NO_EM_RESTART': '1', 06:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:01 INFO - 'PWD': '/builds/slave/test', 06:08:01 INFO - 'SHELL': '/bin/bash', 06:08:01 INFO - 'SHLVL': '1', 06:08:01 INFO - 'TERM': 'linux', 06:08:01 INFO - 'TMOUT': '86400', 06:08:01 INFO - 'USER': 'cltbld', 06:08:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:01 INFO - '_': '/tools/buildbot/bin/python'} 06:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:08:01 INFO - Downloading/unpacking flake8 06:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:08:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:08:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:08:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:03 INFO - no previously-included directories found matching 'docs/_build' 06:08:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:08:04 INFO - Running setup.py install for pep8 06:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:08:04 INFO - no previously-included directories found matching 'docs/_build' 06:08:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:08:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:08:04 INFO - Cleaning up... 06:08:04 INFO - Return code: 0 06:08:04 INFO - Running post-action listener: _resource_record_post_action 06:08:04 INFO - Running post-action listener: _start_resource_monitoring 06:08:04 INFO - Starting resource monitoring. 06:08:04 INFO - ##### 06:08:04 INFO - ##### Finished create-virtualenv step (success) 06:08:04 INFO - ##### 06:08:04 INFO - ##### 06:08:04 INFO - ##### Running install step. 06:08:04 INFO - ##### 06:08:04 INFO - Running pre-action listener: _resource_record_pre_action 06:08:04 INFO - Running main action method: install 06:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:08:04 INFO - Reading from file tmpfile_stdout 06:08:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:08:04 INFO - Reading from file tmpfile_stdout 06:08:04 INFO - Output received: 06:08:04 INFO - Usage: mozinstall [options] installer 06:08:04 INFO - Options: 06:08:04 INFO - -h, --help show this help message and exit 06:08:04 INFO - -d DEST, --destination=DEST 06:08:04 INFO - Directory to install application into. [default: 06:08:04 INFO - "/builds/slave/test"] 06:08:04 INFO - --app=APP Application being installed. [default: firefox] 06:08:04 INFO - mkdir: /builds/slave/test/build/application 06:08:04 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'] 06:08:04 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 06:08:20 INFO - Reading from file tmpfile_stdout 06:08:20 INFO - Output received: 06:08:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:08:20 INFO - Running post-action listener: _resource_record_post_action 06:08:20 INFO - ##### 06:08:20 INFO - ##### Finished install step (success) 06:08:20 INFO - ##### 06:08:20 INFO - ##### 06:08:20 INFO - ##### Running run-tests step. 06:08:20 INFO - ##### 06:08:20 INFO - Running pre-action listener: _resource_record_pre_action 06:08:20 INFO - Running main action method: run_tests 06:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:08:20 INFO - Python 2.7.3 06:08:20 INFO - Return code: 0 06:08:20 INFO - grabbing minidump binary from tooltool 06:08: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')]} 06:08:20 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 0x16802e0>, '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 0x15ec140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ec5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:08:20 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 06:08:20 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 06:08:20 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 06:08:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:08:20 INFO - Return code: 0 06:08:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:08:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:08:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:08:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:08:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:08:21 INFO - Return code: 0 06:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 06:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 06:08:21 INFO - Using env: {'DISPLAY': ':0', 06:08:21 INFO - 'HOME': '/home/cltbld', 06:08:21 INFO - 'LANG': 'en_US.UTF-8', 06:08:21 INFO - 'LANGUAGE': 'en_US:en', 06:08:21 INFO - 'LOGNAME': 'cltbld', 06:08:21 INFO - 'MAIL': '/var/mail/cltbld', 06:08:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:08:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:21 INFO - 'MOZ_NO_REMOTE': '1', 06:08:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:08:21 INFO - 'NO_EM_RESTART': '1', 06:08:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:21 INFO - 'PWD': '/builds/slave/test', 06:08:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:08:21 INFO - 'SHELL': '/bin/bash', 06:08:21 INFO - 'SHLVL': '1', 06:08:21 INFO - 'TERM': 'linux', 06:08:21 INFO - 'TMOUT': '86400', 06:08:21 INFO - 'USER': 'cltbld', 06:08:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105', 06:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:21 INFO - '_': '/tools/buildbot/bin/python'} 06:08:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 06:08:21 INFO - mozversion application_buildid: 20160620045124 06:08:21 INFO - mozversion application_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 06:08:21 INFO - mozversion application_display_name: Nightly 06:08:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:08:21 INFO - mozversion application_name: Firefox 06:08:21 INFO - mozversion application_remotingname: firefox 06:08:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:08:21 INFO - mozversion application_vendor: Mozilla 06:08:21 INFO - mozversion application_version: 50.0a1 06:08:21 INFO - mozversion platform_buildid: 20160620045124 06:08:21 INFO - mozversion platform_changeset: 3c5025f98e561a20e24d97c91a9e4e0ec28015ea 06:08:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:08:21 INFO - mozversion platform_version: 50.0a1 06:08:21 INFO - using testdate: 1466428101 06:08:21 INFO - actual date: 1466428101 06:08:21 INFO - starting webserver on 'localhost:49512' 06:08:21 INFO - SUITE-START | Running 2 tests 06:08:21 INFO - TEST-START | dromaeo_css 06:08:21 INFO - operating with platform_type : linux_ 06:08:21 INFO - Initialising browser for dromaeo_css test... 06:08:21 INFO - TEST-INFO | started process 26514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocptxw/profile http://localhost:49512/getInfo.html) 06:08:26 INFO - PROCESS | 26514 | __metrics Screen width/height:1600/1200 06:08:26 INFO - PROCESS | 26514 | colorDepth:24 06:08:26 INFO - PROCESS | 26514 | Browser inner width/height: 1024/697 06:08:26 INFO - PROCESS | 26514 | __metrics 06:08:27 ERROR - PROCESS | 26514 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:08:28 INFO - TEST-INFO | 26514: exit 0 06:08:28 INFO - Browser initialized. 06:08:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:08:28 INFO - TEST-INFO | started process 26635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocptxw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:40 INFO - PROCESS | 26635 | RSS: Main: 186052608 06:08:40 INFO - PROCESS | 26635 | 06:09:29 INFO - PROCESS | 26635 | 1466428169791 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] 06:11:42 INFO - PROCESS | 26635 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49512/tests/dromaeo/cssquery-ext.html) 06:11:43 INFO - PROCESS | 26635 | RSS: Main: 188690432 06:11:43 INFO - PROCESS | 26635 | 06:14:45 INFO - PROCESS | 26635 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-ext.html (next: http://localhost:49512/tests/dromaeo/cssquery-jquery.html) 06:14:45 INFO - PROCESS | 26635 | RSS: Main: 187772928 06:14:45 INFO - PROCESS | 26635 | 06:17:47 INFO - PROCESS | 26635 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49512/tests/dromaeo/cssquery-mootools.html) 06:17:48 INFO - PROCESS | 26635 | RSS: Main: 189210624 06:17:48 INFO - PROCESS | 26635 | 06:20:50 INFO - PROCESS | 26635 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49512/tests/dromaeo/cssquery-prototype.html) 06:20:50 INFO - PROCESS | 26635 | RSS: Main: 186662912 06:20:50 INFO - PROCESS | 26635 | 06:23:53 INFO - PROCESS | 26635 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49512/tests/dromaeo/cssquery-yui.html) 06:23:54 INFO - PROCESS | 26635 | RSS: Main: 188891136 06:23:54 INFO - PROCESS | 26635 | 06:26:56 INFO - PROCESS | 26635 | Cycle 1(1): loaded http://localhost:49512/tests/dromaeo/cssquery-yui.html (next: http://localhost:49512/tests/dromaeo/cssquery-dojo.html) 06:26:57 INFO - PROCESS | 26635 | RSS: Main: 189927424 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | __start_tp_report 06:26:57 INFO - PROCESS | 26635 | _x_x_mozilla_page_load 06:26:57 INFO - PROCESS | 26635 | _x_x_mozilla_page_load_details 06:26:57 INFO - PROCESS | 26635 | |i|pagename|runs| 06:26:57 INFO - PROCESS | 26635 | |0;dojo.html;2612.581986882099;2667.639868617736;2672.5456672365694;2678.785697144229;2697.0829917827937;4679.859604211871;4692.5542073503;4696.319033740106;4768.260919557474;4797.256425254082;4588.701734387262;4686.976565117178;4694.483606803257;4731.976340118304;4790.784414701338;4253.829846806132;4354.259775838115;4384.9561504384865;4404.339349097629;4416.757078360689;640.3197844227843;4277.807498662568;4367.803448844794;4378.40891479651;4442.600165985061;4347.630451411634;4348.412964249833;4365.672574556889;4366;4414.823407063714;4259.382389553497;4373.868783936487;4380.123975204971;4396.098799746044;4422.71252368595;4229.175310814392;4288.656907447396;4299.204647140258;4310.1379724055005;4318.157959197958;4736.052789442091;4770.8330208442885;4780.665353425262;4816.109019831342;4817.927731084002;5124.795008199668;5127.589792816566;5147;5152.484751524855;5212.817551385721;5188.974055129738;5244.29202057725;5250.65870718402;5252.185911183773;5318.30861987943;4879.658423910328;4891.902161956777;4898.608111351155;4908.901821963612;4915.65590408668;5198.480151984847;5204.843854684365;5255.369355677267;5354.464553544614;5366.087765079946;5054.873628159252;5070.036693028313;5073.746312684425;5076.746162691925;5119.180931051014;5153.665011774297;5153.948460515422;5157.510036546522;5165.612579056586;5215;5006.4492905780335;5076.18780995039;5087.058894104603;5099.719515426687;5134.127198376285;4962.975185124052;5026.648134630614;5052.545270925634;5072.797088116507;5159.380874295109;4323.632491238217;4331.653467722637;4336.241157797373;4342.696011279243;4367.519572846984;3712.443133529938;3740.3080430120513;3748.156664750409;3821.331267028259;3865.053061999828;4523.32150177476;4537.8184872604725;4541.6593755468475;4584.61030812378;4590.334401511829;5173.767180476888;5197.792088316501;5210.140326846028;5215.087359712035;5239.869003274873;4380.956190438119;4487.6185524230805;4491.281394976788;4535.750533720611;4561;4648.604868586141;4685.226937555333;4686.015936653273;4710.62315014798;4724.43306803179;4947.6289278304275;4955.677880937727;4964.478729733326;4977.352944117241;4995.8001679932395;5029.145045342228;5141.38303403594;5166.225066240094;5211.5049070338255;5231.163013917755;4896.167651499182;4922.926156107733;4927.728974906271;4940.505949405031;4992.101421744121;5101.744912754273;5106.642535022513;5128.102582048201;5131.4868513148385;5138.717370544507;5087.64386492942;5092.2361645753435;5153;5178.456262092426;5188.7405629719115;4988.1270777613045;5008.298838162733;5033.798648054037;5046.1673823818655;5073.416557095981;4991.650584459053;5011.599072074298;5015.097282489187;5015.573676237561;5024.371953505812;4863.076015557032;4924.384451943507;4962.057209130254;4986.700797952134;5051.570616497639;5090.592752579711;5117.232415137611;5118.181091025418;5135.563477104339;5184.637075404686;4874.7562621868055;4938.43208031081;5019.0463811875625;5023.372078490189;5024.171011783161 06:26:57 INFO - PROCESS | 26635 | |1;ext.html;537.9083857086235;580.1037397221293;580.9767609295628;595.1637948682102;603.0200923499314;33726.49410258845;38403.61596384032;38473.42289865647;38583.228335433276;38692.22615547691;38292.425613615815;38386;38588.22823543527;38732.61267387332;38802.417963730564;7685.231476852312;7750.806229844243;7762.689492420324;7803.3367163791145;7836.608169591526;7783.377329813629;7858.214178582125;7919.406044546653;7921.841563168762;7949.761507154794;7891.60541972902;7923.762287131395;7924.247196516321;7933.127355990837;7967.16344783798;7843.137254901956;7864.449488535834;7916.762497125095;7924.722634707758;7934.3255823255095;7799.96100019502;7838.333741631968;7857;7883.7240696575345;7912.841743165162;29270.414591708046;36412.27175456502;36846.26307473835;37000;37129.44305835415;2938.38293958269;2973.8402023210965;3059.816411015324;3105.2702614885484;3129.702678245563;27315.726842731518;29479.607031851097;29862.552061719092;29862.552061719092;29878.402431951457;2896.029830006929;2967.4361871244396;2979.0764862892574;3007.8195308281574;3065.57082008519;245890;249522;250653;250725;252369.7381513099;55768.721156393956;56360.436395635516;56407.71796140993;56415.43584564184;56475;33538;34046.82976585151;34191.82904085464;36545;36647.633523664954;13553.59339219825;13686.794698079537;13702.177869327872;13791;13809.171449713049;9647.951760241294;9693.61225550984;9724.124828765445;9731.854022189673;9761.170300524393;19014.144363503674;19103.617927641648;19162.71255931162;19191.32830350931;19214.711779323323;7049.92950070503;7115.679794409264;7512.511686740344;7519.548827070394;7561.752310868755;785.8035491127218;817.2440492544373;919.3151102428733;934.4673536084366;1042.3433237060756;26435.471290574467;26790.732092679213;26949.191524254304;27398;27522.311942201606;934.5794392523255;987.4124895687055;1009.8737657792776;1048.2819268800895;1072.6245813965206;14360.640983975483;14463.13221206731;14555.022781082731;14592.343344549521;14641.121532707859;385256;387504;388087;388313;389245;47209;47261.29108063382;47672.28491572629;47772;47782.761086195045;1160.3791971295316;1164.5400066973498;1168.7896178687747;1179.7168679516853;1194.7610477904454;25703.10039148621;26091.73908260969;26214.73785262199;26627;26724.732752673;40468;40559.797201013804;40840.38739418852;41135;41284;339292;340998;342880;342934;344578;25099.247022589352;25303.620445693698;25485.872570637028;25529.744702552736;25557.3610659735;38321.80839095786;40962.38556421596;41398.58601413947;41767.791161044;42120;35330.82334588311;35399.11502212465;35772.46341304934;35794;35816;34337.828310858284;34399.14002149966;34583.65416345804;34907.650923491456;34924.65075349214;34034.82982585071;34893.30213395769;35043.29913401769;35195.82402087973;35238.47142292817;31301.217469563442;33053.834730826195;33067.66932330742;33085.17287067843;33089.50365744564;25157.87421062883;25634;25724.228273151835;25920.8703956479;26009.349766255236 06:26:57 INFO - PROCESS | 26635 | |2;jquery.html;360.7150351222534;362.813151227118;366.1012215012145;374.46077648186593;385.1603504360493;15450.30473628688;16969.915150424247;17160.74258886116;17557.82442175578;17603.0318332492;15902.920485397586;16035.278412471438;16565.83434165658;16633.41783037594;16689.91655041723;5021.497850214977;5212.670768953912;5250.264962905197;5250.579953603722;5252.3697156341295;3659.1583935694807;5104.05574968632;5723.771049158028;6033.637981721089;6040.607360521574;6052.848678783022;6073.089036644495;6075.119107729377;6077.270727512705;6080.2399700037495;5829.154772557998;5964.224650795412;6021.247344082011;6023.909641355383;6058.39416058395;5058.772355243986;5303.28405665238;5312.601554883399;5313.804394011355;5333.919991200135;18832.5291867703;20123;20523.692144617842;20637.484062898548;20682.68975965362;1905.1522072677665;2058.073866759949;2170.858894171874;2365.219477572397;2395.4969456414174;8931.464112153291;8944.731658050268;9144.8628270576;9515.57179926898;9642.132208101304;1750.1774166141893;1772.8758986870923;1788.9642207155914;1807.3132209760338;1845.704687250047;67352.6632366835;68799.65600172017;69360.6531967342;70065.29934700587;71672;9731.172850307803;9778.706638800848;9909.752256193653;10010.64962726301;10079.445630490247;13584.79622805639;13619.319034048258;13641;13642.93178534101;13690.657733556542;6563.212414510289;6618.635975021324;6761.526693131434;6858.691358888862;6908.792736217922;6289.905651415233;6337.841553961096;6415.166028416276;6423.164988551458;6432.74269029243;4225.260579398654;4328.091100868853;4351.956480435155;4376.474823021258;4379.211741886491;1618.287953300544;1699.7960244770707;1765.2497688482345;1775.2632657447273;1859.2562974810185;795.7612716185122;811.5130921447203;866.8613021916464;879.3536750488514;921.2860033474111;16318.918405408134;16351.42770003068;16728.41450549225;16817.915910420368;16837.494875153767;838.5765188579728;860.5869182792295;865.6494119881459;891.4205766251858;928.0487500312099;9245.953770231241;9248.815023699623;9374.484403357881;9467.479288639053;9664.516774161264;365312;370970;372386;372736;376621;72191;75531.62234188794;77367;77394;79298;876.872848505172;882.5498995512335;903.4985583001497;904.2856143646577;907.5280853956037;14923.403063877757;14994.175320357048;15037.473688420852;15125.924370378078;15230.847691522942;25281.49437011286;26710.065147719735;32580;35682.64317356793;35894;48183.277250841966;48415.757921211574;48574;49212.50787492079;49798;6837.3162683731225;7134.714611415485;7727.652255648622;7780.455368124403;7846.725364612211;11489.885101149215;11923.523059077887;12293;12411.317377544321;12489.812652810397;10687.572497100029;10774.922507749163;10781.460926953778;10874.565017399216;10933.234673572773;10398.792024159626;10912.836307455236;10942.17933654995;10982.615608453665;10984.780304393707;10480.161587073168;10708.62519811834;10859.457027148768;10934.726631834268;11105.111591072857;7192.496525243183;7325.084364454443;7334.009908662262;7372.041634587469;7502;10296.17630589566;10362;10675.679729608124;10734.14126869833;10873.673789786319 06:26:57 INFO - PROCESS | 26635 | |3;mootools.html;1376.77283248264;1407.3104178952312;1469.3241109089818;1642.7453744669574;1663.758754980527;6656.6671666416605;7245.67394467249;7428.888566671498;7894.605269736512;7904.486208396457;7309.634518274078;7450.441216908726;7556.735514257002;7605.239476052392;7622.96188519058;2096.601645687322;2158.0936006877073;2159.0500179920787;2159.8272138228904;2165.4478108082417;2132.1045161032325;2136.092160831648;2169.8047175754177;2198.2855571939185;2198.428408613756;2163.080690706451;2168.251953076186;2175.423512769117;2180.029886700419;2207.4481379655085;2078.282992367631;2093.9371818845384;2095.6961240620026;2103.968440473394;2104.515961328903;2073.2950796729183;2094.6020256151282;2124.6388114020656;2142.06820033286;2143.528423746773;7545.547267163933;7568.508046976984;7587.430942679322;7665.195154508752;7674.347680447168;4312.5903039211225;4454.688171827974;4461.9107617847785;4462.12988467249;4464.6874718769695;2715.4569086182646;2760.6963234044238;2810;2812.0017393825306;2839.389531250791;875.7898104454948;906.8005038891433;914.3736540469733;917.9678711245074;928.8746019287378;9860.408375497493;9970.800583988352;10034.9498252509;10059.195264378832;10209.183265338756;4038.3134867072667;4062.4921884764403;4161.375793630979;4163.458750362433;4170.812313445842;8848.867266991001;8877.467351958774;8899.288056955427;8912.73261802147;8937.195652391316;4557.794899229542;4626.884327891762;4628.884277893079;4628.930566041512;4633.027064316464;3552.91117722059;4027.5569687334955;4150.418941348214;4200.180964711913;4211.136716973075;3560.501529785832;3603.6036036036016;3693.8522459101337;3708.2583483303447;3720.739548231598;1132.6715252576826;1173.812190049588;1182.8580570331444;1184.09416796151;1192.958246461387;757.7310054930531;803.2850762821093;803.3452736020125;810.740563019828;817.2807929022422;4593.770311484413;4833.202521583899;4838.806447742051;4854.732989685601;4968.752026255298;846.8772028055897;849.9107593702696;865.1262225152516;866.2160744526213;884.062893333069;3214.421404147276;3217.951730724041;3222.548843161959;3257;3293.489509126089;9151.359404841598;9229.907700923039;9269.119433653927;9281.535923203948;9345.813083738423;9190.724278271662;9219.400738951947;9220.631174753069;9225.90774092264;9256.259499240045;7181.138263408425;7308.6711098000715;7309.159446663702;7312.1591017033725;7324.304191101837;4802.951970480251;4844;4911.9754401227765;4917.360743103373;4960.72716000609;8429.957850210709;8726.171013753683;8797.868031979653;8800.955995219983;8861.955690221508;8676.956615216883;8851.159139881702;8863;8939.776505587412;8949.239314658327;5718.313802343745;6132.63204207749;6257.1552840367785;6336.619802811846;6367.172267605181;7464.290892365217;7500.812479688051;7504.699812007677;7518.962405187939;7526.661300241392;6710.127683401127;6950.6177160256675;6988.440924726111;7024.086868707035;7035.296470352924;6435.356464353527;6538.8365290868105;6574.967125164344;6597.109390232257;6659.234188068434;5984;6030.48740857032;6066.939330606814;6072.210612620331;6089.786857459968;4347.217500849877;4353.978230108829;4370.257056300373;4397.538258482941;4427.845025424094;4398.538153493837;4452.577005184502;4456.264716321771;4480.88797780045;4482.641388688962 06:26:57 INFO - PROCESS | 26635 | |4;prototype.html;293.10310450022934;296.5255591054313;296.6618055416825;298.6833956006632;301.92451887028244;5056;5071.467495912932;5090.618203634724;5100.33695619569;5131.307273518079;4950.653454258194;4955.6283278754145;4981.178105612569;4986.900261994758;4995.425526064504;3649.324874898139;3829.6553310202075;3835.9424608630893;3861.826217820191;3866.7679939203736;3826.5408151021916;3849.499565056553;3855.4987851579394;3858.2862170498406;3879.321118804198;3829.162002238927;3840.423936409533;3842.5773164951834;3849.8075096245216;3881.3013657541633;3813.7521061130938;3817.2938006468894;3885.9028524286837;3898.5321761388673;3900.180961997984;3417.2823707021557;3422.9486557701653;3441.8107004114763;3444.689977902001;3451.171718787498;4901.705897646117;4916.237983112624;4918.90162196754;4927.679700819435;4949.975250123726;4485.237509623372;4520.796564154621;4522;4523.389342438762;4529.2526733089;4974.527419895104;5268.104422248227;5274.841754747364;5292.788288468457;5309.601779866525;3680.5399325084363;3682.410814269704;3692.187718701908;3693.593704692482;3710.5547334319785;5512.972435137799;5540.473655002768;5574.442555744434;5608.775648974036;5612.607117501777;3528.470729390561;3762.2287431076566;3767.2842159989514;3771.6228377162615;3784.262068896539;3787.2046870157574;3810.40938654509;3814.9699581112945;3827.6363745444137;3831;4344.652427805768;4344.826206951687;4360.956390436118;4400.141972315432;4409.382686423904;5190.662606930538;5270.183121616155;5290.68255904647;5292.227103920153;5306.946930530646;1306.5427100514744;1325.1783893985792;1325.615571484278;1325.8200201820387;1326.9601911942657;792.6631181747849;812.5774597209536;833.9916600834035;847.5507980770202;850.3112478892117;4435.179491794029;4591.265397536378;4606.539346065367;4611.193041217841;4623.306504024356;5388.110961691355;5409.486098820606;5435.934344948894;5495.505404513613;5514.834554963358;4448.199324121624;4710;4741.336212930192;4742.73914934675;4754.23932170851;2850.686424493304;2892;2892.2624730693537;2900.6809250982374;2912.7669786417036;5210.739463026834;5211.765470553758;5212.192110222922;5220.425753167148;5225.824189557396;5406.21609866575;5612.466815652507;5655.1517272409465;5667.1782591524;5673.8297851064535;5177.611679124006;5202.387259949428;5221.634485586049;5231.450697676765;5242.348660172033;5447.972760136174;5462.371827239918;5468.617196796186;5477.616566840283;5481.506664400223;5071.898562028812;5318.654287471457;5334.866628334323;5352.545033672026;5379.987207164001;5196.610254231024;5219.164933610604;5223.9477605223465;5245.239440281214;5259.368875734936;3791.9810400947817;3801.9239615208094;3816.4656948026745;3829.272438236726;3850.9807450963685;5124.128898087409;5488.396276409512;5495.917561236664;5517.44825517445;5539.335279766454;5315.335583052119;5347.304850369427;5349.358077030781;5361.892762144813;5364.839054828361;5168.431472537943;5297.496737809902;5305.31030965972;5326.25432439451;5335.946640533545;5209.71346575942;5229.555487783429;5245.659032162897;5264.526192642527;5308.57531397495;5076.238564215398;5224.164133738584;5366.919496207482;5368.489993450616;5373.5432488237375;5219.598984467188;5223.869403264949;5235.921461178009;5246.3704355477585;5259.47405259471 06:26:57 INFO - PROCESS | 26635 | |5;yui.html;679.6126208061404;679.6703598754603;682.2324884504932;690.9758158464454;733.9486235963485;11937.940310298447;12604.810927836079;12918.870811291896;13210.801837972414;13259.933700331509;12346.320952347618;12357.258564486137;12393.690157746061;12405.131640785126;12406.565770198022;623.9812805615816;778.2373274191295;779.3025242408056;796.4464697035562;799.3804801279026;793.6031984007996;794.364508393283;801.6352559585404;803.5459965119688;803.8352137811764;839.4543546694666;841.1966571923829;841.3941961787503;846.6401779243828;846.652872322348;826.0912995704676;829.3738227638155;832.8334333133367;835.0772396501869;838.0195171649185;609.1259043272918;609.7195290166529;612.9080637904306;613.4846728747873;614.3457218062749;13433.32833358338;13476.797848032189;13537.458501659921;13549.796753048711;13609.251491167981;13770.311484425738;13906.165630062127;13942.930285348508;14105.85894141066;14466.638334041629;10062.547185376676;10114.9494252529;10142.492875356204;10524.00021997909;10747.516361763739;4285.46431696038;4308.116836048603;4316.6546676265825;4330.870073897788;4453.9109217815785;57804.42195578032;59151.40848591502;59415.70292148555;59563.404365956216;59722.40277597212;9774.218062554979;9931.50342482873;10323.63867264642;10353.585856565804;10406.5837366506;15082.924585377003;15205.923970380078;17183.65632687339;17751.822481775016;17849.46451606428;6873.690683919235;6946.93053069473;6969.0940177776565;6992;7112.466565007645;3729.456071501067;3834.2331533693373;3845.5000849889334;3880.902977425587;3902.239063382613;2868.498012847743;2973.226960990158;2984.2091845660916;2999.880004799827;3012.623422072241;516.2797896933756;522.0863488894435;526.2684868033436;527.2355085126582;538.1174873207942;403.1473433687729;441.36884255514923;492.87898732172755;556.2712846171528;594.9469439092782;7228.168760592494;7302.744403945836;7426.814329641802;7442.102263922773;7757.728479503303;467.58385037316816;495.1829481355792;535.7401660194803;580.8083332500265;584.4155844155844;3521.735869809723;3715.256948610289;3721.423179407196;3850.845966161322;3870.4000879863665;89651;90140.09859901448;90876;91270.54364728135;94063.52968235251;79766;80970;80983.59508202421;81133.59433202914;82410;42101.36847947344;43521.12957740891;45957.7702111494;69864;72164;7228.602426866362;7253.601051941982;7316.670749816165;7445.255474452728;7552;37589.624103758615;38717.41923871088;40477.595224047385;42179.789101054295;42258.78870605627;64349.67825160844;65770;66466.33533664794;67280;68460.3153968454;11056.889431105908;11295.265807722471;11303.378314192798;11455.369954652575;11855.76288474243;13418.798718019043;13444.327783610584;13700.314984250947;13765.862341376858;14226.786598200828;11172.608958686407;11358.659240222807;11520.251183673034;11632;11822;11892.762144756884;12083.51665933388;12154.453049612612;12658.746825063632;12660.17708848922;11592.478338474957;11667.299962002307;11839.644810655349;11861.703457413289;12459.314737689514;10339.483025848527;10626;10641.308314959502;10780.568777248822;10849.403282819521;10316.329438586468;10570.894291057299;10687.30532515384;10692.251542391958;10707.625233116803 06:26:57 INFO - PROCESS | 26635 | __end_tp_report 06:26:57 INFO - PROCESS | 26635 | __start_cc_report 06:26:57 INFO - PROCESS | 26635 | _x_x_mozilla_cycle_collect,386 06:26:57 INFO - PROCESS | 26635 | __end_cc_report 06:26:57 INFO - PROCESS | 26635 | __startTimestamp1466429217149__endTimestamp 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | ------- Summary: start ------- 06:26:57 INFO - PROCESS | 26635 | Number of tests: 6 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | [#0] dojo.html Cycles:165 Average:4737.41 Median:4947.63 stddev:607.52 (12.3%) stddev-sans-first:586.07 06:26:57 INFO - PROCESS | 26635 | Values: 2612.6 2667.6 2672.5 2678.8 2697.1 4679.9 4692.6 4696.3 4768.3 4797.3 4588.7 4687.0 4694.5 4732.0 4790.8 4253.8 4354.3 4385.0 4404.3 4416.8 640.3 4277.8 4367.8 4378.4 4442.6 4347.6 4348.4 4365.7 4366.0 4414.8 4259.4 4373.9 4380.1 4396.1 4422.7 4229.2 4288.7 4299.2 4310.1 4318.2 4736.1 4770.8 4780.7 4816.1 4817.9 5124.8 5127.6 5147.0 5152.5 5212.8 5189.0 5244.3 5250.7 5252.2 5318.3 4879.7 4891.9 4898.6 4908.9 4915.7 5198.5 5204.8 5255.4 5354.5 5366.1 5054.9 5070.0 5073.7 5076.7 5119.2 5153.7 5153.9 5157.5 5165.6 5215.0 5006.4 5076.2 5087.1 5099.7 5134.1 4963.0 5026.6 5052.5 5072.8 5159.4 4323.6 4331.7 4336.2 4342.7 4367.5 3712.4 3740.3 3748.2 3821.3 3865.1 4523.3 4537.8 4541.7 4584.6 4590.3 5173.8 5197.8 5210.1 5215.1 5239.9 4381.0 4487.6 4491.3 4535.8 4561.0 4648.6 4685.2 4686.0 4710.6 4724.4 4947.6 4955.7 4964.5 4977.4 4995.8 5029.1 5141.4 5166.2 5211.5 5231.2 4896.2 4922.9 4927.7 4940.5 4992.1 5101.7 5106.6 5128.1 5131.5 5138.7 5087.6 5092.2 5153.0 5178.5 5188.7 4988.1 5008.3 5033.8 5046.2 5073.4 4991.7 5011.6 5015.1 5015.6 5024.4 4863.1 4924.4 4962.1 4986.7 5051.6 5090.6 5117.2 5118.2 5135.6 5184.6 4874.8 4938.4 5019.0 5023.4 5024.2 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | [#1] ext.html Cycles:180 Average:47129.84 Median:35585.79 stddev:87414.84 (245.6%) stddev-sans-first:87590.06 06:26:57 INFO - PROCESS | 26635 | Values: 537.9 580.1 581.0 595.2 603.0 33726.5 38403.6 38473.4 38583.2 38692.2 38292.4 38386.0 38588.2 38732.6 38802.4 7685.2 7750.8 7762.7 7803.3 7836.6 7783.4 7858.2 7919.4 7921.8 7949.8 7891.6 7923.8 7924.2 7933.1 7967.2 7843.1 7864.4 7916.8 7924.7 7934.3 7800.0 7838.3 7857.0 7883.7 7912.8 29270.4 36412.3 36846.3 37000.0 37129.4 2938.4 2973.8 3059.8 3105.3 3129.7 27315.7 29479.6 29862.6 29862.6 29878.4 2896.0 2967.4 2979.1 3007.8 3065.6 245890.0 249522.0 250653.0 250725.0 252369.7 55768.7 56360.4 56407.7 56415.4 56475.0 33538.0 34046.8 34191.8 36545.0 36647.6 13553.6 13686.8 13702.2 13791.0 13809.2 9648.0 9693.6 9724.1 9731.9 9761.2 19014.1 19103.6 19162.7 19191.3 19214.7 7049.9 7115.7 7512.5 7519.5 7561.8 785.8 817.2 919.3 934.5 1042.3 26435.5 26790.7 26949.2 27398.0 27522.3 934.6 987.4 1009.9 1048.3 1072.6 14360.6 14463.1 14555.0 14592.3 14641.1 385256.0 387504.0 388087.0 388313.0 389245.0 47209.0 47261.3 47672.3 47772.0 47782.8 1160.4 1164.5 1168.8 1179.7 1194.8 25703.1 26091.7 26214.7 26627.0 26724.7 40468.0 40559.8 40840.4 41135.0 41284.0 339292.0 340998.0 342880.0 342934.0 344578.0 25099.2 25303.6 25485.9 25529.7 25557.4 38321.8 40962.4 41398.6 41767.8 42120.0 35330.8 35399.1 35772.5 35794.0 35816.0 34337.8 34399.1 34583.7 34907.7 34924.7 34034.8 34893.3 35043.3 35195.8 35238.5 31301.2 33053.8 33067.7 33085.2 33089.5 25157.9 25634.0 25724.2 25920.9 26009.3 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | [#2] jquery.html Cycles:180 Average:23577.29 Median:4364.22 stddev:61419.98 (1407.4%) stddev-sans-first:61567.54 06:26:57 INFO - PROCESS | 26635 | Values: 360.7 362.8 366.1 374.5 385.2 15450.3 16969.9 17160.7 17557.8 17603.0 15902.9 16035.3 16565.8 16633.4 16689.9 5021.5 5212.7 5250.3 5250.6 5252.4 3659.2 5104.1 5723.8 6033.6 6040.6 6052.8 6073.1 6075.1 6077.3 6080.2 5829.2 5964.2 6021.2 6023.9 6058.4 5058.8 5303.3 5312.6 5313.8 5333.9 18832.5 20123.0 20523.7 20637.5 20682.7 1905.2 2058.1 2170.9 2365.2 2395.5 8931.5 8944.7 9144.9 9515.6 9642.1 1750.2 1772.9 1789.0 1807.3 1845.7 67352.7 68799.7 69360.7 70065.3 71672.0 9731.2 9778.7 9909.8 10010.6 10079.4 13584.8 13619.3 13641.0 13642.9 13690.7 6563.2 6618.6 6761.5 6858.7 6908.8 6289.9 6337.8 6415.2 6423.2 6432.7 4225.3 4328.1 4352.0 4376.5 4379.2 1618.3 1699.8 1765.2 1775.3 1859.3 795.8 811.5 866.9 879.4 921.3 16318.9 16351.4 16728.4 16817.9 16837.5 838.6 860.6 865.6 891.4 928.0 9246.0 9248.8 9374.5 9467.5 9664.5 365312.0 370970.0 372386.0 372736.0 376621.0 72191.0 75531.6 77367.0 77394.0 79298.0 876.9 882.5 903.5 904.3 907.5 14923.4 14994.2 15037.5 15125.9 15230.8 25281.5 26710.1 32580.0 35682.6 35894.0 48183.3 48415.8 48574.0 49212.5 49798.0 6837.3 7134.7 7727.7 7780.5 7846.7 11489.9 11923.5 12293.0 12411.3 12489.8 10687.6 10774.9 10781.5 10874.6 10933.2 10398.8 10912.8 10942.2 10982.6 10984.8 10480.2 10708.6 10859.5 10934.7 11105.1 7192.5 7325.1 7334.0 7372.0 7502.0 10296.2 10362.0 10675.7 10734.1 10873.7 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | [#3] mootools.html Cycles:180 Average:4983.48 Median:4939.04 stddev:2779.75 (56.3%) stddev-sans-first:2774.34 06:26:57 INFO - PROCESS | 26635 | Values: 1376.8 1407.3 1469.3 1642.7 1663.8 6656.7 7245.7 7428.9 7894.6 7904.5 7309.6 7450.4 7556.7 7605.2 7623.0 2096.6 2158.1 2159.1 2159.8 2165.4 2132.1 2136.1 2169.8 2198.3 2198.4 2163.1 2168.3 2175.4 2180.0 2207.4 2078.3 2093.9 2095.7 2104.0 2104.5 2073.3 2094.6 2124.6 2142.1 2143.5 7545.5 7568.5 7587.4 7665.2 7674.3 4312.6 4454.7 4461.9 4462.1 4464.7 2715.5 2760.7 2810.0 2812.0 2839.4 875.8 906.8 914.4 918.0 928.9 9860.4 9970.8 10034.9 10059.2 10209.2 4038.3 4062.5 4161.4 4163.5 4170.8 8848.9 8877.5 8899.3 8912.7 8937.2 4557.8 4626.9 4628.9 4628.9 4633.0 3552.9 4027.6 4150.4 4200.2 4211.1 3560.5 3603.6 3693.9 3708.3 3720.7 1132.7 1173.8 1182.9 1184.1 1193.0 757.7 803.3 803.3 810.7 817.3 4593.8 4833.2 4838.8 4854.7 4968.8 846.9 849.9 865.1 866.2 884.1 3214.4 3218.0 3222.5 3257.0 3293.5 9151.4 9229.9 9269.1 9281.5 9345.8 9190.7 9219.4 9220.6 9225.9 9256.3 7181.1 7308.7 7309.2 7312.2 7324.3 4803.0 4844.0 4912.0 4917.4 4960.7 8430.0 8726.2 8797.9 8801.0 8862.0 8677.0 8851.2 8863.0 8939.8 8949.2 5718.3 6132.6 6257.2 6336.6 6367.2 7464.3 7500.8 7504.7 7519.0 7526.7 6710.1 6950.6 6988.4 7024.1 7035.3 6435.4 6538.8 6575.0 6597.1 6659.2 5984.0 6030.5 6066.9 6072.2 6089.8 4347.2 4354.0 4370.3 4397.5 4427.8 4398.5 4452.6 4456.3 4480.9 4482.6 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | [#4] prototype.html Cycles:180 Average:4380.39 Median:5025.71 stddev:1302.53 (25.9%) stddev-sans-first:1269.54 06:26:57 INFO - PROCESS | 26635 | Values: 293.1 296.5 296.7 298.7 301.9 5056.0 5071.5 5090.6 5100.3 5131.3 4950.7 4955.6 4981.2 4986.9 4995.4 3649.3 3829.7 3835.9 3861.8 3866.8 3826.5 3849.5 3855.5 3858.3 3879.3 3829.2 3840.4 3842.6 3849.8 3881.3 3813.8 3817.3 3885.9 3898.5 3900.2 3417.3 3422.9 3441.8 3444.7 3451.2 4901.7 4916.2 4918.9 4927.7 4950.0 4485.2 4520.8 4522.0 4523.4 4529.3 4974.5 5268.1 5274.8 5292.8 5309.6 3680.5 3682.4 3692.2 3693.6 3710.6 5513.0 5540.5 5574.4 5608.8 5612.6 3528.5 3762.2 3767.3 3771.6 3784.3 3787.2 3810.4 3815.0 3827.6 3831.0 4344.7 4344.8 4361.0 4400.1 4409.4 5190.7 5270.2 5290.7 5292.2 5306.9 1306.5 1325.2 1325.6 1325.8 1327.0 792.7 812.6 834.0 847.6 850.3 4435.2 4591.3 4606.5 4611.2 4623.3 5388.1 5409.5 5435.9 5495.5 5514.8 4448.2 4710.0 4741.3 4742.7 4754.2 2850.7 2892.0 2892.3 2900.7 2912.8 5210.7 5211.8 5212.2 5220.4 5225.8 5406.2 5612.5 5655.2 5667.2 5673.8 5177.6 5202.4 5221.6 5231.5 5242.3 5448.0 5462.4 5468.6 5477.6 5481.5 5071.9 5318.7 5334.9 5352.5 5380.0 5196.6 5219.2 5223.9 5245.2 5259.4 3792.0 3801.9 3816.5 3829.3 3851.0 5124.1 5488.4 5495.9 5517.4 5539.3 5315.3 5347.3 5349.4 5361.9 5364.8 5168.4 5297.5 5305.3 5326.3 5335.9 5209.7 5229.6 5245.7 5264.5 5308.6 5076.2 5224.2 5366.9 5368.5 5373.5 5219.6 5223.9 5235.9 5246.4 5259.5 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - PROCESS | 26635 | [#5] yui.html Cycles:180 Average:16872.20 Median:4296.79 stddev:23473.84 (546.3%) stddev-sans-first:23508.21 06:26:57 INFO - PROCESS | 26635 | Values: 679.6 679.7 682.2 691.0 733.9 11937.9 12604.8 12918.9 13210.8 13259.9 12346.3 12357.3 12393.7 12405.1 12406.6 624.0 778.2 779.3 796.4 799.4 793.6 794.4 801.6 803.5 803.8 839.5 841.2 841.4 846.6 846.7 826.1 829.4 832.8 835.1 838.0 609.1 609.7 612.9 613.5 614.3 13433.3 13476.8 13537.5 13549.8 13609.3 13770.3 13906.2 13942.9 14105.9 14466.6 10062.5 10114.9 10142.5 10524.0 10747.5 4285.5 4308.1 4316.7 4330.9 4453.9 57804.4 59151.4 59415.7 59563.4 59722.4 9774.2 9931.5 10323.6 10353.6 10406.6 15082.9 15205.9 17183.7 17751.8 17849.5 6873.7 6946.9 6969.1 6992.0 7112.5 3729.5 3834.2 3845.5 3880.9 3902.2 2868.5 2973.2 2984.2 2999.9 3012.6 516.3 522.1 526.3 527.2 538.1 403.1 441.4 492.9 556.3 594.9 7228.2 7302.7 7426.8 7442.1 7757.7 467.6 495.2 535.7 580.8 584.4 3521.7 3715.3 3721.4 3850.8 3870.4 89651.0 90140.1 90876.0 91270.5 94063.5 79766.0 80970.0 80983.6 81133.6 82410.0 42101.4 43521.1 45957.8 69864.0 72164.0 7228.6 7253.6 7316.7 7445.3 7552.0 37589.6 38717.4 40477.6 42179.8 42258.8 64349.7 65770.0 66466.3 67280.0 68460.3 11056.9 11295.3 11303.4 11455.4 11855.8 13418.8 13444.3 13700.3 13765.9 14226.8 11172.6 11358.7 11520.3 11632.0 11822.0 11892.8 12083.5 12154.5 12658.7 12660.2 11592.5 11667.3 11839.6 11861.7 12459.3 10339.5 10626.0 10641.3 10780.6 10849.4 10316.3 10570.9 10687.3 10692.3 10707.6 06:26:57 INFO - PROCESS | 26635 | -------- Summary: end -------- 06:26:57 INFO - PROCESS | 26635 | 06:26:57 INFO - TEST-INFO | 26635: exit 0 06:26:57 INFO - TEST-OK | dromaeo_css | took 1116043ms 06:26:57 INFO - TEST-START | kraken 06:26:57 INFO - operating with platform_type : linux_ 06:26:57 INFO - Initialising browser for kraken test... 06:26:57 INFO - TEST-INFO | started process 26876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkHwaEs/profile http://localhost:49512/getInfo.html) 06:27:02 INFO - PROCESS | 26876 | __metrics Screen width/height:1600/1200 06:27:02 INFO - PROCESS | 26876 | colorDepth:24 06:27:02 INFO - PROCESS | 26876 | Browser inner width/height: 1024/697 06:27:02 INFO - PROCESS | 26876 | __metrics 06:27:03 ERROR - PROCESS | 26876 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:27:04 INFO - TEST-INFO | 26876: exit 0 06:27:04 INFO - Browser initialized. 06:27:04 INFO - Running cycle 1/1 for kraken test... 06:27:04 INFO - TEST-INFO | started process 26992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkHwaEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:16 INFO - PROCESS | 26992 | RSS: Main: 186277888 06:27:16 INFO - PROCESS | 26992 | 06:27:18 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-beat-detection) 06:27:19 INFO - PROCESS | 26992 | RSS: Main: 190734336 06:27:19 INFO - PROCESS | 26992 | 06:27:22 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-dft) 06:27:23 INFO - PROCESS | 26992 | RSS: Main: 190177280 06:27:23 INFO - PROCESS | 26992 | 06:27:26 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-fft) 06:27:26 INFO - PROCESS | 26992 | RSS: Main: 185982976 06:27:26 INFO - PROCESS | 26992 | 06:27:29 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49512/tests/kraken/driver.html?testName=audio-oscillator) 06:27:29 INFO - PROCESS | 26992 | RSS: Main: 186912768 06:27:29 INFO - PROCESS | 26992 | 06:27:31 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:27:32 INFO - PROCESS | 26992 | RSS: Main: 187162624 06:27:32 INFO - PROCESS | 26992 | 06:27:35 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49512/tests/kraken/driver.html?testName=imaging-darkroom) 06:27:36 INFO - PROCESS | 26992 | RSS: Main: 187297792 06:27:36 INFO - PROCESS | 26992 | 06:27:39 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49512/tests/kraken/driver.html?testName=imaging-desaturate) 06:27:40 INFO - PROCESS | 26992 | RSS: Main: 184307712 06:27:40 INFO - PROCESS | 26992 | 06:27:43 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49512/tests/kraken/driver.html?testName=json-parse-financial) 06:27:44 INFO - PROCESS | 26992 | RSS: Main: 185405440 06:27:44 INFO - PROCESS | 26992 | 06:27:45 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:27:46 INFO - PROCESS | 26992 | RSS: Main: 185843712 06:27:46 INFO - PROCESS | 26992 | 06:27:48 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:27:49 INFO - PROCESS | 26992 | RSS: Main: 185835520 06:27:49 INFO - PROCESS | 26992 | 06:27:51 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:27:51 INFO - PROCESS | 26992 | RSS: Main: 186544128 06:27:51 INFO - PROCESS | 26992 | 06:27:54 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:27:55 INFO - PROCESS | 26992 | RSS: Main: 186474496 06:27:55 INFO - PROCESS | 26992 | 06:27:58 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:27:58 INFO - PROCESS | 26992 | RSS: Main: 187052032 06:27:58 INFO - PROCESS | 26992 | 06:28:00 INFO - PROCESS | 26992 | Cycle 1(1): loaded http://localhost:49512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49512/tests/kraken/driver.html?testName=ai-astar) 06:28:01 INFO - PROCESS | 26992 | RSS: Main: 187846656 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | __start_tp_report 06:28:01 INFO - PROCESS | 26992 | _x_x_mozilla_page_load 06:28:01 INFO - PROCESS | 26992 | _x_x_mozilla_page_load_details 06:28:01 INFO - PROCESS | 26992 | |i|pagename|runs| 06:28:01 INFO - PROCESS | 26992 | |0;ai-astar;115;107;112;113;116;115;114;116;115;114 06:28:01 INFO - PROCESS | 26992 | |1;audio-beat-detection;166;143;155;182;140;162;167;136;195;135 06:28:01 INFO - PROCESS | 26992 | |2;audio-dft;162;167;170;169;166;164;164;166;162;164 06:28:01 INFO - PROCESS | 26992 | |3;audio-fft;76;77;79;169;79;77;76;75;156;78 06:28:01 INFO - PROCESS | 26992 | |4;audio-oscillator;86;87;144;86;88;86;138;88;86;141 06:28:01 INFO - PROCESS | 26992 | |5;imaging-gaussian-blur;118;117;118;117;118;117;118;118;117;117 06:28:01 INFO - PROCESS | 26992 | |6;imaging-darkroom;148;150;147;147;149;149;148;148;147;148 06:28:01 INFO - PROCESS | 26992 | |7;imaging-desaturate;95;95;97;97;95;96;96;96;95;96 06:28:01 INFO - PROCESS | 26992 | |8;json-parse-financial;63;65;64;63;65;63;63;63;65;65 06:28:01 INFO - PROCESS | 26992 | |9;json-stringify-tinderbox;65;65;72;65;65;65;65;67;64;65 06:28:01 INFO - PROCESS | 26992 | |10;stanford-crypto-aes;83;85;84;91;85;86;84;85;119;84 06:28:01 INFO - PROCESS | 26992 | |11;stanford-crypto-ccm;137;132;133;145;130;148;141;132;138;140 06:28:01 INFO - PROCESS | 26992 | |12;stanford-crypto-pbkdf2;173;178;180;170;176;169;170;183;176;170 06:28:01 INFO - PROCESS | 26992 | |13;stanford-crypto-sha256-iterative;74;69;68;68;67;68;67;69;70;71 06:28:01 INFO - PROCESS | 26992 | __end_tp_report 06:28:01 INFO - PROCESS | 26992 | __start_cc_report 06:28:01 INFO - PROCESS | 26992 | _x_x_mozilla_cycle_collect,968 06:28:01 INFO - PROCESS | 26992 | __end_cc_report 06:28:01 INFO - PROCESS | 26992 | __startTimestamp1466429281004__endTimestamp 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | ------- Summary: start ------- 06:28:01 INFO - PROCESS | 26992 | Number of tests: 14 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:2.67 (2.3%) stddev-sans-first:2.79 06:28:01 INFO - PROCESS | 26992 | Values: 115.0 107.0 112.0 113.0 116.0 115.0 114.0 116.0 115.0 114.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:164.00 stddev:20.21 (12.3%) stddev-sans-first:21.24 06:28:01 INFO - PROCESS | 26992 | Values: 166.0 143.0 155.0 182.0 140.0 162.0 167.0 136.0 195.0 135.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:2.72 (1.6%) stddev-sans-first:2.59 06:28:01 INFO - PROCESS | 26992 | Values: 162.0 167.0 170.0 169.0 166.0 164.0 164.0 166.0 162.0 164.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#3] audio-fft Cycles:10 Average:94.20 Median:77.00 stddev:36.15 (46.9%) stddev-sans-first:37.74 06:28:01 INFO - PROCESS | 26992 | Values: 76.0 77.0 79.0 169.0 79.0 77.0 76.0 75.0 156.0 78.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:86.00 stddev:26.27 (30.5%) stddev-sans-first:27.14 06:28:01 INFO - PROCESS | 26992 | Values: 86.0 87.0 144.0 86.0 88.0 86.0 138.0 88.0 86.0 141.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:28:01 INFO - PROCESS | 26992 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 06:28:01 INFO - PROCESS | 26992 | Values: 148.0 150.0 147.0 147.0 149.0 149.0 148.0 148.0 147.0 148.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:28:01 INFO - PROCESS | 26992 | Values: 95.0 95.0 97.0 97.0 95.0 96.0 96.0 96.0 95.0 96.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 06:28:01 INFO - PROCESS | 26992 | Values: 63.0 65.0 64.0 63.0 65.0 63.0 63.0 63.0 65.0 65.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.00 stddev:2.30 (3.5%) stddev-sans-first:2.42 06:28:01 INFO - PROCESS | 26992 | Values: 65.0 65.0 72.0 65.0 65.0 65.0 65.0 67.0 64.0 65.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.00 stddev:10.91 (12.8%) stddev-sans-first:11.38 06:28:01 INFO - PROCESS | 26992 | Values: 83.0 85.0 84.0 91.0 85.0 86.0 84.0 85.0 119.0 84.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:139.00 stddev:5.99 (4.3%) stddev-sans-first:6.34 06:28:01 INFO - PROCESS | 26992 | Values: 137.0 132.0 133.0 145.0 130.0 148.0 141.0 132.0 138.0 140.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:176.00 stddev:4.86 (2.8%) stddev-sans-first:5.12 06:28:01 INFO - PROCESS | 26992 | Values: 173.0 178.0 180.0 170.0 176.0 169.0 170.0 183.0 176.0 170.0 06:28:01 INFO - PROCESS | 26992 | 06:28:01 INFO - PROCESS | 26992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:2.13 (3.1%) stddev-sans-first:1.33 06:28:01 INFO - PROCESS | 26992 | Values: 74.0 69.0 68.0 68.0 67.0 68.0 67.0 69.0 70.0 71.0 06:28:01 INFO - PROCESS | 26992 | -------- Summary: end -------- 06:28:01 INFO - PROCESS | 26992 | 06:28:02 INFO - TEST-INFO | 26992: exit 0 06:28:02 INFO - TEST-OK | kraken | took 64110ms 06:28:02 INFO - SUITE-END | took 1180s 06:28:02 INFO - Completed test suite (00:19:40) 06:28:02 INFO - javascript benchmark 06:28:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6388.150170491416, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.581986882099, 2667.639868617736, 2672.5456672365694, 2678.785697144229, 2697.0829917827937, 4679.859604211871, 4692.5542073503, 4696.319033740106, 4768.260919557474, 4797.256425254082, 4588.701734387262, 4686.976565117178, 4694.483606803257, 4731.976340118304, 4790.784414701338, 4253.829846806132, 4354.259775838115, 4384.9561504384865, 4404.339349097629, 4416.757078360689, 640.3197844227843, 4277.807498662568, 4367.803448844794, 4378.40891479651, 4442.600165985061, 4347.630451411634, 4348.412964249833, 4365.672574556889, 4366.0, 4414.823407063714, 4259.382389553497, 4373.868783936487, 4380.123975204971, 4396.098799746044, 4422.71252368595, 4229.175310814392, 4288.656907447396, 4299.204647140258, 4310.1379724055005, 4318.157959197958, 4736.052789442091, 4770.8330208442885, 4780.665353425262, 4816.109019831342, 4817.927731084002, 5124.795008199668, 5127.589792816566, 5147.0, 5152.484751524855, 5212.817551385721, 5188.974055129738, 5244.29202057725, 5250.65870718402, 5252.185911183773, 5318.30861987943, 4879.658423910328, 4891.902161956777, 4898.608111351155, 4908.901821963612, 4915.65590408668, 5198.480151984847, 5204.843854684365, 5255.369355677267, 5354.464553544614, 5366.087765079946, 5054.873628159252, 5070.036693028313, 5073.746312684425, 5076.746162691925, 5119.180931051014, 5153.665011774297, 5153.948460515422, 5157.510036546522, 5165.612579056586, 5215.0, 5006.4492905780335, 5076.18780995039, 5087.058894104603, 5099.719515426687, 5134.127198376285, 4962.975185124052, 5026.648134630614, 5052.545270925634, 5072.797088116507, 5159.380874295109, 4323.632491238217, 4331.653467722637, 4336.241157797373, 4342.696011279243, 4367.519572846984, 3712.443133529938, 3740.3080430120513, 3748.156664750409, 3821.331267028259, 3865.053061999828, 4523.32150177476, 4537.8184872604725, 4541.6593755468475, 4584.61030812378, 4590.334401511829, 5173.767180476888, 5197.792088316501, 5210.140326846028, 5215.087359712035, 5239.869003274873, 4380.956190438119, 4487.6185524230805, 4491.281394976788, 4535.750533720611, 4561.0, 4648.604868586141, 4685.226937555333, 4686.015936653273, 4710.62315014798, 4724.43306803179, 4947.6289278304275, 4955.677880937727, 4964.478729733326, 4977.352944117241, 4995.8001679932395, 5029.145045342228, 5141.38303403594, 5166.225066240094, 5211.5049070338255, 5231.163013917755, 4896.167651499182, 4922.926156107733, 4927.728974906271, 4940.505949405031, 4992.101421744121, 5101.744912754273, 5106.642535022513, 5128.102582048201, 5131.4868513148385, 5138.717370544507, 5087.64386492942, 5092.2361645753435, 5153.0, 5178.456262092426, 5188.7405629719115, 4988.1270777613045, 5008.298838162733, 5033.798648054037, 5046.1673823818655, 5073.416557095981, 4991.650584459053, 5011.599072074298, 5015.097282489187, 5015.573676237561, 5024.371953505812, 4863.076015557032, 4924.384451943507, 4962.057209130254, 4986.700797952134, 5051.570616497639, 5090.592752579711, 5117.232415137611, 5118.181091025418, 5135.563477104339, 5184.637075404686, 4874.7562621868055, 4938.43208031081, 5019.0463811875625, 5023.372078490189, 5024.171011783161], "value": 4699.155599913334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.9083857086235, 580.1037397221293, 580.9767609295628, 595.1637948682102, 603.0200923499314, 33726.49410258845, 38403.61596384032, 38473.42289865647, 38583.228335433276, 38692.22615547691, 38292.425613615815, 38386.0, 38588.22823543527, 38732.61267387332, 38802.417963730564, 7685.231476852312, 7750.806229844243, 7762.689492420324, 7803.3367163791145, 7836.608169591526, 7783.377329813629, 7858.214178582125, 7919.406044546653, 7921.841563168762, 7949.761507154794, 7891.60541972902, 7923.762287131395, 7924.247196516321, 7933.127355990837, 7967.16344783798, 7843.137254901956, 7864.449488535834, 7916.762497125095, 7924.722634707758, 7934.3255823255095, 7799.96100019502, 7838.333741631968, 7857.0, 7883.7240696575345, 7912.841743165162, 29270.414591708046, 36412.27175456502, 36846.26307473835, 37000.0, 37129.44305835415, 2938.38293958269, 2973.8402023210965, 3059.816411015324, 3105.2702614885484, 3129.702678245563, 27315.726842731518, 29479.607031851097, 29862.552061719092, 29862.552061719092, 29878.402431951457, 2896.029830006929, 2967.4361871244396, 2979.0764862892574, 3007.8195308281574, 3065.57082008519, 245890.0, 249522.0, 250653.0, 250725.0, 252369.7381513099, 55768.721156393956, 56360.436395635516, 56407.71796140993, 56415.43584564184, 56475.0, 33538.0, 34046.82976585151, 34191.82904085464, 36545.0, 36647.633523664954, 13553.59339219825, 13686.794698079537, 13702.177869327872, 13791.0, 13809.171449713049, 9647.951760241294, 9693.61225550984, 9724.124828765445, 9731.854022189673, 9761.170300524393, 19014.144363503674, 19103.617927641648, 19162.71255931162, 19191.32830350931, 19214.711779323323, 7049.92950070503, 7115.679794409264, 7512.511686740344, 7519.548827070394, 7561.752310868755, 785.8035491127218, 817.2440492544373, 919.3151102428733, 934.4673536084366, 1042.3433237060756, 26435.471290574467, 26790.732092679213, 26949.191524254304, 27398.0, 27522.311942201606, 934.5794392523255, 987.4124895687055, 1009.8737657792776, 1048.2819268800895, 1072.6245813965206, 14360.640983975483, 14463.13221206731, 14555.022781082731, 14592.343344549521, 14641.121532707859, 385256.0, 387504.0, 388087.0, 388313.0, 389245.0, 47209.0, 47261.29108063382, 47672.28491572629, 47772.0, 47782.761086195045, 1160.3791971295316, 1164.5400066973498, 1168.7896178687747, 1179.7168679516853, 1194.7610477904454, 25703.10039148621, 26091.73908260969, 26214.73785262199, 26627.0, 26724.732752673, 40468.0, 40559.797201013804, 40840.38739418852, 41135.0, 41284.0, 339292.0, 340998.0, 342880.0, 342934.0, 344578.0, 25099.247022589352, 25303.620445693698, 25485.872570637028, 25529.744702552736, 25557.3610659735, 38321.80839095786, 40962.38556421596, 41398.58601413947, 41767.791161044, 42120.0, 35330.82334588311, 35399.11502212465, 35772.46341304934, 35794.0, 35816.0, 34337.828310858284, 34399.14002149966, 34583.65416345804, 34907.650923491456, 34924.65075349214, 34034.82982585071, 34893.30213395769, 35043.29913401769, 35195.82402087973, 35238.47142292817, 31301.217469563442, 33053.834730826195, 33067.66932330742, 33085.17287067843, 33089.50365744564, 25157.87421062883, 25634.0, 25724.228273151835, 25920.8703956479, 26009.349766255236], "value": 17080.230456559493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.7150351222534, 362.813151227118, 366.1012215012145, 374.46077648186593, 385.1603504360493, 15450.30473628688, 16969.915150424247, 17160.74258886116, 17557.82442175578, 17603.0318332492, 15902.920485397586, 16035.278412471438, 16565.83434165658, 16633.41783037594, 16689.91655041723, 5021.497850214977, 5212.670768953912, 5250.264962905197, 5250.579953603722, 5252.3697156341295, 3659.1583935694807, 5104.05574968632, 5723.771049158028, 6033.637981721089, 6040.607360521574, 6052.848678783022, 6073.089036644495, 6075.119107729377, 6077.270727512705, 6080.2399700037495, 5829.154772557998, 5964.224650795412, 6021.247344082011, 6023.909641355383, 6058.39416058395, 5058.772355243986, 5303.28405665238, 5312.601554883399, 5313.804394011355, 5333.919991200135, 18832.5291867703, 20123.0, 20523.692144617842, 20637.484062898548, 20682.68975965362, 1905.1522072677665, 2058.073866759949, 2170.858894171874, 2365.219477572397, 2395.4969456414174, 8931.464112153291, 8944.731658050268, 9144.8628270576, 9515.57179926898, 9642.132208101304, 1750.1774166141893, 1772.8758986870923, 1788.9642207155914, 1807.3132209760338, 1845.704687250047, 67352.6632366835, 68799.65600172017, 69360.6531967342, 70065.29934700587, 71672.0, 9731.172850307803, 9778.706638800848, 9909.752256193653, 10010.64962726301, 10079.445630490247, 13584.79622805639, 13619.319034048258, 13641.0, 13642.93178534101, 13690.657733556542, 6563.212414510289, 6618.635975021324, 6761.526693131434, 6858.691358888862, 6908.792736217922, 6289.905651415233, 6337.841553961096, 6415.166028416276, 6423.164988551458, 6432.74269029243, 4225.260579398654, 4328.091100868853, 4351.956480435155, 4376.474823021258, 4379.211741886491, 1618.287953300544, 1699.7960244770707, 1765.2497688482345, 1775.2632657447273, 1859.2562974810185, 795.7612716185122, 811.5130921447203, 866.8613021916464, 879.3536750488514, 921.2860033474111, 16318.918405408134, 16351.42770003068, 16728.41450549225, 16817.915910420368, 16837.494875153767, 838.5765188579728, 860.5869182792295, 865.6494119881459, 891.4205766251858, 928.0487500312099, 9245.953770231241, 9248.815023699623, 9374.484403357881, 9467.479288639053, 9664.516774161264, 365312.0, 370970.0, 372386.0, 372736.0, 376621.0, 72191.0, 75531.62234188794, 77367.0, 77394.0, 79298.0, 876.872848505172, 882.5498995512335, 903.4985583001497, 904.2856143646577, 907.5280853956037, 14923.403063877757, 14994.175320357048, 15037.473688420852, 15125.924370378078, 15230.847691522942, 25281.49437011286, 26710.065147719735, 32580.0, 35682.64317356793, 35894.0, 48183.277250841966, 48415.757921211574, 48574.0, 49212.50787492079, 49798.0, 6837.3162683731225, 7134.714611415485, 7727.652255648622, 7780.455368124403, 7846.725364612211, 11489.885101149215, 11923.523059077887, 12293.0, 12411.317377544321, 12489.812652810397, 10687.572497100029, 10774.922507749163, 10781.460926953778, 10874.565017399216, 10933.234673572773, 10398.792024159626, 10912.836307455236, 10942.17933654995, 10982.615608453665, 10984.780304393707, 10480.161587073168, 10708.62519811834, 10859.457027148768, 10934.726631834268, 11105.111591072857, 7192.496525243183, 7325.084364454443, 7334.009908662262, 7372.041634587469, 7502.0, 10296.17630589566, 10362.0, 10675.679729608124, 10734.14126869833, 10873.673789786319], "value": 8183.990110373053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.77283248264, 1407.3104178952312, 1469.3241109089818, 1642.7453744669574, 1663.758754980527, 6656.6671666416605, 7245.67394467249, 7428.888566671498, 7894.605269736512, 7904.486208396457, 7309.634518274078, 7450.441216908726, 7556.735514257002, 7605.239476052392, 7622.96188519058, 2096.601645687322, 2158.0936006877073, 2159.0500179920787, 2159.8272138228904, 2165.4478108082417, 2132.1045161032325, 2136.092160831648, 2169.8047175754177, 2198.2855571939185, 2198.428408613756, 2163.080690706451, 2168.251953076186, 2175.423512769117, 2180.029886700419, 2207.4481379655085, 2078.282992367631, 2093.9371818845384, 2095.6961240620026, 2103.968440473394, 2104.515961328903, 2073.2950796729183, 2094.6020256151282, 2124.6388114020656, 2142.06820033286, 2143.528423746773, 7545.547267163933, 7568.508046976984, 7587.430942679322, 7665.195154508752, 7674.347680447168, 4312.5903039211225, 4454.688171827974, 4461.9107617847785, 4462.12988467249, 4464.6874718769695, 2715.4569086182646, 2760.6963234044238, 2810.0, 2812.0017393825306, 2839.389531250791, 875.7898104454948, 906.8005038891433, 914.3736540469733, 917.9678711245074, 928.8746019287378, 9860.408375497493, 9970.800583988352, 10034.9498252509, 10059.195264378832, 10209.183265338756, 4038.3134867072667, 4062.4921884764403, 4161.375793630979, 4163.458750362433, 4170.812313445842, 8848.867266991001, 8877.467351958774, 8899.288056955427, 8912.73261802147, 8937.195652391316, 4557.794899229542, 4626.884327891762, 4628.884277893079, 4628.930566041512, 4633.027064316464, 3552.91117722059, 4027.5569687334955, 4150.418941348214, 4200.180964711913, 4211.136716973075, 3560.501529785832, 3603.6036036036016, 3693.8522459101337, 3708.2583483303447, 3720.739548231598, 1132.6715252576826, 1173.812190049588, 1182.8580570331444, 1184.09416796151, 1192.958246461387, 757.7310054930531, 803.2850762821093, 803.3452736020125, 810.740563019828, 817.2807929022422, 4593.770311484413, 4833.202521583899, 4838.806447742051, 4854.732989685601, 4968.752026255298, 846.8772028055897, 849.9107593702696, 865.1262225152516, 866.2160744526213, 884.062893333069, 3214.421404147276, 3217.951730724041, 3222.548843161959, 3257.0, 3293.489509126089, 9151.359404841598, 9229.907700923039, 9269.119433653927, 9281.535923203948, 9345.813083738423, 9190.724278271662, 9219.400738951947, 9220.631174753069, 9225.90774092264, 9256.259499240045, 7181.138263408425, 7308.6711098000715, 7309.159446663702, 7312.1591017033725, 7324.304191101837, 4802.951970480251, 4844.0, 4911.9754401227765, 4917.360743103373, 4960.72716000609, 8429.957850210709, 8726.171013753683, 8797.868031979653, 8800.955995219983, 8861.955690221508, 8676.956615216883, 8851.159139881702, 8863.0, 8939.776505587412, 8949.239314658327, 5718.313802343745, 6132.63204207749, 6257.1552840367785, 6336.619802811846, 6367.172267605181, 7464.290892365217, 7500.812479688051, 7504.699812007677, 7518.962405187939, 7526.661300241392, 6710.127683401127, 6950.6177160256675, 6988.440924726111, 7024.086868707035, 7035.296470352924, 6435.356464353527, 6538.8365290868105, 6574.967125164344, 6597.109390232257, 6659.234188068434, 5984.0, 6030.48740857032, 6066.939330606814, 6072.210612620331, 6089.786857459968, 4347.217500849877, 4353.978230108829, 4370.257056300373, 4397.538258482941, 4427.845025424094, 4398.538153493837, 4452.577005184502, 4456.264716321771, 4480.88797780045, 4482.641388688962], "value": 4026.1672410533506, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.10310450022934, 296.5255591054313, 296.6618055416825, 298.6833956006632, 301.92451887028244, 5056.0, 5071.467495912932, 5090.618203634724, 5100.33695619569, 5131.307273518079, 4950.653454258194, 4955.6283278754145, 4981.178105612569, 4986.900261994758, 4995.425526064504, 3649.324874898139, 3829.6553310202075, 3835.9424608630893, 3861.826217820191, 3866.7679939203736, 3826.5408151021916, 3849.499565056553, 3855.4987851579394, 3858.2862170498406, 3879.321118804198, 3829.162002238927, 3840.423936409533, 3842.5773164951834, 3849.8075096245216, 3881.3013657541633, 3813.7521061130938, 3817.2938006468894, 3885.9028524286837, 3898.5321761388673, 3900.180961997984, 3417.2823707021557, 3422.9486557701653, 3441.8107004114763, 3444.689977902001, 3451.171718787498, 4901.705897646117, 4916.237983112624, 4918.90162196754, 4927.679700819435, 4949.975250123726, 4485.237509623372, 4520.796564154621, 4522.0, 4523.389342438762, 4529.2526733089, 4974.527419895104, 5268.104422248227, 5274.841754747364, 5292.788288468457, 5309.601779866525, 3680.5399325084363, 3682.410814269704, 3692.187718701908, 3693.593704692482, 3710.5547334319785, 5512.972435137799, 5540.473655002768, 5574.442555744434, 5608.775648974036, 5612.607117501777, 3528.470729390561, 3762.2287431076566, 3767.2842159989514, 3771.6228377162615, 3784.262068896539, 3787.2046870157574, 3810.40938654509, 3814.9699581112945, 3827.6363745444137, 3831.0, 4344.652427805768, 4344.826206951687, 4360.956390436118, 4400.141972315432, 4409.382686423904, 5190.662606930538, 5270.183121616155, 5290.68255904647, 5292.227103920153, 5306.946930530646, 1306.5427100514744, 1325.1783893985792, 1325.615571484278, 1325.8200201820387, 1326.9601911942657, 792.6631181747849, 812.5774597209536, 833.9916600834035, 847.5507980770202, 850.3112478892117, 4435.179491794029, 4591.265397536378, 4606.539346065367, 4611.193041217841, 4623.306504024356, 5388.110961691355, 5409.486098820606, 5435.934344948894, 5495.505404513613, 5514.834554963358, 4448.199324121624, 4710.0, 4741.336212930192, 4742.73914934675, 4754.23932170851, 2850.686424493304, 2892.0, 2892.2624730693537, 2900.6809250982374, 2912.7669786417036, 5210.739463026834, 5211.765470553758, 5212.192110222922, 5220.425753167148, 5225.824189557396, 5406.21609866575, 5612.466815652507, 5655.1517272409465, 5667.1782591524, 5673.8297851064535, 5177.611679124006, 5202.387259949428, 5221.634485586049, 5231.450697676765, 5242.348660172033, 5447.972760136174, 5462.371827239918, 5468.617196796186, 5477.616566840283, 5481.506664400223, 5071.898562028812, 5318.654287471457, 5334.866628334323, 5352.545033672026, 5379.987207164001, 5196.610254231024, 5219.164933610604, 5223.9477605223465, 5245.239440281214, 5259.368875734936, 3791.9810400947817, 3801.9239615208094, 3816.4656948026745, 3829.272438236726, 3850.9807450963685, 5124.128898087409, 5488.396276409512, 5495.917561236664, 5517.44825517445, 5539.335279766454, 5315.335583052119, 5347.304850369427, 5349.358077030781, 5361.892762144813, 5364.839054828361, 5168.431472537943, 5297.496737809902, 5305.31030965972, 5326.25432439451, 5335.946640533545, 5209.71346575942, 5229.555487783429, 5245.659032162897, 5264.526192642527, 5308.57531397495, 5076.238564215398, 5224.164133738584, 5366.919496207482, 5368.489993450616, 5373.5432488237375, 5219.598984467188, 5223.869403264949, 5235.921461178009, 5246.3704355477585, 5259.47405259471], "value": 3957.152037928991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6126208061404, 679.6703598754603, 682.2324884504932, 690.9758158464454, 733.9486235963485, 11937.940310298447, 12604.810927836079, 12918.870811291896, 13210.801837972414, 13259.933700331509, 12346.320952347618, 12357.258564486137, 12393.690157746061, 12405.131640785126, 12406.565770198022, 623.9812805615816, 778.2373274191295, 779.3025242408056, 796.4464697035562, 799.3804801279026, 793.6031984007996, 794.364508393283, 801.6352559585404, 803.5459965119688, 803.8352137811764, 839.4543546694666, 841.1966571923829, 841.3941961787503, 846.6401779243828, 846.652872322348, 826.0912995704676, 829.3738227638155, 832.8334333133367, 835.0772396501869, 838.0195171649185, 609.1259043272918, 609.7195290166529, 612.9080637904306, 613.4846728747873, 614.3457218062749, 13433.32833358338, 13476.797848032189, 13537.458501659921, 13549.796753048711, 13609.251491167981, 13770.311484425738, 13906.165630062127, 13942.930285348508, 14105.85894141066, 14466.638334041629, 10062.547185376676, 10114.9494252529, 10142.492875356204, 10524.00021997909, 10747.516361763739, 4285.46431696038, 4308.116836048603, 4316.6546676265825, 4330.870073897788, 4453.9109217815785, 57804.42195578032, 59151.40848591502, 59415.70292148555, 59563.404365956216, 59722.40277597212, 9774.218062554979, 9931.50342482873, 10323.63867264642, 10353.585856565804, 10406.5837366506, 15082.924585377003, 15205.923970380078, 17183.65632687339, 17751.822481775016, 17849.46451606428, 6873.690683919235, 6946.93053069473, 6969.0940177776565, 6992.0, 7112.466565007645, 3729.456071501067, 3834.2331533693373, 3845.5000849889334, 3880.902977425587, 3902.239063382613, 2868.498012847743, 2973.226960990158, 2984.2091845660916, 2999.880004799827, 3012.623422072241, 516.2797896933756, 522.0863488894435, 526.2684868033436, 527.2355085126582, 538.1174873207942, 403.1473433687729, 441.36884255514923, 492.87898732172755, 556.2712846171528, 594.9469439092782, 7228.168760592494, 7302.744403945836, 7426.814329641802, 7442.102263922773, 7757.728479503303, 467.58385037316816, 495.1829481355792, 535.7401660194803, 580.8083332500265, 584.4155844155844, 3521.735869809723, 3715.256948610289, 3721.423179407196, 3850.845966161322, 3870.4000879863665, 89651.0, 90140.09859901448, 90876.0, 91270.54364728135, 94063.52968235251, 79766.0, 80970.0, 80983.59508202421, 81133.59433202914, 82410.0, 42101.36847947344, 43521.12957740891, 45957.7702111494, 69864.0, 72164.0, 7228.602426866362, 7253.601051941982, 7316.670749816165, 7445.255474452728, 7552.0, 37589.624103758615, 38717.41923871088, 40477.595224047385, 42179.789101054295, 42258.78870605627, 64349.67825160844, 65770.0, 66466.33533664794, 67280.0, 68460.3153968454, 11056.889431105908, 11295.265807722471, 11303.378314192798, 11455.369954652575, 11855.76288474243, 13418.798718019043, 13444.327783610584, 13700.314984250947, 13765.862341376858, 14226.786598200828, 11172.608958686407, 11358.659240222807, 11520.251183673034, 11632.0, 11822.0, 11892.762144756884, 12083.51665933388, 12154.453049612612, 12658.746825063632, 12660.17708848922, 11592.478338474957, 11667.299962002307, 11839.644810655349, 11861.703457413289, 12459.314737689514, 10339.483025848527, 10626.0, 10641.308314959502, 10780.568777248822, 10849.403282819521, 10316.329438586468, 10570.894291057299, 10687.30532515384, 10692.251542391958, 10707.625233116803], "value": 6493.068887200277, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 112.0, 113.0, 116.0, 115.0, 114.0, 116.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 143.0, 155.0, 182.0, 140.0, 162.0, 167.0, 136.0, 195.0, 135.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 170.0, 169.0, 166.0, 164.0, 164.0, 166.0, 162.0, 164.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 169.0, 79.0, 77.0, 76.0, 75.0, 156.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 144.0, 86.0, 88.0, 86.0, 138.0, 88.0, 86.0, 141.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 147.0, 149.0, 149.0, 148.0, 148.0, 147.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 63.0, 65.0, 63.0, 63.0, 63.0, 65.0, 65.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 72.0, 65.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 91.0, 85.0, 86.0, 84.0, 85.0, 119.0, 84.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 133.0, 145.0, 130.0, 148.0, 141.0, 132.0, 138.0, 140.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 180.0, 170.0, 176.0, 169.0, 170.0, 183.0, 176.0, 170.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 68.0, 68.0, 67.0, 68.0, 67.0, 69.0, 70.0, 71.0], "value": 69.1, "unit": "score"}]}]} 06:28:02 INFO - Return code: 0 06:28:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:28:02 ERROR - # TBPL SUCCESS # 06:28:02 INFO - Running post-action listener: _resource_record_post_action 06:28:02 INFO - ##### 06:28:02 INFO - ##### Finished run-tests step (success) 06:28:02 INFO - ##### 06:28:02 INFO - Running post-run listener: _resource_record_post_run 06:28:02 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534536192; Read time: 12; Write time: 394704 06:28:02 INFO - TinderboxPrint: CPU usage
13.4% 06:28:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:28:02 INFO - TinderboxPrint: I/O write bytes / time
534,536,192 / 394,704 06:28:02 INFO - TinderboxPrint: CPU idle
8,265.2 (86.6%) 06:28:02 INFO - TinderboxPrint: CPU user
1,229.4 (12.9%) 06:28:02 INFO - TinderboxPrint: Swap in / out
0 / 0 06:28:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246063104; Read time: 0; Write time: 227200 06:28:02 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287887360; Read time: 12; Write time: 167492 06:28:02 INFO - Running post-run listener: _upload_blobber_files 06:28:02 INFO - Blob upload gear active. 06:28:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:28:02 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:28:02 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:28:02 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:28:03 INFO - (blobuploader) - INFO - Open directory for files ... 06:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:04 INFO - (blobuploader) - INFO - Done attempting. 06:28:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:28:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:08 INFO - (blobuploader) - INFO - Done attempting. 06:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:28:08 INFO - (blobuploader) - INFO - Done attempting. 06:28:08 INFO - (blobuploader) - INFO - Iteration through files over. 06:28:08 INFO - Return code: 0 06:28:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:28:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:28:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40a5f2f70213ab181967a1c3b365f669f11b25df9422a35d306a6b9d4521a21a463db81970dbbd590f7f5bc0e68332348113c889c2625090478704d6745e33db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/708af781a5e2781c62d1988965f03846a2ca7e802bcf310fd6f7d7e77175402754f4fadef41ba9c23ba3afa1f80b7c85ee6876e7d03e40f109a0c707ec7fe589", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e312f05e7d9ca1b8301bd263e59ca5ed1c3f8cd3dbd83b0c75714ee5d0118fd8cb94028eddd8755315ec3e2dfc0f9c67fc33a03fe291ed1aba5efb18d3c7ff22"} 06:28:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:28:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:28:08 INFO - Contents: 06:28:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40a5f2f70213ab181967a1c3b365f669f11b25df9422a35d306a6b9d4521a21a463db81970dbbd590f7f5bc0e68332348113c889c2625090478704d6745e33db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/708af781a5e2781c62d1988965f03846a2ca7e802bcf310fd6f7d7e77175402754f4fadef41ba9c23ba3afa1f80b7c85ee6876e7d03e40f109a0c707ec7fe589", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e312f05e7d9ca1b8301bd263e59ca5ed1c3f8cd3dbd83b0c75714ee5d0118fd8cb94028eddd8755315ec3e2dfc0f9c67fc33a03fe291ed1aba5efb18d3c7ff22"} 06:28:08 INFO - Running post-run listener: copy_logs_to_upload_dir 06:28:08 INFO - Copying logs to upload dir... 06:28:08 INFO - mkdir: /builds/slave/test/build/upload/logs 06:28:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.265722 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-20 06:28:08.240251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 06:28:08.243896) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105 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-Non-PGO/sha512/40a5f2f70213ab181967a1c3b365f669f11b25df9422a35d306a6b9d4521a21a463db81970dbbd590f7f5bc0e68332348113c889c2625090478704d6745e33db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/708af781a5e2781c62d1988965f03846a2ca7e802bcf310fd6f7d7e77175402754f4fadef41ba9c23ba3afa1f80b7c85ee6876e7d03e40f109a0c707ec7fe589", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e312f05e7d9ca1b8301bd263e59ca5ed1c3f8cd3dbd83b0c75714ee5d0118fd8cb94028eddd8755315ec3e2dfc0f9c67fc33a03fe291ed1aba5efb18d3c7ff22"} build_url:https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/Gy7SPqtARWSrgBLlWNGeDg/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-Non-PGO/sha512/40a5f2f70213ab181967a1c3b365f669f11b25df9422a35d306a6b9d4521a21a463db81970dbbd590f7f5bc0e68332348113c889c2625090478704d6745e33db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/708af781a5e2781c62d1988965f03846a2ca7e802bcf310fd6f7d7e77175402754f4fadef41ba9c23ba3afa1f80b7c85ee6876e7d03e40f109a0c707ec7fe589", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e312f05e7d9ca1b8301bd263e59ca5ed1c3f8cd3dbd83b0c75714ee5d0118fd8cb94028eddd8755315ec3e2dfc0f9c67fc33a03fe291ed1aba5efb18d3c7ff22"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 06:28:08.268627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:28:08.268943) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466428047.336444-1391506105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 06:28:08.356556) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 06:28:08.356883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 06:28:08.357202) ========= ========= Total master_lag: 0.17 =========