builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1464027153.18 results: success (0) buildid: 20160522193137 builduid: c858fb39af334cefa248ec2a3b22030a revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.177906) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.178331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.178695) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.212892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.213188) ========= 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=41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 11:12:34-- 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% 50.4M=0s 2016-05-23 11:12:34 (50.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111472 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.356368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.356717) ========= 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=41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017320 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.473311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:12:33.473707) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e8129bd6590404ff56ea35ac30d719cf7f566ae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e8129bd6590404ff56ea35ac30d719cf7f566ae --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=41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 11:12:34,780 truncating revision to first 12 chars 2016-05-23 11:12:34,780 Setting DEBUG logging. 2016-05-23 11:12:34,780 attempt 1/10 2016-05-23 11:12:34,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2e8129bd6590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:12:35,793 unpacking tar archive at: mozilla-beta-2e8129bd6590/testing/mozharness/ program finished with exit code 0 elapsedTime=1.292843 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:12:34.811382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.811720) ========= script_repo_revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.812210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.812607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.823273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-23 11:12:34.823619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:36 INFO - MultiFileLogger online at 20160523 11:12:36 in /builds/slave/test 11:12:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:12:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:36 INFO - {'append_to_log': False, 11:12:36 INFO - 'base_work_dir': '/builds/slave/test', 11:12:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:12:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:36 INFO - 'branch': 'Mozilla-Beta', 11:12:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:36 INFO - 'config_files': ('talos/linux_config.py',), 11:12:36 INFO - 'default_actions': ('clobber', 11:12:36 INFO - 'read-buildbot-config', 11:12:36 INFO - 'download-and-extract', 11:12:36 INFO - 'populate-webroot', 11:12:36 INFO - 'create-virtualenv', 11:12:36 INFO - 'install', 11:12:36 INFO - 'run-tests'), 11:12:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:36 INFO - 'download_minidump_stackwalk': True, 11:12:36 INFO - 'download_symbols': 'ondemand', 11:12:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:36 INFO - 'installer_path': 'installer.exe', 11:12:36 INFO - 'log_level': 'info', 11:12:36 INFO - 'log_name': 'talos', 11:12:36 INFO - 'log_to_console': True, 11:12:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:36 INFO - 'opt_config_files': (), 11:12:36 INFO - 'pip_index': False, 11:12:36 INFO - 'sps_profile': False, 11:12:36 INFO - 'sps_profile_interval': 0, 11:12:36 INFO - 'suite': 'dromaeojs', 11:12:36 INFO - 'system_bits': '32', 11:12:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:36 INFO - 'title': 'talos-linux64-ix-026', 11:12:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:36 INFO - 'use_talos_json': True, 11:12:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:36 INFO - 'work_dir': 'build'} 11:12:36 INFO - ##### 11:12:36 INFO - ##### Running clobber step. 11:12:36 INFO - ##### 11:12:36 INFO - Running pre-action listener: _resource_record_pre_action 11:12:36 INFO - Running main action method: clobber 11:12:36 INFO - rmtree: /builds/slave/test/build 11:12:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:36 INFO - Running post-action listener: _resource_record_post_action 11:12:36 INFO - ##### 11:12:36 INFO - ##### Running read-buildbot-config step. 11:12:36 INFO - ##### 11:12:36 INFO - Running pre-action listener: _resource_record_pre_action 11:12:36 INFO - Running main action method: read_buildbot_config 11:12:36 INFO - Using buildbot properties: 11:12:36 INFO - { 11:12:36 INFO - "project": "", 11:12:36 INFO - "product": "firefox", 11:12:36 INFO - "script_repo_revision": "production", 11:12:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:12:36 INFO - "repository": "", 11:12:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:12:36 INFO - "buildid": "20160522193137", 11:12:36 INFO - "pgo_build": "True", 11:12:36 INFO - "basedir": "/builds/slave/test", 11:12:36 INFO - "buildnumber": 106, 11:12:36 INFO - "slavename": "talos-linux64-ix-026", 11:12:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:12:36 INFO - "platform": "ubuntu64_hw", 11:12:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:12:36 INFO - "branch": "mozilla-beta", 11:12:36 INFO - "repo_path": "releases/mozilla-beta", 11:12:36 INFO - "revision": "2e8129bd6590404ff56ea35ac30d719cf7f566ae", 11:12:36 INFO - "stage_platform": "linux64-pgo", 11:12:36 INFO - "builduid": "c858fb39af334cefa248ec2a3b22030a", 11:12:36 INFO - "slavebuilddir": "test" 11:12:36 INFO - } 11:12:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 11:12:36 INFO - Running post-action listener: _resource_record_post_action 11:12:36 INFO - ##### 11:12:36 INFO - ##### Running download-and-extract step. 11:12:36 INFO - ##### 11:12:36 INFO - Running pre-action listener: _resource_record_pre_action 11:12:36 INFO - Running main action method: download_and_extract 11:12:36 INFO - mkdir: /builds/slave/test/build/tests 11:12: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')]} 11:12:36 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:12:41 INFO - Downloaded 1412 bytes. 11:12:41 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:41 INFO - Using the following test package requirements: 11:12:41 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:41 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:41 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 11:12:41 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'jsshell-linux-x86_64.zip'], 11:12:41 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:41 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:41 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 11:12:41 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 11:12:41 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:41 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:41 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:41 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:41 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12:41 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')]} 11:12:41 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:44 INFO - Downloaded 23364942 bytes. 11:12:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:12:45 INFO - Return code: 0 11:12:45 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:12: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')]} 11:12:45 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:52 INFO - Downloaded 23364942 bytes. 11:12:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:12:54 INFO - Return code: 0 11:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:54 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:12:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:12:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:12:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:12:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:12:55 INFO - Downloaded 10845194 bytes. 11:12:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:12:55 INFO - Return code: 0 11:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:55 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:12:56 INFO - Downloaded 53800139 bytes. 11:12:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:12:56 INFO - mkdir: /builds/slave/test/properties 11:12:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:56 INFO - Contents: 11:12:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:12:57 INFO - Running post-action listener: _resource_record_post_action 11:12:57 INFO - Running post-action listener: set_extra_try_arguments 11:12:57 INFO - ##### 11:12:57 INFO - ##### Running populate-webroot step. 11:12:57 INFO - ##### 11:12:57 INFO - Running pre-action listener: _resource_record_pre_action 11:12:57 INFO - Running main action method: populate_webroot 11:12:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:57 INFO - '--tppagecycles', 11:12:57 INFO - '7'], 11:12:57 INFO - 'tests': ['tsvgm']}}, 11:12:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:12:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:12:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'tests': ['damp', 'tps']}, 11:12:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['damp', 'tps']}, 11:12:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:12:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:57 INFO - 'other': {'tests': ['a11yr', 11:12:57 INFO - 'ts_paint', 11:12:57 INFO - 'tpaint', 11:12:57 INFO - 'sessionrestore', 11:12:57 INFO - 'sessionrestore_no_auto_restore', 11:12:57 INFO - 'tabpaint']}, 11:12:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['a11yr', 11:12:57 INFO - 'ts_paint', 11:12:57 INFO - 'tpaint', 11:12:57 INFO - 'sessionrestore', 11:12:57 INFO - 'sessionrestore_no_auto_restore', 11:12:57 INFO - 'tabpaint']}, 11:12:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['a11yr', 11:12:57 INFO - 'ts_paint', 11:12:57 INFO - 'tpaint', 11:12:57 INFO - 'sessionrestore', 11:12:57 INFO - 'sessionrestore_no_auto_restore', 11:12:57 INFO - 'tabpaint']}, 11:12:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['a11yr', 11:12:57 INFO - 'ts_paint', 11:12:57 INFO - 'tpaint', 11:12:57 INFO - 'sessionrestore', 11:12:57 INFO - 'sessionrestore_no_auto_restore', 11:12:57 INFO - 'tabpaint']}, 11:12:57 INFO - 'other_l64': {'tests': ['a11yr', 11:12:57 INFO - 'ts_paint', 11:12:57 INFO - 'tpaint', 11:12:57 INFO - 'sessionrestore', 11:12:57 INFO - 'sessionrestore_no_auto_restore', 11:12:57 INFO - 'tabpaint']}, 11:12:57 INFO - 'other_nol64': {'tests': ['a11yr', 11:12:57 INFO - 'ts_paint', 11:12:57 INFO - 'tpaint', 11:12:57 INFO - 'sessionrestore', 11:12:57 INFO - 'sessionrestore_no_auto_restore', 11:12:57 INFO - 'tabpaint']}, 11:12:57 INFO - 'svgr': {'tests': ['tsvgx', 11:12:57 INFO - 'tsvgr_opacity', 11:12:57 INFO - 'tart', 11:12:57 INFO - 'tscrollx', 11:12:57 INFO - 'cart']}, 11:12:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['tsvgx', 11:12:57 INFO - 'tsvgr_opacity', 11:12:57 INFO - 'tart', 11:12:57 INFO - 'tscrollx', 11:12:57 INFO - 'cart']}, 11:12:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'tests': ['tp5o']}, 11:12:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'talos_options': ['--e10s'], 11:12:57 INFO - 'tests': ['tp5o']}, 11:12:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'talos_options': ['--xperf_path', 11:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:57 INFO - 'tests': ['tp5n']}, 11:12:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:57 INFO - 'talos_options': ['--e10s', 11:12:57 INFO - '--xperf_path', 11:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:57 INFO - 'tests': ['tp5n']}}, 11:12:57 INFO - 'talos.zip': {'path': '', 11:12:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:57 INFO - Running post-action listener: _resource_record_post_action 11:12:57 INFO - ##### 11:12:57 INFO - ##### Running create-virtualenv step. 11:12:57 INFO - ##### 11:12:57 INFO - Running pre-action listener: _resource_record_pre_action 11:12:57 INFO - Running main action method: create_virtualenv 11:12:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:57 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 11:12:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:57 INFO - Using real prefix '/usr' 11:12:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:59 INFO - Installing pip.................done. 11:12:59 INFO - Return code: 0 11:12:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:59 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 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:12:59 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 11:12:59 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 11:12:59 INFO - Using env: {'DISPLAY': ':0', 11:12:59 INFO - 'HOME': '/home/cltbld', 11:12:59 INFO - 'LANG': 'en_US.UTF-8', 11:12:59 INFO - 'LANGUAGE': 'en_US:en', 11:12:59 INFO - 'LOGNAME': 'cltbld', 11:12:59 INFO - 'MAIL': '/var/mail/cltbld', 11:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:59 INFO - 'MOZ_NO_REMOTE': '1', 11:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:59 INFO - 'NO_EM_RESTART': '1', 11:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:59 INFO - 'PWD': '/builds/slave/test', 11:12:59 INFO - 'SHELL': '/bin/bash', 11:12:59 INFO - 'SHLVL': '1', 11:12:59 INFO - 'TERM': 'linux', 11:12:59 INFO - 'TMOUT': '86400', 11:12:59 INFO - 'USER': 'cltbld', 11:12:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:59 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 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 11:13:00 INFO - Cleaning up... 11:13:00 INFO - Return code: 0 11:13:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:13: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 psutil>=0.7.1 11:13:00 INFO - Using env: {'DISPLAY': ':0', 11:13:00 INFO - 'HOME': '/home/cltbld', 11:13:00 INFO - 'LANG': 'en_US.UTF-8', 11:13:00 INFO - 'LANGUAGE': 'en_US:en', 11:13:00 INFO - 'LOGNAME': 'cltbld', 11:13:00 INFO - 'MAIL': '/var/mail/cltbld', 11:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:00 INFO - 'MOZ_NO_REMOTE': '1', 11:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:00 INFO - 'NO_EM_RESTART': '1', 11:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:00 INFO - 'PWD': '/builds/slave/test', 11:13:00 INFO - 'SHELL': '/bin/bash', 11:13:00 INFO - 'SHLVL': '1', 11:13:00 INFO - 'TERM': 'linux', 11:13:00 INFO - 'TMOUT': '86400', 11:13:00 INFO - 'USER': 'cltbld', 11:13:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:00 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 INFO - Downloading/unpacking psutil>=0.7.1 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:02 INFO - Installing collected packages: psutil 11:13:02 INFO - Running setup.py install for psutil 11:13:02 INFO - building 'psutil._psutil_linux' extension 11:13:02 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 11:13:02 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 11:13:02 INFO - building 'psutil._psutil_posix' extension 11:13:02 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 11:13:02 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 11:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:02 INFO - Successfully installed psutil 11:13:02 INFO - Cleaning up... 11:13:02 INFO - Return code: 0 11:13:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:13:02 INFO - Using env: {'DISPLAY': ':0', 11:13:02 INFO - 'HOME': '/home/cltbld', 11:13:02 INFO - 'LANG': 'en_US.UTF-8', 11:13:02 INFO - 'LANGUAGE': 'en_US:en', 11:13:02 INFO - 'LOGNAME': 'cltbld', 11:13:02 INFO - 'MAIL': '/var/mail/cltbld', 11:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:02 INFO - 'MOZ_NO_REMOTE': '1', 11:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:02 INFO - 'NO_EM_RESTART': '1', 11:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:02 INFO - 'PWD': '/builds/slave/test', 11:13:02 INFO - 'SHELL': '/bin/bash', 11:13:02 INFO - 'SHLVL': '1', 11:13:02 INFO - 'TERM': 'linux', 11:13:02 INFO - 'TMOUT': '86400', 11:13:02 INFO - 'USER': 'cltbld', 11:13:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:02 INFO - '_': '/tools/buildbot/bin/python'} 11:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:13:05 INFO - Installing collected packages: mozsystemmonitor 11:13:05 INFO - Running setup.py install for mozsystemmonitor 11:13:05 INFO - Successfully installed mozsystemmonitor 11:13:05 INFO - Cleaning up... 11:13:05 INFO - Return code: 0 11:13:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:05 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')]} 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:05 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')]} 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:05 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 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:05 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 11:13:05 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 11:13:05 INFO - Using env: {'DISPLAY': ':0', 11:13:05 INFO - 'HOME': '/home/cltbld', 11:13:05 INFO - 'LANG': 'en_US.UTF-8', 11:13:05 INFO - 'LANGUAGE': 'en_US:en', 11:13:05 INFO - 'LOGNAME': 'cltbld', 11:13:05 INFO - 'MAIL': '/var/mail/cltbld', 11:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:05 INFO - 'MOZ_NO_REMOTE': '1', 11:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:05 INFO - 'NO_EM_RESTART': '1', 11:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:05 INFO - 'PWD': '/builds/slave/test', 11:13:05 INFO - 'SHELL': '/bin/bash', 11:13:05 INFO - 'SHLVL': '1', 11:13:05 INFO - 'TERM': 'linux', 11:13:05 INFO - 'TMOUT': '86400', 11:13:05 INFO - 'USER': 'cltbld', 11:13:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:05 INFO - '_': '/tools/buildbot/bin/python'} 11:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:08 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 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 11:13:08 INFO - Downloading docopt-0.6.1.tar.gz 11:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:08 INFO - Running setup.py install for blobuploader 11:13:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:09 INFO - Running setup.py install for requests 11:13:09 INFO - Running setup.py install for docopt 11:13:09 INFO - Successfully installed blobuploader requests docopt 11:13:09 INFO - Cleaning up... 11:13:09 INFO - Return code: 0 11:13:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:09 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 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:09 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 11:13:09 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 11:13:09 INFO - Using env: {'DISPLAY': ':0', 11:13:09 INFO - 'HOME': '/home/cltbld', 11:13:09 INFO - 'LANG': 'en_US.UTF-8', 11:13:09 INFO - 'LANGUAGE': 'en_US:en', 11:13:09 INFO - 'LOGNAME': 'cltbld', 11:13:09 INFO - 'MAIL': '/var/mail/cltbld', 11:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:09 INFO - 'MOZ_NO_REMOTE': '1', 11:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:09 INFO - 'NO_EM_RESTART': '1', 11:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:09 INFO - 'PWD': '/builds/slave/test', 11:13:09 INFO - 'SHELL': '/bin/bash', 11:13:09 INFO - 'SHLVL': '1', 11:13:09 INFO - 'TERM': 'linux', 11:13:09 INFO - 'TMOUT': '86400', 11:13:09 INFO - 'USER': 'cltbld', 11:13:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:09 INFO - '_': '/tools/buildbot/bin/python'} 11:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:09 INFO - Running setup.py (path:/tmp/pip-ERhzb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:09 INFO - Running setup.py (path:/tmp/pip-FkIoL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:09 INFO - Running setup.py (path:/tmp/pip-bW6Lhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:09 INFO - Running setup.py (path:/tmp/pip-r_JCbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:10 INFO - Running setup.py (path:/tmp/pip-AOr_Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:10 INFO - Running setup.py (path:/tmp/pip-pOsS_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:10 INFO - Running setup.py (path:/tmp/pip-4WiBIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:10 INFO - Running setup.py (path:/tmp/pip-l2dB29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:10 INFO - Running setup.py (path:/tmp/pip-FWk_ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:10 INFO - Running setup.py (path:/tmp/pip-UcYb3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:10 INFO - Running setup.py (path:/tmp/pip-_RKFQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:10 INFO - Running setup.py (path:/tmp/pip-yg3PMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:10 INFO - Running setup.py (path:/tmp/pip-u8RCJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:10 INFO - Running setup.py (path:/tmp/pip-WbXOFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:10 INFO - Running setup.py (path:/tmp/pip-DYT_XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:10 INFO - Running setup.py (path:/tmp/pip-4iZ8Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:10 INFO - Running setup.py (path:/tmp/pip-34ekjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:10 INFO - Running setup.py install for manifestparser 11:13:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Running setup.py install for mozcrash 11:13:11 INFO - Running setup.py install for mozdebug 11:13:11 INFO - Running setup.py install for mozdevice 11:13:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Running setup.py install for mozfile 11:13:11 INFO - Running setup.py install for mozhttpd 11:13:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Running setup.py install for mozinfo 11:13:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Running setup.py install for mozInstall 11:13:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:11 INFO - Running setup.py install for mozleak 11:13:11 INFO - Running setup.py install for mozlog 11:13:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Running setup.py install for moznetwork 11:13:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Running setup.py install for mozprocess 11:13:12 INFO - Running setup.py install for mozprofile 11:13:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Running setup.py install for mozrunner 11:13:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Running setup.py install for mozscreenshot 11:13:12 INFO - Running setup.py install for moztest 11:13:12 INFO - Running setup.py install for mozversion 11:13:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:12 INFO - Cleaning up... 11:13:12 INFO - Return code: 0 11:13:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:12 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 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:12 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 11:13:12 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 11:13:12 INFO - Using env: {'DISPLAY': ':0', 11:13:12 INFO - 'HOME': '/home/cltbld', 11:13:12 INFO - 'LANG': 'en_US.UTF-8', 11:13:12 INFO - 'LANGUAGE': 'en_US:en', 11:13:12 INFO - 'LOGNAME': 'cltbld', 11:13:12 INFO - 'MAIL': '/var/mail/cltbld', 11:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:12 INFO - 'MOZ_NO_REMOTE': '1', 11:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:12 INFO - 'NO_EM_RESTART': '1', 11:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:12 INFO - 'PWD': '/builds/slave/test', 11:13:12 INFO - 'SHELL': '/bin/bash', 11:13:12 INFO - 'SHLVL': '1', 11:13:12 INFO - 'TERM': 'linux', 11:13:12 INFO - 'TMOUT': '86400', 11:13:12 INFO - 'USER': 'cltbld', 11:13:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:12 INFO - '_': '/tools/buildbot/bin/python'} 11:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:12 INFO - Running setup.py (path:/tmp/pip-eU9siB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:13 INFO - Running setup.py (path:/tmp/pip-He7nQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:13 INFO - Running setup.py (path:/tmp/pip-noiSsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:13 INFO - Running setup.py (path:/tmp/pip-zpF301-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:13 INFO - Running setup.py (path:/tmp/pip-wZtSJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:13 INFO - Running setup.py (path:/tmp/pip-y0mPHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:13 INFO - Running setup.py (path:/tmp/pip-ipIrox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:13 INFO - Running setup.py (path:/tmp/pip-fCEqej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:13 INFO - Running setup.py (path:/tmp/pip-VGW7H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:13 INFO - Running setup.py (path:/tmp/pip-V0CfEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:13 INFO - Running setup.py (path:/tmp/pip-wJw0oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:13 INFO - Running setup.py (path:/tmp/pip-U3pB09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:13 INFO - Running setup.py (path:/tmp/pip-I6S1Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:13 INFO - Running setup.py (path:/tmp/pip-M9xzvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:13 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)) 11:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:13 INFO - Running setup.py (path:/tmp/pip-anwUuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:14 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)) 11:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:14 INFO - Running setup.py (path:/tmp/pip-hfRDuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:14 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)) 11:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:14 INFO - Running setup.py (path:/tmp/pip-qRIypM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:14 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)) 11:13:14 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)) 11:13:14 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)) 11:13:14 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)) 11:13:14 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)) 11:13:14 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)) 11:13:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:16 INFO - Downloading blessings-1.6.tar.gz 11:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:16 INFO - Installing collected packages: blessings 11:13:16 INFO - Running setup.py install for blessings 11:13:16 INFO - Successfully installed blessings 11:13:16 INFO - Cleaning up... 11:13:16 INFO - Return code: 0 11:13:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:16 INFO - Reading from file tmpfile_stdout 11:13:16 INFO - Current package versions: 11:13:16 INFO - argparse == 1.2.1 11:13:16 INFO - blessings == 1.6 11:13:16 INFO - blobuploader == 1.2.4 11:13:16 INFO - docopt == 0.6.1 11:13:16 INFO - manifestparser == 1.1 11:13:16 INFO - mozInstall == 1.12 11:13:16 INFO - mozcrash == 0.17 11:13:16 INFO - mozdebug == 0.1 11:13:16 INFO - mozdevice == 0.48 11:13:16 INFO - mozfile == 1.2 11:13:16 INFO - mozhttpd == 0.7 11:13:16 INFO - mozinfo == 0.9 11:13:16 INFO - mozleak == 0.1 11:13:16 INFO - mozlog == 3.1 11:13:16 INFO - moznetwork == 0.27 11:13:16 INFO - mozprocess == 0.22 11:13:16 INFO - mozprofile == 0.28 11:13:16 INFO - mozrunner == 6.11 11:13:16 INFO - mozscreenshot == 0.1 11:13:16 INFO - mozsystemmonitor == 0.0 11:13:16 INFO - moztest == 0.7 11:13:16 INFO - mozversion == 1.4 11:13:16 INFO - psutil == 3.1.1 11:13:16 INFO - requests == 1.2.3 11:13:16 INFO - wsgiref == 0.1.2 11:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 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 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:16 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 11:13:16 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 11:13:16 INFO - Using env: {'DISPLAY': ':0', 11:13:16 INFO - 'HOME': '/home/cltbld', 11:13:16 INFO - 'LANG': 'en_US.UTF-8', 11:13:16 INFO - 'LANGUAGE': 'en_US:en', 11:13:16 INFO - 'LOGNAME': 'cltbld', 11:13:16 INFO - 'MAIL': '/var/mail/cltbld', 11:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:16 INFO - 'MOZ_NO_REMOTE': '1', 11:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:16 INFO - 'NO_EM_RESTART': '1', 11:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:16 INFO - 'PWD': '/builds/slave/test', 11:13:16 INFO - 'SHELL': '/bin/bash', 11:13:16 INFO - 'SHLVL': '1', 11:13:16 INFO - 'TERM': 'linux', 11:13:16 INFO - 'TMOUT': '86400', 11:13:16 INFO - 'USER': 'cltbld', 11:13:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:16 INFO - '_': '/tools/buildbot/bin/python'} 11:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 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)) 11:13:16 INFO - Cleaning up... 11:13:16 INFO - Return code: 0 11:13:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:13:16 INFO - Using env: {'DISPLAY': ':0', 11:13:16 INFO - 'HOME': '/home/cltbld', 11:13:16 INFO - 'LANG': 'en_US.UTF-8', 11:13:16 INFO - 'LANGUAGE': 'en_US:en', 11:13:16 INFO - 'LOGNAME': 'cltbld', 11:13:16 INFO - 'MAIL': '/var/mail/cltbld', 11:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:16 INFO - 'MOZ_NO_REMOTE': '1', 11:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:16 INFO - 'NO_EM_RESTART': '1', 11:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:16 INFO - 'PWD': '/builds/slave/test', 11:13:16 INFO - 'SHELL': '/bin/bash', 11:13:16 INFO - 'SHLVL': '1', 11:13:16 INFO - 'TERM': 'linux', 11:13:16 INFO - 'TMOUT': '86400', 11:13:16 INFO - 'USER': 'cltbld', 11:13:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:16 INFO - '_': '/tools/buildbot/bin/python'} 11:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:17 INFO - Downloading/unpacking jsonschema 11:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:18 INFO - Downloading/unpacking functools32 (from jsonschema) 11:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:19 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:19 INFO - warning: no files found matching '*.txt' 11:13:19 INFO - no previously-included directories found matching 'build' 11:13:19 INFO - no previously-included directories found matching 'dist' 11:13:19 INFO - no previously-included directories found matching '.git*' 11:13:19 INFO - Installing collected packages: jsonschema, functools32 11:13:19 INFO - Running setup.py install for functools32 11:13:19 INFO - warning: no files found matching '*.txt' 11:13:19 INFO - no previously-included directories found matching 'build' 11:13:19 INFO - no previously-included directories found matching 'dist' 11:13:19 INFO - no previously-included directories found matching '.git*' 11:13:19 INFO - Successfully installed jsonschema functools32 11:13:19 INFO - Cleaning up... 11:13:19 INFO - Return code: 0 11:13:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:13:19 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')]} 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 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')]} 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 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 0x7f02d2bc8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1574410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, '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': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', '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 11:13:19 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 11:13:19 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 11:13:19 INFO - Using env: {'DISPLAY': ':0', 11:13:19 INFO - 'HOME': '/home/cltbld', 11:13:19 INFO - 'LANG': 'en_US.UTF-8', 11:13:19 INFO - 'LANGUAGE': 'en_US:en', 11:13:19 INFO - 'LOGNAME': 'cltbld', 11:13:19 INFO - 'MAIL': '/var/mail/cltbld', 11:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:19 INFO - 'MOZ_NO_REMOTE': '1', 11:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:19 INFO - 'NO_EM_RESTART': '1', 11:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:19 INFO - 'PWD': '/builds/slave/test', 11:13:19 INFO - 'SHELL': '/bin/bash', 11:13:19 INFO - 'SHLVL': '1', 11:13:19 INFO - 'TERM': 'linux', 11:13:19 INFO - 'TMOUT': '86400', 11:13:19 INFO - 'USER': 'cltbld', 11:13:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:19 INFO - '_': '/tools/buildbot/bin/python'} 11:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:19 INFO - Downloading/unpacking flake8 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:22 INFO - no previously-included directories found matching 'docs/_build' 11:13:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:22 INFO - Running setup.py install for pep8 11:13:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:22 INFO - no previously-included directories found matching 'docs/_build' 11:13:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:22 INFO - Cleaning up... 11:13:22 INFO - Return code: 0 11:13:22 INFO - Running post-action listener: _resource_record_post_action 11:13:22 INFO - Running post-action listener: _start_resource_monitoring 11:13:22 INFO - Starting resource monitoring. 11:13:22 INFO - ##### 11:13:22 INFO - ##### Running install step. 11:13:22 INFO - ##### 11:13:22 INFO - Running pre-action listener: _resource_record_pre_action 11:13:22 INFO - Running main action method: install 11:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:22 INFO - Reading from file tmpfile_stdout 11:13:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:22 INFO - Reading from file tmpfile_stdout 11:13:22 INFO - Output received: 11:13:22 INFO - Usage: mozinstall [options] installer 11:13:22 INFO - Options: 11:13:22 INFO - -h, --help show this help message and exit 11:13:22 INFO - -d DEST, --destination=DEST 11:13:22 INFO - Directory to install application into. [default: 11:13:22 INFO - "/builds/slave/test"] 11:13:22 INFO - --app=APP Application being installed. [default: firefox] 11:13:22 INFO - mkdir: /builds/slave/test/build/application 11:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:13:35 INFO - Reading from file tmpfile_stdout 11:13:35 INFO - Output received: 11:13:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:35 INFO - Running post-action listener: _resource_record_post_action 11:13:35 INFO - ##### 11:13:35 INFO - ##### Running run-tests step. 11:13:35 INFO - ##### 11:13:35 INFO - Running pre-action listener: _resource_record_pre_action 11:13:35 INFO - Running main action method: run_tests 11:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:35 INFO - Python 2.7.3 11:13:35 INFO - Return code: 0 11:13:35 INFO - grabbing minidump binary from tooltool 11:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:35 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1603160>, '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 0x1604060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16044f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:35 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 11:13:35 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 11:13:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:35 INFO - Return code: 0 11:13:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:36 INFO - Return code: 0 11:13:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:13:36 INFO - Using env: {'DISPLAY': ':0', 11:13:36 INFO - 'HOME': '/home/cltbld', 11:13:36 INFO - 'LANG': 'en_US.UTF-8', 11:13:36 INFO - 'LANGUAGE': 'en_US:en', 11:13:36 INFO - 'LOGNAME': 'cltbld', 11:13:36 INFO - 'MAIL': '/var/mail/cltbld', 11:13:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:36 INFO - 'MOZ_NO_REMOTE': '1', 11:13:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:36 INFO - 'NO_EM_RESTART': '1', 11:13:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:36 INFO - 'PWD': '/builds/slave/test', 11:13:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:36 INFO - 'SHELL': '/bin/bash', 11:13:36 INFO - 'SHLVL': '1', 11:13:36 INFO - 'TERM': 'linux', 11:13:36 INFO - 'TMOUT': '86400', 11:13:36 INFO - 'USER': 'cltbld', 11:13:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413', 11:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:36 INFO - '_': '/tools/buildbot/bin/python'} 11:13:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:13:36 INFO - mozversion application_buildid: 20160522193137 11:13:36 INFO - mozversion application_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:13:36 INFO - mozversion application_display_name: Firefox 11:13:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:36 INFO - mozversion application_name: Firefox 11:13:36 INFO - mozversion application_remotingname: firefox 11:13:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:36 INFO - mozversion application_vendor: Mozilla 11:13:36 INFO - mozversion application_version: 47.0 11:13:36 INFO - mozversion platform_buildid: 20160522193137 11:13:36 INFO - mozversion platform_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:13:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:36 INFO - mozversion platform_version: 47.0 11:13:36 INFO - using testdate: 1464027216 11:13:36 INFO - actual date: 1464027216 11:13:36 INFO - starting webserver on 'localhost:44714' 11:13:36 INFO - SUITE-START | Running 2 tests 11:13:36 INFO - TEST-START | dromaeo_css 11:13:36 INFO - operating with platform_type : linux_ 11:13:36 INFO - Initialising browser for dromaeo_css test... 11:13:36 INFO - TEST-INFO | started process 28972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_n7MB6/profile http://localhost:44714/getInfo.html) 11:13:40 INFO - PROCESS | 28972 | __metrics Screen width/height:1600/1200 11:13:40 INFO - PROCESS | 28972 | colorDepth:24 11:13:40 INFO - PROCESS | 28972 | Browser inner width/height: 1024/697 11:13:40 INFO - PROCESS | 28972 | __metrics 11:13:41 INFO - PROCESS | 28972 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:42 INFO - TEST-INFO | 28972: exit 0 11:13:42 INFO - Browser initialized. 11:13:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:42 INFO - TEST-INFO | started process 29062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_n7MB6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:54 INFO - PROCESS | 29062 | RSS: Main: 139886592 11:13:54 INFO - PROCESS | 29062 | 11:14:45 INFO - PROCESS | 29062 | 1464027285586 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] 11:16:53 INFO - PROCESS | 29062 | Cycle 1(1): loaded http://localhost:44714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44714/tests/dromaeo/cssquery-ext.html) 11:16:54 INFO - PROCESS | 29062 | RSS: Main: 258199552 11:16:54 INFO - PROCESS | 29062 | 11:19:56 INFO - PROCESS | 29062 | Cycle 1(1): loaded http://localhost:44714/tests/dromaeo/cssquery-ext.html (next: http://localhost:44714/tests/dromaeo/cssquery-jquery.html) 11:19:56 INFO - PROCESS | 29062 | RSS: Main: 223281152 11:19:56 INFO - PROCESS | 29062 | 11:22:58 INFO - PROCESS | 29062 | Cycle 1(1): loaded http://localhost:44714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44714/tests/dromaeo/cssquery-mootools.html) 11:22:59 INFO - PROCESS | 29062 | RSS: Main: 232505344 11:22:59 INFO - PROCESS | 29062 | 11:26:00 INFO - PROCESS | 29062 | Cycle 1(1): loaded http://localhost:44714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44714/tests/dromaeo/cssquery-prototype.html) 11:26:01 INFO - PROCESS | 29062 | RSS: Main: 207269888 11:26:01 INFO - PROCESS | 29062 | 11:29:03 INFO - PROCESS | 29062 | Cycle 1(1): loaded http://localhost:44714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44714/tests/dromaeo/cssquery-yui.html) 11:29:04 INFO - PROCESS | 29062 | RSS: Main: 207323136 11:29:04 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | Cycle 1(1): loaded http://localhost:44714/tests/dromaeo/cssquery-yui.html (next: http://localhost:44714/tests/dromaeo/cssquery-dojo.html) 11:32:06 INFO - PROCESS | 29062 | RSS: Main: 253292544 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | __start_tp_report 11:32:06 INFO - PROCESS | 29062 | _x_x_mozilla_page_load 11:32:06 INFO - PROCESS | 29062 | _x_x_mozilla_page_load_details 11:32:06 INFO - PROCESS | 29062 | |i|pagename|runs| 11:32:06 INFO - PROCESS | 29062 | |0;dojo.html;3271.607407111147;3368.124287685201;3381.4589665653502;3387.508811222373;3428.3828910796046;5480.3971563128025;5485.561155107597;5497.972510137449;5500.257465242191;5501.504864562188;5461.617686761918;5489.752961116749;5494.2582751328555;5495.450454954503;5499.3675727291375;4847.51524847516;4951.108800415933;4971.773992106717;5042.873928151789;5056.570191533724;4933.555979961803;4997.000599880039;5001.724905130234;5002.599792016648;5008.29883816266;4965.056639238551;5010.423801262847;5016.523430274118;5019.623528235379;5020.4226513951;4982.302477653131;4994.2009278515625;5011.674241174312;5017.64876458648;5047.141985862412;4864.0515099555605;4891.364122664067;4970.577500912426;4970.602351811846;4992.775325110379;5358.410574836765;5368.277183076096;5369.570434365281;5373.731313434313;5378.193271009341;5826.504747096502;5852.619579727304;5878.911816322759;5888.411158884121;5889.911651325234;5914.645121292736;5915.911261331084;5920.703964801743;5924.259467566554;5940.227770389865;5536.557075433956;5544.112941929312;5545.972270138664;5546.889062218774;5554.833354999357;5841.707914604252;5930.644161350333;6025.066114752132;6033.9742243818655;6058.030715085565;5780.5953583248765;5784.566157538202;5789.53683705311;5789.710514474259;5791.478766910998;5876.9118463223085;5900.704964751745;5909.881802363929;5913.940860591425;5914.378990206053;5791;5799.130130480462;5907.172995780594;5924.259467566554;5937.168796368512;5770.509506691894;5815.360310365856;5817.88364232713;5822.7088645567555;5825.155352473952;4390.209762242827;4395.296752519645;4399.098184872094;4399.340098985178;4426.778661066934;4021.1354558770004;4073.674106071507;4085.59144085595;4085.9387109193385;4130.297849365615;5528.585356098229;5529.115341545414;5536.307961504812;5543.279373681396;5545.556355491551;5763.7406316715005;5854.326752423526;5878.500327472213;5878.794242201502;5943.732532035982;5535.6955367455175;5569.55443564522;5592.245046918695;5593.825296687741;5616.045272303718;5053.2420136979745;5060.873478163002;5073.061483625541;5076.695398276115;5097.057044446789;5996.640201587918;6067.817965461043;6069.3627169147485;6113.724882380304;6124.755009799647;5938.198343223609;5948.315943666361;5948.851278718067;5954.196183515343;5962.25471816023;6047.213862197887;6049.455549000611;6050.183225264533;6054.788082417094;6055.5458340623745;5713.628614140068;5848.678322692293;5852.356240813592;5940.61386009908;5958.404159584007;5978.073398623221;5994.790182343597;6007.519398448201;6012.038073908328;6015.789447369321;5783.566232532493;5831.1544826000845;5841.036229022334;5841.620294680833;5842.970785146217;5666.744996475086;5738.684372359393;5841.883162336814;5842.883142337215;5862.618929769551;5659.151127330933;5660.575456840671;5687.203791469115;5687.77248910039;5689.601727879009;5644.6330988485615;5751;5773.24947756789;5800.709964501673;5826.242588463642;5529.944700552943;5576.972115139399;5615.831525054255;5631.211630371669;5730.283714535683 11:32:06 INFO - PROCESS | 29062 | |1;ext.html;544.170140535683;559.1891756952418;585.0989476206641;618.6628287583267;652.7356420649636;37681.623183768155;38132.809335953316;38190.42714359283;38303.80848095756;38331.80834095833;41270;41703.79148104263;41865.16269674605;42017;42106;8728.51993140377;8924.955375223115;8941.910580894206;8945.910540894572;8950.060243674418;8958.462492250454;9166.22087122592;9168.770780730469;9172.495512746797;9178.128077832594;9127.452352858816;9228.077192280785;9246.53767311635;9246.583903724315;9250;9082.636694532244;9096.727098187064;9144.588493517807;9175.58709858058;9178.770530736718;9053.59258833354;9193.678221262291;9197.21823644991;9207.953960230223;9216.078392160798;42715.35926961067;42814.78592607048;43186.35220471695;43197.78401108006;43213.35179972272;3711.183539621279;3754.8310326035394;3856.749311294785;4479.350494178326;4502.302143167814;32352.83823580867;32557.6744232557;32565.83717081423;32644.510332345035;32720.345593088245;4111.1366613011305;4232.640225580829;4256;4260.826281732205;4283.764392958386;277796;278547;279102.6044869783;281040;283433;42803.785981069894;42912.78543607262;42914.356284655754;59367;59853.401465985655;42045.579544204775;42198.15603687909;42529.36205956913;42643.57356426458;42651;14824.3329050193;15002.174880381466;15037.699246015018;15053.473128440672;15057.623559411102;11739.826017398364;11776.11679124069;11810.468528916219;11855.525778968917;11895.107866909842;15074.397024119131;15230.771538426932;15249.542513724606;15281.770773438408;15411.768823467657;5697.743601537941;5937.317208520989;5946.494547963472;5989.880202396015;6067.575269731076;973.5035132082547;993.5181437003048;1055.7413433708791;1060.1148041385375;1144.5707859552667;28903.85548072246;29178.85410572976;29722.10833674993;29985.850070749508;30005.69994300029;1096.1011970184372;1120.4733775125678;1155.1509640414456;1205.1864991130951;1209.498058305811;14296.857031429552;14795.482158124414;14832.703345933021;14847.2576371181;15021.849781502264;355202;358362;359867;360956;362315;56226.15660765092;56874.43125568774;56953;56969.14546281809;57275.7089716415;1362.7751421015619;1441.3369849868968;1454.9490767823074;1464.1654257073367;1491.328901994107;26664.733352667;27214.183574492796;27760;27807.44385112327;29812;46295;46621.76689116532;46812.53187468082;46837.53162468332;46944.29583556318;197514;197999;198296;198562;198981;28468.861245549946;32700.182495436853;33428.832855835564;34223.31553368869;34708.13229669177;40021.95937515689;40681.38977915274;43969.560304397826;44349;44489.33266000948;36802;37199;37207;37270;37513.81243093767;36394.4540831893;36497.452538211415;37091;37146.25707485889;37169.25661486701;36611.63388366082;37105.44341834821;37800;37941;38494;32418.67581324251;33313.83343083269;33688.1577960553;33694.66305336915;33835;25343.239702808944;25779;26124.477510449306;26726.331841703333;26727.732722672525 11:32:06 INFO - PROCESS | 29062 | |2;jquery.html;372.6236501133855;382.3061144023596;385.43918598439274;386.6539447194761;394.08178943062666;17357.132143392842;18367.908160459196;19067;19069.90465047673;19095.045247737628;12211.20627159234;12538.059645526577;12543.435545400456;12556.874431255685;12573.057020723436;5118.6416950813555;5147.459516750743;5723.284589426322;5723.341815691187;5727.427257274281;5589.469000444951;5639.041362968284;5644.915326270109;5650.0959846424585;5651.463111004448;5446.564274858002;5628.887422251552;5631.18347839563;5634.267545219136;5655.5475561954945;5615.522680572136;5617.494425501704;5623.325200975909;5631.239782629334;5663.405342439026;5687.459691329317;5721.256236689203;5722.742476588522;5727.627704199213;5730.598858079936;13680.384382702803;13869.306534673226;17663.293468261254;20566.177352905866;20594.79405205944;2334.7198336199594;2367.5146594947996;2377.7978871795917;2431.635254711807;2502.78726308264;9970.501474926297;10526.263161578692;11032.834507482394;12520.624381268577;13608.659783505393;1953.150379584885;1958.9020548972494;1965.1451618545977;2033.9288124915556;2040.1941233212797;51537.22694159591;60153.69923150356;63709;64609.353906460805;69860.3013969864;10260.640877569249;10643.46782660864;10654.307470014424;10816.756073051542;10817.080548153495;13590.524331648543;14091.647708807363;14591.12453252787;14619.19594422317;14637;7256.092988376453;7315.567854903042;7830;7859.331956783737;7876.330511906552;7358.77923662291;7366.373858222004;7414.369778568882;7455.85088298231;7458.179600243969;4707.411573553306;4715.127701375257;4719.10337035962;4737.526247375304;4739.312799644102;1795.3446991847882;1963.1165975311167;1974.871633343828;2010.45717656232;2014.5366565689974;912.4114945859883;968.9563969621383;980.5048450532436;1043.5512729526224;1087.7171935296722;17415.39046133379;17520.824791752173;17553.736693949602;18027.2789088435;18255.72616410755;969.1616751510035;983.0660872171466;987.7382493639192;993.0962823830424;1015.9796804064025;9997.850032249522;10217.18262538995;10243.180545556486;10288.948555257175;10324.741881452874;428113;433148;441103;450164;451994;75282.24717752862;78274.21725782669;78275.60862195652;78522.21477785263;78743;1049.2655141401049;1050.3855244681947;1059.7615536504225;1088.1675518228562;1093.9617113400993;15577.766333505233;15917.204139793195;16048.839511605202;16072.839271607134;16140.919295403448;27421.588676169475;27788.722112778614;32618.34763304673;34532.82733586316;35341.46987795237;44911.77544112258;45896.770516147204;46009;46463.76768116138;46528.53471465242;5536.086545719912;8362.540060296498;8467.322614190727;8524.403291769517;8679.045305016569;13115.803262950873;13551.932240339129;13628.93185534066;13637.931810340884;13658.795118073038;11265.549378024787;11993.700157496132;12064.276143431422;12070.45682944252;12104.213226140273;11724.765504690029;11744.942955134078;11897.464614092214;12078.758424831278;12101.092418068503;12115.394230288626;12115.939420303195;12165.635030949086;12248.571300004458;12416.379181040731;8874.156955089256;8937.106289371271;9004.63981440735;9005.459672419676;9102.08979102111;9550.617975280911;11973.880261197624;12096;12227.572034978733;12375.319357435428 11:32:06 INFO - PROCESS | 29062 | |3;mootools.html;1423.9074460160082;1545.6908618276345;1546.5669612508495;1752.5706201980518;1862.264405559803;7784.260495252956;7932.6430310636015;7958.602069896504;7972.402069844756;7979.880301795478;7994.200579942018;8127.837443251132;8148.348132149428;8164.22439868213;8169.550674712888;2419.4677171022436;2444.1079006162713;2447.608382658775;2448.4980578981354;2451.3013791069548;2430.987845060772;2448.7796098351146;2492;2504.0734928076636;2506.135383292761;2433.707955045397;2435.622478515833;2446.2661201639526;2446.3639453742067;2446.376174075608;2437.5612389769835;2439.0853429963763;2466.0382450844095;2484.3789052736815;2506.0852788732163;2462.236706620953;2484.2795589279267;2487.7885379742743;2495.4759500504915;2499.3626625210454;8301.211384918484;8314.750557483285;8327.375446841512;8332.33341332698;8342.791430214233;4978.054169707744;5123;5145.974270128663;5166.7416629168765;5167.7932882684645;3272.6072871255365;3313.966860331414;3371.477420999749;3474.808885511296;3477.8434970426392;1144.2558357047574;1153.0832987774738;1163.976720465586;1170.6897672116895;1200.9399530023463;11787.233829801036;11787.823182652268;11795.29228246308;11795.823062654066;11823.408829558488;4549.840755573539;4683.367745354401;4697.10754956564;4767.73777442244;4778.593819525379;9845.212383009342;9855.45794981283;9864.852027219598;9866.901330986599;9871.457069861226;5157.716325602128;5162.9741851291255;5167.224916262516;5167.6641018333685;5168.0697474454955;3965.2267807777207;4647.442306923191;4691.390119284471;4693.671442999025;4698.671093023456;3822.9426558601645;3889.4360317753767;3893.201893611803;3937.448757173998;3949.19041596472;1249.4377530111306;1251.7308778612642;1259.9181053231512;1287.819705241267;1292.2311224821217;1412.159764939859;1419.9432022719182;1431.6492459347526;1455.4978532406303;1487.0259979713305;7892.4869883457395;7906.604669766603;7990.20097990208;7991.081025682005;7999.800004999922;554.7503623369419;556.2074044486591;557.7350758389732;557.8605348662834;564.0580231014216;6162.014077747539;6187.566870319124;6188.690565471708;6191.659458729813;6241.594296370721;10139.188864890792;10253.538590763284;10463.05832475081;10463.215258855464;10471.05760481545;9632.9036709632;10225.897741022494;10237.539310731036;10270.691879243635;10274.383536987805;7626.275503827239;7755.68977240904;7795.727149549852;7842.215778422226;7853.607319633996;7713.42149338813;7766.339861111643;7861.685532578862;7865.803354916173;7902.091259505;8711.91288087111;8796.516191609522;8892.466452012899;9111.681091161778;9134.954325228331;9015.909840901508;9155.679551215942;9200.079992000747;9400.529973501161;9447.385919915183;6489.643069631215;7150.213476517475;7313.122425308997;7408.185099638928;7511.812204694927;7960.601969901598;7972.561509117054;7986.001749781278;8018.198180181935;8020.278174964281;7109.502334836512;7231.4214862811905;7263.564186148848;7340.302671246223;7416.6291685414435;6925.168979722465;6959.304069593;7039.894401583878;7055.823604409726;7098.929010709827;7432.665530051268;7752.8449431012195;7760.611969401394;7771.650275737718;7771.844563108819;6884.139482564679;6964.825879352854;6969.059177011039;6972.023916651571;6976.720931162697;6994.440444764508;7042.647867606702;7065.964670176616;7128.28717128283;7141.3572778448115 11:32:06 INFO - PROCESS | 29062 | |4;prototype.html;360.4917066935621;366.5235194247479;367.43048275173476;370.10434747910057;374.99062523436913;6072.514198864092;6092.634441933487;6134.417230363119;6171.907421388682;6177.320494745574;6055.909161362583;6059.697015149247;6066.969665151679;6074.969625151879;6076.058210977306;4456.710313829607;4573.8170473181035;4686.90626187476;4739.36018637483;4757.0723708876785;4727.409073865767;4746.501617330183;4750.1924672805535;4754.738489383082;4759.262314341283;4707.482176960531;4721.622270218374;4729;4734.881627959294;4743.383360163174;4454.777261136946;4582.33556134362;4701.7414042227665;4722.834700785456;4726.385569875894;4189.664826813878;4192.748435093904;4198.160367926427;4203.453551038376;4209.852655157055;5781.335146458169;5804.65172089676;5812.273465816773;5818.185454036438;5820.592558520905;5506.5870059745275;5512.80705175317;5517.5585953123655;5520.3651580068;5530.032244357221;6402.647854368008;6403.103565500834;6406.615603063831;6410.935890641127;6424.839379015562;4548.545145485458;4625.444946606429;4645.279981602857;4660.930086048712;4689.109069276827;6573.671316434159;6669.633170175638;6728.394444500019;6747.460203183734;6753.561018533829;4834.20235661112;4835.879103022453;4843.975780121077;4845.103655823684;4845.878853028703;4906.460289368167;4908.092002979389;4913.336699545515;4915.188993816052;4922.163232250526;5540.418256083053;5547.223388725582;5550.195221692832;5558.805441809517;5564.360098588714;6218.502519798405;6502.739890404426;6511.804645860631;6512.869742605121;6518.217813862367;1710.5381546982494;1719.974200386995;1730.4895055958523;1734.17626627351;1734.4623166818326;1080.708208783624;1147.6671765188169;1160.5763896177834;1188.5602327139013;1191.6782468733393;6078.392160783975;6079.392060793885;6103.328633850273;6165.599236049642;6168.19813424252;6611.371919667624;6613.173353330833;6646.83382915431;6655.0682904393425;6658.800235992928;6157.0456579230295;6157.415045570664;6162.476189523941;6164.352742962014;6164.938350616526;3549.964500355015;3588.515550400715;3592.4431713084514;3594.9281014379567;3595.1551385424405;6618.503612229006;6776.9322306777285;6831.931680683129;6906.033155358254;6932.792016239521;6855.280195579392;6862.519623626298;6891.173059232924;6897.620630865351;6910.654467276616;6887.862242755117;6892.862142757217;6896.620685862225;6901.309869013159;6906.343897329745;6740.12378390806;6744.190697116377;6745.156855393076;6752;6755.324467553205;6443.871122577616;6577.473802095917;6577.736890524517;6602.702878370389;6603.933960660332;6860.348266914635;6880.621565813928;6881.036654868422;6895.6552172390175;6905.135613384458;4601.608863246662;4638.026014536985;4649.186392381387;4650.744209068534;4658.627309815139;6727.663616819042;6729.327067293231;6729.966350168218;6731.730730770911;6744.8651026978205;6361.656641966137;6489.935100648933;6513.185851768529;6537.084808126961;6537.738490460329;6496.967515162394;6528.706208220547;6529.151210342625;6530.216374035146;6538.084668146558;6385.616862988236;6391.712372943136;6394.680265986589;6397.552171347961;6400.327965563735;6542.182227221598;6548.738050477928;6552.934470655423;6553.148090748172;6553.311902250195;6009.639421634716;6063.242094738158;6188.319284878569;6313.621182729051;6330.620162790247 11:32:06 INFO - PROCESS | 29062 | |5;yui.html;833.9958300208498;841.1966571923813;845.6913226672262;847.5804476783991;847.8473874702551;16411.58971025725;16499.34002639896;16504;16571.83428165718;16602.418915337967;15103.39586416542;15148.848511514909;15148.924255378708;15170.469033583826;15218.695626087472;769.2499812682646;893.5353616119614;914.3599480363739;933.9206167475738;935.8923723771785;924.6994726713812;926.0507979321183;935.4714586258776;937.4328531238605;938.4041133880002;958.018031517693;961.7355227312476;966.0966995858895;966.2125367825236;968.8982656821038;801.3869389916719;934.1265916368184;942.3026960049583;945.1257586732245;946.6828612414815;686.354826463128;698.4098436820879;701.6351497221416;701.6667083135521;702.4977141343963;14341.713165736732;14533.636659083502;14556;14572.708545829024;14574.635634109127;12928.224306541637;13252.403641836141;13600.123348105217;13814.240216788072;13834.723305533933;11293.943530282379;11314.321140731583;11352.318860868374;11443.771124577544;11583.710407239801;3679.6136405677285;3690.8708195213308;3734.402495600718;3778.981105094457;3827;51348.74325628385;51480;51812;52023.69940751474;52736;9965.701028969142;9990;10058;10128.291019628556;10206.234532410099;18275.268989240547;18332.266709331478;18595.81404185941;18634.068296585116;18664.34674786376;8002.319802816825;8060.032796064393;8076.152004039609;8139.348852091818;8414.537200453911;4568.657350698644;4582.152301824173;4640.721556706609;4662.626989840873;4694.647901407408;3323.3685599735973;3359.630440651575;3373.8313084345687;3376.493525971124;3383.424817780983;557.4147145497212;578.5834199376442;601.3054921565599;629.2260519560965;629.7701339011228;573.3377948469524;640.9070684750685;712.3837880233664;713.333033613573;723.5803234124195;8850.867236991451;8948.642054317885;8995.955020224857;9269.768255793659;9344.672936447192;652.7682672651235;703.9084918960502;710.1726488640676;712.1134187936053;719.4819729794644;4102.323116685773;4139.668826493873;4168.958310416918;4328.480582330078;4350.58669426404;57329;57378.426215738145;58251.12623310654;58329.4167058324;58800.7059964706;54425.72787136118;55345.72327138339;55501.722491387285;55728.44271557314;56056;49821.25268120981;49969.500304997215;50266.49733502618;50792.49207507951;51518.22722659088;7748.643987302312;7944.205579442009;8263.545504997042;8483.95758021206;8509.234168924826;37387.43918841165;37943.810280949525;37962;39735;39939;42884.35673464963;45237.32144017908;47928;48362.274565880834;48849.75575122102;10810.56757729682;11018.944905275423;12157.1489995703;12519.687007824878;12587.118901676795;12816.423260953467;12997.675058123623;13042.673933151747;13059.477620895437;13151.21092734439;10722.303050301705;11253.043491303331;11810.645680629596;12016.63950081499;12369.072319575887;11384.089272858317;11537.250078744855;12100.697482563006;12190.329531875832;12218.20581662189;10847;11310.660680179608;11317.320960742381;11340.716482088013;11629.59296424621;9584.37701549397;10143.28996970205;10257.384556926609;10345.37927724339;10443.843342349719;10209.84685229737;10421.374717516974;10498.055175034284;10513.421761803174;10554.050135487843 11:32:06 INFO - PROCESS | 29062 | __end_tp_report 11:32:06 INFO - PROCESS | 29062 | __start_cc_report 11:32:06 INFO - PROCESS | 29062 | _x_x_mozilla_cycle_collect,925 11:32:06 INFO - PROCESS | 29062 | __end_cc_report 11:32:06 INFO - PROCESS | 29062 | __startTimestamp1464028326909__endTimestamp 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | ------- Summary: start ------- 11:32:06 INFO - PROCESS | 29062 | Number of tests: 6 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | [#0] dojo.html Cycles:165 Average:5468.78 Median:5666.74 stddev:605.38 (10.7%) stddev-sans-first:582.18 11:32:06 INFO - PROCESS | 29062 | Values: 3271.6 3368.1 3381.5 3387.5 3428.4 5480.4 5485.6 5498.0 5500.3 5501.5 5461.6 5489.8 5494.3 5495.5 5499.4 4847.5 4951.1 4971.8 5042.9 5056.6 4933.6 4997.0 5001.7 5002.6 5008.3 4965.1 5010.4 5016.5 5019.6 5020.4 4982.3 4994.2 5011.7 5017.6 5047.1 4864.1 4891.4 4970.6 4970.6 4992.8 5358.4 5368.3 5369.6 5373.7 5378.2 5826.5 5852.6 5878.9 5888.4 5889.9 5914.6 5915.9 5920.7 5924.3 5940.2 5536.6 5544.1 5546.0 5546.9 5554.8 5841.7 5930.6 6025.1 6034.0 6058.0 5780.6 5784.6 5789.5 5789.7 5791.5 5876.9 5900.7 5909.9 5913.9 5914.4 5791.0 5799.1 5907.2 5924.3 5937.2 5770.5 5815.4 5817.9 5822.7 5825.2 4390.2 4395.3 4399.1 4399.3 4426.8 4021.1 4073.7 4085.6 4085.9 4130.3 5528.6 5529.1 5536.3 5543.3 5545.6 5763.7 5854.3 5878.5 5878.8 5943.7 5535.7 5569.6 5592.2 5593.8 5616.0 5053.2 5060.9 5073.1 5076.7 5097.1 5996.6 6067.8 6069.4 6113.7 6124.8 5938.2 5948.3 5948.9 5954.2 5962.3 6047.2 6049.5 6050.2 6054.8 6055.5 5713.6 5848.7 5852.4 5940.6 5958.4 5978.1 5994.8 6007.5 6012.0 6015.8 5783.6 5831.2 5841.0 5841.6 5843.0 5666.7 5738.7 5841.9 5842.9 5862.6 5659.2 5660.6 5687.2 5687.8 5689.6 5644.6 5751.0 5773.2 5800.7 5826.2 5529.9 5577.0 5615.8 5631.2 5730.3 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | [#1] ext.html Cycles:180 Average:44818.96 Median:20634.32 stddev:75150.77 (364.2%) stddev-sans-first:75288.06 11:32:06 INFO - PROCESS | 29062 | Values: 544.2 559.2 585.1 618.7 652.7 37681.6 38132.8 38190.4 38303.8 38331.8 41270.0 41703.8 41865.2 42017.0 42106.0 8728.5 8925.0 8941.9 8945.9 8950.1 8958.5 9166.2 9168.8 9172.5 9178.1 9127.5 9228.1 9246.5 9246.6 9250.0 9082.6 9096.7 9144.6 9175.6 9178.8 9053.6 9193.7 9197.2 9208.0 9216.1 42715.4 42814.8 43186.4 43197.8 43213.4 3711.2 3754.8 3856.7 4479.4 4502.3 32352.8 32557.7 32565.8 32644.5 32720.3 4111.1 4232.6 4256.0 4260.8 4283.8 277796.0 278547.0 279102.6 281040.0 283433.0 42803.8 42912.8 42914.4 59367.0 59853.4 42045.6 42198.2 42529.4 42643.6 42651.0 14824.3 15002.2 15037.7 15053.5 15057.6 11739.8 11776.1 11810.5 11855.5 11895.1 15074.4 15230.8 15249.5 15281.8 15411.8 5697.7 5937.3 5946.5 5989.9 6067.6 973.5 993.5 1055.7 1060.1 1144.6 28903.9 29178.9 29722.1 29985.9 30005.7 1096.1 1120.5 1155.2 1205.2 1209.5 14296.9 14795.5 14832.7 14847.3 15021.8 355202.0 358362.0 359867.0 360956.0 362315.0 56226.2 56874.4 56953.0 56969.1 57275.7 1362.8 1441.3 1454.9 1464.2 1491.3 26664.7 27214.2 27760.0 27807.4 29812.0 46295.0 46621.8 46812.5 46837.5 46944.3 197514.0 197999.0 198296.0 198562.0 198981.0 28468.9 32700.2 33428.8 34223.3 34708.1 40022.0 40681.4 43969.6 44349.0 44489.3 36802.0 37199.0 37207.0 37270.0 37513.8 36394.5 36497.5 37091.0 37146.3 37169.3 36611.6 37105.4 37800.0 37941.0 38494.0 32418.7 33313.8 33688.2 33694.7 33835.0 25343.2 25779.0 26124.5 26726.3 26727.7 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | [#2] jquery.html Cycles:180 Average:25629.14 Median:27605.16 stddev:72280.13 (261.8%) stddev-sans-first:72458.02 11:32:06 INFO - PROCESS | 29062 | Values: 372.6 382.3 385.4 386.7 394.1 17357.1 18367.9 19067.0 19069.9 19095.0 12211.2 12538.1 12543.4 12556.9 12573.1 5118.6 5147.5 5723.3 5723.3 5727.4 5589.5 5639.0 5644.9 5650.1 5651.5 5446.6 5628.9 5631.2 5634.3 5655.5 5615.5 5617.5 5623.3 5631.2 5663.4 5687.5 5721.3 5722.7 5727.6 5730.6 13680.4 13869.3 17663.3 20566.2 20594.8 2334.7 2367.5 2377.8 2431.6 2502.8 9970.5 10526.3 11032.8 12520.6 13608.7 1953.2 1958.9 1965.1 2033.9 2040.2 51537.2 60153.7 63709.0 64609.4 69860.3 10260.6 10643.5 10654.3 10816.8 10817.1 13590.5 14091.6 14591.1 14619.2 14637.0 7256.1 7315.6 7830.0 7859.3 7876.3 7358.8 7366.4 7414.4 7455.9 7458.2 4707.4 4715.1 4719.1 4737.5 4739.3 1795.3 1963.1 1974.9 2010.5 2014.5 912.4 969.0 980.5 1043.6 1087.7 17415.4 17520.8 17553.7 18027.3 18255.7 969.2 983.1 987.7 993.1 1016.0 9997.9 10217.2 10243.2 10288.9 10324.7 428113.0 433148.0 441103.0 450164.0 451994.0 75282.2 78274.2 78275.6 78522.2 78743.0 1049.3 1050.4 1059.8 1088.2 1094.0 15577.8 15917.2 16048.8 16072.8 16140.9 27421.6 27788.7 32618.3 34532.8 35341.5 44911.8 45896.8 46009.0 46463.8 46528.5 5536.1 8362.5 8467.3 8524.4 8679.0 13115.8 13551.9 13628.9 13637.9 13658.8 11265.5 11993.7 12064.3 12070.5 12104.2 11724.8 11744.9 11897.5 12078.8 12101.1 12115.4 12115.9 12165.6 12248.6 12416.4 8874.2 8937.1 9004.6 9005.5 9102.1 9550.6 11973.9 12096.0 12227.6 12375.3 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | [#3] mootools.html Cycles:180 Average:5855.13 Median:556.97 stddev:3057.54 (549.0%) stddev-sans-first:3047.97 11:32:06 INFO - PROCESS | 29062 | Values: 1423.9 1545.7 1546.6 1752.6 1862.3 7784.3 7932.6 7958.6 7972.4 7979.9 7994.2 8127.8 8148.3 8164.2 8169.6 2419.5 2444.1 2447.6 2448.5 2451.3 2431.0 2448.8 2492.0 2504.1 2506.1 2433.7 2435.6 2446.3 2446.4 2446.4 2437.6 2439.1 2466.0 2484.4 2506.1 2462.2 2484.3 2487.8 2495.5 2499.4 8301.2 8314.8 8327.4 8332.3 8342.8 4978.1 5123.0 5146.0 5166.7 5167.8 3272.6 3314.0 3371.5 3474.8 3477.8 1144.3 1153.1 1164.0 1170.7 1200.9 11787.2 11787.8 11795.3 11795.8 11823.4 4549.8 4683.4 4697.1 4767.7 4778.6 9845.2 9855.5 9864.9 9866.9 9871.5 5157.7 5163.0 5167.2 5167.7 5168.1 3965.2 4647.4 4691.4 4693.7 4698.7 3822.9 3889.4 3893.2 3937.4 3949.2 1249.4 1251.7 1259.9 1287.8 1292.2 1412.2 1419.9 1431.6 1455.5 1487.0 7892.5 7906.6 7990.2 7991.1 7999.8 554.8 556.2 557.7 557.9 564.1 6162.0 6187.6 6188.7 6191.7 6241.6 10139.2 10253.5 10463.1 10463.2 10471.1 9632.9 10225.9 10237.5 10270.7 10274.4 7626.3 7755.7 7795.7 7842.2 7853.6 7713.4 7766.3 7861.7 7865.8 7902.1 8711.9 8796.5 8892.5 9111.7 9135.0 9015.9 9155.7 9200.1 9400.5 9447.4 6489.6 7150.2 7313.1 7408.2 7511.8 7960.6 7972.6 7986.0 8018.2 8020.3 7109.5 7231.4 7263.6 7340.3 7416.6 6925.2 6959.3 7039.9 7055.8 7098.9 7432.7 7752.8 7760.6 7771.7 7771.8 6884.1 6964.8 6969.1 6972.0 6976.7 6994.4 7042.6 7066.0 7128.3 7141.4 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | [#4] prototype.html Cycles:180 Average:5444.96 Median:6097.98 stddev:1602.35 (26.3%) stddev-sans-first:1560.73 11:32:06 INFO - PROCESS | 29062 | Values: 360.5 366.5 367.4 370.1 375.0 6072.5 6092.6 6134.4 6171.9 6177.3 6055.9 6059.7 6067.0 6075.0 6076.1 4456.7 4573.8 4686.9 4739.4 4757.1 4727.4 4746.5 4750.2 4754.7 4759.3 4707.5 4721.6 4729.0 4734.9 4743.4 4454.8 4582.3 4701.7 4722.8 4726.4 4189.7 4192.7 4198.2 4203.5 4209.9 5781.3 5804.7 5812.3 5818.2 5820.6 5506.6 5512.8 5517.6 5520.4 5530.0 6402.6 6403.1 6406.6 6410.9 6424.8 4548.5 4625.4 4645.3 4660.9 4689.1 6573.7 6669.6 6728.4 6747.5 6753.6 4834.2 4835.9 4844.0 4845.1 4845.9 4906.5 4908.1 4913.3 4915.2 4922.2 5540.4 5547.2 5550.2 5558.8 5564.4 6218.5 6502.7 6511.8 6512.9 6518.2 1710.5 1720.0 1730.5 1734.2 1734.5 1080.7 1147.7 1160.6 1188.6 1191.7 6078.4 6079.4 6103.3 6165.6 6168.2 6611.4 6613.2 6646.8 6655.1 6658.8 6157.0 6157.4 6162.5 6164.4 6164.9 3550.0 3588.5 3592.4 3594.9 3595.2 6618.5 6776.9 6831.9 6906.0 6932.8 6855.3 6862.5 6891.2 6897.6 6910.7 6887.9 6892.9 6896.6 6901.3 6906.3 6740.1 6744.2 6745.2 6752.0 6755.3 6443.9 6577.5 6577.7 6602.7 6603.9 6860.3 6880.6 6881.0 6895.7 6905.1 4601.6 4638.0 4649.2 4650.7 4658.6 6727.7 6729.3 6730.0 6731.7 6744.9 6361.7 6489.9 6513.2 6537.1 6537.7 6497.0 6528.7 6529.2 6530.2 6538.1 6385.6 6391.7 6394.7 6397.6 6400.3 6542.2 6548.7 6552.9 6553.1 6553.3 6009.6 6063.2 6188.3 6313.6 6330.6 11:32:06 INFO - PROCESS | 29062 | 11:32:06 INFO - PROCESS | 29062 | [#5] yui.html Cycles:180 Average:14707.96 Median:4611.44 stddev:16915.08 (366.8%) stddev-sans-first:16930.44 11:32:06 INFO - PROCESS | 29062 | Values: 834.0 841.2 845.7 847.6 847.8 16411.6 16499.3 16504.0 16571.8 16602.4 15103.4 15148.8 15148.9 15170.5 15218.7 769.2 893.5 914.4 933.9 935.9 924.7 926.1 935.5 937.4 938.4 958.0 961.7 966.1 966.2 968.9 801.4 934.1 942.3 945.1 946.7 686.4 698.4 701.6 701.7 702.5 14341.7 14533.6 14556.0 14572.7 14574.6 12928.2 13252.4 13600.1 13814.2 13834.7 11293.9 11314.3 11352.3 11443.8 11583.7 3679.6 3690.9 3734.4 3779.0 3827.0 51348.7 51480.0 51812.0 52023.7 52736.0 9965.7 9990.0 10058.0 10128.3 10206.2 18275.3 18332.3 18595.8 18634.1 18664.3 8002.3 8060.0 8076.2 8139.3 8414.5 4568.7 4582.2 4640.7 4662.6 4694.6 3323.4 3359.6 3373.8 3376.5 3383.4 557.4 578.6 601.3 629.2 629.8 573.3 640.9 712.4 713.3 723.6 8850.9 8948.6 8996.0 9269.8 9344.7 652.8 703.9 710.2 712.1 719.5 4102.3 4139.7 4169.0 4328.5 4350.6 57329.0 57378.4 58251.1 58329.4 58800.7 54425.7 55345.7 55501.7 55728.4 56056.0 49821.3 49969.5 50266.5 50792.5 51518.2 7748.6 7944.2 8263.5 8484.0 8509.2 37387.4 37943.8 37962.0 39735.0 39939.0 42884.4 45237.3 47928.0 48362.3 48849.8 10810.6 11018.9 12157.1 12519.7 12587.1 12816.4 12997.7 13042.7 13059.5 13151.2 10722.3 11253.0 11810.6 12016.6 12369.1 11384.1 11537.3 12100.7 12190.3 12218.2 10847.0 11310.7 11317.3 11340.7 11629.6 9584.4 10143.3 10257.4 10345.4 10443.8 10209.8 10421.4 10498.1 10513.4 10554.1 11:32:06 INFO - PROCESS | 29062 | -------- Summary: end -------- 11:32:06 INFO - PROCESS | 29062 | 11:32:07 INFO - TEST-INFO | 29062: exit 0 11:32:07 INFO - TEST-OK | dromaeo_css | took 1110827ms 11:32:07 INFO - TEST-START | kraken 11:32:07 INFO - operating with platform_type : linux_ 11:32:07 INFO - Initialising browser for kraken test... 11:32:07 INFO - TEST-INFO | started process 29258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp36hiAl/profile http://localhost:44714/getInfo.html) 11:32:11 INFO - PROCESS | 29258 | __metrics Screen width/height:1600/1200 11:32:11 INFO - PROCESS | 29258 | colorDepth:24 11:32:11 INFO - PROCESS | 29258 | Browser inner width/height: 1024/697 11:32:11 INFO - PROCESS | 29258 | __metrics 11:32:12 INFO - PROCESS | 29258 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:13 INFO - TEST-INFO | 29258: exit 0 11:32:13 INFO - Browser initialized. 11:32:13 INFO - Running cycle 1/1 for kraken test... 11:32:13 INFO - TEST-INFO | started process 29350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp36hiAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:25 INFO - PROCESS | 29350 | RSS: Main: 138866688 11:32:25 INFO - PROCESS | 29350 | 11:32:27 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44714/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:28 INFO - PROCESS | 29350 | RSS: Main: 175058944 11:32:28 INFO - PROCESS | 29350 | 11:32:30 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44714/tests/kraken/driver.html?testName=audio-dft) 11:32:31 INFO - PROCESS | 29350 | RSS: Main: 173858816 11:32:31 INFO - PROCESS | 29350 | 11:32:34 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44714/tests/kraken/driver.html?testName=audio-fft) 11:32:34 INFO - PROCESS | 29350 | RSS: Main: 169476096 11:32:34 INFO - PROCESS | 29350 | 11:32:36 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44714/tests/kraken/driver.html?testName=audio-oscillator) 11:32:37 INFO - PROCESS | 29350 | RSS: Main: 170520576 11:32:37 INFO - PROCESS | 29350 | 11:32:39 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:40 INFO - PROCESS | 29350 | RSS: Main: 168648704 11:32:40 INFO - PROCESS | 29350 | 11:32:43 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44714/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:43 INFO - PROCESS | 29350 | RSS: Main: 168321024 11:32:43 INFO - PROCESS | 29350 | 11:32:47 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44714/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:47 INFO - PROCESS | 29350 | RSS: Main: 167514112 11:32:47 INFO - PROCESS | 29350 | 11:32:50 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44714/tests/kraken/driver.html?testName=json-parse-financial) 11:32:50 INFO - PROCESS | 29350 | RSS: Main: 168673280 11:32:50 INFO - PROCESS | 29350 | 11:32:52 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:53 INFO - PROCESS | 29350 | RSS: Main: 176283648 11:32:53 INFO - PROCESS | 29350 | 11:32:54 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:55 INFO - PROCESS | 29350 | RSS: Main: 174534656 11:32:55 INFO - PROCESS | 29350 | 11:32:57 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:58 INFO - PROCESS | 29350 | RSS: Main: 180031488 11:32:58 INFO - PROCESS | 29350 | 11:33:00 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:00 INFO - PROCESS | 29350 | RSS: Main: 184815616 11:33:00 INFO - PROCESS | 29350 | 11:33:03 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:04 INFO - PROCESS | 29350 | RSS: Main: 183758848 11:33:04 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:44714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44714/tests/kraken/driver.html?testName=ai-astar) 11:33:05 INFO - PROCESS | 29350 | RSS: Main: 245559296 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | __start_tp_report 11:33:05 INFO - PROCESS | 29350 | _x_x_mozilla_page_load 11:33:05 INFO - PROCESS | 29350 | _x_x_mozilla_page_load_details 11:33:05 INFO - PROCESS | 29350 | |i|pagename|runs| 11:33:05 INFO - PROCESS | 29350 | |0;ai-astar;110;111;106;112;112;111;98;110;111;109 11:33:05 INFO - PROCESS | 29350 | |1;audio-beat-detection;155;126;161;170;127;160;158;131;180;128 11:33:05 INFO - PROCESS | 29350 | |2;audio-dft;165;160;159;159;160;159;160;162;161;160 11:33:05 INFO - PROCESS | 29350 | |3;audio-fft;76;79;73;175;77;75;76;76;165;76 11:33:05 INFO - PROCESS | 29350 | |4;audio-oscillator;94;94;141;95;93;94;141;93;94;145 11:33:05 INFO - PROCESS | 29350 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;116;117;117 11:33:05 INFO - PROCESS | 29350 | |6;imaging-darkroom;146;145;145;146;146;146;145;145;145;145 11:33:05 INFO - PROCESS | 29350 | |7;imaging-desaturate;95;95;95;96;96;96;96;95;95;95 11:33:05 INFO - PROCESS | 29350 | |8;json-parse-financial;56;56;57;55;57;57;59;56;60;53 11:33:05 INFO - PROCESS | 29350 | |9;json-stringify-tinderbox;64;64;63;64;64;64;64;64;64;64 11:33:05 INFO - PROCESS | 29350 | |10;stanford-crypto-aes;78;79;80;80;79;78;80;80;78;79 11:33:05 INFO - PROCESS | 29350 | |11;stanford-crypto-ccm;112;112;112;116;113;117;114;110;114;113 11:33:05 INFO - PROCESS | 29350 | |12;stanford-crypto-pbkdf2;146;146;147;157;149;137;147;145;145;144 11:33:05 INFO - PROCESS | 29350 | |13;stanford-crypto-sha256-iterative;74;71;65;66;66;67;65;67;67;66 11:33:05 INFO - PROCESS | 29350 | __end_tp_report 11:33:05 INFO - PROCESS | 29350 | __start_cc_report 11:33:05 INFO - PROCESS | 29350 | _x_x_mozilla_cycle_collect,1030 11:33:05 INFO - PROCESS | 29350 | __end_cc_report 11:33:05 INFO - PROCESS | 29350 | __startTimestamp1464028385973__endTimestamp 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | ------- Summary: start ------- 11:33:05 INFO - PROCESS | 29350 | Number of tests: 14 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.24 (3.8%) stddev-sans-first:4.48 11:33:05 INFO - PROCESS | 29350 | Values: 110.0 111.0 106.0 112.0 112.0 111.0 98.0 110.0 111.0 109.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:159.00 stddev:19.88 (12.5%) stddev-sans-first:20.99 11:33:05 INFO - PROCESS | 29350 | Values: 155.0 126.0 161.0 170.0 127.0 160.0 158.0 131.0 180.0 128.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:1.84 (1.2%) stddev-sans-first:1.00 11:33:05 INFO - PROCESS | 29350 | Values: 165.0 160.0 159.0 159.0 160.0 159.0 160.0 162.0 161.0 160.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.73 (52.3%) stddev-sans-first:41.56 11:33:05 INFO - PROCESS | 29350 | Values: 76.0 79.0 73.0 175.0 77.0 75.0 76.0 76.0 165.0 76.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:94.00 stddev:23.45 (24.9%) stddev-sans-first:24.28 11:33:05 INFO - PROCESS | 29350 | Values: 94.0 94.0 141.0 95.0 93.0 94.0 141.0 93.0 94.0 145.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:33:05 INFO - PROCESS | 29350 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:33:05 INFO - PROCESS | 29350 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:33:05 INFO - PROCESS | 29350 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.96 (3.4%) stddev-sans-first:2.06 11:33:05 INFO - PROCESS | 29350 | Values: 56.0 56.0 57.0 55.0 57.0 57.0 59.0 56.0 60.0 53.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:33:05 INFO - PROCESS | 29350 | Values: 64.0 64.0 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:0.88 (1.1%) stddev-sans-first:0.83 11:33:05 INFO - PROCESS | 29350 | Values: 78.0 79.0 80.0 80.0 79.0 78.0 80.0 80.0 78.0 79.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:113.50 stddev:2.06 (1.8%) stddev-sans-first:2.13 11:33:05 INFO - PROCESS | 29350 | Values: 112.0 112.0 112.0 116.0 113.0 117.0 114.0 110.0 114.0 113.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:146.50 stddev:4.92 (3.4%) stddev-sans-first:5.22 11:33:05 INFO - PROCESS | 29350 | Values: 146.0 146.0 147.0 157.0 149.0 137.0 147.0 145.0 145.0 144.0 11:33:05 INFO - PROCESS | 29350 | 11:33:05 INFO - PROCESS | 29350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:2.88 (4.3%) stddev-sans-first:1.80 11:33:05 INFO - PROCESS | 29350 | Values: 74.0 71.0 65.0 66.0 66.0 67.0 65.0 67.0 67.0 66.0 11:33:05 INFO - PROCESS | 29350 | -------- Summary: end -------- 11:33:05 INFO - PROCESS | 29350 | 11:33:06 INFO - TEST-INFO | 29350: exit 0 11:33:06 INFO - TEST-OK | kraken | took 59227ms 11:33:06 INFO - SUITE-END | took 1170s 11:33:07 INFO - Completed test suite (00:19:30) 11:33:07 INFO - javascript benchmark 11:33:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.607407111147, 3368.124287685201, 3381.4589665653502, 3387.508811222373, 3428.3828910796046, 5480.3971563128025, 5485.561155107597, 5497.972510137449, 5500.257465242191, 5501.504864562188, 5461.617686761918, 5489.752961116749, 5494.2582751328555, 5495.450454954503, 5499.3675727291375, 4847.51524847516, 4951.108800415933, 4971.773992106717, 5042.873928151789, 5056.570191533724, 4933.555979961803, 4997.000599880039, 5001.724905130234, 5002.599792016648, 5008.29883816266, 4965.056639238551, 5010.423801262847, 5016.523430274118, 5019.623528235379, 5020.4226513951, 4982.302477653131, 4994.2009278515625, 5011.674241174312, 5017.64876458648, 5047.141985862412, 4864.0515099555605, 4891.364122664067, 4970.577500912426, 4970.602351811846, 4992.775325110379, 5358.410574836765, 5368.277183076096, 5369.570434365281, 5373.731313434313, 5378.193271009341, 5826.504747096502, 5852.619579727304, 5878.911816322759, 5888.411158884121, 5889.911651325234, 5914.645121292736, 5915.911261331084, 5920.703964801743, 5924.259467566554, 5940.227770389865, 5536.557075433956, 5544.112941929312, 5545.972270138664, 5546.889062218774, 5554.833354999357, 5841.707914604252, 5930.644161350333, 6025.066114752132, 6033.9742243818655, 6058.030715085565, 5780.5953583248765, 5784.566157538202, 5789.53683705311, 5789.710514474259, 5791.478766910998, 5876.9118463223085, 5900.704964751745, 5909.881802363929, 5913.940860591425, 5914.378990206053, 5791.0, 5799.130130480462, 5907.172995780594, 5924.259467566554, 5937.168796368512, 5770.509506691894, 5815.360310365856, 5817.88364232713, 5822.7088645567555, 5825.155352473952, 4390.209762242827, 4395.296752519645, 4399.098184872094, 4399.340098985178, 4426.778661066934, 4021.1354558770004, 4073.674106071507, 4085.59144085595, 4085.9387109193385, 4130.297849365615, 5528.585356098229, 5529.115341545414, 5536.307961504812, 5543.279373681396, 5545.556355491551, 5763.7406316715005, 5854.326752423526, 5878.500327472213, 5878.794242201502, 5943.732532035982, 5535.6955367455175, 5569.55443564522, 5592.245046918695, 5593.825296687741, 5616.045272303718, 5053.2420136979745, 5060.873478163002, 5073.061483625541, 5076.695398276115, 5097.057044446789, 5996.640201587918, 6067.817965461043, 6069.3627169147485, 6113.724882380304, 6124.755009799647, 5938.198343223609, 5948.315943666361, 5948.851278718067, 5954.196183515343, 5962.25471816023, 6047.213862197887, 6049.455549000611, 6050.183225264533, 6054.788082417094, 6055.5458340623745, 5713.628614140068, 5848.678322692293, 5852.356240813592, 5940.61386009908, 5958.404159584007, 5978.073398623221, 5994.790182343597, 6007.519398448201, 6012.038073908328, 6015.789447369321, 5783.566232532493, 5831.1544826000845, 5841.036229022334, 5841.620294680833, 5842.970785146217, 5666.744996475086, 5738.684372359393, 5841.883162336814, 5842.883142337215, 5862.618929769551, 5659.151127330933, 5660.575456840671, 5687.203791469115, 5687.77248910039, 5689.601727879009, 5644.6330988485615, 5751.0, 5773.24947756789, 5800.709964501673, 5826.242588463642, 5529.944700552943, 5576.972115139399, 5615.831525054255, 5631.211630371669, 5730.283714535683], "unit": "score", "name": "dojo.html", "value": 5429.949398719598}, {"lowerIsBetter": false, "replicates": [544.170140535683, 559.1891756952418, 585.0989476206641, 618.6628287583267, 652.7356420649636, 37681.623183768155, 38132.809335953316, 38190.42714359283, 38303.80848095756, 38331.80834095833, 41270.0, 41703.79148104263, 41865.16269674605, 42017.0, 42106.0, 8728.51993140377, 8924.955375223115, 8941.910580894206, 8945.910540894572, 8950.060243674418, 8958.462492250454, 9166.22087122592, 9168.770780730469, 9172.495512746797, 9178.128077832594, 9127.452352858816, 9228.077192280785, 9246.53767311635, 9246.583903724315, 9250.0, 9082.636694532244, 9096.727098187064, 9144.588493517807, 9175.58709858058, 9178.770530736718, 9053.59258833354, 9193.678221262291, 9197.21823644991, 9207.953960230223, 9216.078392160798, 42715.35926961067, 42814.78592607048, 43186.35220471695, 43197.78401108006, 43213.35179972272, 3711.183539621279, 3754.8310326035394, 3856.749311294785, 4479.350494178326, 4502.302143167814, 32352.83823580867, 32557.6744232557, 32565.83717081423, 32644.510332345035, 32720.345593088245, 4111.1366613011305, 4232.640225580829, 4256.0, 4260.826281732205, 4283.764392958386, 277796.0, 278547.0, 279102.6044869783, 281040.0, 283433.0, 42803.785981069894, 42912.78543607262, 42914.356284655754, 59367.0, 59853.401465985655, 42045.579544204775, 42198.15603687909, 42529.36205956913, 42643.57356426458, 42651.0, 14824.3329050193, 15002.174880381466, 15037.699246015018, 15053.473128440672, 15057.623559411102, 11739.826017398364, 11776.11679124069, 11810.468528916219, 11855.525778968917, 11895.107866909842, 15074.397024119131, 15230.771538426932, 15249.542513724606, 15281.770773438408, 15411.768823467657, 5697.743601537941, 5937.317208520989, 5946.494547963472, 5989.880202396015, 6067.575269731076, 973.5035132082547, 993.5181437003048, 1055.7413433708791, 1060.1148041385375, 1144.5707859552667, 28903.85548072246, 29178.85410572976, 29722.10833674993, 29985.850070749508, 30005.69994300029, 1096.1011970184372, 1120.4733775125678, 1155.1509640414456, 1205.1864991130951, 1209.498058305811, 14296.857031429552, 14795.482158124414, 14832.703345933021, 14847.2576371181, 15021.849781502264, 355202.0, 358362.0, 359867.0, 360956.0, 362315.0, 56226.15660765092, 56874.43125568774, 56953.0, 56969.14546281809, 57275.7089716415, 1362.7751421015619, 1441.3369849868968, 1454.9490767823074, 1464.1654257073367, 1491.328901994107, 26664.733352667, 27214.183574492796, 27760.0, 27807.44385112327, 29812.0, 46295.0, 46621.76689116532, 46812.53187468082, 46837.53162468332, 46944.29583556318, 197514.0, 197999.0, 198296.0, 198562.0, 198981.0, 28468.861245549946, 32700.182495436853, 33428.832855835564, 34223.31553368869, 34708.13229669177, 40021.95937515689, 40681.38977915274, 43969.560304397826, 44349.0, 44489.33266000948, 36802.0, 37199.0, 37207.0, 37270.0, 37513.81243093767, 36394.4540831893, 36497.452538211415, 37091.0, 37146.25707485889, 37169.25661486701, 36611.63388366082, 37105.44341834821, 37800.0, 37941.0, 38494.0, 32418.67581324251, 33313.83343083269, 33688.1577960553, 33694.66305336915, 33835.0, 25343.239702808944, 25779.0, 26124.477510449306, 26726.331841703333, 26727.732722672525], "unit": "score", "name": "ext.html", "value": 18397.85682527909}, {"lowerIsBetter": false, "replicates": [372.6236501133855, 382.3061144023596, 385.43918598439274, 386.6539447194761, 394.08178943062666, 17357.132143392842, 18367.908160459196, 19067.0, 19069.90465047673, 19095.045247737628, 12211.20627159234, 12538.059645526577, 12543.435545400456, 12556.874431255685, 12573.057020723436, 5118.6416950813555, 5147.459516750743, 5723.284589426322, 5723.341815691187, 5727.427257274281, 5589.469000444951, 5639.041362968284, 5644.915326270109, 5650.0959846424585, 5651.463111004448, 5446.564274858002, 5628.887422251552, 5631.18347839563, 5634.267545219136, 5655.5475561954945, 5615.522680572136, 5617.494425501704, 5623.325200975909, 5631.239782629334, 5663.405342439026, 5687.459691329317, 5721.256236689203, 5722.742476588522, 5727.627704199213, 5730.598858079936, 13680.384382702803, 13869.306534673226, 17663.293468261254, 20566.177352905866, 20594.79405205944, 2334.7198336199594, 2367.5146594947996, 2377.7978871795917, 2431.635254711807, 2502.78726308264, 9970.501474926297, 10526.263161578692, 11032.834507482394, 12520.624381268577, 13608.659783505393, 1953.150379584885, 1958.9020548972494, 1965.1451618545977, 2033.9288124915556, 2040.1941233212797, 51537.22694159591, 60153.69923150356, 63709.0, 64609.353906460805, 69860.3013969864, 10260.640877569249, 10643.46782660864, 10654.307470014424, 10816.756073051542, 10817.080548153495, 13590.524331648543, 14091.647708807363, 14591.12453252787, 14619.19594422317, 14637.0, 7256.092988376453, 7315.567854903042, 7830.0, 7859.331956783737, 7876.330511906552, 7358.77923662291, 7366.373858222004, 7414.369778568882, 7455.85088298231, 7458.179600243969, 4707.411573553306, 4715.127701375257, 4719.10337035962, 4737.526247375304, 4739.312799644102, 1795.3446991847882, 1963.1165975311167, 1974.871633343828, 2010.45717656232, 2014.5366565689974, 912.4114945859883, 968.9563969621383, 980.5048450532436, 1043.5512729526224, 1087.7171935296722, 17415.39046133379, 17520.824791752173, 17553.736693949602, 18027.2789088435, 18255.72616410755, 969.1616751510035, 983.0660872171466, 987.7382493639192, 993.0962823830424, 1015.9796804064025, 9997.850032249522, 10217.18262538995, 10243.180545556486, 10288.948555257175, 10324.741881452874, 428113.0, 433148.0, 441103.0, 450164.0, 451994.0, 75282.24717752862, 78274.21725782669, 78275.60862195652, 78522.21477785263, 78743.0, 1049.2655141401049, 1050.3855244681947, 1059.7615536504225, 1088.1675518228562, 1093.9617113400993, 15577.766333505233, 15917.204139793195, 16048.839511605202, 16072.839271607134, 16140.919295403448, 27421.588676169475, 27788.722112778614, 32618.34763304673, 34532.82733586316, 35341.46987795237, 44911.77544112258, 45896.770516147204, 46009.0, 46463.76768116138, 46528.53471465242, 5536.086545719912, 8362.540060296498, 8467.322614190727, 8524.403291769517, 8679.045305016569, 13115.803262950873, 13551.932240339129, 13628.93185534066, 13637.931810340884, 13658.795118073038, 11265.549378024787, 11993.700157496132, 12064.276143431422, 12070.45682944252, 12104.213226140273, 11724.765504690029, 11744.942955134078, 11897.464614092214, 12078.758424831278, 12101.092418068503, 12115.394230288626, 12115.939420303195, 12165.635030949086, 12248.571300004458, 12416.379181040731, 8874.156955089256, 8937.106289371271, 9004.63981440735, 9005.459672419676, 9102.08979102111, 9550.617975280911, 11973.880261197624, 12096.0, 12227.572034978733, 12375.319357435428], "unit": "score", "name": "jquery.html", "value": 8708.65773562456}, {"lowerIsBetter": false, "replicates": [1423.9074460160082, 1545.6908618276345, 1546.5669612508495, 1752.5706201980518, 1862.264405559803, 7784.260495252956, 7932.6430310636015, 7958.602069896504, 7972.402069844756, 7979.880301795478, 7994.200579942018, 8127.837443251132, 8148.348132149428, 8164.22439868213, 8169.550674712888, 2419.4677171022436, 2444.1079006162713, 2447.608382658775, 2448.4980578981354, 2451.3013791069548, 2430.987845060772, 2448.7796098351146, 2492.0, 2504.0734928076636, 2506.135383292761, 2433.707955045397, 2435.622478515833, 2446.2661201639526, 2446.3639453742067, 2446.376174075608, 2437.5612389769835, 2439.0853429963763, 2466.0382450844095, 2484.3789052736815, 2506.0852788732163, 2462.236706620953, 2484.2795589279267, 2487.7885379742743, 2495.4759500504915, 2499.3626625210454, 8301.211384918484, 8314.750557483285, 8327.375446841512, 8332.33341332698, 8342.791430214233, 4978.054169707744, 5123.0, 5145.974270128663, 5166.7416629168765, 5167.7932882684645, 3272.6072871255365, 3313.966860331414, 3371.477420999749, 3474.808885511296, 3477.8434970426392, 1144.2558357047574, 1153.0832987774738, 1163.976720465586, 1170.6897672116895, 1200.9399530023463, 11787.233829801036, 11787.823182652268, 11795.29228246308, 11795.823062654066, 11823.408829558488, 4549.840755573539, 4683.367745354401, 4697.10754956564, 4767.73777442244, 4778.593819525379, 9845.212383009342, 9855.45794981283, 9864.852027219598, 9866.901330986599, 9871.457069861226, 5157.716325602128, 5162.9741851291255, 5167.224916262516, 5167.6641018333685, 5168.0697474454955, 3965.2267807777207, 4647.442306923191, 4691.390119284471, 4693.671442999025, 4698.671093023456, 3822.9426558601645, 3889.4360317753767, 3893.201893611803, 3937.448757173998, 3949.19041596472, 1249.4377530111306, 1251.7308778612642, 1259.9181053231512, 1287.819705241267, 1292.2311224821217, 1412.159764939859, 1419.9432022719182, 1431.6492459347526, 1455.4978532406303, 1487.0259979713305, 7892.4869883457395, 7906.604669766603, 7990.20097990208, 7991.081025682005, 7999.800004999922, 554.7503623369419, 556.2074044486591, 557.7350758389732, 557.8605348662834, 564.0580231014216, 6162.014077747539, 6187.566870319124, 6188.690565471708, 6191.659458729813, 6241.594296370721, 10139.188864890792, 10253.538590763284, 10463.05832475081, 10463.215258855464, 10471.05760481545, 9632.9036709632, 10225.897741022494, 10237.539310731036, 10270.691879243635, 10274.383536987805, 7626.275503827239, 7755.68977240904, 7795.727149549852, 7842.215778422226, 7853.607319633996, 7713.42149338813, 7766.339861111643, 7861.685532578862, 7865.803354916173, 7902.091259505, 8711.91288087111, 8796.516191609522, 8892.466452012899, 9111.681091161778, 9134.954325228331, 9015.909840901508, 9155.679551215942, 9200.079992000747, 9400.529973501161, 9447.385919915183, 6489.643069631215, 7150.213476517475, 7313.122425308997, 7408.185099638928, 7511.812204694927, 7960.601969901598, 7972.561509117054, 7986.001749781278, 8018.198180181935, 8020.278174964281, 7109.502334836512, 7231.4214862811905, 7263.564186148848, 7340.302671246223, 7416.6291685414435, 6925.168979722465, 6959.304069593, 7039.894401583878, 7055.823604409726, 7098.929010709827, 7432.665530051268, 7752.8449431012195, 7760.611969401394, 7771.650275737718, 7771.844563108819, 6884.139482564679, 6964.825879352854, 6969.059177011039, 6972.023916651571, 6976.720931162697, 6994.440444764508, 7042.647867606702, 7065.964670176616, 7128.28717128283, 7141.3572778448115], "unit": "score", "name": "mootools.html", "value": 4752.431429920034}, {"lowerIsBetter": false, "replicates": [360.4917066935621, 366.5235194247479, 367.43048275173476, 370.10434747910057, 374.99062523436913, 6072.514198864092, 6092.634441933487, 6134.417230363119, 6171.907421388682, 6177.320494745574, 6055.909161362583, 6059.697015149247, 6066.969665151679, 6074.969625151879, 6076.058210977306, 4456.710313829607, 4573.8170473181035, 4686.90626187476, 4739.36018637483, 4757.0723708876785, 4727.409073865767, 4746.501617330183, 4750.1924672805535, 4754.738489383082, 4759.262314341283, 4707.482176960531, 4721.622270218374, 4729.0, 4734.881627959294, 4743.383360163174, 4454.777261136946, 4582.33556134362, 4701.7414042227665, 4722.834700785456, 4726.385569875894, 4189.664826813878, 4192.748435093904, 4198.160367926427, 4203.453551038376, 4209.852655157055, 5781.335146458169, 5804.65172089676, 5812.273465816773, 5818.185454036438, 5820.592558520905, 5506.5870059745275, 5512.80705175317, 5517.5585953123655, 5520.3651580068, 5530.032244357221, 6402.647854368008, 6403.103565500834, 6406.615603063831, 6410.935890641127, 6424.839379015562, 4548.545145485458, 4625.444946606429, 4645.279981602857, 4660.930086048712, 4689.109069276827, 6573.671316434159, 6669.633170175638, 6728.394444500019, 6747.460203183734, 6753.561018533829, 4834.20235661112, 4835.879103022453, 4843.975780121077, 4845.103655823684, 4845.878853028703, 4906.460289368167, 4908.092002979389, 4913.336699545515, 4915.188993816052, 4922.163232250526, 5540.418256083053, 5547.223388725582, 5550.195221692832, 5558.805441809517, 5564.360098588714, 6218.502519798405, 6502.739890404426, 6511.804645860631, 6512.869742605121, 6518.217813862367, 1710.5381546982494, 1719.974200386995, 1730.4895055958523, 1734.17626627351, 1734.4623166818326, 1080.708208783624, 1147.6671765188169, 1160.5763896177834, 1188.5602327139013, 1191.6782468733393, 6078.392160783975, 6079.392060793885, 6103.328633850273, 6165.599236049642, 6168.19813424252, 6611.371919667624, 6613.173353330833, 6646.83382915431, 6655.0682904393425, 6658.800235992928, 6157.0456579230295, 6157.415045570664, 6162.476189523941, 6164.352742962014, 6164.938350616526, 3549.964500355015, 3588.515550400715, 3592.4431713084514, 3594.9281014379567, 3595.1551385424405, 6618.503612229006, 6776.9322306777285, 6831.931680683129, 6906.033155358254, 6932.792016239521, 6855.280195579392, 6862.519623626298, 6891.173059232924, 6897.620630865351, 6910.654467276616, 6887.862242755117, 6892.862142757217, 6896.620685862225, 6901.309869013159, 6906.343897329745, 6740.12378390806, 6744.190697116377, 6745.156855393076, 6752.0, 6755.324467553205, 6443.871122577616, 6577.473802095917, 6577.736890524517, 6602.702878370389, 6603.933960660332, 6860.348266914635, 6880.621565813928, 6881.036654868422, 6895.6552172390175, 6905.135613384458, 4601.608863246662, 4638.026014536985, 4649.186392381387, 4650.744209068534, 4658.627309815139, 6727.663616819042, 6729.327067293231, 6729.966350168218, 6731.730730770911, 6744.8651026978205, 6361.656641966137, 6489.935100648933, 6513.185851768529, 6537.084808126961, 6537.738490460329, 6496.967515162394, 6528.706208220547, 6529.151210342625, 6530.216374035146, 6538.084668146558, 6385.616862988236, 6391.712372943136, 6394.680265986589, 6397.552171347961, 6400.327965563735, 6542.182227221598, 6548.738050477928, 6552.934470655423, 6553.148090748172, 6553.311902250195, 6009.639421634716, 6063.242094738158, 6188.319284878569, 6313.621182729051, 6330.620162790247], "unit": "score", "name": "prototype.html", "value": 4935.340030530985}, {"lowerIsBetter": false, "replicates": [833.9958300208498, 841.1966571923813, 845.6913226672262, 847.5804476783991, 847.8473874702551, 16411.58971025725, 16499.34002639896, 16504.0, 16571.83428165718, 16602.418915337967, 15103.39586416542, 15148.848511514909, 15148.924255378708, 15170.469033583826, 15218.695626087472, 769.2499812682646, 893.5353616119614, 914.3599480363739, 933.9206167475738, 935.8923723771785, 924.6994726713812, 926.0507979321183, 935.4714586258776, 937.4328531238605, 938.4041133880002, 958.018031517693, 961.7355227312476, 966.0966995858895, 966.2125367825236, 968.8982656821038, 801.3869389916719, 934.1265916368184, 942.3026960049583, 945.1257586732245, 946.6828612414815, 686.354826463128, 698.4098436820879, 701.6351497221416, 701.6667083135521, 702.4977141343963, 14341.713165736732, 14533.636659083502, 14556.0, 14572.708545829024, 14574.635634109127, 12928.224306541637, 13252.403641836141, 13600.123348105217, 13814.240216788072, 13834.723305533933, 11293.943530282379, 11314.321140731583, 11352.318860868374, 11443.771124577544, 11583.710407239801, 3679.6136405677285, 3690.8708195213308, 3734.402495600718, 3778.981105094457, 3827.0, 51348.74325628385, 51480.0, 51812.0, 52023.69940751474, 52736.0, 9965.701028969142, 9990.0, 10058.0, 10128.291019628556, 10206.234532410099, 18275.268989240547, 18332.266709331478, 18595.81404185941, 18634.068296585116, 18664.34674786376, 8002.319802816825, 8060.032796064393, 8076.152004039609, 8139.348852091818, 8414.537200453911, 4568.657350698644, 4582.152301824173, 4640.721556706609, 4662.626989840873, 4694.647901407408, 3323.3685599735973, 3359.630440651575, 3373.8313084345687, 3376.493525971124, 3383.424817780983, 557.4147145497212, 578.5834199376442, 601.3054921565599, 629.2260519560965, 629.7701339011228, 573.3377948469524, 640.9070684750685, 712.3837880233664, 713.333033613573, 723.5803234124195, 8850.867236991451, 8948.642054317885, 8995.955020224857, 9269.768255793659, 9344.672936447192, 652.7682672651235, 703.9084918960502, 710.1726488640676, 712.1134187936053, 719.4819729794644, 4102.323116685773, 4139.668826493873, 4168.958310416918, 4328.480582330078, 4350.58669426404, 57329.0, 57378.426215738145, 58251.12623310654, 58329.4167058324, 58800.7059964706, 54425.72787136118, 55345.72327138339, 55501.722491387285, 55728.44271557314, 56056.0, 49821.25268120981, 49969.500304997215, 50266.49733502618, 50792.49207507951, 51518.22722659088, 7748.643987302312, 7944.205579442009, 8263.545504997042, 8483.95758021206, 8509.234168924826, 37387.43918841165, 37943.810280949525, 37962.0, 39735.0, 39939.0, 42884.35673464963, 45237.32144017908, 47928.0, 48362.274565880834, 48849.75575122102, 10810.56757729682, 11018.944905275423, 12157.1489995703, 12519.687007824878, 12587.118901676795, 12816.423260953467, 12997.675058123623, 13042.673933151747, 13059.477620895437, 13151.21092734439, 10722.303050301705, 11253.043491303331, 11810.645680629596, 12016.63950081499, 12369.072319575887, 11384.089272858317, 11537.250078744855, 12100.697482563006, 12190.329531875832, 12218.20581662189, 10847.0, 11310.660680179608, 11317.320960742381, 11340.716482088013, 11629.59296424621, 9584.37701549397, 10143.28996970205, 10257.384556926609, 10345.37927724339, 10443.843342349719, 10209.84685229737, 10421.374717516974, 10498.055175034284, 10513.421761803174, 10554.050135487843], "unit": "score", "name": "yui.html", "value": 6753.95369601059}], "name": "dromaeo_css", "value": 7187.148827601091}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 112.0, 112.0, 111.0, 98.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 161.0, 170.0, 127.0, 160.0, 158.0, 131.0, 180.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [165.0, 160.0, 159.0, 159.0, 160.0, 159.0, 160.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [76.0, 79.0, 73.0, 175.0, 77.0, 75.0, 76.0, 76.0, 165.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 95.0, 93.0, 94.0, 141.0, 93.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 55.0, 57.0, 57.0, 59.0, 56.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 80.0, 80.0, 79.0, 78.0, 80.0, 80.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [112.0, 112.0, 112.0, 116.0, 113.0, 117.0, 114.0, 110.0, 114.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 157.0, 149.0, 137.0, 147.0, 145.0, 145.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 65.0, 66.0, 66.0, 67.0, 65.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1506.3}]} 11:33:07 INFO - Return code: 0 11:33:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:07 INFO - # TBPL SUCCESS # 11:33:07 INFO - Running post-action listener: _resource_record_post_action 11:33:07 INFO - Running post-run listener: _resource_record_post_run 11:33:08 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 449363968; Read time: 36; Write time: 295692 11:33:08 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237694976; Read time: 0; Write time: 193488 11:33:08 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 211070976; Read time: 36; Write time: 102204 11:33:08 INFO - Running post-run listener: _upload_blobber_files 11:33:08 INFO - Blob upload gear active. 11:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:09 INFO - (blobuploader) - INFO - Done attempting. 11:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:10 INFO - (blobuploader) - INFO - Done attempting. 11:33:10 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:10 INFO - Return code: 0 11:33:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2539b850b148bc76bc8f6829b2755da4a34875f81e5b2ac2c44f7523c2e69cb87de0d99486715a61aaa21dff8603c0e20c3d3924954131d85f0fbd9d1951d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e8fc328f06044dfc149a9396e689be24e6ba76014764d611b1f7b4d78840c0c7f408858484cb6ed188237e06737ac84344055e72b61b38e3d089abf5421661"} 11:33:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:10 INFO - Contents: 11:33:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2539b850b148bc76bc8f6829b2755da4a34875f81e5b2ac2c44f7523c2e69cb87de0d99486715a61aaa21dff8603c0e20c3d3924954131d85f0fbd9d1951d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e8fc328f06044dfc149a9396e689be24e6ba76014764d611b1f7b4d78840c0c7f408858484cb6ed188237e06737ac84344055e72b61b38e3d089abf5421661"} 11:33:10 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:10 INFO - Copying logs to upload dir... 11:33:10 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.511574 ========= master_lag: 6.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-23 11:33:16.080116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:16.088932) ========= 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=41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2539b850b148bc76bc8f6829b2755da4a34875f81e5b2ac2c44f7523c2e69cb87de0d99486715a61aaa21dff8603c0e20c3d3924954131d85f0fbd9d1951d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e8fc328f06044dfc149a9396e689be24e6ba76014764d611b1f7b4d78840c0c7f408858484cb6ed188237e06737ac84344055e72b61b38e3d089abf5421661"} build_url:https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b2539b850b148bc76bc8f6829b2755da4a34875f81e5b2ac2c44f7523c2e69cb87de0d99486715a61aaa21dff8603c0e20c3d3924954131d85f0fbd9d1951d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/80e8fc328f06044dfc149a9396e689be24e6ba76014764d611b1f7b4d78840c0c7f408858484cb6ed188237e06737ac84344055e72b61b38e3d089abf5421661"}' ========= master_lag: 0.18 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:16.277713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:16.278044) ========= 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=41bf3e9aed84707956354da8000001c5-1464026008.51985-1341244413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:16.301982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:33:16.302804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:33:16.304685) ========= ========= Total master_lag: 7.12 =========