builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0161 starttime: 1458964833.27 results: success (0) buildid: 20160325190938 builduid: 78cbae24e2dd425a8b4f1613a4983409 revision: 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:33.274227) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:33.274912) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:33.275441) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005623 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:33.304394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-25 21:00:33.305080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-25 21:00:35.693350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:35.693624) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.005655 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:35.745082) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:35.745744) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:35.746517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:35.746933) ========= 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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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-03-25 21:00:35-- 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.41M=0.001s 2016-03-25 21:00:35 (9.41 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099381 ========= master_lag: 0.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:36.248481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:36.248806) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.027916 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:36.299611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 21:00:36.299963) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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-03-25 21:00:36,328 truncating revision to first 12 chars 2016-03-25 21:00:36,328 Setting DEBUG logging. 2016-03-25 21:00:36,328 attempt 1/10 2016-03-25 21:00:36,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a4359ad909f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 21:00:37,424 unpacking tar archive at: mozilla-central-8a4359ad909f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.340882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 21:00:37.657769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:37.658150) ========= echo 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8a4359ad909fe0cffcfea512770483ffdf8cd4e6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 program finished with exit code 0 elapsedTime=0.004876 script_repo_revision: '8a4359ad909fe0cffcfea512770483ffdf8cd4e6' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:37.707935) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:37.708284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 21:00:37.722342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-25 21:00:37.722736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:00:37 INFO - MultiFileLogger online at 20160325 21:00:37 in /builds/slave/test 21:00:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:00:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:00:37 INFO - {'append_to_log': False, 21:00:37 INFO - 'base_work_dir': '/builds/slave/test', 21:00:37 INFO - 'blob_upload_branch': 'Firefox', 21:00:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:00:37 INFO - 'branch': 'Firefox', 21:00:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:00:37 INFO - 'config_files': ('talos/mac_config.py',), 21:00:37 INFO - 'default_actions': ('clobber', 21:00:37 INFO - 'read-buildbot-config', 21:00:37 INFO - 'download-and-extract', 21:00:37 INFO - 'populate-webroot', 21:00:37 INFO - 'create-virtualenv', 21:00:37 INFO - 'install', 21:00:37 INFO - 'run-tests'), 21:00:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:00:37 INFO - 'download_minidump_stackwalk': True, 21:00:37 INFO - 'download_symbols': 'ondemand', 21:00:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:00:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:00:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:00:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:00:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:00:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:00:37 INFO - 'installer_path': 'installer.exe', 21:00:37 INFO - 'log_level': 'info', 21:00:37 INFO - 'log_name': 'talos', 21:00:37 INFO - 'log_to_console': True, 21:00:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:00:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:00:37 INFO - 'opt_config_files': (), 21:00:37 INFO - 'pip_index': False, 21:00:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:00:37 INFO - 'cmd': ('bash', 21:00:37 INFO - '-c', 21:00:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:00:37 INFO - 'enabled': True, 21:00:37 INFO - 'halt_on_failure': False, 21:00:37 INFO - 'name': 'check_screen_resolution'},), 21:00:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:00:37 INFO - 'cmd': ('bash', 21:00:37 INFO - '-c', 21:00:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:00:37 INFO - 'enabled': True, 21:00:37 INFO - 'halt_on_failure': False, 21:00:37 INFO - 'name': 'check_screen_resolution'},), 21:00:37 INFO - 'run_cmd_checks_enabled': True, 21:00:37 INFO - 'sps_profile': False, 21:00:37 INFO - 'sps_profile_interval': 0, 21:00:37 INFO - 'suite': 'dromaeojs', 21:00:37 INFO - 'system_bits': '32', 21:00:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:00:37 INFO - 'title': 't-yosemite-r7-0161', 21:00:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:00:37 INFO - 'use_talos_json': True, 21:00:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:00:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:00:37 INFO - 'work_dir': 'build'} 21:00:37 INFO - ##### 21:00:37 INFO - ##### Running clobber step. 21:00:37 INFO - ##### 21:00:37 INFO - Running pre-action listener: _resource_record_pre_action 21:00:37 INFO - Running main action method: clobber 21:00:37 INFO - rmtree: /builds/slave/test/build 21:00:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:00:39 INFO - Running post-action listener: _resource_record_post_action 21:00:39 INFO - ##### 21:00:39 INFO - ##### Running read-buildbot-config step. 21:00:39 INFO - ##### 21:00:39 INFO - Running pre-action listener: _resource_record_pre_action 21:00:39 INFO - Running main action method: read_buildbot_config 21:00:39 INFO - Using buildbot properties: 21:00:39 INFO - { 21:00:39 INFO - "project": "", 21:00:39 INFO - "product": "firefox", 21:00:39 INFO - "script_repo_revision": "production", 21:00:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:00:39 INFO - "repository": "", 21:00:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:00:39 INFO - "buildid": "20160325190938", 21:00:39 INFO - "pgo_build": "False", 21:00:39 INFO - "basedir": "/builds/slave/test", 21:00:39 INFO - "buildnumber": 181, 21:00:39 INFO - "slavename": "t-yosemite-r7-0161", 21:00:39 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:00:39 INFO - "platform": "yosemite_r7", 21:00:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:00:39 INFO - "branch": "mozilla-central", 21:00:39 INFO - "repo_path": "mozilla-central", 21:00:39 INFO - "revision": "8a4359ad909fe0cffcfea512770483ffdf8cd4e6", 21:00:39 INFO - "stage_platform": "macosx64", 21:00:39 INFO - "builduid": "78cbae24e2dd425a8b4f1613a4983409", 21:00:39 INFO - "slavebuilddir": "test" 21:00:39 INFO - } 21:00:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:00:39 INFO - Running post-action listener: _resource_record_post_action 21:00:39 INFO - ##### 21:00:39 INFO - ##### Running download-and-extract step. 21:00:39 INFO - ##### 21:00:39 INFO - Running pre-action listener: _resource_record_pre_action 21:00:39 INFO - Running main action method: download_and_extract 21:00:39 INFO - mkdir: /builds/slave/test/build/tests 21:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:39 INFO - https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 21:00:40 INFO - Downloaded 1199 bytes. 21:00:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:00:40 INFO - Using the following test package requirements: 21:00:40 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:00:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:00:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:00:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'jsshell-mac.zip'], 21:00:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:00:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:00:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:00:40 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:00:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:00:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:00:40 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:00:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:00:40 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')]} 21:00:40 INFO - https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:00:41 INFO - Downloaded 17943910 bytes. 21:00:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:00:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:00:44 INFO - Return code: 0 21:00:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:00:44 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')]} 21:00:44 INFO - https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:00:46 INFO - Downloaded 17943910 bytes. 21:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:00:49 INFO - Return code: 0 21:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:00:49 INFO - https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:00:50 INFO - Downloaded 10847531 bytes. 21:00:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:00:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:00:51 INFO - Return code: 0 21:00: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')]} 21:00:51 INFO - https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:00:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:00:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:00:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:00:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 21:00:54 INFO - Downloaded 111391316 bytes. 21:00:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:00:54 INFO - mkdir: /builds/slave/test/properties 21:00:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:00:54 INFO - Writing to file /builds/slave/test/properties/build_url 21:00:54 INFO - Contents: 21:00:54 INFO - build_url:https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:00:56 INFO - Running post-action listener: _resource_record_post_action 21:00:56 INFO - Running post-action listener: set_extra_try_arguments 21:00:56 INFO - ##### 21:00:56 INFO - ##### Running populate-webroot step. 21:00:56 INFO - ##### 21:00:56 INFO - Running pre-action listener: _resource_record_pre_action 21:00:56 INFO - Running main action method: populate_webroot 21:00:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:00:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:00:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:00:56 INFO - '--tppagecycles', 21:00:56 INFO - '7'], 21:00:56 INFO - 'tests': ['tsvgm']}}, 21:00:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:00:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:00:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:00:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:00:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:00:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:00:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'tests': ['damp', 'tps']}, 21:00:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['damp', 'tps']}, 21:00:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:00:56 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['dromaeo_dom']}, 21:00:56 INFO - 'other': {'tests': ['a11yr', 21:00:56 INFO - 'ts_paint', 21:00:56 INFO - 'tpaint', 21:00:56 INFO - 'sessionrestore', 21:00:56 INFO - 'sessionrestore_no_auto_restore', 21:00:56 INFO - 'tabpaint']}, 21:00:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['a11yr', 21:00:56 INFO - 'ts_paint', 21:00:56 INFO - 'tpaint', 21:00:56 INFO - 'sessionrestore', 21:00:56 INFO - 'sessionrestore_no_auto_restore', 21:00:56 INFO - 'tabpaint']}, 21:00:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['a11yr', 21:00:56 INFO - 'ts_paint', 21:00:56 INFO - 'tpaint', 21:00:56 INFO - 'sessionrestore', 21:00:56 INFO - 'sessionrestore_no_auto_restore', 21:00:56 INFO - 'tabpaint']}, 21:00:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['a11yr', 21:00:56 INFO - 'ts_paint', 21:00:56 INFO - 'tpaint', 21:00:56 INFO - 'sessionrestore', 21:00:56 INFO - 'sessionrestore_no_auto_restore', 21:00:56 INFO - 'tabpaint']}, 21:00:56 INFO - 'other_l64': {'tests': ['a11yr', 21:00:56 INFO - 'ts_paint', 21:00:56 INFO - 'tpaint', 21:00:56 INFO - 'sessionrestore', 21:00:56 INFO - 'sessionrestore_no_auto_restore', 21:00:56 INFO - 'tabpaint']}, 21:00:56 INFO - 'other_nol64': {'tests': ['a11yr', 21:00:56 INFO - 'ts_paint', 21:00:56 INFO - 'tpaint', 21:00:56 INFO - 'sessionrestore', 21:00:56 INFO - 'sessionrestore_no_auto_restore', 21:00:56 INFO - 'tabpaint']}, 21:00:56 INFO - 'svgr': {'tests': ['tsvgx', 21:00:56 INFO - 'tsvgr_opacity', 21:00:56 INFO - 'tart', 21:00:56 INFO - 'tscrollx', 21:00:56 INFO - 'cart']}, 21:00:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['tsvgx', 21:00:56 INFO - 'tsvgr_opacity', 21:00:56 INFO - 'tart', 21:00:56 INFO - 'tscrollx', 21:00:56 INFO - 'cart']}, 21:00:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'tests': ['tp5o']}, 21:00:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'talos_options': ['--e10s'], 21:00:56 INFO - 'tests': ['tp5o']}, 21:00:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'talos_options': ['--xperf_path', 21:00:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:00:56 INFO - 'tests': ['tp5n']}, 21:00:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:00:56 INFO - 'talos_options': ['--e10s', 21:00:56 INFO - '--xperf_path', 21:00:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:00:56 INFO - 'tests': ['tp5n']}}, 21:00:56 INFO - 'talos.zip': {'path': '', 21:00:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:00:56 INFO - Running post-action listener: _resource_record_post_action 21:00:56 INFO - ##### 21:00:56 INFO - ##### Running create-virtualenv step. 21:00:56 INFO - ##### 21:00:56 INFO - Running pre-action listener: _resource_record_pre_action 21:00:56 INFO - Running main action method: create_virtualenv 21:00:56 INFO - Creating virtualenv /builds/slave/test/build/venv 21:00: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 21:00:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:00:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:00:56 INFO - Using real prefix '/tools/python27' 21:00:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:00:57 INFO - Installing distribute.............................................................................................................................................................................................done. 21:01:00 INFO - Installing pip.................done. 21:01:00 INFO - Return code: 0 21:01:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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', 'pip>=1.5'] in /builds/slave/test/build 21:01: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 pip>=1.5 21:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:00 INFO - 'HOME': '/Users/cltbld', 21:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:00 INFO - 'LOGNAME': 'cltbld', 21:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:00 INFO - 'MOZ_NO_REMOTE': '1', 21:01:00 INFO - 'NO_EM_RESTART': '1', 21:01:00 INFO - 'PAGER': '/bin/cat', 21:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:00 INFO - 'PWD': '/builds/slave/test', 21:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:00 INFO - 'SHELL': '/bin/bash', 21:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:00 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:00 INFO - 'USER': 'cltbld', 21:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:00 INFO - 'XPC_FLAGS': '0x0', 21:01:00 INFO - 'XPC_SERVICE_NAME': '0', 21:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01: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 21:01:00 INFO - Cleaning up... 21:01:00 INFO - Return code: 0 21:01:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:00 INFO - 'HOME': '/Users/cltbld', 21:01:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:00 INFO - 'LOGNAME': 'cltbld', 21:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:00 INFO - 'MOZ_NO_REMOTE': '1', 21:01:00 INFO - 'NO_EM_RESTART': '1', 21:01:00 INFO - 'PAGER': '/bin/cat', 21:01:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:00 INFO - 'PWD': '/builds/slave/test', 21:01:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:00 INFO - 'SHELL': '/bin/bash', 21:01:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:00 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:00 INFO - 'USER': 'cltbld', 21:01:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:00 INFO - 'XPC_FLAGS': '0x0', 21:01:00 INFO - 'XPC_SERVICE_NAME': '0', 21:01:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:00 INFO - Downloading/unpacking psutil>=0.7.1 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:01:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:01:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:01:03 INFO - Installing collected packages: psutil 21:01:03 INFO - Running setup.py install for psutil 21:01:03 INFO - building 'psutil._psutil_osx' extension 21:01: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 21:01: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 21:01:04 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 21:01:04 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 21:01:04 INFO - building 'psutil._psutil_posix' extension 21:01: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 21:01:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:01:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:01:04 INFO - ^ 21:01:04 INFO - 1 warning generated. 21:01: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 21:01:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:01:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:01:04 INFO - Successfully installed psutil 21:01:04 INFO - Cleaning up... 21:01:04 INFO - Return code: 0 21:01:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:04 INFO - 'HOME': '/Users/cltbld', 21:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:04 INFO - 'LOGNAME': 'cltbld', 21:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:04 INFO - 'MOZ_NO_REMOTE': '1', 21:01:04 INFO - 'NO_EM_RESTART': '1', 21:01:04 INFO - 'PAGER': '/bin/cat', 21:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:04 INFO - 'PWD': '/builds/slave/test', 21:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:04 INFO - 'SHELL': '/bin/bash', 21:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:04 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:04 INFO - 'USER': 'cltbld', 21:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:04 INFO - 'XPC_FLAGS': '0x0', 21:01:04 INFO - 'XPC_SERVICE_NAME': '0', 21:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:01: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) 21:01:07 INFO - Installing collected packages: mozsystemmonitor 21:01:07 INFO - Running setup.py install for mozsystemmonitor 21:01:07 INFO - Successfully installed mozsystemmonitor 21:01:07 INFO - Cleaning up... 21:01:07 INFO - Return code: 0 21:01:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:07 INFO - 'HOME': '/Users/cltbld', 21:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:07 INFO - 'LOGNAME': 'cltbld', 21:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:07 INFO - 'MOZ_NO_REMOTE': '1', 21:01:07 INFO - 'NO_EM_RESTART': '1', 21:01:07 INFO - 'PAGER': '/bin/cat', 21:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:07 INFO - 'PWD': '/builds/slave/test', 21:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:07 INFO - 'SHELL': '/bin/bash', 21:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:07 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:07 INFO - 'USER': 'cltbld', 21:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:07 INFO - 'XPC_FLAGS': '0x0', 21:01:07 INFO - 'XPC_SERVICE_NAME': '0', 21:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:07 INFO - Downloading/unpacking blobuploader==1.2.4 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:10 INFO - Downloading blobuploader-1.2.4.tar.gz 21:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:01:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:01:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:11 INFO - Downloading docopt-0.6.1.tar.gz 21:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:01:11 INFO - Installing collected packages: blobuploader, requests, docopt 21:01:11 INFO - Running setup.py install for blobuploader 21:01:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:01:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:01:11 INFO - Running setup.py install for requests 21:01:11 INFO - Running setup.py install for docopt 21:01:12 INFO - Successfully installed blobuploader requests docopt 21:01:12 INFO - Cleaning up... 21:01:12 INFO - Return code: 0 21:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:12 INFO - 'HOME': '/Users/cltbld', 21:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:12 INFO - 'LOGNAME': 'cltbld', 21:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:12 INFO - 'MOZ_NO_REMOTE': '1', 21:01:12 INFO - 'NO_EM_RESTART': '1', 21:01:12 INFO - 'PAGER': '/bin/cat', 21:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:12 INFO - 'PWD': '/builds/slave/test', 21:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:12 INFO - 'SHELL': '/bin/bash', 21:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:12 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:12 INFO - 'USER': 'cltbld', 21:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:12 INFO - 'XPC_FLAGS': '0x0', 21:01:12 INFO - 'XPC_SERVICE_NAME': '0', 21:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:01:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-zIuT_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:01:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-9MU9Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:01:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-RyRC9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:01:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-RCvF0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:01:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-AlvsLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:01:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:01:12 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-IihNVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-6KgxaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-2nzFmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-wBW6_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-f5hsWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-2ZZyt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-wndxfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Ax8ot6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-5GLZpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:01:13 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-HFlJA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:01:14 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-Iqi2YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:01:14 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-8LKcjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:01:14 INFO - Running setup.py install for manifestparser 21:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:01:14 INFO - Running setup.py install for mozcrash 21:01:14 INFO - Running setup.py install for mozdebug 21:01:14 INFO - Running setup.py install for mozdevice 21:01:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:01:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:01:14 INFO - Running setup.py install for mozfile 21:01:14 INFO - Running setup.py install for mozhttpd 21:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Running setup.py install for mozinfo 21:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Running setup.py install for mozInstall 21:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Running setup.py install for mozleak 21:01:15 INFO - Running setup.py install for mozlog 21:01:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Running setup.py install for moznetwork 21:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:01:15 INFO - Running setup.py install for mozprocess 21:01:15 INFO - Running setup.py install for mozprofile 21:01:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:01:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:01:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:01:16 INFO - Running setup.py install for mozrunner 21:01:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:01:16 INFO - Running setup.py install for mozscreenshot 21:01:16 INFO - Running setup.py install for moztest 21:01:16 INFO - Running setup.py install for mozversion 21:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:01:16 INFO - Cleaning up... 21:01:16 INFO - Return code: 0 21:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:16 INFO - 'HOME': '/Users/cltbld', 21:01:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:16 INFO - 'LOGNAME': 'cltbld', 21:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:16 INFO - 'MOZ_NO_REMOTE': '1', 21:01:16 INFO - 'NO_EM_RESTART': '1', 21:01:16 INFO - 'PAGER': '/bin/cat', 21:01:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:16 INFO - 'PWD': '/builds/slave/test', 21:01:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:16 INFO - 'SHELL': '/bin/bash', 21:01:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:16 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:16 INFO - 'USER': 'cltbld', 21:01:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:16 INFO - 'XPC_FLAGS': '0x0', 21:01:16 INFO - 'XPC_SERVICE_NAME': '0', 21:01:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-XWGLPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-FXrsEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-9cr2sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-tNdFCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-P7LCU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-j1BGZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-mxm0xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-jDYvvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:01:17 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-e800qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:01: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)) 21:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-g9J0ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-fdLsaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-SUB8mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-_FBubP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-aoSihj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-8xx7fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-jXKMVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:01: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)) 21:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:01:18 INFO - Running setup.py (path:/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/pip-SRhBJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:21 INFO - Downloading blessings-1.6.tar.gz 21:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:01:21 INFO - Installing collected packages: blessings 21:01:21 INFO - Running setup.py install for blessings 21:01:21 INFO - Successfully installed blessings 21:01:21 INFO - Cleaning up... 21:01:21 INFO - Return code: 0 21:01:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:01:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:01:21 INFO - Reading from file tmpfile_stdout 21:01:21 INFO - Current package versions: 21:01:21 INFO - blessings == 1.6 21:01:21 INFO - blobuploader == 1.2.4 21:01:21 INFO - docopt == 0.6.1 21:01:21 INFO - manifestparser == 1.1 21:01:21 INFO - mozInstall == 1.12 21:01:21 INFO - mozcrash == 0.17 21:01:21 INFO - mozdebug == 0.1 21:01:21 INFO - mozdevice == 0.48 21:01:21 INFO - mozfile == 1.2 21:01:21 INFO - mozhttpd == 0.7 21:01:21 INFO - mozinfo == 0.9 21:01:21 INFO - mozleak == 0.1 21:01:21 INFO - mozlog == 3.1 21:01:21 INFO - moznetwork == 0.27 21:01:21 INFO - mozprocess == 0.22 21:01:21 INFO - mozprofile == 0.28 21:01:21 INFO - mozrunner == 6.11 21:01:21 INFO - mozscreenshot == 0.1 21:01:21 INFO - mozsystemmonitor == 0.0 21:01:21 INFO - moztest == 0.7 21:01:21 INFO - mozversion == 1.4 21:01:21 INFO - psutil == 3.1.1 21:01:21 INFO - requests == 1.2.3 21:01:21 INFO - wsgiref == 0.1.2 21:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:21 INFO - 'HOME': '/Users/cltbld', 21:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:21 INFO - 'LOGNAME': 'cltbld', 21:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:21 INFO - 'MOZ_NO_REMOTE': '1', 21:01:21 INFO - 'NO_EM_RESTART': '1', 21:01:21 INFO - 'PAGER': '/bin/cat', 21:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:21 INFO - 'PWD': '/builds/slave/test', 21:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:21 INFO - 'SHELL': '/bin/bash', 21:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:21 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:21 INFO - 'USER': 'cltbld', 21:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:21 INFO - 'XPC_FLAGS': '0x0', 21:01:21 INFO - 'XPC_SERVICE_NAME': '0', 21:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01: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)) 21:01:22 INFO - Cleaning up... 21:01:22 INFO - Return code: 0 21:01:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:22 INFO - 'HOME': '/Users/cltbld', 21:01:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:22 INFO - 'LOGNAME': 'cltbld', 21:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:22 INFO - 'MOZ_NO_REMOTE': '1', 21:01:22 INFO - 'NO_EM_RESTART': '1', 21:01:22 INFO - 'PAGER': '/bin/cat', 21:01:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:22 INFO - 'PWD': '/builds/slave/test', 21:01:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:22 INFO - 'SHELL': '/bin/bash', 21:01:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:22 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:22 INFO - 'USER': 'cltbld', 21:01:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:22 INFO - 'XPC_FLAGS': '0x0', 21:01:22 INFO - 'XPC_SERVICE_NAME': '0', 21:01:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:22 INFO - Downloading/unpacking jsonschema 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:01:24 INFO - Downloading/unpacking functools32 (from jsonschema) 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:25 INFO - Downloading functools32-3.2.3-2.tar.gz 21:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:01:25 INFO - warning: no files found matching '*.txt' 21:01:25 INFO - no previously-included directories found matching 'build' 21:01:25 INFO - no previously-included directories found matching 'dist' 21:01:25 INFO - no previously-included directories found matching '.git*' 21:01:25 INFO - Installing collected packages: jsonschema, functools32 21:01:25 INFO - Running setup.py install for functools32 21:01:25 INFO - warning: no files found matching '*.txt' 21:01:25 INFO - no previously-included directories found matching 'build' 21:01:25 INFO - no previously-included directories found matching 'dist' 21:01:25 INFO - no previously-included directories found matching '.git*' 21:01:25 INFO - Successfully installed jsonschema functools32 21:01:25 INFO - Cleaning up... 21:01:25 INFO - Return code: 0 21:01:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:01: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')]} 21:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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')]} 21:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:01: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 0x101a6ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a7c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff06bca23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, '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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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 21:01: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 21:01: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 21:01:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:01:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:01:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:01:25 INFO - 'HOME': '/Users/cltbld', 21:01:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:01:25 INFO - 'LOGNAME': 'cltbld', 21:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:01:25 INFO - 'MOZ_NO_REMOTE': '1', 21:01:25 INFO - 'NO_EM_RESTART': '1', 21:01:25 INFO - 'PAGER': '/bin/cat', 21:01:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:01:25 INFO - 'PWD': '/builds/slave/test', 21:01:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:01:25 INFO - 'SHELL': '/bin/bash', 21:01:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:01:25 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:01:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:01:25 INFO - 'USER': 'cltbld', 21:01:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:01:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:01:25 INFO - 'XPC_FLAGS': '0x0', 21:01:25 INFO - 'XPC_SERVICE_NAME': '0', 21:01:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:01:25 INFO - Downloading/unpacking flake8 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:01:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:01:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01: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 21:01:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:01: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 21:01: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 21:01:29 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 21:01:29 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 21:01: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 21:01: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 21:01:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:01:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:01:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:01:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:01:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:01:29 INFO - no previously-included directories found matching 'docs/_build' 21:01:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:01:29 INFO - Running setup.py install for pep8 21:01:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:01:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:01:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:01:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:01:29 INFO - no previously-included directories found matching 'docs/_build' 21:01:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:01:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:01:29 INFO - Cleaning up... 21:01:29 INFO - Return code: 0 21:01:29 INFO - Running post-action listener: _resource_record_post_action 21:01:29 INFO - Running post-action listener: _start_resource_monitoring 21:01:29 INFO - Starting resource monitoring. 21:01:30 INFO - ##### 21:01:30 INFO - ##### Running install step. 21:01:30 INFO - ##### 21:01:30 INFO - Running pre-action listener: _resource_record_pre_action 21:01:30 INFO - Running main action method: install 21:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:01:30 INFO - Reading from file tmpfile_stdout 21:01:30 INFO - Detecting whether we're running mozinstall >=1.0... 21:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:01:30 INFO - Reading from file tmpfile_stdout 21:01:30 INFO - Output received: 21:01:30 INFO - Usage: mozinstall [options] installer 21:01:30 INFO - Options: 21:01:30 INFO - -h, --help show this help message and exit 21:01:30 INFO - -d DEST, --destination=DEST 21:01:30 INFO - Directory to install application into. [default: 21:01:30 INFO - "/builds/slave/test"] 21:01:30 INFO - --app=APP Application being installed. [default: firefox] 21:01:30 INFO - mkdir: /builds/slave/test/build/application 21:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:02:04 INFO - Reading from file tmpfile_stdout 21:02:04 INFO - Output received: 21:02:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:02:04 INFO - Running post-action listener: _resource_record_post_action 21:02:04 INFO - ##### 21:02:04 INFO - ##### Running run-tests step. 21:02:04 INFO - ##### 21:02:04 INFO - Running pre-action listener: _resource_record_pre_action 21:02:04 INFO - Running main action method: run_tests 21:02:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:02:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:02:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:02:04 INFO - 2016-03-25 21:02:04.876 screenresolution[1637:7388] starting screenresolution argv=screenresolution get 21:02:04 INFO - 2016-03-25 21:02:04.878 screenresolution[1637:7388] Display 0: 1600x1200x32@60 21:02:04 INFO - 2016-03-25 21:02:04.884 screenresolution[1638:7390] starting screenresolution argv=screenresolution list 21:02:04 INFO - Available Modes on Display 0 21:02:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:02:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:02:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:02:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:02:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:02:05 INFO - Intel Iris: 21:02:05 INFO - Chipset Model: Intel Iris 21:02:05 INFO - Type: GPU 21:02:05 INFO - Bus: Built-In 21:02:05 INFO - VRAM (Dynamic, Max): 1536 MB 21:02:05 INFO - Vendor: Intel (0x8086) 21:02:05 INFO - Device ID: 0x0a2e 21:02:05 INFO - Revision ID: 0x0009 21:02:05 INFO - Displays: 21:02:05 INFO - Display: 21:02:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:02:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:02:05 INFO - Display Serial Number: 1600x1200 60 21:02:05 INFO - Main Display: Yes 21:02:05 INFO - Mirror: Off 21:02:05 INFO - Online: Yes 21:02:05 INFO - Rotation: Supported 21:02:05 INFO - Return code: 0 21:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:02:05 INFO - Python 2.7.3 21:02:05 INFO - Return code: 0 21:02:05 INFO - grabbing minidump binary from tooltool 21:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:02:05 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 0x10190be00>, '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 0x101734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101906b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:02:05 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 21:02:05 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 21:02:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:02:05 INFO - Return code: 0 21:02:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:02:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:02:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:02:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:02:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:02:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:02:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:02:06 INFO - Return code: 0 21:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0161 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:02:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DH3h1ccyiQ/Render', 21:02:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:06 INFO - 'HOME': '/Users/cltbld', 21:02:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:06 INFO - 'LOGNAME': 'cltbld', 21:02:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:02:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:06 INFO - 'MOZ_NO_REMOTE': '1', 21:02:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:02:06 INFO - 'NO_EM_RESTART': '1', 21:02:06 INFO - 'PAGER': '/bin/cat', 21:02:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:06 INFO - 'PWD': '/builds/slave/test', 21:02:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:02:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:06 INFO - 'SHELL': '/bin/bash', 21:02:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sXDSORAyf7/Listeners', 21:02:06 INFO - 'TMPDIR': '/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/', 21:02:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:06 INFO - 'USER': 'cltbld', 21:02:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:06 INFO - 'XPC_FLAGS': '0x0', 21:02:06 INFO - 'XPC_SERVICE_NAME': '0', 21:02:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0161', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:02:06 INFO - mozversion application_buildid: 20160325190938 21:02:06 INFO - mozversion application_changeset: 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 21:02:06 INFO - mozversion application_display_name: Nightly 21:02:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:02:06 INFO - mozversion application_name: Firefox 21:02:06 INFO - mozversion application_remotingname: firefox 21:02:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:02:06 INFO - mozversion application_vendor: Mozilla 21:02:06 INFO - mozversion application_version: 48.0a1 21:02:06 INFO - mozversion platform_buildid: 20160325190938 21:02:06 INFO - mozversion platform_changeset: 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 21:02:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:02:06 INFO - mozversion platform_version: 48.0a1 21:02:06 INFO - using testdate: 1458964926 21:02:06 INFO - actual date: 1458964926 21:02:06 INFO - starting webserver on 'localhost:49276' 21:02:06 INFO - SUITE-START | Running 2 tests 21:02:06 INFO - TEST-START | dromaeo_css 21:02:06 INFO - operating with platform_type : mac_ 21:02:06 INFO - Initialising browser for dromaeo_css test... 21:02:06 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpjwNw3W/profile http://localhost:49276/getInfo.html) 21:02:08 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 21:02:08 INFO - PROCESS | 1656 | colorDepth:24 21:02:08 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 21:02:08 INFO - PROCESS | 1656 | __metrics 21:02:09 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:02:09 ERROR - PROCESS | 1656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:02:09 INFO - TEST-INFO | 1656: exit 0 21:02:09 INFO - Browser initialized. 21:02:09 INFO - Running cycle 1/1 for dromaeo_css test... 21:02:09 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpjwNw3W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:02:21 INFO - PROCESS | 1659 | RSS: Main: 244228096 21:02:21 INFO - PROCESS | 1659 | 21:03:12 INFO - PROCESS | 1659 | 1458964992603 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] 21:05:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 21:05:23 INFO - PROCESS | 1659 | RSS: Main: 320315392 21:05:23 INFO - PROCESS | 1659 | 21:08:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 21:08:26 INFO - PROCESS | 1659 | RSS: Main: 374337536 21:08:26 INFO - PROCESS | 1659 | 21:11:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 21:11:29 INFO - PROCESS | 1659 | RSS: Main: 371429376 21:11:29 INFO - PROCESS | 1659 | 21:14:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 21:14:31 INFO - PROCESS | 1659 | RSS: Main: 334073856 21:14:31 INFO - PROCESS | 1659 | 21:17:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 21:17:35 INFO - PROCESS | 1659 | RSS: Main: 336584704 21:17:35 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 21:20:38 INFO - PROCESS | 1659 | RSS: Main: 407011328 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | __start_tp_report 21:20:38 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 21:20:38 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 21:20:38 INFO - PROCESS | 1659 | |i|pagename|runs| 21:20:38 INFO - PROCESS | 1659 | |0;dojo.html;3225.6935591118845;3367.3770352484794;3413.0102270341604;3428.1772374630095;3490.9650903490956;5396.973015134919;5399.271098401715;5404.189371594262;5434;5450.236966824637;5427.538659213971;5462.962037212927;5463.836084917449;5469.234307196995;5471.425500322469;4995.375578052734;5006.624503162259;5033.974830125844;5094.643374963735;5095.3885533736;5044.798208071673;5093.949060509403;5105.463926287742;5106.029854327684;5111.897762044757;5020.723860187688;5066.1387564114;5089.185730283156;5090.338256026711;5099.617528685363;5024.4724303948105;5081.415637201732;5090.49095090488;5092.898142037157;5099.566536844372;4950.2079667253065;4953.727544985024;5019.447860735316;5025.422076461217;5060.645754797166;5327.121025030865;5339.786408543654;5343.679379237258;5376.11294136467;5439.456054394529;5869.148973398876;5884.146798714162;5887.8233652990475;5901.2918449785875;5902.3507414184405;5855.590108692393;5905.43898329658;5977.7608895644125;5979.760809567612;6064.4541991221;5529.751161197715;5532.7786888524815;5534.1975413564805;5547.1124620061;5569.303837020372;6087.299960504599;6145.262568491809;6151.0773383992755;6162.938370616326;6172.321044685081;5100.673824805577;5528.308961379827;5764.538836893039;5788.247527821356;5796.536277097822;5985.371535988746;5988.131720900532;5994.67029313392;6010.759569617167;6015.488683461867;4968.22992436173;5863.765449381977;5887.970560147258;5897.970510147507;5906.143609176645;5806.622569532967;5886.440788125121;5916.437938395931;5921.585489015728;5927.911081333784;3997.200559888034;4696.9060618787435;4743.02767932573;4786.305985632133;4792.017636384533;4266.701330906869;4312.223799716018;4314.827406903752;4340.045190058182;4340.218760623118;5231.346081739783;5390.380106287748;5423.972880135574;5458.4814442627885;5466.01611709896;5941.37615550361;5999.880002399927;6014.6391216527145;6046.667433291212;6066.393360663898;5401.135818269058;5427.864303392368;5451.781928722886;5452.700101494456;5452.836414907559;5079.034983353151;5167.9224811627855;5181.481851814789;5190.11767999441;5231.529162375328;6146.0473626587955;6249.6562689051625;6251.718672659832;6276.497880169484;6285.182926219653;5933.940660593512;5952.813428416359;5966.731497082555;5971.104334349882;6023.789167379121;6128.571000029955;6166.938330616636;6193.535484838745;6238.563300568917;6255.59338643005;5791.102379131242;5852.5317974561085;5859.619124756877;5885.911711324248;5897.616654917417;5787.768489260551;5894.941050589439;5935.525157987265;5957.3744756799915;5958.285005799332;5666.575006874418;5712.771489140554;5787.508061814793;5798.5651076168615;5799.246098007232;5738.856528586819;5759.884802304015;5765.7117144141785;5777.74000169985;5793.217915581343;5620.100783874561;5646.491815736604;5662.915056274242;5665.065264231355;5674.06377947634;5578.497935185853;5710.771569137188;5750.539956803362;5792.102224155263;5826.70866456684;5227.477252274742;5255.500727430888;5681.602287839812;5690.345610254708;5697.173909782975 21:20:38 INFO - PROCESS | 1659 | |1;ext.html;467.15445044469493;549.9340079190498;576.785865752591;611.2533058300885;626.3141859663667;30295.09114726559;38768;38978.99999999996;39000.80499597498;39204.60795392045;41665.7916710416;42337.57662423375;42361.57638423615;42373.78813105938;42379;9470.195033422167;9700.660476883311;9719.708408747749;9725.173360264385;9727.124558789708;9520.523973801317;9676.322657413984;9695.515224238796;9700.75748106296;9708.077732615391;9613.711588652352;9797.902020979805;9866.802663946717;9877.70366888991;9894.703158905244;9744.56149473272;9845.852312215322;9849.60601575936;9864.457454839981;9864.65473708424;9579.13787759105;9751.853722194173;9756.951215243878;9758.316917815755;9783.608655653836;40366.59633403658;40847.79576102101;40959.7952010241;40985.97535061647;41011.7949410254;2617.6073588961617;3313.9005829825146;3386.9830650846834;3463.3939060664534;3775.9284560924107;27068.729312707015;28505;28597.428051438856;28629.427411451656;28637.71362286392;2604.361931326818;2624.593188055854;2686.9462610747673;2757.4347258812095;2765.8893644254204;434895;508229;510542;511246;512155.4392228015;67292.32707672959;67549;68073;68129;68282.65858670774;73167.26832731605;73384;73479;73549.89675154877;73596.26403736002;16834.326626934784;17004;17035.574110647332;17052.914735426242;17058;12958.22250664963;13002.869971300355;13035.348232588332;13045.543405980934;13074.738505229841;20861;21536.676949845765;22024.687407822268;22026.669599956014;22048.228312009003;6779.966100169468;7934.087579928267;8480.872786908078;8942.105789421135;9156.954215228881;922.7693076730817;962.9455745958164;1000.2548101664162;1000.3197825478599;1054.0355574649263;21293.78706212918;26390.076347328137;28254;28528.429431411256;29011.274718132216;1106.8450416941635;1121.5177473686392;1137.635956493914;1143.3654321851286;1164.4643464006483;14359.282035898163;14939.25303734809;14961.625959351104;15022.699546009237;15079.019863708823;1004493;1006633;1006867;1007113;1010738;49692.50307496951;62687.6865615669;62735;62921;62981.37018629755;1369.705513314642;1401.5234820161195;1511.2443778110944;1531.9387224510895;1647.7775500307546;21798.891005544872;24172.758272417756;28432;29295.85352073226;29611.259718507208;45497;49028;49872.002559949324;49898.251526226406;50058.74853128701;402540;404623;405006;405302;405756.97121514205;27745.722542774314;31369.686303136677;32198.678013220506;32614.83692581522;32683.34633307368;35019.774307899104;39791;40323;40550.797246014765;41409.37885931774;31747.206319841265;37946.62053379431;38915.80542097271;39556.2088758229;40460.3930941042;35864.82067589645;36008.63991360053;36137.81931090433;36874.26251474902;36906.70826521059;34192.487112692834;36592.81703591465;37311.44032839455;37550;37553.24893502169;31302.843485782425;32800.68797248083;32860.50709239411;32894.67105328916;32898.5065224017;23953.26290117795;24301.75698242995;24515.877420612782;24892.75107248977;25328 21:20:38 INFO - PROCESS | 1659 | |2;jquery.html;339.6109910466194;341.92135808764;358.84928330101354;364.0589077235347;364.40056107702827;19417.126229319678;19924.800751992494;20279.39161825146;20724.896375518103;20734.48163795906;19044.047797610132;19438.805611943877;20037.899810500963;20069.59860802783;20090.59818803623;5700.230468886699;5846.444587764156;5902.2622172228475;5908.320543137551;5913.3199682036475;4192.203481338551;4403.801828917706;5873.676947767871;6160.599561028541;6460.741570337181;6397.968010159942;6401.231852177745;6405.29541750407;6407.359264073602;6414.294427612959;5516.282883225155;6185.257769067718;6501.902471462932;6508.54440189187;6511.641859697715;3711.0351308659674;4355.651547876162;5511.889762204733;5516.475934786189;5576.498115169654;24113.87943060291;24394.756052439425;24639.507209855703;25147.24558263255;25440.363990900376;2156.105216335219;2239.9328020159423;2242.125571027301;2256;2285.451491641994;14288.85711142896;14705.26473676312;14949.906774394034;15087.868409869194;15316.540503784905;1689.3496004038534;1703.4804384662673;1705.7270836666073;1738.9913050434793;1740.3995621510558;100946.9905300945;104836;105760;105760;105804.94195058028;8410.789730256793;9837.163841073589;10006.749831254278;10239.590416383262;10291.485425728684;12626.621201363974;12669.493220271086;12706.237625742486;12716;12719.300438475973;6920.826979325457;8308.626111824862;8354.8329033419;8385.245327920395;8386.8322633547;7059.788206353817;8669.739907802776;8684.782880427914;8760.91239087601;8807.559622018873;5394.9460505394445;5473.042217611902;6014.72933717975;6036.215292012098;6115.755369785159;1649.1342045426247;1727.8143148916631;1728.887622304546;1729.0835856995811;1786.7051936430344;735.0224201811578;845.4082142500274;963.9084286992725;990.7473594233569;1075.666173944319;20505.657214694897;21227.36317910465;21364.465888352606;21444.57110857774;21491.897282473197;957.6456711016829;968.4044312747609;970.5729479029204;1009.2985375164337;1048.3028785857318;9231.261499080058;10094.293399461967;11129.666110016713;11540.94229528847;11621;567746;623428;632013;644868.7756561281;646018;104113.47943260235;109094.45452772843;111040;111180.444097779;112394.43802780933;1034.7930413917247;1071.062820032456;1073.2219141122623;1094.8248280275277;1096.9012788849043;14392.98000698044;16047.19764011818;18383.632327353647;19396.709049364552;20427.4893127673;45053.774731126134;47152.58542243738;47701;48225.27662085001;50210;49868.76115530221;65264;65284.673576631816;65520;65735;7558.962205188939;7622.961885190539;7892.802679933047;7900.486468379537;8033.955585773812;11847.703807404883;12280.938595306967;12399.318037508023;12694.047946404242;12853.16454430459;9971.217719527169;10838.13294936419;10999.450027498433;11026.393548354597;11045.668629941114;8381.203785640355;10270.383776973405;10445.738856528647;10964.958328958735;11067.335959842436;11095.50070246857;11264.718382040515;11334.773304533699;11341.829872552084;11549.076073914235;7668.501547399401;7778.088373300295;7794.805129871798;7869;8067.3142782864115;8227.218414250636;9921.40471571708;11043.447827608426;11314.773704526027;11334.773304534028 21:20:38 INFO - PROCESS | 1659 | |3;mootools.html;1409.7321508913312;1565.6477292609165;1584.7305957987141;1831.8259765322298;1977.9604407911843;7315.231900650435;7885.80285492863;8559.186877246659;8714.651413943435;8740.082291359404;8385.958070209655;8637.91362086379;8651.30789536837;8656.43733157346;8657.69698060568;1908.3797765726124;2297.621427143709;2359.740428552858;2432.5864603017485;2440.3533063738123;2453.9631905521433;2460.9507809843794;2461.692288463942;2463;2463.470353873917;2380.47629521505;2401.1475926046264;2421.927342179729;2424.5756992526326;2429.2712186344024;2401.3156250468533;2408.1932552594903;2414.384331995339;2455.6739360745178;2455.693038370204;2362.173239366225;2393.4854006388537;2437.7562243775483;2441.2310122311414;2452.730199678034;8757.430767000125;8841.336899732545;8843.823123537557;8856.778580535474;8874.334424918157;5359.464053594648;5492.945070549284;5493.285872836545;5495.120780675073;5504.80733174337;3526.841292141834;3593.586737525192;3666.7433279670436;3673.761205521659;3696.85212591496;1026.7587117027567;1036.7563622548696;1042.5100202904623;1049.7375656085978;1058.1270451877156;11708.941455292754;11743.354115523643;11744.823827642593;11753.412329383496;11756.706082347924;4743.739094349844;4789.706410376186;4811.013742182844;4821.807127714852;4859.416869975555;9757.26820488452;10029.348092373972;10037.297389182833;10052.145567626687;10075.59697612102;5275.868103297372;5284;5382.838514844561;5392.218128371364;5401.891962160735;4354.651627869763;4532.682712210114;4726.078414709167;4872.43966943806;4874.976254986422;3755.8122093895195;3830.9808450957566;3847.6537111659527;3861.150546879738;3900.297946369624;1305.0733978874916;1307.1372893889986;1308.8036794480904;1315.2700251360395;1317.4993502469001;1365.1672479787321;1383.674836413442;1404.3539971612968;1409.2530958591963;1410.2948525737131;8164.306033987177;8341;8386.412951093487;8413.789655258544;8429;1118.424011634009;1153.7865494883474;1219.762146381447;1220.6460126563197;1228.6716671906686;6269.49844012487;6271.498280137578;6322.841928951813;6337.683115844189;6338.873222535523;10016.198704103654;10316.123129533924;10440.63457778974;10471.057604815604;10539.736506587396;9878.654247101316;10425.061744442884;10472.581096756045;10512.421816799997;10516.26386152962;7964.442489025829;8145.981752281084;8175.79560510992;8184.508929464251;8204.220599043081;6416.550841441054;7838.980932478741;7916.960415197887;7976.641051152828;8017.8797318039105;8942.73171804847;9162.312826537904;9176.403533770284;9365.01667324921;9385.436873787594;8721.386543489474;8903;9379.34344595899;9532.571034303335;9534.618615255313;6723.025161351675;6904.998775177471;6906.205786334636;7303.525270857377;7427.2201418850245;7339.302766237199;8186.590670466334;8266.421350505407;8288.544130072903;8292.33661307106;7303.087114110736;7356.742514011984;7366.815829604303;7535.6985720570565;7537.736179233701;7248.939530910033;7358.227386124594;7413.443991700537;7442.330190282684;7489.438292128221;7756.457048006585;7764.417668674759;7818.92181078182;7829.804254893673;7830.177831327856;7013.473989450709;7042.295770422917;7086.539374940612;7098.396636285767;7101.680424380812;7118.323759242864;7133.072700548895;7166.820829479305;7180.138383394026;7195.964020179866 21:20:38 INFO - PROCESS | 1659 | |4;prototype.html;320.92618697699527;326.95259187417827;330.1416317574306;330.63795144316964;335.1888429999403;6488.44848187904;6520.804375868725;6566.179227596551;6575.605463672183;6644.867102657944;6447.419732224111;6501.642409667466;6505.4145126938565;6525.543211975164;6527;4632.166210082184;4697.5772180503745;4761.690490118149;4840.370751802261;4869.123557759602;4121.855735049274;4787.688800227974;4804.639652026094;4804.975975120119;4816.349792777983;4720;4735.621150307984;4740.715557066587;4800.711957282557;4800.90398192036;4527.343535187396;4651.162790697673;4732.219183834663;4732.881677958078;4736.692115012547;4079.8572049978106;4080.6939479539155;4085.22380747657;4093.774842383668;4103.343465045608;6164.938350616526;6247.125402443661;6262.029385445263;6288.025356069817;6289.308176100625;5623.015972204888;5625.128105143709;5632.887342253132;5634.352049514277;5648.576356773258;6862.245153033163;6880.931190688079;6882.827929301758;6893;6907.067545881292;4580.9770951145365;4648.628109751246;4663.2305669564485;4663.2305669564485;4690.0854333405;6272.6236425814595;7150.141982962025;7203.315685009916;7313.305236002571;7326.670299836467;4718.504557021532;4719.362886010414;4725.929111063337;4731.976340118277;4732.455767586703;4785.641076919245;4793.281007848851;4793.616510679138;4797.904041919142;4806.663533552618;5648.85877853057;5650.4349565043985;5657.43425657431;5661.7735290588735;5667.3482549507335;6683.498737594603;6949.548279361826;6965.094537710065;6972.51192416526;6976.51164418496;1385.3350391811784;1652.4877288040504;1659.1372486307052;1675.8575521080602;1677.7986641603086;1025.9692209233735;1058.1799105693149;1077.0790973717515;1086.7826434713088;1112.3881864974232;6362.204724409449;6512.316206798313;6534;6543.051257567626;6547.607143571306;7238.819029524304;7262.31008054234;7268.709251629875;7277.89083163753;7289.453291003196;6508.9349106508325;6524.934750652433;6528.869422611521;6531;6537.313582073909;3107.440660681054;3800.9049773755323;3849.018500282466;3849.268638958589;3854;5753.252077229933;6186.257649082049;6406.775762848278;7524.849503010018;7647.273509016634;7501.324880760758;7565.092188937363;7565.319121279112;7575.772726818204;7591.3547348475995;7589.8861517077285;7600.467967242351;7623.161452240138;7626.809329766689;7631.885521717179;7034.120734908137;7304.96347518259;7307.9634601828775;7316.268373162641;7340.522866013692;7163;7192.96403518;7196.992421060951;7202.855942881218;7219.169795473587;7585;7616.771496855104;7619.009528761448;7624.27569380908;7627.199144090013;4544.341070544819;4594.7243165408845;4594.8391806287955;4603.861884143481;4609.51600082;5971.462568368867;6997.300269972962;7283.526570772883;7284.235155308828;7313.744018959311;6998.860022799618;7030.156381234285;7030.2969703029285;7032.542884712478;7038.718451261892;6917.965410172917;7008.369246767816;7017.228104908558;7020.157581090302;7030.894536582057;5920.467157955804;6883.208431030295;6884;6888;6891.173059232924;6737.494687898526;7013.333733295329;7029.226785053742;7040.331168538981;7045.471589630901;6551.868962620816;6674.532782705358;6677.83305417349;6798.52410331272;6876.312368763083 21:20:38 INFO - PROCESS | 1659 | |5;yui.html;676.5940435738554;681.4514315975638;694.4999600287792;749.0524486524547;772.7102336623765;14828.851711482896;17772.555686107837;18093.366732164377;18095.18571664275;18118.912865228096;13188;16436.589085272873;16482.587935301624;16550.006999580004;16570.99999999997;739.9112106547221;908.8954770201412;923.3213588012806;927.3184209605935;927.7680579855037;746.9701211951516;912.9817403651923;926.5645146781036;930.3859452761179;930.8743319651828;969.3699095587854;976.998576459128;977.0766625538869;980.5146452506019;980.5391466010964;780.5394817057906;940.5720397219249;971.7619183300102;973.0561355485167;974.2887691984855;713.803703981404;714.6462501062008;714.7426926306525;717.0105254748466;717.3830505765038;15307.311170997333;15433.768493472608;15436.228188590525;15439.150846703427;15471.303791329305;12329.555604072848;12452;12587.874121258761;12672.23966562;12865.228086314852;9767;9914.90085099147;9935.304528682995;10023.49882505879;10319.48402579868;3426.9314613707834;3481.3733527964955;3495.475678648223;3525.4006818840858;3684.428913518409;82486;82611.58694206491;82662.17337826604;82697.17302826955;83606.16393836106;8717.782055448537;9225.630974761069;9226;9351.625934962662;9949.502524873727;19093.331733389543;21205.78794212069;21266.574668506542;21278.78721212799;21293;7232.349088582053;7385.409167266605;7485.438592105614;7555.471117021756;7626.733064342832;4037.9394309085387;4103.035786590149;4113.280175969194;4116.197341518375;4117.21772863155;3343.147497388199;3389.322135572895;3390.2033022239752;3390.9491357629654;3399.728021758303;618.2303032724287;619.0806652121596;622.9781957631552;630.3318482408662;631.2866460899246;511.6188439612438;527.343457395545;554.9611527193058;561.6545824318015;607.0802733858209;8069.394795390369;8133.227343402367;8133.389995750343;8240.258376746002;8317.662877641438;559.6642014791092;589.7965202005302;595.354040865657;597.8774351257981;603.2241289651604;3728.2729867675544;3794.715396345285;3820.522434695663;3949.4668219790533;4021.1354558770004;95954.04045959591;96096.03903961011;96150.51924740472;96914.51542742242;97921;82109.58945205236;82779;83645.58177209075;83707;83759.5812020936;65755;65918;66492.66753666298;67754.64490710257;69489.61020779556;7759.340456061298;7796.88304675419;7853.725119620786;7919.643616037177;8086.353091752763;48841.755791220814;48869.26696099633;49053;50989.235161471865;51729.741351293;49605.751971241356;58557.70721146367;67667;67964.32035679778;72602.27397725955;10986.176036797113;11075.889241107487;11086.833697494383;11165.16261280391;11538.250013749079;11008.724781880517;11443.427828608703;12033.45849436795;12151.270923744603;12249.950485244744;9786.314957952874;11391.487383067617;11737.589184378507;11748.29510229389;11939;10415.635452759117;10769.24615276923;10773.784524309627;11397.316161030365;12496.812547811609;10925.344479331265;10976;11075.833862491907;11141.88858111441;12177.391130443619;9362.485063321583;9371.390859594105;9392.67125650599;9462.337636365388;9865.06281903218;8839.46963182211;8867.68963086289;9096.363254572381;9501.762455938657;9518.524073796421 21:20:38 INFO - PROCESS | 1659 | __end_tp_report 21:20:38 INFO - PROCESS | 1659 | __start_cc_report 21:20:38 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1079 21:20:38 INFO - PROCESS | 1659 | __end_cc_report 21:20:38 INFO - PROCESS | 1659 | __startTimestamp1458966038409__endTimestamp 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | ------- Summary: start ------- 21:20:38 INFO - PROCESS | 1659 | Number of tests: 6 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5489.73 Median:5646.49 stddev:591.46 (10.5%) stddev-sans-first:565.98 21:20:38 INFO - PROCESS | 1659 | Values: 3225.7 3367.4 3413.0 3428.2 3491.0 5397.0 5399.3 5404.2 5434.0 5450.2 5427.5 5463.0 5463.8 5469.2 5471.4 4995.4 5006.6 5034.0 5094.6 5095.4 5044.8 5093.9 5105.5 5106.0 5111.9 5020.7 5066.1 5089.2 5090.3 5099.6 5024.5 5081.4 5090.5 5092.9 5099.6 4950.2 4953.7 5019.4 5025.4 5060.6 5327.1 5339.8 5343.7 5376.1 5439.5 5869.1 5884.1 5887.8 5901.3 5902.4 5855.6 5905.4 5977.8 5979.8 6064.5 5529.8 5532.8 5534.2 5547.1 5569.3 6087.3 6145.3 6151.1 6162.9 6172.3 5100.7 5528.3 5764.5 5788.2 5796.5 5985.4 5988.1 5994.7 6010.8 6015.5 4968.2 5863.8 5888.0 5898.0 5906.1 5806.6 5886.4 5916.4 5921.6 5927.9 3997.2 4696.9 4743.0 4786.3 4792.0 4266.7 4312.2 4314.8 4340.0 4340.2 5231.3 5390.4 5424.0 5458.5 5466.0 5941.4 5999.9 6014.6 6046.7 6066.4 5401.1 5427.9 5451.8 5452.7 5452.8 5079.0 5167.9 5181.5 5190.1 5231.5 6146.0 6249.7 6251.7 6276.5 6285.2 5933.9 5952.8 5966.7 5971.1 6023.8 6128.6 6166.9 6193.5 6238.6 6255.6 5791.1 5852.5 5859.6 5885.9 5897.6 5787.8 5894.9 5935.5 5957.4 5958.3 5666.6 5712.8 5787.5 5798.6 5799.2 5738.9 5759.9 5765.7 5777.7 5793.2 5620.1 5646.5 5662.9 5665.1 5674.1 5578.5 5710.8 5750.5 5792.1 5826.7 5227.5 5255.5 5681.6 5690.3 5697.2 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:75886.13 Median:20861.27 stddev:186883.43 (895.8%) stddev-sans-first:187321.89 21:20:38 INFO - PROCESS | 1659 | Values: 467.2 549.9 576.8 611.3 626.3 30295.1 38768.0 38979.0 39000.8 39204.6 41665.8 42337.6 42361.6 42373.8 42379.0 9470.2 9700.7 9719.7 9725.2 9727.1 9520.5 9676.3 9695.5 9700.8 9708.1 9613.7 9797.9 9866.8 9877.7 9894.7 9744.6 9845.9 9849.6 9864.5 9864.7 9579.1 9751.9 9757.0 9758.3 9783.6 40366.6 40847.8 40959.8 40986.0 41011.8 2617.6 3313.9 3387.0 3463.4 3775.9 27068.7 28505.0 28597.4 28629.4 28637.7 2604.4 2624.6 2686.9 2757.4 2765.9 434895.0 508229.0 510542.0 511246.0 512155.4 67292.3 67549.0 68073.0 68129.0 68282.7 73167.3 73384.0 73479.0 73549.9 73596.3 16834.3 17004.0 17035.6 17052.9 17058.0 12958.2 13002.9 13035.3 13045.5 13074.7 20861.0 21536.7 22024.7 22026.7 22048.2 6780.0 7934.1 8480.9 8942.1 9157.0 922.8 962.9 1000.3 1000.3 1054.0 21293.8 26390.1 28254.0 28528.4 29011.3 1106.8 1121.5 1137.6 1143.4 1164.5 14359.3 14939.3 14961.6 15022.7 15079.0 1004493.0 1006633.0 1006867.0 1007113.0 1010738.0 49692.5 62687.7 62735.0 62921.0 62981.4 1369.7 1401.5 1511.2 1531.9 1647.8 21798.9 24172.8 28432.0 29295.9 29611.3 45497.0 49028.0 49872.0 49898.3 50058.7 402540.0 404623.0 405006.0 405302.0 405757.0 27745.7 31369.7 32198.7 32614.8 32683.3 35019.8 39791.0 40323.0 40550.8 41409.4 31747.2 37946.6 38915.8 39556.2 40460.4 35864.8 36008.6 36137.8 36874.3 36906.7 34192.5 36592.8 37311.4 37550.0 37553.2 31302.8 32800.7 32860.5 32894.7 32898.5 23953.3 24301.8 24515.9 24892.8 25328.0 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34154.60 Median:13199.67 stddev:102993.79 (780.3%) stddev-sans-first:103251.42 21:20:38 INFO - PROCESS | 1659 | Values: 339.6 341.9 358.8 364.1 364.4 19417.1 19924.8 20279.4 20724.9 20734.5 19044.0 19438.8 20037.9 20069.6 20090.6 5700.2 5846.4 5902.3 5908.3 5913.3 4192.2 4403.8 5873.7 6160.6 6460.7 6398.0 6401.2 6405.3 6407.4 6414.3 5516.3 6185.3 6501.9 6508.5 6511.6 3711.0 4355.7 5511.9 5516.5 5576.5 24113.9 24394.8 24639.5 25147.2 25440.4 2156.1 2239.9 2242.1 2256.0 2285.5 14288.9 14705.3 14949.9 15087.9 15316.5 1689.3 1703.5 1705.7 1739.0 1740.4 100947.0 104836.0 105760.0 105760.0 105804.9 8410.8 9837.2 10006.7 10239.6 10291.5 12626.6 12669.5 12706.2 12716.0 12719.3 6920.8 8308.6 8354.8 8385.2 8386.8 7059.8 8669.7 8684.8 8760.9 8807.6 5394.9 5473.0 6014.7 6036.2 6115.8 1649.1 1727.8 1728.9 1729.1 1786.7 735.0 845.4 963.9 990.7 1075.7 20505.7 21227.4 21364.5 21444.6 21491.9 957.6 968.4 970.6 1009.3 1048.3 9231.3 10094.3 11129.7 11540.9 11621.0 567746.0 623428.0 632013.0 644868.8 646018.0 104113.5 109094.5 111040.0 111180.4 112394.4 1034.8 1071.1 1073.2 1094.8 1096.9 14393.0 16047.2 18383.6 19396.7 20427.5 45053.8 47152.6 47701.0 48225.3 50210.0 49868.8 65264.0 65284.7 65520.0 65735.0 7559.0 7623.0 7892.8 7900.5 8034.0 11847.7 12280.9 12399.3 12694.0 12853.2 9971.2 10838.1 10999.5 11026.4 11045.7 8381.2 10270.4 10445.7 10965.0 11067.3 11095.5 11264.7 11334.8 11341.8 11549.1 7668.5 7778.1 7794.8 7869.0 8067.3 8227.2 9921.4 11043.4 11314.8 11334.8 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5980.94 Median:5371.15 stddev:3105.01 (57.8%) stddev-sans-first:3094.71 21:20:38 INFO - PROCESS | 1659 | Values: 1409.7 1565.6 1584.7 1831.8 1978.0 7315.2 7885.8 8559.2 8714.7 8740.1 8386.0 8637.9 8651.3 8656.4 8657.7 1908.4 2297.6 2359.7 2432.6 2440.4 2454.0 2461.0 2461.7 2463.0 2463.5 2380.5 2401.1 2421.9 2424.6 2429.3 2401.3 2408.2 2414.4 2455.7 2455.7 2362.2 2393.5 2437.8 2441.2 2452.7 8757.4 8841.3 8843.8 8856.8 8874.3 5359.5 5492.9 5493.3 5495.1 5504.8 3526.8 3593.6 3666.7 3673.8 3696.9 1026.8 1036.8 1042.5 1049.7 1058.1 11708.9 11743.4 11744.8 11753.4 11756.7 4743.7 4789.7 4811.0 4821.8 4859.4 9757.3 10029.3 10037.3 10052.1 10075.6 5275.9 5284.0 5382.8 5392.2 5401.9 4354.7 4532.7 4726.1 4872.4 4875.0 3755.8 3831.0 3847.7 3861.2 3900.3 1305.1 1307.1 1308.8 1315.3 1317.5 1365.2 1383.7 1404.4 1409.3 1410.3 8164.3 8341.0 8386.4 8413.8 8429.0 1118.4 1153.8 1219.8 1220.6 1228.7 6269.5 6271.5 6322.8 6337.7 6338.9 10016.2 10316.1 10440.6 10471.1 10539.7 9878.7 10425.1 10472.6 10512.4 10516.3 7964.4 8146.0 8175.8 8184.5 8204.2 6416.6 7839.0 7917.0 7976.6 8017.9 8942.7 9162.3 9176.4 9365.0 9385.4 8721.4 8903.0 9379.3 9532.6 9534.6 6723.0 6905.0 6906.2 7303.5 7427.2 7339.3 8186.6 8266.4 8288.5 8292.3 7303.1 7356.7 7366.8 7535.7 7537.7 7248.9 7358.2 7413.4 7442.3 7489.4 7756.5 7764.4 7818.9 7829.8 7830.2 7013.5 7042.3 7086.5 7098.4 7101.7 7118.3 7133.1 7166.8 7180.1 7196.0 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:5707.84 Median:6507.17 stddev:1818.08 (27.9%) stddev-sans-first:1777.66 21:20:38 INFO - PROCESS | 1659 | Values: 320.9 327.0 330.1 330.6 335.2 6488.4 6520.8 6566.2 6575.6 6644.9 6447.4 6501.6 6505.4 6525.5 6527.0 4632.2 4697.6 4761.7 4840.4 4869.1 4121.9 4787.7 4804.6 4805.0 4816.3 4720.0 4735.6 4740.7 4800.7 4800.9 4527.3 4651.2 4732.2 4732.9 4736.7 4079.9 4080.7 4085.2 4093.8 4103.3 6164.9 6247.1 6262.0 6288.0 6289.3 5623.0 5625.1 5632.9 5634.4 5648.6 6862.2 6880.9 6882.8 6893.0 6907.1 4581.0 4648.6 4663.2 4663.2 4690.1 6272.6 7150.1 7203.3 7313.3 7326.7 4718.5 4719.4 4725.9 4732.0 4732.5 4785.6 4793.3 4793.6 4797.9 4806.7 5648.9 5650.4 5657.4 5661.8 5667.3 6683.5 6949.5 6965.1 6972.5 6976.5 1385.3 1652.5 1659.1 1675.9 1677.8 1026.0 1058.2 1077.1 1086.8 1112.4 6362.2 6512.3 6534.0 6543.1 6547.6 7238.8 7262.3 7268.7 7277.9 7289.5 6508.9 6524.9 6528.9 6531.0 6537.3 3107.4 3800.9 3849.0 3849.3 3854.0 5753.3 6186.3 6406.8 7524.8 7647.3 7501.3 7565.1 7565.3 7575.8 7591.4 7589.9 7600.5 7623.2 7626.8 7631.9 7034.1 7305.0 7308.0 7316.3 7340.5 7163.0 7193.0 7197.0 7202.9 7219.2 7585.0 7616.8 7619.0 7624.3 7627.2 4544.3 4594.7 4594.8 4603.9 4609.5 5971.5 6997.3 7283.5 7284.2 7313.7 6998.9 7030.2 7030.3 7032.5 7038.7 6918.0 7008.4 7017.2 7020.2 7030.9 5920.5 6883.2 6884.0 6888.0 6891.2 6737.5 7013.3 7029.2 7040.3 7045.5 6551.9 6674.5 6677.8 6798.5 6876.3 21:20:38 INFO - PROCESS | 1659 | 21:20:38 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:18467.58 Median:626.66 stddev:26181.39 (4178.0%) stddev-sans-first:26220.75 21:20:38 INFO - PROCESS | 1659 | Values: 676.6 681.5 694.5 749.1 772.7 14828.9 17772.6 18093.4 18095.2 18118.9 13188.0 16436.6 16482.6 16550.0 16571.0 739.9 908.9 923.3 927.3 927.8 747.0 913.0 926.6 930.4 930.9 969.4 977.0 977.1 980.5 980.5 780.5 940.6 971.8 973.1 974.3 713.8 714.6 714.7 717.0 717.4 15307.3 15433.8 15436.2 15439.2 15471.3 12329.6 12452.0 12587.9 12672.2 12865.2 9767.0 9914.9 9935.3 10023.5 10319.5 3426.9 3481.4 3495.5 3525.4 3684.4 82486.0 82611.6 82662.2 82697.2 83606.2 8717.8 9225.6 9226.0 9351.6 9949.5 19093.3 21205.8 21266.6 21278.8 21293.0 7232.3 7385.4 7485.4 7555.5 7626.7 4037.9 4103.0 4113.3 4116.2 4117.2 3343.1 3389.3 3390.2 3390.9 3399.7 618.2 619.1 623.0 630.3 631.3 511.6 527.3 555.0 561.7 607.1 8069.4 8133.2 8133.4 8240.3 8317.7 559.7 589.8 595.4 597.9 603.2 3728.3 3794.7 3820.5 3949.5 4021.1 95954.0 96096.0 96150.5 96914.5 97921.0 82109.6 82779.0 83645.6 83707.0 83759.6 65755.0 65918.0 66492.7 67754.6 69489.6 7759.3 7796.9 7853.7 7919.6 8086.4 48841.8 48869.3 49053.0 50989.2 51729.7 49605.8 58557.7 67667.0 67964.3 72602.3 10986.2 11075.9 11086.8 11165.2 11538.3 11008.7 11443.4 12033.5 12151.3 12250.0 9786.3 11391.5 11737.6 11748.3 11939.0 10415.6 10769.2 10773.8 11397.3 12496.8 10925.3 10976.0 11075.8 11141.9 12177.4 9362.5 9371.4 9392.7 9462.3 9865.1 8839.5 8867.7 9096.4 9501.8 9518.5 21:20:38 INFO - PROCESS | 1659 | -------- Summary: end -------- 21:20:38 INFO - PROCESS | 1659 | 21:20:39 INFO - TEST-INFO | 1659: exit 0 21:20:39 INFO - TEST-OK | dromaeo_css | took 1112441ms 21:20:39 INFO - TEST-START | kraken 21:20:39 INFO - operating with platform_type : mac_ 21:20:39 INFO - Initialising browser for kraken test... 21:20:39 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpsFZJYl/profile http://localhost:49276/getInfo.html) 21:20:41 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 21:20:41 INFO - PROCESS | 1669 | colorDepth:24 21:20:41 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 21:20:41 INFO - PROCESS | 1669 | __metrics 21:20:41 INFO - PROCESS | 1669 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:20:41 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:20:41 INFO - TEST-INFO | 1669: exit 0 21:20:41 INFO - Browser initialized. 21:20:41 INFO - Running cycle 1/1 for kraken test... 21:20:41 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/T/tmpsFZJYl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:20:54 INFO - PROCESS | 1671 | RSS: Main: 243970048 21:20:54 INFO - PROCESS | 1671 | 21:20:56 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 21:20:57 INFO - PROCESS | 1671 | RSS: Main: 289898496 21:20:57 INFO - PROCESS | 1671 | 21:21:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 21:21:00 INFO - PROCESS | 1671 | RSS: Main: 300453888 21:21:00 INFO - PROCESS | 1671 | 21:21:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 21:21:04 INFO - PROCESS | 1671 | RSS: Main: 285691904 21:21:04 INFO - PROCESS | 1671 | 21:21:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 21:21:07 INFO - PROCESS | 1671 | RSS: Main: 288718848 21:21:07 INFO - PROCESS | 1671 | 21:21:09 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:21:09 INFO - PROCESS | 1671 | RSS: Main: 289882112 21:21:09 INFO - PROCESS | 1671 | 21:21:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 21:21:13 INFO - PROCESS | 1671 | RSS: Main: 290861056 21:21:13 INFO - PROCESS | 1671 | 21:21:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 21:21:16 INFO - PROCESS | 1671 | RSS: Main: 290201600 21:21:16 INFO - PROCESS | 1671 | 21:21:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 21:21:19 INFO - PROCESS | 1671 | RSS: Main: 290562048 21:21:19 INFO - PROCESS | 1671 | 21:21:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:21:22 INFO - PROCESS | 1671 | RSS: Main: 325156864 21:21:22 INFO - PROCESS | 1671 | 21:21:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:21:24 INFO - PROCESS | 1671 | RSS: Main: 323346432 21:21:24 INFO - PROCESS | 1671 | 21:21:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:21:27 INFO - PROCESS | 1671 | RSS: Main: 330764288 21:21:27 INFO - PROCESS | 1671 | 21:21:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:21:30 INFO - PROCESS | 1671 | RSS: Main: 332673024 21:21:30 INFO - PROCESS | 1671 | 21:21:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:21:33 INFO - PROCESS | 1671 | RSS: Main: 331988992 21:21:33 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 21:21:35 INFO - PROCESS | 1671 | RSS: Main: 394432512 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | __start_tp_report 21:21:35 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 21:21:35 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 21:21:35 INFO - PROCESS | 1671 | |i|pagename|runs| 21:21:35 INFO - PROCESS | 1671 | |0;ai-astar;110;108;111;109;112;111;116;118;163;160 21:21:35 INFO - PROCESS | 1671 | |1;audio-beat-detection;144;122;140;156;121;141;139;121;160;116 21:21:35 INFO - PROCESS | 1671 | |2;audio-dft;184;184;184;184;182;186;182;184;184;184 21:21:35 INFO - PROCESS | 1671 | |3;audio-fft;78;75;83;79;56;58;58;79;79;56 21:21:35 INFO - PROCESS | 1671 | |4;audio-oscillator;97;131;174;103;78;80;116;78;76;119 21:21:35 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;85;88;85;88;84;88;85;87;86 21:21:35 INFO - PROCESS | 1671 | |6;imaging-darkroom;94;94;93;95;93;94;95;95;94;94 21:21:35 INFO - PROCESS | 1671 | |7;imaging-desaturate;85;87;86;101;137;145;86;87;86;88 21:21:35 INFO - PROCESS | 1671 | |8;json-parse-financial;55;53;55;54;54;56;55;64;56;53 21:21:35 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;65;66;83;79;73;82;103;105;89;71 21:21:35 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;84;97;111;109;84;82;83;83;87;85 21:21:35 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;121;122;125;122;134;119;120;125;116;134 21:21:35 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;140;130;140;140;140;140;143;177;178;159 21:21:35 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;68;67;67;67;67;67;68;67;66 21:21:35 INFO - PROCESS | 1671 | __end_tp_report 21:21:35 INFO - PROCESS | 1671 | __start_cc_report 21:21:35 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1288 21:21:35 INFO - PROCESS | 1671 | __end_cc_report 21:21:35 INFO - PROCESS | 1671 | __startTimestamp1458966095892__endTimestamp 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | ------- Summary: start ------- 21:21:35 INFO - PROCESS | 1671 | Number of tests: 14 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:121.80 Median:114.00 stddev:21.15 (18.6%) stddev-sans-first:22.00 21:21:35 INFO - PROCESS | 1671 | Values: 110.0 108.0 111.0 109.0 112.0 111.0 116.0 118.0 163.0 160.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:140.50 stddev:15.41 (11.0%) stddev-sans-first:16.07 21:21:35 INFO - PROCESS | 1671 | Values: 144.0 122.0 140.0 156.0 121.0 141.0 139.0 121.0 160.0 116.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.14 (0.6%) stddev-sans-first:1.20 21:21:35 INFO - PROCESS | 1671 | Values: 184.0 184.0 184.0 184.0 182.0 186.0 182.0 184.0 184.0 184.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:70.10 Median:78.50 stddev:11.45 (14.6%) stddev-sans-first:11.79 21:21:35 INFO - PROCESS | 1671 | Values: 78.0 75.0 83.0 79.0 56.0 58.0 58.0 79.0 79.0 56.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:77.00 stddev:31.17 (40.5%) stddev-sans-first:32.92 21:21:35 INFO - PROCESS | 1671 | Values: 97.0 131.0 174.0 103.0 78.0 80.0 116.0 78.0 76.0 119.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 21:21:35 INFO - PROCESS | 1671 | Values: 88.0 85.0 88.0 85.0 88.0 84.0 88.0 85.0 87.0 86.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 21:21:35 INFO - PROCESS | 1671 | Values: 94.0 94.0 93.0 95.0 93.0 94.0 95.0 95.0 94.0 94.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:86.00 stddev:22.79 (26.5%) stddev-sans-first:23.62 21:21:35 INFO - PROCESS | 1671 | Values: 85.0 87.0 86.0 101.0 137.0 145.0 86.0 87.0 86.0 88.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.17 (5.8%) stddev-sans-first:3.36 21:21:35 INFO - PROCESS | 1671 | Values: 55.0 53.0 55.0 54.0 54.0 56.0 55.0 64.0 56.0 53.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:81.60 Median:76.00 stddev:14.04 (18.5%) stddev-sans-first:13.55 21:21:35 INFO - PROCESS | 1671 | Values: 65.0 66.0 83.0 79.0 73.0 82.0 103.0 105.0 89.0 71.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:84.00 stddev:11.14 (13.3%) stddev-sans-first:11.56 21:21:35 INFO - PROCESS | 1671 | Values: 84.0 97.0 111.0 109.0 84.0 82.0 83.0 83.0 87.0 85.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:123.50 stddev:6.00 (4.9%) stddev-sans-first:6.27 21:21:35 INFO - PROCESS | 1671 | Values: 121.0 122.0 125.0 122.0 134.0 119.0 120.0 125.0 116.0 134.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:141.50 stddev:16.75 (11.8%) stddev-sans-first:17.47 21:21:35 INFO - PROCESS | 1671 | Values: 140.0 130.0 140.0 140.0 140.0 140.0 143.0 177.0 178.0 159.0 21:21:35 INFO - PROCESS | 1671 | 21:21:35 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 21:21:35 INFO - PROCESS | 1671 | Values: 68.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 66.0 21:21:35 INFO - PROCESS | 1671 | -------- Summary: end -------- 21:21:35 INFO - PROCESS | 1671 | 21:21:36 INFO - TEST-INFO | 1671: exit 0 21:21:36 INFO - TEST-OK | kraken | took 57550ms 21:21:36 INFO - SUITE-END | took 1169s 21:21:37 INFO - Completed test suite (00:19:30) 21:21:37 INFO - javascript benchmark 21:21:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3225.6935591118845, 3367.3770352484794, 3413.0102270341604, 3428.1772374630095, 3490.9650903490956, 5396.973015134919, 5399.271098401715, 5404.189371594262, 5434.0, 5450.236966824637, 5427.538659213971, 5462.962037212927, 5463.836084917449, 5469.234307196995, 5471.425500322469, 4995.375578052734, 5006.624503162259, 5033.974830125844, 5094.643374963735, 5095.3885533736, 5044.798208071673, 5093.949060509403, 5105.463926287742, 5106.029854327684, 5111.897762044757, 5020.723860187688, 5066.1387564114, 5089.185730283156, 5090.338256026711, 5099.617528685363, 5024.4724303948105, 5081.415637201732, 5090.49095090488, 5092.898142037157, 5099.566536844372, 4950.2079667253065, 4953.727544985024, 5019.447860735316, 5025.422076461217, 5060.645754797166, 5327.121025030865, 5339.786408543654, 5343.679379237258, 5376.11294136467, 5439.456054394529, 5869.148973398876, 5884.146798714162, 5887.8233652990475, 5901.2918449785875, 5902.3507414184405, 5855.590108692393, 5905.43898329658, 5977.7608895644125, 5979.760809567612, 6064.4541991221, 5529.751161197715, 5532.7786888524815, 5534.1975413564805, 5547.1124620061, 5569.303837020372, 6087.299960504599, 6145.262568491809, 6151.0773383992755, 6162.938370616326, 6172.321044685081, 5100.673824805577, 5528.308961379827, 5764.538836893039, 5788.247527821356, 5796.536277097822, 5985.371535988746, 5988.131720900532, 5994.67029313392, 6010.759569617167, 6015.488683461867, 4968.22992436173, 5863.765449381977, 5887.970560147258, 5897.970510147507, 5906.143609176645, 5806.622569532967, 5886.440788125121, 5916.437938395931, 5921.585489015728, 5927.911081333784, 3997.200559888034, 4696.9060618787435, 4743.02767932573, 4786.305985632133, 4792.017636384533, 4266.701330906869, 4312.223799716018, 4314.827406903752, 4340.045190058182, 4340.218760623118, 5231.346081739783, 5390.380106287748, 5423.972880135574, 5458.4814442627885, 5466.01611709896, 5941.37615550361, 5999.880002399927, 6014.6391216527145, 6046.667433291212, 6066.393360663898, 5401.135818269058, 5427.864303392368, 5451.781928722886, 5452.700101494456, 5452.836414907559, 5079.034983353151, 5167.9224811627855, 5181.481851814789, 5190.11767999441, 5231.529162375328, 6146.0473626587955, 6249.6562689051625, 6251.718672659832, 6276.497880169484, 6285.182926219653, 5933.940660593512, 5952.813428416359, 5966.731497082555, 5971.104334349882, 6023.789167379121, 6128.571000029955, 6166.938330616636, 6193.535484838745, 6238.563300568917, 6255.59338643005, 5791.102379131242, 5852.5317974561085, 5859.619124756877, 5885.911711324248, 5897.616654917417, 5787.768489260551, 5894.941050589439, 5935.525157987265, 5957.3744756799915, 5958.285005799332, 5666.575006874418, 5712.771489140554, 5787.508061814793, 5798.5651076168615, 5799.246098007232, 5738.856528586819, 5759.884802304015, 5765.7117144141785, 5777.74000169985, 5793.217915581343, 5620.100783874561, 5646.491815736604, 5662.915056274242, 5665.065264231355, 5674.06377947634, 5578.497935185853, 5710.771569137188, 5750.539956803362, 5792.102224155263, 5826.70866456684, 5227.477252274742, 5255.500727430888, 5681.602287839812, 5690.345610254708, 5697.173909782975], "unit": "score", "name": "dojo.html", "value": 5454.38004057848}, {"lowerIsBetter": false, "replicates": [467.15445044469493, 549.9340079190498, 576.785865752591, 611.2533058300885, 626.3141859663667, 30295.09114726559, 38768.0, 38978.99999999996, 39000.80499597498, 39204.60795392045, 41665.7916710416, 42337.57662423375, 42361.57638423615, 42373.78813105938, 42379.0, 9470.195033422167, 9700.660476883311, 9719.708408747749, 9725.173360264385, 9727.124558789708, 9520.523973801317, 9676.322657413984, 9695.515224238796, 9700.75748106296, 9708.077732615391, 9613.711588652352, 9797.902020979805, 9866.802663946717, 9877.70366888991, 9894.703158905244, 9744.56149473272, 9845.852312215322, 9849.60601575936, 9864.457454839981, 9864.65473708424, 9579.13787759105, 9751.853722194173, 9756.951215243878, 9758.316917815755, 9783.608655653836, 40366.59633403658, 40847.79576102101, 40959.7952010241, 40985.97535061647, 41011.7949410254, 2617.6073588961617, 3313.9005829825146, 3386.9830650846834, 3463.3939060664534, 3775.9284560924107, 27068.729312707015, 28505.0, 28597.428051438856, 28629.427411451656, 28637.71362286392, 2604.361931326818, 2624.593188055854, 2686.9462610747673, 2757.4347258812095, 2765.8893644254204, 434895.0, 508229.0, 510542.0, 511246.0, 512155.4392228015, 67292.32707672959, 67549.0, 68073.0, 68129.0, 68282.65858670774, 73167.26832731605, 73384.0, 73479.0, 73549.89675154877, 73596.26403736002, 16834.326626934784, 17004.0, 17035.574110647332, 17052.914735426242, 17058.0, 12958.22250664963, 13002.869971300355, 13035.348232588332, 13045.543405980934, 13074.738505229841, 20861.0, 21536.676949845765, 22024.687407822268, 22026.669599956014, 22048.228312009003, 6779.966100169468, 7934.087579928267, 8480.872786908078, 8942.105789421135, 9156.954215228881, 922.7693076730817, 962.9455745958164, 1000.2548101664162, 1000.3197825478599, 1054.0355574649263, 21293.78706212918, 26390.076347328137, 28254.0, 28528.429431411256, 29011.274718132216, 1106.8450416941635, 1121.5177473686392, 1137.635956493914, 1143.3654321851286, 1164.4643464006483, 14359.282035898163, 14939.25303734809, 14961.625959351104, 15022.699546009237, 15079.019863708823, 1004493.0, 1006633.0, 1006867.0, 1007113.0, 1010738.0, 49692.50307496951, 62687.6865615669, 62735.0, 62921.0, 62981.37018629755, 1369.705513314642, 1401.5234820161195, 1511.2443778110944, 1531.9387224510895, 1647.7775500307546, 21798.891005544872, 24172.758272417756, 28432.0, 29295.85352073226, 29611.259718507208, 45497.0, 49028.0, 49872.002559949324, 49898.251526226406, 50058.74853128701, 402540.0, 404623.0, 405006.0, 405302.0, 405756.97121514205, 27745.722542774314, 31369.686303136677, 32198.678013220506, 32614.83692581522, 32683.34633307368, 35019.774307899104, 39791.0, 40323.0, 40550.797246014765, 41409.37885931774, 31747.206319841265, 37946.62053379431, 38915.80542097271, 39556.2088758229, 40460.3930941042, 35864.82067589645, 36008.63991360053, 36137.81931090433, 36874.26251474902, 36906.70826521059, 34192.487112692834, 36592.81703591465, 37311.44032839455, 37550.0, 37553.24893502169, 31302.843485782425, 32800.68797248083, 32860.50709239411, 32894.67105328916, 32898.5065224017, 23953.26290117795, 24301.75698242995, 24515.877420612782, 24892.75107248977, 25328.0], "unit": "score", "name": "ext.html", "value": 20107.373932299004}, {"lowerIsBetter": false, "replicates": [339.6109910466194, 341.92135808764, 358.84928330101354, 364.0589077235347, 364.40056107702827, 19417.126229319678, 19924.800751992494, 20279.39161825146, 20724.896375518103, 20734.48163795906, 19044.047797610132, 19438.805611943877, 20037.899810500963, 20069.59860802783, 20090.59818803623, 5700.230468886699, 5846.444587764156, 5902.2622172228475, 5908.320543137551, 5913.3199682036475, 4192.203481338551, 4403.801828917706, 5873.676947767871, 6160.599561028541, 6460.741570337181, 6397.968010159942, 6401.231852177745, 6405.29541750407, 6407.359264073602, 6414.294427612959, 5516.282883225155, 6185.257769067718, 6501.902471462932, 6508.54440189187, 6511.641859697715, 3711.0351308659674, 4355.651547876162, 5511.889762204733, 5516.475934786189, 5576.498115169654, 24113.87943060291, 24394.756052439425, 24639.507209855703, 25147.24558263255, 25440.363990900376, 2156.105216335219, 2239.9328020159423, 2242.125571027301, 2256.0, 2285.451491641994, 14288.85711142896, 14705.26473676312, 14949.906774394034, 15087.868409869194, 15316.540503784905, 1689.3496004038534, 1703.4804384662673, 1705.7270836666073, 1738.9913050434793, 1740.3995621510558, 100946.9905300945, 104836.0, 105760.0, 105760.0, 105804.94195058028, 8410.789730256793, 9837.163841073589, 10006.749831254278, 10239.590416383262, 10291.485425728684, 12626.621201363974, 12669.493220271086, 12706.237625742486, 12716.0, 12719.300438475973, 6920.826979325457, 8308.626111824862, 8354.8329033419, 8385.245327920395, 8386.8322633547, 7059.788206353817, 8669.739907802776, 8684.782880427914, 8760.91239087601, 8807.559622018873, 5394.9460505394445, 5473.042217611902, 6014.72933717975, 6036.215292012098, 6115.755369785159, 1649.1342045426247, 1727.8143148916631, 1728.887622304546, 1729.0835856995811, 1786.7051936430344, 735.0224201811578, 845.4082142500274, 963.9084286992725, 990.7473594233569, 1075.666173944319, 20505.657214694897, 21227.36317910465, 21364.465888352606, 21444.57110857774, 21491.897282473197, 957.6456711016829, 968.4044312747609, 970.5729479029204, 1009.2985375164337, 1048.3028785857318, 9231.261499080058, 10094.293399461967, 11129.666110016713, 11540.94229528847, 11621.0, 567746.0, 623428.0, 632013.0, 644868.7756561281, 646018.0, 104113.47943260235, 109094.45452772843, 111040.0, 111180.444097779, 112394.43802780933, 1034.7930413917247, 1071.062820032456, 1073.2219141122623, 1094.8248280275277, 1096.9012788849043, 14392.98000698044, 16047.19764011818, 18383.632327353647, 19396.709049364552, 20427.4893127673, 45053.774731126134, 47152.58542243738, 47701.0, 48225.27662085001, 50210.0, 49868.76115530221, 65264.0, 65284.673576631816, 65520.0, 65735.0, 7558.962205188939, 7622.961885190539, 7892.802679933047, 7900.486468379537, 8033.955585773812, 11847.703807404883, 12280.938595306967, 12399.318037508023, 12694.047946404242, 12853.16454430459, 9971.217719527169, 10838.13294936419, 10999.450027498433, 11026.393548354597, 11045.668629941114, 8381.203785640355, 10270.383776973405, 10445.738856528647, 10964.958328958735, 11067.335959842436, 11095.50070246857, 11264.718382040515, 11334.773304533699, 11341.829872552084, 11549.076073914235, 7668.501547399401, 7778.088373300295, 7794.805129871798, 7869.0, 8067.3142782864115, 8227.218414250636, 9921.40471571708, 11043.447827608426, 11314.773704526027, 11334.773304534028], "unit": "score", "name": "jquery.html", "value": 9343.780342015749}, {"lowerIsBetter": false, "replicates": [1409.7321508913312, 1565.6477292609165, 1584.7305957987141, 1831.8259765322298, 1977.9604407911843, 7315.231900650435, 7885.80285492863, 8559.186877246659, 8714.651413943435, 8740.082291359404, 8385.958070209655, 8637.91362086379, 8651.30789536837, 8656.43733157346, 8657.69698060568, 1908.3797765726124, 2297.621427143709, 2359.740428552858, 2432.5864603017485, 2440.3533063738123, 2453.9631905521433, 2460.9507809843794, 2461.692288463942, 2463.0, 2463.470353873917, 2380.47629521505, 2401.1475926046264, 2421.927342179729, 2424.5756992526326, 2429.2712186344024, 2401.3156250468533, 2408.1932552594903, 2414.384331995339, 2455.6739360745178, 2455.693038370204, 2362.173239366225, 2393.4854006388537, 2437.7562243775483, 2441.2310122311414, 2452.730199678034, 8757.430767000125, 8841.336899732545, 8843.823123537557, 8856.778580535474, 8874.334424918157, 5359.464053594648, 5492.945070549284, 5493.285872836545, 5495.120780675073, 5504.80733174337, 3526.841292141834, 3593.586737525192, 3666.7433279670436, 3673.761205521659, 3696.85212591496, 1026.7587117027567, 1036.7563622548696, 1042.5100202904623, 1049.7375656085978, 1058.1270451877156, 11708.941455292754, 11743.354115523643, 11744.823827642593, 11753.412329383496, 11756.706082347924, 4743.739094349844, 4789.706410376186, 4811.013742182844, 4821.807127714852, 4859.416869975555, 9757.26820488452, 10029.348092373972, 10037.297389182833, 10052.145567626687, 10075.59697612102, 5275.868103297372, 5284.0, 5382.838514844561, 5392.218128371364, 5401.891962160735, 4354.651627869763, 4532.682712210114, 4726.078414709167, 4872.43966943806, 4874.976254986422, 3755.8122093895195, 3830.9808450957566, 3847.6537111659527, 3861.150546879738, 3900.297946369624, 1305.0733978874916, 1307.1372893889986, 1308.8036794480904, 1315.2700251360395, 1317.4993502469001, 1365.1672479787321, 1383.674836413442, 1404.3539971612968, 1409.2530958591963, 1410.2948525737131, 8164.306033987177, 8341.0, 8386.412951093487, 8413.789655258544, 8429.0, 1118.424011634009, 1153.7865494883474, 1219.762146381447, 1220.6460126563197, 1228.6716671906686, 6269.49844012487, 6271.498280137578, 6322.841928951813, 6337.683115844189, 6338.873222535523, 10016.198704103654, 10316.123129533924, 10440.63457778974, 10471.057604815604, 10539.736506587396, 9878.654247101316, 10425.061744442884, 10472.581096756045, 10512.421816799997, 10516.26386152962, 7964.442489025829, 8145.981752281084, 8175.79560510992, 8184.508929464251, 8204.220599043081, 6416.550841441054, 7838.980932478741, 7916.960415197887, 7976.641051152828, 8017.8797318039105, 8942.73171804847, 9162.312826537904, 9176.403533770284, 9365.01667324921, 9385.436873787594, 8721.386543489474, 8903.0, 9379.34344595899, 9532.571034303335, 9534.618615255313, 6723.025161351675, 6904.998775177471, 6906.205786334636, 7303.525270857377, 7427.2201418850245, 7339.302766237199, 8186.590670466334, 8266.421350505407, 8288.544130072903, 8292.33661307106, 7303.087114110736, 7356.742514011984, 7366.815829604303, 7535.6985720570565, 7537.736179233701, 7248.939530910033, 7358.227386124594, 7413.443991700537, 7442.330190282684, 7489.438292128221, 7756.457048006585, 7764.417668674759, 7818.92181078182, 7829.804254893673, 7830.177831327856, 7013.473989450709, 7042.295770422917, 7086.539374940612, 7098.396636285767, 7101.680424380812, 7118.323759242864, 7133.072700548895, 7166.820829479305, 7180.138383394026, 7195.964020179866], "unit": "score", "name": "mootools.html", "value": 4908.169267841639}, {"lowerIsBetter": false, "replicates": [320.92618697699527, 326.95259187417827, 330.1416317574306, 330.63795144316964, 335.1888429999403, 6488.44848187904, 6520.804375868725, 6566.179227596551, 6575.605463672183, 6644.867102657944, 6447.419732224111, 6501.642409667466, 6505.4145126938565, 6525.543211975164, 6527.0, 4632.166210082184, 4697.5772180503745, 4761.690490118149, 4840.370751802261, 4869.123557759602, 4121.855735049274, 4787.688800227974, 4804.639652026094, 4804.975975120119, 4816.349792777983, 4720.0, 4735.621150307984, 4740.715557066587, 4800.711957282557, 4800.90398192036, 4527.343535187396, 4651.162790697673, 4732.219183834663, 4732.881677958078, 4736.692115012547, 4079.8572049978106, 4080.6939479539155, 4085.22380747657, 4093.774842383668, 4103.343465045608, 6164.938350616526, 6247.125402443661, 6262.029385445263, 6288.025356069817, 6289.308176100625, 5623.015972204888, 5625.128105143709, 5632.887342253132, 5634.352049514277, 5648.576356773258, 6862.245153033163, 6880.931190688079, 6882.827929301758, 6893.0, 6907.067545881292, 4580.9770951145365, 4648.628109751246, 4663.2305669564485, 4663.2305669564485, 4690.0854333405, 6272.6236425814595, 7150.141982962025, 7203.315685009916, 7313.305236002571, 7326.670299836467, 4718.504557021532, 4719.362886010414, 4725.929111063337, 4731.976340118277, 4732.455767586703, 4785.641076919245, 4793.281007848851, 4793.616510679138, 4797.904041919142, 4806.663533552618, 5648.85877853057, 5650.4349565043985, 5657.43425657431, 5661.7735290588735, 5667.3482549507335, 6683.498737594603, 6949.548279361826, 6965.094537710065, 6972.51192416526, 6976.51164418496, 1385.3350391811784, 1652.4877288040504, 1659.1372486307052, 1675.8575521080602, 1677.7986641603086, 1025.9692209233735, 1058.1799105693149, 1077.0790973717515, 1086.7826434713088, 1112.3881864974232, 6362.204724409449, 6512.316206798313, 6534.0, 6543.051257567626, 6547.607143571306, 7238.819029524304, 7262.31008054234, 7268.709251629875, 7277.89083163753, 7289.453291003196, 6508.9349106508325, 6524.934750652433, 6528.869422611521, 6531.0, 6537.313582073909, 3107.440660681054, 3800.9049773755323, 3849.018500282466, 3849.268638958589, 3854.0, 5753.252077229933, 6186.257649082049, 6406.775762848278, 7524.849503010018, 7647.273509016634, 7501.324880760758, 7565.092188937363, 7565.319121279112, 7575.772726818204, 7591.3547348475995, 7589.8861517077285, 7600.467967242351, 7623.161452240138, 7626.809329766689, 7631.885521717179, 7034.120734908137, 7304.96347518259, 7307.9634601828775, 7316.268373162641, 7340.522866013692, 7163.0, 7192.96403518, 7196.992421060951, 7202.855942881218, 7219.169795473587, 7585.0, 7616.771496855104, 7619.009528761448, 7624.27569380908, 7627.199144090013, 4544.341070544819, 4594.7243165408845, 4594.8391806287955, 4603.861884143481, 4609.51600082, 5971.462568368867, 6997.300269972962, 7283.526570772883, 7284.235155308828, 7313.744018959311, 6998.860022799618, 7030.156381234285, 7030.2969703029285, 7032.542884712478, 7038.718451261892, 6917.965410172917, 7008.369246767816, 7017.228104908558, 7020.157581090302, 7030.894536582057, 5920.467157955804, 6883.208431030295, 6884.0, 6888.0, 6891.173059232924, 6737.494687898526, 7013.333733295329, 7029.226785053742, 7040.331168538981, 7045.471589630901, 6551.868962620816, 6674.532782705358, 6677.83305417349, 6798.52410331272, 6876.312368763083], "unit": "score", "name": "prototype.html", "value": 5100.40882786804}, {"lowerIsBetter": false, "replicates": [676.5940435738554, 681.4514315975638, 694.4999600287792, 749.0524486524547, 772.7102336623765, 14828.851711482896, 17772.555686107837, 18093.366732164377, 18095.18571664275, 18118.912865228096, 13188.0, 16436.589085272873, 16482.587935301624, 16550.006999580004, 16570.99999999997, 739.9112106547221, 908.8954770201412, 923.3213588012806, 927.3184209605935, 927.7680579855037, 746.9701211951516, 912.9817403651923, 926.5645146781036, 930.3859452761179, 930.8743319651828, 969.3699095587854, 976.998576459128, 977.0766625538869, 980.5146452506019, 980.5391466010964, 780.5394817057906, 940.5720397219249, 971.7619183300102, 973.0561355485167, 974.2887691984855, 713.803703981404, 714.6462501062008, 714.7426926306525, 717.0105254748466, 717.3830505765038, 15307.311170997333, 15433.768493472608, 15436.228188590525, 15439.150846703427, 15471.303791329305, 12329.555604072848, 12452.0, 12587.874121258761, 12672.23966562, 12865.228086314852, 9767.0, 9914.90085099147, 9935.304528682995, 10023.49882505879, 10319.48402579868, 3426.9314613707834, 3481.3733527964955, 3495.475678648223, 3525.4006818840858, 3684.428913518409, 82486.0, 82611.58694206491, 82662.17337826604, 82697.17302826955, 83606.16393836106, 8717.782055448537, 9225.630974761069, 9226.0, 9351.625934962662, 9949.502524873727, 19093.331733389543, 21205.78794212069, 21266.574668506542, 21278.78721212799, 21293.0, 7232.349088582053, 7385.409167266605, 7485.438592105614, 7555.471117021756, 7626.733064342832, 4037.9394309085387, 4103.035786590149, 4113.280175969194, 4116.197341518375, 4117.21772863155, 3343.147497388199, 3389.322135572895, 3390.2033022239752, 3390.9491357629654, 3399.728021758303, 618.2303032724287, 619.0806652121596, 622.9781957631552, 630.3318482408662, 631.2866460899246, 511.6188439612438, 527.343457395545, 554.9611527193058, 561.6545824318015, 607.0802733858209, 8069.394795390369, 8133.227343402367, 8133.389995750343, 8240.258376746002, 8317.662877641438, 559.6642014791092, 589.7965202005302, 595.354040865657, 597.8774351257981, 603.2241289651604, 3728.2729867675544, 3794.715396345285, 3820.522434695663, 3949.4668219790533, 4021.1354558770004, 95954.04045959591, 96096.03903961011, 96150.51924740472, 96914.51542742242, 97921.0, 82109.58945205236, 82779.0, 83645.58177209075, 83707.0, 83759.5812020936, 65755.0, 65918.0, 66492.66753666298, 67754.64490710257, 69489.61020779556, 7759.340456061298, 7796.88304675419, 7853.725119620786, 7919.643616037177, 8086.353091752763, 48841.755791220814, 48869.26696099633, 49053.0, 50989.235161471865, 51729.741351293, 49605.751971241356, 58557.70721146367, 67667.0, 67964.32035679778, 72602.27397725955, 10986.176036797113, 11075.889241107487, 11086.833697494383, 11165.16261280391, 11538.250013749079, 11008.724781880517, 11443.427828608703, 12033.45849436795, 12151.270923744603, 12249.950485244744, 9786.314957952874, 11391.487383067617, 11737.589184378507, 11748.29510229389, 11939.0, 10415.635452759117, 10769.24615276923, 10773.784524309627, 11397.316161030365, 12496.812547811609, 10925.344479331265, 10976.0, 11075.833862491907, 11141.88858111441, 12177.391130443619, 9362.485063321583, 9371.390859594105, 9392.67125650599, 9462.337636365388, 9865.06281903218, 8839.46963182211, 8867.68963086289, 9096.363254572381, 9501.762455938657, 9518.524073796421], "unit": "score", "name": "yui.html", "value": 6904.088645717012}], "name": "dromaeo_css", "value": 7494.024827905833}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 109.0, 112.0, 111.0, 116.0, 118.0, 163.0, 160.0], "unit": "score", "name": "ai-astar", "value": 121.8}, {"lowerIsBetter": true, "replicates": [144.0, 122.0, 140.0, 156.0, 121.0, 141.0, 139.0, 121.0, 160.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 136.0}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 184.0, 184.0, 182.0, 186.0, 182.0, 184.0, 184.0, 184.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 83.0, 79.0, 56.0, 58.0, 58.0, 79.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.1}, {"lowerIsBetter": true, "replicates": [97.0, 131.0, 174.0, 103.0, 78.0, 80.0, 116.0, 78.0, 76.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 85.0, 88.0, 84.0, 88.0, 85.0, 87.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 93.0, 95.0, 93.0, 94.0, 95.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 101.0, 137.0, 145.0, 86.0, 87.0, 86.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 98.8}, {"lowerIsBetter": true, "replicates": [55.0, 53.0, 55.0, 54.0, 54.0, 56.0, 55.0, 64.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 83.0, 79.0, 73.0, 82.0, 103.0, 105.0, 89.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.6}, {"lowerIsBetter": true, "replicates": [84.0, 97.0, 111.0, 109.0, 84.0, 82.0, 83.0, 83.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.5}, {"lowerIsBetter": true, "replicates": [121.0, 122.0, 125.0, 122.0, 134.0, 119.0, 120.0, 125.0, 116.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [140.0, 130.0, 140.0, 140.0, 140.0, 140.0, 143.0, 177.0, 178.0, 159.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1463.5}]} 21:21:37 INFO - Return code: 0 21:21:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:21:37 ERROR - # TBPL SUCCESS # 21:21:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:21:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:21:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:21:37 INFO - 2016-03-25 21:21:37.220 screenresolution[1675:9647] starting screenresolution argv=screenresolution get 21:21:37 INFO - 2016-03-25 21:21:37.223 screenresolution[1675:9647] Display 0: 1600x1200x32@60 21:21:37 INFO - 2016-03-25 21:21:37.229 screenresolution[1676:9650] starting screenresolution argv=screenresolution list 21:21:37 INFO - Available Modes on Display 0 21:21:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:21:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:21:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:21:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:21:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:21:37 INFO - Intel Iris: 21:21:37 INFO - Chipset Model: Intel Iris 21:21:37 INFO - Type: GPU 21:21:37 INFO - Bus: Built-In 21:21:37 INFO - VRAM (Dynamic, Max): 1536 MB 21:21:37 INFO - Vendor: Intel (0x8086) 21:21:37 INFO - Device ID: 0x0a2e 21:21:37 INFO - Revision ID: 0x0009 21:21:37 INFO - Displays: 21:21:37 INFO - Display: 21:21:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:21:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:21:37 INFO - Display Serial Number: 1600x1200 60 21:21:37 INFO - Main Display: Yes 21:21:37 INFO - Mirror: Off 21:21:37 INFO - Online: Yes 21:21:37 INFO - Rotation: Supported 21:21:37 INFO - Return code: 0 21:21:37 INFO - Running post-action listener: _resource_record_post_action 21:21:37 INFO - Running post-run listener: _resource_record_post_run 21:21:38 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39339520; Write bytes: 704710144; Read time: 434; Write time: 2137 21:21:38 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 383730176; Write bytes: 377665536; Read time: 29644; Write time: 784 21:21:38 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 38368768; Write bytes: 300060160; Read time: 416; Write time: 1298 21:21:38 INFO - Running post-run listener: _upload_blobber_files 21:21:38 INFO - Blob upload gear active. 21:21:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:21:38 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 21:21:38 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:21:38 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:21:38 INFO - (blobuploader) - INFO - Open directory for files ... 21:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:21:39 INFO - (blobuploader) - INFO - Done attempting. 21:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:21:40 INFO - (blobuploader) - INFO - Done attempting. 21:21:40 INFO - (blobuploader) - INFO - Iteration through files over. 21:21:40 INFO - Return code: 0 21:21:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:21:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:21:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a0f743814911419cf3026e8878f037345a4bbd0cf84e3299fbe4f29a3982e65652cea52c28b2c3dd8d4c1452caa38551fd149c9f921c5d728774f02531aaab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7b7085d5d5807009515a0d1fb4ad839401c502cae206b0973f7db699670a27e267c6e62b229e075d64772a8e3390bd60b40b560229341f40c464a5fead0002"} 21:21:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:21:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:21:40 INFO - Contents: 21:21:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a0f743814911419cf3026e8878f037345a4bbd0cf84e3299fbe4f29a3982e65652cea52c28b2c3dd8d4c1452caa38551fd149c9f921c5d728774f02531aaab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7b7085d5d5807009515a0d1fb4ad839401c502cae206b0973f7db699670a27e267c6e62b229e075d64772a8e3390bd60b40b560229341f40c464a5fead0002"} 21:21:40 INFO - Running post-run listener: copy_logs_to_upload_dir 21:21:40 INFO - Copying logs to upload dir... 21:21:40 INFO - mkdir: /builds/slave/test/build/upload/logs 21:21:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.071797 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-25 21:21:41.109212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 21:21:41.113048) ========= 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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a0f743814911419cf3026e8878f037345a4bbd0cf84e3299fbe4f29a3982e65652cea52c28b2c3dd8d4c1452caa38551fd149c9f921c5d728774f02531aaab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7b7085d5d5807009515a0d1fb4ad839401c502cae206b0973f7db699670a27e267c6e62b229e075d64772a8e3390bd60b40b560229341f40c464a5fead0002"} build_url:https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/fdqrPfl8T_KVNYtDjOI8gw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a0f743814911419cf3026e8878f037345a4bbd0cf84e3299fbe4f29a3982e65652cea52c28b2c3dd8d4c1452caa38551fd149c9f921c5d728774f02531aaab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7b7085d5d5807009515a0d1fb4ad839401c502cae206b0973f7db699670a27e267c6e62b229e075d64772a8e3390bd60b40b560229341f40c464a5fead0002"}' ========= master_lag: 0.43 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 21:21:41.557279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:21:41.558105) ========= 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.DH3h1ccyiQ/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.sXDSORAyf7/Listeners TMPDIR=/var/folders/9y/wxkdvkmj0lb2gjy9jhxrw28800000w/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.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 21:21:41.609501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 21:21:41.609787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 21:21:41.610145) ========= ========= Total master_lag: 1.35 =========