builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1461187873.4 results: success (0) buildid: 20160420120429 builduid: ae4579530dd54e17a53496a45dc9bbcc revision: 5649dee23169c659655bfd2f9bae78b5b1bed073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.400248) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.400763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.401043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.417764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.418052) ========= 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=0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 14:31:13-- 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% 19.4M=0.001s 2016-04-20 14:31:13 (19.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.561303) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.561586) ========= 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=0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017235 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:13.649752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 14:31:13.650100) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5649dee23169c659655bfd2f9bae78b5b1bed073 --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 5649dee23169c659655bfd2f9bae78b5b1bed073 --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=0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 14:31:14,054 truncating revision to first 12 chars 2016-04-20 14:31:14,054 Setting DEBUG logging. 2016-04-20 14:31:14,054 attempt 1/10 2016-04-20 14:31:14,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5649dee23169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 14:31:14,866 unpacking tar archive at: mozilla-aurora-5649dee23169/testing/mozharness/ program finished with exit code 0 elapsedTime=1.079898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 14:31:14.746969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.750302) ========= script_repo_revision: 5649dee23169c659655bfd2f9bae78b5b1bed073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.750697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.750978) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:31:14.760711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-20 14:31:14.761047) ========= /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=0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:15 INFO - MultiFileLogger online at 20160420 14:31:15 in /builds/slave/test 14:31:15 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 14:31:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:15 INFO - {'append_to_log': False, 14:31:15 INFO - 'base_work_dir': '/builds/slave/test', 14:31:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:31:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:15 INFO - 'branch': 'Mozilla-Aurora', 14:31:15 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:15 INFO - 'config_files': ('talos/linux_config.py',), 14:31:15 INFO - 'default_actions': ('clobber', 14:31:15 INFO - 'read-buildbot-config', 14:31:15 INFO - 'download-and-extract', 14:31:15 INFO - 'populate-webroot', 14:31:15 INFO - 'create-virtualenv', 14:31:15 INFO - 'install', 14:31:15 INFO - 'run-tests'), 14:31:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:15 INFO - 'download_minidump_stackwalk': True, 14:31:15 INFO - 'download_symbols': 'ondemand', 14:31:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:15 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:15 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:15 INFO - 'installer_path': 'installer.exe', 14:31:15 INFO - 'log_level': 'info', 14:31:15 INFO - 'log_name': 'talos', 14:31:15 INFO - 'log_to_console': True, 14:31:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:15 INFO - 'opt_config_files': (), 14:31:15 INFO - 'pip_index': False, 14:31:15 INFO - 'sps_profile': False, 14:31:15 INFO - 'sps_profile_interval': 0, 14:31:15 INFO - 'suite': 'dromaeojs-e10s', 14:31:15 INFO - 'system_bits': '32', 14:31:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:15 INFO - 'title': 'talos-linux64-ix-017', 14:31:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:15 INFO - 'use_talos_json': True, 14:31:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:15 INFO - 'work_dir': 'build'} 14:31:15 INFO - ##### 14:31:15 INFO - ##### Running clobber step. 14:31:15 INFO - ##### 14:31:15 INFO - Running pre-action listener: _resource_record_pre_action 14:31:15 INFO - Running main action method: clobber 14:31:15 INFO - rmtree: /builds/slave/test/build 14:31:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:16 INFO - Running post-action listener: _resource_record_post_action 14:31:16 INFO - ##### 14:31:16 INFO - ##### Running read-buildbot-config step. 14:31:16 INFO - ##### 14:31:16 INFO - Running pre-action listener: _resource_record_pre_action 14:31:16 INFO - Running main action method: read_buildbot_config 14:31:16 INFO - Using buildbot properties: 14:31:16 INFO - { 14:31:16 INFO - "project": "", 14:31:16 INFO - "product": "firefox", 14:31:16 INFO - "script_repo_revision": "production", 14:31:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:31:16 INFO - "repository": "", 14:31:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:31:16 INFO - "buildid": "20160420120429", 14:31:16 INFO - "pgo_build": "True", 14:31:16 INFO - "basedir": "/builds/slave/test", 14:31:16 INFO - "buildnumber": 221, 14:31:16 INFO - "slavename": "talos-linux64-ix-017", 14:31:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:31:16 INFO - "platform": "ubuntu64_hw", 14:31:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:31:16 INFO - "branch": "mozilla-aurora", 14:31:16 INFO - "repo_path": "releases/mozilla-aurora", 14:31:16 INFO - "revision": "5649dee23169c659655bfd2f9bae78b5b1bed073", 14:31:16 INFO - "stage_platform": "linux64-pgo", 14:31:16 INFO - "builduid": "ae4579530dd54e17a53496a45dc9bbcc", 14:31:16 INFO - "slavebuilddir": "test" 14:31:16 INFO - } 14:31:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 14:31:16 INFO - Running post-action listener: _resource_record_post_action 14:31:16 INFO - ##### 14:31:16 INFO - ##### Running download-and-extract step. 14:31:16 INFO - ##### 14:31:16 INFO - Running pre-action listener: _resource_record_pre_action 14:31:16 INFO - Running main action method: download_and_extract 14:31:16 INFO - mkdir: /builds/slave/test/build/tests 14:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:16 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:31:27 INFO - Downloaded 1448 bytes. 14:31:27 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 14:31:27 INFO - Using the following test package requirements: 14:31:27 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 14:31:27 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:27 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:31:27 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'jsshell-linux-x86_64.zip'], 14:31:27 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:27 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 14:31:27 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:31:27 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:31:27 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:27 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 14:31:27 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 14:31:27 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:27 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:42 INFO - Downloaded 23352853 bytes. 14:31:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:43 INFO - Return code: 0 14:31:43 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:43 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 14:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:54 INFO - Downloaded 23352853 bytes. 14:31:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:55 INFO - Return code: 0 14:31: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')]} 14:31:55 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 14:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 14:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 14:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:31:56 INFO - Downloaded 10845168 bytes. 14:31:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:31:57 INFO - Return code: 0 14:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:57 INFO - https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:31:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:31:58 INFO - Downloaded 60600916 bytes. 14:31:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:31:58 INFO - mkdir: /builds/slave/test/properties 14:31:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:58 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:58 INFO - Contents: 14:31:58 INFO - build_url:https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 14:32:00 INFO - Running post-action listener: _resource_record_post_action 14:32:00 INFO - Running post-action listener: set_extra_try_arguments 14:32:00 INFO - ##### 14:32:00 INFO - ##### Running populate-webroot step. 14:32:00 INFO - ##### 14:32:00 INFO - Running pre-action listener: _resource_record_pre_action 14:32:00 INFO - Running main action method: populate_webroot 14:32:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:00 INFO - '--tppagecycles', 14:32:00 INFO - '7'], 14:32:00 INFO - 'tests': ['tsvgm']}}, 14:32:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:32:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:32:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'tests': ['damp', 'tps']}, 14:32:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['damp', 'tps']}, 14:32:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:32:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:00 INFO - 'other': {'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other_l64': {'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other_nol64': {'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'svgr': {'tests': ['tsvgx', 14:32:00 INFO - 'tsvgr_opacity', 14:32:00 INFO - 'tart', 14:32:00 INFO - 'tscrollx', 14:32:00 INFO - 'cart']}, 14:32:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['tsvgx', 14:32:00 INFO - 'tsvgr_opacity', 14:32:00 INFO - 'tart', 14:32:00 INFO - 'tscrollx', 14:32:00 INFO - 'cart']}, 14:32:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'tests': ['tp5o']}, 14:32:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--e10s'], 14:32:00 INFO - 'tests': ['tp5o']}, 14:32:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--xperf_path', 14:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:00 INFO - 'tests': ['tp5n']}, 14:32:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--e10s', 14:32:00 INFO - '--xperf_path', 14:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:00 INFO - 'tests': ['tp5n']}}, 14:32:00 INFO - 'talos.zip': {'path': '', 14:32:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:00 INFO - Running post-action listener: _resource_record_post_action 14:32:00 INFO - ##### 14:32:00 INFO - ##### Running create-virtualenv step. 14:32:00 INFO - ##### 14:32:00 INFO - Running pre-action listener: _resource_record_pre_action 14:32:00 INFO - Running main action method: create_virtualenv 14:32:00 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:32:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:00 INFO - Using real prefix '/usr' 14:32:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:03 INFO - Installing pip.................done. 14:32:03 INFO - Return code: 0 14:32:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32: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', 'pip>=1.5'] in /builds/slave/test/build 14:32: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 pip>=1.5 14:32:03 INFO - Using env: {'DISPLAY': ':0', 14:32:03 INFO - 'HOME': '/home/cltbld', 14:32:03 INFO - 'LANG': 'en_US.UTF-8', 14:32:03 INFO - 'LANGUAGE': 'en_US:en', 14:32:03 INFO - 'LOGNAME': 'cltbld', 14:32:03 INFO - 'MAIL': '/var/mail/cltbld', 14:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:03 INFO - 'MOZ_NO_REMOTE': '1', 14:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:03 INFO - 'NO_EM_RESTART': '1', 14:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:03 INFO - 'PWD': '/builds/slave/test', 14:32:03 INFO - 'SHELL': '/bin/bash', 14:32:03 INFO - 'SHLVL': '1', 14:32:03 INFO - 'TERM': 'linux', 14:32:03 INFO - 'TMOUT': '86400', 14:32:03 INFO - 'USER': 'cltbld', 14:32:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:03 INFO - '_': '/tools/buildbot/bin/python'} 14:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:32:03 INFO - Cleaning up... 14:32:03 INFO - Return code: 0 14:32:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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', '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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:32: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 psutil>=0.7.1 14:32:03 INFO - Using env: {'DISPLAY': ':0', 14:32:03 INFO - 'HOME': '/home/cltbld', 14:32:03 INFO - 'LANG': 'en_US.UTF-8', 14:32:03 INFO - 'LANGUAGE': 'en_US:en', 14:32:03 INFO - 'LOGNAME': 'cltbld', 14:32:03 INFO - 'MAIL': '/var/mail/cltbld', 14:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:03 INFO - 'MOZ_NO_REMOTE': '1', 14:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:03 INFO - 'NO_EM_RESTART': '1', 14:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:03 INFO - 'PWD': '/builds/slave/test', 14:32:03 INFO - 'SHELL': '/bin/bash', 14:32:03 INFO - 'SHLVL': '1', 14:32:03 INFO - 'TERM': 'linux', 14:32:03 INFO - 'TMOUT': '86400', 14:32:03 INFO - 'USER': 'cltbld', 14:32:03 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:03 INFO - '_': '/tools/buildbot/bin/python'} 14:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:03 INFO - Downloading/unpacking psutil>=0.7.1 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:05 INFO - Installing collected packages: psutil 14:32:05 INFO - Running setup.py install for psutil 14:32:05 INFO - building 'psutil._psutil_linux' extension 14:32:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:32:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:32:05 INFO - building 'psutil._psutil_posix' extension 14:32:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:32:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:32:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:06 INFO - Successfully installed psutil 14:32:06 INFO - Cleaning up... 14:32:06 INFO - Return code: 0 14:32:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:06 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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:32:06 INFO - Using env: {'DISPLAY': ':0', 14:32:06 INFO - 'HOME': '/home/cltbld', 14:32:06 INFO - 'LANG': 'en_US.UTF-8', 14:32:06 INFO - 'LANGUAGE': 'en_US:en', 14:32:06 INFO - 'LOGNAME': 'cltbld', 14:32:06 INFO - 'MAIL': '/var/mail/cltbld', 14:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:06 INFO - 'MOZ_NO_REMOTE': '1', 14:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:06 INFO - 'NO_EM_RESTART': '1', 14:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:06 INFO - 'PWD': '/builds/slave/test', 14:32:06 INFO - 'SHELL': '/bin/bash', 14:32:06 INFO - 'SHLVL': '1', 14:32:06 INFO - 'TERM': 'linux', 14:32:06 INFO - 'TMOUT': '86400', 14:32:06 INFO - 'USER': 'cltbld', 14:32:06 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:06 INFO - '_': '/tools/buildbot/bin/python'} 14:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:32:08 INFO - Installing collected packages: mozsystemmonitor 14:32:08 INFO - Running setup.py install for mozsystemmonitor 14:32:08 INFO - Successfully installed mozsystemmonitor 14:32:08 INFO - Cleaning up... 14:32:08 INFO - Return code: 0 14:32:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:08 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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:32:08 INFO - Using env: {'DISPLAY': ':0', 14:32:08 INFO - 'HOME': '/home/cltbld', 14:32:08 INFO - 'LANG': 'en_US.UTF-8', 14:32:08 INFO - 'LANGUAGE': 'en_US:en', 14:32:08 INFO - 'LOGNAME': 'cltbld', 14:32:08 INFO - 'MAIL': '/var/mail/cltbld', 14:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:08 INFO - 'MOZ_NO_REMOTE': '1', 14:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:08 INFO - 'NO_EM_RESTART': '1', 14:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:08 INFO - 'PWD': '/builds/slave/test', 14:32:08 INFO - 'SHELL': '/bin/bash', 14:32:08 INFO - 'SHLVL': '1', 14:32:08 INFO - 'TERM': 'linux', 14:32:08 INFO - 'TMOUT': '86400', 14:32:08 INFO - 'USER': 'cltbld', 14:32:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:08 INFO - '_': '/tools/buildbot/bin/python'} 14:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:08 INFO - Downloading/unpacking blobuploader==1.2.4 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:10 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:11 INFO - Downloading docopt-0.6.1.tar.gz 14:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:11 INFO - Running setup.py install for blobuploader 14:32:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:11 INFO - Running setup.py install for requests 14:32:11 INFO - Running setup.py install for docopt 14:32:12 INFO - Successfully installed blobuploader requests docopt 14:32:12 INFO - Cleaning up... 14:32:12 INFO - Return code: 0 14:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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')]} 14:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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')]} 14:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:12 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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:32:12 INFO - Using env: {'DISPLAY': ':0', 14:32:12 INFO - 'HOME': '/home/cltbld', 14:32:12 INFO - 'LANG': 'en_US.UTF-8', 14:32:12 INFO - 'LANGUAGE': 'en_US:en', 14:32:12 INFO - 'LOGNAME': 'cltbld', 14:32:12 INFO - 'MAIL': '/var/mail/cltbld', 14:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:12 INFO - 'MOZ_NO_REMOTE': '1', 14:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:12 INFO - 'NO_EM_RESTART': '1', 14:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:12 INFO - 'PWD': '/builds/slave/test', 14:32:12 INFO - 'SHELL': '/bin/bash', 14:32:12 INFO - 'SHLVL': '1', 14:32:12 INFO - 'TERM': 'linux', 14:32:12 INFO - 'TMOUT': '86400', 14:32:12 INFO - 'USER': 'cltbld', 14:32:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:12 INFO - '_': '/tools/buildbot/bin/python'} 14:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:12 INFO - Running setup.py (path:/tmp/pip-DwXxu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:12 INFO - Running setup.py (path:/tmp/pip-bN6iBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:12 INFO - Running setup.py (path:/tmp/pip-FtkUxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:12 INFO - Running setup.py (path:/tmp/pip-aNNwJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:12 INFO - Running setup.py (path:/tmp/pip-db7PKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:12 INFO - Running setup.py (path:/tmp/pip-TUDhHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:12 INFO - Running setup.py (path:/tmp/pip-3CDTdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:12 INFO - Running setup.py (path:/tmp/pip-CquySd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:12 INFO - Running setup.py (path:/tmp/pip-vTkaKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:12 INFO - Running setup.py (path:/tmp/pip-LtfJY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:13 INFO - Running setup.py (path:/tmp/pip-q7ffYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:13 INFO - Running setup.py (path:/tmp/pip-7C96X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:13 INFO - Running setup.py (path:/tmp/pip-OqDMM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:13 INFO - Running setup.py (path:/tmp/pip-lhtHMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:13 INFO - Running setup.py (path:/tmp/pip-RcolIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:13 INFO - Running setup.py (path:/tmp/pip-6ZPY8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:13 INFO - Running setup.py (path:/tmp/pip-hRlH9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:13 INFO - Running setup.py install for manifestparser 14:32:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Running setup.py install for mozcrash 14:32:13 INFO - Running setup.py install for mozdebug 14:32:13 INFO - Running setup.py install for mozdevice 14:32:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Running setup.py install for mozfile 14:32:14 INFO - Running setup.py install for mozhttpd 14:32:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for mozinfo 14:32:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for mozInstall 14:32:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for mozleak 14:32:14 INFO - Running setup.py install for mozlog 14:32:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for moznetwork 14:32:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for mozprocess 14:32:14 INFO - Running setup.py install for mozprofile 14:32:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for mozrunner 14:32:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:14 INFO - Running setup.py install for mozscreenshot 14:32:15 INFO - Running setup.py install for moztest 14:32:15 INFO - Running setup.py install for mozversion 14:32:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:15 INFO - Cleaning up... 14:32:15 INFO - Return code: 0 14:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:15 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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:32:15 INFO - Using env: {'DISPLAY': ':0', 14:32:15 INFO - 'HOME': '/home/cltbld', 14:32:15 INFO - 'LANG': 'en_US.UTF-8', 14:32:15 INFO - 'LANGUAGE': 'en_US:en', 14:32:15 INFO - 'LOGNAME': 'cltbld', 14:32:15 INFO - 'MAIL': '/var/mail/cltbld', 14:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:15 INFO - 'MOZ_NO_REMOTE': '1', 14:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:15 INFO - 'NO_EM_RESTART': '1', 14:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:15 INFO - 'PWD': '/builds/slave/test', 14:32:15 INFO - 'SHELL': '/bin/bash', 14:32:15 INFO - 'SHLVL': '1', 14:32:15 INFO - 'TERM': 'linux', 14:32:15 INFO - 'TMOUT': '86400', 14:32:15 INFO - 'USER': 'cltbld', 14:32:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:15 INFO - '_': '/tools/buildbot/bin/python'} 14:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:15 INFO - Running setup.py (path:/tmp/pip-rq0cU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:15 INFO - Running setup.py (path:/tmp/pip-8tIG3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:15 INFO - Running setup.py (path:/tmp/pip-TGn5ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:15 INFO - Running setup.py (path:/tmp/pip-eOg1G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:15 INFO - Running setup.py (path:/tmp/pip-o1lNNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:15 INFO - Running setup.py (path:/tmp/pip-sx1VqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:15 INFO - Running setup.py (path:/tmp/pip-2vCWTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:16 INFO - Running setup.py (path:/tmp/pip-36Ocgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:16 INFO - Running setup.py (path:/tmp/pip-kDlywy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:16 INFO - Running setup.py (path:/tmp/pip-Y_gi_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:16 INFO - Running setup.py (path:/tmp/pip-6AheIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:16 INFO - Running setup.py (path:/tmp/pip-O2dk72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:16 INFO - Running setup.py (path:/tmp/pip-xDsXTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:16 INFO - Running setup.py (path:/tmp/pip-tmIGPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:16 INFO - Running setup.py (path:/tmp/pip-6BdUPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:16 INFO - Running setup.py (path:/tmp/pip-QMfrkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:16 INFO - Running setup.py (path:/tmp/pip-IYHdGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:32:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:18 INFO - Downloading blessings-1.6.tar.gz 14:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:18 INFO - Installing collected packages: blessings 14:32:18 INFO - Running setup.py install for blessings 14:32:18 INFO - Successfully installed blessings 14:32:18 INFO - Cleaning up... 14:32:18 INFO - Return code: 0 14:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:19 INFO - Reading from file tmpfile_stdout 14:32:19 INFO - Current package versions: 14:32:19 INFO - argparse == 1.2.1 14:32:19 INFO - blessings == 1.6 14:32:19 INFO - blobuploader == 1.2.4 14:32:19 INFO - docopt == 0.6.1 14:32:19 INFO - manifestparser == 1.1 14:32:19 INFO - mozInstall == 1.12 14:32:19 INFO - mozcrash == 0.17 14:32:19 INFO - mozdebug == 0.1 14:32:19 INFO - mozdevice == 0.48 14:32:19 INFO - mozfile == 1.2 14:32:19 INFO - mozhttpd == 0.7 14:32:19 INFO - mozinfo == 0.9 14:32:19 INFO - mozleak == 0.1 14:32:19 INFO - mozlog == 3.1 14:32:19 INFO - moznetwork == 0.27 14:32:19 INFO - mozprocess == 0.22 14:32:19 INFO - mozprofile == 0.28 14:32:19 INFO - mozrunner == 6.11 14:32:19 INFO - mozscreenshot == 0.1 14:32:19 INFO - mozsystemmonitor == 0.0 14:32:19 INFO - moztest == 0.7 14:32:19 INFO - mozversion == 1.4 14:32:19 INFO - psutil == 3.1.1 14:32:19 INFO - requests == 1.2.3 14:32:19 INFO - wsgiref == 0.1.2 14:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:32:19 INFO - Using env: {'DISPLAY': ':0', 14:32:19 INFO - 'HOME': '/home/cltbld', 14:32:19 INFO - 'LANG': 'en_US.UTF-8', 14:32:19 INFO - 'LANGUAGE': 'en_US:en', 14:32:19 INFO - 'LOGNAME': 'cltbld', 14:32:19 INFO - 'MAIL': '/var/mail/cltbld', 14:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:19 INFO - 'MOZ_NO_REMOTE': '1', 14:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:19 INFO - 'NO_EM_RESTART': '1', 14:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:19 INFO - 'PWD': '/builds/slave/test', 14:32:19 INFO - 'SHELL': '/bin/bash', 14:32:19 INFO - 'SHLVL': '1', 14:32:19 INFO - 'TERM': 'linux', 14:32:19 INFO - 'TMOUT': '86400', 14:32:19 INFO - 'USER': 'cltbld', 14:32:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:19 INFO - '_': '/tools/buildbot/bin/python'} 14:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:32:19 INFO - Cleaning up... 14:32:19 INFO - Return code: 0 14:32:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32: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', 'jsonschema'] in /builds/slave/test/build 14:32: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 jsonschema 14:32:19 INFO - Using env: {'DISPLAY': ':0', 14:32:19 INFO - 'HOME': '/home/cltbld', 14:32:19 INFO - 'LANG': 'en_US.UTF-8', 14:32:19 INFO - 'LANGUAGE': 'en_US:en', 14:32:19 INFO - 'LOGNAME': 'cltbld', 14:32:19 INFO - 'MAIL': '/var/mail/cltbld', 14:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:19 INFO - 'MOZ_NO_REMOTE': '1', 14:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:19 INFO - 'NO_EM_RESTART': '1', 14:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:19 INFO - 'PWD': '/builds/slave/test', 14:32:19 INFO - 'SHELL': '/bin/bash', 14:32:19 INFO - 'SHLVL': '1', 14:32:19 INFO - 'TERM': 'linux', 14:32:19 INFO - 'TMOUT': '86400', 14:32:19 INFO - 'USER': 'cltbld', 14:32:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:19 INFO - '_': '/tools/buildbot/bin/python'} 14:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:19 INFO - Downloading/unpacking jsonschema 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:21 INFO - Downloading/unpacking functools32 (from jsonschema) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:21 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:21 INFO - warning: no files found matching '*.txt' 14:32:21 INFO - no previously-included directories found matching 'build' 14:32:21 INFO - no previously-included directories found matching 'dist' 14:32:21 INFO - no previously-included directories found matching '.git*' 14:32:21 INFO - Installing collected packages: jsonschema, functools32 14:32:21 INFO - Running setup.py install for functools32 14:32:21 INFO - warning: no files found matching '*.txt' 14:32:21 INFO - no previously-included directories found matching 'build' 14:32:21 INFO - no previously-included directories found matching 'dist' 14:32:21 INFO - no previously-included directories found matching '.git*' 14:32:21 INFO - Successfully installed jsonschema functools32 14:32:21 INFO - Cleaning up... 14:32:21 INFO - Return code: 0 14:32:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:21 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 0x7f415696cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x150f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15dc410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, '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': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:32:21 INFO - Using env: {'DISPLAY': ':0', 14:32:21 INFO - 'HOME': '/home/cltbld', 14:32:21 INFO - 'LANG': 'en_US.UTF-8', 14:32:21 INFO - 'LANGUAGE': 'en_US:en', 14:32:21 INFO - 'LOGNAME': 'cltbld', 14:32:21 INFO - 'MAIL': '/var/mail/cltbld', 14:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:21 INFO - 'MOZ_NO_REMOTE': '1', 14:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:21 INFO - 'NO_EM_RESTART': '1', 14:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:21 INFO - 'PWD': '/builds/slave/test', 14:32:21 INFO - 'SHELL': '/bin/bash', 14:32:21 INFO - 'SHLVL': '1', 14:32:21 INFO - 'TERM': 'linux', 14:32:21 INFO - 'TMOUT': '86400', 14:32:21 INFO - 'USER': 'cltbld', 14:32:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:21 INFO - '_': '/tools/buildbot/bin/python'} 14:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:22 INFO - Downloading/unpacking flake8 14:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:32:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:32:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:24 INFO - no previously-included directories found matching 'docs/_build' 14:32:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:32:24 INFO - Running setup.py install for pep8 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:24 INFO - no previously-included directories found matching 'docs/_build' 14:32:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:32:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:32:24 INFO - Cleaning up... 14:32:24 INFO - Return code: 0 14:32:24 INFO - Running post-action listener: _resource_record_post_action 14:32:24 INFO - Running post-action listener: _start_resource_monitoring 14:32:24 INFO - Starting resource monitoring. 14:32:24 INFO - ##### 14:32:24 INFO - ##### Running install step. 14:32:24 INFO - ##### 14:32:24 INFO - Running pre-action listener: _resource_record_pre_action 14:32:24 INFO - Running main action method: install 14:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:25 INFO - Reading from file tmpfile_stdout 14:32:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:25 INFO - Reading from file tmpfile_stdout 14:32:25 INFO - Output received: 14:32:25 INFO - Usage: mozinstall [options] installer 14:32:25 INFO - Options: 14:32:25 INFO - -h, --help show this help message and exit 14:32:25 INFO - -d DEST, --destination=DEST 14:32:25 INFO - Directory to install application into. [default: 14:32:25 INFO - "/builds/slave/test"] 14:32:25 INFO - --app=APP Application being installed. [default: firefox] 14:32:25 INFO - mkdir: /builds/slave/test/build/application 14:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:32:40 INFO - Reading from file tmpfile_stdout 14:32:40 INFO - Output received: 14:32:40 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:40 INFO - Running post-action listener: _resource_record_post_action 14:32:40 INFO - ##### 14:32:40 INFO - ##### Running run-tests step. 14:32:40 INFO - ##### 14:32:40 INFO - Running pre-action listener: _resource_record_pre_action 14:32:40 INFO - Running main action method: run_tests 14:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:40 INFO - Python 2.7.3 14:32:40 INFO - Return code: 0 14:32:40 INFO - grabbing minidump binary from tooltool 14:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:40 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 0x166b160>, '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 0x166c060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166c4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:32:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:32:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:40 INFO - Return code: 0 14:32:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:32:41 INFO - Return code: 0 14:32:41 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/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 14:32:41 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/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 14:32:41 INFO - Using env: {'DISPLAY': ':0', 14:32:41 INFO - 'HOME': '/home/cltbld', 14:32:41 INFO - 'LANG': 'en_US.UTF-8', 14:32:41 INFO - 'LANGUAGE': 'en_US:en', 14:32:41 INFO - 'LOGNAME': 'cltbld', 14:32:41 INFO - 'MAIL': '/var/mail/cltbld', 14:32:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:41 INFO - 'MOZ_NO_REMOTE': '1', 14:32:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:41 INFO - 'NO_EM_RESTART': '1', 14:32:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:41 INFO - 'PWD': '/builds/slave/test', 14:32:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:41 INFO - 'SHELL': '/bin/bash', 14:32:41 INFO - 'SHLVL': '1', 14:32:41 INFO - 'TERM': 'linux', 14:32:41 INFO - 'TMOUT': '86400', 14:32:41 INFO - 'USER': 'cltbld', 14:32:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369', 14:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:41 INFO - '_': '/tools/buildbot/bin/python'} 14:32:41 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/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 14:32:41 INFO - mozversion application_buildid: 20160420120429 14:32:41 INFO - mozversion application_changeset: 5649dee23169c659655bfd2f9bae78b5b1bed073 14:32:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:32:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:41 INFO - mozversion application_name: Firefox 14:32:41 INFO - mozversion application_remotingname: firefox-dev 14:32:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:32:41 INFO - mozversion application_vendor: Mozilla 14:32:41 INFO - mozversion application_version: 47.0a2 14:32:41 INFO - mozversion platform_buildid: 20160420120429 14:32:41 INFO - mozversion platform_changeset: 5649dee23169c659655bfd2f9bae78b5b1bed073 14:32:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:32:41 INFO - mozversion platform_version: 47.0a2 14:32:41 INFO - using testdate: 1461187961 14:32:41 INFO - actual date: 1461187961 14:32:41 INFO - starting webserver on 'localhost:41664' 14:32:41 INFO - SUITE-START | Running 2 tests 14:32:41 INFO - TEST-START | dromaeo_css 14:32:41 INFO - operating with platform_type : linux_ 14:32:41 INFO - Initialising browser for dromaeo_css test... 14:32:41 INFO - TEST-INFO | started process 13738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QYOw6/profile http://localhost:41664/getInfo.html) 14:32:45 INFO - PROCESS | 13738 | 14:32:45 INFO - PROCESS | 13738 | (process:13813): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:32:46 INFO - PROCESS | 13738 | __metrics Screen width/height:1600/1200 14:32:46 INFO - PROCESS | 13738 | colorDepth:24 14:32:46 INFO - PROCESS | 13738 | Browser inner width/height: 1024/697 14:32:46 INFO - PROCESS | 13738 | __metrics 14:32:46 ERROR - PROCESS | 13738 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:32:47 INFO - TEST-INFO | 13738: exit 0 14:32:47 INFO - Browser initialized. 14:32:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:47 INFO - TEST-INFO | started process 13864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4QYOw6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:49 INFO - PROCESS | 13864 | 14:32:49 INFO - PROCESS | 13864 | (process:13932): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:32:59 INFO - PROCESS | 13864 | RSS: Main: 151142400 14:32:59 INFO - PROCESS | 13864 | 14:33:49 INFO - PROCESS | 13864 | 1461188029235 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:35:57 INFO - PROCESS | 13864 | Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41664/tests/dromaeo/cssquery-ext.html) 14:35:58 INFO - PROCESS | 13864 | RSS: Main: 155357184 14:35:58 INFO - PROCESS | 13864 | 14:39:00 INFO - PROCESS | 13864 | Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-ext.html (next: http://localhost:41664/tests/dromaeo/cssquery-jquery.html) 14:39:00 INFO - PROCESS | 13864 | RSS: Main: 153456640 14:39:00 INFO - PROCESS | 13864 | 14:42:02 INFO - PROCESS | 13864 | Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41664/tests/dromaeo/cssquery-mootools.html) 14:42:03 INFO - PROCESS | 13864 | RSS: Main: 152944640 14:42:03 INFO - PROCESS | 13864 | 14:45:04 INFO - PROCESS | 13864 | Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41664/tests/dromaeo/cssquery-prototype.html) 14:45:05 INFO - PROCESS | 13864 | RSS: Main: 152719360 14:45:05 INFO - PROCESS | 13864 | 14:48:07 INFO - PROCESS | 13864 | Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41664/tests/dromaeo/cssquery-yui.html) 14:48:08 INFO - PROCESS | 13864 | RSS: Main: 154148864 14:48:08 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-yui.html (next: http://localhost:41664/tests/dromaeo/cssquery-dojo.html) 14:51:10 INFO - PROCESS | 13864 | RSS: Main: 155656192 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | __start_tp_report 14:51:10 INFO - PROCESS | 13864 | _x_x_mozilla_page_load 14:51:10 INFO - PROCESS | 13864 | _x_x_mozilla_page_load_details 14:51:10 INFO - PROCESS | 13864 | |i|pagename|runs| 14:51:10 INFO - PROCESS | 13864 | |0;dojo.html;3339.3488269787395;3357.932841343173;3413.2490852012547;3437.8968630941063;3465.445528715406;5549.722513874311;5605.439456054392;5617.213590097384;5638.633488823229;5654.660720356782;5628.212050312949;5628.802991895284;5651.660900345972;5657.603967722261;5687.829365119042;5072.974635126829;5113.386393632751;5130.692158470485;5182.352205974254;5221.373435187783;5022.673526220784;5175.767090480937;5228.660137091096;5246.186841039645;5300.522952934235;5179.922301165486;5212.713300768475;5274.604404669646;5276.841694749144;5323;5226.24219488174;5248.317718696583;5251.291075704788;5255.710935898524;5287.735613219324;4975.850724478271;4999.4250661174065;5105.846824595268;5149.485051494858;5231.346081739783;5463.590230732671;5466.753996070186;5513.807016754435;5516.475934786229;5531.695756733378;6061.302950160743;6096.939030609681;6136.355682653347;6159.907601385938;6170.8765824683705;6115.388461153893;6145.3547377525165;6164.87670246597;6172.537059720494;6178;5735.766810135758;5744.052231381817;5753.856153596152;5757.596968212227;5783.913241301384;6088.573799833969;6147.72335244915;6232.283287421914;6255.562110652301;6274.403931626488;6015.639061656315;6024.608400453956;6033.306169790442;6037.335893051761;6043.214382130295;6103.786367477117;6105.877882442326;6113.266408030976;6130.693465326716;6138.693065346715;5895.734691938873;6027.668478233739;6068.150458935753;6122.12371750169;6130.2030736004035;6035.094735789579;6055.455009049207;6098.35967223444;6102.389761023951;6102.572819902564;4612.377329060601;4618.792154353062;4621.468531118897;4631.95368046322;4632.60622847055;4050.9594904051173;4101.610347017028;4119.505659320841;4147.502299723992;4172.561881002451;5627.43725627434;5715.857103572361;5742.971285143631;5750.942490575041;5798.8550286242335;6077.301110372364;6097;6109.541784366191;6147.108669242934;6151.6001459904965;5605.850800585951;5705.286839145107;5779.566532510079;5790.623609465371;5823.475887170175;5197.7401129943355;5233.4243233244315;5248.317718696621;5249.763760630781;5259.342582177228;6284.402981716729;6314.8421289467215;6347.5239357047485;6350.491960643138;6359.014352775327;5913.793017244548;5923.289205295392;6086.573939824169;6094.055421409688;6125.785597504066;6269.216347956505;6311.747530098744;6322.589031712924;6328.841778955563;6329;5926.970365148319;6065.8180254592435;6077.604955678044;6081.179040829431;6092.45167934888;6142.2629284484365;6190.876182476415;6213.347598502273;6239.1577137085915;6246.3441338660605;5874.676892770939;5892.112864696353;5899.115132730125;5913.113033045078;5968.820935371946;5675;5818.912716309174;5878.647281163144;5914.58597898143;5931.1399847021075;5768.048272035067;5838.4453476919625;5868.589198756046;5877.324107727666;5901.439363260483;5947.851303717442;5954.047352423591;5965.433283838029;5980.222571065734;6002.759889604367;5720.914186287126;5826.0387036140255;5835.44563266489;5838.3869693683255;5856.677882716492 14:51:10 INFO - PROCESS | 13864 | |1;ext.html;509.1649694501017;558.4945624210088;578.7945279425804;596.2785030113563;667.9098321726566;31119.222019449524;38112;38792.22415551687;38823;38870.41694374587;42705.78647106768;43073.78463107688;43465;43485;43641;8773.385862989593;9043;9045.909540904573;9053.456792592433;9070.77323066922;8869.467831930106;8980.506072166028;8996.775080623003;9024.23294020009;9031.503267320295;8934.55327233639;9042.276617870588;9055.728328150133;9071.863922041175;9089.545522723838;8891.4665120093;8907.376483646147;8967.192952634294;9148.817023659489;9168.541572921395;9028.548572571412;9217.677381291689;9232.723018309462;9245.537723113885;9251.861222081674;42896.78551607222;42929.57070429318;42964.14071718548;43298.56701432977;43321.78339108316;3834.4056671215726;3927.705422093326;4266.978665106686;4275.007494753685;4544.182047231497;32577.022689319358;32776.83611581927;32827.17932051694;32933.3413331732;32989.67010329914;4102.5076990761;4131.277026520377;4139.734765486552;4151.232022075926;4218.915621687549;290869;291577;292706;294360;294366.52816735994;45629;64326.67836660787;65329.34670653327;65334.673326634016;65622;41872.16255674869;41973.16053678971;41988.58011419847;42007.57992420098;42090.789546052074;16705.081220532746;16848.24182911772;16914.577135571708;16998.915005424893;17003.40488082911;12961.351932403531;12978.610641680765;13004.21974681522;13035.674108147372;13041.934790325988;14695.706085878222;14877.776833347509;15194.848051519564;15281.235938203044;15307.081575105529;5697.4302569742695;5877;6004;6053.7881174159575;6068.362821903725;913.8172365526921;969.4813274897896;1075.9677209683723;1076.6918194393693;1120.4845770945456;28288.71711282902;28293;28367.43265134686;28789.568156477668;28824.135275941757;1044.7235008167995;1060.8992145746142;1096.857408536901;1156.8033434316187;1228.4471987605614;14387.92806035963;14419.134851908919;14446.855531444551;14450.638734031734;14663.34014969329;333384;335959;360070;360621;484939;52799.73600132052;52938.47061529412;53067.734661326445;53382.19926701103;53421;767.6890859202032;1299.4087690100982;1498.0637101811367;1508.6907184027248;1510.9471168509049;30525.389492209586;30768.538471922493;30817.537736934413;31386.52920206153;31600.841995789873;50775.492245077075;51195.74402127966;51246.231306529684;51316.486835131174;51567.48432515627;308049;314643;315945;317430;317453;35443.29113417666;35621.82189089038;35743;35947.640523594426;36360;48282.275765864244;48289;48936.2659560114;49257.75371123121;49493.50506494889;40188;40239.79880100698;40291;40708.38937415882;41332.173356533305;38478.42282365711;40791.7960410196;40969.18061638691;42145.15709685851;46617.300740488245;38185.42721859119;38885.22229555449;38905.221895561364;39539;39661.405078924414;33426.66573334236;33572.32855342928;34203.82898085494;34355;34513.482297765055;26770;27077.45845083048;27079.323016924736;27082.593761093995;27103.11161690326 14:51:10 INFO - PROCESS | 13864 | |2;jquery.html;360.5763228206858;376.5594254721975;380.47304483290634;382.6345839723065;388.55122333704566;17761.911190444047;18712.157952892117;19897.403077907686;19900;19934.800651993493;16741.748873766905;17341.21964511597;17412.82587174128;17431.564210894732;17466.825331746677;5083;5290.074237008508;5331.760070796804;5333.733313334337;5337.226102215176;5184.974075129619;5359.1425371940495;5524.917126243109;5567.387587365387;5581.888362232753;5447.945520544803;5511;5518.227448157261;5557.360903496109;5846.766129354821;5766.567507436938;5835.562332825055;5837.6497410155525;5841.532677385799;5886.646801191942;5640.2667653205235;5643.887122257573;5662.094064949588;5676.943230567724;5771.88456230873;12384.442700078518;12639.747205055848;12747.362631868462;12754.936225318907;12829.422675979604;2237.7314722233273;2321.466062805547;2332.4402143485613;2662.1747258349974;2990.1179152150166;9549.904500954972;10070.597176112946;10685.679429617125;12528.373581320897;14035.087719298315;1937.6996565532365;1987.3640435060786;2000.0999550202466;2019.0813180003063;2019.8485113616537;63105.684471577806;64891;65467;66091;69039.65480172617;10415.375077495375;10489.265751397481;10784.78430431387;10814.405207713495;10819.729506762395;15209.771853422208;15273.236338183046;15346.079235245921;15381.923090384476;15383.846161538242;7819.609019549;7957.681692732226;7984.840303193903;7988.241117093867;8062.113167551564;7527.8118047049265;7565.167831538526;7575.848483030309;7631;7669.463137580316;4361.323994780814;4702.529747025338;4799.808007679723;4803.327534145223;4813.9037219256115;1892.5079479335197;1895.781985071707;1949.4736421166206;1954.257382194757;1968.6456437841039;931.1433481197315;963.7301555564453;969.3021024862088;1026.4867566216892;1078.3475997021847;15872.682546349239;15972.920135399248;16775.077370744726;18091.54771130732;18429.81570184281;962.3407965543626;969.5055521683851;989.3272574649308;1020.3418794877263;1032.5147180825;10030.799384012278;10175.694729157989;10193;10326.690199294033;10455;335661;336182;340494;461329;464543;67944;69543.3045669547;70125;70687.64656176686;71030.2896971034;1031.0720351683394;1052.5368837711383;1070.421972135054;1075.8493810866485;1077.1221454514703;15564.84435155634;15589.37642494333;15641.530754077396;15711.921440392725;15752.60618484547;32267.838660807483;32648.510272346408;33622.66377336195;33714.15714607154;33845.66154338425;45032.549674502836;46171.769141155426;51368;51442.74278628732;51815.74092129666;8354.16458354184;8683.782905427415;8733.08302628215;8770.693025744069;8921.509316987369;12333.876661233273;13061;13097.476100955855;13588.524401645895;13656.317184140555;11764.529418823151;11854.466549005143;11863.406829658656;12142.635720928387;12287.69280767988;11903.702407439883;11919.82120268214;12126.090543209119;12214.38928053576;12234.449449774604;11499.425028748361;12121.878781212075;12202.084843636585;12211.572594959134;12460.43928023223;8817.867731984154;8868.733937981871;9006.774830629287;9024.503652299187;9102.635894564144;11134.498947547218;11303.491342889754;11362.204645674723;11795.764084718086;12406.751864962831 14:51:10 INFO - PROCESS | 13864 | |3;mootools.html;1564.4837203722773;1570.1207323898618;1793.9641207175857;1848.251458159446;1939.9612007759845;7531.472796904219;8263.380246481507;8282.751517454479;8570.91429085709;8637.74086777397;8389.706360277392;8413.45312554685;8417.494950302986;8448.07071222165;8450.704225352114;2432.9513409731794;2454.0797201049604;2458.791002764767;2463.359526523099;2464.691913510811;2443.6701045358914;2451;2457.348802567321;2458.7787099161073;2460.6432067350224;2431.501542183848;2440.7437219092008;2508.297676650541;2519.0301733832516;2521.6091505816535;2430.052279610953;2444.767747064026;2449.7182823975204;2493.5137648158616;2505.974940250592;2380.9047638094457;2414.9034038638433;2433.0632706407982;2441.40185654514;2479.404942813712;8574.185452382013;8597.871031934526;8645.092265312114;8660.523671198082;8685.826283474295;5288.312519372457;5382.219578161184;5399.433059528732;5427.674339539641;5431.185322201662;3128.1866714654125;3174.825384603846;3180.3003339265324;3294.407006738786;3298.5876765404323;1044.9947750261276;2061.8247448966854;2063.876167429959;2093.3301343570065;2108.39910625471;11644.126690498162;11647.825282620768;11731.941340293244;11746;11792.41037948099;4469.4860091089295;4584.174848527297;4649.535046495391;4748.406449193851;4752.691075080178;9382.24942004638;9384.436933783994;9393.953030234805;9431.339806213498;9442.669506567374;5175.508326708957;5184.377874655065;5198.662086964335;5217.217417387422;5247.449017853147;4325.697201195949;4791.065742180242;4797;4868.440129385095;4922.926156107661;3643.0710168906758;3715.1269451678836;3724.1062145085525;3732.720045996561;3751.7936513491472;1128.4583399967896;1150.5627861412609;1153.901918336934;1155.9190856640123;1157.548556063136;1168.1218355061285;1176.3588844079998;1203.9879601204052;1469.2653673163418;1483.5475180070182;8171.959140204261;8312.709055183039;8348.707795227137;8360.163983601713;8382.287505562095;545.3675807079863;547.8986387518322;555.3335996803771;555.4584280326649;559.9832005039856;6468.902966455507;6496.675166241669;6536.901946470807;6552.410283074546;6593.703283352261;10223.642172523925;10734.19493537972;10735.463226838627;10757.193210509244;10785.975332343414;10304.690859274233;10353.482325883826;10478.580856765644;10551.366917984946;10594.417307048187;8204.712835050745;8328.583570821313;8340.332773378237;8366.623501942428;8370.372222083368;7884.645190966306;7997.280244777765;8004;8075.636596353061;8091.757247282591;9078.137576930181;9232.907670923205;9399.906000939904;9422.811543768948;9504.809903802023;9589.520523973633;9606.471644059644;9880.604775809175;9965.850512242178;9979.20166386702;6451.354864513699;7491.213422590549;7560.735374261874;7629.6566654499575;7762.650680719268;8013.639386227517;8067;8074.677012919417;8086.353091752528;8117.594120293844;7029.578225306498;7257.237990011184;7271.091113610799;7297;7367.668454919649;7103.538270012433;7141.428685705027;7175.31834475724;7268.89096663561;7286;7564.130125035691;7608.31525162738;7610.238976102345;7613.390928725799;7630;7062.964685176541;7077.610731409822;7084.929150708633;7099.467539934422;7106.324899134574;6939.4448444125355;7100.325469080429;7121.074260346122;7123;7126.037984871976 14:51:10 INFO - PROCESS | 13864 | |4;prototype.html;372.3855638196975;372.54549449671424;375.1708723720577;380.68022860796935;381.5021397076815;6433.839154021151;6434.3887330703565;6437.839054023646;6438.098666186737;6456.580322279048;6362.268339141;6365.968170159154;6384.553081284312;6388.105665206875;6410.358964103587;4676.906461870761;4835.250536166882;4929.704217746928;4953.133201689708;4968.900621987558;4884.487128851472;4912.0175964807;4934.80260789568;4939.728314942677;4950.183219768734;4907;4914.508549145093;4917.631177661672;4941.431735350445;4947.208446648537;4920.261960705905;4920.60635149189;4932.8520144395725;4933.8519844404545;4936.851894443173;4391.363252328427;4394.274944634131;4415.293553031532;4418.160549495586;4424.911501769979;5928.28860536734;6110.969445152746;6114.419130182626;6116.571839971204;6122.846928826815;5691.345495268014;5704.857378565569;5723.427657234285;5729.455701708331;5729.684867332295;6806.693698783567;6821.317868213188;6829.521933464659;6830.931690683079;6833.111695479556;4720.527947205286;4729.6452766042685;4733.668643194977;4736.407949006374;4743.739094349809;7092.255313192092;7161.0332605098165;7164.749233776845;7164.892526612105;7173.748918787817;4754.548317909793;4772.403449568804;4803.519648035169;4822.107910036654;4840.419149702058;4873.975630121898;4875.926861097087;4882.853514394574;4891.853244402673;4893.779779909913;5608.355039170548;5614.438556144353;5647.915281270784;5654.236678048493;5654.575906806924;6811.897821532681;6813.761518346933;6815.965920170367;6821.147356580427;6827.180738311435;1687.907165105931;1713.4602600180904;1735.6094878652202;1751.5971326594954;1752.9123543822757;1135.5911871726173;1147.690123666622;1160.5415860734963;1167.4921409187032;1172.3434876469205;6443.6455994920725;6478.805635830839;6513.511486638521;6523.804285871432;6539.771108011292;6979;6988.615626140509;6998.300169982961;7002.894956575656;7006.194287656883;6469.7412103515335;6488.545801793829;6506.869862602722;6514.771982980573;6518.771842985568;3764.849406023783;3774.75464094833;3787.450819631193;3802.7147963902817;3825.6748176405317;7216.3505284524645;7350.669219885118;7372;7382.520136191238;7392.96303518479;7218.422526197892;7277.636118194069;7281.4538909582;7301.780946571611;7308;7281.235470275651;7301.634918254066;7303;7305.744298949511;7313.524620899624;6923;7081.044059051962;7101.041359416413;7106.609136497542;7136.143662760502;6994.790156295319;6994.985727069445;6998.6850591724515;7023;7030.648467576703;7320.560766354036;7328.78013659591;7339.1926888043345;7341.816454588678;7357.117145942521;4852.95147048525;4878.707277563358;4908.067467181224;4914.557689807934;4941.975290123526;6867.690953907186;7038.788836334918;7067.82330441743;7072;7150.392216661642;6872.965635171792;6891.689873955584;6903.965480172567;6946.6179360135675;6974.7210111597;6803.557768745016;6852.314768523108;6860.073890024983;6876.656167191721;6880.58716477013;6701.597904125768;6749.392554670103;6752.93247067523;6756.290589488033;6765;6713.395794378529;6885.345892140239;6915.757948471981;6918.273581273894;6941.514094013371;6699.698513566998;6721.966390168213;6796.558223715443;6809.38715515606;6829.93170068293 14:51:10 INFO - PROCESS | 13864 | |5;yui.html;855.3029281135872;887.4409122252981;893.932955028373;915.8717779510865;917.1882883647969;13579.25314107725;13685.79471307931;13720.51978180765;13757.174569525836;13776.58670239892;12940.547080852171;13071.803922941139;13128.277944713038;13145;13152.93423532881;761.2767870523012;926.2775035472308;939.8402271613808;946.5787724462617;946.7349142240149;932.9207017403495;934.7195841247633;936.2650319499195;938.3290946972913;938.699616122841;978.496074521622;983.1102851919024;984.3257368702426;985.9605615775396;986.2553771902204;978.706388083572;978.8580655804903;978.8923218445965;980.0738302304326;980.6420656460376;717.6232477949067;718.5293632670557;719.8812195987656;722.1045903080143;723.023917711091;13306.20162790226;13379.331033448289;13409.932950335284;13580.660483487893;13649.931750341284;13606.319684015858;13640.181589104686;13705.246211458365;13791;13868.029237953348;11058.949399807005;11182.944085279521;11211.943940280327;11254;11329.206955513117;3871.8644847430487;3873.709471789627;3927.725059245854;3942.526896772377;3962.049108214008;50863;51030.489695103315;51233.48766512325;51241.487585124414;51798.741006294724;9445.386049906734;9619;9737.610495580097;9745.902540974641;9764.462954537426;19147.329843455413;19194.808051919303;19232.61534769297;19268.903655481634;19302.903485482482;7476.327130558276;7597.088349397997;7661.770146895602;7673.769786906401;7806.960965195138;4163.646090082377;4214.494260688737;4267.146570685875;4289.313709806416;4350.129974005148;3301.092199645069;3318.1372843060976;3342.4986252062386;3345;3357.1103657530775;600.1178267946112;604.8094850122285;608;632.1181951178173;635.3582881289931;541.258475888036;599.8560345517044;630.5617595770987;633.9049142628643;634.7175506899478;8489.575521223915;8505.787355316043;8890.911090889138;8962.955185224033;9250.398724082914;663.93692599203;664.9069130321759;666.380266352297;672.0456951129408;674.3930462583714;4057.431959525669;4062.1469491406547;4142.627163555295;4164.583541645872;4197.244495990751;63373.683131584046;63620.68189659022;63932.680336598016;64149.67925160438;64729.35270647328;55742;56579;56969;57302.7134864323;57435.71282143563;51155.48844511507;51401;51494.99999999925;52354;52673.473265267625;8464.111268316738;8575.87136192945;8672.696455624024;8724.258438032839;8773.122687731176;37061;37269.254614908095;38040.42939355967;38116;38294.80852595719;44308.556914430446;44388;48468.75765621149;48949.5105048945;49949.75025124851;10162.949185254027;10560.049595536439;10585.788284234426;10609.151267898704;10636;11356.54573817038;11359.432028398382;11421.543138274708;11527.481263343001;11550.653480395602;10718.24972251935;10742.033217010507;10754.731131721457;10800.135989120694;10974.780504390028;10534.473276336306;10771.839701696848;10801.621943231949;10893.07408870255;11260.774784504429;10529.315594486641;10556.366618002945;10790.568377265135;11168.720781980515;11240.437978101227;9279.814403711753;9329.72010839676;9459.38513996588;9464.432134071978;9706.320557560903;9795.559199836167;9804.754881128029;9848.852267216142;9861.950690246504;9994.300398972002 14:51:10 INFO - PROCESS | 13864 | __end_tp_report 14:51:10 INFO - PROCESS | 13864 | __start_cc_report 14:51:10 INFO - PROCESS | 13864 | _x_x_mozilla_cycle_collect,332 14:51:10 INFO - PROCESS | 13864 | __end_cc_report 14:51:10 INFO - PROCESS | 13864 | __startTimestamp1461189070666__endTimestamp 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | ------- Summary: start ------- 14:51:10 INFO - PROCESS | 13864 | Number of tests: 6 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | [#0] dojo.html Cycles:165 Average:5651.42 Median:5838.45 stddev:637.76 (10.9%) stddev-sans-first:613.38 14:51:10 INFO - PROCESS | 13864 | Values: 3339.3 3357.9 3413.2 3437.9 3465.4 5549.7 5605.4 5617.2 5638.6 5654.7 5628.2 5628.8 5651.7 5657.6 5687.8 5073.0 5113.4 5130.7 5182.4 5221.4 5022.7 5175.8 5228.7 5246.2 5300.5 5179.9 5212.7 5274.6 5276.8 5323.0 5226.2 5248.3 5251.3 5255.7 5287.7 4975.9 4999.4 5105.8 5149.5 5231.3 5463.6 5466.8 5513.8 5516.5 5531.7 6061.3 6096.9 6136.4 6159.9 6170.9 6115.4 6145.4 6164.9 6172.5 6178.0 5735.8 5744.1 5753.9 5757.6 5783.9 6088.6 6147.7 6232.3 6255.6 6274.4 6015.6 6024.6 6033.3 6037.3 6043.2 6103.8 6105.9 6113.3 6130.7 6138.7 5895.7 6027.7 6068.2 6122.1 6130.2 6035.1 6055.5 6098.4 6102.4 6102.6 4612.4 4618.8 4621.5 4632.0 4632.6 4051.0 4101.6 4119.5 4147.5 4172.6 5627.4 5715.9 5743.0 5750.9 5798.9 6077.3 6097.0 6109.5 6147.1 6151.6 5605.9 5705.3 5779.6 5790.6 5823.5 5197.7 5233.4 5248.3 5249.8 5259.3 6284.4 6314.8 6347.5 6350.5 6359.0 5913.8 5923.3 6086.6 6094.1 6125.8 6269.2 6311.7 6322.6 6328.8 6329.0 5927.0 6065.8 6077.6 6081.2 6092.5 6142.3 6190.9 6213.3 6239.2 6246.3 5874.7 5892.1 5899.1 5913.1 5968.8 5675.0 5818.9 5878.6 5914.6 5931.1 5768.0 5838.4 5868.6 5877.3 5901.4 5947.9 5954.0 5965.4 5980.2 6002.8 5720.9 5826.0 5835.4 5838.4 5856.7 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | [#1] ext.html Cycles:180 Average:49888.37 Median:40265.40 stddev:86810.99 (215.6%) stddev-sans-first:86975.34 14:51:10 INFO - PROCESS | 13864 | Values: 509.2 558.5 578.8 596.3 667.9 31119.2 38112.0 38792.2 38823.0 38870.4 42705.8 43073.8 43465.0 43485.0 43641.0 8773.4 9043.0 9045.9 9053.5 9070.8 8869.5 8980.5 8996.8 9024.2 9031.5 8934.6 9042.3 9055.7 9071.9 9089.5 8891.5 8907.4 8967.2 9148.8 9168.5 9028.5 9217.7 9232.7 9245.5 9251.9 42896.8 42929.6 42964.1 43298.6 43321.8 3834.4 3927.7 4267.0 4275.0 4544.2 32577.0 32776.8 32827.2 32933.3 32989.7 4102.5 4131.3 4139.7 4151.2 4218.9 290869.0 291577.0 292706.0 294360.0 294366.5 45629.0 64326.7 65329.3 65334.7 65622.0 41872.2 41973.2 41988.6 42007.6 42090.8 16705.1 16848.2 16914.6 16998.9 17003.4 12961.4 12978.6 13004.2 13035.7 13041.9 14695.7 14877.8 15194.8 15281.2 15307.1 5697.4 5877.0 6004.0 6053.8 6068.4 913.8 969.5 1076.0 1076.7 1120.5 28288.7 28293.0 28367.4 28789.6 28824.1 1044.7 1060.9 1096.9 1156.8 1228.4 14387.9 14419.1 14446.9 14450.6 14663.3 333384.0 335959.0 360070.0 360621.0 484939.0 52799.7 52938.5 53067.7 53382.2 53421.0 767.7 1299.4 1498.1 1508.7 1510.9 30525.4 30768.5 30817.5 31386.5 31600.8 50775.5 51195.7 51246.2 51316.5 51567.5 308049.0 314643.0 315945.0 317430.0 317453.0 35443.3 35621.8 35743.0 35947.6 36360.0 48282.3 48289.0 48936.3 49257.8 49493.5 40188.0 40239.8 40291.0 40708.4 41332.2 38478.4 40791.8 40969.2 42145.2 46617.3 38185.4 38885.2 38905.2 39539.0 39661.4 33426.7 33572.3 34203.8 34355.0 34513.5 26770.0 27077.5 27079.3 27082.6 27103.1 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | [#2] jquery.html Cycles:180 Average:24210.17 Median:2497.31 stddev:64481.33 (2582.0%) stddev-sans-first:64637.35 14:51:10 INFO - PROCESS | 13864 | Values: 360.6 376.6 380.5 382.6 388.6 17761.9 18712.2 19897.4 19900.0 19934.8 16741.7 17341.2 17412.8 17431.6 17466.8 5083.0 5290.1 5331.8 5333.7 5337.2 5185.0 5359.1 5524.9 5567.4 5581.9 5447.9 5511.0 5518.2 5557.4 5846.8 5766.6 5835.6 5837.6 5841.5 5886.6 5640.3 5643.9 5662.1 5676.9 5771.9 12384.4 12639.7 12747.4 12754.9 12829.4 2237.7 2321.5 2332.4 2662.2 2990.1 9549.9 10070.6 10685.7 12528.4 14035.1 1937.7 1987.4 2000.1 2019.1 2019.8 63105.7 64891.0 65467.0 66091.0 69039.7 10415.4 10489.3 10784.8 10814.4 10819.7 15209.8 15273.2 15346.1 15381.9 15383.8 7819.6 7957.7 7984.8 7988.2 8062.1 7527.8 7565.2 7575.8 7631.0 7669.5 4361.3 4702.5 4799.8 4803.3 4813.9 1892.5 1895.8 1949.5 1954.3 1968.6 931.1 963.7 969.3 1026.5 1078.3 15872.7 15972.9 16775.1 18091.5 18429.8 962.3 969.5 989.3 1020.3 1032.5 10030.8 10175.7 10193.0 10326.7 10455.0 335661.0 336182.0 340494.0 461329.0 464543.0 67944.0 69543.3 70125.0 70687.6 71030.3 1031.1 1052.5 1070.4 1075.8 1077.1 15564.8 15589.4 15641.5 15711.9 15752.6 32267.8 32648.5 33622.7 33714.2 33845.7 45032.5 46171.8 51368.0 51442.7 51815.7 8354.2 8683.8 8733.1 8770.7 8921.5 12333.9 13061.0 13097.5 13588.5 13656.3 11764.5 11854.5 11863.4 12142.6 12287.7 11903.7 11919.8 12126.1 12214.4 12234.4 11499.4 12121.9 12202.1 12211.6 12460.4 8817.9 8868.7 9006.8 9024.5 9102.6 11134.5 11303.5 11362.2 11795.8 12406.8 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | [#3] mootools.html Cycles:180 Average:5981.11 Median:546.63 stddev:3125.52 (571.8%) stddev-sans-first:3116.66 14:51:10 INFO - PROCESS | 13864 | Values: 1564.5 1570.1 1794.0 1848.3 1940.0 7531.5 8263.4 8282.8 8570.9 8637.7 8389.7 8413.5 8417.5 8448.1 8450.7 2433.0 2454.1 2458.8 2463.4 2464.7 2443.7 2451.0 2457.3 2458.8 2460.6 2431.5 2440.7 2508.3 2519.0 2521.6 2430.1 2444.8 2449.7 2493.5 2506.0 2380.9 2414.9 2433.1 2441.4 2479.4 8574.2 8597.9 8645.1 8660.5 8685.8 5288.3 5382.2 5399.4 5427.7 5431.2 3128.2 3174.8 3180.3 3294.4 3298.6 1045.0 2061.8 2063.9 2093.3 2108.4 11644.1 11647.8 11731.9 11746.0 11792.4 4469.5 4584.2 4649.5 4748.4 4752.7 9382.2 9384.4 9394.0 9431.3 9442.7 5175.5 5184.4 5198.7 5217.2 5247.4 4325.7 4791.1 4797.0 4868.4 4922.9 3643.1 3715.1 3724.1 3732.7 3751.8 1128.5 1150.6 1153.9 1155.9 1157.5 1168.1 1176.4 1204.0 1469.3 1483.5 8172.0 8312.7 8348.7 8360.2 8382.3 545.4 547.9 555.3 555.5 560.0 6468.9 6496.7 6536.9 6552.4 6593.7 10223.6 10734.2 10735.5 10757.2 10786.0 10304.7 10353.5 10478.6 10551.4 10594.4 8204.7 8328.6 8340.3 8366.6 8370.4 7884.6 7997.3 8004.0 8075.6 8091.8 9078.1 9232.9 9399.9 9422.8 9504.8 9589.5 9606.5 9880.6 9965.9 9979.2 6451.4 7491.2 7560.7 7629.7 7762.7 8013.6 8067.0 8074.7 8086.4 8117.6 7029.6 7257.2 7271.1 7297.0 7367.7 7103.5 7141.4 7175.3 7268.9 7286.0 7564.1 7608.3 7610.2 7613.4 7630.0 7063.0 7077.6 7084.9 7099.5 7106.3 6939.4 7100.3 7121.1 7123.0 7126.0 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | [#4] prototype.html Cycles:180 Average:5722.46 Median:6463.16 stddev:1725.84 (26.7%) stddev-sans-first:1683.32 14:51:10 INFO - PROCESS | 13864 | Values: 372.4 372.5 375.2 380.7 381.5 6433.8 6434.4 6437.8 6438.1 6456.6 6362.3 6366.0 6384.6 6388.1 6410.4 4676.9 4835.3 4929.7 4953.1 4968.9 4884.5 4912.0 4934.8 4939.7 4950.2 4907.0 4914.5 4917.6 4941.4 4947.2 4920.3 4920.6 4932.9 4933.9 4936.9 4391.4 4394.3 4415.3 4418.2 4424.9 5928.3 6111.0 6114.4 6116.6 6122.8 5691.3 5704.9 5723.4 5729.5 5729.7 6806.7 6821.3 6829.5 6830.9 6833.1 4720.5 4729.6 4733.7 4736.4 4743.7 7092.3 7161.0 7164.7 7164.9 7173.7 4754.5 4772.4 4803.5 4822.1 4840.4 4874.0 4875.9 4882.9 4891.9 4893.8 5608.4 5614.4 5647.9 5654.2 5654.6 6811.9 6813.8 6816.0 6821.1 6827.2 1687.9 1713.5 1735.6 1751.6 1752.9 1135.6 1147.7 1160.5 1167.5 1172.3 6443.6 6478.8 6513.5 6523.8 6539.8 6979.0 6988.6 6998.3 7002.9 7006.2 6469.7 6488.5 6506.9 6514.8 6518.8 3764.8 3774.8 3787.5 3802.7 3825.7 7216.4 7350.7 7372.0 7382.5 7393.0 7218.4 7277.6 7281.5 7301.8 7308.0 7281.2 7301.6 7303.0 7305.7 7313.5 6923.0 7081.0 7101.0 7106.6 7136.1 6994.8 6995.0 6998.7 7023.0 7030.6 7320.6 7328.8 7339.2 7341.8 7357.1 4853.0 4878.7 4908.1 4914.6 4942.0 6867.7 7038.8 7067.8 7072.0 7150.4 6873.0 6891.7 6904.0 6946.6 6974.7 6803.6 6852.3 6860.1 6876.7 6880.6 6701.6 6749.4 6752.9 6756.3 6765.0 6713.4 6885.3 6915.8 6918.3 6941.5 6699.7 6722.0 6796.6 6809.4 6829.9 14:51:10 INFO - PROCESS | 13864 | 14:51:10 INFO - PROCESS | 13864 | [#5] yui.html Cycles:180 Average:14574.42 Median:51448.00 stddev:17544.00 (34.1%) stddev-sans-first:17562.97 14:51:10 INFO - PROCESS | 13864 | Values: 855.3 887.4 893.9 915.9 917.2 13579.3 13685.8 13720.5 13757.2 13776.6 12940.5 13071.8 13128.3 13145.0 13152.9 761.3 926.3 939.8 946.6 946.7 932.9 934.7 936.3 938.3 938.7 978.5 983.1 984.3 986.0 986.3 978.7 978.9 978.9 980.1 980.6 717.6 718.5 719.9 722.1 723.0 13306.2 13379.3 13409.9 13580.7 13649.9 13606.3 13640.2 13705.2 13791.0 13868.0 11058.9 11182.9 11211.9 11254.0 11329.2 3871.9 3873.7 3927.7 3942.5 3962.0 50863.0 51030.5 51233.5 51241.5 51798.7 9445.4 9619.0 9737.6 9745.9 9764.5 19147.3 19194.8 19232.6 19268.9 19302.9 7476.3 7597.1 7661.8 7673.8 7807.0 4163.6 4214.5 4267.1 4289.3 4350.1 3301.1 3318.1 3342.5 3345.0 3357.1 600.1 604.8 608.0 632.1 635.4 541.3 599.9 630.6 633.9 634.7 8489.6 8505.8 8890.9 8963.0 9250.4 663.9 664.9 666.4 672.0 674.4 4057.4 4062.1 4142.6 4164.6 4197.2 63373.7 63620.7 63932.7 64149.7 64729.4 55742.0 56579.0 56969.0 57302.7 57435.7 51155.5 51401.0 51495.0 52354.0 52673.5 8464.1 8575.9 8672.7 8724.3 8773.1 37061.0 37269.3 38040.4 38116.0 38294.8 44308.6 44388.0 48468.8 48949.5 49949.8 10162.9 10560.0 10585.8 10609.2 10636.0 11356.5 11359.4 11421.5 11527.5 11550.7 10718.2 10742.0 10754.7 10800.1 10974.8 10534.5 10771.8 10801.6 10893.1 11260.8 10529.3 10556.4 10790.6 11168.7 11240.4 9279.8 9329.7 9459.4 9464.4 9706.3 9795.6 9804.8 9848.9 9862.0 9994.3 14:51:10 INFO - PROCESS | 13864 | -------- Summary: end -------- 14:51:10 INFO - PROCESS | 13864 | 14:51:11 INFO - TEST-INFO | 13864: exit 0 14:51:11 INFO - TEST-OK | dromaeo_css | took 1109656ms 14:51:11 INFO - TEST-START | kraken 14:51:11 INFO - operating with platform_type : linux_ 14:51:11 INFO - Initialising browser for kraken test... 14:51:11 INFO - TEST-INFO | started process 14107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE27WrM/profile http://localhost:41664/getInfo.html) 14:51:14 INFO - PROCESS | 14107 | 14:51:14 INFO - PROCESS | 14107 | (process:14184): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:51:15 INFO - PROCESS | 14107 | __metrics Screen width/height:1600/1200 14:51:15 INFO - PROCESS | 14107 | colorDepth:24 14:51:15 INFO - PROCESS | 14107 | Browser inner width/height: 1024/697 14:51:15 INFO - PROCESS | 14107 | __metrics 14:51:16 ERROR - PROCESS | 14107 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:51:17 INFO - TEST-INFO | 14107: exit 0 14:51:17 INFO - Browser initialized. 14:51:17 INFO - Running cycle 1/1 for kraken test... 14:51:17 INFO - TEST-INFO | started process 14235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE27WrM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:19 INFO - PROCESS | 14235 | 14:51:19 INFO - PROCESS | 14235 | (process:14302): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:51:29 INFO - PROCESS | 14235 | RSS: Main: 151621632 14:51:29 INFO - PROCESS | 14235 | 14:51:31 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:32 INFO - PROCESS | 14235 | RSS: Main: 155881472 14:51:32 INFO - PROCESS | 14235 | 14:51:34 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-dft) 14:51:35 INFO - PROCESS | 14235 | RSS: Main: 156098560 14:51:35 INFO - PROCESS | 14235 | 14:51:38 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-fft) 14:51:39 INFO - PROCESS | 14235 | RSS: Main: 156651520 14:51:39 INFO - PROCESS | 14235 | 14:51:41 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-oscillator) 14:51:41 INFO - PROCESS | 14235 | RSS: Main: 157159424 14:51:41 INFO - PROCESS | 14235 | 14:51:43 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:44 INFO - PROCESS | 14235 | RSS: Main: 157085696 14:51:44 INFO - PROCESS | 14235 | 14:51:47 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41664/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:48 INFO - PROCESS | 14235 | RSS: Main: 156536832 14:51:48 INFO - PROCESS | 14235 | 14:51:51 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41664/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:52 INFO - PROCESS | 14235 | RSS: Main: 156807168 14:51:52 INFO - PROCESS | 14235 | 14:51:54 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41664/tests/kraken/driver.html?testName=json-parse-financial) 14:51:55 INFO - PROCESS | 14235 | RSS: Main: 156520448 14:51:55 INFO - PROCESS | 14235 | 14:51:57 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:57 INFO - PROCESS | 14235 | RSS: Main: 156672000 14:51:57 INFO - PROCESS | 14235 | 14:51:59 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:00 INFO - PROCESS | 14235 | RSS: Main: 156872704 14:52:00 INFO - PROCESS | 14235 | 14:52:02 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:02 INFO - PROCESS | 14235 | RSS: Main: 157110272 14:52:02 INFO - PROCESS | 14235 | 14:52:05 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:05 INFO - PROCESS | 14235 | RSS: Main: 158146560 14:52:05 INFO - PROCESS | 14235 | 14:52:08 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:08 INFO - PROCESS | 14235 | RSS: Main: 157585408 14:52:08 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41664/tests/kraken/driver.html?testName=ai-astar) 14:52:10 INFO - PROCESS | 14235 | RSS: Main: 159117312 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | __start_tp_report 14:52:10 INFO - PROCESS | 14235 | _x_x_mozilla_page_load 14:52:10 INFO - PROCESS | 14235 | _x_x_mozilla_page_load_details 14:52:10 INFO - PROCESS | 14235 | |i|pagename|runs| 14:52:10 INFO - PROCESS | 14235 | |0;ai-astar;110;105;111;108;111;122;112;110;110;109 14:52:10 INFO - PROCESS | 14235 | |1;audio-beat-detection;158;132;151;162;129;152;152;130;180;130 14:52:10 INFO - PROCESS | 14235 | |2;audio-dft;164;165;164;161;162;164;164;163;165;162 14:52:10 INFO - PROCESS | 14235 | |3;audio-fft;76;77;76;160;77;76;76;76;170;75 14:52:10 INFO - PROCESS | 14235 | |4;audio-oscillator;93;93;140;93;93;94;148;92;93;141 14:52:10 INFO - PROCESS | 14235 | |5;imaging-gaussian-blur;118;117;117;118;118;118;118;117;117;117 14:52:10 INFO - PROCESS | 14235 | |6;imaging-darkroom;146;147;148;147;147;151;147;147;147;147 14:52:10 INFO - PROCESS | 14235 | |7;imaging-desaturate;96;96;96;96;97;96;97;96;96;97 14:52:10 INFO - PROCESS | 14235 | |8;json-parse-financial;57;58;58;58;58;57;56;65;56;57 14:52:10 INFO - PROCESS | 14235 | |9;json-stringify-tinderbox;64;65;65;66;66;66;65;70;64;65 14:52:10 INFO - PROCESS | 14235 | |10;stanford-crypto-aes;78;77;80;78;77;84;79;79;79;78 14:52:10 INFO - PROCESS | 14235 | |11;stanford-crypto-ccm;118;116;132;123;121;114;117;115;111;119 14:52:10 INFO - PROCESS | 14235 | |12;stanford-crypto-pbkdf2;127;141;137;136;144;137;141;136;147;127 14:52:10 INFO - PROCESS | 14235 | |13;stanford-crypto-sha256-iterative;67;67;66;68;68;64;65;70;66;65 14:52:10 INFO - PROCESS | 14235 | __end_tp_report 14:52:10 INFO - PROCESS | 14235 | __start_cc_report 14:52:10 INFO - PROCESS | 14235 | _x_x_mozilla_cycle_collect,845 14:52:10 INFO - PROCESS | 14235 | __end_cc_report 14:52:10 INFO - PROCESS | 14235 | __startTimestamp1461189130655__endTimestamp 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | ------- Summary: start ------- 14:52:10 INFO - PROCESS | 14235 | Number of tests: 14 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:4.39 (4.0%) stddev-sans-first:4.65 14:52:10 INFO - PROCESS | 14235 | Values: 110.0 105.0 111.0 108.0 111.0 122.0 112.0 110.0 110.0 109.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:17.08 (11.2%) stddev-sans-first:17.69 14:52:10 INFO - PROCESS | 14235 | Values: 158.0 132.0 151.0 162.0 129.0 152.0 152.0 130.0 180.0 130.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 14:52:10 INFO - PROCESS | 14235 | Values: 164.0 165.0 164.0 161.0 162.0 164.0 164.0 163.0 165.0 162.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.55 (49.4%) stddev-sans-first:39.27 14:52:10 INFO - PROCESS | 14235 | Values: 76.0 77.0 76.0 160.0 77.0 76.0 76.0 76.0 170.0 75.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:24.24 (26.1%) stddev-sans-first:25.10 14:52:10 INFO - PROCESS | 14235 | Values: 93.0 93.0 140.0 93.0 93.0 94.0 148.0 92.0 93.0 141.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:52:10 INFO - PROCESS | 14235 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.33 14:52:10 INFO - PROCESS | 14235 | Values: 146.0 147.0 148.0 147.0 147.0 151.0 147.0 147.0 147.0 147.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:52:10 INFO - PROCESS | 14235 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 97.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:2.58 (4.5%) stddev-sans-first:2.71 14:52:10 INFO - PROCESS | 14235 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 56.0 65.0 56.0 57.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:1.71 (2.6%) stddev-sans-first:1.72 14:52:10 INFO - PROCESS | 14235 | Values: 64.0 65.0 65.0 66.0 66.0 66.0 65.0 70.0 64.0 65.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:2.02 (2.6%) stddev-sans-first:2.12 14:52:10 INFO - PROCESS | 14235 | Values: 78.0 77.0 80.0 78.0 77.0 84.0 79.0 79.0 79.0 78.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.50 stddev:5.83 (4.9%) stddev-sans-first:6.18 14:52:10 INFO - PROCESS | 14235 | Values: 118.0 116.0 132.0 123.0 121.0 114.0 117.0 115.0 111.0 119.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.30 Median:139.00 stddev:6.52 (4.7%) stddev-sans-first:5.75 14:52:10 INFO - PROCESS | 14235 | Values: 127.0 141.0 137.0 136.0 144.0 137.0 141.0 136.0 147.0 127.0 14:52:10 INFO - PROCESS | 14235 | 14:52:10 INFO - PROCESS | 14235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.88 14:52:10 INFO - PROCESS | 14235 | Values: 67.0 67.0 66.0 68.0 68.0 64.0 65.0 70.0 66.0 65.0 14:52:10 INFO - PROCESS | 14235 | -------- Summary: end -------- 14:52:10 INFO - PROCESS | 14235 | 14:52:11 INFO - TEST-INFO | 14235: exit 0 14:52:11 INFO - TEST-OK | kraken | took 60262ms 14:52:11 INFO - SUITE-END | took 1169s 14:52:11 INFO - Completed test suite (00:19:30) 14:52:11 INFO - javascript benchmark 14:52:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3339.3488269787395, 3357.932841343173, 3413.2490852012547, 3437.8968630941063, 3465.445528715406, 5549.722513874311, 5605.439456054392, 5617.213590097384, 5638.633488823229, 5654.660720356782, 5628.212050312949, 5628.802991895284, 5651.660900345972, 5657.603967722261, 5687.829365119042, 5072.974635126829, 5113.386393632751, 5130.692158470485, 5182.352205974254, 5221.373435187783, 5022.673526220784, 5175.767090480937, 5228.660137091096, 5246.186841039645, 5300.522952934235, 5179.922301165486, 5212.713300768475, 5274.604404669646, 5276.841694749144, 5323.0, 5226.24219488174, 5248.317718696583, 5251.291075704788, 5255.710935898524, 5287.735613219324, 4975.850724478271, 4999.4250661174065, 5105.846824595268, 5149.485051494858, 5231.346081739783, 5463.590230732671, 5466.753996070186, 5513.807016754435, 5516.475934786229, 5531.695756733378, 6061.302950160743, 6096.939030609681, 6136.355682653347, 6159.907601385938, 6170.8765824683705, 6115.388461153893, 6145.3547377525165, 6164.87670246597, 6172.537059720494, 6178.0, 5735.766810135758, 5744.052231381817, 5753.856153596152, 5757.596968212227, 5783.913241301384, 6088.573799833969, 6147.72335244915, 6232.283287421914, 6255.562110652301, 6274.403931626488, 6015.639061656315, 6024.608400453956, 6033.306169790442, 6037.335893051761, 6043.214382130295, 6103.786367477117, 6105.877882442326, 6113.266408030976, 6130.693465326716, 6138.693065346715, 5895.734691938873, 6027.668478233739, 6068.150458935753, 6122.12371750169, 6130.2030736004035, 6035.094735789579, 6055.455009049207, 6098.35967223444, 6102.389761023951, 6102.572819902564, 4612.377329060601, 4618.792154353062, 4621.468531118897, 4631.95368046322, 4632.60622847055, 4050.9594904051173, 4101.610347017028, 4119.505659320841, 4147.502299723992, 4172.561881002451, 5627.43725627434, 5715.857103572361, 5742.971285143631, 5750.942490575041, 5798.8550286242335, 6077.301110372364, 6097.0, 6109.541784366191, 6147.108669242934, 6151.6001459904965, 5605.850800585951, 5705.286839145107, 5779.566532510079, 5790.623609465371, 5823.475887170175, 5197.7401129943355, 5233.4243233244315, 5248.317718696621, 5249.763760630781, 5259.342582177228, 6284.402981716729, 6314.8421289467215, 6347.5239357047485, 6350.491960643138, 6359.014352775327, 5913.793017244548, 5923.289205295392, 6086.573939824169, 6094.055421409688, 6125.785597504066, 6269.216347956505, 6311.747530098744, 6322.589031712924, 6328.841778955563, 6329.0, 5926.970365148319, 6065.8180254592435, 6077.604955678044, 6081.179040829431, 6092.45167934888, 6142.2629284484365, 6190.876182476415, 6213.347598502273, 6239.1577137085915, 6246.3441338660605, 5874.676892770939, 5892.112864696353, 5899.115132730125, 5913.113033045078, 5968.820935371946, 5675.0, 5818.912716309174, 5878.647281163144, 5914.58597898143, 5931.1399847021075, 5768.048272035067, 5838.4453476919625, 5868.589198756046, 5877.324107727666, 5901.439363260483, 5947.851303717442, 5954.047352423591, 5965.433283838029, 5980.222571065734, 6002.759889604367, 5720.914186287126, 5826.0387036140255, 5835.44563266489, 5838.3869693683255, 5856.677882716492], "unit": "score", "name": "dojo.html", "value": 5609.349390110715}, {"lowerIsBetter": false, "replicates": [509.1649694501017, 558.4945624210088, 578.7945279425804, 596.2785030113563, 667.9098321726566, 31119.222019449524, 38112.0, 38792.22415551687, 38823.0, 38870.41694374587, 42705.78647106768, 43073.78463107688, 43465.0, 43485.0, 43641.0, 8773.385862989593, 9043.0, 9045.909540904573, 9053.456792592433, 9070.77323066922, 8869.467831930106, 8980.506072166028, 8996.775080623003, 9024.23294020009, 9031.503267320295, 8934.55327233639, 9042.276617870588, 9055.728328150133, 9071.863922041175, 9089.545522723838, 8891.4665120093, 8907.376483646147, 8967.192952634294, 9148.817023659489, 9168.541572921395, 9028.548572571412, 9217.677381291689, 9232.723018309462, 9245.537723113885, 9251.861222081674, 42896.78551607222, 42929.57070429318, 42964.14071718548, 43298.56701432977, 43321.78339108316, 3834.4056671215726, 3927.705422093326, 4266.978665106686, 4275.007494753685, 4544.182047231497, 32577.022689319358, 32776.83611581927, 32827.17932051694, 32933.3413331732, 32989.67010329914, 4102.5076990761, 4131.277026520377, 4139.734765486552, 4151.232022075926, 4218.915621687549, 290869.0, 291577.0, 292706.0, 294360.0, 294366.52816735994, 45629.0, 64326.67836660787, 65329.34670653327, 65334.673326634016, 65622.0, 41872.16255674869, 41973.16053678971, 41988.58011419847, 42007.57992420098, 42090.789546052074, 16705.081220532746, 16848.24182911772, 16914.577135571708, 16998.915005424893, 17003.40488082911, 12961.351932403531, 12978.610641680765, 13004.21974681522, 13035.674108147372, 13041.934790325988, 14695.706085878222, 14877.776833347509, 15194.848051519564, 15281.235938203044, 15307.081575105529, 5697.4302569742695, 5877.0, 6004.0, 6053.7881174159575, 6068.362821903725, 913.8172365526921, 969.4813274897896, 1075.9677209683723, 1076.6918194393693, 1120.4845770945456, 28288.71711282902, 28293.0, 28367.43265134686, 28789.568156477668, 28824.135275941757, 1044.7235008167995, 1060.8992145746142, 1096.857408536901, 1156.8033434316187, 1228.4471987605614, 14387.92806035963, 14419.134851908919, 14446.855531444551, 14450.638734031734, 14663.34014969329, 333384.0, 335959.0, 360070.0, 360621.0, 484939.0, 52799.73600132052, 52938.47061529412, 53067.734661326445, 53382.19926701103, 53421.0, 767.6890859202032, 1299.4087690100982, 1498.0637101811367, 1508.6907184027248, 1510.9471168509049, 30525.389492209586, 30768.538471922493, 30817.537736934413, 31386.52920206153, 31600.841995789873, 50775.492245077075, 51195.74402127966, 51246.231306529684, 51316.486835131174, 51567.48432515627, 308049.0, 314643.0, 315945.0, 317430.0, 317453.0, 35443.29113417666, 35621.82189089038, 35743.0, 35947.640523594426, 36360.0, 48282.275765864244, 48289.0, 48936.2659560114, 49257.75371123121, 49493.50506494889, 40188.0, 40239.79880100698, 40291.0, 40708.38937415882, 41332.173356533305, 38478.42282365711, 40791.7960410196, 40969.18061638691, 42145.15709685851, 46617.300740488245, 38185.42721859119, 38885.22229555449, 38905.221895561364, 39539.0, 39661.405078924414, 33426.66573334236, 33572.32855342928, 34203.82898085494, 34355.0, 34513.482297765055, 26770.0, 27077.45845083048, 27079.323016924736, 27082.593761093995, 27103.11161690326], "unit": "score", "name": "ext.html", "value": 19123.37577312116}, {"lowerIsBetter": false, "replicates": [360.5763228206858, 376.5594254721975, 380.47304483290634, 382.6345839723065, 388.55122333704566, 17761.911190444047, 18712.157952892117, 19897.403077907686, 19900.0, 19934.800651993493, 16741.748873766905, 17341.21964511597, 17412.82587174128, 17431.564210894732, 17466.825331746677, 5083.0, 5290.074237008508, 5331.760070796804, 5333.733313334337, 5337.226102215176, 5184.974075129619, 5359.1425371940495, 5524.917126243109, 5567.387587365387, 5581.888362232753, 5447.945520544803, 5511.0, 5518.227448157261, 5557.360903496109, 5846.766129354821, 5766.567507436938, 5835.562332825055, 5837.6497410155525, 5841.532677385799, 5886.646801191942, 5640.2667653205235, 5643.887122257573, 5662.094064949588, 5676.943230567724, 5771.88456230873, 12384.442700078518, 12639.747205055848, 12747.362631868462, 12754.936225318907, 12829.422675979604, 2237.7314722233273, 2321.466062805547, 2332.4402143485613, 2662.1747258349974, 2990.1179152150166, 9549.904500954972, 10070.597176112946, 10685.679429617125, 12528.373581320897, 14035.087719298315, 1937.6996565532365, 1987.3640435060786, 2000.0999550202466, 2019.0813180003063, 2019.8485113616537, 63105.684471577806, 64891.0, 65467.0, 66091.0, 69039.65480172617, 10415.375077495375, 10489.265751397481, 10784.78430431387, 10814.405207713495, 10819.729506762395, 15209.771853422208, 15273.236338183046, 15346.079235245921, 15381.923090384476, 15383.846161538242, 7819.609019549, 7957.681692732226, 7984.840303193903, 7988.241117093867, 8062.113167551564, 7527.8118047049265, 7565.167831538526, 7575.848483030309, 7631.0, 7669.463137580316, 4361.323994780814, 4702.529747025338, 4799.808007679723, 4803.327534145223, 4813.9037219256115, 1892.5079479335197, 1895.781985071707, 1949.4736421166206, 1954.257382194757, 1968.6456437841039, 931.1433481197315, 963.7301555564453, 969.3021024862088, 1026.4867566216892, 1078.3475997021847, 15872.682546349239, 15972.920135399248, 16775.077370744726, 18091.54771130732, 18429.81570184281, 962.3407965543626, 969.5055521683851, 989.3272574649308, 1020.3418794877263, 1032.5147180825, 10030.799384012278, 10175.694729157989, 10193.0, 10326.690199294033, 10455.0, 335661.0, 336182.0, 340494.0, 461329.0, 464543.0, 67944.0, 69543.3045669547, 70125.0, 70687.64656176686, 71030.2896971034, 1031.0720351683394, 1052.5368837711383, 1070.421972135054, 1075.8493810866485, 1077.1221454514703, 15564.84435155634, 15589.37642494333, 15641.530754077396, 15711.921440392725, 15752.60618484547, 32267.838660807483, 32648.510272346408, 33622.66377336195, 33714.15714607154, 33845.66154338425, 45032.549674502836, 46171.769141155426, 51368.0, 51442.74278628732, 51815.74092129666, 8354.16458354184, 8683.782905427415, 8733.08302628215, 8770.693025744069, 8921.509316987369, 12333.876661233273, 13061.0, 13097.476100955855, 13588.524401645895, 13656.317184140555, 11764.529418823151, 11854.466549005143, 11863.406829658656, 12142.635720928387, 12287.69280767988, 11903.702407439883, 11919.82120268214, 12126.090543209119, 12214.38928053576, 12234.449449774604, 11499.425028748361, 12121.878781212075, 12202.084843636585, 12211.572594959134, 12460.43928023223, 8817.867731984154, 8868.733937981871, 9006.774830629287, 9024.503652299187, 9102.635894564144, 11134.498947547218, 11303.491342889754, 11362.204645674723, 11795.764084718086, 12406.751864962831], "unit": "score", "name": "jquery.html", "value": 8729.048692433986}, {"lowerIsBetter": false, "replicates": [1564.4837203722773, 1570.1207323898618, 1793.9641207175857, 1848.251458159446, 1939.9612007759845, 7531.472796904219, 8263.380246481507, 8282.751517454479, 8570.91429085709, 8637.74086777397, 8389.706360277392, 8413.45312554685, 8417.494950302986, 8448.07071222165, 8450.704225352114, 2432.9513409731794, 2454.0797201049604, 2458.791002764767, 2463.359526523099, 2464.691913510811, 2443.6701045358914, 2451.0, 2457.348802567321, 2458.7787099161073, 2460.6432067350224, 2431.501542183848, 2440.7437219092008, 2508.297676650541, 2519.0301733832516, 2521.6091505816535, 2430.052279610953, 2444.767747064026, 2449.7182823975204, 2493.5137648158616, 2505.974940250592, 2380.9047638094457, 2414.9034038638433, 2433.0632706407982, 2441.40185654514, 2479.404942813712, 8574.185452382013, 8597.871031934526, 8645.092265312114, 8660.523671198082, 8685.826283474295, 5288.312519372457, 5382.219578161184, 5399.433059528732, 5427.674339539641, 5431.185322201662, 3128.1866714654125, 3174.825384603846, 3180.3003339265324, 3294.407006738786, 3298.5876765404323, 1044.9947750261276, 2061.8247448966854, 2063.876167429959, 2093.3301343570065, 2108.39910625471, 11644.126690498162, 11647.825282620768, 11731.941340293244, 11746.0, 11792.41037948099, 4469.4860091089295, 4584.174848527297, 4649.535046495391, 4748.406449193851, 4752.691075080178, 9382.24942004638, 9384.436933783994, 9393.953030234805, 9431.339806213498, 9442.669506567374, 5175.508326708957, 5184.377874655065, 5198.662086964335, 5217.217417387422, 5247.449017853147, 4325.697201195949, 4791.065742180242, 4797.0, 4868.440129385095, 4922.926156107661, 3643.0710168906758, 3715.1269451678836, 3724.1062145085525, 3732.720045996561, 3751.7936513491472, 1128.4583399967896, 1150.5627861412609, 1153.901918336934, 1155.9190856640123, 1157.548556063136, 1168.1218355061285, 1176.3588844079998, 1203.9879601204052, 1469.2653673163418, 1483.5475180070182, 8171.959140204261, 8312.709055183039, 8348.707795227137, 8360.163983601713, 8382.287505562095, 545.3675807079863, 547.8986387518322, 555.3335996803771, 555.4584280326649, 559.9832005039856, 6468.902966455507, 6496.675166241669, 6536.901946470807, 6552.410283074546, 6593.703283352261, 10223.642172523925, 10734.19493537972, 10735.463226838627, 10757.193210509244, 10785.975332343414, 10304.690859274233, 10353.482325883826, 10478.580856765644, 10551.366917984946, 10594.417307048187, 8204.712835050745, 8328.583570821313, 8340.332773378237, 8366.623501942428, 8370.372222083368, 7884.645190966306, 7997.280244777765, 8004.0, 8075.636596353061, 8091.757247282591, 9078.137576930181, 9232.907670923205, 9399.906000939904, 9422.811543768948, 9504.809903802023, 9589.520523973633, 9606.471644059644, 9880.604775809175, 9965.850512242178, 9979.20166386702, 6451.354864513699, 7491.213422590549, 7560.735374261874, 7629.6566654499575, 7762.650680719268, 8013.639386227517, 8067.0, 8074.677012919417, 8086.353091752528, 8117.594120293844, 7029.578225306498, 7257.237990011184, 7271.091113610799, 7297.0, 7367.668454919649, 7103.538270012433, 7141.428685705027, 7175.31834475724, 7268.89096663561, 7286.0, 7564.130125035691, 7608.31525162738, 7610.238976102345, 7613.390928725799, 7630.0, 7062.964685176541, 7077.610731409822, 7084.929150708633, 7099.467539934422, 7106.324899134574, 6939.4448444125355, 7100.325469080429, 7121.074260346122, 7123.0, 7126.037984871976], "unit": "score", "name": "mootools.html", "value": 4858.155472489687}, {"lowerIsBetter": false, "replicates": [372.3855638196975, 372.54549449671424, 375.1708723720577, 380.68022860796935, 381.5021397076815, 6433.839154021151, 6434.3887330703565, 6437.839054023646, 6438.098666186737, 6456.580322279048, 6362.268339141, 6365.968170159154, 6384.553081284312, 6388.105665206875, 6410.358964103587, 4676.906461870761, 4835.250536166882, 4929.704217746928, 4953.133201689708, 4968.900621987558, 4884.487128851472, 4912.0175964807, 4934.80260789568, 4939.728314942677, 4950.183219768734, 4907.0, 4914.508549145093, 4917.631177661672, 4941.431735350445, 4947.208446648537, 4920.261960705905, 4920.60635149189, 4932.8520144395725, 4933.8519844404545, 4936.851894443173, 4391.363252328427, 4394.274944634131, 4415.293553031532, 4418.160549495586, 4424.911501769979, 5928.28860536734, 6110.969445152746, 6114.419130182626, 6116.571839971204, 6122.846928826815, 5691.345495268014, 5704.857378565569, 5723.427657234285, 5729.455701708331, 5729.684867332295, 6806.693698783567, 6821.317868213188, 6829.521933464659, 6830.931690683079, 6833.111695479556, 4720.527947205286, 4729.6452766042685, 4733.668643194977, 4736.407949006374, 4743.739094349809, 7092.255313192092, 7161.0332605098165, 7164.749233776845, 7164.892526612105, 7173.748918787817, 4754.548317909793, 4772.403449568804, 4803.519648035169, 4822.107910036654, 4840.419149702058, 4873.975630121898, 4875.926861097087, 4882.853514394574, 4891.853244402673, 4893.779779909913, 5608.355039170548, 5614.438556144353, 5647.915281270784, 5654.236678048493, 5654.575906806924, 6811.897821532681, 6813.761518346933, 6815.965920170367, 6821.147356580427, 6827.180738311435, 1687.907165105931, 1713.4602600180904, 1735.6094878652202, 1751.5971326594954, 1752.9123543822757, 1135.5911871726173, 1147.690123666622, 1160.5415860734963, 1167.4921409187032, 1172.3434876469205, 6443.6455994920725, 6478.805635830839, 6513.511486638521, 6523.804285871432, 6539.771108011292, 6979.0, 6988.615626140509, 6998.300169982961, 7002.894956575656, 7006.194287656883, 6469.7412103515335, 6488.545801793829, 6506.869862602722, 6514.771982980573, 6518.771842985568, 3764.849406023783, 3774.75464094833, 3787.450819631193, 3802.7147963902817, 3825.6748176405317, 7216.3505284524645, 7350.669219885118, 7372.0, 7382.520136191238, 7392.96303518479, 7218.422526197892, 7277.636118194069, 7281.4538909582, 7301.780946571611, 7308.0, 7281.235470275651, 7301.634918254066, 7303.0, 7305.744298949511, 7313.524620899624, 6923.0, 7081.044059051962, 7101.041359416413, 7106.609136497542, 7136.143662760502, 6994.790156295319, 6994.985727069445, 6998.6850591724515, 7023.0, 7030.648467576703, 7320.560766354036, 7328.78013659591, 7339.1926888043345, 7341.816454588678, 7357.117145942521, 4852.95147048525, 4878.707277563358, 4908.067467181224, 4914.557689807934, 4941.975290123526, 6867.690953907186, 7038.788836334918, 7067.82330441743, 7072.0, 7150.392216661642, 6872.965635171792, 6891.689873955584, 6903.965480172567, 6946.6179360135675, 6974.7210111597, 6803.557768745016, 6852.314768523108, 6860.073890024983, 6876.656167191721, 6880.58716477013, 6701.597904125768, 6749.392554670103, 6752.93247067523, 6756.290589488033, 6765.0, 6713.395794378529, 6885.345892140239, 6915.757948471981, 6918.273581273894, 6941.514094013371, 6699.698513566998, 6721.966390168213, 6796.558223715443, 6809.38715515606, 6829.93170068293], "unit": "score", "name": "prototype.html", "value": 5165.442387478544}, {"lowerIsBetter": false, "replicates": [855.3029281135872, 887.4409122252981, 893.932955028373, 915.8717779510865, 917.1882883647969, 13579.25314107725, 13685.79471307931, 13720.51978180765, 13757.174569525836, 13776.58670239892, 12940.547080852171, 13071.803922941139, 13128.277944713038, 13145.0, 13152.93423532881, 761.2767870523012, 926.2775035472308, 939.8402271613808, 946.5787724462617, 946.7349142240149, 932.9207017403495, 934.7195841247633, 936.2650319499195, 938.3290946972913, 938.699616122841, 978.496074521622, 983.1102851919024, 984.3257368702426, 985.9605615775396, 986.2553771902204, 978.706388083572, 978.8580655804903, 978.8923218445965, 980.0738302304326, 980.6420656460376, 717.6232477949067, 718.5293632670557, 719.8812195987656, 722.1045903080143, 723.023917711091, 13306.20162790226, 13379.331033448289, 13409.932950335284, 13580.660483487893, 13649.931750341284, 13606.319684015858, 13640.181589104686, 13705.246211458365, 13791.0, 13868.029237953348, 11058.949399807005, 11182.944085279521, 11211.943940280327, 11254.0, 11329.206955513117, 3871.8644847430487, 3873.709471789627, 3927.725059245854, 3942.526896772377, 3962.049108214008, 50863.0, 51030.489695103315, 51233.48766512325, 51241.487585124414, 51798.741006294724, 9445.386049906734, 9619.0, 9737.610495580097, 9745.902540974641, 9764.462954537426, 19147.329843455413, 19194.808051919303, 19232.61534769297, 19268.903655481634, 19302.903485482482, 7476.327130558276, 7597.088349397997, 7661.770146895602, 7673.769786906401, 7806.960965195138, 4163.646090082377, 4214.494260688737, 4267.146570685875, 4289.313709806416, 4350.129974005148, 3301.092199645069, 3318.1372843060976, 3342.4986252062386, 3345.0, 3357.1103657530775, 600.1178267946112, 604.8094850122285, 608.0, 632.1181951178173, 635.3582881289931, 541.258475888036, 599.8560345517044, 630.5617595770987, 633.9049142628643, 634.7175506899478, 8489.575521223915, 8505.787355316043, 8890.911090889138, 8962.955185224033, 9250.398724082914, 663.93692599203, 664.9069130321759, 666.380266352297, 672.0456951129408, 674.3930462583714, 4057.431959525669, 4062.1469491406547, 4142.627163555295, 4164.583541645872, 4197.244495990751, 63373.683131584046, 63620.68189659022, 63932.680336598016, 64149.67925160438, 64729.35270647328, 55742.0, 56579.0, 56969.0, 57302.7134864323, 57435.71282143563, 51155.48844511507, 51401.0, 51494.99999999925, 52354.0, 52673.473265267625, 8464.111268316738, 8575.87136192945, 8672.696455624024, 8724.258438032839, 8773.122687731176, 37061.0, 37269.254614908095, 38040.42939355967, 38116.0, 38294.80852595719, 44308.556914430446, 44388.0, 48468.75765621149, 48949.5105048945, 49949.75025124851, 10162.949185254027, 10560.049595536439, 10585.788284234426, 10609.151267898704, 10636.0, 11356.54573817038, 11359.432028398382, 11421.543138274708, 11527.481263343001, 11550.653480395602, 10718.24972251935, 10742.033217010507, 10754.731131721457, 10800.135989120694, 10974.780504390028, 10534.473276336306, 10771.839701696848, 10801.621943231949, 10893.07408870255, 11260.774784504429, 10529.315594486641, 10556.366618002945, 10790.568377265135, 11168.720781980515, 11240.437978101227, 9279.814403711753, 9329.72010839676, 9459.38513996588, 9464.432134071978, 9706.320557560903, 9795.559199836167, 9804.754881128029, 9848.852267216142, 9861.950690246504, 9994.300398972002], "unit": "score", "name": "yui.html", "value": 6588.498111661498}], "name": "dromaeo_css", "value": 7327.803784291783}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 111.0, 108.0, 111.0, 122.0, 112.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 151.0, 162.0, 129.0, 152.0, 152.0, 130.0, 180.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 164.0, 161.0, 162.0, 164.0, 164.0, 163.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 76.0, 160.0, 77.0, 76.0, 76.0, 76.0, 170.0, 75.0], "unit": "score", "name": "audio-fft", "value": 93.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 93.0, 93.0, 94.0, 148.0, 92.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 147.0, 147.0, 151.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 56.0, 65.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 70.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 80.0, 78.0, 77.0, 84.0, 79.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 132.0, 123.0, 121.0, 114.0, 117.0, 115.0, 111.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [127.0, 141.0, 137.0, 136.0, 144.0, 137.0, 141.0, 136.0, 147.0, 127.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 68.0, 64.0, 65.0, 70.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1509.8999999999996}]} 14:52:11 INFO - Return code: 0 14:52:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:52:11 ERROR - # TBPL SUCCESS # 14:52:11 INFO - Running post-action listener: _resource_record_post_action 14:52:11 INFO - Running post-run listener: _resource_record_post_run 14:52:13 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 274432; Write bytes: 504868864; Read time: 40; Write time: 663420 14:52:13 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 254857216; Read time: 0; Write time: 402804 14:52:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 274432; Write bytes: 250011648; Read time: 40; Write time: 260616 14:52:13 INFO - Running post-run listener: _upload_blobber_files 14:52:13 INFO - Blob upload gear active. 14:52:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:52:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:52:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:14 INFO - (blobuploader) - INFO - Done attempting. 14:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:15 INFO - (blobuploader) - INFO - Done attempting. 14:52:15 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:15 INFO - Return code: 0 14:52:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd0debbd073eac1e8cfb1a79626e206eba1fe0a74de0dda1ef2525933e1e475c5e15c598e1e7aef69c54f2d9add60132f536fcc3a94d4741e1d159f0e2013fc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260d3001b956efc990e77e2cc59c81f70dd8b4f2bf4e12b3f321023f942e8f03e1dda939ec21732f5021cb1526ab7c3aaec8ca961dff367c3d918582b3c62187"} 14:52:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:15 INFO - Contents: 14:52:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd0debbd073eac1e8cfb1a79626e206eba1fe0a74de0dda1ef2525933e1e475c5e15c598e1e7aef69c54f2d9add60132f536fcc3a94d4741e1d159f0e2013fc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260d3001b956efc990e77e2cc59c81f70dd8b4f2bf4e12b3f321023f942e8f03e1dda939ec21732f5021cb1526ab7c3aaec8ca961dff367c3d918582b3c62187"} 14:52:15 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:15 INFO - Copying logs to upload dir... 14:52:15 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.168904 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-20 14:52:14.990086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:14.994317) ========= 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=0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369 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/fd0debbd073eac1e8cfb1a79626e206eba1fe0a74de0dda1ef2525933e1e475c5e15c598e1e7aef69c54f2d9add60132f536fcc3a94d4741e1d159f0e2013fc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260d3001b956efc990e77e2cc59c81f70dd8b4f2bf4e12b3f321023f942e8f03e1dda939ec21732f5021cb1526ab7c3aaec8ca961dff367c3d918582b3c62187"} build_url:https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/JI8Zf4VbQrGB4Gt8BAPK2w/artifacts/public/build/firefox-47.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/fd0debbd073eac1e8cfb1a79626e206eba1fe0a74de0dda1ef2525933e1e475c5e15c598e1e7aef69c54f2d9add60132f536fcc3a94d4741e1d159f0e2013fc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/260d3001b956efc990e77e2cc59c81f70dd8b4f2bf4e12b3f321023f942e8f03e1dda939ec21732f5021cb1526ab7c3aaec8ca961dff367c3d918582b3c62187"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:15.023512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:15.023860) ========= 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=0333a256a5e4f052382dd180000001b1-1461187807.438233-1986024369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.78 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:52:15.807845) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:52:15.808171) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:52:15.809467) ========= ========= Total master_lag: 0.96 =========