builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0098 starttime: 1461185709.69 results: success (0) buildid: 20160420120429 builduid: ae4579530dd54e17a53496a45dc9bbcc revision: 5649dee23169c659655bfd2f9bae78b5b1bed073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 13:55:09.689200) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 13:55:09.689614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-04-20 13:55:09.691933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 9 secs) (at 2016-04-20 13:55:19.676696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 13:55:19.677028) ========= 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.6DBx3fClOy/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.hBeXNHjXiE/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-20 13:55:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.51M=0.001s 2016-04-20 13:55:21 (9.51 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.525868 ========= master_lag: 2.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 13:55:22.444966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 13:55:22.445302) ========= 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.6DBx3fClOy/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.hBeXNHjXiE/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.029100 ========= master_lag: 1.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 13:55:23.551992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 13:55:23.552314) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5649dee23169c659655bfd2f9bae78b5b1bed073 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5649dee23169c659655bfd2f9bae78b5b1bed073 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6DBx3fClOy/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.hBeXNHjXiE/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-20 13:55:23,657 truncating revision to first 12 chars 2016-04-20 13:55:23,657 Setting DEBUG logging. 2016-04-20 13:55:23,657 attempt 1/10 2016-04-20 13:55:23,657 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5649dee23169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 13:55:23,917 unpacking tar archive at: mozilla-aurora-5649dee23169/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510284 ========= master_lag: 0.94 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 13:55:25.004425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 13:55:25.004758) ========= script_repo_revision: 5649dee23169c659655bfd2f9bae78b5b1bed073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 13:55:25.005158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 7 secs) (at 2016-04-20 13:55:25.005436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 7 secs) (at 2016-04-20 13:55:32.666434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 13:55:32.666720) ========= /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.6DBx3fClOy/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.hBeXNHjXiE/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:55:32 INFO - MultiFileLogger online at 20160420 13:55:32 in /builds/slave/test 13:55:32 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:55:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:32 INFO - {'append_to_log': False, 13:55:32 INFO - 'base_work_dir': '/builds/slave/test', 13:55:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:55:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:32 INFO - 'branch': 'Mozilla-Aurora', 13:55:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:32 INFO - 'config_files': ('talos/mac_config.py',), 13:55:32 INFO - 'default_actions': ('clobber', 13:55:32 INFO - 'read-buildbot-config', 13:55:32 INFO - 'download-and-extract', 13:55:32 INFO - 'populate-webroot', 13:55:32 INFO - 'create-virtualenv', 13:55:32 INFO - 'install', 13:55:32 INFO - 'run-tests'), 13:55:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:32 INFO - 'download_minidump_stackwalk': True, 13:55:32 INFO - 'download_symbols': 'ondemand', 13:55:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:32 INFO - 'installer_path': 'installer.exe', 13:55:32 INFO - 'log_level': 'info', 13:55:32 INFO - 'log_name': 'talos', 13:55:32 INFO - 'log_to_console': True, 13:55:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:55:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:55:32 INFO - 'opt_config_files': (), 13:55:32 INFO - 'pip_index': False, 13:55:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:32 INFO - 'cmd': ('bash', 13:55:32 INFO - '-c', 13:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:32 INFO - 'enabled': True, 13:55:32 INFO - 'halt_on_failure': False, 13:55:32 INFO - 'name': 'check_screen_resolution'},), 13:55:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:32 INFO - 'cmd': ('bash', 13:55:32 INFO - '-c', 13:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:32 INFO - 'enabled': True, 13:55:32 INFO - 'halt_on_failure': False, 13:55:32 INFO - 'name': 'check_screen_resolution'},), 13:55:32 INFO - 'run_cmd_checks_enabled': True, 13:55:32 INFO - 'sps_profile': False, 13:55:32 INFO - 'sps_profile_interval': 0, 13:55:32 INFO - 'suite': 'dromaeojs-e10s', 13:55:32 INFO - 'system_bits': '32', 13:55:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:32 INFO - 'title': 't-yosemite-r7-0098', 13:55:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:32 INFO - 'use_talos_json': True, 13:55:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:32 INFO - 'work_dir': 'build'} 13:55:32 INFO - ##### 13:55:32 INFO - ##### Running clobber step. 13:55:32 INFO - ##### 13:55:32 INFO - Running pre-action listener: _resource_record_pre_action 13:55:32 INFO - Running main action method: clobber 13:55:32 INFO - rmtree: /builds/slave/test/build 13:55:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:34 INFO - Running post-action listener: _resource_record_post_action 13:55:34 INFO - ##### 13:55:34 INFO - ##### Running read-buildbot-config step. 13:55:34 INFO - ##### 13:55:34 INFO - Running pre-action listener: _resource_record_pre_action 13:55:34 INFO - Running main action method: read_buildbot_config 13:55:34 INFO - Using buildbot properties: 13:55:34 INFO - { 13:55:34 INFO - "project": "", 13:55:34 INFO - "product": "firefox", 13:55:34 INFO - "script_repo_revision": "production", 13:55:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:55:34 INFO - "repository": "", 13:55:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:55:34 INFO - "buildid": "20160420120429", 13:55:34 INFO - "pgo_build": "False", 13:55:34 INFO - "basedir": "/builds/slave/test", 13:55:34 INFO - "buildnumber": 250, 13:55:34 INFO - "slavename": "t-yosemite-r7-0098", 13:55:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:55:34 INFO - "platform": "yosemite_r7", 13:55:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:55:34 INFO - "branch": "mozilla-aurora", 13:55:34 INFO - "repo_path": "releases/mozilla-aurora", 13:55:34 INFO - "revision": "5649dee23169c659655bfd2f9bae78b5b1bed073", 13:55:34 INFO - "stage_platform": "macosx64", 13:55:34 INFO - "builduid": "ae4579530dd54e17a53496a45dc9bbcc", 13:55:34 INFO - "slavebuilddir": "test" 13:55:34 INFO - } 13:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 13:55:34 INFO - Running post-action listener: _resource_record_post_action 13:55:34 INFO - ##### 13:55:34 INFO - ##### Running download-and-extract step. 13:55:34 INFO - ##### 13:55:34 INFO - Running pre-action listener: _resource_record_pre_action 13:55:34 INFO - Running main action method: download_and_extract 13:55:34 INFO - mkdir: /builds/slave/test/build/tests 13:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:34 INFO - https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:37 INFO - Downloaded 1277 bytes. 13:55:37 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:55:37 INFO - Using the following test package requirements: 13:55:37 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:55:37 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 13:55:37 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 13:55:37 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'jsshell-mac.zip'], 13:55:37 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 13:55:37 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:55:37 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 13:55:37 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 13:55:37 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 13:55:37 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:55:37 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:55:37 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 13:55:37 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:55: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:55:37 INFO - https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:55:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:55:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:55:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:38 INFO - Downloaded 17912060 bytes. 13:55:38 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:55:38 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:55:41 INFO - Return code: 0 13:55:41 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:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:41 INFO - https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:44 INFO - Downloaded 17912060 bytes. 13:55: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:55: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:55:48 INFO - Return code: 0 13:55: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:55:48 INFO - https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:51 INFO - Downloaded 10845168 bytes. 13:55:51 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:55:51 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:55:51 INFO - Return code: 0 13:55:51 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:55:51 INFO - https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:55:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:55:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:55:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 13:55:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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:55:54 INFO - Downloaded 115258307 bytes. 13:55:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:55:54 INFO - mkdir: /builds/slave/test/properties 13:55:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:54 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:54 INFO - Contents: 13:55:54 INFO - build_url:https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:55:56 INFO - Running post-action listener: _resource_record_post_action 13:55:56 INFO - Running post-action listener: set_extra_try_arguments 13:55:56 INFO - ##### 13:55:56 INFO - ##### Running populate-webroot step. 13:55:56 INFO - ##### 13:55:56 INFO - Running pre-action listener: _resource_record_pre_action 13:55:56 INFO - Running main action method: populate_webroot 13:55:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:56 INFO - '--tppagecycles', 13:55:56 INFO - '7'], 13:55:56 INFO - 'tests': ['tsvgm']}}, 13:55:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:55:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:55:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'tests': ['damp', 'tps']}, 13:55:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['damp', 'tps']}, 13:55:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:55:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:56 INFO - 'other': {'tests': ['a11yr', 13:55:56 INFO - 'ts_paint', 13:55:56 INFO - 'tpaint', 13:55:56 INFO - 'sessionrestore', 13:55:56 INFO - 'sessionrestore_no_auto_restore', 13:55:56 INFO - 'tabpaint']}, 13:55:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['a11yr', 13:55:56 INFO - 'ts_paint', 13:55:56 INFO - 'tpaint', 13:55:56 INFO - 'sessionrestore', 13:55:56 INFO - 'sessionrestore_no_auto_restore', 13:55:56 INFO - 'tabpaint']}, 13:55:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['a11yr', 13:55:56 INFO - 'ts_paint', 13:55:56 INFO - 'tpaint', 13:55:56 INFO - 'sessionrestore', 13:55:56 INFO - 'sessionrestore_no_auto_restore', 13:55:56 INFO - 'tabpaint']}, 13:55:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['a11yr', 13:55:56 INFO - 'ts_paint', 13:55:56 INFO - 'tpaint', 13:55:56 INFO - 'sessionrestore', 13:55:56 INFO - 'sessionrestore_no_auto_restore', 13:55:56 INFO - 'tabpaint']}, 13:55:56 INFO - 'other_l64': {'tests': ['a11yr', 13:55:56 INFO - 'ts_paint', 13:55:56 INFO - 'tpaint', 13:55:56 INFO - 'sessionrestore', 13:55:56 INFO - 'sessionrestore_no_auto_restore', 13:55:56 INFO - 'tabpaint']}, 13:55:56 INFO - 'other_nol64': {'tests': ['a11yr', 13:55:56 INFO - 'ts_paint', 13:55:56 INFO - 'tpaint', 13:55:56 INFO - 'sessionrestore', 13:55:56 INFO - 'sessionrestore_no_auto_restore', 13:55:56 INFO - 'tabpaint']}, 13:55:56 INFO - 'svgr': {'tests': ['tsvgx', 13:55:56 INFO - 'tsvgr_opacity', 13:55:56 INFO - 'tart', 13:55:56 INFO - 'tscrollx', 13:55:56 INFO - 'cart']}, 13:55:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['tsvgx', 13:55:56 INFO - 'tsvgr_opacity', 13:55:56 INFO - 'tart', 13:55:56 INFO - 'tscrollx', 13:55:56 INFO - 'cart']}, 13:55:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'tests': ['tp5o']}, 13:55:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'talos_options': ['--e10s'], 13:55:56 INFO - 'tests': ['tp5o']}, 13:55:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'talos_options': ['--xperf_path', 13:55:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:56 INFO - 'tests': ['tp5n']}, 13:55:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:56 INFO - 'talos_options': ['--e10s', 13:55:56 INFO - '--xperf_path', 13:55:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:56 INFO - 'tests': ['tp5n']}}, 13:55:56 INFO - 'talos.zip': {'path': '', 13:55:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:56 INFO - Running post-action listener: _resource_record_post_action 13:55:56 INFO - ##### 13:55:56 INFO - ##### Running create-virtualenv step. 13:55:56 INFO - ##### 13:55:56 INFO - Running pre-action listener: _resource_record_pre_action 13:55:56 INFO - Running main action method: create_virtualenv 13:55:56 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:56 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:55:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:56 INFO - Using real prefix '/tools/python27' 13:55:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:59 INFO - Installing pip.................done. 13:55:59 INFO - Return code: 0 13:55:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:59 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:55:59 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:55:59 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:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:55:59 INFO - 'HOME': '/Users/cltbld', 13:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:55:59 INFO - 'LOGNAME': 'cltbld', 13:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:59 INFO - 'MOZ_NO_REMOTE': '1', 13:55:59 INFO - 'NO_EM_RESTART': '1', 13:55:59 INFO - 'PAGER': '/bin/cat', 13:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:59 INFO - 'PWD': '/builds/slave/test', 13:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:55:59 INFO - 'SHELL': '/bin/bash', 13:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:55:59 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:55:59 INFO - 'USER': 'cltbld', 13:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:59 INFO - 'XPC_FLAGS': '0x0', 13:55:59 INFO - 'XPC_SERVICE_NAME': '0', 13:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:00 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:56:00 INFO - Cleaning up... 13:56:00 INFO - Return code: 0 13:56:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:56:00 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:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:00 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:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:00 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:00 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:56:00 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:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:00 INFO - 'HOME': '/Users/cltbld', 13:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:00 INFO - 'LOGNAME': 'cltbld', 13:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:00 INFO - 'MOZ_NO_REMOTE': '1', 13:56:00 INFO - 'NO_EM_RESTART': '1', 13:56:00 INFO - 'PAGER': '/bin/cat', 13:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:00 INFO - 'PWD': '/builds/slave/test', 13:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:00 INFO - 'SHELL': '/bin/bash', 13:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:00 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:00 INFO - 'USER': 'cltbld', 13:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:00 INFO - 'XPC_FLAGS': '0x0', 13:56:00 INFO - 'XPC_SERVICE_NAME': '0', 13:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:00 INFO - Downloading/unpacking psutil>=0.7.1 13:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:56:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:03 INFO - Installing collected packages: psutil 13:56:03 INFO - Running setup.py install for psutil 13:56:03 INFO - building 'psutil._psutil_osx' extension 13:56:03 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:56:03 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:56:03 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:56:03 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:56:04 INFO - building 'psutil._psutil_posix' extension 13:56:04 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:56:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:56:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:56:04 INFO - ^ 13:56:04 INFO - 1 warning generated. 13:56:04 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:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:04 INFO - Successfully installed psutil 13:56:04 INFO - Cleaning up... 13:56:04 INFO - Return code: 0 13:56:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:04 INFO - 'HOME': '/Users/cltbld', 13:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:04 INFO - 'LOGNAME': 'cltbld', 13:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:04 INFO - 'MOZ_NO_REMOTE': '1', 13:56:04 INFO - 'NO_EM_RESTART': '1', 13:56:04 INFO - 'PAGER': '/bin/cat', 13:56:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:04 INFO - 'PWD': '/builds/slave/test', 13:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:04 INFO - 'SHELL': '/bin/bash', 13:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:04 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:04 INFO - 'USER': 'cltbld', 13:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:04 INFO - 'XPC_FLAGS': '0x0', 13:56:04 INFO - 'XPC_SERVICE_NAME': '0', 13:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:56:04 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:56:04 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:56:04 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:56:04 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:56:04 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:56:04 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:56:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:56:07 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:56:07 INFO - Installing collected packages: mozsystemmonitor 13:56:07 INFO - Running setup.py install for mozsystemmonitor 13:56:07 INFO - Successfully installed mozsystemmonitor 13:56:07 INFO - Cleaning up... 13:56:07 INFO - Return code: 0 13:56:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:56:07 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:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:07 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:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:07 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:07 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:56:07 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:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:07 INFO - 'HOME': '/Users/cltbld', 13:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:07 INFO - 'LOGNAME': 'cltbld', 13:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:07 INFO - 'MOZ_NO_REMOTE': '1', 13:56:07 INFO - 'NO_EM_RESTART': '1', 13:56:07 INFO - 'PAGER': '/bin/cat', 13:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:07 INFO - 'PWD': '/builds/slave/test', 13:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:07 INFO - 'SHELL': '/bin/bash', 13:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:07 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:07 INFO - 'USER': 'cltbld', 13:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:07 INFO - 'XPC_FLAGS': '0x0', 13:56:07 INFO - 'XPC_SERVICE_NAME': '0', 13:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:07 INFO - Downloading/unpacking blobuploader==1.2.4 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:56:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:56:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:11 INFO - Downloading docopt-0.6.1.tar.gz 13:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:56:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:56:11 INFO - Running setup.py install for blobuploader 13:56:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:56:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:56:11 INFO - Running setup.py install for requests 13:56:11 INFO - Running setup.py install for docopt 13:56:12 INFO - Successfully installed blobuploader requests docopt 13:56:12 INFO - Cleaning up... 13:56:12 INFO - Return code: 0 13:56:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:12 INFO - 'HOME': '/Users/cltbld', 13:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:12 INFO - 'LOGNAME': 'cltbld', 13:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:12 INFO - 'MOZ_NO_REMOTE': '1', 13:56:12 INFO - 'NO_EM_RESTART': '1', 13:56:12 INFO - 'PAGER': '/bin/cat', 13:56:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:12 INFO - 'PWD': '/builds/slave/test', 13:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:12 INFO - 'SHELL': '/bin/bash', 13:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:12 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:12 INFO - 'USER': 'cltbld', 13:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:12 INFO - 'XPC_FLAGS': '0x0', 13:56:12 INFO - 'XPC_SERVICE_NAME': '0', 13:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:12 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-iHBJHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:12 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-jMjgzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:12 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-S6MNXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:12 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-R_dvcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:12 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-z7M469-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:12 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-6UlzXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-XR9hVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-uTFaeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Wm7eJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-B8w0YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Iuzseb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-xCCF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-T2_uzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-h5woq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:13 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-lwJ2Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:14 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-zg0TAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:14 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-lNbSFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:56:14 INFO - Running setup.py install for manifestparser 13:56:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:56:14 INFO - Running setup.py install for mozcrash 13:56:14 INFO - Running setup.py install for mozdebug 13:56:14 INFO - Running setup.py install for mozdevice 13:56:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:56:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:56:14 INFO - Running setup.py install for mozfile 13:56:14 INFO - Running setup.py install for mozhttpd 13:56:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Running setup.py install for mozinfo 13:56:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Running setup.py install for mozInstall 13:56:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Running setup.py install for mozleak 13:56:15 INFO - Running setup.py install for mozlog 13:56:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Running setup.py install for moznetwork 13:56:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:56:15 INFO - Running setup.py install for mozprocess 13:56:15 INFO - Running setup.py install for mozprofile 13:56:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:56:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:56:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:56:16 INFO - Running setup.py install for mozrunner 13:56:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:56:16 INFO - Running setup.py install for mozscreenshot 13:56:16 INFO - Running setup.py install for moztest 13:56:16 INFO - Running setup.py install for mozversion 13:56:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:56:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:56:16 INFO - Cleaning up... 13:56:16 INFO - Return code: 0 13:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:16 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:16 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:56:16 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:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:16 INFO - 'HOME': '/Users/cltbld', 13:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:16 INFO - 'LOGNAME': 'cltbld', 13:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:16 INFO - 'MOZ_NO_REMOTE': '1', 13:56:16 INFO - 'NO_EM_RESTART': '1', 13:56:16 INFO - 'PAGER': '/bin/cat', 13:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:16 INFO - 'PWD': '/builds/slave/test', 13:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:16 INFO - 'SHELL': '/bin/bash', 13:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:16 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:16 INFO - 'USER': 'cltbld', 13:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:16 INFO - 'XPC_FLAGS': '0x0', 13:56:16 INFO - 'XPC_SERVICE_NAME': '0', 13:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-XzKO7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-jzJPI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-MOxcnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ohfwJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-x30N2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-MZEWk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-rzD52M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Q1zk7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-0KU4_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:56:17 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:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:56:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-s7NH2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JgYe44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-U7qn5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-sMHvYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-WrKbOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-0U_Yg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Qy5AwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:56:18 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:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:56:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-djns4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:56:18 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:56:18 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:56:18 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:56:18 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:56:18 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:56:18 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:56:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:56:18 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:56:18 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:56:18 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:56:18 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:56:18 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:56:18 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:56:21 INFO - Downloading blessings-1.6.tar.gz 13:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:56:21 INFO - Installing collected packages: blessings 13:56:21 INFO - Running setup.py install for blessings 13:56:21 INFO - Successfully installed blessings 13:56:21 INFO - Cleaning up... 13:56:21 INFO - Return code: 0 13:56:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:21 INFO - Reading from file tmpfile_stdout 13:56:21 INFO - Current package versions: 13:56:21 INFO - blessings == 1.6 13:56:21 INFO - blobuploader == 1.2.4 13:56:21 INFO - docopt == 0.6.1 13:56:21 INFO - manifestparser == 1.1 13:56:21 INFO - mozInstall == 1.12 13:56:21 INFO - mozcrash == 0.17 13:56:21 INFO - mozdebug == 0.1 13:56:21 INFO - mozdevice == 0.48 13:56:21 INFO - mozfile == 1.2 13:56:21 INFO - mozhttpd == 0.7 13:56:21 INFO - mozinfo == 0.9 13:56:21 INFO - mozleak == 0.1 13:56:21 INFO - mozlog == 3.1 13:56:21 INFO - moznetwork == 0.27 13:56:21 INFO - mozprocess == 0.22 13:56:21 INFO - mozprofile == 0.28 13:56:21 INFO - mozrunner == 6.11 13:56:21 INFO - mozscreenshot == 0.1 13:56:21 INFO - mozsystemmonitor == 0.0 13:56:21 INFO - moztest == 0.7 13:56:21 INFO - mozversion == 1.4 13:56:21 INFO - psutil == 3.1.1 13:56:21 INFO - requests == 1.2.3 13:56:21 INFO - wsgiref == 0.1.2 13:56:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:21 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:21 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:56:21 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:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:21 INFO - 'HOME': '/Users/cltbld', 13:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:21 INFO - 'LOGNAME': 'cltbld', 13:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:21 INFO - 'MOZ_NO_REMOTE': '1', 13:56:21 INFO - 'NO_EM_RESTART': '1', 13:56:21 INFO - 'PAGER': '/bin/cat', 13:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:21 INFO - 'PWD': '/builds/slave/test', 13:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:21 INFO - 'SHELL': '/bin/bash', 13:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:21 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:21 INFO - 'USER': 'cltbld', 13:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:21 INFO - 'XPC_FLAGS': '0x0', 13:56:21 INFO - 'XPC_SERVICE_NAME': '0', 13:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 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:56:22 INFO - Cleaning up... 13:56:22 INFO - Return code: 0 13:56:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:22 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:22 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:56:22 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:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:22 INFO - 'HOME': '/Users/cltbld', 13:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:22 INFO - 'LOGNAME': 'cltbld', 13:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:22 INFO - 'MOZ_NO_REMOTE': '1', 13:56:22 INFO - 'NO_EM_RESTART': '1', 13:56:22 INFO - 'PAGER': '/bin/cat', 13:56:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:22 INFO - 'PWD': '/builds/slave/test', 13:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:22 INFO - 'SHELL': '/bin/bash', 13:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:22 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:22 INFO - 'USER': 'cltbld', 13:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:22 INFO - 'XPC_FLAGS': '0x0', 13:56:22 INFO - 'XPC_SERVICE_NAME': '0', 13:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:22 INFO - Downloading/unpacking jsonschema 13:56: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:56: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:56: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:56: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:56: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:56: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:56:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:56:24 INFO - Downloading/unpacking functools32 (from jsonschema) 13:56: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:56: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:56: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:56: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:56: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:56: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:56:25 INFO - Downloading functools32-3.2.3-2.tar.gz 13:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:56:25 INFO - warning: no files found matching '*.txt' 13:56:25 INFO - no previously-included directories found matching 'build' 13:56:25 INFO - no previously-included directories found matching 'dist' 13:56:25 INFO - no previously-included directories found matching '.git*' 13:56:25 INFO - Installing collected packages: jsonschema, functools32 13:56:25 INFO - Running setup.py install for functools32 13:56:25 INFO - warning: no files found matching '*.txt' 13:56:25 INFO - no previously-included directories found matching 'build' 13:56:25 INFO - no previously-included directories found matching 'dist' 13:56:25 INFO - no previously-included directories found matching '.git*' 13:56:25 INFO - Successfully installed jsonschema functools32 13:56:25 INFO - Cleaning up... 13:56:25 INFO - Return code: 0 13:56:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:56:25 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:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:25 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:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:25 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 0x102091a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020984c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc679d76fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, '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.6DBx3fClOy/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.hBeXNHjXiE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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:56:25 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:56:25 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:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:25 INFO - 'HOME': '/Users/cltbld', 13:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:25 INFO - 'LOGNAME': 'cltbld', 13:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:25 INFO - 'MOZ_NO_REMOTE': '1', 13:56:25 INFO - 'NO_EM_RESTART': '1', 13:56:25 INFO - 'PAGER': '/bin/cat', 13:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:25 INFO - 'PWD': '/builds/slave/test', 13:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:25 INFO - 'SHELL': '/bin/bash', 13:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:56:25 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:25 INFO - 'USER': 'cltbld', 13:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:25 INFO - 'XPC_FLAGS': '0x0', 13:56:25 INFO - 'XPC_SERVICE_NAME': '0', 13:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:25 INFO - Downloading/unpacking flake8 13:56:25 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:56:25 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:56:25 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:56:25 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:56:25 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:56:25 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:56:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:56:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:56:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:29 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:56:29 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:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:56:29 INFO - no previously-included directories found matching 'docs/_build' 13:56:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:56:29 INFO - Running setup.py install for pep8 13:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:56:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:56:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:56:29 INFO - no previously-included directories found matching 'docs/_build' 13:56:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:56:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:56:29 INFO - Cleaning up... 13:56:29 INFO - Return code: 0 13:56:29 INFO - Running post-action listener: _resource_record_post_action 13:56:29 INFO - Running post-action listener: _start_resource_monitoring 13:56:29 INFO - Starting resource monitoring. 13:56:29 INFO - ##### 13:56:29 INFO - ##### Running install step. 13:56:29 INFO - ##### 13:56:29 INFO - Running pre-action listener: _resource_record_pre_action 13:56:29 INFO - Running main action method: install 13:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:56:30 INFO - Reading from file tmpfile_stdout 13:56:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:56:30 INFO - Reading from file tmpfile_stdout 13:56:30 INFO - Output received: 13:56:30 INFO - Usage: mozinstall [options] installer 13:56:30 INFO - Options: 13:56:30 INFO - -h, --help show this help message and exit 13:56:30 INFO - -d DEST, --destination=DEST 13:56:30 INFO - Directory to install application into. [default: 13:56:30 INFO - "/builds/slave/test"] 13:56:30 INFO - --app=APP Application being installed. [default: firefox] 13:56:30 INFO - mkdir: /builds/slave/test/build/application 13:56:30 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:56:30 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:57:02 INFO - Reading from file tmpfile_stdout 13:57:02 INFO - Output received: 13:57:02 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:57:02 INFO - Running post-action listener: _resource_record_post_action 13:57:02 INFO - ##### 13:57:02 INFO - ##### Running run-tests step. 13:57:02 INFO - ##### 13:57:02 INFO - Running pre-action listener: _resource_record_pre_action 13:57:02 INFO - Running main action method: run_tests 13:57:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:57:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:57:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:57:02 INFO - 2016-04-20 13:57:02.522 screenresolution[1642:7992] starting screenresolution argv=screenresolution get 13:57:02 INFO - 2016-04-20 13:57:02.524 screenresolution[1642:7992] Display 0: 1600x1200x32@60 13:57:02 INFO - 2016-04-20 13:57:02.529 screenresolution[1643:7995] starting screenresolution argv=screenresolution list 13:57:02 INFO - Available Modes on Display 0 13:57:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:57:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:57:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:57:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:57:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:57:02 INFO - Intel Iris: 13:57:02 INFO - Chipset Model: Intel Iris 13:57:02 INFO - Type: GPU 13:57:02 INFO - Bus: Built-In 13:57:02 INFO - VRAM (Dynamic, Max): 1536 MB 13:57:02 INFO - Vendor: Intel (0x8086) 13:57:02 INFO - Device ID: 0x0a2e 13:57:02 INFO - Revision ID: 0x0009 13:57:02 INFO - Displays: 13:57:02 INFO - Display: 13:57:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:57:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:57:02 INFO - Display Serial Number: 1600x1200 60 13:57:02 INFO - Main Display: Yes 13:57:02 INFO - Mirror: Off 13:57:02 INFO - Online: Yes 13:57:02 INFO - Rotation: Supported 13:57:02 INFO - Return code: 0 13:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:57:02 INFO - Python 2.7.3 13:57:02 INFO - Return code: 0 13:57:02 INFO - grabbing minidump binary from tooltool 13:57: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:57:02 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 0x101f35d30>, '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 0x101d99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:57:02 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:57:02 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:57:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:57:02 INFO - Return code: 0 13:57:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:57:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:57:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:57:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:57:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:57:04 INFO - Return code: 0 13:57:04 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/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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:57:04 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/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --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:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6DBx3fClOy/Render', 13:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:04 INFO - 'HOME': '/Users/cltbld', 13:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:04 INFO - 'LOGNAME': 'cltbld', 13:57:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:57:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:04 INFO - 'MOZ_NO_REMOTE': '1', 13:57:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:57:04 INFO - 'NO_EM_RESTART': '1', 13:57:04 INFO - 'PAGER': '/bin/cat', 13:57:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:04 INFO - 'PWD': '/builds/slave/test', 13:57:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:04 INFO - 'SHELL': '/bin/bash', 13:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hBeXNHjXiE/Listeners', 13:57:04 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 13:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:04 INFO - 'USER': 'cltbld', 13:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:04 INFO - 'XPC_FLAGS': '0x0', 13:57:04 INFO - 'XPC_SERVICE_NAME': '0', 13:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:04 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/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--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:57:04 INFO - mozversion application_buildid: 20160420120429 13:57:04 INFO - mozversion application_changeset: 5649dee23169c659655bfd2f9bae78b5b1bed073 13:57:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:57:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:57:04 INFO - mozversion application_name: Firefox 13:57:04 INFO - mozversion application_remotingname: firefox-dev 13:57:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:57:04 INFO - mozversion application_vendor: Mozilla 13:57:04 INFO - mozversion application_version: 47.0a2 13:57:04 INFO - mozversion platform_buildid: 20160420120429 13:57:04 INFO - mozversion platform_changeset: 5649dee23169c659655bfd2f9bae78b5b1bed073 13:57:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:57:04 INFO - mozversion platform_version: 47.0a2 13:57:04 INFO - using testdate: 1461185824 13:57:04 INFO - actual date: 1461185824 13:57:04 INFO - starting webserver on 'localhost:49275' 13:57:04 INFO - SUITE-START | Running 2 tests 13:57:04 INFO - TEST-START | dromaeo_css 13:57:04 INFO - operating with platform_type : mac_ 13:57:04 INFO - Initialising browser for dromaeo_css test... 13:57:04 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpqHB6Xf/profile http://localhost:49275/getInfo.html) 13:57:07 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 13:57:07 INFO - PROCESS | 1661 | colorDepth:24 13:57:07 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 13:57:07 INFO - PROCESS | 1661 | __metrics 13:57:07 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:57:07 INFO - TEST-INFO | 1661: exit 0 13:57:07 INFO - Browser initialized. 13:57:07 INFO - Running cycle 1/1 for dromaeo_css test... 13:57:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpqHB6Xf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:20 INFO - PROCESS | 1665 | RSS: Main: 217845760 13:57:20 INFO - PROCESS | 1665 | 13:58:09 INFO - PROCESS | 1665 | 1461185889822 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:00:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 14:00:22 INFO - PROCESS | 1665 | RSS: Main: 228995072 14:00:22 INFO - PROCESS | 1665 | 14:03:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 14:03:24 INFO - PROCESS | 1665 | RSS: Main: 240476160 14:03:24 INFO - PROCESS | 1665 | 14:06:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 14:06:26 INFO - PROCESS | 1665 | RSS: Main: 242581504 14:06:26 INFO - PROCESS | 1665 | 14:09:28 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 14:09:29 INFO - PROCESS | 1665 | RSS: Main: 244543488 14:09:29 INFO - PROCESS | 1665 | 14:12:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 14:12:32 INFO - PROCESS | 1665 | RSS: Main: 246841344 14:12:32 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 14:15:34 INFO - PROCESS | 1665 | RSS: Main: 248397824 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | __start_tp_report 14:15:34 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:15:34 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:15:34 INFO - PROCESS | 1665 | |i|pagename|runs| 14:15:34 INFO - PROCESS | 1665 | |0;dojo.html;3544.9645503544966;3578.320119177358;3621.9496346059645;3628.546431696038;3629.909252268693;5846.649201047941;5855.414458554137;5859.15042318864;5874.383189765066;5883.8529036774;5833.795817146401;5860.443257890493;5872.559558033143;5880.176775251458;5891.587588868781;5188.169892817141;5231.555317797992;5289.603279754034;5302.973485132588;5354.170103633943;5165.276861239429;5304.920426193591;5319.574434045287;5323.44103869092;5342.2253773202865;5227.08526007949;5265.65773224741;5320.281761962144;5342.27879236302;5383.084875571143;5297.761600727958;5300.284461597674;5317.175837745156;5327.946720532784;5348.545373643245;4273.380359847804;5160.509751573594;5261.657992230493;5268.894622107537;5325;4678.7660616969015;5594.440555944414;5697.1739097831;5716.399778023289;5816.069428891357;5183.663061900965;6242.063690446424;6305.905411418832;6328.082428047907;6334.334894836068;6221.035739460391;6305.558610897239;6308.337624549448;6311.4950803936035;6319.6524191169465;5886.117082437669;5992.400759923973;5994.760209591611;5998.8302281054775;6042.15409842618;5452.40023597404;6273.153124328249;6395.328490508429;6414.230292364946;6422.357764223634;6145.924463218918;6165.5375846810775;6273.101279991204;6279.277883043508;6293.622382657055;6261.373862613702;6337.588056776295;6337.936620633827;6343.429091381798;6344.809655710336;6283.277423096311;6286.339934306923;6291.716872740738;6316.336784637639;6325.683715814191;5189.922151167735;6201.193844800147;6225.501959843202;6330.936690633127;6344.460720838781;4999.850004499871;5003.374578177728;5008.949910500921;5010.5240002199735;5014.724190169576;4479.216137175981;4517.796699148546;4529.932051019237;4530.320451932171;4545.136424079415;5693.459121383462;5734.05388110957;5840.386759390288;5871.64770113786;5889.617174883619;6274.811755647338;6288.402601752826;6309;6321.1782468278825;6343.682815859189;5811.070228763378;5843.444872737083;5875.294964604275;5896.166444800119;5905.822825315247;5377.865553361197;5388.434214407509;5397.70312632809;5453;5506.64206826555;6355.745770169234;6399.3600639937495;6404.551681382259;6413.518986076063;6431.710573024318;6293.779717709858;6306.432421082125;6312.021636646327;6331.651759153291;6415.615063096229;5203.8178663746585;6283.685815709287;6412.871742565216;6435.839104022437;6465.676716164267;6274.090256912813;6304.117423560613;6340.397662222082;6343.90484142729;6355.682215889095;6256.280527739368;6310.652914089769;6332.778352757631;6341.746330146742;6345.555811093179;5679.9148012779015;6115.605440958429;6233.781817636361;6268.874622507433;6288.151099601495;6200.503959683124;6207.534434917309;6228;6237.625742455467;6260.624362538262;4915;5948.791792287422;6042.093685947143;6114.052321890114;6116.938830611815;6106.73370229429;6203.8138855834395;6224.408681175281;6240.095186197885;6291;6144.139820425234;6147.754089836535;6156.78451254204;6185.567010309235;6190.164327815687 14:15:34 INFO - PROCESS | 1665 | |1;ext.html;501.04800878331145;521.7182721330481;572.753715902162;627.3945642455031;661.9238787539433;32911.67088329116;39355.80322098386;39653.80173099138;39741;39836.80081599588;41239.587604123946;41273;41456.378154327635;41550;41672.74981750545;8717.825643487127;9215.723528294162;9459;9695.854562181574;9700.417974921527;9613.423194608311;9645.807083858319;9692.27307951903;9775.169110625606;9795.657151999681;9665.130138287554;9749.122578967892;9751.12239898409;9757;9790.314677972545;9648.228141748643;9704.75738106546;9706.902930970671;9727.027297270288;9746.074122958307;9556.139947404698;9590.520473976274;9627.374220675703;9737.951310243474;9747.902520974842;39878.80060599678;40602.390964135564;40662.59337406618;40749.388759168636;40895.795521022505;3442.208292092833;3581.8388172532036;3612.747107702462;4011.8194681239415;4029.798510074514;29073.127806165638;29835;29854.850725746233;30001.099967001024;31262.374752504824;2431.5623187826186;2687.0595291647965;2778.749912507884;2826.7314605112483;2907.941841163186;484853;488428.55785721197;488704;488940.99999999645;489172;49351.753241233564;65767.34232657708;71881.92177117347;75137.24862751411;75836;48768.26847597289;48810.75594622075;48844.75577622089;49320.506794932306;49445.25832112521;17166.57083572896;17168.141592920303;17384.391546296072;17414.564635884206;17421.39025134114;13367.532136375181;13556.389962451713;13601.387937542835;13761.931190343985;13762.24307663088;12599;15503.612409689847;15530.301136448887;15868.20658967047;16045.438409655839;5676.801311954062;6670.733170673216;6755.49333799967;6756.155480564929;6763.898541521881;882.5675419044622;1003.8694969654044;1044.6500422358442;1052.8210204265292;1144.6451600003859;30973.69026309753;30977;31126.377472450426;31331.686683133332;31800;1062.5377960587168;1162.3026184289358;1166.6383421139474;1171.7363593191635;1284.6081945006677;15443.91892567532;15608.687826243638;15818.76271855923;15822.60443488899;16041.87706860532;522663;525777;530941;531837;535674.3216283894;65249;65743;65837.67081164563;66194;66237.33762662408;1551.0771091200718;1557.9532614021598;1581.7073841339388;1592.633694250329;1592.6416556274978;30070.548941765453;30755.769769208982;30818.485106891698;31277.8436107818;31320.373592527565;56911.71544142418;57377.42622573721;57456;57587;57709.711451442476;496095;502379;503902;504699;505664.47167763923;35001.124971875906;35927.46108808422;36031.81984090063;36522;36555.268894621426;48471.75764121157;48689.75655121702;48722.75638621784;49137;49257.507424925294;39694.60305397025;40286.79856600698;42695.786521067195;44048;44163.89590260269;40275.54902343076;41796.373054404816;42009.78995105005;42168.78915605525;42689;42700.78649606732;43459.13081738411;43912.780436097615;44235;45016.77491612521;32189.678103218666;38968.2206355877;39536;39964.60035399609;40701.59298406978;22361.329160125224;27202.639868006125;27220.591691125046;27403;27479.725202747715 14:15:34 INFO - PROCESS | 1665 | |2;jquery.html;377.2040993503708;381.7919234017461;383.0691419849765;389.8401655321319;390.3091527995448;19464.912368402634;21374.824384658838;21939.561208775816;22057.66913496297;22272.777272227293;21765.455863603416;21804;21813;21988.780112198914;22222.555548889053;5408.783648654059;5696.601237913327;5858.941410585882;6069.575129740898;6108.389161083901;5871.178035075071;5871.588988770788;5909.4090590941;6013.067974463965;6014.248218972629;4958.157113290749;5044.646874718771;5171.172612382001;5866.384029676887;5919.644821310713;5847.678377689225;5941.465268125868;5960.1357803118735;5983.431574000485;6011.939880601203;5071.847844564632;5161.767720452589;5194.7662355193725;5216.634835561512;5239.73801309933;26248.60627090595;26276.73723262762;26361.73638263612;26430.207093787023;26643.733562664514;2191.0906973605934;2246.213825161197;2333.288347054148;2358.386819426961;2507.736687647789;12300.876991230063;15624;15673.137977411237;15808.367665293374;15927.840721592751;1786.481920243128;1839.3470318037039;1856.7122096074995;2003.3188715836686;2035.7760646328893;113555.86444135536;116519;118189;119423.40288298503;120126.59746805015;11872.228305160137;11950.88049119515;11995.76008479843;12045.397730113635;12125.27248365101;14555.92722036383;14592.781108283385;14699.779503307458;14702.926485367505;14772.55682329532;9132.634694612274;9139.451632902048;9246.76883077915;9255.213306868856;9265.629374824932;8566.800647909298;8608.612612432456;9490.861096668445;9595.568199431042;9603.90396096044;3807.0672685192303;4582.564656357641;4631.814727410933;4659.697119687277;4718.268668356411;1947.464447276982;1964.6168997045725;1984.563396052866;1986.3842208915282;2012.104613447002;942.4863449420083;983.5623147699205;1009.4094954451581;1056.4612047855649;1082.3343643659093;19721;19970.90014549918;20332.593348132956;20348.49128771763;20351.59296814085;854.8974123105268;863.404251066762;956.5791051937125;1020.4846552491093;1116.1684545014016;10516.13707165109;10723;10738.463076846127;10768;10788.136949044057;659634;682243;685580;691681.6247756288;692078;114449;116192;123218.38390807988;130878.69121308856;137259;932.2122806228726;1075.714935542082;1081.0756802933536;1090.5256213547132;1094.813881640139;13209.801852972405;18010.36963706264;18052.638947221243;18373;18773.624527509648;40476.59523404728;50785.74607126941;51077.74461127819;51144;52017.7399113002;60446.79106417759;74917.62541187259;80126.5993670028;80702.19297807182;83518;6884.345987131214;8121.959390203011;8177.4684645497855;8208.425410221227;8281.54451505173;9620.37467564606;13325.466981320638;13342.666433339244;13502.932485337511;13656.248906310248;11360.204785664924;11547.595834145764;11600.767984640092;11896.643100706993;12075.818862717242;11394.715132121431;11535.884641153481;11659.533618655498;11888.940555297168;11922.284662920252;11453.942730286628;11702.414879255834;12041.819372709591;12115.273083615011;12147.75704485923;8022.9598852005365;8086.1509541499645;8362.60194194121;8438.746837594881;8512.446690965067;11062.225644205151;12124.636260912186;12128.818067728815;12198.634040978784;12291.446884890023 14:15:34 INFO - PROCESS | 1665 | |3;mootools.html;1511.5616471223343;1620.6839666265075;1867.747854039705;1908.30346923373;2001.6797312430015;8260.752177434671;8957.641694332218;9167.679131230409;9377.859332110023;9405.294602904783;8988.820223595525;9022.368434209608;9047.592858321375;9111.997680255166;9211.12494313041;2588.3011586871535;2588.404666926608;2595.7014943281483;2613.751693589106;2614.3856193794445;2547.9108231211912;2592.546304396723;2608.6087086936923;2609.5302845487804;2616.123598594473;2576.085489651175;2601.2586412872333;2634.1834031450217;2636.433166869123;2637.643918071055;2597.129961462912;2615.3069436599317;2620.65931428913;2627.632131501591;2627.8160528762996;2572.0611976628397;2611.673540807399;2612.373030472692;2613.3597268669296;2626.120249716347;9083.273338132933;9153.359264851462;9220.492872891988;9221.631134754602;9222.35443518954;5821.18503409523;5864.970675146639;5884.499817515516;5977.2229610150835;5993.160957465958;3657;3771.886843394675;3811.6760075393627;3819.083419979185;3820.102275965146;1052.5684469367523;1063.7659714862718;1069.4759567811793;1105.1987309200845;1106.4246591772314;12421.503139874394;12452.439640216213;12469.127161098726;12493;12499.812502812465;4225.598568136023;4993.151164302078;5090.363704536933;5132.486751324837;5136.9743151284;10554.788904221872;10586.100181484506;10587.788244235073;10619.575216991234;10701.411422371844;5604.103343465026;5752.683602401824;5767.942320576824;5779.653220806765;5782.2483077199695;4603.769811509411;5023.924641130386;5158.561522270574;5161.922571161435;5182.844514664566;3468.323676883034;4101.425800387948;4157.520852456404;4164.167166566699;4168.103857670615;1063.2238465919922;1380.171896861895;1381.8461584576992;1385.9445622175;1392.8955328350414;1119.652907598647;1363.9045266831226;1386.9930650346685;1391.679913619873;1421.5593166118535;8439.662413503514;8530.87203691945;8554.443961142506;8566.057733649293;8567.4002819802;539.0889396919194;551.1402212548358;551.9586031047687;554.0442736279884;555.8249151517259;5423.4847689470225;6363.936360636334;6366.108744775735;6509.804705858832;6522.119513865662;11021.724456888642;11049.226554141294;11311.660650180507;11319.37743424103;11385.259958102697;9347.485888276075;11110.222284440173;11199.66401007971;11259.380734059541;11298.661040168809;8536.8719469208;8608.65565377378;8646;8713.607887645072;8748.387612867038;8062.234087761653;8159.388045896463;8199.42604017713;8222.753317400488;8232.62953167097;9807.21542276602;9824.950875245579;9918.851217231891;10125.79748405013;10158.492075396052;10136.89863101389;10330.121939634915;10409.68770936873;10426.635067772591;10451.163906887583;7037.155541334868;7423.406127509894;7689.3464055555905;7791.142974272939;7862.488938218998;8499.915000849913;8504.192101750325;8565.400421970402;8578;8590.742277731679;7417.777466676009;7593.354564862048;7611.809704757204;7620.390368770596;7705.075390953121;7371.115466144097;7391.778246652609;7416.110066792019;7436.182019977907;7573.9242607575425;7926.365890728844;8057.113717490954;8085.312748416451;8112.75661730149;8114.756557303291;7066.929330706833;7303.707851686086;7319.304666056716;7338.596377199306;7363.742269020773;6241.594296370903;7339.889901651586;7442;7444.032275804111;7447.776566703008 14:15:34 INFO - PROCESS | 1665 | |4;prototype.html;324.96262929763077;337.9712724418424;339.2858033838768;343.3407856914723;344.15681580128677;6918.827029324257;6940.791776246714;6944.3055694430595;6950.026996220533;6974.267701891305;6356.745730170787;6844.79465616031;6851.623160726158;6852.074969879065;6857.759978400757;4800.639952003597;4970.179920313144;5014.774335154927;5015.5486006259425;5017.573506251963;5018.619879533121;5021.447640759514;5052.0906236877345;5099.209622508517;5110.693358398508;5016.874578135539;5025.271335656327;5043.974780126095;5052.14113600687;5054.646174767768;5041.067402530525;5054.848354549369;5068.518490743392;5070.949290507103;5083.542481176712;4307.806148723315;4320.24395730749;4331.545187755271;4338.6095251427205;4340.978295108504;5329.520343169133;6331.620102793847;6597.60414375139;6671.866562668768;6703.597784132919;5492.231087647732;5916.201312822757;5924;5926.170336152899;5934.080217566284;7402.851942961164;7406.777796666109;7419.554826710415;7440.404767618577;7455.701771929116;4731.881702957419;4734.2425211966265;4736.242201247818;4743.928841067387;4749.4775574686755;7362.926370736332;7735.497192682514;7810.492317999312;7814.0623125224765;7837.686492540349;4478.776061196927;4605.286180641939;4693.788779504862;4758.310045043519;4766.785494652749;3574.1064733816547;4357.847475338412;4627.95372046282;4756.548127927841;4893.804247830047;5833.620814647034;5839.678817665069;5854.121881717691;5860.355360910296;5860.619059761102;6419.903701444388;6971.442284617218;7398.3341499265325;7410.740174170404;7429.925700742923;1685.9409920652718;1703.1654489300154;1703.5315288295817;1703.8040625328;1706.1895599590096;1049.1344640671325;1087.8259478483562;1087.896649818266;1090.2749671468384;1092.9672109836717;6740.83147921296;6788.389044985876;6794.558353706993;6827.351401616838;6827.69275382609;7591.316781489692;7595.658195381221;7610.961945190239;7622.313991740659;7636.732714354971;4972.55247027762;5839.919614871177;6400.135981642512;6597.670116494156;6799.184097908283;4002.2195671844293;4009.4587230724064;4040.595940405936;4043.757374557536;4068.3694027425795;6318.273398559132;7234.385077268491;7858.921410785933;7952.880706789403;7957;6937.236903940562;7570.545767253872;8004.599770011476;8032.357411407073;8035.517868927766;7007.808672525683;7477.588732619649;8003.599820009093;8010.158933311918;8067.919320806835;6887.483438742214;7181.138263408216;7464.290892365217;7775.844483110193;7784.143744188248;7578.583177925267;7612.56397952672;7619.771406857803;7634.6182690864125;7661.463697541119;8003.799905002422;8021.558814265271;8047.436679432383;8049.637766300648;8049.879251811345;4826.276058591239;4853.4418541868135;4856.8300109495995;4856.882916929056;4882.487338829514;7371.705131794668;7600.619969001417;7701.383889288732;7714.228577142241;7737.83932410143;5841.211436456024;5871.500922421642;6281.654509002049;6590.978398348264;7315.85418270149;5928.703564821655;7338.339549440576;7394.408447324308;7429.888551671837;7430.182679905314;6527.5430719849155;7236.34872861445;7257.528260663251;7271.3455788979245;7276.090488688914;5911.881762364815;7109.4667899908745;7372.410207183305;7390.039294891844;7428.628568571442;7223.386012189023;7224.13310402755;7235;7251.492395532262;7268.418526517971 14:15:34 INFO - PROCESS | 1665 | |5;yui.html;714.2964180282422;769.9692012319504;774.6049514747484;784.3960150683973;797.7287722174459;15225.695486090299;15263.38946442141;15270.847291527081;15614.985025973318;15638.687226255468;14122.576322710334;14389.928050359733;14443.711125777478;14444.566663000127;14454.710905781878;804.5775967616989;971.6987733802526;971.7279161834663;978.4373984958642;1005.15566923784;988.495867107773;989.0999190736432;996.5017491254373;1006.1900170362856;1006.7684432580475;1039.5997540946753;1045.1951996962334;1047.0681093826463;1050.322541960435;1061.739873730937;1010.8736407949007;1034.4000479721744;1046.4558429616634;1049.821530339844;1050.1074087026004;691.6092407789582;751.1174370115093;757.9507332023456;779.3453499060817;793.7063286584001;15400;15452.690946181126;15534.689306213926;15557.533274001798;15789.21053947298;13459.528916487876;13512.729745405135;13530.458781648722;13636.659083522893;13696.93151534236;10303.175745940307;10362.067413932707;10385.376877387305;10397.32417392867;10559.47202639865;3568.107973006748;3585.910352241189;3588.784672919633;3639.94540081899;3655.707543396522;85276;86864.13135868624;87318.12681873163;87388;87415.12584874197;9885.456299903575;9945.502724863727;9953;10036;10256.743581410525;23778.762212378002;23818.40453988664;23821.642675359883;23854.284371468537;23855.284341469785;7698.961505192438;7713.267239612228;7765.961170194226;7767.37860971121;7921.049474063034;4176.665866730655;4207.810648520824;4232.217039847638;4252.829886804555;4258.936115958263;3826.9808650956566;3863.2466668999277;3870.825812838429;3876.7673939563715;3897.201073779925;670.7819958513503;671.3890359772583;689.3520091114436;690.4855882367668;696.8432102776936;545.118174892909;602.4276936909953;604.4197570332442;607.3440684061292;615.923009623797;8281.503109813431;8527.360447966428;8580;8639.740807775777;8711.34664900135;587.4800801290803;598.2970010237952;607.1924340627044;610.1640752169557;619.1393962392278;3524.806135662563;3643.872464463784;3849.4610754494392;3935.7835319057153;3953.8616148434667;92540.0745992545;94766;95286.57070143953;96403;96670.51664741631;36495.63504364975;37619.247615048094;71240;74923.87614185791;83506;71403;72303.6384818083;72884;72993.6350318245;74004.62997685085;7909.406794490551;8016.7194148204535;8031.759047228593;8140.59297035134;8153.959230203811;51416;51665.741671291406;52259.73870130777;53309;53341;64834;69238.65380673064;70801.29198707947;72434.27565724275;72614;9111.544422778701;10399.440083987462;10508.369497830156;10733.570657173626;10927.398993055458;10587.788244234918;10646.307989980627;10694;10869.565217391215;11604.767904642029;9531.523423828643;9905.653302134391;9912.603495860085;10373.325733827278;10589.629362972259;10281.640142594973;10471.476426178508;10543.78912421732;10778.73053173677;10898.291611045257;10025;10399.1160751337;10493.790124197625;10567.63013294531;11278.154138439486;8489.4481858679;8504.319654427754;8609.053004169411;8643.308535317285;9070.727878163665;8733.214010739064;8884.244839188741;8908.376413650982;8914.643414263357;9003.594838232426 14:15:34 INFO - PROCESS | 1665 | __end_tp_report 14:15:34 INFO - PROCESS | 1665 | __start_cc_report 14:15:34 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,361 14:15:34 INFO - PROCESS | 1665 | __end_cc_report 14:15:34 INFO - PROCESS | 1665 | __startTimestamp1461186934555__endTimestamp 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:15:34 INFO - PROCESS | 1665 | Number of tests: 6 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5804.83 Median:6042.15 stddev:647.57 (10.7%) stddev-sans-first:624.82 14:15:34 INFO - PROCESS | 1665 | Values: 3545.0 3578.3 3621.9 3628.5 3629.9 5846.6 5855.4 5859.2 5874.4 5883.9 5833.8 5860.4 5872.6 5880.2 5891.6 5188.2 5231.6 5289.6 5303.0 5354.2 5165.3 5304.9 5319.6 5323.4 5342.2 5227.1 5265.7 5320.3 5342.3 5383.1 5297.8 5300.3 5317.2 5327.9 5348.5 4273.4 5160.5 5261.7 5268.9 5325.0 4678.8 5594.4 5697.2 5716.4 5816.1 5183.7 6242.1 6305.9 6328.1 6334.3 6221.0 6305.6 6308.3 6311.5 6319.7 5886.1 5992.4 5994.8 5998.8 6042.2 5452.4 6273.2 6395.3 6414.2 6422.4 6145.9 6165.5 6273.1 6279.3 6293.6 6261.4 6337.6 6337.9 6343.4 6344.8 6283.3 6286.3 6291.7 6316.3 6325.7 5189.9 6201.2 6225.5 6330.9 6344.5 4999.9 5003.4 5008.9 5010.5 5014.7 4479.2 4517.8 4529.9 4530.3 4545.1 5693.5 5734.1 5840.4 5871.6 5889.6 6274.8 6288.4 6309.0 6321.2 6343.7 5811.1 5843.4 5875.3 5896.2 5905.8 5377.9 5388.4 5397.7 5453.0 5506.6 6355.7 6399.4 6404.6 6413.5 6431.7 6293.8 6306.4 6312.0 6331.7 6415.6 5203.8 6283.7 6412.9 6435.8 6465.7 6274.1 6304.1 6340.4 6343.9 6355.7 6256.3 6310.7 6332.8 6341.7 6345.6 5679.9 6115.6 6233.8 6268.9 6288.2 6200.5 6207.5 6228.0 6237.6 6260.6 4915.0 5948.8 6042.1 6114.1 6116.9 6106.7 6203.8 6224.4 6240.1 6291.0 6144.1 6147.8 6156.8 6185.6 6190.2 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:66022.37 Median:41611.37 stddev:134667.58 (323.6%) stddev-sans-first:134955.50 14:15:34 INFO - PROCESS | 1665 | Values: 501.0 521.7 572.8 627.4 661.9 32911.7 39355.8 39653.8 39741.0 39836.8 41239.6 41273.0 41456.4 41550.0 41672.7 8717.8 9215.7 9459.0 9695.9 9700.4 9613.4 9645.8 9692.3 9775.2 9795.7 9665.1 9749.1 9751.1 9757.0 9790.3 9648.2 9704.8 9706.9 9727.0 9746.1 9556.1 9590.5 9627.4 9738.0 9747.9 39878.8 40602.4 40662.6 40749.4 40895.8 3442.2 3581.8 3612.7 4011.8 4029.8 29073.1 29835.0 29854.9 30001.1 31262.4 2431.6 2687.1 2778.7 2826.7 2907.9 484853.0 488428.6 488704.0 488941.0 489172.0 49351.8 65767.3 71881.9 75137.2 75836.0 48768.3 48810.8 48844.8 49320.5 49445.3 17166.6 17168.1 17384.4 17414.6 17421.4 13367.5 13556.4 13601.4 13761.9 13762.2 12599.0 15503.6 15530.3 15868.2 16045.4 5676.8 6670.7 6755.5 6756.2 6763.9 882.6 1003.9 1044.7 1052.8 1144.6 30973.7 30977.0 31126.4 31331.7 31800.0 1062.5 1162.3 1166.6 1171.7 1284.6 15443.9 15608.7 15818.8 15822.6 16041.9 522663.0 525777.0 530941.0 531837.0 535674.3 65249.0 65743.0 65837.7 66194.0 66237.3 1551.1 1558.0 1581.7 1592.6 1592.6 30070.5 30755.8 30818.5 31277.8 31320.4 56911.7 57377.4 57456.0 57587.0 57709.7 496095.0 502379.0 503902.0 504699.0 505664.5 35001.1 35927.5 36031.8 36522.0 36555.3 48471.8 48689.8 48722.8 49137.0 49257.5 39694.6 40286.8 42695.8 44048.0 44163.9 40275.5 41796.4 42009.8 42168.8 42689.0 42700.8 43459.1 43912.8 44235.0 45016.8 32189.7 38968.2 39536.0 39964.6 40701.6 22361.3 27202.6 27220.6 27403.0 27479.7 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:37382.09 Median:22023.22 stddev:113008.61 (513.1%) stddev-sans-first:113291.47 14:15:34 INFO - PROCESS | 1665 | Values: 377.2 381.8 383.1 389.8 390.3 19464.9 21374.8 21939.6 22057.7 22272.8 21765.5 21804.0 21813.0 21988.8 22222.6 5408.8 5696.6 5858.9 6069.6 6108.4 5871.2 5871.6 5909.4 6013.1 6014.2 4958.2 5044.6 5171.2 5866.4 5919.6 5847.7 5941.5 5960.1 5983.4 6011.9 5071.8 5161.8 5194.8 5216.6 5239.7 26248.6 26276.7 26361.7 26430.2 26643.7 2191.1 2246.2 2333.3 2358.4 2507.7 12300.9 15624.0 15673.1 15808.4 15927.8 1786.5 1839.3 1856.7 2003.3 2035.8 113555.9 116519.0 118189.0 119423.4 120126.6 11872.2 11950.9 11995.8 12045.4 12125.3 14555.9 14592.8 14699.8 14702.9 14772.6 9132.6 9139.5 9246.8 9255.2 9265.6 8566.8 8608.6 9490.9 9595.6 9603.9 3807.1 4582.6 4631.8 4659.7 4718.3 1947.5 1964.6 1984.6 1986.4 2012.1 942.5 983.6 1009.4 1056.5 1082.3 19721.0 19970.9 20332.6 20348.5 20351.6 854.9 863.4 956.6 1020.5 1116.2 10516.1 10723.0 10738.5 10768.0 10788.1 659634.0 682243.0 685580.0 691681.6 692078.0 114449.0 116192.0 123218.4 130878.7 137259.0 932.2 1075.7 1081.1 1090.5 1094.8 13209.8 18010.4 18052.6 18373.0 18773.6 40476.6 50785.7 51077.7 51144.0 52017.7 60446.8 74917.6 80126.6 80702.2 83518.0 6884.3 8122.0 8177.5 8208.4 8281.5 9620.4 13325.5 13342.7 13502.9 13656.2 11360.2 11547.6 11600.8 11896.6 12075.8 11394.7 11535.9 11659.5 11888.9 11922.3 11453.9 11702.4 12041.8 12115.3 12147.8 8023.0 8086.2 8362.6 8438.7 8512.4 11062.2 12124.6 12128.8 12198.6 12291.4 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:6291.09 Median:2860.97 stddev:3337.70 (116.7%) stddev-sans-first:3327.73 14:15:34 INFO - PROCESS | 1665 | Values: 1511.6 1620.7 1867.7 1908.3 2001.7 8260.8 8957.6 9167.7 9377.9 9405.3 8988.8 9022.4 9047.6 9112.0 9211.1 2588.3 2588.4 2595.7 2613.8 2614.4 2547.9 2592.5 2608.6 2609.5 2616.1 2576.1 2601.3 2634.2 2636.4 2637.6 2597.1 2615.3 2620.7 2627.6 2627.8 2572.1 2611.7 2612.4 2613.4 2626.1 9083.3 9153.4 9220.5 9221.6 9222.4 5821.2 5865.0 5884.5 5977.2 5993.2 3657.0 3771.9 3811.7 3819.1 3820.1 1052.6 1063.8 1069.5 1105.2 1106.4 12421.5 12452.4 12469.1 12493.0 12499.8 4225.6 4993.2 5090.4 5132.5 5137.0 10554.8 10586.1 10587.8 10619.6 10701.4 5604.1 5752.7 5767.9 5779.7 5782.2 4603.8 5023.9 5158.6 5161.9 5182.8 3468.3 4101.4 4157.5 4164.2 4168.1 1063.2 1380.2 1381.8 1385.9 1392.9 1119.7 1363.9 1387.0 1391.7 1421.6 8439.7 8530.9 8554.4 8566.1 8567.4 539.1 551.1 552.0 554.0 555.8 5423.5 6363.9 6366.1 6509.8 6522.1 11021.7 11049.2 11311.7 11319.4 11385.3 9347.5 11110.2 11199.7 11259.4 11298.7 8536.9 8608.7 8646.0 8713.6 8748.4 8062.2 8159.4 8199.4 8222.8 8232.6 9807.2 9825.0 9918.9 10125.8 10158.5 10136.9 10330.1 10409.7 10426.6 10451.2 7037.2 7423.4 7689.3 7791.1 7862.5 8499.9 8504.2 8565.4 8578.0 8590.7 7417.8 7593.4 7611.8 7620.4 7705.1 7371.1 7391.8 7416.1 7436.2 7573.9 7926.4 8057.1 8085.3 8112.8 8114.8 7066.9 7303.7 7319.3 7338.6 7363.7 6241.6 7339.9 7442.0 7444.0 7447.8 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5924.57 Median:6597.64 stddev:1912.86 (29.0%) stddev-sans-first:1871.48 14:15:34 INFO - PROCESS | 1665 | Values: 325.0 338.0 339.3 343.3 344.2 6918.8 6940.8 6944.3 6950.0 6974.3 6356.7 6844.8 6851.6 6852.1 6857.8 4800.6 4970.2 5014.8 5015.5 5017.6 5018.6 5021.4 5052.1 5099.2 5110.7 5016.9 5025.3 5044.0 5052.1 5054.6 5041.1 5054.8 5068.5 5070.9 5083.5 4307.8 4320.2 4331.5 4338.6 4341.0 5329.5 6331.6 6597.6 6671.9 6703.6 5492.2 5916.2 5924.0 5926.2 5934.1 7402.9 7406.8 7419.6 7440.4 7455.7 4731.9 4734.2 4736.2 4743.9 4749.5 7362.9 7735.5 7810.5 7814.1 7837.7 4478.8 4605.3 4693.8 4758.3 4766.8 3574.1 4357.8 4628.0 4756.5 4893.8 5833.6 5839.7 5854.1 5860.4 5860.6 6419.9 6971.4 7398.3 7410.7 7429.9 1685.9 1703.2 1703.5 1703.8 1706.2 1049.1 1087.8 1087.9 1090.3 1093.0 6740.8 6788.4 6794.6 6827.4 6827.7 7591.3 7595.7 7611.0 7622.3 7636.7 4972.6 5839.9 6400.1 6597.7 6799.2 4002.2 4009.5 4040.6 4043.8 4068.4 6318.3 7234.4 7858.9 7952.9 7957.0 6937.2 7570.5 8004.6 8032.4 8035.5 7007.8 7477.6 8003.6 8010.2 8067.9 6887.5 7181.1 7464.3 7775.8 7784.1 7578.6 7612.6 7619.8 7634.6 7661.5 8003.8 8021.6 8047.4 8049.6 8049.9 4826.3 4853.4 4856.8 4856.9 4882.5 7371.7 7600.6 7701.4 7714.2 7737.8 5841.2 5871.5 6281.7 6591.0 7315.9 5928.7 7338.3 7394.4 7429.9 7430.2 6527.5 7236.3 7257.5 7271.3 7276.1 5911.9 7109.5 7372.4 7390.0 7428.6 7223.4 7224.1 7235.0 7251.5 7268.4 14:15:34 INFO - PROCESS | 1665 | 14:15:34 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18284.53 Median:52784.37 stddev:25999.18 (49.3%) stddev-sans-first:26038.64 14:15:34 INFO - PROCESS | 1665 | Values: 714.3 770.0 774.6 784.4 797.7 15225.7 15263.4 15270.8 15615.0 15638.7 14122.6 14389.9 14443.7 14444.6 14454.7 804.6 971.7 971.7 978.4 1005.2 988.5 989.1 996.5 1006.2 1006.8 1039.6 1045.2 1047.1 1050.3 1061.7 1010.9 1034.4 1046.5 1049.8 1050.1 691.6 751.1 758.0 779.3 793.7 15400.0 15452.7 15534.7 15557.5 15789.2 13459.5 13512.7 13530.5 13636.7 13696.9 10303.2 10362.1 10385.4 10397.3 10559.5 3568.1 3585.9 3588.8 3639.9 3655.7 85276.0 86864.1 87318.1 87388.0 87415.1 9885.5 9945.5 9953.0 10036.0 10256.7 23778.8 23818.4 23821.6 23854.3 23855.3 7699.0 7713.3 7766.0 7767.4 7921.0 4176.7 4207.8 4232.2 4252.8 4258.9 3827.0 3863.2 3870.8 3876.8 3897.2 670.8 671.4 689.4 690.5 696.8 545.1 602.4 604.4 607.3 615.9 8281.5 8527.4 8580.0 8639.7 8711.3 587.5 598.3 607.2 610.2 619.1 3524.8 3643.9 3849.5 3935.8 3953.9 92540.1 94766.0 95286.6 96403.0 96670.5 36495.6 37619.2 71240.0 74923.9 83506.0 71403.0 72303.6 72884.0 72993.6 74004.6 7909.4 8016.7 8031.8 8140.6 8154.0 51416.0 51665.7 52259.7 53309.0 53341.0 64834.0 69238.7 70801.3 72434.3 72614.0 9111.5 10399.4 10508.4 10733.6 10927.4 10587.8 10646.3 10694.0 10869.6 11604.8 9531.5 9905.7 9912.6 10373.3 10589.6 10281.6 10471.5 10543.8 10778.7 10898.3 10025.0 10399.1 10493.8 10567.6 11278.2 8489.4 8504.3 8609.1 8643.3 9070.7 8733.2 8884.2 8908.4 8914.6 9003.6 14:15:34 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:15:34 INFO - PROCESS | 1665 | 14:15:35 INFO - TEST-INFO | 1665: exit 0 14:15:35 INFO - TEST-OK | dromaeo_css | took 1110838ms 14:15:35 INFO - TEST-START | kraken 14:15:35 INFO - operating with platform_type : mac_ 14:15:35 INFO - Initialising browser for kraken test... 14:15:35 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpVhKf1L/profile http://localhost:49275/getInfo.html) 14:15:37 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 14:15:37 INFO - PROCESS | 1672 | colorDepth:24 14:15:37 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 14:15:37 INFO - PROCESS | 1672 | __metrics 14:15:37 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:15:38 INFO - TEST-INFO | 1672: exit 0 14:15:38 INFO - Browser initialized. 14:15:38 INFO - Running cycle 1/1 for kraken test... 14:15:38 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpVhKf1L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:50 INFO - PROCESS | 1675 | RSS: Main: 217952256 14:15:50 INFO - PROCESS | 1675 | 14:15:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 14:15:53 INFO - PROCESS | 1675 | RSS: Main: 229900288 14:15:53 INFO - PROCESS | 1675 | 14:15:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 14:15:57 INFO - PROCESS | 1675 | RSS: Main: 238895104 14:15:57 INFO - PROCESS | 1675 | 14:16:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 14:16:01 INFO - PROCESS | 1675 | RSS: Main: 242638848 14:16:01 INFO - PROCESS | 1675 | 14:16:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 14:16:03 INFO - PROCESS | 1675 | RSS: Main: 242982912 14:16:03 INFO - PROCESS | 1675 | 14:16:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:16:06 INFO - PROCESS | 1675 | RSS: Main: 244523008 14:16:06 INFO - PROCESS | 1675 | 14:16:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 14:16:09 INFO - PROCESS | 1675 | RSS: Main: 244936704 14:16:09 INFO - PROCESS | 1675 | 14:16:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 14:16:13 INFO - PROCESS | 1675 | RSS: Main: 244473856 14:16:13 INFO - PROCESS | 1675 | 14:16:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 14:16:16 INFO - PROCESS | 1675 | RSS: Main: 245002240 14:16:16 INFO - PROCESS | 1675 | 14:16:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:16:19 INFO - PROCESS | 1675 | RSS: Main: 244711424 14:16:19 INFO - PROCESS | 1675 | 14:16:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:16:21 INFO - PROCESS | 1675 | RSS: Main: 244527104 14:16:21 INFO - PROCESS | 1675 | 14:16:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:16:24 INFO - PROCESS | 1675 | RSS: Main: 244539392 14:16:24 INFO - PROCESS | 1675 | 14:16:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:16:27 INFO - PROCESS | 1675 | RSS: Main: 244654080 14:16:27 INFO - PROCESS | 1675 | 14:16:30 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:16:30 INFO - PROCESS | 1675 | RSS: Main: 244670464 14:16:30 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 14:16:32 INFO - PROCESS | 1675 | RSS: Main: 246640640 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | __start_tp_report 14:16:32 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 14:16:32 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 14:16:32 INFO - PROCESS | 1675 | |i|pagename|runs| 14:16:32 INFO - PROCESS | 1675 | |0;ai-astar;131;161;154;114;119;130;113;114;169;167 14:16:32 INFO - PROCESS | 1675 | |1;audio-beat-detection;162;145;142;174;155;168;151;157;143;122 14:16:32 INFO - PROCESS | 1675 | |2;audio-dft;269;249;194;197;198;191;196;198;198;194 14:16:32 INFO - PROCESS | 1675 | |3;audio-fft;69;74;69;108;66;86;48;50;135;50 14:16:32 INFO - PROCESS | 1675 | |4;audio-oscillator;82;80;121;80;79;83;117;78;77;113 14:16:32 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;88;77;78;94;134;95;113;108;86 14:16:32 INFO - PROCESS | 1675 | |6;imaging-darkroom;114;94;98;133;99;94;95;104;95;95 14:16:32 INFO - PROCESS | 1675 | |7;imaging-desaturate;145;151;150;96;124;148;95;152;80;98 14:16:32 INFO - PROCESS | 1675 | |8;json-parse-financial;54;51;52;83;52;54;66;102;92;84 14:16:32 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;64;66;71;74;100;109;85;64;76;98 14:16:32 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;94;103;107;108;109;95;112;80;94;114 14:16:32 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;132;131;109;128;132;134;135;121;133;122 14:16:32 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;132;133;136;132;140;124;133;135;130;138 14:16:32 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;68;65;67;69;66;80;85;108;79;79 14:16:32 INFO - PROCESS | 1675 | __end_tp_report 14:16:32 INFO - PROCESS | 1675 | __start_cc_report 14:16:32 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,926 14:16:32 INFO - PROCESS | 1675 | __end_cc_report 14:16:32 INFO - PROCESS | 1675 | __startTimestamp1461186992852__endTimestamp 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | ------- Summary: start ------- 14:16:32 INFO - PROCESS | 1675 | Number of tests: 14 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:137.20 Median:142.50 stddev:23.17 (16.3%) stddev-sans-first:24.47 14:16:32 INFO - PROCESS | 1675 | Values: 131.0 161.0 154.0 114.0 119.0 130.0 113.0 114.0 169.0 167.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:14.93 (9.6%) stddev-sans-first:15.38 14:16:32 INFO - PROCESS | 1675 | Values: 162.0 145.0 142.0 174.0 155.0 168.0 151.0 157.0 143.0 122.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:208.40 Median:198.00 stddev:27.18 (13.7%) stddev-sans-first:17.91 14:16:32 INFO - PROCESS | 1675 | Values: 269.0 249.0 194.0 197.0 198.0 191.0 196.0 198.0 198.0 194.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:75.50 Median:67.50 stddev:27.77 (41.1%) stddev-sans-first:29.35 14:16:32 INFO - PROCESS | 1675 | Values: 69.0 74.0 69.0 108.0 66.0 86.0 48.0 50.0 135.0 50.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:79.50 stddev:18.12 (22.8%) stddev-sans-first:18.93 14:16:32 INFO - PROCESS | 1675 | Values: 82.0 80.0 121.0 80.0 79.0 83.0 117.0 78.0 77.0 113.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:87.00 stddev:17.53 (20.2%) stddev-sans-first:18.45 14:16:32 INFO - PROCESS | 1675 | Values: 90.0 88.0 77.0 78.0 94.0 134.0 95.0 113.0 108.0 86.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:95.00 stddev:12.51 (13.2%) stddev-sans-first:12.51 14:16:32 INFO - PROCESS | 1675 | Values: 114.0 94.0 98.0 133.0 99.0 94.0 95.0 104.0 95.0 95.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:123.90 Median:116.00 stddev:28.76 (24.8%) stddev-sans-first:29.47 14:16:32 INFO - PROCESS | 1675 | Values: 145.0 151.0 150.0 96.0 124.0 148.0 95.0 152.0 80.0 98.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:60.00 stddev:19.44 (32.4%) stddev-sans-first:19.84 14:16:32 INFO - PROCESS | 1675 | Values: 54.0 51.0 52.0 83.0 52.0 54.0 66.0 102.0 92.0 84.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:80.70 Median:72.50 stddev:16.42 (22.6%) stddev-sans-first:16.26 14:16:32 INFO - PROCESS | 1675 | Values: 64.0 66.0 71.0 74.0 100.0 109.0 85.0 64.0 76.0 98.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:101.60 Median:97.00 stddev:10.62 (10.9%) stddev-sans-first:10.90 14:16:32 INFO - PROCESS | 1675 | Values: 94.0 103.0 107.0 108.0 109.0 95.0 112.0 80.0 94.0 114.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:132.00 stddev:8.14 (6.2%) stddev-sans-first:8.48 14:16:32 INFO - PROCESS | 1675 | Values: 132.0 131.0 109.0 128.0 132.0 134.0 135.0 121.0 133.0 122.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.30 Median:134.00 stddev:4.45 (3.3%) stddev-sans-first:4.69 14:16:32 INFO - PROCESS | 1675 | Values: 132.0 133.0 136.0 132.0 140.0 124.0 133.0 135.0 130.0 138.0 14:16:32 INFO - PROCESS | 1675 | 14:16:32 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:74.00 stddev:13.13 (17.7%) stddev-sans-first:13.55 14:16:32 INFO - PROCESS | 1675 | Values: 68.0 65.0 67.0 69.0 66.0 80.0 85.0 108.0 79.0 79.0 14:16:32 INFO - PROCESS | 1675 | -------- Summary: end -------- 14:16:32 INFO - PROCESS | 1675 | 14:16:33 INFO - TEST-INFO | 1675: exit 0 14:16:33 INFO - TEST-OK | kraken | took 58726ms 14:16:33 INFO - SUITE-END | took 1169s 14:16:34 INFO - Completed test suite (00:19:29) 14:16:34 INFO - javascript benchmark 14:16:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3544.9645503544966, 3578.320119177358, 3621.9496346059645, 3628.546431696038, 3629.909252268693, 5846.649201047941, 5855.414458554137, 5859.15042318864, 5874.383189765066, 5883.8529036774, 5833.795817146401, 5860.443257890493, 5872.559558033143, 5880.176775251458, 5891.587588868781, 5188.169892817141, 5231.555317797992, 5289.603279754034, 5302.973485132588, 5354.170103633943, 5165.276861239429, 5304.920426193591, 5319.574434045287, 5323.44103869092, 5342.2253773202865, 5227.08526007949, 5265.65773224741, 5320.281761962144, 5342.27879236302, 5383.084875571143, 5297.761600727958, 5300.284461597674, 5317.175837745156, 5327.946720532784, 5348.545373643245, 4273.380359847804, 5160.509751573594, 5261.657992230493, 5268.894622107537, 5325.0, 4678.7660616969015, 5594.440555944414, 5697.1739097831, 5716.399778023289, 5816.069428891357, 5183.663061900965, 6242.063690446424, 6305.905411418832, 6328.082428047907, 6334.334894836068, 6221.035739460391, 6305.558610897239, 6308.337624549448, 6311.4950803936035, 6319.6524191169465, 5886.117082437669, 5992.400759923973, 5994.760209591611, 5998.8302281054775, 6042.15409842618, 5452.40023597404, 6273.153124328249, 6395.328490508429, 6414.230292364946, 6422.357764223634, 6145.924463218918, 6165.5375846810775, 6273.101279991204, 6279.277883043508, 6293.622382657055, 6261.373862613702, 6337.588056776295, 6337.936620633827, 6343.429091381798, 6344.809655710336, 6283.277423096311, 6286.339934306923, 6291.716872740738, 6316.336784637639, 6325.683715814191, 5189.922151167735, 6201.193844800147, 6225.501959843202, 6330.936690633127, 6344.460720838781, 4999.850004499871, 5003.374578177728, 5008.949910500921, 5010.5240002199735, 5014.724190169576, 4479.216137175981, 4517.796699148546, 4529.932051019237, 4530.320451932171, 4545.136424079415, 5693.459121383462, 5734.05388110957, 5840.386759390288, 5871.64770113786, 5889.617174883619, 6274.811755647338, 6288.402601752826, 6309.0, 6321.1782468278825, 6343.682815859189, 5811.070228763378, 5843.444872737083, 5875.294964604275, 5896.166444800119, 5905.822825315247, 5377.865553361197, 5388.434214407509, 5397.70312632809, 5453.0, 5506.64206826555, 6355.745770169234, 6399.3600639937495, 6404.551681382259, 6413.518986076063, 6431.710573024318, 6293.779717709858, 6306.432421082125, 6312.021636646327, 6331.651759153291, 6415.615063096229, 5203.8178663746585, 6283.685815709287, 6412.871742565216, 6435.839104022437, 6465.676716164267, 6274.090256912813, 6304.117423560613, 6340.397662222082, 6343.90484142729, 6355.682215889095, 6256.280527739368, 6310.652914089769, 6332.778352757631, 6341.746330146742, 6345.555811093179, 5679.9148012779015, 6115.605440958429, 6233.781817636361, 6268.874622507433, 6288.151099601495, 6200.503959683124, 6207.534434917309, 6228.0, 6237.625742455467, 6260.624362538262, 4915.0, 5948.791792287422, 6042.093685947143, 6114.052321890114, 6116.938830611815, 6106.73370229429, 6203.8138855834395, 6224.408681175281, 6240.095186197885, 6291.0, 6144.139820425234, 6147.754089836535, 6156.78451254204, 6185.567010309235, 6190.164327815687], "unit": "score", "name": "dojo.html", "value": 5767.360724481285}, {"lowerIsBetter": false, "replicates": [501.04800878331145, 521.7182721330481, 572.753715902162, 627.3945642455031, 661.9238787539433, 32911.67088329116, 39355.80322098386, 39653.80173099138, 39741.0, 39836.80081599588, 41239.587604123946, 41273.0, 41456.378154327635, 41550.0, 41672.74981750545, 8717.825643487127, 9215.723528294162, 9459.0, 9695.854562181574, 9700.417974921527, 9613.423194608311, 9645.807083858319, 9692.27307951903, 9775.169110625606, 9795.657151999681, 9665.130138287554, 9749.122578967892, 9751.12239898409, 9757.0, 9790.314677972545, 9648.228141748643, 9704.75738106546, 9706.902930970671, 9727.027297270288, 9746.074122958307, 9556.139947404698, 9590.520473976274, 9627.374220675703, 9737.951310243474, 9747.902520974842, 39878.80060599678, 40602.390964135564, 40662.59337406618, 40749.388759168636, 40895.795521022505, 3442.208292092833, 3581.8388172532036, 3612.747107702462, 4011.8194681239415, 4029.798510074514, 29073.127806165638, 29835.0, 29854.850725746233, 30001.099967001024, 31262.374752504824, 2431.5623187826186, 2687.0595291647965, 2778.749912507884, 2826.7314605112483, 2907.941841163186, 484853.0, 488428.55785721197, 488704.0, 488940.99999999645, 489172.0, 49351.753241233564, 65767.34232657708, 71881.92177117347, 75137.24862751411, 75836.0, 48768.26847597289, 48810.75594622075, 48844.75577622089, 49320.506794932306, 49445.25832112521, 17166.57083572896, 17168.141592920303, 17384.391546296072, 17414.564635884206, 17421.39025134114, 13367.532136375181, 13556.389962451713, 13601.387937542835, 13761.931190343985, 13762.24307663088, 12599.0, 15503.612409689847, 15530.301136448887, 15868.20658967047, 16045.438409655839, 5676.801311954062, 6670.733170673216, 6755.49333799967, 6756.155480564929, 6763.898541521881, 882.5675419044622, 1003.8694969654044, 1044.6500422358442, 1052.8210204265292, 1144.6451600003859, 30973.69026309753, 30977.0, 31126.377472450426, 31331.686683133332, 31800.0, 1062.5377960587168, 1162.3026184289358, 1166.6383421139474, 1171.7363593191635, 1284.6081945006677, 15443.91892567532, 15608.687826243638, 15818.76271855923, 15822.60443488899, 16041.87706860532, 522663.0, 525777.0, 530941.0, 531837.0, 535674.3216283894, 65249.0, 65743.0, 65837.67081164563, 66194.0, 66237.33762662408, 1551.0771091200718, 1557.9532614021598, 1581.7073841339388, 1592.633694250329, 1592.6416556274978, 30070.548941765453, 30755.769769208982, 30818.485106891698, 31277.8436107818, 31320.373592527565, 56911.71544142418, 57377.42622573721, 57456.0, 57587.0, 57709.711451442476, 496095.0, 502379.0, 503902.0, 504699.0, 505664.47167763923, 35001.124971875906, 35927.46108808422, 36031.81984090063, 36522.0, 36555.268894621426, 48471.75764121157, 48689.75655121702, 48722.75638621784, 49137.0, 49257.507424925294, 39694.60305397025, 40286.79856600698, 42695.786521067195, 44048.0, 44163.89590260269, 40275.54902343076, 41796.373054404816, 42009.78995105005, 42168.78915605525, 42689.0, 42700.78649606732, 43459.13081738411, 43912.780436097615, 44235.0, 45016.77491612521, 32189.678103218666, 38968.2206355877, 39536.0, 39964.60035399609, 40701.59298406978, 22361.329160125224, 27202.639868006125, 27220.591691125046, 27403.0, 27479.725202747715], "unit": "score", "name": "ext.html", "value": 20400.754116609623}, {"lowerIsBetter": false, "replicates": [377.2040993503708, 381.7919234017461, 383.0691419849765, 389.8401655321319, 390.3091527995448, 19464.912368402634, 21374.824384658838, 21939.561208775816, 22057.66913496297, 22272.777272227293, 21765.455863603416, 21804.0, 21813.0, 21988.780112198914, 22222.555548889053, 5408.783648654059, 5696.601237913327, 5858.941410585882, 6069.575129740898, 6108.389161083901, 5871.178035075071, 5871.588988770788, 5909.4090590941, 6013.067974463965, 6014.248218972629, 4958.157113290749, 5044.646874718771, 5171.172612382001, 5866.384029676887, 5919.644821310713, 5847.678377689225, 5941.465268125868, 5960.1357803118735, 5983.431574000485, 6011.939880601203, 5071.847844564632, 5161.767720452589, 5194.7662355193725, 5216.634835561512, 5239.73801309933, 26248.60627090595, 26276.73723262762, 26361.73638263612, 26430.207093787023, 26643.733562664514, 2191.0906973605934, 2246.213825161197, 2333.288347054148, 2358.386819426961, 2507.736687647789, 12300.876991230063, 15624.0, 15673.137977411237, 15808.367665293374, 15927.840721592751, 1786.481920243128, 1839.3470318037039, 1856.7122096074995, 2003.3188715836686, 2035.7760646328893, 113555.86444135536, 116519.0, 118189.0, 119423.40288298503, 120126.59746805015, 11872.228305160137, 11950.88049119515, 11995.76008479843, 12045.397730113635, 12125.27248365101, 14555.92722036383, 14592.781108283385, 14699.779503307458, 14702.926485367505, 14772.55682329532, 9132.634694612274, 9139.451632902048, 9246.76883077915, 9255.213306868856, 9265.629374824932, 8566.800647909298, 8608.612612432456, 9490.861096668445, 9595.568199431042, 9603.90396096044, 3807.0672685192303, 4582.564656357641, 4631.814727410933, 4659.697119687277, 4718.268668356411, 1947.464447276982, 1964.6168997045725, 1984.563396052866, 1986.3842208915282, 2012.104613447002, 942.4863449420083, 983.5623147699205, 1009.4094954451581, 1056.4612047855649, 1082.3343643659093, 19721.0, 19970.90014549918, 20332.593348132956, 20348.49128771763, 20351.59296814085, 854.8974123105268, 863.404251066762, 956.5791051937125, 1020.4846552491093, 1116.1684545014016, 10516.13707165109, 10723.0, 10738.463076846127, 10768.0, 10788.136949044057, 659634.0, 682243.0, 685580.0, 691681.6247756288, 692078.0, 114449.0, 116192.0, 123218.38390807988, 130878.69121308856, 137259.0, 932.2122806228726, 1075.714935542082, 1081.0756802933536, 1090.5256213547132, 1094.813881640139, 13209.801852972405, 18010.36963706264, 18052.638947221243, 18373.0, 18773.624527509648, 40476.59523404728, 50785.74607126941, 51077.74461127819, 51144.0, 52017.7399113002, 60446.79106417759, 74917.62541187259, 80126.5993670028, 80702.19297807182, 83518.0, 6884.345987131214, 8121.959390203011, 8177.4684645497855, 8208.425410221227, 8281.54451505173, 9620.37467564606, 13325.466981320638, 13342.666433339244, 13502.932485337511, 13656.248906310248, 11360.204785664924, 11547.595834145764, 11600.767984640092, 11896.643100706993, 12075.818862717242, 11394.715132121431, 11535.884641153481, 11659.533618655498, 11888.940555297168, 11922.284662920252, 11453.942730286628, 11702.414879255834, 12041.819372709591, 12115.273083615011, 12147.75704485923, 8022.9598852005365, 8086.1509541499645, 8362.60194194121, 8438.746837594881, 8512.446690965067, 11062.225644205151, 12124.636260912186, 12128.818067728815, 12198.634040978784, 12291.446884890023], "unit": "score", "name": "jquery.html", "value": 9840.76462958777}, {"lowerIsBetter": false, "replicates": [1511.5616471223343, 1620.6839666265075, 1867.747854039705, 1908.30346923373, 2001.6797312430015, 8260.752177434671, 8957.641694332218, 9167.679131230409, 9377.859332110023, 9405.294602904783, 8988.820223595525, 9022.368434209608, 9047.592858321375, 9111.997680255166, 9211.12494313041, 2588.3011586871535, 2588.404666926608, 2595.7014943281483, 2613.751693589106, 2614.3856193794445, 2547.9108231211912, 2592.546304396723, 2608.6087086936923, 2609.5302845487804, 2616.123598594473, 2576.085489651175, 2601.2586412872333, 2634.1834031450217, 2636.433166869123, 2637.643918071055, 2597.129961462912, 2615.3069436599317, 2620.65931428913, 2627.632131501591, 2627.8160528762996, 2572.0611976628397, 2611.673540807399, 2612.373030472692, 2613.3597268669296, 2626.120249716347, 9083.273338132933, 9153.359264851462, 9220.492872891988, 9221.631134754602, 9222.35443518954, 5821.18503409523, 5864.970675146639, 5884.499817515516, 5977.2229610150835, 5993.160957465958, 3657.0, 3771.886843394675, 3811.6760075393627, 3819.083419979185, 3820.102275965146, 1052.5684469367523, 1063.7659714862718, 1069.4759567811793, 1105.1987309200845, 1106.4246591772314, 12421.503139874394, 12452.439640216213, 12469.127161098726, 12493.0, 12499.812502812465, 4225.598568136023, 4993.151164302078, 5090.363704536933, 5132.486751324837, 5136.9743151284, 10554.788904221872, 10586.100181484506, 10587.788244235073, 10619.575216991234, 10701.411422371844, 5604.103343465026, 5752.683602401824, 5767.942320576824, 5779.653220806765, 5782.2483077199695, 4603.769811509411, 5023.924641130386, 5158.561522270574, 5161.922571161435, 5182.844514664566, 3468.323676883034, 4101.425800387948, 4157.520852456404, 4164.167166566699, 4168.103857670615, 1063.2238465919922, 1380.171896861895, 1381.8461584576992, 1385.9445622175, 1392.8955328350414, 1119.652907598647, 1363.9045266831226, 1386.9930650346685, 1391.679913619873, 1421.5593166118535, 8439.662413503514, 8530.87203691945, 8554.443961142506, 8566.057733649293, 8567.4002819802, 539.0889396919194, 551.1402212548358, 551.9586031047687, 554.0442736279884, 555.8249151517259, 5423.4847689470225, 6363.936360636334, 6366.108744775735, 6509.804705858832, 6522.119513865662, 11021.724456888642, 11049.226554141294, 11311.660650180507, 11319.37743424103, 11385.259958102697, 9347.485888276075, 11110.222284440173, 11199.66401007971, 11259.380734059541, 11298.661040168809, 8536.8719469208, 8608.65565377378, 8646.0, 8713.607887645072, 8748.387612867038, 8062.234087761653, 8159.388045896463, 8199.42604017713, 8222.753317400488, 8232.62953167097, 9807.21542276602, 9824.950875245579, 9918.851217231891, 10125.79748405013, 10158.492075396052, 10136.89863101389, 10330.121939634915, 10409.68770936873, 10426.635067772591, 10451.163906887583, 7037.155541334868, 7423.406127509894, 7689.3464055555905, 7791.142974272939, 7862.488938218998, 8499.915000849913, 8504.192101750325, 8565.400421970402, 8578.0, 8590.742277731679, 7417.777466676009, 7593.354564862048, 7611.809704757204, 7620.390368770596, 7705.075390953121, 7371.115466144097, 7391.778246652609, 7416.110066792019, 7436.182019977907, 7573.9242607575425, 7926.365890728844, 8057.113717490954, 8085.312748416451, 8112.75661730149, 8114.756557303291, 7066.929330706833, 7303.707851686086, 7319.304666056716, 7338.596377199306, 7363.742269020773, 6241.594296370903, 7339.889901651586, 7442.0, 7444.032275804111, 7447.776566703008], "unit": "score", "name": "mootools.html", "value": 5049.3518481352685}, {"lowerIsBetter": false, "replicates": [324.96262929763077, 337.9712724418424, 339.2858033838768, 343.3407856914723, 344.15681580128677, 6918.827029324257, 6940.791776246714, 6944.3055694430595, 6950.026996220533, 6974.267701891305, 6356.745730170787, 6844.79465616031, 6851.623160726158, 6852.074969879065, 6857.759978400757, 4800.639952003597, 4970.179920313144, 5014.774335154927, 5015.5486006259425, 5017.573506251963, 5018.619879533121, 5021.447640759514, 5052.0906236877345, 5099.209622508517, 5110.693358398508, 5016.874578135539, 5025.271335656327, 5043.974780126095, 5052.14113600687, 5054.646174767768, 5041.067402530525, 5054.848354549369, 5068.518490743392, 5070.949290507103, 5083.542481176712, 4307.806148723315, 4320.24395730749, 4331.545187755271, 4338.6095251427205, 4340.978295108504, 5329.520343169133, 6331.620102793847, 6597.60414375139, 6671.866562668768, 6703.597784132919, 5492.231087647732, 5916.201312822757, 5924.0, 5926.170336152899, 5934.080217566284, 7402.851942961164, 7406.777796666109, 7419.554826710415, 7440.404767618577, 7455.701771929116, 4731.881702957419, 4734.2425211966265, 4736.242201247818, 4743.928841067387, 4749.4775574686755, 7362.926370736332, 7735.497192682514, 7810.492317999312, 7814.0623125224765, 7837.686492540349, 4478.776061196927, 4605.286180641939, 4693.788779504862, 4758.310045043519, 4766.785494652749, 3574.1064733816547, 4357.847475338412, 4627.95372046282, 4756.548127927841, 4893.804247830047, 5833.620814647034, 5839.678817665069, 5854.121881717691, 5860.355360910296, 5860.619059761102, 6419.903701444388, 6971.442284617218, 7398.3341499265325, 7410.740174170404, 7429.925700742923, 1685.9409920652718, 1703.1654489300154, 1703.5315288295817, 1703.8040625328, 1706.1895599590096, 1049.1344640671325, 1087.8259478483562, 1087.896649818266, 1090.2749671468384, 1092.9672109836717, 6740.83147921296, 6788.389044985876, 6794.558353706993, 6827.351401616838, 6827.69275382609, 7591.316781489692, 7595.658195381221, 7610.961945190239, 7622.313991740659, 7636.732714354971, 4972.55247027762, 5839.919614871177, 6400.135981642512, 6597.670116494156, 6799.184097908283, 4002.2195671844293, 4009.4587230724064, 4040.595940405936, 4043.757374557536, 4068.3694027425795, 6318.273398559132, 7234.385077268491, 7858.921410785933, 7952.880706789403, 7957.0, 6937.236903940562, 7570.545767253872, 8004.599770011476, 8032.357411407073, 8035.517868927766, 7007.808672525683, 7477.588732619649, 8003.599820009093, 8010.158933311918, 8067.919320806835, 6887.483438742214, 7181.138263408216, 7464.290892365217, 7775.844483110193, 7784.143744188248, 7578.583177925267, 7612.56397952672, 7619.771406857803, 7634.6182690864125, 7661.463697541119, 8003.799905002422, 8021.558814265271, 8047.436679432383, 8049.637766300648, 8049.879251811345, 4826.276058591239, 4853.4418541868135, 4856.8300109495995, 4856.882916929056, 4882.487338829514, 7371.705131794668, 7600.619969001417, 7701.383889288732, 7714.228577142241, 7737.83932410143, 5841.211436456024, 5871.500922421642, 6281.654509002049, 6590.978398348264, 7315.85418270149, 5928.703564821655, 7338.339549440576, 7394.408447324308, 7429.888551671837, 7430.182679905314, 6527.5430719849155, 7236.34872861445, 7257.528260663251, 7271.3455788979245, 7276.090488688914, 5911.881762364815, 7109.4667899908745, 7372.410207183305, 7390.039294891844, 7428.628568571442, 7223.386012189023, 7224.13310402755, 7235.0, 7251.492395532262, 7268.418526517971], "unit": "score", "name": "prototype.html", "value": 5289.082158732355}, {"lowerIsBetter": false, "replicates": [714.2964180282422, 769.9692012319504, 774.6049514747484, 784.3960150683973, 797.7287722174459, 15225.695486090299, 15263.38946442141, 15270.847291527081, 15614.985025973318, 15638.687226255468, 14122.576322710334, 14389.928050359733, 14443.711125777478, 14444.566663000127, 14454.710905781878, 804.5775967616989, 971.6987733802526, 971.7279161834663, 978.4373984958642, 1005.15566923784, 988.495867107773, 989.0999190736432, 996.5017491254373, 1006.1900170362856, 1006.7684432580475, 1039.5997540946753, 1045.1951996962334, 1047.0681093826463, 1050.322541960435, 1061.739873730937, 1010.8736407949007, 1034.4000479721744, 1046.4558429616634, 1049.821530339844, 1050.1074087026004, 691.6092407789582, 751.1174370115093, 757.9507332023456, 779.3453499060817, 793.7063286584001, 15400.0, 15452.690946181126, 15534.689306213926, 15557.533274001798, 15789.21053947298, 13459.528916487876, 13512.729745405135, 13530.458781648722, 13636.659083522893, 13696.93151534236, 10303.175745940307, 10362.067413932707, 10385.376877387305, 10397.32417392867, 10559.47202639865, 3568.107973006748, 3585.910352241189, 3588.784672919633, 3639.94540081899, 3655.707543396522, 85276.0, 86864.13135868624, 87318.12681873163, 87388.0, 87415.12584874197, 9885.456299903575, 9945.502724863727, 9953.0, 10036.0, 10256.743581410525, 23778.762212378002, 23818.40453988664, 23821.642675359883, 23854.284371468537, 23855.284341469785, 7698.961505192438, 7713.267239612228, 7765.961170194226, 7767.37860971121, 7921.049474063034, 4176.665866730655, 4207.810648520824, 4232.217039847638, 4252.829886804555, 4258.936115958263, 3826.9808650956566, 3863.2466668999277, 3870.825812838429, 3876.7673939563715, 3897.201073779925, 670.7819958513503, 671.3890359772583, 689.3520091114436, 690.4855882367668, 696.8432102776936, 545.118174892909, 602.4276936909953, 604.4197570332442, 607.3440684061292, 615.923009623797, 8281.503109813431, 8527.360447966428, 8580.0, 8639.740807775777, 8711.34664900135, 587.4800801290803, 598.2970010237952, 607.1924340627044, 610.1640752169557, 619.1393962392278, 3524.806135662563, 3643.872464463784, 3849.4610754494392, 3935.7835319057153, 3953.8616148434667, 92540.0745992545, 94766.0, 95286.57070143953, 96403.0, 96670.51664741631, 36495.63504364975, 37619.247615048094, 71240.0, 74923.87614185791, 83506.0, 71403.0, 72303.6384818083, 72884.0, 72993.6350318245, 74004.62997685085, 7909.406794490551, 8016.7194148204535, 8031.759047228593, 8140.59297035134, 8153.959230203811, 51416.0, 51665.741671291406, 52259.73870130777, 53309.0, 53341.0, 64834.0, 69238.65380673064, 70801.29198707947, 72434.27565724275, 72614.0, 9111.544422778701, 10399.440083987462, 10508.369497830156, 10733.570657173626, 10927.398993055458, 10587.788244234918, 10646.307989980627, 10694.0, 10869.565217391215, 11604.767904642029, 9531.523423828643, 9905.653302134391, 9912.603495860085, 10373.325733827278, 10589.629362972259, 10281.640142594973, 10471.476426178508, 10543.78912421732, 10778.73053173677, 10898.291611045257, 10025.0, 10399.1160751337, 10493.790124197625, 10567.63013294531, 11278.154138439486, 8489.4481858679, 8504.319654427754, 8609.053004169411, 8643.308535317285, 9070.727878163665, 8733.214010739064, 8884.244839188741, 8908.376413650982, 8914.643414263357, 9003.594838232426], "unit": "score", "name": "yui.html", "value": 7001.0103371601635}], "name": "dromaeo_css", "value": 7748.968711482996}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [131.0, 161.0, 154.0, 114.0, 119.0, 130.0, 113.0, 114.0, 169.0, 167.0], "unit": "score", "name": "ai-astar", "value": 137.2}, {"lowerIsBetter": true, "replicates": [162.0, 145.0, 142.0, 174.0, 155.0, 168.0, 151.0, 157.0, 143.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [269.0, 249.0, 194.0, 197.0, 198.0, 191.0, 196.0, 198.0, 198.0, 194.0], "unit": "score", "name": "audio-dft", "value": 208.4}, {"lowerIsBetter": true, "replicates": [69.0, 74.0, 69.0, 108.0, 66.0, 86.0, 48.0, 50.0, 135.0, 50.0], "unit": "score", "name": "audio-fft", "value": 75.5}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 121.0, 80.0, 79.0, 83.0, 117.0, 78.0, 77.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 91.0}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 77.0, 78.0, 94.0, 134.0, 95.0, 113.0, 108.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.3}, {"lowerIsBetter": true, "replicates": [114.0, 94.0, 98.0, 133.0, 99.0, 94.0, 95.0, 104.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 102.1}, {"lowerIsBetter": true, "replicates": [145.0, 151.0, 150.0, 96.0, 124.0, 148.0, 95.0, 152.0, 80.0, 98.0], "unit": "score", "name": "imaging-desaturate", "value": 123.9}, {"lowerIsBetter": true, "replicates": [54.0, 51.0, 52.0, 83.0, 52.0, 54.0, 66.0, 102.0, 92.0, 84.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 71.0, 74.0, 100.0, 109.0, 85.0, 64.0, 76.0, 98.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.7}, {"lowerIsBetter": true, "replicates": [94.0, 103.0, 107.0, 108.0, 109.0, 95.0, 112.0, 80.0, 94.0, 114.0], "unit": "score", "name": "stanford-crypto-aes", "value": 101.6}, {"lowerIsBetter": true, "replicates": [132.0, 131.0, 109.0, 128.0, 132.0, 134.0, 135.0, 121.0, 133.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [132.0, 133.0, 136.0, 132.0, 140.0, 124.0, 133.0, 135.0, 130.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.3}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 69.0, 66.0, 80.0, 85.0, 108.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.6}], "name": "kraken", "value": 1575.1999999999998}]} 14:16:34 INFO - Return code: 0 14:16:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:16:34 ERROR - # TBPL SUCCESS # 14:16:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:16:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:16:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:16:34 INFO - 2016-04-20 14:16:34.164 screenresolution[1682:10910] starting screenresolution argv=screenresolution get 14:16:34 INFO - 2016-04-20 14:16:34.166 screenresolution[1682:10910] Display 0: 1600x1200x32@60 14:16:34 INFO - 2016-04-20 14:16:34.172 screenresolution[1683:10912] starting screenresolution argv=screenresolution list 14:16:34 INFO - Available Modes on Display 0 14:16:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:16:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:16:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:16:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:16:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:16:34 INFO - Intel Iris: 14:16:34 INFO - Chipset Model: Intel Iris 14:16:34 INFO - Type: GPU 14:16:34 INFO - Bus: Built-In 14:16:34 INFO - VRAM (Dynamic, Max): 1536 MB 14:16:34 INFO - Vendor: Intel (0x8086) 14:16:34 INFO - Device ID: 0x0a2e 14:16:34 INFO - Revision ID: 0x0009 14:16:34 INFO - Displays: 14:16:34 INFO - Display: 14:16:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:16:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:16:34 INFO - Display Serial Number: 1600x1200 60 14:16:34 INFO - Main Display: Yes 14:16:34 INFO - Mirror: Off 14:16:34 INFO - Online: Yes 14:16:34 INFO - Rotation: Supported 14:16:34 INFO - Return code: 0 14:16:34 INFO - Running post-action listener: _resource_record_post_action 14:16:34 INFO - Running post-run listener: _resource_record_post_run 14:16:35 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 39095808; Write bytes: 673732096; Read time: 427; Write time: 2024 14:16:35 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354374144; Write bytes: 353154560; Read time: 28065; Write time: 648 14:16:35 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37334528; Write bytes: 309399552; Read time: 408; Write time: 1346 14:16:35 INFO - Running post-run listener: _upload_blobber_files 14:16:35 INFO - Blob upload gear active. 14:16:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:16:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:16:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:37 INFO - (blobuploader) - INFO - Done attempting. 14:16:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:16:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:16:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:16:38 INFO - (blobuploader) - INFO - Done attempting. 14:16:38 INFO - (blobuploader) - INFO - Iteration through files over. 14:16:38 INFO - Return code: 0 14:16:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:16:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:16:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b45b8c2e4c4336f9747fedec7bd561d0434c3f15dc81ff3522b0cd1ad0100b1dda4c852a9f8b3f14410411b2b22d82878c83930531cd8b3226f586f0383cd698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c571e423c58b4d3f9db8681e23fe83ee6f8da667cca957d54576ac1bec2f14088b5802a4a3ee781ba359d4937233cc22c5cdefa32931db3cb38fcb0c9e67694c"} 14:16:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:16:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:16:38 INFO - Contents: 14:16:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b45b8c2e4c4336f9747fedec7bd561d0434c3f15dc81ff3522b0cd1ad0100b1dda4c852a9f8b3f14410411b2b22d82878c83930531cd8b3226f586f0383cd698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c571e423c58b4d3f9db8681e23fe83ee6f8da667cca957d54576ac1bec2f14088b5802a4a3ee781ba359d4937233cc22c5cdefa32931db3cb38fcb0c9e67694c"} 14:16:38 INFO - Running post-run listener: copy_logs_to_upload_dir 14:16:38 INFO - Copying logs to upload dir... 14:16:38 INFO - mkdir: /builds/slave/test/build/upload/logs 14:16:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.488867 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 14:16:38.248486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:16:38.253228) ========= 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.6DBx3fClOy/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.hBeXNHjXiE/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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/b45b8c2e4c4336f9747fedec7bd561d0434c3f15dc81ff3522b0cd1ad0100b1dda4c852a9f8b3f14410411b2b22d82878c83930531cd8b3226f586f0383cd698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c571e423c58b4d3f9db8681e23fe83ee6f8da667cca957d54576ac1bec2f14088b5802a4a3ee781ba359d4937233cc22c5cdefa32931db3cb38fcb0c9e67694c"} build_url:https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/YHMxrCyoSZuRYZeoWq3kFA/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/b45b8c2e4c4336f9747fedec7bd561d0434c3f15dc81ff3522b0cd1ad0100b1dda4c852a9f8b3f14410411b2b22d82878c83930531cd8b3226f586f0383cd698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c571e423c58b4d3f9db8681e23fe83ee6f8da667cca957d54576ac1bec2f14088b5802a4a3ee781ba359d4937233cc22c5cdefa32931db3cb38fcb0c9e67694c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 14:16:38.287879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:16:38.288218) ========= 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.6DBx3fClOy/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.hBeXNHjXiE/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005135 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:16:38.336203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:16:38.336560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 14:16:38.339961) ========= ========= Total master_lag: 4.42 =========