builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1462482597.44 results: success (0) buildid: 20160505110241 builduid: e1dd3273511e47c796b1dacf7e4d74a7 revision: 995ecc8dbf0b3a5337784766ee575934cb61df03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.437376) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.437929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.438201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.456095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.456377) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 14:09:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2016-05-05 14:09:57 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.552277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.552602) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019619 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.602390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:57.602776) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 995ecc8dbf0b3a5337784766ee575934cb61df03 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 995ecc8dbf0b3a5337784766ee575934cb61df03 --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=9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 14:09:57,965 truncating revision to first 12 chars 2016-05-05 14:09:57,965 Setting DEBUG logging. 2016-05-05 14:09:57,965 attempt 1/10 2016-05-05 14:09:57,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/995ecc8dbf0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 14:09:58,229 unpacking tar archive at: mozilla-aurora-995ecc8dbf0b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:58.156207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:58.156528) ========= script_repo_revision: 995ecc8dbf0b3a5337784766ee575934cb61df03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:58.156922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:58.157186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 14:09:58.167104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-05 14:09:58.167479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:09:58 INFO - MultiFileLogger online at 20160505 14:09:58 in /builds/slave/test 14:09:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:09:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:58 INFO - {'append_to_log': False, 14:09:58 INFO - 'base_work_dir': '/builds/slave/test', 14:09:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:09:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:58 INFO - 'branch': 'Mozilla-Aurora', 14:09:58 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:58 INFO - 'config_files': ('talos/linux_config.py',), 14:09:58 INFO - 'default_actions': ('clobber', 14:09:58 INFO - 'read-buildbot-config', 14:09:58 INFO - 'download-and-extract', 14:09:58 INFO - 'populate-webroot', 14:09:58 INFO - 'create-virtualenv', 14:09:58 INFO - 'install', 14:09:58 INFO - 'run-tests'), 14:09:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:58 INFO - 'download_minidump_stackwalk': True, 14:09:58 INFO - 'download_symbols': 'ondemand', 14:09:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:58 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:58 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:58 INFO - 'installer_path': 'installer.exe', 14:09:58 INFO - 'log_level': 'info', 14:09:58 INFO - 'log_name': 'talos', 14:09:58 INFO - 'log_to_console': True, 14:09:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:09:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:09:58 INFO - 'opt_config_files': (), 14:09:58 INFO - 'pip_index': False, 14:09:58 INFO - 'sps_profile': False, 14:09:58 INFO - 'sps_profile_interval': 0, 14:09:58 INFO - 'suite': 'dromaeojs', 14:09:58 INFO - 'system_bits': '32', 14:09:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:58 INFO - 'title': 'talos-linux64-ix-013', 14:09:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:58 INFO - 'use_talos_json': True, 14:09:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:58 INFO - 'work_dir': 'build'} 14:09:58 INFO - ##### 14:09:58 INFO - ##### Running clobber step. 14:09:58 INFO - ##### 14:09:58 INFO - Running pre-action listener: _resource_record_pre_action 14:09:58 INFO - Running main action method: clobber 14:09:58 INFO - rmtree: /builds/slave/test/build 14:09:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:59 INFO - Running post-action listener: _resource_record_post_action 14:09:59 INFO - ##### 14:09:59 INFO - ##### Running read-buildbot-config step. 14:09:59 INFO - ##### 14:09:59 INFO - Running pre-action listener: _resource_record_pre_action 14:09:59 INFO - Running main action method: read_buildbot_config 14:09:59 INFO - Using buildbot properties: 14:09:59 INFO - { 14:09:59 INFO - "project": "", 14:09:59 INFO - "product": "firefox", 14:09:59 INFO - "script_repo_revision": "production", 14:09:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:09:59 INFO - "repository": "", 14:09:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:09:59 INFO - "buildid": "20160505110241", 14:09:59 INFO - "pgo_build": "True", 14:09:59 INFO - "basedir": "/builds/slave/test", 14:09:59 INFO - "buildnumber": 219, 14:09:59 INFO - "slavename": "talos-linux64-ix-013", 14:09:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:09:59 INFO - "platform": "ubuntu64_hw", 14:09:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:09:59 INFO - "branch": "mozilla-aurora", 14:09:59 INFO - "repo_path": "releases/mozilla-aurora", 14:09:59 INFO - "revision": "995ecc8dbf0b3a5337784766ee575934cb61df03", 14:09:59 INFO - "stage_platform": "linux64-pgo", 14:09:59 INFO - "builduid": "e1dd3273511e47c796b1dacf7e4d74a7", 14:09:59 INFO - "slavebuilddir": "test" 14:09:59 INFO - } 14:09:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 14:09:59 INFO - Running post-action listener: _resource_record_post_action 14:09:59 INFO - ##### 14:09:59 INFO - ##### Running download-and-extract step. 14:09:59 INFO - ##### 14:09:59 INFO - Running pre-action listener: _resource_record_pre_action 14:09:59 INFO - Running main action method: download_and_extract 14:09:59 INFO - mkdir: /builds/slave/test/build/tests 14:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:59 INFO - https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:09:59 INFO - Downloaded 1361 bytes. 14:09:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 14:09:59 INFO - Using the following test package requirements: 14:09:59 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:09:59 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:09:59 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:09:59 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'jsshell-linux-x86_64.zip'], 14:09:59 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:09:59 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 14:09:59 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:09:59 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:09:59 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:09:59 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 14:09:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:09:59 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:59 INFO - https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:00 INFO - Downloaded 23824818 bytes. 14:10:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:02 INFO - Return code: 0 14:10:02 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:10: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')]} 14:10:02 INFO - https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 14:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:03 INFO - Downloaded 23824818 bytes. 14:10:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:04 INFO - Return code: 0 14:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:04 INFO - https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:10:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:10:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 14:10:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:10:06 INFO - Downloaded 10840145 bytes. 14:10:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:10:06 INFO - Return code: 0 14:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:06 INFO - https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:10:07 INFO - Downloaded 62715553 bytes. 14:10:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:10:07 INFO - mkdir: /builds/slave/test/properties 14:10:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:07 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:07 INFO - Contents: 14:10:07 INFO - build_url:https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 14:10:08 INFO - Running post-action listener: _resource_record_post_action 14:10:08 INFO - Running post-action listener: set_extra_try_arguments 14:10:08 INFO - ##### 14:10:08 INFO - ##### Running populate-webroot step. 14:10:08 INFO - ##### 14:10:08 INFO - Running pre-action listener: _resource_record_pre_action 14:10:08 INFO - Running main action method: populate_webroot 14:10:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:08 INFO - '--tppagecycles', 14:10:08 INFO - '7'], 14:10:08 INFO - 'tests': ['tsvgm']}}, 14:10:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['damp', 'tps']}, 14:10:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'tests': ['damp', 'tps']}, 14:10:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['dromaeo_dom']}, 14:10:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['a11yr', 14:10:08 INFO - 'ts_paint', 14:10:08 INFO - 'tpaint', 14:10:08 INFO - 'sessionrestore', 14:10:08 INFO - 'sessionrestore_no_auto_restore', 14:10:08 INFO - 'tabpaint']}, 14:10:08 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:08 INFO - 'ts_paint', 14:10:08 INFO - 'tpaint', 14:10:08 INFO - 'sessionrestore', 14:10:08 INFO - 'sessionrestore_no_auto_restore', 14:10:08 INFO - 'tabpaint']}, 14:10:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:08 INFO - 'ts_paint', 14:10:08 INFO - 'tpaint', 14:10:08 INFO - 'sessionrestore', 14:10:08 INFO - 'sessionrestore_no_auto_restore', 14:10:08 INFO - 'tabpaint']}, 14:10:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:08 INFO - 'ts_paint', 14:10:08 INFO - 'tpaint', 14:10:08 INFO - 'sessionrestore', 14:10:08 INFO - 'sessionrestore_no_auto_restore', 14:10:08 INFO - 'tabpaint']}, 14:10:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['a11yr', 14:10:08 INFO - 'ts_paint', 14:10:08 INFO - 'tpaint', 14:10:08 INFO - 'sessionrestore', 14:10:08 INFO - 'sessionrestore_no_auto_restore', 14:10:08 INFO - 'tabpaint']}, 14:10:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['a11yr', 14:10:08 INFO - 'ts_paint', 14:10:08 INFO - 'tpaint', 14:10:08 INFO - 'sessionrestore', 14:10:08 INFO - 'sessionrestore_no_auto_restore', 14:10:08 INFO - 'tabpaint']}, 14:10:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['tsvgx', 14:10:08 INFO - 'tsvgr_opacity', 14:10:08 INFO - 'tart', 14:10:08 INFO - 'tscrollx', 14:10:08 INFO - 'cart']}, 14:10:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:08 INFO - 'tsvgr_opacity', 14:10:08 INFO - 'tart', 14:10:08 INFO - 'tscrollx', 14:10:08 INFO - 'cart']}, 14:10:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'talos_options': ['--disable-e10s'], 14:10:08 INFO - 'tests': ['tp5o']}, 14:10:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'tests': ['tp5o']}, 14:10:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'talos_options': ['--disable-e10s', 14:10:08 INFO - '--xperf_path', 14:10:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:08 INFO - 'tests': ['tp5n']}, 14:10:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:08 INFO - 'talos_options': ['--xperf_path', 14:10:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:08 INFO - 'tests': ['tp5n']}}, 14:10:08 INFO - 'talos.zip': {'path': '', 14:10:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:08 INFO - Running post-action listener: _resource_record_post_action 14:10:08 INFO - ##### 14:10:08 INFO - ##### Running create-virtualenv step. 14:10:08 INFO - ##### 14:10:08 INFO - Running pre-action listener: _resource_record_pre_action 14:10:08 INFO - Running main action method: create_virtualenv 14:10:08 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:08 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 14:10:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:08 INFO - Using real prefix '/usr' 14:10:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:09 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:11 INFO - Installing pip.................done. 14:10:11 INFO - Return code: 0 14:10:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:11 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')]} 14:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:11 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')]} 14:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:11 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 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:11 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 14:10:11 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 14:10:11 INFO - Using env: {'DISPLAY': ':0', 14:10:11 INFO - 'HOME': '/home/cltbld', 14:10:11 INFO - 'LANG': 'en_US.UTF-8', 14:10:11 INFO - 'LANGUAGE': 'en_US:en', 14:10:11 INFO - 'LOGNAME': 'cltbld', 14:10:11 INFO - 'MAIL': '/var/mail/cltbld', 14:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:11 INFO - 'MOZ_NO_REMOTE': '1', 14:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:11 INFO - 'NO_EM_RESTART': '1', 14:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:11 INFO - 'PWD': '/builds/slave/test', 14:10:11 INFO - 'SHELL': '/bin/bash', 14:10:11 INFO - 'SHLVL': '1', 14:10:11 INFO - 'TERM': 'linux', 14:10:11 INFO - 'TMOUT': '86400', 14:10:11 INFO - 'USER': 'cltbld', 14:10:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:11 INFO - '_': '/tools/buildbot/bin/python'} 14:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:11 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 14:10:11 INFO - Cleaning up... 14:10:11 INFO - Return code: 0 14:10:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:10:11 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')]} 14:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:11 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')]} 14:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:11 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 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:11 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 14:10:11 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 14:10:11 INFO - Using env: {'DISPLAY': ':0', 14:10:11 INFO - 'HOME': '/home/cltbld', 14:10:11 INFO - 'LANG': 'en_US.UTF-8', 14:10:11 INFO - 'LANGUAGE': 'en_US:en', 14:10:11 INFO - 'LOGNAME': 'cltbld', 14:10:11 INFO - 'MAIL': '/var/mail/cltbld', 14:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:11 INFO - 'MOZ_NO_REMOTE': '1', 14:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:11 INFO - 'NO_EM_RESTART': '1', 14:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:11 INFO - 'PWD': '/builds/slave/test', 14:10:11 INFO - 'SHELL': '/bin/bash', 14:10:11 INFO - 'SHLVL': '1', 14:10:11 INFO - 'TERM': 'linux', 14:10:11 INFO - 'TMOUT': '86400', 14:10:11 INFO - 'USER': 'cltbld', 14:10:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:11 INFO - '_': '/tools/buildbot/bin/python'} 14:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:11 INFO - Downloading/unpacking psutil>=0.7.1 14:10:11 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 14:10:11 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 14:10:11 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 14:10:11 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 14:10:11 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 14:10:11 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 14:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:13 INFO - Installing collected packages: psutil 14:10:13 INFO - Running setup.py install for psutil 14:10:13 INFO - building 'psutil._psutil_linux' extension 14:10:13 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 14:10:13 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 14:10:13 INFO - building 'psutil._psutil_posix' extension 14:10:13 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 14:10:14 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 14:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:14 INFO - Successfully installed psutil 14:10:14 INFO - Cleaning up... 14:10:14 INFO - Return code: 0 14:10:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:10:14 INFO - Using env: {'DISPLAY': ':0', 14:10:14 INFO - 'HOME': '/home/cltbld', 14:10:14 INFO - 'LANG': 'en_US.UTF-8', 14:10:14 INFO - 'LANGUAGE': 'en_US:en', 14:10:14 INFO - 'LOGNAME': 'cltbld', 14:10:14 INFO - 'MAIL': '/var/mail/cltbld', 14:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:14 INFO - 'MOZ_NO_REMOTE': '1', 14:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:14 INFO - 'NO_EM_RESTART': '1', 14:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:14 INFO - 'PWD': '/builds/slave/test', 14:10:14 INFO - 'SHELL': '/bin/bash', 14:10:14 INFO - 'SHLVL': '1', 14:10:14 INFO - 'TERM': 'linux', 14:10:14 INFO - 'TMOUT': '86400', 14:10:14 INFO - 'USER': 'cltbld', 14:10:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:14 INFO - '_': '/tools/buildbot/bin/python'} 14:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:10:16 INFO - Installing collected packages: mozsystemmonitor 14:10:16 INFO - Running setup.py install for mozsystemmonitor 14:10:16 INFO - Successfully installed mozsystemmonitor 14:10:16 INFO - Cleaning up... 14:10:16 INFO - Return code: 0 14:10:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:10:16 INFO - Using env: {'DISPLAY': ':0', 14:10:16 INFO - 'HOME': '/home/cltbld', 14:10:16 INFO - 'LANG': 'en_US.UTF-8', 14:10:16 INFO - 'LANGUAGE': 'en_US:en', 14:10:16 INFO - 'LOGNAME': 'cltbld', 14:10:16 INFO - 'MAIL': '/var/mail/cltbld', 14:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:16 INFO - 'MOZ_NO_REMOTE': '1', 14:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:16 INFO - 'NO_EM_RESTART': '1', 14:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:16 INFO - 'PWD': '/builds/slave/test', 14:10:16 INFO - 'SHELL': '/bin/bash', 14:10:16 INFO - 'SHLVL': '1', 14:10:16 INFO - 'TERM': 'linux', 14:10:16 INFO - 'TMOUT': '86400', 14:10:16 INFO - 'USER': 'cltbld', 14:10:16 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:16 INFO - '_': '/tools/buildbot/bin/python'} 14:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:19 INFO - Downloading docopt-0.6.1.tar.gz 14:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:19 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:19 INFO - Running setup.py install for blobuploader 14:10:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:19 INFO - Running setup.py install for requests 14:10:19 INFO - Running setup.py install for docopt 14:10:19 INFO - Successfully installed blobuploader requests docopt 14:10:19 INFO - Cleaning up... 14:10:19 INFO - Return code: 0 14:10:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:19 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 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:19 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 14:10:19 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 14:10:19 INFO - Using env: {'DISPLAY': ':0', 14:10:19 INFO - 'HOME': '/home/cltbld', 14:10:19 INFO - 'LANG': 'en_US.UTF-8', 14:10:19 INFO - 'LANGUAGE': 'en_US:en', 14:10:19 INFO - 'LOGNAME': 'cltbld', 14:10:19 INFO - 'MAIL': '/var/mail/cltbld', 14:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:19 INFO - 'MOZ_NO_REMOTE': '1', 14:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:19 INFO - 'NO_EM_RESTART': '1', 14:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:19 INFO - 'PWD': '/builds/slave/test', 14:10:19 INFO - 'SHELL': '/bin/bash', 14:10:19 INFO - 'SHLVL': '1', 14:10:19 INFO - 'TERM': 'linux', 14:10:19 INFO - 'TMOUT': '86400', 14:10:19 INFO - 'USER': 'cltbld', 14:10:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:19 INFO - '_': '/tools/buildbot/bin/python'} 14:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:20 INFO - Running setup.py (path:/tmp/pip-ZrKkw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:20 INFO - Running setup.py (path:/tmp/pip-CtDRqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:20 INFO - Running setup.py (path:/tmp/pip-Ksr4n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:20 INFO - Running setup.py (path:/tmp/pip-OHgBwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:20 INFO - Running setup.py (path:/tmp/pip-BR39hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:20 INFO - Running setup.py (path:/tmp/pip-Xa9gG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:20 INFO - Running setup.py (path:/tmp/pip-cJGMhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:20 INFO - Running setup.py (path:/tmp/pip-XREwfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:20 INFO - Running setup.py (path:/tmp/pip-4Xk7Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:20 INFO - Running setup.py (path:/tmp/pip-jVWSYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:20 INFO - Running setup.py (path:/tmp/pip-hUV37o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:20 INFO - Running setup.py (path:/tmp/pip-abSES6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:21 INFO - Running setup.py (path:/tmp/pip-1pkKRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:21 INFO - Running setup.py (path:/tmp/pip-thRTvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:21 INFO - Running setup.py (path:/tmp/pip-cwLn_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:21 INFO - Running setup.py (path:/tmp/pip-fnzpWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:21 INFO - Running setup.py (path:/tmp/pip-FKj0TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:21 INFO - Running setup.py install for manifestparser 14:10:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:21 INFO - Running setup.py install for mozcrash 14:10:21 INFO - Running setup.py install for mozdebug 14:10:21 INFO - Running setup.py install for mozdevice 14:10:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:21 INFO - Running setup.py install for mozfile 14:10:21 INFO - Running setup.py install for mozhttpd 14:10:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for mozinfo 14:10:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for mozInstall 14:10:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for mozleak 14:10:22 INFO - Running setup.py install for mozlog 14:10:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for moznetwork 14:10:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for mozprocess 14:10:22 INFO - Running setup.py install for mozprofile 14:10:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for mozrunner 14:10:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:22 INFO - Running setup.py install for mozscreenshot 14:10:23 INFO - Running setup.py install for moztest 14:10:23 INFO - Running setup.py install for mozversion 14:10:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:23 INFO - Cleaning up... 14:10:23 INFO - Return code: 0 14:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:10:23 INFO - Using env: {'DISPLAY': ':0', 14:10:23 INFO - 'HOME': '/home/cltbld', 14:10:23 INFO - 'LANG': 'en_US.UTF-8', 14:10:23 INFO - 'LANGUAGE': 'en_US:en', 14:10:23 INFO - 'LOGNAME': 'cltbld', 14:10:23 INFO - 'MAIL': '/var/mail/cltbld', 14:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:23 INFO - 'MOZ_NO_REMOTE': '1', 14:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:23 INFO - 'NO_EM_RESTART': '1', 14:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:23 INFO - 'PWD': '/builds/slave/test', 14:10:23 INFO - 'SHELL': '/bin/bash', 14:10:23 INFO - 'SHLVL': '1', 14:10:23 INFO - 'TERM': 'linux', 14:10:23 INFO - 'TMOUT': '86400', 14:10:23 INFO - 'USER': 'cltbld', 14:10:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:23 INFO - '_': '/tools/buildbot/bin/python'} 14:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:23 INFO - Running setup.py (path:/tmp/pip-rZ90hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:23 INFO - Running setup.py (path:/tmp/pip-4XTpAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:23 INFO - Running setup.py (path:/tmp/pip-8Lpjaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:23 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)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:23 INFO - Running setup.py (path:/tmp/pip-yib3Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:23 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)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:23 INFO - Running setup.py (path:/tmp/pip-PoUc_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:23 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)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:23 INFO - Running setup.py (path:/tmp/pip-ja4saV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:23 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)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:23 INFO - Running setup.py (path:/tmp/pip-gTcP_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:23 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)) 14:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:23 INFO - Running setup.py (path:/tmp/pip-y3i25U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:24 INFO - Running setup.py (path:/tmp/pip-r5EBMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:24 INFO - Running setup.py (path:/tmp/pip-Uk7zM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:24 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)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:24 INFO - Running setup.py (path:/tmp/pip-w8mBV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:24 INFO - Running setup.py (path:/tmp/pip-Ny_lnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:24 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)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:24 INFO - Running setup.py (path:/tmp/pip-1dNDLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:24 INFO - Running setup.py (path:/tmp/pip-kUG1oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:24 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)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:24 INFO - Running setup.py (path:/tmp/pip-o5XdrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:24 INFO - Running setup.py (path:/tmp/pip-3njFN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:24 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)) 14:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:24 INFO - Running setup.py (path:/tmp/pip-eoEKNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:24 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 14:10:24 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 14:10:24 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 14:10:24 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 14:10:24 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 14:10:24 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 14:10:26 INFO - Downloading blessings-1.6.tar.gz 14:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:26 INFO - Installing collected packages: blessings 14:10:26 INFO - Running setup.py install for blessings 14:10:26 INFO - Successfully installed blessings 14:10:26 INFO - Cleaning up... 14:10:26 INFO - Return code: 0 14:10:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:27 INFO - Reading from file tmpfile_stdout 14:10:27 INFO - Current package versions: 14:10:27 INFO - argparse == 1.2.1 14:10:27 INFO - blessings == 1.6 14:10:27 INFO - blobuploader == 1.2.4 14:10:27 INFO - docopt == 0.6.1 14:10:27 INFO - manifestparser == 1.1 14:10:27 INFO - mozInstall == 1.12 14:10:27 INFO - mozcrash == 0.17 14:10:27 INFO - mozdebug == 0.1 14:10:27 INFO - mozdevice == 0.48 14:10:27 INFO - mozfile == 1.2 14:10:27 INFO - mozhttpd == 0.7 14:10:27 INFO - mozinfo == 0.9 14:10:27 INFO - mozleak == 0.1 14:10:27 INFO - mozlog == 3.1 14:10:27 INFO - moznetwork == 0.27 14:10:27 INFO - mozprocess == 0.22 14:10:27 INFO - mozprofile == 0.28 14:10:27 INFO - mozrunner == 6.11 14:10:27 INFO - mozscreenshot == 0.1 14:10:27 INFO - mozsystemmonitor == 0.0 14:10:27 INFO - moztest == 0.7 14:10:27 INFO - mozversion == 1.4 14:10:27 INFO - psutil == 3.1.1 14:10:27 INFO - requests == 1.2.3 14:10:27 INFO - wsgiref == 0.1.2 14:10:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:10:27 INFO - Using env: {'DISPLAY': ':0', 14:10:27 INFO - 'HOME': '/home/cltbld', 14:10:27 INFO - 'LANG': 'en_US.UTF-8', 14:10:27 INFO - 'LANGUAGE': 'en_US:en', 14:10:27 INFO - 'LOGNAME': 'cltbld', 14:10:27 INFO - 'MAIL': '/var/mail/cltbld', 14:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:27 INFO - 'MOZ_NO_REMOTE': '1', 14:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:27 INFO - 'NO_EM_RESTART': '1', 14:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:27 INFO - 'PWD': '/builds/slave/test', 14:10:27 INFO - 'SHELL': '/bin/bash', 14:10:27 INFO - 'SHLVL': '1', 14:10:27 INFO - 'TERM': 'linux', 14:10:27 INFO - 'TMOUT': '86400', 14:10:27 INFO - 'USER': 'cltbld', 14:10:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:27 INFO - '_': '/tools/buildbot/bin/python'} 14:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:10:27 INFO - Cleaning up... 14:10:27 INFO - Return code: 0 14:10:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:10:27 INFO - Using env: {'DISPLAY': ':0', 14:10:27 INFO - 'HOME': '/home/cltbld', 14:10:27 INFO - 'LANG': 'en_US.UTF-8', 14:10:27 INFO - 'LANGUAGE': 'en_US:en', 14:10:27 INFO - 'LOGNAME': 'cltbld', 14:10:27 INFO - 'MAIL': '/var/mail/cltbld', 14:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:27 INFO - 'MOZ_NO_REMOTE': '1', 14:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:27 INFO - 'NO_EM_RESTART': '1', 14:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:27 INFO - 'PWD': '/builds/slave/test', 14:10:27 INFO - 'SHELL': '/bin/bash', 14:10:27 INFO - 'SHLVL': '1', 14:10:27 INFO - 'TERM': 'linux', 14:10:27 INFO - 'TMOUT': '86400', 14:10:27 INFO - 'USER': 'cltbld', 14:10:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:27 INFO - '_': '/tools/buildbot/bin/python'} 14:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:27 INFO - Downloading/unpacking jsonschema 14:10:27 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 14:10:27 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 14:10:27 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 14:10:27 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 14:10:27 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 14:10:27 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 14:10:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:29 INFO - Downloading/unpacking functools32 (from jsonschema) 14:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:29 INFO - warning: no files found matching '*.txt' 14:10:29 INFO - no previously-included directories found matching 'build' 14:10:29 INFO - no previously-included directories found matching 'dist' 14:10:29 INFO - no previously-included directories found matching '.git*' 14:10:29 INFO - Installing collected packages: jsonschema, functools32 14:10:29 INFO - Running setup.py install for functools32 14:10:29 INFO - warning: no files found matching '*.txt' 14:10:29 INFO - no previously-included directories found matching 'build' 14:10:29 INFO - no previously-included directories found matching 'dist' 14:10:29 INFO - no previously-included directories found matching '.git*' 14:10:29 INFO - Successfully installed jsonschema functools32 14:10:29 INFO - Cleaning up... 14:10:29 INFO - Return code: 0 14:10:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:10:29 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')]} 14:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:29 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')]} 14:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:29 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 0x7f5f3adfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1af45a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', '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 14:10:29 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 14:10:29 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 14:10:29 INFO - Using env: {'DISPLAY': ':0', 14:10:29 INFO - 'HOME': '/home/cltbld', 14:10:29 INFO - 'LANG': 'en_US.UTF-8', 14:10:29 INFO - 'LANGUAGE': 'en_US:en', 14:10:29 INFO - 'LOGNAME': 'cltbld', 14:10:29 INFO - 'MAIL': '/var/mail/cltbld', 14:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:29 INFO - 'MOZ_NO_REMOTE': '1', 14:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:29 INFO - 'NO_EM_RESTART': '1', 14:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:29 INFO - 'PWD': '/builds/slave/test', 14:10:29 INFO - 'SHELL': '/bin/bash', 14:10:29 INFO - 'SHLVL': '1', 14:10:29 INFO - 'TERM': 'linux', 14:10:29 INFO - 'TMOUT': '86400', 14:10:29 INFO - 'USER': 'cltbld', 14:10:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:29 INFO - '_': '/tools/buildbot/bin/python'} 14:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:29 INFO - Downloading/unpacking flake8 14:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:10:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:10:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 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 14:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:10:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:10:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:10:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:10:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:10:32 INFO - no previously-included directories found matching 'docs/_build' 14:10:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:10:32 INFO - Running setup.py install for pep8 14:10:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:10:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:10:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:10:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:10:32 INFO - no previously-included directories found matching 'docs/_build' 14:10:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:10:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:10:32 INFO - Cleaning up... 14:10:32 INFO - Return code: 0 14:10:32 INFO - Running post-action listener: _resource_record_post_action 14:10:32 INFO - Running post-action listener: _start_resource_monitoring 14:10:32 INFO - Starting resource monitoring. 14:10:32 INFO - ##### 14:10:32 INFO - ##### Running install step. 14:10:32 INFO - ##### 14:10:32 INFO - Running pre-action listener: _resource_record_pre_action 14:10:32 INFO - Running main action method: install 14:10:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:33 INFO - Reading from file tmpfile_stdout 14:10:33 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:33 INFO - Reading from file tmpfile_stdout 14:10:33 INFO - Output received: 14:10:33 INFO - Usage: mozinstall [options] installer 14:10:33 INFO - Options: 14:10:33 INFO - -h, --help show this help message and exit 14:10:33 INFO - -d DEST, --destination=DEST 14:10:33 INFO - Directory to install application into. [default: 14:10:33 INFO - "/builds/slave/test"] 14:10:33 INFO - --app=APP Application being installed. [default: firefox] 14:10:33 INFO - mkdir: /builds/slave/test/build/application 14:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:10:48 INFO - Reading from file tmpfile_stdout 14:10:48 INFO - Output received: 14:10:48 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:48 INFO - Running post-action listener: _resource_record_post_action 14:10:48 INFO - ##### 14:10:48 INFO - ##### Running run-tests step. 14:10:48 INFO - ##### 14:10:48 INFO - Running pre-action listener: _resource_record_pre_action 14:10:48 INFO - Running main action method: run_tests 14:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:48 INFO - Python 2.7.3 14:10:48 INFO - Return code: 0 14:10:48 INFO - grabbing minidump binary from tooltool 14:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b83410>, '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 0x1b84310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b847a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:10:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:10:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:48 INFO - Return code: 0 14:10:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:10:49 INFO - Return code: 0 14:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 14:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 14:10:49 INFO - Using env: {'DISPLAY': ':0', 14:10:49 INFO - 'HOME': '/home/cltbld', 14:10:49 INFO - 'LANG': 'en_US.UTF-8', 14:10:49 INFO - 'LANGUAGE': 'en_US:en', 14:10:49 INFO - 'LOGNAME': 'cltbld', 14:10:49 INFO - 'MAIL': '/var/mail/cltbld', 14:10:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:49 INFO - 'MOZ_NO_REMOTE': '1', 14:10:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:49 INFO - 'NO_EM_RESTART': '1', 14:10:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:49 INFO - 'PWD': '/builds/slave/test', 14:10:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:49 INFO - 'SHELL': '/bin/bash', 14:10:49 INFO - 'SHLVL': '1', 14:10:49 INFO - 'TERM': 'linux', 14:10:49 INFO - 'TMOUT': '86400', 14:10:49 INFO - 'USER': 'cltbld', 14:10:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874', 14:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:49 INFO - '_': '/tools/buildbot/bin/python'} 14:10:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 14:10:49 INFO - mozversion application_buildid: 20160505110241 14:10:49 INFO - mozversion application_changeset: 995ecc8dbf0b3a5337784766ee575934cb61df03 14:10:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:10:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:49 INFO - mozversion application_name: Firefox 14:10:49 INFO - mozversion application_remotingname: firefox-dev 14:10:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:10:49 INFO - mozversion application_vendor: Mozilla 14:10:49 INFO - mozversion application_version: 48.0a2 14:10:49 INFO - mozversion platform_buildid: 20160505110241 14:10:49 INFO - mozversion platform_changeset: 995ecc8dbf0b3a5337784766ee575934cb61df03 14:10:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:10:49 INFO - mozversion platform_version: 48.0a2 14:10:49 INFO - using testdate: 1462482649 14:10:49 INFO - actual date: 1462482649 14:10:49 INFO - starting webserver on 'localhost:45856' 14:10:49 INFO - SUITE-START | Running 2 tests 14:10:49 INFO - TEST-START | dromaeo_css 14:10:49 INFO - operating with platform_type : linux_ 14:10:49 INFO - Initialising browser for dromaeo_css test... 14:10:49 INFO - TEST-INFO | started process 20507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjIBc9/profile http://localhost:45856/getInfo.html) 14:10:54 INFO - PROCESS | 20507 | __metrics Screen width/height:1600/1200 14:10:54 INFO - PROCESS | 20507 | colorDepth:24 14:10:54 INFO - PROCESS | 20507 | Browser inner width/height: 1024/697 14:10:54 INFO - PROCESS | 20507 | __metrics 14:10:55 ERROR - PROCESS | 20507 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:10:55 INFO - TEST-INFO | 20507: exit 0 14:10:55 INFO - Browser initialized. 14:10:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:55 INFO - TEST-INFO | started process 20593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjIBc9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:07 INFO - PROCESS | 20593 | RSS: Main: 142667776 14:11:07 INFO - PROCESS | 20593 | 14:11:58 INFO - PROCESS | 20593 | 1462482718803 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] 14:14:06 INFO - PROCESS | 20593 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45856/tests/dromaeo/cssquery-ext.html) 14:14:07 INFO - PROCESS | 20593 | RSS: Main: 247095296 14:14:07 INFO - PROCESS | 20593 | 14:17:09 INFO - PROCESS | 20593 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-ext.html (next: http://localhost:45856/tests/dromaeo/cssquery-jquery.html) 14:17:10 INFO - PROCESS | 20593 | RSS: Main: 224063488 14:17:10 INFO - PROCESS | 20593 | 14:20:12 INFO - PROCESS | 20593 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45856/tests/dromaeo/cssquery-mootools.html) 14:20:12 INFO - PROCESS | 20593 | RSS: Main: 224088064 14:20:12 INFO - PROCESS | 20593 | 14:23:14 INFO - PROCESS | 20593 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45856/tests/dromaeo/cssquery-prototype.html) 14:23:15 INFO - PROCESS | 20593 | RSS: Main: 220975104 14:23:15 INFO - PROCESS | 20593 | 14:26:17 INFO - PROCESS | 20593 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45856/tests/dromaeo/cssquery-yui.html) 14:26:18 INFO - PROCESS | 20593 | RSS: Main: 215302144 14:26:18 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-yui.html (next: http://localhost:45856/tests/dromaeo/cssquery-dojo.html) 14:29:20 INFO - PROCESS | 20593 | RSS: Main: 253722624 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | __start_tp_report 14:29:20 INFO - PROCESS | 20593 | _x_x_mozilla_page_load 14:29:20 INFO - PROCESS | 20593 | _x_x_mozilla_page_load_details 14:29:20 INFO - PROCESS | 20593 | |i|pagename|runs| 14:29:20 INFO - PROCESS | 20593 | |0;dojo.html;3317.071220058384;3415.2315728961003;3425.9999999999986;3438.7764795288304;3467.497212904129;5633.802816901404;5657.2928383952;5659.51894089003;5674;5679.488846003864;5611.7474713637885;5663.575231857607;5663.745131469083;5677.43225677432;5705.629134106281;4831.975840120795;5033.270175824494;5071.543561079502;5120.411152717448;5157.303763991869;5016.724080175589;5078.365204349457;5080.364954380702;5083.517065878736;5086.847394578169;5010.248462730601;5045.217991211368;5064.670796398223;5091.79632814687;5095.719735414551;5047.192449208127;5081.669691470042;5097.745112744348;5097.821576244851;5132.024915266106;4896.2410826321975;4956.529129732669;5014.172661510846;5022.296878436985;5042.369703787027;5396.83809485716;5449.5640348772;5465.207544905967;5476.096444086721;5485.314335708036;5967.015442451991;5998.7600495980105;6007.699615019232;6008.03871380577;6009.068594367836;5876.882462350772;6016.037434010581;6035.064564992434;6047.727852246616;6089.238845144357;5637.126245431965;5662.235598194232;5663.093904975184;5666.914996275059;5671.291088613923;6157.599756015845;6174.8147555573405;6183.536234782409;6185.288691800411;6186.721597528122;5824.417558244227;5842.912356314659;5913.497352725067;5945.435183657545;5959.7914073008105;5995.550333724988;6013.188219590387;6024.8795024100145;6029.186059881948;6031.849203769941;5971.940280597225;5997.880042399215;6004.489618382487;6005.819825405245;6006.489448396847;5724.885502289931;5949.2266005419015;6014.218151640259;6055.061465472859;6055.122007308915;4514.45826500822;4533.52397998212;4535.183666939916;4540.659450541222;4570.8171673133365;3997.8200980955344;4078.7552746835286;4088.0801819590356;4094.0583665757044;4124.1133156371525;5579.386267510652;5639.182318563785;5657.405972372924;5686;5686.459786320293;5978.8206353809455;5979.402059793986;5985.491233245223;5988.071848863433;5989.850253743604;5514.338279406497;5626.662400255997;5631.71841407928;5635.492805647429;5684.8010319638615;5148.433672296044;5150.768215430315;5151.2273159026445;5162.767675454614;5178.818741344035;6240.781572644935;6245.781397651152;6248.75004999804;6250.031245156917;6253.906191407133;5864.648121112747;6026.638401695912;6030.728617212324;6041.305249896318;6120.386183820548;6156.415140561639;6161.72272247741;6162.198914141133;6162.661053642093;6181.289151747606;5718.742656580381;5831.096180092092;5833.970830145822;5836.328822185503;5857.414258574108;5869.325027621878;5914.67469289176;5974.9402505974385;6068.939310606837;6089.025755879038;5806.303243610793;5814.680192589448;5821.79623713168;5824.097264923944;5825.563082768725;5760.510356619734;5772.567057470623;5780.855478613068;5782.653040817396;5782.826515204551;5592.077307244422;5755.395683453177;5827.475527202572;5840.620359676607;5859.794907178229;5865.354810970875;5871.295444546682;5877.265341832271;5877.970610146922;5883.882322353615;5643.746031428514;5728.885422291448;5754;5755;5760.423957604206 14:29:20 INFO - PROCESS | 20593 | |1;ext.html;612.7579606055608;664.1697877652933;667.5860966200956;678.5385937562455;679.8062552172626;33828;34777.13057173572;34799.65200347999;34850.30299394017;34894.12764680881;35483;40576;41454.17091658165;41559;41606;8734.170253825892;8973.192412682858;8976.057513961037;8981.416207946462;8983.730488085368;7964.681412743512;8153.9184608153755;8775.166359195899;8952.149545793172;8964.955175224148;10221.948890255539;10454.895451045506;10455.84316235257;10457.947710261438;10462.319949203278;10378.532966016548;10500.894991050069;10506.159507239441;10506.737331566696;10508.579656813718;8009.839803203903;10268.075873171376;10326.483675816255;10431.800342960581;10447.582096716122;41941.79029104865;42743.35884961728;42778;42815.57184428147;43000.1399972002;3382.915427114317;3547.5210846535647;3577.8926632201074;3837.6737977271964;3953.4267531207815;31863.52204716908;32199.034028978935;32315.838420807744;32419.189520261945;32470.18824529382;4432.534583868712;4437.955620443787;4452.087322098994;4523.683342166049;4576.130535198302;388579;390465;391512;392758;393814;71272;71919.64040179871;71946;72056;72088;64918.35081649217;66474.66762666253;66702.66648666725;66846.66576667085;66861.33138668552;17917.910410447865;17996.37012704549;18065.548361291072;18119.275228990955;18244.63510729778;13418.530351437848;13495.662608434868;13496.055276130577;13520.797188042186;13580.660483487993;19029.333973310866;19452.319168829305;20913;21443.67834482484;21620.13519459204;7609.961950190213;7916.802079948047;8019.278264956182;8056;8149.022117345838;1098.3245304137897;1101.8871687482892;1144.9427528623535;1153.8326942593278;1154.1171004181808;31559.842200788848;32409;32425.189370265933;33021.09717288887;33459.16352091169;1183.0771997841698;1235.5613757116093;1237.461704158694;1275.0537087713512;1296.5591698822257;16957.915210424115;17717.202725877367;18194.545136371697;18283.451496455127;18735.81264187368;581032;588718;590307;591110;591394;64558.67720661461;65413.34586654168;65706;65740.67129664417;65742.67128664421;1429.0996672096512;1490.2474250503426;1530.954071377838;1532.6628141808785;1535.5009621872712;30487.695123048485;31425.21436964094;31799.841000794848;31958.36083278368;32757.836210818794;51761.22358164706;51999.48000519946;52818;52910.47089529209;52937;412062;414284;414543;415019;416316;23660;28239.15282541527;28363.290917726397;28474;28538.57192142078;40509.59490405058;47525;48354.274685880446;48524.514754851996;48532.27201591909;39902.80048599738;39921.2015759689;40001;40015;40172.598274016884;36935;38965.41551876668;39530.20939581135;40177.1964560713;40739.59260407358;40020;40691.389629155;40854.38718419167;40914.38628420517;41299.793501032305;32783.91849263368;37381.62618373781;37790.811045944596;38162.42756358712;38397.424038638885;29093.272668183465;29156.416871662022;29340.266493336985;29442.852785735933;29532 14:29:20 INFO - PROCESS | 20593 | |2;jquery.html;435.0228212772948;438.50667998501683;444.3623400420399;445.52309095348915;446.1100105289947;18782.154803033845;19322.613547729037;19806.801931980714;19879.900600496996;19929.501762455944;19011.809881901176;19025.2389904404;19111.808881911176;19320.903395483037;19336.613267734636;5660.575456840743;5883.588148829584;5911.615744976584;5918.615290006157;5921.437463440988;5590.804321848736;5717.799877004306;5771.624844385102;5802.767889284423;5911.88176236475;5850.824475265749;5858.033424484955;5891.499222566065;5892.086726557391;5895.056790913454;5806.332271788735;5838.970805145989;6171.691415429233;6326.49388048955;6388.616682999035;5620.185073164368;5645.774169033234;5647.37878833328;5654.802081927113;5662.462066103713;20352;23177.188798391977;24123.758762412326;24733.50532989348;24762.50474990508;2446.7308596054418;2483.1805504183576;2494.9126780562774;2565.0893932653826;2701.837889726603;10469.738256543571;10654.627088051959;10746.570137194503;11007.724806879893;11209.383483908381;1994.750656167979;2006.809353111452;2009.2264478175862;2055.1573854719495;2070.33749200256;86090;89112.55443722804;89121.55439222827;89302;89909.55045224798;11673.591424300108;11788;11868.525258989717;11931.821022684666;11985.580504682293;16870.493885183463;16899.493015209562;16995.66008679844;17000.744988825176;17035.744463833053;8675.21923026918;8720.206710081135;8764.079771624016;8790.208881200722;8841.425307355;8190;8283;8390.790230244293;8433.409661323649;8445.239928406472;5000.599952003831;5025.422076461181;5062.873428164326;5178;5186.144286192736;2087.2903212907686;2102.3062389411457;2121.48023734183;2133.0934352899953;2189.1243502599086;1024.4775164666073;1082.6589624268488;1127.7406196574834;1136.6476392318407;1166.877477864812;19661.705074423895;19765.802341976683;19990.50023749389;20027.59944801096;20209.292674756314;1008.7982403519326;1059.2373491086405;1063.6755789484282;1085.0180586569168;1092.721356054217;10248.436336001443;10535.683929482127;10574.551989217698;10610.522526486327;10733.463326833627;537832;540485;549698;554715;565257;79052.6047369771;103759.99999999849;105695.47152264189;106156;106254.46872765741;1165.1028707894873;1175.670812172593;1177.8527684039666;1200.711829160995;1236.8330275412884;18205.54486137857;18370.816291837444;18433.446996590123;18551.90724046371;18642.254309827455;40094.19811603693;40569;42117;42984;43172.78413607912;60906;61135;62061.689691551255;62533.374666254575;62863.05705414331;8618;8985.101489850962;9140.451572905647;9408.247340212629;9426.905730942877;10245;13387.598372048855;13889.02776805614;14151.929240354144;14268.357923893242;12216.87783122193;12417.689557761129;12469;12499.687507812014;12503.187292825936;12075.456604452997;12410.937945310216;12428.937855310665;12501.24992500453;12668.683282918;12182.086343524094;12244.204126732091;12403.317817520123;12600.432980515716;12694.682632934251;8868.689595864114;8902.510361930155;9042.412243204171;9163.266938645025;9310.394824336396;8791.340529578489;11820.586279480176;12089.335086570323;12355.876441235472;12421.130520863453 14:29:20 INFO - PROCESS | 20593 | |3;mootools.html;1427.4932398998362;1529.9158546279957;1572.748360262358;1704.309754549408;1872.5505878589142;8433.873491897619;8845.469271843695;8857.335699822515;8858.822823543525;8861.46831190129;8607.354448416363;8787.209151176392;8808;8821.426607270523;8821.999999999984;2159.4385459780415;2229.665550167472;2450.2036838027625;2484.9006039758387;2532.556802559545;2463.8521688698647;2480.9255722328357;2482.900683972639;2485.005997600956;2486.0925762096886;2417.4560723837085;2514.4845306712173;2515.2831443038735;2515.786158176548;2517.1190083470824;2047.6416627090275;2376.5603363377745;2397.5085107552995;2452.558539462896;2463;2456.8894399752053;2462.22439931421;2466.654668346433;2492.6011838105815;2495.8502489850666;8751.824963500694;8843.557822108869;8846.203841654218;8856.291496680315;8861.911380886173;5238.083335416325;5420.322459692538;5421.213923981;5435.565154787608;5468.699221542814;3407.7784943978563;3420.521127042216;3469.9653003469894;3532.487789270567;3536.3634545781747;1161.2800063960399;1170.5961443302047;1178.7465694875643;1198.3049831098028;1212.2847519963263;11884.049276057982;12056.939715301454;12138.332391718452;12138.696532586668;12143.878561214451;4798.664093513421;4841.782119804618;4878.341423907798;4916.901661966741;4973.030259099513;10565;10602.681919542427;10670.466476676134;10673.092787113028;10674.62638807638;5509.889802203934;5538.335399752055;5552.833414997556;5557.527610153183;5566.443355664401;4555.840545580889;5035.370578677665;5125.384953805493;5130.12787826063;5154.30416893722;4263.658907287409;4282.207791558571;4302.913941721211;4333.653307735437;4353.303471444617;1332.3271747767315;1360.9523666671619;1375.2642336350004;1403.7683782176032;1416.4900635771114;977.6236149082512;1003.2225025605214;1005.7284533176002;1026.594495174402;1034.632705389591;5965.3139888912465;6063.757449701962;6118.20463339763;6122.479589234965;6226.315105338409;488.0775334617576;500.294584635662;500.3345550417935;505.7294347524057;1059.2214722179192;4166.395872598517;4227.154569086195;4233.851815186454;4257.4252475915355;4259.382389553497;10856.34861908288;11288.435578221057;11371.715707107389;11430;11430.542778288942;10933.453327333602;11229.831552526719;11454.312741235553;11461.197716159788;11477.024452921596;8209.753707388787;8278.751637450887;8520.062793092755;8574.399792014623;8612.870806938026;5928.288605367384;6021.337652858095;6035.758569657341;6092.8781424372155;6102.135098014734;10200;10398.376097434179;10408.687739367831;10413.479326033517;10526.473676316307;9904.108630223314;9938.503074846374;10308.020738029874;10494.10800081971;10514.947425262824;6653.9667301663185;6820.693068811816;7035.366816986496;7420.925790742023;7538.849223015619;8511;8513.489190648581;8545.273651739422;8587.613557390057;8619.91380086191;7461.253874612496;7661.15727270011;7696.230376962259;7719.112302085332;7814.921850781647;7520.172780993977;7603.315701586884;7613.885791713239;7702;7722.111957125003;6997.265287144776;7208;7216.675249613885;7248;7251.782446526613;5175.404828444777;5251.684898906078;5344.225087362233;5375.08623534008;5384.246205531307;5354.598405119554;5421.159720243369;5421.241026256406;5468;5634 14:29:20 INFO - PROCESS | 20593 | |4;prototype.html;353.4239190120104;361.667266115174;362.3025675574518;368.2747667262259;368.7529355331927;5424.159255315428;5583.827396246793;5587.552995760339;5608.355039170497;5620.522255608268;5213.218017297408;5306.628536002481;5443.401225865152;5521.723913804314;5543.390227075019;4258.148370325932;4259.275923093074;4289.785510724467;4292.141571685675;4317.848875289365;4307.483102027761;4310;4328.696991210617;4338.1540599583095;4351.912961740779;4021.5978402159694;4072.1041370898356;4093.3626549380187;4259.5740425957465;4280.400743895857;4210.105452546336;4214.262504061808;4220.092680073799;4273.846061563376;4276.2089013532595;3810.5617853946874;3816.542014958195;3818.5417749869916;3821.8660698227463;3822.9044273893096;5154.896902061975;5246.55719677088;5275.942382470839;5276.92084618731;5318.25544423781;4939.308496810413;4944.184209605411;4953.876153096166;4955.727434991074;4975.706316357737;5713.7144142568;5725.599208055438;5733.226014488074;5741.282339707536;5760.337561180476;4069.1454794493193;4215.515215750197;4218.346156345771;4228.978855105735;4251.256030194703;5908.231929849092;5920.082387229986;5928.9407105928385;5981.162637230791;5997.460228579405;4327.545607711208;4338.913221735547;4353.651707863363;4360.149770794665;4363.934540981888;4297.505786834491;4356.716813407118;4364.978175109104;4390.780460976938;4400.251957167226;4915.11527924977;4917.680350777188;4922.8769280768265;4923.359963204761;4928.7289199093675;5754.043625167463;5758.193852860602;5771.624844385102;5774.624649397776;5812.767489300465;1521.6576270339085;1530.869876060525;1559.1736379718768;1563.7419825728855;1603.9599010024842;1090.7436752363187;1096.802575536411;1107.9889201108047;1118.4351902289293;1119.1885882734953;5814.651120932757;5815.331236907809;5817.7963771267805;5834.5624078194305;5926.170336152942;6263.906041409291;6279.937200628026;6284.968575157095;6289.308176100717;6299.6850157491945;5736.827895163152;5900.557458190567;5915.733791979371;5931.347551769302;5956.910646340309;3312.2878581104696;3327.1515763480156;3332.500124981272;3337.2658015236607;3348.1462227131924;6296.590721603081;6305.626191989821;6367.917454032826;6406.743730250738;6446.387593178641;6287.025511045796;6304.684765761694;6337.081123237197;6342.809715708536;6346.968265158737;6201.890698660493;6356.968215158895;6365.968170159213;6374.362563743589;6391.552591318563;6153.353897840662;6174.783882564268;6177.135201071764;6195.535334849995;6214.471769899609;6055.788047418319;6075.756969721162;6114;6116.602420842631;6136.662483563447;6215.34738852414;6411.294757576756;6433.774817881352;6434.131392261985;6439.162908821823;4496.88757781045;4530.436999235259;4534.977325113353;4541.341505481752;4541.409616749801;5562.33130060972;5695.800646977336;6154.261488621215;6218.787336469345;6241.781537646342;5784.363719990882;5811.27359080115;5825.883482330245;5856.3558008618165;5869.383714710065;5733.168690539765;5784.884302314014;5801.36185019639;5802.448767367094;5812.21535092757;5512.641678290898;5662.546996240373;5668.178114173339;5722.1702853085235;5724.627899186539;5804;5851.239338885917;5880.294364676266;5898.8230353089475;5901.5868889177345;5606.018946684396;5742.885142297047;5756.3380211276235;5757.136429535603;5766.394528574607 14:29:20 INFO - PROCESS | 20593 | |5;yui.html;772.7411317208733;796.3191471292046;800.1118758178425;825.2778818533783;859.4155973937724;14629.195394253326;14964.476243331486;14969.625759356022;14973.401063957428;15089.849101508982;12281.69295767604;12355.50577976882;12392.070594705388;12403.317817520032;12423.130380873343;736.9299916507923;870.3950754225816;884.9955750221272;899.536738579632;903.2864037410438;901.0223907060847;901.5176880369004;903.3044555692113;906.0441234497603;906.4334790755778;940.7789169545151;944.7543638653965;947.6020071569957;947.7488465556632;948.1419315519431;771.3674786674928;793.0047790023513;793.1394437035765;920.5719340506696;942.9104235097689;686.5160062156168;690.2752110284182;691.6265216782931;692.3111504053448;692.7679227458807;13857;13897.583072507841;13941.860581394158;13992.230427326493;14029.85970140306;14118.36467358961;14498.130112193303;14507.274636268145;14582.4896128635;14602.19687917164;11047.944760276228;11323.053757262658;11417.771644567145;11421.657350279505;11607.30356178632;4547.477040140393;4630.282306242538;4740.715557066587;4797.448293446263;4839.491853355382;50742;51512.484875151145;51841.48158518442;51868.740656296475;52681;9901.207903367713;9990.650327238513;10101.949490252502;10306.433146177033;10306.587736490457;17545.56136096608;17660.911695441697;17691.911540442215;17715.911420443073;17999.100044997696;8236;8467;8502.11285110614;8525.40322177454;8583.699570515002;4828.637852161102;4866.148424025781;4910.508949105132;4954.950450495521;5081.923771143436;3516.08581768742;3623.873164439232;3779.149691319431;3785.432185172246;3804.334241507725;658.5456035335603;659.0674196012588;670.1890712238246;676.3101636331013;676.8781619308473;631.2488139114439;640.8526039011053;679.8572299816994;704.6547191876047;733.9339459448676;10138.949305253574;10333.896661033445;10367.32612380193;10424.947875260576;10527.420991845522;584.5498965796313;634.2325785799143;643.6331291164086;725.6081715873474;758.9544627322379;4537.818487260539;4637.373954516164;4717.410323709536;4735;4742.762861856893;76505.61747191228;76985;77109.61445192738;77906.6104669473;78548;66098;66399.66800165968;66738;66781.33218667848;67978.66010669916;57021.714891426105;59304;61264.387356125866;62659.6867015662;62691.05963410553;8904.73285801427;8914.777130571787;8928.86606700887;8993.640254390013;9003.594838232164;38831.80584097174;39309.2138157241;39393.40909886297;39464.40803387894;40027;47916.281255780494;48987.5101248983;49155.754221228664;50435.49564504308;55275.723621383244;11665.766684666089;11966.820497692368;11994.280343179436;12028.879711202775;12032.398380080786;12883.613491595268;13397.196168229937;13877.444902203799;13931.373088210852;14605.415783368971;13333.466661333438;13391.397387117799;13399.732005360032;13508.611066815296;13551.86448135506;12583.685407864876;12775.936120319711;12891.548795792101;13039;13149.276789776653;12940.547080852126;13087.607371778862;13413.932930335677;13777.862221377658;13862.168269903837;10931.78136437251;11228.66314010581;11364.54541818318;11388.373639449579;11493;11096.944515277371;11197.832032519682;11340.546378144782;11602.303861768321;11628.418579070843 14:29:20 INFO - PROCESS | 20593 | __end_tp_report 14:29:20 INFO - PROCESS | 20593 | __start_cc_report 14:29:20 INFO - PROCESS | 20593 | _x_x_mozilla_cycle_collect,840 14:29:20 INFO - PROCESS | 20593 | __end_cc_report 14:29:20 INFO - PROCESS | 20593 | __startTimestamp1462483760873__endTimestamp 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | ------- Summary: start ------- 14:29:20 INFO - PROCESS | 20593 | Number of tests: 6 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | [#0] dojo.html Cycles:165 Average:5557.39 Median:5755.40 stddev:621.50 (10.8%) stddev-sans-first:598.05 14:29:20 INFO - PROCESS | 20593 | Values: 3317.1 3415.2 3426.0 3438.8 3467.5 5633.8 5657.3 5659.5 5674.0 5679.5 5611.7 5663.6 5663.7 5677.4 5705.6 4832.0 5033.3 5071.5 5120.4 5157.3 5016.7 5078.4 5080.4 5083.5 5086.8 5010.2 5045.2 5064.7 5091.8 5095.7 5047.2 5081.7 5097.7 5097.8 5132.0 4896.2 4956.5 5014.2 5022.3 5042.4 5396.8 5449.6 5465.2 5476.1 5485.3 5967.0 5998.8 6007.7 6008.0 6009.1 5876.9 6016.0 6035.1 6047.7 6089.2 5637.1 5662.2 5663.1 5666.9 5671.3 6157.6 6174.8 6183.5 6185.3 6186.7 5824.4 5842.9 5913.5 5945.4 5959.8 5995.6 6013.2 6024.9 6029.2 6031.8 5971.9 5997.9 6004.5 6005.8 6006.5 5724.9 5949.2 6014.2 6055.1 6055.1 4514.5 4533.5 4535.2 4540.7 4570.8 3997.8 4078.8 4088.1 4094.1 4124.1 5579.4 5639.2 5657.4 5686.0 5686.5 5978.8 5979.4 5985.5 5988.1 5989.9 5514.3 5626.7 5631.7 5635.5 5684.8 5148.4 5150.8 5151.2 5162.8 5178.8 6240.8 6245.8 6248.8 6250.0 6253.9 5864.6 6026.6 6030.7 6041.3 6120.4 6156.4 6161.7 6162.2 6162.7 6181.3 5718.7 5831.1 5834.0 5836.3 5857.4 5869.3 5914.7 5974.9 6068.9 6089.0 5806.3 5814.7 5821.8 5824.1 5825.6 5760.5 5772.6 5780.9 5782.7 5782.8 5592.1 5755.4 5827.5 5840.6 5859.8 5865.4 5871.3 5877.3 5878.0 5883.9 5643.7 5728.9 5754.0 5755.0 5760.4 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | [#1] ext.html Cycles:180 Average:62883.22 Median:213772.21 stddev:125642.51 (58.8%) stddev-sans-first:125907.98 14:29:20 INFO - PROCESS | 20593 | Values: 612.8 664.2 667.6 678.5 679.8 33828.0 34777.1 34799.7 34850.3 34894.1 35483.0 40576.0 41454.2 41559.0 41606.0 8734.2 8973.2 8976.1 8981.4 8983.7 7964.7 8153.9 8775.2 8952.1 8965.0 10221.9 10454.9 10455.8 10457.9 10462.3 10378.5 10500.9 10506.2 10506.7 10508.6 8009.8 10268.1 10326.5 10431.8 10447.6 41941.8 42743.4 42778.0 42815.6 43000.1 3382.9 3547.5 3577.9 3837.7 3953.4 31863.5 32199.0 32315.8 32419.2 32470.2 4432.5 4438.0 4452.1 4523.7 4576.1 388579.0 390465.0 391512.0 392758.0 393814.0 71272.0 71919.6 71946.0 72056.0 72088.0 64918.4 66474.7 66702.7 66846.7 66861.3 17917.9 17996.4 18065.5 18119.3 18244.6 13418.5 13495.7 13496.1 13520.8 13580.7 19029.3 19452.3 20913.0 21443.7 21620.1 7610.0 7916.8 8019.3 8056.0 8149.0 1098.3 1101.9 1144.9 1153.8 1154.1 31559.8 32409.0 32425.2 33021.1 33459.2 1183.1 1235.6 1237.5 1275.1 1296.6 16957.9 17717.2 18194.5 18283.5 18735.8 581032.0 588718.0 590307.0 591110.0 591394.0 64558.7 65413.3 65706.0 65740.7 65742.7 1429.1 1490.2 1531.0 1532.7 1535.5 30487.7 31425.2 31799.8 31958.4 32757.8 51761.2 51999.5 52818.0 52910.5 52937.0 412062.0 414284.0 414543.0 415019.0 416316.0 23660.0 28239.2 28363.3 28474.0 28538.6 40509.6 47525.0 48354.3 48524.5 48532.3 39902.8 39921.2 40001.0 40015.0 40172.6 36935.0 38965.4 39530.2 40177.2 40739.6 40020.0 40691.4 40854.4 40914.4 41299.8 32783.9 37381.6 37790.8 38162.4 38397.4 29093.3 29156.4 29340.3 29442.9 29532.0 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | [#2] jquery.html Cycles:180 Average:31525.32 Median:2111.89 stddev:90617.54 (4290.8%) stddev-sans-first:90841.67 14:29:20 INFO - PROCESS | 20593 | Values: 435.0 438.5 444.4 445.5 446.1 18782.2 19322.6 19806.8 19879.9 19929.5 19011.8 19025.2 19111.8 19320.9 19336.6 5660.6 5883.6 5911.6 5918.6 5921.4 5590.8 5717.8 5771.6 5802.8 5911.9 5850.8 5858.0 5891.5 5892.1 5895.1 5806.3 5839.0 6171.7 6326.5 6388.6 5620.2 5645.8 5647.4 5654.8 5662.5 20352.0 23177.2 24123.8 24733.5 24762.5 2446.7 2483.2 2494.9 2565.1 2701.8 10469.7 10654.6 10746.6 11007.7 11209.4 1994.8 2006.8 2009.2 2055.2 2070.3 86090.0 89112.6 89121.6 89302.0 89909.6 11673.6 11788.0 11868.5 11931.8 11985.6 16870.5 16899.5 16995.7 17000.7 17035.7 8675.2 8720.2 8764.1 8790.2 8841.4 8190.0 8283.0 8390.8 8433.4 8445.2 5000.6 5025.4 5062.9 5178.0 5186.1 2087.3 2102.3 2121.5 2133.1 2189.1 1024.5 1082.7 1127.7 1136.6 1166.9 19661.7 19765.8 19990.5 20027.6 20209.3 1008.8 1059.2 1063.7 1085.0 1092.7 10248.4 10535.7 10574.6 10610.5 10733.5 537832.0 540485.0 549698.0 554715.0 565257.0 79052.6 103760.0 105695.5 106156.0 106254.5 1165.1 1175.7 1177.9 1200.7 1236.8 18205.5 18370.8 18433.4 18551.9 18642.3 40094.2 40569.0 42117.0 42984.0 43172.8 60906.0 61135.0 62061.7 62533.4 62863.1 8618.0 8985.1 9140.5 9408.2 9426.9 10245.0 13387.6 13889.0 14151.9 14268.4 12216.9 12417.7 12469.0 12499.7 12503.2 12075.5 12410.9 12428.9 12501.2 12668.7 12182.1 12244.2 12403.3 12600.4 12694.7 8868.7 8902.5 9042.4 9163.3 9310.4 8791.3 11820.6 12089.3 12355.9 12421.1 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | [#3] mootools.html Cycles:180 Average:5904.81 Median:4860.06 stddev:3313.47 (68.2%) stddev-sans-first:3305.68 14:29:20 INFO - PROCESS | 20593 | Values: 1427.5 1529.9 1572.7 1704.3 1872.6 8433.9 8845.5 8857.3 8858.8 8861.5 8607.4 8787.2 8808.0 8821.4 8822.0 2159.4 2229.7 2450.2 2484.9 2532.6 2463.9 2480.9 2482.9 2485.0 2486.1 2417.5 2514.5 2515.3 2515.8 2517.1 2047.6 2376.6 2397.5 2452.6 2463.0 2456.9 2462.2 2466.7 2492.6 2495.9 8751.8 8843.6 8846.2 8856.3 8861.9 5238.1 5420.3 5421.2 5435.6 5468.7 3407.8 3420.5 3470.0 3532.5 3536.4 1161.3 1170.6 1178.7 1198.3 1212.3 11884.0 12056.9 12138.3 12138.7 12143.9 4798.7 4841.8 4878.3 4916.9 4973.0 10565.0 10602.7 10670.5 10673.1 10674.6 5509.9 5538.3 5552.8 5557.5 5566.4 4555.8 5035.4 5125.4 5130.1 5154.3 4263.7 4282.2 4302.9 4333.7 4353.3 1332.3 1361.0 1375.3 1403.8 1416.5 977.6 1003.2 1005.7 1026.6 1034.6 5965.3 6063.8 6118.2 6122.5 6226.3 488.1 500.3 500.3 505.7 1059.2 4166.4 4227.2 4233.9 4257.4 4259.4 10856.3 11288.4 11371.7 11430.0 11430.5 10933.5 11229.8 11454.3 11461.2 11477.0 8209.8 8278.8 8520.1 8574.4 8612.9 5928.3 6021.3 6035.8 6092.9 6102.1 10200.0 10398.4 10408.7 10413.5 10526.5 9904.1 9938.5 10308.0 10494.1 10514.9 6654.0 6820.7 7035.4 7420.9 7538.8 8511.0 8513.5 8545.3 8587.6 8619.9 7461.3 7661.2 7696.2 7719.1 7814.9 7520.2 7603.3 7613.9 7702.0 7722.1 6997.3 7208.0 7216.7 7248.0 7251.8 5175.4 5251.7 5344.2 5375.1 5384.2 5354.6 5421.2 5421.2 5468.0 5634.0 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | [#4] prototype.html Cycles:180 Average:4964.29 Median:5607.19 stddev:1461.26 (26.1%) stddev-sans-first:1423.78 14:29:20 INFO - PROCESS | 20593 | Values: 353.4 361.7 362.3 368.3 368.8 5424.2 5583.8 5587.6 5608.4 5620.5 5213.2 5306.6 5443.4 5521.7 5543.4 4258.1 4259.3 4289.8 4292.1 4317.8 4307.5 4310.0 4328.7 4338.2 4351.9 4021.6 4072.1 4093.4 4259.6 4280.4 4210.1 4214.3 4220.1 4273.8 4276.2 3810.6 3816.5 3818.5 3821.9 3822.9 5154.9 5246.6 5275.9 5276.9 5318.3 4939.3 4944.2 4953.9 4955.7 4975.7 5713.7 5725.6 5733.2 5741.3 5760.3 4069.1 4215.5 4218.3 4229.0 4251.3 5908.2 5920.1 5928.9 5981.2 5997.5 4327.5 4338.9 4353.7 4360.1 4363.9 4297.5 4356.7 4365.0 4390.8 4400.3 4915.1 4917.7 4922.9 4923.4 4928.7 5754.0 5758.2 5771.6 5774.6 5812.8 1521.7 1530.9 1559.2 1563.7 1604.0 1090.7 1096.8 1108.0 1118.4 1119.2 5814.7 5815.3 5817.8 5834.6 5926.2 6263.9 6279.9 6285.0 6289.3 6299.7 5736.8 5900.6 5915.7 5931.3 5956.9 3312.3 3327.2 3332.5 3337.3 3348.1 6296.6 6305.6 6367.9 6406.7 6446.4 6287.0 6304.7 6337.1 6342.8 6347.0 6201.9 6357.0 6366.0 6374.4 6391.6 6153.4 6174.8 6177.1 6195.5 6214.5 6055.8 6075.8 6114.0 6116.6 6136.7 6215.3 6411.3 6433.8 6434.1 6439.2 4496.9 4530.4 4535.0 4541.3 4541.4 5562.3 5695.8 6154.3 6218.8 6241.8 5784.4 5811.3 5825.9 5856.4 5869.4 5733.2 5784.9 5801.4 5802.4 5812.2 5512.6 5662.5 5668.2 5722.2 5724.6 5804.0 5851.2 5880.3 5898.8 5901.6 5606.0 5742.9 5756.3 5757.1 5766.4 14:29:20 INFO - PROCESS | 20593 | 14:29:20 INFO - PROCESS | 20593 | [#5] yui.html Cycles:180 Average:16170.12 Median:26329.52 stddev:19969.73 (75.8%) stddev-sans-first:19992.28 14:29:20 INFO - PROCESS | 20593 | Values: 772.7 796.3 800.1 825.3 859.4 14629.2 14964.5 14969.6 14973.4 15089.8 12281.7 12355.5 12392.1 12403.3 12423.1 736.9 870.4 885.0 899.5 903.3 901.0 901.5 903.3 906.0 906.4 940.8 944.8 947.6 947.7 948.1 771.4 793.0 793.1 920.6 942.9 686.5 690.3 691.6 692.3 692.8 13857.0 13897.6 13941.9 13992.2 14029.9 14118.4 14498.1 14507.3 14582.5 14602.2 11047.9 11323.1 11417.8 11421.7 11607.3 4547.5 4630.3 4740.7 4797.4 4839.5 50742.0 51512.5 51841.5 51868.7 52681.0 9901.2 9990.7 10101.9 10306.4 10306.6 17545.6 17660.9 17691.9 17715.9 17999.1 8236.0 8467.0 8502.1 8525.4 8583.7 4828.6 4866.1 4910.5 4955.0 5081.9 3516.1 3623.9 3779.1 3785.4 3804.3 658.5 659.1 670.2 676.3 676.9 631.2 640.9 679.9 704.7 733.9 10138.9 10333.9 10367.3 10424.9 10527.4 584.5 634.2 643.6 725.6 759.0 4537.8 4637.4 4717.4 4735.0 4742.8 76505.6 76985.0 77109.6 77906.6 78548.0 66098.0 66399.7 66738.0 66781.3 67978.7 57021.7 59304.0 61264.4 62659.7 62691.1 8904.7 8914.8 8928.9 8993.6 9003.6 38831.8 39309.2 39393.4 39464.4 40027.0 47916.3 48987.5 49155.8 50435.5 55275.7 11665.8 11966.8 11994.3 12028.9 12032.4 12883.6 13397.2 13877.4 13931.4 14605.4 13333.5 13391.4 13399.7 13508.6 13551.9 12583.7 12775.9 12891.5 13039.0 13149.3 12940.5 13087.6 13413.9 13777.9 13862.2 10931.8 11228.7 11364.5 11388.4 11493.0 11096.9 11197.8 11340.5 11602.3 11628.4 14:29:20 INFO - PROCESS | 20593 | -------- Summary: end -------- 14:29:20 INFO - PROCESS | 20593 | 14:29:21 INFO - TEST-INFO | 20593: exit 0 14:29:21 INFO - TEST-OK | dromaeo_css | took 1111521ms 14:29:21 INFO - TEST-START | kraken 14:29:21 INFO - operating with platform_type : linux_ 14:29:21 INFO - Initialising browser for kraken test... 14:29:21 INFO - TEST-INFO | started process 20781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMbd1_7/profile http://localhost:45856/getInfo.html) 14:29:25 INFO - PROCESS | 20781 | __metrics Screen width/height:1600/1200 14:29:25 INFO - PROCESS | 20781 | colorDepth:24 14:29:25 INFO - PROCESS | 20781 | Browser inner width/height: 1024/697 14:29:25 INFO - PROCESS | 20781 | __metrics 14:29:26 ERROR - PROCESS | 20781 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:29:27 INFO - TEST-INFO | 20781: exit 0 14:29:27 INFO - Browser initialized. 14:29:27 INFO - Running cycle 1/1 for kraken test... 14:29:27 INFO - TEST-INFO | started process 20871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMbd1_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:39 INFO - PROCESS | 20871 | RSS: Main: 142761984 14:29:39 INFO - PROCESS | 20871 | 14:29:41 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-beat-detection) 14:29:42 INFO - PROCESS | 20871 | RSS: Main: 191410176 14:29:42 INFO - PROCESS | 20871 | 14:29:45 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-dft) 14:29:45 INFO - PROCESS | 20871 | RSS: Main: 184569856 14:29:45 INFO - PROCESS | 20871 | 14:29:48 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-fft) 14:29:49 INFO - PROCESS | 20871 | RSS: Main: 273293312 14:29:49 INFO - PROCESS | 20871 | 14:29:51 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-oscillator) 14:29:51 INFO - PROCESS | 20871 | RSS: Main: 183156736 14:29:51 INFO - PROCESS | 20871 | 14:29:54 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:54 INFO - PROCESS | 20871 | RSS: Main: 180940800 14:29:54 INFO - PROCESS | 20871 | 14:29:57 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:58 INFO - PROCESS | 20871 | RSS: Main: 216096768 14:29:58 INFO - PROCESS | 20871 | 14:30:01 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:02 INFO - PROCESS | 20871 | RSS: Main: 215449600 14:30:02 INFO - PROCESS | 20871 | 14:30:04 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45856/tests/kraken/driver.html?testName=json-parse-financial) 14:30:05 INFO - PROCESS | 20871 | RSS: Main: 214990848 14:30:05 INFO - PROCESS | 20871 | 14:30:07 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:07 INFO - PROCESS | 20871 | RSS: Main: 194932736 14:30:07 INFO - PROCESS | 20871 | 14:30:09 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:09 INFO - PROCESS | 20871 | RSS: Main: 198852608 14:30:09 INFO - PROCESS | 20871 | 14:30:11 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:12 INFO - PROCESS | 20871 | RSS: Main: 207679488 14:30:12 INFO - PROCESS | 20871 | 14:30:14 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:15 INFO - PROCESS | 20871 | RSS: Main: 215650304 14:30:15 INFO - PROCESS | 20871 | 14:30:18 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:18 INFO - PROCESS | 20871 | RSS: Main: 212246528 14:30:18 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45856/tests/kraken/driver.html?testName=ai-astar) 14:30:20 INFO - PROCESS | 20871 | RSS: Main: 276475904 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | __start_tp_report 14:30:20 INFO - PROCESS | 20871 | _x_x_mozilla_page_load 14:30:20 INFO - PROCESS | 20871 | _x_x_mozilla_page_load_details 14:30:20 INFO - PROCESS | 20871 | |i|pagename|runs| 14:30:20 INFO - PROCESS | 20871 | |0;ai-astar;111;111;106;109;110;110;98;108;109;110 14:30:20 INFO - PROCESS | 20871 | |1;audio-beat-detection;163;133;151;176;127;156;148;130;180;125 14:30:20 INFO - PROCESS | 20871 | |2;audio-dft;162;162;159;160;166;161;162;165;163;162 14:30:20 INFO - PROCESS | 20871 | |3;audio-fft;73;73;76;168;77;75;75;77;150;76 14:30:20 INFO - PROCESS | 20871 | |4;audio-oscillator;93;93;153;92;92;92;153;91;92;158 14:30:20 INFO - PROCESS | 20871 | |5;imaging-gaussian-blur;117;117;117;116;117;118;118;118;117;116 14:30:20 INFO - PROCESS | 20871 | |6;imaging-darkroom;145;146;145;145;145;146;145;146;145;145 14:30:20 INFO - PROCESS | 20871 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 14:30:20 INFO - PROCESS | 20871 | |8;json-parse-financial;55;57;56;55;56;55;55;76;55;53 14:30:20 INFO - PROCESS | 20871 | |9;json-stringify-tinderbox;57;58;57;59;58;57;58;58;58;60 14:30:20 INFO - PROCESS | 20871 | |10;stanford-crypto-aes;80;71;74;73;74;74;74;73;75;81 14:30:20 INFO - PROCESS | 20871 | |11;stanford-crypto-ccm;121;119;121;119;119;122;117;119;149;117 14:30:20 INFO - PROCESS | 20871 | |12;stanford-crypto-pbkdf2;155;154;158;156;156;157;159;153;158;161 14:30:20 INFO - PROCESS | 20871 | |13;stanford-crypto-sha256-iterative;67;66;66;65;65;65;65;65;65;64 14:30:20 INFO - PROCESS | 20871 | __end_tp_report 14:30:20 INFO - PROCESS | 20871 | __start_cc_report 14:30:20 INFO - PROCESS | 20871 | _x_x_mozilla_cycle_collect,1591 14:30:20 INFO - PROCESS | 20871 | __end_cc_report 14:30:20 INFO - PROCESS | 20871 | __startTimestamp1462483820724__endTimestamp 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | ------- Summary: start ------- 14:30:20 INFO - PROCESS | 20871 | Number of tests: 14 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.88 (3.5%) stddev-sans-first:3.98 14:30:20 INFO - PROCESS | 20871 | Values: 111.0 111.0 106.0 109.0 110.0 110.0 98.0 108.0 109.0 110.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:153.50 stddev:20.05 (13.1%) stddev-sans-first:20.60 14:30:20 INFO - PROCESS | 20871 | Values: 163.0 133.0 151.0 176.0 127.0 156.0 148.0 130.0 180.0 125.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 14:30:20 INFO - PROCESS | 20871 | Values: 162.0 162.0 159.0 160.0 166.0 161.0 162.0 165.0 163.0 162.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:35.59 (47.1%) stddev-sans-first:37.08 14:30:20 INFO - PROCESS | 20871 | Values: 73.0 73.0 76.0 168.0 77.0 75.0 75.0 77.0 150.0 76.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:92.00 stddev:30.24 (32.9%) stddev-sans-first:31.37 14:30:20 INFO - PROCESS | 20871 | Values: 93.0 93.0 153.0 92.0 92.0 92.0 153.0 91.0 92.0 158.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:30:20 INFO - PROCESS | 20871 | Values: 117.0 117.0 117.0 116.0 117.0 118.0 118.0 118.0 117.0 116.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:30:20 INFO - PROCESS | 20871 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:30:20 INFO - PROCESS | 20871 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.50 stddev:6.65 (12.0%) stddev-sans-first:7.00 14:30:20 INFO - PROCESS | 20871 | Values: 55.0 57.0 56.0 55.0 56.0 55.0 55.0 76.0 55.0 53.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.94 (1.6%) stddev-sans-first:0.93 14:30:20 INFO - PROCESS | 20871 | Values: 57.0 58.0 57.0 59.0 58.0 57.0 58.0 58.0 58.0 60.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:3.14 (4.2%) stddev-sans-first:2.74 14:30:20 INFO - PROCESS | 20871 | Values: 80.0 71.0 74.0 73.0 74.0 74.0 74.0 73.0 75.0 81.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:120.00 stddev:9.52 (7.9%) stddev-sans-first:10.09 14:30:20 INFO - PROCESS | 20871 | Values: 121.0 119.0 121.0 119.0 119.0 122.0 117.0 119.0 149.0 117.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:157.50 stddev:2.41 (1.5%) stddev-sans-first:2.47 14:30:20 INFO - PROCESS | 20871 | Values: 155.0 154.0 158.0 156.0 156.0 157.0 159.0 153.0 158.0 161.0 14:30:20 INFO - PROCESS | 20871 | 14:30:20 INFO - PROCESS | 20871 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 14:30:20 INFO - PROCESS | 20871 | Values: 67.0 66.0 66.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 14:30:20 INFO - PROCESS | 20871 | -------- Summary: end -------- 14:30:20 INFO - PROCESS | 20871 | 14:30:21 INFO - TEST-INFO | 20871: exit 0 14:30:21 INFO - TEST-OK | kraken | took 60157ms 14:30:21 INFO - SUITE-END | took 1171s 14:30:21 INFO - Completed test suite (00:19:31) 14:30:21 INFO - javascript benchmark 14:30:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.071220058384, 3415.2315728961003, 3425.9999999999986, 3438.7764795288304, 3467.497212904129, 5633.802816901404, 5657.2928383952, 5659.51894089003, 5674.0, 5679.488846003864, 5611.7474713637885, 5663.575231857607, 5663.745131469083, 5677.43225677432, 5705.629134106281, 4831.975840120795, 5033.270175824494, 5071.543561079502, 5120.411152717448, 5157.303763991869, 5016.724080175589, 5078.365204349457, 5080.364954380702, 5083.517065878736, 5086.847394578169, 5010.248462730601, 5045.217991211368, 5064.670796398223, 5091.79632814687, 5095.719735414551, 5047.192449208127, 5081.669691470042, 5097.745112744348, 5097.821576244851, 5132.024915266106, 4896.2410826321975, 4956.529129732669, 5014.172661510846, 5022.296878436985, 5042.369703787027, 5396.83809485716, 5449.5640348772, 5465.207544905967, 5476.096444086721, 5485.314335708036, 5967.015442451991, 5998.7600495980105, 6007.699615019232, 6008.03871380577, 6009.068594367836, 5876.882462350772, 6016.037434010581, 6035.064564992434, 6047.727852246616, 6089.238845144357, 5637.126245431965, 5662.235598194232, 5663.093904975184, 5666.914996275059, 5671.291088613923, 6157.599756015845, 6174.8147555573405, 6183.536234782409, 6185.288691800411, 6186.721597528122, 5824.417558244227, 5842.912356314659, 5913.497352725067, 5945.435183657545, 5959.7914073008105, 5995.550333724988, 6013.188219590387, 6024.8795024100145, 6029.186059881948, 6031.849203769941, 5971.940280597225, 5997.880042399215, 6004.489618382487, 6005.819825405245, 6006.489448396847, 5724.885502289931, 5949.2266005419015, 6014.218151640259, 6055.061465472859, 6055.122007308915, 4514.45826500822, 4533.52397998212, 4535.183666939916, 4540.659450541222, 4570.8171673133365, 3997.8200980955344, 4078.7552746835286, 4088.0801819590356, 4094.0583665757044, 4124.1133156371525, 5579.386267510652, 5639.182318563785, 5657.405972372924, 5686.0, 5686.459786320293, 5978.8206353809455, 5979.402059793986, 5985.491233245223, 5988.071848863433, 5989.850253743604, 5514.338279406497, 5626.662400255997, 5631.71841407928, 5635.492805647429, 5684.8010319638615, 5148.433672296044, 5150.768215430315, 5151.2273159026445, 5162.767675454614, 5178.818741344035, 6240.781572644935, 6245.781397651152, 6248.75004999804, 6250.031245156917, 6253.906191407133, 5864.648121112747, 6026.638401695912, 6030.728617212324, 6041.305249896318, 6120.386183820548, 6156.415140561639, 6161.72272247741, 6162.198914141133, 6162.661053642093, 6181.289151747606, 5718.742656580381, 5831.096180092092, 5833.970830145822, 5836.328822185503, 5857.414258574108, 5869.325027621878, 5914.67469289176, 5974.9402505974385, 6068.939310606837, 6089.025755879038, 5806.303243610793, 5814.680192589448, 5821.79623713168, 5824.097264923944, 5825.563082768725, 5760.510356619734, 5772.567057470623, 5780.855478613068, 5782.653040817396, 5782.826515204551, 5592.077307244422, 5755.395683453177, 5827.475527202572, 5840.620359676607, 5859.794907178229, 5865.354810970875, 5871.295444546682, 5877.265341832271, 5877.970610146922, 5883.882322353615, 5643.746031428514, 5728.885422291448, 5754.0, 5755.0, 5760.423957604206], "value": 5517.144072129177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.7579606055608, 664.1697877652933, 667.5860966200956, 678.5385937562455, 679.8062552172626, 33828.0, 34777.13057173572, 34799.65200347999, 34850.30299394017, 34894.12764680881, 35483.0, 40576.0, 41454.17091658165, 41559.0, 41606.0, 8734.170253825892, 8973.192412682858, 8976.057513961037, 8981.416207946462, 8983.730488085368, 7964.681412743512, 8153.9184608153755, 8775.166359195899, 8952.149545793172, 8964.955175224148, 10221.948890255539, 10454.895451045506, 10455.84316235257, 10457.947710261438, 10462.319949203278, 10378.532966016548, 10500.894991050069, 10506.159507239441, 10506.737331566696, 10508.579656813718, 8009.839803203903, 10268.075873171376, 10326.483675816255, 10431.800342960581, 10447.582096716122, 41941.79029104865, 42743.35884961728, 42778.0, 42815.57184428147, 43000.1399972002, 3382.915427114317, 3547.5210846535647, 3577.8926632201074, 3837.6737977271964, 3953.4267531207815, 31863.52204716908, 32199.034028978935, 32315.838420807744, 32419.189520261945, 32470.18824529382, 4432.534583868712, 4437.955620443787, 4452.087322098994, 4523.683342166049, 4576.130535198302, 388579.0, 390465.0, 391512.0, 392758.0, 393814.0, 71272.0, 71919.64040179871, 71946.0, 72056.0, 72088.0, 64918.35081649217, 66474.66762666253, 66702.66648666725, 66846.66576667085, 66861.33138668552, 17917.910410447865, 17996.37012704549, 18065.548361291072, 18119.275228990955, 18244.63510729778, 13418.530351437848, 13495.662608434868, 13496.055276130577, 13520.797188042186, 13580.660483487993, 19029.333973310866, 19452.319168829305, 20913.0, 21443.67834482484, 21620.13519459204, 7609.961950190213, 7916.802079948047, 8019.278264956182, 8056.0, 8149.022117345838, 1098.3245304137897, 1101.8871687482892, 1144.9427528623535, 1153.8326942593278, 1154.1171004181808, 31559.842200788848, 32409.0, 32425.189370265933, 33021.09717288887, 33459.16352091169, 1183.0771997841698, 1235.5613757116093, 1237.461704158694, 1275.0537087713512, 1296.5591698822257, 16957.915210424115, 17717.202725877367, 18194.545136371697, 18283.451496455127, 18735.81264187368, 581032.0, 588718.0, 590307.0, 591110.0, 591394.0, 64558.67720661461, 65413.34586654168, 65706.0, 65740.67129664417, 65742.67128664421, 1429.0996672096512, 1490.2474250503426, 1530.954071377838, 1532.6628141808785, 1535.5009621872712, 30487.695123048485, 31425.21436964094, 31799.841000794848, 31958.36083278368, 32757.836210818794, 51761.22358164706, 51999.48000519946, 52818.0, 52910.47089529209, 52937.0, 412062.0, 414284.0, 414543.0, 415019.0, 416316.0, 23660.0, 28239.15282541527, 28363.290917726397, 28474.0, 28538.57192142078, 40509.59490405058, 47525.0, 48354.274685880446, 48524.514754851996, 48532.27201591909, 39902.80048599738, 39921.2015759689, 40001.0, 40015.0, 40172.598274016884, 36935.0, 38965.41551876668, 39530.20939581135, 40177.1964560713, 40739.59260407358, 40020.0, 40691.389629155, 40854.38718419167, 40914.38628420517, 41299.793501032305, 32783.91849263368, 37381.62618373781, 37790.811045944596, 38162.42756358712, 38397.424038638885, 29093.272668183465, 29156.416871662022, 29340.266493336985, 29442.852785735933, 29532.0], "value": 20961.355668415865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.0228212772948, 438.50667998501683, 444.3623400420399, 445.52309095348915, 446.1100105289947, 18782.154803033845, 19322.613547729037, 19806.801931980714, 19879.900600496996, 19929.501762455944, 19011.809881901176, 19025.2389904404, 19111.808881911176, 19320.903395483037, 19336.613267734636, 5660.575456840743, 5883.588148829584, 5911.615744976584, 5918.615290006157, 5921.437463440988, 5590.804321848736, 5717.799877004306, 5771.624844385102, 5802.767889284423, 5911.88176236475, 5850.824475265749, 5858.033424484955, 5891.499222566065, 5892.086726557391, 5895.056790913454, 5806.332271788735, 5838.970805145989, 6171.691415429233, 6326.49388048955, 6388.616682999035, 5620.185073164368, 5645.774169033234, 5647.37878833328, 5654.802081927113, 5662.462066103713, 20352.0, 23177.188798391977, 24123.758762412326, 24733.50532989348, 24762.50474990508, 2446.7308596054418, 2483.1805504183576, 2494.9126780562774, 2565.0893932653826, 2701.837889726603, 10469.738256543571, 10654.627088051959, 10746.570137194503, 11007.724806879893, 11209.383483908381, 1994.750656167979, 2006.809353111452, 2009.2264478175862, 2055.1573854719495, 2070.33749200256, 86090.0, 89112.55443722804, 89121.55439222827, 89302.0, 89909.55045224798, 11673.591424300108, 11788.0, 11868.525258989717, 11931.821022684666, 11985.580504682293, 16870.493885183463, 16899.493015209562, 16995.66008679844, 17000.744988825176, 17035.744463833053, 8675.21923026918, 8720.206710081135, 8764.079771624016, 8790.208881200722, 8841.425307355, 8190.0, 8283.0, 8390.790230244293, 8433.409661323649, 8445.239928406472, 5000.599952003831, 5025.422076461181, 5062.873428164326, 5178.0, 5186.144286192736, 2087.2903212907686, 2102.3062389411457, 2121.48023734183, 2133.0934352899953, 2189.1243502599086, 1024.4775164666073, 1082.6589624268488, 1127.7406196574834, 1136.6476392318407, 1166.877477864812, 19661.705074423895, 19765.802341976683, 19990.50023749389, 20027.59944801096, 20209.292674756314, 1008.7982403519326, 1059.2373491086405, 1063.6755789484282, 1085.0180586569168, 1092.721356054217, 10248.436336001443, 10535.683929482127, 10574.551989217698, 10610.522526486327, 10733.463326833627, 537832.0, 540485.0, 549698.0, 554715.0, 565257.0, 79052.6047369771, 103759.99999999849, 105695.47152264189, 106156.0, 106254.46872765741, 1165.1028707894873, 1175.670812172593, 1177.8527684039666, 1200.711829160995, 1236.8330275412884, 18205.54486137857, 18370.816291837444, 18433.446996590123, 18551.90724046371, 18642.254309827455, 40094.19811603693, 40569.0, 42117.0, 42984.0, 43172.78413607912, 60906.0, 61135.0, 62061.689691551255, 62533.374666254575, 62863.05705414331, 8618.0, 8985.101489850962, 9140.451572905647, 9408.247340212629, 9426.905730942877, 10245.0, 13387.598372048855, 13889.02776805614, 14151.929240354144, 14268.357923893242, 12216.87783122193, 12417.689557761129, 12469.0, 12499.687507812014, 12503.187292825936, 12075.456604452997, 12410.937945310216, 12428.937855310665, 12501.24992500453, 12668.683282918, 12182.086343524094, 12244.204126732091, 12403.317817520123, 12600.432980515716, 12694.682632934251, 8868.689595864114, 8902.510361930155, 9042.412243204171, 9163.266938645025, 9310.394824336396, 8791.340529578489, 11820.586279480176, 12089.335086570323, 12355.876441235472, 12421.130520863453], "value": 9740.615666472477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.4932398998362, 1529.9158546279957, 1572.748360262358, 1704.309754549408, 1872.5505878589142, 8433.873491897619, 8845.469271843695, 8857.335699822515, 8858.822823543525, 8861.46831190129, 8607.354448416363, 8787.209151176392, 8808.0, 8821.426607270523, 8821.999999999984, 2159.4385459780415, 2229.665550167472, 2450.2036838027625, 2484.9006039758387, 2532.556802559545, 2463.8521688698647, 2480.9255722328357, 2482.900683972639, 2485.005997600956, 2486.0925762096886, 2417.4560723837085, 2514.4845306712173, 2515.2831443038735, 2515.786158176548, 2517.1190083470824, 2047.6416627090275, 2376.5603363377745, 2397.5085107552995, 2452.558539462896, 2463.0, 2456.8894399752053, 2462.22439931421, 2466.654668346433, 2492.6011838105815, 2495.8502489850666, 8751.824963500694, 8843.557822108869, 8846.203841654218, 8856.291496680315, 8861.911380886173, 5238.083335416325, 5420.322459692538, 5421.213923981, 5435.565154787608, 5468.699221542814, 3407.7784943978563, 3420.521127042216, 3469.9653003469894, 3532.487789270567, 3536.3634545781747, 1161.2800063960399, 1170.5961443302047, 1178.7465694875643, 1198.3049831098028, 1212.2847519963263, 11884.049276057982, 12056.939715301454, 12138.332391718452, 12138.696532586668, 12143.878561214451, 4798.664093513421, 4841.782119804618, 4878.341423907798, 4916.901661966741, 4973.030259099513, 10565.0, 10602.681919542427, 10670.466476676134, 10673.092787113028, 10674.62638807638, 5509.889802203934, 5538.335399752055, 5552.833414997556, 5557.527610153183, 5566.443355664401, 4555.840545580889, 5035.370578677665, 5125.384953805493, 5130.12787826063, 5154.30416893722, 4263.658907287409, 4282.207791558571, 4302.913941721211, 4333.653307735437, 4353.303471444617, 1332.3271747767315, 1360.9523666671619, 1375.2642336350004, 1403.7683782176032, 1416.4900635771114, 977.6236149082512, 1003.2225025605214, 1005.7284533176002, 1026.594495174402, 1034.632705389591, 5965.3139888912465, 6063.757449701962, 6118.20463339763, 6122.479589234965, 6226.315105338409, 488.0775334617576, 500.294584635662, 500.3345550417935, 505.7294347524057, 1059.2214722179192, 4166.395872598517, 4227.154569086195, 4233.851815186454, 4257.4252475915355, 4259.382389553497, 10856.34861908288, 11288.435578221057, 11371.715707107389, 11430.0, 11430.542778288942, 10933.453327333602, 11229.831552526719, 11454.312741235553, 11461.197716159788, 11477.024452921596, 8209.753707388787, 8278.751637450887, 8520.062793092755, 8574.399792014623, 8612.870806938026, 5928.288605367384, 6021.337652858095, 6035.758569657341, 6092.8781424372155, 6102.135098014734, 10200.0, 10398.376097434179, 10408.687739367831, 10413.479326033517, 10526.473676316307, 9904.108630223314, 9938.503074846374, 10308.020738029874, 10494.10800081971, 10514.947425262824, 6653.9667301663185, 6820.693068811816, 7035.366816986496, 7420.925790742023, 7538.849223015619, 8511.0, 8513.489190648581, 8545.273651739422, 8587.613557390057, 8619.91380086191, 7461.253874612496, 7661.15727270011, 7696.230376962259, 7719.112302085332, 7814.921850781647, 7520.172780993977, 7603.315701586884, 7613.885791713239, 7702.0, 7722.111957125003, 6997.265287144776, 7208.0, 7216.675249613885, 7248.0, 7251.782446526613, 5175.404828444777, 5251.684898906078, 5344.225087362233, 5375.08623534008, 5384.246205531307, 5354.598405119554, 5421.159720243369, 5421.241026256406, 5468.0, 5634.0], "value": 4714.471606953958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.4239190120104, 361.667266115174, 362.3025675574518, 368.2747667262259, 368.7529355331927, 5424.159255315428, 5583.827396246793, 5587.552995760339, 5608.355039170497, 5620.522255608268, 5213.218017297408, 5306.628536002481, 5443.401225865152, 5521.723913804314, 5543.390227075019, 4258.148370325932, 4259.275923093074, 4289.785510724467, 4292.141571685675, 4317.848875289365, 4307.483102027761, 4310.0, 4328.696991210617, 4338.1540599583095, 4351.912961740779, 4021.5978402159694, 4072.1041370898356, 4093.3626549380187, 4259.5740425957465, 4280.400743895857, 4210.105452546336, 4214.262504061808, 4220.092680073799, 4273.846061563376, 4276.2089013532595, 3810.5617853946874, 3816.542014958195, 3818.5417749869916, 3821.8660698227463, 3822.9044273893096, 5154.896902061975, 5246.55719677088, 5275.942382470839, 5276.92084618731, 5318.25544423781, 4939.308496810413, 4944.184209605411, 4953.876153096166, 4955.727434991074, 4975.706316357737, 5713.7144142568, 5725.599208055438, 5733.226014488074, 5741.282339707536, 5760.337561180476, 4069.1454794493193, 4215.515215750197, 4218.346156345771, 4228.978855105735, 4251.256030194703, 5908.231929849092, 5920.082387229986, 5928.9407105928385, 5981.162637230791, 5997.460228579405, 4327.545607711208, 4338.913221735547, 4353.651707863363, 4360.149770794665, 4363.934540981888, 4297.505786834491, 4356.716813407118, 4364.978175109104, 4390.780460976938, 4400.251957167226, 4915.11527924977, 4917.680350777188, 4922.8769280768265, 4923.359963204761, 4928.7289199093675, 5754.043625167463, 5758.193852860602, 5771.624844385102, 5774.624649397776, 5812.767489300465, 1521.6576270339085, 1530.869876060525, 1559.1736379718768, 1563.7419825728855, 1603.9599010024842, 1090.7436752363187, 1096.802575536411, 1107.9889201108047, 1118.4351902289293, 1119.1885882734953, 5814.651120932757, 5815.331236907809, 5817.7963771267805, 5834.5624078194305, 5926.170336152942, 6263.906041409291, 6279.937200628026, 6284.968575157095, 6289.308176100717, 6299.6850157491945, 5736.827895163152, 5900.557458190567, 5915.733791979371, 5931.347551769302, 5956.910646340309, 3312.2878581104696, 3327.1515763480156, 3332.500124981272, 3337.2658015236607, 3348.1462227131924, 6296.590721603081, 6305.626191989821, 6367.917454032826, 6406.743730250738, 6446.387593178641, 6287.025511045796, 6304.684765761694, 6337.081123237197, 6342.809715708536, 6346.968265158737, 6201.890698660493, 6356.968215158895, 6365.968170159213, 6374.362563743589, 6391.552591318563, 6153.353897840662, 6174.783882564268, 6177.135201071764, 6195.535334849995, 6214.471769899609, 6055.788047418319, 6075.756969721162, 6114.0, 6116.602420842631, 6136.662483563447, 6215.34738852414, 6411.294757576756, 6433.774817881352, 6434.131392261985, 6439.162908821823, 4496.88757781045, 4530.436999235259, 4534.977325113353, 4541.341505481752, 4541.409616749801, 5562.33130060972, 5695.800646977336, 6154.261488621215, 6218.787336469345, 6241.781537646342, 5784.363719990882, 5811.27359080115, 5825.883482330245, 5856.3558008618165, 5869.383714710065, 5733.168690539765, 5784.884302314014, 5801.36185019639, 5802.448767367094, 5812.21535092757, 5512.641678290898, 5662.546996240373, 5668.178114173339, 5722.1702853085235, 5724.627899186539, 5804.0, 5851.239338885917, 5880.294364676266, 5898.8230353089475, 5901.5868889177345, 5606.018946684396, 5742.885142297047, 5756.3380211276235, 5757.136429535603, 5766.394528574607], "value": 4512.189507161452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.7411317208733, 796.3191471292046, 800.1118758178425, 825.2778818533783, 859.4155973937724, 14629.195394253326, 14964.476243331486, 14969.625759356022, 14973.401063957428, 15089.849101508982, 12281.69295767604, 12355.50577976882, 12392.070594705388, 12403.317817520032, 12423.130380873343, 736.9299916507923, 870.3950754225816, 884.9955750221272, 899.536738579632, 903.2864037410438, 901.0223907060847, 901.5176880369004, 903.3044555692113, 906.0441234497603, 906.4334790755778, 940.7789169545151, 944.7543638653965, 947.6020071569957, 947.7488465556632, 948.1419315519431, 771.3674786674928, 793.0047790023513, 793.1394437035765, 920.5719340506696, 942.9104235097689, 686.5160062156168, 690.2752110284182, 691.6265216782931, 692.3111504053448, 692.7679227458807, 13857.0, 13897.583072507841, 13941.860581394158, 13992.230427326493, 14029.85970140306, 14118.36467358961, 14498.130112193303, 14507.274636268145, 14582.4896128635, 14602.19687917164, 11047.944760276228, 11323.053757262658, 11417.771644567145, 11421.657350279505, 11607.30356178632, 4547.477040140393, 4630.282306242538, 4740.715557066587, 4797.448293446263, 4839.491853355382, 50742.0, 51512.484875151145, 51841.48158518442, 51868.740656296475, 52681.0, 9901.207903367713, 9990.650327238513, 10101.949490252502, 10306.433146177033, 10306.587736490457, 17545.56136096608, 17660.911695441697, 17691.911540442215, 17715.911420443073, 17999.100044997696, 8236.0, 8467.0, 8502.11285110614, 8525.40322177454, 8583.699570515002, 4828.637852161102, 4866.148424025781, 4910.508949105132, 4954.950450495521, 5081.923771143436, 3516.08581768742, 3623.873164439232, 3779.149691319431, 3785.432185172246, 3804.334241507725, 658.5456035335603, 659.0674196012588, 670.1890712238246, 676.3101636331013, 676.8781619308473, 631.2488139114439, 640.8526039011053, 679.8572299816994, 704.6547191876047, 733.9339459448676, 10138.949305253574, 10333.896661033445, 10367.32612380193, 10424.947875260576, 10527.420991845522, 584.5498965796313, 634.2325785799143, 643.6331291164086, 725.6081715873474, 758.9544627322379, 4537.818487260539, 4637.373954516164, 4717.410323709536, 4735.0, 4742.762861856893, 76505.61747191228, 76985.0, 77109.61445192738, 77906.6104669473, 78548.0, 66098.0, 66399.66800165968, 66738.0, 66781.33218667848, 67978.66010669916, 57021.714891426105, 59304.0, 61264.387356125866, 62659.6867015662, 62691.05963410553, 8904.73285801427, 8914.777130571787, 8928.86606700887, 8993.640254390013, 9003.594838232164, 38831.80584097174, 39309.2138157241, 39393.40909886297, 39464.40803387894, 40027.0, 47916.281255780494, 48987.5101248983, 49155.754221228664, 50435.49564504308, 55275.723621383244, 11665.766684666089, 11966.820497692368, 11994.280343179436, 12028.879711202775, 12032.398380080786, 12883.613491595268, 13397.196168229937, 13877.444902203799, 13931.373088210852, 14605.415783368971, 13333.466661333438, 13391.397387117799, 13399.732005360032, 13508.611066815296, 13551.86448135506, 12583.685407864876, 12775.936120319711, 12891.548795792101, 13039.0, 13149.276789776653, 12940.547080852126, 13087.607371778862, 13413.932930335677, 13777.862221377658, 13862.168269903837, 10931.78136437251, 11228.66314010581, 11364.54541818318, 11388.373639449579, 11493.0, 11096.944515277371, 11197.832032519682, 11340.546378144782, 11602.303861768321, 11628.418579070843], "value": 7080.139876339544, "unit": "score"}], "name": "dromaeo_css", "value": 7440.537332908388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 109.0, 110.0, 110.0, 98.0, 108.0, 109.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 151.0, 176.0, 127.0, 156.0, 148.0, 130.0, 180.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 159.0, 160.0, 166.0, 161.0, 162.0, 165.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 76.0, 168.0, 77.0, 75.0, 75.0, 77.0, 150.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 153.0, 92.0, 92.0, 92.0, 153.0, 91.0, 92.0, 158.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 56.0, 55.0, 55.0, 76.0, 55.0, 53.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0, 60.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 71.0, 74.0, 73.0, 74.0, 74.0, 74.0, 73.0, 75.0, 81.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 121.0, 119.0, 119.0, 122.0, 117.0, 119.0, 149.0, 117.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 158.0, 156.0, 156.0, 157.0, 159.0, 153.0, 158.0, 161.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1514.0000000000002, "alertThreshold": 2.0}]} 14:30:21 INFO - Return code: 0 14:30:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:30:22 ERROR - # TBPL SUCCESS # 14:30:22 INFO - Running post-action listener: _resource_record_post_action 14:30:22 INFO - Running post-run listener: _resource_record_post_run 14:30:23 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 499535872; Read time: 0; Write time: 429088 14:30:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 249028608; Read time: 0; Write time: 249896 14:30:23 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 250507264; Read time: 0; Write time: 179192 14:30:23 INFO - Running post-run listener: _upload_blobber_files 14:30:23 INFO - Blob upload gear active. 14:30:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:23 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 14:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:23 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:30:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:24 INFO - (blobuploader) - INFO - Done attempting. 14:30:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:30:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:24 INFO - (blobuploader) - INFO - Done attempting. 14:30:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:25 INFO - Return code: 0 14:30:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7471086f3ad921ecbd22cadf0f953f7daf145c8e73918d0e4fa64fb96b596d2798a352f06d661ec4e30bf0a3a4df4fe7d62123a024f507f44eab32028dd3dcec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a5f5077206b46166207e8aa26c6b451a4b9c7f841cc8ce83998fde84b7dfeebb7e212dd63a0a787eb869e91f164dc69784a766235d00e6005473bad4f60ccb"} 14:30:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:25 INFO - Contents: 14:30:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7471086f3ad921ecbd22cadf0f953f7daf145c8e73918d0e4fa64fb96b596d2798a352f06d661ec4e30bf0a3a4df4fe7d62123a024f507f44eab32028dd3dcec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a5f5077206b46166207e8aa26c6b451a4b9c7f841cc8ce83998fde84b7dfeebb7e212dd63a0a787eb869e91f164dc69784a766235d00e6005473bad4f60ccb"} 14:30:25 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:25 INFO - Copying logs to upload dir... 14:30:25 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.547023 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-05 14:30:24.737209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 14:30:24.740579) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7471086f3ad921ecbd22cadf0f953f7daf145c8e73918d0e4fa64fb96b596d2798a352f06d661ec4e30bf0a3a4df4fe7d62123a024f507f44eab32028dd3dcec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a5f5077206b46166207e8aa26c6b451a4b9c7f841cc8ce83998fde84b7dfeebb7e212dd63a0a787eb869e91f164dc69784a766235d00e6005473bad4f60ccb"} build_url:https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/WI90EiKJQxGQ-PqAUnfE5Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7471086f3ad921ecbd22cadf0f953f7daf145c8e73918d0e4fa64fb96b596d2798a352f06d661ec4e30bf0a3a4df4fe7d62123a024f507f44eab32028dd3dcec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11a5f5077206b46166207e8aa26c6b451a4b9c7f841cc8ce83998fde84b7dfeebb7e212dd63a0a787eb869e91f164dc69784a766235d00e6005473bad4f60ccb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 14:30:24.765932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:30:24.766258) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1462482586.274967-365253874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004346 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 14:30:24.849169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 14:30:24.849570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 14:30:24.849909) ========= ========= Total master_lag: 0.17 =========