builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1460677275.79 results: success (0) buildid: 20160414141343 builduid: 74e89ea8d85143b992a68ce6e16b164e revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:15.786582) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:15.787152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:15.787482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:15.871260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:15.871602) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 16:41:15-- 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% 114M=0s 2016-04-14 16:41:16 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.386548 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:16.287581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:16.287933) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.204809 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:16.504686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:16.505095) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4633816cde73beee6ed194e571c3a2ba14b15069 --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 4633816cde73beee6ed194e571c3a2ba14b15069 --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=3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 16:41:16,578 truncating revision to first 12 chars 2016-04-14 16:41:16,578 Setting DEBUG logging. 2016-04-14 16:41:16,578 attempt 1/10 2016-04-14 16:41:16,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4633816cde73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 16:41:16,808 unpacking tar archive at: mozilla-aurora-4633816cde73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.498663 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:17.018266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:17.018581) ========= script_repo_revision: 4633816cde73beee6ed194e571c3a2ba14b15069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:17.019023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:17.019330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 16:41:17.029469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-14 16:41:17.029861) ========= /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=3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:41:17 INFO - MultiFileLogger online at 20160414 16:41:17 in /builds/slave/test 16:41:17 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 16:41:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:41:17 INFO - {'append_to_log': False, 16:41:17 INFO - 'base_work_dir': '/builds/slave/test', 16:41:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:41:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:41:17 INFO - 'branch': 'Mozilla-Aurora', 16:41:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:41:17 INFO - 'config_files': ('talos/linux_config.py',), 16:41:17 INFO - 'default_actions': ('clobber', 16:41:17 INFO - 'read-buildbot-config', 16:41:17 INFO - 'download-and-extract', 16:41:17 INFO - 'populate-webroot', 16:41:17 INFO - 'create-virtualenv', 16:41:17 INFO - 'install', 16:41:17 INFO - 'run-tests'), 16:41:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:41:17 INFO - 'download_minidump_stackwalk': True, 16:41:17 INFO - 'download_symbols': 'ondemand', 16:41:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:41:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:41:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:41:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:41:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:41:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:41:17 INFO - 'installer_path': 'installer.exe', 16:41:17 INFO - 'log_level': 'info', 16:41:17 INFO - 'log_name': 'talos', 16:41:17 INFO - 'log_to_console': True, 16:41:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:41:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:41:17 INFO - 'opt_config_files': (), 16:41:17 INFO - 'pip_index': False, 16:41:17 INFO - 'sps_profile': False, 16:41:17 INFO - 'sps_profile_interval': 0, 16:41:17 INFO - 'suite': 'dromaeojs-e10s', 16:41:17 INFO - 'system_bits': '32', 16:41:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:41:17 INFO - 'title': 'talos-linux64-ix-059', 16:41:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:41:17 INFO - 'use_talos_json': True, 16:41:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:41:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:41:17 INFO - 'work_dir': 'build'} 16:41:17 INFO - ##### 16:41:17 INFO - ##### Running clobber step. 16:41:17 INFO - ##### 16:41:17 INFO - Running pre-action listener: _resource_record_pre_action 16:41:17 INFO - Running main action method: clobber 16:41:17 INFO - rmtree: /builds/slave/test/build 16:41:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:41:18 INFO - Running post-action listener: _resource_record_post_action 16:41:18 INFO - ##### 16:41:18 INFO - ##### Running read-buildbot-config step. 16:41:18 INFO - ##### 16:41:18 INFO - Running pre-action listener: _resource_record_pre_action 16:41:18 INFO - Running main action method: read_buildbot_config 16:41:18 INFO - Using buildbot properties: 16:41:18 INFO - { 16:41:18 INFO - "project": "", 16:41:18 INFO - "product": "firefox", 16:41:18 INFO - "script_repo_revision": "production", 16:41:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:41:18 INFO - "repository": "", 16:41:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:41:18 INFO - "buildid": "20160414141343", 16:41:18 INFO - "pgo_build": "True", 16:41:18 INFO - "basedir": "/builds/slave/test", 16:41:18 INFO - "buildnumber": 242, 16:41:18 INFO - "slavename": "talos-linux64-ix-059", 16:41:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:41:18 INFO - "platform": "ubuntu64_hw", 16:41:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:41:18 INFO - "branch": "mozilla-aurora", 16:41:18 INFO - "repo_path": "releases/mozilla-aurora", 16:41:18 INFO - "revision": "4633816cde73beee6ed194e571c3a2ba14b15069", 16:41:18 INFO - "stage_platform": "linux64-pgo", 16:41:18 INFO - "builduid": "74e89ea8d85143b992a68ce6e16b164e", 16:41:18 INFO - "slavebuilddir": "test" 16:41:18 INFO - } 16:41:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:41:18 INFO - Running post-action listener: _resource_record_post_action 16:41:18 INFO - ##### 16:41:18 INFO - ##### Running download-and-extract step. 16:41:18 INFO - ##### 16:41:18 INFO - Running pre-action listener: _resource_record_pre_action 16:41:18 INFO - Running main action method: download_and_extract 16:41:18 INFO - mkdir: /builds/slave/test/build/tests 16:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:18 INFO - https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:41:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:41:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:41:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:19 INFO - Downloaded 1448 bytes. 16:41:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:41:19 INFO - Using the following test package requirements: 16:41:19 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:41:19 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:41:19 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:41:19 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'jsshell-linux-x86_64.zip'], 16:41:19 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:41:19 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:41:19 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:41:19 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:41:19 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:41:19 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:41:19 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:41:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:41:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:41: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')]} 16:41:19 INFO - https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:41:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:41:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:41:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:21 INFO - Downloaded 23352259 bytes. 16:41:21 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'] 16:41:21 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 16:41:22 INFO - Return code: 0 16:41:22 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 16:41:22 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')]} 16:41:22 INFO - https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:40 INFO - Downloaded 23352259 bytes. 16:41:40 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'] 16:41:40 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 16:41:41 INFO - Return code: 0 16:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:41 INFO - https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:43 INFO - Downloaded 10845168 bytes. 16:41:43 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'] 16:41:43 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 16:41:43 INFO - Return code: 0 16:41: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')]} 16:41:43 INFO - https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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 16:41:45 INFO - Downloaded 60576593 bytes. 16:41:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:41:45 INFO - mkdir: /builds/slave/test/properties 16:41:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:41:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:41:45 INFO - Contents: 16:41:45 INFO - build_url:https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:41:46 INFO - Running post-action listener: _resource_record_post_action 16:41:46 INFO - Running post-action listener: set_extra_try_arguments 16:41:46 INFO - ##### 16:41:46 INFO - ##### Running populate-webroot step. 16:41:46 INFO - ##### 16:41:46 INFO - Running pre-action listener: _resource_record_pre_action 16:41:46 INFO - Running main action method: populate_webroot 16:41:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:41:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:41:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:41:46 INFO - '--tppagecycles', 16:41:46 INFO - '7'], 16:41:46 INFO - 'tests': ['tsvgm']}}, 16:41:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:41:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:41:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:41:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:41:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'tests': ['damp', 'tps']}, 16:41:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['damp', 'tps']}, 16:41:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:41:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:41:46 INFO - 'other': {'tests': ['a11yr', 16:41:46 INFO - 'ts_paint', 16:41:46 INFO - 'tpaint', 16:41:46 INFO - 'sessionrestore', 16:41:46 INFO - 'sessionrestore_no_auto_restore', 16:41:46 INFO - 'tabpaint']}, 16:41:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['a11yr', 16:41:46 INFO - 'ts_paint', 16:41:46 INFO - 'tpaint', 16:41:46 INFO - 'sessionrestore', 16:41:46 INFO - 'sessionrestore_no_auto_restore', 16:41:46 INFO - 'tabpaint']}, 16:41:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['a11yr', 16:41:46 INFO - 'ts_paint', 16:41:46 INFO - 'tpaint', 16:41:46 INFO - 'sessionrestore', 16:41:46 INFO - 'sessionrestore_no_auto_restore', 16:41:46 INFO - 'tabpaint']}, 16:41:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['a11yr', 16:41:46 INFO - 'ts_paint', 16:41:46 INFO - 'tpaint', 16:41:46 INFO - 'sessionrestore', 16:41:46 INFO - 'sessionrestore_no_auto_restore', 16:41:46 INFO - 'tabpaint']}, 16:41:46 INFO - 'other_l64': {'tests': ['a11yr', 16:41:46 INFO - 'ts_paint', 16:41:46 INFO - 'tpaint', 16:41:46 INFO - 'sessionrestore', 16:41:46 INFO - 'sessionrestore_no_auto_restore', 16:41:46 INFO - 'tabpaint']}, 16:41:46 INFO - 'other_nol64': {'tests': ['a11yr', 16:41:46 INFO - 'ts_paint', 16:41:46 INFO - 'tpaint', 16:41:46 INFO - 'sessionrestore', 16:41:46 INFO - 'sessionrestore_no_auto_restore', 16:41:46 INFO - 'tabpaint']}, 16:41:46 INFO - 'svgr': {'tests': ['tsvgx', 16:41:46 INFO - 'tsvgr_opacity', 16:41:46 INFO - 'tart', 16:41:46 INFO - 'tscrollx', 16:41:46 INFO - 'cart']}, 16:41:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['tsvgx', 16:41:46 INFO - 'tsvgr_opacity', 16:41:46 INFO - 'tart', 16:41:46 INFO - 'tscrollx', 16:41:46 INFO - 'cart']}, 16:41:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'tests': ['tp5o']}, 16:41:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'talos_options': ['--e10s'], 16:41:46 INFO - 'tests': ['tp5o']}, 16:41:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'talos_options': ['--xperf_path', 16:41:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:46 INFO - 'tests': ['tp5n']}, 16:41:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:46 INFO - 'talos_options': ['--e10s', 16:41:46 INFO - '--xperf_path', 16:41:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:46 INFO - 'tests': ['tp5n']}}, 16:41:46 INFO - 'talos.zip': {'path': '', 16:41:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:41:46 INFO - Running post-action listener: _resource_record_post_action 16:41:46 INFO - ##### 16:41:46 INFO - ##### Running create-virtualenv step. 16:41:46 INFO - ##### 16:41:46 INFO - Running pre-action listener: _resource_record_pre_action 16:41:46 INFO - Running main action method: create_virtualenv 16:41:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:41:46 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 16:41:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:41:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:41:46 INFO - Using real prefix '/usr' 16:41:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:41:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:41:48 INFO - Installing pip.................done. 16:41:48 INFO - Return code: 0 16:41:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:48 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:41:48 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 16:41:48 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 16:41:48 INFO - Using env: {'DISPLAY': ':0', 16:41:48 INFO - 'HOME': '/home/cltbld', 16:41:48 INFO - 'LANG': 'en_US.UTF-8', 16:41:48 INFO - 'LANGUAGE': 'en_US:en', 16:41:48 INFO - 'LOGNAME': 'cltbld', 16:41:48 INFO - 'MAIL': '/var/mail/cltbld', 16:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:48 INFO - 'MOZ_NO_REMOTE': '1', 16:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:48 INFO - 'NO_EM_RESTART': '1', 16:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:48 INFO - 'PWD': '/builds/slave/test', 16:41:48 INFO - 'SHELL': '/bin/bash', 16:41:48 INFO - 'SHLVL': '1', 16:41:48 INFO - 'TERM': 'linux', 16:41:48 INFO - 'TMOUT': '86400', 16:41:48 INFO - 'USER': 'cltbld', 16:41:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:48 INFO - '_': '/tools/buildbot/bin/python'} 16:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:49 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 16:41:49 INFO - Cleaning up... 16:41:49 INFO - Return code: 0 16:41:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:41:49 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')]} 16:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:49 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')]} 16:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:49 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:41:49 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 16:41:49 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 16:41:49 INFO - Using env: {'DISPLAY': ':0', 16:41:49 INFO - 'HOME': '/home/cltbld', 16:41:49 INFO - 'LANG': 'en_US.UTF-8', 16:41:49 INFO - 'LANGUAGE': 'en_US:en', 16:41:49 INFO - 'LOGNAME': 'cltbld', 16:41:49 INFO - 'MAIL': '/var/mail/cltbld', 16:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:49 INFO - 'MOZ_NO_REMOTE': '1', 16:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:49 INFO - 'NO_EM_RESTART': '1', 16:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:49 INFO - 'PWD': '/builds/slave/test', 16:41:49 INFO - 'SHELL': '/bin/bash', 16:41:49 INFO - 'SHLVL': '1', 16:41:49 INFO - 'TERM': 'linux', 16:41:49 INFO - 'TMOUT': '86400', 16:41:49 INFO - 'USER': 'cltbld', 16:41:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:49 INFO - '_': '/tools/buildbot/bin/python'} 16:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:49 INFO - Downloading/unpacking psutil>=0.7.1 16:41:49 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 16:41:49 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 16:41:49 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 16:41:49 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 16:41:49 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 16:41:49 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 16:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:41:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:51 INFO - Installing collected packages: psutil 16:41:51 INFO - Running setup.py install for psutil 16:41:51 INFO - building 'psutil._psutil_linux' extension 16:41:51 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 16:41:52 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 16:41:52 INFO - building 'psutil._psutil_posix' extension 16:41:52 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 16:41:52 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 16:41:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:52 INFO - Successfully installed psutil 16:41:52 INFO - Cleaning up... 16:41:52 INFO - Return code: 0 16:41:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:41:52 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')]} 16:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:52 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')]} 16:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:52 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:41:52 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 16:41:52 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 16:41:52 INFO - Using env: {'DISPLAY': ':0', 16:41:52 INFO - 'HOME': '/home/cltbld', 16:41:52 INFO - 'LANG': 'en_US.UTF-8', 16:41:52 INFO - 'LANGUAGE': 'en_US:en', 16:41:52 INFO - 'LOGNAME': 'cltbld', 16:41:52 INFO - 'MAIL': '/var/mail/cltbld', 16:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:52 INFO - 'MOZ_NO_REMOTE': '1', 16:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:52 INFO - 'NO_EM_RESTART': '1', 16:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:52 INFO - 'PWD': '/builds/slave/test', 16:41:52 INFO - 'SHELL': '/bin/bash', 16:41:52 INFO - 'SHLVL': '1', 16:41:52 INFO - 'TERM': 'linux', 16:41:52 INFO - 'TMOUT': '86400', 16:41:52 INFO - 'USER': 'cltbld', 16:41:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:52 INFO - '_': '/tools/buildbot/bin/python'} 16:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 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 16:41:53 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 16:41:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:41:55 INFO - Installing collected packages: mozsystemmonitor 16:41:55 INFO - Running setup.py install for mozsystemmonitor 16:41:55 INFO - Successfully installed mozsystemmonitor 16:41:55 INFO - Cleaning up... 16:41:55 INFO - Return code: 0 16:41:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:55 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:41:55 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 16:41:55 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 16:41:55 INFO - Using env: {'DISPLAY': ':0', 16:41:55 INFO - 'HOME': '/home/cltbld', 16:41:55 INFO - 'LANG': 'en_US.UTF-8', 16:41:55 INFO - 'LANGUAGE': 'en_US:en', 16:41:55 INFO - 'LOGNAME': 'cltbld', 16:41:55 INFO - 'MAIL': '/var/mail/cltbld', 16:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:55 INFO - 'MOZ_NO_REMOTE': '1', 16:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:55 INFO - 'NO_EM_RESTART': '1', 16:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:55 INFO - 'PWD': '/builds/slave/test', 16:41:55 INFO - 'SHELL': '/bin/bash', 16:41:55 INFO - 'SHLVL': '1', 16:41:55 INFO - 'TERM': 'linux', 16:41:55 INFO - 'TMOUT': '86400', 16:41:55 INFO - 'USER': 'cltbld', 16:41:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:55 INFO - '_': '/tools/buildbot/bin/python'} 16:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:41:55 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 16:41:55 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 16:41:55 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 16:41:55 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 16:41:55 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 16:41:55 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 16:41:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:41:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:41:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 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 16:41:57 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 16:41:58 INFO - Downloading docopt-0.6.1.tar.gz 16:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:41:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:41:58 INFO - Running setup.py install for blobuploader 16:41:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:41:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:41:58 INFO - Running setup.py install for requests 16:41:58 INFO - Running setup.py install for docopt 16:41:58 INFO - Successfully installed blobuploader requests docopt 16:41:58 INFO - Cleaning up... 16:41:58 INFO - Return code: 0 16:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:41:58 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')]} 16:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:58 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')]} 16:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:58 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:41:58 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 16:41:58 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 16:41:58 INFO - Using env: {'DISPLAY': ':0', 16:41:58 INFO - 'HOME': '/home/cltbld', 16:41:58 INFO - 'LANG': 'en_US.UTF-8', 16:41:58 INFO - 'LANGUAGE': 'en_US:en', 16:41:58 INFO - 'LOGNAME': 'cltbld', 16:41:58 INFO - 'MAIL': '/var/mail/cltbld', 16:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:58 INFO - 'MOZ_NO_REMOTE': '1', 16:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:41:58 INFO - 'NO_EM_RESTART': '1', 16:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:58 INFO - 'PWD': '/builds/slave/test', 16:41:58 INFO - 'SHELL': '/bin/bash', 16:41:58 INFO - 'SHLVL': '1', 16:41:58 INFO - 'TERM': 'linux', 16:41:58 INFO - 'TMOUT': '86400', 16:41:58 INFO - 'USER': 'cltbld', 16:41:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:58 INFO - '_': '/tools/buildbot/bin/python'} 16:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:41:59 INFO - Running setup.py (path:/tmp/pip-BNbMSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:41:59 INFO - Running setup.py (path:/tmp/pip-VpX2Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:41:59 INFO - Running setup.py (path:/tmp/pip-r5Z70X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:41:59 INFO - Running setup.py (path:/tmp/pip-xuwhaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:41:59 INFO - Running setup.py (path:/tmp/pip-XohjUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:41:59 INFO - Running setup.py (path:/tmp/pip-FnWAQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:41:59 INFO - Running setup.py (path:/tmp/pip-ZV_YT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:41:59 INFO - Running setup.py (path:/tmp/pip-4H0HMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:41:59 INFO - Running setup.py (path:/tmp/pip-oXhWG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:41:59 INFO - Running setup.py (path:/tmp/pip-xVwTgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:41:59 INFO - Running setup.py (path:/tmp/pip-PRmUa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:41:59 INFO - Running setup.py (path:/tmp/pip-KawsOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:41:59 INFO - Running setup.py (path:/tmp/pip-Y4Pnd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:41:59 INFO - Running setup.py (path:/tmp/pip-638E6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:00 INFO - Running setup.py (path:/tmp/pip-E1_e9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:00 INFO - Running setup.py (path:/tmp/pip-itzLDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:00 INFO - Running setup.py (path:/tmp/pip-60WvbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:00 INFO - Running setup.py install for manifestparser 16:42:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:00 INFO - Running setup.py install for mozcrash 16:42:00 INFO - Running setup.py install for mozdebug 16:42:00 INFO - Running setup.py install for mozdevice 16:42:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:42:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:00 INFO - Running setup.py install for mozfile 16:42:00 INFO - Running setup.py install for mozhttpd 16:42:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:00 INFO - Running setup.py install for mozinfo 16:42:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:00 INFO - Running setup.py install for mozInstall 16:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Running setup.py install for mozleak 16:42:01 INFO - Running setup.py install for mozlog 16:42:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Running setup.py install for moznetwork 16:42:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Running setup.py install for mozprocess 16:42:01 INFO - Running setup.py install for mozprofile 16:42:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Running setup.py install for mozrunner 16:42:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Running setup.py install for mozscreenshot 16:42:01 INFO - Running setup.py install for moztest 16:42:01 INFO - Running setup.py install for mozversion 16:42:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:42:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:42:01 INFO - Cleaning up... 16:42:01 INFO - Return code: 0 16:42:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:01 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')]} 16:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:01 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')]} 16:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:02 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:42:02 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 16:42:02 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 16:42:02 INFO - Using env: {'DISPLAY': ':0', 16:42:02 INFO - 'HOME': '/home/cltbld', 16:42:02 INFO - 'LANG': 'en_US.UTF-8', 16:42:02 INFO - 'LANGUAGE': 'en_US:en', 16:42:02 INFO - 'LOGNAME': 'cltbld', 16:42:02 INFO - 'MAIL': '/var/mail/cltbld', 16:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:02 INFO - 'MOZ_NO_REMOTE': '1', 16:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:02 INFO - 'NO_EM_RESTART': '1', 16:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:02 INFO - 'PWD': '/builds/slave/test', 16:42:02 INFO - 'SHELL': '/bin/bash', 16:42:02 INFO - 'SHLVL': '1', 16:42:02 INFO - 'TERM': 'linux', 16:42:02 INFO - 'TMOUT': '86400', 16:42:02 INFO - 'USER': 'cltbld', 16:42:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:02 INFO - '_': '/tools/buildbot/bin/python'} 16:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:02 INFO - Running setup.py (path:/tmp/pip-N4iq4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:02 INFO - Running setup.py (path:/tmp/pip-lu8qeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:02 INFO - Running setup.py (path:/tmp/pip-NrElAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:02 INFO - Running setup.py (path:/tmp/pip-onBWx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:02 INFO - Running setup.py (path:/tmp/pip-hBTQkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:02 INFO - Running setup.py (path:/tmp/pip-WPwrCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:02 INFO - Running setup.py (path:/tmp/pip-c56FEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:02 INFO - Running setup.py (path:/tmp/pip-eUFFE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:02 INFO - Running setup.py (path:/tmp/pip-BEhmKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:02 INFO - Running setup.py (path:/tmp/pip-cDcmVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:02 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)) 16:42:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:02 INFO - Running setup.py (path:/tmp/pip-4mXcEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:03 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)) 16:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:03 INFO - Running setup.py (path:/tmp/pip-DvYsLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:03 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)) 16:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:03 INFO - Running setup.py (path:/tmp/pip-VfaHzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:03 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)) 16:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:03 INFO - Running setup.py (path:/tmp/pip-41Lw_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:03 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)) 16:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:03 INFO - Running setup.py (path:/tmp/pip-N4ztiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:03 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)) 16:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:03 INFO - Running setup.py (path:/tmp/pip-zyba_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:03 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)) 16:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:03 INFO - Running setup.py (path:/tmp/pip-B5u1M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:03 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)) 16:42:03 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)) 16:42:03 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)) 16:42:03 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)) 16:42:03 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)) 16:42:03 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)) 16:42:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:05 INFO - Downloading blessings-1.6.tar.gz 16:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:42:05 INFO - Installing collected packages: blessings 16:42:05 INFO - Running setup.py install for blessings 16:42:05 INFO - Successfully installed blessings 16:42:05 INFO - Cleaning up... 16:42:05 INFO - Return code: 0 16:42:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:42:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:05 INFO - Reading from file tmpfile_stdout 16:42:05 INFO - Current package versions: 16:42:05 INFO - argparse == 1.2.1 16:42:05 INFO - blessings == 1.6 16:42:05 INFO - blobuploader == 1.2.4 16:42:05 INFO - docopt == 0.6.1 16:42:05 INFO - manifestparser == 1.1 16:42:05 INFO - mozInstall == 1.12 16:42:05 INFO - mozcrash == 0.17 16:42:05 INFO - mozdebug == 0.1 16:42:05 INFO - mozdevice == 0.48 16:42:05 INFO - mozfile == 1.2 16:42:05 INFO - mozhttpd == 0.7 16:42:05 INFO - mozinfo == 0.9 16:42:05 INFO - mozleak == 0.1 16:42:05 INFO - mozlog == 3.1 16:42:05 INFO - moznetwork == 0.27 16:42:05 INFO - mozprocess == 0.22 16:42:05 INFO - mozprofile == 0.28 16:42:05 INFO - mozrunner == 6.11 16:42:05 INFO - mozscreenshot == 0.1 16:42:05 INFO - mozsystemmonitor == 0.0 16:42:05 INFO - moztest == 0.7 16:42:05 INFO - mozversion == 1.4 16:42:05 INFO - psutil == 3.1.1 16:42:05 INFO - requests == 1.2.3 16:42:05 INFO - wsgiref == 0.1.2 16:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:05 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:42:05 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 16:42:05 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 16:42:05 INFO - Using env: {'DISPLAY': ':0', 16:42:05 INFO - 'HOME': '/home/cltbld', 16:42:05 INFO - 'LANG': 'en_US.UTF-8', 16:42:05 INFO - 'LANGUAGE': 'en_US:en', 16:42:05 INFO - 'LOGNAME': 'cltbld', 16:42:05 INFO - 'MAIL': '/var/mail/cltbld', 16:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:05 INFO - 'MOZ_NO_REMOTE': '1', 16:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:05 INFO - 'NO_EM_RESTART': '1', 16:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:05 INFO - 'PWD': '/builds/slave/test', 16:42:05 INFO - 'SHELL': '/bin/bash', 16:42:05 INFO - 'SHLVL': '1', 16:42:05 INFO - 'TERM': 'linux', 16:42:05 INFO - 'TMOUT': '86400', 16:42:05 INFO - 'USER': 'cltbld', 16:42:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:05 INFO - '_': '/tools/buildbot/bin/python'} 16:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 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)) 16:42:06 INFO - Cleaning up... 16:42:06 INFO - Return code: 0 16:42:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:42: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')]} 16:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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')]} 16:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:42: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', 'jsonschema'] in /builds/slave/test/build 16:42: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 jsonschema 16:42:06 INFO - Using env: {'DISPLAY': ':0', 16:42:06 INFO - 'HOME': '/home/cltbld', 16:42:06 INFO - 'LANG': 'en_US.UTF-8', 16:42:06 INFO - 'LANGUAGE': 'en_US:en', 16:42:06 INFO - 'LOGNAME': 'cltbld', 16:42:06 INFO - 'MAIL': '/var/mail/cltbld', 16:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:06 INFO - 'MOZ_NO_REMOTE': '1', 16:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:06 INFO - 'NO_EM_RESTART': '1', 16:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:06 INFO - 'PWD': '/builds/slave/test', 16:42:06 INFO - 'SHELL': '/bin/bash', 16:42:06 INFO - 'SHLVL': '1', 16:42:06 INFO - 'TERM': 'linux', 16:42:06 INFO - 'TMOUT': '86400', 16:42:06 INFO - 'USER': 'cltbld', 16:42:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:06 INFO - '_': '/tools/buildbot/bin/python'} 16:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:06 INFO - Downloading/unpacking jsonschema 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:42:09 INFO - Downloading/unpacking functools32 (from jsonschema) 16:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:42:09 INFO - warning: no files found matching '*.txt' 16:42:09 INFO - no previously-included directories found matching 'build' 16:42:09 INFO - no previously-included directories found matching 'dist' 16:42:09 INFO - no previously-included directories found matching '.git*' 16:42:09 INFO - Installing collected packages: jsonschema, functools32 16:42:09 INFO - Running setup.py install for functools32 16:42:09 INFO - warning: no files found matching '*.txt' 16:42:09 INFO - no previously-included directories found matching 'build' 16:42:09 INFO - no previously-included directories found matching 'dist' 16:42:09 INFO - no previously-included directories found matching '.git*' 16:42:09 INFO - Successfully installed jsonschema functools32 16:42:09 INFO - Cleaning up... 16:42:09 INFO - Return code: 0 16:42:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:09 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 0x7ff73e00bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, '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': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', '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 16:42:09 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 16:42:09 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 16:42:09 INFO - Using env: {'DISPLAY': ':0', 16:42:09 INFO - 'HOME': '/home/cltbld', 16:42:09 INFO - 'LANG': 'en_US.UTF-8', 16:42:09 INFO - 'LANGUAGE': 'en_US:en', 16:42:09 INFO - 'LOGNAME': 'cltbld', 16:42:09 INFO - 'MAIL': '/var/mail/cltbld', 16:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:09 INFO - 'MOZ_NO_REMOTE': '1', 16:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:09 INFO - 'NO_EM_RESTART': '1', 16:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:09 INFO - 'PWD': '/builds/slave/test', 16:42:09 INFO - 'SHELL': '/bin/bash', 16:42:09 INFO - 'SHLVL': '1', 16:42:09 INFO - 'TERM': 'linux', 16:42:09 INFO - 'TMOUT': '86400', 16:42:09 INFO - 'USER': 'cltbld', 16:42:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:09 INFO - '_': '/tools/buildbot/bin/python'} 16:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:09 INFO - Downloading/unpacking flake8 16:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:42:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:42:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:42:12 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 16:42:12 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 16:42:12 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 16:42:12 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 16:42:12 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 16:42:12 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 16:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:42:12 INFO - no previously-included directories found matching 'docs/_build' 16:42:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:42:12 INFO - Running setup.py install for pep8 16:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:42:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:42:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:42:12 INFO - no previously-included directories found matching 'docs/_build' 16:42:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:42:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:42:12 INFO - Cleaning up... 16:42:12 INFO - Return code: 0 16:42:12 INFO - Running post-action listener: _resource_record_post_action 16:42:12 INFO - Running post-action listener: _start_resource_monitoring 16:42:12 INFO - Starting resource monitoring. 16:42:12 INFO - ##### 16:42:12 INFO - ##### Running install step. 16:42:12 INFO - ##### 16:42:12 INFO - Running pre-action listener: _resource_record_pre_action 16:42:12 INFO - Running main action method: install 16:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:12 INFO - Reading from file tmpfile_stdout 16:42:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:42:12 INFO - Reading from file tmpfile_stdout 16:42:12 INFO - Output received: 16:42:12 INFO - Usage: mozinstall [options] installer 16:42:12 INFO - Options: 16:42:12 INFO - -h, --help show this help message and exit 16:42:12 INFO - -d DEST, --destination=DEST 16:42:12 INFO - Directory to install application into. [default: 16:42:12 INFO - "/builds/slave/test"] 16:42:12 INFO - --app=APP Application being installed. [default: firefox] 16:42:12 INFO - mkdir: /builds/slave/test/build/application 16:42:12 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'] 16:42:12 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 16:42:28 INFO - Reading from file tmpfile_stdout 16:42:28 INFO - Output received: 16:42:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:42:28 INFO - Running post-action listener: _resource_record_post_action 16:42:28 INFO - ##### 16:42:28 INFO - ##### Running run-tests step. 16:42:28 INFO - ##### 16:42:28 INFO - Running pre-action listener: _resource_record_pre_action 16:42:28 INFO - Running main action method: run_tests 16:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:42:28 INFO - Python 2.7.3 16:42:28 INFO - Return code: 0 16:42:28 INFO - grabbing minidump binary from tooltool 16:42:28 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')]} 16:42:28 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 0x119a160>, '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 0x119b060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119b4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:42:28 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 16:42:28 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 16:42:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:42:28 INFO - Return code: 0 16:42:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:42:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:42:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:42:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:42:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:42:29 INFO - Return code: 0 16:42:29 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/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:42:29 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/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 16:42:29 INFO - Using env: {'DISPLAY': ':0', 16:42:29 INFO - 'HOME': '/home/cltbld', 16:42:29 INFO - 'LANG': 'en_US.UTF-8', 16:42:29 INFO - 'LANGUAGE': 'en_US:en', 16:42:29 INFO - 'LOGNAME': 'cltbld', 16:42:29 INFO - 'MAIL': '/var/mail/cltbld', 16:42:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:42:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:29 INFO - 'MOZ_NO_REMOTE': '1', 16:42:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:29 INFO - 'NO_EM_RESTART': '1', 16:42:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:29 INFO - 'PWD': '/builds/slave/test', 16:42:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:42:29 INFO - 'SHELL': '/bin/bash', 16:42:29 INFO - 'SHLVL': '1', 16:42:29 INFO - 'TERM': 'linux', 16:42:29 INFO - 'TMOUT': '86400', 16:42:29 INFO - 'USER': 'cltbld', 16:42:29 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829', 16:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:29 INFO - '_': '/tools/buildbot/bin/python'} 16:42:29 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/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 16:42:29 INFO - mozversion application_buildid: 20160414141343 16:42:29 INFO - mozversion application_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 16:42:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:42:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:42:29 INFO - mozversion application_name: Firefox 16:42:29 INFO - mozversion application_remotingname: firefox-dev 16:42:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:42:29 INFO - mozversion application_vendor: Mozilla 16:42:29 INFO - mozversion application_version: 47.0a2 16:42:29 INFO - mozversion platform_buildid: 20160414141343 16:42:29 INFO - mozversion platform_changeset: 4633816cde73beee6ed194e571c3a2ba14b15069 16:42:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:42:29 INFO - mozversion platform_version: 47.0a2 16:42:29 INFO - using testdate: 1460677349 16:42:29 INFO - actual date: 1460677349 16:42:29 INFO - starting webserver on 'localhost:58694' 16:42:29 INFO - SUITE-START | Running 2 tests 16:42:29 INFO - TEST-START | dromaeo_css 16:42:29 INFO - operating with platform_type : linux_ 16:42:29 INFO - Initialising browser for dromaeo_css test... 16:42:29 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSxCmz/profile http://localhost:58694/getInfo.html) 16:42:33 INFO - PROCESS | 3313 | 16:42:33 INFO - PROCESS | 3313 | (process:3390): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:42:34 INFO - PROCESS | 3313 | __metrics Screen width/height:1600/1200 16:42:34 INFO - PROCESS | 3313 | colorDepth:24 16:42:34 INFO - PROCESS | 3313 | Browser inner width/height: 1024/697 16:42:34 INFO - PROCESS | 3313 | __metrics 16:42:35 ERROR - PROCESS | 3313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:42:36 INFO - TEST-INFO | 3313: exit 0 16:42:36 INFO - Browser initialized. 16:42:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:42:36 INFO - TEST-INFO | started process 3441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHSxCmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:38 INFO - PROCESS | 3441 | 16:42:38 INFO - PROCESS | 3441 | (process:3509): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:42:48 INFO - PROCESS | 3441 | RSS: Main: 151359488 16:42:48 INFO - PROCESS | 3441 | 16:43:37 INFO - PROCESS | 3441 | 1460677417629 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] 16:45:45 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58694/tests/dromaeo/cssquery-ext.html) 16:45:46 INFO - PROCESS | 3441 | RSS: Main: 154927104 16:45:46 INFO - PROCESS | 3441 | 16:48:48 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-ext.html (next: http://localhost:58694/tests/dromaeo/cssquery-jquery.html) 16:48:49 INFO - PROCESS | 3441 | RSS: Main: 153509888 16:48:49 INFO - PROCESS | 3441 | 16:51:50 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58694/tests/dromaeo/cssquery-mootools.html) 16:51:51 INFO - PROCESS | 3441 | RSS: Main: 153583616 16:51:51 INFO - PROCESS | 3441 | 16:54:53 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58694/tests/dromaeo/cssquery-prototype.html) 16:54:53 INFO - PROCESS | 3441 | RSS: Main: 152727552 16:54:53 INFO - PROCESS | 3441 | 16:57:55 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58694/tests/dromaeo/cssquery-yui.html) 16:57:56 INFO - PROCESS | 3441 | RSS: Main: 153833472 16:57:56 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-yui.html (next: http://localhost:58694/tests/dromaeo/cssquery-dojo.html) 17:00:58 INFO - PROCESS | 3441 | RSS: Main: 155807744 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | __start_tp_report 17:00:58 INFO - PROCESS | 3441 | _x_x_mozilla_page_load 17:00:58 INFO - PROCESS | 3441 | _x_x_mozilla_page_load_details 17:00:58 INFO - PROCESS | 3441 | |i|pagename|runs| 17:00:58 INFO - PROCESS | 3441 | |0;dojo.html;3297.0438572813887;3333.316670082633;3353.9832300838493;3358.66413358664;3383.95097519769;5359.624826262163;5370.087085195516;5380.91928621071;5401.56787457003;5404.405515393309;5356.9732151339285;5366.543843773275;5368.785248590061;5394.460553944604;5455.890882182354;4933.013397320541;4983.750812459362;5021.246812978046;5033.697978121324;5063.341765570489;4889.437714662824;4952.182889823175;5014.924776128361;5015.272785446108;5043.218301163325;4975.9004819903585;5024.271480635306;5025.070361983045;5035.521625445577;5037.798488060474;4888.780004899788;5018.422881368653;5030.069437154101;5042.268871013719;5063.0380227756605;4815.036992601459;4870.9269360959615;4886.657933944625;4895.804167833282;4929.704217746947;5114.335136432277;5148.922766158473;5152.458991805881;5169.302144210521;5193.298904647862;5596.692181929992;5715.2855893013375;5734.799282025151;5771.682557459338;5785.82642520725;5770.04794208955;5784.2769653793275;5797.130430435426;5828.766849326022;5840.737166827503;5441.2654291670515;5467;5474.698891560963;5478.753456094485;5481.451854814526;5826.475617194473;5861.150133230658;5921.644701317935;5923.822285331447;5925.259342582177;5655.123455864347;5664.461876121762;5673.517750991129;5678.261825962599;5708.429157084258;5745.368009518949;5747.655140691572;5751.626144300607;5753.654780713171;5770.711464426762;5651.632643878134;5719.7426115824055;5736.5123964462655;5759.913601295984;5822.214001109796;5748.856278593069;5767.394423585547;5798.391168927286;5802.535797136219;5804.1293805929445;4397.648188144941;4437.733735975852;4453;4473.664475164375;4475.753833539186;3862.517185351831;3983.0440694233175;3984.322665146932;4024.054347228399;4076.0421300994244;5408.134698448308;5495.560355171577;5556.972215138899;5573.219749235111;5607.214989901417;5842.737076831553;5863.442972917566;5866.794662186803;5868.207791948118;5868.2664666916635;5511.118221084607;5518.227448157261;5598.58010649203;5614.466625670555;5629.127485239795;4984.651074424828;4989.3264409305;4991.051700176955;5029.346184995927;5048.0913435581215;6049.758009679652;6050.45545900871;6055.909161362583;6056.424639659225;6085.056816193497;5618.803341882933;5693.345265294544;5768.077107662753;5770.192173095686;5776;5976.731047102978;5988.311344195473;5999.790007349722;6044.425779550936;6064.211652485325;5636.549076073986;5739.253896993364;5756.683382414008;5759.136129580596;5760.33756118035;5783.479486846204;5794.159846822103;5820.952228598893;5843.2695913010875;5857.970710146422;5574.219609254788;5608.915866262091;5640.435956404327;5644.125160600113;5651.039323314964;5513.944860551504;5585.078462053716;5609.80365687199;5649.745761440663;5661.264035675335;5556.833295001156;5587.44125587438;5588.580856435702;5589.245451863946;5622.578306626938;5659.943400565941;5669.4047125051275;5704.429557044263;5716.142578613075;5716.256886604881;5420.918686219631;5457.372402173801;5468.2344471773185;5580.414056524007;5604.075327570905 17:00:58 INFO - PROCESS | 3441 | |1;ext.html;512.7538781384933;536.2413750557596;542.991855122173;596.5645079092262;627.6736097229441;36817;37457.250854982885;37584.62415375846;37599.81200094002;37651;38624.227515449675;39363.60636393635;39394.21211575774;39463.210735785266;39497.40753888694;8394.79013024673;8577.39958202926;8639.740807775777;8659.35054870884;8700.738977830675;8595.269402100828;8944.060873608276;8951.641934322652;8981.506017169053;9000.684976025841;8909.777255568597;8949.821003579924;8989;9027.729168124966;9052.954735226347;8836.293096552261;8954.955225223897;8972.955135224314;8985.146411090936;9011.098890111001;8740.825183496358;8901.154390332907;8912.598933048028;8924.062973387765;8934.73195804127;33456.49815252773;38218;38772.80613596914;38820.22359552793;38840.80579597112;3282.770206085575;3344.7491438142238;3419.281950790337;3430.9828450857585;3763.209725957552;25518.10686625978;25596.23211303664;26082.73917260822;26291.34271643205;26649.600255996174;4005.7997100144876;4094.4267802507675;4119.938200926988;4134.669226461876;4158.979205103986;256218;256274;256391;256478.99999999814;257085;37187.25625487475;37667.05832354158;37773;46619.766901165276;47173.76413117912;35997;36370;36398.8180059098;36426.089347766516;36474.27051458956;15198.46805361807;15279.541613751606;15319.387224511118;15332.693346133015;15365.539033829004;13199.076064675573;13234.867651323557;13244.072914895865;13251.602451926457;13252.337383130805;14634;14976;14990.250487475801;15152.16663083541;15252;5923.674197919069;6070.119832624245;6096.420840020191;6099.603525770811;6107.633541987495;1020.4795554267378;1081.0162751895737;1084.3006260961636;1104.8839871813504;1149.655103468956;29211.415771684446;29505.409891802472;29525;30475.390492190032;30518.84740576283;1107.1585594947737;1120.5797825815318;1123.4102096399456;1126.645106791358;1177.2230327983489;15204.163770992702;15469.226538673021;15694.450694225647;15703.528894133195;15817.68364632724;328337;620258;770299;778273;780162;60534.69732651309;61240.693796531625;61268.08097878535;61283.38716612866;61360.38639613636;1330.6540299522194;1350.9662258443618;1375.6698392385756;1413.611256904339;1450.173401161349;27286.181414557595;27371.198168151408;27429.725702743515;27532.17403477899;28046.719532805226;43185.3522197161;43464.565354347316;43581.564184357754;43655.56344436515;44983.32525012062;303211;303316;304822;306506;307087;33270;34046.82976585101;34663;34788.30423391569;34797;44797;45643.087138256386;46074.769626151654;46131.30803038024;46368.30447543357;38590.42114368343;38752.22495550017;38963.61036389713;39205.2158956825;39366.212675746894;38173.80913095417;38587.807060964515;38936.2212755749;39168.216635666555;39396.409053863645;37797.43303850389;38201.5991089543;38422.615773841906;39032.41451378175;39063.609363906;32808.586762075705;33894.491582625786;34072;34084.14789630279;34115;25945.6108158374;26464;26544.734552654227;26567.734322656524;26726 17:00:58 INFO - PROCESS | 3441 | |2;jquery.html;357.2230398882432;366.7414472796678;370.09696340928133;376.8963535027867;379.5445465441467;17456.650866982654;17635.911820440895;18154.3645972391;18277.543061423472;18328.083595820222;15124.09255444674;15874.603134921632;15991.200439978013;16097.597560061004;16109.194540272998;5315.335583052119;5330.3603567571945;5335.986162629108;5350.117230656956;5435.728213589315;5477.287952566161;5494.038543254935;5504.366997795265;5506.64206826557;5513.61404701671;5218.2172674099;5413.133898576229;5434.347878254615;5437.184422336642;5452.863678408032;5456.972715136399;5469.671819690831;5516.365617953927;5524.33707955044;5547;5493.258410114623;5537.640053396516;5548.0845660465975;5550.666959982414;5557.277553918006;13380.79928801059;13539.458421663121;16047.919760401122;21681.891590542105;21948.561028779335;2240.473488730147;2303.659718253873;2311.780380863815;2349.447879748258;2542.545022170481;9157.862632060524;11532.884671153264;12776;12782.744345113046;12846.550370736979;1762.841344279021;1783.7235228539598;1791.758112654788;1798.1638538079856;1830.359374219026;65385;66687.66656166737;67840;68151;68953;10041;10043.748906277255;10155.7461063474;10238.232132590085;10309.639162629272;13753.174809511462;13789.655258618413;13791.51729689476;13812.86187138136;13842.100263482842;7643.1974642662835;8057.35541156706;8111.107778144399;8133.064697559738;8188.14024527416;7623.542587444771;7671.77251639735;7811.648475818602;7874.881876771853;8018.799530011796;4358.280883654225;4498.437695288089;4533.38799262102;4551.543506078023;4661.95338046622;1836.091134888239;1879.351623689825;1931.690929451309;1936.1771247220156;1964.0965156028387;930.3441074042784;967.9854802177973;1009.4548943570536;1067.2475904487317;1067.7010437077631;17393.565160870825;17590.472285831445;17615.82384176142;17679.55801104957;18135.818641813414;999.4153420249236;1028.9897101029044;1029.9794004119876;1047.36634336227;1052.5105825791045;9811.558479868423;10124.291299608956;10153;10178.541965611565;10248.333858299187;416607;424084;427537;432952;434807;71510;74623.62688186632;78430.6078469604;79792.20207797848;81846;1049.5434485998614;1063.813832579311;1068.2415485005733;1068.8824229334766;1091.9454027298602;15996.360145594512;16185.4335098271;16311.510654680378;16421.42525011619;16568.17159142062;36058.63941360553;36729.26541469102;36985.260294793414;37112.443313350865;37838.810805945795;51198;52547;52557;52728.47271527389;52939;8179.509229446252;8220.58897055133;8451.830963380575;8466.57667116654;8490.702825401082;11633.767324653629;12515.37423128858;12645.620631381073;13215.537456188988;13265.535706250621;10844.566217351217;11005.394703291397;11085.170946793689;11214.439278036229;11530;10990.186619207741;11043.503042362952;11103.278286911325;11188.776224475629;11270.436478175894;11187.440627968406;11237.60668376603;11268.83096753533;11388;11452.885471145515;8348.624311905858;8360.832783344178;8370.748877533684;8443.83112337762;8723.869141963003;11236.550537978716;11730.413479326171;11768.646940591796;11819.290842549475;12138.575149869712 17:00:58 INFO - PROCESS | 3441 | |3;mootools.html;1523.3449616664834;1603.8556529912305;1860.5999710062342;1940.2627001739336;1967.1541237267977;7261.636918154084;7446.069241344832;7954.562499062549;8091.3526917846575;8183.099859015503;7675.6545955432;7935.682572697086;7954.801129971739;8172.91827081729;8251.587420628975;2374.19277445668;2409.373562873648;2425.2118061629953;2425.7816796488314;2427.017058091476;2454.460018795871;2457.8033757299463;2467.938301542458;2481.4540801023745;2488.7635674610883;2414.1791790791126;2428.2715185444385;2431.258466167818;2432.5134973005383;2445.730969593343;2381.678473406094;2394.257780088178;2402.3393566769105;2408.7109546854313;2431.610942249232;2428.84212526187;2440.7803297703113;2458.5697502936914;2463.4703538739077;2472.122396549235;8340.416170868042;8346;8347.207015333533;8353.289970352467;8438.11399803018;5023.899522009576;5102.566281866046;5127.5385215330425;5157.277981082651;5162.561182299509;3201.2477067889026;3239.7570182236427;3293.835308234579;3324.5844269466315;3336.182635254378;1017.282815614997;2062.3503596367245;2075.740532433446;2082.437741809718;2084.0413409831494;11167.162462815322;11253.60612378571;11290.830637540443;11331.603393881174;11346.319220846775;4226.640735537514;4339.7830108494445;4384.4519435070615;4404.317330813729;4415.712978656377;9099.226565741854;9108.544572771334;9118.95440522793;9163.541822908828;9212.032736562564;5076.18780995039;5115.283860259567;5128.8717782055;5129.538341549279;5131.923021154686;4527.796249168729;4585.014221942299;4614.653900957442;4663.417072865892;4721.858344249678;3568.4647302904773;3605.9098522536624;3650.4341827016324;3650.525431693916;3668.5414323209598;1058.380847204394;1068.647346375694;1073.897979691928;1074.4949873559572;1082.437132691012;1186.5431808753692;1188.102982248397;1223.877612238769;1228.6744012836605;1246.6945598328286;7783.766487005286;7825.13923468418;7855.175206603339;7897.763067107996;7928.127905930343;506.82767858927406;511.1974200505171;511.2842021170391;513.7046198435914;524.2320001198262;6169.136320915076;6233.096201050822;6239.438450539473;6294.370562943761;6297.905531417033;9904.851427228597;10148.08667219939;10173.694789156338;10249.641262555924;10332;10079.748006299902;10268.229882758824;10293.228007899437;10407.271490995709;10412.947935260276;7961.283484486424;8047.476914000571;8071.152528984607;8092.352611791042;8159.46963447374;7496.962515187389;7680.5391676499585;7874.1338452769005;7932.127465978622;7944.563049032358;8794;8898.06570310134;9006.954965225394;9021.052789457275;9056.54717264121;9054.139856713602;9203.539823008956;9210.631574736935;9303.76740581491;9413.670521531714;6483.546151769331;6911.17065952089;7195.568265904062;7200.963995179991;7216.386607138242;7856.332211761835;7863.803404914923;7873.566953817595;7901.209879012283;7944.6424910877995;6828.419584335188;6958.965205173941;7077.221505634273;7088.326608972139;7208.96395518019;6855.657217139223;6870;6968.965155174192;6996.335348141918;7092.078029856086;7449.4412919032375;7496.925030749622;7665.808354790952;7671.462997590115;7685.654145563575;6888.448924085961;6933.653317334214;6954.547954382949;6955.165380154212;6960.617166055916;6540.705668245036;6548.8362790930605;6604.900926486011;6609.702563384563;6612 17:00:58 INFO - PROCESS | 3441 | |4;prototype.html;348.6112984022815;351.63254399152896;353.33572882979996;353.78242380935734;353.9504469374288;6256.186695729554;6311.747530098791;6325.557210995221;6350.269718982318;6352.428281454668;6245.843853903654;6250.687465626712;6258.092576576405;6259.499240060795;6266.216722909637;4685.1800934836265;4798.304245884345;4806.9038619227595;4820.301056346828;4850.636202284834;4792.113459010076;4806.83176088837;4812.278158276252;4814.229723244282;4828.396450443694;4775.570198682118;4786.401699787527;4787.425508938933;4791.425028996526;4810.158222311099;4800.1119792838435;4812.181929072066;4813.49458306878;4816.349792777965;4820.68665536739;4184.309588917825;4186.769727664977;4189.287821070426;4195.811188496495;4212;5909.4090590941;5916.467517923407;5924.229850119457;5932.911006334908;5940.34656187819;5436.456354364572;5592.105263157916;5602.803901863415;5603;5606.6636001839615;6655.168103987002;6665.900011499832;6680.866382672368;6682.766103186365;6683.866322673519;4587.931181032287;4591.79336929839;4591.977040114812;4607;4617.145828021793;6864.450843932474;6871.828204294932;6883.105196324495;6932.826679333007;6950.235474097845;4642.65180111493;4713.505081966413;4718.575328220477;4728.31439441286;4729.881752956204;4664.976675116603;4742.668013239109;4750.097481478508;4755.286706993978;4766.189747742892;5494.423085576037;5504;5526.58550608706;5528.622692242375;5542.5565954723525;6734.393904548614;6739.157605299338;6742.056112144303;6743.932560674429;6748.426383757435;1672.2976349933058;1696.9066701331544;1699.2778069320489;1699.566610514311;1700.923458444373;1081.5781845080426;1106.8395082713123;1114.5820317380983;1117.1788735279563;1123.7640095579857;6553.868922621521;6568.8357791055605;6586.407223349922;6586.571872828346;6596.175478065242;6936.34104760047;6940.444764418834;6952.687129079203;6954.4436445084275;6960.686769095403;6478.157839480931;6558.770443034471;6583.473322134314;6634.635095069818;6646.534742567974;3753.3994560870674;3762.4168253920684;3783.6783873370523;3796.8291426885858;3799.3920972644246;7222.602756848424;7280.235575264627;7281.890771638429;7313.2321106284135;7313.89029164563;7112.395446387011;7136.3220494052985;7157.57054576727;7165.749198778018;7165.928340716526;6977.720891164398;7258.927410725825;7288.453365997571;7316.853662926818;7318.451116166309;6957.547759395623;6960.060391847238;6992.930070699228;6993.776089184271;6999.405050570758;6805.557638753465;6817.795466136024;6834.692438840165;6870.587764734132;6874.450043996369;7222.422206223595;7316.561006339637;7321.9383189438295;7324.340809327186;7333.046703928455;4560.156371071363;4566.771661416849;4754.191787396082;4754.572088512051;4755.048990201904;6886.724531018904;6910.930890691029;6927.3419025192525;6971.233164352018;6988.336108069725;6706.597604143767;6708.19501659804;6727.428168605527;6746.392824645805;6746.730130794714;6618.536702430783;6676.298988606127;6681.398674119353;6687;6716.3955244028275;6447.4197322241225;6547.148870646785;6600.867982640224;6601.405873471411;6638.037484564615;6664.100346453167;6689.799306020827;6699.464042876461;6718.563293385914;6757.831054223684;6593.208814942238;6609.438197753245;6610.239822420291;6616.536842420985;6618.305077966744 17:00:58 INFO - PROCESS | 3441 | |5;yui.html;773.79494433975;775.2170307988937;805.243071512778;879.1252703559957;891.2736120062149;14315.141091534502;14453.421863125463;14478.710425791478;14503.854961450383;14550.854491455082;14024.228667423287;14043.578692639212;14056.578302650936;14066.929665351685;14069.71860562788;902.7066203483878;905.0587389115312;930.4696323095839;933.0110083311678;934.4299977014016;917.0645941140033;922.5710044829153;923.7321176858703;925.2505470568827;925.296774451415;970.034815358719;973.630020592174;973.9366941148838;977.779999500114;982.1847866271014;958.7603099225194;963.9180669643089;966.840471322231;966.8646389505475;970.3353203055894;717.4153065251803;719.3957076056085;720.1610124205295;720.7657511308793;721.7726416178887;13311.201327920258;13357.332133393389;13362.933185334108;13754.105983111065;13795.724085518234;12092.939535302356;12185.573504927284;12256.38718064102;12330.19853709515;12589.055820813384;10447.111995480393;10465.895341046567;10516.211284153642;10580.576776928914;10647.201459890539;3600.135967367839;3627.165751877083;3646.8176591170336;3687.59436461989;3740.532433445819;53462.465375345746;54026.45973540254;54045.72977135128;54327.72836135794;54466.72766636142;9581.377210481296;9840.16358609512;9854.50727463624;9892.703218903445;9934.80130397388;17047;17168.570785730208;17236.396726114777;17248.913755431142;18017.099145042695;7035.788926332219;7061.082059332254;7165.247648996885;7345;7373.525294941033;4310.267254566731;4368.8907777305185;4407.845725399659;4484.932726009112;4526;3021.9244518886762;3047.4057558775826;3053.129857990462;3054.2059064643354;3058.067289476731;545.1060261171682;562.8508445262008;583.0176153181902;583.5185971573469;584.2959234122872;657.9439252336449;670.5105273150627;681.8738533371342;682.7610336382227;692.8718187135396;7079.858402831915;7220.4584656151;7261.455390845602;7264.34620884123;7276.417886569062;561.7612514681244;573.899567575681;622.3745136138152;645.0710976194359;646.3536463536464;3408.1479630092476;3430.1939044324563;3467.2025434150287;3505.8948231553095;3575.106223444139;57550.7122464385;58076.70961645249;61460.078098828555;61572;61611.383886161464;51393;51491.74254128705;52292;53466.73266633642;53630;47899.281510777364;48505.999999999294;48570.27144592834;48619;49290.26064609034;7579.772606821804;7813.257740514642;7875.921240787518;8035.156308587514;8205.548694821842;36782.080447989014;37010.25979480449;37019.814900925325;38091.047723807125;38257.80871095627;46327.30509042434;47125.29312060253;47484;47803;48668.756656216494;9931.801363972536;10111.898881011095;10434.37393756377;10440.791184176425;10620.787584248117;11164.720881978015;11349.375784331942;11362.772744544898;11508.769824603629;11513.30920144794;9653.9034609653;10055.346402484107;10311.793764124826;10319.896801032193;10512.42181680015;10900.073493752803;10932.508037138507;10957.616483423042;11071;11159.051480624237;10015.949920250352;10119.7470063249;10160.745981350525;10224.53989570486;10376.066154046172;8546.914530854861;8709.825803483767;8736.519491428033;8835.779105522413;9061.365704400629;8823.514706690938;8863.379563430499;9215.216706580015;9237.769055773659;9276.489793061446 17:00:58 INFO - PROCESS | 3441 | __end_tp_report 17:00:58 INFO - PROCESS | 3441 | __start_cc_report 17:00:58 INFO - PROCESS | 3441 | _x_x_mozilla_cycle_collect,351 17:00:58 INFO - PROCESS | 3441 | __end_cc_report 17:00:58 INFO - PROCESS | 3441 | __startTimestamp1460678458744__endTimestamp 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | ------- Summary: start ------- 17:00:58 INFO - PROCESS | 3441 | Number of tests: 6 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | [#0] dojo.html Cycles:165 Average:5387.29 Median:5596.69 stddev:577.92 (10.3%) stddev-sans-first:555.94 17:00:58 INFO - PROCESS | 3441 | Values: 3297.0 3333.3 3354.0 3358.7 3384.0 5359.6 5370.1 5380.9 5401.6 5404.4 5357.0 5366.5 5368.8 5394.5 5455.9 4933.0 4983.8 5021.2 5033.7 5063.3 4889.4 4952.2 5014.9 5015.3 5043.2 4975.9 5024.3 5025.1 5035.5 5037.8 4888.8 5018.4 5030.1 5042.3 5063.0 4815.0 4870.9 4886.7 4895.8 4929.7 5114.3 5148.9 5152.5 5169.3 5193.3 5596.7 5715.3 5734.8 5771.7 5785.8 5770.0 5784.3 5797.1 5828.8 5840.7 5441.3 5467.0 5474.7 5478.8 5481.5 5826.5 5861.2 5921.6 5923.8 5925.3 5655.1 5664.5 5673.5 5678.3 5708.4 5745.4 5747.7 5751.6 5753.7 5770.7 5651.6 5719.7 5736.5 5759.9 5822.2 5748.9 5767.4 5798.4 5802.5 5804.1 4397.6 4437.7 4453.0 4473.7 4475.8 3862.5 3983.0 3984.3 4024.1 4076.0 5408.1 5495.6 5557.0 5573.2 5607.2 5842.7 5863.4 5866.8 5868.2 5868.3 5511.1 5518.2 5598.6 5614.5 5629.1 4984.7 4989.3 4991.1 5029.3 5048.1 6049.8 6050.5 6055.9 6056.4 6085.1 5618.8 5693.3 5768.1 5770.2 5776.0 5976.7 5988.3 5999.8 6044.4 6064.2 5636.5 5739.3 5756.7 5759.1 5760.3 5783.5 5794.2 5821.0 5843.3 5858.0 5574.2 5608.9 5640.4 5644.1 5651.0 5513.9 5585.1 5609.8 5649.7 5661.3 5556.8 5587.4 5588.6 5589.2 5622.6 5659.9 5669.4 5704.4 5716.1 5716.3 5420.9 5457.4 5468.2 5580.4 5604.1 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | [#1] ext.html Cycles:180 Average:54863.49 Median:20681.51 stddev:122458.03 (592.1%) stddev-sans-first:122733.57 17:00:58 INFO - PROCESS | 3441 | Values: 512.8 536.2 543.0 596.6 627.7 36817.0 37457.3 37584.6 37599.8 37651.0 38624.2 39363.6 39394.2 39463.2 39497.4 8394.8 8577.4 8639.7 8659.4 8700.7 8595.3 8944.1 8951.6 8981.5 9000.7 8909.8 8949.8 8989.0 9027.7 9053.0 8836.3 8955.0 8973.0 8985.1 9011.1 8740.8 8901.2 8912.6 8924.1 8934.7 33456.5 38218.0 38772.8 38820.2 38840.8 3282.8 3344.7 3419.3 3431.0 3763.2 25518.1 25596.2 26082.7 26291.3 26649.6 4005.8 4094.4 4119.9 4134.7 4159.0 256218.0 256274.0 256391.0 256479.0 257085.0 37187.3 37667.1 37773.0 46619.8 47173.8 35997.0 36370.0 36398.8 36426.1 36474.3 15198.5 15279.5 15319.4 15332.7 15365.5 13199.1 13234.9 13244.1 13251.6 13252.3 14634.0 14976.0 14990.3 15152.2 15252.0 5923.7 6070.1 6096.4 6099.6 6107.6 1020.5 1081.0 1084.3 1104.9 1149.7 29211.4 29505.4 29525.0 30475.4 30518.8 1107.2 1120.6 1123.4 1126.6 1177.2 15204.2 15469.2 15694.5 15703.5 15817.7 328337.0 620258.0 770299.0 778273.0 780162.0 60534.7 61240.7 61268.1 61283.4 61360.4 1330.7 1351.0 1375.7 1413.6 1450.2 27286.2 27371.2 27429.7 27532.2 28046.7 43185.4 43464.6 43581.6 43655.6 44983.3 303211.0 303316.0 304822.0 306506.0 307087.0 33270.0 34046.8 34663.0 34788.3 34797.0 44797.0 45643.1 46074.8 46131.3 46368.3 38590.4 38752.2 38963.6 39205.2 39366.2 38173.8 38587.8 38936.2 39168.2 39396.4 37797.4 38201.6 38422.6 39032.4 39063.6 32808.6 33894.5 34072.0 34084.1 34115.0 25945.6 26464.0 26544.7 26567.7 26726.0 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | [#2] jquery.html Cycles:180 Average:25669.37 Median:2272.07 stddev:70231.96 (3091.1%) stddev-sans-first:70403.27 17:00:58 INFO - PROCESS | 3441 | Values: 357.2 366.7 370.1 376.9 379.5 17456.7 17635.9 18154.4 18277.5 18328.1 15124.1 15874.6 15991.2 16097.6 16109.2 5315.3 5330.4 5336.0 5350.1 5435.7 5477.3 5494.0 5504.4 5506.6 5513.6 5218.2 5413.1 5434.3 5437.2 5452.9 5457.0 5469.7 5516.4 5524.3 5547.0 5493.3 5537.6 5548.1 5550.7 5557.3 13380.8 13539.5 16047.9 21681.9 21948.6 2240.5 2303.7 2311.8 2349.4 2542.5 9157.9 11532.9 12776.0 12782.7 12846.6 1762.8 1783.7 1791.8 1798.2 1830.4 65385.0 66687.7 67840.0 68151.0 68953.0 10041.0 10043.7 10155.7 10238.2 10309.6 13753.2 13789.7 13791.5 13812.9 13842.1 7643.2 8057.4 8111.1 8133.1 8188.1 7623.5 7671.8 7811.6 7874.9 8018.8 4358.3 4498.4 4533.4 4551.5 4662.0 1836.1 1879.4 1931.7 1936.2 1964.1 930.3 968.0 1009.5 1067.2 1067.7 17393.6 17590.5 17615.8 17679.6 18135.8 999.4 1029.0 1030.0 1047.4 1052.5 9811.6 10124.3 10153.0 10178.5 10248.3 416607.0 424084.0 427537.0 432952.0 434807.0 71510.0 74623.6 78430.6 79792.2 81846.0 1049.5 1063.8 1068.2 1068.9 1091.9 15996.4 16185.4 16311.5 16421.4 16568.2 36058.6 36729.3 36985.3 37112.4 37838.8 51198.0 52547.0 52557.0 52728.5 52939.0 8179.5 8220.6 8451.8 8466.6 8490.7 11633.8 12515.4 12645.6 13215.5 13265.5 10844.6 11005.4 11085.2 11214.4 11530.0 10990.2 11043.5 11103.3 11188.8 11270.4 11187.4 11237.6 11268.8 11388.0 11452.9 8348.6 8360.8 8370.7 8443.8 8723.9 11236.6 11730.4 11768.6 11819.3 12138.6 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | [#3] mootools.html Cycles:180 Average:5774.84 Median:5144.60 stddev:2992.24 (58.2%) stddev-sans-first:2983.57 17:00:58 INFO - PROCESS | 3441 | Values: 1523.3 1603.9 1860.6 1940.3 1967.2 7261.6 7446.1 7954.6 8091.4 8183.1 7675.7 7935.7 7954.8 8172.9 8251.6 2374.2 2409.4 2425.2 2425.8 2427.0 2454.5 2457.8 2467.9 2481.5 2488.8 2414.2 2428.3 2431.3 2432.5 2445.7 2381.7 2394.3 2402.3 2408.7 2431.6 2428.8 2440.8 2458.6 2463.5 2472.1 8340.4 8346.0 8347.2 8353.3 8438.1 5023.9 5102.6 5127.5 5157.3 5162.6 3201.2 3239.8 3293.8 3324.6 3336.2 1017.3 2062.4 2075.7 2082.4 2084.0 11167.2 11253.6 11290.8 11331.6 11346.3 4226.6 4339.8 4384.5 4404.3 4415.7 9099.2 9108.5 9119.0 9163.5 9212.0 5076.2 5115.3 5128.9 5129.5 5131.9 4527.8 4585.0 4614.7 4663.4 4721.9 3568.5 3605.9 3650.4 3650.5 3668.5 1058.4 1068.6 1073.9 1074.5 1082.4 1186.5 1188.1 1223.9 1228.7 1246.7 7783.8 7825.1 7855.2 7897.8 7928.1 506.8 511.2 511.3 513.7 524.2 6169.1 6233.1 6239.4 6294.4 6297.9 9904.9 10148.1 10173.7 10249.6 10332.0 10079.7 10268.2 10293.2 10407.3 10412.9 7961.3 8047.5 8071.2 8092.4 8159.5 7497.0 7680.5 7874.1 7932.1 7944.6 8794.0 8898.1 9007.0 9021.1 9056.5 9054.1 9203.5 9210.6 9303.8 9413.7 6483.5 6911.2 7195.6 7201.0 7216.4 7856.3 7863.8 7873.6 7901.2 7944.6 6828.4 6959.0 7077.2 7088.3 7209.0 6855.7 6870.0 6969.0 6996.3 7092.1 7449.4 7496.9 7665.8 7671.5 7685.7 6888.4 6933.7 6954.5 6955.2 6960.6 6540.7 6548.8 6604.9 6609.7 6612.0 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | [#4] prototype.html Cycles:180 Average:5613.15 Median:6462.79 stddev:1711.24 (26.5%) stddev-sans-first:1669.80 17:00:58 INFO - PROCESS | 3441 | Values: 348.6 351.6 353.3 353.8 354.0 6256.2 6311.7 6325.6 6350.3 6352.4 6245.8 6250.7 6258.1 6259.5 6266.2 4685.2 4798.3 4806.9 4820.3 4850.6 4792.1 4806.8 4812.3 4814.2 4828.4 4775.6 4786.4 4787.4 4791.4 4810.2 4800.1 4812.2 4813.5 4816.3 4820.7 4184.3 4186.8 4189.3 4195.8 4212.0 5909.4 5916.5 5924.2 5932.9 5940.3 5436.5 5592.1 5602.8 5603.0 5606.7 6655.2 6665.9 6680.9 6682.8 6683.9 4587.9 4591.8 4592.0 4607.0 4617.1 6864.5 6871.8 6883.1 6932.8 6950.2 4642.7 4713.5 4718.6 4728.3 4729.9 4665.0 4742.7 4750.1 4755.3 4766.2 5494.4 5504.0 5526.6 5528.6 5542.6 6734.4 6739.2 6742.1 6743.9 6748.4 1672.3 1696.9 1699.3 1699.6 1700.9 1081.6 1106.8 1114.6 1117.2 1123.8 6553.9 6568.8 6586.4 6586.6 6596.2 6936.3 6940.4 6952.7 6954.4 6960.7 6478.2 6558.8 6583.5 6634.6 6646.5 3753.4 3762.4 3783.7 3796.8 3799.4 7222.6 7280.2 7281.9 7313.2 7313.9 7112.4 7136.3 7157.6 7165.7 7165.9 6977.7 7258.9 7288.5 7316.9 7318.5 6957.5 6960.1 6992.9 6993.8 6999.4 6805.6 6817.8 6834.7 6870.6 6874.5 7222.4 7316.6 7321.9 7324.3 7333.0 4560.2 4566.8 4754.2 4754.6 4755.0 6886.7 6910.9 6927.3 6971.2 6988.3 6706.6 6708.2 6727.4 6746.4 6746.7 6618.5 6676.3 6681.4 6687.0 6716.4 6447.4 6547.1 6600.9 6601.4 6638.0 6664.1 6689.8 6699.5 6718.6 6757.8 6593.2 6609.4 6610.2 6616.5 6618.3 17:00:58 INFO - PROCESS | 3441 | 17:00:58 INFO - PROCESS | 3441 | [#5] yui.html Cycles:180 Average:14085.98 Median:52877.23 stddev:17009.90 (32.2%) stddev-sans-first:17028.24 17:00:58 INFO - PROCESS | 3441 | Values: 773.8 775.2 805.2 879.1 891.3 14315.1 14453.4 14478.7 14503.9 14550.9 14024.2 14043.6 14056.6 14066.9 14069.7 902.7 905.1 930.5 933.0 934.4 917.1 922.6 923.7 925.3 925.3 970.0 973.6 973.9 977.8 982.2 958.8 963.9 966.8 966.9 970.3 717.4 719.4 720.2 720.8 721.8 13311.2 13357.3 13362.9 13754.1 13795.7 12092.9 12185.6 12256.4 12330.2 12589.1 10447.1 10465.9 10516.2 10580.6 10647.2 3600.1 3627.2 3646.8 3687.6 3740.5 53462.5 54026.5 54045.7 54327.7 54466.7 9581.4 9840.2 9854.5 9892.7 9934.8 17047.0 17168.6 17236.4 17248.9 18017.1 7035.8 7061.1 7165.2 7345.0 7373.5 4310.3 4368.9 4407.8 4484.9 4526.0 3021.9 3047.4 3053.1 3054.2 3058.1 545.1 562.9 583.0 583.5 584.3 657.9 670.5 681.9 682.8 692.9 7079.9 7220.5 7261.5 7264.3 7276.4 561.8 573.9 622.4 645.1 646.4 3408.1 3430.2 3467.2 3505.9 3575.1 57550.7 58076.7 61460.1 61572.0 61611.4 51393.0 51491.7 52292.0 53466.7 53630.0 47899.3 48506.0 48570.3 48619.0 49290.3 7579.8 7813.3 7875.9 8035.2 8205.5 36782.1 37010.3 37019.8 38091.0 38257.8 46327.3 47125.3 47484.0 47803.0 48668.8 9931.8 10111.9 10434.4 10440.8 10620.8 11164.7 11349.4 11362.8 11508.8 11513.3 9653.9 10055.3 10311.8 10319.9 10512.4 10900.1 10932.5 10957.6 11071.0 11159.1 10015.9 10119.7 10160.7 10224.5 10376.1 8546.9 8709.8 8736.5 8835.8 9061.4 8823.5 8863.4 9215.2 9237.8 9276.5 17:00:58 INFO - PROCESS | 3441 | -------- Summary: end -------- 17:00:58 INFO - PROCESS | 3441 | 17:00:59 INFO - TEST-INFO | 3441: exit 0 17:00:59 INFO - TEST-OK | dromaeo_css | took 1109607ms 17:00:59 INFO - TEST-START | kraken 17:00:59 INFO - operating with platform_type : linux_ 17:00:59 INFO - Initialising browser for kraken test... 17:00:59 INFO - TEST-INFO | started process 3684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8QET3C/profile http://localhost:58694/getInfo.html) 17:01:02 INFO - PROCESS | 3684 | 17:01:02 INFO - PROCESS | 3684 | (process:3759): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:03 INFO - PROCESS | 3684 | __metrics Screen width/height:1600/1200 17:01:03 INFO - PROCESS | 3684 | colorDepth:24 17:01:03 INFO - PROCESS | 3684 | Browser inner width/height: 1024/697 17:01:03 INFO - PROCESS | 3684 | __metrics 17:01:04 ERROR - PROCESS | 3684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:01:05 INFO - TEST-INFO | 3684: exit 0 17:01:05 INFO - Browser initialized. 17:01:05 INFO - Running cycle 1/1 for kraken test... 17:01:05 INFO - TEST-INFO | started process 3810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8QET3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:07 INFO - PROCESS | 3810 | 17:01:07 INFO - PROCESS | 3810 | (process:3879): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:17 INFO - PROCESS | 3810 | RSS: Main: 150929408 17:01:17 INFO - PROCESS | 3810 | 17:01:19 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-beat-detection) 17:01:20 INFO - PROCESS | 3810 | RSS: Main: 155123712 17:01:20 INFO - PROCESS | 3810 | 17:01:22 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-dft) 17:01:23 INFO - PROCESS | 3810 | RSS: Main: 156229632 17:01:23 INFO - PROCESS | 3810 | 17:01:26 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-fft) 17:01:26 INFO - PROCESS | 3810 | RSS: Main: 155852800 17:01:26 INFO - PROCESS | 3810 | 17:01:29 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-oscillator) 17:01:29 INFO - PROCESS | 3810 | RSS: Main: 155664384 17:01:29 INFO - PROCESS | 3810 | 17:01:31 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:01:32 INFO - PROCESS | 3810 | RSS: Main: 155590656 17:01:32 INFO - PROCESS | 3810 | 17:01:35 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58694/tests/kraken/driver.html?testName=imaging-darkroom) 17:01:36 INFO - PROCESS | 3810 | RSS: Main: 156491776 17:01:36 INFO - PROCESS | 3810 | 17:01:39 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58694/tests/kraken/driver.html?testName=imaging-desaturate) 17:01:40 INFO - PROCESS | 3810 | RSS: Main: 156692480 17:01:40 INFO - PROCESS | 3810 | 17:01:43 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58694/tests/kraken/driver.html?testName=json-parse-financial) 17:01:43 INFO - PROCESS | 3810 | RSS: Main: 156676096 17:01:44 INFO - PROCESS | 3810 | 17:01:45 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:01:45 INFO - PROCESS | 3810 | RSS: Main: 156565504 17:01:45 INFO - PROCESS | 3810 | 17:01:47 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:01:48 INFO - PROCESS | 3810 | RSS: Main: 156454912 17:01:48 INFO - PROCESS | 3810 | 17:01:50 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:01:51 INFO - PROCESS | 3810 | RSS: Main: 156520448 17:01:51 INFO - PROCESS | 3810 | 17:01:53 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:01:54 INFO - PROCESS | 3810 | RSS: Main: 156655616 17:01:54 INFO - PROCESS | 3810 | 17:01:56 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:01:57 INFO - PROCESS | 3810 | RSS: Main: 156528640 17:01:57 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58694/tests/kraken/driver.html?testName=ai-astar) 17:01:59 INFO - PROCESS | 3810 | RSS: Main: 158384128 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | __start_tp_report 17:01:59 INFO - PROCESS | 3810 | _x_x_mozilla_page_load 17:01:59 INFO - PROCESS | 3810 | _x_x_mozilla_page_load_details 17:01:59 INFO - PROCESS | 3810 | |i|pagename|runs| 17:01:59 INFO - PROCESS | 3810 | |0;ai-astar;110;105;111;110;111;124;110;109;111;111 17:01:59 INFO - PROCESS | 3810 | |1;audio-beat-detection;163;127;158;173;129;160;157;136;171;128 17:01:59 INFO - PROCESS | 3810 | |2;audio-dft;160;163;166;161;164;163;164;162;164;162 17:01:59 INFO - PROCESS | 3810 | |3;audio-fft;74;74;76;170;76;76;77;77;182;78 17:01:59 INFO - PROCESS | 3810 | |4;audio-oscillator;93;94;147;93;93;92;143;95;95;144 17:01:59 INFO - PROCESS | 3810 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;118;118 17:01:59 INFO - PROCESS | 3810 | |6;imaging-darkroom;147;146;146;147;146;146;147;146;147;146 17:01:59 INFO - PROCESS | 3810 | |7;imaging-desaturate;97;101;96;97;96;97;96;96;96;96 17:01:59 INFO - PROCESS | 3810 | |8;json-parse-financial;56;55;55;56;54;54;58;61;53;58 17:01:59 INFO - PROCESS | 3810 | |9;json-stringify-tinderbox;71;64;64;64;64;68;65;64;64;64 17:01:59 INFO - PROCESS | 3810 | |10;stanford-crypto-aes;79;80;82;80;81;79;77;79;80;80 17:01:59 INFO - PROCESS | 3810 | |11;stanford-crypto-ccm;121;121;115;123;120;114;120;111;114;115 17:01:59 INFO - PROCESS | 3810 | |12;stanford-crypto-pbkdf2;148;141;150;149;136;150;148;153;147;138 17:01:59 INFO - PROCESS | 3810 | |13;stanford-crypto-sha256-iterative;68;68;68;72;70;70;70;71;67;68 17:01:59 INFO - PROCESS | 3810 | __end_tp_report 17:01:59 INFO - PROCESS | 3810 | __start_cc_report 17:01:59 INFO - PROCESS | 3810 | _x_x_mozilla_cycle_collect,850 17:01:59 INFO - PROCESS | 3810 | __end_cc_report 17:01:59 INFO - PROCESS | 3810 | __startTimestamp1460678519300__endTimestamp 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | ------- Summary: start ------- 17:01:59 INFO - PROCESS | 3810 | Number of tests: 14 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.85 (4.4%) stddev-sans-first:5.12 17:01:59 INFO - PROCESS | 3810 | Values: 110.0 105.0 111.0 110.0 111.0 124.0 110.0 109.0 111.0 111.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:159.00 stddev:18.26 (11.5%) stddev-sans-first:18.77 17:01:59 INFO - PROCESS | 3810 | Values: 163.0 127.0 158.0 173.0 129.0 160.0 157.0 136.0 171.0 128.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:1.73 (1.1%) stddev-sans-first:1.48 17:01:59 INFO - PROCESS | 3810 | Values: 160.0 163.0 166.0 161.0 164.0 163.0 164.0 162.0 164.0 162.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:42.28 (55.6%) stddev-sans-first:44.09 17:01:59 INFO - PROCESS | 3810 | Values: 74.0 74.0 76.0 170.0 76.0 76.0 77.0 77.0 182.0 78.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:24.72 (26.6%) stddev-sans-first:25.54 17:01:59 INFO - PROCESS | 3810 | Values: 93.0 94.0 147.0 93.0 93.0 92.0 143.0 95.0 95.0 144.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:01:59 INFO - PROCESS | 3810 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:01:59 INFO - PROCESS | 3810 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:1.64 17:01:59 INFO - PROCESS | 3810 | Values: 97.0 101.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.40 (4.3%) stddev-sans-first:2.55 17:01:59 INFO - PROCESS | 3810 | Values: 56.0 55.0 55.0 56.0 54.0 54.0 58.0 61.0 53.0 58.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:64.00 stddev:2.39 (3.7%) stddev-sans-first:1.33 17:01:59 INFO - PROCESS | 3810 | Values: 71.0 64.0 64.0 64.0 64.0 68.0 65.0 64.0 64.0 64.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:1.34 (1.7%) stddev-sans-first:1.39 17:01:59 INFO - PROCESS | 3810 | Values: 79.0 80.0 82.0 80.0 81.0 79.0 77.0 79.0 80.0 80.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:120.00 stddev:4.03 (3.4%) stddev-sans-first:4.06 17:01:59 INFO - PROCESS | 3810 | Values: 121.0 121.0 115.0 123.0 120.0 114.0 120.0 111.0 114.0 115.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.50 stddev:5.66 (3.8%) stddev-sans-first:5.95 17:01:59 INFO - PROCESS | 3810 | Values: 148.0 141.0 150.0 149.0 136.0 150.0 148.0 153.0 147.0 138.0 17:01:59 INFO - PROCESS | 3810 | 17:01:59 INFO - PROCESS | 3810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:70.00 stddev:1.62 (2.3%) stddev-sans-first:1.66 17:01:59 INFO - PROCESS | 3810 | Values: 68.0 68.0 68.0 72.0 70.0 70.0 70.0 71.0 67.0 68.0 17:01:59 INFO - PROCESS | 3810 | -------- Summary: end -------- 17:01:59 INFO - PROCESS | 3810 | 17:02:00 INFO - TEST-INFO | 3810: exit 0 17:02:00 INFO - TEST-OK | kraken | took 60795ms 17:02:00 INFO - SUITE-END | took 1170s 17:02:00 INFO - Completed test suite (00:19:30) 17:02:00 INFO - javascript benchmark 17:02:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3297.0438572813887, 3333.316670082633, 3353.9832300838493, 3358.66413358664, 3383.95097519769, 5359.624826262163, 5370.087085195516, 5380.91928621071, 5401.56787457003, 5404.405515393309, 5356.9732151339285, 5366.543843773275, 5368.785248590061, 5394.460553944604, 5455.890882182354, 4933.013397320541, 4983.750812459362, 5021.246812978046, 5033.697978121324, 5063.341765570489, 4889.437714662824, 4952.182889823175, 5014.924776128361, 5015.272785446108, 5043.218301163325, 4975.9004819903585, 5024.271480635306, 5025.070361983045, 5035.521625445577, 5037.798488060474, 4888.780004899788, 5018.422881368653, 5030.069437154101, 5042.268871013719, 5063.0380227756605, 4815.036992601459, 4870.9269360959615, 4886.657933944625, 4895.804167833282, 4929.704217746947, 5114.335136432277, 5148.922766158473, 5152.458991805881, 5169.302144210521, 5193.298904647862, 5596.692181929992, 5715.2855893013375, 5734.799282025151, 5771.682557459338, 5785.82642520725, 5770.04794208955, 5784.2769653793275, 5797.130430435426, 5828.766849326022, 5840.737166827503, 5441.2654291670515, 5467.0, 5474.698891560963, 5478.753456094485, 5481.451854814526, 5826.475617194473, 5861.150133230658, 5921.644701317935, 5923.822285331447, 5925.259342582177, 5655.123455864347, 5664.461876121762, 5673.517750991129, 5678.261825962599, 5708.429157084258, 5745.368009518949, 5747.655140691572, 5751.626144300607, 5753.654780713171, 5770.711464426762, 5651.632643878134, 5719.7426115824055, 5736.5123964462655, 5759.913601295984, 5822.214001109796, 5748.856278593069, 5767.394423585547, 5798.391168927286, 5802.535797136219, 5804.1293805929445, 4397.648188144941, 4437.733735975852, 4453.0, 4473.664475164375, 4475.753833539186, 3862.517185351831, 3983.0440694233175, 3984.322665146932, 4024.054347228399, 4076.0421300994244, 5408.134698448308, 5495.560355171577, 5556.972215138899, 5573.219749235111, 5607.214989901417, 5842.737076831553, 5863.442972917566, 5866.794662186803, 5868.207791948118, 5868.2664666916635, 5511.118221084607, 5518.227448157261, 5598.58010649203, 5614.466625670555, 5629.127485239795, 4984.651074424828, 4989.3264409305, 4991.051700176955, 5029.346184995927, 5048.0913435581215, 6049.758009679652, 6050.45545900871, 6055.909161362583, 6056.424639659225, 6085.056816193497, 5618.803341882933, 5693.345265294544, 5768.077107662753, 5770.192173095686, 5776.0, 5976.731047102978, 5988.311344195473, 5999.790007349722, 6044.425779550936, 6064.211652485325, 5636.549076073986, 5739.253896993364, 5756.683382414008, 5759.136129580596, 5760.33756118035, 5783.479486846204, 5794.159846822103, 5820.952228598893, 5843.2695913010875, 5857.970710146422, 5574.219609254788, 5608.915866262091, 5640.435956404327, 5644.125160600113, 5651.039323314964, 5513.944860551504, 5585.078462053716, 5609.80365687199, 5649.745761440663, 5661.264035675335, 5556.833295001156, 5587.44125587438, 5588.580856435702, 5589.245451863946, 5622.578306626938, 5659.943400565941, 5669.4047125051275, 5704.429557044263, 5716.142578613075, 5716.256886604881, 5420.918686219631, 5457.372402173801, 5468.2344471773185, 5580.414056524007, 5604.075327570905], "unit": "score", "name": "dojo.html", "value": 5351.329606153885}, {"lowerIsBetter": false, "replicates": [512.7538781384933, 536.2413750557596, 542.991855122173, 596.5645079092262, 627.6736097229441, 36817.0, 37457.250854982885, 37584.62415375846, 37599.81200094002, 37651.0, 38624.227515449675, 39363.60636393635, 39394.21211575774, 39463.210735785266, 39497.40753888694, 8394.79013024673, 8577.39958202926, 8639.740807775777, 8659.35054870884, 8700.738977830675, 8595.269402100828, 8944.060873608276, 8951.641934322652, 8981.506017169053, 9000.684976025841, 8909.777255568597, 8949.821003579924, 8989.0, 9027.729168124966, 9052.954735226347, 8836.293096552261, 8954.955225223897, 8972.955135224314, 8985.146411090936, 9011.098890111001, 8740.825183496358, 8901.154390332907, 8912.598933048028, 8924.062973387765, 8934.73195804127, 33456.49815252773, 38218.0, 38772.80613596914, 38820.22359552793, 38840.80579597112, 3282.770206085575, 3344.7491438142238, 3419.281950790337, 3430.9828450857585, 3763.209725957552, 25518.10686625978, 25596.23211303664, 26082.73917260822, 26291.34271643205, 26649.600255996174, 4005.7997100144876, 4094.4267802507675, 4119.938200926988, 4134.669226461876, 4158.979205103986, 256218.0, 256274.0, 256391.0, 256478.99999999814, 257085.0, 37187.25625487475, 37667.05832354158, 37773.0, 46619.766901165276, 47173.76413117912, 35997.0, 36370.0, 36398.8180059098, 36426.089347766516, 36474.27051458956, 15198.46805361807, 15279.541613751606, 15319.387224511118, 15332.693346133015, 15365.539033829004, 13199.076064675573, 13234.867651323557, 13244.072914895865, 13251.602451926457, 13252.337383130805, 14634.0, 14976.0, 14990.250487475801, 15152.16663083541, 15252.0, 5923.674197919069, 6070.119832624245, 6096.420840020191, 6099.603525770811, 6107.633541987495, 1020.4795554267378, 1081.0162751895737, 1084.3006260961636, 1104.8839871813504, 1149.655103468956, 29211.415771684446, 29505.409891802472, 29525.0, 30475.390492190032, 30518.84740576283, 1107.1585594947737, 1120.5797825815318, 1123.4102096399456, 1126.645106791358, 1177.2230327983489, 15204.163770992702, 15469.226538673021, 15694.450694225647, 15703.528894133195, 15817.68364632724, 328337.0, 620258.0, 770299.0, 778273.0, 780162.0, 60534.69732651309, 61240.693796531625, 61268.08097878535, 61283.38716612866, 61360.38639613636, 1330.6540299522194, 1350.9662258443618, 1375.6698392385756, 1413.611256904339, 1450.173401161349, 27286.181414557595, 27371.198168151408, 27429.725702743515, 27532.17403477899, 28046.719532805226, 43185.3522197161, 43464.565354347316, 43581.564184357754, 43655.56344436515, 44983.32525012062, 303211.0, 303316.0, 304822.0, 306506.0, 307087.0, 33270.0, 34046.82976585101, 34663.0, 34788.30423391569, 34797.0, 44797.0, 45643.087138256386, 46074.769626151654, 46131.30803038024, 46368.30447543357, 38590.42114368343, 38752.22495550017, 38963.61036389713, 39205.2158956825, 39366.212675746894, 38173.80913095417, 38587.807060964515, 38936.2212755749, 39168.216635666555, 39396.409053863645, 37797.43303850389, 38201.5991089543, 38422.615773841906, 39032.41451378175, 39063.609363906, 32808.586762075705, 33894.491582625786, 34072.0, 34084.14789630279, 34115.0, 25945.6108158374, 26464.0, 26544.734552654227, 26567.734322656524, 26726.0], "unit": "score", "name": "ext.html", "value": 18512.930575510432}, {"lowerIsBetter": false, "replicates": [357.2230398882432, 366.7414472796678, 370.09696340928133, 376.8963535027867, 379.5445465441467, 17456.650866982654, 17635.911820440895, 18154.3645972391, 18277.543061423472, 18328.083595820222, 15124.09255444674, 15874.603134921632, 15991.200439978013, 16097.597560061004, 16109.194540272998, 5315.335583052119, 5330.3603567571945, 5335.986162629108, 5350.117230656956, 5435.728213589315, 5477.287952566161, 5494.038543254935, 5504.366997795265, 5506.64206826557, 5513.61404701671, 5218.2172674099, 5413.133898576229, 5434.347878254615, 5437.184422336642, 5452.863678408032, 5456.972715136399, 5469.671819690831, 5516.365617953927, 5524.33707955044, 5547.0, 5493.258410114623, 5537.640053396516, 5548.0845660465975, 5550.666959982414, 5557.277553918006, 13380.79928801059, 13539.458421663121, 16047.919760401122, 21681.891590542105, 21948.561028779335, 2240.473488730147, 2303.659718253873, 2311.780380863815, 2349.447879748258, 2542.545022170481, 9157.862632060524, 11532.884671153264, 12776.0, 12782.744345113046, 12846.550370736979, 1762.841344279021, 1783.7235228539598, 1791.758112654788, 1798.1638538079856, 1830.359374219026, 65385.0, 66687.66656166737, 67840.0, 68151.0, 68953.0, 10041.0, 10043.748906277255, 10155.7461063474, 10238.232132590085, 10309.639162629272, 13753.174809511462, 13789.655258618413, 13791.51729689476, 13812.86187138136, 13842.100263482842, 7643.1974642662835, 8057.35541156706, 8111.107778144399, 8133.064697559738, 8188.14024527416, 7623.542587444771, 7671.77251639735, 7811.648475818602, 7874.881876771853, 8018.799530011796, 4358.280883654225, 4498.437695288089, 4533.38799262102, 4551.543506078023, 4661.95338046622, 1836.091134888239, 1879.351623689825, 1931.690929451309, 1936.1771247220156, 1964.0965156028387, 930.3441074042784, 967.9854802177973, 1009.4548943570536, 1067.2475904487317, 1067.7010437077631, 17393.565160870825, 17590.472285831445, 17615.82384176142, 17679.55801104957, 18135.818641813414, 999.4153420249236, 1028.9897101029044, 1029.9794004119876, 1047.36634336227, 1052.5105825791045, 9811.558479868423, 10124.291299608956, 10153.0, 10178.541965611565, 10248.333858299187, 416607.0, 424084.0, 427537.0, 432952.0, 434807.0, 71510.0, 74623.62688186632, 78430.6078469604, 79792.20207797848, 81846.0, 1049.5434485998614, 1063.813832579311, 1068.2415485005733, 1068.8824229334766, 1091.9454027298602, 15996.360145594512, 16185.4335098271, 16311.510654680378, 16421.42525011619, 16568.17159142062, 36058.63941360553, 36729.26541469102, 36985.260294793414, 37112.443313350865, 37838.810805945795, 51198.0, 52547.0, 52557.0, 52728.47271527389, 52939.0, 8179.509229446252, 8220.58897055133, 8451.830963380575, 8466.57667116654, 8490.702825401082, 11633.767324653629, 12515.37423128858, 12645.620631381073, 13215.537456188988, 13265.535706250621, 10844.566217351217, 11005.394703291397, 11085.170946793689, 11214.439278036229, 11530.0, 10990.186619207741, 11043.503042362952, 11103.278286911325, 11188.776224475629, 11270.436478175894, 11187.440627968406, 11237.60668376603, 11268.83096753533, 11388.0, 11452.885471145515, 8348.624311905858, 8360.832783344178, 8370.748877533684, 8443.83112337762, 8723.869141963003, 11236.550537978716, 11730.413479326171, 11768.646940591796, 11819.290842549475, 12138.575149869712], "unit": "score", "name": "jquery.html", "value": 8707.434275043559}, {"lowerIsBetter": false, "replicates": [1523.3449616664834, 1603.8556529912305, 1860.5999710062342, 1940.2627001739336, 1967.1541237267977, 7261.636918154084, 7446.069241344832, 7954.562499062549, 8091.3526917846575, 8183.099859015503, 7675.6545955432, 7935.682572697086, 7954.801129971739, 8172.91827081729, 8251.587420628975, 2374.19277445668, 2409.373562873648, 2425.2118061629953, 2425.7816796488314, 2427.017058091476, 2454.460018795871, 2457.8033757299463, 2467.938301542458, 2481.4540801023745, 2488.7635674610883, 2414.1791790791126, 2428.2715185444385, 2431.258466167818, 2432.5134973005383, 2445.730969593343, 2381.678473406094, 2394.257780088178, 2402.3393566769105, 2408.7109546854313, 2431.610942249232, 2428.84212526187, 2440.7803297703113, 2458.5697502936914, 2463.4703538739077, 2472.122396549235, 8340.416170868042, 8346.0, 8347.207015333533, 8353.289970352467, 8438.11399803018, 5023.899522009576, 5102.566281866046, 5127.5385215330425, 5157.277981082651, 5162.561182299509, 3201.2477067889026, 3239.7570182236427, 3293.835308234579, 3324.5844269466315, 3336.182635254378, 1017.282815614997, 2062.3503596367245, 2075.740532433446, 2082.437741809718, 2084.0413409831494, 11167.162462815322, 11253.60612378571, 11290.830637540443, 11331.603393881174, 11346.319220846775, 4226.640735537514, 4339.7830108494445, 4384.4519435070615, 4404.317330813729, 4415.712978656377, 9099.226565741854, 9108.544572771334, 9118.95440522793, 9163.541822908828, 9212.032736562564, 5076.18780995039, 5115.283860259567, 5128.8717782055, 5129.538341549279, 5131.923021154686, 4527.796249168729, 4585.014221942299, 4614.653900957442, 4663.417072865892, 4721.858344249678, 3568.4647302904773, 3605.9098522536624, 3650.4341827016324, 3650.525431693916, 3668.5414323209598, 1058.380847204394, 1068.647346375694, 1073.897979691928, 1074.4949873559572, 1082.437132691012, 1186.5431808753692, 1188.102982248397, 1223.877612238769, 1228.6744012836605, 1246.6945598328286, 7783.766487005286, 7825.13923468418, 7855.175206603339, 7897.763067107996, 7928.127905930343, 506.82767858927406, 511.1974200505171, 511.2842021170391, 513.7046198435914, 524.2320001198262, 6169.136320915076, 6233.096201050822, 6239.438450539473, 6294.370562943761, 6297.905531417033, 9904.851427228597, 10148.08667219939, 10173.694789156338, 10249.641262555924, 10332.0, 10079.748006299902, 10268.229882758824, 10293.228007899437, 10407.271490995709, 10412.947935260276, 7961.283484486424, 8047.476914000571, 8071.152528984607, 8092.352611791042, 8159.46963447374, 7496.962515187389, 7680.5391676499585, 7874.1338452769005, 7932.127465978622, 7944.563049032358, 8794.0, 8898.06570310134, 9006.954965225394, 9021.052789457275, 9056.54717264121, 9054.139856713602, 9203.539823008956, 9210.631574736935, 9303.76740581491, 9413.670521531714, 6483.546151769331, 6911.17065952089, 7195.568265904062, 7200.963995179991, 7216.386607138242, 7856.332211761835, 7863.803404914923, 7873.566953817595, 7901.209879012283, 7944.6424910877995, 6828.419584335188, 6958.965205173941, 7077.221505634273, 7088.326608972139, 7208.96395518019, 6855.657217139223, 6870.0, 6968.965155174192, 6996.335348141918, 7092.078029856086, 7449.4412919032375, 7496.925030749622, 7665.808354790952, 7671.462997590115, 7685.654145563575, 6888.448924085961, 6933.653317334214, 6954.547954382949, 6955.165380154212, 6960.617166055916, 6540.705668245036, 6548.8362790930605, 6604.900926486011, 6609.702563384563, 6612.0], "unit": "score", "name": "mootools.html", "value": 4702.381451016005}, {"lowerIsBetter": false, "replicates": [348.6112984022815, 351.63254399152896, 353.33572882979996, 353.78242380935734, 353.9504469374288, 6256.186695729554, 6311.747530098791, 6325.557210995221, 6350.269718982318, 6352.428281454668, 6245.843853903654, 6250.687465626712, 6258.092576576405, 6259.499240060795, 6266.216722909637, 4685.1800934836265, 4798.304245884345, 4806.9038619227595, 4820.301056346828, 4850.636202284834, 4792.113459010076, 4806.83176088837, 4812.278158276252, 4814.229723244282, 4828.396450443694, 4775.570198682118, 4786.401699787527, 4787.425508938933, 4791.425028996526, 4810.158222311099, 4800.1119792838435, 4812.181929072066, 4813.49458306878, 4816.349792777965, 4820.68665536739, 4184.309588917825, 4186.769727664977, 4189.287821070426, 4195.811188496495, 4212.0, 5909.4090590941, 5916.467517923407, 5924.229850119457, 5932.911006334908, 5940.34656187819, 5436.456354364572, 5592.105263157916, 5602.803901863415, 5603.0, 5606.6636001839615, 6655.168103987002, 6665.900011499832, 6680.866382672368, 6682.766103186365, 6683.866322673519, 4587.931181032287, 4591.79336929839, 4591.977040114812, 4607.0, 4617.145828021793, 6864.450843932474, 6871.828204294932, 6883.105196324495, 6932.826679333007, 6950.235474097845, 4642.65180111493, 4713.505081966413, 4718.575328220477, 4728.31439441286, 4729.881752956204, 4664.976675116603, 4742.668013239109, 4750.097481478508, 4755.286706993978, 4766.189747742892, 5494.423085576037, 5504.0, 5526.58550608706, 5528.622692242375, 5542.5565954723525, 6734.393904548614, 6739.157605299338, 6742.056112144303, 6743.932560674429, 6748.426383757435, 1672.2976349933058, 1696.9066701331544, 1699.2778069320489, 1699.566610514311, 1700.923458444373, 1081.5781845080426, 1106.8395082713123, 1114.5820317380983, 1117.1788735279563, 1123.7640095579857, 6553.868922621521, 6568.8357791055605, 6586.407223349922, 6586.571872828346, 6596.175478065242, 6936.34104760047, 6940.444764418834, 6952.687129079203, 6954.4436445084275, 6960.686769095403, 6478.157839480931, 6558.770443034471, 6583.473322134314, 6634.635095069818, 6646.534742567974, 3753.3994560870674, 3762.4168253920684, 3783.6783873370523, 3796.8291426885858, 3799.3920972644246, 7222.602756848424, 7280.235575264627, 7281.890771638429, 7313.2321106284135, 7313.89029164563, 7112.395446387011, 7136.3220494052985, 7157.57054576727, 7165.749198778018, 7165.928340716526, 6977.720891164398, 7258.927410725825, 7288.453365997571, 7316.853662926818, 7318.451116166309, 6957.547759395623, 6960.060391847238, 6992.930070699228, 6993.776089184271, 6999.405050570758, 6805.557638753465, 6817.795466136024, 6834.692438840165, 6870.587764734132, 6874.450043996369, 7222.422206223595, 7316.561006339637, 7321.9383189438295, 7324.340809327186, 7333.046703928455, 4560.156371071363, 4566.771661416849, 4754.191787396082, 4754.572088512051, 4755.048990201904, 6886.724531018904, 6910.930890691029, 6927.3419025192525, 6971.233164352018, 6988.336108069725, 6706.597604143767, 6708.19501659804, 6727.428168605527, 6746.392824645805, 6746.730130794714, 6618.536702430783, 6676.298988606127, 6681.398674119353, 6687.0, 6716.3955244028275, 6447.4197322241225, 6547.148870646785, 6600.867982640224, 6601.405873471411, 6638.037484564615, 6664.100346453167, 6689.799306020827, 6699.464042876461, 6718.563293385914, 6757.831054223684, 6593.208814942238, 6609.438197753245, 6610.239822420291, 6616.536842420985, 6618.305077966744], "unit": "score", "name": "prototype.html", "value": 5054.171952909995}, {"lowerIsBetter": false, "replicates": [773.79494433975, 775.2170307988937, 805.243071512778, 879.1252703559957, 891.2736120062149, 14315.141091534502, 14453.421863125463, 14478.710425791478, 14503.854961450383, 14550.854491455082, 14024.228667423287, 14043.578692639212, 14056.578302650936, 14066.929665351685, 14069.71860562788, 902.7066203483878, 905.0587389115312, 930.4696323095839, 933.0110083311678, 934.4299977014016, 917.0645941140033, 922.5710044829153, 923.7321176858703, 925.2505470568827, 925.296774451415, 970.034815358719, 973.630020592174, 973.9366941148838, 977.779999500114, 982.1847866271014, 958.7603099225194, 963.9180669643089, 966.840471322231, 966.8646389505475, 970.3353203055894, 717.4153065251803, 719.3957076056085, 720.1610124205295, 720.7657511308793, 721.7726416178887, 13311.201327920258, 13357.332133393389, 13362.933185334108, 13754.105983111065, 13795.724085518234, 12092.939535302356, 12185.573504927284, 12256.38718064102, 12330.19853709515, 12589.055820813384, 10447.111995480393, 10465.895341046567, 10516.211284153642, 10580.576776928914, 10647.201459890539, 3600.135967367839, 3627.165751877083, 3646.8176591170336, 3687.59436461989, 3740.532433445819, 53462.465375345746, 54026.45973540254, 54045.72977135128, 54327.72836135794, 54466.72766636142, 9581.377210481296, 9840.16358609512, 9854.50727463624, 9892.703218903445, 9934.80130397388, 17047.0, 17168.570785730208, 17236.396726114777, 17248.913755431142, 18017.099145042695, 7035.788926332219, 7061.082059332254, 7165.247648996885, 7345.0, 7373.525294941033, 4310.267254566731, 4368.8907777305185, 4407.845725399659, 4484.932726009112, 4526.0, 3021.9244518886762, 3047.4057558775826, 3053.129857990462, 3054.2059064643354, 3058.067289476731, 545.1060261171682, 562.8508445262008, 583.0176153181902, 583.5185971573469, 584.2959234122872, 657.9439252336449, 670.5105273150627, 681.8738533371342, 682.7610336382227, 692.8718187135396, 7079.858402831915, 7220.4584656151, 7261.455390845602, 7264.34620884123, 7276.417886569062, 561.7612514681244, 573.899567575681, 622.3745136138152, 645.0710976194359, 646.3536463536464, 3408.1479630092476, 3430.1939044324563, 3467.2025434150287, 3505.8948231553095, 3575.106223444139, 57550.7122464385, 58076.70961645249, 61460.078098828555, 61572.0, 61611.383886161464, 51393.0, 51491.74254128705, 52292.0, 53466.73266633642, 53630.0, 47899.281510777364, 48505.999999999294, 48570.27144592834, 48619.0, 49290.26064609034, 7579.772606821804, 7813.257740514642, 7875.921240787518, 8035.156308587514, 8205.548694821842, 36782.080447989014, 37010.25979480449, 37019.814900925325, 38091.047723807125, 38257.80871095627, 46327.30509042434, 47125.29312060253, 47484.0, 47803.0, 48668.756656216494, 9931.801363972536, 10111.898881011095, 10434.37393756377, 10440.791184176425, 10620.787584248117, 11164.720881978015, 11349.375784331942, 11362.772744544898, 11508.769824603629, 11513.30920144794, 9653.9034609653, 10055.346402484107, 10311.793764124826, 10319.896801032193, 10512.42181680015, 10900.073493752803, 10932.508037138507, 10957.616483423042, 11071.0, 11159.051480624237, 10015.949920250352, 10119.7470063249, 10160.745981350525, 10224.53989570486, 10376.066154046172, 8546.914530854861, 8709.825803483767, 8736.519491428033, 8835.779105522413, 9061.365704400629, 8823.514706690938, 8863.379563430499, 9215.216706580015, 9237.769055773659, 9276.489793061446], "unit": "score", "name": "yui.html", "value": 6341.3941700309815}], "name": "dromaeo_css", "value": 7117.636558275248}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 111.0, 110.0, 111.0, 124.0, 110.0, 109.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [163.0, 127.0, 158.0, 173.0, 129.0, 160.0, 157.0, 136.0, 171.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 166.0, 161.0, 164.0, 163.0, 164.0, 162.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 76.0, 170.0, 76.0, 76.0, 77.0, 77.0, 182.0, 78.0], "unit": "score", "name": "audio-fft", "value": 96.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 147.0, 93.0, 93.0, 92.0, 143.0, 95.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 101.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 56.0, 54.0, 54.0, 58.0, 61.0, 53.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [71.0, 64.0, 64.0, 64.0, 64.0, 68.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 82.0, 80.0, 81.0, 79.0, 77.0, 79.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 115.0, 123.0, 120.0, 114.0, 120.0, 111.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [148.0, 141.0, 150.0, 149.0, 136.0, 150.0, 148.0, 153.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 72.0, 70.0, 70.0, 70.0, 71.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1523.3}]} 17:02:00 INFO - Return code: 0 17:02:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:02:00 ERROR - # TBPL SUCCESS # 17:02:00 INFO - Running post-action listener: _resource_record_post_action 17:02:00 INFO - Running post-run listener: _resource_record_post_run 17:02:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 7950336; Write bytes: 384806912; Read time: 1712; Write time: 313392 17:02:01 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8540160; Read time: 0; Write time: 6164 17:02:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 6184960; Write bytes: 311676928; Read time: 1440; Write time: 268124 17:02:01 INFO - Running post-run listener: _upload_blobber_files 17:02:01 INFO - Blob upload gear active. 17:02:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:02:01 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 17:02:01 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'] 17:02:01 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 17:02:02 INFO - (blobuploader) - INFO - Open directory for files ... 17:02:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:02:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:02:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:02 INFO - (blobuploader) - INFO - Done attempting. 17:02:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:02:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:02:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:03 INFO - (blobuploader) - INFO - Done attempting. 17:02:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:02:03 INFO - Return code: 0 17:02:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:02:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:02:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5c1b553ed3a63994fe32e57e97b7ade5cc76f75da5f89bb139f3ab1f08d16526abd748a97d1235db1aafcf7930c62dea0f77ef8342279e74b42491c711f9cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24cadb9200f6483749f81e0cc76a13bd3678bb3cd960ad49909ec9a311ce78f35b4d29aa20de7853c21100673e19cb5b02b621f077fca1a4857a4ad1db6d629"} 17:02:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:02:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:02:03 INFO - Contents: 17:02:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5c1b553ed3a63994fe32e57e97b7ade5cc76f75da5f89bb139f3ab1f08d16526abd748a97d1235db1aafcf7930c62dea0f77ef8342279e74b42491c711f9cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24cadb9200f6483749f81e0cc76a13bd3678bb3cd960ad49909ec9a311ce78f35b4d29aa20de7853c21100673e19cb5b02b621f077fca1a4857a4ad1db6d629"} 17:02:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:02:03 INFO - Copying logs to upload dir... 17:02:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:02:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.699765 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-14 17:02:03.731193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:03.734437) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829 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/b5c1b553ed3a63994fe32e57e97b7ade5cc76f75da5f89bb139f3ab1f08d16526abd748a97d1235db1aafcf7930c62dea0f77ef8342279e74b42491c711f9cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24cadb9200f6483749f81e0cc76a13bd3678bb3cd960ad49909ec9a311ce78f35b4d29aa20de7853c21100673e19cb5b02b621f077fca1a4857a4ad1db6d629"} build_url:https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/LQbX3TdxRHCLa_KE5GOC4g/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/b5c1b553ed3a63994fe32e57e97b7ade5cc76f75da5f89bb139f3ab1f08d16526abd748a97d1235db1aafcf7930c62dea0f77ef8342279e74b42491c711f9cf8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e24cadb9200f6483749f81e0cc76a13bd3678bb3cd960ad49909ec9a311ce78f35b4d29aa20de7853c21100673e19cb5b02b621f077fca1a4857a4ad1db6d629"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:03.763883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:03.764453) ========= 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=3a3620fb28aea1604ab609ef000001d2-1460676830.260915-818161829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 17:02:03.849945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:02:03.850698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 17:02:03.851431) ========= ========= Total master_lag: 0.16 =========