builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0036 starttime: 1461528568.97 results: success (0) buildid: 20160424112253 builduid: eb832a50cfa34e9e8973982c06b07fa4 revision: eefaf5e207f01443d61a15b6d22a01979fbfeda9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:28.974663) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:28.975125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:28.975404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:28.997994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:28.998369) ========= 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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-04-24 13:09:29-- 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% 161M=0s 2016-04-24 13:09:29 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192009 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:29.372951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:29.373271) ========= 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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.026598 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:29.576207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-24 13:09:29.576556) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eefaf5e207f01443d61a15b6d22a01979fbfeda9 --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 eefaf5e207f01443d61a15b6d22a01979fbfeda9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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-04-24 13:09:29,646 truncating revision to first 12 chars 2016-04-24 13:09:29,646 Setting DEBUG logging. 2016-04-24 13:09:29,646 attempt 1/10 2016-04-24 13:09:29,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/eefaf5e207f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 13:09:30,440 unpacking tar archive at: mozilla-aurora-eefaf5e207f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.034409 ========= master_lag: 4.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-24 13:09:34.670376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:34.670920) ========= script_repo_revision: eefaf5e207f01443d61a15b6d22a01979fbfeda9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 13:09:34.671377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-04-24 13:09:34.671667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-04-24 13:09:35.862842) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-24 13:09:35.863151) ========= /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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:09:36 INFO - MultiFileLogger online at 20160424 13:09:36 in /builds/slave/test 13:09:36 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 13:09:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:36 INFO - {'append_to_log': False, 13:09:36 INFO - 'base_work_dir': '/builds/slave/test', 13:09:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:09:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:36 INFO - 'branch': 'Mozilla-Aurora', 13:09:36 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:36 INFO - 'config_files': ('talos/mac_config.py',), 13:09:36 INFO - 'default_actions': ('clobber', 13:09:36 INFO - 'read-buildbot-config', 13:09:36 INFO - 'download-and-extract', 13:09:36 INFO - 'populate-webroot', 13:09:36 INFO - 'create-virtualenv', 13:09:36 INFO - 'install', 13:09:36 INFO - 'run-tests'), 13:09:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:36 INFO - 'download_minidump_stackwalk': True, 13:09:36 INFO - 'download_symbols': 'ondemand', 13:09:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:36 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:36 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:36 INFO - 'installer_path': 'installer.exe', 13:09:36 INFO - 'log_level': 'info', 13:09:36 INFO - 'log_name': 'talos', 13:09:36 INFO - 'log_to_console': True, 13:09:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:09:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:09:36 INFO - 'opt_config_files': (), 13:09:36 INFO - 'pip_index': False, 13:09:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:09:36 INFO - 'cmd': ('bash', 13:09:36 INFO - '-c', 13:09:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:09:36 INFO - 'enabled': True, 13:09:36 INFO - 'halt_on_failure': False, 13:09:36 INFO - 'name': 'check_screen_resolution'},), 13:09:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:09:36 INFO - 'cmd': ('bash', 13:09:36 INFO - '-c', 13:09:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:09:36 INFO - 'enabled': True, 13:09:36 INFO - 'halt_on_failure': False, 13:09:36 INFO - 'name': 'check_screen_resolution'},), 13:09:36 INFO - 'run_cmd_checks_enabled': True, 13:09:36 INFO - 'sps_profile': False, 13:09:36 INFO - 'sps_profile_interval': 0, 13:09:36 INFO - 'suite': 'dromaeojs-e10s', 13:09:36 INFO - 'system_bits': '32', 13:09:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:36 INFO - 'title': 't-yosemite-r7-0036', 13:09:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:36 INFO - 'use_talos_json': True, 13:09:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:36 INFO - 'work_dir': 'build'} 13:09:36 INFO - ##### 13:09:36 INFO - ##### Running clobber step. 13:09:36 INFO - ##### 13:09:36 INFO - Running pre-action listener: _resource_record_pre_action 13:09:36 INFO - Running main action method: clobber 13:09:36 INFO - rmtree: /builds/slave/test/build 13:09:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:37 INFO - Running post-action listener: _resource_record_post_action 13:09:37 INFO - ##### 13:09:37 INFO - ##### Running read-buildbot-config step. 13:09:37 INFO - ##### 13:09:37 INFO - Running pre-action listener: _resource_record_pre_action 13:09:37 INFO - Running main action method: read_buildbot_config 13:09:37 INFO - Using buildbot properties: 13:09:37 INFO - { 13:09:37 INFO - "project": "", 13:09:37 INFO - "product": "firefox", 13:09:37 INFO - "script_repo_revision": "production", 13:09:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:09:37 INFO - "repository": "", 13:09:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:09:37 INFO - "buildid": "20160424112253", 13:09:37 INFO - "pgo_build": "False", 13:09:37 INFO - "basedir": "/builds/slave/test", 13:09:37 INFO - "buildnumber": 292, 13:09:37 INFO - "slavename": "t-yosemite-r7-0036", 13:09:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:09:37 INFO - "platform": "yosemite_r7", 13:09:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:09:37 INFO - "branch": "mozilla-aurora", 13:09:37 INFO - "repo_path": "releases/mozilla-aurora", 13:09:37 INFO - "revision": "eefaf5e207f01443d61a15b6d22a01979fbfeda9", 13:09:37 INFO - "stage_platform": "macosx64", 13:09:37 INFO - "builduid": "eb832a50cfa34e9e8973982c06b07fa4", 13:09:37 INFO - "slavebuilddir": "test" 13:09:37 INFO - } 13:09:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 13:09:37 INFO - Running post-action listener: _resource_record_post_action 13:09:37 INFO - ##### 13:09:37 INFO - ##### Running download-and-extract step. 13:09:37 INFO - ##### 13:09:37 INFO - Running pre-action listener: _resource_record_pre_action 13:09:37 INFO - Running main action method: download_and_extract 13:09:37 INFO - mkdir: /builds/slave/test/build/tests 13:09: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')]} 13:09:37 INFO - https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 13:09:39 INFO - Downloaded 1277 bytes. 13:09:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:09:39 INFO - Using the following test package requirements: 13:09:39 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:09:39 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 13:09:39 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 13:09:39 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'jsshell-mac.zip'], 13:09:39 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 13:09:39 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:09:39 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 13:09:39 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 13:09:39 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 13:09:39 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:09:39 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:09:39 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 13:09:39 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:09:39 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')]} 13:09:39 INFO - https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:09:40 INFO - Downloaded 17919104 bytes. 13:09:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:09:43 INFO - Return code: 0 13:09:43 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:43 INFO - https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:09:44 INFO - Downloaded 17919104 bytes. 13:09:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:09:48 INFO - Return code: 0 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:09:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:09:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:09:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:09:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:09:49 INFO - Downloaded 10845194 bytes. 13:09:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:09:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:09:49 INFO - Return code: 0 13:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:49 INFO - https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 13:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 13:09:52 INFO - Downloaded 115768132 bytes. 13:09:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:09:52 INFO - mkdir: /builds/slave/test/properties 13:09:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:52 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:52 INFO - Contents: 13:09:52 INFO - build_url:https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:09:53 INFO - Running post-action listener: _resource_record_post_action 13:09:53 INFO - Running post-action listener: set_extra_try_arguments 13:09:53 INFO - ##### 13:09:53 INFO - ##### Running populate-webroot step. 13:09:53 INFO - ##### 13:09:53 INFO - Running pre-action listener: _resource_record_pre_action 13:09:53 INFO - Running main action method: populate_webroot 13:09:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:53 INFO - '--tppagecycles', 13:09:53 INFO - '7'], 13:09:53 INFO - 'tests': ['tsvgm']}}, 13:09:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:09:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:09:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'tests': ['damp', 'tps']}, 13:09:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['damp', 'tps']}, 13:09:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:09:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:53 INFO - 'other': {'tests': ['a11yr', 13:09:53 INFO - 'ts_paint', 13:09:53 INFO - 'tpaint', 13:09:53 INFO - 'sessionrestore', 13:09:53 INFO - 'sessionrestore_no_auto_restore', 13:09:53 INFO - 'tabpaint']}, 13:09:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['a11yr', 13:09:53 INFO - 'ts_paint', 13:09:53 INFO - 'tpaint', 13:09:53 INFO - 'sessionrestore', 13:09:53 INFO - 'sessionrestore_no_auto_restore', 13:09:53 INFO - 'tabpaint']}, 13:09:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['a11yr', 13:09:53 INFO - 'ts_paint', 13:09:53 INFO - 'tpaint', 13:09:53 INFO - 'sessionrestore', 13:09:53 INFO - 'sessionrestore_no_auto_restore', 13:09:53 INFO - 'tabpaint']}, 13:09:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['a11yr', 13:09:53 INFO - 'ts_paint', 13:09:53 INFO - 'tpaint', 13:09:53 INFO - 'sessionrestore', 13:09:53 INFO - 'sessionrestore_no_auto_restore', 13:09:53 INFO - 'tabpaint']}, 13:09:53 INFO - 'other_l64': {'tests': ['a11yr', 13:09:53 INFO - 'ts_paint', 13:09:53 INFO - 'tpaint', 13:09:53 INFO - 'sessionrestore', 13:09:53 INFO - 'sessionrestore_no_auto_restore', 13:09:53 INFO - 'tabpaint']}, 13:09:53 INFO - 'other_nol64': {'tests': ['a11yr', 13:09:53 INFO - 'ts_paint', 13:09:53 INFO - 'tpaint', 13:09:53 INFO - 'sessionrestore', 13:09:53 INFO - 'sessionrestore_no_auto_restore', 13:09:53 INFO - 'tabpaint']}, 13:09:53 INFO - 'svgr': {'tests': ['tsvgx', 13:09:53 INFO - 'tsvgr_opacity', 13:09:53 INFO - 'tart', 13:09:53 INFO - 'tscrollx', 13:09:53 INFO - 'cart']}, 13:09:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['tsvgx', 13:09:53 INFO - 'tsvgr_opacity', 13:09:53 INFO - 'tart', 13:09:53 INFO - 'tscrollx', 13:09:53 INFO - 'cart']}, 13:09:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'tests': ['tp5o']}, 13:09:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'talos_options': ['--e10s'], 13:09:53 INFO - 'tests': ['tp5o']}, 13:09:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'talos_options': ['--xperf_path', 13:09:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:53 INFO - 'tests': ['tp5n']}, 13:09:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:53 INFO - 'talos_options': ['--e10s', 13:09:53 INFO - '--xperf_path', 13:09:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:53 INFO - 'tests': ['tp5n']}}, 13:09:53 INFO - 'talos.zip': {'path': '', 13:09:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:53 INFO - Running post-action listener: _resource_record_post_action 13:09:53 INFO - ##### 13:09:53 INFO - ##### Running create-virtualenv step. 13:09:53 INFO - ##### 13:09:53 INFO - Running pre-action listener: _resource_record_pre_action 13:09:53 INFO - Running main action method: create_virtualenv 13:09:53 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:53 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 13:09:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:53 INFO - Using real prefix '/tools/python27' 13:09:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:54 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:57 INFO - Installing pip.................done. 13:09:57 INFO - Return code: 0 13:09:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:09:57 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 13:09:57 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 13:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:57 INFO - 'HOME': '/Users/cltbld', 13:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:57 INFO - 'LOGNAME': 'cltbld', 13:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:57 INFO - 'MOZ_NO_REMOTE': '1', 13:09:57 INFO - 'NO_EM_RESTART': '1', 13:09:57 INFO - 'PAGER': '/bin/cat', 13:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:57 INFO - 'PWD': '/builds/slave/test', 13:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:57 INFO - 'SHELL': '/bin/bash', 13:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:09:57 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:57 INFO - 'USER': 'cltbld', 13:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:57 INFO - 'XPC_FLAGS': '0x0', 13:09:57 INFO - 'XPC_SERVICE_NAME': '0', 13:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:57 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 13:09:57 INFO - Cleaning up... 13:09:57 INFO - Return code: 0 13:09:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:09:57 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 13:09:57 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 13:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:57 INFO - 'HOME': '/Users/cltbld', 13:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:57 INFO - 'LOGNAME': 'cltbld', 13:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:57 INFO - 'MOZ_NO_REMOTE': '1', 13:09:57 INFO - 'NO_EM_RESTART': '1', 13:09:57 INFO - 'PAGER': '/bin/cat', 13:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:57 INFO - 'PWD': '/builds/slave/test', 13:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:57 INFO - 'SHELL': '/bin/bash', 13:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:09:57 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:57 INFO - 'USER': 'cltbld', 13:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:57 INFO - 'XPC_FLAGS': '0x0', 13:09:57 INFO - 'XPC_SERVICE_NAME': '0', 13:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:58 INFO - Downloading/unpacking psutil>=0.7.1 13:09:58 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 13:09:58 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 13:09:58 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 13:09:58 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 13:09:58 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 13:09:58 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 13:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:01 INFO - Installing collected packages: psutil 13:10:01 INFO - Running setup.py install for psutil 13:10:01 INFO - building 'psutil._psutil_osx' extension 13:10:01 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 13:10:01 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 13:10:01 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 13:10:01 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 13:10:01 INFO - building 'psutil._psutil_posix' extension 13:10:01 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 13:10:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:10:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:10:02 INFO - ^ 13:10:02 INFO - 1 warning generated. 13:10:02 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 13:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:10:02 INFO - Successfully installed psutil 13:10:02 INFO - Cleaning up... 13:10:02 INFO - Return code: 0 13:10:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:02 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:02 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 13:10:02 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 13:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:02 INFO - 'HOME': '/Users/cltbld', 13:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:02 INFO - 'LOGNAME': 'cltbld', 13:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:02 INFO - 'MOZ_NO_REMOTE': '1', 13:10:02 INFO - 'NO_EM_RESTART': '1', 13:10:02 INFO - 'PAGER': '/bin/cat', 13:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:02 INFO - 'PWD': '/builds/slave/test', 13:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:02 INFO - 'SHELL': '/bin/bash', 13:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:02 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:02 INFO - 'USER': 'cltbld', 13:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:02 INFO - 'XPC_FLAGS': '0x0', 13:10:02 INFO - 'XPC_SERVICE_NAME': '0', 13:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 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 13:10:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:10:05 INFO - Installing collected packages: mozsystemmonitor 13:10:05 INFO - Running setup.py install for mozsystemmonitor 13:10:05 INFO - Successfully installed mozsystemmonitor 13:10:05 INFO - Cleaning up... 13:10:05 INFO - Return code: 0 13:10:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:10: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')]} 13:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10: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')]} 13:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:05 INFO - 'HOME': '/Users/cltbld', 13:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:05 INFO - 'LOGNAME': 'cltbld', 13:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:05 INFO - 'MOZ_NO_REMOTE': '1', 13:10:05 INFO - 'NO_EM_RESTART': '1', 13:10:05 INFO - 'PAGER': '/bin/cat', 13:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:05 INFO - 'PWD': '/builds/slave/test', 13:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:05 INFO - 'SHELL': '/bin/bash', 13:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:05 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:05 INFO - 'USER': 'cltbld', 13:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:05 INFO - 'XPC_FLAGS': '0x0', 13:10:05 INFO - 'XPC_SERVICE_NAME': '0', 13:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:10:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:10:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:09 INFO - Downloading docopt-0.6.1.tar.gz 13:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:10:09 INFO - Installing collected packages: blobuploader, requests, docopt 13:10:09 INFO - Running setup.py install for blobuploader 13:10:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:10:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:10:09 INFO - Running setup.py install for requests 13:10:09 INFO - Running setup.py install for docopt 13:10:10 INFO - Successfully installed blobuploader requests docopt 13:10:10 INFO - Cleaning up... 13:10:10 INFO - Return code: 0 13:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:10 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')]} 13:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:10 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')]} 13:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:10 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:10 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 13:10:10 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 13:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:10 INFO - 'HOME': '/Users/cltbld', 13:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:10 INFO - 'LOGNAME': 'cltbld', 13:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:10 INFO - 'MOZ_NO_REMOTE': '1', 13:10:10 INFO - 'NO_EM_RESTART': '1', 13:10:10 INFO - 'PAGER': '/bin/cat', 13:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:10 INFO - 'PWD': '/builds/slave/test', 13:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:10 INFO - 'SHELL': '/bin/bash', 13:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:10 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:10 INFO - 'USER': 'cltbld', 13:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:10 INFO - 'XPC_FLAGS': '0x0', 13:10:10 INFO - 'XPC_SERVICE_NAME': '0', 13:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:10 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CvYPvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:10 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qyJhxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:10 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Z1Zy4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:10 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Rkw5Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:10 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Ewd0zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:10 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-AP80mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KRSnNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-5Xivon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-xKqFFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nxgmT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-yBI0Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-grhzTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-aMIZje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ocYKOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-N9BTYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:11 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-uuO2Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:12 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Jbneob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:10:12 INFO - Running setup.py install for manifestparser 13:10:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:10:12 INFO - Running setup.py install for mozcrash 13:10:12 INFO - Running setup.py install for mozdebug 13:10:12 INFO - Running setup.py install for mozdevice 13:10:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:10:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:10:12 INFO - Running setup.py install for mozfile 13:10:12 INFO - Running setup.py install for mozhttpd 13:10:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Running setup.py install for mozinfo 13:10:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Running setup.py install for mozInstall 13:10:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Running setup.py install for mozleak 13:10:13 INFO - Running setup.py install for mozlog 13:10:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Running setup.py install for moznetwork 13:10:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:10:13 INFO - Running setup.py install for mozprocess 13:10:13 INFO - Running setup.py install for mozprofile 13:10:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:10:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:10:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:10:14 INFO - Running setup.py install for mozrunner 13:10:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:10:14 INFO - Running setup.py install for mozscreenshot 13:10:14 INFO - Running setup.py install for moztest 13:10:14 INFO - Running setup.py install for mozversion 13:10:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:10:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:10:14 INFO - Cleaning up... 13:10:14 INFO - Return code: 0 13:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:14 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')]} 13:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:14 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')]} 13:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:14 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:14 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 13:10:14 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 13:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:14 INFO - 'HOME': '/Users/cltbld', 13:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:14 INFO - 'LOGNAME': 'cltbld', 13:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:14 INFO - 'MOZ_NO_REMOTE': '1', 13:10:14 INFO - 'NO_EM_RESTART': '1', 13:10:14 INFO - 'PAGER': '/bin/cat', 13:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:14 INFO - 'PWD': '/builds/slave/test', 13:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:14 INFO - 'SHELL': '/bin/bash', 13:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:14 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:14 INFO - 'USER': 'cltbld', 13:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:14 INFO - 'XPC_FLAGS': '0x0', 13:10:14 INFO - 'XPC_SERVICE_NAME': '0', 13:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-k6VYXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vBgFyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-GuREPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-pK4HVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-MAo21H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-PUkr6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-uphkWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:15 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)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-39RAb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:15 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)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-rUMs20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:15 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)) 13:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:15 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-FfZhcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Lkr6o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-M25qOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-_KZxBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-JDcJs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-BTJDSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-q_QLga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:16 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-N9yCAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:10:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10:19 INFO - Downloading blessings-1.6.tar.gz 13:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:10:19 INFO - Installing collected packages: blessings 13:10:19 INFO - Running setup.py install for blessings 13:10:19 INFO - Successfully installed blessings 13:10:19 INFO - Cleaning up... 13:10:19 INFO - Return code: 0 13:10:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:19 INFO - Reading from file tmpfile_stdout 13:10:19 INFO - Current package versions: 13:10:19 INFO - blessings == 1.6 13:10:19 INFO - blobuploader == 1.2.4 13:10:19 INFO - docopt == 0.6.1 13:10:19 INFO - manifestparser == 1.1 13:10:19 INFO - mozInstall == 1.12 13:10:19 INFO - mozcrash == 0.17 13:10:19 INFO - mozdebug == 0.1 13:10:19 INFO - mozdevice == 0.48 13:10:19 INFO - mozfile == 1.2 13:10:19 INFO - mozhttpd == 0.7 13:10:19 INFO - mozinfo == 0.9 13:10:19 INFO - mozleak == 0.1 13:10:19 INFO - mozlog == 3.1 13:10:19 INFO - moznetwork == 0.27 13:10:19 INFO - mozprocess == 0.22 13:10:19 INFO - mozprofile == 0.28 13:10:19 INFO - mozrunner == 6.11 13:10:19 INFO - mozscreenshot == 0.1 13:10:19 INFO - mozsystemmonitor == 0.0 13:10:19 INFO - moztest == 0.7 13:10:19 INFO - mozversion == 1.4 13:10:19 INFO - psutil == 3.1.1 13:10:19 INFO - requests == 1.2.3 13:10:19 INFO - wsgiref == 0.1.2 13:10:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:19 INFO - 'HOME': '/Users/cltbld', 13:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:19 INFO - 'LOGNAME': 'cltbld', 13:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:19 INFO - 'MOZ_NO_REMOTE': '1', 13:10:19 INFO - 'NO_EM_RESTART': '1', 13:10:19 INFO - 'PAGER': '/bin/cat', 13:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:19 INFO - 'PWD': '/builds/slave/test', 13:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:19 INFO - 'SHELL': '/bin/bash', 13:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:19 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:19 INFO - 'USER': 'cltbld', 13:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:19 INFO - 'XPC_FLAGS': '0x0', 13:10:19 INFO - 'XPC_SERVICE_NAME': '0', 13:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 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)) 13:10:20 INFO - Cleaning up... 13:10:20 INFO - Return code: 0 13:10:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:10:20 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')]} 13:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:20 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')]} 13:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:20 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:20 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 13:10:20 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 13:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:20 INFO - 'HOME': '/Users/cltbld', 13:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:20 INFO - 'LOGNAME': 'cltbld', 13:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:20 INFO - 'MOZ_NO_REMOTE': '1', 13:10:20 INFO - 'NO_EM_RESTART': '1', 13:10:20 INFO - 'PAGER': '/bin/cat', 13:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:20 INFO - 'PWD': '/builds/slave/test', 13:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:20 INFO - 'SHELL': '/bin/bash', 13:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:20 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:20 INFO - 'USER': 'cltbld', 13:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:20 INFO - 'XPC_FLAGS': '0x0', 13:10:20 INFO - 'XPC_SERVICE_NAME': '0', 13:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:20 INFO - Downloading/unpacking jsonschema 13:10:20 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 13:10:20 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 13:10:20 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 13:10:20 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 13:10:20 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 13:10:20 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 13:10:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:10:22 INFO - Downloading/unpacking functools32 (from jsonschema) 13:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:23 INFO - Downloading functools32-3.2.3-2.tar.gz 13:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:10:23 INFO - warning: no files found matching '*.txt' 13:10:23 INFO - no previously-included directories found matching 'build' 13:10:23 INFO - no previously-included directories found matching 'dist' 13:10:23 INFO - no previously-included directories found matching '.git*' 13:10:23 INFO - Installing collected packages: jsonschema, functools32 13:10:23 INFO - Running setup.py install for functools32 13:10:23 INFO - warning: no files found matching '*.txt' 13:10:23 INFO - no previously-included directories found matching 'build' 13:10:23 INFO - no previously-included directories found matching 'dist' 13:10:23 INFO - no previously-included directories found matching '.git*' 13:10:23 INFO - Successfully installed jsonschema functools32 13:10:23 INFO - Cleaning up... 13:10:23 INFO - Return code: 0 13:10:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:10:23 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')]} 13:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:24 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 0x10e1ffa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2064c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb970488c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, '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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 13:10:24 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 13:10:24 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 13:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:10:24 INFO - 'HOME': '/Users/cltbld', 13:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:10:24 INFO - 'LOGNAME': 'cltbld', 13:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:24 INFO - 'MOZ_NO_REMOTE': '1', 13:10:24 INFO - 'NO_EM_RESTART': '1', 13:10:24 INFO - 'PAGER': '/bin/cat', 13:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:24 INFO - 'PWD': '/builds/slave/test', 13:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:10:24 INFO - 'SHELL': '/bin/bash', 13:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:10:24 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:10:24 INFO - 'USER': 'cltbld', 13:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:24 INFO - 'XPC_FLAGS': '0x0', 13:10:24 INFO - 'XPC_SERVICE_NAME': '0', 13:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:24 INFO - Downloading/unpacking flake8 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10: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 13:10:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:10:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:10:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:27 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 13:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:28 INFO - no previously-included directories found matching 'docs/_build' 13:10:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:10:28 INFO - Running setup.py install for pep8 13:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:28 INFO - no previously-included directories found matching 'docs/_build' 13:10:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:10:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:10:28 INFO - Cleaning up... 13:10:28 INFO - Return code: 0 13:10:28 INFO - Running post-action listener: _resource_record_post_action 13:10:28 INFO - Running post-action listener: _start_resource_monitoring 13:10:28 INFO - Starting resource monitoring. 13:10:28 INFO - ##### 13:10:28 INFO - ##### Running install step. 13:10:28 INFO - ##### 13:10:28 INFO - Running pre-action listener: _resource_record_pre_action 13:10:28 INFO - Running main action method: install 13:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:28 INFO - Reading from file tmpfile_stdout 13:10:28 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:29 INFO - Reading from file tmpfile_stdout 13:10:29 INFO - Output received: 13:10:29 INFO - Usage: mozinstall [options] installer 13:10:29 INFO - Options: 13:10:29 INFO - -h, --help show this help message and exit 13:10:29 INFO - -d DEST, --destination=DEST 13:10:29 INFO - Directory to install application into. [default: 13:10:29 INFO - "/builds/slave/test"] 13:10:29 INFO - --app=APP Application being installed. [default: firefox] 13:10:29 INFO - mkdir: /builds/slave/test/build/application 13:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:11:01 INFO - Reading from file tmpfile_stdout 13:11:01 INFO - Output received: 13:11:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:11:01 INFO - Running post-action listener: _resource_record_post_action 13:11:01 INFO - ##### 13:11:01 INFO - ##### Running run-tests step. 13:11:01 INFO - ##### 13:11:01 INFO - Running pre-action listener: _resource_record_pre_action 13:11:01 INFO - Running main action method: run_tests 13:11:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:11:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:11:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:11:01 INFO - 2016-04-24 13:11:01.529 screenresolution[1638:7647] starting screenresolution argv=screenresolution get 13:11:01 INFO - 2016-04-24 13:11:01.532 screenresolution[1638:7647] Display 0: 1600x1200x32@60 13:11:01 INFO - 2016-04-24 13:11:01.538 screenresolution[1639:7649] starting screenresolution argv=screenresolution list 13:11:01 INFO - Available Modes on Display 0 13:11:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:11:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:11:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:11:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:11:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:11:01 INFO - Intel Iris: 13:11:01 INFO - Chipset Model: Intel Iris 13:11:01 INFO - Type: GPU 13:11:01 INFO - Bus: Built-In 13:11:01 INFO - VRAM (Dynamic, Max): 1536 MB 13:11:01 INFO - Vendor: Intel (0x8086) 13:11:01 INFO - Device ID: 0x0a2e 13:11:01 INFO - Revision ID: 0x0009 13:11:01 INFO - Displays: 13:11:01 INFO - Display: 13:11:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:11:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:11:01 INFO - Display Serial Number: 1600x1200 60 13:11:01 INFO - Main Display: Yes 13:11:01 INFO - Mirror: Off 13:11:01 INFO - Online: Yes 13:11:01 INFO - Rotation: Supported 13:11:01 INFO - Return code: 0 13:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:11:01 INFO - Python 2.7.3 13:11:01 INFO - Return code: 0 13:11:01 INFO - grabbing minidump binary from tooltool 13:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:01 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 0x10e0a3d30>, '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 0x10df07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e09ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:11:01 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 13:11:01 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 13:11:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:01 INFO - Return code: 0 13:11:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:11:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:11:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:11:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:11:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:11:03 INFO - Return code: 0 13:11:03 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/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 13:11:03 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/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --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 13:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lfB4s3Hzyn/Render', 13:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:11:03 INFO - 'HOME': '/Users/cltbld', 13:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:11:03 INFO - 'LOGNAME': 'cltbld', 13:11:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:11:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:03 INFO - 'MOZ_NO_REMOTE': '1', 13:11:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:11:03 INFO - 'NO_EM_RESTART': '1', 13:11:03 INFO - 'PAGER': '/bin/cat', 13:11:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:03 INFO - 'PWD': '/builds/slave/test', 13:11:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:11:03 INFO - 'SHELL': '/bin/bash', 13:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVMJ8NF5v5/Listeners', 13:11:03 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 13:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:11:03 INFO - 'USER': 'cltbld', 13:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:03 INFO - 'XPC_FLAGS': '0x0', 13:11:03 INFO - 'XPC_SERVICE_NAME': '0', 13:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:11:03 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/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 13:11:03 INFO - mozversion application_buildid: 20160424112253 13:11:03 INFO - mozversion application_changeset: eefaf5e207f01443d61a15b6d22a01979fbfeda9 13:11:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:11:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:03 INFO - mozversion application_name: Firefox 13:11:03 INFO - mozversion application_remotingname: firefox-dev 13:11:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:11:03 INFO - mozversion application_vendor: Mozilla 13:11:03 INFO - mozversion application_version: 47.0a2 13:11:03 INFO - mozversion platform_buildid: 20160424112253 13:11:03 INFO - mozversion platform_changeset: eefaf5e207f01443d61a15b6d22a01979fbfeda9 13:11:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:11:03 INFO - mozversion platform_version: 47.0a2 13:11:03 INFO - using testdate: 1461528663 13:11:03 INFO - actual date: 1461528663 13:11:03 INFO - starting webserver on 'localhost:49271' 13:11:03 INFO - SUITE-START | Running 2 tests 13:11:03 INFO - TEST-START | dromaeo_css 13:11:03 INFO - operating with platform_type : mac_ 13:11:03 INFO - Initialising browser for dromaeo_css test... 13:11:03 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmprS5l4D/profile http://localhost:49271/getInfo.html) 13:11:06 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 13:11:06 INFO - PROCESS | 1657 | colorDepth:24 13:11:06 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 13:11:06 INFO - PROCESS | 1657 | __metrics 13:11:06 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:11:07 INFO - TEST-INFO | 1657: exit 0 13:11:07 INFO - Browser initialized. 13:11:07 INFO - Running cycle 1/1 for dromaeo_css test... 13:11:07 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmprS5l4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:18 INFO - PROCESS | 1663 | RSS: Main: 218333184 13:11:18 INFO - PROCESS | 1663 | 13:12:08 INFO - PROCESS | 1663 | 1461528728585 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] 13:14:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 13:14:20 INFO - PROCESS | 1663 | RSS: Main: 228614144 13:14:20 INFO - PROCESS | 1663 | 13:17:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 13:17:23 INFO - PROCESS | 1663 | RSS: Main: 240209920 13:17:23 INFO - PROCESS | 1663 | 13:20:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 13:20:25 INFO - PROCESS | 1663 | RSS: Main: 242434048 13:20:25 INFO - PROCESS | 1663 | 13:23:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 13:23:27 INFO - PROCESS | 1663 | RSS: Main: 243957760 13:23:27 INFO - PROCESS | 1663 | 13:26:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 13:26:30 INFO - PROCESS | 1663 | RSS: Main: 246804480 13:26:30 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 13:29:33 INFO - PROCESS | 1663 | RSS: Main: 248119296 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | __start_tp_report 13:29:33 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 13:29:33 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 13:29:33 INFO - PROCESS | 1663 | |i|pagename|runs| 13:29:33 INFO - PROCESS | 1663 | |0;dojo.html;2773.5978283148943;3493.7205023598117;3532.417151170057;3553.2005298807753;3576.749627526073;4821.783019764111;5745.138229265613;5761.827145185651;5803.303603567578;5810.15752715856;5808.82573522794;5841.415858414157;5845.09401042838;5869.9706501467435;5882.529397648189;5189.117849965505;5201.323827902367;5253.264542963988;5293.15309550472;5308.628396012281;5130.153524668425;5263.736813159346;5286.629935904488;5289.709066001368;5377.623566350357;5232.058229518685;5251.947480525203;5272;5278.551323137538;5360.892782144355;5259.0796610593;5311.362636483627;5318.601104917147;5320.76056577455;5339.866503337409;5191.974040129813;5231.633785634969;5277.551408130314;5283.656562323436;5307.416184219733;5515.641483303572;5595.468430499096;5688.5733569982;5734.254546908917;5773.769049238025;5136.614753893473;5217.452167522393;6187.319394866561;6196.752129914798;6239.095331176999;5429.67421954684;6147.87704245917;6260.029695397221;6271.811845644638;6282.874342513124;5922.3781502942;5931.733072011683;5952.880942381172;5964.522838172936;5999.640021598718;6245.594036387621;6277.027060805491;6309;6311.873762524724;6324.841878953063;4813.879653008703;5934.495567876693;6047.3045599755715;6134.650895842656;6205.627662340274;5231.319928409359;5349.812756553502;6184.072389141665;6246.3441338659695;6279.183706118267;6092.817215483543;6156.138140660311;6158.445739883342;6221.564490485713;6225.1907252057845;5130.230465430141;6137.7447333336595;6191.1641928339095;6199.287081985539;6251.187345645037;4884.267359896044;4902.50974902514;4921.311016457699;4938.728369939616;4947.703137811671;4415.337699345124;4433.935855394682;4445.622122119591;4466.798994045275;4481.820727170942;5686.658800471985;5751;5818.389069147764;5840.094785308284;5847.415258474119;6140.04415716754;6211.565190436626;6281.96859015702;6284.654344011032;6300.243970723451;5813.09896965971;5821.301443826683;5832.795852145155;5849.415058494202;5868.149118377812;4993.6005119590345;5319.361676598833;5465.808696695596;5482.616216864861;5484.780608775604;6338.239411270677;6361.427471527585;6367.586106903036;6374.458171055419;6383.170187875547;5265.868353291198;6279.96860015697;6283.340249273943;6291.245050593958;6298.905516417349;6259.374062593704;6287.46556542699;6345.17512723343;6366.554341196072;6378.266499352634;6231.7818876340925;6237.5633705641985;6240.157578726814;6243.8126856194385;6244.375562443719;6222.844428889314;6234.220722409699;6240.875182496416;6251.937480625135;6255.530835187288;5076;5707.4577915098;6085.786997455068;6094.908576371269;6185.84535386619;6124;6187.597806142767;6203.875922481435;6204.565680402509;6217.937820621917;5703.8859222816145;5813.94186058134;6030.246219222598;6054.212952316171;6073.453389194994;6126.479249263863;6161.815145545641;6171.444569988723;6179.443850053517;6188.721507532262;5732.996725573092;5826.854328641648;6014.879702405839;6032.969835150971;6038.849028774316 13:29:33 INFO - PROCESS | 1663 | |1;ext.html;492.77824978759566;562.8789810190808;591.9230500034995;676.2324761395815;676.8037269191934;36874.81562592187;37486.8125659372;37490.250194996086;37560.24879502412;37579.43630845539;38723.61276387242;39266.01834954128;39327.803360983155;39401.80299098501;39469.21061578774;9339.813203735921;9540.045995400475;9559.856602150974;9580.377275477073;9592.280578956572;8426;9485.241180705561;9508.429494230333;9628.3260171788;9752.756181095494;8431.19903609156;9650.662226822064;9660.178884794801;9757.658481953133;9789;9654.179394751454;9656.179224765832;9706.611735530605;9722.9513852431;9730.708078757649;8296.253337199681;9479.81502312211;9604.663836765749;9616.66341678045;9617.663381781604;31689.366212675617;39160;39316.606833931866;39370.60629393698;39625.40561891574;2625.3567875870535;3175.6506784253716;3430.879919202841;3596.8561257549927;3906.0234941264684;28764.42471150586;29199.85400072986;29518.85240573805;30656.540151897738;31064.378712425623;2683.725230515509;2714.877830497632;2771.4457108578363;2780.4439112177442;2798.720127987185;463343;464005.9999999966;464633;467914;468692;38140.61859381426;70645;70751.93872091922;71123.64438177776;71169;46194.76902615533;46314;46373.76813115913;46724;46770.5322946773;13620.931895340658;14287.642673945958;15165.09009459436;16471.91764041196;16494.83505164933;13119.344032798323;13160.078794484294;13208.075434719478;13232.338383081;13289.3355332233;13175.802362964563;14865.628359291104;14884.95805293619;15006.249687515581;15212;5604.747786349624;6591.582809695842;6687.632180230037;6771.6614169292325;6776.6950487227205;980.2452111873818;1043.175891046065;1046.2885238038054;1052.9102379037658;1070.3791800755544;29619.555706663985;29754.851225743732;30123.548146777815;30367.392652146835;30725.69274307273;1114.1977776001265;1151.9193656443967;1199.9880001199876;1246.875312468746;1275.6045625856013;14766.63083422923;15134.621634459007;15294;15356.462523811613;15675.529734107995;423276;482746;487148.5642571764;491565;493190;59530.40469595335;59826.80346393135;59844.401555984754;60152.39847601556;60400;1537.2467490929587;1543.1975372806303;1560.4928398270608;1576.8265490796002;1587.857092861625;29526.409471810013;29887.459565936268;29922.803087877113;30418.087457376314;30573.54139687951;50543.74728126336;51013.744931275105;51385.74307128441;51474.485255148466;51748.482515174364;437032;440989;441276;441920;443134;33562.496562551096;34280.14299642529;34501.482477763355;44959.77520112378;45682.771586143186;43182.352264715424;43554.34668479912;44129.896752581444;44186;44798;36161.91514254577;36824.81587592045;37572.60883222478;37808;39053;29749;31271.374572507968;37609;37609.623903760614;38290.6170938287;30700.232494187825;37673.246535069695;39452.40821387624;39458.2108357837;40148.1970360597;31261.687383125878;32237.51643725393;32659.836700816344;32702.34595308128;32898.67101329052;21632.13471461124;24821.13126040652;25555.6166657504;25625.97496100135;25845 13:29:33 INFO - PROCESS | 1663 | |2;jquery.html;346.56159957653557;348.64264129267497;365.9469376940344;382.85451528419196;388.78117102882464;20059.59880802383;20590.073446694896;21159.942002899832;21842.781572184293;21873.890630546826;21242.57514849702;21298.57402851942;21462;21575.81333026683;21589.784102158974;5643.125315576092;5939.732712027969;5964.910526342108;5968.403159684019;5969.761209551612;5491.258680078178;5798.246227990356;5829.038208695561;5838.153467747175;5846.4445877641765;5748.42515748426;5768.42315768424;5786.594938354296;5787.739551720161;5795.797147099853;4989.176785830352;5441.401445840955;5708.343540492855;5733.254676892019;5783.074708046714;5036.244563315532;5057.696538207682;5060.22891987805;5066.113430149746;5069.44236134025;25687.972481100733;25975.610365844528;26076;26172;26291.605625915625;2460.495598402323;2561.6413702081722;2568.730283320243;2676.210517897225;2822.548392257229;14757.852421475754;14989;15063.54809355721;15072.246387680572;15319.617009574738;1733.2200509770653;1793.1482545790775;1804.1340156724714;1847.7690288713911;1886.9339573114876;75255;103820.48089759503;107956.4602176984;107978;108411.45794271056;8944.239739622206;11583.494145761166;11628.592999245155;11730.472128754227;11806.937375636235;14267.357968891425;14366;14395.712085758436;14416.567502974927;14468.565943021726;8809.515476648718;8914.465132092095;8935.151160639729;8953.328500362368;8954.731358059269;9023.097690230925;9024.45853248794;9113.908860911306;9192.448453092837;9209.986901440836;4473.941986686161;4586.8165273388695;4614.3309220163555;4614.838480653161;4663.556962088596;1883.1431698577114;1947.9220831166595;1976.960460790776;2017.7175195472646;2035.5725297687652;913.3150137396952;938.8639745907392;983.9458829764432;1050.2490719135856;1052.037385792007;19990.800091999186;20459.693104603444;20511.8974405127;20849.791502084787;20852.791472085388;974.9658761943298;995.9850602240972;1006.9899301006897;1020.6682828080903;1052.3580615824342;8890.822183556293;11225.989660930556;11262;11263.155263355282;11304.830427543593;643939;654350;654495;663342;666506;72962.2703772966;74043.88934165992;75207;114922.4253878742;121919;994.3785134291213;1045.6601604478574;1110.4003837927428;1110.838928355384;1117.4189421500937;15250.31373588169;18002.379785818815;18965;19028.143733531746;19054.809451905305;42181;49676.751616243135;51839.96320073653;52952.20571691505;55979;72383;73636;79925.60037199777;80619;82217.76673350025;6850.623215723183;8194.426390152632;8197.34421246287;8338.166183381612;8346.833063338821;9687;11769;12065.879341206475;13333;13455.798163027366;9942.652007179713;10064.29549931527;10929.251319788795;11875.762484750085;11956.880431195577;11302.547898084313;11357;11450.885491144982;11659.18385713026;11827.349495777471;11427.714307142389;11678.481797366288;11783.882161178279;11887.167898247386;11947.283163009899;8088.83822323562;10586.36481811063;11469.483873225558;11744.060475161796;11893.345865977455;11577.189596728149;12011.399430028638;12172.45223964906;12244;12277.877221227673 13:29:33 INFO - PROCESS | 1663 | |3;mootools.html;1655.0897006646346;1675.0870775427395;2023.1705000949614;2054.5171884607116;2084.7810979847127;8362.540060296682;8670.739877803677;9116.179543841054;9344.81310373792;9377.71866843994;7672.808179795508;9038.683646072388;9071;9131.954340228289;9171.449713017224;2545.2491515003026;2555.2845203343095;2562.397836508419;2564.9615255771178;2575.188815523104;2519.8866051027658;2565.717771045193;2572.768450839424;2574.948501029978;2582.4705935283314;2468.0744720729726;2501.8999240030375;2531.8480891146496;2544.7200807911113;2548.3374322676054;2561.884715187821;2567.229831050677;2587.5730504466833;2596.844189348645;2610.4126571521447;2570.5758549839443;2582.8579428131447;2603.5964425514076;2604.6353510508543;2605.387733882536;9079.773005674844;9270.351075424724;9277.814443711155;9287.349885507949;9305.25557955362;5737.168110623936;5756.827295181151;5852.297724273072;5859.824205273849;5864.530837532987;3711.9814400928094;3822.560405553369;3830.042489377656;3836.1176929306416;3857.556381016191;1076.1068313299943;1084.7071290751533;1089.6186334782763;1129.8305254211934;1132.915031372642;12395.380230988414;12400.503979840796;12461.376931153496;12499.125061245717;12602.621921342374;4268.338407546835;5088.211327244283;5144.897102057937;5196.038732834362;5247.055530004636;10633.149348052137;10634.627788027537;10643.308184967953;10663.680089597325;10677.252592318464;5696.601237913306;5727.140928860705;5744.655320680772;5750.396208398058;5770.682612456355;4660.580547750718;5010.323606313174;5100.2349647553165;5114.079465696136;5215.217717342429;3387.9153021174175;3501.9824900875333;3507.5264839246884;4070.206309769626;4104.261232978033;1180.8228765685217;1377.3182274774051;1387.2439520461373;1391.9860801391856;1401.9299035048207;1376.4012654495327;1407.8592140786045;1412.1174266083697;1433.254707552067;1451.1438251431705;7351.301626345488;7547.811304717426;8622.137786221328;8740.388172827968;8885.911140888638;1104.3429159649995;1272.516443751387;1277.7380636969585;1278.0733967873402;1291.728736965248;6490.740370385226;6569.80290591283;6618.503612229102;6637.435817955431;6672.666366681647;10726.517306721216;11127.833082503768;11174.217804753589;11206.831897521544;11381.146414018982;10939.12487001038;11101.944490277498;11106.222564420414;11216.831747523795;11340.489677964511;8718.041015488292;8814.86777698335;8831.381803273709;8895.599698013604;8917.286617070618;7003.929960700328;8195.262426381654;8269.669213231644;8360.08039115709;8415.53714545706;10057.899421005988;10131.79736405253;10171.28800983924;10194.388336699822;10197.031282028196;10322.793544128925;10323.019313165238;10679.733006674895;10686.732831678959;10694.251402401756;6762.594244345355;6999.580025198505;7128.714851405885;7177.820554485971;7357.558546487228;7394.667239974106;8680.479171249744;8686.001109872193;8726.563671816511;8743.868841967504;7479.775606731807;7605.923940760522;7623.123340815655;7645.503042302233;7765.456418050682;7309.5248808827255;7341.192468828532;7368.300011498899;7422.554646721214;7508.474406791473;8156.062052863759;8186.959065204635;8221.83556328882;8227.095019547725;8247.670093196444;7094.467914906506;7251.709931602677;7309.451791115794;7366.079240094989;7440.3675687567165;7412.592307423143;7463.440241981982;7490.662920168496;7494.737684181027;7494.812629684301 13:29:33 INFO - PROCESS | 1663 | |4;prototype.html;336.48181800027953;336.9915752106197;342.48456073609213;345.05627109854544;347.9756417050806;6742.595444273341;6792.932070679291;6802.18373795144;6847.486438517106;6856.965715171417;6791.3208679132185;6805;6807.455403567715;6817.284185160549;6827.2831352708;4736.810527578893;4837.443693975185;4926.285688575154;4930.654854160192;5034.29519867218;4887.8778030549165;4927.630427717918;4931.063098011385;4933.975330123362;4947.431045429767;4861.197902346109;4871.366722326093;4905.166121759309;4909.288153217782;4936.185529387647;4905.166121759309;4915.992221594583;4918.950810491885;4932.5807306379;4932.605391568683;4078.9190864420952;4114.300568903293;4284.785760711983;4287.892802679958;4312.331588603772;6243.625382477066;6548.312427195171;6562.507811914125;6567.113439685677;6598.934010659928;5015.6238282128625;5510.173473978895;5820.417958204188;5822.417758224144;5853.268341457318;5873.85315367115;5975.372585878464;6227.968860155715;6893.4829887758115;7306.050213472267;4672.929906051412;4684.992726563805;4687.531246875319;4688.132695451352;4691.319758634979;7243.891341629933;7630.732924347677;7717.768466946;7719.729809456642;7722.382209423289;4600.539946005372;4652.116097941448;4686.414198225222;4752.453467851241;4761.904761904742;4830.903381932341;4834.927476087862;4839.201531747292;4844.128056949712;4859.781309841065;5767.163761254595;5785.768569257182;5789.884202316014;5796.449337312949;5811.622244554091;7240.710371585183;7241.3844823189565;7249.927500724925;7253.927460725431;7261.5280006799385;1626.772251884737;1651.6118712102887;1675.5224760943318;1686.376040864888;1687.864970802333;909.8043920557112;1053.6628278950661;1060.3637817309552;1077.06833588945;1081.7511972246427;6707.564008339442;6721.596704197764;6731.427828634621;6736;6748.291429399842;7551;7553;7554.471187016966;7557.659905304275;7593.962030189814;6709.329067093252;6725.529212955144;6734.696938637773;6743.258241593421;6782.050512928194;3466.3760523106084;3987.8803635890968;4001.139754952699;4017.819198136091;4021.738586991836;7659.042619672541;8029.799255018671;8051.832484289862;8068.193180681885;8068.7175948841505;7864.134945156028;7904.644291006918;7914.960425197953;7918.247766462292;7932.651449253641;6842.828929276808;8012.158723333966;8018.158093400109;8027.438079334391;8030.07654119772;7330.926690733025;7685.615719213905;7696.15342312334;7711.652975616223;7716.498427602188;7484.663190156565;7519.43604229674;7526.473146879885;7534.284242996907;7552.471327007057;8003.079645840803;8025.678972841021;8026.8394632105865;8033.718819841278;8061.435699500978;4734.124187025412;4785.6171506278715;4791.808327666854;4797.424309082932;4821.156297647968;7323.084614423197;7416.480846340704;7571.886421703789;7576.166621671501;7660.73187438437;7280.271972802678;7299.233580474186;7304.488685791944;7364.153122390993;7386.372158366384;7327.120745510573;7334.4132469403385;7352.228016058237;7374.410047196318;7377.631118444164;5477.945220547744;6884.208316043519;7156.212816590067;7157.105361829771;7168.749093781901;7308.8903666443985;7310.378617817545;7377.26227377258;7391.926080739339;7426.108866936002;5811.854703632443;7133.429325653831;7159.821004474929;7173.713051478091;7181.964090179725 13:29:33 INFO - PROCESS | 1663 | |5;yui.html;649.9057636642684;733.2117973178835;746.8095635612918;748.6556184155288;775.6315750018738;15145.772813407793;15162.772558411632;15376.846231537667;15397.230138493058;15453;14219.004669673128;14230;14237;14238.857611423882;14262.928685356585;789.6367670871406;959.8080383923243;979.4710856137694;984.8276551603476;988.2588058955783;965.6234068713208;965.6958058211676;979.0063085967748;979.8432250839867;980.0689345122126;999.6801023672427;1006.0090810551601;1043.207162556455;1043.9217058720587;1046.3042077018774;1024.2164743970832;1026.6765968719867;1035.0684384054337;1040.0067935121979;1040.583766493401;757.7082823113141;761.8895260187297;770.0412985832675;775.9573223472706;777.1761932351725;15124.243787810565;15208.771868421982;15245.466408675644;15247.542573722805;15363;13082.869171308355;13088.149270297401;13210.273434961073;13213.603591892259;13241.536546220836;9305.209057230144;9555;9871.654492092743;10157.644482443078;10380.688579342632;3525.365434221839;3553.058439513531;3592.263585964871;3652.196516766307;3741.0834345585235;46863.76568117172;60089;73554.63222683906;79166.81249781259;80660.59669701672;8456.704015359433;9484.38765409882;9639.518024098907;9674.467904265191;10196.439195844152;22278.55442891133;22338.441538961655;22500.874956252123;22557.210497632503;22576.774232257467;7496.925030749622;7596.8480630388185;7611.238876112345;7694.730684426018;7815.179406162271;3929.960700393017;3996.6003399659803;4100.5899410058755;4122.876313710593;4312.223799716018;3663.358912190356;3711.5917249102577;3731.0112820102695;3732.234891847165;3735.2529494101286;667.9432248258855;672.2806596941324;676.55009418736;693.4591019005184;721;553.7535796570487;600.1957377114687;600.6036016229268;603.526231907959;603.8490377405649;8147.714829980922;8162.510249385056;8264.876026859602;8355.623996920152;8645.178708022728;506.6250974279007;559.7928766356474;600.8017354273079;607.4411541381851;615.4583966109794;3207.8556464959133;3723.1809002019513;3759.947214779866;3864.4589757433982;3944.4083387492105;94549.0545094554;95471.0452895476;96579;98489.50755246179;99383.50924736135;81191;81429;82509.58745206236;82543.17456825355;82863.17136828676;72508.18729531698;73213.63393183106;73803;74165;75688;7838.882416763639;7959.363250940027;7962.283394494523;8029.357651387992;8269.46248493846;48893.51106489032;50168.24747628861;50214.74892625513;50723.98552029012;50913;67861.32138678747;71465.21336966618;71680;71855.64072179605;71946.64026679833;9834.459104749307;10090.747731306776;10106.898931010595;10120.89879101229;10894.61868834587;10548.156147508027;10866.891331086588;10991.395473249047;11014.44927753593;11125;10431.634892778717;10545.736356591147;10549.683509494727;11052.949969753183;11163;10423;10437.895621043692;10680.83978740335;10928.836067459153;10980.505877235384;8564.657413703382;9685.17675997548;9736.805263894825;9753.122219000325;9988.350757200758;8400;8703.47779133254;8901.51041692713;8991.370604057653;9095.772605684646;8417.915820841714;8526;8735.737927862174;8861.202491775772;8925.642974281216 13:29:33 INFO - PROCESS | 1663 | __end_tp_report 13:29:33 INFO - PROCESS | 1663 | __start_cc_report 13:29:33 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,364 13:29:33 INFO - PROCESS | 1663 | __end_cc_report 13:29:33 INFO - PROCESS | 1663 | __startTimestamp1461529773411__endTimestamp 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | ------- Summary: start ------- 13:29:33 INFO - PROCESS | 1663 | Number of tests: 6 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5718.25 Median:5869.97 stddev:646.09 (11.0%) stddev-sans-first:605.37 13:29:33 INFO - PROCESS | 1663 | Values: 2773.6 3493.7 3532.4 3553.2 3576.7 4821.8 5745.1 5761.8 5803.3 5810.2 5808.8 5841.4 5845.1 5870.0 5882.5 5189.1 5201.3 5253.3 5293.2 5308.6 5130.2 5263.7 5286.6 5289.7 5377.6 5232.1 5251.9 5272.0 5278.6 5360.9 5259.1 5311.4 5318.6 5320.8 5339.9 5192.0 5231.6 5277.6 5283.7 5307.4 5515.6 5595.5 5688.6 5734.3 5773.8 5136.6 5217.5 6187.3 6196.8 6239.1 5429.7 6147.9 6260.0 6271.8 6282.9 5922.4 5931.7 5952.9 5964.5 5999.6 6245.6 6277.0 6309.0 6311.9 6324.8 4813.9 5934.5 6047.3 6134.7 6205.6 5231.3 5349.8 6184.1 6246.3 6279.2 6092.8 6156.1 6158.4 6221.6 6225.2 5130.2 6137.7 6191.2 6199.3 6251.2 4884.3 4902.5 4921.3 4938.7 4947.7 4415.3 4433.9 4445.6 4466.8 4481.8 5686.7 5751.0 5818.4 5840.1 5847.4 6140.0 6211.6 6282.0 6284.7 6300.2 5813.1 5821.3 5832.8 5849.4 5868.1 4993.6 5319.4 5465.8 5482.6 5484.8 6338.2 6361.4 6367.6 6374.5 6383.2 5265.9 6280.0 6283.3 6291.2 6298.9 6259.4 6287.5 6345.2 6366.6 6378.3 6231.8 6237.6 6240.2 6243.8 6244.4 6222.8 6234.2 6240.9 6251.9 6255.5 5076.0 5707.5 6085.8 6094.9 6185.8 6124.0 6187.6 6203.9 6204.6 6217.9 5703.9 5813.9 6030.2 6054.2 6073.5 6126.5 6161.8 6171.4 6179.4 6188.7 5733.0 5826.9 6014.9 6033.0 6038.8 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:60577.94 Median:21479.51 stddev:122400.57 (569.8%) stddev-sans-first:122660.80 13:29:33 INFO - PROCESS | 1663 | Values: 492.8 562.9 591.9 676.2 676.8 36874.8 37486.8 37490.3 37560.2 37579.4 38723.6 39266.0 39327.8 39401.8 39469.2 9339.8 9540.0 9559.9 9580.4 9592.3 8426.0 9485.2 9508.4 9628.3 9752.8 8431.2 9650.7 9660.2 9757.7 9789.0 9654.2 9656.2 9706.6 9723.0 9730.7 8296.3 9479.8 9604.7 9616.7 9617.7 31689.4 39160.0 39316.6 39370.6 39625.4 2625.4 3175.7 3430.9 3596.9 3906.0 28764.4 29199.9 29518.9 30656.5 31064.4 2683.7 2714.9 2771.4 2780.4 2798.7 463343.0 464006.0 464633.0 467914.0 468692.0 38140.6 70645.0 70751.9 71123.6 71169.0 46194.8 46314.0 46373.8 46724.0 46770.5 13620.9 14287.6 15165.1 16471.9 16494.8 13119.3 13160.1 13208.1 13232.3 13289.3 13175.8 14865.6 14885.0 15006.2 15212.0 5604.7 6591.6 6687.6 6771.7 6776.7 980.2 1043.2 1046.3 1052.9 1070.4 29619.6 29754.9 30123.5 30367.4 30725.7 1114.2 1151.9 1200.0 1246.9 1275.6 14766.6 15134.6 15294.0 15356.5 15675.5 423276.0 482746.0 487148.6 491565.0 493190.0 59530.4 59826.8 59844.4 60152.4 60400.0 1537.2 1543.2 1560.5 1576.8 1587.9 29526.4 29887.5 29922.8 30418.1 30573.5 50543.7 51013.7 51385.7 51474.5 51748.5 437032.0 440989.0 441276.0 441920.0 443134.0 33562.5 34280.1 34501.5 44959.8 45682.8 43182.4 43554.3 44129.9 44186.0 44798.0 36161.9 36824.8 37572.6 37808.0 39053.0 29749.0 31271.4 37609.0 37609.6 38290.6 30700.2 37673.2 39452.4 39458.2 40148.2 31261.7 32237.5 32659.8 32702.3 32898.7 21632.1 24821.1 25555.6 25626.0 25845.0 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35371.97 Median:2511.07 stddev:108071.68 (4303.8%) stddev-sans-first:108342.85 13:29:33 INFO - PROCESS | 1663 | Values: 346.6 348.6 365.9 382.9 388.8 20059.6 20590.1 21159.9 21842.8 21873.9 21242.6 21298.6 21462.0 21575.8 21589.8 5643.1 5939.7 5964.9 5968.4 5969.8 5491.3 5798.2 5829.0 5838.2 5846.4 5748.4 5768.4 5786.6 5787.7 5795.8 4989.2 5441.4 5708.3 5733.3 5783.1 5036.2 5057.7 5060.2 5066.1 5069.4 25688.0 25975.6 26076.0 26172.0 26291.6 2460.5 2561.6 2568.7 2676.2 2822.5 14757.9 14989.0 15063.5 15072.2 15319.6 1733.2 1793.1 1804.1 1847.8 1886.9 75255.0 103820.5 107956.5 107978.0 108411.5 8944.2 11583.5 11628.6 11730.5 11806.9 14267.4 14366.0 14395.7 14416.6 14468.6 8809.5 8914.5 8935.2 8953.3 8954.7 9023.1 9024.5 9113.9 9192.4 9210.0 4473.9 4586.8 4614.3 4614.8 4663.6 1883.1 1947.9 1977.0 2017.7 2035.6 913.3 938.9 983.9 1050.2 1052.0 19990.8 20459.7 20511.9 20849.8 20852.8 975.0 996.0 1007.0 1020.7 1052.4 8890.8 11226.0 11262.0 11263.2 11304.8 643939.0 654350.0 654495.0 663342.0 666506.0 72962.3 74043.9 75207.0 114922.4 121919.0 994.4 1045.7 1110.4 1110.8 1117.4 15250.3 18002.4 18965.0 19028.1 19054.8 42181.0 49676.8 51840.0 52952.2 55979.0 72383.0 73636.0 79925.6 80619.0 82217.8 6850.6 8194.4 8197.3 8338.2 8346.8 9687.0 11769.0 12065.9 13333.0 13455.8 9942.7 10064.3 10929.3 11875.8 11956.9 11302.5 11357.0 11450.9 11659.2 11827.3 11427.7 11678.5 11783.9 11887.2 11947.3 8088.8 10586.4 11469.5 11744.1 11893.3 11577.2 12011.4 12172.5 12244.0 12277.9 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6312.80 Median:4464.46 stddev:3321.67 (74.4%) stddev-sans-first:3312.54 13:29:33 INFO - PROCESS | 1663 | Values: 1655.1 1675.1 2023.2 2054.5 2084.8 8362.5 8670.7 9116.2 9344.8 9377.7 7672.8 9038.7 9071.0 9132.0 9171.4 2545.2 2555.3 2562.4 2565.0 2575.2 2519.9 2565.7 2572.8 2574.9 2582.5 2468.1 2501.9 2531.8 2544.7 2548.3 2561.9 2567.2 2587.6 2596.8 2610.4 2570.6 2582.9 2603.6 2604.6 2605.4 9079.8 9270.4 9277.8 9287.3 9305.3 5737.2 5756.8 5852.3 5859.8 5864.5 3712.0 3822.6 3830.0 3836.1 3857.6 1076.1 1084.7 1089.6 1129.8 1132.9 12395.4 12400.5 12461.4 12499.1 12602.6 4268.3 5088.2 5144.9 5196.0 5247.1 10633.1 10634.6 10643.3 10663.7 10677.3 5696.6 5727.1 5744.7 5750.4 5770.7 4660.6 5010.3 5100.2 5114.1 5215.2 3387.9 3502.0 3507.5 4070.2 4104.3 1180.8 1377.3 1387.2 1392.0 1401.9 1376.4 1407.9 1412.1 1433.3 1451.1 7351.3 7547.8 8622.1 8740.4 8885.9 1104.3 1272.5 1277.7 1278.1 1291.7 6490.7 6569.8 6618.5 6637.4 6672.7 10726.5 11127.8 11174.2 11206.8 11381.1 10939.1 11101.9 11106.2 11216.8 11340.5 8718.0 8814.9 8831.4 8895.6 8917.3 7003.9 8195.3 8269.7 8360.1 8415.5 10057.9 10131.8 10171.3 10194.4 10197.0 10322.8 10323.0 10679.7 10686.7 10694.3 6762.6 6999.6 7128.7 7177.8 7357.6 7394.7 8680.5 8686.0 8726.6 8743.9 7479.8 7605.9 7623.1 7645.5 7765.5 7309.5 7341.2 7368.3 7422.6 7508.5 8156.1 8187.0 8221.8 8227.1 8247.7 7094.5 7251.7 7309.5 7366.1 7440.4 7412.6 7463.4 7490.7 7494.7 7494.8 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5936.69 Median:6739.30 stddev:1934.93 (28.7%) stddev-sans-first:1894.15 13:29:33 INFO - PROCESS | 1663 | Values: 336.5 337.0 342.5 345.1 348.0 6742.6 6792.9 6802.2 6847.5 6857.0 6791.3 6805.0 6807.5 6817.3 6827.3 4736.8 4837.4 4926.3 4930.7 5034.3 4887.9 4927.6 4931.1 4934.0 4947.4 4861.2 4871.4 4905.2 4909.3 4936.2 4905.2 4916.0 4919.0 4932.6 4932.6 4078.9 4114.3 4284.8 4287.9 4312.3 6243.6 6548.3 6562.5 6567.1 6598.9 5015.6 5510.2 5820.4 5822.4 5853.3 5873.9 5975.4 6228.0 6893.5 7306.1 4672.9 4685.0 4687.5 4688.1 4691.3 7243.9 7630.7 7717.8 7719.7 7722.4 4600.5 4652.1 4686.4 4752.5 4761.9 4830.9 4834.9 4839.2 4844.1 4859.8 5767.2 5785.8 5789.9 5796.4 5811.6 7240.7 7241.4 7249.9 7253.9 7261.5 1626.8 1651.6 1675.5 1686.4 1687.9 909.8 1053.7 1060.4 1077.1 1081.8 6707.6 6721.6 6731.4 6736.0 6748.3 7551.0 7553.0 7554.5 7557.7 7594.0 6709.3 6725.5 6734.7 6743.3 6782.1 3466.4 3987.9 4001.1 4017.8 4021.7 7659.0 8029.8 8051.8 8068.2 8068.7 7864.1 7904.6 7915.0 7918.2 7932.7 6842.8 8012.2 8018.2 8027.4 8030.1 7330.9 7685.6 7696.2 7711.7 7716.5 7484.7 7519.4 7526.5 7534.3 7552.5 8003.1 8025.7 8026.8 8033.7 8061.4 4734.1 4785.6 4791.8 4797.4 4821.2 7323.1 7416.5 7571.9 7576.2 7660.7 7280.3 7299.2 7304.5 7364.2 7386.4 7327.1 7334.4 7352.2 7374.4 7377.6 5477.9 6884.2 7156.2 7157.1 7168.7 7308.9 7310.4 7377.3 7391.9 7426.1 5811.9 7133.4 7159.8 7173.7 7182.0 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18274.15 Median:605.65 stddev:26113.96 (4311.8%) stddev-sans-first:26153.69 13:29:33 INFO - PROCESS | 1663 | Values: 649.9 733.2 746.8 748.7 775.6 15145.8 15162.8 15376.8 15397.2 15453.0 14219.0 14230.0 14237.0 14238.9 14262.9 789.6 959.8 979.5 984.8 988.3 965.6 965.7 979.0 979.8 980.1 999.7 1006.0 1043.2 1043.9 1046.3 1024.2 1026.7 1035.1 1040.0 1040.6 757.7 761.9 770.0 776.0 777.2 15124.2 15208.8 15245.5 15247.5 15363.0 13082.9 13088.1 13210.3 13213.6 13241.5 9305.2 9555.0 9871.7 10157.6 10380.7 3525.4 3553.1 3592.3 3652.2 3741.1 46863.8 60089.0 73554.6 79166.8 80660.6 8456.7 9484.4 9639.5 9674.5 10196.4 22278.6 22338.4 22500.9 22557.2 22576.8 7496.9 7596.8 7611.2 7694.7 7815.2 3930.0 3996.6 4100.6 4122.9 4312.2 3663.4 3711.6 3731.0 3732.2 3735.3 667.9 672.3 676.6 693.5 721.0 553.8 600.2 600.6 603.5 603.8 8147.7 8162.5 8264.9 8355.6 8645.2 506.6 559.8 600.8 607.4 615.5 3207.9 3723.2 3759.9 3864.5 3944.4 94549.1 95471.0 96579.0 98489.5 99383.5 81191.0 81429.0 82509.6 82543.2 82863.2 72508.2 73213.6 73803.0 74165.0 75688.0 7838.9 7959.4 7962.3 8029.4 8269.5 48893.5 50168.2 50214.7 50724.0 50913.0 67861.3 71465.2 71680.0 71855.6 71946.6 9834.5 10090.7 10106.9 10120.9 10894.6 10548.2 10866.9 10991.4 11014.4 11125.0 10431.6 10545.7 10549.7 11052.9 11163.0 10423.0 10437.9 10680.8 10928.8 10980.5 8564.7 9685.2 9736.8 9753.1 9988.4 8400.0 8703.5 8901.5 8991.4 9095.8 8417.9 8526.0 8735.7 8861.2 8925.6 13:29:33 INFO - PROCESS | 1663 | -------- Summary: end -------- 13:29:33 INFO - PROCESS | 1663 | 13:29:33 INFO - TEST-INFO | 1663: exit 0 13:29:33 INFO - TEST-OK | dromaeo_css | took 1110652ms 13:29:33 INFO - TEST-START | kraken 13:29:33 INFO - operating with platform_type : mac_ 13:29:33 INFO - Initialising browser for kraken test... 13:29:33 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp0Somzc/profile http://localhost:49271/getInfo.html) 13:29:36 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 13:29:36 INFO - PROCESS | 1671 | colorDepth:24 13:29:36 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 13:29:36 INFO - PROCESS | 1671 | __metrics 13:29:36 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:29:37 INFO - TEST-INFO | 1671: exit 0 13:29:37 INFO - Browser initialized. 13:29:37 INFO - Running cycle 1/1 for kraken test... 13:29:37 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp0Somzc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:49 INFO - PROCESS | 1674 | RSS: Main: 218107904 13:29:49 INFO - PROCESS | 1674 | 13:29:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:52 INFO - PROCESS | 1674 | RSS: Main: 230232064 13:29:52 INFO - PROCESS | 1674 | 13:29:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 13:29:56 INFO - PROCESS | 1674 | RSS: Main: 239259648 13:29:56 INFO - PROCESS | 1674 | 13:29:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 13:29:59 INFO - PROCESS | 1674 | RSS: Main: 242966528 13:29:59 INFO - PROCESS | 1674 | 13:30:01 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 13:30:02 INFO - PROCESS | 1674 | RSS: Main: 244310016 13:30:02 INFO - PROCESS | 1674 | 13:30:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:30:05 INFO - PROCESS | 1674 | RSS: Main: 244793344 13:30:05 INFO - PROCESS | 1674 | 13:30:08 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 13:30:08 INFO - PROCESS | 1674 | RSS: Main: 245145600 13:30:08 INFO - PROCESS | 1674 | 13:30:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 13:30:12 INFO - PROCESS | 1674 | RSS: Main: 244756480 13:30:12 INFO - PROCESS | 1674 | 13:30:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 13:30:15 INFO - PROCESS | 1674 | RSS: Main: 245026816 13:30:15 INFO - PROCESS | 1674 | 13:30:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:30:18 INFO - PROCESS | 1674 | RSS: Main: 244805632 13:30:18 INFO - PROCESS | 1674 | 13:30:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:30:20 INFO - PROCESS | 1674 | RSS: Main: 244826112 13:30:20 INFO - PROCESS | 1674 | 13:30:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:30:23 INFO - PROCESS | 1674 | RSS: Main: 245592064 13:30:23 INFO - PROCESS | 1674 | 13:30:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:30:26 INFO - PROCESS | 1674 | RSS: Main: 245403648 13:30:26 INFO - PROCESS | 1674 | 13:30:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:30:29 INFO - PROCESS | 1674 | RSS: Main: 245309440 13:30:29 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 13:30:31 INFO - PROCESS | 1674 | RSS: Main: 246689792 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | __start_tp_report 13:30:31 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 13:30:31 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 13:30:31 INFO - PROCESS | 1674 | |i|pagename|runs| 13:30:31 INFO - PROCESS | 1674 | |0;ai-astar;116;112;122;162;170;132;132;100;153;169 13:30:31 INFO - PROCESS | 1674 | |1;audio-beat-detection;149;122;139;152;120;174;155;189;144;115 13:30:31 INFO - PROCESS | 1674 | |2;audio-dft;191;198;199;202;198;224;186;239;200;200 13:30:31 INFO - PROCESS | 1674 | |3;audio-fft;69;76;73;113;63;58;62;59;127;57 13:30:31 INFO - PROCESS | 1674 | |4;audio-oscillator;85;85;117;79;81;80;118;79;80;117 13:30:31 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;91;81;136;129;91;88;92;76;134;126 13:30:31 INFO - PROCESS | 1674 | |6;imaging-darkroom;104;124;96;115;149;96;97;117;120;96 13:30:31 INFO - PROCESS | 1674 | |7;imaging-desaturate;83;142;144;138;92;79;147;146;92;93 13:30:31 INFO - PROCESS | 1674 | |8;json-parse-financial;53;61;57;58;59;59;58;65;56;53 13:30:31 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;60;65;71;65;71;75;98;95;74;64 13:30:31 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;81;86;84;84;85;83;84;81;109;89 13:30:31 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;131;136;120;119;140;121;107;138;109;114 13:30:31 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;129;142;145;160;183;182;165;138;143;131 13:30:31 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;68;69;67;72;91;93;60;62;90;98 13:30:31 INFO - PROCESS | 1674 | __end_tp_report 13:30:31 INFO - PROCESS | 1674 | __start_cc_report 13:30:31 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,939 13:30:31 INFO - PROCESS | 1674 | __end_cc_report 13:30:31 INFO - PROCESS | 1674 | __startTimestamp1461529831682__endTimestamp 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | ------- Summary: start ------- 13:30:31 INFO - PROCESS | 1674 | Number of tests: 14 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:136.80 Median:142.50 stddev:25.17 (17.7%) stddev-sans-first:25.55 13:30:31 INFO - PROCESS | 1674 | Values: 116.0 112.0 122.0 162.0 170.0 132.0 132.0 100.0 153.0 169.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:150.50 stddev:23.63 (15.7%) stddev-sans-first:25.04 13:30:31 INFO - PROCESS | 1674 | Values: 149.0 122.0 139.0 152.0 120.0 174.0 155.0 189.0 144.0 115.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:203.70 Median:200.00 stddev:15.81 (7.9%) stddev-sans-first:16.09 13:30:31 INFO - PROCESS | 1674 | Values: 191.0 198.0 199.0 202.0 198.0 224.0 186.0 239.0 200.0 200.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:75.70 Median:62.50 stddev:24.42 (39.1%) stddev-sans-first:25.78 13:30:31 INFO - PROCESS | 1674 | Values: 69.0 76.0 73.0 113.0 63.0 58.0 62.0 59.0 127.0 57.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:80.00 stddev:17.55 (21.9%) stddev-sans-first:18.42 13:30:31 INFO - PROCESS | 1674 | Values: 85.0 85.0 117.0 79.0 81.0 80.0 118.0 79.0 80.0 117.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:84.50 stddev:23.76 (28.1%) stddev-sans-first:24.71 13:30:31 INFO - PROCESS | 1674 | Values: 91.0 81.0 136.0 129.0 91.0 88.0 92.0 76.0 134.0 126.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:122.50 stddev:17.21 (14.0%) stddev-sans-first:18.04 13:30:31 INFO - PROCESS | 1674 | Values: 104.0 124.0 96.0 115.0 149.0 96.0 97.0 117.0 120.0 96.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:115.60 Median:81.00 stddev:29.71 (36.7%) stddev-sans-first:29.07 13:30:31 INFO - PROCESS | 1674 | Values: 83.0 142.0 144.0 138.0 92.0 79.0 147.0 146.0 92.0 93.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:3.57 (6.1%) stddev-sans-first:3.32 13:30:31 INFO - PROCESS | 1674 | Values: 53.0 61.0 57.0 58.0 59.0 59.0 58.0 65.0 56.0 53.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:72.50 stddev:12.88 (17.8%) stddev-sans-first:12.66 13:30:31 INFO - PROCESS | 1674 | Values: 60.0 65.0 71.0 65.0 71.0 75.0 98.0 95.0 74.0 64.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.00 stddev:8.21 (9.8%) stddev-sans-first:8.45 13:30:31 INFO - PROCESS | 1674 | Values: 81.0 86.0 84.0 84.0 85.0 83.0 84.0 81.0 109.0 89.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:126.00 stddev:12.05 (9.6%) stddev-sans-first:12.47 13:30:31 INFO - PROCESS | 1674 | Values: 131.0 136.0 120.0 119.0 140.0 121.0 107.0 138.0 109.0 114.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:152.50 stddev:19.69 (12.9%) stddev-sans-first:19.08 13:30:31 INFO - PROCESS | 1674 | Values: 129.0 142.0 145.0 160.0 183.0 182.0 165.0 138.0 143.0 131.0 13:30:31 INFO - PROCESS | 1674 | 13:30:31 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:81.00 stddev:14.32 (17.7%) stddev-sans-first:14.82 13:30:31 INFO - PROCESS | 1674 | Values: 68.0 69.0 67.0 72.0 91.0 93.0 60.0 62.0 90.0 98.0 13:30:31 INFO - PROCESS | 1674 | -------- Summary: end -------- 13:30:31 INFO - PROCESS | 1674 | 13:30:32 INFO - TEST-INFO | 1674: exit 0 13:30:32 INFO - TEST-OK | kraken | took 58470ms 13:30:32 INFO - SUITE-END | took 1169s 13:30:32 INFO - Completed test suite (00:19:29) 13:30:32 INFO - javascript benchmark 13:30:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2773.5978283148943, 3493.7205023598117, 3532.417151170057, 3553.2005298807753, 3576.749627526073, 4821.783019764111, 5745.138229265613, 5761.827145185651, 5803.303603567578, 5810.15752715856, 5808.82573522794, 5841.415858414157, 5845.09401042838, 5869.9706501467435, 5882.529397648189, 5189.117849965505, 5201.323827902367, 5253.264542963988, 5293.15309550472, 5308.628396012281, 5130.153524668425, 5263.736813159346, 5286.629935904488, 5289.709066001368, 5377.623566350357, 5232.058229518685, 5251.947480525203, 5272.0, 5278.551323137538, 5360.892782144355, 5259.0796610593, 5311.362636483627, 5318.601104917147, 5320.76056577455, 5339.866503337409, 5191.974040129813, 5231.633785634969, 5277.551408130314, 5283.656562323436, 5307.416184219733, 5515.641483303572, 5595.468430499096, 5688.5733569982, 5734.254546908917, 5773.769049238025, 5136.614753893473, 5217.452167522393, 6187.319394866561, 6196.752129914798, 6239.095331176999, 5429.67421954684, 6147.87704245917, 6260.029695397221, 6271.811845644638, 6282.874342513124, 5922.3781502942, 5931.733072011683, 5952.880942381172, 5964.522838172936, 5999.640021598718, 6245.594036387621, 6277.027060805491, 6309.0, 6311.873762524724, 6324.841878953063, 4813.879653008703, 5934.495567876693, 6047.3045599755715, 6134.650895842656, 6205.627662340274, 5231.319928409359, 5349.812756553502, 6184.072389141665, 6246.3441338659695, 6279.183706118267, 6092.817215483543, 6156.138140660311, 6158.445739883342, 6221.564490485713, 6225.1907252057845, 5130.230465430141, 6137.7447333336595, 6191.1641928339095, 6199.287081985539, 6251.187345645037, 4884.267359896044, 4902.50974902514, 4921.311016457699, 4938.728369939616, 4947.703137811671, 4415.337699345124, 4433.935855394682, 4445.622122119591, 4466.798994045275, 4481.820727170942, 5686.658800471985, 5751.0, 5818.389069147764, 5840.094785308284, 5847.415258474119, 6140.04415716754, 6211.565190436626, 6281.96859015702, 6284.654344011032, 6300.243970723451, 5813.09896965971, 5821.301443826683, 5832.795852145155, 5849.415058494202, 5868.149118377812, 4993.6005119590345, 5319.361676598833, 5465.808696695596, 5482.616216864861, 5484.780608775604, 6338.239411270677, 6361.427471527585, 6367.586106903036, 6374.458171055419, 6383.170187875547, 5265.868353291198, 6279.96860015697, 6283.340249273943, 6291.245050593958, 6298.905516417349, 6259.374062593704, 6287.46556542699, 6345.17512723343, 6366.554341196072, 6378.266499352634, 6231.7818876340925, 6237.5633705641985, 6240.157578726814, 6243.8126856194385, 6244.375562443719, 6222.844428889314, 6234.220722409699, 6240.875182496416, 6251.937480625135, 6255.530835187288, 5076.0, 5707.4577915098, 6085.786997455068, 6094.908576371269, 6185.84535386619, 6124.0, 6187.597806142767, 6203.875922481435, 6204.565680402509, 6217.937820621917, 5703.8859222816145, 5813.94186058134, 6030.246219222598, 6054.212952316171, 6073.453389194994, 6126.479249263863, 6161.815145545641, 6171.444569988723, 6179.443850053517, 6188.721507532262, 5732.996725573092, 5826.854328641648, 6014.879702405839, 6032.969835150971, 6038.849028774316], "unit": "score", "name": "dojo.html", "value": 5680.296313422498}, {"lowerIsBetter": false, "replicates": [492.77824978759566, 562.8789810190808, 591.9230500034995, 676.2324761395815, 676.8037269191934, 36874.81562592187, 37486.8125659372, 37490.250194996086, 37560.24879502412, 37579.43630845539, 38723.61276387242, 39266.01834954128, 39327.803360983155, 39401.80299098501, 39469.21061578774, 9339.813203735921, 9540.045995400475, 9559.856602150974, 9580.377275477073, 9592.280578956572, 8426.0, 9485.241180705561, 9508.429494230333, 9628.3260171788, 9752.756181095494, 8431.19903609156, 9650.662226822064, 9660.178884794801, 9757.658481953133, 9789.0, 9654.179394751454, 9656.179224765832, 9706.611735530605, 9722.9513852431, 9730.708078757649, 8296.253337199681, 9479.81502312211, 9604.663836765749, 9616.66341678045, 9617.663381781604, 31689.366212675617, 39160.0, 39316.606833931866, 39370.60629393698, 39625.40561891574, 2625.3567875870535, 3175.6506784253716, 3430.879919202841, 3596.8561257549927, 3906.0234941264684, 28764.42471150586, 29199.85400072986, 29518.85240573805, 30656.540151897738, 31064.378712425623, 2683.725230515509, 2714.877830497632, 2771.4457108578363, 2780.4439112177442, 2798.720127987185, 463343.0, 464005.9999999966, 464633.0, 467914.0, 468692.0, 38140.61859381426, 70645.0, 70751.93872091922, 71123.64438177776, 71169.0, 46194.76902615533, 46314.0, 46373.76813115913, 46724.0, 46770.5322946773, 13620.931895340658, 14287.642673945958, 15165.09009459436, 16471.91764041196, 16494.83505164933, 13119.344032798323, 13160.078794484294, 13208.075434719478, 13232.338383081, 13289.3355332233, 13175.802362964563, 14865.628359291104, 14884.95805293619, 15006.249687515581, 15212.0, 5604.747786349624, 6591.582809695842, 6687.632180230037, 6771.6614169292325, 6776.6950487227205, 980.2452111873818, 1043.175891046065, 1046.2885238038054, 1052.9102379037658, 1070.3791800755544, 29619.555706663985, 29754.851225743732, 30123.548146777815, 30367.392652146835, 30725.69274307273, 1114.1977776001265, 1151.9193656443967, 1199.9880001199876, 1246.875312468746, 1275.6045625856013, 14766.63083422923, 15134.621634459007, 15294.0, 15356.462523811613, 15675.529734107995, 423276.0, 482746.0, 487148.5642571764, 491565.0, 493190.0, 59530.40469595335, 59826.80346393135, 59844.401555984754, 60152.39847601556, 60400.0, 1537.2467490929587, 1543.1975372806303, 1560.4928398270608, 1576.8265490796002, 1587.857092861625, 29526.409471810013, 29887.459565936268, 29922.803087877113, 30418.087457376314, 30573.54139687951, 50543.74728126336, 51013.744931275105, 51385.74307128441, 51474.485255148466, 51748.482515174364, 437032.0, 440989.0, 441276.0, 441920.0, 443134.0, 33562.496562551096, 34280.14299642529, 34501.482477763355, 44959.77520112378, 45682.771586143186, 43182.352264715424, 43554.34668479912, 44129.896752581444, 44186.0, 44798.0, 36161.91514254577, 36824.81587592045, 37572.60883222478, 37808.0, 39053.0, 29749.0, 31271.374572507968, 37609.0, 37609.623903760614, 38290.6170938287, 30700.232494187825, 37673.246535069695, 39452.40821387624, 39458.2108357837, 40148.1970360597, 31261.687383125878, 32237.51643725393, 32659.836700816344, 32702.34595308128, 32898.67101329052, 21632.13471461124, 24821.13126040652, 25555.6166657504, 25625.97496100135, 25845.0], "unit": "score", "name": "ext.html", "value": 19360.691008040478}, {"lowerIsBetter": false, "replicates": [346.56159957653557, 348.64264129267497, 365.9469376940344, 382.85451528419196, 388.78117102882464, 20059.59880802383, 20590.073446694896, 21159.942002899832, 21842.781572184293, 21873.890630546826, 21242.57514849702, 21298.57402851942, 21462.0, 21575.81333026683, 21589.784102158974, 5643.125315576092, 5939.732712027969, 5964.910526342108, 5968.403159684019, 5969.761209551612, 5491.258680078178, 5798.246227990356, 5829.038208695561, 5838.153467747175, 5846.4445877641765, 5748.42515748426, 5768.42315768424, 5786.594938354296, 5787.739551720161, 5795.797147099853, 4989.176785830352, 5441.401445840955, 5708.343540492855, 5733.254676892019, 5783.074708046714, 5036.244563315532, 5057.696538207682, 5060.22891987805, 5066.113430149746, 5069.44236134025, 25687.972481100733, 25975.610365844528, 26076.0, 26172.0, 26291.605625915625, 2460.495598402323, 2561.6413702081722, 2568.730283320243, 2676.210517897225, 2822.548392257229, 14757.852421475754, 14989.0, 15063.54809355721, 15072.246387680572, 15319.617009574738, 1733.2200509770653, 1793.1482545790775, 1804.1340156724714, 1847.7690288713911, 1886.9339573114876, 75255.0, 103820.48089759503, 107956.4602176984, 107978.0, 108411.45794271056, 8944.239739622206, 11583.494145761166, 11628.592999245155, 11730.472128754227, 11806.937375636235, 14267.357968891425, 14366.0, 14395.712085758436, 14416.567502974927, 14468.565943021726, 8809.515476648718, 8914.465132092095, 8935.151160639729, 8953.328500362368, 8954.731358059269, 9023.097690230925, 9024.45853248794, 9113.908860911306, 9192.448453092837, 9209.986901440836, 4473.941986686161, 4586.8165273388695, 4614.3309220163555, 4614.838480653161, 4663.556962088596, 1883.1431698577114, 1947.9220831166595, 1976.960460790776, 2017.7175195472646, 2035.5725297687652, 913.3150137396952, 938.8639745907392, 983.9458829764432, 1050.2490719135856, 1052.037385792007, 19990.800091999186, 20459.693104603444, 20511.8974405127, 20849.791502084787, 20852.791472085388, 974.9658761943298, 995.9850602240972, 1006.9899301006897, 1020.6682828080903, 1052.3580615824342, 8890.822183556293, 11225.989660930556, 11262.0, 11263.155263355282, 11304.830427543593, 643939.0, 654350.0, 654495.0, 663342.0, 666506.0, 72962.2703772966, 74043.88934165992, 75207.0, 114922.4253878742, 121919.0, 994.3785134291213, 1045.6601604478574, 1110.4003837927428, 1110.838928355384, 1117.4189421500937, 15250.31373588169, 18002.379785818815, 18965.0, 19028.143733531746, 19054.809451905305, 42181.0, 49676.751616243135, 51839.96320073653, 52952.20571691505, 55979.0, 72383.0, 73636.0, 79925.60037199777, 80619.0, 82217.76673350025, 6850.623215723183, 8194.426390152632, 8197.34421246287, 8338.166183381612, 8346.833063338821, 9687.0, 11769.0, 12065.879341206475, 13333.0, 13455.798163027366, 9942.652007179713, 10064.29549931527, 10929.251319788795, 11875.762484750085, 11956.880431195577, 11302.547898084313, 11357.0, 11450.885491144982, 11659.18385713026, 11827.349495777471, 11427.714307142389, 11678.481797366288, 11783.882161178279, 11887.167898247386, 11947.283163009899, 8088.83822323562, 10586.36481811063, 11469.483873225558, 11744.060475161796, 11893.345865977455, 11577.189596728149, 12011.399430028638, 12172.45223964906, 12244.0, 12277.877221227673], "unit": "score", "name": "jquery.html", "value": 9734.986390400898}, {"lowerIsBetter": false, "replicates": [1655.0897006646346, 1675.0870775427395, 2023.1705000949614, 2054.5171884607116, 2084.7810979847127, 8362.540060296682, 8670.739877803677, 9116.179543841054, 9344.81310373792, 9377.71866843994, 7672.808179795508, 9038.683646072388, 9071.0, 9131.954340228289, 9171.449713017224, 2545.2491515003026, 2555.2845203343095, 2562.397836508419, 2564.9615255771178, 2575.188815523104, 2519.8866051027658, 2565.717771045193, 2572.768450839424, 2574.948501029978, 2582.4705935283314, 2468.0744720729726, 2501.8999240030375, 2531.8480891146496, 2544.7200807911113, 2548.3374322676054, 2561.884715187821, 2567.229831050677, 2587.5730504466833, 2596.844189348645, 2610.4126571521447, 2570.5758549839443, 2582.8579428131447, 2603.5964425514076, 2604.6353510508543, 2605.387733882536, 9079.773005674844, 9270.351075424724, 9277.814443711155, 9287.349885507949, 9305.25557955362, 5737.168110623936, 5756.827295181151, 5852.297724273072, 5859.824205273849, 5864.530837532987, 3711.9814400928094, 3822.560405553369, 3830.042489377656, 3836.1176929306416, 3857.556381016191, 1076.1068313299943, 1084.7071290751533, 1089.6186334782763, 1129.8305254211934, 1132.915031372642, 12395.380230988414, 12400.503979840796, 12461.376931153496, 12499.125061245717, 12602.621921342374, 4268.338407546835, 5088.211327244283, 5144.897102057937, 5196.038732834362, 5247.055530004636, 10633.149348052137, 10634.627788027537, 10643.308184967953, 10663.680089597325, 10677.252592318464, 5696.601237913306, 5727.140928860705, 5744.655320680772, 5750.396208398058, 5770.682612456355, 4660.580547750718, 5010.323606313174, 5100.2349647553165, 5114.079465696136, 5215.217717342429, 3387.9153021174175, 3501.9824900875333, 3507.5264839246884, 4070.206309769626, 4104.261232978033, 1180.8228765685217, 1377.3182274774051, 1387.2439520461373, 1391.9860801391856, 1401.9299035048207, 1376.4012654495327, 1407.8592140786045, 1412.1174266083697, 1433.254707552067, 1451.1438251431705, 7351.301626345488, 7547.811304717426, 8622.137786221328, 8740.388172827968, 8885.911140888638, 1104.3429159649995, 1272.516443751387, 1277.7380636969585, 1278.0733967873402, 1291.728736965248, 6490.740370385226, 6569.80290591283, 6618.503612229102, 6637.435817955431, 6672.666366681647, 10726.517306721216, 11127.833082503768, 11174.217804753589, 11206.831897521544, 11381.146414018982, 10939.12487001038, 11101.944490277498, 11106.222564420414, 11216.831747523795, 11340.489677964511, 8718.041015488292, 8814.86777698335, 8831.381803273709, 8895.599698013604, 8917.286617070618, 7003.929960700328, 8195.262426381654, 8269.669213231644, 8360.08039115709, 8415.53714545706, 10057.899421005988, 10131.79736405253, 10171.28800983924, 10194.388336699822, 10197.031282028196, 10322.793544128925, 10323.019313165238, 10679.733006674895, 10686.732831678959, 10694.251402401756, 6762.594244345355, 6999.580025198505, 7128.714851405885, 7177.820554485971, 7357.558546487228, 7394.667239974106, 8680.479171249744, 8686.001109872193, 8726.563671816511, 8743.868841967504, 7479.775606731807, 7605.923940760522, 7623.123340815655, 7645.503042302233, 7765.456418050682, 7309.5248808827255, 7341.192468828532, 7368.300011498899, 7422.554646721214, 7508.474406791473, 8156.062052863759, 8186.959065204635, 8221.83556328882, 8227.095019547725, 8247.670093196444, 7094.467914906506, 7251.709931602677, 7309.451791115794, 7366.079240094989, 7440.3675687567165, 7412.592307423143, 7463.440241981982, 7490.662920168496, 7494.737684181027, 7494.812629684301], "unit": "score", "name": "mootools.html", "value": 5171.575917510457}, {"lowerIsBetter": false, "replicates": [336.48181800027953, 336.9915752106197, 342.48456073609213, 345.05627109854544, 347.9756417050806, 6742.595444273341, 6792.932070679291, 6802.18373795144, 6847.486438517106, 6856.965715171417, 6791.3208679132185, 6805.0, 6807.455403567715, 6817.284185160549, 6827.2831352708, 4736.810527578893, 4837.443693975185, 4926.285688575154, 4930.654854160192, 5034.29519867218, 4887.8778030549165, 4927.630427717918, 4931.063098011385, 4933.975330123362, 4947.431045429767, 4861.197902346109, 4871.366722326093, 4905.166121759309, 4909.288153217782, 4936.185529387647, 4905.166121759309, 4915.992221594583, 4918.950810491885, 4932.5807306379, 4932.605391568683, 4078.9190864420952, 4114.300568903293, 4284.785760711983, 4287.892802679958, 4312.331588603772, 6243.625382477066, 6548.312427195171, 6562.507811914125, 6567.113439685677, 6598.934010659928, 5015.6238282128625, 5510.173473978895, 5820.417958204188, 5822.417758224144, 5853.268341457318, 5873.85315367115, 5975.372585878464, 6227.968860155715, 6893.4829887758115, 7306.050213472267, 4672.929906051412, 4684.992726563805, 4687.531246875319, 4688.132695451352, 4691.319758634979, 7243.891341629933, 7630.732924347677, 7717.768466946, 7719.729809456642, 7722.382209423289, 4600.539946005372, 4652.116097941448, 4686.414198225222, 4752.453467851241, 4761.904761904742, 4830.903381932341, 4834.927476087862, 4839.201531747292, 4844.128056949712, 4859.781309841065, 5767.163761254595, 5785.768569257182, 5789.884202316014, 5796.449337312949, 5811.622244554091, 7240.710371585183, 7241.3844823189565, 7249.927500724925, 7253.927460725431, 7261.5280006799385, 1626.772251884737, 1651.6118712102887, 1675.5224760943318, 1686.376040864888, 1687.864970802333, 909.8043920557112, 1053.6628278950661, 1060.3637817309552, 1077.06833588945, 1081.7511972246427, 6707.564008339442, 6721.596704197764, 6731.427828634621, 6736.0, 6748.291429399842, 7551.0, 7553.0, 7554.471187016966, 7557.659905304275, 7593.962030189814, 6709.329067093252, 6725.529212955144, 6734.696938637773, 6743.258241593421, 6782.050512928194, 3466.3760523106084, 3987.8803635890968, 4001.139754952699, 4017.819198136091, 4021.738586991836, 7659.042619672541, 8029.799255018671, 8051.832484289862, 8068.193180681885, 8068.7175948841505, 7864.134945156028, 7904.644291006918, 7914.960425197953, 7918.247766462292, 7932.651449253641, 6842.828929276808, 8012.158723333966, 8018.158093400109, 8027.438079334391, 8030.07654119772, 7330.926690733025, 7685.615719213905, 7696.15342312334, 7711.652975616223, 7716.498427602188, 7484.663190156565, 7519.43604229674, 7526.473146879885, 7534.284242996907, 7552.471327007057, 8003.079645840803, 8025.678972841021, 8026.8394632105865, 8033.718819841278, 8061.435699500978, 4734.124187025412, 4785.6171506278715, 4791.808327666854, 4797.424309082932, 4821.156297647968, 7323.084614423197, 7416.480846340704, 7571.886421703789, 7576.166621671501, 7660.73187438437, 7280.271972802678, 7299.233580474186, 7304.488685791944, 7364.153122390993, 7386.372158366384, 7327.120745510573, 7334.4132469403385, 7352.228016058237, 7374.410047196318, 7377.631118444164, 5477.945220547744, 6884.208316043519, 7156.212816590067, 7157.105361829771, 7168.749093781901, 7308.8903666443985, 7310.378617817545, 7377.26227377258, 7391.926080739339, 7426.108866936002, 5811.854703632443, 7133.429325653831, 7159.821004474929, 7173.713051478091, 7181.964090179725], "unit": "score", "name": "prototype.html", "value": 5286.409717177269}, {"lowerIsBetter": false, "replicates": [649.9057636642684, 733.2117973178835, 746.8095635612918, 748.6556184155288, 775.6315750018738, 15145.772813407793, 15162.772558411632, 15376.846231537667, 15397.230138493058, 15453.0, 14219.004669673128, 14230.0, 14237.0, 14238.857611423882, 14262.928685356585, 789.6367670871406, 959.8080383923243, 979.4710856137694, 984.8276551603476, 988.2588058955783, 965.6234068713208, 965.6958058211676, 979.0063085967748, 979.8432250839867, 980.0689345122126, 999.6801023672427, 1006.0090810551601, 1043.207162556455, 1043.9217058720587, 1046.3042077018774, 1024.2164743970832, 1026.6765968719867, 1035.0684384054337, 1040.0067935121979, 1040.583766493401, 757.7082823113141, 761.8895260187297, 770.0412985832675, 775.9573223472706, 777.1761932351725, 15124.243787810565, 15208.771868421982, 15245.466408675644, 15247.542573722805, 15363.0, 13082.869171308355, 13088.149270297401, 13210.273434961073, 13213.603591892259, 13241.536546220836, 9305.209057230144, 9555.0, 9871.654492092743, 10157.644482443078, 10380.688579342632, 3525.365434221839, 3553.058439513531, 3592.263585964871, 3652.196516766307, 3741.0834345585235, 46863.76568117172, 60089.0, 73554.63222683906, 79166.81249781259, 80660.59669701672, 8456.704015359433, 9484.38765409882, 9639.518024098907, 9674.467904265191, 10196.439195844152, 22278.55442891133, 22338.441538961655, 22500.874956252123, 22557.210497632503, 22576.774232257467, 7496.925030749622, 7596.8480630388185, 7611.238876112345, 7694.730684426018, 7815.179406162271, 3929.960700393017, 3996.6003399659803, 4100.5899410058755, 4122.876313710593, 4312.223799716018, 3663.358912190356, 3711.5917249102577, 3731.0112820102695, 3732.234891847165, 3735.2529494101286, 667.9432248258855, 672.2806596941324, 676.55009418736, 693.4591019005184, 721.0, 553.7535796570487, 600.1957377114687, 600.6036016229268, 603.526231907959, 603.8490377405649, 8147.714829980922, 8162.510249385056, 8264.876026859602, 8355.623996920152, 8645.178708022728, 506.6250974279007, 559.7928766356474, 600.8017354273079, 607.4411541381851, 615.4583966109794, 3207.8556464959133, 3723.1809002019513, 3759.947214779866, 3864.4589757433982, 3944.4083387492105, 94549.0545094554, 95471.0452895476, 96579.0, 98489.50755246179, 99383.50924736135, 81191.0, 81429.0, 82509.58745206236, 82543.17456825355, 82863.17136828676, 72508.18729531698, 73213.63393183106, 73803.0, 74165.0, 75688.0, 7838.882416763639, 7959.363250940027, 7962.283394494523, 8029.357651387992, 8269.46248493846, 48893.51106489032, 50168.24747628861, 50214.74892625513, 50723.98552029012, 50913.0, 67861.32138678747, 71465.21336966618, 71680.0, 71855.64072179605, 71946.64026679833, 9834.459104749307, 10090.747731306776, 10106.898931010595, 10120.89879101229, 10894.61868834587, 10548.156147508027, 10866.891331086588, 10991.395473249047, 11014.44927753593, 11125.0, 10431.634892778717, 10545.736356591147, 10549.683509494727, 11052.949969753183, 11163.0, 10423.0, 10437.895621043692, 10680.83978740335, 10928.836067459153, 10980.505877235384, 8564.657413703382, 9685.17675997548, 9736.805263894825, 9753.122219000325, 9988.350757200758, 8400.0, 8703.47779133254, 8901.51041692713, 8991.370604057653, 9095.772605684646, 8417.915820841714, 8526.0, 8735.737927862174, 8861.202491775772, 8925.642974281216], "unit": "score", "name": "yui.html", "value": 6907.443269575554}], "name": "dromaeo_css", "value": 7661.140646822713}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 112.0, 122.0, 162.0, 170.0, 132.0, 132.0, 100.0, 153.0, 169.0], "unit": "score", "name": "ai-astar", "value": 136.8}, {"lowerIsBetter": true, "replicates": [149.0, 122.0, 139.0, 152.0, 120.0, 174.0, 155.0, 189.0, 144.0, 115.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [191.0, 198.0, 199.0, 202.0, 198.0, 224.0, 186.0, 239.0, 200.0, 200.0], "unit": "score", "name": "audio-dft", "value": 203.7}, {"lowerIsBetter": true, "replicates": [69.0, 76.0, 73.0, 113.0, 63.0, 58.0, 62.0, 59.0, 127.0, 57.0], "unit": "score", "name": "audio-fft", "value": 75.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 117.0, 79.0, 81.0, 80.0, 118.0, 79.0, 80.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [91.0, 81.0, 136.0, 129.0, 91.0, 88.0, 92.0, 76.0, 134.0, 126.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 104.4}, {"lowerIsBetter": true, "replicates": [104.0, 124.0, 96.0, 115.0, 149.0, 96.0, 97.0, 117.0, 120.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 111.4}, {"lowerIsBetter": true, "replicates": [83.0, 142.0, 144.0, 138.0, 92.0, 79.0, 147.0, 146.0, 92.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 115.6}, {"lowerIsBetter": true, "replicates": [53.0, 61.0, 57.0, 58.0, 59.0, 59.0, 58.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [60.0, 65.0, 71.0, 65.0, 71.0, 75.0, 98.0, 95.0, 74.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.8}, {"lowerIsBetter": true, "replicates": [81.0, 86.0, 84.0, 84.0, 85.0, 83.0, 84.0, 81.0, 109.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [131.0, 136.0, 120.0, 119.0, 140.0, 121.0, 107.0, 138.0, 109.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [129.0, 142.0, 145.0, 160.0, 183.0, 182.0, 165.0, 138.0, 143.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 72.0, 91.0, 93.0, 60.0, 62.0, 90.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.0}], "name": "kraken", "value": 1556.1999999999998}]} 13:30:32 INFO - Return code: 0 13:30:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:30:32 ERROR - # TBPL SUCCESS # 13:30:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:30:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:30:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:30:32 INFO - 2016-04-24 13:30:32.962 screenresolution[1680:10520] starting screenresolution argv=screenresolution get 13:30:32 INFO - 2016-04-24 13:30:32.964 screenresolution[1680:10520] Display 0: 1600x1200x32@60 13:30:32 INFO - 2016-04-24 13:30:32.970 screenresolution[1681:10523] starting screenresolution argv=screenresolution list 13:30:32 INFO - Available Modes on Display 0 13:30:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:30:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:30:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:30:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:30:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:30:33 INFO - Intel Iris: 13:30:33 INFO - Chipset Model: Intel Iris 13:30:33 INFO - Type: GPU 13:30:33 INFO - Bus: Built-In 13:30:33 INFO - VRAM (Dynamic, Max): 1536 MB 13:30:33 INFO - Vendor: Intel (0x8086) 13:30:33 INFO - Device ID: 0x0a2e 13:30:33 INFO - Revision ID: 0x0009 13:30:33 INFO - Displays: 13:30:33 INFO - Display: 13:30:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:30:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:30:33 INFO - Display Serial Number: 1600x1200 60 13:30:33 INFO - Main Display: Yes 13:30:33 INFO - Mirror: Off 13:30:33 INFO - Online: Yes 13:30:33 INFO - Rotation: Supported 13:30:33 INFO - Return code: 0 13:30:33 INFO - Running post-action listener: _resource_record_post_action 13:30:33 INFO - Running post-run listener: _resource_record_post_run 13:30:34 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 38036992; Write bytes: 668156928; Read time: 396; Write time: 1891 13:30:34 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 354064896; Write bytes: 355354624; Read time: 27952; Write time: 668 13:30:34 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37062144; Write bytes: 302459904; Read time: 381; Write time: 1189 13:30:34 INFO - Running post-run listener: _upload_blobber_files 13:30:34 INFO - Blob upload gear active. 13:30:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:30:34 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 13:30:34 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'] 13:30:34 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 13:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 13:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:35 INFO - (blobuploader) - INFO - Done attempting. 13:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:36 INFO - (blobuploader) - INFO - Done attempting. 13:30:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:30:36 INFO - Return code: 0 13:30:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:30:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:30:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c6401fd300352d925e96a2c48f1959a60ce13f8b2634a5a3158c330c6f05a725b8aa18528f77e650d7ffb54a3c991a127ea0ff80385c7b6aef6e5ee99a7c537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02b96e7481c0ffc7d479dff923239f10e86e304631e82f9824bbdadaf5971344efadc6a00a849259dd9b1381ecf3a37889d171669387d9edc4142fed2a5764b"} 13:30:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:30:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:30:36 INFO - Contents: 13:30:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c6401fd300352d925e96a2c48f1959a60ce13f8b2634a5a3158c330c6f05a725b8aa18528f77e650d7ffb54a3c991a127ea0ff80385c7b6aef6e5ee99a7c537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02b96e7481c0ffc7d479dff923239f10e86e304631e82f9824bbdadaf5971344efadc6a00a849259dd9b1381ecf3a37889d171669387d9edc4142fed2a5764b"} 13:30:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:30:36 INFO - Copying logs to upload dir... 13:30:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:30:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.401362 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-24 13:30:36.312232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 13:30:36.315264) ========= 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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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/7c6401fd300352d925e96a2c48f1959a60ce13f8b2634a5a3158c330c6f05a725b8aa18528f77e650d7ffb54a3c991a127ea0ff80385c7b6aef6e5ee99a7c537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02b96e7481c0ffc7d479dff923239f10e86e304631e82f9824bbdadaf5971344efadc6a00a849259dd9b1381ecf3a37889d171669387d9edc4142fed2a5764b"} build_url:https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/HSvm9CWLS6ynqnzVIM6DxQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c6401fd300352d925e96a2c48f1959a60ce13f8b2634a5a3158c330c6f05a725b8aa18528f77e650d7ffb54a3c991a127ea0ff80385c7b6aef6e5ee99a7c537", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e02b96e7481c0ffc7d479dff923239f10e86e304631e82f9824bbdadaf5971344efadc6a00a849259dd9b1381ecf3a37889d171669387d9edc4142fed2a5764b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 13:30:36.343158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:30:36.343477) ========= 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.lfB4s3Hzyn/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.HVMJ8NF5v5/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005083 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 13:30:36.392958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 13:30:36.393277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 13:30:36.393728) ========= ========= Total master_lag: 4.53 =========