builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0250 starttime: 1464786438.49 results: success (0) buildid: 20160601050353 builduid: 1b865cf5cc7d41a7a85f37d3a9881a42 revision: bf4d710c80531aa2c170f076716513e69206b05d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:18.494499) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:18.494860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:18.495128) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:18.551030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:18.551271) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTKdSsNX6E/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-01 06:07:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 147M=0s 2016-06-01 06:07:19 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.595912 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:19.172856) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:19.173605) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTKdSsNX6E/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:19.227387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 06:07:19.227749) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bf4d710c80531aa2c170f076716513e69206b05d --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 bf4d710c80531aa2c170f076716513e69206b05d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTKdSsNX6E/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-01 06:07:19,310 truncating revision to first 12 chars 2016-06-01 06:07:19,310 Setting DEBUG logging. 2016-06-01 06:07:19,310 attempt 1/10 2016-06-01 06:07:19,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bf4d710c8053?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 06:07:20,401 unpacking tar archive at: mozilla-aurora-bf4d710c8053/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368717 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 06:07:20.620094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:20.620739) ========= script_repo_revision: bf4d710c80531aa2c170f076716513e69206b05d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:20.621666) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:20.622324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 06:07:20.646005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-06-01 06:07:20.646311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_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/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTKdSsNX6E/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:07:20 INFO - MultiFileLogger online at 20160601 06:07:20 in /builds/slave/test 06:07:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:07:20 INFO - {'append_to_log': False, 06:07:20 INFO - 'base_work_dir': '/builds/slave/test', 06:07:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:07:20 INFO - 'branch': 'Mozilla-Aurora', 06:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 06:07:20 INFO - 'config_files': ('talos/mac_config.py',), 06:07:20 INFO - 'default_actions': ('clobber', 06:07:20 INFO - 'read-buildbot-config', 06:07:20 INFO - 'download-and-extract', 06:07:20 INFO - 'populate-webroot', 06:07:20 INFO - 'create-virtualenv', 06:07:20 INFO - 'install', 06:07:20 INFO - 'run-tests'), 06:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:07:20 INFO - 'download_minidump_stackwalk': True, 06:07:20 INFO - 'download_symbols': 'ondemand', 06:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 06:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 06:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:07:20 INFO - 'installer_path': 'installer.exe', 06:07:20 INFO - 'log_level': 'info', 06:07:20 INFO - 'log_name': 'talos', 06:07:20 INFO - 'log_to_console': True, 06:07:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:07:20 INFO - 'opt_config_files': (), 06:07:20 INFO - 'pip_index': False, 06:07:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:07:20 INFO - 'cmd': ('bash', 06:07:20 INFO - '-c', 06:07:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:07:20 INFO - 'enabled': True, 06:07:20 INFO - 'halt_on_failure': False, 06:07:20 INFO - 'name': 'check_screen_resolution'},), 06:07:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:07:20 INFO - 'cmd': ('bash', 06:07:20 INFO - '-c', 06:07:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:07:20 INFO - 'enabled': True, 06:07:20 INFO - 'halt_on_failure': False, 06:07:20 INFO - 'name': 'check_screen_resolution'},), 06:07:20 INFO - 'run_cmd_checks_enabled': True, 06:07:20 INFO - 'sps_profile': False, 06:07:20 INFO - 'sps_profile_interval': 0, 06:07:20 INFO - 'suite': 'dromaeojs-e10s', 06:07:20 INFO - 'system_bits': '32', 06:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:07:20 INFO - 'title': 't-yosemite-r7-0250', 06:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:07:20 INFO - 'use_talos_json': True, 06:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:07:20 INFO - 'work_dir': 'build'} 06:07:20 INFO - ##### 06:07:20 INFO - ##### Running clobber step. 06:07:20 INFO - ##### 06:07:20 INFO - Running pre-action listener: _resource_record_pre_action 06:07:20 INFO - Running main action method: clobber 06:07:20 INFO - rmtree: /builds/slave/test/build 06:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:07:21 INFO - Running post-action listener: _resource_record_post_action 06:07:21 INFO - ##### 06:07:21 INFO - ##### Running read-buildbot-config step. 06:07:21 INFO - ##### 06:07:21 INFO - Running pre-action listener: _resource_record_pre_action 06:07:21 INFO - Running main action method: read_buildbot_config 06:07:21 INFO - Using buildbot properties: 06:07:21 INFO - { 06:07:21 INFO - "project": "", 06:07:21 INFO - "product": "firefox", 06:07:21 INFO - "script_repo_revision": "production", 06:07:21 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:07:21 INFO - "repository": "", 06:07:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:07:21 INFO - "buildid": "20160601050353", 06:07:21 INFO - "pgo_build": "False", 06:07:21 INFO - "basedir": "/builds/slave/test", 06:07:21 INFO - "buildnumber": 23, 06:07:21 INFO - "slavename": "t-yosemite-r7-0250", 06:07:21 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:07:21 INFO - "platform": "yosemite_r7", 06:07:21 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:07:21 INFO - "branch": "mozilla-aurora", 06:07:21 INFO - "repo_path": "releases/mozilla-aurora", 06:07:21 INFO - "revision": "bf4d710c80531aa2c170f076716513e69206b05d", 06:07:21 INFO - "stage_platform": "macosx64", 06:07:21 INFO - "builduid": "1b865cf5cc7d41a7a85f37d3a9881a42", 06:07:21 INFO - "slavebuilddir": "test" 06:07:21 INFO - } 06:07:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 06:07:21 INFO - Running post-action listener: _resource_record_post_action 06:07:21 INFO - ##### 06:07:21 INFO - ##### Running download-and-extract step. 06:07:21 INFO - ##### 06:07:21 INFO - Running pre-action listener: _resource_record_pre_action 06:07:21 INFO - Running main action method: download_and_extract 06:07:21 INFO - mkdir: /builds/slave/test/build/tests 06:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:07:21 INFO - https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 06:07:51 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json: timed out 06:07:51 INFO - retry: attempt #1 caught exception: timed out 06:07:51 INFO - retry: Failed, sleeping 30 seconds before retrying 06:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #2 06:08:27 INFO - Downloaded 1199 bytes. 06:08:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:08:27 INFO - Using the following test package requirements: 06:08:27 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:08:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 06:08:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 06:08:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'jsshell-mac.zip'], 06:08:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 06:08:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:08:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 06:08:27 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 06:08:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 06:08:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:08:27 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 06:08:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:27 INFO - https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:08:34 INFO - Downloaded 18463763 bytes. 06:08:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:08:37 INFO - Return code: 0 06:08:37 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:08:37 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')]} 06:08:37 INFO - https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:08:49 INFO - Downloaded 18463763 bytes. 06:08:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:08:53 INFO - Return code: 0 06:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:08:53 INFO - https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:08:54 INFO - Downloaded 10840145 bytes. 06:08:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:08:54 INFO - Return code: 0 06:08:54 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')]} 06:08:54 INFO - https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 06:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 06:08:59 INFO - Downloaded 114155300 bytes. 06:08:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:08:59 INFO - mkdir: /builds/slave/test/properties 06:08:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:08:59 INFO - Writing to file /builds/slave/test/properties/build_url 06:08:59 INFO - Contents: 06:08:59 INFO - build_url:https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:09:01 INFO - Running post-action listener: _resource_record_post_action 06:09:01 INFO - Running post-action listener: set_extra_try_arguments 06:09:01 INFO - ##### 06:09:01 INFO - ##### Running populate-webroot step. 06:09:01 INFO - ##### 06:09:01 INFO - Running pre-action listener: _resource_record_pre_action 06:09:01 INFO - Running main action method: populate_webroot 06:09:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:09:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:09:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:09:01 INFO - '--tppagecycles', 06:09:01 INFO - '7'], 06:09:01 INFO - 'tests': ['tsvgm']}}, 06:09:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:09:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:09:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:09:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:09:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:09:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:09:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['damp', 'tps']}, 06:09:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'tests': ['damp', 'tps']}, 06:09:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['dromaeo_dom']}, 06:09:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:09:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['a11yr', 06:09:01 INFO - 'ts_paint', 06:09:01 INFO - 'tpaint', 06:09:01 INFO - 'sessionrestore', 06:09:01 INFO - 'sessionrestore_no_auto_restore', 06:09:01 INFO - 'tabpaint']}, 06:09:01 INFO - 'other-e10s': {'tests': ['a11yr', 06:09:01 INFO - 'ts_paint', 06:09:01 INFO - 'tpaint', 06:09:01 INFO - 'sessionrestore', 06:09:01 INFO - 'sessionrestore_no_auto_restore', 06:09:01 INFO - 'tabpaint']}, 06:09:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:09:01 INFO - 'ts_paint', 06:09:01 INFO - 'tpaint', 06:09:01 INFO - 'sessionrestore', 06:09:01 INFO - 'sessionrestore_no_auto_restore', 06:09:01 INFO - 'tabpaint']}, 06:09:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:09:01 INFO - 'ts_paint', 06:09:01 INFO - 'tpaint', 06:09:01 INFO - 'sessionrestore', 06:09:01 INFO - 'sessionrestore_no_auto_restore', 06:09:01 INFO - 'tabpaint']}, 06:09:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['a11yr', 06:09:01 INFO - 'ts_paint', 06:09:01 INFO - 'tpaint', 06:09:01 INFO - 'sessionrestore', 06:09:01 INFO - 'sessionrestore_no_auto_restore', 06:09:01 INFO - 'tabpaint']}, 06:09:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['a11yr', 06:09:01 INFO - 'ts_paint', 06:09:01 INFO - 'tpaint', 06:09:01 INFO - 'sessionrestore', 06:09:01 INFO - 'sessionrestore_no_auto_restore', 06:09:01 INFO - 'tabpaint']}, 06:09:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['tsvgx', 06:09:01 INFO - 'tsvgr_opacity', 06:09:01 INFO - 'tart', 06:09:01 INFO - 'tscrollx', 06:09:01 INFO - 'cart']}, 06:09:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:09:01 INFO - 'tsvgr_opacity', 06:09:01 INFO - 'tart', 06:09:01 INFO - 'tscrollx', 06:09:01 INFO - 'cart']}, 06:09:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'talos_options': ['--disable-e10s'], 06:09:01 INFO - 'tests': ['tp5o']}, 06:09:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'tests': ['tp5o']}, 06:09:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'talos_options': ['--disable-e10s', 06:09:01 INFO - '--xperf_path', 06:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:09:01 INFO - 'tests': ['tp5n']}, 06:09:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:01 INFO - 'talos_options': ['--xperf_path', 06:09:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:09:01 INFO - 'tests': ['tp5n']}}, 06:09:01 INFO - 'talos.zip': {'path': '', 06:09:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:09:01 INFO - Running post-action listener: _resource_record_post_action 06:09:01 INFO - ##### 06:09:01 INFO - ##### Running create-virtualenv step. 06:09:01 INFO - ##### 06:09:01 INFO - Running pre-action listener: _resource_record_pre_action 06:09:01 INFO - Running main action method: create_virtualenv 06:09:01 INFO - Creating virtualenv /builds/slave/test/build/venv 06:09:01 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 06:09:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:09:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:09:01 INFO - Using real prefix '/tools/python27' 06:09:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:09:02 INFO - Installing distribute.............................................................................................................................................................................................done. 06:09:04 INFO - Installing pip.................done. 06:09:04 INFO - Return code: 0 06:09:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:09:04 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')]} 06:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:04 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')]} 06:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:04 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:04 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 06:09:04 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 06:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:04 INFO - 'HOME': '/Users/cltbld', 06:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:04 INFO - 'LOGNAME': 'cltbld', 06:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:04 INFO - 'MOZ_NO_REMOTE': '1', 06:09:04 INFO - 'NO_EM_RESTART': '1', 06:09:04 INFO - 'PAGER': '/bin/cat', 06:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:04 INFO - 'PWD': '/builds/slave/test', 06:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:04 INFO - 'SHELL': '/bin/bash', 06:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:04 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:04 INFO - 'USER': 'cltbld', 06:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:04 INFO - 'XPC_FLAGS': '0x0', 06:09:04 INFO - 'XPC_SERVICE_NAME': '0', 06:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:05 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 06:09:05 INFO - Cleaning up... 06:09:05 INFO - Return code: 0 06:09:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:05 INFO - 'HOME': '/Users/cltbld', 06:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:05 INFO - 'LOGNAME': 'cltbld', 06:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:05 INFO - 'MOZ_NO_REMOTE': '1', 06:09:05 INFO - 'NO_EM_RESTART': '1', 06:09:05 INFO - 'PAGER': '/bin/cat', 06:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:05 INFO - 'PWD': '/builds/slave/test', 06:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:05 INFO - 'SHELL': '/bin/bash', 06:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:05 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:05 INFO - 'USER': 'cltbld', 06:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:05 INFO - 'XPC_FLAGS': '0x0', 06:09:05 INFO - 'XPC_SERVICE_NAME': '0', 06:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:05 INFO - Downloading/unpacking psutil>=0.7.1 06:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:09:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:09:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:09:08 INFO - Installing collected packages: psutil 06:09:08 INFO - Running setup.py install for psutil 06:09:09 INFO - building 'psutil._psutil_osx' extension 06:09:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:09:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:09:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:09:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:09:09 INFO - building 'psutil._psutil_posix' extension 06:09:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:09:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:09:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:09:09 INFO - ^ 06:09:09 INFO - 1 warning generated. 06:09:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:09:09 INFO - Successfully installed psutil 06:09:09 INFO - Cleaning up... 06:09:09 INFO - Return code: 0 06:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:09 INFO - 'HOME': '/Users/cltbld', 06:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:09 INFO - 'LOGNAME': 'cltbld', 06:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:09 INFO - 'MOZ_NO_REMOTE': '1', 06:09:09 INFO - 'NO_EM_RESTART': '1', 06:09:09 INFO - 'PAGER': '/bin/cat', 06:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:09 INFO - 'PWD': '/builds/slave/test', 06:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:09 INFO - 'SHELL': '/bin/bash', 06:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:09 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:09 INFO - 'USER': 'cltbld', 06:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:09 INFO - 'XPC_FLAGS': '0x0', 06:09:09 INFO - 'XPC_SERVICE_NAME': '0', 06:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:09:12 INFO - Installing collected packages: mozsystemmonitor 06:09:12 INFO - Running setup.py install for mozsystemmonitor 06:09:12 INFO - Successfully installed mozsystemmonitor 06:09:12 INFO - Cleaning up... 06:09:12 INFO - Return code: 0 06:09:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:12 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:12 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 06:09:12 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 06:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:12 INFO - 'HOME': '/Users/cltbld', 06:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:12 INFO - 'LOGNAME': 'cltbld', 06:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:12 INFO - 'MOZ_NO_REMOTE': '1', 06:09:12 INFO - 'NO_EM_RESTART': '1', 06:09:12 INFO - 'PAGER': '/bin/cat', 06:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:12 INFO - 'PWD': '/builds/slave/test', 06:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:12 INFO - 'SHELL': '/bin/bash', 06:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:12 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:12 INFO - 'USER': 'cltbld', 06:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:12 INFO - 'XPC_FLAGS': '0x0', 06:09:12 INFO - 'XPC_SERVICE_NAME': '0', 06:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:09:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:16 INFO - Downloading docopt-0.6.1.tar.gz 06:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:09:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:09:16 INFO - Running setup.py install for blobuploader 06:09:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:09:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:09:16 INFO - Running setup.py install for requests 06:09:17 INFO - Running setup.py install for docopt 06:09:17 INFO - Successfully installed blobuploader requests docopt 06:09:17 INFO - Cleaning up... 06:09:17 INFO - Return code: 0 06:09:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:17 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')]} 06:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:17 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')]} 06:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:17 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:17 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 06:09:17 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 06:09:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:17 INFO - 'HOME': '/Users/cltbld', 06:09:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:17 INFO - 'LOGNAME': 'cltbld', 06:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:17 INFO - 'MOZ_NO_REMOTE': '1', 06:09:17 INFO - 'NO_EM_RESTART': '1', 06:09:17 INFO - 'PAGER': '/bin/cat', 06:09:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:17 INFO - 'PWD': '/builds/slave/test', 06:09:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:17 INFO - 'SHELL': '/bin/bash', 06:09:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:17 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:17 INFO - 'USER': 'cltbld', 06:09:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:17 INFO - 'XPC_FLAGS': '0x0', 06:09:17 INFO - 'XPC_SERVICE_NAME': '0', 06:09:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:17 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-lDgPpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-jQysR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-WzZzC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Vkq3Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-qK6Pwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ZjomgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-YYm13G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-dG2gVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-_YZyzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-NCsNyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:18 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Ivy_lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:19 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-L0AG3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:19 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-0adoiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:19 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-9Ox8vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:19 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-rrX_Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:19 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-fUujqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:19 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-jLgSnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:09:19 INFO - Running setup.py install for manifestparser 06:09:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:09:19 INFO - Running setup.py install for mozcrash 06:09:19 INFO - Running setup.py install for mozdebug 06:09:20 INFO - Running setup.py install for mozdevice 06:09:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Running setup.py install for mozfile 06:09:20 INFO - Running setup.py install for mozhttpd 06:09:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Running setup.py install for mozinfo 06:09:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Running setup.py install for mozInstall 06:09:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:09:20 INFO - Running setup.py install for mozleak 06:09:20 INFO - Running setup.py install for mozlog 06:09:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:09:21 INFO - Running setup.py install for moznetwork 06:09:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:09:21 INFO - Running setup.py install for mozprocess 06:09:21 INFO - Running setup.py install for mozprofile 06:09:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:09:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:09:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:09:21 INFO - Running setup.py install for mozrunner 06:09:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:09:21 INFO - Running setup.py install for mozscreenshot 06:09:21 INFO - Running setup.py install for moztest 06:09:22 INFO - Running setup.py install for mozversion 06:09:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:09:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:09:22 INFO - Cleaning up... 06:09:22 INFO - Return code: 0 06:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:22 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:22 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 06:09:22 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 06:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:22 INFO - 'HOME': '/Users/cltbld', 06:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:22 INFO - 'LOGNAME': 'cltbld', 06:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:22 INFO - 'MOZ_NO_REMOTE': '1', 06:09:22 INFO - 'NO_EM_RESTART': '1', 06:09:22 INFO - 'PAGER': '/bin/cat', 06:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:22 INFO - 'PWD': '/builds/slave/test', 06:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:22 INFO - 'SHELL': '/bin/bash', 06:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:22 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:22 INFO - 'USER': 'cltbld', 06:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:22 INFO - 'XPC_FLAGS': '0x0', 06:09:22 INFO - 'XPC_SERVICE_NAME': '0', 06:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:22 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-SGbgQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:22 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)) 06:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:22 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-mE9A9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:22 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)) 06:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:22 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-_WVzAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:22 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)) 06:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:22 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-y7Q68W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:22 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)) 06:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:22 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ALH8Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Q49Pk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-aJb95c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-oztBNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ZZCo4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-n0I1w4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-9ooT4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-Vy7OYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-cJsjVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-O4Awph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:23 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)) 06:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:23 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-KvGf6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:24 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)) 06:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:24 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-d7Gjvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:24 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)) 06:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:24 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-O0EQuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:24 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)) 06:09:24 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)) 06:09:24 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)) 06:09:24 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)) 06:09:24 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)) 06:09:24 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)) 06:09:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:27 INFO - Downloading blessings-1.6.tar.gz 06:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:09:27 INFO - Installing collected packages: blessings 06:09:27 INFO - Running setup.py install for blessings 06:09:27 INFO - Successfully installed blessings 06:09:27 INFO - Cleaning up... 06:09:27 INFO - Return code: 0 06:09:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:27 INFO - Reading from file tmpfile_stdout 06:09:27 INFO - Current package versions: 06:09:27 INFO - blessings == 1.6 06:09:27 INFO - blobuploader == 1.2.4 06:09:27 INFO - docopt == 0.6.1 06:09:27 INFO - manifestparser == 1.1 06:09:27 INFO - mozInstall == 1.12 06:09:27 INFO - mozcrash == 0.17 06:09:27 INFO - mozdebug == 0.1 06:09:27 INFO - mozdevice == 0.48 06:09:27 INFO - mozfile == 1.2 06:09:27 INFO - mozhttpd == 0.7 06:09:27 INFO - mozinfo == 0.9 06:09:27 INFO - mozleak == 0.1 06:09:27 INFO - mozlog == 3.1 06:09:27 INFO - moznetwork == 0.27 06:09:27 INFO - mozprocess == 0.22 06:09:27 INFO - mozprofile == 0.28 06:09:27 INFO - mozrunner == 6.11 06:09:27 INFO - mozscreenshot == 0.1 06:09:27 INFO - mozsystemmonitor == 0.0 06:09:27 INFO - moztest == 0.7 06:09:27 INFO - mozversion == 1.4 06:09:27 INFO - psutil == 3.1.1 06:09:27 INFO - requests == 1.2.3 06:09:27 INFO - wsgiref == 0.1.2 06:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:27 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:27 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 06:09:27 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 06:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:27 INFO - 'HOME': '/Users/cltbld', 06:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:27 INFO - 'LOGNAME': 'cltbld', 06:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:27 INFO - 'MOZ_NO_REMOTE': '1', 06:09:27 INFO - 'NO_EM_RESTART': '1', 06:09:27 INFO - 'PAGER': '/bin/cat', 06:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:27 INFO - 'PWD': '/builds/slave/test', 06:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:27 INFO - 'SHELL': '/bin/bash', 06:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:27 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:27 INFO - 'USER': 'cltbld', 06:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:27 INFO - 'XPC_FLAGS': '0x0', 06:09:27 INFO - 'XPC_SERVICE_NAME': '0', 06:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 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)) 06:09:27 INFO - Cleaning up... 06:09:27 INFO - Return code: 0 06:09:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:28 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:28 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 06:09:28 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 06:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:28 INFO - 'HOME': '/Users/cltbld', 06:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:28 INFO - 'LOGNAME': 'cltbld', 06:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:28 INFO - 'MOZ_NO_REMOTE': '1', 06:09:28 INFO - 'NO_EM_RESTART': '1', 06:09:28 INFO - 'PAGER': '/bin/cat', 06:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:28 INFO - 'PWD': '/builds/slave/test', 06:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:28 INFO - 'SHELL': '/bin/bash', 06:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:28 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:28 INFO - 'USER': 'cltbld', 06:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:28 INFO - 'XPC_FLAGS': '0x0', 06:09:28 INFO - 'XPC_SERVICE_NAME': '0', 06:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:28 INFO - Downloading/unpacking jsonschema 06:09:28 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 06:09:28 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 06:09:28 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 06:09:28 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 06:09:28 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 06:09:28 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 06:09:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:09:31 INFO - Downloading/unpacking functools32 (from jsonschema) 06:09:31 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 06:09:31 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 06:09:31 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 06:09:31 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 06:09:31 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 06:09:31 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 06:09:31 INFO - Downloading functools32-3.2.3-2.tar.gz 06:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:09:31 INFO - warning: no files found matching '*.txt' 06:09:31 INFO - no previously-included directories found matching 'build' 06:09:31 INFO - no previously-included directories found matching 'dist' 06:09:31 INFO - no previously-included directories found matching '.git*' 06:09:31 INFO - Installing collected packages: jsonschema, functools32 06:09:31 INFO - Running setup.py install for functools32 06:09:31 INFO - warning: no files found matching '*.txt' 06:09:31 INFO - no previously-included directories found matching 'build' 06:09:31 INFO - no previously-included directories found matching 'dist' 06:09:31 INFO - no previously-included directories found matching '.git*' 06:09:31 INFO - Successfully installed jsonschema functools32 06:09:31 INFO - Cleaning up... 06:09:31 INFO - Return code: 0 06:09:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:09:31 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')]} 06:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:31 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')]} 06:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:31 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 0x10a584a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a594420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80b0d91710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:09:31 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 06:09:31 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 06:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:31 INFO - 'HOME': '/Users/cltbld', 06:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:31 INFO - 'LOGNAME': 'cltbld', 06:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:31 INFO - 'MOZ_NO_REMOTE': '1', 06:09:31 INFO - 'NO_EM_RESTART': '1', 06:09:31 INFO - 'PAGER': '/bin/cat', 06:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:31 INFO - 'PWD': '/builds/slave/test', 06:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:31 INFO - 'SHELL': '/bin/bash', 06:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:09:31 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:31 INFO - 'USER': 'cltbld', 06:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:31 INFO - 'XPC_FLAGS': '0x0', 06:09:31 INFO - 'XPC_SERVICE_NAME': '0', 06:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:32 INFO - Downloading/unpacking flake8 06:09:32 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 06:09:32 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 06:09:32 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 06:09:32 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 06:09:32 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 06:09:32 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 06:09:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:09:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:09:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 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 06:09:34 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 06:09:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:09:35 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 06:09:35 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 06:09:35 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 06:09:35 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 06:09:35 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 06:09:35 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 06:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:09:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:35 INFO - no previously-included directories found matching 'docs/_build' 06:09:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:09:35 INFO - Running setup.py install for pep8 06:09:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:09:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:09:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:09:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:09:36 INFO - no previously-included directories found matching 'docs/_build' 06:09:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:09:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:09:36 INFO - Cleaning up... 06:09:36 INFO - Return code: 0 06:09:36 INFO - Running post-action listener: _resource_record_post_action 06:09:36 INFO - Running post-action listener: _start_resource_monitoring 06:09:36 INFO - Starting resource monitoring. 06:09:36 INFO - ##### 06:09:36 INFO - ##### Running install step. 06:09:36 INFO - ##### 06:09:36 INFO - Running pre-action listener: _resource_record_pre_action 06:09:36 INFO - Running main action method: install 06:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:09:36 INFO - Reading from file tmpfile_stdout 06:09:36 INFO - Detecting whether we're running mozinstall >=1.0... 06:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:09:36 INFO - Reading from file tmpfile_stdout 06:09:36 INFO - Output received: 06:09:36 INFO - Usage: mozinstall [options] installer 06:09:36 INFO - Options: 06:09:36 INFO - -h, --help show this help message and exit 06:09:36 INFO - -d DEST, --destination=DEST 06:09:36 INFO - Directory to install application into. [default: 06:09:36 INFO - "/builds/slave/test"] 06:09:36 INFO - --app=APP Application being installed. [default: firefox] 06:09:36 INFO - mkdir: /builds/slave/test/build/application 06:09:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:10:08 INFO - Reading from file tmpfile_stdout 06:10:08 INFO - Output received: 06:10:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:10:08 INFO - Running post-action listener: _resource_record_post_action 06:10:08 INFO - ##### 06:10:08 INFO - ##### Running run-tests step. 06:10:08 INFO - ##### 06:10:08 INFO - Running pre-action listener: _resource_record_pre_action 06:10:08 INFO - Running main action method: run_tests 06:10:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:10:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:10:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:10:08 INFO - 2016-06-01 06:10:08.384 screenresolution[2560:27305] starting screenresolution argv=screenresolution get 06:10:08 INFO - 2016-06-01 06:10:08.387 screenresolution[2560:27305] Display 0: 1600x1200x32@60 06:10:08 INFO - 2016-06-01 06:10:08.393 screenresolution[2561:27307] starting screenresolution argv=screenresolution list 06:10:08 INFO - Available Modes on Display 0 06:10:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:10:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:10:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:10:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:10:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:10:08 INFO - Intel Iris: 06:10:08 INFO - Chipset Model: Intel Iris 06:10:08 INFO - Type: GPU 06:10:08 INFO - Bus: Built-In 06:10:08 INFO - VRAM (Dynamic, Max): 1536 MB 06:10:08 INFO - Vendor: Intel (0x8086) 06:10:08 INFO - Device ID: 0x0a2e 06:10:08 INFO - Revision ID: 0x0009 06:10:08 INFO - Displays: 06:10:08 INFO - Display: 06:10:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:10:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:10:08 INFO - Display Serial Number: 1600x1200 60 06:10:08 INFO - Main Display: Yes 06:10:08 INFO - Mirror: Off 06:10:08 INFO - Online: Yes 06:10:08 INFO - Rotation: Supported 06:10:08 INFO - Return code: 0 06:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:10:08 INFO - Python 2.7.3 06:10:08 INFO - Return code: 0 06:10:08 INFO - grabbing minidump binary from tooltool 06:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:10:08 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a423e00>, '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 0x10a28cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a41eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:10:08 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:10:08 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:10:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:10:08 INFO - Return code: 0 06:10:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:10:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:10:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:10:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:10:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:10:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:10:09 INFO - Return code: 0 06:10:09 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 06:10:09 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0250 --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 06:10:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTKdSsNX6E/Render', 06:10:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:09 INFO - 'HOME': '/Users/cltbld', 06:10:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:09 INFO - 'LOGNAME': 'cltbld', 06:10:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:10:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:09 INFO - 'MOZ_NO_REMOTE': '1', 06:10:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:10:09 INFO - 'NO_EM_RESTART': '1', 06:10:09 INFO - 'PAGER': '/bin/cat', 06:10:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:09 INFO - 'PWD': '/builds/slave/test', 06:10:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:10:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:09 INFO - 'SHELL': '/bin/bash', 06:10:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners', 06:10:09 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 06:10:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:09 INFO - 'USER': 'cltbld', 06:10:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:09 INFO - 'XPC_FLAGS': '0x0', 06:10:09 INFO - 'XPC_SERVICE_NAME': '0', 06:10:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:09 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 06:10:10 INFO - mozversion application_buildid: 20160601050353 06:10:10 INFO - mozversion application_changeset: bf4d710c80531aa2c170f076716513e69206b05d 06:10:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:10:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:10:10 INFO - mozversion application_name: Firefox 06:10:10 INFO - mozversion application_remotingname: firefox-dev 06:10:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:10:10 INFO - mozversion application_vendor: Mozilla 06:10:10 INFO - mozversion application_version: 48.0a2 06:10:10 INFO - mozversion platform_buildid: 20160601050353 06:10:10 INFO - mozversion platform_changeset: bf4d710c80531aa2c170f076716513e69206b05d 06:10:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:10:10 INFO - mozversion platform_version: 48.0a2 06:10:10 INFO - using testdate: 1464786610 06:10:10 INFO - actual date: 1464786610 06:10:10 INFO - starting webserver on 'localhost:53752' 06:10:10 INFO - SUITE-START | Running 2 tests 06:10:10 INFO - TEST-START | dromaeo_css 06:10:10 INFO - operating with platform_type : mac_ 06:10:10 INFO - Initialising browser for dromaeo_css test... 06:10:10 INFO - TEST-INFO | started process 2579 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpRnDbo4/profile http://localhost:53752/getInfo.html) 06:10:12 INFO - PROCESS | 2579 | __metrics Screen width/height:1600/1200 06:10:12 INFO - PROCESS | 2579 | colorDepth:24 06:10:12 INFO - PROCESS | 2579 | Browser inner width/height: 1024/689 06:10:12 INFO - PROCESS | 2579 | __metrics 06:10:12 ERROR - PROCESS | 2579 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:10:13 INFO - TEST-INFO | 2579: exit 0 06:10:13 INFO - Browser initialized. 06:10:13 INFO - Running cycle 1/1 for dromaeo_css test... 06:10:13 INFO - TEST-INFO | started process 2582 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpRnDbo4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:25 INFO - PROCESS | 2582 | RSS: Main: 221429760 06:10:25 INFO - PROCESS | 2582 | 06:11:15 INFO - PROCESS | 2582 | 1464786675267 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] 06:13:26 INFO - PROCESS | 2582 | Cycle 1(1): loaded http://localhost:53752/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53752/tests/dromaeo/cssquery-ext.html) 06:13:27 INFO - PROCESS | 2582 | RSS: Main: 231755776 06:13:27 INFO - PROCESS | 2582 | 06:16:29 INFO - PROCESS | 2582 | Cycle 1(1): loaded http://localhost:53752/tests/dromaeo/cssquery-ext.html (next: http://localhost:53752/tests/dromaeo/cssquery-jquery.html) 06:16:30 INFO - PROCESS | 2582 | RSS: Main: 243322880 06:16:30 INFO - PROCESS | 2582 | 06:19:32 INFO - PROCESS | 2582 | Cycle 1(1): loaded http://localhost:53752/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53752/tests/dromaeo/cssquery-mootools.html) 06:19:32 INFO - PROCESS | 2582 | RSS: Main: 245272576 06:19:32 INFO - PROCESS | 2582 | 06:22:34 INFO - PROCESS | 2582 | Cycle 1(1): loaded http://localhost:53752/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53752/tests/dromaeo/cssquery-prototype.html) 06:22:35 INFO - PROCESS | 2582 | RSS: Main: 247037952 06:22:35 INFO - PROCESS | 2582 | 06:25:37 INFO - PROCESS | 2582 | Cycle 1(1): loaded http://localhost:53752/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53752/tests/dromaeo/cssquery-yui.html) 06:25:38 INFO - PROCESS | 2582 | RSS: Main: 249860096 06:25:38 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | Cycle 1(1): loaded http://localhost:53752/tests/dromaeo/cssquery-yui.html (next: http://localhost:53752/tests/dromaeo/cssquery-dojo.html) 06:28:40 INFO - PROCESS | 2582 | RSS: Main: 251011072 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | __start_tp_report 06:28:40 INFO - PROCESS | 2582 | _x_x_mozilla_page_load 06:28:40 INFO - PROCESS | 2582 | _x_x_mozilla_page_load_details 06:28:40 INFO - PROCESS | 2582 | |i|pagename|runs| 06:28:40 INFO - PROCESS | 2582 | |0;dojo.html;3373.4939759036142;3443.2424866529363;3460.6366331535173;3488.5290485784412;3510.0873772819077;5597.21638970544;5630.690312032847;5634.323881134264;5646;5646.463585959337;5679.4036626154275;5682.659040457575;5683.2895888014;5699.059655156904;5724.62789918655;5177.767000484978;5201;5201.55786758126;5234.816781412651;5245.842624721265;5135.794568217267;5254.789808407659;5278.630495865291;5327.893442131155;5367.624266301361;5276.8153114641;5290.127129023706;5300.893982120355;5304.496072873071;5313.814016509423;3978.741381810173;4768.403949506312;5232.110541207985;5285.339332583427;5290.55030322423;4593.977030114828;4964.560277519551;5286.259923610659;5312.654677445954;5346.893062138735;5737.110747834093;5745.88508229833;5783.913241301384;5799.101139323411;5814.5057670098095;5372.247885296062;6085.117657939574;6110.266767987825;6133.723982420802;6181.041938499539;6131.778844714162;6159.860425821193;6184.8763024739255;6196.473299769525;6199.101130336121;4669.976650116761;5909.940900590982;5919.644821310735;5923.940760592382;5939.970300148515;5883.61756485827;6146.108814222002;6184.81445556634;6206.193194884727;6279.058141278753;5833.591648584643;6173.950428427178;6186.938130618636;6189.876202475925;6209.627422354673;5724.570657200727;5786.710664466844;6224.253089629274;6245.6252624842655;6245.875082498324;5094.745262736922;6071.635701857815;6128.167033931328;6146.0473626587955;6196.349383314777;6156.722947467375;6197.876042479215;6202.038684003986;6202.131701561785;6238.313785483593;4891.095147397743;4893.4617192108835;4903.53416425439;4905;4908.852734417973;4385.539518350527;4390.4511936008;4446.199684056836;4449.421575195269;4484.798184081724;4893.339399181136;5770.163326317745;5856.472917437366;5862.179294898718;5900.970495147582;5950.345461999176;6110.7106460192745;6159.722812473449;6272.780452684134;6283.622982621057;5846.473817356458;5849.239598852122;5874.118882167623;5879.735411906475;5905.43898329658;5409.783608655688;5414.91877621836;5430.8099216527235;5433.592480563973;5437.32033495813;6223.253209614875;6280.7487700491465;6358.2687990879795;6436.066770318372;6453.257875344301;6203.96898015507;6206.10011548332;6208.4722798562625;6224.1597384352535;6224.284207316216;6356.586821856565;6384.904226436514;6413.4869210463985;6414;6429.935700642934;6089.177960975212;6120.54095942815;6144.433169541739;6153.077038444269;6191.349908259568;6130.279684642889;6150.630962142286;6173.351798061319;6202.224721909762;6250.406211409909;6137.907931381123;6141.785037523665;6161.815145545641;6165.660888651168;6172.135900973957;5984.730687119003;6045.697715114139;6129.542179248731;6136.539759518143;6138.723757431016;5103.642745007814;5892.234009578899;5937.901488224692;5990.430909063632;6009.909851352146;5995.400459953969;6141.508679305555;6141.723622436912;6142.017277235799;6157.076438534255;5940.584159108994;5958.7616495341435;6002.939970600412;6017.578769486094;6055.818325450244 06:28:40 INFO - PROCESS | 2582 | |1;ext.html;510.9882432783089;517.1544524702113;520.6745783885071;559.0245022435848;642.3415998601433;31009.689903100963;41162.79418602907;41286.38070428946;41388.79305603475;41431.17137657253;42179.36730949038;42695.57304426955;42736.14527709444;43390.56609433905;43488.78255608718;9583.66457173999;9626.75933101671;9716.028397160298;9738.951305243463;9835.31152819303;9717.222622190244;9805.803883922317;9820.312578119534;9840.950795246014;9849.65526206583;9702.563384647672;9779.022097790199;9825.65610203643;9847.16299114576;9852.014798520126;9749.902500975006;9800.411975281506;9823;9826.263030272758;9911.603535858558;9603.711888643353;9709.854352184722;9724.173445257162;9759.902400976041;9779.168770654504;39616.405753913714;40058.399124013165;40070;40090;40103.7994810027;3121.672224416449;3175.7776955613117;3196.616406031268;3212.4860022396306;3319.5020746887917;27977;28623.570646440112;28725.569116463063;28892.844286228526;29403.558946615816;2767.9723202767914;2771.431856469439;2813.409184071327;2841.4885320642275;2867.1255267143515;490528.0947190554;495444;498128;498666;500179;52297;63303;63839.04241436382;63868.68065659642;63914.680426597566;70427.64786176036;71574.64212678903;71977;72060.63969680118;72083.63958180175;17185.39851105205;17624.383146589807;17697.469075927744;17768.200430980636;17837.554061148574;13457.394417251247;13547.932260338832;13564.253966031964;13579.321033948263;13606.251656159006;17263.827361726475;19446.22215111408;19453;19546.60906781885;19694.507637308896;6922.930770692329;7089.858202835914;7932.682692692343;8127.75616731499;8181.67273309061;944.6599224279254;985.4579981010415;994.0804755601184;1011.3224139826334;1023.3706270643501;29876.402471950438;30309.393812123635;30347.393052139276;30612.38775224483;30668.846655766578;1103.3545375954996;1123.938183399921;1129.0008342616843;1194.5784516425426;1257.6478585995935;15229;15418.6145346365;15423;15548.611284717972;15588.309510026533;507010;635371;646699;647920;648910;58388.708056460295;60418.39581604215;60650;60725.69637151786;60874.69562652247;1405.1569058564983;1423.3168079321983;1452.3101526774697;1453.6729235922044;1465.7215129125645;29890.402191955603;29896.953606623665;29991.850040749658;30468.695313046584;30509.084727458212;52932.47067529275;53206.2019069722;53324.93350132898;53454.73272633612;53528.92942141213;526082;540209;544210;544691;548186;42047;42592.83103711241;43481.78259108684;44421.77789111034;44463;44813.32780008237;45370.54629453663;45842.083158337315;46203.53796461992;46757.2986405211;35635.82182089073;37692.05769855776;37760.81119594385;37763.62236377711;38136.04659883525;37677.434838477995;38029;38830.223395531364;39230.6076939227;39591.604083958795;34764.783232586735;35088.82455587706;35969.820150899075;36487.45268821023;36750.081247969014;31143;32917.835410822794;33080.33839323248;33183.004509864746;33304.83347583246;24861.62384480082;25087.372815679755;25113.32683609495;25324.860381282517;26123.869380652974 06:28:40 INFO - PROCESS | 2582 | |2;jquery.html;373.18645353130165;377.6374680306905;383.80234179397615;403.0870079270453;405.9695522835787;18589;21546.27629789617;22031;22111.33665990019;22123.778762212354;20301.18795248192;20866.374008779723;20962.475938101554;21707.45731356713;22006.449838754;5822.796202132926;5877.441643043904;6062.666553339586;6064.272287325527;6101.542384321171;5273.525382715555;6074;6096.35988221237;6113.174721412597;6128.601640893327;5692.146178073281;6035.939640603604;6054.848628784293;6062.787802426916;6075;5945.851353716149;5961.986462301419;6000.549958753068;6002.309734380558;6017.06735456005;5165.767540460651;5264.7367631618645;5282;5470.6202801780955;5778.913316300259;13297.601071967856;13430.395632196476;13454.730905381837;13491.055626106176;21945.780542194534;2089.561192149635;2179.1719146724304;2267.353804165821;2332.183735692511;2616.5028644557665;10024.248181386352;10398.636047738368;12541.749165016648;13935.954803389786;14721.043132196373;1706.8378504042096;1718.4844546636084;1718.6047209141968;1760.3574695236275;1811.538057795267;85652;91866.54066729691;96020;105119.4744026275;109010.45494772475;9609.90390096104;11499.712507187387;11543.595974141033;11872;11993.220440671328;14790.186539740202;14980.40078396852;15008.399664013536;15009.724173445162;15118.697626047637;8128.715494957648;8295.377846661404;8790.25282850952;8797;8830.91169088301;7911.406644501571;8764.956175219211;8776.736697899074;8811.515366654896;8856.202941735275;4569.246074397754;4571.839985600554;4617.07658468301;4622.237330840441;4647.372604698322;1974.5853370792008;2020.8181263686338;2030.2792508659213;2050.3746357361147;2071.461420030803;885.9557022148866;990.4057565460666;1000.1898462245459;1017;1022.3967858963099;19992.700109498368;20197.596048078954;20209.292674756605;20673.379798606067;20743.8962805185;956.8421210500329;958.3052287091942;981.7643765496372;1002.588938535197;1017.5065093429681;10607.310524815863;10979.560817567368;10996.835047474295;11019.504122314514;11036.337819730841;226488;238368;420457;436869;646416;108954;126205.36897315455;128169.3591532055;140018;141579;446.5043801380465;461.9422572178478;462.1657907476969;462.5813638657021;464.8953985353336;10755.838662419914;10782.975617316342;10836.970487803646;11049.17131215146;11271.211015228855;44703.21187152478;47805.521944781496;47820.2826957589;49994;52067.47932520778;71522.64238678773;74949.6252518734;75989.62005189939;76154.61922690351;76691.61654191693;6449.838754030999;7900.881486777818;7936.682532698858;7975.162607926316;8284.751457456287;10879;11178.832317515407;11744.119191060534;11983.64049078529;12081.516739330329;10651.786964260516;10710.464476775975;10748.516316765921;10904.94547527289;10995.460635510875;10580.20648451354;10595.576176952836;10610.787784244427;10643.680689579016;10790;10482.475876206006;10959.397233152253;10982.176336774934;11012.39431831257;11233.887661123612;8042.115367309708;8084.989376327959;8181.590920454072;8243.815388922061;8275.08974012846;7958.960205198937;9599.568019439002;10881.183911206534;10972.396518191576;11100.833487497855 06:28:40 INFO - PROCESS | 2582 | |3;mootools.html;1574.0712979342188;1581.9683606327878;1781.8752687311885;1811.1306572845035;1951.2585217617304;8064.153263907293;8801.251893589037;8864.024957254705;9168.449893006407;9193.58628861701;9012.774680632987;9067.365284430076;9072.36493445459;9164.266858651308;9188.632454701803;2500.187439082301;2508.523380557688;2518.8866501007496;2526.2421273617933;2534.9733357990044;2474.5669507836055;2498.350428888493;2524.3184340228127;2525.1288305534563;2532.9240122796346;2493.0651005872796;2495.7129930058004;2501.5122051199933;2503.249025292414;2518.2067648690604;2480.528699547089;2489.3154382544853;2502.949941001188;2512.309114993373;2512.673352464168;2454.6195339722194;2466;2485.6644353012475;2490.68866391701;2526.178991827663;9099.22656574192;9128.45229286245;9129.589168487368;9170.266378689688;9199.172074513326;5518.227448157261;5585.553155747531;5617.185508101303;5622.57830662702;5638.323401191842;2697.325668582854;3264.069740124077;3299.307145499448;3516.841742121585;3540.274243780019;1062.5484169228048;1065.211743309953;1066.5946940162767;1074.2007138043746;1085.2403317677579;9724.270679699051;12191.45138468771;12419.379031048502;12462.43919023646;12495.000399968072;4984.227444745998;4991.101601711654;5001.099802035668;5009.674371165863;5029.899402011939;10494.475276236157;10519.579216831395;10548.261621686408;10553.63062292816;10557.419341936115;5571.220029195916;5618;5642.181883626851;5657.688827114466;5696.943030569724;4455.77721113943;4461.9514414112655;4874.780634871439;4979.0788704089855;4983.626228032912;3430.2281986553326;4191.937120943188;4239.745615263094;4255.29787585045;4288.978555107267;1178.3754610056683;1182.4737991593831;1379.4551152294787;1393.7978993045951;1395.2605119286795;852.3394369363792;892.8035832116924;896.6323807239131;939.8966113727485;950.6910254167424;5987.072003839412;5990;6074;6078.300995385587;6265.373462653698;894.4633220067907;980.9362391444533;990.232569758443;991.5438898106952;1011.9089281964511;3205.83970801459;3524;3608.657177568127;3944.1322908959983;4028.5971402860064;8871.733847984571;10463.006014428616;10770.461476926122;10854.62008829703;11065.948734870335;9022.684206052756;10781.975712307318;10873.021428071512;10894.40080795548;10947.890521094847;8110.5539195343645;8473.237408633253;8474.449160804528;8475.110113438124;8500.319974402157;5670.809130082729;5714.885702286014;5725.141228815544;5780.104083867007;5815.79644712433;9463.668771592962;9469.810603788024;9783.315167938175;9814.411135331902;9822.410655360702;9800.264980126376;9822.410655360702;10109.19126469866;10149.949250253701;10229.181665466596;6970.79087627372;7409.740659076906;7655.196204398458;7710.691572337268;7896;8302.750917472244;8415.915840841513;8427;8439.451435656663;8488.74533763988;7363.595002274927;7535.73624923147;7587.772366829004;7599.772006839804;7605.467617266738;6418.743250269937;7310.086239220098;7331.6334183289555;7433.516821406592;7469.1037075551285;7022.754203603054;7124.073870396815;7133.144022717307;7165.462590305852;7169.175544812205;4916.655834091579;4951.3810773653295;5005;5013.699178049329;5046.444891062054;4639.791209395653;5005.499450054966;5038.697678139323;5149.253358263106;5165.586753059671 06:28:40 INFO - PROCESS | 2582 | |4;prototype.html;325.34767790579883;327.81642280323007;329.22139140931694;332.09338505878935;338.2372749449993;6653.567518111326;6655.767048153316;6716.361945615165;6812.420944219735;6818.420434263094;5674.347450043247;6646.867062658744;6680.632565208912;6685.097511835913;6712.463002959764;4746.264329029006;4791.233402655575;4916.1888288432365;4945.738836596663;4951.900961980758;4791.592714619244;4914.778834952418;4935.383077115361;4937.456879743226;4938.827141050064;4871.050145221683;4882.096812089775;4890.046440944017;4962.702237865721;4997.5252351026775;4941.431735350445;4941.950580494185;4959.429665588467;4962.503749625044;4969.8012079516775;4258.041940563348;4260.573942605745;4265.658747300239;4273.230818452677;4273.952881544011;6249.0938813871735;6400.839979000516;6433.324500927382;6453.1610890583925;6494.707738151795;5860.501857342131;5910.852228694274;5925.407459254083;5931.851703707442;5939.287285525765;7121.430285577141;7181.6409179540815;7195.6042417667;7196.388306993912;7248.565086094851;4742.1227072991605;4783.760811959388;4789.401324834395;4792.616590672773;4811.206150985084;7303.196648368676;7485.176630570633;7572.621368931532;7579.810504737426;7590.3548198403205;4851.902961940812;4876.073546026244;4877.951220487821;4879.097366987119;4882.12121818069;4920.065187614414;4962.5533701967;4978.477259887732;4978.502149785065;4989.725565093955;5881.823545293648;5890.793822216202;5892.234009578813;5904.675242861598;5930.822075337746;6469.708863101172;6628.105205797156;7221.277872212737;7238.565686058748;7238.84178531443;1707.581642497596;1726.3008481564987;1730.8788384813195;1732.1512458895052;1733.6706025855046;1012.3520946594185;1057.0697785948316;1060.4220699718671;1061.2253055269696;1118.457548089176;6593.967030164915;6646.235682896432;6689.5986240825705;6699.832504187434;6719.832004199934;7184.892226616605;7485.70057197706;7497.212792656802;7498.362639175732;7503.8499230015095;6553.049807777846;6648.301928297459;6690.19717633887;6781.11845460087;6782.457403407716;3954.9011274717786;3981.6217459341315;3984.860529881498;3988.0428697112484;3989.3218152914073;7790.87032380313;7882.487638303492;7938.960305198552;7948.483348582439;7974.122846486882;6801.18385793708;7467.663955122032;7819.804504887424;7831.6475758591005;7868.134505204423;6285.528585356116;6662.533622646368;7911.485753426009;7931.127575966639;7946.086200087064;7169.4981351304905;7500.474966752275;7503.699852005859;7557.2820582044615;7566.016417865642;7390.704371825067;7390.704371825067;7396.186419493743;7405.148407933157;7442.96278518604;6311.990081586924;7803.453758236869;7920.762377128695;7925.564093974886;7939.841203175789;4680.344751734692;4719.5752382285755;4721.551452611996;4725.220338644085;4742.88142796419;7600.885986710315;7643.159252482112;7655.617219139132;7671.578063206577;7700.961495192488;7143.892841607484;7146.499745017799;7181.569105853666;7191.280871912767;7261.6006119663925;7015.964920175366;7191.964040179766;7222.06113205301;7249.963750181215;7258.274172582699;6048.455638992512;6965.199002114619;7071.080759501232;7086.433085353056;7094.184168820445;5820.70896455184;6145.784897528565;7193.640317983975;7262.455315851226;7272.527285726411;7051.471139664443;7088.787336379917;7093.113360829896;7098.964505177441;7122.358987691133 06:28:40 INFO - PROCESS | 2582 | |5;yui.html;716.6774951271927;723.1611330856205;746.5259560179285;754.3324158120065;767.7274567528527;15020.549383518484;15041.774373384394;15280.312385942632;15323.004004739683;15329.310181041852;10407.167426605873;11193.44032798361;13899.235542045184;13988.37052332645;14048.71902561948;725.2457444257965;732.9193788683241;896.3456676626067;910.622091831889;927.7726956895536;896.6547879066541;916.4134953629682;919.9264058875308;924.0851556958596;932.2262522106669;972.9854052189223;974.2887691984855;978.0561757903622;983.0415345038601;984.8965858584853;961.8028304197622;975.7121649113564;977.2084611464736;979.4955597867104;980.8822941247024;694.7429451103073;716.2372073741449;728.9781306560811;730.857482790856;731.6341829085458;14742.557723268319;14784.334704938303;14943.626409339744;14971.251437428085;15042.097474151586;12737.617871463872;12789.808152877715;12951.222926624338;13035.674108147277;13166.53917112906;9568.33021688482;9787.804243915152;9824.41053536783;9930.652427165014;9993.300468967174;2999.9100026999226;3531.788092714445;3566.8394922228563;3591.982040089783;3753.361928472139;75309.62345188294;75828;78407.82388264181;78675;79062;9571.856422153673;9638.180754635934;9712.902870971342;9780.972997835124;10178.694639160836;21833;21895.562088758135;22116.778832211792;22380.44048898758;22523.099076037102;7543.585102819397;7622.656980435893;7626.923730762733;7733.381329493627;7773.611319434119;4131.32708484965;4132.958670413317;4213.87358379243;4225.704200705983;4288;3503.7547371683736;3557.7153827693724;3565.7860528368383;3576.052346128226;3578.2306804037257;563.9210510528529;645.6771614192903;651.5406638319973;655.8294843340766;657.5397221944658;530.4297879779252;574.9626274292158;595.2767387623971;597.9043353063576;609.8536351275662;8080.4343695940715;8185.79535511617;8215.465994710325;8233.79415514617;8587.95706021466;524.6642149024627;574.8072749045747;594.1444320178929;594.6877889108166;604.9637021778619;3657.8725189962197;3728.2357116790995;3741.663250307485;3910.550286717007;3950.7234493585747;96303;98074.01925980792;98371;99052.27122976804;99082;79358.6032069836;79700.60149699214;79878.60060699776;80697;81618.18381816224;68023.31976680268;68509;71311.64344178246;72094;73127;6083;7493.775186744407;7821.491603045783;7877.448578599443;7901.920980790119;45456.09087818291;49999.750006250135;50873.74563127161;51295.48704512907;51333.459996200174;68608;70887.29112708807;71001.93497097444;71514.56970860658;72711.27288727045;8284.917150828414;9698.806023879342;9752.658656946973;9815;10382.117520010883;10729.248952573556;10800.513976870903;11983.400829958642;12186.634400967985;12723.491060357483;9968.704068471052;11301.321920684784;11396.886031139582;11738.178327516991;11952;11253.043491303331;11488.655340339803;11504.079673625922;11593.478293476644;11925.463354149259;10478.00458956398;10687.679369618923;11097.389643569359;11271.718207044889;11813.936745692929;9535.904640953502;9588.43958325037;9635.277354198603;9677.951610242186;9714.75713107178;9474.431534107976;9703.320767546204;9734.46460444654;9770.267229957639;9802.75493112678 06:28:40 INFO - PROCESS | 2582 | __end_tp_report 06:28:40 INFO - PROCESS | 2582 | __start_cc_report 06:28:40 INFO - PROCESS | 2582 | _x_x_mozilla_cycle_collect,417 06:28:40 INFO - PROCESS | 2582 | __end_cc_report 06:28:40 INFO - PROCESS | 2582 | __startTimestamp1464787720879__endTimestamp 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | ------- Summary: start ------- 06:28:40 INFO - PROCESS | 2582 | Number of tests: 6 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | [#0] dojo.html Cycles:165 Average:5711.21 Median:5937.90 stddev:647.66 (10.9%) stddev-sans-first:623.14 06:28:40 INFO - PROCESS | 2582 | Values: 3373.5 3443.2 3460.6 3488.5 3510.1 5597.2 5630.7 5634.3 5646.0 5646.5 5679.4 5682.7 5683.3 5699.1 5724.6 5177.8 5201.0 5201.6 5234.8 5245.8 5135.8 5254.8 5278.6 5327.9 5367.6 5276.8 5290.1 5300.9 5304.5 5313.8 3978.7 4768.4 5232.1 5285.3 5290.6 4594.0 4964.6 5286.3 5312.7 5346.9 5737.1 5745.9 5783.9 5799.1 5814.5 5372.2 6085.1 6110.3 6133.7 6181.0 6131.8 6159.9 6184.9 6196.5 6199.1 4670.0 5909.9 5919.6 5923.9 5940.0 5883.6 6146.1 6184.8 6206.2 6279.1 5833.6 6174.0 6186.9 6189.9 6209.6 5724.6 5786.7 6224.3 6245.6 6245.9 5094.7 6071.6 6128.2 6146.0 6196.3 6156.7 6197.9 6202.0 6202.1 6238.3 4891.1 4893.5 4903.5 4905.0 4908.9 4385.5 4390.5 4446.2 4449.4 4484.8 4893.3 5770.2 5856.5 5862.2 5901.0 5950.3 6110.7 6159.7 6272.8 6283.6 5846.5 5849.2 5874.1 5879.7 5905.4 5409.8 5414.9 5430.8 5433.6 5437.3 6223.3 6280.7 6358.3 6436.1 6453.3 6204.0 6206.1 6208.5 6224.2 6224.3 6356.6 6384.9 6413.5 6414.0 6429.9 6089.2 6120.5 6144.4 6153.1 6191.3 6130.3 6150.6 6173.4 6202.2 6250.4 6137.9 6141.8 6161.8 6165.7 6172.1 5984.7 6045.7 6129.5 6136.5 6138.7 5103.6 5892.2 5937.9 5990.4 6009.9 5995.4 6141.5 6141.7 6142.0 6157.1 5940.6 5958.8 6002.9 6017.6 6055.8 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | [#1] ext.html Cycles:180 Average:69551.65 Median:41409.98 stddev:147928.23 (357.2%) stddev-sans-first:148252.38 06:28:40 INFO - PROCESS | 2582 | Values: 511.0 517.2 520.7 559.0 642.3 31009.7 41162.8 41286.4 41388.8 41431.2 42179.4 42695.6 42736.1 43390.6 43488.8 9583.7 9626.8 9716.0 9739.0 9835.3 9717.2 9805.8 9820.3 9841.0 9849.7 9702.6 9779.0 9825.7 9847.2 9852.0 9749.9 9800.4 9823.0 9826.3 9911.6 9603.7 9709.9 9724.2 9759.9 9779.2 39616.4 40058.4 40070.0 40090.0 40103.8 3121.7 3175.8 3196.6 3212.5 3319.5 27977.0 28623.6 28725.6 28892.8 29403.6 2768.0 2771.4 2813.4 2841.5 2867.1 490528.1 495444.0 498128.0 498666.0 500179.0 52297.0 63303.0 63839.0 63868.7 63914.7 70427.6 71574.6 71977.0 72060.6 72083.6 17185.4 17624.4 17697.5 17768.2 17837.6 13457.4 13547.9 13564.3 13579.3 13606.3 17263.8 19446.2 19453.0 19546.6 19694.5 6922.9 7089.9 7932.7 8127.8 8181.7 944.7 985.5 994.1 1011.3 1023.4 29876.4 30309.4 30347.4 30612.4 30668.8 1103.4 1123.9 1129.0 1194.6 1257.6 15229.0 15418.6 15423.0 15548.6 15588.3 507010.0 635371.0 646699.0 647920.0 648910.0 58388.7 60418.4 60650.0 60725.7 60874.7 1405.2 1423.3 1452.3 1453.7 1465.7 29890.4 29897.0 29991.9 30468.7 30509.1 52932.5 53206.2 53324.9 53454.7 53528.9 526082.0 540209.0 544210.0 544691.0 548186.0 42047.0 42592.8 43481.8 44421.8 44463.0 44813.3 45370.5 45842.1 46203.5 46757.3 35635.8 37692.1 37760.8 37763.6 38136.0 37677.4 38029.0 38830.2 39230.6 39591.6 34764.8 35088.8 35969.8 36487.5 36750.1 31143.0 32917.8 33080.3 33183.0 33304.8 24861.6 25087.4 25113.3 25324.9 26123.9 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | [#2] jquery.html Cycles:180 Average:28113.62 Median:124305.89 stddev:72466.25 (58.3%) stddev-sans-first:72639.61 06:28:40 INFO - PROCESS | 2582 | Values: 373.2 377.6 383.8 403.1 406.0 18589.0 21546.3 22031.0 22111.3 22123.8 20301.2 20866.4 20962.5 21707.5 22006.4 5822.8 5877.4 6062.7 6064.3 6101.5 5273.5 6074.0 6096.4 6113.2 6128.6 5692.1 6035.9 6054.8 6062.8 6075.0 5945.9 5962.0 6000.5 6002.3 6017.1 5165.8 5264.7 5282.0 5470.6 5778.9 13297.6 13430.4 13454.7 13491.1 21945.8 2089.6 2179.2 2267.4 2332.2 2616.5 10024.2 10398.6 12541.7 13936.0 14721.0 1706.8 1718.5 1718.6 1760.4 1811.5 85652.0 91866.5 96020.0 105119.5 109010.5 9609.9 11499.7 11543.6 11872.0 11993.2 14790.2 14980.4 15008.4 15009.7 15118.7 8128.7 8295.4 8790.3 8797.0 8830.9 7911.4 8765.0 8776.7 8811.5 8856.2 4569.2 4571.8 4617.1 4622.2 4647.4 1974.6 2020.8 2030.3 2050.4 2071.5 886.0 990.4 1000.2 1017.0 1022.4 19992.7 20197.6 20209.3 20673.4 20743.9 956.8 958.3 981.8 1002.6 1017.5 10607.3 10979.6 10996.8 11019.5 11036.3 226488.0 238368.0 420457.0 436869.0 646416.0 108954.0 126205.4 128169.4 140018.0 141579.0 446.5 461.9 462.2 462.6 464.9 10755.8 10783.0 10837.0 11049.2 11271.2 44703.2 47805.5 47820.3 49994.0 52067.5 71522.6 74949.6 75989.6 76154.6 76691.6 6449.8 7900.9 7936.7 7975.2 8284.8 10879.0 11178.8 11744.1 11983.6 12081.5 10651.8 10710.5 10748.5 10904.9 10995.5 10580.2 10595.6 10610.8 10643.7 10790.0 10482.5 10959.4 10982.2 11012.4 11233.9 8042.1 8085.0 8181.6 8243.8 8275.1 7959.0 9599.6 10881.2 10972.4 11100.8 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | [#3] mootools.html Cycles:180 Average:5793.83 Median:5021.80 stddev:3218.58 (64.1%) stddev-sans-first:3211.99 06:28:40 INFO - PROCESS | 2582 | Values: 1574.1 1582.0 1781.9 1811.1 1951.3 8064.2 8801.3 8864.0 9168.4 9193.6 9012.8 9067.4 9072.4 9164.3 9188.6 2500.2 2508.5 2518.9 2526.2 2535.0 2474.6 2498.4 2524.3 2525.1 2532.9 2493.1 2495.7 2501.5 2503.2 2518.2 2480.5 2489.3 2502.9 2512.3 2512.7 2454.6 2466.0 2485.7 2490.7 2526.2 9099.2 9128.5 9129.6 9170.3 9199.2 5518.2 5585.6 5617.2 5622.6 5638.3 2697.3 3264.1 3299.3 3516.8 3540.3 1062.5 1065.2 1066.6 1074.2 1085.2 9724.3 12191.5 12419.4 12462.4 12495.0 4984.2 4991.1 5001.1 5009.7 5029.9 10494.5 10519.6 10548.3 10553.6 10557.4 5571.2 5618.0 5642.2 5657.7 5696.9 4455.8 4462.0 4874.8 4979.1 4983.6 3430.2 4191.9 4239.7 4255.3 4289.0 1178.4 1182.5 1379.5 1393.8 1395.3 852.3 892.8 896.6 939.9 950.7 5987.1 5990.0 6074.0 6078.3 6265.4 894.5 980.9 990.2 991.5 1011.9 3205.8 3524.0 3608.7 3944.1 4028.6 8871.7 10463.0 10770.5 10854.6 11065.9 9022.7 10782.0 10873.0 10894.4 10947.9 8110.6 8473.2 8474.4 8475.1 8500.3 5670.8 5714.9 5725.1 5780.1 5815.8 9463.7 9469.8 9783.3 9814.4 9822.4 9800.3 9822.4 10109.2 10149.9 10229.2 6970.8 7409.7 7655.2 7710.7 7896.0 8302.8 8415.9 8427.0 8439.5 8488.7 7363.6 7535.7 7587.8 7599.8 7605.5 6418.7 7310.1 7331.6 7433.5 7469.1 7022.8 7124.1 7133.1 7165.5 7169.2 4916.7 4951.4 5005.0 5013.7 5046.4 4639.8 5005.5 5038.7 5149.3 5165.6 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | [#4] prototype.html Cycles:180 Average:5894.51 Median:6646.55 stddev:1866.61 (28.1%) stddev-sans-first:1824.44 06:28:40 INFO - PROCESS | 2582 | Values: 325.3 327.8 329.2 332.1 338.2 6653.6 6655.8 6716.4 6812.4 6818.4 5674.3 6646.9 6680.6 6685.1 6712.5 4746.3 4791.2 4916.2 4945.7 4951.9 4791.6 4914.8 4935.4 4937.5 4938.8 4871.1 4882.1 4890.0 4962.7 4997.5 4941.4 4942.0 4959.4 4962.5 4969.8 4258.0 4260.6 4265.7 4273.2 4274.0 6249.1 6400.8 6433.3 6453.2 6494.7 5860.5 5910.9 5925.4 5931.9 5939.3 7121.4 7181.6 7195.6 7196.4 7248.6 4742.1 4783.8 4789.4 4792.6 4811.2 7303.2 7485.2 7572.6 7579.8 7590.4 4851.9 4876.1 4878.0 4879.1 4882.1 4920.1 4962.6 4978.5 4978.5 4989.7 5881.8 5890.8 5892.2 5904.7 5930.8 6469.7 6628.1 7221.3 7238.6 7238.8 1707.6 1726.3 1730.9 1732.2 1733.7 1012.4 1057.1 1060.4 1061.2 1118.5 6594.0 6646.2 6689.6 6699.8 6719.8 7184.9 7485.7 7497.2 7498.4 7503.8 6553.0 6648.3 6690.2 6781.1 6782.5 3954.9 3981.6 3984.9 3988.0 3989.3 7790.9 7882.5 7939.0 7948.5 7974.1 6801.2 7467.7 7819.8 7831.6 7868.1 6285.5 6662.5 7911.5 7931.1 7946.1 7169.5 7500.5 7503.7 7557.3 7566.0 7390.7 7390.7 7396.2 7405.1 7443.0 6312.0 7803.5 7920.8 7925.6 7939.8 4680.3 4719.6 4721.6 4725.2 4742.9 7600.9 7643.2 7655.6 7671.6 7701.0 7143.9 7146.5 7181.6 7191.3 7261.6 7016.0 7192.0 7222.1 7250.0 7258.3 6048.5 6965.2 7071.1 7086.4 7094.2 5820.7 6145.8 7193.6 7262.5 7272.5 7051.5 7088.8 7093.1 7099.0 7122.4 06:28:40 INFO - PROCESS | 2582 | 06:28:40 INFO - PROCESS | 2582 | [#5] yui.html Cycles:180 Average:18460.48 Median:35791.02 stddev:26338.88 (73.6%) stddev-sans-first:26379.07 06:28:40 INFO - PROCESS | 2582 | Values: 716.7 723.2 746.5 754.3 767.7 15020.5 15041.8 15280.3 15323.0 15329.3 10407.2 11193.4 13899.2 13988.4 14048.7 725.2 732.9 896.3 910.6 927.8 896.7 916.4 919.9 924.1 932.2 973.0 974.3 978.1 983.0 984.9 961.8 975.7 977.2 979.5 980.9 694.7 716.2 729.0 730.9 731.6 14742.6 14784.3 14943.6 14971.3 15042.1 12737.6 12789.8 12951.2 13035.7 13166.5 9568.3 9787.8 9824.4 9930.7 9993.3 2999.9 3531.8 3566.8 3592.0 3753.4 75309.6 75828.0 78407.8 78675.0 79062.0 9571.9 9638.2 9712.9 9781.0 10178.7 21833.0 21895.6 22116.8 22380.4 22523.1 7543.6 7622.7 7626.9 7733.4 7773.6 4131.3 4133.0 4213.9 4225.7 4288.0 3503.8 3557.7 3565.8 3576.1 3578.2 563.9 645.7 651.5 655.8 657.5 530.4 575.0 595.3 597.9 609.9 8080.4 8185.8 8215.5 8233.8 8588.0 524.7 574.8 594.1 594.7 605.0 3657.9 3728.2 3741.7 3910.6 3950.7 96303.0 98074.0 98371.0 99052.3 99082.0 79358.6 79700.6 79878.6 80697.0 81618.2 68023.3 68509.0 71311.6 72094.0 73127.0 6083.0 7493.8 7821.5 7877.4 7901.9 45456.1 49999.8 50873.7 51295.5 51333.5 68608.0 70887.3 71001.9 71514.6 72711.3 8284.9 9698.8 9752.7 9815.0 10382.1 10729.2 10800.5 11983.4 12186.6 12723.5 9968.7 11301.3 11396.9 11738.2 11952.0 11253.0 11488.7 11504.1 11593.5 11925.5 10478.0 10687.7 11097.4 11271.7 11813.9 9535.9 9588.4 9635.3 9678.0 9714.8 9474.4 9703.3 9734.5 9770.3 9802.8 06:28:40 INFO - PROCESS | 2582 | -------- Summary: end -------- 06:28:40 INFO - PROCESS | 2582 | 06:28:41 INFO - TEST-INFO | 2582: exit 0 06:28:41 INFO - TEST-OK | dromaeo_css | took 1111396ms 06:28:41 INFO - TEST-START | kraken 06:28:41 INFO - operating with platform_type : mac_ 06:28:41 INFO - Initialising browser for kraken test... 06:28:41 INFO - TEST-INFO | started process 2588 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpwat08G/profile http://localhost:53752/getInfo.html) 06:28:43 INFO - PROCESS | 2588 | __metrics Screen width/height:1600/1200 06:28:43 INFO - PROCESS | 2588 | colorDepth:24 06:28:43 INFO - PROCESS | 2588 | Browser inner width/height: 1024/689 06:28:43 INFO - PROCESS | 2588 | __metrics 06:28:44 ERROR - PROCESS | 2588 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 06:28:44 INFO - TEST-INFO | 2588: exit 0 06:28:44 INFO - Browser initialized. 06:28:44 INFO - Running cycle 1/1 for kraken test... 06:28:44 INFO - TEST-INFO | started process 2591 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpwat08G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:56 INFO - PROCESS | 2591 | RSS: Main: 221118464 06:28:56 INFO - PROCESS | 2591 | 06:28:59 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53752/tests/kraken/driver.html?testName=audio-beat-detection) 06:29:00 INFO - PROCESS | 2591 | RSS: Main: 233205760 06:29:00 INFO - PROCESS | 2591 | 06:29:03 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53752/tests/kraken/driver.html?testName=audio-dft) 06:29:03 INFO - PROCESS | 2591 | RSS: Main: 242122752 06:29:03 INFO - PROCESS | 2591 | 06:29:07 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53752/tests/kraken/driver.html?testName=audio-fft) 06:29:07 INFO - PROCESS | 2591 | RSS: Main: 245723136 06:29:07 INFO - PROCESS | 2591 | 06:29:09 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53752/tests/kraken/driver.html?testName=audio-oscillator) 06:29:10 INFO - PROCESS | 2591 | RSS: Main: 247160832 06:29:10 INFO - PROCESS | 2591 | 06:29:12 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53752/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:29:13 INFO - PROCESS | 2591 | RSS: Main: 247906304 06:29:13 INFO - PROCESS | 2591 | 06:29:15 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53752/tests/kraken/driver.html?testName=imaging-darkroom) 06:29:16 INFO - PROCESS | 2591 | RSS: Main: 247840768 06:29:16 INFO - PROCESS | 2591 | 06:29:19 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53752/tests/kraken/driver.html?testName=imaging-desaturate) 06:29:19 INFO - PROCESS | 2591 | RSS: Main: 247861248 06:29:19 INFO - PROCESS | 2591 | 06:29:22 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53752/tests/kraken/driver.html?testName=json-parse-financial) 06:29:23 INFO - PROCESS | 2591 | RSS: Main: 247873536 06:29:23 INFO - PROCESS | 2591 | 06:29:25 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53752/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:29:25 INFO - PROCESS | 2591 | RSS: Main: 247582720 06:29:25 INFO - PROCESS | 2591 | 06:29:27 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:29:28 INFO - PROCESS | 2591 | RSS: Main: 247689216 06:29:28 INFO - PROCESS | 2591 | 06:29:30 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:29:31 INFO - PROCESS | 2591 | RSS: Main: 247975936 06:29:31 INFO - PROCESS | 2591 | 06:29:34 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:29:34 INFO - PROCESS | 2591 | RSS: Main: 247951360 06:29:34 INFO - PROCESS | 2591 | 06:29:37 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:29:38 INFO - PROCESS | 2591 | RSS: Main: 247975936 06:29:38 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:53752/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53752/tests/kraken/driver.html?testName=ai-astar) 06:29:40 INFO - PROCESS | 2591 | RSS: Main: 249815040 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | __start_tp_report 06:29:40 INFO - PROCESS | 2591 | _x_x_mozilla_page_load 06:29:40 INFO - PROCESS | 2591 | _x_x_mozilla_page_load_details 06:29:40 INFO - PROCESS | 2591 | |i|pagename|runs| 06:29:40 INFO - PROCESS | 2591 | |0;ai-astar;112;120;109;117;119;116;106;119;126;165 06:29:40 INFO - PROCESS | 2591 | |1;audio-beat-detection;152;161;177;161;153;171;154;151;157;121 06:29:40 INFO - PROCESS | 2591 | |2;audio-dft;198;196;201;202;196;198;193;205;205;197 06:29:40 INFO - PROCESS | 2591 | |3;audio-fft;66;113;107;188;82;57;57;59;122;58 06:29:40 INFO - PROCESS | 2591 | |4;audio-oscillator;76;84;138;73;75;79;120;81;80;120 06:29:40 INFO - PROCESS | 2591 | |5;imaging-gaussian-blur;91;88;90;89;93;87;91;89;91;87 06:29:40 INFO - PROCESS | 2591 | |6;imaging-darkroom;95;97;103;97;96;96;97;97;95;96 06:29:40 INFO - PROCESS | 2591 | |7;imaging-desaturate;140;123;92;125;146;101;90;91;93;90 06:29:40 INFO - PROCESS | 2591 | |8;json-parse-financial;62;66;66;65;67;66;66;81;62;59 06:29:40 INFO - PROCESS | 2591 | |9;json-stringify-tinderbox;64;84;111;60;101;100;104;103;83;71 06:29:40 INFO - PROCESS | 2591 | |10;stanford-crypto-aes;86;70;100;106;107;104;100;84;95;107 06:29:40 INFO - PROCESS | 2591 | |11;stanford-crypto-ccm;135;154;131;129;116;140;142;129;183;174 06:29:40 INFO - PROCESS | 2591 | |12;stanford-crypto-pbkdf2;169;223;227;183;167;169;209;169;168;209 06:29:40 INFO - PROCESS | 2591 | |13;stanford-crypto-sha256-iterative;70;60;85;95;101;102;79;68;73;68 06:29:40 INFO - PROCESS | 2591 | __end_tp_report 06:29:40 INFO - PROCESS | 2591 | __start_cc_report 06:29:40 INFO - PROCESS | 2591 | _x_x_mozilla_cycle_collect,1103 06:29:40 INFO - PROCESS | 2591 | __end_cc_report 06:29:40 INFO - PROCESS | 2591 | __startTimestamp1464787780671__endTimestamp 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | ------- Summary: start ------- 06:29:40 INFO - PROCESS | 2591 | Number of tests: 14 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#0] ai-astar Cycles:10 Average:120.90 Median:119.00 stddev:16.54 (13.9%) stddev-sans-first:17.22 06:29:40 INFO - PROCESS | 2591 | Values: 112.0 120.0 109.0 117.0 119.0 116.0 106.0 119.0 126.0 165.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#1] audio-beat-detection Cycles:10 Average:155.80 Median:159.00 stddev:14.89 (9.4%) stddev-sans-first:15.73 06:29:40 INFO - PROCESS | 2591 | Values: 152.0 161.0 177.0 161.0 153.0 171.0 154.0 151.0 157.0 121.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#2] audio-dft Cycles:10 Average:199.10 Median:199.50 stddev:4.01 (2.0%) stddev-sans-first:4.24 06:29:40 INFO - PROCESS | 2591 | Values: 198.0 196.0 201.0 202.0 196.0 198.0 193.0 205.0 205.0 197.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#3] audio-fft Cycles:10 Average:90.90 Median:57.50 stddev:42.48 (73.9%) stddev-sans-first:44.09 06:29:40 INFO - PROCESS | 2591 | Values: 66.0 113.0 107.0 188.0 82.0 57.0 57.0 59.0 122.0 58.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:77.50 stddev:23.77 (30.7%) stddev-sans-first:24.44 06:29:40 INFO - PROCESS | 2591 | Values: 76.0 84.0 138.0 73.0 75.0 79.0 120.0 81.0 80.0 120.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:90.50 stddev:1.96 (2.2%) stddev-sans-first:2.01 06:29:40 INFO - PROCESS | 2591 | Values: 91.0 88.0 90.0 89.0 93.0 87.0 91.0 89.0 91.0 87.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:96.50 stddev:2.28 (2.4%) stddev-sans-first:2.32 06:29:40 INFO - PROCESS | 2591 | Values: 95.0 97.0 103.0 97.0 96.0 96.0 97.0 97.0 95.0 96.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#7] imaging-desaturate Cycles:10 Average:109.10 Median:90.00 stddev:22.20 (24.7%) stddev-sans-first:20.54 06:29:40 INFO - PROCESS | 2591 | Values: 140.0 123.0 92.0 125.0 146.0 101.0 90.0 91.0 93.0 90.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:5.85 (8.9%) stddev-sans-first:6.02 06:29:40 INFO - PROCESS | 2591 | Values: 62.0 66.0 66.0 65.0 67.0 66.0 66.0 81.0 62.0 59.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#9] json-stringify-tinderbox Cycles:10 Average:88.10 Median:62.00 stddev:18.30 (29.5%) stddev-sans-first:17.20 06:29:40 INFO - PROCESS | 2591 | Values: 64.0 84.0 111.0 60.0 101.0 100.0 104.0 103.0 83.0 71.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#10] stanford-crypto-aes Cycles:10 Average:95.90 Median:88.50 stddev:12.29 (13.9%) stddev-sans-first:12.50 06:29:40 INFO - PROCESS | 2591 | Values: 86.0 70.0 100.0 106.0 107.0 104.0 100.0 84.0 95.0 107.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:141.00 stddev:21.13 (15.0%) stddev-sans-first:22.20 06:29:40 INFO - PROCESS | 2591 | Values: 135.0 154.0 131.0 129.0 116.0 140.0 142.0 129.0 183.0 174.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:196.00 stddev:24.86 (12.7%) stddev-sans-first:25.25 06:29:40 INFO - PROCESS | 2591 | Values: 169.0 223.0 227.0 183.0 167.0 169.0 209.0 169.0 168.0 209.0 06:29:40 INFO - PROCESS | 2591 | 06:29:40 INFO - PROCESS | 2591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.10 Median:71.50 stddev:14.96 (20.9%) stddev-sans-first:15.41 06:29:40 INFO - PROCESS | 2591 | Values: 70.0 60.0 85.0 95.0 101.0 102.0 79.0 68.0 73.0 68.0 06:29:40 INFO - PROCESS | 2591 | -------- Summary: end -------- 06:29:40 INFO - PROCESS | 2591 | 06:29:41 INFO - TEST-INFO | 2591: exit 0 06:29:41 INFO - TEST-OK | kraken | took 60013ms 06:29:41 INFO - SUITE-END | took 1171s 06:29:41 INFO - Completed test suite (00:19:31) 06:29:41 INFO - javascript benchmark 06:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.4939759036142, 3443.2424866529363, 3460.6366331535173, 3488.5290485784412, 3510.0873772819077, 5597.21638970544, 5630.690312032847, 5634.323881134264, 5646.0, 5646.463585959337, 5679.4036626154275, 5682.659040457575, 5683.2895888014, 5699.059655156904, 5724.62789918655, 5177.767000484978, 5201.0, 5201.55786758126, 5234.816781412651, 5245.842624721265, 5135.794568217267, 5254.789808407659, 5278.630495865291, 5327.893442131155, 5367.624266301361, 5276.8153114641, 5290.127129023706, 5300.893982120355, 5304.496072873071, 5313.814016509423, 3978.741381810173, 4768.403949506312, 5232.110541207985, 5285.339332583427, 5290.55030322423, 4593.977030114828, 4964.560277519551, 5286.259923610659, 5312.654677445954, 5346.893062138735, 5737.110747834093, 5745.88508229833, 5783.913241301384, 5799.101139323411, 5814.5057670098095, 5372.247885296062, 6085.117657939574, 6110.266767987825, 6133.723982420802, 6181.041938499539, 6131.778844714162, 6159.860425821193, 6184.8763024739255, 6196.473299769525, 6199.101130336121, 4669.976650116761, 5909.940900590982, 5919.644821310735, 5923.940760592382, 5939.970300148515, 5883.61756485827, 6146.108814222002, 6184.81445556634, 6206.193194884727, 6279.058141278753, 5833.591648584643, 6173.950428427178, 6186.938130618636, 6189.876202475925, 6209.627422354673, 5724.570657200727, 5786.710664466844, 6224.253089629274, 6245.6252624842655, 6245.875082498324, 5094.745262736922, 6071.635701857815, 6128.167033931328, 6146.0473626587955, 6196.349383314777, 6156.722947467375, 6197.876042479215, 6202.038684003986, 6202.131701561785, 6238.313785483593, 4891.095147397743, 4893.4617192108835, 4903.53416425439, 4905.0, 4908.852734417973, 4385.539518350527, 4390.4511936008, 4446.199684056836, 4449.421575195269, 4484.798184081724, 4893.339399181136, 5770.163326317745, 5856.472917437366, 5862.179294898718, 5900.970495147582, 5950.345461999176, 6110.7106460192745, 6159.722812473449, 6272.780452684134, 6283.622982621057, 5846.473817356458, 5849.239598852122, 5874.118882167623, 5879.735411906475, 5905.43898329658, 5409.783608655688, 5414.91877621836, 5430.8099216527235, 5433.592480563973, 5437.32033495813, 6223.253209614875, 6280.7487700491465, 6358.2687990879795, 6436.066770318372, 6453.257875344301, 6203.96898015507, 6206.10011548332, 6208.4722798562625, 6224.1597384352535, 6224.284207316216, 6356.586821856565, 6384.904226436514, 6413.4869210463985, 6414.0, 6429.935700642934, 6089.177960975212, 6120.54095942815, 6144.433169541739, 6153.077038444269, 6191.349908259568, 6130.279684642889, 6150.630962142286, 6173.351798061319, 6202.224721909762, 6250.406211409909, 6137.907931381123, 6141.785037523665, 6161.815145545641, 6165.660888651168, 6172.135900973957, 5984.730687119003, 6045.697715114139, 6129.542179248731, 6136.539759518143, 6138.723757431016, 5103.642745007814, 5892.234009578899, 5937.901488224692, 5990.430909063632, 6009.909851352146, 5995.400459953969, 6141.508679305555, 6141.723622436912, 6142.017277235799, 6157.076438534255, 5940.584159108994, 5958.7616495341435, 6002.939970600412, 6017.578769486094, 6055.818325450244], "value": 5672.262464138431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.9882432783089, 517.1544524702113, 520.6745783885071, 559.0245022435848, 642.3415998601433, 31009.689903100963, 41162.79418602907, 41286.38070428946, 41388.79305603475, 41431.17137657253, 42179.36730949038, 42695.57304426955, 42736.14527709444, 43390.56609433905, 43488.78255608718, 9583.66457173999, 9626.75933101671, 9716.028397160298, 9738.951305243463, 9835.31152819303, 9717.222622190244, 9805.803883922317, 9820.312578119534, 9840.950795246014, 9849.65526206583, 9702.563384647672, 9779.022097790199, 9825.65610203643, 9847.16299114576, 9852.014798520126, 9749.902500975006, 9800.411975281506, 9823.0, 9826.263030272758, 9911.603535858558, 9603.711888643353, 9709.854352184722, 9724.173445257162, 9759.902400976041, 9779.168770654504, 39616.405753913714, 40058.399124013165, 40070.0, 40090.0, 40103.7994810027, 3121.672224416449, 3175.7776955613117, 3196.616406031268, 3212.4860022396306, 3319.5020746887917, 27977.0, 28623.570646440112, 28725.569116463063, 28892.844286228526, 29403.558946615816, 2767.9723202767914, 2771.431856469439, 2813.409184071327, 2841.4885320642275, 2867.1255267143515, 490528.0947190554, 495444.0, 498128.0, 498666.0, 500179.0, 52297.0, 63303.0, 63839.04241436382, 63868.68065659642, 63914.680426597566, 70427.64786176036, 71574.64212678903, 71977.0, 72060.63969680118, 72083.63958180175, 17185.39851105205, 17624.383146589807, 17697.469075927744, 17768.200430980636, 17837.554061148574, 13457.394417251247, 13547.932260338832, 13564.253966031964, 13579.321033948263, 13606.251656159006, 17263.827361726475, 19446.22215111408, 19453.0, 19546.60906781885, 19694.507637308896, 6922.930770692329, 7089.858202835914, 7932.682692692343, 8127.75616731499, 8181.67273309061, 944.6599224279254, 985.4579981010415, 994.0804755601184, 1011.3224139826334, 1023.3706270643501, 29876.402471950438, 30309.393812123635, 30347.393052139276, 30612.38775224483, 30668.846655766578, 1103.3545375954996, 1123.938183399921, 1129.0008342616843, 1194.5784516425426, 1257.6478585995935, 15229.0, 15418.6145346365, 15423.0, 15548.611284717972, 15588.309510026533, 507010.0, 635371.0, 646699.0, 647920.0, 648910.0, 58388.708056460295, 60418.39581604215, 60650.0, 60725.69637151786, 60874.69562652247, 1405.1569058564983, 1423.3168079321983, 1452.3101526774697, 1453.6729235922044, 1465.7215129125645, 29890.402191955603, 29896.953606623665, 29991.850040749658, 30468.695313046584, 30509.084727458212, 52932.47067529275, 53206.2019069722, 53324.93350132898, 53454.73272633612, 53528.92942141213, 526082.0, 540209.0, 544210.0, 544691.0, 548186.0, 42047.0, 42592.83103711241, 43481.78259108684, 44421.77789111034, 44463.0, 44813.32780008237, 45370.54629453663, 45842.083158337315, 46203.53796461992, 46757.2986405211, 35635.82182089073, 37692.05769855776, 37760.81119594385, 37763.62236377711, 38136.04659883525, 37677.434838477995, 38029.0, 38830.223395531364, 39230.6076939227, 39591.604083958795, 34764.783232586735, 35088.82455587706, 35969.820150899075, 36487.45268821023, 36750.081247969014, 31143.0, 32917.835410822794, 33080.33839323248, 33183.004509864746, 33304.83347583246, 24861.62384480082, 25087.372815679755, 25113.32683609495, 25324.860381282517, 26123.869380652974], "value": 20398.510101398428, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.18645353130165, 377.6374680306905, 383.80234179397615, 403.0870079270453, 405.9695522835787, 18589.0, 21546.27629789617, 22031.0, 22111.33665990019, 22123.778762212354, 20301.18795248192, 20866.374008779723, 20962.475938101554, 21707.45731356713, 22006.449838754, 5822.796202132926, 5877.441643043904, 6062.666553339586, 6064.272287325527, 6101.542384321171, 5273.525382715555, 6074.0, 6096.35988221237, 6113.174721412597, 6128.601640893327, 5692.146178073281, 6035.939640603604, 6054.848628784293, 6062.787802426916, 6075.0, 5945.851353716149, 5961.986462301419, 6000.549958753068, 6002.309734380558, 6017.06735456005, 5165.767540460651, 5264.7367631618645, 5282.0, 5470.6202801780955, 5778.913316300259, 13297.601071967856, 13430.395632196476, 13454.730905381837, 13491.055626106176, 21945.780542194534, 2089.561192149635, 2179.1719146724304, 2267.353804165821, 2332.183735692511, 2616.5028644557665, 10024.248181386352, 10398.636047738368, 12541.749165016648, 13935.954803389786, 14721.043132196373, 1706.8378504042096, 1718.4844546636084, 1718.6047209141968, 1760.3574695236275, 1811.538057795267, 85652.0, 91866.54066729691, 96020.0, 105119.4744026275, 109010.45494772475, 9609.90390096104, 11499.712507187387, 11543.595974141033, 11872.0, 11993.220440671328, 14790.186539740202, 14980.40078396852, 15008.399664013536, 15009.724173445162, 15118.697626047637, 8128.715494957648, 8295.377846661404, 8790.25282850952, 8797.0, 8830.91169088301, 7911.406644501571, 8764.956175219211, 8776.736697899074, 8811.515366654896, 8856.202941735275, 4569.246074397754, 4571.839985600554, 4617.07658468301, 4622.237330840441, 4647.372604698322, 1974.5853370792008, 2020.8181263686338, 2030.2792508659213, 2050.3746357361147, 2071.461420030803, 885.9557022148866, 990.4057565460666, 1000.1898462245459, 1017.0, 1022.3967858963099, 19992.700109498368, 20197.596048078954, 20209.292674756605, 20673.379798606067, 20743.8962805185, 956.8421210500329, 958.3052287091942, 981.7643765496372, 1002.588938535197, 1017.5065093429681, 10607.310524815863, 10979.560817567368, 10996.835047474295, 11019.504122314514, 11036.337819730841, 226488.0, 238368.0, 420457.0, 436869.0, 646416.0, 108954.0, 126205.36897315455, 128169.3591532055, 140018.0, 141579.0, 446.5043801380465, 461.9422572178478, 462.1657907476969, 462.5813638657021, 464.8953985353336, 10755.838662419914, 10782.975617316342, 10836.970487803646, 11049.17131215146, 11271.211015228855, 44703.21187152478, 47805.521944781496, 47820.2826957589, 49994.0, 52067.47932520778, 71522.64238678773, 74949.6252518734, 75989.62005189939, 76154.61922690351, 76691.61654191693, 6449.838754030999, 7900.881486777818, 7936.682532698858, 7975.162607926316, 8284.751457456287, 10879.0, 11178.832317515407, 11744.119191060534, 11983.64049078529, 12081.516739330329, 10651.786964260516, 10710.464476775975, 10748.516316765921, 10904.94547527289, 10995.460635510875, 10580.20648451354, 10595.576176952836, 10610.787784244427, 10643.680689579016, 10790.0, 10482.475876206006, 10959.397233152253, 10982.176336774934, 11012.39431831257, 11233.887661123612, 8042.115367309708, 8084.989376327959, 8181.590920454072, 8243.815388922061, 8275.08974012846, 7958.960205198937, 9599.568019439002, 10881.183911206534, 10972.396518191576, 11100.833487497855], "value": 8958.349823460456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1574.0712979342188, 1581.9683606327878, 1781.8752687311885, 1811.1306572845035, 1951.2585217617304, 8064.153263907293, 8801.251893589037, 8864.024957254705, 9168.449893006407, 9193.58628861701, 9012.774680632987, 9067.365284430076, 9072.36493445459, 9164.266858651308, 9188.632454701803, 2500.187439082301, 2508.523380557688, 2518.8866501007496, 2526.2421273617933, 2534.9733357990044, 2474.5669507836055, 2498.350428888493, 2524.3184340228127, 2525.1288305534563, 2532.9240122796346, 2493.0651005872796, 2495.7129930058004, 2501.5122051199933, 2503.249025292414, 2518.2067648690604, 2480.528699547089, 2489.3154382544853, 2502.949941001188, 2512.309114993373, 2512.673352464168, 2454.6195339722194, 2466.0, 2485.6644353012475, 2490.68866391701, 2526.178991827663, 9099.22656574192, 9128.45229286245, 9129.589168487368, 9170.266378689688, 9199.172074513326, 5518.227448157261, 5585.553155747531, 5617.185508101303, 5622.57830662702, 5638.323401191842, 2697.325668582854, 3264.069740124077, 3299.307145499448, 3516.841742121585, 3540.274243780019, 1062.5484169228048, 1065.211743309953, 1066.5946940162767, 1074.2007138043746, 1085.2403317677579, 9724.270679699051, 12191.45138468771, 12419.379031048502, 12462.43919023646, 12495.000399968072, 4984.227444745998, 4991.101601711654, 5001.099802035668, 5009.674371165863, 5029.899402011939, 10494.475276236157, 10519.579216831395, 10548.261621686408, 10553.63062292816, 10557.419341936115, 5571.220029195916, 5618.0, 5642.181883626851, 5657.688827114466, 5696.943030569724, 4455.77721113943, 4461.9514414112655, 4874.780634871439, 4979.0788704089855, 4983.626228032912, 3430.2281986553326, 4191.937120943188, 4239.745615263094, 4255.29787585045, 4288.978555107267, 1178.3754610056683, 1182.4737991593831, 1379.4551152294787, 1393.7978993045951, 1395.2605119286795, 852.3394369363792, 892.8035832116924, 896.6323807239131, 939.8966113727485, 950.6910254167424, 5987.072003839412, 5990.0, 6074.0, 6078.300995385587, 6265.373462653698, 894.4633220067907, 980.9362391444533, 990.232569758443, 991.5438898106952, 1011.9089281964511, 3205.83970801459, 3524.0, 3608.657177568127, 3944.1322908959983, 4028.5971402860064, 8871.733847984571, 10463.006014428616, 10770.461476926122, 10854.62008829703, 11065.948734870335, 9022.684206052756, 10781.975712307318, 10873.021428071512, 10894.40080795548, 10947.890521094847, 8110.5539195343645, 8473.237408633253, 8474.449160804528, 8475.110113438124, 8500.319974402157, 5670.809130082729, 5714.885702286014, 5725.141228815544, 5780.104083867007, 5815.79644712433, 9463.668771592962, 9469.810603788024, 9783.315167938175, 9814.411135331902, 9822.410655360702, 9800.264980126376, 9822.410655360702, 10109.19126469866, 10149.949250253701, 10229.181665466596, 6970.79087627372, 7409.740659076906, 7655.196204398458, 7710.691572337268, 7896.0, 8302.750917472244, 8415.915840841513, 8427.0, 8439.451435656663, 8488.74533763988, 7363.595002274927, 7535.73624923147, 7587.772366829004, 7599.772006839804, 7605.467617266738, 6418.743250269937, 7310.086239220098, 7331.6334183289555, 7433.516821406592, 7469.1037075551285, 7022.754203603054, 7124.073870396815, 7133.144022717307, 7165.462590305852, 7169.175544812205, 4916.655834091579, 4951.3810773653295, 5005.0, 5013.699178049329, 5046.444891062054, 4639.791209395653, 5005.499450054966, 5038.697678139323, 5149.253358263106, 5165.586753059671], "value": 4680.019218551869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.34767790579883, 327.81642280323007, 329.22139140931694, 332.09338505878935, 338.2372749449993, 6653.567518111326, 6655.767048153316, 6716.361945615165, 6812.420944219735, 6818.420434263094, 5674.347450043247, 6646.867062658744, 6680.632565208912, 6685.097511835913, 6712.463002959764, 4746.264329029006, 4791.233402655575, 4916.1888288432365, 4945.738836596663, 4951.900961980758, 4791.592714619244, 4914.778834952418, 4935.383077115361, 4937.456879743226, 4938.827141050064, 4871.050145221683, 4882.096812089775, 4890.046440944017, 4962.702237865721, 4997.5252351026775, 4941.431735350445, 4941.950580494185, 4959.429665588467, 4962.503749625044, 4969.8012079516775, 4258.041940563348, 4260.573942605745, 4265.658747300239, 4273.230818452677, 4273.952881544011, 6249.0938813871735, 6400.839979000516, 6433.324500927382, 6453.1610890583925, 6494.707738151795, 5860.501857342131, 5910.852228694274, 5925.407459254083, 5931.851703707442, 5939.287285525765, 7121.430285577141, 7181.6409179540815, 7195.6042417667, 7196.388306993912, 7248.565086094851, 4742.1227072991605, 4783.760811959388, 4789.401324834395, 4792.616590672773, 4811.206150985084, 7303.196648368676, 7485.176630570633, 7572.621368931532, 7579.810504737426, 7590.3548198403205, 4851.902961940812, 4876.073546026244, 4877.951220487821, 4879.097366987119, 4882.12121818069, 4920.065187614414, 4962.5533701967, 4978.477259887732, 4978.502149785065, 4989.725565093955, 5881.823545293648, 5890.793822216202, 5892.234009578813, 5904.675242861598, 5930.822075337746, 6469.708863101172, 6628.105205797156, 7221.277872212737, 7238.565686058748, 7238.84178531443, 1707.581642497596, 1726.3008481564987, 1730.8788384813195, 1732.1512458895052, 1733.6706025855046, 1012.3520946594185, 1057.0697785948316, 1060.4220699718671, 1061.2253055269696, 1118.457548089176, 6593.967030164915, 6646.235682896432, 6689.5986240825705, 6699.832504187434, 6719.832004199934, 7184.892226616605, 7485.70057197706, 7497.212792656802, 7498.362639175732, 7503.8499230015095, 6553.049807777846, 6648.301928297459, 6690.19717633887, 6781.11845460087, 6782.457403407716, 3954.9011274717786, 3981.6217459341315, 3984.860529881498, 3988.0428697112484, 3989.3218152914073, 7790.87032380313, 7882.487638303492, 7938.960305198552, 7948.483348582439, 7974.122846486882, 6801.18385793708, 7467.663955122032, 7819.804504887424, 7831.6475758591005, 7868.134505204423, 6285.528585356116, 6662.533622646368, 7911.485753426009, 7931.127575966639, 7946.086200087064, 7169.4981351304905, 7500.474966752275, 7503.699852005859, 7557.2820582044615, 7566.016417865642, 7390.704371825067, 7390.704371825067, 7396.186419493743, 7405.148407933157, 7442.96278518604, 6311.990081586924, 7803.453758236869, 7920.762377128695, 7925.564093974886, 7939.841203175789, 4680.344751734692, 4719.5752382285755, 4721.551452611996, 4725.220338644085, 4742.88142796419, 7600.885986710315, 7643.159252482112, 7655.617219139132, 7671.578063206577, 7700.961495192488, 7143.892841607484, 7146.499745017799, 7181.569105853666, 7191.280871912767, 7261.6006119663925, 7015.964920175366, 7191.964040179766, 7222.06113205301, 7249.963750181215, 7258.274172582699, 6048.455638992512, 6965.199002114619, 7071.080759501232, 7086.433085353056, 7094.184168820445, 5820.70896455184, 6145.784897528565, 7193.640317983975, 7262.455315851226, 7272.527285726411, 7051.471139664443, 7088.787336379917, 7093.113360829896, 7098.964505177441, 7122.358987691133], "value": 5267.295546760465, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.6774951271927, 723.1611330856205, 746.5259560179285, 754.3324158120065, 767.7274567528527, 15020.549383518484, 15041.774373384394, 15280.312385942632, 15323.004004739683, 15329.310181041852, 10407.167426605873, 11193.44032798361, 13899.235542045184, 13988.37052332645, 14048.71902561948, 725.2457444257965, 732.9193788683241, 896.3456676626067, 910.622091831889, 927.7726956895536, 896.6547879066541, 916.4134953629682, 919.9264058875308, 924.0851556958596, 932.2262522106669, 972.9854052189223, 974.2887691984855, 978.0561757903622, 983.0415345038601, 984.8965858584853, 961.8028304197622, 975.7121649113564, 977.2084611464736, 979.4955597867104, 980.8822941247024, 694.7429451103073, 716.2372073741449, 728.9781306560811, 730.857482790856, 731.6341829085458, 14742.557723268319, 14784.334704938303, 14943.626409339744, 14971.251437428085, 15042.097474151586, 12737.617871463872, 12789.808152877715, 12951.222926624338, 13035.674108147277, 13166.53917112906, 9568.33021688482, 9787.804243915152, 9824.41053536783, 9930.652427165014, 9993.300468967174, 2999.9100026999226, 3531.788092714445, 3566.8394922228563, 3591.982040089783, 3753.361928472139, 75309.62345188294, 75828.0, 78407.82388264181, 78675.0, 79062.0, 9571.856422153673, 9638.180754635934, 9712.902870971342, 9780.972997835124, 10178.694639160836, 21833.0, 21895.562088758135, 22116.778832211792, 22380.44048898758, 22523.099076037102, 7543.585102819397, 7622.656980435893, 7626.923730762733, 7733.381329493627, 7773.611319434119, 4131.32708484965, 4132.958670413317, 4213.87358379243, 4225.704200705983, 4288.0, 3503.7547371683736, 3557.7153827693724, 3565.7860528368383, 3576.052346128226, 3578.2306804037257, 563.9210510528529, 645.6771614192903, 651.5406638319973, 655.8294843340766, 657.5397221944658, 530.4297879779252, 574.9626274292158, 595.2767387623971, 597.9043353063576, 609.8536351275662, 8080.4343695940715, 8185.79535511617, 8215.465994710325, 8233.79415514617, 8587.95706021466, 524.6642149024627, 574.8072749045747, 594.1444320178929, 594.6877889108166, 604.9637021778619, 3657.8725189962197, 3728.2357116790995, 3741.663250307485, 3910.550286717007, 3950.7234493585747, 96303.0, 98074.01925980792, 98371.0, 99052.27122976804, 99082.0, 79358.6032069836, 79700.60149699214, 79878.60060699776, 80697.0, 81618.18381816224, 68023.31976680268, 68509.0, 71311.64344178246, 72094.0, 73127.0, 6083.0, 7493.775186744407, 7821.491603045783, 7877.448578599443, 7901.920980790119, 45456.09087818291, 49999.750006250135, 50873.74563127161, 51295.48704512907, 51333.459996200174, 68608.0, 70887.29112708807, 71001.93497097444, 71514.56970860658, 72711.27288727045, 8284.917150828414, 9698.806023879342, 9752.658656946973, 9815.0, 10382.117520010883, 10729.248952573556, 10800.513976870903, 11983.400829958642, 12186.634400967985, 12723.491060357483, 9968.704068471052, 11301.321920684784, 11396.886031139582, 11738.178327516991, 11952.0, 11253.043491303331, 11488.655340339803, 11504.079673625922, 11593.478293476644, 11925.463354149259, 10478.00458956398, 10687.679369618923, 11097.389643569359, 11271.718207044889, 11813.936745692929, 9535.904640953502, 9588.43958325037, 9635.277354198603, 9677.951610242186, 9714.75713107178, 9474.431534107976, 9703.320767546204, 9734.46460444654, 9770.267229957639, 9802.75493112678], "value": 6881.223502897994, "unit": "score"}], "name": "dromaeo_css", "value": 7484.912373934968, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 120.0, 109.0, 117.0, 119.0, 116.0, 106.0, 119.0, 126.0, 165.0], "value": 120.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 161.0, 177.0, 161.0, 153.0, 171.0, 154.0, 151.0, 157.0, 121.0], "value": 155.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 201.0, 202.0, 196.0, 198.0, 193.0, 205.0, 205.0, 197.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 113.0, 107.0, 188.0, 82.0, 57.0, 57.0, 59.0, 122.0, 58.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 138.0, 73.0, 75.0, 79.0, 120.0, 81.0, 80.0, 120.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 89.0, 93.0, 87.0, 91.0, 89.0, 91.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 103.0, 97.0, 96.0, 96.0, 97.0, 97.0, 95.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 123.0, 92.0, 125.0, 146.0, 101.0, 90.0, 91.0, 93.0, 90.0], "value": 109.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 81.0, 62.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 84.0, 111.0, 60.0, 101.0, 100.0, 104.0, 103.0, 83.0, 71.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 100.0, 106.0, 107.0, 104.0, 100.0, 84.0, 95.0, 107.0], "value": 95.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 154.0, 131.0, 129.0, 116.0, 140.0, 142.0, 129.0, 183.0, 174.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 223.0, 227.0, 183.0, 167.0, 169.0, 209.0, 169.0, 168.0, 209.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 60.0, 85.0, 95.0, 101.0, 102.0, 79.0, 68.0, 73.0, 68.0], "value": 80.1, "unit": "score"}], "name": "kraken", "value": 1617.6, "alertThreshold": 2.0}]} 06:29:41 INFO - Return code: 0 06:29:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:29:41 ERROR - # TBPL SUCCESS # 06:29:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:29:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:29:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:29:41 INFO - 2016-06-01 06:29:41.976 screenresolution[2596:30173] starting screenresolution argv=screenresolution get 06:29:41 INFO - 2016-06-01 06:29:41.979 screenresolution[2596:30173] Display 0: 1600x1200x32@60 06:29:41 INFO - 2016-06-01 06:29:41.985 screenresolution[2597:30177] starting screenresolution argv=screenresolution list 06:29:41 INFO - Available Modes on Display 0 06:29:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:29:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:29:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:29:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:29:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:29:42 INFO - Intel Iris: 06:29:42 INFO - Chipset Model: Intel Iris 06:29:42 INFO - Type: GPU 06:29:42 INFO - Bus: Built-In 06:29:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:29:42 INFO - Vendor: Intel (0x8086) 06:29:42 INFO - Device ID: 0x0a2e 06:29:42 INFO - Revision ID: 0x0009 06:29:42 INFO - Displays: 06:29:42 INFO - Display: 06:29:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:29:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:29:42 INFO - Display Serial Number: 1600x1200 60 06:29:42 INFO - Main Display: Yes 06:29:42 INFO - Mirror: Off 06:29:42 INFO - Online: Yes 06:29:42 INFO - Rotation: Supported 06:29:42 INFO - Return code: 0 06:29:42 INFO - Running post-action listener: _resource_record_post_action 06:29:42 INFO - Running post-run listener: _resource_record_post_run 06:29:43 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 258048; Write bytes: 656904192; Read time: 3; Write time: 1893 06:29:43 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 354609664; Write bytes: 355936256; Read time: 27685; Write time: 746 06:29:43 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 258048; Write bytes: 298476032; Read time: 3; Write time: 1135 06:29:43 INFO - Running post-run listener: _upload_blobber_files 06:29:43 INFO - Blob upload gear active. 06:29:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:29:43 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 06:29:43 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'] 06:29:43 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 06:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:44 INFO - (blobuploader) - INFO - Done attempting. 06:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:29:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:29:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:29:45 INFO - (blobuploader) - INFO - Done attempting. 06:29:45 INFO - (blobuploader) - INFO - Iteration through files over. 06:29:45 INFO - Return code: 0 06:29:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:29:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:29:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f72a92b19a796f3ea5e882d4f724cacaaa21c6ce0b83aaea33fadca0aa67c950653c3f0a7d2ee0a79d9ff8605f97b061a11c88bd41cbef25894ec1e02d0f0377", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec18efe0705294179a7ee26598e1cc930a32a899517ae0e1d826895b5cc6f7eac29f547c2c8c87a971e75c489964b7b6e2c445a384dc6629f1ccedb47f8abd2"} 06:29:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:29:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:29:45 INFO - Contents: 06:29:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f72a92b19a796f3ea5e882d4f724cacaaa21c6ce0b83aaea33fadca0aa67c950653c3f0a7d2ee0a79d9ff8605f97b061a11c88bd41cbef25894ec1e02d0f0377", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec18efe0705294179a7ee26598e1cc930a32a899517ae0e1d826895b5cc6f7eac29f547c2c8c87a971e75c489964b7b6e2c445a384dc6629f1ccedb47f8abd2"} 06:29:45 INFO - Running post-run listener: copy_logs_to_upload_dir 06:29:45 INFO - Copying logs to upload dir... 06:29:45 INFO - mkdir: /builds/slave/test/build/upload/logs 06:29:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1345.287400 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2016-06-01 06:29:46.349131) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 06:29:46.353028) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTKdSsNX6E/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f72a92b19a796f3ea5e882d4f724cacaaa21c6ce0b83aaea33fadca0aa67c950653c3f0a7d2ee0a79d9ff8605f97b061a11c88bd41cbef25894ec1e02d0f0377", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec18efe0705294179a7ee26598e1cc930a32a899517ae0e1d826895b5cc6f7eac29f547c2c8c87a971e75c489964b7b6e2c445a384dc6629f1ccedb47f8abd2"} build_url:https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/RqSpbPNDS-eOOU4ZopfEKw/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f72a92b19a796f3ea5e882d4f724cacaaa21c6ce0b83aaea33fadca0aa67c950653c3f0a7d2ee0a79d9ff8605f97b061a11c88bd41cbef25894ec1e02d0f0377", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cec18efe0705294179a7ee26598e1cc930a32a899517ae0e1d826895b5cc6f7eac29f547c2c8c87a971e75c489964b7b6e2c445a384dc6629f1ccedb47f8abd2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 06:29:46.384620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:29:46.384964) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTKdSsNX6E/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.pXVrzpOnwC/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005313 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:29:46.434847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 06:29:46.435383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 06:29:46.435975) ========= ========= Total master_lag: 0.56 =========