builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1463969313.29 results: success (0) buildid: 20160522162928 builduid: 85d713b6e9974a8cb8042c065bafad7d revision: 40994e384c130872bb8430268780726d4416cf40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.293567) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.294168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.294513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.331680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.331982) ========= 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=920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-22 19:08:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 222M=0s 2016-05-22 19:08:34 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119287 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.497965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.498284) ========= 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=920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017837 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.552218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:33.552575) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 40994e384c130872bb8430268780726d4416cf40 --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 40994e384c130872bb8430268780726d4416cf40 --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=920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-22 19:08:34,507 truncating revision to first 12 chars 2016-05-22 19:08:34,507 Setting DEBUG logging. 2016-05-22 19:08:34,507 attempt 1/10 2016-05-22 19:08:34,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/40994e384c13?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-22 19:08:34,893 unpacking tar archive at: mozilla-aurora-40994e384c13/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:34.244200) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:34.244620) ========= script_repo_revision: 40994e384c130872bb8430268780726d4416cf40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:34.245202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:34.245551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-22 19:08:34.257113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-22 19:08:34.257432) ========= /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=920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:08:35 INFO - MultiFileLogger online at 20160522 19:08:35 in /builds/slave/test 19:08:35 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 19:08:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:08:35 INFO - {'append_to_log': False, 19:08:35 INFO - 'base_work_dir': '/builds/slave/test', 19:08:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:08:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:08:35 INFO - 'branch': 'Mozilla-Aurora', 19:08:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:08:35 INFO - 'config_files': ('talos/linux_config.py',), 19:08:35 INFO - 'default_actions': ('clobber', 19:08:35 INFO - 'read-buildbot-config', 19:08:35 INFO - 'download-and-extract', 19:08:35 INFO - 'populate-webroot', 19:08:35 INFO - 'create-virtualenv', 19:08:35 INFO - 'install', 19:08:35 INFO - 'run-tests'), 19:08:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:08:35 INFO - 'download_minidump_stackwalk': True, 19:08:35 INFO - 'download_symbols': 'ondemand', 19:08:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:08:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:08:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:08:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:08:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:08:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:08:35 INFO - 'installer_path': 'installer.exe', 19:08:35 INFO - 'log_level': 'info', 19:08:35 INFO - 'log_name': 'talos', 19:08:35 INFO - 'log_to_console': True, 19:08:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:08:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:08:35 INFO - 'opt_config_files': (), 19:08:35 INFO - 'pip_index': False, 19:08:35 INFO - 'sps_profile': False, 19:08:35 INFO - 'sps_profile_interval': 0, 19:08:35 INFO - 'suite': 'dromaeojs-e10s', 19:08:35 INFO - 'system_bits': '32', 19:08:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:08:35 INFO - 'title': 'talos-linux64-ix-053', 19:08:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:08:35 INFO - 'use_talos_json': True, 19:08:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:08:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:08:35 INFO - 'work_dir': 'build'} 19:08:35 INFO - ##### 19:08:35 INFO - ##### Running clobber step. 19:08:35 INFO - ##### 19:08:35 INFO - Running pre-action listener: _resource_record_pre_action 19:08:35 INFO - Running main action method: clobber 19:08:35 INFO - rmtree: /builds/slave/test/build 19:08:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:08:35 INFO - Running post-action listener: _resource_record_post_action 19:08:35 INFO - ##### 19:08:35 INFO - ##### Running read-buildbot-config step. 19:08:35 INFO - ##### 19:08:35 INFO - Running pre-action listener: _resource_record_pre_action 19:08:35 INFO - Running main action method: read_buildbot_config 19:08:35 INFO - Using buildbot properties: 19:08:35 INFO - { 19:08:35 INFO - "project": "", 19:08:35 INFO - "product": "firefox", 19:08:35 INFO - "script_repo_revision": "production", 19:08:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:08:35 INFO - "repository": "", 19:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:08:35 INFO - "buildid": "20160522162928", 19:08:35 INFO - "pgo_build": "True", 19:08:35 INFO - "basedir": "/builds/slave/test", 19:08:35 INFO - "buildnumber": 326, 19:08:35 INFO - "slavename": "talos-linux64-ix-053", 19:08:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:08:35 INFO - "platform": "ubuntu64_hw", 19:08:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:08:35 INFO - "branch": "mozilla-aurora", 19:08:35 INFO - "repo_path": "releases/mozilla-aurora", 19:08:35 INFO - "revision": "40994e384c130872bb8430268780726d4416cf40", 19:08:35 INFO - "stage_platform": "linux64-pgo", 19:08:35 INFO - "builduid": "85d713b6e9974a8cb8042c065bafad7d", 19:08:35 INFO - "slavebuilddir": "test" 19:08:35 INFO - } 19:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 19:08:35 INFO - Running post-action listener: _resource_record_post_action 19:08:35 INFO - ##### 19:08:35 INFO - ##### Running download-and-extract step. 19:08:35 INFO - ##### 19:08:35 INFO - Running pre-action listener: _resource_record_pre_action 19:08:35 INFO - Running main action method: download_and_extract 19:08:35 INFO - mkdir: /builds/slave/test/build/tests 19:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:35 INFO - https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:41 INFO - Downloaded 1361 bytes. 19:08:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 19:08:41 INFO - Using the following test package requirements: 19:08:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:08:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:08:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'jsshell-linux-x86_64.zip'], 19:08:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 19:08:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:08:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:08:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 19:08:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:41 INFO - https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:45 INFO - Downloaded 23812944 bytes. 19:08:45 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'] 19:08:45 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 19:08:46 INFO - Return code: 0 19:08:46 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 19:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:46 INFO - https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:08:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 19:08:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:52 INFO - Downloaded 23812944 bytes. 19:08:52 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'] 19:08:52 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 19:08:53 INFO - Return code: 0 19:08: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')]} 19:08:53 INFO - https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 19:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:54 INFO - Downloaded 10840145 bytes. 19:08:54 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'] 19:08:54 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 19:08:55 INFO - Return code: 0 19:08: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')]} 19:08:55 INFO - https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwm5B6rTTEOFEjg2JInzFw/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 19:08:57 INFO - Downloaded 62732754 bytes. 19:08:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:08:57 INFO - mkdir: /builds/slave/test/properties 19:08:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:57 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:57 INFO - Contents: 19:08:57 INFO - build_url:https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 19:08:57 INFO - Running post-action listener: _resource_record_post_action 19:08:57 INFO - Running post-action listener: set_extra_try_arguments 19:08:57 INFO - ##### 19:08:57 INFO - ##### Running populate-webroot step. 19:08:57 INFO - ##### 19:08:57 INFO - Running pre-action listener: _resource_record_pre_action 19:08:57 INFO - Running main action method: populate_webroot 19:08:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:57 INFO - '--tppagecycles', 19:08:57 INFO - '7'], 19:08:57 INFO - 'tests': ['tsvgm']}}, 19:08:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['damp', 'tps']}, 19:08:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'tests': ['damp', 'tps']}, 19:08:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['dromaeo_dom']}, 19:08:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['a11yr', 19:08:57 INFO - 'ts_paint', 19:08:57 INFO - 'tpaint', 19:08:57 INFO - 'sessionrestore', 19:08:57 INFO - 'sessionrestore_no_auto_restore', 19:08:57 INFO - 'tabpaint']}, 19:08:57 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:57 INFO - 'ts_paint', 19:08:57 INFO - 'tpaint', 19:08:57 INFO - 'sessionrestore', 19:08:57 INFO - 'sessionrestore_no_auto_restore', 19:08:57 INFO - 'tabpaint']}, 19:08:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:57 INFO - 'ts_paint', 19:08:57 INFO - 'tpaint', 19:08:57 INFO - 'sessionrestore', 19:08:57 INFO - 'sessionrestore_no_auto_restore', 19:08:57 INFO - 'tabpaint']}, 19:08:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:57 INFO - 'ts_paint', 19:08:57 INFO - 'tpaint', 19:08:57 INFO - 'sessionrestore', 19:08:57 INFO - 'sessionrestore_no_auto_restore', 19:08:57 INFO - 'tabpaint']}, 19:08:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['a11yr', 19:08:57 INFO - 'ts_paint', 19:08:57 INFO - 'tpaint', 19:08:57 INFO - 'sessionrestore', 19:08:57 INFO - 'sessionrestore_no_auto_restore', 19:08:57 INFO - 'tabpaint']}, 19:08:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['a11yr', 19:08:57 INFO - 'ts_paint', 19:08:57 INFO - 'tpaint', 19:08:57 INFO - 'sessionrestore', 19:08:57 INFO - 'sessionrestore_no_auto_restore', 19:08:57 INFO - 'tabpaint']}, 19:08:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['tsvgx', 19:08:57 INFO - 'tsvgr_opacity', 19:08:57 INFO - 'tart', 19:08:57 INFO - 'tscrollx', 19:08:57 INFO - 'cart']}, 19:08:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:57 INFO - 'tsvgr_opacity', 19:08:57 INFO - 'tart', 19:08:57 INFO - 'tscrollx', 19:08:57 INFO - 'cart']}, 19:08:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'talos_options': ['--disable-e10s'], 19:08:57 INFO - 'tests': ['tp5o']}, 19:08:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'tests': ['tp5o']}, 19:08:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'talos_options': ['--disable-e10s', 19:08:57 INFO - '--xperf_path', 19:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:57 INFO - 'tests': ['tp5n']}, 19:08:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:57 INFO - 'talos_options': ['--xperf_path', 19:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:57 INFO - 'tests': ['tp5n']}}, 19:08:57 INFO - 'talos.zip': {'path': '', 19:08:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:57 INFO - Running post-action listener: _resource_record_post_action 19:08:57 INFO - ##### 19:08:57 INFO - ##### Running create-virtualenv step. 19:08:57 INFO - ##### 19:08:57 INFO - Running pre-action listener: _resource_record_pre_action 19:08:57 INFO - Running main action method: create_virtualenv 19:08:57 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:08:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:58 INFO - Using real prefix '/usr' 19:08:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:00 INFO - Installing pip.................done. 19:09:00 INFO - Return code: 0 19:09:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:09:00 INFO - Using env: {'DISPLAY': ':0', 19:09:00 INFO - 'HOME': '/home/cltbld', 19:09:00 INFO - 'LANG': 'en_US.UTF-8', 19:09:00 INFO - 'LANGUAGE': 'en_US:en', 19:09:00 INFO - 'LOGNAME': 'cltbld', 19:09:00 INFO - 'MAIL': '/var/mail/cltbld', 19:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:00 INFO - 'MOZ_NO_REMOTE': '1', 19:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:00 INFO - 'NO_EM_RESTART': '1', 19:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:00 INFO - 'PWD': '/builds/slave/test', 19:09:00 INFO - 'SHELL': '/bin/bash', 19:09:00 INFO - 'SHLVL': '1', 19:09:00 INFO - 'TERM': 'linux', 19:09:00 INFO - 'TMOUT': '86400', 19:09:00 INFO - 'USER': 'cltbld', 19:09:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:00 INFO - '_': '/tools/buildbot/bin/python'} 19:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:09:00 INFO - Cleaning up... 19:09:00 INFO - Return code: 0 19:09:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:09:00 INFO - Using env: {'DISPLAY': ':0', 19:09:00 INFO - 'HOME': '/home/cltbld', 19:09:00 INFO - 'LANG': 'en_US.UTF-8', 19:09:00 INFO - 'LANGUAGE': 'en_US:en', 19:09:00 INFO - 'LOGNAME': 'cltbld', 19:09:00 INFO - 'MAIL': '/var/mail/cltbld', 19:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:00 INFO - 'MOZ_NO_REMOTE': '1', 19:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:00 INFO - 'NO_EM_RESTART': '1', 19:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:00 INFO - 'PWD': '/builds/slave/test', 19:09:00 INFO - 'SHELL': '/bin/bash', 19:09:00 INFO - 'SHLVL': '1', 19:09:00 INFO - 'TERM': 'linux', 19:09:00 INFO - 'TMOUT': '86400', 19:09:00 INFO - 'USER': 'cltbld', 19:09:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:00 INFO - '_': '/tools/buildbot/bin/python'} 19:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:00 INFO - Downloading/unpacking psutil>=0.7.1 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:02 INFO - Installing collected packages: psutil 19:09:02 INFO - Running setup.py install for psutil 19:09:03 INFO - building 'psutil._psutil_linux' extension 19:09:03 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 19:09:03 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 19:09:03 INFO - building 'psutil._psutil_posix' extension 19:09:03 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 19:09:03 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 19:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:03 INFO - Successfully installed psutil 19:09:03 INFO - Cleaning up... 19:09:03 INFO - Return code: 0 19:09:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:09:03 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')]} 19:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:03 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')]} 19:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:03 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 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:03 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 19:09:03 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 19:09:03 INFO - Using env: {'DISPLAY': ':0', 19:09:03 INFO - 'HOME': '/home/cltbld', 19:09:03 INFO - 'LANG': 'en_US.UTF-8', 19:09:03 INFO - 'LANGUAGE': 'en_US:en', 19:09:03 INFO - 'LOGNAME': 'cltbld', 19:09:03 INFO - 'MAIL': '/var/mail/cltbld', 19:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:03 INFO - 'MOZ_NO_REMOTE': '1', 19:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:03 INFO - 'NO_EM_RESTART': '1', 19:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:03 INFO - 'PWD': '/builds/slave/test', 19:09:03 INFO - 'SHELL': '/bin/bash', 19:09:03 INFO - 'SHLVL': '1', 19:09:03 INFO - 'TERM': 'linux', 19:09:03 INFO - 'TMOUT': '86400', 19:09:03 INFO - 'USER': 'cltbld', 19:09:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:03 INFO - '_': '/tools/buildbot/bin/python'} 19:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:09:05 INFO - Installing collected packages: mozsystemmonitor 19:09:05 INFO - Running setup.py install for mozsystemmonitor 19:09:05 INFO - Successfully installed mozsystemmonitor 19:09:05 INFO - Cleaning up... 19:09:05 INFO - Return code: 0 19:09:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:09:05 INFO - Using env: {'DISPLAY': ':0', 19:09:05 INFO - 'HOME': '/home/cltbld', 19:09:05 INFO - 'LANG': 'en_US.UTF-8', 19:09:05 INFO - 'LANGUAGE': 'en_US:en', 19:09:05 INFO - 'LOGNAME': 'cltbld', 19:09:05 INFO - 'MAIL': '/var/mail/cltbld', 19:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:05 INFO - 'MOZ_NO_REMOTE': '1', 19:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:05 INFO - 'NO_EM_RESTART': '1', 19:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:05 INFO - 'PWD': '/builds/slave/test', 19:09:05 INFO - 'SHELL': '/bin/bash', 19:09:05 INFO - 'SHLVL': '1', 19:09:05 INFO - 'TERM': 'linux', 19:09:05 INFO - 'TMOUT': '86400', 19:09:05 INFO - 'USER': 'cltbld', 19:09:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:05 INFO - '_': '/tools/buildbot/bin/python'} 19:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:05 INFO - Downloading/unpacking blobuploader==1.2.4 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:08 INFO - Downloading docopt-0.6.1.tar.gz 19:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:08 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:08 INFO - Running setup.py install for blobuploader 19:09:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:08 INFO - Running setup.py install for requests 19:09:09 INFO - Running setup.py install for docopt 19:09:09 INFO - Successfully installed blobuploader requests docopt 19:09:09 INFO - Cleaning up... 19:09:09 INFO - Return code: 0 19:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:09:09 INFO - Using env: {'DISPLAY': ':0', 19:09:09 INFO - 'HOME': '/home/cltbld', 19:09:09 INFO - 'LANG': 'en_US.UTF-8', 19:09:09 INFO - 'LANGUAGE': 'en_US:en', 19:09:09 INFO - 'LOGNAME': 'cltbld', 19:09:09 INFO - 'MAIL': '/var/mail/cltbld', 19:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:09 INFO - 'MOZ_NO_REMOTE': '1', 19:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:09 INFO - 'NO_EM_RESTART': '1', 19:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:09 INFO - 'PWD': '/builds/slave/test', 19:09:09 INFO - 'SHELL': '/bin/bash', 19:09:09 INFO - 'SHLVL': '1', 19:09:09 INFO - 'TERM': 'linux', 19:09:09 INFO - 'TMOUT': '86400', 19:09:09 INFO - 'USER': 'cltbld', 19:09:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:09 INFO - '_': '/tools/buildbot/bin/python'} 19:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:09 INFO - Running setup.py (path:/tmp/pip-RK5upw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:09 INFO - Running setup.py (path:/tmp/pip-iEGCkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:09 INFO - Running setup.py (path:/tmp/pip-97dqfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:09 INFO - Running setup.py (path:/tmp/pip-UcQz0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:09 INFO - Running setup.py (path:/tmp/pip-ZVV96Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:09 INFO - Running setup.py (path:/tmp/pip-9tooFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:09 INFO - Running setup.py (path:/tmp/pip-Bp3P_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:09 INFO - Running setup.py (path:/tmp/pip-UL4JtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:09 INFO - Running setup.py (path:/tmp/pip-8cR26T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:10 INFO - Running setup.py (path:/tmp/pip-HP2Ta1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:10 INFO - Running setup.py (path:/tmp/pip-Z0GR_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:10 INFO - Running setup.py (path:/tmp/pip-fcDh05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:10 INFO - Running setup.py (path:/tmp/pip-jkCu84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:10 INFO - Running setup.py (path:/tmp/pip-LPddWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:10 INFO - Running setup.py (path:/tmp/pip-KDGKTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:10 INFO - Running setup.py (path:/tmp/pip-6YyCYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:10 INFO - Running setup.py (path:/tmp/pip-jU0Gqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:10 INFO - Running setup.py install for manifestparser 19:09:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:10 INFO - Running setup.py install for mozcrash 19:09:10 INFO - Running setup.py install for mozdebug 19:09:10 INFO - Running setup.py install for mozdevice 19:09:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for mozfile 19:09:11 INFO - Running setup.py install for mozhttpd 19:09:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for mozinfo 19:09:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for mozInstall 19:09:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for mozleak 19:09:11 INFO - Running setup.py install for mozlog 19:09:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for moznetwork 19:09:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for mozprocess 19:09:11 INFO - Running setup.py install for mozprofile 19:09:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:11 INFO - Running setup.py install for mozrunner 19:09:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:12 INFO - Running setup.py install for mozscreenshot 19:09:12 INFO - Running setup.py install for moztest 19:09:12 INFO - Running setup.py install for mozversion 19:09:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:12 INFO - Cleaning up... 19:09:12 INFO - Return code: 0 19:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:09:12 INFO - Using env: {'DISPLAY': ':0', 19:09:12 INFO - 'HOME': '/home/cltbld', 19:09:12 INFO - 'LANG': 'en_US.UTF-8', 19:09:12 INFO - 'LANGUAGE': 'en_US:en', 19:09:12 INFO - 'LOGNAME': 'cltbld', 19:09:12 INFO - 'MAIL': '/var/mail/cltbld', 19:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:12 INFO - 'MOZ_NO_REMOTE': '1', 19:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:12 INFO - 'NO_EM_RESTART': '1', 19:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:12 INFO - 'PWD': '/builds/slave/test', 19:09:12 INFO - 'SHELL': '/bin/bash', 19:09:12 INFO - 'SHLVL': '1', 19:09:12 INFO - 'TERM': 'linux', 19:09:12 INFO - 'TMOUT': '86400', 19:09:12 INFO - 'USER': 'cltbld', 19:09:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:12 INFO - '_': '/tools/buildbot/bin/python'} 19:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:12 INFO - Running setup.py (path:/tmp/pip-YdRIkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:12 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)) 19:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:12 INFO - Running setup.py (path:/tmp/pip-68Wd_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:12 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)) 19:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:12 INFO - Running setup.py (path:/tmp/pip-fNA3SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:12 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)) 19:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:12 INFO - Running setup.py (path:/tmp/pip-D9oYMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:12 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)) 19:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:12 INFO - Running setup.py (path:/tmp/pip-cp4RLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:13 INFO - Running setup.py (path:/tmp/pip-UCMzaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:13 INFO - Running setup.py (path:/tmp/pip-FLM9zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:13 INFO - Running setup.py (path:/tmp/pip-3yd40b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:13 INFO - Running setup.py (path:/tmp/pip-nNBdte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:13 INFO - Running setup.py (path:/tmp/pip-hFhc4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:13 INFO - Running setup.py (path:/tmp/pip-AyRCXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:13 INFO - Running setup.py (path:/tmp/pip-yAqlq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:13 INFO - Running setup.py (path:/tmp/pip-zBhbdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:13 INFO - Running setup.py (path:/tmp/pip-KWaYGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:13 INFO - Running setup.py (path:/tmp/pip-DKAdo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:13 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)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:13 INFO - Running setup.py (path:/tmp/pip-MNIz73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:13 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)) 19:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:13 INFO - Running setup.py (path:/tmp/pip-jxaFsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:13 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)) 19:09:13 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)) 19:09:13 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)) 19:09:13 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)) 19:09:13 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)) 19:09:13 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)) 19:09:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:15 INFO - Downloading blessings-1.6.tar.gz 19:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:09:15 INFO - Installing collected packages: blessings 19:09:15 INFO - Running setup.py install for blessings 19:09:16 INFO - Successfully installed blessings 19:09:16 INFO - Cleaning up... 19:09:16 INFO - Return code: 0 19:09:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:16 INFO - Reading from file tmpfile_stdout 19:09:16 INFO - Current package versions: 19:09:16 INFO - argparse == 1.2.1 19:09:16 INFO - blessings == 1.6 19:09:16 INFO - blobuploader == 1.2.4 19:09:16 INFO - docopt == 0.6.1 19:09:16 INFO - manifestparser == 1.1 19:09:16 INFO - mozInstall == 1.12 19:09:16 INFO - mozcrash == 0.17 19:09:16 INFO - mozdebug == 0.1 19:09:16 INFO - mozdevice == 0.48 19:09:16 INFO - mozfile == 1.2 19:09:16 INFO - mozhttpd == 0.7 19:09:16 INFO - mozinfo == 0.9 19:09:16 INFO - mozleak == 0.1 19:09:16 INFO - mozlog == 3.1 19:09:16 INFO - moznetwork == 0.27 19:09:16 INFO - mozprocess == 0.22 19:09:16 INFO - mozprofile == 0.28 19:09:16 INFO - mozrunner == 6.11 19:09:16 INFO - mozscreenshot == 0.1 19:09:16 INFO - mozsystemmonitor == 0.0 19:09:16 INFO - moztest == 0.7 19:09:16 INFO - mozversion == 1.4 19:09:16 INFO - psutil == 3.1.1 19:09:16 INFO - requests == 1.2.3 19:09:16 INFO - wsgiref == 0.1.2 19:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:09:16 INFO - Using env: {'DISPLAY': ':0', 19:09:16 INFO - 'HOME': '/home/cltbld', 19:09:16 INFO - 'LANG': 'en_US.UTF-8', 19:09:16 INFO - 'LANGUAGE': 'en_US:en', 19:09:16 INFO - 'LOGNAME': 'cltbld', 19:09:16 INFO - 'MAIL': '/var/mail/cltbld', 19:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:16 INFO - 'MOZ_NO_REMOTE': '1', 19:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:16 INFO - 'NO_EM_RESTART': '1', 19:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:16 INFO - 'PWD': '/builds/slave/test', 19:09:16 INFO - 'SHELL': '/bin/bash', 19:09:16 INFO - 'SHLVL': '1', 19:09:16 INFO - 'TERM': 'linux', 19:09:16 INFO - 'TMOUT': '86400', 19:09:16 INFO - 'USER': 'cltbld', 19:09:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:16 INFO - '_': '/tools/buildbot/bin/python'} 19:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:09:16 INFO - Cleaning up... 19:09:16 INFO - Return code: 0 19:09:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:09:16 INFO - Using env: {'DISPLAY': ':0', 19:09:16 INFO - 'HOME': '/home/cltbld', 19:09:16 INFO - 'LANG': 'en_US.UTF-8', 19:09:16 INFO - 'LANGUAGE': 'en_US:en', 19:09:16 INFO - 'LOGNAME': 'cltbld', 19:09:16 INFO - 'MAIL': '/var/mail/cltbld', 19:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:16 INFO - 'MOZ_NO_REMOTE': '1', 19:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:16 INFO - 'NO_EM_RESTART': '1', 19:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:16 INFO - 'PWD': '/builds/slave/test', 19:09:16 INFO - 'SHELL': '/bin/bash', 19:09:16 INFO - 'SHLVL': '1', 19:09:16 INFO - 'TERM': 'linux', 19:09:16 INFO - 'TMOUT': '86400', 19:09:16 INFO - 'USER': 'cltbld', 19:09:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:16 INFO - '_': '/tools/buildbot/bin/python'} 19:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:16 INFO - Downloading/unpacking jsonschema 19:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:18 INFO - Downloading/unpacking functools32 (from jsonschema) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:18 INFO - warning: no files found matching '*.txt' 19:09:18 INFO - no previously-included directories found matching 'build' 19:09:18 INFO - no previously-included directories found matching 'dist' 19:09:18 INFO - no previously-included directories found matching '.git*' 19:09:18 INFO - Installing collected packages: jsonschema, functools32 19:09:18 INFO - Running setup.py install for functools32 19:09:19 INFO - warning: no files found matching '*.txt' 19:09:19 INFO - no previously-included directories found matching 'build' 19:09:19 INFO - no previously-included directories found matching 'dist' 19:09:19 INFO - no previously-included directories found matching '.git*' 19:09:19 INFO - Successfully installed jsonschema functools32 19:09:19 INFO - Cleaning up... 19:09:19 INFO - Return code: 0 19:09:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8caeccbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, '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': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', '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 19:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:09:19 INFO - Using env: {'DISPLAY': ':0', 19:09:19 INFO - 'HOME': '/home/cltbld', 19:09:19 INFO - 'LANG': 'en_US.UTF-8', 19:09:19 INFO - 'LANGUAGE': 'en_US:en', 19:09:19 INFO - 'LOGNAME': 'cltbld', 19:09:19 INFO - 'MAIL': '/var/mail/cltbld', 19:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:19 INFO - 'MOZ_NO_REMOTE': '1', 19:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:19 INFO - 'NO_EM_RESTART': '1', 19:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:19 INFO - 'PWD': '/builds/slave/test', 19:09:19 INFO - 'SHELL': '/bin/bash', 19:09:19 INFO - 'SHLVL': '1', 19:09:19 INFO - 'TERM': 'linux', 19:09:19 INFO - 'TMOUT': '86400', 19:09:19 INFO - 'USER': 'cltbld', 19:09:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:19 INFO - '_': '/tools/buildbot/bin/python'} 19:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:19 INFO - Downloading/unpacking flake8 19:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:09:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:09:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09: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 19:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:21 INFO - no previously-included directories found matching 'docs/_build' 19:09:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:09:21 INFO - Running setup.py install for pep8 19:09:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:09:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:09:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:09:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:09:22 INFO - no previously-included directories found matching 'docs/_build' 19:09:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:09:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:09:22 INFO - Cleaning up... 19:09:22 INFO - Return code: 0 19:09:22 INFO - Running post-action listener: _resource_record_post_action 19:09:22 INFO - Running post-action listener: _start_resource_monitoring 19:09:22 INFO - Starting resource monitoring. 19:09:22 INFO - ##### 19:09:22 INFO - ##### Running install step. 19:09:22 INFO - ##### 19:09:22 INFO - Running pre-action listener: _resource_record_pre_action 19:09:22 INFO - Running main action method: install 19:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:09:22 INFO - Reading from file tmpfile_stdout 19:09:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:09:22 INFO - Reading from file tmpfile_stdout 19:09:22 INFO - Output received: 19:09:22 INFO - Usage: mozinstall [options] installer 19:09:22 INFO - Options: 19:09:22 INFO - -h, --help show this help message and exit 19:09:22 INFO - -d DEST, --destination=DEST 19:09:22 INFO - Directory to install application into. [default: 19:09:22 INFO - "/builds/slave/test"] 19:09:22 INFO - --app=APP Application being installed. [default: firefox] 19:09:22 INFO - mkdir: /builds/slave/test/build/application 19:09:22 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'] 19:09:22 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 19:09:38 INFO - Reading from file tmpfile_stdout 19:09:38 INFO - Output received: 19:09:38 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:38 INFO - Running post-action listener: _resource_record_post_action 19:09:38 INFO - ##### 19:09:38 INFO - ##### Running run-tests step. 19:09:38 INFO - ##### 19:09:38 INFO - Running pre-action listener: _resource_record_pre_action 19:09:38 INFO - Running main action method: run_tests 19:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:38 INFO - Python 2.7.3 19:09:38 INFO - Return code: 0 19:09:38 INFO - grabbing minidump binary from tooltool 19:09:38 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')]} 19:09:38 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 0x23cf410>, '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 0x23d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:38 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 19:09:38 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 19:09:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:38 INFO - Return code: 0 19:09:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:09:39 INFO - Return code: 0 19:09:39 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/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 19:09:39 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/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 19:09:39 INFO - Using env: {'DISPLAY': ':0', 19:09:39 INFO - 'HOME': '/home/cltbld', 19:09:39 INFO - 'LANG': 'en_US.UTF-8', 19:09:39 INFO - 'LANGUAGE': 'en_US:en', 19:09:39 INFO - 'LOGNAME': 'cltbld', 19:09:39 INFO - 'MAIL': '/var/mail/cltbld', 19:09:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:39 INFO - 'MOZ_NO_REMOTE': '1', 19:09:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:39 INFO - 'NO_EM_RESTART': '1', 19:09:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:39 INFO - 'PWD': '/builds/slave/test', 19:09:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:39 INFO - 'SHELL': '/bin/bash', 19:09:39 INFO - 'SHLVL': '1', 19:09:39 INFO - 'TERM': 'linux', 19:09:39 INFO - 'TMOUT': '86400', 19:09:39 INFO - 'USER': 'cltbld', 19:09:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417', 19:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:39 INFO - '_': '/tools/buildbot/bin/python'} 19:09:39 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/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 19:09:39 INFO - mozversion application_buildid: 20160522162928 19:09:39 INFO - mozversion application_changeset: 40994e384c130872bb8430268780726d4416cf40 19:09:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:09:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:39 INFO - mozversion application_name: Firefox 19:09:39 INFO - mozversion application_remotingname: firefox-dev 19:09:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:09:39 INFO - mozversion application_vendor: Mozilla 19:09:39 INFO - mozversion application_version: 48.0a2 19:09:39 INFO - mozversion platform_buildid: 20160522162928 19:09:39 INFO - mozversion platform_changeset: 40994e384c130872bb8430268780726d4416cf40 19:09:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:09:39 INFO - mozversion platform_version: 48.0a2 19:09:39 INFO - using testdate: 1463969379 19:09:39 INFO - actual date: 1463969379 19:09:39 INFO - starting webserver on 'localhost:59685' 19:09:39 INFO - SUITE-START | Running 2 tests 19:09:39 INFO - TEST-START | dromaeo_css 19:09:39 INFO - operating with platform_type : linux_ 19:09:39 INFO - Initialising browser for dromaeo_css test... 19:09:39 INFO - TEST-INFO | started process 7115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLg5hln/profile http://localhost:59685/getInfo.html) 19:09:43 INFO - PROCESS | 7115 | 19:09:43 INFO - PROCESS | 7115 | (process:7192): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:43 INFO - PROCESS | 7115 | __metrics Screen width/height:1600/1200 19:09:43 INFO - PROCESS | 7115 | colorDepth:24 19:09:43 INFO - PROCESS | 7115 | Browser inner width/height: 1024/697 19:09:43 INFO - PROCESS | 7115 | __metrics 19:09:44 ERROR - PROCESS | 7115 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:09:45 INFO - TEST-INFO | 7115: exit 0 19:09:45 INFO - Browser initialized. 19:09:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:45 INFO - TEST-INFO | started process 7243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLg5hln/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:47 INFO - PROCESS | 7243 | 19:09:47 INFO - PROCESS | 7243 | (process:7311): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:09:57 INFO - PROCESS | 7243 | RSS: Main: 151871488 19:09:57 INFO - PROCESS | 7243 | 19:10:46 INFO - PROCESS | 7243 | 1463969446775 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] 19:12:54 INFO - PROCESS | 7243 | Cycle 1(1): loaded http://localhost:59685/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59685/tests/dromaeo/cssquery-ext.html) 19:12:55 INFO - PROCESS | 7243 | RSS: Main: 155299840 19:12:55 INFO - PROCESS | 7243 | 19:15:57 INFO - PROCESS | 7243 | Cycle 1(1): loaded http://localhost:59685/tests/dromaeo/cssquery-ext.html (next: http://localhost:59685/tests/dromaeo/cssquery-jquery.html) 19:15:57 INFO - PROCESS | 7243 | RSS: Main: 153292800 19:15:57 INFO - PROCESS | 7243 | 19:18:59 INFO - PROCESS | 7243 | Cycle 1(1): loaded http://localhost:59685/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59685/tests/dromaeo/cssquery-mootools.html) 19:18:59 INFO - PROCESS | 7243 | RSS: Main: 153296896 19:18:59 INFO - PROCESS | 7243 | 19:22:01 INFO - PROCESS | 7243 | Cycle 1(1): loaded http://localhost:59685/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59685/tests/dromaeo/cssquery-prototype.html) 19:22:02 INFO - PROCESS | 7243 | RSS: Main: 152801280 19:22:02 INFO - PROCESS | 7243 | 19:25:04 INFO - PROCESS | 7243 | Cycle 1(1): loaded http://localhost:59685/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59685/tests/dromaeo/cssquery-yui.html) 19:25:05 INFO - PROCESS | 7243 | RSS: Main: 154370048 19:25:05 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | Cycle 1(1): loaded http://localhost:59685/tests/dromaeo/cssquery-yui.html (next: http://localhost:59685/tests/dromaeo/cssquery-dojo.html) 19:28:07 INFO - PROCESS | 7243 | RSS: Main: 155770880 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | __start_tp_report 19:28:07 INFO - PROCESS | 7243 | _x_x_mozilla_page_load 19:28:07 INFO - PROCESS | 7243 | _x_x_mozilla_page_load_details 19:28:07 INFO - PROCESS | 7243 | |i|pagename|runs| 19:28:07 INFO - PROCESS | 7243 | |0;dojo.html;3392.508086327482;3444.07010107271;3470.3926812807767;3476.8609255629776;3507.7719948203367;5656;5659.17941898425;5678.57410694198;5685.175649530821;5725.942740572593;5663.207150998864;5688.146777983305;5689.146628005801;5704.942950570493;5738.31140263168;5141.357330333699;5204.375474943012;5226.608004399666;5236.371635403757;5262.842114736545;5111.08000559899;5221.973890130544;5226.346706661668;5341.092014357569;5391.757370918299;5167.405748338932;5189.091908915943;5248.343957005374;5255.894882102356;5259.868503287429;5157.252198431206;5160.612954028463;5161.587073034186;5175.585953123741;5197.688138711689;4925.113479573675;5043.87390315245;5061.974690126563;5091.032703786306;5155.072087024334;5482.342118945752;5543.362513310981;5569.888602227933;5580.051391263495;5608.747606357723;6069.180660610849;6095.481884039862;6102.145699602059;6126.846828829271;6152.938470615326;6026.457618814327;6073.696315184267;6144.262688477412;6148.108524264001;6168.537359697995;5704.515116215127;5713.657180569137;5719.14212868069;5719.914201286942;5724.084146536534;6150.323464418911;6220.471259942865;6228.22147231596;6245.188125543741;6250.718717657716;5889.116632505158;5947.31605865331;5975.103734439869;6037.215162028908;6094.634321940698;6115.602485838406;6121.938780612137;6126.969365153235;6127.356627554132;6129.325774164839;6032.668203248863;6050.062240352752;6084.239470066242;6100.69496525172;6112.113743507167;5843.620164689367;5896.64620122794;6002.279726432856;6003.579749417586;6049.122877182784;4499.797509112098;4522.8643140705835;4525.185466616041;4542.0915816836105;4549.27211646135;3989.7007724420782;4066.2274167908595;4073.877783666495;4089.9386509202386;4095.4266402703647;5724.427557244242;5767.567432442584;5794.797182098607;5880.470757631748;5897.705114744245;6192.916239658041;6194;6203.441690247809;6222.12890195373;6222.937770622327;5671.376148623648;5758.3665796762325;5855.180274761537;5892.263467066617;5932.58471906971;5016.573591244785;5035.370578677665;5073.847784566469;5077.1876499759865;5107.897842043139;6182.381761823782;6215.378462153839;6227.595206311576;6269.937300627026;6287.842803929847;6031.547633927561;6075.665838378932;6077.2099627049965;6078.118672792332;6078.848028799315;6182.7217775201125;6271.404216599416;6393.520485963664;6404.871902561829;6412.198475190601;5967.791127310524;6002.279726432856;6003.669798161143;6008.407771940352;6048;6007.219061521974;6089.939100608937;6091.634501929899;6110.633361998294;6119.2350956130485;5963.373845746134;5986.4013598639785;6011.819645410645;6048.0625503047095;6077.331493535796;5899.528037757055;5930.406959304035;5936.495397891227;5947.405259474018;5950.256217972754;5756.769729210785;5797.275340582427;5824.650520968756;5837.357890632112;5843.415658434123;5991.370906054802;5991.64050156992;6019.157317975574;6019.6990150493175;6036.0644100164545;5829.854253643693;5867.090600956859;5869.207656966255;5885.440883116097;5893.499052580407 19:28:07 INFO - PROCESS | 7243 | |1;ext.html;666.9099671544342;677.6611694152925;682.1064405628626;701.8806802843516;771.6720393832627;38794.8060259699;39645.207095858066;39750.80124599373;40020.59979400209;40023.19953600926;39956.40065399014;40499.79750101253;40622.79688601553;40769;40974.18051638966;8698.39111262212;8873.423227490224;8873.822523549525;8877.289816814638;8891.777705557348;8656.091110433408;8849.33629977751;8958.820823583525;9044.638214471413;9067.183953444188;9047.411918225294;9108.954455227748;9122.407043542182;9144.314176436794;9164;8985.955070224672;9030.051844556325;9069.047749986255;9096.044915283932;9105.544722763836;8868.068852770431;9014.504202268872;9023.96224434192;9049.276057915351;9072.183503484717;41623.167536649096;42071;42125.36811947823;42127;42360;3037.5595538646994;3675.46705727668;3752.8498860045565;4018.397240413932;4465.017696106851;28316.29209269764;28356.858215708995;28365;28392.29019274514;29029.854850725824;4217.568064570613;4222.767747773902;4238.724482908601;4261.296886013804;4300.505441874193;192384;193720.03139984352;193898;194472;195148;36798.63201367952;38476;38656;39076.41385379222;39529.60470395317;36844.71043513464;37090.629093709256;37289.254214916094;37322.62677373246;37397.43903841444;16203.270852811651;16484;16491.257893394584;16512.669746605;16514.42199523011;14290.356933937997;14296.285185740671;14321;14389.856101439062;14454.132752034911;9107.590158442887;9354.345195836362;9451.716448506555;9452.10205030521;9483.241340692728;3590.7666001710327;3615.1504396466808;3658.817059147032;3672.394054980898;3716.758410703296;1145.9885401145882;1149.3965668024186;1157.6179860645966;1168.6435637130587;1183.2841131115724;33497.33005339879;33536;33681.663183367855;34326.313473730384;34335.65664343325;1242.6085782978332;1249.3815561297215;1252.4551819958347;1276.3809552367095;1320.392619395089;17349.653006939792;17751.73372399415;17810.465686029438;17837.46487605374;17931.103444827706;547813;648131;659341;667224;880681;57259.42740572541;57914.420855791745;58314;58501;58510.414895850496;1520.665453600206;1547.752359622455;1548.4657793061376;1551.697419003306;1563.4996801023563;30792.53811192789;31509.527357089202;31745.365092698477;31922.52116218305;32373.51439728453;54284.45715542952;61362.38637613745;63107;63125;63205;510997;514615;517393;517602;518135;47728;47970.520294798;48804;49000;49028;52604.736976314874;52630.47369526256;52895.206571900686;53247;53575.73212133914;43934.56065439433;44714.3292850601;44815.775921120185;45203.77398112988;45254.321185182904;43167.78416107899;43835.12329753323;44415.11169776651;45222.54777452183;45464.54535454736;44968.32547511724;45025.77487112543;45080.323795142445;45670.54329456663;45757.54242457533;34766.47850282298;35147;36043.81978090093;36409.63590364168;36728.449073264455;28987.420251594427;29006.854965725037;29053.692583833355;29075.127746167647;29292.853535732185 19:28:07 INFO - PROCESS | 7243 | |2;jquery.html;424.8937765558611;436.65504251641204;437.59569318911446;442.4933451198377;446.95306992765757;18401.723974140397;18885.71671424928;19171.808281917176;19206.711899321486;19713.11290991905;17875.821241787577;17906.462806115804;18013.639727205482;18072.909635451804;18088.63822723548;5498.862528436801;5568.276124103881;5580.358258800229;5740;5994.13085102662;5823.82528524145;5888.882222355551;5894.705264736767;5917.704114794265;5918.201042859202;5622.072358060936;5821.592488525784;5822.796202132926;5870;5874.412558744134;5787.739551720161;5814.5057670097885;5815.098659707752;5817.0983497557945;5886.852828679296;5104.464031276737;5273.9736301318635;5284.524392804666;5314.388845282803;5318.973405132988;23137.53724925492;23198.65202021971;23220.535589288287;23645.76354236453;23813.404664883517;2498.3504288884837;2663.961055188459;2861.1702606244166;2966.61434013579;3175.555422240888;14432.78350824728;14662.926685366612;14939.626509337244;15093.094414335064;15332.693346133126;1881.9811801881942;1961.0586918279305;2005.8495612829097;2006.7792542820278;2040.8571400002006;74692;74743;75593;76039.23960760432;76176.61911690405;11045;11156.553737850558;11390.145739069603;11427.314361138358;11625.767484650429;16023.919880400523;16046.679066418606;16092.195390230441;16100.67798644044;16200.675986480204;8566.571671416405;8603.52680602573;8927.553622318857;9016.09839016093;9037.322200834964;8400.327973762085;8422.705205317907;8561.058283588925;8641.567921603895;8676.783080422914;6927.099477067949;7014.964925175342;7116.359527642537;7129.89305160423;7241.8551628967125;2003.4290227285153;2012.45663670811;2024.7064175694443;2037.6026674798568;2086.228095604636;1074.4090750087578;1087.5541028178568;1098.3135540287321;1176.670532250971;1183.237141275115;16868.746968795476;17342.132893355283;18399.8960062394;18637;19757;1102.7904698107334;1110.6223883879359;1120.960766373173;1123.3989815448697;1140.0099651220728;11207.943960280147;11403.771924561463;11437.885621143849;11454.370009649549;11517.424128793527;602232;606520;612778;617988;622078;60690.393096069354;77689;79377;81009;83244.16755832486;1148.7759886821989;1153.8384626152344;1163.8196079607844;1190.3869507203797;1190.5475919150667;17888.642227155644;17893.68144338656;18068;18142.909285453487;18290.725639115157;37500.43749343707;37616.62383376131;38128.809355953046;39691.20617587574;39804.40293395543;52622.47377526176;52628.210576842146;52724;53195;53454.19818702645;8472.957635212031;8529.029679224692;8682.348823838363;8706.738797836075;8736.082711315474;11792.646220613395;12755.61733148007;12846.229226246081;12916.935415322863;12973.416196271002;11670.358130302575;11694.356810375511;11714.76570468603;11864.584739534075;12010.099242557018;11026.724331891766;11355.091592672401;11355.205135640756;11526.250793698382;11557.826632600685;11542.59600913964;11825.408729563316;11879.76240475203;11939.880601194225;12022;8408.495490270603;8493.193146651058;8618.827623447622;8664;8676.08901065379;11526.366049867338;11528.250663706833;11548.133889958119;11609.187356885275;11763.529458821551 19:28:07 INFO - PROCESS | 7243 | |3;mootools.html;1567.7021365940466;1568.435363269223;1779.9110044497772;1835.0824587706147;1870.6913359295718;7439.665215065322;8033.638486268117;8074;8258.2154695304;8278.793030174249;7930.722424715136;7944.443888927763;8034.638441270142;8040.437169398145;8088.636011379487;2385.6660067590506;2415.52897185049;2415.9516809663796;2418.3349578865864;2418.673479080328;2359.6932398788217;2372.063035101134;2388.0567175965484;2394.8563086214795;2396.6884305040408;2379.9048038078454;2398.3164798032562;2411.3489357873364;2433.853968761871;2440.2191298784396;2311.872846993415;2324.500232450023;2337.2403968710237;2352.3413444235644;2390.964135537968;2370.3007612754277;2381.7022872140983;2402.0752010475917;2403.663487111806;2421.685180926486;8271.21423464776;8315.83368332636;8322.042965059036;8323.375746818952;8327.708530201475;5278.419373868871;5331.747039445727;5361.544268737123;5392.299001129867;5392.78428862845;3390.8640605397222;3460.636633153533;3482.112061424346;3533.7173026158102;3538.1331573764337;1120.803859324615;1156.121347775688;1157.6874243954085;1158.7798318319492;1173.9413029348584;11804.586839460577;11810.88189118115;11857.822132668018;11877.049836013099;11879.34663593502;4469.4636643602325;4494.955050449454;4511.88720281989;4545.340925565841;4547.1815073287125;10127.240456965757;10160.593576257015;10162.542685579167;10179.03299186576;10191;5154.329937108227;5166.483351664803;5187.170052791535;5204.115300398941;5210.6613070150315;4333.371661109121;4701.882452938636;4773.880652983703;4821.9035619287415;4859.24681674334;4059.9797001014804;4193.287141186006;4270.786460677016;4276.72201306914;4284.571542845691;1334.6329759316266;1357.1178733823094;1362.9931850340686;1375.0580852116332;1375.931203439824;942.4675058591873;954.5418199264392;1011.4538149399389;1019.2966852871494;1021.1626466297565;5572.777088916398;5585.832425027255;5625.6905870176715;5681.545476361881;5689.715514224272;1122.747381839096;1134.0813940708053;1149.1898211760688;1161.361251311775;1186.3297237061033;3978.1645854370327;4065.4511640928094;4106.630403263721;4134.979325103415;4141.64795992338;9651.131398174199;10105.494725263854;10339;10349.482525873827;10351.896481035245;10040.748981275527;10075.244356673278;10104.898951010397;10122.898771012196;10135.797284054277;7899.526028438312;7906.407019473562;7961.562114083781;8049.034115906012;8100.432969692183;5568.972155139199;5632.070708333079;5693;5725.255716756795;5756.625819321731;8802.119788021402;8996.28029757631;9051.366404351633;9052.818943621223;9167.954160229156;9134.36059475857;9149.679761208326;9174.724758257264;9240.399374040666;9260.30547708938;6925.549839260432;7301.452391070585;7389.445791565547;7410.592417417094;7592.8481430372185;7935.285824275843;7966.960165199137;7974.481658692166;7996.24035716606;8040.718574849852;6908.3437073477935;6929;6932.688029038604;6978.197507286727;7017.543859649107;7088.432925365855;7093.255208203064;7112.35988761014;7218.819529511804;7232.493725439379;6663.233728121328;6742.190937087581;6768.120144381396;6789.15135608049;6797.320267973163;4998.3252260945765;5008.223725322581;5017;5018.749062546785;5119.46245644202;4936.333594964633;4970.25446183061;4970.428400733962;5047.4952504749235;5056.191009438472 19:28:07 INFO - PROCESS | 7243 | |4;prototype.html;359.5936591651433;361.4253337193861;371.94048952167657;377.3377722097718;380.86098574020474;6637.369449902258;6652;6665.433438157756;6669.666516674159;6678.632675202862;6531.804045878619;6557.1147895034155;6558.5899031708295;6560.245571759249;6569.310222426648;4766.73782941938;4885.316055752198;4950.6287028472825;4979.651424400294;4981.750912454381;4951.752412379385;4962.1812400953795;4964.60283177345;4969.652124351297;4980.078685443204;4928.33467481889;4934.777934992934;4936.136176169174;4940.382452193476;4943.30793688882;4936.037472692827;4936.136176169174;4942.876428089308;4960.751962401901;5015.598752099823;4361.6074553290355;4390.2317094508335;4391.967887546424;4397.538258482845;4399.252127138394;6245.7501699931945;6314.463270622003;6323.778667746653;6397.168368112162;6404.039394090877;5823.330317013513;5838;5846.356900740915;5850.151727999459;5863.9706801466145;6902.516823822334;6944.270851560564;6945.201301850301;6949.791506254821;6951.548149370275;4840.249761287007;4861.951380486185;4866.3673722416215;4868.002059577778;4876.073546026244;7129.714811407537;7225.747098851515;7294.234105418907;7301.817454563626;7302.342789148949;4971.577415919615;5006;5008.449070602231;5013.949860501421;5019.799208031711;5043.873903152377;5069.771860266297;5076.670016448919;5079.923801142986;5080.390353157571;5829.125631155276;5838.795642152504;5841.415858414124;5841.795537156179;5846.473817356458;6932.688029038705;6968.79093627192;6977.755778547727;6989.545679530815;7012.263712310236;1778.0309731196528;1821.5446138465384;1821.5901422179904;1822.599028213791;1825.7078867381156;1121.9158563107799;1158.0561842098662;1159.2464897816487;1160.1241062997383;1196.5692350753723;6551.508636852255;6616.470682345401;6694.364035416627;6706.429953454011;6713.56361836479;7072.257412971667;7187.460940429489;7190.8202294942;7200.711971521186;7202.243764404767;6783.559068660521;6825.35159159879;6855.040294358794;6859.07402500666;6865.176178858469;3923.6468717815533;3969.3053715599654;3969.920601587952;3970.861019864291;3980.7412518186807;7584.317411432998;7587.317141457295;7594.088709354913;7609.505382150142;7617.466777325645;7298.452616053817;7423.220561840929;7466.85066298671;7489.925100749032;7493.70025198986;7498.550086994798;7544.47188696786;7577.810554736176;7603.847923041508;7612.467127301035;7287.198408174991;7348.816279592839;7350.375218106307;7355.301246381585;7364.226756190523;7184.922261660584;7215;7224.096987876515;7227.241139680258;7237.203907570269;7417.147028091838;7556.924430755622;7593.544387336557;7604.505707129019;7609.809754756176;5067.77195026232;5088.363954505687;5119.897602047864;5122.103631864484;5125.974370128126;7248.818779530554;7249.746258880914;7250.709971601077;7255.854882902418;7267.963660181877;7014.40377567892;7016.614086225307;7042.823929401806;7050.682719277543;7062.964685176541;6922.480813938874;7005.614691192033;7034.085568876218;7103.431725462054;7108;6923.099997000358;6959.652017399008;6967.477439192182;6968.512204145661;6971.442284617117;7100.4319654428555;7104.928950710633;7124.928750712426;7133.251008644018;7143.928560714534;6950.270221626656;6956.40870526011;6958.826029349104;6964.129483814523;6966.233714291525 19:28:07 INFO - PROCESS | 7243 | |5;yui.html;904.9140331668493;913.4199783137706;921.1065266691311;925.9074092590739;947.5262368815593;14857.257137143153;15059.774103388458;15140.621484462894;15152;15182.240887955599;14202.218877961734;14210.289485525735;14227.928860355709;14246.786298205509;14314.856851431483;729.6388287797548;873.2184694698241;889.235257678396;897.3539051882667;901.6078006067381;876.4960147914975;885.6324625280533;891.1667590802621;893.1158153428092;894.7763059235191;934.8924873639551;937.2221056523103;941.4915945389481;945.1682519382933;946.3044662173297;931.483026920059;932.9533523323806;939.9953000234989;940;942.8727121838601;686.3342557719054;686.7767975408012;687.4363022321699;688.7933619914056;698.4063545985871;13736.587902362946;13840.861591384059;13855.722885542333;13867;13935.372908219155;15244.618884527865;15422.768658470131;15438.614034649112;15560.37758489659;15564.455244066403;11857.347845868473;11922.880771192264;11997.280163190237;12158.270503769802;12254.693632659255;4019.658329042035;4035.4955630546183;4088.7751173685438;4093.1199792044554;4193.20329137466;55737.72131139359;55860;56202.71898640521;57327;57853.42146578564;11941.761164776655;11954.880451195551;12126.575569855013;12245.571405000783;12266;20304.289349872684;21834.89082554577;21847.235346762787;21851.890740546194;21882.12471501122;8392.916070839214;8512.148785121562;8600.182982616641;8930.419522731001;8939.597718102701;4870.537298956593;4922.114019476457;4977.352944117314;4985;4992.650514463952;3818.3317919364;3850.614938506183;3874.4575759393706;3879.243547508209;3882.8835134946;675.4157653629575;681.877262092828;687.1101923009714;688.7795905310253;697.6407150317591;702.224042433104;778.8559116563454;806.5684858600621;806.6732973145886;815.2540425510709;9880.851787223197;10016.899831001596;10058.698239052841;10099.192064634812;10370.429626370471;733.2044731466312;765.7664412354285;771.3366504805863;787.8188016756063;822.1408627983772;4507.729536227836;4511.187986162522;4511.368408422823;4527.230370836965;4603.079384123189;62977.05534416987;63258.36741632525;65319.67340163269;67489.32510674928;67634.66182669056;55043.44956550383;55500.44499555034;55640.443595564335;56001;57420.42579574235;48888.26667599989;50024.24963625549;53571.46428535665;54332.72833635886;54574;9497.418691271549;9615.51922403863;10206.218463931642;10214.233932454947;10222.355468944948;39191.60808391879;39371;39551.20897581975;39791.40312895251;41097.58902410937;47371.76314118407;49661.75169124276;50296.74851625718;50516.49483505118;50967.2354914684;12408.131430800118;12550.686232844251;12880.018334545583;12914.547990820276;13016.674583135118;14019.649508762363;14465.49370772018;14469.710605788036;14631.92684036573;15798.76301855496;13627.79558306646;13910.721785564434;14645.560633181021;14651.12093274407;14659.120452772868;13404.396802143732;13578.049536532742;13772.931135344259;14010;14468;12817.551385701456;12849.486020559072;13177.934110329386;13216.801747973595;13442.596722098353;11030.944845275722;11090.112790976542;11239.943800280946;11658.12564057716;11725.061995040547;10738.570457181626;11217.13263541799;11324.547018119512;11366.829497557377;11459.31244125355 19:28:07 INFO - PROCESS | 7243 | __end_tp_report 19:28:07 INFO - PROCESS | 7243 | __start_cc_report 19:28:07 INFO - PROCESS | 7243 | _x_x_mozilla_cycle_collect,329 19:28:07 INFO - PROCESS | 7243 | __end_cc_report 19:28:07 INFO - PROCESS | 7243 | __startTimestamp1463970487705__endTimestamp 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | ------- Summary: start ------- 19:28:07 INFO - PROCESS | 7243 | Number of tests: 6 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | [#0] dojo.html Cycles:165 Average:5651.09 Median:5889.12 stddev:643.33 (10.9%) stddev-sans-first:620.43 19:28:07 INFO - PROCESS | 7243 | Values: 3392.5 3444.1 3470.4 3476.9 3507.8 5656.0 5659.2 5678.6 5685.2 5725.9 5663.2 5688.1 5689.1 5704.9 5738.3 5141.4 5204.4 5226.6 5236.4 5262.8 5111.1 5222.0 5226.3 5341.1 5391.8 5167.4 5189.1 5248.3 5255.9 5259.9 5157.3 5160.6 5161.6 5175.6 5197.7 4925.1 5043.9 5062.0 5091.0 5155.1 5482.3 5543.4 5569.9 5580.1 5608.7 6069.2 6095.5 6102.1 6126.8 6152.9 6026.5 6073.7 6144.3 6148.1 6168.5 5704.5 5713.7 5719.1 5719.9 5724.1 6150.3 6220.5 6228.2 6245.2 6250.7 5889.1 5947.3 5975.1 6037.2 6094.6 6115.6 6121.9 6127.0 6127.4 6129.3 6032.7 6050.1 6084.2 6100.7 6112.1 5843.6 5896.6 6002.3 6003.6 6049.1 4499.8 4522.9 4525.2 4542.1 4549.3 3989.7 4066.2 4073.9 4089.9 4095.4 5724.4 5767.6 5794.8 5880.5 5897.7 6192.9 6194.0 6203.4 6222.1 6222.9 5671.4 5758.4 5855.2 5892.3 5932.6 5016.6 5035.4 5073.8 5077.2 5107.9 6182.4 6215.4 6227.6 6269.9 6287.8 6031.5 6075.7 6077.2 6078.1 6078.8 6182.7 6271.4 6393.5 6404.9 6412.2 5967.8 6002.3 6003.7 6008.4 6048.0 6007.2 6089.9 6091.6 6110.6 6119.2 5963.4 5986.4 6011.8 6048.1 6077.3 5899.5 5930.4 5936.5 5947.4 5950.3 5756.8 5797.3 5824.7 5837.4 5843.4 5991.4 5991.6 6019.2 6019.7 6036.1 5829.9 5867.1 5869.2 5885.4 5893.5 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | [#1] ext.html Cycles:180 Average:61709.39 Median:42098.18 stddev:137235.64 (326.0%) stddev-sans-first:137544.09 19:28:07 INFO - PROCESS | 7243 | Values: 666.9 677.7 682.1 701.9 771.7 38794.8 39645.2 39750.8 40020.6 40023.2 39956.4 40499.8 40622.8 40769.0 40974.2 8698.4 8873.4 8873.8 8877.3 8891.8 8656.1 8849.3 8958.8 9044.6 9067.2 9047.4 9109.0 9122.4 9144.3 9164.0 8986.0 9030.1 9069.0 9096.0 9105.5 8868.1 9014.5 9024.0 9049.3 9072.2 41623.2 42071.0 42125.4 42127.0 42360.0 3037.6 3675.5 3752.8 4018.4 4465.0 28316.3 28356.9 28365.0 28392.3 29029.9 4217.6 4222.8 4238.7 4261.3 4300.5 192384.0 193720.0 193898.0 194472.0 195148.0 36798.6 38476.0 38656.0 39076.4 39529.6 36844.7 37090.6 37289.3 37322.6 37397.4 16203.3 16484.0 16491.3 16512.7 16514.4 14290.4 14296.3 14321.0 14389.9 14454.1 9107.6 9354.3 9451.7 9452.1 9483.2 3590.8 3615.2 3658.8 3672.4 3716.8 1146.0 1149.4 1157.6 1168.6 1183.3 33497.3 33536.0 33681.7 34326.3 34335.7 1242.6 1249.4 1252.5 1276.4 1320.4 17349.7 17751.7 17810.5 17837.5 17931.1 547813.0 648131.0 659341.0 667224.0 880681.0 57259.4 57914.4 58314.0 58501.0 58510.4 1520.7 1547.8 1548.5 1551.7 1563.5 30792.5 31509.5 31745.4 31922.5 32373.5 54284.5 61362.4 63107.0 63125.0 63205.0 510997.0 514615.0 517393.0 517602.0 518135.0 47728.0 47970.5 48804.0 49000.0 49028.0 52604.7 52630.5 52895.2 53247.0 53575.7 43934.6 44714.3 44815.8 45203.8 45254.3 43167.8 43835.1 44415.1 45222.5 45464.5 44968.3 45025.8 45080.3 45670.5 45757.5 34766.5 35147.0 36043.8 36409.6 36728.4 28987.4 29006.9 29053.7 29075.1 29292.9 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | [#2] jquery.html Cycles:180 Average:31837.21 Median:23168.09 stddev:100034.76 (431.8%) stddev-sans-first:100287.58 19:28:07 INFO - PROCESS | 7243 | Values: 424.9 436.7 437.6 442.5 447.0 18401.7 18885.7 19171.8 19206.7 19713.1 17875.8 17906.5 18013.6 18072.9 18088.6 5498.9 5568.3 5580.4 5740.0 5994.1 5823.8 5888.9 5894.7 5917.7 5918.2 5622.1 5821.6 5822.8 5870.0 5874.4 5787.7 5814.5 5815.1 5817.1 5886.9 5104.5 5274.0 5284.5 5314.4 5319.0 23137.5 23198.7 23220.5 23645.8 23813.4 2498.4 2664.0 2861.2 2966.6 3175.6 14432.8 14662.9 14939.6 15093.1 15332.7 1882.0 1961.1 2005.8 2006.8 2040.9 74692.0 74743.0 75593.0 76039.2 76176.6 11045.0 11156.6 11390.1 11427.3 11625.8 16023.9 16046.7 16092.2 16100.7 16200.7 8566.6 8603.5 8927.6 9016.1 9037.3 8400.3 8422.7 8561.1 8641.6 8676.8 6927.1 7015.0 7116.4 7129.9 7241.9 2003.4 2012.5 2024.7 2037.6 2086.2 1074.4 1087.6 1098.3 1176.7 1183.2 16868.7 17342.1 18399.9 18637.0 19757.0 1102.8 1110.6 1121.0 1123.4 1140.0 11207.9 11403.8 11437.9 11454.4 11517.4 602232.0 606520.0 612778.0 617988.0 622078.0 60690.4 77689.0 79377.0 81009.0 83244.2 1148.8 1153.8 1163.8 1190.4 1190.5 17888.6 17893.7 18068.0 18142.9 18290.7 37500.4 37616.6 38128.8 39691.2 39804.4 52622.5 52628.2 52724.0 53195.0 53454.2 8473.0 8529.0 8682.3 8706.7 8736.1 11792.6 12755.6 12846.2 12916.9 12973.4 11670.4 11694.4 11714.8 11864.6 12010.1 11026.7 11355.1 11355.2 11526.3 11557.8 11542.6 11825.4 11879.8 11939.9 12022.0 8408.5 8493.2 8618.8 8664.0 8676.1 11526.4 11528.3 11548.1 11609.2 11763.5 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | [#3] mootools.html Cycles:180 Average:5559.53 Median:4840.58 stddev:2996.96 (61.9%) stddev-sans-first:2990.35 19:28:07 INFO - PROCESS | 7243 | Values: 1567.7 1568.4 1779.9 1835.1 1870.7 7439.7 8033.6 8074.0 8258.2 8278.8 7930.7 7944.4 8034.6 8040.4 8088.6 2385.7 2415.5 2416.0 2418.3 2418.7 2359.7 2372.1 2388.1 2394.9 2396.7 2379.9 2398.3 2411.3 2433.9 2440.2 2311.9 2324.5 2337.2 2352.3 2391.0 2370.3 2381.7 2402.1 2403.7 2421.7 8271.2 8315.8 8322.0 8323.4 8327.7 5278.4 5331.7 5361.5 5392.3 5392.8 3390.9 3460.6 3482.1 3533.7 3538.1 1120.8 1156.1 1157.7 1158.8 1173.9 11804.6 11810.9 11857.8 11877.0 11879.3 4469.5 4495.0 4511.9 4545.3 4547.2 10127.2 10160.6 10162.5 10179.0 10191.0 5154.3 5166.5 5187.2 5204.1 5210.7 4333.4 4701.9 4773.9 4821.9 4859.2 4060.0 4193.3 4270.8 4276.7 4284.6 1334.6 1357.1 1363.0 1375.1 1375.9 942.5 954.5 1011.5 1019.3 1021.2 5572.8 5585.8 5625.7 5681.5 5689.7 1122.7 1134.1 1149.2 1161.4 1186.3 3978.2 4065.5 4106.6 4135.0 4141.6 9651.1 10105.5 10339.0 10349.5 10351.9 10040.7 10075.2 10104.9 10122.9 10135.8 7899.5 7906.4 7961.6 8049.0 8100.4 5569.0 5632.1 5693.0 5725.3 5756.6 8802.1 8996.3 9051.4 9052.8 9168.0 9134.4 9149.7 9174.7 9240.4 9260.3 6925.5 7301.5 7389.4 7410.6 7592.8 7935.3 7967.0 7974.5 7996.2 8040.7 6908.3 6929.0 6932.7 6978.2 7017.5 7088.4 7093.3 7112.4 7218.8 7232.5 6663.2 6742.2 6768.1 6789.2 6797.3 4998.3 5008.2 5017.0 5018.7 5119.5 4936.3 4970.3 4970.4 5047.5 5056.2 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | [#4] prototype.html Cycles:180 Average:5879.38 Median:6674.15 stddev:1782.46 (26.7%) stddev-sans-first:1738.64 19:28:07 INFO - PROCESS | 7243 | Values: 359.6 361.4 371.9 377.3 380.9 6637.4 6652.0 6665.4 6669.7 6678.6 6531.8 6557.1 6558.6 6560.2 6569.3 4766.7 4885.3 4950.6 4979.7 4981.8 4951.8 4962.2 4964.6 4969.7 4980.1 4928.3 4934.8 4936.1 4940.4 4943.3 4936.0 4936.1 4942.9 4960.8 5015.6 4361.6 4390.2 4392.0 4397.5 4399.3 6245.8 6314.5 6323.8 6397.2 6404.0 5823.3 5838.0 5846.4 5850.2 5864.0 6902.5 6944.3 6945.2 6949.8 6951.5 4840.2 4862.0 4866.4 4868.0 4876.1 7129.7 7225.7 7294.2 7301.8 7302.3 4971.6 5006.0 5008.4 5013.9 5019.8 5043.9 5069.8 5076.7 5079.9 5080.4 5829.1 5838.8 5841.4 5841.8 5846.5 6932.7 6968.8 6977.8 6989.5 7012.3 1778.0 1821.5 1821.6 1822.6 1825.7 1121.9 1158.1 1159.2 1160.1 1196.6 6551.5 6616.5 6694.4 6706.4 6713.6 7072.3 7187.5 7190.8 7200.7 7202.2 6783.6 6825.4 6855.0 6859.1 6865.2 3923.6 3969.3 3969.9 3970.9 3980.7 7584.3 7587.3 7594.1 7609.5 7617.5 7298.5 7423.2 7466.9 7489.9 7493.7 7498.6 7544.5 7577.8 7603.8 7612.5 7287.2 7348.8 7350.4 7355.3 7364.2 7184.9 7215.0 7224.1 7227.2 7237.2 7417.1 7556.9 7593.5 7604.5 7609.8 5067.8 5088.4 5119.9 5122.1 5126.0 7248.8 7249.7 7250.7 7255.9 7268.0 7014.4 7016.6 7042.8 7050.7 7063.0 6922.5 7005.6 7034.1 7103.4 7108.0 6923.1 6959.7 6967.5 6968.5 6971.4 7100.4 7104.9 7124.9 7133.3 7143.9 6950.3 6956.4 6958.8 6964.1 6966.2 19:28:07 INFO - PROCESS | 7243 | 19:28:07 INFO - PROCESS | 7243 | [#5] yui.html Cycles:180 Average:15801.80 Median:22645.40 stddev:17995.66 (79.5%) stddev-sans-first:18011.37 19:28:07 INFO - PROCESS | 7243 | Values: 904.9 913.4 921.1 925.9 947.5 14857.3 15059.8 15140.6 15152.0 15182.2 14202.2 14210.3 14227.9 14246.8 14314.9 729.6 873.2 889.2 897.4 901.6 876.5 885.6 891.2 893.1 894.8 934.9 937.2 941.5 945.2 946.3 931.5 933.0 940.0 940.0 942.9 686.3 686.8 687.4 688.8 698.4 13736.6 13840.9 13855.7 13867.0 13935.4 15244.6 15422.8 15438.6 15560.4 15564.5 11857.3 11922.9 11997.3 12158.3 12254.7 4019.7 4035.5 4088.8 4093.1 4193.2 55737.7 55860.0 56202.7 57327.0 57853.4 11941.8 11954.9 12126.6 12245.6 12266.0 20304.3 21834.9 21847.2 21851.9 21882.1 8392.9 8512.1 8600.2 8930.4 8939.6 4870.5 4922.1 4977.4 4985.0 4992.7 3818.3 3850.6 3874.5 3879.2 3882.9 675.4 681.9 687.1 688.8 697.6 702.2 778.9 806.6 806.7 815.3 9880.9 10016.9 10058.7 10099.2 10370.4 733.2 765.8 771.3 787.8 822.1 4507.7 4511.2 4511.4 4527.2 4603.1 62977.1 63258.4 65319.7 67489.3 67634.7 55043.4 55500.4 55640.4 56001.0 57420.4 48888.3 50024.2 53571.5 54332.7 54574.0 9497.4 9615.5 10206.2 10214.2 10222.4 39191.6 39371.0 39551.2 39791.4 41097.6 47371.8 49661.8 50296.7 50516.5 50967.2 12408.1 12550.7 12880.0 12914.5 13016.7 14019.6 14465.5 14469.7 14631.9 15798.8 13627.8 13910.7 14645.6 14651.1 14659.1 13404.4 13578.0 13772.9 14010.0 14468.0 12817.6 12849.5 13177.9 13216.8 13442.6 11030.9 11090.1 11239.9 11658.1 11725.1 10738.6 11217.1 11324.5 11366.8 11459.3 19:28:07 INFO - PROCESS | 7243 | -------- Summary: end -------- 19:28:07 INFO - PROCESS | 7243 | 19:28:08 INFO - TEST-INFO | 7243: exit 0 19:28:08 INFO - TEST-OK | dromaeo_css | took 1109133ms 19:28:08 INFO - TEST-START | kraken 19:28:08 INFO - operating with platform_type : linux_ 19:28:08 INFO - Initialising browser for kraken test... 19:28:08 INFO - TEST-INFO | started process 7491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ26PnA/profile http://localhost:59685/getInfo.html) 19:28:11 INFO - PROCESS | 7491 | 19:28:11 INFO - PROCESS | 7491 | (process:7570): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:12 INFO - PROCESS | 7491 | __metrics Screen width/height:1600/1200 19:28:12 INFO - PROCESS | 7491 | colorDepth:24 19:28:12 INFO - PROCESS | 7491 | Browser inner width/height: 1024/697 19:28:12 INFO - PROCESS | 7491 | __metrics 19:28:13 ERROR - PROCESS | 7491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 19:28:14 INFO - TEST-INFO | 7491: exit 0 19:28:14 INFO - Browser initialized. 19:28:14 INFO - Running cycle 1/1 for kraken test... 19:28:14 INFO - TEST-INFO | started process 7621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ26PnA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:16 INFO - PROCESS | 7621 | 19:28:16 INFO - PROCESS | 7621 | (process:7688): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:28:26 INFO - PROCESS | 7621 | RSS: Main: 152195072 19:28:26 INFO - PROCESS | 7621 | 19:28:28 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59685/tests/kraken/driver.html?testName=audio-beat-detection) 19:28:29 INFO - PROCESS | 7621 | RSS: Main: 156966912 19:28:29 INFO - PROCESS | 7621 | 19:28:32 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59685/tests/kraken/driver.html?testName=audio-dft) 19:28:32 INFO - PROCESS | 7621 | RSS: Main: 157143040 19:28:32 INFO - PROCESS | 7621 | 19:28:35 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59685/tests/kraken/driver.html?testName=audio-fft) 19:28:36 INFO - PROCESS | 7621 | RSS: Main: 157163520 19:28:36 INFO - PROCESS | 7621 | 19:28:38 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59685/tests/kraken/driver.html?testName=audio-oscillator) 19:28:38 INFO - PROCESS | 7621 | RSS: Main: 157184000 19:28:38 INFO - PROCESS | 7621 | 19:28:41 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59685/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:41 INFO - PROCESS | 7621 | RSS: Main: 157089792 19:28:41 INFO - PROCESS | 7621 | 19:28:44 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59685/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:45 INFO - PROCESS | 7621 | RSS: Main: 157327360 19:28:45 INFO - PROCESS | 7621 | 19:28:48 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59685/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:49 INFO - PROCESS | 7621 | RSS: Main: 157515776 19:28:49 INFO - PROCESS | 7621 | 19:28:52 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59685/tests/kraken/driver.html?testName=json-parse-financial) 19:28:52 INFO - PROCESS | 7621 | RSS: Main: 157413376 19:28:52 INFO - PROCESS | 7621 | 19:28:54 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59685/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:54 INFO - PROCESS | 7621 | RSS: Main: 157335552 19:28:54 INFO - PROCESS | 7621 | 19:28:56 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:57 INFO - PROCESS | 7621 | RSS: Main: 157380608 19:28:57 INFO - PROCESS | 7621 | 19:28:59 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:59 INFO - PROCESS | 7621 | RSS: Main: 157233152 19:28:59 INFO - PROCESS | 7621 | 19:29:02 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:29:02 INFO - PROCESS | 7621 | RSS: Main: 157925376 19:29:02 INFO - PROCESS | 7621 | 19:29:05 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:29:06 INFO - PROCESS | 7621 | RSS: Main: 157954048 19:29:06 INFO - PROCESS | 7621 | 19:29:07 INFO - PROCESS | 7621 | Cycle 1(1): loaded http://localhost:59685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59685/tests/kraken/driver.html?testName=ai-astar) 19:29:08 INFO - PROCESS | 7621 | RSS: Main: 159694848 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | __start_tp_report 19:29:08 INFO - PROCESS | 7621 | _x_x_mozilla_page_load 19:29:08 INFO - PROCESS | 7621 | _x_x_mozilla_page_load_details 19:29:08 INFO - PROCESS | 7621 | |i|pagename|runs| 19:29:08 INFO - PROCESS | 7621 | |0;ai-astar;106;109;102;110;111;110;100;110;111;109 19:29:08 INFO - PROCESS | 7621 | |1;audio-beat-detection;151;135;168;180;130;155;161;127;193;130 19:29:08 INFO - PROCESS | 7621 | |2;audio-dft;162;162;163;162;161;163;160;162;161;162 19:29:08 INFO - PROCESS | 7621 | |3;audio-fft;73;75;76;167;74;76;77;78;169;77 19:29:08 INFO - PROCESS | 7621 | |4;audio-oscillator;92;91;158;91;92;92;141;91;92;147 19:29:08 INFO - PROCESS | 7621 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;117;118 19:29:08 INFO - PROCESS | 7621 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;147;147 19:29:08 INFO - PROCESS | 7621 | |7;imaging-desaturate;98;95;95;96;94;95;95;95;95;95 19:29:08 INFO - PROCESS | 7621 | |8;json-parse-financial;56;56;56;55;61;61;57;77;55;55 19:29:08 INFO - PROCESS | 7621 | |9;json-stringify-tinderbox;59;57;57;58;58;59;57;57;60;57 19:29:08 INFO - PROCESS | 7621 | |10;stanford-crypto-aes;74;74;74;81;75;73;74;82;83;72 19:29:08 INFO - PROCESS | 7621 | |11;stanford-crypto-ccm;119;113;122;119;115;111;113;111;127;124 19:29:08 INFO - PROCESS | 7621 | |12;stanford-crypto-pbkdf2;163;160;161;158;164;170;156;158;162;158 19:29:08 INFO - PROCESS | 7621 | |13;stanford-crypto-sha256-iterative;67;65;75;68;71;66;69;66;64;66 19:29:08 INFO - PROCESS | 7621 | __end_tp_report 19:29:08 INFO - PROCESS | 7621 | __start_cc_report 19:29:08 INFO - PROCESS | 7621 | _x_x_mozilla_cycle_collect,841 19:29:08 INFO - PROCESS | 7621 | __end_cc_report 19:29:08 INFO - PROCESS | 7621 | __startTimestamp1463970548186__endTimestamp 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | ------- Summary: start ------- 19:29:08 INFO - PROCESS | 7621 | Number of tests: 14 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:3.88 (3.5%) stddev-sans-first:4.06 19:29:08 INFO - PROCESS | 7621 | Values: 106.0 109.0 102.0 110.0 111.0 110.0 100.0 110.0 111.0 109.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:158.00 stddev:22.81 (14.4%) stddev-sans-first:24.19 19:29:08 INFO - PROCESS | 7621 | Values: 151.0 135.0 168.0 180.0 130.0 155.0 161.0 127.0 193.0 130.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 19:29:08 INFO - PROCESS | 7621 | Values: 162.0 162.0 163.0 162.0 161.0 163.0 160.0 162.0 161.0 162.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.93 (51.2%) stddev-sans-first:40.53 19:29:08 INFO - PROCESS | 7621 | Values: 73.0 75.0 76.0 167.0 74.0 76.0 77.0 78.0 169.0 77.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:91.50 stddev:27.88 (30.5%) stddev-sans-first:28.91 19:29:08 INFO - PROCESS | 7621 | Values: 92.0 91.0 158.0 91.0 92.0 92.0 141.0 91.0 92.0 147.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:29:08 INFO - PROCESS | 7621 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:29:08 INFO - PROCESS | 7621 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:0.50 19:29:08 INFO - PROCESS | 7621 | Values: 98.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 95.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:56.50 stddev:6.76 (12.0%) stddev-sans-first:7.08 19:29:08 INFO - PROCESS | 7621 | Values: 56.0 56.0 56.0 55.0 61.0 61.0 57.0 77.0 55.0 55.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:1.10 (1.9%) stddev-sans-first:1.09 19:29:08 INFO - PROCESS | 7621 | Values: 59.0 57.0 57.0 58.0 58.0 59.0 57.0 57.0 60.0 57.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:74.50 stddev:4.10 (5.5%) stddev-sans-first:4.28 19:29:08 INFO - PROCESS | 7621 | Values: 74.0 74.0 74.0 81.0 75.0 73.0 74.0 82.0 83.0 72.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:119.00 stddev:5.66 (4.8%) stddev-sans-first:5.97 19:29:08 INFO - PROCESS | 7621 | Values: 119.0 113.0 122.0 119.0 115.0 111.0 113.0 111.0 127.0 124.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:4.06 (2.5%) stddev-sans-first:4.24 19:29:08 INFO - PROCESS | 7621 | Values: 163.0 160.0 161.0 158.0 164.0 170.0 156.0 158.0 162.0 158.0 19:29:08 INFO - PROCESS | 7621 | 19:29:08 INFO - PROCESS | 7621 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:3.27 (4.8%) stddev-sans-first:3.46 19:29:08 INFO - PROCESS | 7621 | Values: 67.0 65.0 75.0 68.0 71.0 66.0 69.0 66.0 64.0 66.0 19:29:08 INFO - PROCESS | 7621 | -------- Summary: end -------- 19:29:08 INFO - PROCESS | 7621 | 19:29:09 INFO - TEST-INFO | 7621: exit 0 19:29:09 INFO - TEST-OK | kraken | took 60751ms 19:29:09 INFO - SUITE-END | took 1169s 19:29:09 INFO - Completed test suite (00:19:30) 19:29:09 INFO - javascript benchmark 19:29:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3392.508086327482, 3444.07010107271, 3470.3926812807767, 3476.8609255629776, 3507.7719948203367, 5656.0, 5659.17941898425, 5678.57410694198, 5685.175649530821, 5725.942740572593, 5663.207150998864, 5688.146777983305, 5689.146628005801, 5704.942950570493, 5738.31140263168, 5141.357330333699, 5204.375474943012, 5226.608004399666, 5236.371635403757, 5262.842114736545, 5111.08000559899, 5221.973890130544, 5226.346706661668, 5341.092014357569, 5391.757370918299, 5167.405748338932, 5189.091908915943, 5248.343957005374, 5255.894882102356, 5259.868503287429, 5157.252198431206, 5160.612954028463, 5161.587073034186, 5175.585953123741, 5197.688138711689, 4925.113479573675, 5043.87390315245, 5061.974690126563, 5091.032703786306, 5155.072087024334, 5482.342118945752, 5543.362513310981, 5569.888602227933, 5580.051391263495, 5608.747606357723, 6069.180660610849, 6095.481884039862, 6102.145699602059, 6126.846828829271, 6152.938470615326, 6026.457618814327, 6073.696315184267, 6144.262688477412, 6148.108524264001, 6168.537359697995, 5704.515116215127, 5713.657180569137, 5719.14212868069, 5719.914201286942, 5724.084146536534, 6150.323464418911, 6220.471259942865, 6228.22147231596, 6245.188125543741, 6250.718717657716, 5889.116632505158, 5947.31605865331, 5975.103734439869, 6037.215162028908, 6094.634321940698, 6115.602485838406, 6121.938780612137, 6126.969365153235, 6127.356627554132, 6129.325774164839, 6032.668203248863, 6050.062240352752, 6084.239470066242, 6100.69496525172, 6112.113743507167, 5843.620164689367, 5896.64620122794, 6002.279726432856, 6003.579749417586, 6049.122877182784, 4499.797509112098, 4522.8643140705835, 4525.185466616041, 4542.0915816836105, 4549.27211646135, 3989.7007724420782, 4066.2274167908595, 4073.877783666495, 4089.9386509202386, 4095.4266402703647, 5724.427557244242, 5767.567432442584, 5794.797182098607, 5880.470757631748, 5897.705114744245, 6192.916239658041, 6194.0, 6203.441690247809, 6222.12890195373, 6222.937770622327, 5671.376148623648, 5758.3665796762325, 5855.180274761537, 5892.263467066617, 5932.58471906971, 5016.573591244785, 5035.370578677665, 5073.847784566469, 5077.1876499759865, 5107.897842043139, 6182.381761823782, 6215.378462153839, 6227.595206311576, 6269.937300627026, 6287.842803929847, 6031.547633927561, 6075.665838378932, 6077.2099627049965, 6078.118672792332, 6078.848028799315, 6182.7217775201125, 6271.404216599416, 6393.520485963664, 6404.871902561829, 6412.198475190601, 5967.791127310524, 6002.279726432856, 6003.669798161143, 6008.407771940352, 6048.0, 6007.219061521974, 6089.939100608937, 6091.634501929899, 6110.633361998294, 6119.2350956130485, 5963.373845746134, 5986.4013598639785, 6011.819645410645, 6048.0625503047095, 6077.331493535796, 5899.528037757055, 5930.406959304035, 5936.495397891227, 5947.405259474018, 5950.256217972754, 5756.769729210785, 5797.275340582427, 5824.650520968756, 5837.357890632112, 5843.415658434123, 5991.370906054802, 5991.64050156992, 6019.157317975574, 6019.6990150493175, 6036.0644100164545, 5829.854253643693, 5867.090600956859, 5869.207656966255, 5885.440883116097, 5893.499052580407], "value": 5608.398963970496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.9099671544342, 677.6611694152925, 682.1064405628626, 701.8806802843516, 771.6720393832627, 38794.8060259699, 39645.207095858066, 39750.80124599373, 40020.59979400209, 40023.19953600926, 39956.40065399014, 40499.79750101253, 40622.79688601553, 40769.0, 40974.18051638966, 8698.39111262212, 8873.423227490224, 8873.822523549525, 8877.289816814638, 8891.777705557348, 8656.091110433408, 8849.33629977751, 8958.820823583525, 9044.638214471413, 9067.183953444188, 9047.411918225294, 9108.954455227748, 9122.407043542182, 9144.314176436794, 9164.0, 8985.955070224672, 9030.051844556325, 9069.047749986255, 9096.044915283932, 9105.544722763836, 8868.068852770431, 9014.504202268872, 9023.96224434192, 9049.276057915351, 9072.183503484717, 41623.167536649096, 42071.0, 42125.36811947823, 42127.0, 42360.0, 3037.5595538646994, 3675.46705727668, 3752.8498860045565, 4018.397240413932, 4465.017696106851, 28316.29209269764, 28356.858215708995, 28365.0, 28392.29019274514, 29029.854850725824, 4217.568064570613, 4222.767747773902, 4238.724482908601, 4261.296886013804, 4300.505441874193, 192384.0, 193720.03139984352, 193898.0, 194472.0, 195148.0, 36798.63201367952, 38476.0, 38656.0, 39076.41385379222, 39529.60470395317, 36844.71043513464, 37090.629093709256, 37289.254214916094, 37322.62677373246, 37397.43903841444, 16203.270852811651, 16484.0, 16491.257893394584, 16512.669746605, 16514.42199523011, 14290.356933937997, 14296.285185740671, 14321.0, 14389.856101439062, 14454.132752034911, 9107.590158442887, 9354.345195836362, 9451.716448506555, 9452.10205030521, 9483.241340692728, 3590.7666001710327, 3615.1504396466808, 3658.817059147032, 3672.394054980898, 3716.758410703296, 1145.9885401145882, 1149.3965668024186, 1157.6179860645966, 1168.6435637130587, 1183.2841131115724, 33497.33005339879, 33536.0, 33681.663183367855, 34326.313473730384, 34335.65664343325, 1242.6085782978332, 1249.3815561297215, 1252.4551819958347, 1276.3809552367095, 1320.392619395089, 17349.653006939792, 17751.73372399415, 17810.465686029438, 17837.46487605374, 17931.103444827706, 547813.0, 648131.0, 659341.0, 667224.0, 880681.0, 57259.42740572541, 57914.420855791745, 58314.0, 58501.0, 58510.414895850496, 1520.665453600206, 1547.752359622455, 1548.4657793061376, 1551.697419003306, 1563.4996801023563, 30792.53811192789, 31509.527357089202, 31745.365092698477, 31922.52116218305, 32373.51439728453, 54284.45715542952, 61362.38637613745, 63107.0, 63125.0, 63205.0, 510997.0, 514615.0, 517393.0, 517602.0, 518135.0, 47728.0, 47970.520294798, 48804.0, 49000.0, 49028.0, 52604.736976314874, 52630.47369526256, 52895.206571900686, 53247.0, 53575.73212133914, 43934.56065439433, 44714.3292850601, 44815.775921120185, 45203.77398112988, 45254.321185182904, 43167.78416107899, 43835.12329753323, 44415.11169776651, 45222.54777452183, 45464.54535454736, 44968.32547511724, 45025.77487112543, 45080.323795142445, 45670.54329456663, 45757.54242457533, 34766.47850282298, 35147.0, 36043.81978090093, 36409.63590364168, 36728.449073264455, 28987.420251594427, 29006.854965725037, 29053.692583833355, 29075.127746167647, 29292.853535732185], "value": 19663.158623023784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.8937765558611, 436.65504251641204, 437.59569318911446, 442.4933451198377, 446.95306992765757, 18401.723974140397, 18885.71671424928, 19171.808281917176, 19206.711899321486, 19713.11290991905, 17875.821241787577, 17906.462806115804, 18013.639727205482, 18072.909635451804, 18088.63822723548, 5498.862528436801, 5568.276124103881, 5580.358258800229, 5740.0, 5994.13085102662, 5823.82528524145, 5888.882222355551, 5894.705264736767, 5917.704114794265, 5918.201042859202, 5622.072358060936, 5821.592488525784, 5822.796202132926, 5870.0, 5874.412558744134, 5787.739551720161, 5814.5057670097885, 5815.098659707752, 5817.0983497557945, 5886.852828679296, 5104.464031276737, 5273.9736301318635, 5284.524392804666, 5314.388845282803, 5318.973405132988, 23137.53724925492, 23198.65202021971, 23220.535589288287, 23645.76354236453, 23813.404664883517, 2498.3504288884837, 2663.961055188459, 2861.1702606244166, 2966.61434013579, 3175.555422240888, 14432.78350824728, 14662.926685366612, 14939.626509337244, 15093.094414335064, 15332.693346133126, 1881.9811801881942, 1961.0586918279305, 2005.8495612829097, 2006.7792542820278, 2040.8571400002006, 74692.0, 74743.0, 75593.0, 76039.23960760432, 76176.61911690405, 11045.0, 11156.553737850558, 11390.145739069603, 11427.314361138358, 11625.767484650429, 16023.919880400523, 16046.679066418606, 16092.195390230441, 16100.67798644044, 16200.675986480204, 8566.571671416405, 8603.52680602573, 8927.553622318857, 9016.09839016093, 9037.322200834964, 8400.327973762085, 8422.705205317907, 8561.058283588925, 8641.567921603895, 8676.783080422914, 6927.099477067949, 7014.964925175342, 7116.359527642537, 7129.89305160423, 7241.8551628967125, 2003.4290227285153, 2012.45663670811, 2024.7064175694443, 2037.6026674798568, 2086.228095604636, 1074.4090750087578, 1087.5541028178568, 1098.3135540287321, 1176.670532250971, 1183.237141275115, 16868.746968795476, 17342.132893355283, 18399.8960062394, 18637.0, 19757.0, 1102.7904698107334, 1110.6223883879359, 1120.960766373173, 1123.3989815448697, 1140.0099651220728, 11207.943960280147, 11403.771924561463, 11437.885621143849, 11454.370009649549, 11517.424128793527, 602232.0, 606520.0, 612778.0, 617988.0, 622078.0, 60690.393096069354, 77689.0, 79377.0, 81009.0, 83244.16755832486, 1148.7759886821989, 1153.8384626152344, 1163.8196079607844, 1190.3869507203797, 1190.5475919150667, 17888.642227155644, 17893.68144338656, 18068.0, 18142.909285453487, 18290.725639115157, 37500.43749343707, 37616.62383376131, 38128.809355953046, 39691.20617587574, 39804.40293395543, 52622.47377526176, 52628.210576842146, 52724.0, 53195.0, 53454.19818702645, 8472.957635212031, 8529.029679224692, 8682.348823838363, 8706.738797836075, 8736.082711315474, 11792.646220613395, 12755.61733148007, 12846.229226246081, 12916.935415322863, 12973.416196271002, 11670.358130302575, 11694.356810375511, 11714.76570468603, 11864.584739534075, 12010.099242557018, 11026.724331891766, 11355.091592672401, 11355.205135640756, 11526.250793698382, 11557.826632600685, 11542.59600913964, 11825.408729563316, 11879.76240475203, 11939.880601194225, 12022.0, 8408.495490270603, 8493.193146651058, 8618.827623447622, 8664.0, 8676.08901065379, 11526.366049867338, 11528.250663706833, 11548.133889958119, 11609.187356885275, 11763.529458821551], "value": 9608.493124503124, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1567.7021365940466, 1568.435363269223, 1779.9110044497772, 1835.0824587706147, 1870.6913359295718, 7439.665215065322, 8033.638486268117, 8074.0, 8258.2154695304, 8278.793030174249, 7930.722424715136, 7944.443888927763, 8034.638441270142, 8040.437169398145, 8088.636011379487, 2385.6660067590506, 2415.52897185049, 2415.9516809663796, 2418.3349578865864, 2418.673479080328, 2359.6932398788217, 2372.063035101134, 2388.0567175965484, 2394.8563086214795, 2396.6884305040408, 2379.9048038078454, 2398.3164798032562, 2411.3489357873364, 2433.853968761871, 2440.2191298784396, 2311.872846993415, 2324.500232450023, 2337.2403968710237, 2352.3413444235644, 2390.964135537968, 2370.3007612754277, 2381.7022872140983, 2402.0752010475917, 2403.663487111806, 2421.685180926486, 8271.21423464776, 8315.83368332636, 8322.042965059036, 8323.375746818952, 8327.708530201475, 5278.419373868871, 5331.747039445727, 5361.544268737123, 5392.299001129867, 5392.78428862845, 3390.8640605397222, 3460.636633153533, 3482.112061424346, 3533.7173026158102, 3538.1331573764337, 1120.803859324615, 1156.121347775688, 1157.6874243954085, 1158.7798318319492, 1173.9413029348584, 11804.586839460577, 11810.88189118115, 11857.822132668018, 11877.049836013099, 11879.34663593502, 4469.4636643602325, 4494.955050449454, 4511.88720281989, 4545.340925565841, 4547.1815073287125, 10127.240456965757, 10160.593576257015, 10162.542685579167, 10179.03299186576, 10191.0, 5154.329937108227, 5166.483351664803, 5187.170052791535, 5204.115300398941, 5210.6613070150315, 4333.371661109121, 4701.882452938636, 4773.880652983703, 4821.9035619287415, 4859.24681674334, 4059.9797001014804, 4193.287141186006, 4270.786460677016, 4276.72201306914, 4284.571542845691, 1334.6329759316266, 1357.1178733823094, 1362.9931850340686, 1375.0580852116332, 1375.931203439824, 942.4675058591873, 954.5418199264392, 1011.4538149399389, 1019.2966852871494, 1021.1626466297565, 5572.777088916398, 5585.832425027255, 5625.6905870176715, 5681.545476361881, 5689.715514224272, 1122.747381839096, 1134.0813940708053, 1149.1898211760688, 1161.361251311775, 1186.3297237061033, 3978.1645854370327, 4065.4511640928094, 4106.630403263721, 4134.979325103415, 4141.64795992338, 9651.131398174199, 10105.494725263854, 10339.0, 10349.482525873827, 10351.896481035245, 10040.748981275527, 10075.244356673278, 10104.898951010397, 10122.898771012196, 10135.797284054277, 7899.526028438312, 7906.407019473562, 7961.562114083781, 8049.034115906012, 8100.432969692183, 5568.972155139199, 5632.070708333079, 5693.0, 5725.255716756795, 5756.625819321731, 8802.119788021402, 8996.28029757631, 9051.366404351633, 9052.818943621223, 9167.954160229156, 9134.36059475857, 9149.679761208326, 9174.724758257264, 9240.399374040666, 9260.30547708938, 6925.549839260432, 7301.452391070585, 7389.445791565547, 7410.592417417094, 7592.8481430372185, 7935.285824275843, 7966.960165199137, 7974.481658692166, 7996.24035716606, 8040.718574849852, 6908.3437073477935, 6929.0, 6932.688029038604, 6978.197507286727, 7017.543859649107, 7088.432925365855, 7093.255208203064, 7112.35988761014, 7218.819529511804, 7232.493725439379, 6663.233728121328, 6742.190937087581, 6768.120144381396, 6789.15135608049, 6797.320267973163, 4998.3252260945765, 5008.223725322581, 5017.0, 5018.749062546785, 5119.46245644202, 4936.333594964633, 4970.25446183061, 4970.428400733962, 5047.4952504749235, 5056.191009438472], "value": 4572.57843883492, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5936591651433, 361.4253337193861, 371.94048952167657, 377.3377722097718, 380.86098574020474, 6637.369449902258, 6652.0, 6665.433438157756, 6669.666516674159, 6678.632675202862, 6531.804045878619, 6557.1147895034155, 6558.5899031708295, 6560.245571759249, 6569.310222426648, 4766.73782941938, 4885.316055752198, 4950.6287028472825, 4979.651424400294, 4981.750912454381, 4951.752412379385, 4962.1812400953795, 4964.60283177345, 4969.652124351297, 4980.078685443204, 4928.33467481889, 4934.777934992934, 4936.136176169174, 4940.382452193476, 4943.30793688882, 4936.037472692827, 4936.136176169174, 4942.876428089308, 4960.751962401901, 5015.598752099823, 4361.6074553290355, 4390.2317094508335, 4391.967887546424, 4397.538258482845, 4399.252127138394, 6245.7501699931945, 6314.463270622003, 6323.778667746653, 6397.168368112162, 6404.039394090877, 5823.330317013513, 5838.0, 5846.356900740915, 5850.151727999459, 5863.9706801466145, 6902.516823822334, 6944.270851560564, 6945.201301850301, 6949.791506254821, 6951.548149370275, 4840.249761287007, 4861.951380486185, 4866.3673722416215, 4868.002059577778, 4876.073546026244, 7129.714811407537, 7225.747098851515, 7294.234105418907, 7301.817454563626, 7302.342789148949, 4971.577415919615, 5006.0, 5008.449070602231, 5013.949860501421, 5019.799208031711, 5043.873903152377, 5069.771860266297, 5076.670016448919, 5079.923801142986, 5080.390353157571, 5829.125631155276, 5838.795642152504, 5841.415858414124, 5841.795537156179, 5846.473817356458, 6932.688029038705, 6968.79093627192, 6977.755778547727, 6989.545679530815, 7012.263712310236, 1778.0309731196528, 1821.5446138465384, 1821.5901422179904, 1822.599028213791, 1825.7078867381156, 1121.9158563107799, 1158.0561842098662, 1159.2464897816487, 1160.1241062997383, 1196.5692350753723, 6551.508636852255, 6616.470682345401, 6694.364035416627, 6706.429953454011, 6713.56361836479, 7072.257412971667, 7187.460940429489, 7190.8202294942, 7200.711971521186, 7202.243764404767, 6783.559068660521, 6825.35159159879, 6855.040294358794, 6859.07402500666, 6865.176178858469, 3923.6468717815533, 3969.3053715599654, 3969.920601587952, 3970.861019864291, 3980.7412518186807, 7584.317411432998, 7587.317141457295, 7594.088709354913, 7609.505382150142, 7617.466777325645, 7298.452616053817, 7423.220561840929, 7466.85066298671, 7489.925100749032, 7493.70025198986, 7498.550086994798, 7544.47188696786, 7577.810554736176, 7603.847923041508, 7612.467127301035, 7287.198408174991, 7348.816279592839, 7350.375218106307, 7355.301246381585, 7364.226756190523, 7184.922261660584, 7215.0, 7224.096987876515, 7227.241139680258, 7237.203907570269, 7417.147028091838, 7556.924430755622, 7593.544387336557, 7604.505707129019, 7609.809754756176, 5067.77195026232, 5088.363954505687, 5119.897602047864, 5122.103631864484, 5125.974370128126, 7248.818779530554, 7249.746258880914, 7250.709971601077, 7255.854882902418, 7267.963660181877, 7014.40377567892, 7016.614086225307, 7042.823929401806, 7050.682719277543, 7062.964685176541, 6922.480813938874, 7005.614691192033, 7034.085568876218, 7103.431725462054, 7108.0, 6923.099997000358, 6959.652017399008, 6967.477439192182, 6968.512204145661, 6971.442284617117, 7100.4319654428555, 7104.928950710633, 7124.928750712426, 7133.251008644018, 7143.928560714534, 6950.270221626656, 6956.40870526011, 6958.826029349104, 6964.129483814523, 6966.233714291525], "value": 5298.111010177258, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.9140331668493, 913.4199783137706, 921.1065266691311, 925.9074092590739, 947.5262368815593, 14857.257137143153, 15059.774103388458, 15140.621484462894, 15152.0, 15182.240887955599, 14202.218877961734, 14210.289485525735, 14227.928860355709, 14246.786298205509, 14314.856851431483, 729.6388287797548, 873.2184694698241, 889.235257678396, 897.3539051882667, 901.6078006067381, 876.4960147914975, 885.6324625280533, 891.1667590802621, 893.1158153428092, 894.7763059235191, 934.8924873639551, 937.2221056523103, 941.4915945389481, 945.1682519382933, 946.3044662173297, 931.483026920059, 932.9533523323806, 939.9953000234989, 940.0, 942.8727121838601, 686.3342557719054, 686.7767975408012, 687.4363022321699, 688.7933619914056, 698.4063545985871, 13736.587902362946, 13840.861591384059, 13855.722885542333, 13867.0, 13935.372908219155, 15244.618884527865, 15422.768658470131, 15438.614034649112, 15560.37758489659, 15564.455244066403, 11857.347845868473, 11922.880771192264, 11997.280163190237, 12158.270503769802, 12254.693632659255, 4019.658329042035, 4035.4955630546183, 4088.7751173685438, 4093.1199792044554, 4193.20329137466, 55737.72131139359, 55860.0, 56202.71898640521, 57327.0, 57853.42146578564, 11941.761164776655, 11954.880451195551, 12126.575569855013, 12245.571405000783, 12266.0, 20304.289349872684, 21834.89082554577, 21847.235346762787, 21851.890740546194, 21882.12471501122, 8392.916070839214, 8512.148785121562, 8600.182982616641, 8930.419522731001, 8939.597718102701, 4870.537298956593, 4922.114019476457, 4977.352944117314, 4985.0, 4992.650514463952, 3818.3317919364, 3850.614938506183, 3874.4575759393706, 3879.243547508209, 3882.8835134946, 675.4157653629575, 681.877262092828, 687.1101923009714, 688.7795905310253, 697.6407150317591, 702.224042433104, 778.8559116563454, 806.5684858600621, 806.6732973145886, 815.2540425510709, 9880.851787223197, 10016.899831001596, 10058.698239052841, 10099.192064634812, 10370.429626370471, 733.2044731466312, 765.7664412354285, 771.3366504805863, 787.8188016756063, 822.1408627983772, 4507.729536227836, 4511.187986162522, 4511.368408422823, 4527.230370836965, 4603.079384123189, 62977.05534416987, 63258.36741632525, 65319.67340163269, 67489.32510674928, 67634.66182669056, 55043.44956550383, 55500.44499555034, 55640.443595564335, 56001.0, 57420.42579574235, 48888.26667599989, 50024.24963625549, 53571.46428535665, 54332.72833635886, 54574.0, 9497.418691271549, 9615.51922403863, 10206.218463931642, 10214.233932454947, 10222.355468944948, 39191.60808391879, 39371.0, 39551.20897581975, 39791.40312895251, 41097.58902410937, 47371.76314118407, 49661.75169124276, 50296.74851625718, 50516.49483505118, 50967.2354914684, 12408.131430800118, 12550.686232844251, 12880.018334545583, 12914.547990820276, 13016.674583135118, 14019.649508762363, 14465.49370772018, 14469.710605788036, 14631.92684036573, 15798.76301855496, 13627.79558306646, 13910.721785564434, 14645.560633181021, 14651.12093274407, 14659.120452772868, 13404.396802143732, 13578.049536532742, 13772.931135344259, 14010.0, 14468.0, 12817.551385701456, 12849.486020559072, 13177.934110329386, 13216.801747973595, 13442.596722098353, 11030.944845275722, 11090.112790976542, 11239.943800280946, 11658.12564057716, 11725.061995040547, 10738.570457181626, 11217.13263541799, 11324.547018119512, 11366.829497557377, 11459.31244125355], "value": 7274.036787157698, "unit": "score"}], "name": "dromaeo_css", "value": 7560.322361545241, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 109.0, 102.0, 110.0, 111.0, 110.0, 100.0, 110.0, 111.0, 109.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 135.0, 168.0, 180.0, 130.0, 155.0, 161.0, 127.0, 193.0, 130.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 163.0, 160.0, 162.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 167.0, 74.0, 76.0, 77.0, 78.0, 169.0, 77.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 158.0, 91.0, 92.0, 92.0, 141.0, 91.0, 92.0, 147.0], "value": 108.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 61.0, 61.0, 57.0, 77.0, 55.0, 55.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 58.0, 58.0, 59.0, 57.0, 57.0, 60.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 81.0, 75.0, 73.0, 74.0, 82.0, 83.0, 72.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 113.0, 122.0, 119.0, 115.0, 111.0, 113.0, 111.0, 127.0, 124.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 158.0, 164.0, 170.0, 156.0, 158.0, 162.0, 158.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 75.0, 68.0, 71.0, 66.0, 69.0, 66.0, 64.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1523.6000000000004, "alertThreshold": 2.0}]} 19:29:09 INFO - Return code: 0 19:29:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:29:09 ERROR - # TBPL SUCCESS # 19:29:09 INFO - Running post-action listener: _resource_record_post_action 19:29:09 INFO - Running post-run listener: _resource_record_post_run 19:29:10 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 270336; Write bytes: 498212864; Read time: 232; Write time: 449404 19:29:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248676352; Read time: 0; Write time: 254852 19:29:10 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 270336; Write bytes: 249536512; Read time: 232; Write time: 194552 19:29:10 INFO - Running post-run listener: _upload_blobber_files 19:29:10 INFO - Blob upload gear active. 19:29:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:29:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:29:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:29:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:11 INFO - (blobuploader) - INFO - Done attempting. 19:29:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:29:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:29:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:29:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:29:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:29:12 INFO - (blobuploader) - INFO - Done attempting. 19:29:12 INFO - (blobuploader) - INFO - Iteration through files over. 19:29:12 INFO - Return code: 0 19:29:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:29:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:29:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2ad59c077c2c7cb5babbf170167b46afe2ad48b21c7110bda8c8c8af3894ff9b5a21d087694068ea7d90d0149ee037fbf0904553c988d478fe105915c10ddb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcb3c5684623f53ff01c1b79e4153ae1bcb7c6983fa3dbb890bdfd03b1751a50f3db4a76c4cdcb4ebeeb524e3da3b6d96d62d9e035b275a91da1b6f259b78c2c"} 19:29:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:29:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:29:12 INFO - Contents: 19:29:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2ad59c077c2c7cb5babbf170167b46afe2ad48b21c7110bda8c8c8af3894ff9b5a21d087694068ea7d90d0149ee037fbf0904553c988d478fe105915c10ddb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcb3c5684623f53ff01c1b79e4153ae1bcb7c6983fa3dbb890bdfd03b1751a50f3db4a76c4cdcb4ebeeb524e3da3b6d96d62d9e035b275a91da1b6f259b78c2c"} 19:29:12 INFO - Running post-run listener: copy_logs_to_upload_dir 19:29:12 INFO - Copying logs to upload dir... 19:29:12 INFO - mkdir: /builds/slave/test/build/upload/logs 19:29:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.343297 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-22 19:29:11.611209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 19:29:11.614908) ========= 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=920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417 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/f2ad59c077c2c7cb5babbf170167b46afe2ad48b21c7110bda8c8c8af3894ff9b5a21d087694068ea7d90d0149ee037fbf0904553c988d478fe105915c10ddb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcb3c5684623f53ff01c1b79e4153ae1bcb7c6983fa3dbb890bdfd03b1751a50f3db4a76c4cdcb4ebeeb524e3da3b6d96d62d9e035b275a91da1b6f259b78c2c"} build_url:https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/cwm5B6rTTEOFEjg2JInzFw/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/f2ad59c077c2c7cb5babbf170167b46afe2ad48b21c7110bda8c8c8af3894ff9b5a21d087694068ea7d90d0149ee037fbf0904553c988d478fe105915c10ddb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fcb3c5684623f53ff01c1b79e4153ae1bcb7c6983fa3dbb890bdfd03b1751a50f3db4a76c4cdcb4ebeeb524e3da3b6d96d62d9e035b275a91da1b6f259b78c2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-22 19:29:11.640429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:29:11.640774) ========= 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=920470bf432669ad7e3a5387000001ca-1463967505.940570-1618855417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-22 19:29:11.723539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 19:29:11.723855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-22 19:29:11.724200) ========= ========= Total master_lag: 0.20 =========