builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1461199273.31 results: success (0) buildid: 20160420124052 builduid: 273b70f21fd344da850619ad6714fc0e revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.308560) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.309014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.309303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.368849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.369119) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 17:41:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-04-20 17:41:13 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166660 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.578194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.578484) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.071474 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.661503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:13.661859) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --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 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 17:41:13,746 truncating revision to first 12 chars 2016-04-20 17:41:13,746 Setting DEBUG logging. 2016-04-20 17:41:13,746 attempt 1/10 2016-04-20 17:41:13,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2387e00d2ce8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 17:41:14,081 unpacking tar archive at: mozilla-aurora-2387e00d2ce8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:14.337131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:14.337482) ========= script_repo_revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:14.337865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:14.338148) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:41:14.348916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-20 17:41:14.349272) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:41:14 INFO - MultiFileLogger online at 20160420 17:41:14 in /builds/slave/test 17:41:14 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 17:41:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:41:14 INFO - {'append_to_log': False, 17:41:14 INFO - 'base_work_dir': '/builds/slave/test', 17:41:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:41:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:41:14 INFO - 'branch': 'Mozilla-Aurora', 17:41:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:41:14 INFO - 'config_files': ('talos/linux_config.py',), 17:41:14 INFO - 'default_actions': ('clobber', 17:41:14 INFO - 'read-buildbot-config', 17:41:14 INFO - 'download-and-extract', 17:41:14 INFO - 'populate-webroot', 17:41:14 INFO - 'create-virtualenv', 17:41:14 INFO - 'install', 17:41:14 INFO - 'run-tests'), 17:41:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:41:14 INFO - 'download_minidump_stackwalk': True, 17:41:14 INFO - 'download_symbols': 'ondemand', 17:41:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:41:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:41:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:41:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:41:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:41:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:41:14 INFO - 'installer_path': 'installer.exe', 17:41:14 INFO - 'log_level': 'info', 17:41:14 INFO - 'log_name': 'talos', 17:41:14 INFO - 'log_to_console': True, 17:41:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:41:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:41:14 INFO - 'opt_config_files': (), 17:41:14 INFO - 'pip_index': False, 17:41:14 INFO - 'sps_profile': False, 17:41:14 INFO - 'sps_profile_interval': 0, 17:41:14 INFO - 'suite': 'dromaeojs-e10s', 17:41:14 INFO - 'system_bits': '32', 17:41:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:41:14 INFO - 'title': 'talos-linux64-ix-013', 17:41:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:41:14 INFO - 'use_talos_json': True, 17:41:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:41:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:41:14 INFO - 'work_dir': 'build'} 17:41:14 INFO - ##### 17:41:14 INFO - ##### Running clobber step. 17:41:14 INFO - ##### 17:41:14 INFO - Running pre-action listener: _resource_record_pre_action 17:41:14 INFO - Running main action method: clobber 17:41:14 INFO - rmtree: /builds/slave/test/build 17:41:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:41:19 INFO - Running post-action listener: _resource_record_post_action 17:41:19 INFO - ##### 17:41:19 INFO - ##### Running read-buildbot-config step. 17:41:19 INFO - ##### 17:41:19 INFO - Running pre-action listener: _resource_record_pre_action 17:41:19 INFO - Running main action method: read_buildbot_config 17:41:19 INFO - Using buildbot properties: 17:41:19 INFO - { 17:41:19 INFO - "project": "", 17:41:19 INFO - "product": "firefox", 17:41:19 INFO - "script_repo_revision": "production", 17:41:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:41:19 INFO - "repository": "", 17:41:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 17:41:19 INFO - "buildid": "20160420124052", 17:41:19 INFO - "pgo_build": "True", 17:41:19 INFO - "basedir": "/builds/slave/test", 17:41:19 INFO - "buildnumber": 223, 17:41:19 INFO - "slavename": "talos-linux64-ix-013", 17:41:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:41:19 INFO - "platform": "ubuntu64_hw", 17:41:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:41:19 INFO - "branch": "mozilla-aurora", 17:41:19 INFO - "repo_path": "releases/mozilla-aurora", 17:41:19 INFO - "revision": "2387e00d2ce89a2cd641df7ca92af4feeeebe556", 17:41:19 INFO - "stage_platform": "linux64-pgo", 17:41:19 INFO - "builduid": "273b70f21fd344da850619ad6714fc0e", 17:41:19 INFO - "slavebuilddir": "test" 17:41:19 INFO - } 17:41:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 17:41:19 INFO - Running post-action listener: _resource_record_post_action 17:41:19 INFO - ##### 17:41:19 INFO - ##### Running download-and-extract step. 17:41:19 INFO - ##### 17:41:19 INFO - Running pre-action listener: _resource_record_pre_action 17:41:19 INFO - Running main action method: download_and_extract 17:41:19 INFO - mkdir: /builds/slave/test/build/tests 17: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')]} 17:41:19 INFO - https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:41:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:41:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:41:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:24 INFO - Downloaded 1448 bytes. 17:41:24 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:41:24 INFO - Using the following test package requirements: 17:41:24 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:41:24 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:41:24 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:41:24 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'jsshell-linux-x86_64.zip'], 17:41:24 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:41:24 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:41:24 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:41:24 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:41:24 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:41:24 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:41:24 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:41:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:41:24 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:41:24 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')]} 17:41:24 INFO - https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:41:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:41:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:41:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:33 INFO - Downloaded 23353228 bytes. 17:41:33 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'] 17:41:33 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 17:41:34 INFO - Return code: 0 17:41:34 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 17:41:34 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')]} 17:41:34 INFO - https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:37 INFO - Downloaded 23353228 bytes. 17:41:37 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'] 17:41:37 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 17:41:38 INFO - Return code: 0 17:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:38 INFO - https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:40 INFO - Downloaded 10845198 bytes. 17:41:40 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'] 17:41:40 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 17:41:41 INFO - Return code: 0 17: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')]} 17:41:41 INFO - https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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 17:41:42 INFO - Downloaded 60601641 bytes. 17:41:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:41:42 INFO - mkdir: /builds/slave/test/properties 17:41:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:41:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:41:42 INFO - Contents: 17:41:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:41:43 INFO - Running post-action listener: _resource_record_post_action 17:41:43 INFO - Running post-action listener: set_extra_try_arguments 17:41:43 INFO - ##### 17:41:43 INFO - ##### Running populate-webroot step. 17:41:43 INFO - ##### 17:41:43 INFO - Running pre-action listener: _resource_record_pre_action 17:41:43 INFO - Running main action method: populate_webroot 17:41:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:41:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:41:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:41:43 INFO - '--tppagecycles', 17:41:43 INFO - '7'], 17:41:43 INFO - 'tests': ['tsvgm']}}, 17:41:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:41:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:41:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:41:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:41:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:41:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'tests': ['damp', 'tps']}, 17:41:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['damp', 'tps']}, 17:41:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:41:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:41:43 INFO - 'other': {'tests': ['a11yr', 17:41:43 INFO - 'ts_paint', 17:41:43 INFO - 'tpaint', 17:41:43 INFO - 'sessionrestore', 17:41:43 INFO - 'sessionrestore_no_auto_restore', 17:41:43 INFO - 'tabpaint']}, 17:41:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['a11yr', 17:41:43 INFO - 'ts_paint', 17:41:43 INFO - 'tpaint', 17:41:43 INFO - 'sessionrestore', 17:41:43 INFO - 'sessionrestore_no_auto_restore', 17:41:43 INFO - 'tabpaint']}, 17:41:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['a11yr', 17:41:43 INFO - 'ts_paint', 17:41:43 INFO - 'tpaint', 17:41:43 INFO - 'sessionrestore', 17:41:43 INFO - 'sessionrestore_no_auto_restore', 17:41:43 INFO - 'tabpaint']}, 17:41:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['a11yr', 17:41:43 INFO - 'ts_paint', 17:41:43 INFO - 'tpaint', 17:41:43 INFO - 'sessionrestore', 17:41:43 INFO - 'sessionrestore_no_auto_restore', 17:41:43 INFO - 'tabpaint']}, 17:41:43 INFO - 'other_l64': {'tests': ['a11yr', 17:41:43 INFO - 'ts_paint', 17:41:43 INFO - 'tpaint', 17:41:43 INFO - 'sessionrestore', 17:41:43 INFO - 'sessionrestore_no_auto_restore', 17:41:43 INFO - 'tabpaint']}, 17:41:43 INFO - 'other_nol64': {'tests': ['a11yr', 17:41:43 INFO - 'ts_paint', 17:41:43 INFO - 'tpaint', 17:41:43 INFO - 'sessionrestore', 17:41:43 INFO - 'sessionrestore_no_auto_restore', 17:41:43 INFO - 'tabpaint']}, 17:41:43 INFO - 'svgr': {'tests': ['tsvgx', 17:41:43 INFO - 'tsvgr_opacity', 17:41:43 INFO - 'tart', 17:41:43 INFO - 'tscrollx', 17:41:43 INFO - 'cart']}, 17:41:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['tsvgx', 17:41:43 INFO - 'tsvgr_opacity', 17:41:43 INFO - 'tart', 17:41:43 INFO - 'tscrollx', 17:41:43 INFO - 'cart']}, 17:41:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'tests': ['tp5o']}, 17:41:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'talos_options': ['--e10s'], 17:41:43 INFO - 'tests': ['tp5o']}, 17:41:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'talos_options': ['--xperf_path', 17:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:43 INFO - 'tests': ['tp5n']}, 17:41:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:41:43 INFO - 'talos_options': ['--e10s', 17:41:43 INFO - '--xperf_path', 17:41:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:41:43 INFO - 'tests': ['tp5n']}}, 17:41:43 INFO - 'talos.zip': {'path': '', 17:41:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:41:43 INFO - Running post-action listener: _resource_record_post_action 17:41:43 INFO - ##### 17:41:43 INFO - ##### Running create-virtualenv step. 17:41:43 INFO - ##### 17:41:43 INFO - Running pre-action listener: _resource_record_pre_action 17:41:43 INFO - Running main action method: create_virtualenv 17:41:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:41:43 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 17:41:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:41:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:41:43 INFO - Using real prefix '/usr' 17:41:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:41:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:41:46 INFO - Installing pip.................done. 17:41:46 INFO - Return code: 0 17:41:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:46 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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:41:46 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 17:41:46 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 17:41:46 INFO - Using env: {'DISPLAY': ':0', 17:41:46 INFO - 'HOME': '/home/cltbld', 17:41:46 INFO - 'LANG': 'en_US.UTF-8', 17:41:46 INFO - 'LANGUAGE': 'en_US:en', 17:41:46 INFO - 'LOGNAME': 'cltbld', 17:41:46 INFO - 'MAIL': '/var/mail/cltbld', 17:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:46 INFO - 'MOZ_NO_REMOTE': '1', 17:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:46 INFO - 'NO_EM_RESTART': '1', 17:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:46 INFO - 'PWD': '/builds/slave/test', 17:41:46 INFO - 'SHELL': '/bin/bash', 17:41:46 INFO - 'SHLVL': '1', 17:41:46 INFO - 'TERM': 'linux', 17:41:46 INFO - 'TMOUT': '86400', 17:41:46 INFO - 'USER': 'cltbld', 17:41:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:46 INFO - '_': '/tools/buildbot/bin/python'} 17:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:46 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 17:41:46 INFO - Cleaning up... 17:41:46 INFO - Return code: 0 17:41:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:46 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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:41:46 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 17:41:46 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 17:41:46 INFO - Using env: {'DISPLAY': ':0', 17:41:46 INFO - 'HOME': '/home/cltbld', 17:41:46 INFO - 'LANG': 'en_US.UTF-8', 17:41:46 INFO - 'LANGUAGE': 'en_US:en', 17:41:46 INFO - 'LOGNAME': 'cltbld', 17:41:46 INFO - 'MAIL': '/var/mail/cltbld', 17:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:46 INFO - 'MOZ_NO_REMOTE': '1', 17:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:46 INFO - 'NO_EM_RESTART': '1', 17:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:46 INFO - 'PWD': '/builds/slave/test', 17:41:46 INFO - 'SHELL': '/bin/bash', 17:41:46 INFO - 'SHLVL': '1', 17:41:46 INFO - 'TERM': 'linux', 17:41:46 INFO - 'TMOUT': '86400', 17:41:46 INFO - 'USER': 'cltbld', 17:41:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:46 INFO - '_': '/tools/buildbot/bin/python'} 17:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:46 INFO - Downloading/unpacking psutil>=0.7.1 17:41:46 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 17:41:46 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 17:41:46 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 17:41:46 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 17:41:46 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 17:41:46 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 17:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:48 INFO - Installing collected packages: psutil 17:41:48 INFO - Running setup.py install for psutil 17:41:48 INFO - building 'psutil._psutil_linux' extension 17:41:48 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 17:41:49 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 17:41:49 INFO - building 'psutil._psutil_posix' extension 17:41:49 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 17:41:50 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 17:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:50 INFO - Successfully installed psutil 17:41:50 INFO - Cleaning up... 17:41:50 INFO - Return code: 0 17:41:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:50 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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:41:50 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 17:41:50 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 17:41:50 INFO - Using env: {'DISPLAY': ':0', 17:41:50 INFO - 'HOME': '/home/cltbld', 17:41:50 INFO - 'LANG': 'en_US.UTF-8', 17:41:50 INFO - 'LANGUAGE': 'en_US:en', 17:41:50 INFO - 'LOGNAME': 'cltbld', 17:41:50 INFO - 'MAIL': '/var/mail/cltbld', 17:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:50 INFO - 'MOZ_NO_REMOTE': '1', 17:41:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:50 INFO - 'NO_EM_RESTART': '1', 17:41:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:50 INFO - 'PWD': '/builds/slave/test', 17:41:50 INFO - 'SHELL': '/bin/bash', 17:41:50 INFO - 'SHLVL': '1', 17:41:50 INFO - 'TERM': 'linux', 17:41:50 INFO - 'TMOUT': '86400', 17:41:50 INFO - 'USER': 'cltbld', 17:41:50 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:50 INFO - '_': '/tools/buildbot/bin/python'} 17:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:41:50 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 17:41:50 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 17:41:50 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 17:41:50 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 17:41:50 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 17:41:50 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 17:41:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:41:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:41:52 INFO - Installing collected packages: mozsystemmonitor 17:41:52 INFO - Running setup.py install for mozsystemmonitor 17:41:52 INFO - Successfully installed mozsystemmonitor 17:41:52 INFO - Cleaning up... 17:41:52 INFO - Return code: 0 17:41:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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', '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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17: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 blobuploader==1.2.4 17:41:52 INFO - Using env: {'DISPLAY': ':0', 17:41:52 INFO - 'HOME': '/home/cltbld', 17:41:52 INFO - 'LANG': 'en_US.UTF-8', 17:41:52 INFO - 'LANGUAGE': 'en_US:en', 17:41:52 INFO - 'LOGNAME': 'cltbld', 17:41:52 INFO - 'MAIL': '/var/mail/cltbld', 17:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:52 INFO - 'MOZ_NO_REMOTE': '1', 17:41:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:52 INFO - 'NO_EM_RESTART': '1', 17:41:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:52 INFO - 'PWD': '/builds/slave/test', 17:41:52 INFO - 'SHELL': '/bin/bash', 17:41:52 INFO - 'SHLVL': '1', 17:41:52 INFO - 'TERM': 'linux', 17:41:52 INFO - 'TMOUT': '86400', 17:41:52 INFO - 'USER': 'cltbld', 17:41:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:52 INFO - '_': '/tools/buildbot/bin/python'} 17:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:41:52 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 17:41:52 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 17:41:52 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 17:41:52 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 17:41:52 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 17:41:52 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 17:41:54 INFO - Downloading blobuploader-1.2.4.tar.gz 17:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:41:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 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 17:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:41:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17: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 17: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 17: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 17: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 17: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 17: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 17:41:55 INFO - Downloading docopt-0.6.1.tar.gz 17:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:41:55 INFO - Installing collected packages: blobuploader, requests, docopt 17:41:55 INFO - Running setup.py install for blobuploader 17:41:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:41:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:41:55 INFO - Running setup.py install for requests 17:41:55 INFO - Running setup.py install for docopt 17:41:55 INFO - Successfully installed blobuploader requests docopt 17:41:55 INFO - Cleaning up... 17:41:56 INFO - Return code: 0 17:41:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:56 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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:41:56 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 17:41:56 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 17:41:56 INFO - Using env: {'DISPLAY': ':0', 17:41:56 INFO - 'HOME': '/home/cltbld', 17:41:56 INFO - 'LANG': 'en_US.UTF-8', 17:41:56 INFO - 'LANGUAGE': 'en_US:en', 17:41:56 INFO - 'LOGNAME': 'cltbld', 17:41:56 INFO - 'MAIL': '/var/mail/cltbld', 17:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:56 INFO - 'MOZ_NO_REMOTE': '1', 17:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:56 INFO - 'NO_EM_RESTART': '1', 17:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:56 INFO - 'PWD': '/builds/slave/test', 17:41:56 INFO - 'SHELL': '/bin/bash', 17:41:56 INFO - 'SHLVL': '1', 17:41:56 INFO - 'TERM': 'linux', 17:41:56 INFO - 'TMOUT': '86400', 17:41:56 INFO - 'USER': 'cltbld', 17:41:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:56 INFO - '_': '/tools/buildbot/bin/python'} 17:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:56 INFO - Running setup.py (path:/tmp/pip-ixja_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:56 INFO - Running setup.py (path:/tmp/pip-P6xupF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:56 INFO - Running setup.py (path:/tmp/pip-xU1ZVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:56 INFO - Running setup.py (path:/tmp/pip-bb9dtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:56 INFO - Running setup.py (path:/tmp/pip-iDmQCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:56 INFO - Running setup.py (path:/tmp/pip-MHqYmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:56 INFO - Running setup.py (path:/tmp/pip-STySv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:56 INFO - Running setup.py (path:/tmp/pip-mhR3C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:56 INFO - Running setup.py (path:/tmp/pip-XRQYeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:56 INFO - Running setup.py (path:/tmp/pip-WSq5lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:56 INFO - Running setup.py (path:/tmp/pip-631mYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:57 INFO - Running setup.py (path:/tmp/pip-2Zfvjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:57 INFO - Running setup.py (path:/tmp/pip-q9XR0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:57 INFO - Running setup.py (path:/tmp/pip-5IxToS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:57 INFO - Running setup.py (path:/tmp/pip-Oj_4oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:57 INFO - Running setup.py (path:/tmp/pip-K51abw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:57 INFO - Running setup.py (path:/tmp/pip-DlDH3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:41:57 INFO - Running setup.py install for manifestparser 17:41:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:41:57 INFO - Running setup.py install for mozcrash 17:41:57 INFO - Running setup.py install for mozdebug 17:41:57 INFO - Running setup.py install for mozdevice 17:41:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:41:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:41:57 INFO - Running setup.py install for mozfile 17:41:57 INFO - Running setup.py install for mozhttpd 17:41:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for mozinfo 17:41:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for mozInstall 17:41:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for mozleak 17:41:58 INFO - Running setup.py install for mozlog 17:41:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for moznetwork 17:41:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for mozprocess 17:41:58 INFO - Running setup.py install for mozprofile 17:41:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for mozrunner 17:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:41:58 INFO - Running setup.py install for mozscreenshot 17:41:58 INFO - Running setup.py install for moztest 17:41:59 INFO - Running setup.py install for mozversion 17:41:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:41:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:41:59 INFO - Cleaning up... 17:41:59 INFO - Return code: 0 17:41:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:59 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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:41:59 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 17:41:59 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 17:41:59 INFO - Using env: {'DISPLAY': ':0', 17:41:59 INFO - 'HOME': '/home/cltbld', 17:41:59 INFO - 'LANG': 'en_US.UTF-8', 17:41:59 INFO - 'LANGUAGE': 'en_US:en', 17:41:59 INFO - 'LOGNAME': 'cltbld', 17:41:59 INFO - 'MAIL': '/var/mail/cltbld', 17:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:59 INFO - 'MOZ_NO_REMOTE': '1', 17:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:59 INFO - 'NO_EM_RESTART': '1', 17:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:59 INFO - 'PWD': '/builds/slave/test', 17:41:59 INFO - 'SHELL': '/bin/bash', 17:41:59 INFO - 'SHLVL': '1', 17:41:59 INFO - 'TERM': 'linux', 17:41:59 INFO - 'TMOUT': '86400', 17:41:59 INFO - 'USER': 'cltbld', 17:41:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:59 INFO - '_': '/tools/buildbot/bin/python'} 17:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:59 INFO - Running setup.py (path:/tmp/pip-GCJaOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:59 INFO - Running setup.py (path:/tmp/pip-_sdEcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:59 INFO - Running setup.py (path:/tmp/pip-2JpcQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:59 INFO - Running setup.py (path:/tmp/pip-HbCKiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:59 INFO - Running setup.py (path:/tmp/pip-szCBnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:59 INFO - Running setup.py (path:/tmp/pip-DvillZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:59 INFO - Running setup.py (path:/tmp/pip-G_a8Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:59 INFO - Running setup.py (path:/tmp/pip-y1n_mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:59 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)) 17:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:59 INFO - Running setup.py (path:/tmp/pip-t8Zlrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:42:00 INFO - Running setup.py (path:/tmp/pip-knwi9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:42:00 INFO - Running setup.py (path:/tmp/pip-5Y6j9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:42:00 INFO - Running setup.py (path:/tmp/pip-wCwi0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:42:00 INFO - Running setup.py (path:/tmp/pip-ObptFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:42:00 INFO - Running setup.py (path:/tmp/pip-DmZYU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:00 INFO - Running setup.py (path:/tmp/pip-J4boDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:42:00 INFO - Running setup.py (path:/tmp/pip-SMa15R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:42:00 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)) 17:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:42:00 INFO - Running setup.py (path:/tmp/pip-xzYC0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:42:00 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)) 17:42:00 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)) 17:42:00 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)) 17:42:00 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)) 17:42:00 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)) 17:42:00 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)) 17:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:02 INFO - Downloading blessings-1.6.tar.gz 17:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:42:02 INFO - Installing collected packages: blessings 17:42:02 INFO - Running setup.py install for blessings 17:42:02 INFO - Successfully installed blessings 17:42:02 INFO - Cleaning up... 17:42:02 INFO - Return code: 0 17:42:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:42:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:02 INFO - Reading from file tmpfile_stdout 17:42:02 INFO - Current package versions: 17:42:02 INFO - argparse == 1.2.1 17:42:02 INFO - blessings == 1.6 17:42:02 INFO - blobuploader == 1.2.4 17:42:02 INFO - docopt == 0.6.1 17:42:02 INFO - manifestparser == 1.1 17:42:02 INFO - mozInstall == 1.12 17:42:02 INFO - mozcrash == 0.17 17:42:02 INFO - mozdebug == 0.1 17:42:02 INFO - mozdevice == 0.48 17:42:02 INFO - mozfile == 1.2 17:42:02 INFO - mozhttpd == 0.7 17:42:02 INFO - mozinfo == 0.9 17:42:02 INFO - mozleak == 0.1 17:42:02 INFO - mozlog == 3.1 17:42:02 INFO - moznetwork == 0.27 17:42:02 INFO - mozprocess == 0.22 17:42:02 INFO - mozprofile == 0.28 17:42:02 INFO - mozrunner == 6.11 17:42:02 INFO - mozscreenshot == 0.1 17:42:02 INFO - mozsystemmonitor == 0.0 17:42:02 INFO - moztest == 0.7 17:42:02 INFO - mozversion == 1.4 17:42:02 INFO - psutil == 3.1.1 17:42:02 INFO - requests == 1.2.3 17:42:02 INFO - wsgiref == 0.1.2 17:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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/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 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:42:02 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 17:42:02 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 17:42:02 INFO - Using env: {'DISPLAY': ':0', 17:42:02 INFO - 'HOME': '/home/cltbld', 17:42:02 INFO - 'LANG': 'en_US.UTF-8', 17:42:02 INFO - 'LANGUAGE': 'en_US:en', 17:42:02 INFO - 'LOGNAME': 'cltbld', 17:42:02 INFO - 'MAIL': '/var/mail/cltbld', 17:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:02 INFO - 'MOZ_NO_REMOTE': '1', 17:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:02 INFO - 'NO_EM_RESTART': '1', 17:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:02 INFO - 'PWD': '/builds/slave/test', 17:42:02 INFO - 'SHELL': '/bin/bash', 17:42:02 INFO - 'SHLVL': '1', 17:42:02 INFO - 'TERM': 'linux', 17:42:02 INFO - 'TMOUT': '86400', 17:42:02 INFO - 'USER': 'cltbld', 17:42:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:02 INFO - '_': '/tools/buildbot/bin/python'} 17:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17:42:03 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)) 17: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 mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:42:03 INFO - Cleaning up... 17:42:03 INFO - Return code: 0 17:42:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:42:03 INFO - Using env: {'DISPLAY': ':0', 17:42:03 INFO - 'HOME': '/home/cltbld', 17:42:03 INFO - 'LANG': 'en_US.UTF-8', 17:42:03 INFO - 'LANGUAGE': 'en_US:en', 17:42:03 INFO - 'LOGNAME': 'cltbld', 17:42:03 INFO - 'MAIL': '/var/mail/cltbld', 17:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:03 INFO - 'MOZ_NO_REMOTE': '1', 17:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:03 INFO - 'NO_EM_RESTART': '1', 17:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:03 INFO - 'PWD': '/builds/slave/test', 17:42:03 INFO - 'SHELL': '/bin/bash', 17:42:03 INFO - 'SHLVL': '1', 17:42:03 INFO - 'TERM': 'linux', 17:42:03 INFO - 'TMOUT': '86400', 17:42:03 INFO - 'USER': 'cltbld', 17:42:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:03 INFO - '_': '/tools/buildbot/bin/python'} 17:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:03 INFO - Downloading/unpacking jsonschema 17: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 17: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 17: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 17: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 17: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 17: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 17:42:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:05 INFO - Downloading/unpacking functools32 (from jsonschema) 17:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:05 INFO - warning: no files found matching '*.txt' 17:42:05 INFO - no previously-included directories found matching 'build' 17:42:05 INFO - no previously-included directories found matching 'dist' 17:42:05 INFO - no previously-included directories found matching '.git*' 17:42:05 INFO - Installing collected packages: jsonschema, functools32 17:42:05 INFO - Running setup.py install for functools32 17:42:05 INFO - warning: no files found matching '*.txt' 17:42:05 INFO - no previously-included directories found matching 'build' 17:42:05 INFO - no previously-included directories found matching 'dist' 17:42:05 INFO - no previously-included directories found matching '.git*' 17:42:05 INFO - Successfully installed jsonschema functools32 17:42:05 INFO - Cleaning up... 17:42:05 INFO - Return code: 0 17:42:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17: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')]} 17:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0331e86f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b72410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', '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 17:42:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:42:05 INFO - Using env: {'DISPLAY': ':0', 17:42:05 INFO - 'HOME': '/home/cltbld', 17:42:05 INFO - 'LANG': 'en_US.UTF-8', 17:42:05 INFO - 'LANGUAGE': 'en_US:en', 17:42:05 INFO - 'LOGNAME': 'cltbld', 17:42:05 INFO - 'MAIL': '/var/mail/cltbld', 17:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:05 INFO - 'MOZ_NO_REMOTE': '1', 17:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:05 INFO - 'NO_EM_RESTART': '1', 17:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:05 INFO - 'PWD': '/builds/slave/test', 17:42:05 INFO - 'SHELL': '/bin/bash', 17:42:05 INFO - 'SHLVL': '1', 17:42:05 INFO - 'TERM': 'linux', 17:42:05 INFO - 'TMOUT': '86400', 17:42:05 INFO - 'USER': 'cltbld', 17:42:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:05 INFO - '_': '/tools/buildbot/bin/python'} 17:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:06 INFO - Downloading/unpacking flake8 17: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 17: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 17: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 17: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 17: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 17: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 17:42:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:42:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:42:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:42:08 INFO - no previously-included directories found matching 'docs/_build' 17:42:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:42:08 INFO - Running setup.py install for pep8 17:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:42:08 INFO - no previously-included directories found matching 'docs/_build' 17:42:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:42:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:42:08 INFO - Cleaning up... 17:42:08 INFO - Return code: 0 17:42:08 INFO - Running post-action listener: _resource_record_post_action 17:42:08 INFO - Running post-action listener: _start_resource_monitoring 17:42:08 INFO - Starting resource monitoring. 17:42:08 INFO - ##### 17:42:08 INFO - ##### Running install step. 17:42:08 INFO - ##### 17:42:08 INFO - Running pre-action listener: _resource_record_pre_action 17:42:08 INFO - Running main action method: install 17:42:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:42:09 INFO - Reading from file tmpfile_stdout 17:42:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:42:09 INFO - Reading from file tmpfile_stdout 17:42:09 INFO - Output received: 17:42:09 INFO - Usage: mozinstall [options] installer 17:42:09 INFO - Options: 17:42:09 INFO - -h, --help show this help message and exit 17:42:09 INFO - -d DEST, --destination=DEST 17:42:09 INFO - Directory to install application into. [default: 17:42:09 INFO - "/builds/slave/test"] 17:42:09 INFO - --app=APP Application being installed. [default: firefox] 17:42:09 INFO - mkdir: /builds/slave/test/build/application 17:42:09 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'] 17:42:09 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 17:42:24 INFO - Reading from file tmpfile_stdout 17:42:24 INFO - Output received: 17:42:24 INFO - /builds/slave/test/build/application/firefox/firefox 17:42:24 INFO - Running post-action listener: _resource_record_post_action 17:42:24 INFO - ##### 17:42:24 INFO - ##### Running run-tests step. 17:42:24 INFO - ##### 17:42:24 INFO - Running pre-action listener: _resource_record_pre_action 17:42:24 INFO - Running main action method: run_tests 17:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:42:24 INFO - Python 2.7.3 17:42:24 INFO - Return code: 0 17:42:24 INFO - grabbing minidump binary from tooltool 17:42:24 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')]} 17:42:24 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 0x1c01160>, '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 0x1c02060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c024f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:42:24 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 17:42:24 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 17:42:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:42:24 INFO - Return code: 0 17:42:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:42:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:42:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:42:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:42:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:42:25 INFO - Return code: 0 17:42:25 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/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:42:25 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/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:42:25 INFO - Using env: {'DISPLAY': ':0', 17:42:25 INFO - 'HOME': '/home/cltbld', 17:42:25 INFO - 'LANG': 'en_US.UTF-8', 17:42:25 INFO - 'LANGUAGE': 'en_US:en', 17:42:25 INFO - 'LOGNAME': 'cltbld', 17:42:25 INFO - 'MAIL': '/var/mail/cltbld', 17:42:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:25 INFO - 'MOZ_NO_REMOTE': '1', 17:42:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:25 INFO - 'NO_EM_RESTART': '1', 17:42:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:25 INFO - 'PWD': '/builds/slave/test', 17:42:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:25 INFO - 'SHELL': '/bin/bash', 17:42:25 INFO - 'SHLVL': '1', 17:42:25 INFO - 'TERM': 'linux', 17:42:25 INFO - 'TMOUT': '86400', 17:42:25 INFO - 'USER': 'cltbld', 17:42:25 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142', 17:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:25 INFO - '_': '/tools/buildbot/bin/python'} 17:42:25 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/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:42:25 INFO - mozversion application_buildid: 20160420124052 17:42:25 INFO - mozversion application_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 17:42:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:42:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:42:25 INFO - mozversion application_name: Firefox 17:42:25 INFO - mozversion application_remotingname: firefox-dev 17:42:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:42:25 INFO - mozversion application_vendor: Mozilla 17:42:25 INFO - mozversion application_version: 47.0a2 17:42:25 INFO - mozversion platform_buildid: 20160420124052 17:42:25 INFO - mozversion platform_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 17:42:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:42:25 INFO - mozversion platform_version: 47.0a2 17:42:25 INFO - using testdate: 1461199345 17:42:25 INFO - actual date: 1461199345 17:42:25 INFO - starting webserver on 'localhost:60947' 17:42:25 INFO - SUITE-START | Running 2 tests 17:42:25 INFO - TEST-START | dromaeo_css 17:42:25 INFO - operating with platform_type : linux_ 17:42:25 INFO - Initialising browser for dromaeo_css test... 17:42:25 INFO - TEST-INFO | started process 3287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYDsZ62/profile http://localhost:60947/getInfo.html) 17:42:30 INFO - PROCESS | 3287 | 17:42:30 INFO - PROCESS | 3287 | (process:3367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:42:31 INFO - PROCESS | 3287 | __metrics Screen width/height:1600/1200 17:42:31 INFO - PROCESS | 3287 | colorDepth:24 17:42:31 INFO - PROCESS | 3287 | Browser inner width/height: 1024/697 17:42:31 INFO - PROCESS | 3287 | __metrics 17:42:32 ERROR - PROCESS | 3287 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:42:33 INFO - TEST-INFO | 3287: exit 0 17:42:33 INFO - Browser initialized. 17:42:33 INFO - Running cycle 1/1 for dromaeo_css test... 17:42:33 INFO - TEST-INFO | started process 3418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYDsZ62/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:34 INFO - PROCESS | 3418 | 17:42:34 INFO - PROCESS | 3418 | (process:3485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:42:44 INFO - PROCESS | 3418 | RSS: Main: 150917120 17:42:44 INFO - PROCESS | 3418 | 17:43:34 INFO - PROCESS | 3418 | 1461199414583 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] 17:45:42 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60947/tests/dromaeo/cssquery-ext.html) 17:45:43 INFO - PROCESS | 3418 | RSS: Main: 155611136 17:45:43 INFO - PROCESS | 3418 | 17:48:45 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60947/tests/dromaeo/cssquery-ext.html (next: http://localhost:60947/tests/dromaeo/cssquery-jquery.html) 17:48:45 INFO - PROCESS | 3418 | RSS: Main: 153632768 17:48:45 INFO - PROCESS | 3418 | 17:51:47 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60947/tests/dromaeo/cssquery-mootools.html) 17:51:48 INFO - PROCESS | 3418 | RSS: Main: 153292800 17:51:48 INFO - PROCESS | 3418 | 17:54:49 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60947/tests/dromaeo/cssquery-prototype.html) 17:54:50 INFO - PROCESS | 3418 | RSS: Main: 152109056 17:54:50 INFO - PROCESS | 3418 | 17:57:52 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60947/tests/dromaeo/cssquery-yui.html) 17:57:53 INFO - PROCESS | 3418 | RSS: Main: 153628672 17:57:53 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:60947/tests/dromaeo/cssquery-yui.html (next: http://localhost:60947/tests/dromaeo/cssquery-dojo.html) 18:00:55 INFO - PROCESS | 3418 | RSS: Main: 155209728 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | __start_tp_report 18:00:55 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 18:00:55 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 18:00:55 INFO - PROCESS | 3418 | |i|pagename|runs| 18:00:55 INFO - PROCESS | 3418 | |0;dojo.html;3328.2844188499475;3354.1782263345467;3375.3080618473214;3380.9492857607124;3397.456406974883;5418.485243901833;5457.781688732451;5458.590605704569;5487.286652735143;5504.366997795255;5374.6237763356585;5477.698726570037;5483.259759932408;5491.450854914507;5534.723263836812;4952.083864485082;5001.499850015006;5057.443681195065;5086.949130508703;5101.566366858821;4870.43989941156;4991.251312303148;5075.111855425286;5081.79672813087;5169.198774190007;5084.898302033957;5119.488051194888;5123.333966584339;5143;5147.253648221005;5069.61977851659;5120.743962801864;5136.897262054738;5146.922796158024;5167.819126330579;4928.482509336504;4967.90064198714;5010.2735103409805;5029.346184995927;5050.545450909436;5253.159494480865;5272.103742363807;5273.683578985235;5283.207518872162;5284.445133261029;5849.7660093596205;5864.266966629171;5871.001929671966;5880.558958078119;5899.46904778572;5766.509846663039;5874.823755287348;5903.645781253095;5908.231929849135;5949.9107513387335;5469.671819690831;5495.230667706524;5503.11950087984;5523.889522209573;5529.972350138264;5881.470667639933;5972.134040564094;6005;6037.516998640098;6038.30559485656;5827.184194212814;5842.328132264759;5856.355800861902;5858.297004359419;5882.529397648178;5935.910961335583;5967.522598192134;5974.641521508724;5980.282366116007;5984.970075149597;5745.2243947067445;5906.49794767441;5910.320313164041;5944.316403613553;5944.346121926585;5831.1544826000845;5866;5867.119932010232;5872.471477567039;5872.823815285548;4456.844010459618;4476.843310484118;4488.685791994594;4498.730076195438;4515.729056256635;4022.4770779799023;4029.174019326031;4049.7772622506045;4069.2878746219294;4080.8979775505254;5364.249005139283;5528.861778455571;5565.387807341189;5618.129189975561;5683.8294851153705;5929.140274660236;5943.732532036069;5945.346011938684;5946.821595352147;5951.285845698458;5321.175217841241;5497.47773961473;5549.611527193058;5575.386707462176;5581.944180558224;5093.694378337312;5123.820666276662;5126.641135120506;5137.922931156036;5145.4597267287145;6060.727267272983;6065.302490213594;6089.878202435926;6097;6106.114613381035;5782.710864456844;5889.352171261244;5928.703564821655;5940.46535811779;5945.672987985616;6100.054491553817;6106.664133472702;6111.113888486056;6111.419415155553;6139.938600613937;5883.646981181143;5890.9116363253725;5893.410658934244;5895.233619629421;5896.23348964649;5727.599068065196;5937.376575459687;5963.821085367446;5993.880122397615;6016.2479690038745;5686.744096515584;5711.086226203787;5722.570807189394;5731.226284451545;5745.454181852718;5715.199872018004;5732.799352022659;5734.197212390352;5734.770609175586;5754.712264386848;5513.58648101386;5665.405132461032;5705.058665320175;5717.5425965921795;5722.055860782924;5791;5802.883942321215;5831.1544826000845;5858.355580886185;5874.559408044499;5519.724013799374;5692.516136128475;5730.770769169187;5740.425957404226;5754.827355179351 18:00:55 INFO - PROCESS | 3418 | |1;ext.html;536.8738346488577;563.3549585724346;582.7319433060793;592.6384905207823;609.44236024038;30748.53877191844;38549.229015419674;38887.250073746676;39008.41487377685;39142;42272;42567;42774.572254277446;42857;42901.35647965283;8667.653293868238;8904.376693631448;8932.33007524435;8940;8964.103589641049;8953.910460895406;9108.681196158135;9141.771455713628;9217.539123043822;9239.861402078941;9140.72577822663;9259.861102083474;9261.95369023154;9267.490288034189;9277.396969197014;9105.908940910605;9210.67762628308;9221.907780922173;9222.677206297782;9224.8616270756;8852.336074794352;9037.909620903773;9106.180443760028;9115.316351273681;9120.635174593075;41995.37006944898;42595.787021064694;42711;42770;42916.57083429157;3781.3949768037255;3858.787766672832;4399.076193999264;4506.954930450686;4553.726776393427;31874;32300.838495807606;32389.51415728766;32445.351092978246;33308;4295.4201182840225;4326;4326.156399502099;4330.30715085588;4413.205622987861;294214;295711;296958.99999999785;297683;297839;45368.3194752079;45646.771766140955;45694.314585281245;60329.39670603238;61277;43215.78392108082;43539.78230108829;43721;43815.56184438179;43838;16442.917785410995;16670.916645416695;16683.748718846135;16694;16759.497215083324;13443.386793584637;13608.047436679535;13649.249291288876;13650.044496885122;13693.657658558417;15358.923205384124;15457.149856757986;15546.84453155454;15574.688506229812;15640.687186256211;5875.500582450454;5892.145638882338;6106.145139680449;6142.976350490436;6209.720562574695;1007.1640538353149;1093.092733031582;1099.5491848342301;1111.366521082991;1159.0785325666116;30871.382572348426;31022.689773102433;31206.063818085495;31406.685933140376;31825.84087079596;1073.9301945373525;1110.5946329589804;1131.2929419113054;1150.3558007515817;1209.0992210803008;15949.601259968362;16190.67618647644;16209.432669856498;16223.107729075015;16419.096949667644;340150;492637;499477;521736;525086;55002.44997549973;55905.440945590024;55918;55940.16089758657;56102.43897561054;1499.6250937265684;1524.6188452886556;1535.8848086393566;1536.0322996512125;1546.891717579781;28008;28668.713312866603;29219.561706574845;30754.538681920236;31276.218094547818;48964.75517622389;49493.50506494889;49702.502974971234;49851.501484984685;49938.50061499338;315905;323253;323388;323785;324819;34317;34493.550644935305;34924.47613285752;34955.30089398147;35100.824495878376;45873.77063114663;46272;46710;46818.76590617025;47326;46071.308930366744;46335.536644633125;47579.52420475751;47673;47940;41139.382909255786;41523;42290;44509.554904451834;45199.32201016921;43856.56143438525;44463.33305000492;44482.55517444784;45499;45540;42492;43347.783261083496;43881.56118438775;44300;44535.55464445314;29638.703612963593;30209.848950755106;30293.84853075809;30325.393492130475;30419 18:00:55 INFO - PROCESS | 3418 | |2;jquery.html;368.11101190624635;379.93920972644366;384.5155104568243;397.9761214327141;400.47537725579474;17515.912420437897;18688.813111868876;18817.965011924338;19336;19380.903095484522;12627.62117136485;12799.424025918832;12938.288394138319;12955.546555870524;13039.934800325986;5088.542031217199;5377.4084850666395;5765.884682306351;5805.970970145165;5821.796237131702;5675.971620141893;5768.134779783024;5776.682282474462;5779.046457334556;5786.9710651446685;5238.8690282742855;5254.710990895499;5257.13257312543;5327.067763141435;5749.683767392792;5203.19350500673;5219.164933610604;5227.973860130694;5239.895202095937;5247.449017853109;4994.225894986283;5020.497950204986;5030.673006254582;5057.797688092509;5073.315102461194;13553.796693049611;13724.176549406968;13745.518906838213;13854.722905541934;18420.631587368178;2225.9554808903895;2245.5621153875;2271.806896413807;2359.8466099703464;2360.268316821791;9885.406875587487;9932.702018939442;10157.187425005981;10194.388336699747;10379.42913139777;1840.4202676156967;1894.5642502224428;1941.669916114264;1978.4064780565773;2005.6991451282279;65034.67482662557;69013.65493172553;69781.65109174473;70966.64516677486;71264.64367678181;10502.842457363146;10526.947365263124;10547.525361358757;10690.893091069145;10717.946410268054;15051.698966020618;15118.470853520073;15136.318865651072;15176.392944282326;15188.088714677155;7702.229777022253;7848.254415830487;7866;7897.24976127267;7935.246151615587;7516.6993320267675;7528.548287102792;7577.052868391451;7586.051743532059;7592.354649854714;4583.449986001635;4683.063387322549;4778.761061946958;4783.162946484351;4832.130216560982;1934.1006432009183;1936.6998115292151;1962.2151139544012;2003.6894281386408;2032.5020370009147;943.688582767685;979.3389462113046;1021.2034613001871;1045.0803293102022;1076.9892301077045;17676.89538740726;17783.822161778477;17944.730829037573;18057.187426565837;18610.255589776258;960.870282511852;979.5249304087512;988.9901100989042;1008.8940661230612;1059.5761695321778;10183.13443357323;10324.587016519255;10406.167506599453;10466.372017678963;10520.421376824348;458678;468258;474818;475337;483511;65628;71370;73110;75067.62466187634;81302.59348703218;1050.0916707048348;1111.8888111188817;1149.1036991146918;1153.4751687982116;1155.3876445483907;16300.184990750653;16444.424445144363;16562.089085100437;16665.416710415077;16884.24020919037;35193.24033798351;36057.27885442224;36194.63805361913;36974.445383318736;36975;48695.26957095575;53472;53706.73146634242;53713.46286537241;53932.19101713399;8513.19124683154;8523.82952340962;8526.190011948855;8668.26319762802;8775.91224087751;9870.654527091518;13152.473901043852;13263.270520121487;13358.064935454813;13383.732325353243;10940.835887461853;11044.282121662067;11196.38419886914;11207;11849.822252666045;11938.164328497269;11988.820167697317;12121.69695757613;12139.104676418054;12316.692082698004;11715.531378744754;11867;12045.698857528281;12419.875801242233;12582.433790479266;8210.384221183554;8438.198371154731;8501.489910605384;8733.91266087331;8774;9063.456192628464;11075.224734268846;11756.58851940178;11756.882431175578;11814.232074915102 18:00:55 INFO - PROCESS | 3418 | |3;mootools.html;1570.6780110077436;1621.9918900405496;1873.6065426260484;1927.315802889975;1971.8718283311593;7529.698812047512;8330.541820199887;8448.788780280489;8653.30773538117;8721.040685524595;8358.205970432815;8399.874001889977;8458.492490450577;8469.068402475723;8510;2438.4757277185404;2447.302518782147;2458.9508209835794;2466.2724496273554;2467.679201703776;2442.2306973303444;2471.9011239550396;2472.81453890958;2489.8381605195605;2489.8630575318352;2470.5305991861487;2485.1177831869695;2542.084849454195;2548.923532294034;2551.9744802552013;2486.5648511510503;2490.489449662833;2495.5508008558454;2503.0613519930025;2514.371407148213;2470.8641024743633;2472.8021758259297;2477.6531285620026;2481.950360992788;2509.2346834215555;8615.138486151398;8620.310375170035;8628;8651.351148663813;8658.090900455487;5224.39919409269;5391.595630327702;5393.352797664266;5403.918941215885;5418.91871621926;3305.1076209423563;3309.271960168759;3337.182390314364;3341.7159541439005;3361.159710072482;981.316100465227;1006.4716024087339;1015.8831734350571;1042.2027149230844;1047.8375851742992;12196.39018049103;12238.571649992207;12267.57063502773;12341.074419418579;12383.071269654722;4656.3946686930485;4724.196886529298;4808.422989241313;4854.247591623304;4871.634627402888;10179.440130792878;10281.897181028244;10330.638427654996;10346.172306215485;10364.274500785023;5419.485148910847;5420.647657902303;5454.563634909197;5461.9453805462235;5462.481064298885;4222;4816.397950256218;4895.779689913962;4898.191798353232;4930.383702037246;4033.7176397651883;4038.7374820636564;4040.4343391925154;4049.0889549851636;4071.816768245436;1307.1046333261745;1334.5996201139812;1340.249460302234;1342.9865701343058;1343.4894739998738;1238.68413554543;1468.7943687883705;1489;1505.7816616590533;1509.5169545745257;8173.223543763333;8277.710280140167;8327.167283271745;8385.035720892054;8405.243528082501;1163.3601519164426;1242.6085782978332;1261.9116661833584;1269.2321145706715;1291.1736488647273;6477.4170324671;6525.608463492205;6555.410013098749;6569.408753212138;6584.835379115465;9986.800263994679;10301.278910476345;10411.479426028669;10432.478376081166;10494.370337779757;10131.746706332253;10136.645217417356;10187.796244075076;10267.897321026843;10351.844722329171;8100.270975612106;8226.547539885243;8265.049519305237;8308.501489910625;8342.124076971952;7931;7932.365410767009;8032.678692852221;8071.556064416513;8165.550894700848;9079.273658107204;9291.48896810682;9335;9484.762880928032;9563.043695630382;9453.298406286935;9587.808243834945;9619.663311784054;9661.13049825519;9777.41335519871;6535.869282614416;6778.762743303961;7003.789886303419;7162.283771622796;7267.890981635174;8127.959360203161;8194.67221311141;8208.630611622371;8219.835603287782;8250.793730156794;7324.926750732425;7505.774826755206;7536.208698086842;7635.923640763522;7643.808904777425;7577.848443031219;7609.809754756176;7631;7699.307062364414;7778.49439786412;7338.889916651147;7411.888821667571;7428.294312040348;7429.628518574158;7479.925200747923;7096.219415864148;7186.89219661695;7272.854542909218;7280;7301.160366557914;7208.7116515340895;7229.674664640209;7278.454115941219;7331.010313607808;7340.779776606711 18:00:55 INFO - PROCESS | 3418 | |4;prototype.html;360.3082082401789;362.3568166504454;364.42057129164624;368.94834723138763;370.8590735520502;6372.012338087598;6382.138411314471;6398.040293955909;6399.520035997301;6408.198975128109;6212;6316.968415157918;6336.524760642958;6338.144350512691;6349.7142628581705;4738.265568836836;4877.5366340197625;4879.731614761186;4887.706737595738;4897.142999975008;4835.806567737286;4855.32025516428;4862.659613827033;4881.316615673809;4898.191798353268;4802.03959208158;4821.662483626147;4822.228443449048;4828.517148285161;4840.733759643218;4835.564799168092;4845.903081938359;4846.030793841228;4849.684770489906;4857.805687772485;4241.066965267636;4246.745195288293;4246.766427846467;4248.490181178247;4256.255155347832;5932.614380065282;6078.149059131725;6085.026395776655;6086.969565152191;6094.299155597118;5587.245721827542;5605.971970140124;5606.55147588192;5608.747606357723;5612.214289999403;6671.5997040177745;6705.396514313735;6720.630365329905;6732.865342693168;6752.704080612615;4598.678092533524;4598.79305431253;4602.05657840142;4604.240300350438;4610.492845786961;7014.22843487216;7063.293670632947;7083.504154709172;7090.468214883853;7097.21930587635;4739.336492890998;4793.209120495079;4833.05755377698;4833.589144922651;4850.854474365775;4849.321095046696;4873;4874.488178741181;4877.853664390074;4878.463369029404;5585.58108141891;5609.5792815539;5610.49505544503;5620.100783874561;5629.437056294338;6748.527603067738;6798.456123510107;6803.421709154678;6808.557443766139;6810.046593476917;1682.3270691723408;1728.9049102299493;1735.8264173582793;1738.2178019890846;1739.7129473636962;1091.6997825598023;1135.6763322453062;1142.1490989212923;1143.9313641181388;1153.5501154549731;6446.645434501053;6464.515161362917;6469.902951455732;6486.67566621667;6491.285958544557;6948.5483443576;6975.755848545276;6984.092068031124;7000.649967501707;7017.228104908456;6224.439800417984;6365.649889256043;6449.355064493513;6480.611163330215;6538.509611779135;3797.6392242736897;3831.6934645228316;3834.4631751554803;3837.2517359114704;3840.327942610088;7192.928070719226;7204.0994875640545;7283.854322913512;7291.781246562611;7326.194118646945;7185.2814718527725;7195.89206161908;7200.711971521186;7232.20445750967;7232.349088582053;7057.647117644097;7202.819929501699;7273.818154546073;7294;7331.963340183265;7035.5426897253565;7081.504294699527;7085.610291434021;7092.822679433056;7093.255208203064;7009.193942696451;7019.333163349474;7023.543469674455;7049.929500704928;7055.400290975324;7350.411967042731;7377.225391333833;7382.5570465772225;7409.629518523944;7416.480846340704;4674.22875225584;4787.40157480315;4816.325714399917;4839.467658557626;4860.562549370432;6953;6986.196587392515;6996.825079373057;7004.824879377852;7010.404115650227;6734.528582999143;6813.386795188457;6817.079694241413;6821.3178682133375;6822.965885170741;6735.898961515679;6823.931760682528;6827.658617069027;6836.316368363124;6839.726410943706;6587.110740050032;6694.59832410057;6724.361185687352;6755.729770809309;6762.797116086525;6877.346652068046;6896.2069362022;6911.274316196727;6914.861702765816;6917.446604271747;6727.428168605527;6752.763653272112;6755.324467553205;6761.256261811099;6766.932330676827 18:00:55 INFO - PROCESS | 3418 | |5;yui.html;801.5110782422721;807.8545861744888;894.3739382432299;923.9538023098844;936.1714882329139;13253.33733313333;13322.866771332283;13394.196348219102;13411.128276662022;13495.190288582691;13357.265350405723;13504.864951350484;13523.256220907846;13585.728285434285;13593.59219223425;759.6809340077181;914.0813482450145;917.3532659475054;937.8218138553688;942.4204114469586;935.2798345274169;936.6113063078848;941.1529623338981;944.3767113704956;944.84882418813;983.9704808855746;987.2496902354227;992.9751756206117;993.8260804359209;994.900509949003;980.2109302011878;988.5847943863558;991.4546999150439;991.4646091110827;993.4734590666922;727.7052793618593;730.6675462664475;732.9486935914488;733.9669714862844;734.988975165373;13598.32008399576;13602.455901763917;13607.115537490032;13625.863741362558;13681.179129252178;13552.322383880766;13704.24626645534;13810.792838107436;13853.238071906042;13862;11465.770684586261;11569.479373428216;11571.826422603668;11584;11658.125640576991;3776.169242766587;3819.4461803038403;3831.3103641344546;3832.6358995895343;3866.149447121629;50197.498025019646;50314.74842625763;50439.49560504421;50493.49506504925;50734;10282.383057016603;10588.205884558534;11352.262102963281;11367.658970230907;11394.3163410194;20075.899620501805;20095.296664616668;20290.188392464137;20310.492237694176;20371.185152594026;7022.6488675566015;7544.0192774938905;7606.505577137468;7701.268379503938;7808.726694565663;4136.358864376027;4136.607022332873;4147.108371700099;4237.25847976609;4237.343211802176;3328.1180487170436;3339.7996120232865;3345.43127668297;3385.069105995871;3394.35507253621;617.5985609353955;628.5725706519519;631.7094136697079;635.3487675132933;635.6916895305773;712.4158190284021;718.964051797408;726.556800351785;731.0678884422404;732.9340359367683;8414.579271036424;8471.19523645265;8488.448250863798;8490.830183396298;8675.436096653697;692.764460083574;694.8957656351588;698.8811901976676;699.9860002799916;706.8762966480846;3893;3991.560928297885;4086.7547947123267;4087.8569250076102;4119.279126152911;59833.70083149557;60116;60480.69759651262;61014.389856101756;61023.08465373023;51802.740986294826;51963;52074.21888671673;52689;52713.7364313176;48639;52195.21707174395;52325.47674523206;52397.47602524002;52616.47383526116;8702.608382622924;8703.129687031245;8771.035186129648;8818.338624603051;8820.162084601952;35870.64129358673;36205.81897090498;36686.816565917;37044.07389815276;37120.25759484741;41871.37192942047;43922;45882.54117458783;46245.30632040589;46376.30435543537;12220.633380998584;12593.811092833432;12757.872421275668;12912.741745164856;13224.867751322749;11863.169578129447;12037.097217708882;12353.073519486254;12363.69090772738;12446;11240.156988225752;11269.436528173723;11336.093112551142;11386.373749443861;11455.255408398427;11487.597934072268;11646;11671.183017188716;11792.115591330856;11817.468213930566;10491.475426228812;11861;11965.341906195243;12015.819762703391;12197.207181533173;9904.653337133166;10260.384376937407;10350.275480716278;10383.532741026824;10442.68671939843;9736.269779766404;9766.121049105615;10022.098011179029;10059.29584929048;10079.294449388472 18:00:55 INFO - PROCESS | 3418 | __end_tp_report 18:00:55 INFO - PROCESS | 3418 | __start_cc_report 18:00:55 INFO - PROCESS | 3418 | _x_x_mozilla_cycle_collect,334 18:00:55 INFO - PROCESS | 3418 | __end_cc_report 18:00:55 INFO - PROCESS | 3418 | __startTimestamp1461200455618__endTimestamp 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | ------- Summary: start ------- 18:00:55 INFO - PROCESS | 3418 | Number of tests: 6 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | [#0] dojo.html Cycles:165 Average:5483.03 Median:5715.20 stddev:598.29 (10.5%) stddev-sans-first:575.75 18:00:55 INFO - PROCESS | 3418 | Values: 3328.3 3354.2 3375.3 3380.9 3397.5 5418.5 5457.8 5458.6 5487.3 5504.4 5374.6 5477.7 5483.3 5491.5 5534.7 4952.1 5001.5 5057.4 5086.9 5101.6 4870.4 4991.3 5075.1 5081.8 5169.2 5084.9 5119.5 5123.3 5143.0 5147.3 5069.6 5120.7 5136.9 5146.9 5167.8 4928.5 4967.9 5010.3 5029.3 5050.5 5253.2 5272.1 5273.7 5283.2 5284.4 5849.8 5864.3 5871.0 5880.6 5899.5 5766.5 5874.8 5903.6 5908.2 5949.9 5469.7 5495.2 5503.1 5523.9 5530.0 5881.5 5972.1 6005.0 6037.5 6038.3 5827.2 5842.3 5856.4 5858.3 5882.5 5935.9 5967.5 5974.6 5980.3 5985.0 5745.2 5906.5 5910.3 5944.3 5944.3 5831.2 5866.0 5867.1 5872.5 5872.8 4456.8 4476.8 4488.7 4498.7 4515.7 4022.5 4029.2 4049.8 4069.3 4080.9 5364.2 5528.9 5565.4 5618.1 5683.8 5929.1 5943.7 5945.3 5946.8 5951.3 5321.2 5497.5 5549.6 5575.4 5581.9 5093.7 5123.8 5126.6 5137.9 5145.5 6060.7 6065.3 6089.9 6097.0 6106.1 5782.7 5889.4 5928.7 5940.5 5945.7 6100.1 6106.7 6111.1 6111.4 6139.9 5883.6 5890.9 5893.4 5895.2 5896.2 5727.6 5937.4 5963.8 5993.9 6016.2 5686.7 5711.1 5722.6 5731.2 5745.5 5715.2 5732.8 5734.2 5734.8 5754.7 5513.6 5665.4 5705.1 5717.5 5722.1 5791.0 5802.9 5831.2 5858.4 5874.6 5519.7 5692.5 5730.8 5740.4 5754.8 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | [#1] ext.html Cycles:180 Average:53542.06 Median:42908.96 stddev:99098.60 (231.0%) stddev-sans-first:99296.68 18:00:55 INFO - PROCESS | 3418 | Values: 536.9 563.4 582.7 592.6 609.4 30748.5 38549.2 38887.3 39008.4 39142.0 42272.0 42567.0 42774.6 42857.0 42901.4 8667.7 8904.4 8932.3 8940.0 8964.1 8953.9 9108.7 9141.8 9217.5 9239.9 9140.7 9259.9 9262.0 9267.5 9277.4 9105.9 9210.7 9221.9 9222.7 9224.9 8852.3 9037.9 9106.2 9115.3 9120.6 41995.4 42595.8 42711.0 42770.0 42916.6 3781.4 3858.8 4399.1 4507.0 4553.7 31874.0 32300.8 32389.5 32445.4 33308.0 4295.4 4326.0 4326.2 4330.3 4413.2 294214.0 295711.0 296959.0 297683.0 297839.0 45368.3 45646.8 45694.3 60329.4 61277.0 43215.8 43539.8 43721.0 43815.6 43838.0 16442.9 16670.9 16683.7 16694.0 16759.5 13443.4 13608.0 13649.2 13650.0 13693.7 15358.9 15457.1 15546.8 15574.7 15640.7 5875.5 5892.1 6106.1 6143.0 6209.7 1007.2 1093.1 1099.5 1111.4 1159.1 30871.4 31022.7 31206.1 31406.7 31825.8 1073.9 1110.6 1131.3 1150.4 1209.1 15949.6 16190.7 16209.4 16223.1 16419.1 340150.0 492637.0 499477.0 521736.0 525086.0 55002.4 55905.4 55918.0 55940.2 56102.4 1499.6 1524.6 1535.9 1536.0 1546.9 28008.0 28668.7 29219.6 30754.5 31276.2 48964.8 49493.5 49702.5 49851.5 49938.5 315905.0 323253.0 323388.0 323785.0 324819.0 34317.0 34493.6 34924.5 34955.3 35100.8 45873.8 46272.0 46710.0 46818.8 47326.0 46071.3 46335.5 47579.5 47673.0 47940.0 41139.4 41523.0 42290.0 44509.6 45199.3 43856.6 44463.3 44482.6 45499.0 45540.0 42492.0 43347.8 43881.6 44300.0 44535.6 29638.7 30209.8 30293.8 30325.4 30419.0 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | [#2] jquery.html Cycles:180 Average:26772.95 Median:18776.75 stddev:77404.79 (412.2%) stddev-sans-first:77596.54 18:00:55 INFO - PROCESS | 3418 | Values: 368.1 379.9 384.5 398.0 400.5 17515.9 18688.8 18818.0 19336.0 19380.9 12627.6 12799.4 12938.3 12955.5 13039.9 5088.5 5377.4 5765.9 5806.0 5821.8 5676.0 5768.1 5776.7 5779.0 5787.0 5238.9 5254.7 5257.1 5327.1 5749.7 5203.2 5219.2 5228.0 5239.9 5247.4 4994.2 5020.5 5030.7 5057.8 5073.3 13553.8 13724.2 13745.5 13854.7 18420.6 2226.0 2245.6 2271.8 2359.8 2360.3 9885.4 9932.7 10157.2 10194.4 10379.4 1840.4 1894.6 1941.7 1978.4 2005.7 65034.7 69013.7 69781.7 70966.6 71264.6 10502.8 10526.9 10547.5 10690.9 10717.9 15051.7 15118.5 15136.3 15176.4 15188.1 7702.2 7848.3 7866.0 7897.2 7935.2 7516.7 7528.5 7577.1 7586.1 7592.4 4583.4 4683.1 4778.8 4783.2 4832.1 1934.1 1936.7 1962.2 2003.7 2032.5 943.7 979.3 1021.2 1045.1 1077.0 17676.9 17783.8 17944.7 18057.2 18610.3 960.9 979.5 989.0 1008.9 1059.6 10183.1 10324.6 10406.2 10466.4 10520.4 458678.0 468258.0 474818.0 475337.0 483511.0 65628.0 71370.0 73110.0 75067.6 81302.6 1050.1 1111.9 1149.1 1153.5 1155.4 16300.2 16444.4 16562.1 16665.4 16884.2 35193.2 36057.3 36194.6 36974.4 36975.0 48695.3 53472.0 53706.7 53713.5 53932.2 8513.2 8523.8 8526.2 8668.3 8775.9 9870.7 13152.5 13263.3 13358.1 13383.7 10940.8 11044.3 11196.4 11207.0 11849.8 11938.2 11988.8 12121.7 12139.1 12316.7 11715.5 11867.0 12045.7 12419.9 12582.4 8210.4 8438.2 8501.5 8733.9 8774.0 9063.5 11075.2 11756.6 11756.9 11814.2 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | [#3] mootools.html Cycles:180 Average:6052.40 Median:5398.64 stddev:3137.78 (58.1%) stddev-sans-first:3128.50 18:00:55 INFO - PROCESS | 3418 | Values: 1570.7 1622.0 1873.6 1927.3 1971.9 7529.7 8330.5 8448.8 8653.3 8721.0 8358.2 8399.9 8458.5 8469.1 8510.0 2438.5 2447.3 2459.0 2466.3 2467.7 2442.2 2471.9 2472.8 2489.8 2489.9 2470.5 2485.1 2542.1 2548.9 2552.0 2486.6 2490.5 2495.6 2503.1 2514.4 2470.9 2472.8 2477.7 2482.0 2509.2 8615.1 8620.3 8628.0 8651.4 8658.1 5224.4 5391.6 5393.4 5403.9 5418.9 3305.1 3309.3 3337.2 3341.7 3361.2 981.3 1006.5 1015.9 1042.2 1047.8 12196.4 12238.6 12267.6 12341.1 12383.1 4656.4 4724.2 4808.4 4854.2 4871.6 10179.4 10281.9 10330.6 10346.2 10364.3 5419.5 5420.6 5454.6 5461.9 5462.5 4222.0 4816.4 4895.8 4898.2 4930.4 4033.7 4038.7 4040.4 4049.1 4071.8 1307.1 1334.6 1340.2 1343.0 1343.5 1238.7 1468.8 1489.0 1505.8 1509.5 8173.2 8277.7 8327.2 8385.0 8405.2 1163.4 1242.6 1261.9 1269.2 1291.2 6477.4 6525.6 6555.4 6569.4 6584.8 9986.8 10301.3 10411.5 10432.5 10494.4 10131.7 10136.6 10187.8 10267.9 10351.8 8100.3 8226.5 8265.0 8308.5 8342.1 7931.0 7932.4 8032.7 8071.6 8165.6 9079.3 9291.5 9335.0 9484.8 9563.0 9453.3 9587.8 9619.7 9661.1 9777.4 6535.9 6778.8 7003.8 7162.3 7267.9 8128.0 8194.7 8208.6 8219.8 8250.8 7324.9 7505.8 7536.2 7635.9 7643.8 7577.8 7609.8 7631.0 7699.3 7778.5 7338.9 7411.9 7428.3 7429.6 7479.9 7096.2 7186.9 7272.9 7280.0 7301.2 7208.7 7229.7 7278.5 7331.0 7340.8 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | [#4] prototype.html Cycles:180 Average:5676.60 Median:6403.86 stddev:1722.99 (26.9%) stddev-sans-first:1680.98 18:00:55 INFO - PROCESS | 3418 | Values: 360.3 362.4 364.4 368.9 370.9 6372.0 6382.1 6398.0 6399.5 6408.2 6212.0 6317.0 6336.5 6338.1 6349.7 4738.3 4877.5 4879.7 4887.7 4897.1 4835.8 4855.3 4862.7 4881.3 4898.2 4802.0 4821.7 4822.2 4828.5 4840.7 4835.6 4845.9 4846.0 4849.7 4857.8 4241.1 4246.7 4246.8 4248.5 4256.3 5932.6 6078.1 6085.0 6087.0 6094.3 5587.2 5606.0 5606.6 5608.7 5612.2 6671.6 6705.4 6720.6 6732.9 6752.7 4598.7 4598.8 4602.1 4604.2 4610.5 7014.2 7063.3 7083.5 7090.5 7097.2 4739.3 4793.2 4833.1 4833.6 4850.9 4849.3 4873.0 4874.5 4877.9 4878.5 5585.6 5609.6 5610.5 5620.1 5629.4 6748.5 6798.5 6803.4 6808.6 6810.0 1682.3 1728.9 1735.8 1738.2 1739.7 1091.7 1135.7 1142.1 1143.9 1153.6 6446.6 6464.5 6469.9 6486.7 6491.3 6948.5 6975.8 6984.1 7000.6 7017.2 6224.4 6365.6 6449.4 6480.6 6538.5 3797.6 3831.7 3834.5 3837.3 3840.3 7192.9 7204.1 7283.9 7291.8 7326.2 7185.3 7195.9 7200.7 7232.2 7232.3 7057.6 7202.8 7273.8 7294.0 7332.0 7035.5 7081.5 7085.6 7092.8 7093.3 7009.2 7019.3 7023.5 7049.9 7055.4 7350.4 7377.2 7382.6 7409.6 7416.5 4674.2 4787.4 4816.3 4839.5 4860.6 6953.0 6986.2 6996.8 7004.8 7010.4 6734.5 6813.4 6817.1 6821.3 6823.0 6735.9 6823.9 6827.7 6836.3 6839.7 6587.1 6694.6 6724.4 6755.7 6762.8 6877.3 6896.2 6911.3 6914.9 6917.4 6727.4 6752.8 6755.3 6761.3 6766.9 18:00:55 INFO - PROCESS | 3418 | 18:00:55 INFO - PROCESS | 3418 | [#5] yui.html Cycles:180 Average:14468.92 Median:23054.32 stddev:16721.90 (72.5%) stddev-sans-first:16737.31 18:00:55 INFO - PROCESS | 3418 | Values: 801.5 807.9 894.4 924.0 936.2 13253.3 13322.9 13394.2 13411.1 13495.2 13357.3 13504.9 13523.3 13585.7 13593.6 759.7 914.1 917.4 937.8 942.4 935.3 936.6 941.2 944.4 944.8 984.0 987.2 993.0 993.8 994.9 980.2 988.6 991.5 991.5 993.5 727.7 730.7 732.9 734.0 735.0 13598.3 13602.5 13607.1 13625.9 13681.2 13552.3 13704.2 13810.8 13853.2 13862.0 11465.8 11569.5 11571.8 11584.0 11658.1 3776.2 3819.4 3831.3 3832.6 3866.1 50197.5 50314.7 50439.5 50493.5 50734.0 10282.4 10588.2 11352.3 11367.7 11394.3 20075.9 20095.3 20290.2 20310.5 20371.2 7022.6 7544.0 7606.5 7701.3 7808.7 4136.4 4136.6 4147.1 4237.3 4237.3 3328.1 3339.8 3345.4 3385.1 3394.4 617.6 628.6 631.7 635.3 635.7 712.4 719.0 726.6 731.1 732.9 8414.6 8471.2 8488.4 8490.8 8675.4 692.8 694.9 698.9 700.0 706.9 3893.0 3991.6 4086.8 4087.9 4119.3 59833.7 60116.0 60480.7 61014.4 61023.1 51802.7 51963.0 52074.2 52689.0 52713.7 48639.0 52195.2 52325.5 52397.5 52616.5 8702.6 8703.1 8771.0 8818.3 8820.2 35870.6 36205.8 36686.8 37044.1 37120.3 41871.4 43922.0 45882.5 46245.3 46376.3 12220.6 12593.8 12757.9 12912.7 13224.9 11863.2 12037.1 12353.1 12363.7 12446.0 11240.2 11269.4 11336.1 11386.4 11455.3 11487.6 11646.0 11671.2 11792.1 11817.5 10491.5 11861.0 11965.3 12015.8 12197.2 9904.7 10260.4 10350.3 10383.5 10442.7 9736.3 9766.1 10022.1 10059.3 10079.3 18:00:55 INFO - PROCESS | 3418 | -------- Summary: end -------- 18:00:55 INFO - PROCESS | 3418 | 18:00:56 INFO - TEST-INFO | 3418: exit 0 18:00:56 INFO - TEST-OK | dromaeo_css | took 1110564ms 18:00:56 INFO - TEST-START | kraken 18:00:56 INFO - operating with platform_type : linux_ 18:00:56 INFO - Initialising browser for kraken test... 18:00:56 INFO - TEST-INFO | started process 3660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1WAE7k/profile http://localhost:60947/getInfo.html) 18:00:59 INFO - PROCESS | 3660 | 18:00:59 INFO - PROCESS | 3660 | (process:3735): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:01:00 INFO - PROCESS | 3660 | __metrics Screen width/height:1600/1200 18:01:00 INFO - PROCESS | 3660 | colorDepth:24 18:01:00 INFO - PROCESS | 3660 | Browser inner width/height: 1024/697 18:01:00 INFO - PROCESS | 3660 | __metrics 18:01:01 ERROR - PROCESS | 3660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:01:02 INFO - TEST-INFO | 3660: exit 0 18:01:02 INFO - Browser initialized. 18:01:02 INFO - Running cycle 1/1 for kraken test... 18:01:02 INFO - TEST-INFO | started process 3786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1WAE7k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:04 INFO - PROCESS | 3786 | 18:01:04 INFO - PROCESS | 3786 | (process:3852): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:01:14 INFO - PROCESS | 3786 | RSS: Main: 151687168 18:01:14 INFO - PROCESS | 3786 | 18:01:16 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60947/tests/kraken/driver.html?testName=audio-beat-detection) 18:01:17 INFO - PROCESS | 3786 | RSS: Main: 155938816 18:01:17 INFO - PROCESS | 3786 | 18:01:20 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60947/tests/kraken/driver.html?testName=audio-dft) 18:01:20 INFO - PROCESS | 3786 | RSS: Main: 155885568 18:01:20 INFO - PROCESS | 3786 | 18:01:23 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60947/tests/kraken/driver.html?testName=audio-fft) 18:01:24 INFO - PROCESS | 3786 | RSS: Main: 156397568 18:01:24 INFO - PROCESS | 3786 | 18:01:26 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60947/tests/kraken/driver.html?testName=audio-oscillator) 18:01:26 INFO - PROCESS | 3786 | RSS: Main: 156807168 18:01:26 INFO - PROCESS | 3786 | 18:01:29 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:01:29 INFO - PROCESS | 3786 | RSS: Main: 156295168 18:01:29 INFO - PROCESS | 3786 | 18:01:32 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60947/tests/kraken/driver.html?testName=imaging-darkroom) 18:01:33 INFO - PROCESS | 3786 | RSS: Main: 156528640 18:01:33 INFO - PROCESS | 3786 | 18:01:36 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60947/tests/kraken/driver.html?testName=imaging-desaturate) 18:01:37 INFO - PROCESS | 3786 | RSS: Main: 156487680 18:01:37 INFO - PROCESS | 3786 | 18:01:40 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60947/tests/kraken/driver.html?testName=json-parse-financial) 18:01:40 INFO - PROCESS | 3786 | RSS: Main: 156721152 18:01:40 INFO - PROCESS | 3786 | 18:01:42 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:42 INFO - PROCESS | 3786 | RSS: Main: 156643328 18:01:42 INFO - PROCESS | 3786 | 18:01:44 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:45 INFO - PROCESS | 3786 | RSS: Main: 157282304 18:01:45 INFO - PROCESS | 3786 | 18:01:48 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:01:48 INFO - PROCESS | 3786 | RSS: Main: 157089792 18:01:48 INFO - PROCESS | 3786 | 18:01:51 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:01:51 INFO - PROCESS | 3786 | RSS: Main: 157642752 18:01:51 INFO - PROCESS | 3786 | 18:01:54 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:01:54 INFO - PROCESS | 3786 | RSS: Main: 157618176 18:01:54 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | Cycle 1(1): loaded http://localhost:60947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60947/tests/kraken/driver.html?testName=ai-astar) 18:01:56 INFO - PROCESS | 3786 | RSS: Main: 159277056 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | __start_tp_report 18:01:56 INFO - PROCESS | 3786 | _x_x_mozilla_page_load 18:01:56 INFO - PROCESS | 3786 | _x_x_mozilla_page_load_details 18:01:56 INFO - PROCESS | 3786 | |i|pagename|runs| 18:01:56 INFO - PROCESS | 3786 | |0;ai-astar;113;106;111;109;111;122;111;111;111;110 18:01:56 INFO - PROCESS | 3786 | |1;audio-beat-detection;151;128;158;176;128;156;156;129;176;127 18:01:56 INFO - PROCESS | 3786 | |2;audio-dft;163;163;163;162;162;161;161;160;165;163 18:01:56 INFO - PROCESS | 3786 | |3;audio-fft;76;76;77;167;76;73;74;74;159;76 18:01:56 INFO - PROCESS | 3786 | |4;audio-oscillator;92;94;148;92;93;94;145;92;93;143 18:01:56 INFO - PROCESS | 3786 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;117;117 18:01:56 INFO - PROCESS | 3786 | |6;imaging-darkroom;147;146;147;149;149;147;147;147;147;146 18:01:56 INFO - PROCESS | 3786 | |7;imaging-desaturate;96;96;95;97;97;96;96;96;95;96 18:01:56 INFO - PROCESS | 3786 | |8;json-parse-financial;58;62;63;55;56;55;55;63;53;58 18:01:56 INFO - PROCESS | 3786 | |9;json-stringify-tinderbox;66;64;65;65;65;66;65;65;65;65 18:01:56 INFO - PROCESS | 3786 | |10;stanford-crypto-aes;77;79;80;80;80;79;79;80;81;78 18:01:56 INFO - PROCESS | 3786 | |11;stanford-crypto-ccm;118;126;114;123;115;114;118;118;125;115 18:01:56 INFO - PROCESS | 3786 | |12;stanford-crypto-pbkdf2;137;146;135;136;154;141;149;148;147;135 18:01:56 INFO - PROCESS | 3786 | |13;stanford-crypto-sha256-iterative;67;70;76;72;71;67;66;66;68;65 18:01:56 INFO - PROCESS | 3786 | __end_tp_report 18:01:56 INFO - PROCESS | 3786 | __start_cc_report 18:01:56 INFO - PROCESS | 3786 | _x_x_mozilla_cycle_collect,833 18:01:56 INFO - PROCESS | 3786 | __end_cc_report 18:01:56 INFO - PROCESS | 3786 | __startTimestamp1461200516755__endTimestamp 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | ------- Summary: start ------- 18:01:56 INFO - PROCESS | 3786 | Number of tests: 14 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.33 18:01:56 INFO - PROCESS | 3786 | Values: 113.0 106.0 111.0 109.0 111.0 122.0 111.0 111.0 111.0 110.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:156.00 stddev:19.45 (12.5%) stddev-sans-first:20.61 18:01:56 INFO - PROCESS | 3786 | Values: 151.0 128.0 158.0 176.0 128.0 156.0 156.0 129.0 176.0 127.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 18:01:56 INFO - PROCESS | 3786 | Values: 163.0 163.0 163.0 162.0 162.0 161.0 161.0 160.0 165.0 163.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:37.07 (48.8%) stddev-sans-first:38.81 18:01:56 INFO - PROCESS | 3786 | Values: 76.0 76.0 77.0 167.0 76.0 73.0 74.0 74.0 159.0 76.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.50 stddev:25.39 (27.4%) stddev-sans-first:26.21 18:01:56 INFO - PROCESS | 3786 | Values: 92.0 94.0 148.0 92.0 93.0 94.0 145.0 92.0 93.0 143.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:01:56 INFO - PROCESS | 3786 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 18:01:56 INFO - PROCESS | 3786 | Values: 147.0 146.0 147.0 149.0 149.0 147.0 147.0 147.0 147.0 146.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:01:56 INFO - PROCESS | 3786 | Values: 96.0 96.0 95.0 97.0 97.0 96.0 96.0 96.0 95.0 96.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:3.68 (6.3%) stddev-sans-first:3.90 18:01:56 INFO - PROCESS | 3786 | Values: 58.0 62.0 63.0 55.0 56.0 55.0 55.0 63.0 53.0 58.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 18:01:56 INFO - PROCESS | 3786 | Values: 66.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:1.16 (1.4%) stddev-sans-first:0.88 18:01:56 INFO - PROCESS | 3786 | Values: 77.0 79.0 80.0 80.0 80.0 79.0 79.0 80.0 81.0 78.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.00 stddev:4.53 (3.8%) stddev-sans-first:4.80 18:01:56 INFO - PROCESS | 3786 | Values: 118.0 126.0 114.0 123.0 115.0 114.0 118.0 118.0 125.0 115.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:146.50 stddev:6.86 (4.7%) stddev-sans-first:6.95 18:01:56 INFO - PROCESS | 3786 | Values: 137.0 146.0 135.0 136.0 154.0 141.0 149.0 148.0 147.0 135.0 18:01:56 INFO - PROCESS | 3786 | 18:01:56 INFO - PROCESS | 3786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:3.43 (5.0%) stddev-sans-first:3.57 18:01:56 INFO - PROCESS | 3786 | Values: 67.0 70.0 76.0 72.0 71.0 67.0 66.0 66.0 68.0 65.0 18:01:56 INFO - PROCESS | 3786 | -------- Summary: end -------- 18:01:56 INFO - PROCESS | 3786 | 18:01:57 INFO - TEST-INFO | 3786: exit 0 18:01:57 INFO - TEST-OK | kraken | took 61280ms 18:01:57 INFO - SUITE-END | took 1171s 18:01:57 INFO - Completed test suite (00:19:32) 18:01:57 INFO - javascript benchmark 18:01:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3328.2844188499475, 3354.1782263345467, 3375.3080618473214, 3380.9492857607124, 3397.456406974883, 5418.485243901833, 5457.781688732451, 5458.590605704569, 5487.286652735143, 5504.366997795255, 5374.6237763356585, 5477.698726570037, 5483.259759932408, 5491.450854914507, 5534.723263836812, 4952.083864485082, 5001.499850015006, 5057.443681195065, 5086.949130508703, 5101.566366858821, 4870.43989941156, 4991.251312303148, 5075.111855425286, 5081.79672813087, 5169.198774190007, 5084.898302033957, 5119.488051194888, 5123.333966584339, 5143.0, 5147.253648221005, 5069.61977851659, 5120.743962801864, 5136.897262054738, 5146.922796158024, 5167.819126330579, 4928.482509336504, 4967.90064198714, 5010.2735103409805, 5029.346184995927, 5050.545450909436, 5253.159494480865, 5272.103742363807, 5273.683578985235, 5283.207518872162, 5284.445133261029, 5849.7660093596205, 5864.266966629171, 5871.001929671966, 5880.558958078119, 5899.46904778572, 5766.509846663039, 5874.823755287348, 5903.645781253095, 5908.231929849135, 5949.9107513387335, 5469.671819690831, 5495.230667706524, 5503.11950087984, 5523.889522209573, 5529.972350138264, 5881.470667639933, 5972.134040564094, 6005.0, 6037.516998640098, 6038.30559485656, 5827.184194212814, 5842.328132264759, 5856.355800861902, 5858.297004359419, 5882.529397648178, 5935.910961335583, 5967.522598192134, 5974.641521508724, 5980.282366116007, 5984.970075149597, 5745.2243947067445, 5906.49794767441, 5910.320313164041, 5944.316403613553, 5944.346121926585, 5831.1544826000845, 5866.0, 5867.119932010232, 5872.471477567039, 5872.823815285548, 4456.844010459618, 4476.843310484118, 4488.685791994594, 4498.730076195438, 4515.729056256635, 4022.4770779799023, 4029.174019326031, 4049.7772622506045, 4069.2878746219294, 4080.8979775505254, 5364.249005139283, 5528.861778455571, 5565.387807341189, 5618.129189975561, 5683.8294851153705, 5929.140274660236, 5943.732532036069, 5945.346011938684, 5946.821595352147, 5951.285845698458, 5321.175217841241, 5497.47773961473, 5549.611527193058, 5575.386707462176, 5581.944180558224, 5093.694378337312, 5123.820666276662, 5126.641135120506, 5137.922931156036, 5145.4597267287145, 6060.727267272983, 6065.302490213594, 6089.878202435926, 6097.0, 6106.114613381035, 5782.710864456844, 5889.352171261244, 5928.703564821655, 5940.46535811779, 5945.672987985616, 6100.054491553817, 6106.664133472702, 6111.113888486056, 6111.419415155553, 6139.938600613937, 5883.646981181143, 5890.9116363253725, 5893.410658934244, 5895.233619629421, 5896.23348964649, 5727.599068065196, 5937.376575459687, 5963.821085367446, 5993.880122397615, 6016.2479690038745, 5686.744096515584, 5711.086226203787, 5722.570807189394, 5731.226284451545, 5745.454181852718, 5715.199872018004, 5732.799352022659, 5734.197212390352, 5734.770609175586, 5754.712264386848, 5513.58648101386, 5665.405132461032, 5705.058665320175, 5717.5425965921795, 5722.055860782924, 5791.0, 5802.883942321215, 5831.1544826000845, 5858.355580886185, 5874.559408044499, 5519.724013799374, 5692.516136128475, 5730.770769169187, 5740.425957404226, 5754.827355179351], "unit": "score", "name": "dojo.html", "value": 5445.11733085343}, {"lowerIsBetter": false, "replicates": [536.8738346488577, 563.3549585724346, 582.7319433060793, 592.6384905207823, 609.44236024038, 30748.53877191844, 38549.229015419674, 38887.250073746676, 39008.41487377685, 39142.0, 42272.0, 42567.0, 42774.572254277446, 42857.0, 42901.35647965283, 8667.653293868238, 8904.376693631448, 8932.33007524435, 8940.0, 8964.103589641049, 8953.910460895406, 9108.681196158135, 9141.771455713628, 9217.539123043822, 9239.861402078941, 9140.72577822663, 9259.861102083474, 9261.95369023154, 9267.490288034189, 9277.396969197014, 9105.908940910605, 9210.67762628308, 9221.907780922173, 9222.677206297782, 9224.8616270756, 8852.336074794352, 9037.909620903773, 9106.180443760028, 9115.316351273681, 9120.635174593075, 41995.37006944898, 42595.787021064694, 42711.0, 42770.0, 42916.57083429157, 3781.3949768037255, 3858.787766672832, 4399.076193999264, 4506.954930450686, 4553.726776393427, 31874.0, 32300.838495807606, 32389.51415728766, 32445.351092978246, 33308.0, 4295.4201182840225, 4326.0, 4326.156399502099, 4330.30715085588, 4413.205622987861, 294214.0, 295711.0, 296958.99999999785, 297683.0, 297839.0, 45368.3194752079, 45646.771766140955, 45694.314585281245, 60329.39670603238, 61277.0, 43215.78392108082, 43539.78230108829, 43721.0, 43815.56184438179, 43838.0, 16442.917785410995, 16670.916645416695, 16683.748718846135, 16694.0, 16759.497215083324, 13443.386793584637, 13608.047436679535, 13649.249291288876, 13650.044496885122, 13693.657658558417, 15358.923205384124, 15457.149856757986, 15546.84453155454, 15574.688506229812, 15640.687186256211, 5875.500582450454, 5892.145638882338, 6106.145139680449, 6142.976350490436, 6209.720562574695, 1007.1640538353149, 1093.092733031582, 1099.5491848342301, 1111.366521082991, 1159.0785325666116, 30871.382572348426, 31022.689773102433, 31206.063818085495, 31406.685933140376, 31825.84087079596, 1073.9301945373525, 1110.5946329589804, 1131.2929419113054, 1150.3558007515817, 1209.0992210803008, 15949.601259968362, 16190.67618647644, 16209.432669856498, 16223.107729075015, 16419.096949667644, 340150.0, 492637.0, 499477.0, 521736.0, 525086.0, 55002.44997549973, 55905.440945590024, 55918.0, 55940.16089758657, 56102.43897561054, 1499.6250937265684, 1524.6188452886556, 1535.8848086393566, 1536.0322996512125, 1546.891717579781, 28008.0, 28668.713312866603, 29219.561706574845, 30754.538681920236, 31276.218094547818, 48964.75517622389, 49493.50506494889, 49702.502974971234, 49851.501484984685, 49938.50061499338, 315905.0, 323253.0, 323388.0, 323785.0, 324819.0, 34317.0, 34493.550644935305, 34924.47613285752, 34955.30089398147, 35100.824495878376, 45873.77063114663, 46272.0, 46710.0, 46818.76590617025, 47326.0, 46071.308930366744, 46335.536644633125, 47579.52420475751, 47673.0, 47940.0, 41139.382909255786, 41523.0, 42290.0, 44509.554904451834, 45199.32201016921, 43856.56143438525, 44463.33305000492, 44482.55517444784, 45499.0, 45540.0, 42492.0, 43347.783261083496, 43881.56118438775, 44300.0, 44535.55464445314, 29638.703612963593, 30209.848950755106, 30293.84853075809, 30325.393492130475, 30419.0], "unit": "score", "name": "ext.html", "value": 19804.270484931298}, {"lowerIsBetter": false, "replicates": [368.11101190624635, 379.93920972644366, 384.5155104568243, 397.9761214327141, 400.47537725579474, 17515.912420437897, 18688.813111868876, 18817.965011924338, 19336.0, 19380.903095484522, 12627.62117136485, 12799.424025918832, 12938.288394138319, 12955.546555870524, 13039.934800325986, 5088.542031217199, 5377.4084850666395, 5765.884682306351, 5805.970970145165, 5821.796237131702, 5675.971620141893, 5768.134779783024, 5776.682282474462, 5779.046457334556, 5786.9710651446685, 5238.8690282742855, 5254.710990895499, 5257.13257312543, 5327.067763141435, 5749.683767392792, 5203.19350500673, 5219.164933610604, 5227.973860130694, 5239.895202095937, 5247.449017853109, 4994.225894986283, 5020.497950204986, 5030.673006254582, 5057.797688092509, 5073.315102461194, 13553.796693049611, 13724.176549406968, 13745.518906838213, 13854.722905541934, 18420.631587368178, 2225.9554808903895, 2245.5621153875, 2271.806896413807, 2359.8466099703464, 2360.268316821791, 9885.406875587487, 9932.702018939442, 10157.187425005981, 10194.388336699747, 10379.42913139777, 1840.4202676156967, 1894.5642502224428, 1941.669916114264, 1978.4064780565773, 2005.6991451282279, 65034.67482662557, 69013.65493172553, 69781.65109174473, 70966.64516677486, 71264.64367678181, 10502.842457363146, 10526.947365263124, 10547.525361358757, 10690.893091069145, 10717.946410268054, 15051.698966020618, 15118.470853520073, 15136.318865651072, 15176.392944282326, 15188.088714677155, 7702.229777022253, 7848.254415830487, 7866.0, 7897.24976127267, 7935.246151615587, 7516.6993320267675, 7528.548287102792, 7577.052868391451, 7586.051743532059, 7592.354649854714, 4583.449986001635, 4683.063387322549, 4778.761061946958, 4783.162946484351, 4832.130216560982, 1934.1006432009183, 1936.6998115292151, 1962.2151139544012, 2003.6894281386408, 2032.5020370009147, 943.688582767685, 979.3389462113046, 1021.2034613001871, 1045.0803293102022, 1076.9892301077045, 17676.89538740726, 17783.822161778477, 17944.730829037573, 18057.187426565837, 18610.255589776258, 960.870282511852, 979.5249304087512, 988.9901100989042, 1008.8940661230612, 1059.5761695321778, 10183.13443357323, 10324.587016519255, 10406.167506599453, 10466.372017678963, 10520.421376824348, 458678.0, 468258.0, 474818.0, 475337.0, 483511.0, 65628.0, 71370.0, 73110.0, 75067.62466187634, 81302.59348703218, 1050.0916707048348, 1111.8888111188817, 1149.1036991146918, 1153.4751687982116, 1155.3876445483907, 16300.184990750653, 16444.424445144363, 16562.089085100437, 16665.416710415077, 16884.24020919037, 35193.24033798351, 36057.27885442224, 36194.63805361913, 36974.445383318736, 36975.0, 48695.26957095575, 53472.0, 53706.73146634242, 53713.46286537241, 53932.19101713399, 8513.19124683154, 8523.82952340962, 8526.190011948855, 8668.26319762802, 8775.91224087751, 9870.654527091518, 13152.473901043852, 13263.270520121487, 13358.064935454813, 13383.732325353243, 10940.835887461853, 11044.282121662067, 11196.38419886914, 11207.0, 11849.822252666045, 11938.164328497269, 11988.820167697317, 12121.69695757613, 12139.104676418054, 12316.692082698004, 11715.531378744754, 11867.0, 12045.698857528281, 12419.875801242233, 12582.433790479266, 8210.384221183554, 8438.198371154731, 8501.489910605384, 8733.91266087331, 8774.0, 9063.456192628464, 11075.224734268846, 11756.58851940178, 11756.882431175578, 11814.232074915102], "unit": "score", "name": "jquery.html", "value": 8704.78746457434}, {"lowerIsBetter": false, "replicates": [1570.6780110077436, 1621.9918900405496, 1873.6065426260484, 1927.315802889975, 1971.8718283311593, 7529.698812047512, 8330.541820199887, 8448.788780280489, 8653.30773538117, 8721.040685524595, 8358.205970432815, 8399.874001889977, 8458.492490450577, 8469.068402475723, 8510.0, 2438.4757277185404, 2447.302518782147, 2458.9508209835794, 2466.2724496273554, 2467.679201703776, 2442.2306973303444, 2471.9011239550396, 2472.81453890958, 2489.8381605195605, 2489.8630575318352, 2470.5305991861487, 2485.1177831869695, 2542.084849454195, 2548.923532294034, 2551.9744802552013, 2486.5648511510503, 2490.489449662833, 2495.5508008558454, 2503.0613519930025, 2514.371407148213, 2470.8641024743633, 2472.8021758259297, 2477.6531285620026, 2481.950360992788, 2509.2346834215555, 8615.138486151398, 8620.310375170035, 8628.0, 8651.351148663813, 8658.090900455487, 5224.39919409269, 5391.595630327702, 5393.352797664266, 5403.918941215885, 5418.91871621926, 3305.1076209423563, 3309.271960168759, 3337.182390314364, 3341.7159541439005, 3361.159710072482, 981.316100465227, 1006.4716024087339, 1015.8831734350571, 1042.2027149230844, 1047.8375851742992, 12196.39018049103, 12238.571649992207, 12267.57063502773, 12341.074419418579, 12383.071269654722, 4656.3946686930485, 4724.196886529298, 4808.422989241313, 4854.247591623304, 4871.634627402888, 10179.440130792878, 10281.897181028244, 10330.638427654996, 10346.172306215485, 10364.274500785023, 5419.485148910847, 5420.647657902303, 5454.563634909197, 5461.9453805462235, 5462.481064298885, 4222.0, 4816.397950256218, 4895.779689913962, 4898.191798353232, 4930.383702037246, 4033.7176397651883, 4038.7374820636564, 4040.4343391925154, 4049.0889549851636, 4071.816768245436, 1307.1046333261745, 1334.5996201139812, 1340.249460302234, 1342.9865701343058, 1343.4894739998738, 1238.68413554543, 1468.7943687883705, 1489.0, 1505.7816616590533, 1509.5169545745257, 8173.223543763333, 8277.710280140167, 8327.167283271745, 8385.035720892054, 8405.243528082501, 1163.3601519164426, 1242.6085782978332, 1261.9116661833584, 1269.2321145706715, 1291.1736488647273, 6477.4170324671, 6525.608463492205, 6555.410013098749, 6569.408753212138, 6584.835379115465, 9986.800263994679, 10301.278910476345, 10411.479426028669, 10432.478376081166, 10494.370337779757, 10131.746706332253, 10136.645217417356, 10187.796244075076, 10267.897321026843, 10351.844722329171, 8100.270975612106, 8226.547539885243, 8265.049519305237, 8308.501489910625, 8342.124076971952, 7931.0, 7932.365410767009, 8032.678692852221, 8071.556064416513, 8165.550894700848, 9079.273658107204, 9291.48896810682, 9335.0, 9484.762880928032, 9563.043695630382, 9453.298406286935, 9587.808243834945, 9619.663311784054, 9661.13049825519, 9777.41335519871, 6535.869282614416, 6778.762743303961, 7003.789886303419, 7162.283771622796, 7267.890981635174, 8127.959360203161, 8194.67221311141, 8208.630611622371, 8219.835603287782, 8250.793730156794, 7324.926750732425, 7505.774826755206, 7536.208698086842, 7635.923640763522, 7643.808904777425, 7577.848443031219, 7609.809754756176, 7631.0, 7699.307062364414, 7778.49439786412, 7338.889916651147, 7411.888821667571, 7428.294312040348, 7429.628518574158, 7479.925200747923, 7096.219415864148, 7186.89219661695, 7272.854542909218, 7280.0, 7301.160366557914, 7208.7116515340895, 7229.674664640209, 7278.454115941219, 7331.010313607808, 7340.779776606711], "unit": "score", "name": "mootools.html", "value": 4979.521730649745}, {"lowerIsBetter": false, "replicates": [360.3082082401789, 362.3568166504454, 364.42057129164624, 368.94834723138763, 370.8590735520502, 6372.012338087598, 6382.138411314471, 6398.040293955909, 6399.520035997301, 6408.198975128109, 6212.0, 6316.968415157918, 6336.524760642958, 6338.144350512691, 6349.7142628581705, 4738.265568836836, 4877.5366340197625, 4879.731614761186, 4887.706737595738, 4897.142999975008, 4835.806567737286, 4855.32025516428, 4862.659613827033, 4881.316615673809, 4898.191798353268, 4802.03959208158, 4821.662483626147, 4822.228443449048, 4828.517148285161, 4840.733759643218, 4835.564799168092, 4845.903081938359, 4846.030793841228, 4849.684770489906, 4857.805687772485, 4241.066965267636, 4246.745195288293, 4246.766427846467, 4248.490181178247, 4256.255155347832, 5932.614380065282, 6078.149059131725, 6085.026395776655, 6086.969565152191, 6094.299155597118, 5587.245721827542, 5605.971970140124, 5606.55147588192, 5608.747606357723, 5612.214289999403, 6671.5997040177745, 6705.396514313735, 6720.630365329905, 6732.865342693168, 6752.704080612615, 4598.678092533524, 4598.79305431253, 4602.05657840142, 4604.240300350438, 4610.492845786961, 7014.22843487216, 7063.293670632947, 7083.504154709172, 7090.468214883853, 7097.21930587635, 4739.336492890998, 4793.209120495079, 4833.05755377698, 4833.589144922651, 4850.854474365775, 4849.321095046696, 4873.0, 4874.488178741181, 4877.853664390074, 4878.463369029404, 5585.58108141891, 5609.5792815539, 5610.49505544503, 5620.100783874561, 5629.437056294338, 6748.527603067738, 6798.456123510107, 6803.421709154678, 6808.557443766139, 6810.046593476917, 1682.3270691723408, 1728.9049102299493, 1735.8264173582793, 1738.2178019890846, 1739.7129473636962, 1091.6997825598023, 1135.6763322453062, 1142.1490989212923, 1143.9313641181388, 1153.5501154549731, 6446.645434501053, 6464.515161362917, 6469.902951455732, 6486.67566621667, 6491.285958544557, 6948.5483443576, 6975.755848545276, 6984.092068031124, 7000.649967501707, 7017.228104908456, 6224.439800417984, 6365.649889256043, 6449.355064493513, 6480.611163330215, 6538.509611779135, 3797.6392242736897, 3831.6934645228316, 3834.4631751554803, 3837.2517359114704, 3840.327942610088, 7192.928070719226, 7204.0994875640545, 7283.854322913512, 7291.781246562611, 7326.194118646945, 7185.2814718527725, 7195.89206161908, 7200.711971521186, 7232.20445750967, 7232.349088582053, 7057.647117644097, 7202.819929501699, 7273.818154546073, 7294.0, 7331.963340183265, 7035.5426897253565, 7081.504294699527, 7085.610291434021, 7092.822679433056, 7093.255208203064, 7009.193942696451, 7019.333163349474, 7023.543469674455, 7049.929500704928, 7055.400290975324, 7350.411967042731, 7377.225391333833, 7382.5570465772225, 7409.629518523944, 7416.480846340704, 4674.22875225584, 4787.40157480315, 4816.325714399917, 4839.467658557626, 4860.562549370432, 6953.0, 6986.196587392515, 6996.825079373057, 7004.824879377852, 7010.404115650227, 6734.528582999143, 6813.386795188457, 6817.079694241413, 6821.3178682133375, 6822.965885170741, 6735.898961515679, 6823.931760682528, 6827.658617069027, 6836.316368363124, 6839.726410943706, 6587.110740050032, 6694.59832410057, 6724.361185687352, 6755.729770809309, 6762.797116086525, 6877.346652068046, 6896.2069362022, 6911.274316196727, 6914.861702765816, 6917.446604271747, 6727.428168605527, 6752.763653272112, 6755.324467553205, 6761.256261811099, 6766.932330676827], "unit": "score", "name": "prototype.html", "value": 5117.910482997788}, {"lowerIsBetter": false, "replicates": [801.5110782422721, 807.8545861744888, 894.3739382432299, 923.9538023098844, 936.1714882329139, 13253.33733313333, 13322.866771332283, 13394.196348219102, 13411.128276662022, 13495.190288582691, 13357.265350405723, 13504.864951350484, 13523.256220907846, 13585.728285434285, 13593.59219223425, 759.6809340077181, 914.0813482450145, 917.3532659475054, 937.8218138553688, 942.4204114469586, 935.2798345274169, 936.6113063078848, 941.1529623338981, 944.3767113704956, 944.84882418813, 983.9704808855746, 987.2496902354227, 992.9751756206117, 993.8260804359209, 994.900509949003, 980.2109302011878, 988.5847943863558, 991.4546999150439, 991.4646091110827, 993.4734590666922, 727.7052793618593, 730.6675462664475, 732.9486935914488, 733.9669714862844, 734.988975165373, 13598.32008399576, 13602.455901763917, 13607.115537490032, 13625.863741362558, 13681.179129252178, 13552.322383880766, 13704.24626645534, 13810.792838107436, 13853.238071906042, 13862.0, 11465.770684586261, 11569.479373428216, 11571.826422603668, 11584.0, 11658.125640576991, 3776.169242766587, 3819.4461803038403, 3831.3103641344546, 3832.6358995895343, 3866.149447121629, 50197.498025019646, 50314.74842625763, 50439.49560504421, 50493.49506504925, 50734.0, 10282.383057016603, 10588.205884558534, 11352.262102963281, 11367.658970230907, 11394.3163410194, 20075.899620501805, 20095.296664616668, 20290.188392464137, 20310.492237694176, 20371.185152594026, 7022.6488675566015, 7544.0192774938905, 7606.505577137468, 7701.268379503938, 7808.726694565663, 4136.358864376027, 4136.607022332873, 4147.108371700099, 4237.25847976609, 4237.343211802176, 3328.1180487170436, 3339.7996120232865, 3345.43127668297, 3385.069105995871, 3394.35507253621, 617.5985609353955, 628.5725706519519, 631.7094136697079, 635.3487675132933, 635.6916895305773, 712.4158190284021, 718.964051797408, 726.556800351785, 731.0678884422404, 732.9340359367683, 8414.579271036424, 8471.19523645265, 8488.448250863798, 8490.830183396298, 8675.436096653697, 692.764460083574, 694.8957656351588, 698.8811901976676, 699.9860002799916, 706.8762966480846, 3893.0, 3991.560928297885, 4086.7547947123267, 4087.8569250076102, 4119.279126152911, 59833.70083149557, 60116.0, 60480.69759651262, 61014.389856101756, 61023.08465373023, 51802.740986294826, 51963.0, 52074.21888671673, 52689.0, 52713.7364313176, 48639.0, 52195.21707174395, 52325.47674523206, 52397.47602524002, 52616.47383526116, 8702.608382622924, 8703.129687031245, 8771.035186129648, 8818.338624603051, 8820.162084601952, 35870.64129358673, 36205.81897090498, 36686.816565917, 37044.07389815276, 37120.25759484741, 41871.37192942047, 43922.0, 45882.54117458783, 46245.30632040589, 46376.30435543537, 12220.633380998584, 12593.811092833432, 12757.872421275668, 12912.741745164856, 13224.867751322749, 11863.169578129447, 12037.097217708882, 12353.073519486254, 12363.69090772738, 12446.0, 11240.156988225752, 11269.436528173723, 11336.093112551142, 11386.373749443861, 11455.255408398427, 11487.597934072268, 11646.0, 11671.183017188716, 11792.115591330856, 11817.468213930566, 10491.475426228812, 11861.0, 11965.341906195243, 12015.819762703391, 12197.207181533173, 9904.653337133166, 10260.384376937407, 10350.275480716278, 10383.532741026824, 10442.68671939843, 9736.269779766404, 9766.121049105615, 10022.098011179029, 10059.29584929048, 10079.294449388472], "unit": "score", "name": "yui.html", "value": 6716.016357125957}], "name": "dromaeo_css", "value": 7373.242842815877}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 111.0, 109.0, 111.0, 122.0, 111.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 158.0, 176.0, 128.0, 156.0, 156.0, 129.0, 176.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 162.0, 162.0, 161.0, 161.0, 160.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 77.0, 167.0, 76.0, 73.0, 74.0, 74.0, 159.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 148.0, 92.0, 93.0, 94.0, 145.0, 92.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 149.0, 149.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 63.0, 55.0, 56.0, 55.0, 55.0, 63.0, 53.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 80.0, 80.0, 80.0, 79.0, 79.0, 80.0, 81.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [118.0, 126.0, 114.0, 123.0, 115.0, 114.0, 118.0, 118.0, 125.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [137.0, 146.0, 135.0, 136.0, 154.0, 141.0, 149.0, 148.0, 147.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 76.0, 72.0, 71.0, 67.0, 66.0, 66.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1516.6999999999996}]} 18:01:58 INFO - Return code: 0 18:01:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:01:58 ERROR - # TBPL SUCCESS # 18:01:58 INFO - Running post-action listener: _resource_record_post_action 18:01:58 INFO - Running post-run listener: _resource_record_post_run 18:01:59 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8200192; Write bytes: 382935040; Read time: 2264; Write time: 386272 18:01:59 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6598656; Read time: 0; Write time: 1512 18:01:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6307840; Write bytes: 362184704; Read time: 1960; Write time: 383692 18:01:59 INFO - Running post-run listener: _upload_blobber_files 18:01:59 INFO - Blob upload gear active. 18:01:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:01:59 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 18:01:59 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'] 18:01:59 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 18:01:59 INFO - (blobuploader) - INFO - Open directory for files ... 18:01:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:01:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:02:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:00 INFO - (blobuploader) - INFO - Done attempting. 18:02:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:02:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:02:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:02:01 INFO - (blobuploader) - INFO - Done attempting. 18:02:01 INFO - (blobuploader) - INFO - Iteration through files over. 18:02:01 INFO - Return code: 0 18:02:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:02:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:02:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bff56bf11f231f2ce7085db10d7c7719c6fd4ec78667db3a5d1b9ee1c70e52d36c1fbc3059df73105290df5c9a905070ee3d6056ad2c3317fe73aa38e1bf2c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8477bc22d9f23b780792e3b2f36bc24026c04fd567600fe0f89aa06dcb0f2ce7bca7fed31d61c9edc545a3ef3c87cad9c0adb1501d9782dec8026310f88aed03"} 18:02:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:02:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:02:01 INFO - Contents: 18:02:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bff56bf11f231f2ce7085db10d7c7719c6fd4ec78667db3a5d1b9ee1c70e52d36c1fbc3059df73105290df5c9a905070ee3d6056ad2c3317fe73aa38e1bf2c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8477bc22d9f23b780792e3b2f36bc24026c04fd567600fe0f89aa06dcb0f2ce7bca7fed31d61c9edc545a3ef3c87cad9c0adb1501d9782dec8026310f88aed03"} 18:02:01 INFO - Running post-run listener: copy_logs_to_upload_dir 18:02:01 INFO - Copying logs to upload dir... 18:02:01 INFO - mkdir: /builds/slave/test/build/upload/logs 18:02:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.034069 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-20 18:02:01.402191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 18:02:01.405508) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142 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/bff56bf11f231f2ce7085db10d7c7719c6fd4ec78667db3a5d1b9ee1c70e52d36c1fbc3059df73105290df5c9a905070ee3d6056ad2c3317fe73aa38e1bf2c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8477bc22d9f23b780792e3b2f36bc24026c04fd567600fe0f89aa06dcb0f2ce7bca7fed31d61c9edc545a3ef3c87cad9c0adb1501d9782dec8026310f88aed03"} build_url:https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/Z1C4l9mQSpCNfZukxtfN8A/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/bff56bf11f231f2ce7085db10d7c7719c6fd4ec78667db3a5d1b9ee1c70e52d36c1fbc3059df73105290df5c9a905070ee3d6056ad2c3317fe73aa38e1bf2c71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8477bc22d9f23b780792e3b2f36bc24026c04fd567600fe0f89aa06dcb0f2ce7bca7fed31d61c9edc545a3ef3c87cad9c0adb1501d9782dec8026310f88aed03"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 18:02:01.430419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 18:02:01.430742) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1461195648.804743-383761142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 18:02:01.514936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 18:02:01.515354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 18:02:01.515855) ========= ========= Total master_lag: 0.18 =========