builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1464145548.2 results: success (0) buildid: 20160524172038 builduid: 9fc0ea4b20ba4ca598a90d24ce8c98d6 revision: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.201274) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.201765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.202046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.217365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.217700) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 20:05:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2016-05-24 20:05:48 (34.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.343868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.344185) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019956 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.393592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.393979) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 14079be66b19b1fa8c60fa34239bcff57ca51ab0 --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 14079be66b19b1fa8c60fa34239bcff57ca51ab0 --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=14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 20:05:48,476 truncating revision to first 12 chars 2016-05-24 20:05:48,477 Setting DEBUG logging. 2016-05-24 20:05:48,477 attempt 1/10 2016-05-24 20:05:48,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/14079be66b19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 20:05:48,749 unpacking tar archive at: mozilla-aurora-14079be66b19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.945951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.946272) ========= script_repo_revision: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.946669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.946961) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:48.956615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-24 20:05:48.956934) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:49 INFO - MultiFileLogger online at 20160524 20:05:49 in /builds/slave/test 20:05:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:05:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:49 INFO - {'append_to_log': False, 20:05:49 INFO - 'base_work_dir': '/builds/slave/test', 20:05:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:05:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:49 INFO - 'branch': 'Mozilla-Aurora', 20:05:49 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:49 INFO - 'config_files': ('talos/linux_config.py',), 20:05:49 INFO - 'default_actions': ('clobber', 20:05:49 INFO - 'read-buildbot-config', 20:05:49 INFO - 'download-and-extract', 20:05:49 INFO - 'populate-webroot', 20:05:49 INFO - 'create-virtualenv', 20:05:49 INFO - 'install', 20:05:49 INFO - 'run-tests'), 20:05:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:49 INFO - 'download_minidump_stackwalk': True, 20:05:49 INFO - 'download_symbols': 'ondemand', 20:05:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:49 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:49 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:49 INFO - 'installer_path': 'installer.exe', 20:05:49 INFO - 'log_level': 'info', 20:05:49 INFO - 'log_name': 'talos', 20:05:49 INFO - 'log_to_console': True, 20:05:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:49 INFO - 'opt_config_files': (), 20:05:49 INFO - 'pip_index': False, 20:05:49 INFO - 'sps_profile': False, 20:05:49 INFO - 'sps_profile_interval': 0, 20:05:49 INFO - 'suite': 'dromaeojs-e10s', 20:05:49 INFO - 'system_bits': '32', 20:05:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:49 INFO - 'title': 'talos-linux64-ix-036', 20:05:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:49 INFO - 'use_talos_json': True, 20:05:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:49 INFO - 'work_dir': 'build'} 20:05:49 INFO - ##### 20:05:49 INFO - ##### Running clobber step. 20:05:49 INFO - ##### 20:05:49 INFO - Running pre-action listener: _resource_record_pre_action 20:05:49 INFO - Running main action method: clobber 20:05:49 INFO - rmtree: /builds/slave/test/build 20:05:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:50 INFO - Running post-action listener: _resource_record_post_action 20:05:50 INFO - ##### 20:05:50 INFO - ##### Running read-buildbot-config step. 20:05:50 INFO - ##### 20:05:50 INFO - Running pre-action listener: _resource_record_pre_action 20:05:50 INFO - Running main action method: read_buildbot_config 20:05:50 INFO - Using buildbot properties: 20:05:50 INFO - { 20:05:50 INFO - "project": "", 20:05:50 INFO - "product": "firefox", 20:05:50 INFO - "script_repo_revision": "production", 20:05:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:05:50 INFO - "repository": "", 20:05:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:05:50 INFO - "buildid": "20160524172038", 20:05:50 INFO - "pgo_build": "True", 20:05:50 INFO - "basedir": "/builds/slave/test", 20:05:50 INFO - "buildnumber": 286, 20:05:50 INFO - "slavename": "talos-linux64-ix-036", 20:05:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:05:50 INFO - "platform": "ubuntu64_hw", 20:05:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:05:50 INFO - "branch": "mozilla-aurora", 20:05:50 INFO - "repo_path": "releases/mozilla-aurora", 20:05:50 INFO - "revision": "14079be66b19b1fa8c60fa34239bcff57ca51ab0", 20:05:50 INFO - "stage_platform": "linux64-pgo", 20:05:50 INFO - "builduid": "9fc0ea4b20ba4ca598a90d24ce8c98d6", 20:05:50 INFO - "slavebuilddir": "test" 20:05:50 INFO - } 20:05:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 20:05:50 INFO - Running post-action listener: _resource_record_post_action 20:05:50 INFO - ##### 20:05:50 INFO - ##### Running download-and-extract step. 20:05:50 INFO - ##### 20:05:50 INFO - Running pre-action listener: _resource_record_pre_action 20:05:50 INFO - Running main action method: download_and_extract 20:05:50 INFO - mkdir: /builds/slave/test/build/tests 20:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:50 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:50 INFO - Downloaded 1361 bytes. 20:05:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:05:50 INFO - Using the following test package requirements: 20:05:50 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:50 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:50 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:05:50 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'jsshell-linux-x86_64.zip'], 20:05:50 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:50 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:50 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:05:50 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:05:50 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:50 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:50 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:50 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:50 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:51 INFO - Downloaded 24136092 bytes. 20:05:51 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'] 20:05:51 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 20:05:53 INFO - Return code: 0 20:05:53 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 20:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:53 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:05:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:05:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:54 INFO - Downloaded 24136092 bytes. 20:05:54 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'] 20:05:54 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 20:05:55 INFO - Return code: 0 20:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:55 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:05:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:56 INFO - Downloaded 10840145 bytes. 20:05:56 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'] 20:05:56 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 20:05:56 INFO - Return code: 0 20:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:56 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:58 INFO - Downloaded 62733260 bytes. 20:05:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:05:58 INFO - mkdir: /builds/slave/test/properties 20:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:58 INFO - Contents: 20:05:58 INFO - build_url:https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:05:59 INFO - Running post-action listener: _resource_record_post_action 20:05:59 INFO - Running post-action listener: set_extra_try_arguments 20:05:59 INFO - ##### 20:05:59 INFO - ##### Running populate-webroot step. 20:05:59 INFO - ##### 20:05:59 INFO - Running pre-action listener: _resource_record_pre_action 20:05:59 INFO - Running main action method: populate_webroot 20:05:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:59 INFO - '--tppagecycles', 20:05:59 INFO - '7'], 20:05:59 INFO - 'tests': ['tsvgm']}}, 20:05:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['damp', 'tps']}, 20:05:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'tests': ['damp', 'tps']}, 20:05:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['dromaeo_dom']}, 20:05:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['a11yr', 20:05:59 INFO - 'ts_paint', 20:05:59 INFO - 'tpaint', 20:05:59 INFO - 'sessionrestore', 20:05:59 INFO - 'sessionrestore_no_auto_restore', 20:05:59 INFO - 'tabpaint']}, 20:05:59 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:59 INFO - 'ts_paint', 20:05:59 INFO - 'tpaint', 20:05:59 INFO - 'sessionrestore', 20:05:59 INFO - 'sessionrestore_no_auto_restore', 20:05:59 INFO - 'tabpaint']}, 20:05:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:59 INFO - 'ts_paint', 20:05:59 INFO - 'tpaint', 20:05:59 INFO - 'sessionrestore', 20:05:59 INFO - 'sessionrestore_no_auto_restore', 20:05:59 INFO - 'tabpaint']}, 20:05:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:59 INFO - 'ts_paint', 20:05:59 INFO - 'tpaint', 20:05:59 INFO - 'sessionrestore', 20:05:59 INFO - 'sessionrestore_no_auto_restore', 20:05:59 INFO - 'tabpaint']}, 20:05:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['a11yr', 20:05:59 INFO - 'ts_paint', 20:05:59 INFO - 'tpaint', 20:05:59 INFO - 'sessionrestore', 20:05:59 INFO - 'sessionrestore_no_auto_restore', 20:05:59 INFO - 'tabpaint']}, 20:05:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['a11yr', 20:05:59 INFO - 'ts_paint', 20:05:59 INFO - 'tpaint', 20:05:59 INFO - 'sessionrestore', 20:05:59 INFO - 'sessionrestore_no_auto_restore', 20:05:59 INFO - 'tabpaint']}, 20:05:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['tsvgx', 20:05:59 INFO - 'tsvgr_opacity', 20:05:59 INFO - 'tart', 20:05:59 INFO - 'tscrollx', 20:05:59 INFO - 'cart']}, 20:05:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:59 INFO - 'tsvgr_opacity', 20:05:59 INFO - 'tart', 20:05:59 INFO - 'tscrollx', 20:05:59 INFO - 'cart']}, 20:05:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'talos_options': ['--disable-e10s'], 20:05:59 INFO - 'tests': ['tp5o']}, 20:05:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'tests': ['tp5o']}, 20:05:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'talos_options': ['--disable-e10s', 20:05:59 INFO - '--xperf_path', 20:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:59 INFO - 'tests': ['tp5n']}, 20:05:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:59 INFO - 'talos_options': ['--xperf_path', 20:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:59 INFO - 'tests': ['tp5n']}}, 20:05:59 INFO - 'talos.zip': {'path': '', 20:05:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:59 INFO - Running post-action listener: _resource_record_post_action 20:05:59 INFO - ##### 20:05:59 INFO - ##### Running create-virtualenv step. 20:05:59 INFO - ##### 20:05:59 INFO - Running pre-action listener: _resource_record_pre_action 20:05:59 INFO - Running main action method: create_virtualenv 20:05:59 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:59 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 20:05:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:59 INFO - Using real prefix '/usr' 20:05:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:00 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:02 INFO - Installing pip.................done. 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:06:02 INFO - Using env: {'DISPLAY': ':0', 20:06:02 INFO - 'HOME': '/home/cltbld', 20:06:02 INFO - 'LANG': 'en_US.UTF-8', 20:06:02 INFO - 'LANGUAGE': 'en_US:en', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MAIL': '/var/mail/cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SHLVL': '1', 20:06:02 INFO - 'TERM': 'linux', 20:06:02 INFO - 'TMOUT': '86400', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - '_': '/tools/buildbot/bin/python'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 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 20:06:02 INFO - Cleaning up... 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:06:02 INFO - Using env: {'DISPLAY': ':0', 20:06:02 INFO - 'HOME': '/home/cltbld', 20:06:02 INFO - 'LANG': 'en_US.UTF-8', 20:06:02 INFO - 'LANGUAGE': 'en_US:en', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MAIL': '/var/mail/cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SHLVL': '1', 20:06:02 INFO - 'TERM': 'linux', 20:06:02 INFO - 'TMOUT': '86400', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - '_': '/tools/buildbot/bin/python'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Downloading/unpacking psutil>=0.7.1 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:04 INFO - Installing collected packages: psutil 20:06:04 INFO - Running setup.py install for psutil 20:06:04 INFO - building 'psutil._psutil_linux' extension 20:06:04 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 20:06:04 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 20:06:04 INFO - building 'psutil._psutil_posix' extension 20:06:04 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 20:06:05 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 20:06:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:05 INFO - Successfully installed psutil 20:06:05 INFO - Cleaning up... 20:06:05 INFO - Return code: 0 20:06:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:06:05 INFO - Using env: {'DISPLAY': ':0', 20:06:05 INFO - 'HOME': '/home/cltbld', 20:06:05 INFO - 'LANG': 'en_US.UTF-8', 20:06:05 INFO - 'LANGUAGE': 'en_US:en', 20:06:05 INFO - 'LOGNAME': 'cltbld', 20:06:05 INFO - 'MAIL': '/var/mail/cltbld', 20:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:05 INFO - 'MOZ_NO_REMOTE': '1', 20:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:05 INFO - 'NO_EM_RESTART': '1', 20:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:05 INFO - 'PWD': '/builds/slave/test', 20:06:05 INFO - 'SHELL': '/bin/bash', 20:06:05 INFO - 'SHLVL': '1', 20:06:05 INFO - 'TERM': 'linux', 20:06:05 INFO - 'TMOUT': '86400', 20:06:05 INFO - 'USER': 'cltbld', 20:06:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:05 INFO - '_': '/tools/buildbot/bin/python'} 20:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:06:07 INFO - Installing collected packages: mozsystemmonitor 20:06:07 INFO - Running setup.py install for mozsystemmonitor 20:06:07 INFO - Successfully installed mozsystemmonitor 20:06:07 INFO - Cleaning up... 20:06:07 INFO - Return code: 0 20:06:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:07 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')]} 20:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:07 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')]} 20:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:07 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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:07 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 20:06:07 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 20:06:07 INFO - Using env: {'DISPLAY': ':0', 20:06:07 INFO - 'HOME': '/home/cltbld', 20:06:07 INFO - 'LANG': 'en_US.UTF-8', 20:06:07 INFO - 'LANGUAGE': 'en_US:en', 20:06:07 INFO - 'LOGNAME': 'cltbld', 20:06:07 INFO - 'MAIL': '/var/mail/cltbld', 20:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:07 INFO - 'MOZ_NO_REMOTE': '1', 20:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:07 INFO - 'NO_EM_RESTART': '1', 20:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:07 INFO - 'PWD': '/builds/slave/test', 20:06:07 INFO - 'SHELL': '/bin/bash', 20:06:07 INFO - 'SHLVL': '1', 20:06:07 INFO - 'TERM': 'linux', 20:06:07 INFO - 'TMOUT': '86400', 20:06:07 INFO - 'USER': 'cltbld', 20:06:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:07 INFO - '_': '/tools/buildbot/bin/python'} 20:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:07 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:07 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 20:06:07 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 20:06:07 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 20:06:07 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 20:06:07 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 20:06:07 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 20:06:09 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - Downloading docopt-0.6.1.tar.gz 20:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:10 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:10 INFO - Running setup.py install for blobuploader 20:06:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:10 INFO - Running setup.py install for requests 20:06:10 INFO - Running setup.py install for docopt 20:06:10 INFO - Successfully installed blobuploader requests docopt 20:06:10 INFO - Cleaning up... 20:06:11 INFO - Return code: 0 20:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:11 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 20:06:11 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 20:06:11 INFO - Using env: {'DISPLAY': ':0', 20:06:11 INFO - 'HOME': '/home/cltbld', 20:06:11 INFO - 'LANG': 'en_US.UTF-8', 20:06:11 INFO - 'LANGUAGE': 'en_US:en', 20:06:11 INFO - 'LOGNAME': 'cltbld', 20:06:11 INFO - 'MAIL': '/var/mail/cltbld', 20:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:11 INFO - 'MOZ_NO_REMOTE': '1', 20:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:11 INFO - 'NO_EM_RESTART': '1', 20:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:11 INFO - 'PWD': '/builds/slave/test', 20:06:11 INFO - 'SHELL': '/bin/bash', 20:06:11 INFO - 'SHLVL': '1', 20:06:11 INFO - 'TERM': 'linux', 20:06:11 INFO - 'TMOUT': '86400', 20:06:11 INFO - 'USER': 'cltbld', 20:06:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:11 INFO - '_': '/tools/buildbot/bin/python'} 20:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:11 INFO - Running setup.py (path:/tmp/pip-W5PxvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:11 INFO - Running setup.py (path:/tmp/pip-FxJKLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:11 INFO - Running setup.py (path:/tmp/pip-7JyCyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:11 INFO - Running setup.py (path:/tmp/pip-2Dp_v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:11 INFO - Running setup.py (path:/tmp/pip-Gm5c3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:11 INFO - Running setup.py (path:/tmp/pip-mfLKhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:11 INFO - Running setup.py (path:/tmp/pip-NTEXGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:11 INFO - Running setup.py (path:/tmp/pip-e_YsZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:11 INFO - Running setup.py (path:/tmp/pip-bQvEQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:11 INFO - Running setup.py (path:/tmp/pip-668xhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:11 INFO - Running setup.py (path:/tmp/pip-HzygRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:12 INFO - Running setup.py (path:/tmp/pip-66RgkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:12 INFO - Running setup.py (path:/tmp/pip-xMmt54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:12 INFO - Running setup.py (path:/tmp/pip-79a6y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:12 INFO - Running setup.py (path:/tmp/pip-Uha4yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:12 INFO - Running setup.py (path:/tmp/pip-sNlJ2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:12 INFO - Running setup.py (path:/tmp/pip-dI4rdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:12 INFO - Running setup.py install for manifestparser 20:06:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:12 INFO - Running setup.py install for mozcrash 20:06:12 INFO - Running setup.py install for mozdebug 20:06:12 INFO - Running setup.py install for mozdevice 20:06:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:12 INFO - Running setup.py install for mozfile 20:06:12 INFO - Running setup.py install for mozhttpd 20:06:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for mozinfo 20:06:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for mozInstall 20:06:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for mozleak 20:06:13 INFO - Running setup.py install for mozlog 20:06:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for moznetwork 20:06:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for mozprocess 20:06:13 INFO - Running setup.py install for mozprofile 20:06:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for mozrunner 20:06:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:13 INFO - Running setup.py install for mozscreenshot 20:06:14 INFO - Running setup.py install for moztest 20:06:14 INFO - Running setup.py install for mozversion 20:06:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:14 INFO - Cleaning up... 20:06:14 INFO - Return code: 0 20:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:14 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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:14 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 20:06:14 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 20:06:14 INFO - Using env: {'DISPLAY': ':0', 20:06:14 INFO - 'HOME': '/home/cltbld', 20:06:14 INFO - 'LANG': 'en_US.UTF-8', 20:06:14 INFO - 'LANGUAGE': 'en_US:en', 20:06:14 INFO - 'LOGNAME': 'cltbld', 20:06:14 INFO - 'MAIL': '/var/mail/cltbld', 20:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:14 INFO - 'MOZ_NO_REMOTE': '1', 20:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:14 INFO - 'NO_EM_RESTART': '1', 20:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:14 INFO - 'PWD': '/builds/slave/test', 20:06:14 INFO - 'SHELL': '/bin/bash', 20:06:14 INFO - 'SHLVL': '1', 20:06:14 INFO - 'TERM': 'linux', 20:06:14 INFO - 'TMOUT': '86400', 20:06:14 INFO - 'USER': 'cltbld', 20:06:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:14 INFO - '_': '/tools/buildbot/bin/python'} 20:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:14 INFO - Running setup.py (path:/tmp/pip-CzFTIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:14 INFO - Running setup.py (path:/tmp/pip-34UeQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:14 INFO - Running setup.py (path:/tmp/pip-dSqB7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:14 INFO - Running setup.py (path:/tmp/pip-6H9nkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:14 INFO - Running setup.py (path:/tmp/pip-nhHSto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:14 INFO - Running setup.py (path:/tmp/pip-3PD4iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:14 INFO - Running setup.py (path:/tmp/pip-zB5Iad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:14 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)) 20:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:14 INFO - Running setup.py (path:/tmp/pip-tVn_io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:15 INFO - Running setup.py (path:/tmp/pip-pSICrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:15 INFO - Running setup.py (path:/tmp/pip-1BP9SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:15 INFO - Running setup.py (path:/tmp/pip-zzIuIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:15 INFO - Running setup.py (path:/tmp/pip-aPw3Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:15 INFO - Running setup.py (path:/tmp/pip-bfInPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:15 INFO - Running setup.py (path:/tmp/pip-cFjAZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:15 INFO - Running setup.py (path:/tmp/pip-ig4kpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:15 INFO - Running setup.py (path:/tmp/pip-pAjWdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:15 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)) 20:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:15 INFO - Running setup.py (path:/tmp/pip-OYYhtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:15 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)) 20:06:15 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)) 20:06:15 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)) 20:06:15 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)) 20:06:15 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)) 20:06:15 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)) 20:06:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - Downloading blessings-1.6.tar.gz 20:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:17 INFO - Installing collected packages: blessings 20:06:17 INFO - Running setup.py install for blessings 20:06:17 INFO - Successfully installed blessings 20:06:17 INFO - Cleaning up... 20:06:17 INFO - Return code: 0 20:06:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:18 INFO - Reading from file tmpfile_stdout 20:06:18 INFO - Current package versions: 20:06:18 INFO - argparse == 1.2.1 20:06:18 INFO - blessings == 1.6 20:06:18 INFO - blobuploader == 1.2.4 20:06:18 INFO - docopt == 0.6.1 20:06:18 INFO - manifestparser == 1.1 20:06:18 INFO - mozInstall == 1.12 20:06:18 INFO - mozcrash == 0.17 20:06:18 INFO - mozdebug == 0.1 20:06:18 INFO - mozdevice == 0.48 20:06:18 INFO - mozfile == 1.2 20:06:18 INFO - mozhttpd == 0.7 20:06:18 INFO - mozinfo == 0.9 20:06:18 INFO - mozleak == 0.1 20:06:18 INFO - mozlog == 3.1 20:06:18 INFO - moznetwork == 0.27 20:06:18 INFO - mozprocess == 0.22 20:06:18 INFO - mozprofile == 0.28 20:06:18 INFO - mozrunner == 6.11 20:06:18 INFO - mozscreenshot == 0.1 20:06:18 INFO - mozsystemmonitor == 0.0 20:06:18 INFO - moztest == 0.7 20:06:18 INFO - mozversion == 1.4 20:06:18 INFO - psutil == 3.1.1 20:06:18 INFO - requests == 1.2.3 20:06:18 INFO - wsgiref == 0.1.2 20:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:18 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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:18 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 20:06:18 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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 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)) 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:18 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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:18 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 20:06:18 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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:18 INFO - Downloading/unpacking jsonschema 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:20 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:20 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 20:06:20 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 20:06:20 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 20:06:20 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 20:06:20 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 20:06:20 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 20:06:20 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:20 INFO - warning: no files found matching '*.txt' 20:06:20 INFO - no previously-included directories found matching 'build' 20:06:20 INFO - no previously-included directories found matching 'dist' 20:06:20 INFO - no previously-included directories found matching '.git*' 20:06:20 INFO - Installing collected packages: jsonschema, functools32 20:06:20 INFO - Running setup.py install for functools32 20:06:20 INFO - warning: no files found matching '*.txt' 20:06:20 INFO - no previously-included directories found matching 'build' 20:06:20 INFO - no previously-included directories found matching 'dist' 20:06:20 INFO - no previously-included directories found matching '.git*' 20:06:20 INFO - Successfully installed jsonschema functools32 20:06:20 INFO - Cleaning up... 20:06:20 INFO - Return code: 0 20:06:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:20 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 0x7fdb422dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x223e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', '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 20:06:20 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 20:06:20 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 20:06:20 INFO - Using env: {'DISPLAY': ':0', 20:06:20 INFO - 'HOME': '/home/cltbld', 20:06:20 INFO - 'LANG': 'en_US.UTF-8', 20:06:20 INFO - 'LANGUAGE': 'en_US:en', 20:06:20 INFO - 'LOGNAME': 'cltbld', 20:06:20 INFO - 'MAIL': '/var/mail/cltbld', 20:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:20 INFO - 'MOZ_NO_REMOTE': '1', 20:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:20 INFO - 'NO_EM_RESTART': '1', 20:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:20 INFO - 'PWD': '/builds/slave/test', 20:06:20 INFO - 'SHELL': '/bin/bash', 20:06:20 INFO - 'SHLVL': '1', 20:06:20 INFO - 'TERM': 'linux', 20:06:20 INFO - 'TMOUT': '86400', 20:06:20 INFO - 'USER': 'cltbld', 20:06:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:20 INFO - '_': '/tools/buildbot/bin/python'} 20:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:21 INFO - Downloading/unpacking flake8 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:22 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 20:06:22 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 20:06:22 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 20:06:22 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 20:06:22 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 20:06:22 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 20:06:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 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 20:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:23 INFO - no previously-included directories found matching 'docs/_build' 20:06:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:23 INFO - Running setup.py install for pep8 20:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:23 INFO - no previously-included directories found matching 'docs/_build' 20:06:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:23 INFO - Cleaning up... 20:06:23 INFO - Return code: 0 20:06:23 INFO - Running post-action listener: _resource_record_post_action 20:06:23 INFO - Running post-action listener: _start_resource_monitoring 20:06:23 INFO - Starting resource monitoring. 20:06:23 INFO - ##### 20:06:23 INFO - ##### Running install step. 20:06:23 INFO - ##### 20:06:23 INFO - Running pre-action listener: _resource_record_pre_action 20:06:23 INFO - Running main action method: install 20:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:24 INFO - Reading from file tmpfile_stdout 20:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:24 INFO - Reading from file tmpfile_stdout 20:06:24 INFO - Output received: 20:06:24 INFO - Usage: mozinstall [options] installer 20:06:24 INFO - Options: 20:06:24 INFO - -h, --help show this help message and exit 20:06:24 INFO - -d DEST, --destination=DEST 20:06:24 INFO - Directory to install application into. [default: 20:06:24 INFO - "/builds/slave/test"] 20:06:24 INFO - --app=APP Application being installed. [default: firefox] 20:06:24 INFO - mkdir: /builds/slave/test/build/application 20:06:24 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'] 20:06:24 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 20:06:39 INFO - Reading from file tmpfile_stdout 20:06:39 INFO - Output received: 20:06:39 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:39 INFO - Running post-action listener: _resource_record_post_action 20:06:39 INFO - ##### 20:06:39 INFO - ##### Running run-tests step. 20:06:39 INFO - ##### 20:06:39 INFO - Running pre-action listener: _resource_record_pre_action 20:06:39 INFO - Running main action method: run_tests 20:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:39 INFO - Python 2.7.3 20:06:39 INFO - Return code: 0 20:06:39 INFO - grabbing minidump binary from tooltool 20:06:39 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')]} 20:06:39 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 0x22cd410>, '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 0x22ce310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ce7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:39 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 20:06:39 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 20:06:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:39 INFO - Return code: 0 20:06:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:40 INFO - Return code: 0 20:06:40 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:06:40 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:06:40 INFO - Using env: {'DISPLAY': ':0', 20:06:40 INFO - 'HOME': '/home/cltbld', 20:06:40 INFO - 'LANG': 'en_US.UTF-8', 20:06:40 INFO - 'LANGUAGE': 'en_US:en', 20:06:40 INFO - 'LOGNAME': 'cltbld', 20:06:40 INFO - 'MAIL': '/var/mail/cltbld', 20:06:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:40 INFO - 'MOZ_NO_REMOTE': '1', 20:06:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:40 INFO - 'NO_EM_RESTART': '1', 20:06:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:40 INFO - 'PWD': '/builds/slave/test', 20:06:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:40 INFO - 'SHELL': '/bin/bash', 20:06:40 INFO - 'SHLVL': '1', 20:06:40 INFO - 'TERM': 'linux', 20:06:40 INFO - 'TMOUT': '86400', 20:06:40 INFO - 'USER': 'cltbld', 20:06:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470', 20:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:40 INFO - '_': '/tools/buildbot/bin/python'} 20:06:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:06:40 INFO - mozversion application_buildid: 20160524172038 20:06:40 INFO - mozversion application_changeset: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 20:06:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:06:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:40 INFO - mozversion application_name: Firefox 20:06:40 INFO - mozversion application_remotingname: firefox-dev 20:06:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:06:40 INFO - mozversion application_vendor: Mozilla 20:06:40 INFO - mozversion application_version: 48.0a2 20:06:40 INFO - mozversion platform_buildid: 20160524172038 20:06:40 INFO - mozversion platform_changeset: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 20:06:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:06:40 INFO - mozversion platform_version: 48.0a2 20:06:40 INFO - using testdate: 1464145600 20:06:40 INFO - actual date: 1464145600 20:06:40 INFO - starting webserver on 'localhost:55144' 20:06:40 INFO - SUITE-START | Running 2 tests 20:06:40 INFO - TEST-START | dromaeo_css 20:06:40 INFO - operating with platform_type : linux_ 20:06:40 INFO - Initialising browser for dromaeo_css test... 20:06:40 INFO - TEST-INFO | started process 20330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KaXWE/profile http://localhost:55144/getInfo.html) 20:06:44 INFO - PROCESS | 20330 | 20:06:44 INFO - PROCESS | 20330 | (process:20407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:45 INFO - PROCESS | 20330 | __metrics Screen width/height:1600/1200 20:06:45 INFO - PROCESS | 20330 | colorDepth:24 20:06:45 INFO - PROCESS | 20330 | Browser inner width/height: 1024/697 20:06:45 INFO - PROCESS | 20330 | __metrics 20:06:46 ERROR - PROCESS | 20330 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:06:47 INFO - TEST-INFO | 20330: exit 0 20:06:47 INFO - Browser initialized. 20:06:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:47 INFO - TEST-INFO | started process 20458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1KaXWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:48 INFO - PROCESS | 20458 | 20:06:48 INFO - PROCESS | 20458 | (process:20527): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:58 INFO - PROCESS | 20458 | RSS: Main: 152252416 20:06:58 INFO - PROCESS | 20458 | 20:07:48 INFO - PROCESS | 20458 | 1464145668425 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] 20:09:56 INFO - PROCESS | 20458 | Cycle 1(1): loaded http://localhost:55144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55144/tests/dromaeo/cssquery-ext.html) 20:09:57 INFO - PROCESS | 20458 | RSS: Main: 156192768 20:09:57 INFO - PROCESS | 20458 | 20:12:58 INFO - PROCESS | 20458 | Cycle 1(1): loaded http://localhost:55144/tests/dromaeo/cssquery-ext.html (next: http://localhost:55144/tests/dromaeo/cssquery-jquery.html) 20:12:59 INFO - PROCESS | 20458 | RSS: Main: 153874432 20:12:59 INFO - PROCESS | 20458 | 20:16:01 INFO - PROCESS | 20458 | Cycle 1(1): loaded http://localhost:55144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55144/tests/dromaeo/cssquery-mootools.html) 20:16:01 INFO - PROCESS | 20458 | RSS: Main: 153493504 20:16:01 INFO - PROCESS | 20458 | 20:19:03 INFO - PROCESS | 20458 | Cycle 1(1): loaded http://localhost:55144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55144/tests/dromaeo/cssquery-prototype.html) 20:19:03 INFO - PROCESS | 20458 | RSS: Main: 153395200 20:19:03 INFO - PROCESS | 20458 | 20:22:06 INFO - PROCESS | 20458 | Cycle 1(1): loaded http://localhost:55144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55144/tests/dromaeo/cssquery-yui.html) 20:22:06 INFO - PROCESS | 20458 | RSS: Main: 154632192 20:22:06 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | Cycle 1(1): loaded http://localhost:55144/tests/dromaeo/cssquery-yui.html (next: http://localhost:55144/tests/dromaeo/cssquery-dojo.html) 20:25:09 INFO - PROCESS | 20458 | RSS: Main: 156221440 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | __start_tp_report 20:25:09 INFO - PROCESS | 20458 | _x_x_mozilla_page_load 20:25:09 INFO - PROCESS | 20458 | _x_x_mozilla_page_load_details 20:25:09 INFO - PROCESS | 20458 | |i|pagename|runs| 20:25:09 INFO - PROCESS | 20458 | |0;dojo.html;3360.3111362170757;3364.932701345974;3407.6251612322626;3442.191085095002;3458.187325978396;5638.210650508921;5639.66162030278;5667.801626943053;5685.232493613371;5697.8005769798065;5643.830685079454;5674.489295963363;5713.257276554053;5714.799982000631;5725.828225153252;5048.444671086178;5102.056119617864;5123.180291153416;5141.228815677641;5201.375834899817;5126.769295381698;5224.294720212761;5261.210818377236;5261.815836445706;5289.074411977907;5105.310783044279;5111.361079865017;5205.60957928155;5238.842834714965;5277.472252774711;5216.66091704038;5218.034663587229;5218.973905130488;5227.869303267411;5272.789088436458;4994.850154495371;5069.087564238435;5144.897102057937;5196.948030519722;5199.766010529497;5448.101063324547;5479.232907392969;5500.477454641843;5506.559475241971;5579.330480342385;5955.642661440284;5999.430054144849;6004.12940123684;6005.069214271794;6008.128821320927;5810.070388737824;5985.820425387202;6030.487408570233;6030.698465076729;6087.269527656666;5679.176519404705;5680.630759000652;5692.686902220376;5701.600887937846;5735.713214339266;6207.286162091417;6219.1604133442315;6220.253569571681;6224.968875155686;6225.408586184305;5859.560532960045;5906.055031194988;5923.763049477972;5992.101184822312;5993.520518358521;5980.401959804072;5990.161377407167;6001.939980600138;6005.579609427298;6048.274207095177;5920.792772253037;5923.229980102646;5960.046392577166;5967.6121052131475;5973;5837.3287071986415;5967.5524335675;6045.969770151209;6093.634381937098;6128.78549250783;4564.7032942858605;4566.977165114153;4569.268916973335;4579.519150489217;4590.196715574761;4106.630403263721;4117.3206420940805;4135.17296540693;4137.9861933826405;4154.439150714615;5784.623999440023;5896.528277737771;5921.378255283219;5938.049912014057;5986.820395388146;6019.277686677627;6071.726772295257;6122.142899994004;6123.265208174958;6125.9680843641045;5799.2460980073165;5887;5887.322957859901;5900.291964964232;5910.852228694317;5242.449542798027;5253.868653283622;5270.051390749702;5300.072487314705;5333.173358129418;6336.936630633727;6367.235931688135;6368.554201205871;6374.107624932513;6394.456471199907;5933.317668468181;6056.333803281547;6146;6146.846328841814;6165.599236049642;6343.5876668016435;6354.555181137276;6383.0744542042075;6383.106365108982;6384.106225128393;5970.0746384310505;5995.700214989146;5999.850003749767;6028.547858910511;6040.365761595145;5908.409159084057;6151.84620384494;6165.630062196283;6173.629582225081;6257.749690012349;6008.969955150196;6015.518758499222;6020.096985452217;6027;6047.969760151347;5955.91066134017;5982.820515384546;5995.340512543704;5997.91003134962;6018.969905150446;5781.248437703071;5903.645781253139;5928.940710593011;5963.612365196248;6088.086786981989;5996.610220335664;6036.788712395045;6036.84907877289;6040.637561746309;6052.485538729257;5890;5891.734871930687;5897.823065308047;5906.527477801851;5915.645061296336 20:25:09 INFO - PROCESS | 20458 | |1;ext.html;671.6708812681787;677.8034370032691;678.8336857469919;733.1861633586718;744.8994385757923;33033.33933321335;41195.79402102993;41836.16327673445;42015.15969680612;42172;45111.09777804442;45396.54603453964;45474;45565.31652025222;45609.0878182437;8818.999999999984;8950.597223124974;9006.414583052081;9017.323700722472;9029.0519495453;8847.77880552985;8858.424202426822;8859.911400885972;8907.064758200393;8908.153725396109;9101.908980910206;9139.131782480687;9215.078492150766;9222.216111630485;9231.907680923172;9142.177204051633;9180.586873590704;9182.678606248783;9187.908120918806;9195.954020229923;9063.59213835379;9139.497327646977;9168.954155229248;9171.082891710843;9213.90786092144;43568.564314356765;43896.3415548767;43997.34003989943;44112;44336.55663443357;3739.383001804699;3841.9423708644395;4057.2696914555368;4061.776602286873;4584.991301913574;33486.49770253448;33565.83217083899;33589;33615.83192084049;33650.49524257138;4547.909041819178;4592.2422800238255;4598.747068911209;4641.76791160444;4658.883527911796;235746;236393;236563.99999999828;236701.99999999828;237215;65172.34827651758;65654.67172664202;65886.34113658898;65913;65977;69608.30391696018;72738;73797.6310118446;74482;74929.25070749223;19554.21783128659;19643.31248406299;19818.20727170926;19818.70271945922;19858.1063852127;15306.923465382602;15343.846561534465;15404.768928466083;15409.614759631098;15429.691406171814;20648.79351206499;20702;20805.271815486387;20830.895845520674;20851.582968340852;7600.923990760021;7644.159142494321;7766.932061835543;7838.079670480654;7864.449488535747;1071.5338827609858;1152.5332240442633;1154.861416629993;1163.5345861655237;1188.0911103006208;33278.334433311684;33623;33737.139892029816;33755.49366759501;33899.152521186676;1111.3887361950895;1163.2962057954985;1224.3981539229137;1230.686175025363;1301.8502872169631;17796.52134853897;18170.727439088423;18208.60047536281;19474.805251947582;19626.50933726668;516524;543670;575047;588142;590173;64317.35682643114;65424.345756542774;65988.67005665037;66203.66898165479;66227.66886165539;1484.5323723027427;1524.329295110148;1545.7449520828936;1548.5199588127716;1551.5112739487026;33347.666523334454;34195.658043419244;34238.315233695685;34390.14024649404;34837.47743783896;57569.71215143897;63331;65234;65291.673541631986;65391.34608653853;444291;446716;447700;451849;452836;46719;47313.52686473229;47496;47768.28347574858;48725.269120962505;51912.221316679526;52864.4713552875;53617.46382536125;54032.459675404316;55135.72432137974;38860.41709374305;39282.410763837994;39656.801715991234;41724;42254;41988.58011419847;42218.36672449854;42568;43557.78221108874;43587;43093.784531078396;43110.35334469923;43730;44547.33179002253;44724.77637611791;36172;36701.26597468089;37120.814395927846;37204.255914882095;37378.252434950606;28317.292067698472;29117.231250343175;29294.853525732236;29398.265043374086;29442 20:25:09 INFO - PROCESS | 20458 | |2;jquery.html;412.9793510324484;416.9249535083685;434.3029437752405;436.4566115186593;441.8895276180955;18677;19198.616027679436;19253.941033243165;19696.507587310287;20109.497262568406;19358.903205483988;20023.098960546773;20163.495912602193;20190.394288171377;20294.492637684067;5396.217548455472;5398.8920221595445;5474.91787623186;5515.117581187011;5534.418886016951;4968.527989840977;5514.5864060195445;5537.916931246034;5539.9169012464645;5575.553955683556;5509.586780991422;5536.778528858861;5544.667319960795;5545.944540554583;5597.832065038056;5533.418991005927;5533.944660553403;5538.944610553883;5551.555875529948;5568.749406276707;5276.630635855492;5324.520793128637;5440.537554307849;5455.727213639342;5456.91814622781;14756.70486590273;15022.24888755558;15255.694886102327;15302.387904483807;15407.075575465396;2464.7042354917344;2572.498362819232;2672.1182009936674;2725.6320396746382;3034.6965303469697;11101.3894235817;11398.145139114516;14941.103533787898;15062.322195501229;15155.090694558361;2134.5090629155225;2145.184829764695;2176.858504197222;2211.4803021289986;2221.1892659179443;83820.58089709573;86275.56862215648;87055;87117.82205444851;87676.5616171915;11893.286402815858;11893.40532973348;11974.64076077719;11987.940060299818;11990.34053127069;16618.58453538671;16724.163791810362;16806.57983550421;16809.15954202285;16885.662286754196;9141.954290228507;9372.109649583279;9387.10822471864;9387.62449502026;9505.239580833517;9176.541172941326;9184;9234.769130771785;9365.531723413802;9418.717438476857;5123.3339665843205;5180.637355385087;5194.246834209094;5235.921461178085;5246.632735708464;2130.2118216260083;2162.826973842089;2188.529466164782;2211.5797998380576;2222.344408399526;1033.8242498775226;1091.0344345254507;1121.870984836738;1154.001788452982;1196.9760604787855;18852.245910163714;19908;20029.198832046848;20267.695984560243;20585.279515216895;1105.4583254205543;1108.9390083545482;1115.514751083265;1151.0848875144281;1233.7779199743952;11421.771564568662;11495.252808567584;11502.82000429609;11519.76960460803;11630.76738465226;517130;518065;522844;524880;531402;56428.43571564232;57793.133103003485;82398.17601823906;96148.51925740327;98126;1075.8745843325153;1110.6612483192541;1119.071170928144;1131.3551275772732;1131.886811318878;17787.73318400251;17955.551111222325;18008.729869051713;18041;18187.090645467408;40174.1965160701;41370.58629413667;42638.36042459428;43158.35262471128;43352.349714754935;58388.70805645944;61145.38854611397;61354.38645613487;61421.38578614157;61520.69239653773;9493.905060949579;9514;9523.142917137491;9577.281703872377;9831.399167944037;11130.666080017612;13947.511837085653;14058.507952221624;14102.153870767786;14329.283535822959;11415.258008229439;11788.174827761974;12259.75480490403;12429.192102513307;12743.235405875677;12446.439910204244;12705.36473176356;12765.8085128725;12767.93616031914;13031.08782385224;12978.480860765841;13002.544910928073;13112.344382780631;13156.671083222996;13183.67040823987;9540.427574345562;9605.951970240105;9726.562304696447;9798.51007449639;9850.014998500379;9569.808603827745;12432.316222607844;13010.479580816662;13107.934460328019;13278.269695166859 20:25:09 INFO - PROCESS | 20458 | |3;mootools.html;1571.7406627906391;1572.58326543466;1790.2838864454216;1905.8094190580935;1921.2219051284217;7844;8133.715319963802;8614.569271536422;8807.559622018898;8831.381803273765;8633.09352517986;8635.39552231344;8733.083026282244;8767.079456657038;8779;2483.925482235527;2487.067349743846;2496.0639760089966;2499.237732491589;2509.82431229814;2353.8234632402637;2458.6434966929783;2461.90152393904;2463.938401539958;2469.1481438903547;2426.4904370082218;2442.1818690738537;2494;2495.7254701982765;2498.350428888493;2491.53906527293;2512.309114993373;2512.899484020646;2518.5214809186195;2525.696916370029;2429.708434987813;2450.8774561271866;2450.9264722058365;2465.8520488770732;2497.5254701606636;8913.509756963364;8916.643334266622;8926.509042002752;8931.50876701781;8940.865887011634;5560.2493663355735;5632.943670563324;5704.543636509069;5706.029974904235;5707.0298049331295;3520.2431477232262;3598.874039408608;3613.476045973345;3755.267722794056;3793.336166170909;1224.553038141081;1262.0219330019218;1283.1018287198904;1311.809787580805;1318.3408295852073;12526.874731252754;12566.120371573994;12575.559855405018;12583.559575414816;12721.745565088646;4775.689580177277;4778.768951870562;4843.321934929113;4862.319275301461;4864.173090574611;10490.423026733602;10582.417967011734;10587.682369528926;10592.205584581186;10611.045005949502;5496.697681627549;5503.449655034465;5529.142982837667;5538.418466061005;5540.473655002768;4542.613877820356;4971.875703107451;5100.719460429637;5149.48505149482;5163.380394352702;4155.10665206982;4213.389058586549;4303.182395344875;4321.049369138785;4479.081788233404;1393.770027945398;1401.2433286025637;1423.0821120377298;1438.1443041390355;1443.6968236670207;923.3351986569659;1053.2206167436195;1063.6649455421518;1073.393532654048;1076.5155679944057;6152.107944348045;6341.746330146835;6356.586821856565;6391.488680905516;6497.057926600616;471.14016919122736;483.7339463295174;494.0538868067682;496.9950300497021;502.4347608939943;4271.9786401067795;4346.587074227943;4350.21696094706;4351.0645211279725;4360.367746676714;10717.83923241152;11024.944875275733;11086.667399978014;11165.665030049111;11227.66317010491;10846.349219046882;10861;10958.397288149068;10961.83557246642;11002.064824489848;7969.203079691984;8225.46534475269;8389.077201507951;8574.056853746082;8584.184502472255;6213.220335619075;6410.326915673787;6422.197225346832;6480.935190648033;6481.611103333815;9890.950545247228;9902.059304366074;9944.204463642747;10146.340487868265;10160.847587286049;9826;10150.898491014996;10250.641227557;10366.896331036593;10374.27380083387;7985.441019128605;7995.520268783892;8132.87800683002;8169.918300816916;8218.342532597497;8667.219950204511;8673.262772664395;8680.305575554066;8690.478571285743;8713.607887644945;7658.081030276402;7821.061472623322;7920.683172673259;7940.28537431634;7970.800729981797;7451.552906825608;7583.544987300779;7677.961610191914;7728.111267204344;7775.066991961001;7095.219525852049;7147.714091436284;7192.820179495555;7203.495755297079;7208.35124838767;5070.442251352274;5097.8215762448135;5175.068487672255;5192.714400707997;5241.633085684118;5394.32570928634;5411.567074633941;5453.509184173444;5500.257465242141;5688.033034384247 20:25:09 INFO - PROCESS | 20458 | |4;prototype.html;356.5311615225979;360.46830924386535;364.04801444223364;376.7551091790336;378.8995916082238;6543.5746676466115;6549.214094308678;6600.669966501674;6657.267700552941;6731.903324470749;6618.536702430832;6650.572541022529;6684.632345221011;6695.832604184898;6705.161854768154;5105.846824595268;5108.2593024011685;5110.923336149961;5112.565431938271;5124.743762811863;5103.3875934887865;5113.258577506259;5118.181091025437;5118.6416950813455;5122.487751224885;5052.292679024939;5055.3933527976515;5074.061298659742;5082.593392528607;5085.389753229618;4959.6528243023;5020.146575082244;5036.546710796046;5073.974630126862;5088.389393272812;4410.691251612388;4433.379326894237;4438.42300500936;4448.7108337957925;4450.755208463565;6330.8100756977365;6357.268914074894;6360.809175724736;6363.490920726331;6375.139356186948;5895.970520147414;5913.024350982083;5937.465628093449;5971.731272092723;5974.551908606872;6991.580505169706;7036.120484939383;7037.859242815166;7042.753503627348;7057.858842823166;4642.837500687459;4806.807727690888;4857.028594281158;4984.800607975713;5006.799728010875;7261.5280006799385;7271.490995630308;7272.600006999613;7335.669894854745;7358.521696089737;4924.0890435268875;4944.233643785219;4950.381202349707;4956.207006878954;4966.1309270877455;4995.475475075064;5014.598832093424;5021.5229553192385;5026.070177017264;5032.572231360376;5820.505257053113;5821.330546987066;5822.184894114827;5823.563232757476;5827.7668893244645;6849.1438570178725;6967.651617419108;7010.719571217196;7011.89482157768;7013.789586312317;1729.3342063305718;1762.9382971595933;1768.0629266488525;1768.6285879965094;1774.4410510689092;1043.410473082706;1109.9889001109887;1115.7880002799443;1121.0863146535548;1169.5088063013554;6747.595144291358;6921.861562768717;6952.200496942815;6960.512764106464;6988.056612357267;7304.96347518259;7321.450891183076;7328.59692716895;7328.890066649004;7344.742933997284;6919.8962015569805;6920.723171073201;6924.584524928419;6936.34104760047;6946;3867.149227170018;3939.330313846653;3944.723869329119;3955.20895820837;3970.781607011584;7643.121041080347;7645.235476452311;7656.196099409593;7657.731979380695;7662.846743065107;7395.112586489548;7415.88876166858;7427.925720742724;7434.033575635241;7452.180260171377;7621.047369078865;7626.580538070349;7638.968739220134;7651.923480765233;7658.502197357043;7167.3599009332365;7285.125784905846;7297.233790452138;7307.926920730724;7318.560886346836;7103.538270012433;7108.182559005781;7130.322619351154;7161.749338773118;7190.280971902768;7643.082830060428;7651.273129052731;7655.387568994578;7657.540547567164;7664.501807382502;4959.082569724613;4977.4773648767805;4978.502149784992;4983.476734942924;4987.526185012418;7093.794055010558;7258.346748792634;7311.159216690149;7312.41500679955;7324.230955749569;7022.12223472066;7064.682089305891;7108.893366599402;7110.7511237106455;7134.607596582237;7040.0847889774;7082.433405327459;7083.972823940603;7087.787366379017;7093.2197458278515;6921.2386637468835;6959.478039146983;6959.965200173967;6961.930380696128;6980.441564674916;6985.755498557526;7124.073870396815;7137.536060156073;7147.46394020461;7149.499535032498;6764.763233286812;6932.202796678446;6989.685464154227;6990.930090699231;7006.649667516705 20:25:09 INFO - PROCESS | 20458 | |5;yui.html;859.5100792548249;912.507246087113;919.7516670498966;938.2775263047454;941.2846236859984;14227.71544569108;14424.206668633235;14452.5664230073;14499;14507.202103884296;13216.273104979246;15193.240337983112;15518.534443966699;15537.84462155378;15629.609259768511;776.8290975985274;883.6200433813458;895.3240303570827;923.0953665407905;924.3437159616664;910.8223896340184;915.1214833759599;915.839728047589;918.8024574716435;919.8528235482324;959.4195511715417;962.8122516109327;963.3352986439335;963.5952899782109;965.874436323277;942.6794889737488;946.8911075226334;955.9952200239023;956.9425834449955;957.8563215517693;706.4207349973024;706.8974998625171;708.9432845372357;709.2977951827653;711.1111111111111;15621.609459763484;15731.764023539656;15735.370585176579;15770.448034318859;15797.131157786318;14741.262936853114;14753.77869331961;14776.187309697962;14897.553073407815;14928.850711492854;11063.336199828036;11355.43222838863;11598.682013269614;11913.463894124785;12041.698957526045;3908.570057293724;3916.2167566486532;3955.762654240726;3974.1058261890844;3975.7018223633345;62047.6897615509;62235.37764622341;62402;62517.68741156311;62953.685231574;11844.28934263947;11891;11895.702607434883;12094.516219351128;12101.878981210251;20818.58362832735;20895.791042089688;20973.26593569248;21034.368968930958;21053.789462105487;8308.5430301334;8592.484450932963;8636.136386361313;8856.778580535409;9089.27285817133;5059.645824792303;5066.316047333563;5082.949170508247;5089.414717307557;5161.793528258902;3593.1735700788963;3615.29501747162;3636.4181730922924;3640.8543658253375;3642.1623026704005;648.7761722205831;675.2841987493273;676.7123972311748;678.3047376439091;691.9688614012382;686.6875571614903;767.9594149926769;772.2933515833063;783.5181363461544;830.779843341515;9062.592183351764;9350.540509530643;9417.529123543796;9506;9550.37922535033;759.0663483914706;765.0933643632313;769.9884501732479;781.2890269854405;786.1666633368648;4025.355943049098;4133.359329303963;4165.854195103157;4317.373980772771;4503.347014682919;67535.66232168808;68214.31785682178;68650.31349686539;68858;69329.65335173393;58391.12413313804;59833;60301.39698602958;61083.38916610866;61666.69166654138;51165.48834511607;52048.479515204366;52189.21716174261;52510.21234681406;52902.20646690303;9540.141387275178;9786;9883.258755593502;9929.702108936743;10132.493375331056;38194.23611527698;38209.80895095507;39193;41560.58439415688;41863.7906810464;49831.252531212784;50523.2421513685;51152;51395.22907156321;51466;12364.752704946031;12490.06324525646;12589.307588082744;12718.491260349483;12866.549670761478;13768.380422880795;13830.65423364424;14031.719365612835;14123.717525649636;14571.489997850449;12029;12446.751064978831;12859.421326040163;12900.29048402347;12982.285974271506;12703.174293670882;13040.673983150496;13070.673233169247;13254.53609123676;13478.797818032934;12426.502939882303;12867.549635762703;12904.935475322563;13069.215847049207;13375.53185638498;11455.198136130392;11589.760996745363;11601.897819707114;11602.6519204424;11613.593524226611;10627.787444250916;10672.946635267084;10788.892111079103;10908.290961087821;10945.507452164513 20:25:09 INFO - PROCESS | 20458 | __end_tp_report 20:25:09 INFO - PROCESS | 20458 | __start_cc_report 20:25:09 INFO - PROCESS | 20458 | _x_x_mozilla_cycle_collect,341 20:25:09 INFO - PROCESS | 20458 | __end_cc_report 20:25:09 INFO - PROCESS | 20458 | __startTimestamp1464146709329__endTimestamp 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | ------- Summary: start ------- 20:25:09 INFO - PROCESS | 20458 | Number of tests: 6 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | [#0] dojo.html Cycles:165 Average:5656.82 Median:5910.85 stddev:636.84 (10.8%) stddev-sans-first:612.78 20:25:09 INFO - PROCESS | 20458 | Values: 3360.3 3364.9 3407.6 3442.2 3458.2 5638.2 5639.7 5667.8 5685.2 5697.8 5643.8 5674.5 5713.3 5714.8 5725.8 5048.4 5102.1 5123.2 5141.2 5201.4 5126.8 5224.3 5261.2 5261.8 5289.1 5105.3 5111.4 5205.6 5238.8 5277.5 5216.7 5218.0 5219.0 5227.9 5272.8 4994.9 5069.1 5144.9 5196.9 5199.8 5448.1 5479.2 5500.5 5506.6 5579.3 5955.6 5999.4 6004.1 6005.1 6008.1 5810.1 5985.8 6030.5 6030.7 6087.3 5679.2 5680.6 5692.7 5701.6 5735.7 6207.3 6219.2 6220.3 6225.0 6225.4 5859.6 5906.1 5923.8 5992.1 5993.5 5980.4 5990.2 6001.9 6005.6 6048.3 5920.8 5923.2 5960.0 5967.6 5973.0 5837.3 5967.6 6046.0 6093.6 6128.8 4564.7 4567.0 4569.3 4579.5 4590.2 4106.6 4117.3 4135.2 4138.0 4154.4 5784.6 5896.5 5921.4 5938.0 5986.8 6019.3 6071.7 6122.1 6123.3 6126.0 5799.2 5887.0 5887.3 5900.3 5910.9 5242.4 5253.9 5270.1 5300.1 5333.2 6336.9 6367.2 6368.6 6374.1 6394.5 5933.3 6056.3 6146.0 6146.8 6165.6 6343.6 6354.6 6383.1 6383.1 6384.1 5970.1 5995.7 5999.9 6028.5 6040.4 5908.4 6151.8 6165.6 6173.6 6257.7 6009.0 6015.5 6020.1 6027.0 6048.0 5955.9 5982.8 5995.3 5997.9 6019.0 5781.2 5903.6 5928.9 5963.6 6088.1 5996.6 6036.8 6036.8 6040.6 6052.5 5890.0 5891.7 5897.8 5906.5 5915.6 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | [#1] ext.html Cycles:180 Average:60601.64 Median:44224.28 stddev:116297.71 (263.0%) stddev-sans-first:116536.90 20:25:09 INFO - PROCESS | 20458 | Values: 671.7 677.8 678.8 733.2 744.9 33033.3 41195.8 41836.2 42015.2 42172.0 45111.1 45396.5 45474.0 45565.3 45609.1 8819.0 8950.6 9006.4 9017.3 9029.1 8847.8 8858.4 8859.9 8907.1 8908.2 9101.9 9139.1 9215.1 9222.2 9231.9 9142.2 9180.6 9182.7 9187.9 9196.0 9063.6 9139.5 9169.0 9171.1 9213.9 43568.6 43896.3 43997.3 44112.0 44336.6 3739.4 3841.9 4057.3 4061.8 4585.0 33486.5 33565.8 33589.0 33615.8 33650.5 4547.9 4592.2 4598.7 4641.8 4658.9 235746.0 236393.0 236564.0 236702.0 237215.0 65172.3 65654.7 65886.3 65913.0 65977.0 69608.3 72738.0 73797.6 74482.0 74929.3 19554.2 19643.3 19818.2 19818.7 19858.1 15306.9 15343.8 15404.8 15409.6 15429.7 20648.8 20702.0 20805.3 20830.9 20851.6 7600.9 7644.2 7766.9 7838.1 7864.4 1071.5 1152.5 1154.9 1163.5 1188.1 33278.3 33623.0 33737.1 33755.5 33899.2 1111.4 1163.3 1224.4 1230.7 1301.9 17796.5 18170.7 18208.6 19474.8 19626.5 516524.0 543670.0 575047.0 588142.0 590173.0 64317.4 65424.3 65988.7 66203.7 66227.7 1484.5 1524.3 1545.7 1548.5 1551.5 33347.7 34195.7 34238.3 34390.1 34837.5 57569.7 63331.0 65234.0 65291.7 65391.3 444291.0 446716.0 447700.0 451849.0 452836.0 46719.0 47313.5 47496.0 47768.3 48725.3 51912.2 52864.5 53617.5 54032.5 55135.7 38860.4 39282.4 39656.8 41724.0 42254.0 41988.6 42218.4 42568.0 43557.8 43587.0 43093.8 43110.4 43730.0 44547.3 44724.8 36172.0 36701.3 37120.8 37204.3 37378.3 28317.3 29117.2 29294.9 29398.3 29442.0 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | [#2] jquery.html Cycles:180 Average:30046.49 Median:2211.53 stddev:85895.25 (3884.0%) stddev-sans-first:86107.39 20:25:09 INFO - PROCESS | 20458 | Values: 413.0 416.9 434.3 436.5 441.9 18677.0 19198.6 19253.9 19696.5 20109.5 19358.9 20023.1 20163.5 20190.4 20294.5 5396.2 5398.9 5474.9 5515.1 5534.4 4968.5 5514.6 5537.9 5539.9 5575.6 5509.6 5536.8 5544.7 5545.9 5597.8 5533.4 5533.9 5538.9 5551.6 5568.7 5276.6 5324.5 5440.5 5455.7 5456.9 14756.7 15022.2 15255.7 15302.4 15407.1 2464.7 2572.5 2672.1 2725.6 3034.7 11101.4 11398.1 14941.1 15062.3 15155.1 2134.5 2145.2 2176.9 2211.5 2221.2 83820.6 86275.6 87055.0 87117.8 87676.6 11893.3 11893.4 11974.6 11987.9 11990.3 16618.6 16724.2 16806.6 16809.2 16885.7 9142.0 9372.1 9387.1 9387.6 9505.2 9176.5 9184.0 9234.8 9365.5 9418.7 5123.3 5180.6 5194.2 5235.9 5246.6 2130.2 2162.8 2188.5 2211.6 2222.3 1033.8 1091.0 1121.9 1154.0 1197.0 18852.2 19908.0 20029.2 20267.7 20585.3 1105.5 1108.9 1115.5 1151.1 1233.8 11421.8 11495.3 11502.8 11519.8 11630.8 517130.0 518065.0 522844.0 524880.0 531402.0 56428.4 57793.1 82398.2 96148.5 98126.0 1075.9 1110.7 1119.1 1131.4 1131.9 17787.7 17955.6 18008.7 18041.0 18187.1 40174.2 41370.6 42638.4 43158.4 43352.3 58388.7 61145.4 61354.4 61421.4 61520.7 9493.9 9514.0 9523.1 9577.3 9831.4 11130.7 13947.5 14058.5 14102.2 14329.3 11415.3 11788.2 12259.8 12429.2 12743.2 12446.4 12705.4 12765.8 12767.9 13031.1 12978.5 13002.5 13112.3 13156.7 13183.7 9540.4 9606.0 9726.6 9798.5 9850.0 9569.8 12432.3 13010.5 13107.9 13278.3 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | [#3] mootools.html Cycles:180 Average:5951.82 Median:4852.82 stddev:3293.41 (67.9%) stddev-sans-first:3286.20 20:25:09 INFO - PROCESS | 20458 | Values: 1571.7 1572.6 1790.3 1905.8 1921.2 7844.0 8133.7 8614.6 8807.6 8831.4 8633.1 8635.4 8733.1 8767.1 8779.0 2483.9 2487.1 2496.1 2499.2 2509.8 2353.8 2458.6 2461.9 2463.9 2469.1 2426.5 2442.2 2494.0 2495.7 2498.4 2491.5 2512.3 2512.9 2518.5 2525.7 2429.7 2450.9 2450.9 2465.9 2497.5 8913.5 8916.6 8926.5 8931.5 8940.9 5560.2 5632.9 5704.5 5706.0 5707.0 3520.2 3598.9 3613.5 3755.3 3793.3 1224.6 1262.0 1283.1 1311.8 1318.3 12526.9 12566.1 12575.6 12583.6 12721.7 4775.7 4778.8 4843.3 4862.3 4864.2 10490.4 10582.4 10587.7 10592.2 10611.0 5496.7 5503.4 5529.1 5538.4 5540.5 4542.6 4971.9 5100.7 5149.5 5163.4 4155.1 4213.4 4303.2 4321.0 4479.1 1393.8 1401.2 1423.1 1438.1 1443.7 923.3 1053.2 1063.7 1073.4 1076.5 6152.1 6341.7 6356.6 6391.5 6497.1 471.1 483.7 494.1 497.0 502.4 4272.0 4346.6 4350.2 4351.1 4360.4 10717.8 11024.9 11086.7 11165.7 11227.7 10846.3 10861.0 10958.4 10961.8 11002.1 7969.2 8225.5 8389.1 8574.1 8584.2 6213.2 6410.3 6422.2 6480.9 6481.6 9891.0 9902.1 9944.2 10146.3 10160.8 9826.0 10150.9 10250.6 10366.9 10374.3 7985.4 7995.5 8132.9 8169.9 8218.3 8667.2 8673.3 8680.3 8690.5 8713.6 7658.1 7821.1 7920.7 7940.3 7970.8 7451.6 7583.5 7678.0 7728.1 7775.1 7095.2 7147.7 7192.8 7203.5 7208.4 5070.4 5097.8 5175.1 5192.7 5241.6 5394.3 5411.6 5453.5 5500.3 5688.0 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | [#4] prototype.html Cycles:180 Average:5912.27 Median:6756.18 stddev:1800.77 (26.7%) stddev-sans-first:1756.88 20:25:09 INFO - PROCESS | 20458 | Values: 356.5 360.5 364.0 376.8 378.9 6543.6 6549.2 6600.7 6657.3 6731.9 6618.5 6650.6 6684.6 6695.8 6705.2 5105.8 5108.3 5110.9 5112.6 5124.7 5103.4 5113.3 5118.2 5118.6 5122.5 5052.3 5055.4 5074.1 5082.6 5085.4 4959.7 5020.1 5036.5 5074.0 5088.4 4410.7 4433.4 4438.4 4448.7 4450.8 6330.8 6357.3 6360.8 6363.5 6375.1 5896.0 5913.0 5937.5 5971.7 5974.6 6991.6 7036.1 7037.9 7042.8 7057.9 4642.8 4806.8 4857.0 4984.8 5006.8 7261.5 7271.5 7272.6 7335.7 7358.5 4924.1 4944.2 4950.4 4956.2 4966.1 4995.5 5014.6 5021.5 5026.1 5032.6 5820.5 5821.3 5822.2 5823.6 5827.8 6849.1 6967.7 7010.7 7011.9 7013.8 1729.3 1762.9 1768.1 1768.6 1774.4 1043.4 1110.0 1115.8 1121.1 1169.5 6747.6 6921.9 6952.2 6960.5 6988.1 7305.0 7321.5 7328.6 7328.9 7344.7 6919.9 6920.7 6924.6 6936.3 6946.0 3867.1 3939.3 3944.7 3955.2 3970.8 7643.1 7645.2 7656.2 7657.7 7662.8 7395.1 7415.9 7427.9 7434.0 7452.2 7621.0 7626.6 7639.0 7651.9 7658.5 7167.4 7285.1 7297.2 7307.9 7318.6 7103.5 7108.2 7130.3 7161.7 7190.3 7643.1 7651.3 7655.4 7657.5 7664.5 4959.1 4977.5 4978.5 4983.5 4987.5 7093.8 7258.3 7311.2 7312.4 7324.2 7022.1 7064.7 7108.9 7110.8 7134.6 7040.1 7082.4 7084.0 7087.8 7093.2 6921.2 6959.5 6960.0 6961.9 6980.4 6985.8 7124.1 7137.5 7147.5 7149.5 6764.8 6932.2 6989.7 6990.9 7006.6 20:25:09 INFO - PROCESS | 20458 | 20:25:09 INFO - PROCESS | 20458 | [#5] yui.html Cycles:180 Average:16073.25 Median:27167.30 stddev:18971.81 (69.8%) stddev-sans-first:18990.63 20:25:09 INFO - PROCESS | 20458 | Values: 859.5 912.5 919.8 938.3 941.3 14227.7 14424.2 14452.6 14499.0 14507.2 13216.3 15193.2 15518.5 15537.8 15629.6 776.8 883.6 895.3 923.1 924.3 910.8 915.1 915.8 918.8 919.9 959.4 962.8 963.3 963.6 965.9 942.7 946.9 956.0 956.9 957.9 706.4 706.9 708.9 709.3 711.1 15621.6 15731.8 15735.4 15770.4 15797.1 14741.3 14753.8 14776.2 14897.6 14928.9 11063.3 11355.4 11598.7 11913.5 12041.7 3908.6 3916.2 3955.8 3974.1 3975.7 62047.7 62235.4 62402.0 62517.7 62953.7 11844.3 11891.0 11895.7 12094.5 12101.9 20818.6 20895.8 20973.3 21034.4 21053.8 8308.5 8592.5 8636.1 8856.8 9089.3 5059.6 5066.3 5082.9 5089.4 5161.8 3593.2 3615.3 3636.4 3640.9 3642.2 648.8 675.3 676.7 678.3 692.0 686.7 768.0 772.3 783.5 830.8 9062.6 9350.5 9417.5 9506.0 9550.4 759.1 765.1 770.0 781.3 786.2 4025.4 4133.4 4165.9 4317.4 4503.3 67535.7 68214.3 68650.3 68858.0 69329.7 58391.1 59833.0 60301.4 61083.4 61666.7 51165.5 52048.5 52189.2 52510.2 52902.2 9540.1 9786.0 9883.3 9929.7 10132.5 38194.2 38209.8 39193.0 41560.6 41863.8 49831.3 50523.2 51152.0 51395.2 51466.0 12364.8 12490.1 12589.3 12718.5 12866.5 13768.4 13830.7 14031.7 14123.7 14571.5 12029.0 12446.8 12859.4 12900.3 12982.3 12703.2 13040.7 13070.7 13254.5 13478.8 12426.5 12867.5 12904.9 13069.2 13375.5 11455.2 11589.8 11601.9 11602.7 11613.6 10627.8 10672.9 10788.9 10908.3 10945.5 20:25:09 INFO - PROCESS | 20458 | -------- Summary: end -------- 20:25:09 INFO - PROCESS | 20458 | 20:25:10 INFO - TEST-INFO | 20458: exit 0 20:25:10 INFO - TEST-OK | dromaeo_css | took 1109043ms 20:25:10 INFO - TEST-START | kraken 20:25:10 INFO - operating with platform_type : linux_ 20:25:10 INFO - Initialising browser for kraken test... 20:25:10 INFO - TEST-INFO | started process 20702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRLC7cf/profile http://localhost:55144/getInfo.html) 20:25:13 INFO - PROCESS | 20702 | 20:25:13 INFO - PROCESS | 20702 | (process:20780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:25:14 INFO - PROCESS | 20702 | __metrics Screen width/height:1600/1200 20:25:14 INFO - PROCESS | 20702 | colorDepth:24 20:25:14 INFO - PROCESS | 20702 | Browser inner width/height: 1024/697 20:25:14 INFO - PROCESS | 20702 | __metrics 20:25:15 ERROR - PROCESS | 20702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:25:16 INFO - TEST-INFO | 20702: exit 0 20:25:16 INFO - Browser initialized. 20:25:16 INFO - Running cycle 1/1 for kraken test... 20:25:16 INFO - TEST-INFO | started process 20831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRLC7cf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:17 INFO - PROCESS | 20831 | 20:25:17 INFO - PROCESS | 20831 | (process:20903): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:25:27 INFO - PROCESS | 20831 | RSS: Main: 151965696 20:25:27 INFO - PROCESS | 20831 | 20:25:30 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55144/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:31 INFO - PROCESS | 20831 | RSS: Main: 156999680 20:25:31 INFO - PROCESS | 20831 | 20:25:33 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55144/tests/kraken/driver.html?testName=audio-dft) 20:25:34 INFO - PROCESS | 20831 | RSS: Main: 157044736 20:25:34 INFO - PROCESS | 20831 | 20:25:37 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55144/tests/kraken/driver.html?testName=audio-fft) 20:25:37 INFO - PROCESS | 20831 | RSS: Main: 156733440 20:25:37 INFO - PROCESS | 20831 | 20:25:39 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55144/tests/kraken/driver.html?testName=audio-oscillator) 20:25:40 INFO - PROCESS | 20831 | RSS: Main: 156692480 20:25:40 INFO - PROCESS | 20831 | 20:25:42 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:43 INFO - PROCESS | 20831 | RSS: Main: 157011968 20:25:43 INFO - PROCESS | 20831 | 20:25:46 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55144/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:46 INFO - PROCESS | 20831 | RSS: Main: 157233152 20:25:46 INFO - PROCESS | 20831 | 20:25:50 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55144/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:50 INFO - PROCESS | 20831 | RSS: Main: 157044736 20:25:50 INFO - PROCESS | 20831 | 20:25:53 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55144/tests/kraken/driver.html?testName=json-parse-financial) 20:25:54 INFO - PROCESS | 20831 | RSS: Main: 157110272 20:25:54 INFO - PROCESS | 20831 | 20:25:55 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:56 INFO - PROCESS | 20831 | RSS: Main: 157048832 20:25:56 INFO - PROCESS | 20831 | 20:25:58 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:58 INFO - PROCESS | 20831 | RSS: Main: 157294592 20:25:58 INFO - PROCESS | 20831 | 20:26:00 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:01 INFO - PROCESS | 20831 | RSS: Main: 157200384 20:26:01 INFO - PROCESS | 20831 | 20:26:03 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:04 INFO - PROCESS | 20831 | RSS: Main: 158453760 20:26:04 INFO - PROCESS | 20831 | 20:26:07 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:07 INFO - PROCESS | 20831 | RSS: Main: 157978624 20:26:07 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | Cycle 1(1): loaded http://localhost:55144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55144/tests/kraken/driver.html?testName=ai-astar) 20:26:09 INFO - PROCESS | 20831 | RSS: Main: 159539200 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | __start_tp_report 20:26:09 INFO - PROCESS | 20831 | _x_x_mozilla_page_load 20:26:09 INFO - PROCESS | 20831 | _x_x_mozilla_page_load_details 20:26:09 INFO - PROCESS | 20831 | |i|pagename|runs| 20:26:09 INFO - PROCESS | 20831 | |0;ai-astar;108;111;102;111;111;111;103;110;113;109 20:26:09 INFO - PROCESS | 20831 | |1;audio-beat-detection;158;125;154;172;130;156;150;135;179;127 20:26:09 INFO - PROCESS | 20831 | |2;audio-dft;162;163;165;161;161;162;163;162;162;161 20:26:09 INFO - PROCESS | 20831 | |3;audio-fft;75;78;74;174;74;76;76;76;161;77 20:26:09 INFO - PROCESS | 20831 | |4;audio-oscillator;92;92;146;92;92;91;140;93;92;147 20:26:09 INFO - PROCESS | 20831 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;117;117;117 20:26:09 INFO - PROCESS | 20831 | |6;imaging-darkroom;147;147;146;146;146;147;147;147;147;147 20:26:09 INFO - PROCESS | 20831 | |7;imaging-desaturate;95;94;96;97;95;95;96;95;95;95 20:26:09 INFO - PROCESS | 20831 | |8;json-parse-financial;55;55;55;55;59;59;60;76;55;54 20:26:09 INFO - PROCESS | 20831 | |9;json-stringify-tinderbox;60;60;59;59;58;59;58;58;59;60 20:26:09 INFO - PROCESS | 20831 | |10;stanford-crypto-aes;73;76;73;73;80;74;73;75;74;82 20:26:09 INFO - PROCESS | 20831 | |11;stanford-crypto-ccm;121;118;126;113;119;115;113;122;127;138 20:26:09 INFO - PROCESS | 20831 | |12;stanford-crypto-pbkdf2;161;162;157;158;162;156;169;158;159;156 20:26:09 INFO - PROCESS | 20831 | |13;stanford-crypto-sha256-iterative;68;65;65;68;70;65;64;65;66;67 20:26:09 INFO - PROCESS | 20831 | __end_tp_report 20:26:09 INFO - PROCESS | 20831 | __start_cc_report 20:26:09 INFO - PROCESS | 20831 | _x_x_mozilla_cycle_collect,855 20:26:09 INFO - PROCESS | 20831 | __end_cc_report 20:26:09 INFO - PROCESS | 20831 | __startTimestamp1464146769799__endTimestamp 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | ------- Summary: start ------- 20:26:09 INFO - PROCESS | 20831 | Number of tests: 14 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.63 (3.3%) stddev-sans-first:3.84 20:26:09 INFO - PROCESS | 20831 | Values: 108.0 111.0 102.0 111.0 111.0 111.0 103.0 110.0 113.0 109.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.00 stddev:18.86 (12.2%) stddev-sans-first:19.69 20:26:09 INFO - PROCESS | 20831 | Values: 158.0 125.0 154.0 172.0 130.0 156.0 150.0 135.0 179.0 127.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 20:26:09 INFO - PROCESS | 20831 | Values: 162.0 163.0 165.0 161.0 161.0 162.0 163.0 162.0 162.0 161.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.00 stddev:38.83 (51.1%) stddev-sans-first:40.56 20:26:09 INFO - PROCESS | 20831 | Values: 75.0 78.0 74.0 174.0 74.0 76.0 76.0 76.0 161.0 77.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:92.00 stddev:25.35 (27.6%) stddev-sans-first:26.24 20:26:09 INFO - PROCESS | 20831 | Values: 92.0 92.0 146.0 92.0 92.0 91.0 140.0 93.0 92.0 147.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 20:26:09 INFO - PROCESS | 20831 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 20:26:09 INFO - PROCESS | 20831 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 20:26:09 INFO - PROCESS | 20831 | Values: 95.0 94.0 96.0 97.0 95.0 95.0 96.0 95.0 95.0 95.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.00 stddev:6.58 (11.6%) stddev-sans-first:6.87 20:26:09 INFO - PROCESS | 20831 | Values: 55.0 55.0 55.0 55.0 59.0 59.0 60.0 76.0 55.0 54.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 20:26:09 INFO - PROCESS | 20831 | Values: 60.0 60.0 59.0 59.0 58.0 59.0 58.0 58.0 59.0 60.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.50 stddev:3.20 (4.3%) stddev-sans-first:3.28 20:26:09 INFO - PROCESS | 20831 | Values: 73.0 76.0 73.0 73.0 80.0 74.0 73.0 75.0 74.0 82.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.50 stddev:7.66 (6.3%) stddev-sans-first:8.12 20:26:09 INFO - PROCESS | 20831 | Values: 121.0 118.0 126.0 113.0 119.0 115.0 113.0 122.0 127.0 138.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:3.94 (2.5%) stddev-sans-first:4.15 20:26:09 INFO - PROCESS | 20831 | Values: 161.0 162.0 157.0 158.0 162.0 156.0 169.0 158.0 159.0 156.0 20:26:09 INFO - PROCESS | 20831 | 20:26:09 INFO - PROCESS | 20831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.89 (2.8%) stddev-sans-first:1.90 20:26:09 INFO - PROCESS | 20831 | Values: 68.0 65.0 65.0 68.0 70.0 65.0 64.0 65.0 66.0 67.0 20:26:09 INFO - PROCESS | 20831 | -------- Summary: end -------- 20:26:09 INFO - PROCESS | 20831 | 20:26:10 INFO - TEST-INFO | 20831: exit 0 20:26:10 INFO - TEST-OK | kraken | took 60694ms 20:26:10 INFO - SUITE-END | took 1169s 20:26:10 INFO - Completed test suite (00:19:29) 20:26:10 INFO - javascript benchmark 20:26:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.3111362170757, 3364.932701345974, 3407.6251612322626, 3442.191085095002, 3458.187325978396, 5638.210650508921, 5639.66162030278, 5667.801626943053, 5685.232493613371, 5697.8005769798065, 5643.830685079454, 5674.489295963363, 5713.257276554053, 5714.799982000631, 5725.828225153252, 5048.444671086178, 5102.056119617864, 5123.180291153416, 5141.228815677641, 5201.375834899817, 5126.769295381698, 5224.294720212761, 5261.210818377236, 5261.815836445706, 5289.074411977907, 5105.310783044279, 5111.361079865017, 5205.60957928155, 5238.842834714965, 5277.472252774711, 5216.66091704038, 5218.034663587229, 5218.973905130488, 5227.869303267411, 5272.789088436458, 4994.850154495371, 5069.087564238435, 5144.897102057937, 5196.948030519722, 5199.766010529497, 5448.101063324547, 5479.232907392969, 5500.477454641843, 5506.559475241971, 5579.330480342385, 5955.642661440284, 5999.430054144849, 6004.12940123684, 6005.069214271794, 6008.128821320927, 5810.070388737824, 5985.820425387202, 6030.487408570233, 6030.698465076729, 6087.269527656666, 5679.176519404705, 5680.630759000652, 5692.686902220376, 5701.600887937846, 5735.713214339266, 6207.286162091417, 6219.1604133442315, 6220.253569571681, 6224.968875155686, 6225.408586184305, 5859.560532960045, 5906.055031194988, 5923.763049477972, 5992.101184822312, 5993.520518358521, 5980.401959804072, 5990.161377407167, 6001.939980600138, 6005.579609427298, 6048.274207095177, 5920.792772253037, 5923.229980102646, 5960.046392577166, 5967.6121052131475, 5973.0, 5837.3287071986415, 5967.5524335675, 6045.969770151209, 6093.634381937098, 6128.78549250783, 4564.7032942858605, 4566.977165114153, 4569.268916973335, 4579.519150489217, 4590.196715574761, 4106.630403263721, 4117.3206420940805, 4135.17296540693, 4137.9861933826405, 4154.439150714615, 5784.623999440023, 5896.528277737771, 5921.378255283219, 5938.049912014057, 5986.820395388146, 6019.277686677627, 6071.726772295257, 6122.142899994004, 6123.265208174958, 6125.9680843641045, 5799.2460980073165, 5887.0, 5887.322957859901, 5900.291964964232, 5910.852228694317, 5242.449542798027, 5253.868653283622, 5270.051390749702, 5300.072487314705, 5333.173358129418, 6336.936630633727, 6367.235931688135, 6368.554201205871, 6374.107624932513, 6394.456471199907, 5933.317668468181, 6056.333803281547, 6146.0, 6146.846328841814, 6165.599236049642, 6343.5876668016435, 6354.555181137276, 6383.0744542042075, 6383.106365108982, 6384.106225128393, 5970.0746384310505, 5995.700214989146, 5999.850003749767, 6028.547858910511, 6040.365761595145, 5908.409159084057, 6151.84620384494, 6165.630062196283, 6173.629582225081, 6257.749690012349, 6008.969955150196, 6015.518758499222, 6020.096985452217, 6027.0, 6047.969760151347, 5955.91066134017, 5982.820515384546, 5995.340512543704, 5997.91003134962, 6018.969905150446, 5781.248437703071, 5903.645781253139, 5928.940710593011, 5963.612365196248, 6088.086786981989, 5996.610220335664, 6036.788712395045, 6036.84907877289, 6040.637561746309, 6052.485538729257, 5890.0, 5891.734871930687, 5897.823065308047, 5906.527477801851, 5915.645061296336], "value": 5614.802589593753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.6708812681787, 677.8034370032691, 678.8336857469919, 733.1861633586718, 744.8994385757923, 33033.33933321335, 41195.79402102993, 41836.16327673445, 42015.15969680612, 42172.0, 45111.09777804442, 45396.54603453964, 45474.0, 45565.31652025222, 45609.0878182437, 8818.999999999984, 8950.597223124974, 9006.414583052081, 9017.323700722472, 9029.0519495453, 8847.77880552985, 8858.424202426822, 8859.911400885972, 8907.064758200393, 8908.153725396109, 9101.908980910206, 9139.131782480687, 9215.078492150766, 9222.216111630485, 9231.907680923172, 9142.177204051633, 9180.586873590704, 9182.678606248783, 9187.908120918806, 9195.954020229923, 9063.59213835379, 9139.497327646977, 9168.954155229248, 9171.082891710843, 9213.90786092144, 43568.564314356765, 43896.3415548767, 43997.34003989943, 44112.0, 44336.55663443357, 3739.383001804699, 3841.9423708644395, 4057.2696914555368, 4061.776602286873, 4584.991301913574, 33486.49770253448, 33565.83217083899, 33589.0, 33615.83192084049, 33650.49524257138, 4547.909041819178, 4592.2422800238255, 4598.747068911209, 4641.76791160444, 4658.883527911796, 235746.0, 236393.0, 236563.99999999828, 236701.99999999828, 237215.0, 65172.34827651758, 65654.67172664202, 65886.34113658898, 65913.0, 65977.0, 69608.30391696018, 72738.0, 73797.6310118446, 74482.0, 74929.25070749223, 19554.21783128659, 19643.31248406299, 19818.20727170926, 19818.70271945922, 19858.1063852127, 15306.923465382602, 15343.846561534465, 15404.768928466083, 15409.614759631098, 15429.691406171814, 20648.79351206499, 20702.0, 20805.271815486387, 20830.895845520674, 20851.582968340852, 7600.923990760021, 7644.159142494321, 7766.932061835543, 7838.079670480654, 7864.449488535747, 1071.5338827609858, 1152.5332240442633, 1154.861416629993, 1163.5345861655237, 1188.0911103006208, 33278.334433311684, 33623.0, 33737.139892029816, 33755.49366759501, 33899.152521186676, 1111.3887361950895, 1163.2962057954985, 1224.3981539229137, 1230.686175025363, 1301.8502872169631, 17796.52134853897, 18170.727439088423, 18208.60047536281, 19474.805251947582, 19626.50933726668, 516524.0, 543670.0, 575047.0, 588142.0, 590173.0, 64317.35682643114, 65424.345756542774, 65988.67005665037, 66203.66898165479, 66227.66886165539, 1484.5323723027427, 1524.329295110148, 1545.7449520828936, 1548.5199588127716, 1551.5112739487026, 33347.666523334454, 34195.658043419244, 34238.315233695685, 34390.14024649404, 34837.47743783896, 57569.71215143897, 63331.0, 65234.0, 65291.673541631986, 65391.34608653853, 444291.0, 446716.0, 447700.0, 451849.0, 452836.0, 46719.0, 47313.52686473229, 47496.0, 47768.28347574858, 48725.269120962505, 51912.221316679526, 52864.4713552875, 53617.46382536125, 54032.459675404316, 55135.72432137974, 38860.41709374305, 39282.410763837994, 39656.801715991234, 41724.0, 42254.0, 41988.58011419847, 42218.36672449854, 42568.0, 43557.78221108874, 43587.0, 43093.784531078396, 43110.35334469923, 43730.0, 44547.33179002253, 44724.77637611791, 36172.0, 36701.26597468089, 37120.814395927846, 37204.255914882095, 37378.252434950606, 28317.292067698472, 29117.231250343175, 29294.853525732236, 29398.265043374086, 29442.0], "value": 21649.190214787952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9793510324484, 416.9249535083685, 434.3029437752405, 436.4566115186593, 441.8895276180955, 18677.0, 19198.616027679436, 19253.941033243165, 19696.507587310287, 20109.497262568406, 19358.903205483988, 20023.098960546773, 20163.495912602193, 20190.394288171377, 20294.492637684067, 5396.217548455472, 5398.8920221595445, 5474.91787623186, 5515.117581187011, 5534.418886016951, 4968.527989840977, 5514.5864060195445, 5537.916931246034, 5539.9169012464645, 5575.553955683556, 5509.586780991422, 5536.778528858861, 5544.667319960795, 5545.944540554583, 5597.832065038056, 5533.418991005927, 5533.944660553403, 5538.944610553883, 5551.555875529948, 5568.749406276707, 5276.630635855492, 5324.520793128637, 5440.537554307849, 5455.727213639342, 5456.91814622781, 14756.70486590273, 15022.24888755558, 15255.694886102327, 15302.387904483807, 15407.075575465396, 2464.7042354917344, 2572.498362819232, 2672.1182009936674, 2725.6320396746382, 3034.6965303469697, 11101.3894235817, 11398.145139114516, 14941.103533787898, 15062.322195501229, 15155.090694558361, 2134.5090629155225, 2145.184829764695, 2176.858504197222, 2211.4803021289986, 2221.1892659179443, 83820.58089709573, 86275.56862215648, 87055.0, 87117.82205444851, 87676.5616171915, 11893.286402815858, 11893.40532973348, 11974.64076077719, 11987.940060299818, 11990.34053127069, 16618.58453538671, 16724.163791810362, 16806.57983550421, 16809.15954202285, 16885.662286754196, 9141.954290228507, 9372.109649583279, 9387.10822471864, 9387.62449502026, 9505.239580833517, 9176.541172941326, 9184.0, 9234.769130771785, 9365.531723413802, 9418.717438476857, 5123.3339665843205, 5180.637355385087, 5194.246834209094, 5235.921461178085, 5246.632735708464, 2130.2118216260083, 2162.826973842089, 2188.529466164782, 2211.5797998380576, 2222.344408399526, 1033.8242498775226, 1091.0344345254507, 1121.870984836738, 1154.001788452982, 1196.9760604787855, 18852.245910163714, 19908.0, 20029.198832046848, 20267.695984560243, 20585.279515216895, 1105.4583254205543, 1108.9390083545482, 1115.514751083265, 1151.0848875144281, 1233.7779199743952, 11421.771564568662, 11495.252808567584, 11502.82000429609, 11519.76960460803, 11630.76738465226, 517130.0, 518065.0, 522844.0, 524880.0, 531402.0, 56428.43571564232, 57793.133103003485, 82398.17601823906, 96148.51925740327, 98126.0, 1075.8745843325153, 1110.6612483192541, 1119.071170928144, 1131.3551275772732, 1131.886811318878, 17787.73318400251, 17955.551111222325, 18008.729869051713, 18041.0, 18187.090645467408, 40174.1965160701, 41370.58629413667, 42638.36042459428, 43158.35262471128, 43352.349714754935, 58388.70805645944, 61145.38854611397, 61354.38645613487, 61421.38578614157, 61520.69239653773, 9493.905060949579, 9514.0, 9523.142917137491, 9577.281703872377, 9831.399167944037, 11130.666080017612, 13947.511837085653, 14058.507952221624, 14102.153870767786, 14329.283535822959, 11415.258008229439, 11788.174827761974, 12259.75480490403, 12429.192102513307, 12743.235405875677, 12446.439910204244, 12705.36473176356, 12765.8085128725, 12767.93616031914, 13031.08782385224, 12978.480860765841, 13002.544910928073, 13112.344382780631, 13156.671083222996, 13183.67040823987, 9540.427574345562, 9605.951970240105, 9726.562304696447, 9798.51007449639, 9850.014998500379, 9569.808603827745, 12432.316222607844, 13010.479580816662, 13107.934460328019, 13278.269695166859], "value": 9691.708449408514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1571.7406627906391, 1572.58326543466, 1790.2838864454216, 1905.8094190580935, 1921.2219051284217, 7844.0, 8133.715319963802, 8614.569271536422, 8807.559622018898, 8831.381803273765, 8633.09352517986, 8635.39552231344, 8733.083026282244, 8767.079456657038, 8779.0, 2483.925482235527, 2487.067349743846, 2496.0639760089966, 2499.237732491589, 2509.82431229814, 2353.8234632402637, 2458.6434966929783, 2461.90152393904, 2463.938401539958, 2469.1481438903547, 2426.4904370082218, 2442.1818690738537, 2494.0, 2495.7254701982765, 2498.350428888493, 2491.53906527293, 2512.309114993373, 2512.899484020646, 2518.5214809186195, 2525.696916370029, 2429.708434987813, 2450.8774561271866, 2450.9264722058365, 2465.8520488770732, 2497.5254701606636, 8913.509756963364, 8916.643334266622, 8926.509042002752, 8931.50876701781, 8940.865887011634, 5560.2493663355735, 5632.943670563324, 5704.543636509069, 5706.029974904235, 5707.0298049331295, 3520.2431477232262, 3598.874039408608, 3613.476045973345, 3755.267722794056, 3793.336166170909, 1224.553038141081, 1262.0219330019218, 1283.1018287198904, 1311.809787580805, 1318.3408295852073, 12526.874731252754, 12566.120371573994, 12575.559855405018, 12583.559575414816, 12721.745565088646, 4775.689580177277, 4778.768951870562, 4843.321934929113, 4862.319275301461, 4864.173090574611, 10490.423026733602, 10582.417967011734, 10587.682369528926, 10592.205584581186, 10611.045005949502, 5496.697681627549, 5503.449655034465, 5529.142982837667, 5538.418466061005, 5540.473655002768, 4542.613877820356, 4971.875703107451, 5100.719460429637, 5149.48505149482, 5163.380394352702, 4155.10665206982, 4213.389058586549, 4303.182395344875, 4321.049369138785, 4479.081788233404, 1393.770027945398, 1401.2433286025637, 1423.0821120377298, 1438.1443041390355, 1443.6968236670207, 923.3351986569659, 1053.2206167436195, 1063.6649455421518, 1073.393532654048, 1076.5155679944057, 6152.107944348045, 6341.746330146835, 6356.586821856565, 6391.488680905516, 6497.057926600616, 471.14016919122736, 483.7339463295174, 494.0538868067682, 496.9950300497021, 502.4347608939943, 4271.9786401067795, 4346.587074227943, 4350.21696094706, 4351.0645211279725, 4360.367746676714, 10717.83923241152, 11024.944875275733, 11086.667399978014, 11165.665030049111, 11227.66317010491, 10846.349219046882, 10861.0, 10958.397288149068, 10961.83557246642, 11002.064824489848, 7969.203079691984, 8225.46534475269, 8389.077201507951, 8574.056853746082, 8584.184502472255, 6213.220335619075, 6410.326915673787, 6422.197225346832, 6480.935190648033, 6481.611103333815, 9890.950545247228, 9902.059304366074, 9944.204463642747, 10146.340487868265, 10160.847587286049, 9826.0, 10150.898491014996, 10250.641227557, 10366.896331036593, 10374.27380083387, 7985.441019128605, 7995.520268783892, 8132.87800683002, 8169.918300816916, 8218.342532597497, 8667.219950204511, 8673.262772664395, 8680.305575554066, 8690.478571285743, 8713.607887644945, 7658.081030276402, 7821.061472623322, 7920.683172673259, 7940.28537431634, 7970.800729981797, 7451.552906825608, 7583.544987300779, 7677.961610191914, 7728.111267204344, 7775.066991961001, 7095.219525852049, 7147.714091436284, 7192.820179495555, 7203.495755297079, 7208.35124838767, 5070.442251352274, 5097.8215762448135, 5175.068487672255, 5192.714400707997, 5241.633085684118, 5394.32570928634, 5411.567074633941, 5453.509184173444, 5500.257465242141, 5688.033034384247], "value": 4757.118095741879, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5311615225979, 360.46830924386535, 364.04801444223364, 376.7551091790336, 378.8995916082238, 6543.5746676466115, 6549.214094308678, 6600.669966501674, 6657.267700552941, 6731.903324470749, 6618.536702430832, 6650.572541022529, 6684.632345221011, 6695.832604184898, 6705.161854768154, 5105.846824595268, 5108.2593024011685, 5110.923336149961, 5112.565431938271, 5124.743762811863, 5103.3875934887865, 5113.258577506259, 5118.181091025437, 5118.6416950813455, 5122.487751224885, 5052.292679024939, 5055.3933527976515, 5074.061298659742, 5082.593392528607, 5085.389753229618, 4959.6528243023, 5020.146575082244, 5036.546710796046, 5073.974630126862, 5088.389393272812, 4410.691251612388, 4433.379326894237, 4438.42300500936, 4448.7108337957925, 4450.755208463565, 6330.8100756977365, 6357.268914074894, 6360.809175724736, 6363.490920726331, 6375.139356186948, 5895.970520147414, 5913.024350982083, 5937.465628093449, 5971.731272092723, 5974.551908606872, 6991.580505169706, 7036.120484939383, 7037.859242815166, 7042.753503627348, 7057.858842823166, 4642.837500687459, 4806.807727690888, 4857.028594281158, 4984.800607975713, 5006.799728010875, 7261.5280006799385, 7271.490995630308, 7272.600006999613, 7335.669894854745, 7358.521696089737, 4924.0890435268875, 4944.233643785219, 4950.381202349707, 4956.207006878954, 4966.1309270877455, 4995.475475075064, 5014.598832093424, 5021.5229553192385, 5026.070177017264, 5032.572231360376, 5820.505257053113, 5821.330546987066, 5822.184894114827, 5823.563232757476, 5827.7668893244645, 6849.1438570178725, 6967.651617419108, 7010.719571217196, 7011.89482157768, 7013.789586312317, 1729.3342063305718, 1762.9382971595933, 1768.0629266488525, 1768.6285879965094, 1774.4410510689092, 1043.410473082706, 1109.9889001109887, 1115.7880002799443, 1121.0863146535548, 1169.5088063013554, 6747.595144291358, 6921.861562768717, 6952.200496942815, 6960.512764106464, 6988.056612357267, 7304.96347518259, 7321.450891183076, 7328.59692716895, 7328.890066649004, 7344.742933997284, 6919.8962015569805, 6920.723171073201, 6924.584524928419, 6936.34104760047, 6946.0, 3867.149227170018, 3939.330313846653, 3944.723869329119, 3955.20895820837, 3970.781607011584, 7643.121041080347, 7645.235476452311, 7656.196099409593, 7657.731979380695, 7662.846743065107, 7395.112586489548, 7415.88876166858, 7427.925720742724, 7434.033575635241, 7452.180260171377, 7621.047369078865, 7626.580538070349, 7638.968739220134, 7651.923480765233, 7658.502197357043, 7167.3599009332365, 7285.125784905846, 7297.233790452138, 7307.926920730724, 7318.560886346836, 7103.538270012433, 7108.182559005781, 7130.322619351154, 7161.749338773118, 7190.280971902768, 7643.082830060428, 7651.273129052731, 7655.387568994578, 7657.540547567164, 7664.501807382502, 4959.082569724613, 4977.4773648767805, 4978.502149784992, 4983.476734942924, 4987.526185012418, 7093.794055010558, 7258.346748792634, 7311.159216690149, 7312.41500679955, 7324.230955749569, 7022.12223472066, 7064.682089305891, 7108.893366599402, 7110.7511237106455, 7134.607596582237, 7040.0847889774, 7082.433405327459, 7083.972823940603, 7087.787366379017, 7093.2197458278515, 6921.2386637468835, 6959.478039146983, 6959.965200173967, 6961.930380696128, 6980.441564674916, 6985.755498557526, 7124.073870396815, 7137.536060156073, 7147.46394020461, 7149.499535032498, 6764.763233286812, 6932.202796678446, 6989.685464154227, 6990.930090699231, 7006.649667516705], "value": 5316.612735430442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.5100792548249, 912.507246087113, 919.7516670498966, 938.2775263047454, 941.2846236859984, 14227.71544569108, 14424.206668633235, 14452.5664230073, 14499.0, 14507.202103884296, 13216.273104979246, 15193.240337983112, 15518.534443966699, 15537.84462155378, 15629.609259768511, 776.8290975985274, 883.6200433813458, 895.3240303570827, 923.0953665407905, 924.3437159616664, 910.8223896340184, 915.1214833759599, 915.839728047589, 918.8024574716435, 919.8528235482324, 959.4195511715417, 962.8122516109327, 963.3352986439335, 963.5952899782109, 965.874436323277, 942.6794889737488, 946.8911075226334, 955.9952200239023, 956.9425834449955, 957.8563215517693, 706.4207349973024, 706.8974998625171, 708.9432845372357, 709.2977951827653, 711.1111111111111, 15621.609459763484, 15731.764023539656, 15735.370585176579, 15770.448034318859, 15797.131157786318, 14741.262936853114, 14753.77869331961, 14776.187309697962, 14897.553073407815, 14928.850711492854, 11063.336199828036, 11355.43222838863, 11598.682013269614, 11913.463894124785, 12041.698957526045, 3908.570057293724, 3916.2167566486532, 3955.762654240726, 3974.1058261890844, 3975.7018223633345, 62047.6897615509, 62235.37764622341, 62402.0, 62517.68741156311, 62953.685231574, 11844.28934263947, 11891.0, 11895.702607434883, 12094.516219351128, 12101.878981210251, 20818.58362832735, 20895.791042089688, 20973.26593569248, 21034.368968930958, 21053.789462105487, 8308.5430301334, 8592.484450932963, 8636.136386361313, 8856.778580535409, 9089.27285817133, 5059.645824792303, 5066.316047333563, 5082.949170508247, 5089.414717307557, 5161.793528258902, 3593.1735700788963, 3615.29501747162, 3636.4181730922924, 3640.8543658253375, 3642.1623026704005, 648.7761722205831, 675.2841987493273, 676.7123972311748, 678.3047376439091, 691.9688614012382, 686.6875571614903, 767.9594149926769, 772.2933515833063, 783.5181363461544, 830.779843341515, 9062.592183351764, 9350.540509530643, 9417.529123543796, 9506.0, 9550.37922535033, 759.0663483914706, 765.0933643632313, 769.9884501732479, 781.2890269854405, 786.1666633368648, 4025.355943049098, 4133.359329303963, 4165.854195103157, 4317.373980772771, 4503.347014682919, 67535.66232168808, 68214.31785682178, 68650.31349686539, 68858.0, 69329.65335173393, 58391.12413313804, 59833.0, 60301.39698602958, 61083.38916610866, 61666.69166654138, 51165.48834511607, 52048.479515204366, 52189.21716174261, 52510.21234681406, 52902.20646690303, 9540.141387275178, 9786.0, 9883.258755593502, 9929.702108936743, 10132.493375331056, 38194.23611527698, 38209.80895095507, 39193.0, 41560.58439415688, 41863.7906810464, 49831.252531212784, 50523.2421513685, 51152.0, 51395.22907156321, 51466.0, 12364.752704946031, 12490.06324525646, 12589.307588082744, 12718.491260349483, 12866.549670761478, 13768.380422880795, 13830.65423364424, 14031.719365612835, 14123.717525649636, 14571.489997850449, 12029.0, 12446.751064978831, 12859.421326040163, 12900.29048402347, 12982.285974271506, 12703.174293670882, 13040.673983150496, 13070.673233169247, 13254.53609123676, 13478.797818032934, 12426.502939882303, 12867.549635762703, 12904.935475322563, 13069.215847049207, 13375.53185638498, 11455.198136130392, 11589.760996745363, 11601.897819707114, 11602.6519204424, 11613.593524226611, 10627.787444250916, 10672.946635267084, 10788.892111079103, 10908.290961087821, 10945.507452164513], "value": 7243.338287050514, "unit": "score"}], "name": "dromaeo_css", "value": 7745.013043784501, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 102.0, 111.0, 111.0, 111.0, 103.0, 110.0, 113.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 154.0, 172.0, 130.0, 156.0, 150.0, 135.0, 179.0, 127.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 161.0, 161.0, 162.0, 163.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 174.0, 74.0, 76.0, 76.0, 76.0, 161.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 92.0, 92.0, 91.0, 140.0, 93.0, 92.0, 147.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 59.0, 59.0, 60.0, 76.0, 55.0, 54.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 73.0, 80.0, 74.0, 73.0, 75.0, 74.0, 82.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 126.0, 113.0, 119.0, 115.0, 113.0, 122.0, 127.0, 138.0], "value": 121.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 157.0, 158.0, 162.0, 156.0, 169.0, 158.0, 159.0, 156.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 68.0, 70.0, 65.0, 64.0, 65.0, 66.0, 67.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1520.6, "alertThreshold": 2.0}]} 20:26:11 INFO - Return code: 0 20:26:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:11 ERROR - # TBPL SUCCESS # 20:26:11 INFO - Running post-action listener: _resource_record_post_action 20:26:11 INFO - Running post-run listener: _resource_record_post_run 20:26:12 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 262144; Write bytes: 499630080; Read time: 20; Write time: 400972 20:26:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255102976; Read time: 0; Write time: 247496 20:26:12 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 262144; Write bytes: 244527104; Read time: 20; Write time: 153476 20:26:12 INFO - Running post-run listener: _upload_blobber_files 20:26:12 INFO - Blob upload gear active. 20:26:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:12 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 20:26:12 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'] 20:26:12 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 20:26:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:13 INFO - (blobuploader) - INFO - Done attempting. 20:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:14 INFO - (blobuploader) - INFO - Done attempting. 20:26:14 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:14 INFO - Return code: 0 20:26:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f98ccaa67cf658bd447b1cfd73146c8331c2250256f7d3e94a3cf3dddd597abd91451a29600f0ea59f3b404eaf700e5b6fd3cf25f177eb7e41d8c23d4c7a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36548ea0ba9601f4166faa1599e567ae871d96a4dd95fbfc3c04f89fc723a912d8d0f70da317df86fa5fec3857e2792a010287b2311f5bff2a0b2dfa4ca44655"} 20:26:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:14 INFO - Contents: 20:26:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f98ccaa67cf658bd447b1cfd73146c8331c2250256f7d3e94a3cf3dddd597abd91451a29600f0ea59f3b404eaf700e5b6fd3cf25f177eb7e41d8c23d4c7a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36548ea0ba9601f4166faa1599e567ae871d96a4dd95fbfc3c04f89fc723a912d8d0f70da317df86fa5fec3857e2792a010287b2311f5bff2a0b2dfa4ca44655"} 20:26:14 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:14 INFO - Copying logs to upload dir... 20:26:14 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.111183 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-24 20:26:14.089521) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:14.092938) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f98ccaa67cf658bd447b1cfd73146c8331c2250256f7d3e94a3cf3dddd597abd91451a29600f0ea59f3b404eaf700e5b6fd3cf25f177eb7e41d8c23d4c7a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36548ea0ba9601f4166faa1599e567ae871d96a4dd95fbfc3c04f89fc723a912d8d0f70da317df86fa5fec3857e2792a010287b2311f5bff2a0b2dfa4ca44655"} build_url:https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010666 build_url: 'https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5f98ccaa67cf658bd447b1cfd73146c8331c2250256f7d3e94a3cf3dddd597abd91451a29600f0ea59f3b404eaf700e5b6fd3cf25f177eb7e41d8c23d4c7a23", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36548ea0ba9601f4166faa1599e567ae871d96a4dd95fbfc3c04f89fc723a912d8d0f70da317df86fa5fec3857e2792a010287b2311f5bff2a0b2dfa4ca44655"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:14.114664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:14.114959) ========= 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=14ef55db36f7623abb31b9cf000001d5-1464145542.166217-1224937470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:14.197185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:26:14.197513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:26:14.197809) ========= ========= Total master_lag: 0.17 =========